builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-069 starttime: 1488990561.4 results: success (0) revision: ae315069c70eb5fe7da4dd2b158b3eee3ca9b94a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-08 08:29:21.404704) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-08 08:29:21.405146) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-08 08:29:21.405415) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-08 08:29:21.419927) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 08:29:21.420218) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1488990561.699894-543194811 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-08 08:29:22-- 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% 214M=0s 2017-03-08 08:29:22 (214 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.090074 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 08:29:21.523956) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 08:29:21.524260) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1488990561.699894-543194811 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016494 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 08:29:21.573274) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 08:29:21.573650) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ae315069c70eb5fe7da4dd2b158b3eee3ca9b94a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ae315069c70eb5fe7da4dd2b158b3eee3ca9b94a --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=05b19d94dfa9f3ce7b6e62cc000001f7-1488990561.699894-543194811 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-08 08:29:22,694 truncating revision to first 12 chars 2017-03-08 08:29:22,694 Setting DEBUG logging. 2017-03-08 08:29:22,694 attempt 1/10 2017-03-08 08:29:22,694 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ae315069c70e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-08 08:29:23,127 unpacking tar archive at: mozilla-aurora-ae315069c70e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.774249 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 08:29:22.360635) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-08 08:29:22.360952) ========= script_repo_revision: ae315069c70eb5fe7da4dd2b158b3eee3ca9b94a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-08 08:29:22.361309) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-08 08:29:22.361585) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-08 08:29:22.370930) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-03-08 08:29:22.371217) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=05b19d94dfa9f3ce7b6e62cc000001f7-1488990561.699894-543194811 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:29:23 INFO - MultiFileLogger online at 20170308 08:29:23 in /builds/slave/test 08:29:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:29:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:29:23 INFO - {'append_to_log': False, 08:29:23 INFO - 'base_work_dir': '/builds/slave/test', 08:29:23 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:29:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:29:23 INFO - 'branch': 'Mozilla-Aurora', 08:29:23 INFO - 'buildbot_json_path': 'buildprops.json', 08:29:23 INFO - 'config_files': ('talos/linux_config.py',), 08:29:23 INFO - 'default_actions': ('clobber', 08:29:23 INFO - 'read-buildbot-config', 08:29:23 INFO - 'download-and-extract', 08:29:23 INFO - 'populate-webroot', 08:29:23 INFO - 'create-virtualenv', 08:29:23 INFO - 'install', 08:29:23 INFO - 'run-tests'), 08:29:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:29:23 INFO - 'download_minidump_stackwalk': True, 08:29:23 INFO - 'download_symbols': 'ondemand', 08:29:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:29:23 INFO - 'tooltool.py': '/tools/tooltool.py', 08:29:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:29:23 INFO - '/tools/misc-python/virtualenv.py')}, 08:29:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:29:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:29:23 INFO - 'gecko_profile': False, 08:29:23 INFO - 'gecko_profile_interval': 0, 08:29:23 INFO - 'installer_path': 'installer.exe', 08:29:23 INFO - 'log_level': 'info', 08:29:23 INFO - 'log_name': 'talos', 08:29:23 INFO - 'log_to_console': True, 08:29:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:29:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:29:23 INFO - 'opt_config_files': (), 08:29:23 INFO - 'pip_index': False, 08:29:23 INFO - 'suite': 'dromaeojs', 08:29:23 INFO - 'system_bits': '32', 08:29:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:29:23 INFO - 'title': 'talos-linux64-ix-069', 08:29:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:29:23 INFO - 'use_talos_json': True, 08:29:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:29:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:29:23 INFO - 'work_dir': 'build'} 08:29:23 INFO - [mozharness: 2017-03-08 16:29:23.590657Z] Running clobber step. 08:29:23 INFO - Running pre-action listener: _resource_record_pre_action 08:29:23 INFO - Running main action method: clobber 08:29:23 INFO - rmtree: /builds/slave/test/build 08:29:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:29:24 INFO - Running post-action listener: _resource_record_post_action 08:29:24 INFO - [mozharness: 2017-03-08 16:29:24.530443Z] Finished clobber step (success) 08:29:24 INFO - [mozharness: 2017-03-08 16:29:24.530542Z] Running read-buildbot-config step. 08:29:24 INFO - Running pre-action listener: _resource_record_pre_action 08:29:24 INFO - Running main action method: read_buildbot_config 08:29:24 INFO - Using buildbot properties: 08:29:24 INFO - { 08:29:24 INFO - "project": "", 08:29:24 INFO - "product": "firefox", 08:29:24 INFO - "who": "ffxbld@noreply.mozilla.org", 08:29:24 INFO - "installer_path": "public/build/target.tar.bz2", 08:29:24 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 08:29:24 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 08:29:24 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 08:29:24 INFO - "stage_platform": "linux64-pgo", 08:29:24 INFO - "basedir": "/builds/slave/test", 08:29:24 INFO - "buildnumber": 817, 08:29:24 INFO - "platform": "ubuntu64_hw", 08:29:24 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:29:24 INFO - "slavebuilddir": "test", 08:29:24 INFO - "taskId": "D2cvpnMHTSiQ7EBgpkq_lw", 08:29:24 INFO - "branch": "mozilla-aurora", 08:29:24 INFO - "script_repo_revision": "production", 08:29:24 INFO - "revision": "ae315069c70eb5fe7da4dd2b158b3eee3ca9b94a", 08:29:24 INFO - "slavename": "talos-linux64-ix-069", 08:29:24 INFO - "repo_path": "releases/mozilla-aurora" 08:29:24 INFO - } 08:29:24 INFO - Finding installer, test and symbols from parent task. 08:29:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D2cvpnMHTSiQ7EBgpkq_lw'}, attempt #1 08:29:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D2cvpnMHTSiQ7EBgpkq_lw'}, attempt #1 08:29:25 INFO - Task dependencies: aC-0RQJ6Sde-4mUvuw1v-Q 08:29:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aC-0RQJ6Sde-4mUvuw1v-Q'}, attempt #1 08:29:25 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/aC-0RQJ6Sde-4mUvuw1v-Q/artifacts/public/build/target.tar.bz2 08:29:25 INFO - Set test_url: https://queue.taskcluster.net/v1/task/aC-0RQJ6Sde-4mUvuw1v-Q/artifacts/public/build/test_packages.json 08:29:25 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/aC-0RQJ6Sde-4mUvuw1v-Q/artifacts/public/build/target.crashreporter-symbols.zip 08:29:25 INFO - Running post-action listener: _resource_record_post_action 08:29:25 INFO - [mozharness: 2017-03-08 16:29:25.926871Z] Finished read-buildbot-config step (success) 08:29:25 INFO - [mozharness: 2017-03-08 16:29:25.927121Z] Running download-and-extract step. 08:29:25 INFO - Running pre-action listener: _resource_record_pre_action 08:29:25 INFO - Running main action method: download_and_extract 08:29:25 INFO - mkdir: /builds/slave/test/build/tests 08:29:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:29:25 INFO - trying https://queue.taskcluster.net/v1/task/aC-0RQJ6Sde-4mUvuw1v-Q/artifacts/public/build/target.test_packages.json 08:29:25 INFO - Downloading https://queue.taskcluster.net/v1/task/aC-0RQJ6Sde-4mUvuw1v-Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:29:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aC-0RQJ6Sde-4mUvuw1v-Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:29:26 INFO - Downloaded 896 bytes. 08:29:26 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:29:26 INFO - Using the following test package requirements: 08:29:26 INFO - {u'common': [u'target.common.tests.zip'], 08:29:26 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:29:26 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:29:26 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:29:26 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:29:26 INFO - u'mozbase': [u'target.common.tests.zip'], 08:29:26 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:29:26 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:29:26 INFO - u'web-platform': [u'target.common.tests.zip', 08:29:26 INFO - u'target.web-platform.tests.zip'], 08:29:26 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:29:26 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:29:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aC-0RQJ6Sde-4mUvuw1v-Q/artifacts/public/build/target.common.tests.zip 08:29:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aC-0RQJ6Sde-4mUvuw1v-Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:29:26 INFO - Fetch https://queue.taskcluster.net/v1/task/aC-0RQJ6Sde-4mUvuw1v-Q/artifacts/public/build/target.common.tests.zip into memory 08:29:27 INFO - Expected file size: 59529318 08:29:27 INFO - Obtained file size: 59529318 08:29:37 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:29:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aC-0RQJ6Sde-4mUvuw1v-Q/artifacts/public/build/target.common.tests.zip 08:29:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aC-0RQJ6Sde-4mUvuw1v-Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:29:37 INFO - Fetch https://queue.taskcluster.net/v1/task/aC-0RQJ6Sde-4mUvuw1v-Q/artifacts/public/build/target.common.tests.zip into memory 08:29:38 INFO - Expected file size: 59529318 08:29:38 INFO - Obtained file size: 59529318 08:29:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aC-0RQJ6Sde-4mUvuw1v-Q/artifacts/public/build/target.talos.tests.zip 08:29:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aC-0RQJ6Sde-4mUvuw1v-Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:29:49 INFO - Fetch https://queue.taskcluster.net/v1/task/aC-0RQJ6Sde-4mUvuw1v-Q/artifacts/public/build/target.talos.tests.zip into memory 08:29:50 INFO - Expected file size: 14404424 08:29:50 INFO - Obtained file size: 14404424 08:29:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:29:50 INFO - trying https://queue.taskcluster.net/v1/task/aC-0RQJ6Sde-4mUvuw1v-Q/artifacts/public/build/target.tar.bz2 08:29:50 INFO - Downloading https://queue.taskcluster.net/v1/task/aC-0RQJ6Sde-4mUvuw1v-Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:29:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aC-0RQJ6Sde-4mUvuw1v-Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:29:51 INFO - Downloaded 66604636 bytes. 08:29:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aC-0RQJ6Sde-4mUvuw1v-Q/artifacts/public/build/target.tar.bz2 08:29:51 INFO - mkdir: /builds/slave/test/properties 08:29:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:29:51 INFO - Writing to file /builds/slave/test/properties/build_url 08:29:51 INFO - Contents: 08:29:51 INFO - build_url:https://queue.taskcluster.net/v1/task/aC-0RQJ6Sde-4mUvuw1v-Q/artifacts/public/build/target.tar.bz2 08:29:51 INFO - Running post-action listener: _resource_record_post_action 08:29:51 INFO - Running post-action listener: set_extra_try_arguments 08:29:51 INFO - [mozharness: 2017-03-08 16:29:51.474393Z] Finished download-and-extract step (success) 08:29:51 INFO - [mozharness: 2017-03-08 16:29:51.474490Z] Running populate-webroot step. 08:29:51 INFO - Running pre-action listener: _resource_record_pre_action 08:29:51 INFO - Running main action method: populate_webroot 08:29:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:29:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:29:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:29:51 INFO - '--tppagecycles', 08:29:51 INFO - '7'], 08:29:51 INFO - 'tests': ['tsvgm']}}, 08:29:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:29:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:29:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:29:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:29:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:29:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:29:51 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:29:51 INFO - 'talos_options': ['--disable-e10s'], 08:29:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:29:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:29:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:29:51 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:29:51 INFO - 'talos_options': ['--disable-e10s'], 08:29:51 INFO - 'tests': ['damp', 'tps']}, 08:29:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:29:51 INFO - 'tests': ['damp', 'tps']}, 08:29:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:29:51 INFO - 'tests': ['dromaeo_dom']}, 08:29:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:29:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:29:51 INFO - 'tests': ['basic_compositor_video']}, 08:29:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:29:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:29:51 INFO - 'tests': ['a11yr', 08:29:51 INFO - 'ts_paint', 08:29:51 INFO - 'tpaint', 08:29:51 INFO - 'sessionrestore', 08:29:51 INFO - 'sessionrestore_no_auto_restore', 08:29:51 INFO - 'tabpaint']}, 08:29:51 INFO - 'other-e10s': {'tests': ['a11yr', 08:29:51 INFO - 'ts_paint', 08:29:51 INFO - 'tpaint', 08:29:51 INFO - 'sessionrestore', 08:29:51 INFO - 'sessionrestore_no_auto_restore', 08:29:51 INFO - 'tabpaint']}, 08:29:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:29:51 INFO - 'ts_paint', 08:29:51 INFO - 'tpaint', 08:29:51 INFO - 'sessionrestore', 08:29:51 INFO - 'sessionrestore_no_auto_restore', 08:29:51 INFO - 'tabpaint']}, 08:29:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:29:51 INFO - 'ts_paint', 08:29:51 INFO - 'tpaint', 08:29:51 INFO - 'sessionrestore', 08:29:51 INFO - 'sessionrestore_no_auto_restore', 08:29:51 INFO - 'tabpaint']}, 08:29:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:29:51 INFO - 'tests': ['a11yr', 08:29:51 INFO - 'ts_paint', 08:29:51 INFO - 'tpaint', 08:29:51 INFO - 'sessionrestore', 08:29:51 INFO - 'sessionrestore_no_auto_restore', 08:29:51 INFO - 'tabpaint']}, 08:29:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:29:51 INFO - 'tests': ['a11yr', 08:29:51 INFO - 'ts_paint', 08:29:51 INFO - 'tpaint', 08:29:51 INFO - 'sessionrestore', 08:29:51 INFO - 'sessionrestore_no_auto_restore', 08:29:51 INFO - 'tabpaint']}, 08:29:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:29:51 INFO - 'tests': ['tsvgx', 08:29:51 INFO - 'tsvgr_opacity', 08:29:51 INFO - 'tart', 08:29:51 INFO - 'tscrollx', 08:29:51 INFO - 'cart', 08:29:51 INFO - 'tsvg_static']}, 08:29:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:29:51 INFO - 'tsvgr_opacity', 08:29:51 INFO - 'tart', 08:29:51 INFO - 'tscrollx', 08:29:51 INFO - 'cart', 08:29:51 INFO - 'tsvg_static']}, 08:29:51 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:29:51 INFO - 'talos_options': ['--disable-e10s'], 08:29:51 INFO - 'tests': ['tp5o']}, 08:29:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:29:51 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:29:51 INFO - 'talos_options': ['--disable-e10s', 08:29:51 INFO - '--xperf_path', 08:29:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:29:51 INFO - 'tests': ['tp5n']}, 08:29:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:29:51 INFO - 'talos_options': ['--xperf_path', 08:29:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:29:51 INFO - 'tests': ['tp5n']}}, 08:29:51 INFO - 'talos.zip': {'path': '', 08:29:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:29:51 INFO - Running post-action listener: _resource_record_post_action 08:29:51 INFO - [mozharness: 2017-03-08 16:29:51.487618Z] Finished populate-webroot step (success) 08:29:51 INFO - [mozharness: 2017-03-08 16:29:51.487709Z] Running create-virtualenv step. 08:29:51 INFO - Running pre-action listener: _resource_record_pre_action 08:29:51 INFO - Running main action method: create_virtualenv 08:29:51 INFO - Creating virtualenv /builds/slave/test/build/venv 08:29:51 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 08:29:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:29:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:29:51 INFO - Using real prefix '/usr' 08:29:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:29:52 INFO - Installing distribute.............................................................................................................................................................................................done. 08:29:54 INFO - Installing pip.................done. 08:29:54 INFO - Return code: 0 08:29:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:29:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:29:54 INFO - Reading from file tmpfile_stdout 08:29:54 INFO - Output received: 08:29:54 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) 08:29:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:29:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:29:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:54 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1b6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c62a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e07b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e05290>, '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 0x1e05b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e06040>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1488990561.699894-543194811', '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 08:29:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 08:29:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:29:54 INFO - Using env: {'DISPLAY': ':0', 08:29:54 INFO - 'HOME': '/home/cltbld', 08:29:54 INFO - 'LANG': 'en_US.UTF-8', 08:29:54 INFO - 'LANGUAGE': 'en_US:en', 08:29:54 INFO - 'LOGNAME': 'cltbld', 08:29:54 INFO - 'MAIL': '/var/mail/cltbld', 08:29:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:54 INFO - 'MOZ_NO_REMOTE': '1', 08:29:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:54 INFO - 'NO_EM_RESTART': '1', 08:29:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:54 INFO - 'PWD': '/builds/slave/test', 08:29:54 INFO - 'SHELL': '/bin/bash', 08:29:54 INFO - 'SHLVL': '1', 08:29:54 INFO - 'TERM': 'linux', 08:29:54 INFO - 'TMOUT': '86400', 08:29:54 INFO - 'USER': 'cltbld', 08:29:54 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1488990561.699894-543194811', 08:29:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:54 INFO - '_': '/tools/buildbot/bin/python'} 08:29:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:54 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 08:29:54 INFO - Cleaning up... 08:29:54 INFO - Return code: 0 08:29:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:29:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:29:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:54 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1b6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c62a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e07b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e05290>, '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 0x1e05b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e06040>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1488990561.699894-543194811', '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 08:29:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 08:29:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:29:54 INFO - Using env: {'DISPLAY': ':0', 08:29:54 INFO - 'HOME': '/home/cltbld', 08:29:54 INFO - 'LANG': 'en_US.UTF-8', 08:29:54 INFO - 'LANGUAGE': 'en_US:en', 08:29:54 INFO - 'LOGNAME': 'cltbld', 08:29:54 INFO - 'MAIL': '/var/mail/cltbld', 08:29:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:54 INFO - 'MOZ_NO_REMOTE': '1', 08:29:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:54 INFO - 'NO_EM_RESTART': '1', 08:29:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:54 INFO - 'PWD': '/builds/slave/test', 08:29:54 INFO - 'SHELL': '/bin/bash', 08:29:54 INFO - 'SHLVL': '1', 08:29:54 INFO - 'TERM': 'linux', 08:29:54 INFO - 'TMOUT': '86400', 08:29:54 INFO - 'USER': 'cltbld', 08:29:54 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1488990561.699894-543194811', 08:29:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:54 INFO - '_': '/tools/buildbot/bin/python'} 08:29:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:54 INFO - Downloading/unpacking psutil>=3.1.1 08:29:54 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 08:29:54 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 08:29:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:54 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 08:29:54 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 08:29:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:29:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:29:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:29:56 INFO - Installing collected packages: psutil 08:29:56 INFO - Running setup.py install for psutil 08:29:56 INFO - building 'psutil._psutil_linux' extension 08:29:56 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 08:29: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 08:29:57 INFO - building 'psutil._psutil_posix' extension 08:29: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 08:29: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 08:29:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:29:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:29:57 INFO - Successfully installed psutil 08:29:57 INFO - Cleaning up... 08:29:57 INFO - Return code: 0 08:29:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:29:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:29:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:29:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:57 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1b6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c62a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e07b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e05290>, '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 0x1e05b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e06040>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1488990561.699894-543194811', '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 08:29:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 08:29:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:29:57 INFO - Using env: {'DISPLAY': ':0', 08:29:57 INFO - 'HOME': '/home/cltbld', 08:29:57 INFO - 'LANG': 'en_US.UTF-8', 08:29:57 INFO - 'LANGUAGE': 'en_US:en', 08:29:57 INFO - 'LOGNAME': 'cltbld', 08:29:57 INFO - 'MAIL': '/var/mail/cltbld', 08:29:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:57 INFO - 'MOZ_NO_REMOTE': '1', 08:29:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:57 INFO - 'NO_EM_RESTART': '1', 08:29:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:57 INFO - 'PWD': '/builds/slave/test', 08:29:57 INFO - 'SHELL': '/bin/bash', 08:29:57 INFO - 'SHLVL': '1', 08:29:57 INFO - 'TERM': 'linux', 08:29:57 INFO - 'TMOUT': '86400', 08:29:57 INFO - 'USER': 'cltbld', 08:29:57 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1488990561.699894-543194811', 08:29:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:57 INFO - '_': '/tools/buildbot/bin/python'} 08:29:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:29:57 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 08:29:57 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 08:29:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:57 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 08:29:57 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 08:29:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:29:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:29:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:29:59 INFO - Installing collected packages: mozsystemmonitor 08:29:59 INFO - Running setup.py install for mozsystemmonitor 08:29:59 INFO - Successfully installed mozsystemmonitor 08:29:59 INFO - Cleaning up... 08:29:59 INFO - Return code: 0 08:29:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:29:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:29:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29: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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1b6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c62a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e07b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e05290>, '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 0x1e05b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e06040>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1488990561.699894-543194811', '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 08:29:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 08:29:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:29:59 INFO - Using env: {'DISPLAY': ':0', 08:29:59 INFO - 'HOME': '/home/cltbld', 08:29:59 INFO - 'LANG': 'en_US.UTF-8', 08:29:59 INFO - 'LANGUAGE': 'en_US:en', 08:29:59 INFO - 'LOGNAME': 'cltbld', 08:29:59 INFO - 'MAIL': '/var/mail/cltbld', 08:29:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:59 INFO - 'MOZ_NO_REMOTE': '1', 08:29:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:59 INFO - 'NO_EM_RESTART': '1', 08:29:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:59 INFO - 'PWD': '/builds/slave/test', 08:29:59 INFO - 'SHELL': '/bin/bash', 08:29:59 INFO - 'SHLVL': '1', 08:29:59 INFO - 'TERM': 'linux', 08:29:59 INFO - 'TMOUT': '86400', 08:29:59 INFO - 'USER': 'cltbld', 08:29:59 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1488990561.699894-543194811', 08:29:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:59 INFO - '_': '/tools/buildbot/bin/python'} 08:30:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:00 INFO - Downloading/unpacking jsonschema==2.5.1 08:30: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 08:30: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 08:30:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30: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 08:30: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 08:30:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:30:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:30: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 08:30: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 08:30:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30: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 08:30: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 08:30:02 INFO - Downloading functools32-3.2.3-2.tar.gz 08:30:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:30:02 INFO - warning: no files found matching '*.txt' 08:30:02 INFO - no previously-included directories found matching 'build' 08:30:02 INFO - no previously-included directories found matching 'dist' 08:30:02 INFO - no previously-included directories found matching '.git*' 08:30:02 INFO - Installing collected packages: jsonschema, functools32 08:30:02 INFO - Running setup.py install for functools32 08:30:02 INFO - warning: no files found matching '*.txt' 08:30:02 INFO - no previously-included directories found matching 'build' 08:30:02 INFO - no previously-included directories found matching 'dist' 08:30:02 INFO - no previously-included directories found matching '.git*' 08:30:02 INFO - Successfully installed jsonschema functools32 08:30:02 INFO - Cleaning up... 08:30:02 INFO - Return code: 0 08:30:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:30:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:30:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:02 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1b6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c62a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e07b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e05290>, '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 0x1e05b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e06040>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1488990561.699894-543194811', '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 08:30:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 08:30:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:30:02 INFO - Using env: {'DISPLAY': ':0', 08:30:02 INFO - 'HOME': '/home/cltbld', 08:30:02 INFO - 'LANG': 'en_US.UTF-8', 08:30:02 INFO - 'LANGUAGE': 'en_US:en', 08:30:02 INFO - 'LOGNAME': 'cltbld', 08:30:02 INFO - 'MAIL': '/var/mail/cltbld', 08:30:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:02 INFO - 'MOZ_NO_REMOTE': '1', 08:30:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:02 INFO - 'NO_EM_RESTART': '1', 08:30:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:02 INFO - 'PWD': '/builds/slave/test', 08:30:02 INFO - 'SHELL': '/bin/bash', 08:30:02 INFO - 'SHLVL': '1', 08:30:02 INFO - 'TERM': 'linux', 08:30:02 INFO - 'TMOUT': '86400', 08:30:02 INFO - 'USER': 'cltbld', 08:30:02 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1488990561.699894-543194811', 08:30:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:02 INFO - '_': '/tools/buildbot/bin/python'} 08:30:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:30:02 INFO - Cleaning up... 08:30:02 INFO - Return code: 0 08:30:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:30:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:30:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:02 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1b6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c62a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e07b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e05290>, '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 0x1e05b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e06040>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1488990561.699894-543194811', '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 08:30:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 08:30:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:30:02 INFO - Using env: {'DISPLAY': ':0', 08:30:02 INFO - 'HOME': '/home/cltbld', 08:30:02 INFO - 'LANG': 'en_US.UTF-8', 08:30:02 INFO - 'LANGUAGE': 'en_US:en', 08:30:02 INFO - 'LOGNAME': 'cltbld', 08:30:02 INFO - 'MAIL': '/var/mail/cltbld', 08:30:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:02 INFO - 'MOZ_NO_REMOTE': '1', 08:30:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:02 INFO - 'NO_EM_RESTART': '1', 08:30:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:02 INFO - 'PWD': '/builds/slave/test', 08:30:02 INFO - 'SHELL': '/bin/bash', 08:30:02 INFO - 'SHLVL': '1', 08:30:02 INFO - 'TERM': 'linux', 08:30:02 INFO - 'TMOUT': '86400', 08:30:02 INFO - 'USER': 'cltbld', 08:30:02 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1488990561.699894-543194811', 08:30:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:02 INFO - '_': '/tools/buildbot/bin/python'} 08:30:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:02 INFO - Downloading/unpacking blobuploader==1.2.4 08:30: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 08:30: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 08:30:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30: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 08:30: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 08:30:04 INFO - Downloading blobuploader-1.2.4.tar.gz 08:30:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:30:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:30:05 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 08:30:05 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 08:30:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:05 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 08:30:05 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 08:30:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:30:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:30:05 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 08:30:05 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 08:30:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:05 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 08:30:05 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 08:30:05 INFO - Downloading docopt-0.6.1.tar.gz 08:30:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:30:05 INFO - Installing collected packages: blobuploader, requests, docopt 08:30:05 INFO - Running setup.py install for blobuploader 08:30:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:30:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:30:05 INFO - Running setup.py install for requests 08:30:06 INFO - Running setup.py install for docopt 08:30:06 INFO - Successfully installed blobuploader requests docopt 08:30:06 INFO - Cleaning up... 08:30:06 INFO - Return code: 0 08:30:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:30:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:30:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:30:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:06 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1b6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c62a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e07b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e05290>, '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 0x1e05b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e06040>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1488990561.699894-543194811', '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 08:30:06 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 08:30:06 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:30:06 INFO - Using env: {'DISPLAY': ':0', 08:30:06 INFO - 'HOME': '/home/cltbld', 08:30:06 INFO - 'LANG': 'en_US.UTF-8', 08:30:06 INFO - 'LANGUAGE': 'en_US:en', 08:30:06 INFO - 'LOGNAME': 'cltbld', 08:30:06 INFO - 'MAIL': '/var/mail/cltbld', 08:30:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:06 INFO - 'MOZ_NO_REMOTE': '1', 08:30:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:06 INFO - 'NO_EM_RESTART': '1', 08:30:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:06 INFO - 'PWD': '/builds/slave/test', 08:30:06 INFO - 'SHELL': '/bin/bash', 08:30:06 INFO - 'SHLVL': '1', 08:30:06 INFO - 'TERM': 'linux', 08:30:06 INFO - 'TMOUT': '86400', 08:30:06 INFO - 'USER': 'cltbld', 08:30:06 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1488990561.699894-543194811', 08:30:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:06 INFO - '_': '/tools/buildbot/bin/python'} 08:30:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:30:06 INFO - Running setup.py (path:/tmp/pip-MWNY1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:30:06 INFO - Running setup.py (path:/tmp/pip-yEvlho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:30:06 INFO - Running setup.py (path:/tmp/pip-mMUkJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:30:06 INFO - Running setup.py (path:/tmp/pip-0ZHE5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:30:06 INFO - Running setup.py (path:/tmp/pip-kPeTrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:30:06 INFO - Running setup.py (path:/tmp/pip-_GOYQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:30:07 INFO - Running setup.py (path:/tmp/pip-Mm0U9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:30:07 INFO - Running setup.py (path:/tmp/pip-E76hck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:30:07 INFO - Running setup.py (path:/tmp/pip-b_7_JG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:30:07 INFO - Running setup.py (path:/tmp/pip-TQk4PR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:30:07 INFO - Running setup.py (path:/tmp/pip-sTllmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:30:07 INFO - Running setup.py (path:/tmp/pip-WVfuJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:30:07 INFO - Running setup.py (path:/tmp/pip-SDgbSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:30:07 INFO - Running setup.py (path:/tmp/pip-1JSdzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:30:07 INFO - Running setup.py (path:/tmp/pip-4Lbasb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:30:07 INFO - Running setup.py (path:/tmp/pip-tkCJHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:30:07 INFO - Running setup.py (path:/tmp/pip-0gOQby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:30:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:30:07 INFO - Running setup.py install for manifestparser 08:30:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:30:07 INFO - Running setup.py install for mozcrash 08:30:08 INFO - Running setup.py install for mozdebug 08:30:08 INFO - Running setup.py install for mozdevice 08:30:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:30:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:30:08 INFO - Running setup.py install for mozfile 08:30:08 INFO - Running setup.py install for mozhttpd 08:30:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:30:08 INFO - Running setup.py install for mozinfo 08:30:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:30:08 INFO - Running setup.py install for mozInstall 08:30:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:30:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:30:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:30:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:30:08 INFO - Running setup.py install for mozleak 08:30:08 INFO - Running setup.py install for mozlog 08:30:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:30:08 INFO - Running setup.py install for moznetwork 08:30:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:30:08 INFO - Running setup.py install for mozprocess 08:30:09 INFO - Running setup.py install for mozprofile 08:30:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:30:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:30:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:30:09 INFO - Running setup.py install for mozrunner 08:30:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:30:09 INFO - Running setup.py install for mozscreenshot 08:30:09 INFO - Running setup.py install for moztest 08:30:09 INFO - Running setup.py install for mozversion 08:30:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:30:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:30:09 INFO - Cleaning up... 08:30:09 INFO - Return code: 0 08:30:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:30:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:30:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:09 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1b6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c62a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e07b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e05290>, '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 0x1e05b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e06040>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1488990561.699894-543194811', '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 08:30:09 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 08:30:09 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:30:09 INFO - Using env: {'DISPLAY': ':0', 08:30:09 INFO - 'HOME': '/home/cltbld', 08:30:09 INFO - 'LANG': 'en_US.UTF-8', 08:30:09 INFO - 'LANGUAGE': 'en_US:en', 08:30:09 INFO - 'LOGNAME': 'cltbld', 08:30:09 INFO - 'MAIL': '/var/mail/cltbld', 08:30:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:09 INFO - 'MOZ_NO_REMOTE': '1', 08:30:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:09 INFO - 'NO_EM_RESTART': '1', 08:30:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:09 INFO - 'PWD': '/builds/slave/test', 08:30:09 INFO - 'SHELL': '/bin/bash', 08:30:09 INFO - 'SHLVL': '1', 08:30:09 INFO - 'TERM': 'linux', 08:30:09 INFO - 'TMOUT': '86400', 08:30:09 INFO - 'USER': 'cltbld', 08:30:09 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1488990561.699894-543194811', 08:30:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:09 INFO - '_': '/tools/buildbot/bin/python'} 08:30:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:30:09 INFO - Running setup.py (path:/tmp/pip-4ptqF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:30:09 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)) 08:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:30:09 INFO - Running setup.py (path:/tmp/pip-uGaZm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:30:10 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)) 08:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:30:10 INFO - Running setup.py (path:/tmp/pip-pVIlSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:30:10 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)) 08:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:30:10 INFO - Running setup.py (path:/tmp/pip-zfj02F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:30:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 08:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:30:10 INFO - Running setup.py (path:/tmp/pip-ScHh2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:30:10 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)) 08:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:30:10 INFO - Running setup.py (path:/tmp/pip-ZAC53y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:30:10 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)) 08:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:30:10 INFO - Running setup.py (path:/tmp/pip-sGyi0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:30:10 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)) 08:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:30:10 INFO - Running setup.py (path:/tmp/pip-96elkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:30:10 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)) 08:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:30:10 INFO - Running setup.py (path:/tmp/pip-TJliWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:30:10 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)) 08:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:30:10 INFO - Running setup.py (path:/tmp/pip-y8KpDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:30:10 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)) 08:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:30:10 INFO - Running setup.py (path:/tmp/pip-g6p1LJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:30:10 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)) 08:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:30:10 INFO - Running setup.py (path:/tmp/pip-jpc0h0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:30:10 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)) 08:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:30:10 INFO - Running setup.py (path:/tmp/pip-x9cFeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:30:10 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)) 08:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:30:10 INFO - Running setup.py (path:/tmp/pip-L6C2QW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:30:10 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)) 08:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:30:10 INFO - Running setup.py (path:/tmp/pip-9O5Bjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:30:10 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)) 08:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:30:10 INFO - Running setup.py (path:/tmp/pip-dPQncj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:30:11 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)) 08:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:30:11 INFO - Running setup.py (path:/tmp/pip-pdy_Ab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:30:11 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)) 08:30:11 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)) 08:30:11 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)) 08:30:11 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)) 08:30:11 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:30:11 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:30:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:13 INFO - Downloading blessings-1.6.tar.gz 08:30:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:30:13 INFO - Installing collected packages: blessings 08:30:13 INFO - Running setup.py install for blessings 08:30:13 INFO - Successfully installed blessings 08:30:13 INFO - Cleaning up... 08:30:13 INFO - Return code: 0 08:30:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:30:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:30:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:30:13 INFO - Reading from file tmpfile_stdout 08:30:13 INFO - Current package versions: 08:30:13 INFO - argparse == 1.2.1 08:30:13 INFO - blessings == 1.6 08:30:13 INFO - blobuploader == 1.2.4 08:30:13 INFO - docopt == 0.6.1 08:30:13 INFO - functools32 == 3.2.3-2 08:30:13 INFO - jsonschema == 2.5.1 08:30:13 INFO - manifestparser == 1.1 08:30:13 INFO - mozInstall == 1.12 08:30:13 INFO - mozcrash == 1.0 08:30:13 INFO - mozdebug == 0.1 08:30:13 INFO - mozdevice == 0.49 08:30:13 INFO - mozfile == 1.2 08:30:13 INFO - mozhttpd == 0.7 08:30:13 INFO - mozinfo == 0.9 08:30:13 INFO - mozleak == 0.1 08:30:13 INFO - mozlog == 3.4 08:30:13 INFO - moznetwork == 0.27 08:30:13 INFO - mozprocess == 0.25 08:30:13 INFO - mozprofile == 0.28 08:30:13 INFO - mozrunner == 6.13 08:30:13 INFO - mozscreenshot == 0.1 08:30:13 INFO - mozsystemmonitor == 0.3 08:30:13 INFO - moztest == 0.8 08:30:13 INFO - mozversion == 1.4 08:30:13 INFO - psutil == 3.1.1 08:30:13 INFO - requests == 1.2.3 08:30:13 INFO - wsgiref == 0.1.2 08:30:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:30:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:30:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:13 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1b6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c62a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e07b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e05290>, '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 0x1e05b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e06040>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1488990561.699894-543194811', '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 08:30:13 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 08:30:13 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:30:13 INFO - Using env: {'DISPLAY': ':0', 08:30:13 INFO - 'HOME': '/home/cltbld', 08:30:13 INFO - 'LANG': 'en_US.UTF-8', 08:30:13 INFO - 'LANGUAGE': 'en_US:en', 08:30:13 INFO - 'LOGNAME': 'cltbld', 08:30:13 INFO - 'MAIL': '/var/mail/cltbld', 08:30:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:13 INFO - 'MOZ_NO_REMOTE': '1', 08:30:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:13 INFO - 'NO_EM_RESTART': '1', 08:30:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:13 INFO - 'PWD': '/builds/slave/test', 08:30:13 INFO - 'SHELL': '/bin/bash', 08:30:13 INFO - 'SHLVL': '1', 08:30:13 INFO - 'TERM': 'linux', 08:30:13 INFO - 'TMOUT': '86400', 08:30:13 INFO - 'USER': 'cltbld', 08:30:13 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1488990561.699894-543194811', 08:30:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:13 INFO - '_': '/tools/buildbot/bin/python'} 08:30:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:13 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)) 08:30:13 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)) 08:30:13 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)) 08:30:13 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)) 08:30:13 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)) 08:30:13 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)) 08:30:13 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)) 08:30:13 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)) 08:30:13 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)) 08:30:13 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)) 08:30:13 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)) 08:30:13 INFO - Cleaning up... 08:30:13 INFO - Return code: 0 08:30:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:30:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:30:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1b6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c62a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e07b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e05290>, '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 0x1e05b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e06040>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1488990561.699894-543194811', '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 08:30:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:30:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:30:13 INFO - Using env: {'DISPLAY': ':0', 08:30:13 INFO - 'HOME': '/home/cltbld', 08:30:13 INFO - 'LANG': 'en_US.UTF-8', 08:30:13 INFO - 'LANGUAGE': 'en_US:en', 08:30:13 INFO - 'LOGNAME': 'cltbld', 08:30:13 INFO - 'MAIL': '/var/mail/cltbld', 08:30:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:13 INFO - 'MOZ_NO_REMOTE': '1', 08:30:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:13 INFO - 'NO_EM_RESTART': '1', 08:30:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:13 INFO - 'PWD': '/builds/slave/test', 08:30:13 INFO - 'SHELL': '/bin/bash', 08:30:13 INFO - 'SHLVL': '1', 08:30:13 INFO - 'TERM': 'linux', 08:30:13 INFO - 'TMOUT': '86400', 08:30:13 INFO - 'USER': 'cltbld', 08:30:13 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1488990561.699894-543194811', 08:30:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:13 INFO - '_': '/tools/buildbot/bin/python'} 08:30:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:30:14 INFO - Cleaning up... 08:30:14 INFO - Return code: 0 08:30:14 INFO - Running post-action listener: _resource_record_post_action 08:30:14 INFO - Running post-action listener: _start_resource_monitoring 08:30:14 INFO - Starting resource monitoring. 08:30:14 INFO - [mozharness: 2017-03-08 16:30:14.067738Z] Finished create-virtualenv step (success) 08:30:14 INFO - [mozharness: 2017-03-08 16:30:14.068209Z] Running install step. 08:30:14 INFO - Running pre-action listener: _resource_record_pre_action 08:30:14 INFO - Running main action method: install 08:30:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:30:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:30:14 INFO - Reading from file tmpfile_stdout 08:30:14 INFO - Detecting whether we're running mozinstall >=1.0... 08:30:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:30:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:30:14 INFO - Reading from file tmpfile_stdout 08:30:14 INFO - Output received: 08:30:14 INFO - Usage: mozinstall [options] installer 08:30:14 INFO - Options: 08:30:14 INFO - -h, --help show this help message and exit 08:30:14 INFO - -d DEST, --destination=DEST 08:30:14 INFO - Directory to install application into. [default: 08:30:14 INFO - "/builds/slave/test"] 08:30:14 INFO - --app=APP Application being installed. [default: firefox] 08:30:14 INFO - mkdir: /builds/slave/test/build/application 08:30:14 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'] 08:30:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:30:30 INFO - Reading from file tmpfile_stdout 08:30:30 INFO - Output received: 08:30:30 INFO - /builds/slave/test/build/application/firefox/firefox 08:30:30 INFO - Running post-action listener: _resource_record_post_action 08:30:30 INFO - [mozharness: 2017-03-08 16:30:30.959743Z] Finished install step (success) 08:30:30 INFO - [mozharness: 2017-03-08 16:30:30.960016Z] Running run-tests step. 08:30:30 INFO - Running pre-action listener: _resource_record_pre_action 08:30:30 INFO - Running main action method: run_tests 08:30:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:30:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:30:30 INFO - Python 2.7.3 08:30:30 INFO - Return code: 0 08:30:30 INFO - grabbing minidump binary from tooltool 08:30:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:30:30 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 0x1e05290>, '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 0x1e05b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e06040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:30:30 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 08:30:30 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 08:30:30 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 08:30:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:30:31 INFO - Return code: 0 08:30:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:30:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:30:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:30:31 INFO - ENV: RUST_BACKTRACE is now 1 08:30:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:30:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:30:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aC-0RQJ6Sde-4mUvuw1v-Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:30:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aC-0RQJ6Sde-4mUvuw1v-Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-069 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:30:31 INFO - Using env: {'DISPLAY': ':0', 08:30:31 INFO - 'HOME': '/home/cltbld', 08:30:31 INFO - 'LANG': 'en_US.UTF-8', 08:30:31 INFO - 'LANGUAGE': 'en_US:en', 08:30:31 INFO - 'LOGNAME': 'cltbld', 08:30:31 INFO - 'MAIL': '/var/mail/cltbld', 08:30:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:30:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:30:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:31 INFO - 'MOZ_NO_REMOTE': '1', 08:30:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:30:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:31 INFO - 'NO_EM_RESTART': '1', 08:30:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:31 INFO - 'PWD': '/builds/slave/test', 08:30:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:30:31 INFO - 'RUST_BACKTRACE': '1', 08:30:31 INFO - 'SHELL': '/bin/bash', 08:30:31 INFO - 'SHLVL': '1', 08:30:31 INFO - 'TERM': 'linux', 08:30:31 INFO - 'TMOUT': '86400', 08:30:31 INFO - 'USER': 'cltbld', 08:30:31 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1488990561.699894-543194811', 08:30:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:31 INFO - '_': '/tools/buildbot/bin/python'} 08:30:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aC-0RQJ6Sde-4mUvuw1v-Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:30:31 INFO - mozversion application_buildid: 20170308153659 08:30:31 INFO - mozversion application_changeset: ae315069c70eb5fe7da4dd2b158b3eee3ca9b94a 08:30:31 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:30:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:30:31 INFO - mozversion application_name: Firefox 08:30:31 INFO - mozversion application_remotingname: firefox-dev 08:30:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:30:31 INFO - mozversion application_vendor: Mozilla 08:30:31 INFO - mozversion application_version: 54.0a2 08:30:31 INFO - mozversion platform_buildid: 20170308153659 08:30:31 INFO - mozversion platform_changeset: ae315069c70eb5fe7da4dd2b158b3eee3ca9b94a 08:30:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:30:31 INFO - mozversion platform_version: 54.0a2 08:30:31 INFO - using testdate: 1488990631 08:30:31 INFO - actual date: 1488990631 08:30:31 INFO - starting webserver on 'localhost:35540' 08:30:31 INFO - SUITE-START | Running 2 tests 08:30:31 INFO - TEST-START | dromaeo_css 08:30:31 INFO - operating with platform_type : linux_ 08:30:31 INFO - Initialising browser for dromaeo_css test... 08:30:31 INFO - TEST-INFO | started process 1751 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIxZdKB/profile http://localhost:35540/getInfo.html) 08:30:35 INFO - PROCESS | 1751 | __metrics Screen width/height:1600/1200 08:30:35 INFO - PROCESS | 1751 | colorDepth:24 08:30:35 INFO - PROCESS | 1751 | Browser inner width/height: 1024/697 08:30:35 INFO - PROCESS | 1751 | __metrics 08:30:36 INFO - PROCESS | 1751 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:30:36 INFO - PROCESS | 1751 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:30:37 INFO - PROCESS | 1751 | console.error: PushService: 08:30:37 INFO - PROCESS | 1751 | stateChangeProcessEnqueue: Error transitioning state 08:30:37 INFO - PROCESS | 1751 | UnknownError 08:30:37 INFO - TEST-INFO | 1751: exit 0 08:30:37 INFO - Browser initialized. 08:30:37 INFO - Running cycle 1/1 for dromaeo_css test... 08:30:37 INFO - TEST-INFO | started process 1838 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIxZdKB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:30:49 INFO - PROCESS | 1838 | RSS: Main: 138780672 08:30:49 INFO - PROCESS | 1838 | 08:33:51 INFO - PROCESS | 1838 | Cycle 1(1): loaded http://localhost:35540/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35540/tests/dromaeo/cssquery-ext.html) 08:33:52 INFO - PROCESS | 1838 | RSS: Main: 271564800 08:33:52 INFO - PROCESS | 1838 | 08:35:39 INFO - PROCESS | 1838 | ************************* 08:35:39 INFO - PROCESS | 1838 | A coding exception was thrown and uncaught in a Task. 08:35:39 INFO - PROCESS | 1838 | 08:35:39 ERROR - PROCESS | 1838 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:35:39 INFO - PROCESS | 1838 | Full stack: 08:35:39 INFO - PROCESS | 1838 | ************************* 08:36:54 INFO - PROCESS | 1838 | Cycle 1(1): loaded http://localhost:35540/tests/dromaeo/cssquery-ext.html (next: http://localhost:35540/tests/dromaeo/cssquery-jquery.html) 08:36:55 INFO - PROCESS | 1838 | RSS: Main: 226934784 08:36:55 INFO - PROCESS | 1838 | 08:39:57 INFO - PROCESS | 1838 | Cycle 1(1): loaded http://localhost:35540/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35540/tests/dromaeo/cssquery-mootools.html) 08:39:58 INFO - PROCESS | 1838 | RSS: Main: 190414848 08:39:58 INFO - PROCESS | 1838 | 08:42:59 INFO - PROCESS | 1838 | Cycle 1(1): loaded http://localhost:35540/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35540/tests/dromaeo/cssquery-prototype.html) 08:43:00 INFO - PROCESS | 1838 | RSS: Main: 197623808 08:43:00 INFO - PROCESS | 1838 | 08:46:03 INFO - PROCESS | 1838 | Cycle 1(1): loaded http://localhost:35540/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35540/tests/dromaeo/cssquery-yui.html) 08:46:04 INFO - PROCESS | 1838 | RSS: Main: 172728320 08:46:04 INFO - PROCESS | 1838 | 08:49:06 INFO - PROCESS | 1838 | Cycle 1(1): loaded http://localhost:35540/tests/dromaeo/cssquery-yui.html (next: http://localhost:35540/tests/dromaeo/cssquery-dojo.html) 08:49:06 INFO - PROCESS | 1838 | RSS: Main: 260149248 08:49:06 INFO - PROCESS | 1838 | 08:49:06 INFO - PROCESS | 1838 | __start_tp_report 08:49:06 INFO - PROCESS | 1838 | _x_x_mozilla_page_load 08:49:06 INFO - PROCESS | 1838 | _x_x_mozilla_page_load_details 08:49:06 INFO - PROCESS | 1838 | |i|pagename|runs| 08:49:06 INFO - PROCESS | 1838 | |0;dojo.html;3322.534845121682;3330.78349907256;3371.32573485303;3375.189954410942;3418.914527136821;5576.776928922838;5586.162075688649;5597.384287728347;5604.80383186588;5610;5707.457791509811;5773.4515221054035;5816.4765171134695;5838.795642152526;5841.591088623798;5274.393444753845;5276.050310944019;5290.603204759639;5309.41596424393;5354.41101478837;5092.770825312851;5132.794688212486;5210.791568337262;5380.031594313022;5389.245505629215;5304.018756530054;5307.920381194285;5320.122179840322;5328.147496400557;5333.57331413486;5333.679979201261;5334.199870019489;5334.3598768147685;5338.27933229013;5355.223492593552;5009.323741294915;5073.162928116893;5215.348081489814;5230.476952304739;5289.603279754034;5599.832005039855;5607.495325420732;5621.128725047624;5657.971710141464;5678;6150.569460137792;6176.96911515444;6204.534659900525;6209.3790620938;6209.844753881144;6224.37756224374;6241.126242326078;6253.7185826637915;6257.5619706620555;6260.342664020303;5475.178723191553;5503.944960550383;5722.198892155102;5759.712014399263;5796.420357964212;6302.716377763011;6333.20834895638;6347.777827776005;6347.96826015867;6361.045843123568;6110.175126357884;6126.693665316806;6126.724297406628;6130.233720784902;6133.325334213233;5944.791932282349;5999.430054144849;6110.022396416552;6139.631622102688;6215.564910456315;6126.895025200522;6127.383771656488;6173.783917562864;6176.073588961692;6184.567080304336;5926.940730592725;5949.970250148722;6116.449519543263;6137.144455097482;6142.477889379364;4543.772811359485;4638.443386793607;4658.976705116453;4665.906681866344;4670.136024835417;4191.392248124005;4226.1336426032585;4227.217964676544;4229.534751177368;4250.489941207075;5707.200991861143;5739.713014349266;5885.646861188342;5926.851828704317;6046.486048685911;6226.377362263828;6235.438810507076;6243.469305109026;6250.312465628777;6253.874922501615;5984.251968503937;5989.580729348991;5995.820125396245;5998.850028749316;6032.366601506778;5081.136206844772;5109.335786347751;5205.063088644005;5271.4464981176425;5271.499207575274;6444.677766111582;6482.67586620667;6495.2855185928565;6495.805125846232;6503;6136.23297087864;6206.379362063757;6216;6219.346968568235;6245.500359971101;6147.139400483847;6182.289036760651;6506.642134682638;6506.707198175999;6510.576812507172;6042.607230530001;6057.212562366864;6138.9095594588325;6146.846328841814;6153.569250152446;6244.594101383395;6245.219347581552;6245.6252624842655;6249.6562689052535;6250.781222657185;5821.7089145543405;6028.216331876828;6086.60437071589;6087.604305720114;6087.995480745627;5915.290165180206;5985.072313791369;6017.247844019497;6072.028475443908;6120.08198770188;6058.909116363347;6068.6358818471035;6071.666058366833;6074.149619053424;6075.331713511422;5861.062230043172;5895.882082358415;5978.163057171912;6094.603850749687;6115.8776824462375;5771.7402716877;5920.052791553331;5969.73136208863;5973.611715238496;5982.371850955587 08:49:06 INFO - PROCESS | 1838 | |1;ext.html;779.2986312318912;838.6310023589621;858.3004851046398;909.0182602788989;929.5445231836402;31195;31588;43687.344689829675;44116.55883441173;44250.33624495635;41752.37371439431;46171.07657846841;46197.769011154895;46214.768926155324;46263.30605040927;8944.284457243404;9059.411138276024;9072.863907041366;9077.727668169966;9081;7535.54786712799;7649.732259370923;10459.68620941373;10633.202509811756;10941.070009049201;10600.363978161335;10660.680179594587;10669.359838409682;10676.199285053613;10677;10547.208959328005;10579.788404231911;10585.311954722918;10600.416977066257;10625.415602141878;10358.896411035945;10366.274360794747;10367.429791361472;10368.377897326185;10413.16694664425;41914.79042604767;42306.57693423057;42324.57675423268;42331.1533769326;42335;3606;3645.325614761251;3670;3688.612695666943;3777.924441511182;27550.862245688844;27761.583576246372;27862.442751145067;28239.717602823916;28298.575521367195;4292.24885645014;4307;4322.184722298401;4340.761258130801;4418.602325790662;218558;218773;220026.9999999984;220091;220411;52541;52815.73592132015;52981.47018529842;52982.73508632509;53048.204276935874;55196.72401638047;55620;55782;55806.44193558094;55866.72066639641;15831.841681583037;16237.837621623868;16249.512514624581;16290.755638665429;16318;14320.57038288853;14327.498537551135;14345.426182952773;14365.13809171453;14372.281385930663;11533.365664888344;11711.414429278502;11812.055035597303;12034.157608967464;12382.81425778614;4806.822460525844;4891.486393928586;4899.424212966467;4904.137335801217;4941.50584941503;943.8159558885951;947.9620815167455;952.547539918547;972.7811242470387;977.5503268496429;25330.620040699403;26971;27028.189154325402;27652.723472765014;28844.711552884623;1101.3116801998751;1165.0970497864053;1184.9289042657467;1212.6301478049104;1219.1222319929636;15629.06225626466;16558.172091395383;16734.74897876533;17187.3984410545;17554.824451755576;337792;338196;338769;339087;339565;56404.153937690964;56604.71697641568;56727.71636141793;56734.71632641811;56775;1549.2795849929612;1574.0634322578048;1576.188263044533;1598.9040657560583;1609.1793185475492;29816.850915745283;31005.68994310028;31360.215994600316;31592.684073158973;31600;44027.33958990554;44356.112877741616;44413.33379999367;44437.666869993955;44563.331550027426;312503;313110;313206;313232;313447;36231;36835.447468288534;36875.81562092173;36879.26241475209;37029.44455833111;44248.55751442444;44432;44479;45431;45445.318320224564;35627;36410.45384319184;36486;36608.81695591612;36666.26667466689;36589.81705091564;36976.81511592425;37258.813705931294;37290;37472.063198419164;38602.227955441296;38825.61174388333;38846;39351.40972885352;39362.80318598389;31640.525392119598;33390.16524586808;33423.49864752079;33540.32919341648;33604.49593256152;25814.017933137133;25891.741082588935;25951.351216219744;26038.609420858324;26107.335131208783 08:49:06 INFO - PROCESS | 1838 | |2;jquery.html;393.278334256639;461.52924017502147;462.45892306001997;470.8022630495192;471.053183101965;18904.24383024679;19388.41834744958;21543.784562154393;21822.781772182312;21857.781422185773;21323.147074117016;21594.24420145295;21917.452063698416;22268.99789509472;22276.88861555694;6670.099536562575;6772.119624448815;6779.423748981342;6846.589204647712;6884.0362349271145;4234.1955028544635;6753.493487988396;6837.65811709415;6857.3828355448;6860.382565569098;7321.231270716578;7560.130584982742;7595.848083038336;7598.1262154852075;7599.696012159507;7515.286047825475;7610.315071643523;7684.077910650702;7705.4220933430215;7761.41789365797;7370.152432470281;7479.887801682979;7486.513376630502;7494.437917156235;7518.924810751877;23649.29052128439;24118.638220426707;24172;25422.36444088894;25633.871830640914;3026.788124831263;3039.7720170987045;3140.5917230759856;3210.1493104327374;3434.845431955568;14700.191489468076;14959.252037398086;15418.691626167527;16095.758563621555;16331.673366532603;2125.2880285104507;2168.92408765694;2173.1959175105153;2214.966775498369;2222.7888350606668;116202.41898790536;117032;120397;123322;123656.38171809174;14025.954176597284;15598;18047.729284060748;18085.7287140693;18327.725084123747;31279.68720312813;31341.843290783858;31480.212994674857;31487.84256078705;31918.36163276768;9756;9792.167665748491;9877.357971731815;9996.450195239186;10097.899021009844;8735.25750311218;8775.166359195866;8786.560671966376;8829.205371516595;9028.413153145024;9123.224525915239;9174.770630734152;9249.537523123818;9299.116583924517;9555.61777528891;3733.4213196954515;3806.885793426202;3848.3650197717625;4027.838886444509;4081.77550234734;934.7149119518476;936.442816524167;950.3822515365068;956.6938579654583;958.8082383523323;19817.405477835688;21025.474363141046;21128.78871211268;21371.893140534197;21411.8929405352;936.8969413364524;939.2579861909152;944.6457578408097;948;951.9861347664715;10946.56213751457;11649.825252621218;11654.592089276835;11713.648590542298;11826.349550774617;468167;469986;621710;723261;724382;104335.99999999849;116484;123438;125015.37492312663;125041.37479312545;1311.7901135818415;1320.4982106799546;1323.219300612643;1341.2086868747485;1342.1410297409666;14114.2942852859;17617.383391581745;18329.175187116343;18947.621047579247;18963;46894.29658555056;47643;51113.48886511236;51886;53098.20352694635;67888.6605566969;68155.65922170358;68189.65905170442;68807.31192688209;69028;7675.5010924289745;10814.972577605115;11044.613438529614;11878.82181767257;11963.76072478563;8666.610002549774;12571;12861.678458038625;12914.547990820276;12950.417231224428;10636.468176591294;10988.835167472334;11557.30656160633;11717.531298747954;11752.412379381169;10647.840282395615;10697.304675196086;10760.354378736987;11090.500927458123;11130.443477826238;11253.388447080293;11285.774284514428;11488.080953523531;11488.712782180512;11952.402379880798;11706.35615041181;11788.70528236801;11886.405679716152;11914.463849126983;12151.75696486083;11605.419729013347;11794.174407791372;11797.17419780607;12072.39638018078;12156.088293377856 08:49:06 INFO - PROCESS | 1838 | |3;mootools.html;1577.5346272849508;1588.3884704388813;1601.8638415734658;1602.4551652438172;1618.7410014397692;10787.514561844717;11549.826752598707;11612.419379031056;11617.767644647101;11641.12691548135;10902.345859248431;11266.098712103032;11279.436028198577;11286.548538058489;11311;2459.8032157427406;2494.738052504488;2505.812064095191;2512.321673148249;2512.321673148258;2370.5021945391404;2427.623718323654;2433.7931275841574;2436.1595249638935;2437.695288088989;2260.819134469247;2268.943276418086;2271.4207876991345;2275.4311422144465;2279.5440911817705;2279.6466547685136;2306.4810417655976;2313.7223533176043;2314.109068008812;2315.2591170825344;2331.6269396896587;2380.1074597026113;2409.6987876515436;2415.0460568075687;2419.7701218384227;11613.88386116145;11766.176367654267;11780.352080635561;11780.70548236301;11806.527738890434;5885.028970219909;6011.669358185298;6017.939820601781;6031.155638210654;6043.1841701370195;3462.8614855405754;3514.7188224941942;3536.2927414516944;3570.2145527983803;3621.7283703722064;1386.9098508596908;1387.5767890793304;1391.8816900563363;1471.2349578219266;1472.9158241088846;16928.322867085302;17486.47540573785;17652.20565074562;17694.91152544229;17741.911290443593;4793.760311984387;4815.22956326986;4836.202026665631;4904.950950490449;5027.4218464877;12642.431090600945;12644.747105057848;12675.49298028087;12691.936540317423;12737.044721645914;5843.298804143445;5857.20927674767;5857.88284234313;5864.413558644187;5867.677277749679;5415.972920135453;5460.235567020621;5467.644603100785;5471.863203419866;5569;3988.4814974053766;4050.7164498485413;4076.3681629347498;4110;4139.441175441337;1049.2864851900629;1052.4685034057904;1056.070657821128;1064.6273804168634;1071.3732466507024;981.3964411886639;995.9502024898871;1013.8276492996208;1014.9898501015043;1015.1472762879217;6740.325967403319;6742.831429214309;6931.58230879779;6943.166819981533;7077.823054423578;1043.994780026095;1058.767071244325;1068.433730123036;1069.652362982034;1074.6937122920087;4536.637069034469;4610.2854057621125;4629.421322334708;4632.652551058684;4679.64902632304;14469.565913022416;14835.258237088103;15118;15141.545753627408;15155.469558565617;12486.562970295996;13966.790498142536;14267.928660356632;14328.570142895522;14971.40114395412;9256.90743092574;10104.292699510963;10164.949175254224;10426;10528.789424211625;6856.965715171392;6958.095447591781;7030.894536582057;7041.788746337618;7420.5176663516695;12629.368531573567;12851.907587855138;12867.806982895452;12925.741485170432;13278.402471888981;12869.678258043623;12906.806397904227;12929.676758081123;13094.672633183865;13243;9513.762155946157;9788.657396991071;9796.167325777104;9802.166815820736;9812.754681133028;10478.266521343738;10498.370097794157;10566.260361774603;10600.575976960836;10654.73363165896;8954.731358059269;9071.546422678708;9094.909050909406;9119.224865886208;9198.632054718004;9173.724788256362;9221.953890230507;9309.162175404246;9331.580078896603;9331.86002209981;7619.809504762426;7746.49647772893;7750.263724946121;7754.495957762728;7766.262205090507;5642.125470552071;5726.341470730919;5823.941760582509;5825.621334613236;5881.353051164454;5843.29880414353;5906.232189815297;5955.40445955401;5976.7908123215475;6179.474744646755 08:49:06 INFO - PROCESS | 1838 | |4;prototype.html;390.7982952421305;408.84668249406474;418.9120284740204;420.1680672268909;426.76314645371804;5097.439281679017;5136.91954758323;5161.612879034069;5168.896622067557;5188.299579556754;4960.6527543072;5013.21766419637;5032.817287937341;5061.266116413118;5121.308623335858;4393.187260356836;4420.270655341865;4425.557444255564;4438.312061630452;4445.199864024475;4424.3142312941545;4439.2254840724545;4450.310201918708;4462.598366147046;4464.196444639963;4358.8910277243;4419.160359531695;4447.466304043519;4453.330001249531;4476.731396116227;4439.267520859071;4440.24515832306;4447.444069491314;4455.131249406367;4484.596386325214;4272.081502476983;4289.549597292271;4290.528041915387;4291.97854010731;4292.377605247221;4798.304245884362;4939.950600493985;4990.4011518617635;5016.262884151294;5021.497850214986;5105.617078719111;5137.357830271216;5155.896882062375;5162.19985902182;5164.734640013221;5397.379301380313;5403.2165336026055;5408.729563521808;5426.348838139409;5431.375391829951;4633.6061434778085;4731.858044258678;4753.786079626425;4788.688735232199;4793.675067592215;5370.838874833761;5458.863528411822;5494.395616482184;5612.915806262909;5654.491095801398;4857.295692124622;4881.414230292387;4896.681715688469;4911.435184953704;4924.482929292372;4746.71838603582;4812.807487700453;4967.975160124176;5002.349694539759;5028;4801.783919723621;4993.300937868701;5120.897582048338;5129.7175706073485;5149.330587023663;5366.095036262149;5367.382750983609;5369.114096174166;5379.112446446371;5383.730813459311;1653.2725600735637;1696.4571337171988;1702.569841333286;1717.931282748676;1726.9740953885703;1398.5175713743465;1402.6703724624706;1427.635952832042;1438.266484093099;1440.8703216710546;5232.215167724872;5234.528892399702;5253.185756207794;5257.342832145981;5298.81454149103;5474.206240095164;5479.739659878171;5487.2317875497465;5498.75573411689;5530.870614813326;5041.218611115283;5074.934263804643;5101.846944591668;5210;5242.40106767432;2860;2863.9427211455654;2872.8707208175683;2890.2629829393372;2891.8698658560415;5624.746886390122;5635.380108188178;5651.350094739076;5676.744546495418;5690;5317.707526086102;5623.775048997994;5633.239512665819;5636.859078522988;5637.971810141005;5694.9782827096615;5706.28671416073;5706.885862282731;5707.828765136969;5708.31500219968;5283.603729720363;5507.669539827623;5515.573147814948;5551.389347171888;5554;5231.659942103751;5428.430014848384;5486.845064088245;5540.390557038803;5554.111342185231;5503.449655034625;5527.595495959271;5558.861028474321;5569.081101618188;5588.944110559005;4561.654311978041;4592.311153327028;4598.908021839611;4600.470945841271;4631.564215093332;5398.379186393615;5459.12653975362;5466.699331536804;5487.64330318528;5528.834134975958;5343.7862485500145;5360.919586206132;5364.195370694427;5377.516023557899;5384.407715151252;5326.416687906285;5360;5372.865678358073;5383.981007122329;5415.377231618414;5130.23474410672;5308.25684404176;5319.813806516908;5347.657713928795;5354.491323324278;5278.81524146653;5374.704391258519;5394.973025134849;5397.8110766123;5411.458854114557;5246.344206974129;5247.239150323106;5249.186376111708;5273.973630131824;5276.182191760283 08:49:06 INFO - PROCESS | 1838 | |5;yui.html;800.2997377294867;851.5359129274544;878.8198419324038;885.712143553345;919.3734345803682;16941.576460588476;17929.820701792978;18101.09494525275;18133.546661333472;18200.180991855366;16450.670986580262;16476.83523164768;16600.58498537537;17074.31702731889;17709.29162833485;880.0935036911959;893.8525143351355;896.6727144592243;915.8122584870085;922.8200500902293;888.2760550151605;888.9733308000738;890.9866352004725;891.131147131548;891.7993451473432;956.5312996631635;956.8373376525973;957.5882370580682;957.6169532187112;958.6261358070358;953.3898305084751;955.1403736637047;955.1880901233931;955.2405837359281;956.3879117364892;701.5404909784048;703.2510376449065;703.9049728286718;703.96480175991;704.6124631452732;17809.821901781077;17926.372576959744;17991.820081799277;18394.63210735778;18606.34877779285;17472.91263543674;17534.29862805486;17819.910900445546;17886.195121219578;18181.54546136344;13668.316584170752;14177.503787367496;14308.785368219485;14317.35571899267;14366.138031718026;4159.896002599929;4197.412362269285;4223.429836972;4293.377460268243;4329.935050974238;92185;93416;94018;95778.52110739471;97115;12492.68768280782;12498.375081245902;12705.364731763375;12767.744645107046;12801.167924084904;27037.324066898484;27180.864095679393;27235;27246.45507089847;27277;8753.387262891663;8784.824303513893;9062.81874362509;9095.454272743656;9118.042605526456;4914.606831453475;5046.066477701637;5073.746312684351;5094.465081166498;5111.667741596784;3862.729608927348;3958;3975.1453437511072;3990.700697447703;3997.4603428537357;590.6367583935848;597.310106826616;603.6317846113867;611.1169360274449;612.7089632424563;816.6610856494489;828.8590939540293;847.6058632735808;855.6577369052304;875.4528419737663;11006.38826038521;11449.656510304705;11594.71013224676;11815.672328467232;11820.527178912747;825.0594322472386;825.3397282174236;845.5856630251133;849.6176720475687;862.3101518784947;5330.333708286465;5342.91985620216;5361.651492652965;5670.291213598301;6105.175801266772;81783;82734;84597.57701211455;85410;87582.56208719042;46271.76864115658;73016.26983730095;74346.62826685832;75689.24310756932;76276.23723762692;39492.60507394889;52705.736471317396;59534.70232648809;59562.40437595742;59775.701121494116;10972.835407468734;11314.15143864197;11505;11558;11715;41206.587934120274;41597.37603936004;41606.167876641695;42089.78955105205;42358.78820605877;47493.287600685326;49004;49539.50460495349;50101.24848127208;50415.74792126016;13329.466821327425;13496.460141594227;13536.323183840965;13599.660008499866;13885.652858678613;16232;16599.91700041492;17357.65284694324;17562.12189390551;17632.294708211528;15236.542903712907;15338.386464541294;15608;16354.591135221715;16355;14932.328045238208;14933.253337333308;15621.297041633381;15806.920965395559;15841.68316633684;14679.486217982747;14855.92572037133;14910.77633835515;16035.118068506345;16064.678706425571;11697.23967942081;11984.880151198377;12289.324087175291;12426.81359779586;12527.060470464568;11737.178397512092;11835.763284734085;11851.644450666494;11887.643370698894;12131.818022729489 08:49:06 INFO - PROCESS | 1838 | __end_tp_report 08:49:06 INFO - PROCESS | 1838 | __start_cc_report 08:49:06 INFO - PROCESS | 1838 | _x_x_mozilla_cycle_collect,1286 08:49:06 INFO - PROCESS | 1838 | __end_cc_report 08:49:06 INFO - PROCESS | 1838 | __startTimestamp1488991746878__endTimestamp 08:49:06 INFO - PROCESS | 1838 | 08:49:06 INFO - PROCESS | 1838 | ------- Summary: start ------- 08:49:06 INFO - PROCESS | 1838 | Number of tests: 6 08:49:06 INFO - PROCESS | 1838 | 08:49:06 INFO - PROCESS | 1838 | [#0] dojo.html Cycles:165 Average:5733.06 Median:5984.25 stddev:662.51 (11.1%) stddev-sans-first:636.99 08:49:06 INFO - PROCESS | 1838 | Values: 3322.5 3330.8 3371.3 3375.2 3418.9 5576.8 5586.2 5597.4 5604.8 5610.0 5707.5 5773.5 5816.5 5838.8 5841.6 5274.4 5276.1 5290.6 5309.4 5354.4 5092.8 5132.8 5210.8 5380.0 5389.2 5304.0 5307.9 5320.1 5328.1 5333.6 5333.7 5334.2 5334.4 5338.3 5355.2 5009.3 5073.2 5215.3 5230.5 5289.6 5599.8 5607.5 5621.1 5658.0 5678.0 6150.6 6177.0 6204.5 6209.4 6209.8 6224.4 6241.1 6253.7 6257.6 6260.3 5475.2 5503.9 5722.2 5759.7 5796.4 6302.7 6333.2 6347.8 6348.0 6361.0 6110.2 6126.7 6126.7 6130.2 6133.3 5944.8 5999.4 6110.0 6139.6 6215.6 6126.9 6127.4 6173.8 6176.1 6184.6 5926.9 5950.0 6116.4 6137.1 6142.5 4543.8 4638.4 4659.0 4665.9 4670.1 4191.4 4226.1 4227.2 4229.5 4250.5 5707.2 5739.7 5885.6 5926.9 6046.5 6226.4 6235.4 6243.5 6250.3 6253.9 5984.3 5989.6 5995.8 5998.9 6032.4 5081.1 5109.3 5205.1 5271.4 5271.5 6444.7 6482.7 6495.3 6495.8 6503.0 6136.2 6206.4 6216.0 6219.3 6245.5 6147.1 6182.3 6506.6 6506.7 6510.6 6042.6 6057.2 6138.9 6146.8 6153.6 6244.6 6245.2 6245.6 6249.7 6250.8 5821.7 6028.2 6086.6 6087.6 6088.0 5915.3 5985.1 6017.2 6072.0 6120.1 6058.9 6068.6 6071.7 6074.1 6075.3 5861.1 5895.9 5978.2 6094.6 6115.9 5771.7 5920.1 5969.7 5973.6 5982.4 08:49:06 INFO - PROCESS | 1838 | 08:49:06 INFO - PROCESS | 1838 | [#1] ext.html Cycles:180 Average:46485.77 Median:19616.50 stddev:77120.23 (393.1%) stddev-sans-first:77260.21 08:49:06 INFO - PROCESS | 1838 | Values: 779.3 838.6 858.3 909.0 929.5 31195.0 31588.0 43687.3 44116.6 44250.3 41752.4 46171.1 46197.8 46214.8 46263.3 8944.3 9059.4 9072.9 9077.7 9081.0 7535.5 7649.7 10459.7 10633.2 10941.1 10600.4 10660.7 10669.4 10676.2 10677.0 10547.2 10579.8 10585.3 10600.4 10625.4 10358.9 10366.3 10367.4 10368.4 10413.2 41914.8 42306.6 42324.6 42331.2 42335.0 3606.0 3645.3 3670.0 3688.6 3777.9 27550.9 27761.6 27862.4 28239.7 28298.6 4292.2 4307.0 4322.2 4340.8 4418.6 218558.0 218773.0 220027.0 220091.0 220411.0 52541.0 52815.7 52981.5 52982.7 53048.2 55196.7 55620.0 55782.0 55806.4 55866.7 15831.8 16237.8 16249.5 16290.8 16318.0 14320.6 14327.5 14345.4 14365.1 14372.3 11533.4 11711.4 11812.1 12034.2 12382.8 4806.8 4891.5 4899.4 4904.1 4941.5 943.8 948.0 952.5 972.8 977.6 25330.6 26971.0 27028.2 27652.7 28844.7 1101.3 1165.1 1184.9 1212.6 1219.1 15629.1 16558.2 16734.7 17187.4 17554.8 337792.0 338196.0 338769.0 339087.0 339565.0 56404.2 56604.7 56727.7 56734.7 56775.0 1549.3 1574.1 1576.2 1598.9 1609.2 29816.9 31005.7 31360.2 31592.7 31600.0 44027.3 44356.1 44413.3 44437.7 44563.3 312503.0 313110.0 313206.0 313232.0 313447.0 36231.0 36835.4 36875.8 36879.3 37029.4 44248.6 44432.0 44479.0 45431.0 45445.3 35627.0 36410.5 36486.0 36608.8 36666.3 36589.8 36976.8 37258.8 37290.0 37472.1 38602.2 38825.6 38846.0 39351.4 39362.8 31640.5 33390.2 33423.5 33540.3 33604.5 25814.0 25891.7 25951.4 26038.6 26107.3 08:49:06 INFO - PROCESS | 1838 | 08:49:06 INFO - PROCESS | 1838 | [#2] jquery.html Cycles:180 Average:36026.63 Median:24145.32 stddev:101578.00 (420.7%) stddev-sans-first:101827.71 08:49:06 INFO - PROCESS | 1838 | Values: 393.3 461.5 462.5 470.8 471.1 18904.2 19388.4 21543.8 21822.8 21857.8 21323.1 21594.2 21917.5 22269.0 22276.9 6670.1 6772.1 6779.4 6846.6 6884.0 4234.2 6753.5 6837.7 6857.4 6860.4 7321.2 7560.1 7595.8 7598.1 7599.7 7515.3 7610.3 7684.1 7705.4 7761.4 7370.2 7479.9 7486.5 7494.4 7518.9 23649.3 24118.6 24172.0 25422.4 25633.9 3026.8 3039.8 3140.6 3210.1 3434.8 14700.2 14959.3 15418.7 16095.8 16331.7 2125.3 2168.9 2173.2 2215.0 2222.8 116202.4 117032.0 120397.0 123322.0 123656.4 14026.0 15598.0 18047.7 18085.7 18327.7 31279.7 31341.8 31480.2 31487.8 31918.4 9756.0 9792.2 9877.4 9996.5 10097.9 8735.3 8775.2 8786.6 8829.2 9028.4 9123.2 9174.8 9249.5 9299.1 9555.6 3733.4 3806.9 3848.4 4027.8 4081.8 934.7 936.4 950.4 956.7 958.8 19817.4 21025.5 21128.8 21371.9 21411.9 936.9 939.3 944.6 948.0 952.0 10946.6 11649.8 11654.6 11713.6 11826.3 468167.0 469986.0 621710.0 723261.0 724382.0 104336.0 116484.0 123438.0 125015.4 125041.4 1311.8 1320.5 1323.2 1341.2 1342.1 14114.3 17617.4 18329.2 18947.6 18963.0 46894.3 47643.0 51113.5 51886.0 53098.2 67888.7 68155.7 68189.7 68807.3 69028.0 7675.5 10815.0 11044.6 11878.8 11963.8 8666.6 12571.0 12861.7 12914.5 12950.4 10636.5 10988.8 11557.3 11717.5 11752.4 10647.8 10697.3 10760.4 11090.5 11130.4 11253.4 11285.8 11488.1 11488.7 11952.4 11706.4 11788.7 11886.4 11914.5 12151.8 11605.4 11794.2 11797.2 12072.4 12156.1 08:49:06 INFO - PROCESS | 1838 | 08:49:06 INFO - PROCESS | 1838 | [#3] mootools.html Cycles:180 Average:7058.56 Median:2412.37 stddev:4541.51 (188.3%) stddev-sans-first:4535.58 08:49:06 INFO - PROCESS | 1838 | Values: 1577.5 1588.4 1601.9 1602.5 1618.7 10787.5 11549.8 11612.4 11617.8 11641.1 10902.3 11266.1 11279.4 11286.5 11311.0 2459.8 2494.7 2505.8 2512.3 2512.3 2370.5 2427.6 2433.8 2436.2 2437.7 2260.8 2268.9 2271.4 2275.4 2279.5 2279.6 2306.5 2313.7 2314.1 2315.3 2331.6 2380.1 2409.7 2415.0 2419.8 11613.9 11766.2 11780.4 11780.7 11806.5 5885.0 6011.7 6017.9 6031.2 6043.2 3462.9 3514.7 3536.3 3570.2 3621.7 1386.9 1387.6 1391.9 1471.2 1472.9 16928.3 17486.5 17652.2 17694.9 17741.9 4793.8 4815.2 4836.2 4905.0 5027.4 12642.4 12644.7 12675.5 12691.9 12737.0 5843.3 5857.2 5857.9 5864.4 5867.7 5416.0 5460.2 5467.6 5471.9 5569.0 3988.5 4050.7 4076.4 4110.0 4139.4 1049.3 1052.5 1056.1 1064.6 1071.4 981.4 996.0 1013.8 1015.0 1015.1 6740.3 6742.8 6931.6 6943.2 7077.8 1044.0 1058.8 1068.4 1069.7 1074.7 4536.6 4610.3 4629.4 4632.7 4679.6 14469.6 14835.3 15118.0 15141.5 15155.5 12486.6 13966.8 14267.9 14328.6 14971.4 9256.9 10104.3 10164.9 10426.0 10528.8 6857.0 6958.1 7030.9 7041.8 7420.5 12629.4 12851.9 12867.8 12925.7 13278.4 12869.7 12906.8 12929.7 13094.7 13243.0 9513.8 9788.7 9796.2 9802.2 9812.8 10478.3 10498.4 10566.3 10600.6 10654.7 8954.7 9071.5 9094.9 9119.2 9198.6 9173.7 9222.0 9309.2 9331.6 9331.9 7619.8 7746.5 7750.3 7754.5 7766.3 5642.1 5726.3 5823.9 5825.6 5881.4 5843.3 5906.2 5955.4 5976.8 6179.5 08:49:06 INFO - PROCESS | 1838 | 08:49:06 INFO - PROCESS | 1838 | [#4] prototype.html Cycles:180 Average:4740.30 Median:5163.47 stddev:1213.08 (23.5%) stddev-sans-first:1171.73 08:49:06 INFO - PROCESS | 1838 | Values: 390.8 408.8 418.9 420.2 426.8 5097.4 5136.9 5161.6 5168.9 5188.3 4960.7 5013.2 5032.8 5061.3 5121.3 4393.2 4420.3 4425.6 4438.3 4445.2 4424.3 4439.2 4450.3 4462.6 4464.2 4358.9 4419.2 4447.5 4453.3 4476.7 4439.3 4440.2 4447.4 4455.1 4484.6 4272.1 4289.5 4290.5 4292.0 4292.4 4798.3 4940.0 4990.4 5016.3 5021.5 5105.6 5137.4 5155.9 5162.2 5164.7 5397.4 5403.2 5408.7 5426.3 5431.4 4633.6 4731.9 4753.8 4788.7 4793.7 5370.8 5458.9 5494.4 5612.9 5654.5 4857.3 4881.4 4896.7 4911.4 4924.5 4746.7 4812.8 4968.0 5002.3 5028.0 4801.8 4993.3 5120.9 5129.7 5149.3 5366.1 5367.4 5369.1 5379.1 5383.7 1653.3 1696.5 1702.6 1717.9 1727.0 1398.5 1402.7 1427.6 1438.3 1440.9 5232.2 5234.5 5253.2 5257.3 5298.8 5474.2 5479.7 5487.2 5498.8 5530.9 5041.2 5074.9 5101.8 5210.0 5242.4 2860.0 2863.9 2872.9 2890.3 2891.9 5624.7 5635.4 5651.4 5676.7 5690.0 5317.7 5623.8 5633.2 5636.9 5638.0 5695.0 5706.3 5706.9 5707.8 5708.3 5283.6 5507.7 5515.6 5551.4 5554.0 5231.7 5428.4 5486.8 5540.4 5554.1 5503.4 5527.6 5558.9 5569.1 5588.9 4561.7 4592.3 4598.9 4600.5 4631.6 5398.4 5459.1 5466.7 5487.6 5528.8 5343.8 5360.9 5364.2 5377.5 5384.4 5326.4 5360.0 5372.9 5384.0 5415.4 5130.2 5308.3 5319.8 5347.7 5354.5 5278.8 5374.7 5395.0 5397.8 5411.5 5246.3 5247.2 5249.2 5274.0 5276.2 08:49:06 INFO - PROCESS | 1838 | 08:49:06 INFO - PROCESS | 1838 | [#5] yui.html Cycles:180 Average:18820.16 Median:23143.60 stddev:23446.00 (101.3%) stddev-sans-first:23472.73 08:49:06 INFO - PROCESS | 1838 | Values: 800.3 851.5 878.8 885.7 919.4 16941.6 17929.8 18101.1 18133.5 18200.2 16450.7 16476.8 16600.6 17074.3 17709.3 880.1 893.9 896.7 915.8 922.8 888.3 889.0 891.0 891.1 891.8 956.5 956.8 957.6 957.6 958.6 953.4 955.1 955.2 955.2 956.4 701.5 703.3 703.9 704.0 704.6 17809.8 17926.4 17991.8 18394.6 18606.3 17472.9 17534.3 17819.9 17886.2 18181.5 13668.3 14177.5 14308.8 14317.4 14366.1 4159.9 4197.4 4223.4 4293.4 4329.9 92185.0 93416.0 94018.0 95778.5 97115.0 12492.7 12498.4 12705.4 12767.7 12801.2 27037.3 27180.9 27235.0 27246.5 27277.0 8753.4 8784.8 9062.8 9095.5 9118.0 4914.6 5046.1 5073.7 5094.5 5111.7 3862.7 3958.0 3975.1 3990.7 3997.5 590.6 597.3 603.6 611.1 612.7 816.7 828.9 847.6 855.7 875.5 11006.4 11449.7 11594.7 11815.7 11820.5 825.1 825.3 845.6 849.6 862.3 5330.3 5342.9 5361.7 5670.3 6105.2 81783.0 82734.0 84597.6 85410.0 87582.6 46271.8 73016.3 74346.6 75689.2 76276.2 39492.6 52705.7 59534.7 59562.4 59775.7 10972.8 11314.2 11505.0 11558.0 11715.0 41206.6 41597.4 41606.2 42089.8 42358.8 47493.3 49004.0 49539.5 50101.2 50415.7 13329.5 13496.5 13536.3 13599.7 13885.7 16232.0 16599.9 17357.7 17562.1 17632.3 15236.5 15338.4 15608.0 16354.6 16355.0 14932.3 14933.3 15621.3 15806.9 15841.7 14679.5 14855.9 14910.8 16035.1 16064.7 11697.2 11984.9 12289.3 12426.8 12527.1 11737.2 11835.8 11851.6 11887.6 12131.8 08:49:06 INFO - PROCESS | 1838 | -------- Summary: end -------- 08:49:06 INFO - PROCESS | 1838 | 08:49:07 INFO - TEST-INFO | 1838: exit 0 08:49:07 INFO - TEST-OK | dromaeo_css | took 1116461ms 08:49:07 INFO - TEST-START | kraken 08:49:07 INFO - operating with platform_type : linux_ 08:49:07 INFO - Initialising browser for kraken test... 08:49:07 INFO - TEST-INFO | started process 2159 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT4z1f0/profile http://localhost:35540/getInfo.html) 08:49:11 INFO - PROCESS | 2159 | __metrics Screen width/height:1600/1200 08:49:11 INFO - PROCESS | 2159 | colorDepth:24 08:49:11 INFO - PROCESS | 2159 | Browser inner width/height: 1024/697 08:49:11 INFO - PROCESS | 2159 | __metrics 08:49:12 INFO - PROCESS | 2159 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:49:12 INFO - PROCESS | 2159 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:49:13 INFO - TEST-INFO | 2159: exit 0 08:49:13 INFO - Browser initialized. 08:49:13 INFO - Running cycle 1/1 for kraken test... 08:49:13 INFO - TEST-INFO | started process 2251 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT4z1f0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:49:25 INFO - PROCESS | 2251 | RSS: Main: 139087872 08:49:25 INFO - PROCESS | 2251 | 08:49:27 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:35540/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35540/tests/kraken/driver.html?testName=audio-beat-detection) 08:49:28 INFO - PROCESS | 2251 | RSS: Main: 182571008 08:49:28 INFO - PROCESS | 2251 | 08:49:31 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:35540/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35540/tests/kraken/driver.html?testName=audio-dft) 08:49:31 INFO - PROCESS | 2251 | RSS: Main: 173633536 08:49:31 INFO - PROCESS | 2251 | 08:49:34 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:35540/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35540/tests/kraken/driver.html?testName=audio-fft) 08:49:35 INFO - PROCESS | 2251 | RSS: Main: 265584640 08:49:35 INFO - PROCESS | 2251 | 08:49:37 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:35540/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35540/tests/kraken/driver.html?testName=audio-oscillator) 08:49:37 INFO - PROCESS | 2251 | RSS: Main: 172122112 08:49:37 INFO - PROCESS | 2251 | 08:49:40 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:35540/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35540/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:49:40 INFO - PROCESS | 2251 | RSS: Main: 174493696 08:49:40 INFO - PROCESS | 2251 | 08:49:43 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:35540/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35540/tests/kraken/driver.html?testName=imaging-darkroom) 08:49:44 INFO - PROCESS | 2251 | RSS: Main: 213053440 08:49:44 INFO - PROCESS | 2251 | 08:49:47 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:35540/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35540/tests/kraken/driver.html?testName=imaging-desaturate) 08:49:48 INFO - PROCESS | 2251 | RSS: Main: 205320192 08:49:48 INFO - PROCESS | 2251 | 08:49:51 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:35540/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35540/tests/kraken/driver.html?testName=json-parse-financial) 08:49:51 INFO - PROCESS | 2251 | RSS: Main: 207687680 08:49:51 INFO - PROCESS | 2251 | 08:49:53 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:35540/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35540/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:49:54 INFO - PROCESS | 2251 | RSS: Main: 170979328 08:49:54 INFO - PROCESS | 2251 | 08:49:55 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:35540/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35540/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:49:56 INFO - PROCESS | 2251 | RSS: Main: 178364416 08:49:56 INFO - PROCESS | 2251 | 08:49:58 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:35540/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35540/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:49:58 INFO - PROCESS | 2251 | RSS: Main: 187658240 08:49:58 INFO - PROCESS | 2251 | 08:50:01 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:35540/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35540/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:50:02 INFO - PROCESS | 2251 | RSS: Main: 196751360 08:50:02 INFO - PROCESS | 2251 | 08:50:04 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:35540/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35540/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:50:05 INFO - PROCESS | 2251 | RSS: Main: 192516096 08:50:05 INFO - PROCESS | 2251 | 08:50:07 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:35540/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35540/tests/kraken/driver.html?testName=ai-astar) 08:50:07 INFO - PROCESS | 2251 | RSS: Main: 244113408 08:50:07 INFO - PROCESS | 2251 | 08:50:07 INFO - PROCESS | 2251 | __start_tp_report 08:50:07 INFO - PROCESS | 2251 | _x_x_mozilla_page_load 08:50:07 INFO - PROCESS | 2251 | _x_x_mozilla_page_load_details 08:50:07 INFO - PROCESS | 2251 | |i|pagename|runs| 08:50:07 INFO - PROCESS | 2251 | |0;ai-astar;104;112;112;111;111;111;111;111;110;111 08:50:07 INFO - PROCESS | 2251 | |1;audio-beat-detection;145;115;123;151;118;116;117;116;134;116 08:50:07 INFO - PROCESS | 2251 | |2;audio-dft;161;161;160;161;160;160;160;162;160;162 08:50:07 INFO - PROCESS | 2251 | |3;audio-fft;75;75;78;119;77;77;76;76;97;77 08:50:07 INFO - PROCESS | 2251 | |4;audio-oscillator;81;81;99;81;81;82;100;81;81;102 08:50:07 INFO - PROCESS | 2251 | |5;imaging-gaussian-blur;113;113;113;121;112;113;112;113;112;113 08:50:07 INFO - PROCESS | 2251 | |6;imaging-darkroom;145;146;147;146;146;146;147;146;146;146 08:50:07 INFO - PROCESS | 2251 | |7;imaging-desaturate;93;94;94;94;95;94;94;94;94;94 08:50:07 INFO - PROCESS | 2251 | |8;json-parse-financial;55;53;54;54;54;54;55;62;54;56 08:50:07 INFO - PROCESS | 2251 | |9;json-stringify-tinderbox;54;55;55;54;53;54;54;54;54;54 08:50:07 INFO - PROCESS | 2251 | |10;stanford-crypto-aes;76;76;84;77;82;76;79;81;85;75 08:50:07 INFO - PROCESS | 2251 | |11;stanford-crypto-ccm;125;124;124;130;120;128;119;130;172;152 08:50:07 INFO - PROCESS | 2251 | |12;stanford-crypto-pbkdf2;159;161;162;162;164;160;159;159;165;158 08:50:07 INFO - PROCESS | 2251 | |13;stanford-crypto-sha256-iterative;67;60;65;60;61;62;70;59;59;59 08:50:07 INFO - PROCESS | 2251 | __end_tp_report 08:50:07 INFO - PROCESS | 2251 | __start_cc_report 08:50:07 INFO - PROCESS | 2251 | _x_x_mozilla_cycle_collect,1676 08:50:07 INFO - PROCESS | 2251 | __end_cc_report 08:50:07 INFO - PROCESS | 2251 | __startTimestamp1488991807402__endTimestamp 08:50:07 INFO - PROCESS | 2251 | 08:50:07 INFO - PROCESS | 2251 | ------- Summary: start ------- 08:50:07 INFO - PROCESS | 2251 | Number of tests: 14 08:50:07 INFO - PROCESS | 2251 | 08:50:07 INFO - PROCESS | 2251 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:2.32 (2.1%) stddev-sans-first:0.60 08:50:07 INFO - PROCESS | 2251 | Values: 104.0 112.0 112.0 111.0 111.0 111.0 111.0 111.0 110.0 111.0 08:50:07 INFO - PROCESS | 2251 | 08:50:07 INFO - PROCESS | 2251 | [#1] audio-beat-detection Cycles:10 Average:125.10 Median:120.50 stddev:13.40 (11.1%) stddev-sans-first:12.13 08:50:07 INFO - PROCESS | 2251 | Values: 145.0 115.0 123.0 151.0 118.0 116.0 117.0 116.0 134.0 116.0 08:50:07 INFO - PROCESS | 2251 | 08:50:07 INFO - PROCESS | 2251 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 08:50:07 INFO - PROCESS | 2251 | Values: 161.0 161.0 160.0 161.0 160.0 160.0 160.0 162.0 160.0 162.0 08:50:07 INFO - PROCESS | 2251 | 08:50:07 INFO - PROCESS | 2251 | [#3] audio-fft Cycles:10 Average:82.70 Median:77.00 stddev:14.34 (18.6%) stddev-sans-first:14.93 08:50:07 INFO - PROCESS | 2251 | Values: 75.0 75.0 78.0 119.0 77.0 77.0 76.0 76.0 97.0 77.0 08:50:07 INFO - PROCESS | 2251 | 08:50:07 INFO - PROCESS | 2251 | [#4] audio-oscillator Cycles:10 Average:86.90 Median:81.00 stddev:9.30 (11.5%) stddev-sans-first:9.62 08:50:07 INFO - PROCESS | 2251 | Values: 81.0 81.0 99.0 81.0 81.0 82.0 100.0 81.0 81.0 102.0 08:50:07 INFO - PROCESS | 2251 | 08:50:07 INFO - PROCESS | 2251 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:113.00 stddev:2.68 (2.4%) stddev-sans-first:2.83 08:50:07 INFO - PROCESS | 2251 | Values: 113.0 113.0 113.0 121.0 112.0 113.0 112.0 113.0 112.0 113.0 08:50:07 INFO - PROCESS | 2251 | 08:50:07 INFO - PROCESS | 2251 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.44 08:50:07 INFO - PROCESS | 2251 | Values: 145.0 146.0 147.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 08:50:07 INFO - PROCESS | 2251 | 08:50:07 INFO - PROCESS | 2251 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 08:50:07 INFO - PROCESS | 2251 | Values: 93.0 94.0 94.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 08:50:07 INFO - PROCESS | 2251 | 08:50:07 INFO - PROCESS | 2251 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:54.50 stddev:2.56 (4.7%) stddev-sans-first:2.71 08:50:07 INFO - PROCESS | 2251 | Values: 55.0 53.0 54.0 54.0 54.0 54.0 55.0 62.0 54.0 56.0 08:50:07 INFO - PROCESS | 2251 | 08:50:07 INFO - PROCESS | 2251 | [#9] json-stringify-tinderbox Cycles:10 Average:54.10 Median:54.00 stddev:0.57 (1.1%) stddev-sans-first:0.60 08:50:07 INFO - PROCESS | 2251 | Values: 54.0 55.0 55.0 54.0 53.0 54.0 54.0 54.0 54.0 54.0 08:50:07 INFO - PROCESS | 2251 | 08:50:07 INFO - PROCESS | 2251 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:80.00 stddev:3.67 (4.6%) stddev-sans-first:3.71 08:50:07 INFO - PROCESS | 2251 | Values: 76.0 76.0 84.0 77.0 82.0 76.0 79.0 81.0 85.0 75.0 08:50:07 INFO - PROCESS | 2251 | 08:50:07 INFO - PROCESS | 2251 | [#11] stanford-crypto-ccm Cycles:10 Average:132.40 Median:129.00 stddev:16.71 (13.0%) stddev-sans-first:17.51 08:50:07 INFO - PROCESS | 2251 | Values: 125.0 124.0 124.0 130.0 120.0 128.0 119.0 130.0 172.0 152.0 08:50:07 INFO - PROCESS | 2251 | 08:50:07 INFO - PROCESS | 2251 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.90 Median:161.50 stddev:2.33 (1.4%) stddev-sans-first:2.37 08:50:07 INFO - PROCESS | 2251 | Values: 159.0 161.0 162.0 162.0 164.0 160.0 159.0 159.0 165.0 158.0 08:50:07 INFO - PROCESS | 2251 | 08:50:07 INFO - PROCESS | 2251 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:61.50 stddev:3.85 (6.3%) stddev-sans-first:3.67 08:50:07 INFO - PROCESS | 2251 | Values: 67.0 60.0 65.0 60.0 61.0 62.0 70.0 59.0 59.0 59.0 08:50:07 INFO - PROCESS | 2251 | -------- Summary: end -------- 08:50:07 INFO - PROCESS | 2251 | 08:50:08 INFO - TEST-INFO | 2251: exit 0 08:50:08 INFO - TEST-OK | kraken | took 60883ms 08:50:08 INFO - SUITE-END | took 1177s 08:50:09 INFO - Completed test suite (00:19:37) 08:50:09 INFO - javascript benchmark 08:50:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7828.713858781019, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3322.534845121682, 3330.78349907256, 3371.32573485303, 3375.189954410942, 3418.914527136821, 5576.776928922838, 5586.162075688649, 5597.384287728347, 5604.80383186588, 5610.0, 5707.457791509811, 5773.4515221054035, 5816.4765171134695, 5838.795642152526, 5841.591088623798, 5274.393444753845, 5276.050310944019, 5290.603204759639, 5309.41596424393, 5354.41101478837, 5092.770825312851, 5132.794688212486, 5210.791568337262, 5380.031594313022, 5389.245505629215, 5304.018756530054, 5307.920381194285, 5320.122179840322, 5328.147496400557, 5333.57331413486, 5333.679979201261, 5334.199870019489, 5334.3598768147685, 5338.27933229013, 5355.223492593552, 5009.323741294915, 5073.162928116893, 5215.348081489814, 5230.476952304739, 5289.603279754034, 5599.832005039855, 5607.495325420732, 5621.128725047624, 5657.971710141464, 5678.0, 6150.569460137792, 6176.96911515444, 6204.534659900525, 6209.3790620938, 6209.844753881144, 6224.37756224374, 6241.126242326078, 6253.7185826637915, 6257.5619706620555, 6260.342664020303, 5475.178723191553, 5503.944960550383, 5722.198892155102, 5759.712014399263, 5796.420357964212, 6302.716377763011, 6333.20834895638, 6347.777827776005, 6347.96826015867, 6361.045843123568, 6110.175126357884, 6126.693665316806, 6126.724297406628, 6130.233720784902, 6133.325334213233, 5944.791932282349, 5999.430054144849, 6110.022396416552, 6139.631622102688, 6215.564910456315, 6126.895025200522, 6127.383771656488, 6173.783917562864, 6176.073588961692, 6184.567080304336, 5926.940730592725, 5949.970250148722, 6116.449519543263, 6137.144455097482, 6142.477889379364, 4543.772811359485, 4638.443386793607, 4658.976705116453, 4665.906681866344, 4670.136024835417, 4191.392248124005, 4226.1336426032585, 4227.217964676544, 4229.534751177368, 4250.489941207075, 5707.200991861143, 5739.713014349266, 5885.646861188342, 5926.851828704317, 6046.486048685911, 6226.377362263828, 6235.438810507076, 6243.469305109026, 6250.312465628777, 6253.874922501615, 5984.251968503937, 5989.580729348991, 5995.820125396245, 5998.850028749316, 6032.366601506778, 5081.136206844772, 5109.335786347751, 5205.063088644005, 5271.4464981176425, 5271.499207575274, 6444.677766111582, 6482.67586620667, 6495.2855185928565, 6495.805125846232, 6503.0, 6136.23297087864, 6206.379362063757, 6216.0, 6219.346968568235, 6245.500359971101, 6147.139400483847, 6182.289036760651, 6506.642134682638, 6506.707198175999, 6510.576812507172, 6042.607230530001, 6057.212562366864, 6138.9095594588325, 6146.846328841814, 6153.569250152446, 6244.594101383395, 6245.219347581552, 6245.6252624842655, 6249.6562689052535, 6250.781222657185, 5821.7089145543405, 6028.216331876828, 6086.60437071589, 6087.604305720114, 6087.995480745627, 5915.290165180206, 5985.072313791369, 6017.247844019497, 6072.028475443908, 6120.08198770188, 6058.909116363347, 6068.6358818471035, 6071.666058366833, 6074.149619053424, 6075.331713511422, 5861.062230043172, 5895.882082358415, 5978.163057171912, 6094.603850749687, 6115.8776824462375, 5771.7402716877, 5920.052791553331, 5969.73136208863, 5973.611715238496, 5982.371850955587], "value": 5688.150257201636, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [779.2986312318912, 838.6310023589621, 858.3004851046398, 909.0182602788989, 929.5445231836402, 31195.0, 31588.0, 43687.344689829675, 44116.55883441173, 44250.33624495635, 41752.37371439431, 46171.07657846841, 46197.769011154895, 46214.768926155324, 46263.30605040927, 8944.284457243404, 9059.411138276024, 9072.863907041366, 9077.727668169966, 9081.0, 7535.54786712799, 7649.732259370923, 10459.68620941373, 10633.202509811756, 10941.070009049201, 10600.363978161335, 10660.680179594587, 10669.359838409682, 10676.199285053613, 10677.0, 10547.208959328005, 10579.788404231911, 10585.311954722918, 10600.416977066257, 10625.415602141878, 10358.896411035945, 10366.274360794747, 10367.429791361472, 10368.377897326185, 10413.16694664425, 41914.79042604767, 42306.57693423057, 42324.57675423268, 42331.1533769326, 42335.0, 3606.0, 3645.325614761251, 3670.0, 3688.612695666943, 3777.924441511182, 27550.862245688844, 27761.583576246372, 27862.442751145067, 28239.717602823916, 28298.575521367195, 4292.24885645014, 4307.0, 4322.184722298401, 4340.761258130801, 4418.602325790662, 218558.0, 218773.0, 220026.9999999984, 220091.0, 220411.0, 52541.0, 52815.73592132015, 52981.47018529842, 52982.73508632509, 53048.204276935874, 55196.72401638047, 55620.0, 55782.0, 55806.44193558094, 55866.72066639641, 15831.841681583037, 16237.837621623868, 16249.512514624581, 16290.755638665429, 16318.0, 14320.57038288853, 14327.498537551135, 14345.426182952773, 14365.13809171453, 14372.281385930663, 11533.365664888344, 11711.414429278502, 11812.055035597303, 12034.157608967464, 12382.81425778614, 4806.822460525844, 4891.486393928586, 4899.424212966467, 4904.137335801217, 4941.50584941503, 943.8159558885951, 947.9620815167455, 952.547539918547, 972.7811242470387, 977.5503268496429, 25330.620040699403, 26971.0, 27028.189154325402, 27652.723472765014, 28844.711552884623, 1101.3116801998751, 1165.0970497864053, 1184.9289042657467, 1212.6301478049104, 1219.1222319929636, 15629.06225626466, 16558.172091395383, 16734.74897876533, 17187.3984410545, 17554.824451755576, 337792.0, 338196.0, 338769.0, 339087.0, 339565.0, 56404.153937690964, 56604.71697641568, 56727.71636141793, 56734.71632641811, 56775.0, 1549.2795849929612, 1574.0634322578048, 1576.188263044533, 1598.9040657560583, 1609.1793185475492, 29816.850915745283, 31005.68994310028, 31360.215994600316, 31592.684073158973, 31600.0, 44027.33958990554, 44356.112877741616, 44413.33379999367, 44437.666869993955, 44563.331550027426, 312503.0, 313110.0, 313206.0, 313232.0, 313447.0, 36231.0, 36835.447468288534, 36875.81562092173, 36879.26241475209, 37029.44455833111, 44248.55751442444, 44432.0, 44479.0, 45431.0, 45445.318320224564, 35627.0, 36410.45384319184, 36486.0, 36608.81695591612, 36666.26667466689, 36589.81705091564, 36976.81511592425, 37258.813705931294, 37290.0, 37472.063198419164, 38602.227955441296, 38825.61174388333, 38846.0, 39351.40972885352, 39362.80318598389, 31640.525392119598, 33390.16524586808, 33423.49864752079, 33540.32919341648, 33604.49593256152, 25814.017933137133, 25891.741082588935, 25951.351216219744, 26038.609420858324, 26107.335131208783], "value": 19078.647093061674, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.278334256639, 461.52924017502147, 462.45892306001997, 470.8022630495192, 471.053183101965, 18904.24383024679, 19388.41834744958, 21543.784562154393, 21822.781772182312, 21857.781422185773, 21323.147074117016, 21594.24420145295, 21917.452063698416, 22268.99789509472, 22276.88861555694, 6670.099536562575, 6772.119624448815, 6779.423748981342, 6846.589204647712, 6884.0362349271145, 4234.1955028544635, 6753.493487988396, 6837.65811709415, 6857.3828355448, 6860.382565569098, 7321.231270716578, 7560.130584982742, 7595.848083038336, 7598.1262154852075, 7599.696012159507, 7515.286047825475, 7610.315071643523, 7684.077910650702, 7705.4220933430215, 7761.41789365797, 7370.152432470281, 7479.887801682979, 7486.513376630502, 7494.437917156235, 7518.924810751877, 23649.29052128439, 24118.638220426707, 24172.0, 25422.36444088894, 25633.871830640914, 3026.788124831263, 3039.7720170987045, 3140.5917230759856, 3210.1493104327374, 3434.845431955568, 14700.191489468076, 14959.252037398086, 15418.691626167527, 16095.758563621555, 16331.673366532603, 2125.2880285104507, 2168.92408765694, 2173.1959175105153, 2214.966775498369, 2222.7888350606668, 116202.41898790536, 117032.0, 120397.0, 123322.0, 123656.38171809174, 14025.954176597284, 15598.0, 18047.729284060748, 18085.7287140693, 18327.725084123747, 31279.68720312813, 31341.843290783858, 31480.212994674857, 31487.84256078705, 31918.36163276768, 9756.0, 9792.167665748491, 9877.357971731815, 9996.450195239186, 10097.899021009844, 8735.25750311218, 8775.166359195866, 8786.560671966376, 8829.205371516595, 9028.413153145024, 9123.224525915239, 9174.770630734152, 9249.537523123818, 9299.116583924517, 9555.61777528891, 3733.4213196954515, 3806.885793426202, 3848.3650197717625, 4027.838886444509, 4081.77550234734, 934.7149119518476, 936.442816524167, 950.3822515365068, 956.6938579654583, 958.8082383523323, 19817.405477835688, 21025.474363141046, 21128.78871211268, 21371.893140534197, 21411.8929405352, 936.8969413364524, 939.2579861909152, 944.6457578408097, 948.0, 951.9861347664715, 10946.56213751457, 11649.825252621218, 11654.592089276835, 11713.648590542298, 11826.349550774617, 468167.0, 469986.0, 621710.0, 723261.0, 724382.0, 104335.99999999849, 116484.0, 123438.0, 125015.37492312663, 125041.37479312545, 1311.7901135818415, 1320.4982106799546, 1323.219300612643, 1341.2086868747485, 1342.1410297409666, 14114.2942852859, 17617.383391581745, 18329.175187116343, 18947.621047579247, 18963.0, 46894.29658555056, 47643.0, 51113.48886511236, 51886.0, 53098.20352694635, 67888.6605566969, 68155.65922170358, 68189.65905170442, 68807.31192688209, 69028.0, 7675.5010924289745, 10814.972577605115, 11044.613438529614, 11878.82181767257, 11963.76072478563, 8666.610002549774, 12571.0, 12861.678458038625, 12914.547990820276, 12950.417231224428, 10636.468176591294, 10988.835167472334, 11557.30656160633, 11717.531298747954, 11752.412379381169, 10647.840282395615, 10697.304675196086, 10760.354378736987, 11090.500927458123, 11130.443477826238, 11253.388447080293, 11285.774284514428, 11488.080953523531, 11488.712782180512, 11952.402379880798, 11706.35615041181, 11788.70528236801, 11886.405679716152, 11914.463849126983, 12151.75696486083, 11605.419729013347, 11794.174407791372, 11797.17419780607, 12072.39638018078, 12156.088293377856], "value": 11224.824316874163, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1577.5346272849508, 1588.3884704388813, 1601.8638415734658, 1602.4551652438172, 1618.7410014397692, 10787.514561844717, 11549.826752598707, 11612.419379031056, 11617.767644647101, 11641.12691548135, 10902.345859248431, 11266.098712103032, 11279.436028198577, 11286.548538058489, 11311.0, 2459.8032157427406, 2494.738052504488, 2505.812064095191, 2512.321673148249, 2512.321673148258, 2370.5021945391404, 2427.623718323654, 2433.7931275841574, 2436.1595249638935, 2437.695288088989, 2260.819134469247, 2268.943276418086, 2271.4207876991345, 2275.4311422144465, 2279.5440911817705, 2279.6466547685136, 2306.4810417655976, 2313.7223533176043, 2314.109068008812, 2315.2591170825344, 2331.6269396896587, 2380.1074597026113, 2409.6987876515436, 2415.0460568075687, 2419.7701218384227, 11613.88386116145, 11766.176367654267, 11780.352080635561, 11780.70548236301, 11806.527738890434, 5885.028970219909, 6011.669358185298, 6017.939820601781, 6031.155638210654, 6043.1841701370195, 3462.8614855405754, 3514.7188224941942, 3536.2927414516944, 3570.2145527983803, 3621.7283703722064, 1386.9098508596908, 1387.5767890793304, 1391.8816900563363, 1471.2349578219266, 1472.9158241088846, 16928.322867085302, 17486.47540573785, 17652.20565074562, 17694.91152544229, 17741.911290443593, 4793.760311984387, 4815.22956326986, 4836.202026665631, 4904.950950490449, 5027.4218464877, 12642.431090600945, 12644.747105057848, 12675.49298028087, 12691.936540317423, 12737.044721645914, 5843.298804143445, 5857.20927674767, 5857.88284234313, 5864.413558644187, 5867.677277749679, 5415.972920135453, 5460.235567020621, 5467.644603100785, 5471.863203419866, 5569.0, 3988.4814974053766, 4050.7164498485413, 4076.3681629347498, 4110.0, 4139.441175441337, 1049.2864851900629, 1052.4685034057904, 1056.070657821128, 1064.6273804168634, 1071.3732466507024, 981.3964411886639, 995.9502024898871, 1013.8276492996208, 1014.9898501015043, 1015.1472762879217, 6740.325967403319, 6742.831429214309, 6931.58230879779, 6943.166819981533, 7077.823054423578, 1043.994780026095, 1058.767071244325, 1068.433730123036, 1069.652362982034, 1074.6937122920087, 4536.637069034469, 4610.2854057621125, 4629.421322334708, 4632.652551058684, 4679.64902632304, 14469.565913022416, 14835.258237088103, 15118.0, 15141.545753627408, 15155.469558565617, 12486.562970295996, 13966.790498142536, 14267.928660356632, 14328.570142895522, 14971.40114395412, 9256.90743092574, 10104.292699510963, 10164.949175254224, 10426.0, 10528.789424211625, 6856.965715171392, 6958.095447591781, 7030.894536582057, 7041.788746337618, 7420.5176663516695, 12629.368531573567, 12851.907587855138, 12867.806982895452, 12925.741485170432, 13278.402471888981, 12869.678258043623, 12906.806397904227, 12929.676758081123, 13094.672633183865, 13243.0, 9513.762155946157, 9788.657396991071, 9796.167325777104, 9802.166815820736, 9812.754681133028, 10478.266521343738, 10498.370097794157, 10566.260361774603, 10600.575976960836, 10654.73363165896, 8954.731358059269, 9071.546422678708, 9094.909050909406, 9119.224865886208, 9198.632054718004, 9173.724788256362, 9221.953890230507, 9309.162175404246, 9331.580078896603, 9331.86002209981, 7619.809504762426, 7746.49647772893, 7750.263724946121, 7754.495957762728, 7766.262205090507, 5642.125470552071, 5726.341470730919, 5823.941760582509, 5825.621334613236, 5881.353051164454, 5843.29880414353, 5906.232189815297, 5955.40445955401, 5976.7908123215475, 6179.474744646755], "value": 5346.766567241886, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.7982952421305, 408.84668249406474, 418.9120284740204, 420.1680672268909, 426.76314645371804, 5097.439281679017, 5136.91954758323, 5161.612879034069, 5168.896622067557, 5188.299579556754, 4960.6527543072, 5013.21766419637, 5032.817287937341, 5061.266116413118, 5121.308623335858, 4393.187260356836, 4420.270655341865, 4425.557444255564, 4438.312061630452, 4445.199864024475, 4424.3142312941545, 4439.2254840724545, 4450.310201918708, 4462.598366147046, 4464.196444639963, 4358.8910277243, 4419.160359531695, 4447.466304043519, 4453.330001249531, 4476.731396116227, 4439.267520859071, 4440.24515832306, 4447.444069491314, 4455.131249406367, 4484.596386325214, 4272.081502476983, 4289.549597292271, 4290.528041915387, 4291.97854010731, 4292.377605247221, 4798.304245884362, 4939.950600493985, 4990.4011518617635, 5016.262884151294, 5021.497850214986, 5105.617078719111, 5137.357830271216, 5155.896882062375, 5162.19985902182, 5164.734640013221, 5397.379301380313, 5403.2165336026055, 5408.729563521808, 5426.348838139409, 5431.375391829951, 4633.6061434778085, 4731.858044258678, 4753.786079626425, 4788.688735232199, 4793.675067592215, 5370.838874833761, 5458.863528411822, 5494.395616482184, 5612.915806262909, 5654.491095801398, 4857.295692124622, 4881.414230292387, 4896.681715688469, 4911.435184953704, 4924.482929292372, 4746.71838603582, 4812.807487700453, 4967.975160124176, 5002.349694539759, 5028.0, 4801.783919723621, 4993.300937868701, 5120.897582048338, 5129.7175706073485, 5149.330587023663, 5366.095036262149, 5367.382750983609, 5369.114096174166, 5379.112446446371, 5383.730813459311, 1653.2725600735637, 1696.4571337171988, 1702.569841333286, 1717.931282748676, 1726.9740953885703, 1398.5175713743465, 1402.6703724624706, 1427.635952832042, 1438.266484093099, 1440.8703216710546, 5232.215167724872, 5234.528892399702, 5253.185756207794, 5257.342832145981, 5298.81454149103, 5474.206240095164, 5479.739659878171, 5487.2317875497465, 5498.75573411689, 5530.870614813326, 5041.218611115283, 5074.934263804643, 5101.846944591668, 5210.0, 5242.40106767432, 2860.0, 2863.9427211455654, 2872.8707208175683, 2890.2629829393372, 2891.8698658560415, 5624.746886390122, 5635.380108188178, 5651.350094739076, 5676.744546495418, 5690.0, 5317.707526086102, 5623.775048997994, 5633.239512665819, 5636.859078522988, 5637.971810141005, 5694.9782827096615, 5706.28671416073, 5706.885862282731, 5707.828765136969, 5708.31500219968, 5283.603729720363, 5507.669539827623, 5515.573147814948, 5551.389347171888, 5554.0, 5231.659942103751, 5428.430014848384, 5486.845064088245, 5540.390557038803, 5554.111342185231, 5503.449655034625, 5527.595495959271, 5558.861028474321, 5569.081101618188, 5588.944110559005, 4561.654311978041, 4592.311153327028, 4598.908021839611, 4600.470945841271, 4631.564215093332, 5398.379186393615, 5459.12653975362, 5466.699331536804, 5487.64330318528, 5528.834134975958, 5343.7862485500145, 5360.919586206132, 5364.195370694427, 5377.516023557899, 5384.407715151252, 5326.416687906285, 5360.0, 5372.865678358073, 5383.981007122329, 5415.377231618414, 5130.23474410672, 5308.25684404176, 5319.813806516908, 5347.657713928795, 5354.491323324278, 5278.81524146653, 5374.704391258519, 5394.973025134849, 5397.8110766123, 5411.458854114557, 5246.344206974129, 5247.239150323106, 5249.186376111708, 5273.973630131824, 5276.182191760283], "value": 4394.549110532506, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [800.2997377294867, 851.5359129274544, 878.8198419324038, 885.712143553345, 919.3734345803682, 16941.576460588476, 17929.820701792978, 18101.09494525275, 18133.546661333472, 18200.180991855366, 16450.670986580262, 16476.83523164768, 16600.58498537537, 17074.31702731889, 17709.29162833485, 880.0935036911959, 893.8525143351355, 896.6727144592243, 915.8122584870085, 922.8200500902293, 888.2760550151605, 888.9733308000738, 890.9866352004725, 891.131147131548, 891.7993451473432, 956.5312996631635, 956.8373376525973, 957.5882370580682, 957.6169532187112, 958.6261358070358, 953.3898305084751, 955.1403736637047, 955.1880901233931, 955.2405837359281, 956.3879117364892, 701.5404909784048, 703.2510376449065, 703.9049728286718, 703.96480175991, 704.6124631452732, 17809.821901781077, 17926.372576959744, 17991.820081799277, 18394.63210735778, 18606.34877779285, 17472.91263543674, 17534.29862805486, 17819.910900445546, 17886.195121219578, 18181.54546136344, 13668.316584170752, 14177.503787367496, 14308.785368219485, 14317.35571899267, 14366.138031718026, 4159.896002599929, 4197.412362269285, 4223.429836972, 4293.377460268243, 4329.935050974238, 92185.0, 93416.0, 94018.0, 95778.52110739471, 97115.0, 12492.68768280782, 12498.375081245902, 12705.364731763375, 12767.744645107046, 12801.167924084904, 27037.324066898484, 27180.864095679393, 27235.0, 27246.45507089847, 27277.0, 8753.387262891663, 8784.824303513893, 9062.81874362509, 9095.454272743656, 9118.042605526456, 4914.606831453475, 5046.066477701637, 5073.746312684351, 5094.465081166498, 5111.667741596784, 3862.729608927348, 3958.0, 3975.1453437511072, 3990.700697447703, 3997.4603428537357, 590.6367583935848, 597.310106826616, 603.6317846113867, 611.1169360274449, 612.7089632424563, 816.6610856494489, 828.8590939540293, 847.6058632735808, 855.6577369052304, 875.4528419737663, 11006.38826038521, 11449.656510304705, 11594.71013224676, 11815.672328467232, 11820.527178912747, 825.0594322472386, 825.3397282174236, 845.5856630251133, 849.6176720475687, 862.3101518784947, 5330.333708286465, 5342.91985620216, 5361.651492652965, 5670.291213598301, 6105.175801266772, 81783.0, 82734.0, 84597.57701211455, 85410.0, 87582.56208719042, 46271.76864115658, 73016.26983730095, 74346.62826685832, 75689.24310756932, 76276.23723762692, 39492.60507394889, 52705.736471317396, 59534.70232648809, 59562.40437595742, 59775.701121494116, 10972.835407468734, 11314.15143864197, 11505.0, 11558.0, 11715.0, 41206.587934120274, 41597.37603936004, 41606.167876641695, 42089.78955105205, 42358.78820605877, 47493.287600685326, 49004.0, 49539.50460495349, 50101.24848127208, 50415.74792126016, 13329.466821327425, 13496.460141594227, 13536.323183840965, 13599.660008499866, 13885.652858678613, 16232.0, 16599.91700041492, 17357.65284694324, 17562.12189390551, 17632.294708211528, 15236.542903712907, 15338.386464541294, 15608.0, 16354.591135221715, 16355.0, 14932.328045238208, 14933.253337333308, 15621.297041633381, 15806.920965395559, 15841.68316633684, 14679.486217982747, 14855.92572037133, 14910.77633835515, 16035.118068506345, 16064.678706425571, 11697.23967942081, 11984.880151198377, 12289.324087175291, 12426.81359779586, 12527.060470464568, 11737.178397512092, 11835.763284734085, 11851.644450666494, 11887.643370698894, 12131.818022729489], "value": 8042.661453231204, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1463.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 112.0, 111.0, 111.0, 111.0, 111.0, 111.0, 110.0, 111.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 115.0, 123.0, 151.0, 118.0, 116.0, 117.0, 116.0, 134.0, 116.0], "value": 125.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 161.0, 160.0, 160.0, 160.0, 162.0, 160.0, 162.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 78.0, 119.0, 77.0, 77.0, 76.0, 76.0, 97.0, 77.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 99.0, 81.0, 81.0, 82.0, 100.0, 81.0, 81.0, 102.0], "value": 86.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 121.0, 112.0, 113.0, 112.0, 113.0, 112.0, 113.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 54.0, 54.0, 54.0, 54.0, 55.0, 62.0, 54.0, 56.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 55.0, 54.0, 53.0, 54.0, 54.0, 54.0, 54.0, 54.0], "value": 54.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 84.0, 77.0, 82.0, 76.0, 79.0, 81.0, 85.0, 75.0], "value": 79.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 124.0, 124.0, 130.0, 120.0, 128.0, 119.0, 130.0, 172.0, 152.0], "value": 132.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 162.0, 162.0, 164.0, 160.0, 159.0, 159.0, 165.0, 158.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 60.0, 65.0, 60.0, 61.0, 62.0, 70.0, 59.0, 59.0, 59.0], "value": 62.2, "unit": "score"}]}]} 08:50:09 INFO - Return code: 0 08:50:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:50:09 ERROR - # TBPL SUCCESS # 08:50:09 INFO - Running post-action listener: _resource_record_post_action 08:50:09 INFO - [mozharness: 2017-03-08 16:50:09.207508Z] Finished run-tests step (success) 08:50:09 INFO - Running post-run listener: _resource_record_post_run 08:50:09 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 266240; Write bytes: 368709632; Read time: 28; Write time: 377024 08:50:09 INFO - TinderboxPrint: CPU usage
13.1% 08:50:09 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 28 08:50:09 INFO - TinderboxPrint: I/O write bytes / time
368,709,632 / 377,024 08:50:09 INFO - TinderboxPrint: CPU idle
8,286.2 (86.9%) 08:50:09 INFO - TinderboxPrint: CPU user
1,202.4 (12.6%) 08:50:09 INFO - TinderboxPrint: Swap in / out
0 / 0 08:50:09 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110632960; Read time: 0; Write time: 149148 08:50:09 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 266240; Write bytes: 258076672; Read time: 28; Write time: 227876 08:50:09 INFO - Running post-run listener: _upload_blobber_files 08:50:09 INFO - Blob upload gear active. 08:50:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:50:09 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 08:50:09 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:50:09 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:50:10 INFO - (blobuploader) - INFO - Open directory for files ... 08:50:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:50:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:50:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:50:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:50:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:50:10 INFO - (blobuploader) - INFO - Done attempting. 08:50:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:50:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:50:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:50:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:50:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:50:14 INFO - (blobuploader) - INFO - Done attempting. 08:50:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:50:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:50:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:50:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:50:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:50:14 INFO - (blobuploader) - INFO - Done attempting. 08:50:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:50:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:50:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:50:15 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:50:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:50:15 INFO - (blobuploader) - INFO - Done attempting. 08:50:15 INFO - (blobuploader) - INFO - Iteration through files over. 08:50:15 INFO - Return code: 0 08:50:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:50:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:50:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7db50417e085dbf487f0f11290827bfb38d5c81e0f92ddc76c197df8a185c21816b1997f65b7de0df73f9f8b0be4d291a39242d01ec709e2b5869bd0daee301d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0f91d7b4294ddd0d72406fe01dc4d710d81265dbec04eb16d0b94ae78e6ed069e0cc73a5a9556d680ede950fa82cc889f532f5d68cbb9f09e63cfdd85feb93fa", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e8790def7026ace92011022967ac0d5111aeaef0de801ef590bc14381e82589a2dadcb47b6653956cc11f3a2b5e97ec79269bfca19c9feb2348c9fa3150aa692", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/56e8bf67cc018c32a3dd80157c1eebec65647dc31e8bfa7dfce3562b2b6b19ba2f3621daf85d233bf23afbfc2896960d786b8b3319abae7107e76982d5331b2b"} 08:50:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:50:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:50:15 INFO - Contents: 08:50:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7db50417e085dbf487f0f11290827bfb38d5c81e0f92ddc76c197df8a185c21816b1997f65b7de0df73f9f8b0be4d291a39242d01ec709e2b5869bd0daee301d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0f91d7b4294ddd0d72406fe01dc4d710d81265dbec04eb16d0b94ae78e6ed069e0cc73a5a9556d680ede950fa82cc889f532f5d68cbb9f09e63cfdd85feb93fa", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e8790def7026ace92011022967ac0d5111aeaef0de801ef590bc14381e82589a2dadcb47b6653956cc11f3a2b5e97ec79269bfca19c9feb2348c9fa3150aa692", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/56e8bf67cc018c32a3dd80157c1eebec65647dc31e8bfa7dfce3562b2b6b19ba2f3621daf85d233bf23afbfc2896960d786b8b3319abae7107e76982d5331b2b"} 08:50:15 INFO - Running post-run listener: copy_logs_to_upload_dir 08:50:15 INFO - Copying logs to upload dir... 08:50:15 INFO - mkdir: /builds/slave/test/build/upload/logs 08:50:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.300814 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-03-08 08:50:14.662625) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-08 08:50:14.665779) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1488990561.699894-543194811 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7db50417e085dbf487f0f11290827bfb38d5c81e0f92ddc76c197df8a185c21816b1997f65b7de0df73f9f8b0be4d291a39242d01ec709e2b5869bd0daee301d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0f91d7b4294ddd0d72406fe01dc4d710d81265dbec04eb16d0b94ae78e6ed069e0cc73a5a9556d680ede950fa82cc889f532f5d68cbb9f09e63cfdd85feb93fa", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e8790def7026ace92011022967ac0d5111aeaef0de801ef590bc14381e82589a2dadcb47b6653956cc11f3a2b5e97ec79269bfca19c9feb2348c9fa3150aa692", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/56e8bf67cc018c32a3dd80157c1eebec65647dc31e8bfa7dfce3562b2b6b19ba2f3621daf85d233bf23afbfc2896960d786b8b3319abae7107e76982d5331b2b"} build_url:https://queue.taskcluster.net/v1/task/aC-0RQJ6Sde-4mUvuw1v-Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011219 build_url: 'https://queue.taskcluster.net/v1/task/aC-0RQJ6Sde-4mUvuw1v-Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7db50417e085dbf487f0f11290827bfb38d5c81e0f92ddc76c197df8a185c21816b1997f65b7de0df73f9f8b0be4d291a39242d01ec709e2b5869bd0daee301d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0f91d7b4294ddd0d72406fe01dc4d710d81265dbec04eb16d0b94ae78e6ed069e0cc73a5a9556d680ede950fa82cc889f532f5d68cbb9f09e63cfdd85feb93fa", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e8790def7026ace92011022967ac0d5111aeaef0de801ef590bc14381e82589a2dadcb47b6653956cc11f3a2b5e97ec79269bfca19c9feb2348c9fa3150aa692", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/56e8bf67cc018c32a3dd80157c1eebec65647dc31e8bfa7dfce3562b2b6b19ba2f3621daf85d233bf23afbfc2896960d786b8b3319abae7107e76982d5331b2b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-08 08:50:14.689835) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 08:50:14.690110) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1488990561.699894-543194811 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004732 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 08:50:14.773683) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-08 08:50:14.774084) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-08 08:50:14.774486) ========= ========= Total master_lag: 0.14 =========