builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-047 starttime: 1491356574.37 results: success (0) revision: 896e9cfb9d67d6a73e70e39532f31306c22202cb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-04 18:42:54.367133) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-04 18:42:54.367565) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-04 18:42:54.367861) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-04 18:42:54.384831) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 18:42:54.385091) ========= 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=03627c79f6bb3d1578c4a402000001ba-1491356569.35742-1626508172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-04 18:42:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.2M=0s 2017-04-04 18:42:54 (42.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118565 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 18:42:54.517475) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 18:42:54.517825) ========= 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=03627c79f6bb3d1578c4a402000001ba-1491356569.35742-1626508172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019229 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 18:42:54.567375) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 18:42:54.567694) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 896e9cfb9d67d6a73e70e39532f31306c22202cb --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 896e9cfb9d67d6a73e70e39532f31306c22202cb --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=03627c79f6bb3d1578c4a402000001ba-1491356569.35742-1626508172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-04 18:42:54,605 truncating revision to first 12 chars 2017-04-04 18:42:54,605 Setting DEBUG logging. 2017-04-04 18:42:54,605 attempt 1/10 2017-04-04 18:42:54,605 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/896e9cfb9d67?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-04 18:42:55,051 unpacking tar archive at: mozilla-aurora-896e9cfb9d67/testing/mozharness/ program finished with exit code 0 elapsedTime=0.751699 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 18:42:55.333638) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-04 18:42:55.334088) ========= script_repo_revision: 896e9cfb9d67d6a73e70e39532f31306c22202cb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-04 18:42:55.334573) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-04 18:42:55.334852) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-04 18:42:55.344167) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-04-04 18:42:55.344431) ========= /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=03627c79f6bb3d1578c4a402000001ba-1491356569.35742-1626508172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:42:55 INFO - MultiFileLogger online at 20170404 18:42:55 in /builds/slave/test 18:42:55 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 18:42:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:42:55 INFO - {'append_to_log': False, 18:42:55 INFO - 'base_work_dir': '/builds/slave/test', 18:42:55 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 18:42:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:42:55 INFO - 'branch': 'Mozilla-Aurora', 18:42:55 INFO - 'buildbot_json_path': 'buildprops.json', 18:42:55 INFO - 'config_files': ('talos/linux_config.py',), 18:42:55 INFO - 'default_actions': ('clobber', 18:42:55 INFO - 'read-buildbot-config', 18:42:55 INFO - 'download-and-extract', 18:42:55 INFO - 'populate-webroot', 18:42:55 INFO - 'create-virtualenv', 18:42:55 INFO - 'install', 18:42:55 INFO - 'run-tests'), 18:42:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:42:55 INFO - 'download_minidump_stackwalk': True, 18:42:55 INFO - 'download_symbols': 'ondemand', 18:42:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:42:55 INFO - 'tooltool.py': '/tools/tooltool.py', 18:42:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:42:55 INFO - '/tools/misc-python/virtualenv.py')}, 18:42:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:42:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:42:55 INFO - 'gecko_profile': False, 18:42:55 INFO - 'gecko_profile_interval': 0, 18:42:55 INFO - 'installer_path': 'installer.exe', 18:42:55 INFO - 'log_level': 'info', 18:42:55 INFO - 'log_name': 'talos', 18:42:55 INFO - 'log_to_console': True, 18:42:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:42:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:42:55 INFO - 'opt_config_files': (), 18:42:55 INFO - 'pip_index': False, 18:42:55 INFO - 'suite': 'dromaeojs', 18:42:55 INFO - 'system_bits': '32', 18:42:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:42:55 INFO - 'title': 'talos-linux64-ix-047', 18:42:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:42:55 INFO - 'use_talos_json': True, 18:42:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:42:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:42:55 INFO - 'work_dir': 'build'} 18:42:55 INFO - [mozharness: 2017-04-05 01:42:55.485054Z] Running clobber step. 18:42:55 INFO - Running pre-action listener: _resource_record_pre_action 18:42:55 INFO - Running main action method: clobber 18:42:55 INFO - rmtree: /builds/slave/test/build 18:42:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:42:56 INFO - Running post-action listener: _resource_record_post_action 18:42:56 INFO - [mozharness: 2017-04-05 01:42:56.417053Z] Finished clobber step (success) 18:42:56 INFO - [mozharness: 2017-04-05 01:42:56.417153Z] Running read-buildbot-config step. 18:42:56 INFO - Running pre-action listener: _resource_record_pre_action 18:42:56 INFO - Running main action method: read_buildbot_config 18:42:56 INFO - Using buildbot properties: 18:42:56 INFO - { 18:42:56 INFO - "project": "", 18:42:56 INFO - "product": "firefox", 18:42:56 INFO - "who": "ryanvm@gmail.com", 18:42:56 INFO - "installer_path": "public/build/target.tar.bz2", 18:42:56 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 18:42:56 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 18:42:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 18:42:56 INFO - "stage_platform": "linux64-pgo", 18:42:56 INFO - "basedir": "/builds/slave/test", 18:42:56 INFO - "buildnumber": 1137, 18:42:56 INFO - "platform": "ubuntu64_hw", 18:42:56 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:42:56 INFO - "slavebuilddir": "test", 18:42:56 INFO - "taskId": "U-f4SU5LT5iyRxQlGn0BRg", 18:42:56 INFO - "branch": "mozilla-aurora", 18:42:56 INFO - "script_repo_revision": "production", 18:42:56 INFO - "revision": "896e9cfb9d67d6a73e70e39532f31306c22202cb", 18:42:56 INFO - "slavename": "talos-linux64-ix-047", 18:42:56 INFO - "repo_path": "releases/mozilla-aurora" 18:42:56 INFO - } 18:42:56 INFO - Finding installer, test and symbols from parent task. 18:42:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U-f4SU5LT5iyRxQlGn0BRg'}, attempt #1 18:42:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U-f4SU5LT5iyRxQlGn0BRg'}, attempt #1 18:42:57 INFO - Task dependencies: Pv3OoWUGRh2f9yhYeImwbw 18:42:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pv3OoWUGRh2f9yhYeImwbw'}, attempt #1 18:42:57 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Pv3OoWUGRh2f9yhYeImwbw/artifacts/public/build/target.tar.bz2 18:42:57 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Pv3OoWUGRh2f9yhYeImwbw/artifacts/public/build/test_packages.json 18:42:57 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Pv3OoWUGRh2f9yhYeImwbw/artifacts/public/build/target.crashreporter-symbols.zip 18:42:57 INFO - Running post-action listener: _resource_record_post_action 18:42:57 INFO - [mozharness: 2017-04-05 01:42:57.776236Z] Finished read-buildbot-config step (success) 18:42:57 INFO - [mozharness: 2017-04-05 01:42:57.776453Z] Running download-and-extract step. 18:42:57 INFO - Running pre-action listener: _resource_record_pre_action 18:42:57 INFO - Running main action method: download_and_extract 18:42:57 INFO - mkdir: /builds/slave/test/build/tests 18:42: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')]} 18:42:57 INFO - trying https://queue.taskcluster.net/v1/task/Pv3OoWUGRh2f9yhYeImwbw/artifacts/public/build/target.test_packages.json 18:42:57 INFO - Downloading https://queue.taskcluster.net/v1/task/Pv3OoWUGRh2f9yhYeImwbw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:42:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pv3OoWUGRh2f9yhYeImwbw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:42:58 INFO - Downloaded 896 bytes. 18:42:58 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:42:58 INFO - Using the following test package requirements: 18:42:58 INFO - {u'common': [u'target.common.tests.zip'], 18:42:58 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:42:58 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:42:58 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:42:58 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:42:58 INFO - u'mozbase': [u'target.common.tests.zip'], 18:42:58 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:42:58 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:42:58 INFO - u'web-platform': [u'target.common.tests.zip', 18:42:58 INFO - u'target.web-platform.tests.zip'], 18:42:58 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:42:58 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:42:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Pv3OoWUGRh2f9yhYeImwbw/artifacts/public/build/target.common.tests.zip 18:42:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pv3OoWUGRh2f9yhYeImwbw/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:42:58 INFO - Fetch https://queue.taskcluster.net/v1/task/Pv3OoWUGRh2f9yhYeImwbw/artifacts/public/build/target.common.tests.zip into memory 18:42:59 INFO - Expected file size: 59540708 18:42:59 INFO - Obtained file size: 59540708 18:43:09 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:43:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Pv3OoWUGRh2f9yhYeImwbw/artifacts/public/build/target.common.tests.zip 18:43:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pv3OoWUGRh2f9yhYeImwbw/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:43:09 INFO - Fetch https://queue.taskcluster.net/v1/task/Pv3OoWUGRh2f9yhYeImwbw/artifacts/public/build/target.common.tests.zip into memory 18:43:10 INFO - Expected file size: 59540708 18:43:10 INFO - Obtained file size: 59540708 18:43:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Pv3OoWUGRh2f9yhYeImwbw/artifacts/public/build/target.talos.tests.zip 18:43:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pv3OoWUGRh2f9yhYeImwbw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:43:20 INFO - Fetch https://queue.taskcluster.net/v1/task/Pv3OoWUGRh2f9yhYeImwbw/artifacts/public/build/target.talos.tests.zip into memory 18:43:21 INFO - Expected file size: 14404438 18:43:21 INFO - Obtained file size: 14404438 18:43:21 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')]} 18:43:21 INFO - trying https://queue.taskcluster.net/v1/task/Pv3OoWUGRh2f9yhYeImwbw/artifacts/public/build/target.tar.bz2 18:43:21 INFO - Downloading https://queue.taskcluster.net/v1/task/Pv3OoWUGRh2f9yhYeImwbw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:43:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pv3OoWUGRh2f9yhYeImwbw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:43:22 INFO - Downloaded 66784982 bytes. 18:43:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Pv3OoWUGRh2f9yhYeImwbw/artifacts/public/build/target.tar.bz2 18:43:22 INFO - mkdir: /builds/slave/test/properties 18:43:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:43:22 INFO - Writing to file /builds/slave/test/properties/build_url 18:43:22 INFO - Contents: 18:43:22 INFO - build_url:https://queue.taskcluster.net/v1/task/Pv3OoWUGRh2f9yhYeImwbw/artifacts/public/build/target.tar.bz2 18:43:22 INFO - Running post-action listener: _resource_record_post_action 18:43:22 INFO - Running post-action listener: set_extra_try_arguments 18:43:22 INFO - [mozharness: 2017-04-05 01:43:22.970344Z] Finished download-and-extract step (success) 18:43:22 INFO - [mozharness: 2017-04-05 01:43:22.970441Z] Running populate-webroot step. 18:43:22 INFO - Running pre-action listener: _resource_record_pre_action 18:43:22 INFO - Running main action method: populate_webroot 18:43:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:43:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:43:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:43:22 INFO - '--tppagecycles', 18:43:22 INFO - '7'], 18:43:22 INFO - 'tests': ['tsvgm']}}, 18:43:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:43:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:43:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:43:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:43:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:43:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:43:22 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:43:22 INFO - 'talos_options': ['--disable-e10s'], 18:43:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:43:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:43:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:43:22 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:43:22 INFO - 'talos_options': ['--disable-e10s'], 18:43:22 INFO - 'tests': ['damp', 'tps']}, 18:43:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:43:22 INFO - 'tests': ['damp', 'tps']}, 18:43:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:43:22 INFO - 'tests': ['dromaeo_dom']}, 18:43:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:43:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:43:22 INFO - 'tests': ['basic_compositor_video']}, 18:43:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:43:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:43:22 INFO - 'tests': ['a11yr', 18:43:22 INFO - 'ts_paint', 18:43:22 INFO - 'tpaint', 18:43:22 INFO - 'sessionrestore', 18:43:22 INFO - 'sessionrestore_no_auto_restore', 18:43:22 INFO - 'tabpaint']}, 18:43:22 INFO - 'other-e10s': {'tests': ['a11yr', 18:43:22 INFO - 'ts_paint', 18:43:22 INFO - 'tpaint', 18:43:22 INFO - 'sessionrestore', 18:43:22 INFO - 'sessionrestore_no_auto_restore', 18:43:22 INFO - 'tabpaint']}, 18:43:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:43:22 INFO - 'ts_paint', 18:43:22 INFO - 'tpaint', 18:43:22 INFO - 'sessionrestore', 18:43:22 INFO - 'sessionrestore_no_auto_restore', 18:43:22 INFO - 'tabpaint']}, 18:43:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:43:22 INFO - 'ts_paint', 18:43:22 INFO - 'tpaint', 18:43:22 INFO - 'sessionrestore', 18:43:22 INFO - 'sessionrestore_no_auto_restore', 18:43:22 INFO - 'tabpaint']}, 18:43:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:43:22 INFO - 'tests': ['a11yr', 18:43:22 INFO - 'ts_paint', 18:43:22 INFO - 'tpaint', 18:43:22 INFO - 'sessionrestore', 18:43:22 INFO - 'sessionrestore_no_auto_restore', 18:43:22 INFO - 'tabpaint']}, 18:43:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:43:22 INFO - 'tests': ['a11yr', 18:43:22 INFO - 'ts_paint', 18:43:22 INFO - 'tpaint', 18:43:22 INFO - 'sessionrestore', 18:43:22 INFO - 'sessionrestore_no_auto_restore', 18:43:22 INFO - 'tabpaint']}, 18:43:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:43:22 INFO - 'tests': ['tsvgx', 18:43:22 INFO - 'tsvgr_opacity', 18:43:22 INFO - 'tart', 18:43:22 INFO - 'tscrollx', 18:43:22 INFO - 'cart', 18:43:22 INFO - 'tsvg_static']}, 18:43:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:43:22 INFO - 'tsvgr_opacity', 18:43:22 INFO - 'tart', 18:43:22 INFO - 'tscrollx', 18:43:22 INFO - 'cart', 18:43:22 INFO - 'tsvg_static']}, 18:43:22 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:43:22 INFO - 'talos_options': ['--disable-e10s'], 18:43:22 INFO - 'tests': ['tp5o']}, 18:43:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:43:22 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:43:22 INFO - 'talos_options': ['--disable-e10s', 18:43:22 INFO - '--xperf_path', 18:43:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:43:22 INFO - 'tests': ['tp5n']}, 18:43:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:43:22 INFO - 'talos_options': ['--xperf_path', 18:43:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:43:22 INFO - 'tests': ['tp5n']}}, 18:43:22 INFO - 'talos.zip': {'path': '', 18:43:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:43:22 INFO - Running post-action listener: _resource_record_post_action 18:43:22 INFO - [mozharness: 2017-04-05 01:43:22.983556Z] Finished populate-webroot step (success) 18:43:22 INFO - [mozharness: 2017-04-05 01:43:22.983646Z] Running create-virtualenv step. 18:43:22 INFO - Running pre-action listener: _resource_record_pre_action 18:43:22 INFO - Running main action method: create_virtualenv 18:43:22 INFO - Creating virtualenv /builds/slave/test/build/venv 18:43:22 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 18:43:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:43:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:43:23 INFO - Using real prefix '/usr' 18:43:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:43:23 INFO - Installing distribute.............................................................................................................................................................................................done. 18:43:25 INFO - Installing pip.................done. 18:43:25 INFO - Return code: 0 18:43:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:43:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:43:25 INFO - Reading from file tmpfile_stdout 18:43:25 INFO - Output received: 18:43:25 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) 18:43:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:43: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')]} 18:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43: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')]} 18:43:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:25 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 0x247e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2576a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2719290>, '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 0x2719b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271a040>, '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': '03627c79f6bb3d1578c4a402000001ba-1491356569.35742-1626508172', '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 18:43:25 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 18:43:25 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 18:43:25 INFO - Using env: {'DISPLAY': ':0', 18:43:25 INFO - 'HOME': '/home/cltbld', 18:43:25 INFO - 'LANG': 'en_US.UTF-8', 18:43:25 INFO - 'LANGUAGE': 'en_US:en', 18:43:25 INFO - 'LOGNAME': 'cltbld', 18:43:25 INFO - 'MAIL': '/var/mail/cltbld', 18:43:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:25 INFO - 'MOZ_NO_REMOTE': '1', 18:43:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:25 INFO - 'NO_EM_RESTART': '1', 18:43:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:25 INFO - 'PWD': '/builds/slave/test', 18:43:25 INFO - 'SHELL': '/bin/bash', 18:43:25 INFO - 'SHLVL': '1', 18:43:25 INFO - 'TERM': 'linux', 18:43:25 INFO - 'TMOUT': '86400', 18:43:25 INFO - 'USER': 'cltbld', 18:43:25 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1491356569.35742-1626508172', 18:43:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:25 INFO - '_': '/tools/buildbot/bin/python'} 18:43:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:25 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 18:43:25 INFO - Cleaning up... 18:43:25 INFO - Return code: 0 18:43:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:43: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')]} 18:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43: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')]} 18:43:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x247e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2576a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2719290>, '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 0x2719b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271a040>, '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': '03627c79f6bb3d1578c4a402000001ba-1491356569.35742-1626508172', '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 18:43:26 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 18:43:26 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 18:43:26 INFO - Using env: {'DISPLAY': ':0', 18:43:26 INFO - 'HOME': '/home/cltbld', 18:43:26 INFO - 'LANG': 'en_US.UTF-8', 18:43:26 INFO - 'LANGUAGE': 'en_US:en', 18:43:26 INFO - 'LOGNAME': 'cltbld', 18:43:26 INFO - 'MAIL': '/var/mail/cltbld', 18:43:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:26 INFO - 'MOZ_NO_REMOTE': '1', 18:43:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:26 INFO - 'NO_EM_RESTART': '1', 18:43:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:26 INFO - 'PWD': '/builds/slave/test', 18:43:26 INFO - 'SHELL': '/bin/bash', 18:43:26 INFO - 'SHLVL': '1', 18:43:26 INFO - 'TERM': 'linux', 18:43:26 INFO - 'TMOUT': '86400', 18:43:26 INFO - 'USER': 'cltbld', 18:43:26 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1491356569.35742-1626508172', 18:43:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:26 INFO - '_': '/tools/buildbot/bin/python'} 18:43:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:26 INFO - Downloading/unpacking psutil>=3.1.1 18:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:26 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 18:43:26 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 18:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:43:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:43:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:43:28 INFO - Installing collected packages: psutil 18:43:28 INFO - Running setup.py install for psutil 18:43:28 INFO - building 'psutil._psutil_linux' extension 18:43:28 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 18:43:28 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:43:28 INFO - building 'psutil._psutil_posix' extension 18:43:28 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 18:43:28 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:43:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:43:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:43:28 INFO - Successfully installed psutil 18:43:28 INFO - Cleaning up... 18:43:28 INFO - Return code: 0 18:43:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:43:28 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')]} 18:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:28 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')]} 18:43:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x247e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2576a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2719290>, '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 0x2719b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271a040>, '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': '03627c79f6bb3d1578c4a402000001ba-1491356569.35742-1626508172', '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 18:43:28 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 18:43:28 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 18:43:28 INFO - Using env: {'DISPLAY': ':0', 18:43:28 INFO - 'HOME': '/home/cltbld', 18:43:28 INFO - 'LANG': 'en_US.UTF-8', 18:43:28 INFO - 'LANGUAGE': 'en_US:en', 18:43:28 INFO - 'LOGNAME': 'cltbld', 18:43:28 INFO - 'MAIL': '/var/mail/cltbld', 18:43:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:28 INFO - 'MOZ_NO_REMOTE': '1', 18:43:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:28 INFO - 'NO_EM_RESTART': '1', 18:43:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:28 INFO - 'PWD': '/builds/slave/test', 18:43:28 INFO - 'SHELL': '/bin/bash', 18:43:28 INFO - 'SHLVL': '1', 18:43:28 INFO - 'TERM': 'linux', 18:43:28 INFO - 'TMOUT': '86400', 18:43:28 INFO - 'USER': 'cltbld', 18:43:28 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1491356569.35742-1626508172', 18:43:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:28 INFO - '_': '/tools/buildbot/bin/python'} 18:43:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:29 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 18:43:29 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 18:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:43:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:43:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:43:31 INFO - Installing collected packages: mozsystemmonitor 18:43:31 INFO - Running setup.py install for mozsystemmonitor 18:43:31 INFO - Successfully installed mozsystemmonitor 18:43:31 INFO - Cleaning up... 18:43:31 INFO - Return code: 0 18:43:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:43:31 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')]} 18:43:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:31 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')]} 18:43:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x247e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2576a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2719290>, '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 0x2719b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271a040>, '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': '03627c79f6bb3d1578c4a402000001ba-1491356569.35742-1626508172', '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 18:43:31 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 18:43:31 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 18:43:31 INFO - Using env: {'DISPLAY': ':0', 18:43:31 INFO - 'HOME': '/home/cltbld', 18:43:31 INFO - 'LANG': 'en_US.UTF-8', 18:43:31 INFO - 'LANGUAGE': 'en_US:en', 18:43:31 INFO - 'LOGNAME': 'cltbld', 18:43:31 INFO - 'MAIL': '/var/mail/cltbld', 18:43:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:31 INFO - 'MOZ_NO_REMOTE': '1', 18:43:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:31 INFO - 'NO_EM_RESTART': '1', 18:43:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:31 INFO - 'PWD': '/builds/slave/test', 18:43:31 INFO - 'SHELL': '/bin/bash', 18:43:31 INFO - 'SHLVL': '1', 18:43:31 INFO - 'TERM': 'linux', 18:43:31 INFO - 'TMOUT': '86400', 18:43:31 INFO - 'USER': 'cltbld', 18:43:31 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1491356569.35742-1626508172', 18:43:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:31 INFO - '_': '/tools/buildbot/bin/python'} 18:43:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:31 INFO - Downloading/unpacking jsonschema==2.5.1 18:43:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:31 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 18:43:31 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 18:43:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:43:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:43:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:33 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 18:43:33 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 18:43:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:33 INFO - Downloading functools32-3.2.3-2.tar.gz 18:43:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:43:33 INFO - warning: no files found matching '*.txt' 18:43:33 INFO - no previously-included directories found matching 'build' 18:43:33 INFO - no previously-included directories found matching 'dist' 18:43:33 INFO - no previously-included directories found matching '.git*' 18:43:33 INFO - Installing collected packages: jsonschema, functools32 18:43:33 INFO - Running setup.py install for functools32 18:43:33 INFO - warning: no files found matching '*.txt' 18:43:33 INFO - no previously-included directories found matching 'build' 18:43:33 INFO - no previously-included directories found matching 'dist' 18:43:33 INFO - no previously-included directories found matching '.git*' 18:43:33 INFO - Successfully installed jsonschema functools32 18:43:33 INFO - Cleaning up... 18:43:34 INFO - Return code: 0 18:43:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:43:34 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')]} 18:43:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:34 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')]} 18:43:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:34 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 0x247e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2576a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2719290>, '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 0x2719b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271a040>, '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': '03627c79f6bb3d1578c4a402000001ba-1491356569.35742-1626508172', '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 18:43:34 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 18:43:34 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 18:43:34 INFO - Using env: {'DISPLAY': ':0', 18:43:34 INFO - 'HOME': '/home/cltbld', 18:43:34 INFO - 'LANG': 'en_US.UTF-8', 18:43:34 INFO - 'LANGUAGE': 'en_US:en', 18:43:34 INFO - 'LOGNAME': 'cltbld', 18:43:34 INFO - 'MAIL': '/var/mail/cltbld', 18:43:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:34 INFO - 'MOZ_NO_REMOTE': '1', 18:43:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:34 INFO - 'NO_EM_RESTART': '1', 18:43:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:34 INFO - 'PWD': '/builds/slave/test', 18:43:34 INFO - 'SHELL': '/bin/bash', 18:43:34 INFO - 'SHLVL': '1', 18:43:34 INFO - 'TERM': 'linux', 18:43:34 INFO - 'TMOUT': '86400', 18:43:34 INFO - 'USER': 'cltbld', 18:43:34 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1491356569.35742-1626508172', 18:43:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:34 INFO - '_': '/tools/buildbot/bin/python'} 18:43:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:43:34 INFO - Cleaning up... 18:43:34 INFO - Return code: 0 18:43:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:43:34 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')]} 18:43:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:34 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')]} 18:43:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:34 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 0x247e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2576a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2719290>, '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 0x2719b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271a040>, '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': '03627c79f6bb3d1578c4a402000001ba-1491356569.35742-1626508172', '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 18:43:34 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 18:43:34 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 18:43:34 INFO - Using env: {'DISPLAY': ':0', 18:43:34 INFO - 'HOME': '/home/cltbld', 18:43:34 INFO - 'LANG': 'en_US.UTF-8', 18:43:34 INFO - 'LANGUAGE': 'en_US:en', 18:43:34 INFO - 'LOGNAME': 'cltbld', 18:43:34 INFO - 'MAIL': '/var/mail/cltbld', 18:43:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:34 INFO - 'MOZ_NO_REMOTE': '1', 18:43:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:34 INFO - 'NO_EM_RESTART': '1', 18:43:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:34 INFO - 'PWD': '/builds/slave/test', 18:43:34 INFO - 'SHELL': '/bin/bash', 18:43:34 INFO - 'SHLVL': '1', 18:43:34 INFO - 'TERM': 'linux', 18:43:34 INFO - 'TMOUT': '86400', 18:43:34 INFO - 'USER': 'cltbld', 18:43:34 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1491356569.35742-1626508172', 18:43:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:34 INFO - '_': '/tools/buildbot/bin/python'} 18:43:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:34 INFO - Downloading/unpacking blobuploader==1.2.4 18:43:34 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 18:43:34 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 18:43:34 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 18:43:34 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 18:43:34 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 18:43:34 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 18:43:36 INFO - Downloading blobuploader-1.2.4.tar.gz 18:43:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:43:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:43:36 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 18:43:36 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 18:43:36 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 18:43:36 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 18:43:36 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 18:43:36 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 18:43:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:43:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:43:37 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 18:43:37 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 18:43:37 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 18:43:37 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 18:43:37 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 18:43:37 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 18:43:37 INFO - Downloading docopt-0.6.1.tar.gz 18:43:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:43:37 INFO - Installing collected packages: blobuploader, requests, docopt 18:43:37 INFO - Running setup.py install for blobuploader 18:43:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:43:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:43:37 INFO - Running setup.py install for requests 18:43:37 INFO - Running setup.py install for docopt 18:43:37 INFO - Successfully installed blobuploader requests docopt 18:43:37 INFO - Cleaning up... 18:43:37 INFO - Return code: 0 18:43:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:43:37 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')]} 18:43:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:37 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')]} 18:43:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:37 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 0x247e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2576a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2719290>, '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 0x2719b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271a040>, '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': '03627c79f6bb3d1578c4a402000001ba-1491356569.35742-1626508172', '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 18:43:37 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 18:43:37 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 18:43:37 INFO - Using env: {'DISPLAY': ':0', 18:43:37 INFO - 'HOME': '/home/cltbld', 18:43:37 INFO - 'LANG': 'en_US.UTF-8', 18:43:37 INFO - 'LANGUAGE': 'en_US:en', 18:43:37 INFO - 'LOGNAME': 'cltbld', 18:43:37 INFO - 'MAIL': '/var/mail/cltbld', 18:43:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:37 INFO - 'MOZ_NO_REMOTE': '1', 18:43:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:37 INFO - 'NO_EM_RESTART': '1', 18:43:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:37 INFO - 'PWD': '/builds/slave/test', 18:43:37 INFO - 'SHELL': '/bin/bash', 18:43:37 INFO - 'SHLVL': '1', 18:43:37 INFO - 'TERM': 'linux', 18:43:37 INFO - 'TMOUT': '86400', 18:43:37 INFO - 'USER': 'cltbld', 18:43:37 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1491356569.35742-1626508172', 18:43:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:37 INFO - '_': '/tools/buildbot/bin/python'} 18:43:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:43:38 INFO - Running setup.py (path:/tmp/pip-lhoTlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:43:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:43:38 INFO - Running setup.py (path:/tmp/pip-fYuQ0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:43:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:43:38 INFO - Running setup.py (path:/tmp/pip-YkEwTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:43:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:43:38 INFO - Running setup.py (path:/tmp/pip-MUwAIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:43:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:43:38 INFO - Running setup.py (path:/tmp/pip-Chbr0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:43:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:43:38 INFO - Running setup.py (path:/tmp/pip-wVcRXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:43:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:43:38 INFO - Running setup.py (path:/tmp/pip-qFSujo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:43:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:43:38 INFO - Running setup.py (path:/tmp/pip-fXrLh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:43:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:43:38 INFO - Running setup.py (path:/tmp/pip-ea3eeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:43:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:43:38 INFO - Running setup.py (path:/tmp/pip-LD8XyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:43:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:43:38 INFO - Running setup.py (path:/tmp/pip-46PdWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:43:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:43:38 INFO - Running setup.py (path:/tmp/pip-kHab1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:43:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:43:38 INFO - Running setup.py (path:/tmp/pip-0tBORD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:43:39 INFO - Running setup.py (path:/tmp/pip-L9aNUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:43:39 INFO - Running setup.py (path:/tmp/pip-v5oNsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:43:39 INFO - Running setup.py (path:/tmp/pip-qZP_Be-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:43:39 INFO - Running setup.py (path:/tmp/pip-DLGnJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:43:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:43:39 INFO - Running setup.py install for manifestparser 18:43:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:43:39 INFO - Running setup.py install for mozcrash 18:43:39 INFO - Running setup.py install for mozdebug 18:43:39 INFO - Running setup.py install for mozdevice 18:43:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:43:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:43:39 INFO - Running setup.py install for mozfile 18:43:39 INFO - Running setup.py install for mozhttpd 18:43:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:43:39 INFO - Running setup.py install for mozinfo 18:43:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:43:40 INFO - Running setup.py install for mozInstall 18:43:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:43:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:43:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:43:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:43:40 INFO - Running setup.py install for mozleak 18:43:40 INFO - Running setup.py install for mozlog 18:43:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:43:40 INFO - Running setup.py install for moznetwork 18:43:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:43:40 INFO - Running setup.py install for mozprocess 18:43:40 INFO - Running setup.py install for mozprofile 18:43:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:43:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:43:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:43:40 INFO - Running setup.py install for mozrunner 18:43:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:43:40 INFO - Running setup.py install for mozscreenshot 18:43:40 INFO - Running setup.py install for moztest 18:43:41 INFO - Running setup.py install for mozversion 18:43:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:43:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:43:41 INFO - Cleaning up... 18:43:41 INFO - Return code: 0 18:43:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:43:41 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')]} 18:43:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:41 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')]} 18:43:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:41 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 0x247e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2576a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2719290>, '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 0x2719b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271a040>, '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': '03627c79f6bb3d1578c4a402000001ba-1491356569.35742-1626508172', '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 18:43:41 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 18:43:41 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 18:43:41 INFO - Using env: {'DISPLAY': ':0', 18:43:41 INFO - 'HOME': '/home/cltbld', 18:43:41 INFO - 'LANG': 'en_US.UTF-8', 18:43:41 INFO - 'LANGUAGE': 'en_US:en', 18:43:41 INFO - 'LOGNAME': 'cltbld', 18:43:41 INFO - 'MAIL': '/var/mail/cltbld', 18:43:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:41 INFO - 'MOZ_NO_REMOTE': '1', 18:43:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:41 INFO - 'NO_EM_RESTART': '1', 18:43:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:41 INFO - 'PWD': '/builds/slave/test', 18:43:41 INFO - 'SHELL': '/bin/bash', 18:43:41 INFO - 'SHLVL': '1', 18:43:41 INFO - 'TERM': 'linux', 18:43:41 INFO - 'TMOUT': '86400', 18:43:41 INFO - 'USER': 'cltbld', 18:43:41 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1491356569.35742-1626508172', 18:43:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:41 INFO - '_': '/tools/buildbot/bin/python'} 18:43:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:43:41 INFO - Running setup.py (path:/tmp/pip-YcO8bC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:43:41 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)) 18:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:43:41 INFO - Running setup.py (path:/tmp/pip-anlCS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:43:41 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)) 18:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:43:41 INFO - Running setup.py (path:/tmp/pip-o6DK5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:43:41 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)) 18:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:43:41 INFO - Running setup.py (path:/tmp/pip-aRPvYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:43:41 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)) 18:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:43:41 INFO - Running setup.py (path:/tmp/pip-W9Vt4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:43:41 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)) 18:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:43:41 INFO - Running setup.py (path:/tmp/pip-FLHDE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:43:41 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)) 18:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:43:41 INFO - Running setup.py (path:/tmp/pip-k73Dvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:43:41 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)) 18:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:43:41 INFO - Running setup.py (path:/tmp/pip-Rwlqwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:43:41 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)) 18:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:43:41 INFO - Running setup.py (path:/tmp/pip-vW2izX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:43:42 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)) 18:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:43:42 INFO - Running setup.py (path:/tmp/pip-M1YXWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:43:42 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)) 18:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:43:42 INFO - Running setup.py (path:/tmp/pip-t4NesG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:43:42 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)) 18:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:43:42 INFO - Running setup.py (path:/tmp/pip-7dE42r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:43:42 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)) 18:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:43:42 INFO - Running setup.py (path:/tmp/pip-eNRC1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:43:42 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)) 18:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:43:42 INFO - Running setup.py (path:/tmp/pip-3YiJ3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:43:42 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)) 18:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:43:42 INFO - Running setup.py (path:/tmp/pip-WBWbeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:43:42 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)) 18:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:43:42 INFO - Running setup.py (path:/tmp/pip-00CYb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:43:42 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)) 18:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:43:42 INFO - Running setup.py (path:/tmp/pip-n1Fy_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:43:42 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)) 18:43:42 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)) 18:43:42 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)) 18:43:42 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)) 18:43:42 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)) 18:43:42 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)) 18:43:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:43:42 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 18:43:42 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 18:43:42 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 18:43:42 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 18:43:42 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 18:43:42 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 18:43:44 INFO - Downloading blessings-1.6.tar.gz 18:43:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:43:44 INFO - Installing collected packages: blessings 18:43:44 INFO - Running setup.py install for blessings 18:43:44 INFO - Successfully installed blessings 18:43:44 INFO - Cleaning up... 18:43:44 INFO - Return code: 0 18:43:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:43:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:43:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:43:45 INFO - Reading from file tmpfile_stdout 18:43:45 INFO - Current package versions: 18:43:45 INFO - argparse == 1.2.1 18:43:45 INFO - blessings == 1.6 18:43:45 INFO - blobuploader == 1.2.4 18:43:45 INFO - docopt == 0.6.1 18:43:45 INFO - functools32 == 3.2.3-2 18:43:45 INFO - jsonschema == 2.5.1 18:43:45 INFO - manifestparser == 1.1 18:43:45 INFO - mozInstall == 1.12 18:43:45 INFO - mozcrash == 1.0 18:43:45 INFO - mozdebug == 0.1 18:43:45 INFO - mozdevice == 0.49 18:43:45 INFO - mozfile == 1.2 18:43:45 INFO - mozhttpd == 0.7 18:43:45 INFO - mozinfo == 0.9 18:43:45 INFO - mozleak == 0.1 18:43:45 INFO - mozlog == 3.4 18:43:45 INFO - moznetwork == 0.27 18:43:45 INFO - mozprocess == 0.25 18:43:45 INFO - mozprofile == 0.28 18:43:45 INFO - mozrunner == 6.13 18:43:45 INFO - mozscreenshot == 0.1 18:43:45 INFO - mozsystemmonitor == 0.3 18:43:45 INFO - moztest == 0.8 18:43:45 INFO - mozversion == 1.4 18:43:45 INFO - psutil == 3.1.1 18:43:45 INFO - requests == 1.2.3 18:43:45 INFO - wsgiref == 0.1.2 18:43:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:43:45 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')]} 18:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:45 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')]} 18:43:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:45 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 0x247e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2576a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2719290>, '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 0x2719b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271a040>, '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': '03627c79f6bb3d1578c4a402000001ba-1491356569.35742-1626508172', '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 18:43:45 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 18:43:45 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 18:43:45 INFO - Using env: {'DISPLAY': ':0', 18:43:45 INFO - 'HOME': '/home/cltbld', 18:43:45 INFO - 'LANG': 'en_US.UTF-8', 18:43:45 INFO - 'LANGUAGE': 'en_US:en', 18:43:45 INFO - 'LOGNAME': 'cltbld', 18:43:45 INFO - 'MAIL': '/var/mail/cltbld', 18:43:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:45 INFO - 'MOZ_NO_REMOTE': '1', 18:43:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:45 INFO - 'NO_EM_RESTART': '1', 18:43:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:45 INFO - 'PWD': '/builds/slave/test', 18:43:45 INFO - 'SHELL': '/bin/bash', 18:43:45 INFO - 'SHLVL': '1', 18:43:45 INFO - 'TERM': 'linux', 18:43:45 INFO - 'TMOUT': '86400', 18:43:45 INFO - 'USER': 'cltbld', 18:43:45 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1491356569.35742-1626508172', 18:43:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:45 INFO - '_': '/tools/buildbot/bin/python'} 18:43:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:45 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)) 18:43:45 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)) 18:43:45 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)) 18:43:45 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)) 18:43:45 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)) 18:43:45 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)) 18:43:45 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)) 18:43:45 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)) 18:43:45 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)) 18:43:45 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)) 18:43:45 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)) 18:43:45 INFO - Cleaning up... 18:43:45 INFO - Return code: 0 18:43:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:43:45 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')]} 18:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:45 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')]} 18:43:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:45 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 0x247e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2576a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2719290>, '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 0x2719b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271a040>, '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': '03627c79f6bb3d1578c4a402000001ba-1491356569.35742-1626508172', '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 18:43:45 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 18:43:45 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 18:43:45 INFO - Using env: {'DISPLAY': ':0', 18:43:45 INFO - 'HOME': '/home/cltbld', 18:43:45 INFO - 'LANG': 'en_US.UTF-8', 18:43:45 INFO - 'LANGUAGE': 'en_US:en', 18:43:45 INFO - 'LOGNAME': 'cltbld', 18:43:45 INFO - 'MAIL': '/var/mail/cltbld', 18:43:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:45 INFO - 'MOZ_NO_REMOTE': '1', 18:43:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:45 INFO - 'NO_EM_RESTART': '1', 18:43:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:45 INFO - 'PWD': '/builds/slave/test', 18:43:45 INFO - 'SHELL': '/bin/bash', 18:43:45 INFO - 'SHLVL': '1', 18:43:45 INFO - 'TERM': 'linux', 18:43:45 INFO - 'TMOUT': '86400', 18:43:45 INFO - 'USER': 'cltbld', 18:43:45 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1491356569.35742-1626508172', 18:43:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:45 INFO - '_': '/tools/buildbot/bin/python'} 18:43:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:43:45 INFO - Cleaning up... 18:43:45 INFO - Return code: 0 18:43:45 INFO - Running post-action listener: _resource_record_post_action 18:43:45 INFO - Running post-action listener: _start_resource_monitoring 18:43:45 INFO - Starting resource monitoring. 18:43:45 INFO - [mozharness: 2017-04-05 01:43:45.609836Z] Finished create-virtualenv step (success) 18:43:45 INFO - [mozharness: 2017-04-05 01:43:45.610345Z] Running install step. 18:43:45 INFO - Running pre-action listener: _resource_record_pre_action 18:43:45 INFO - Running main action method: install 18:43:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:43:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:43:45 INFO - Reading from file tmpfile_stdout 18:43:45 INFO - Detecting whether we're running mozinstall >=1.0... 18:43:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:43:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:43:45 INFO - Reading from file tmpfile_stdout 18:43:45 INFO - Output received: 18:43:45 INFO - Usage: mozinstall [options] installer 18:43:45 INFO - Options: 18:43:45 INFO - -h, --help show this help message and exit 18:43:45 INFO - -d DEST, --destination=DEST 18:43:45 INFO - Directory to install application into. [default: 18:43:45 INFO - "/builds/slave/test"] 18:43:45 INFO - --app=APP Application being installed. [default: firefox] 18:43:45 INFO - mkdir: /builds/slave/test/build/application 18:43:45 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'] 18:43:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:44:02 INFO - Reading from file tmpfile_stdout 18:44:02 INFO - Output received: 18:44:02 INFO - /builds/slave/test/build/application/firefox/firefox 18:44:02 INFO - Running post-action listener: _resource_record_post_action 18:44:02 INFO - [mozharness: 2017-04-05 01:44:02.497224Z] Finished install step (success) 18:44:02 INFO - [mozharness: 2017-04-05 01:44:02.497489Z] Running run-tests step. 18:44:02 INFO - Running pre-action listener: _resource_record_pre_action 18:44:02 INFO - Running main action method: run_tests 18:44:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:44:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:44:02 INFO - Python 2.7.3 18:44:02 INFO - Return code: 0 18:44:02 INFO - grabbing minidump binary from tooltool 18:44: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')]} 18:44:02 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 0x2719290>, '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 0x2719b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271a040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:44:02 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 18:44:02 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 18:44:02 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 18:44:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:44:02 INFO - Return code: 0 18:44:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:44:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:44:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:44:02 INFO - ENV: RUST_BACKTRACE is now 1 18:44:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:44:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:44:02 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/Pv3OoWUGRh2f9yhYeImwbw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 18:44:02 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/Pv3OoWUGRh2f9yhYeImwbw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 18:44:02 INFO - Using env: {'DISPLAY': ':0', 18:44:02 INFO - 'HOME': '/home/cltbld', 18:44:02 INFO - 'LANG': 'en_US.UTF-8', 18:44:02 INFO - 'LANGUAGE': 'en_US:en', 18:44:02 INFO - 'LOGNAME': 'cltbld', 18:44:02 INFO - 'MAIL': '/var/mail/cltbld', 18:44:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:44:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:44:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:02 INFO - 'MOZ_NO_REMOTE': '1', 18:44:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:44:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:02 INFO - 'NO_EM_RESTART': '1', 18:44:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:02 INFO - 'PWD': '/builds/slave/test', 18:44:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:44:02 INFO - 'RUST_BACKTRACE': '1', 18:44:02 INFO - 'SHELL': '/bin/bash', 18:44:02 INFO - 'SHLVL': '1', 18:44:02 INFO - 'TERM': 'linux', 18:44:02 INFO - 'TMOUT': '86400', 18:44:02 INFO - 'USER': 'cltbld', 18:44:02 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1491356569.35742-1626508172', 18:44:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:02 INFO - '_': '/tools/buildbot/bin/python'} 18:44:02 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/Pv3OoWUGRh2f9yhYeImwbw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 18:44:02 INFO - mozversion application_buildid: 20170405004534 18:44:02 INFO - mozversion application_changeset: 896e9cfb9d67d6a73e70e39532f31306c22202cb 18:44:02 INFO - mozversion application_display_name: FirefoxDeveloperEdition 18:44:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:44:02 INFO - mozversion application_name: Firefox 18:44:02 INFO - mozversion application_remotingname: firefox-dev 18:44:02 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:44:02 INFO - mozversion application_vendor: Mozilla 18:44:02 INFO - mozversion application_version: 54.0a2 18:44:02 INFO - mozversion platform_buildid: 20170405004534 18:44:02 INFO - mozversion platform_changeset: 896e9cfb9d67d6a73e70e39532f31306c22202cb 18:44:02 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:44:02 INFO - mozversion platform_version: 54.0a2 18:44:02 INFO - using testdate: 1491356642 18:44:02 INFO - actual date: 1491356642 18:44:02 INFO - starting webserver on 'localhost:49869' 18:44:02 INFO - SUITE-START | Running 2 tests 18:44:02 INFO - TEST-START | dromaeo_css 18:44:02 INFO - operating with platform_type : linux_ 18:44:02 INFO - Initialising browser for dromaeo_css test... 18:44:02 INFO - TEST-INFO | started process 32602 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6jh29T/profile http://localhost:49869/getInfo.html) 18:44:06 INFO - PROCESS | 32602 | __metrics Screen width/height:1600/1200 18:44:06 INFO - PROCESS | 32602 | colorDepth:24 18:44:06 INFO - PROCESS | 32602 | Browser inner width/height: 1024/697 18:44:06 INFO - PROCESS | 32602 | __metrics 18:44:07 ERROR - PROCESS | 32602 | 1491356647614 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4954:11 < observe@XPIProvider.jsm:2917:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 18:44:07 INFO - PROCESS | 32602 | 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" 18:44:07 INFO - PROCESS | 32602 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:44:08 INFO - TEST-INFO | 32602: exit 0 18:44:08 INFO - Browser initialized. 18:44:08 INFO - Running cycle 1/1 for dromaeo_css test... 18:44:08 INFO - TEST-INFO | started process 32691 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6jh29T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:44:20 INFO - PROCESS | 32691 | RSS: Main: 140075008 18:44:20 INFO - PROCESS | 32691 | 18:47:21 INFO - PROCESS | 32691 | Cycle 1(1): loaded http://localhost:49869/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49869/tests/dromaeo/cssquery-ext.html) 18:47:23 INFO - PROCESS | 32691 | RSS: Main: 286117888 18:47:23 INFO - PROCESS | 32691 | 18:49:10 INFO - PROCESS | 32691 | ************************* 18:49:10 INFO - PROCESS | 32691 | A coding exception was thrown and uncaught in a Task. 18:49:10 INFO - PROCESS | 32691 | 18:49:10 ERROR - PROCESS | 32691 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:49:10 INFO - PROCESS | 32691 | Full stack: 18:49:10 INFO - PROCESS | 32691 | ************************* 18:49:10 INFO - PROCESS | 32691 | ************************* 18:49:10 INFO - PROCESS | 32691 | A coding exception was thrown and uncaught in a Task. 18:49:10 INFO - PROCESS | 32691 | 18:49:10 ERROR - PROCESS | 32691 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:49:10 INFO - PROCESS | 32691 | Full stack: 18:49:10 INFO - PROCESS | 32691 | ************************* 18:49:10 INFO - PROCESS | 32691 | ************************* 18:49:10 INFO - PROCESS | 32691 | A coding exception was thrown and uncaught in a Task. 18:49:10 INFO - PROCESS | 32691 | 18:49:10 ERROR - PROCESS | 32691 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:49:10 INFO - PROCESS | 32691 | Full stack: 18:49:10 INFO - PROCESS | 32691 | ************************* 18:49:10 INFO - PROCESS | 32691 | ************************* 18:49:10 INFO - PROCESS | 32691 | A coding exception was thrown and uncaught in a Task. 18:49:10 INFO - PROCESS | 32691 | 18:49:10 ERROR - PROCESS | 32691 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:49:10 INFO - PROCESS | 32691 | Full stack: 18:49:10 INFO - PROCESS | 32691 | ************************* 18:50:25 INFO - PROCESS | 32691 | Cycle 1(1): loaded http://localhost:49869/tests/dromaeo/cssquery-ext.html (next: http://localhost:49869/tests/dromaeo/cssquery-jquery.html) 18:50:26 INFO - PROCESS | 32691 | RSS: Main: 222466048 18:50:26 INFO - PROCESS | 32691 | 18:53:28 INFO - PROCESS | 32691 | Cycle 1(1): loaded http://localhost:49869/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49869/tests/dromaeo/cssquery-mootools.html) 18:53:28 INFO - PROCESS | 32691 | RSS: Main: 215166976 18:53:28 INFO - PROCESS | 32691 | 18:56:30 INFO - PROCESS | 32691 | Cycle 1(1): loaded http://localhost:49869/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49869/tests/dromaeo/cssquery-prototype.html) 18:56:31 INFO - PROCESS | 32691 | RSS: Main: 193474560 18:56:31 INFO - PROCESS | 32691 | 18:59:34 INFO - PROCESS | 32691 | Cycle 1(1): loaded http://localhost:49869/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49869/tests/dromaeo/cssquery-yui.html) 18:59:34 INFO - PROCESS | 32691 | RSS: Main: 176025600 18:59:34 INFO - PROCESS | 32691 | 19:02:37 INFO - PROCESS | 32691 | Cycle 1(1): loaded http://localhost:49869/tests/dromaeo/cssquery-yui.html (next: http://localhost:49869/tests/dromaeo/cssquery-dojo.html) 19:02:37 INFO - PROCESS | 32691 | RSS: Main: 252153856 19:02:37 INFO - PROCESS | 32691 | 19:02:37 INFO - PROCESS | 32691 | __start_tp_report 19:02:37 INFO - PROCESS | 32691 | _x_x_mozilla_page_load 19:02:37 INFO - PROCESS | 32691 | _x_x_mozilla_page_load_details 19:02:37 INFO - PROCESS | 32691 | |i|pagename|runs| 19:02:37 INFO - PROCESS | 32691 | |0;dojo.html;3382.2389962258485;3424.7260219182454;3438.1576513754135;3439.191789929367;3480.791152530848;5754.654720716755;5825.854353641161;5830.795922142725;5833.533317334608;5868.4718375346265;5830.941690583093;5879.617824841383;5897.970510147454;5898.734556944937;5900.3214630317525;5214.4524824893315;5227.4511176326505;5244.501772331641;5306.8407947761625;5320.201969704556;5104.8979020419565;5133.794648214067;5185.818496352609;5319.335083114611;5323.866903327409;5278.076336641092;5290.65610735301;5299.12564426871;5306.893862122774;5317.627766056377;5307.495787900143;5311.575073994071;5313;5322.600804939606;5332.760025798849;5043.9747801260755;5070.923936140961;5188.143956247215;5252.973735131338;5307.787688492455;5701;5713.400092990218;5750.856228594319;5776.682282474462;5788.710564471759;6215.471684906788;6265.592736472115;6269.435750782452;6271.059341098826;6272.87454250917;6054.364291749391;6308;6318.810435686937;6340.144080549159;6343.429091381751;5776.682282474462;5788.18965344852;5837.445442682938;5842.298924129089;5849.444302791228;6374.075759014917;6401.679916004181;6411.070394792729;6412.166418365676;6416.101745755598;6113.419225173601;6174.25908890936;6179.104029915637;6187.195664563668;6188.4739797117745;6064.272287325549;6108.083787431832;6147.354527774519;6191.040388739752;6204.937950620526;6226.439620434092;6282.591631543935;6283.8114856554375;6286.277078136073;6288.245410550763;6072.089186621954;6116.541259405473;6123.203983482208;6126.203593532812;6134.173184329662;4648.093621743795;4657.1617108920045;4665.860024199212;4671.182543054952;4700.271457924027;4125.834966601303;4142.627163555295;4170.186813571385;4244.129953359554;4258.190943720683;5925.140854576062;5952.196453478725;5975.731092100779;5981.043033114768;5983.700814959322;6191.752329906753;6194.5044396448175;6197.690115494207;6202.596831205957;6214.130021796952;5834.416558344132;5875.853103672443;5951.077582974646;5957.702114894325;5964.612300200473;5258;5309.601779866448;5338.199270109515;5340.092184328673;5373.11343628297;6490.48076153916;6525.445337146396;6531.738730450728;6531.738730450728;6539.08452816606;6084.087386891824;6236.968815155895;6304.873902522016;6308.810735677937;6313.40022697843;6412.743490260337;6422.518311126778;6456.7740129095255;6574.079628851869;6590.044443555562;6208.72060757258;6215.254169499508;6221.47117495018;6222.09779581949;6223.0354295084335;6267.185265915402;6318.873622527615;6330.082138089859;6339.080833279241;6340.334264902119;5919.112133179885;5986.431289027535;6049.364816694184;6096.908546371719;6119.959572021022;6053;6068.120122582289;6102.572819902564;6119.816405507842;6137.41694539018;5910.320313163869;6128.693565321627;6143.754249829957;6145.631262124287;6156.569040167145;6001.729922153426;6075.3317135115985;6104.084387341934;6124.045297608125;6188.381161883775;6049.18336024631;6053.788117415869;6055.515558755201;6062.757489700362;6084.269887613515 19:02:37 INFO - PROCESS | 32691 | |1;ext.html;760.3119177144682;845.1379592815329;864.2826454043145;917.9127982841632;933.8505839065751;30331.241718957037;30846;32787.67212327879;32799.67200327996;42281.36577951325;43951;44165.337519937224;44201.33697994533;44241.778791106;44242;9007.099290071006;9143.954280228623;9153.496557689325;9154.130357616015;9165.175134237918;7603.847923041536;7770.145284018753;8999.325050621197;9096.226820720247;10542.156627469822;10844.511996960116;10878.020978111968;10883.83674244887;10884.455777211148;10887.673369798918;10843.240973131884;10866.348019118877;10866.511007004665;10867.402292873889;10874.238803283693;10583.62957296491;10613.946930265376;10634;10640.733981650443;10643.680689579247;41676.79161604203;41883.581164188574;41955;41956;41968.79015604933;4103.548609652936;4112.033672087057;4151.7924103794685;4208.3687446882905;4238.025254191553;26209.959085919607;29266.268343291376;29383.70616293831;29584.55623165654;29908;3437.5015622734563;3479.4780782882517;3495.405781017233;3591.281743651254;3599.3881040222964;228239;229364;230273;230561;230941;46166;46332.7683361581;46353;46373.30440043402;46389.07221855544;48384.516154838;48387;48509.5149048512;48804;48824.511754882;14965.700685986438;15411.768823467657;15418.614534636723;15424.5372638821;15433;13154.144980576231;13157.802632960513;13197.604071877668;13208.141470804367;13208.801867971988;11463.140264480196;11779.528818847322;12724.745505089846;13081.084324097223;13415;5424.891502169935;5484.890302194013;5597.496225339739;5607.467290607386;5612.775488980476;1035.2597892506894;1043.9269251152498;1046.1483174780597;1234.2409418207737;1302.863199364072;26690.5996410054;27213.591796123073;27433.31416714598;27490.450190996067;27521.31196720098;1363.8772510473907;1372.9656758580916;1381.9170849749048;1383.688670049231;1393.5888912770756;14348.713025739427;14408;14493.347799349054;14500.419983200554;14763.33564989578;166460;166846;167237;167279;167645;57530.712346438;57822.421775782546;57923.23498972553;57974.42025579775;57999.130013049835;1498.4530646314236;1538.230884557721;1549.5196489088419;1559.4697802746894;1562.3281988744948;25010.874945625157;26293;26473.205803825917;26549;26615;42503.362449562665;42716.78641606772;42793.78603106965;42856.35715464333;42911.57088429201;336964;338193;338435;338890;338974;31252.218694532818;32233;32235.194120147185;32238.516422253215;32241.193970150933;33420.83289583537;40925.59074409218;42243.3663495054;45723;46529;33893.66106338905;34022.14944626305;34186.48720269148;34504.309913802084;34518.96443106711;33001;33142.337153257286;33392.833035834665;33404;33417.83291083626;38106;38669.61330386773;38832;39310;39773.40339894962;32534.67465325411;32733.345333093683;32759.508607370433;32892.83553582217;32916;25807.225783226535;26208.737912621393;26273.343166420993;26374.20877373682;26564 19:02:37 INFO - PROCESS | 32691 | |2;jquery.html;452.5045075642171;462.3619405220797;475.41049099117083;476.22613253463123;487.28961345676674;19651.901740491296;20900.37298881034;21330.57338853222;21853.453663658416;22032.8898355508;21790.782092179074;21874.562508749816;22177.334679959586;22363.55272894545;22406.77593224067;6830.6584670766515;6831.897521537168;6908.1364829396325;6958.756443524478;7151.427885769126;6978.232394436608;7033.683484243222;7058.400035996947;7734.381249500027;8054.073781515113;8139.308158806479;8220.83558328833;8231.053428855668;8239;8247.422680412374;7917.406194535404;8121.106678265386;8121.512709237465;8126.878096828582;8170.754877353689;7716.7684969451;7926.445148839583;8019.39854510914;8043.758687239392;8044.034715834137;29397.41205175906;30228.546571801442;30364.392712145855;30570.235744106354;30652.693473065206;3079.6920307969026;3128.89048883288;3215.3730022645595;3307.58655168104;3568.6252943440822;17338.7399189011;17357.566060848454;17660.381886634033;18362.724559131624;18652.62694746111;2264.6899814995613;2285.4514916420108;2294.162630639821;2338.5790557699606;2368.2066507719933;106937.46531267294;112712.43643781729;113980.4300978498;118313.40843295814;118884.40557797156;19732.30936917201;20803.479913001993;21844.563108738053;21859.781402186094;22480.662790058162;41868.371974420406;41886.58113418888;41893;41978;42373;11378;11391.259568128045;11552.306861588331;11585.131115166396;11803.763924721457;9238.676646317346;9280.443173409618;9331.90668093324;9511.66709165176;9511.714648560554;11079.279846809932;11316.886831131584;11467.197296189186;11697.473613687405;11733.765324693459;4215.470717569434;4297.484301883794;4323.697341186087;4347.217500849814;4446.863872227583;966.9951650241704;973.8831340239217;978.2418625565244;997.581015973293;1001.0740065439439;19274.32539861126;19980.800191997892;20772.272970445963;20943.790562094488;21254.937253137283;1083.2525557365393;1096.7916095941746;1109.9889001110048;1110.0897264243404;1146.6674664347245;10660.840087398696;11364.204505684687;11419.429028548539;11427.542898283975;11587.59443419493;578186;630879;702110;702579;728981;119575;122479.11016547146;124111.37944310221;125190;126754;1316.8485624153154;1326.8142460055599;1341.7182391697852;1349.561392547426;1361.3669643615567;17602.559936001704;17855.375061873292;18137.27450901949;18314.908425457787;18353.3576324828;53630.195547067604;54475.45524544704;54494.45505544894;54794.452055478934;56173.71913140408;71008.28991710016;71176;71536.64231678809;71669.6416517914;71831;12027.879721202677;12088.274703517816;12483.56307529232;12616.684582885502;12641.93679031599;13603.183808971493;13994.860051399763;14074.718505629626;14140.78788818148;14204.147751134966;12236.449359778653;12266.877331226931;12343.938280308541;12545.498180072695;12589.307588082744;11560.710982225512;11669.88330116688;11812.527498899948;11888.881111188777;12155.939220303842;12487.750244995232;12587.559435419716;12795.808062878878;12836.358182091044;12895.419706113435;12325.630231093082;12424.937875310565;12484.93757531243;12588.685282868002;12625.431855566705;12376.75246495083;12447.191246062755;12528.624141275777;12825.102242843284;12849.871501284868 19:02:37 INFO - PROCESS | 32691 | |3;mootools.html;1395.4139261510165;1469.0891647178744;1507.2765072765073;1526.3131590784144;1526.847060819408;9604.759881002978;11261.099112071035;11688.006519445848;12072.336021518813;12109.394530273496;11646.883531164685;11658.82511762322;11737.47181376838;11749.412529373518;11766.176367654267;1956.5499935014955;2021.1006102284489;2468.9753102468926;2513.6355228491857;2518.508890766301;2449.9755002449924;2501.7498250175017;2513.924582262535;2548.120898290087;2550.4644024754825;2437.1591800828774;2464.4578192797558;2467.6545283660303;2471.3450935502015;2472.7032756069207;2413.915512957038;2440.9389765255924;2450.681411416522;2455.72986971433;2457.238256140602;2351.2358483492935;2353.435175557871;2355.882205889716;2360.197532838843;2362.692849929498;11758.118141139448;11897.762044759143;11926.642200733992;11949.342786146759;11977.341246231454;5654.802081927154;5771.942280577183;5782.884342313172;5799.768009279666;5852.970735146339;3253.3818574470774;3330.8667653293837;3497.178163131662;3507.0355652195594;3508.7894726316504;1295.9740805183937;1314.9737005259938;1353.0731448957397;1355.4442678501766;2061.670132778763;17993.280268789233;17996.370127045622;18010.90994545032;18021.27914883416;18075.819241807545;4704.811807527661;4770.880727981828;4865.537773911473;4868.707877527359;4881.219004959189;12992.415341309665;12994.480220791062;12997.740045199233;12999.935000324938;13010.934945325402;5846.181534585162;5857.26784151981;5859.062549991981;5864.970675146597;5868.706564671749;4718.669693121517;4865.829695960695;5323.387810401776;5434.70109143993;5437.673739575638;4160.667146628262;4165.291900376943;4248.9787551062045;4274.123804620045;4275.935860962088;1097.05653138301;1102.8345748137845;1109.9278546894589;1122.1359553144034;1129.6667483092508;993.7068564773409;1000.4697510319543;1012.5291739341242;1016.6594190946116;1018.6027449294781;6756.358145976124;6787.796366109024;6839.110915581042;6873.140857392826;6960.9303906961295;1048.5805677728817;1060.6605886116522;1074.7205726511006;1084.728817795551;1091.3124731419155;4275.636570891447;4343.9348409773875;4449.710768800082;4492.213862574036;4514.187446259639;13907.304634768221;14212.644683882985;14702.63243418923;15229.238538073274;15276.465323713617;14448.133112013313;14648.780268295985;14752.40990360395;14769;14786.334614942354;10703.304285221591;10861.02250797432;11113.666590002313;11115.72210694739;11141.832872506919;6950.443964482931;7045.189803172496;7168.8924666129005;7169.426445884213;7234.457415693739;12831.486740530647;12874;12877.806832897326;12892;12892.806607900702;13012.869871301544;13170.934145329213;13298.601041968757;13364.799528006894;13797.51708690191;8152.510849349058;8919.464832110094;9851.310408271638;10035.14701250402;10047.296689231976;11021.83467247976;11366.431678416211;11430.599929002445;11447;11465.885341146482;9470.857937130811;9512.191463725385;9644.855327170239;9660.082292182231;9681.177099946583;9039.68361107358;9102.817943641223;9160.358774885693;9191.632334706537;9236.769080773034;8369.204925532065;8454.070052294366;8514.574271286534;8524.318054555744;8524.914750852413;5878.706064696834;5917.142014407801;6014.0678194879865;6022.879542409215;6159.630422174684;5904.9704751475965;5912.201852749824;5948.40515948419;6012;6147.362955048165 19:02:37 INFO - PROCESS | 32691 | |4;prototype.html;406.82099876054514;418.4372019633593;421.35532635068336;436.5307294658241;438.08658946097376;5076.746162691869;5164.967006598686;5237.81456358205;5280.947190528093;5288.391834938983;5115.7697903594335;5173.9482605173935;5190.506901844328;5199.324087868572;5207.6875387476775;4497.347884556737;4498.550144985508;4512.398098674972;4532.342810292505;4539.319102134689;4328.956710432903;4452.243118669834;4503.504614492404;4516.887077823064;4570.817167313304;4428.250840917835;4449.997501124491;4458.821647134127;4473.463184417875;4477.753723545204;4474.485434175079;4481.3726078349055;4481.955180448203;4500.34744961982;4506.188886000518;4177.248095342837;4311.762853043081;4349.891252718708;4359.645791272709;4372.497162826284;5079.933214025059;5084.110280700863;5084.694918304914;5108.616853735947;5114.723947843211;5223.563520031984;5244.685318880879;5255.527002569787;5273.288106105703;5277.551408130314;5387.73061346935;5458.181272809071;5491.9290738306045;5542.972285138589;5563;4785.3300537924715;4791.976040119812;4804.447488538828;4836.032793441326;4839.854804355875;5704.429557044304;5719.313682358102;5726.226959360516;5731;5771.826845194651;4897.975510122498;4936.48166942473;5020.146575082244;5043.394792624908;5063.594912406998;5036.597072234213;5076.873078173001;5080.644354895196;5097.490250974873;5132.820351287687;5306.8407947761625;5308.893822123536;5323.441038690959;5327;5330;5323.254744335719;5457.417348968755;5500.7524661390335;5568;5583.218349431083;1692.2046638080083;1710.8203638618015;1751.1594434671174;1767.7537336177963;1774.308019872251;1384.4978198654371;1444.2356353305054;1449.6665766873468;1452.2012892908858;1481.1705444950646;5353.678779273178;5355.544778693777;5377.892442151135;5399.244105825188;5462.945370546244;5593.496585307342;5602.663840169603;5615.185798059259;5623.746931388016;5627.859303517363;5153.458886816905;5388.811391601275;5425.6202065855805;5438.293021907127;5450.773575945381;2929.9121026369244;2945.262295245815;2959.150530918176;2959.230600043961;2959.77801664876;5765.769369225184;5795.391483894215;5846.970765146147;5867.589268751231;5886.941130588725;5460.262864513319;5712.429731417864;5755.359722479074;5774.3070831499645;5797.0000699517195;5963.284405871236;5973.342932277446;5983.5295528593315;5988.251468566429;5988.790392336247;5427.24018637399;5693.743781529758;5710.200571919851;5722.341930677859;5737.5983681141915;5628.577856660685;5648.209250704823;5656.462636049569;5691.950897676916;5696.231008813757;5744.482996530165;5895.469407753323;5938.703064846654;5943.762249509971;5952.910706339495;4695.5539223773685;4836.274558816065;5030.723310217973;5094.5160209780015;5109.412417571878;5406.594505412031;5520.420355862737;5530.617345663584;5667.688277144632;5685.545156387397;5514.80698175562;5519.39286678457;5522.144067669517;5541.833744987657;5549.361823390362;5457.117294533379;5467.906418716352;5485.135054081631;5511.5669925818775;5532.446755324436;5310.946890531045;5461.197804724511;5483.670979741229;5510.944890551204;5518.586106041983;5494.478024587658;5507.669539827623;5548.529639645417;5582.525485333792;5587.832365029056;5208.921866171935;5378.462153784591;5416.454266494741;5424.132138857922;5437.673739575638 19:02:37 INFO - PROCESS | 32691 | |5;yui.html;838.9958050209748;881.5680316644846;903.2457897655457;926.5598840550738;943.1935694980789;17298.56753581161;17454.94766106491;17659.381921632747;17667.64664706705;17683.29266829327;16343.754843677325;17063.74404383932;17118.486445406626;17154.82845171548;17205.397811076615;884.9424787388831;890.5814267294361;905.3933864310894;908.9000209976897;911.1116661255256;887.414306557672;889.1153302464057;889.9955500222522;890.341147550811;890.398980688033;936.1901954809109;936.8220038192756;942.6323733743845;944.8393773058563;945.6879229854131;935.8923723771751;937.2267878999818;937.5640327247794;937.728058862929;939.0937745076001;693.549193024533;694.2918223412091;694.3369082526175;694.4132208283992;694.798508432554;17322.307107715675;17359.132043397778;17533.824661753475;18080.18639161241;18379.172937217725;16158;16315.83684163155;16493.257803398876;16580.668386632322;16635;12731.490740370375;12888.484460621565;13051.543195988095;13141.605751827461;13164.40760165795;3835.7314987950854;3847.71142164336;3876.1666241758157;3920.4511368408444;3924.7448915820382;87630;89515.10484895133;89543.10456895414;90182.5490872548;91895;11360.204785664924;12434.62696119118;12449.25304481734;12544.184627999151;12694.238345699288;21501.24745633895;21568.460788480414;21665.891670541547;21896.671549926763;22000.33998980033;8243.752687419386;8264.421490495728;8329.708460203863;8435.915640843636;8569.742907712778;4372.868813935587;4519.683622146484;4842.225243960949;4847.3698419205275;4919.803207871645;3710.851565937386;3798.8290526926353;3802.125511132455;3810.3141434541494;3812.1232116613332;606.730005147705;619.9256089269227;624.4629618528062;630.391672036487;635.2726128582747;840.3528487464332;850.0691742542031;856.4946681457845;869.4088020146235;881.1981097201516;10319.116614285731;10347.327423717434;10840.078593319657;11451.54193832254;11488.253263537843;798.8202654402713;804.6137853830194;811.5171472973572;812.7521106062708;826.9255766981;5226;5365.543928766098;5522.972385138129;5551.361593416728;5720.08478643415;66533.33466665368;75794.24205757982;79363.60318198372;82646;83077;43311.56688433075;44152.558474415484;47156.7642161787;73126.63436682783;77474.61262693763;57880;62342.688286558274;62515.37484625186;62758;63173.68413157997;10639.308444951053;10997.175211859303;11000.169909947741;11114.110871130451;11244.437778111225;42280;42935.57064429441;43681.78159109184;43771;44457.555424445345;50541.74729126331;51154.74422627863;51975;52380.73809630927;56693;13338;13476.124051936593;13966.790498142333;14082.647933801736;14119.929400353343;15156.393744250106;15869;16420.507384777997;16463.670726585642;16668.41660541875;13945.790813137608;14628.780568291271;14721.705565888837;14734.26328683583;14743.778843317574;14393.496227631982;14589.781153282496;14644.41422343137;14973.700525989638;15209.771853421986;14084.859151408355;14152.78770818459;14527.564173074825;14569.927150364181;14658.706825863635;10888.45557722095;11179.608713695307;11742.706432338919;11779.115341545312;11802.114841387101;11191.832122518006;11257.268277561932;11958.521659133885;11990.400479975791;12693.619191424272 19:02:37 INFO - PROCESS | 32691 | __end_tp_report 19:02:37 INFO - PROCESS | 32691 | __start_cc_report 19:02:37 INFO - PROCESS | 32691 | _x_x_mozilla_cycle_collect,1429 19:02:37 INFO - PROCESS | 32691 | __end_cc_report 19:02:37 INFO - PROCESS | 32691 | __startTimestamp1491357757684__endTimestamp 19:02:37 INFO - PROCESS | 32691 | 19:02:37 INFO - PROCESS | 32691 | ------- Summary: start ------- 19:02:37 INFO - PROCESS | 32691 | Number of tests: 6 19:02:37 INFO - PROCESS | 32691 | 19:02:37 INFO - PROCESS | 32691 | [#0] dojo.html Cycles:165 Average:5789.44 Median:6053.79 stddev:674.46 (11.1%) stddev-sans-first:649.56 19:02:37 INFO - PROCESS | 32691 | Values: 3382.2 3424.7 3438.2 3439.2 3480.8 5754.7 5825.9 5830.8 5833.5 5868.5 5830.9 5879.6 5898.0 5898.7 5900.3 5214.5 5227.5 5244.5 5306.8 5320.2 5104.9 5133.8 5185.8 5319.3 5323.9 5278.1 5290.7 5299.1 5306.9 5317.6 5307.5 5311.6 5313.0 5322.6 5332.8 5044.0 5070.9 5188.1 5253.0 5307.8 5701.0 5713.4 5750.9 5776.7 5788.7 6215.5 6265.6 6269.4 6271.1 6272.9 6054.4 6308.0 6318.8 6340.1 6343.4 5776.7 5788.2 5837.4 5842.3 5849.4 6374.1 6401.7 6411.1 6412.2 6416.1 6113.4 6174.3 6179.1 6187.2 6188.5 6064.3 6108.1 6147.4 6191.0 6204.9 6226.4 6282.6 6283.8 6286.3 6288.2 6072.1 6116.5 6123.2 6126.2 6134.2 4648.1 4657.2 4665.9 4671.2 4700.3 4125.8 4142.6 4170.2 4244.1 4258.2 5925.1 5952.2 5975.7 5981.0 5983.7 6191.8 6194.5 6197.7 6202.6 6214.1 5834.4 5875.9 5951.1 5957.7 5964.6 5258.0 5309.6 5338.2 5340.1 5373.1 6490.5 6525.4 6531.7 6531.7 6539.1 6084.1 6237.0 6304.9 6308.8 6313.4 6412.7 6422.5 6456.8 6574.1 6590.0 6208.7 6215.3 6221.5 6222.1 6223.0 6267.2 6318.9 6330.1 6339.1 6340.3 5919.1 5986.4 6049.4 6096.9 6120.0 6053.0 6068.1 6102.6 6119.8 6137.4 5910.3 6128.7 6143.8 6145.6 6156.6 6001.7 6075.3 6104.1 6124.0 6188.4 6049.2 6053.8 6055.5 6062.8 6084.3 19:02:37 INFO - PROCESS | 32691 | 19:02:37 INFO - PROCESS | 32691 | [#1] ext.html Cycles:180 Average:41560.03 Median:32773.59 stddev:66756.94 (203.7%) stddev-sans-first:66873.92 19:02:37 INFO - PROCESS | 32691 | Values: 760.3 845.1 864.3 917.9 933.9 30331.2 30846.0 32787.7 32799.7 42281.4 43951.0 44165.3 44201.3 44241.8 44242.0 9007.1 9144.0 9153.5 9154.1 9165.2 7603.8 7770.1 8999.3 9096.2 10542.2 10844.5 10878.0 10883.8 10884.5 10887.7 10843.2 10866.3 10866.5 10867.4 10874.2 10583.6 10613.9 10634.0 10640.7 10643.7 41676.8 41883.6 41955.0 41956.0 41968.8 4103.5 4112.0 4151.8 4208.4 4238.0 26210.0 29266.3 29383.7 29584.6 29908.0 3437.5 3479.5 3495.4 3591.3 3599.4 228239.0 229364.0 230273.0 230561.0 230941.0 46166.0 46332.8 46353.0 46373.3 46389.1 48384.5 48387.0 48509.5 48804.0 48824.5 14965.7 15411.8 15418.6 15424.5 15433.0 13154.1 13157.8 13197.6 13208.1 13208.8 11463.1 11779.5 12724.7 13081.1 13415.0 5424.9 5484.9 5597.5 5607.5 5612.8 1035.3 1043.9 1046.1 1234.2 1302.9 26690.6 27213.6 27433.3 27490.5 27521.3 1363.9 1373.0 1381.9 1383.7 1393.6 14348.7 14408.0 14493.3 14500.4 14763.3 166460.0 166846.0 167237.0 167279.0 167645.0 57530.7 57822.4 57923.2 57974.4 57999.1 1498.5 1538.2 1549.5 1559.5 1562.3 25010.9 26293.0 26473.2 26549.0 26615.0 42503.4 42716.8 42793.8 42856.4 42911.6 336964.0 338193.0 338435.0 338890.0 338974.0 31252.2 32233.0 32235.2 32238.5 32241.2 33420.8 40925.6 42243.4 45723.0 46529.0 33893.7 34022.1 34186.5 34504.3 34519.0 33001.0 33142.3 33392.8 33404.0 33417.8 38106.0 38669.6 38832.0 39310.0 39773.4 32534.7 32733.3 32759.5 32892.8 32916.0 25807.2 26208.7 26273.3 26374.2 26564.0 19:02:37 INFO - PROCESS | 32691 | 19:02:37 INFO - PROCESS | 32691 | [#2] jquery.html Cycles:180 Average:39171.26 Median:21560.68 stddev:110652.66 (513.2%) stddev-sans-first:110924.88 19:02:37 INFO - PROCESS | 32691 | Values: 452.5 462.4 475.4 476.2 487.3 19651.9 20900.4 21330.6 21853.5 22032.9 21790.8 21874.6 22177.3 22363.6 22406.8 6830.7 6831.9 6908.1 6958.8 7151.4 6978.2 7033.7 7058.4 7734.4 8054.1 8139.3 8220.8 8231.1 8239.0 8247.4 7917.4 8121.1 8121.5 8126.9 8170.8 7716.8 7926.4 8019.4 8043.8 8044.0 29397.4 30228.5 30364.4 30570.2 30652.7 3079.7 3128.9 3215.4 3307.6 3568.6 17338.7 17357.6 17660.4 18362.7 18652.6 2264.7 2285.5 2294.2 2338.6 2368.2 106937.5 112712.4 113980.4 118313.4 118884.4 19732.3 20803.5 21844.6 21859.8 22480.7 41868.4 41886.6 41893.0 41978.0 42373.0 11378.0 11391.3 11552.3 11585.1 11803.8 9238.7 9280.4 9331.9 9511.7 9511.7 11079.3 11316.9 11467.2 11697.5 11733.8 4215.5 4297.5 4323.7 4347.2 4446.9 967.0 973.9 978.2 997.6 1001.1 19274.3 19980.8 20772.3 20943.8 21254.9 1083.3 1096.8 1110.0 1110.1 1146.7 10660.8 11364.2 11419.4 11427.5 11587.6 578186.0 630879.0 702110.0 702579.0 728981.0 119575.0 122479.1 124111.4 125190.0 126754.0 1316.8 1326.8 1341.7 1349.6 1361.4 17602.6 17855.4 18137.3 18314.9 18353.4 53630.2 54475.5 54494.5 54794.5 56173.7 71008.3 71176.0 71536.6 71669.6 71831.0 12027.9 12088.3 12483.6 12616.7 12641.9 13603.2 13994.9 14074.7 14140.8 14204.1 12236.4 12266.9 12343.9 12545.5 12589.3 11560.7 11669.9 11812.5 11888.9 12155.9 12487.8 12587.6 12795.8 12836.4 12895.4 12325.6 12424.9 12484.9 12588.7 12625.4 12376.8 12447.2 12528.6 12825.1 12849.9 19:02:37 INFO - PROCESS | 32691 | 19:02:37 INFO - PROCESS | 32691 | [#3] mootools.html Cycles:180 Average:7175.34 Median:2450.33 stddev:4673.89 (190.7%) stddev-sans-first:4666.82 19:02:37 INFO - PROCESS | 32691 | Values: 1395.4 1469.1 1507.3 1526.3 1526.8 9604.8 11261.1 11688.0 12072.3 12109.4 11646.9 11658.8 11737.5 11749.4 11766.2 1956.5 2021.1 2469.0 2513.6 2518.5 2450.0 2501.7 2513.9 2548.1 2550.5 2437.2 2464.5 2467.7 2471.3 2472.7 2413.9 2440.9 2450.7 2455.7 2457.2 2351.2 2353.4 2355.9 2360.2 2362.7 11758.1 11897.8 11926.6 11949.3 11977.3 5654.8 5771.9 5782.9 5799.8 5853.0 3253.4 3330.9 3497.2 3507.0 3508.8 1296.0 1315.0 1353.1 1355.4 2061.7 17993.3 17996.4 18010.9 18021.3 18075.8 4704.8 4770.9 4865.5 4868.7 4881.2 12992.4 12994.5 12997.7 12999.9 13010.9 5846.2 5857.3 5859.1 5865.0 5868.7 4718.7 4865.8 5323.4 5434.7 5437.7 4160.7 4165.3 4249.0 4274.1 4275.9 1097.1 1102.8 1109.9 1122.1 1129.7 993.7 1000.5 1012.5 1016.7 1018.6 6756.4 6787.8 6839.1 6873.1 6960.9 1048.6 1060.7 1074.7 1084.7 1091.3 4275.6 4343.9 4449.7 4492.2 4514.2 13907.3 14212.6 14702.6 15229.2 15276.5 14448.1 14648.8 14752.4 14769.0 14786.3 10703.3 10861.0 11113.7 11115.7 11141.8 6950.4 7045.2 7168.9 7169.4 7234.5 12831.5 12874.0 12877.8 12892.0 12892.8 13012.9 13170.9 13298.6 13364.8 13797.5 8152.5 8919.5 9851.3 10035.1 10047.3 11021.8 11366.4 11430.6 11447.0 11465.9 9470.9 9512.2 9644.9 9660.1 9681.2 9039.7 9102.8 9160.4 9191.6 9236.8 8369.2 8454.1 8514.6 8524.3 8524.9 5878.7 5917.1 6014.1 6022.9 6159.6 5905.0 5912.2 5948.4 6012.0 6147.4 19:02:37 INFO - PROCESS | 32691 | 19:02:37 INFO - PROCESS | 32691 | [#4] prototype.html Cycles:180 Average:4874.21 Median:5323.35 stddev:1259.70 (23.7%) stddev-sans-first:1217.79 19:02:37 INFO - PROCESS | 32691 | Values: 406.8 418.4 421.4 436.5 438.1 5076.7 5165.0 5237.8 5280.9 5288.4 5115.8 5173.9 5190.5 5199.3 5207.7 4497.3 4498.6 4512.4 4532.3 4539.3 4329.0 4452.2 4503.5 4516.9 4570.8 4428.3 4450.0 4458.8 4473.5 4477.8 4474.5 4481.4 4482.0 4500.3 4506.2 4177.2 4311.8 4349.9 4359.6 4372.5 5079.9 5084.1 5084.7 5108.6 5114.7 5223.6 5244.7 5255.5 5273.3 5277.6 5387.7 5458.2 5491.9 5543.0 5563.0 4785.3 4792.0 4804.4 4836.0 4839.9 5704.4 5719.3 5726.2 5731.0 5771.8 4898.0 4936.5 5020.1 5043.4 5063.6 5036.6 5076.9 5080.6 5097.5 5132.8 5306.8 5308.9 5323.4 5327.0 5330.0 5323.3 5457.4 5500.8 5568.0 5583.2 1692.2 1710.8 1751.2 1767.8 1774.3 1384.5 1444.2 1449.7 1452.2 1481.2 5353.7 5355.5 5377.9 5399.2 5462.9 5593.5 5602.7 5615.2 5623.7 5627.9 5153.5 5388.8 5425.6 5438.3 5450.8 2929.9 2945.3 2959.2 2959.2 2959.8 5765.8 5795.4 5847.0 5867.6 5886.9 5460.3 5712.4 5755.4 5774.3 5797.0 5963.3 5973.3 5983.5 5988.3 5988.8 5427.2 5693.7 5710.2 5722.3 5737.6 5628.6 5648.2 5656.5 5692.0 5696.2 5744.5 5895.5 5938.7 5943.8 5952.9 4695.6 4836.3 5030.7 5094.5 5109.4 5406.6 5520.4 5530.6 5667.7 5685.5 5514.8 5519.4 5522.1 5541.8 5549.4 5457.1 5467.9 5485.1 5511.6 5532.4 5310.9 5461.2 5483.7 5510.9 5518.6 5494.5 5507.7 5548.5 5582.5 5587.8 5208.9 5378.5 5416.5 5424.1 5437.7 19:02:37 INFO - PROCESS | 32691 | 19:02:37 INFO - PROCESS | 32691 | [#5] yui.html Cycles:180 Average:18063.64 Median:42607.79 stddev:22441.57 (52.7%) stddev-sans-first:22467.25 19:02:37 INFO - PROCESS | 32691 | Values: 839.0 881.6 903.2 926.6 943.2 17298.6 17454.9 17659.4 17667.6 17683.3 16343.8 17063.7 17118.5 17154.8 17205.4 884.9 890.6 905.4 908.9 911.1 887.4 889.1 890.0 890.3 890.4 936.2 936.8 942.6 944.8 945.7 935.9 937.2 937.6 937.7 939.1 693.5 694.3 694.3 694.4 694.8 17322.3 17359.1 17533.8 18080.2 18379.2 16158.0 16315.8 16493.3 16580.7 16635.0 12731.5 12888.5 13051.5 13141.6 13164.4 3835.7 3847.7 3876.2 3920.5 3924.7 87630.0 89515.1 89543.1 90182.5 91895.0 11360.2 12434.6 12449.3 12544.2 12694.2 21501.2 21568.5 21665.9 21896.7 22000.3 8243.8 8264.4 8329.7 8435.9 8569.7 4372.9 4519.7 4842.2 4847.4 4919.8 3710.9 3798.8 3802.1 3810.3 3812.1 606.7 619.9 624.5 630.4 635.3 840.4 850.1 856.5 869.4 881.2 10319.1 10347.3 10840.1 11451.5 11488.3 798.8 804.6 811.5 812.8 826.9 5226.0 5365.5 5523.0 5551.4 5720.1 66533.3 75794.2 79363.6 82646.0 83077.0 43311.6 44152.6 47156.8 73126.6 77474.6 57880.0 62342.7 62515.4 62758.0 63173.7 10639.3 10997.2 11000.2 11114.1 11244.4 42280.0 42935.6 43681.8 43771.0 44457.6 50541.7 51154.7 51975.0 52380.7 56693.0 13338.0 13476.1 13966.8 14082.6 14119.9 15156.4 15869.0 16420.5 16463.7 16668.4 13945.8 14628.8 14721.7 14734.3 14743.8 14393.5 14589.8 14644.4 14973.7 15209.8 14084.9 14152.8 14527.6 14569.9 14658.7 10888.5 11179.6 11742.7 11779.1 11802.1 11191.8 11257.3 11958.5 11990.4 12693.6 19:02:37 INFO - PROCESS | 32691 | -------- Summary: end -------- 19:02:37 INFO - PROCESS | 32691 | 19:02:38 INFO - TEST-INFO | 32691: exit 0 19:02:38 INFO - TEST-OK | dromaeo_css | took 1115690ms 19:02:38 INFO - TEST-START | kraken 19:02:38 INFO - operating with platform_type : linux_ 19:02:38 INFO - Initialising browser for kraken test... 19:02:38 INFO - TEST-INFO | started process 551 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpArBi2t/profile http://localhost:49869/getInfo.html) 19:02:42 INFO - PROCESS | 551 | __metrics Screen width/height:1600/1200 19:02:42 INFO - PROCESS | 551 | colorDepth:24 19:02:42 INFO - PROCESS | 551 | Browser inner width/height: 1024/697 19:02:42 INFO - PROCESS | 551 | __metrics 19:02:43 ERROR - PROCESS | 551 | 1491357763276 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4954:11 < observe@XPIProvider.jsm:2917:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 19:02:43 INFO - PROCESS | 551 | 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" 19:02:43 INFO - PROCESS | 551 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:02:44 INFO - TEST-INFO | 551: exit 0 19:02:44 INFO - Browser initialized. 19:02:44 INFO - Running cycle 1/1 for kraken test... 19:02:44 INFO - TEST-INFO | started process 648 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpArBi2t/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:02:56 INFO - PROCESS | 648 | RSS: Main: 140005376 19:02:56 INFO - PROCESS | 648 | 19:02:58 INFO - PROCESS | 648 | Cycle 1(1): loaded http://localhost:49869/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49869/tests/kraken/driver.html?testName=audio-beat-detection) 19:02:59 INFO - PROCESS | 648 | RSS: Main: 184004608 19:02:59 INFO - PROCESS | 648 | 19:03:02 INFO - PROCESS | 648 | Cycle 1(1): loaded http://localhost:49869/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49869/tests/kraken/driver.html?testName=audio-dft) 19:03:02 INFO - PROCESS | 648 | RSS: Main: 174206976 19:03:02 INFO - PROCESS | 648 | 19:03:05 INFO - PROCESS | 648 | Cycle 1(1): loaded http://localhost:49869/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49869/tests/kraken/driver.html?testName=audio-fft) 19:03:06 INFO - PROCESS | 648 | RSS: Main: 265572352 19:03:06 INFO - PROCESS | 648 | 19:03:08 INFO - PROCESS | 648 | Cycle 1(1): loaded http://localhost:49869/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49869/tests/kraken/driver.html?testName=audio-oscillator) 19:03:08 INFO - PROCESS | 648 | RSS: Main: 171778048 19:03:08 INFO - PROCESS | 648 | 19:03:10 INFO - PROCESS | 648 | Cycle 1(1): loaded http://localhost:49869/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49869/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:03:11 INFO - PROCESS | 648 | RSS: Main: 174653440 19:03:11 INFO - PROCESS | 648 | 19:03:14 INFO - PROCESS | 648 | Cycle 1(1): loaded http://localhost:49869/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49869/tests/kraken/driver.html?testName=imaging-darkroom) 19:03:15 INFO - PROCESS | 648 | RSS: Main: 213164032 19:03:15 INFO - PROCESS | 648 | 19:03:18 INFO - PROCESS | 648 | Cycle 1(1): loaded http://localhost:49869/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49869/tests/kraken/driver.html?testName=imaging-desaturate) 19:03:19 INFO - PROCESS | 648 | RSS: Main: 211898368 19:03:19 INFO - PROCESS | 648 | 19:03:21 INFO - PROCESS | 648 | Cycle 1(1): loaded http://localhost:49869/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49869/tests/kraken/driver.html?testName=json-parse-financial) 19:03:22 INFO - PROCESS | 648 | RSS: Main: 211243008 19:03:22 INFO - PROCESS | 648 | 19:03:23 INFO - PROCESS | 648 | Cycle 1(1): loaded http://localhost:49869/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49869/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:03:24 INFO - PROCESS | 648 | RSS: Main: 173031424 19:03:24 INFO - PROCESS | 648 | 19:03:26 INFO - PROCESS | 648 | Cycle 1(1): loaded http://localhost:49869/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49869/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:03:26 INFO - PROCESS | 648 | RSS: Main: 179396608 19:03:26 INFO - PROCESS | 648 | 19:03:28 INFO - PROCESS | 648 | Cycle 1(1): loaded http://localhost:49869/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49869/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:03:29 INFO - PROCESS | 648 | RSS: Main: 189751296 19:03:29 INFO - PROCESS | 648 | 19:03:31 INFO - PROCESS | 648 | Cycle 1(1): loaded http://localhost:49869/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49869/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:03:32 INFO - PROCESS | 648 | RSS: Main: 198234112 19:03:32 INFO - PROCESS | 648 | 19:03:35 INFO - PROCESS | 648 | Cycle 1(1): loaded http://localhost:49869/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49869/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:03:35 INFO - PROCESS | 648 | RSS: Main: 194977792 19:03:35 INFO - PROCESS | 648 | 19:03:37 INFO - PROCESS | 648 | Cycle 1(1): loaded http://localhost:49869/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49869/tests/kraken/driver.html?testName=ai-astar) 19:03:37 INFO - PROCESS | 648 | RSS: Main: 246718464 19:03:37 INFO - PROCESS | 648 | 19:03:37 INFO - PROCESS | 648 | __start_tp_report 19:03:37 INFO - PROCESS | 648 | _x_x_mozilla_page_load 19:03:37 INFO - PROCESS | 648 | _x_x_mozilla_page_load_details 19:03:37 INFO - PROCESS | 648 | |i|pagename|runs| 19:03:37 INFO - PROCESS | 648 | |0;ai-astar;103;113;114;112;112;113;112;112;113;113 19:03:37 INFO - PROCESS | 648 | |1;audio-beat-detection;138;114;116;154;116;121;114;120;135;117 19:03:37 INFO - PROCESS | 648 | |2;audio-dft;161;161;161;160;160;162;162;161;160;159 19:03:37 INFO - PROCESS | 648 | |3;audio-fft;74;75;85;110;76;76;75;75;104;75 19:03:37 INFO - PROCESS | 648 | |4;audio-oscillator;82;82;115;81;81;81;93;81;81;99 19:03:37 INFO - PROCESS | 648 | |5;imaging-gaussian-blur;113;114;113;113;113;112;113;113;113;113 19:03:37 INFO - PROCESS | 648 | |6;imaging-darkroom;146;145;147;146;146;146;145;146;145;146 19:03:37 INFO - PROCESS | 648 | |7;imaging-desaturate;95;93;94;94;95;94;94;93;94;94 19:03:37 INFO - PROCESS | 648 | |8;json-parse-financial;55;56;56;54;55;56;56;55;55;55 19:03:37 INFO - PROCESS | 648 | |9;json-stringify-tinderbox;53;53;52;53;52;53;52;52;52;53 19:03:37 INFO - PROCESS | 648 | |10;stanford-crypto-aes;77;80;75;77;78;80;84;82;80;78 19:03:37 INFO - PROCESS | 648 | |11;stanford-crypto-ccm;123;123;123;122;121;119;121;123;159;134 19:03:37 INFO - PROCESS | 648 | |12;stanford-crypto-pbkdf2;165;166;160;158;158;160;164;163;160;158 19:03:37 INFO - PROCESS | 648 | |13;stanford-crypto-sha256-iterative;61;60;59;68;60;59;59;66;58;58 19:03:37 INFO - PROCESS | 648 | __end_tp_report 19:03:37 INFO - PROCESS | 648 | __start_cc_report 19:03:37 INFO - PROCESS | 648 | _x_x_mozilla_cycle_collect,1679 19:03:37 INFO - PROCESS | 648 | __end_cc_report 19:03:37 INFO - PROCESS | 648 | __startTimestamp1491357817801__endTimestamp 19:03:37 INFO - PROCESS | 648 | 19:03:37 INFO - PROCESS | 648 | ------- Summary: start ------- 19:03:37 INFO - PROCESS | 648 | Number of tests: 14 19:03:37 INFO - PROCESS | 648 | 19:03:37 INFO - PROCESS | 648 | [#0] ai-astar Cycles:10 Average:111.70 Median:113.00 stddev:3.13 (2.8%) stddev-sans-first:0.71 19:03:37 INFO - PROCESS | 648 | Values: 103.0 113.0 114.0 112.0 112.0 113.0 112.0 112.0 113.0 113.0 19:03:37 INFO - PROCESS | 648 | 19:03:37 INFO - PROCESS | 648 | [#1] audio-beat-detection Cycles:10 Average:124.50 Median:120.50 stddev:13.40 (11.1%) stddev-sans-first:13.29 19:03:37 INFO - PROCESS | 648 | Values: 138.0 114.0 116.0 154.0 116.0 121.0 114.0 120.0 135.0 117.0 19:03:37 INFO - PROCESS | 648 | 19:03:37 INFO - PROCESS | 648 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 19:03:37 INFO - PROCESS | 648 | Values: 161.0 161.0 161.0 160.0 160.0 162.0 162.0 161.0 160.0 159.0 19:03:37 INFO - PROCESS | 648 | 19:03:37 INFO - PROCESS | 648 | [#3] audio-fft Cycles:10 Average:82.50 Median:75.00 stddev:13.36 (17.8%) stddev-sans-first:13.81 19:03:37 INFO - PROCESS | 648 | Values: 74.0 75.0 85.0 110.0 76.0 76.0 75.0 75.0 104.0 75.0 19:03:37 INFO - PROCESS | 648 | 19:03:37 INFO - PROCESS | 648 | [#4] audio-oscillator Cycles:10 Average:87.60 Median:81.50 stddev:11.50 (14.1%) stddev-sans-first:12.02 19:03:37 INFO - PROCESS | 648 | Values: 82.0 82.0 115.0 81.0 81.0 81.0 93.0 81.0 81.0 99.0 19:03:37 INFO - PROCESS | 648 | 19:03:37 INFO - PROCESS | 648 | [#5] imaging-gaussian-blur Cycles:10 Average:113.00 Median:113.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 19:03:37 INFO - PROCESS | 648 | Values: 113.0 114.0 113.0 113.0 113.0 112.0 113.0 113.0 113.0 113.0 19:03:37 INFO - PROCESS | 648 | 19:03:37 INFO - PROCESS | 648 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 19:03:37 INFO - PROCESS | 648 | Values: 146.0 145.0 147.0 146.0 146.0 146.0 145.0 146.0 145.0 146.0 19:03:37 INFO - PROCESS | 648 | 19:03:37 INFO - PROCESS | 648 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 19:03:37 INFO - PROCESS | 648 | Values: 95.0 93.0 94.0 94.0 95.0 94.0 94.0 93.0 94.0 94.0 19:03:37 INFO - PROCESS | 648 | 19:03:37 INFO - PROCESS | 648 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.50 stddev:0.67 (1.2%) stddev-sans-first:0.71 19:03:37 INFO - PROCESS | 648 | Values: 55.0 56.0 56.0 54.0 55.0 56.0 56.0 55.0 55.0 55.0 19:03:37 INFO - PROCESS | 648 | 19:03:37 INFO - PROCESS | 648 | [#9] json-stringify-tinderbox Cycles:10 Average:52.50 Median:53.00 stddev:0.53 (1.0%) stddev-sans-first:0.53 19:03:37 INFO - PROCESS | 648 | Values: 53.0 53.0 52.0 53.0 52.0 53.0 52.0 52.0 52.0 53.0 19:03:37 INFO - PROCESS | 648 | 19:03:37 INFO - PROCESS | 648 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:80.00 stddev:2.64 (3.3%) stddev-sans-first:2.69 19:03:37 INFO - PROCESS | 648 | Values: 77.0 80.0 75.0 77.0 78.0 80.0 84.0 82.0 80.0 78.0 19:03:37 INFO - PROCESS | 648 | 19:03:37 INFO - PROCESS | 648 | [#11] stanford-crypto-ccm Cycles:10 Average:126.80 Median:123.00 stddev:12.01 (9.8%) stddev-sans-first:12.66 19:03:37 INFO - PROCESS | 648 | Values: 123.0 123.0 123.0 122.0 121.0 119.0 121.0 123.0 159.0 134.0 19:03:37 INFO - PROCESS | 648 | 19:03:37 INFO - PROCESS | 648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.20 Median:161.50 stddev:3.05 (1.9%) stddev-sans-first:2.91 19:03:37 INFO - PROCESS | 648 | Values: 165.0 166.0 160.0 158.0 158.0 160.0 164.0 163.0 160.0 158.0 19:03:37 INFO - PROCESS | 648 | 19:03:37 INFO - PROCESS | 648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.80 Median:60.00 stddev:3.43 (5.7%) stddev-sans-first:3.63 19:03:37 INFO - PROCESS | 648 | Values: 61.0 60.0 59.0 68.0 60.0 59.0 59.0 66.0 58.0 58.0 19:03:37 INFO - PROCESS | 648 | -------- Summary: end -------- 19:03:37 INFO - PROCESS | 648 | 19:03:38 INFO - TEST-INFO | 648: exit 0 19:03:38 INFO - TEST-OK | kraken | took 60359ms 19:03:38 INFO - SUITE-END | took 1176s 19:03:38 INFO - Completed test suite (00:19:36) 19:03:38 INFO - javascript benchmark 19:03:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7904.726997682287, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3382.2389962258485, 3424.7260219182454, 3438.1576513754135, 3439.191789929367, 3480.791152530848, 5754.654720716755, 5825.854353641161, 5830.795922142725, 5833.533317334608, 5868.4718375346265, 5830.941690583093, 5879.617824841383, 5897.970510147454, 5898.734556944937, 5900.3214630317525, 5214.4524824893315, 5227.4511176326505, 5244.501772331641, 5306.8407947761625, 5320.201969704556, 5104.8979020419565, 5133.794648214067, 5185.818496352609, 5319.335083114611, 5323.866903327409, 5278.076336641092, 5290.65610735301, 5299.12564426871, 5306.893862122774, 5317.627766056377, 5307.495787900143, 5311.575073994071, 5313.0, 5322.600804939606, 5332.760025798849, 5043.9747801260755, 5070.923936140961, 5188.143956247215, 5252.973735131338, 5307.787688492455, 5701.0, 5713.400092990218, 5750.856228594319, 5776.682282474462, 5788.710564471759, 6215.471684906788, 6265.592736472115, 6269.435750782452, 6271.059341098826, 6272.87454250917, 6054.364291749391, 6308.0, 6318.810435686937, 6340.144080549159, 6343.429091381751, 5776.682282474462, 5788.18965344852, 5837.445442682938, 5842.298924129089, 5849.444302791228, 6374.075759014917, 6401.679916004181, 6411.070394792729, 6412.166418365676, 6416.101745755598, 6113.419225173601, 6174.25908890936, 6179.104029915637, 6187.195664563668, 6188.4739797117745, 6064.272287325549, 6108.083787431832, 6147.354527774519, 6191.040388739752, 6204.937950620526, 6226.439620434092, 6282.591631543935, 6283.8114856554375, 6286.277078136073, 6288.245410550763, 6072.089186621954, 6116.541259405473, 6123.203983482208, 6126.203593532812, 6134.173184329662, 4648.093621743795, 4657.1617108920045, 4665.860024199212, 4671.182543054952, 4700.271457924027, 4125.834966601303, 4142.627163555295, 4170.186813571385, 4244.129953359554, 4258.190943720683, 5925.140854576062, 5952.196453478725, 5975.731092100779, 5981.043033114768, 5983.700814959322, 6191.752329906753, 6194.5044396448175, 6197.690115494207, 6202.596831205957, 6214.130021796952, 5834.416558344132, 5875.853103672443, 5951.077582974646, 5957.702114894325, 5964.612300200473, 5258.0, 5309.601779866448, 5338.199270109515, 5340.092184328673, 5373.11343628297, 6490.48076153916, 6525.445337146396, 6531.738730450728, 6531.738730450728, 6539.08452816606, 6084.087386891824, 6236.968815155895, 6304.873902522016, 6308.810735677937, 6313.40022697843, 6412.743490260337, 6422.518311126778, 6456.7740129095255, 6574.079628851869, 6590.044443555562, 6208.72060757258, 6215.254169499508, 6221.47117495018, 6222.09779581949, 6223.0354295084335, 6267.185265915402, 6318.873622527615, 6330.082138089859, 6339.080833279241, 6340.334264902119, 5919.112133179885, 5986.431289027535, 6049.364816694184, 6096.908546371719, 6119.959572021022, 6053.0, 6068.120122582289, 6102.572819902564, 6119.816405507842, 6137.41694539018, 5910.320313163869, 6128.693565321627, 6143.754249829957, 6145.631262124287, 6156.569040167145, 6001.729922153426, 6075.3317135115985, 6104.084387341934, 6124.045297608125, 6188.381161883775, 6049.18336024631, 6053.788117415869, 6055.515558755201, 6062.757489700362, 6084.269887613515], "value": 5743.260298825172, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [760.3119177144682, 845.1379592815329, 864.2826454043145, 917.9127982841632, 933.8505839065751, 30331.241718957037, 30846.0, 32787.67212327879, 32799.67200327996, 42281.36577951325, 43951.0, 44165.337519937224, 44201.33697994533, 44241.778791106, 44242.0, 9007.099290071006, 9143.954280228623, 9153.496557689325, 9154.130357616015, 9165.175134237918, 7603.847923041536, 7770.145284018753, 8999.325050621197, 9096.226820720247, 10542.156627469822, 10844.511996960116, 10878.020978111968, 10883.83674244887, 10884.455777211148, 10887.673369798918, 10843.240973131884, 10866.348019118877, 10866.511007004665, 10867.402292873889, 10874.238803283693, 10583.62957296491, 10613.946930265376, 10634.0, 10640.733981650443, 10643.680689579247, 41676.79161604203, 41883.581164188574, 41955.0, 41956.0, 41968.79015604933, 4103.548609652936, 4112.033672087057, 4151.7924103794685, 4208.3687446882905, 4238.025254191553, 26209.959085919607, 29266.268343291376, 29383.70616293831, 29584.55623165654, 29908.0, 3437.5015622734563, 3479.4780782882517, 3495.405781017233, 3591.281743651254, 3599.3881040222964, 228239.0, 229364.0, 230273.0, 230561.0, 230941.0, 46166.0, 46332.7683361581, 46353.0, 46373.30440043402, 46389.07221855544, 48384.516154838, 48387.0, 48509.5149048512, 48804.0, 48824.511754882, 14965.700685986438, 15411.768823467657, 15418.614534636723, 15424.5372638821, 15433.0, 13154.144980576231, 13157.802632960513, 13197.604071877668, 13208.141470804367, 13208.801867971988, 11463.140264480196, 11779.528818847322, 12724.745505089846, 13081.084324097223, 13415.0, 5424.891502169935, 5484.890302194013, 5597.496225339739, 5607.467290607386, 5612.775488980476, 1035.2597892506894, 1043.9269251152498, 1046.1483174780597, 1234.2409418207737, 1302.863199364072, 26690.5996410054, 27213.591796123073, 27433.31416714598, 27490.450190996067, 27521.31196720098, 1363.8772510473907, 1372.9656758580916, 1381.9170849749048, 1383.688670049231, 1393.5888912770756, 14348.713025739427, 14408.0, 14493.347799349054, 14500.419983200554, 14763.33564989578, 166460.0, 166846.0, 167237.0, 167279.0, 167645.0, 57530.712346438, 57822.421775782546, 57923.23498972553, 57974.42025579775, 57999.130013049835, 1498.4530646314236, 1538.230884557721, 1549.5196489088419, 1559.4697802746894, 1562.3281988744948, 25010.874945625157, 26293.0, 26473.205803825917, 26549.0, 26615.0, 42503.362449562665, 42716.78641606772, 42793.78603106965, 42856.35715464333, 42911.57088429201, 336964.0, 338193.0, 338435.0, 338890.0, 338974.0, 31252.218694532818, 32233.0, 32235.194120147185, 32238.516422253215, 32241.193970150933, 33420.83289583537, 40925.59074409218, 42243.3663495054, 45723.0, 46529.0, 33893.66106338905, 34022.14944626305, 34186.48720269148, 34504.309913802084, 34518.96443106711, 33001.0, 33142.337153257286, 33392.833035834665, 33404.0, 33417.83291083626, 38106.0, 38669.61330386773, 38832.0, 39310.0, 39773.40339894962, 32534.67465325411, 32733.345333093683, 32759.508607370433, 32892.83553582217, 32916.0, 25807.225783226535, 26208.737912621393, 26273.343166420993, 26374.20877373682, 26564.0], "value": 18330.811377233804, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [452.5045075642171, 462.3619405220797, 475.41049099117083, 476.22613253463123, 487.28961345676674, 19651.901740491296, 20900.37298881034, 21330.57338853222, 21853.453663658416, 22032.8898355508, 21790.782092179074, 21874.562508749816, 22177.334679959586, 22363.55272894545, 22406.77593224067, 6830.6584670766515, 6831.897521537168, 6908.1364829396325, 6958.756443524478, 7151.427885769126, 6978.232394436608, 7033.683484243222, 7058.400035996947, 7734.381249500027, 8054.073781515113, 8139.308158806479, 8220.83558328833, 8231.053428855668, 8239.0, 8247.422680412374, 7917.406194535404, 8121.106678265386, 8121.512709237465, 8126.878096828582, 8170.754877353689, 7716.7684969451, 7926.445148839583, 8019.39854510914, 8043.758687239392, 8044.034715834137, 29397.41205175906, 30228.546571801442, 30364.392712145855, 30570.235744106354, 30652.693473065206, 3079.6920307969026, 3128.89048883288, 3215.3730022645595, 3307.58655168104, 3568.6252943440822, 17338.7399189011, 17357.566060848454, 17660.381886634033, 18362.724559131624, 18652.62694746111, 2264.6899814995613, 2285.4514916420108, 2294.162630639821, 2338.5790557699606, 2368.2066507719933, 106937.46531267294, 112712.43643781729, 113980.4300978498, 118313.40843295814, 118884.40557797156, 19732.30936917201, 20803.479913001993, 21844.563108738053, 21859.781402186094, 22480.662790058162, 41868.371974420406, 41886.58113418888, 41893.0, 41978.0, 42373.0, 11378.0, 11391.259568128045, 11552.306861588331, 11585.131115166396, 11803.763924721457, 9238.676646317346, 9280.443173409618, 9331.90668093324, 9511.66709165176, 9511.714648560554, 11079.279846809932, 11316.886831131584, 11467.197296189186, 11697.473613687405, 11733.765324693459, 4215.470717569434, 4297.484301883794, 4323.697341186087, 4347.217500849814, 4446.863872227583, 966.9951650241704, 973.8831340239217, 978.2418625565244, 997.581015973293, 1001.0740065439439, 19274.32539861126, 19980.800191997892, 20772.272970445963, 20943.790562094488, 21254.937253137283, 1083.2525557365393, 1096.7916095941746, 1109.9889001110048, 1110.0897264243404, 1146.6674664347245, 10660.840087398696, 11364.204505684687, 11419.429028548539, 11427.542898283975, 11587.59443419493, 578186.0, 630879.0, 702110.0, 702579.0, 728981.0, 119575.0, 122479.11016547146, 124111.37944310221, 125190.0, 126754.0, 1316.8485624153154, 1326.8142460055599, 1341.7182391697852, 1349.561392547426, 1361.3669643615567, 17602.559936001704, 17855.375061873292, 18137.27450901949, 18314.908425457787, 18353.3576324828, 53630.195547067604, 54475.45524544704, 54494.45505544894, 54794.452055478934, 56173.71913140408, 71008.28991710016, 71176.0, 71536.64231678809, 71669.6416517914, 71831.0, 12027.879721202677, 12088.274703517816, 12483.56307529232, 12616.684582885502, 12641.93679031599, 13603.183808971493, 13994.860051399763, 14074.718505629626, 14140.78788818148, 14204.147751134966, 12236.449359778653, 12266.877331226931, 12343.938280308541, 12545.498180072695, 12589.307588082744, 11560.710982225512, 11669.88330116688, 11812.527498899948, 11888.881111188777, 12155.939220303842, 12487.750244995232, 12587.559435419716, 12795.808062878878, 12836.358182091044, 12895.419706113435, 12325.630231093082, 12424.937875310565, 12484.93757531243, 12588.685282868002, 12625.431855566705, 12376.75246495083, 12447.191246062755, 12528.624141275777, 12825.102242843284, 12849.871501284868], "value": 12213.43594391196, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1395.4139261510165, 1469.0891647178744, 1507.2765072765073, 1526.3131590784144, 1526.847060819408, 9604.759881002978, 11261.099112071035, 11688.006519445848, 12072.336021518813, 12109.394530273496, 11646.883531164685, 11658.82511762322, 11737.47181376838, 11749.412529373518, 11766.176367654267, 1956.5499935014955, 2021.1006102284489, 2468.9753102468926, 2513.6355228491857, 2518.508890766301, 2449.9755002449924, 2501.7498250175017, 2513.924582262535, 2548.120898290087, 2550.4644024754825, 2437.1591800828774, 2464.4578192797558, 2467.6545283660303, 2471.3450935502015, 2472.7032756069207, 2413.915512957038, 2440.9389765255924, 2450.681411416522, 2455.72986971433, 2457.238256140602, 2351.2358483492935, 2353.435175557871, 2355.882205889716, 2360.197532838843, 2362.692849929498, 11758.118141139448, 11897.762044759143, 11926.642200733992, 11949.342786146759, 11977.341246231454, 5654.802081927154, 5771.942280577183, 5782.884342313172, 5799.768009279666, 5852.970735146339, 3253.3818574470774, 3330.8667653293837, 3497.178163131662, 3507.0355652195594, 3508.7894726316504, 1295.9740805183937, 1314.9737005259938, 1353.0731448957397, 1355.4442678501766, 2061.670132778763, 17993.280268789233, 17996.370127045622, 18010.90994545032, 18021.27914883416, 18075.819241807545, 4704.811807527661, 4770.880727981828, 4865.537773911473, 4868.707877527359, 4881.219004959189, 12992.415341309665, 12994.480220791062, 12997.740045199233, 12999.935000324938, 13010.934945325402, 5846.181534585162, 5857.26784151981, 5859.062549991981, 5864.970675146597, 5868.706564671749, 4718.669693121517, 4865.829695960695, 5323.387810401776, 5434.70109143993, 5437.673739575638, 4160.667146628262, 4165.291900376943, 4248.9787551062045, 4274.123804620045, 4275.935860962088, 1097.05653138301, 1102.8345748137845, 1109.9278546894589, 1122.1359553144034, 1129.6667483092508, 993.7068564773409, 1000.4697510319543, 1012.5291739341242, 1016.6594190946116, 1018.6027449294781, 6756.358145976124, 6787.796366109024, 6839.110915581042, 6873.140857392826, 6960.9303906961295, 1048.5805677728817, 1060.6605886116522, 1074.7205726511006, 1084.728817795551, 1091.3124731419155, 4275.636570891447, 4343.9348409773875, 4449.710768800082, 4492.213862574036, 4514.187446259639, 13907.304634768221, 14212.644683882985, 14702.63243418923, 15229.238538073274, 15276.465323713617, 14448.133112013313, 14648.780268295985, 14752.40990360395, 14769.0, 14786.334614942354, 10703.304285221591, 10861.02250797432, 11113.666590002313, 11115.72210694739, 11141.832872506919, 6950.443964482931, 7045.189803172496, 7168.8924666129005, 7169.426445884213, 7234.457415693739, 12831.486740530647, 12874.0, 12877.806832897326, 12892.0, 12892.806607900702, 13012.869871301544, 13170.934145329213, 13298.601041968757, 13364.799528006894, 13797.51708690191, 8152.510849349058, 8919.464832110094, 9851.310408271638, 10035.14701250402, 10047.296689231976, 11021.83467247976, 11366.431678416211, 11430.599929002445, 11447.0, 11465.885341146482, 9470.857937130811, 9512.191463725385, 9644.855327170239, 9660.082292182231, 9681.177099946583, 9039.68361107358, 9102.817943641223, 9160.358774885693, 9191.632334706537, 9236.769080773034, 8369.204925532065, 8454.070052294366, 8514.574271286534, 8524.318054555744, 8524.914750852413, 5878.706064696834, 5917.142014407801, 6014.0678194879865, 6022.879542409215, 6159.630422174684, 5904.9704751475965, 5912.201852749824, 5948.40515948419, 6012.0, 6147.362955048165], "value": 5405.967715111128, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.82099876054514, 418.4372019633593, 421.35532635068336, 436.5307294658241, 438.08658946097376, 5076.746162691869, 5164.967006598686, 5237.81456358205, 5280.947190528093, 5288.391834938983, 5115.7697903594335, 5173.9482605173935, 5190.506901844328, 5199.324087868572, 5207.6875387476775, 4497.347884556737, 4498.550144985508, 4512.398098674972, 4532.342810292505, 4539.319102134689, 4328.956710432903, 4452.243118669834, 4503.504614492404, 4516.887077823064, 4570.817167313304, 4428.250840917835, 4449.997501124491, 4458.821647134127, 4473.463184417875, 4477.753723545204, 4474.485434175079, 4481.3726078349055, 4481.955180448203, 4500.34744961982, 4506.188886000518, 4177.248095342837, 4311.762853043081, 4349.891252718708, 4359.645791272709, 4372.497162826284, 5079.933214025059, 5084.110280700863, 5084.694918304914, 5108.616853735947, 5114.723947843211, 5223.563520031984, 5244.685318880879, 5255.527002569787, 5273.288106105703, 5277.551408130314, 5387.73061346935, 5458.181272809071, 5491.9290738306045, 5542.972285138589, 5563.0, 4785.3300537924715, 4791.976040119812, 4804.447488538828, 4836.032793441326, 4839.854804355875, 5704.429557044304, 5719.313682358102, 5726.226959360516, 5731.0, 5771.826845194651, 4897.975510122498, 4936.48166942473, 5020.146575082244, 5043.394792624908, 5063.594912406998, 5036.597072234213, 5076.873078173001, 5080.644354895196, 5097.490250974873, 5132.820351287687, 5306.8407947761625, 5308.893822123536, 5323.441038690959, 5327.0, 5330.0, 5323.254744335719, 5457.417348968755, 5500.7524661390335, 5568.0, 5583.218349431083, 1692.2046638080083, 1710.8203638618015, 1751.1594434671174, 1767.7537336177963, 1774.308019872251, 1384.4978198654371, 1444.2356353305054, 1449.6665766873468, 1452.2012892908858, 1481.1705444950646, 5353.678779273178, 5355.544778693777, 5377.892442151135, 5399.244105825188, 5462.945370546244, 5593.496585307342, 5602.663840169603, 5615.185798059259, 5623.746931388016, 5627.859303517363, 5153.458886816905, 5388.811391601275, 5425.6202065855805, 5438.293021907127, 5450.773575945381, 2929.9121026369244, 2945.262295245815, 2959.150530918176, 2959.230600043961, 2959.77801664876, 5765.769369225184, 5795.391483894215, 5846.970765146147, 5867.589268751231, 5886.941130588725, 5460.262864513319, 5712.429731417864, 5755.359722479074, 5774.3070831499645, 5797.0000699517195, 5963.284405871236, 5973.342932277446, 5983.5295528593315, 5988.251468566429, 5988.790392336247, 5427.24018637399, 5693.743781529758, 5710.200571919851, 5722.341930677859, 5737.5983681141915, 5628.577856660685, 5648.209250704823, 5656.462636049569, 5691.950897676916, 5696.231008813757, 5744.482996530165, 5895.469407753323, 5938.703064846654, 5943.762249509971, 5952.910706339495, 4695.5539223773685, 4836.274558816065, 5030.723310217973, 5094.5160209780015, 5109.412417571878, 5406.594505412031, 5520.420355862737, 5530.617345663584, 5667.688277144632, 5685.545156387397, 5514.80698175562, 5519.39286678457, 5522.144067669517, 5541.833744987657, 5549.361823390362, 5457.117294533379, 5467.906418716352, 5485.135054081631, 5511.5669925818775, 5532.446755324436, 5310.946890531045, 5461.197804724511, 5483.670979741229, 5510.944890551204, 5518.586106041983, 5494.478024587658, 5507.669539827623, 5548.529639645417, 5582.525485333792, 5587.832365029056, 5208.921866171935, 5378.462153784591, 5416.454266494741, 5424.132138857922, 5437.673739575638], "value": 4514.751121820034, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [838.9958050209748, 881.5680316644846, 903.2457897655457, 926.5598840550738, 943.1935694980789, 17298.56753581161, 17454.94766106491, 17659.381921632747, 17667.64664706705, 17683.29266829327, 16343.754843677325, 17063.74404383932, 17118.486445406626, 17154.82845171548, 17205.397811076615, 884.9424787388831, 890.5814267294361, 905.3933864310894, 908.9000209976897, 911.1116661255256, 887.414306557672, 889.1153302464057, 889.9955500222522, 890.341147550811, 890.398980688033, 936.1901954809109, 936.8220038192756, 942.6323733743845, 944.8393773058563, 945.6879229854131, 935.8923723771751, 937.2267878999818, 937.5640327247794, 937.728058862929, 939.0937745076001, 693.549193024533, 694.2918223412091, 694.3369082526175, 694.4132208283992, 694.798508432554, 17322.307107715675, 17359.132043397778, 17533.824661753475, 18080.18639161241, 18379.172937217725, 16158.0, 16315.83684163155, 16493.257803398876, 16580.668386632322, 16635.0, 12731.490740370375, 12888.484460621565, 13051.543195988095, 13141.605751827461, 13164.40760165795, 3835.7314987950854, 3847.71142164336, 3876.1666241758157, 3920.4511368408444, 3924.7448915820382, 87630.0, 89515.10484895133, 89543.10456895414, 90182.5490872548, 91895.0, 11360.204785664924, 12434.62696119118, 12449.25304481734, 12544.184627999151, 12694.238345699288, 21501.24745633895, 21568.460788480414, 21665.891670541547, 21896.671549926763, 22000.33998980033, 8243.752687419386, 8264.421490495728, 8329.708460203863, 8435.915640843636, 8569.742907712778, 4372.868813935587, 4519.683622146484, 4842.225243960949, 4847.3698419205275, 4919.803207871645, 3710.851565937386, 3798.8290526926353, 3802.125511132455, 3810.3141434541494, 3812.1232116613332, 606.730005147705, 619.9256089269227, 624.4629618528062, 630.391672036487, 635.2726128582747, 840.3528487464332, 850.0691742542031, 856.4946681457845, 869.4088020146235, 881.1981097201516, 10319.116614285731, 10347.327423717434, 10840.078593319657, 11451.54193832254, 11488.253263537843, 798.8202654402713, 804.6137853830194, 811.5171472973572, 812.7521106062708, 826.9255766981, 5226.0, 5365.543928766098, 5522.972385138129, 5551.361593416728, 5720.08478643415, 66533.33466665368, 75794.24205757982, 79363.60318198372, 82646.0, 83077.0, 43311.56688433075, 44152.558474415484, 47156.7642161787, 73126.63436682783, 77474.61262693763, 57880.0, 62342.688286558274, 62515.37484625186, 62758.0, 63173.68413157997, 10639.308444951053, 10997.175211859303, 11000.169909947741, 11114.110871130451, 11244.437778111225, 42280.0, 42935.57064429441, 43681.78159109184, 43771.0, 44457.555424445345, 50541.74729126331, 51154.74422627863, 51975.0, 52380.73809630927, 56693.0, 13338.0, 13476.124051936593, 13966.790498142333, 14082.647933801736, 14119.929400353343, 15156.393744250106, 15869.0, 16420.507384777997, 16463.670726585642, 16668.41660541875, 13945.790813137608, 14628.780568291271, 14721.705565888837, 14734.26328683583, 14743.778843317574, 14393.496227631982, 14589.781153282496, 14644.41422343137, 14973.700525989638, 15209.771853421986, 14084.859151408355, 14152.78770818459, 14527.564173074825, 14569.927150364181, 14658.706825863635, 10888.45557722095, 11179.608713695307, 11742.706432338919, 11779.115341545312, 11802.114841387101, 11191.832122518006, 11257.268277561932, 11958.521659133885, 11990.400479975791, 12693.619191424272], "value": 7773.172912467164, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1455.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 114.0, 112.0, 112.0, 113.0, 112.0, 112.0, 113.0, 113.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 114.0, 116.0, 154.0, 116.0, 121.0, 114.0, 120.0, 135.0, 117.0], "value": 124.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 160.0, 160.0, 162.0, 162.0, 161.0, 160.0, 159.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 85.0, 110.0, 76.0, 76.0, 75.0, 75.0, 104.0, 75.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 115.0, 81.0, 81.0, 81.0, 93.0, 81.0, 81.0, 99.0], "value": 87.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 113.0, 113.0, 112.0, 113.0, 113.0, 113.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 147.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 93.0, 94.0, 94.0, 95.0, 94.0, 94.0, 93.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 54.0, 55.0, 56.0, 56.0, 55.0, 55.0, 55.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 52.0, 53.0, 52.0, 53.0, 52.0, 52.0, 52.0, 53.0], "value": 52.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 80.0, 75.0, 77.0, 78.0, 80.0, 84.0, 82.0, 80.0, 78.0], "value": 79.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 123.0, 123.0, 122.0, 121.0, 119.0, 121.0, 123.0, 159.0, 134.0], "value": 126.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 160.0, 158.0, 158.0, 160.0, 164.0, 163.0, 160.0, 158.0], "value": 161.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 59.0, 68.0, 60.0, 59.0, 59.0, 66.0, 58.0, 58.0], "value": 60.8, "unit": "score"}]}]} 19:03:39 INFO - Return code: 0 19:03:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:03:39 ERROR - # TBPL SUCCESS # 19:03:39 INFO - Running post-action listener: _resource_record_post_action 19:03:39 INFO - [mozharness: 2017-04-05 02:03:39.103020Z] Finished run-tests step (success) 19:03:39 INFO - Running post-run listener: _resource_record_post_run 19:03:39 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 266240; Write bytes: 366317568; Read time: 32; Write time: 260236 19:03:39 INFO - TinderboxPrint: CPU usage
13.1% 19:03:39 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 32 19:03:39 INFO - TinderboxPrint: I/O write bytes / time
366,317,568 / 260,236 19:03:39 INFO - TinderboxPrint: CPU idle
8,271.8 (86.9%) 19:03:39 INFO - TinderboxPrint: CPU user
1,201.7 (12.6%) 19:03:39 INFO - TinderboxPrint: Swap in / out
0 / 0 19:03:39 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 112857088; Read time: 0; Write time: 110076 19:03:39 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 266240; Write bytes: 253460480; Read time: 32; Write time: 150160 19:03:39 INFO - Running post-run listener: _upload_blobber_files 19:03:39 INFO - Blob upload gear active. 19:03:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:03:39 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 19:03:39 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'] 19:03:39 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 19:03:40 INFO - (blobuploader) - INFO - Open directory for files ... 19:03:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:03:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:03:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:03:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:03:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:03:44 INFO - (blobuploader) - INFO - Done attempting. 19:03:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:03:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:03:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:03:45 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:03:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:03:45 INFO - (blobuploader) - INFO - Done attempting. 19:03:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:03:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:03:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:03:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:03:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:03:46 INFO - (blobuploader) - INFO - Done attempting. 19:03:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:03:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:03:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:03:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:03:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:03:47 INFO - (blobuploader) - INFO - Done attempting. 19:03:47 INFO - (blobuploader) - INFO - Iteration through files over. 19:03:47 INFO - Return code: 0 19:03:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:03:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:03:47 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/221f59b32d25e67c89f60777980684c86c3e0dace6c371046258e7226e0657b5df0d3fb79a9e590b44a6b6c4c85ef97bf45b7bb4f75fde71e51647d3ba4f9cc8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/71e36716535d090c993a48dbbff161159e1d32575683b8d578947ee69af271e8a55cfef42b82527dd7d6cb31c23601ab9f6dbe109d4a6983454063c0e0e56c71", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/440ef86f18c3e8a3b52851498366ecedd7fee99aba6e6509ccbaf381531abaf825553ed983a6e06d3a427eabd4d881c3a96868f2d1f6a56d79ee062735c60a96", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ceaa45e0ee7649ce85babdae7dfda283f17dc183ddaabb1f2d66de87eb08c06217bdcd659de43919b6d167cd8f3b569c94bfc70a975e367cd6f87f4b4b10d730"} 19:03:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:03:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:03:47 INFO - Contents: 19:03:47 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/221f59b32d25e67c89f60777980684c86c3e0dace6c371046258e7226e0657b5df0d3fb79a9e590b44a6b6c4c85ef97bf45b7bb4f75fde71e51647d3ba4f9cc8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/71e36716535d090c993a48dbbff161159e1d32575683b8d578947ee69af271e8a55cfef42b82527dd7d6cb31c23601ab9f6dbe109d4a6983454063c0e0e56c71", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/440ef86f18c3e8a3b52851498366ecedd7fee99aba6e6509ccbaf381531abaf825553ed983a6e06d3a427eabd4d881c3a96868f2d1f6a56d79ee062735c60a96", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ceaa45e0ee7649ce85babdae7dfda283f17dc183ddaabb1f2d66de87eb08c06217bdcd659de43919b6d167cd8f3b569c94bfc70a975e367cd6f87f4b4b10d730"} 19:03:47 INFO - Running post-run listener: copy_logs_to_upload_dir 19:03:47 INFO - Copying logs to upload dir... 19:03:47 INFO - mkdir: /builds/slave/test/build/upload/logs 19:03:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.043495 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-04-04 19:03:47.408256) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-04 19:03:47.412334) ========= 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=03627c79f6bb3d1578c4a402000001ba-1491356569.35742-1626508172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/221f59b32d25e67c89f60777980684c86c3e0dace6c371046258e7226e0657b5df0d3fb79a9e590b44a6b6c4c85ef97bf45b7bb4f75fde71e51647d3ba4f9cc8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/71e36716535d090c993a48dbbff161159e1d32575683b8d578947ee69af271e8a55cfef42b82527dd7d6cb31c23601ab9f6dbe109d4a6983454063c0e0e56c71", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/440ef86f18c3e8a3b52851498366ecedd7fee99aba6e6509ccbaf381531abaf825553ed983a6e06d3a427eabd4d881c3a96868f2d1f6a56d79ee062735c60a96", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ceaa45e0ee7649ce85babdae7dfda283f17dc183ddaabb1f2d66de87eb08c06217bdcd659de43919b6d167cd8f3b569c94bfc70a975e367cd6f87f4b4b10d730"} build_url:https://queue.taskcluster.net/v1/task/Pv3OoWUGRh2f9yhYeImwbw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011301 build_url: 'https://queue.taskcluster.net/v1/task/Pv3OoWUGRh2f9yhYeImwbw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/221f59b32d25e67c89f60777980684c86c3e0dace6c371046258e7226e0657b5df0d3fb79a9e590b44a6b6c4c85ef97bf45b7bb4f75fde71e51647d3ba4f9cc8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/71e36716535d090c993a48dbbff161159e1d32575683b8d578947ee69af271e8a55cfef42b82527dd7d6cb31c23601ab9f6dbe109d4a6983454063c0e0e56c71", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/440ef86f18c3e8a3b52851498366ecedd7fee99aba6e6509ccbaf381531abaf825553ed983a6e06d3a427eabd4d881c3a96868f2d1f6a56d79ee062735c60a96", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ceaa45e0ee7649ce85babdae7dfda283f17dc183ddaabb1f2d66de87eb08c06217bdcd659de43919b6d167cd8f3b569c94bfc70a975e367cd6f87f4b4b10d730"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-04 19:03:47.437635) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 19:03:47.437976) ========= 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=03627c79f6bb3d1578c4a402000001ba-1491356569.35742-1626508172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004407 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 19:03:47.523562) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-04 19:03:47.523890) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-04 19:03:47.524183) ========= ========= Total master_lag: 0.17 =========