builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-018 starttime: 1491356758.89 results: success (0) revision: 896e9cfb9d67d6a73e70e39532f31306c22202cb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-04 18:45:58.886188) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-04 18:45:58.886679) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-04 18:45:58.886961) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-04 18:45:58.901490) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 18:45:58.901797) ========= 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=62c568580acbfdaac3eec7be000001dc-1491356757.669321-477141698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-04 18:45:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.7M=0s 2017-04-04 18:45:59 (42.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.115444 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 18:45:59.031368) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 18:45:59.031734) ========= 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=62c568580acbfdaac3eec7be000001dc-1491356757.669321-477141698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014363 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 18:45:59.081729) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 18:45:59.082079) ========= 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=62c568580acbfdaac3eec7be000001dc-1491356757.669321-477141698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-04 18:45:59,179 truncating revision to first 12 chars 2017-04-04 18:45:59,179 Setting DEBUG logging. 2017-04-04 18:45:59,179 attempt 1/10 2017-04-04 18:45:59,179 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:45:59,475 unpacking tar archive at: mozilla-aurora-896e9cfb9d67/testing/mozharness/ program finished with exit code 0 elapsedTime=0.584253 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 18:45:59.679918) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-04 18:45:59.680251) ========= script_repo_revision: 896e9cfb9d67d6a73e70e39532f31306c22202cb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-04 18:45:59.680714) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-04 18:45:59.681014) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-04 18:45:59.690047) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-04-04 18:45:59.690428) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=62c568580acbfdaac3eec7be000001dc-1491356757.669321-477141698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:45:59 INFO - MultiFileLogger online at 20170404 18:45:59 in /builds/slave/test 18:45:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:45:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:45:59 INFO - {'append_to_log': False, 18:45:59 INFO - 'base_work_dir': '/builds/slave/test', 18:45:59 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 18:45:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:45:59 INFO - 'branch': 'Mozilla-Aurora', 18:45:59 INFO - 'buildbot_json_path': 'buildprops.json', 18:45:59 INFO - 'config_files': ('talos/linux_config.py',), 18:45:59 INFO - 'default_actions': ('clobber', 18:45:59 INFO - 'read-buildbot-config', 18:45:59 INFO - 'download-and-extract', 18:45:59 INFO - 'populate-webroot', 18:45:59 INFO - 'create-virtualenv', 18:45:59 INFO - 'install', 18:45:59 INFO - 'run-tests'), 18:45:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:45:59 INFO - 'download_minidump_stackwalk': True, 18:45:59 INFO - 'download_symbols': 'ondemand', 18:45:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:45:59 INFO - 'tooltool.py': '/tools/tooltool.py', 18:45:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:45:59 INFO - '/tools/misc-python/virtualenv.py')}, 18:45:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:45:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:45:59 INFO - 'gecko_profile': False, 18:45:59 INFO - 'gecko_profile_interval': 0, 18:45:59 INFO - 'installer_path': 'installer.exe', 18:45:59 INFO - 'log_level': 'info', 18:45:59 INFO - 'log_name': 'talos', 18:45:59 INFO - 'log_to_console': True, 18:45:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:45:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:45:59 INFO - 'opt_config_files': (), 18:45:59 INFO - 'pip_index': False, 18:45:59 INFO - 'suite': 'dromaeojs-e10s', 18:45:59 INFO - 'system_bits': '32', 18:45:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:45:59 INFO - 'title': 'talos-linux64-ix-018', 18:45:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:45:59 INFO - 'use_talos_json': True, 18:45:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:45:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:45:59 INFO - 'work_dir': 'build'} 18:45:59 INFO - [mozharness: 2017-04-05 01:45:59.881904Z] Running clobber step. 18:45:59 INFO - Running pre-action listener: _resource_record_pre_action 18:45:59 INFO - Running main action method: clobber 18:45:59 INFO - rmtree: /builds/slave/test/build 18:45:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:46:00 INFO - Running post-action listener: _resource_record_post_action 18:46:00 INFO - [mozharness: 2017-04-05 01:46:00.820254Z] Finished clobber step (success) 18:46:00 INFO - [mozharness: 2017-04-05 01:46:00.820353Z] Running read-buildbot-config step. 18:46:00 INFO - Running pre-action listener: _resource_record_pre_action 18:46:00 INFO - Running main action method: read_buildbot_config 18:46:00 INFO - Using buildbot properties: 18:46:00 INFO - { 18:46:00 INFO - "project": "", 18:46:00 INFO - "product": "firefox", 18:46:00 INFO - "who": "ryanvm@gmail.com", 18:46:00 INFO - "installer_path": "public/build/target.tar.bz2", 18:46:00 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 18:46:00 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 18:46:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 18:46:00 INFO - "stage_platform": "linux64-pgo", 18:46:00 INFO - "basedir": "/builds/slave/test", 18:46:00 INFO - "buildnumber": 857, 18:46:00 INFO - "platform": "ubuntu64_hw", 18:46:00 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:46:00 INFO - "slavebuilddir": "test", 18:46:00 INFO - "taskId": "ZqmrQSxmSOSbQp4_oOY1gA", 18:46:00 INFO - "branch": "mozilla-aurora", 18:46:00 INFO - "script_repo_revision": "production", 18:46:00 INFO - "revision": "896e9cfb9d67d6a73e70e39532f31306c22202cb", 18:46:00 INFO - "slavename": "talos-linux64-ix-018", 18:46:00 INFO - "repo_path": "releases/mozilla-aurora" 18:46:00 INFO - } 18:46:00 INFO - Finding installer, test and symbols from parent task. 18:46:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZqmrQSxmSOSbQp4_oOY1gA'}, attempt #1 18:46:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZqmrQSxmSOSbQp4_oOY1gA'}, attempt #1 18:46:01 INFO - Task dependencies: Pv3OoWUGRh2f9yhYeImwbw 18:46:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pv3OoWUGRh2f9yhYeImwbw'}, attempt #1 18:46:02 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Pv3OoWUGRh2f9yhYeImwbw/artifacts/public/build/target.tar.bz2 18:46:02 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Pv3OoWUGRh2f9yhYeImwbw/artifacts/public/build/test_packages.json 18:46:02 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Pv3OoWUGRh2f9yhYeImwbw/artifacts/public/build/target.crashreporter-symbols.zip 18:46:02 INFO - Running post-action listener: _resource_record_post_action 18:46:02 INFO - [mozharness: 2017-04-05 01:46:02.184937Z] Finished read-buildbot-config step (success) 18:46:02 INFO - [mozharness: 2017-04-05 01:46:02.185158Z] Running download-and-extract step. 18:46:02 INFO - Running pre-action listener: _resource_record_pre_action 18:46:02 INFO - Running main action method: download_and_extract 18:46:02 INFO - mkdir: /builds/slave/test/build/tests 18:46: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:46:02 INFO - trying https://queue.taskcluster.net/v1/task/Pv3OoWUGRh2f9yhYeImwbw/artifacts/public/build/target.test_packages.json 18:46:02 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:46:02 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:46:02 INFO - Downloaded 896 bytes. 18:46:02 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:46:02 INFO - Using the following test package requirements: 18:46:02 INFO - {u'common': [u'target.common.tests.zip'], 18:46:02 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:46:02 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:46:02 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:46:02 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:46:02 INFO - u'mozbase': [u'target.common.tests.zip'], 18:46:02 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:46:02 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:46:02 INFO - u'web-platform': [u'target.common.tests.zip', 18:46:02 INFO - u'target.web-platform.tests.zip'], 18:46:02 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:46:02 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:46:02 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:46:02 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:46:02 INFO - Fetch https://queue.taskcluster.net/v1/task/Pv3OoWUGRh2f9yhYeImwbw/artifacts/public/build/target.common.tests.zip into memory 18:46:03 INFO - Expected file size: 59540708 18:46:03 INFO - Obtained file size: 59540708 18:46:13 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:46:13 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:46:13 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:46:13 INFO - Fetch https://queue.taskcluster.net/v1/task/Pv3OoWUGRh2f9yhYeImwbw/artifacts/public/build/target.common.tests.zip into memory 18:46:14 INFO - Expected file size: 59540708 18:46:14 INFO - Obtained file size: 59540708 18:46:25 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:46:25 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:46:25 INFO - Fetch https://queue.taskcluster.net/v1/task/Pv3OoWUGRh2f9yhYeImwbw/artifacts/public/build/target.talos.tests.zip into memory 18:46:26 INFO - Expected file size: 14404438 18:46:26 INFO - Obtained file size: 14404438 18:46:26 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:46:26 INFO - trying https://queue.taskcluster.net/v1/task/Pv3OoWUGRh2f9yhYeImwbw/artifacts/public/build/target.tar.bz2 18:46:26 INFO - Downloading https://queue.taskcluster.net/v1/task/Pv3OoWUGRh2f9yhYeImwbw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:46:26 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:46:27 INFO - Downloaded 66784982 bytes. 18:46:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Pv3OoWUGRh2f9yhYeImwbw/artifacts/public/build/target.tar.bz2 18:46:27 INFO - mkdir: /builds/slave/test/properties 18:46:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:46:27 INFO - Writing to file /builds/slave/test/properties/build_url 18:46:27 INFO - Contents: 18:46:27 INFO - build_url:https://queue.taskcluster.net/v1/task/Pv3OoWUGRh2f9yhYeImwbw/artifacts/public/build/target.tar.bz2 18:46:27 INFO - Running post-action listener: _resource_record_post_action 18:46:27 INFO - Running post-action listener: set_extra_try_arguments 18:46:27 INFO - [mozharness: 2017-04-05 01:46:27.613487Z] Finished download-and-extract step (success) 18:46:27 INFO - [mozharness: 2017-04-05 01:46:27.613583Z] Running populate-webroot step. 18:46:27 INFO - Running pre-action listener: _resource_record_pre_action 18:46:27 INFO - Running main action method: populate_webroot 18:46:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:46:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:46:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:46:27 INFO - '--tppagecycles', 18:46:27 INFO - '7'], 18:46:27 INFO - 'tests': ['tsvgm']}}, 18:46:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:46:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:46:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:46:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:46:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:46:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:46:27 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:46:27 INFO - 'talos_options': ['--disable-e10s'], 18:46:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:46:27 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:46:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:46:27 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:46:27 INFO - 'talos_options': ['--disable-e10s'], 18:46:27 INFO - 'tests': ['damp', 'tps']}, 18:46:27 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:46:27 INFO - 'tests': ['damp', 'tps']}, 18:46:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:46:27 INFO - 'tests': ['dromaeo_dom']}, 18:46:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:46:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:46:27 INFO - 'tests': ['basic_compositor_video']}, 18:46:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:46:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:46:27 INFO - 'tests': ['a11yr', 18:46:27 INFO - 'ts_paint', 18:46:27 INFO - 'tpaint', 18:46:27 INFO - 'sessionrestore', 18:46:27 INFO - 'sessionrestore_no_auto_restore', 18:46:27 INFO - 'tabpaint']}, 18:46:27 INFO - 'other-e10s': {'tests': ['a11yr', 18:46:27 INFO - 'ts_paint', 18:46:27 INFO - 'tpaint', 18:46:27 INFO - 'sessionrestore', 18:46:27 INFO - 'sessionrestore_no_auto_restore', 18:46:27 INFO - 'tabpaint']}, 18:46:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:46:27 INFO - 'ts_paint', 18:46:27 INFO - 'tpaint', 18:46:27 INFO - 'sessionrestore', 18:46:27 INFO - 'sessionrestore_no_auto_restore', 18:46:27 INFO - 'tabpaint']}, 18:46:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:46:27 INFO - 'ts_paint', 18:46:27 INFO - 'tpaint', 18:46:27 INFO - 'sessionrestore', 18:46:27 INFO - 'sessionrestore_no_auto_restore', 18:46:27 INFO - 'tabpaint']}, 18:46:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:46:27 INFO - 'tests': ['a11yr', 18:46:27 INFO - 'ts_paint', 18:46:27 INFO - 'tpaint', 18:46:27 INFO - 'sessionrestore', 18:46:27 INFO - 'sessionrestore_no_auto_restore', 18:46:27 INFO - 'tabpaint']}, 18:46:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:46:27 INFO - 'tests': ['a11yr', 18:46:27 INFO - 'ts_paint', 18:46:27 INFO - 'tpaint', 18:46:27 INFO - 'sessionrestore', 18:46:27 INFO - 'sessionrestore_no_auto_restore', 18:46:27 INFO - 'tabpaint']}, 18:46:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:46:27 INFO - 'tests': ['tsvgx', 18:46:27 INFO - 'tsvgr_opacity', 18:46:27 INFO - 'tart', 18:46:27 INFO - 'tscrollx', 18:46:27 INFO - 'cart', 18:46:27 INFO - 'tsvg_static']}, 18:46:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:46:27 INFO - 'tsvgr_opacity', 18:46:27 INFO - 'tart', 18:46:27 INFO - 'tscrollx', 18:46:27 INFO - 'cart', 18:46:27 INFO - 'tsvg_static']}, 18:46:27 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:46:27 INFO - 'talos_options': ['--disable-e10s'], 18:46:27 INFO - 'tests': ['tp5o']}, 18:46:27 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:46:27 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:46:27 INFO - 'talos_options': ['--disable-e10s', 18:46:27 INFO - '--xperf_path', 18:46:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:46:27 INFO - 'tests': ['tp5n']}, 18:46:27 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:46:27 INFO - 'talos_options': ['--xperf_path', 18:46:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:46:27 INFO - 'tests': ['tp5n']}}, 18:46:27 INFO - 'talos.zip': {'path': '', 18:46:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:46:27 INFO - Running post-action listener: _resource_record_post_action 18:46:27 INFO - [mozharness: 2017-04-05 01:46:27.626714Z] Finished populate-webroot step (success) 18:46:27 INFO - [mozharness: 2017-04-05 01:46:27.626803Z] Running create-virtualenv step. 18:46:27 INFO - Running pre-action listener: _resource_record_pre_action 18:46:27 INFO - Running main action method: create_virtualenv 18:46:27 INFO - Creating virtualenv /builds/slave/test/build/venv 18:46:27 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:46:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:46:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:46:27 INFO - Using real prefix '/usr' 18:46:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:46:28 INFO - Installing distribute.............................................................................................................................................................................................done. 18:46:30 INFO - Installing pip.................done. 18:46:30 INFO - Return code: 0 18:46:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:46:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:46:30 INFO - Reading from file tmpfile_stdout 18:46:30 INFO - Output received: 18:46:30 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:46:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:46:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:46:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:30 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 0x10811f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1179a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131c290>, '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 0x131cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x131d040>, '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': '62c568580acbfdaac3eec7be000001dc-1491356757.669321-477141698', '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:46:30 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:46:30 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:46:30 INFO - Using env: {'DISPLAY': ':0', 18:46:30 INFO - 'HOME': '/home/cltbld', 18:46:30 INFO - 'LANG': 'en_US.UTF-8', 18:46:30 INFO - 'LANGUAGE': 'en_US:en', 18:46:30 INFO - 'LOGNAME': 'cltbld', 18:46:30 INFO - 'MAIL': '/var/mail/cltbld', 18:46:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:30 INFO - 'MOZ_NO_REMOTE': '1', 18:46:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:30 INFO - 'NO_EM_RESTART': '1', 18:46:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:30 INFO - 'PWD': '/builds/slave/test', 18:46:30 INFO - 'SHELL': '/bin/bash', 18:46:30 INFO - 'SHLVL': '1', 18:46:30 INFO - 'TERM': 'linux', 18:46:30 INFO - 'TMOUT': '86400', 18:46:30 INFO - 'USER': 'cltbld', 18:46:30 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1491356757.669321-477141698', 18:46:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:30 INFO - '_': '/tools/buildbot/bin/python'} 18:46:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:30 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:46:30 INFO - Cleaning up... 18:46:30 INFO - Return code: 0 18:46:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:46:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:46:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:30 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 0x10811f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1179a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131c290>, '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 0x131cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x131d040>, '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': '62c568580acbfdaac3eec7be000001dc-1491356757.669321-477141698', '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:46:30 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:46:30 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:46:30 INFO - Using env: {'DISPLAY': ':0', 18:46:30 INFO - 'HOME': '/home/cltbld', 18:46:30 INFO - 'LANG': 'en_US.UTF-8', 18:46:30 INFO - 'LANGUAGE': 'en_US:en', 18:46:30 INFO - 'LOGNAME': 'cltbld', 18:46:30 INFO - 'MAIL': '/var/mail/cltbld', 18:46:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:30 INFO - 'MOZ_NO_REMOTE': '1', 18:46:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:30 INFO - 'NO_EM_RESTART': '1', 18:46:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:30 INFO - 'PWD': '/builds/slave/test', 18:46:30 INFO - 'SHELL': '/bin/bash', 18:46:30 INFO - 'SHLVL': '1', 18:46:30 INFO - 'TERM': 'linux', 18:46:30 INFO - 'TMOUT': '86400', 18:46:30 INFO - 'USER': 'cltbld', 18:46:30 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1491356757.669321-477141698', 18:46:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:30 INFO - '_': '/tools/buildbot/bin/python'} 18:46:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:30 INFO - Downloading/unpacking psutil>=3.1.1 18:46:30 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:46:30 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:46:30 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:46:30 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:46:30 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:46:30 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:46:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:46:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:46:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:46:32 INFO - Installing collected packages: psutil 18:46:32 INFO - Running setup.py install for psutil 18:46:33 INFO - building 'psutil._psutil_linux' extension 18:46:33 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:46:33 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:46:33 INFO - building 'psutil._psutil_posix' extension 18:46:33 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:46:33 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:46:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:46:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:46:33 INFO - Successfully installed psutil 18:46:33 INFO - Cleaning up... 18:46:33 INFO - Return code: 0 18:46:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:46:33 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:46:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:33 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:46:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:33 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 0x10811f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1179a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131c290>, '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 0x131cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x131d040>, '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': '62c568580acbfdaac3eec7be000001dc-1491356757.669321-477141698', '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:46:33 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:46:33 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:46:33 INFO - Using env: {'DISPLAY': ':0', 18:46:33 INFO - 'HOME': '/home/cltbld', 18:46:33 INFO - 'LANG': 'en_US.UTF-8', 18:46:33 INFO - 'LANGUAGE': 'en_US:en', 18:46:33 INFO - 'LOGNAME': 'cltbld', 18:46:33 INFO - 'MAIL': '/var/mail/cltbld', 18:46:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:33 INFO - 'MOZ_NO_REMOTE': '1', 18:46:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:33 INFO - 'NO_EM_RESTART': '1', 18:46:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:33 INFO - 'PWD': '/builds/slave/test', 18:46:33 INFO - 'SHELL': '/bin/bash', 18:46:33 INFO - 'SHLVL': '1', 18:46:33 INFO - 'TERM': 'linux', 18:46:33 INFO - 'TMOUT': '86400', 18:46:33 INFO - 'USER': 'cltbld', 18:46:33 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1491356757.669321-477141698', 18:46:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:33 INFO - '_': '/tools/buildbot/bin/python'} 18:46:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:46: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:46: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:46: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:46: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:46: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:46: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:46:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:46:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:46:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:46:35 INFO - Installing collected packages: mozsystemmonitor 18:46:35 INFO - Running setup.py install for mozsystemmonitor 18:46:35 INFO - Successfully installed mozsystemmonitor 18:46:35 INFO - Cleaning up... 18:46:35 INFO - Return code: 0 18:46:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:46:35 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:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:35 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:46:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:35 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 0x10811f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1179a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131c290>, '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 0x131cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x131d040>, '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': '62c568580acbfdaac3eec7be000001dc-1491356757.669321-477141698', '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:46:35 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:46:35 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:46:35 INFO - Using env: {'DISPLAY': ':0', 18:46:35 INFO - 'HOME': '/home/cltbld', 18:46:35 INFO - 'LANG': 'en_US.UTF-8', 18:46:35 INFO - 'LANGUAGE': 'en_US:en', 18:46:35 INFO - 'LOGNAME': 'cltbld', 18:46:35 INFO - 'MAIL': '/var/mail/cltbld', 18:46:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:35 INFO - 'MOZ_NO_REMOTE': '1', 18:46:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:35 INFO - 'NO_EM_RESTART': '1', 18:46:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:35 INFO - 'PWD': '/builds/slave/test', 18:46:35 INFO - 'SHELL': '/bin/bash', 18:46:35 INFO - 'SHLVL': '1', 18:46:35 INFO - 'TERM': 'linux', 18:46:35 INFO - 'TMOUT': '86400', 18:46:35 INFO - 'USER': 'cltbld', 18:46:35 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1491356757.669321-477141698', 18:46:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:35 INFO - '_': '/tools/buildbot/bin/python'} 18:46:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:36 INFO - Downloading/unpacking jsonschema==2.5.1 18:46: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:46: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:46: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:46: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:46: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:46: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:46:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:46:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:46:38 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:46:38 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:46:38 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:46:38 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:46:38 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:46:38 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:46:38 INFO - Downloading functools32-3.2.3-2.tar.gz 18:46:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:46:38 INFO - warning: no files found matching '*.txt' 18:46:38 INFO - no previously-included directories found matching 'build' 18:46:38 INFO - no previously-included directories found matching 'dist' 18:46:38 INFO - no previously-included directories found matching '.git*' 18:46:38 INFO - Installing collected packages: jsonschema, functools32 18:46:38 INFO - Running setup.py install for functools32 18:46:38 INFO - warning: no files found matching '*.txt' 18:46:38 INFO - no previously-included directories found matching 'build' 18:46:38 INFO - no previously-included directories found matching 'dist' 18:46:38 INFO - no previously-included directories found matching '.git*' 18:46:38 INFO - Successfully installed jsonschema functools32 18:46:38 INFO - Cleaning up... 18:46:38 INFO - Return code: 0 18:46:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:46:38 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:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:38 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:46:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:38 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 0x10811f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1179a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131c290>, '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 0x131cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x131d040>, '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': '62c568580acbfdaac3eec7be000001dc-1491356757.669321-477141698', '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:46:38 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:46:38 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:46:38 INFO - Using env: {'DISPLAY': ':0', 18:46:38 INFO - 'HOME': '/home/cltbld', 18:46:38 INFO - 'LANG': 'en_US.UTF-8', 18:46:38 INFO - 'LANGUAGE': 'en_US:en', 18:46:38 INFO - 'LOGNAME': 'cltbld', 18:46:38 INFO - 'MAIL': '/var/mail/cltbld', 18:46:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:38 INFO - 'MOZ_NO_REMOTE': '1', 18:46:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:38 INFO - 'NO_EM_RESTART': '1', 18:46:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:38 INFO - 'PWD': '/builds/slave/test', 18:46:38 INFO - 'SHELL': '/bin/bash', 18:46:38 INFO - 'SHLVL': '1', 18:46:38 INFO - 'TERM': 'linux', 18:46:38 INFO - 'TMOUT': '86400', 18:46:38 INFO - 'USER': 'cltbld', 18:46:38 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1491356757.669321-477141698', 18:46:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:38 INFO - '_': '/tools/buildbot/bin/python'} 18:46:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:46:38 INFO - Cleaning up... 18:46:38 INFO - Return code: 0 18:46:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:46:38 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:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:38 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:46:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:38 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 0x10811f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1179a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131c290>, '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 0x131cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x131d040>, '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': '62c568580acbfdaac3eec7be000001dc-1491356757.669321-477141698', '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:46:38 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:46:38 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:46:38 INFO - Using env: {'DISPLAY': ':0', 18:46:38 INFO - 'HOME': '/home/cltbld', 18:46:38 INFO - 'LANG': 'en_US.UTF-8', 18:46:38 INFO - 'LANGUAGE': 'en_US:en', 18:46:38 INFO - 'LOGNAME': 'cltbld', 18:46:38 INFO - 'MAIL': '/var/mail/cltbld', 18:46:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:38 INFO - 'MOZ_NO_REMOTE': '1', 18:46:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:38 INFO - 'NO_EM_RESTART': '1', 18:46:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:38 INFO - 'PWD': '/builds/slave/test', 18:46:38 INFO - 'SHELL': '/bin/bash', 18:46:38 INFO - 'SHLVL': '1', 18:46:38 INFO - 'TERM': 'linux', 18:46:38 INFO - 'TMOUT': '86400', 18:46:38 INFO - 'USER': 'cltbld', 18:46:38 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1491356757.669321-477141698', 18:46:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:38 INFO - '_': '/tools/buildbot/bin/python'} 18:46:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:39 INFO - Downloading/unpacking blobuploader==1.2.4 18:46:39 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:46:39 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:46:39 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:46:39 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:46:39 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:46:39 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:46:41 INFO - Downloading blobuploader-1.2.4.tar.gz 18:46:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:46:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:46:41 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:46:41 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:46:41 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:46:41 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:46:41 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:46:41 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:46:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:46:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:46:41 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:46:41 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:46:41 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:46:41 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:46:41 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:46:41 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:46:41 INFO - Downloading docopt-0.6.1.tar.gz 18:46:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:46:41 INFO - Installing collected packages: blobuploader, requests, docopt 18:46:41 INFO - Running setup.py install for blobuploader 18:46:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:46:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:46:42 INFO - Running setup.py install for requests 18:46:42 INFO - Running setup.py install for docopt 18:46:42 INFO - Successfully installed blobuploader requests docopt 18:46:42 INFO - Cleaning up... 18:46:42 INFO - Return code: 0 18:46:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:46:42 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:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:42 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:46:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:42 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 0x10811f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1179a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131c290>, '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 0x131cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x131d040>, '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': '62c568580acbfdaac3eec7be000001dc-1491356757.669321-477141698', '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:46:42 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:46:42 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:46:42 INFO - Using env: {'DISPLAY': ':0', 18:46:42 INFO - 'HOME': '/home/cltbld', 18:46:42 INFO - 'LANG': 'en_US.UTF-8', 18:46:42 INFO - 'LANGUAGE': 'en_US:en', 18:46:42 INFO - 'LOGNAME': 'cltbld', 18:46:42 INFO - 'MAIL': '/var/mail/cltbld', 18:46:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:42 INFO - 'MOZ_NO_REMOTE': '1', 18:46:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:42 INFO - 'NO_EM_RESTART': '1', 18:46:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:42 INFO - 'PWD': '/builds/slave/test', 18:46:42 INFO - 'SHELL': '/bin/bash', 18:46:42 INFO - 'SHLVL': '1', 18:46:42 INFO - 'TERM': 'linux', 18:46:42 INFO - 'TMOUT': '86400', 18:46:42 INFO - 'USER': 'cltbld', 18:46:42 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1491356757.669321-477141698', 18:46:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:42 INFO - '_': '/tools/buildbot/bin/python'} 18:46:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:46:42 INFO - Running setup.py (path:/tmp/pip-DRssLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:46:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:46:42 INFO - Running setup.py (path:/tmp/pip-Lh9PBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:46:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:46:42 INFO - Running setup.py (path:/tmp/pip-TgjF59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:46:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:46:42 INFO - Running setup.py (path:/tmp/pip-InEnhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:46:43 INFO - Running setup.py (path:/tmp/pip-xpTd1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:46:43 INFO - Running setup.py (path:/tmp/pip-CVYRxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:46:43 INFO - Running setup.py (path:/tmp/pip-J6rTkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:46:43 INFO - Running setup.py (path:/tmp/pip-es0pkq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:46:43 INFO - Running setup.py (path:/tmp/pip-oMfoPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:46:43 INFO - Running setup.py (path:/tmp/pip-iQgoS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:46:43 INFO - Running setup.py (path:/tmp/pip-M8EH1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:46:43 INFO - Running setup.py (path:/tmp/pip-0UlkkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:46:43 INFO - Running setup.py (path:/tmp/pip-IG5FAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:46:43 INFO - Running setup.py (path:/tmp/pip-DbBGRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:46:43 INFO - Running setup.py (path:/tmp/pip-GQinMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:46:43 INFO - Running setup.py (path:/tmp/pip-Z_Hvr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:46:43 INFO - Running setup.py (path:/tmp/pip-r2UkUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:46:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:46:44 INFO - Running setup.py install for manifestparser 18:46:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:46:44 INFO - Running setup.py install for mozcrash 18:46:44 INFO - Running setup.py install for mozdebug 18:46:44 INFO - Running setup.py install for mozdevice 18:46:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:46:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:46:44 INFO - Running setup.py install for mozfile 18:46:44 INFO - Running setup.py install for mozhttpd 18:46:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:46:44 INFO - Running setup.py install for mozinfo 18:46:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:46:44 INFO - Running setup.py install for mozInstall 18:46:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:46:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:46:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:46:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:46:44 INFO - Running setup.py install for mozleak 18:46:44 INFO - Running setup.py install for mozlog 18:46:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:46:45 INFO - Running setup.py install for moznetwork 18:46:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:46:45 INFO - Running setup.py install for mozprocess 18:46:45 INFO - Running setup.py install for mozprofile 18:46:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:46:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:46:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:46:45 INFO - Running setup.py install for mozrunner 18:46:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:46:45 INFO - Running setup.py install for mozscreenshot 18:46:45 INFO - Running setup.py install for moztest 18:46:45 INFO - Running setup.py install for mozversion 18:46:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:46:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:46:45 INFO - Cleaning up... 18:46:45 INFO - Return code: 0 18:46:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:46: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:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46: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:46:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:45 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 0x10811f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1179a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131c290>, '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 0x131cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x131d040>, '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': '62c568580acbfdaac3eec7be000001dc-1491356757.669321-477141698', '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:46:45 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:46:45 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:46:45 INFO - Using env: {'DISPLAY': ':0', 18:46:45 INFO - 'HOME': '/home/cltbld', 18:46:45 INFO - 'LANG': 'en_US.UTF-8', 18:46:45 INFO - 'LANGUAGE': 'en_US:en', 18:46:45 INFO - 'LOGNAME': 'cltbld', 18:46:45 INFO - 'MAIL': '/var/mail/cltbld', 18:46:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:45 INFO - 'MOZ_NO_REMOTE': '1', 18:46:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:45 INFO - 'NO_EM_RESTART': '1', 18:46:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:45 INFO - 'PWD': '/builds/slave/test', 18:46:45 INFO - 'SHELL': '/bin/bash', 18:46:45 INFO - 'SHLVL': '1', 18:46:45 INFO - 'TERM': 'linux', 18:46:45 INFO - 'TMOUT': '86400', 18:46:45 INFO - 'USER': 'cltbld', 18:46:45 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1491356757.669321-477141698', 18:46:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:45 INFO - '_': '/tools/buildbot/bin/python'} 18:46:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:46:46 INFO - Running setup.py (path:/tmp/pip-jwmqAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:46:46 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:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:46:46 INFO - Running setup.py (path:/tmp/pip-f5a3RU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:46:46 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:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:46:46 INFO - Running setup.py (path:/tmp/pip-bhrcL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:46:46 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:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:46:46 INFO - Running setup.py (path:/tmp/pip-pUvtpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:46:46 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:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:46:46 INFO - Running setup.py (path:/tmp/pip-onmz2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:46:46 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:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:46:46 INFO - Running setup.py (path:/tmp/pip-Y0BuEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:46:46 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:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:46:46 INFO - Running setup.py (path:/tmp/pip-DzBKbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:46:46 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:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:46:46 INFO - Running setup.py (path:/tmp/pip-3ZQuOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:46:46 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:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:46:46 INFO - Running setup.py (path:/tmp/pip-Wb_pyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:46:46 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:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:46:46 INFO - Running setup.py (path:/tmp/pip-X4YFip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:46:46 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:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:46:46 INFO - Running setup.py (path:/tmp/pip-ZXhIPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:46:46 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:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:46:46 INFO - Running setup.py (path:/tmp/pip-b8Uurc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:46:46 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:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:46:46 INFO - Running setup.py (path:/tmp/pip-MtN92Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:46:46 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:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:46:46 INFO - Running setup.py (path:/tmp/pip-xzQAa9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:46:47 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:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:46:47 INFO - Running setup.py (path:/tmp/pip-KollRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:46:47 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:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:46:47 INFO - Running setup.py (path:/tmp/pip-znswvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:46:47 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:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:46:47 INFO - Running setup.py (path:/tmp/pip-GwHcm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:46:47 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:46:47 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:46:47 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:46:47 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:46:47 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:46:47 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:46:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:46:47 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:46:47 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:46:47 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:46:47 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:46:47 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:46:47 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:46:49 INFO - Downloading blessings-1.6.tar.gz 18:46:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:46:49 INFO - Installing collected packages: blessings 18:46:49 INFO - Running setup.py install for blessings 18:46:49 INFO - Successfully installed blessings 18:46:49 INFO - Cleaning up... 18:46:49 INFO - Return code: 0 18:46:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:46:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:46:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:46:49 INFO - Reading from file tmpfile_stdout 18:46:49 INFO - Current package versions: 18:46:49 INFO - argparse == 1.2.1 18:46:49 INFO - blessings == 1.6 18:46:49 INFO - blobuploader == 1.2.4 18:46:49 INFO - docopt == 0.6.1 18:46:49 INFO - functools32 == 3.2.3-2 18:46:49 INFO - jsonschema == 2.5.1 18:46:49 INFO - manifestparser == 1.1 18:46:49 INFO - mozInstall == 1.12 18:46:49 INFO - mozcrash == 1.0 18:46:49 INFO - mozdebug == 0.1 18:46:49 INFO - mozdevice == 0.49 18:46:49 INFO - mozfile == 1.2 18:46:49 INFO - mozhttpd == 0.7 18:46:49 INFO - mozinfo == 0.9 18:46:49 INFO - mozleak == 0.1 18:46:49 INFO - mozlog == 3.4 18:46:49 INFO - moznetwork == 0.27 18:46:49 INFO - mozprocess == 0.25 18:46:49 INFO - mozprofile == 0.28 18:46:49 INFO - mozrunner == 6.13 18:46:49 INFO - mozscreenshot == 0.1 18:46:49 INFO - mozsystemmonitor == 0.3 18:46:49 INFO - moztest == 0.8 18:46:49 INFO - mozversion == 1.4 18:46:49 INFO - psutil == 3.1.1 18:46:49 INFO - requests == 1.2.3 18:46:49 INFO - wsgiref == 0.1.2 18:46:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:46:49 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:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:49 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:46:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:49 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 0x10811f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1179a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131c290>, '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 0x131cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x131d040>, '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': '62c568580acbfdaac3eec7be000001dc-1491356757.669321-477141698', '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:46:49 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:46:49 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:46:49 INFO - Using env: {'DISPLAY': ':0', 18:46:49 INFO - 'HOME': '/home/cltbld', 18:46:49 INFO - 'LANG': 'en_US.UTF-8', 18:46:49 INFO - 'LANGUAGE': 'en_US:en', 18:46:49 INFO - 'LOGNAME': 'cltbld', 18:46:49 INFO - 'MAIL': '/var/mail/cltbld', 18:46:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:49 INFO - 'MOZ_NO_REMOTE': '1', 18:46:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:49 INFO - 'NO_EM_RESTART': '1', 18:46:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:49 INFO - 'PWD': '/builds/slave/test', 18:46:49 INFO - 'SHELL': '/bin/bash', 18:46:49 INFO - 'SHLVL': '1', 18:46:49 INFO - 'TERM': 'linux', 18:46:49 INFO - 'TMOUT': '86400', 18:46:49 INFO - 'USER': 'cltbld', 18:46:49 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1491356757.669321-477141698', 18:46:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:49 INFO - '_': '/tools/buildbot/bin/python'} 18:46:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:49 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:46:49 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:46:49 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:46:49 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:46:49 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:46:49 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:46:49 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:46:49 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:46:49 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:46:49 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:46:49 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:46:49 INFO - Cleaning up... 18:46:49 INFO - Return code: 0 18:46:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:46:49 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:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:49 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:46:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:50 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 0x10811f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1179a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131c290>, '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 0x131cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x131d040>, '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': '62c568580acbfdaac3eec7be000001dc-1491356757.669321-477141698', '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:46:50 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:46:50 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:46:50 INFO - Using env: {'DISPLAY': ':0', 18:46:50 INFO - 'HOME': '/home/cltbld', 18:46:50 INFO - 'LANG': 'en_US.UTF-8', 18:46:50 INFO - 'LANGUAGE': 'en_US:en', 18:46:50 INFO - 'LOGNAME': 'cltbld', 18:46:50 INFO - 'MAIL': '/var/mail/cltbld', 18:46:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:50 INFO - 'MOZ_NO_REMOTE': '1', 18:46:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:50 INFO - 'NO_EM_RESTART': '1', 18:46:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:50 INFO - 'PWD': '/builds/slave/test', 18:46:50 INFO - 'SHELL': '/bin/bash', 18:46:50 INFO - 'SHLVL': '1', 18:46:50 INFO - 'TERM': 'linux', 18:46:50 INFO - 'TMOUT': '86400', 18:46:50 INFO - 'USER': 'cltbld', 18:46:50 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1491356757.669321-477141698', 18:46:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:50 INFO - '_': '/tools/buildbot/bin/python'} 18:46:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:46:50 INFO - Cleaning up... 18:46:50 INFO - Return code: 0 18:46:50 INFO - Running post-action listener: _resource_record_post_action 18:46:50 INFO - Running post-action listener: _start_resource_monitoring 18:46:50 INFO - Starting resource monitoring. 18:46:50 INFO - [mozharness: 2017-04-05 01:46:50.248591Z] Finished create-virtualenv step (success) 18:46:50 INFO - [mozharness: 2017-04-05 01:46:50.249059Z] Running install step. 18:46:50 INFO - Running pre-action listener: _resource_record_pre_action 18:46:50 INFO - Running main action method: install 18:46:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:46:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:46:50 INFO - Reading from file tmpfile_stdout 18:46:50 INFO - Detecting whether we're running mozinstall >=1.0... 18:46:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:46:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:46:50 INFO - Reading from file tmpfile_stdout 18:46:50 INFO - Output received: 18:46:50 INFO - Usage: mozinstall [options] installer 18:46:50 INFO - Options: 18:46:50 INFO - -h, --help show this help message and exit 18:46:50 INFO - -d DEST, --destination=DEST 18:46:50 INFO - Directory to install application into. [default: 18:46:50 INFO - "/builds/slave/test"] 18:46:50 INFO - --app=APP Application being installed. [default: firefox] 18:46:50 INFO - mkdir: /builds/slave/test/build/application 18:46:50 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:46:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:47:07 INFO - Reading from file tmpfile_stdout 18:47:07 INFO - Output received: 18:47:07 INFO - /builds/slave/test/build/application/firefox/firefox 18:47:07 INFO - Running post-action listener: _resource_record_post_action 18:47:07 INFO - [mozharness: 2017-04-05 01:47:07.149693Z] Finished install step (success) 18:47:07 INFO - [mozharness: 2017-04-05 01:47:07.149969Z] Running run-tests step. 18:47:07 INFO - Running pre-action listener: _resource_record_pre_action 18:47:07 INFO - Running main action method: run_tests 18:47:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:47:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:47:07 INFO - Python 2.7.3 18:47:07 INFO - Return code: 0 18:47:07 INFO - grabbing minidump binary from tooltool 18:47:07 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:47:07 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 0x131c290>, '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 0x131cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x131d040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:47:07 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:47:07 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:47:07 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:47:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:47:07 INFO - Return code: 0 18:47:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:47:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:47:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:47:07 INFO - ENV: RUST_BACKTRACE is now 1 18:47:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:47:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:47:07 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-e10s', '--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-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:47:07 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-e10s --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-018 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:47:07 INFO - Using env: {'DISPLAY': ':0', 18:47:07 INFO - 'HOME': '/home/cltbld', 18:47:07 INFO - 'LANG': 'en_US.UTF-8', 18:47:07 INFO - 'LANGUAGE': 'en_US:en', 18:47:07 INFO - 'LOGNAME': 'cltbld', 18:47:07 INFO - 'MAIL': '/var/mail/cltbld', 18:47:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:47:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:47:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:07 INFO - 'MOZ_NO_REMOTE': '1', 18:47:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:47:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:07 INFO - 'NO_EM_RESTART': '1', 18:47:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:47:07 INFO - 'PWD': '/builds/slave/test', 18:47:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:47:07 INFO - 'RUST_BACKTRACE': '1', 18:47:07 INFO - 'SHELL': '/bin/bash', 18:47:07 INFO - 'SHLVL': '1', 18:47:07 INFO - 'TERM': 'linux', 18:47:07 INFO - 'TMOUT': '86400', 18:47:07 INFO - 'USER': 'cltbld', 18:47:07 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1491356757.669321-477141698', 18:47:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:07 INFO - '_': '/tools/buildbot/bin/python'} 18:47:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--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-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:47:07 INFO - mozversion application_buildid: 20170405004534 18:47:07 INFO - mozversion application_changeset: 896e9cfb9d67d6a73e70e39532f31306c22202cb 18:47:07 INFO - mozversion application_display_name: FirefoxDeveloperEdition 18:47:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:47:07 INFO - mozversion application_name: Firefox 18:47:07 INFO - mozversion application_remotingname: firefox-dev 18:47:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:47:07 INFO - mozversion application_vendor: Mozilla 18:47:07 INFO - mozversion application_version: 54.0a2 18:47:07 INFO - mozversion platform_buildid: 20170405004534 18:47:07 INFO - mozversion platform_changeset: 896e9cfb9d67d6a73e70e39532f31306c22202cb 18:47:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:47:07 INFO - mozversion platform_version: 54.0a2 18:47:07 INFO - using testdate: 1491356827 18:47:07 INFO - actual date: 1491356827 18:47:07 INFO - starting webserver on 'localhost:56023' 18:47:07 INFO - SUITE-START | Running 2 tests 18:47:07 INFO - TEST-START | dromaeo_css 18:47:07 INFO - operating with platform_type : linux_ 18:47:07 INFO - Initialising browser for dromaeo_css test... 18:47:07 INFO - TEST-INFO | started process 28026 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9VcB2X/profile http://localhost:56023/getInfo.html) 18:47:11 INFO - PROCESS | 28026 | __metrics Screen width/height:1600/1200 18:47:11 INFO - PROCESS | 28026 | colorDepth:24 18:47:11 INFO - PROCESS | 28026 | Browser inner width/height: 1024/697 18:47:11 INFO - PROCESS | 28026 | __metrics 18:47:12 ERROR - PROCESS | 28026 | 1491356832561 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 < permitUnload@remote-browser.xml:357:13 < CanCloseWindow@browser.js:6373:36 < canClose@browser.js:5234:12 < forceQuit@jar:file:///tmp/tmp9VcB2X/profile/extensions/talos-powers@TalosPowersService.js:237:7 < whenDone@jar:file:///tmp/tmp9VcB2X/profile/extensions/talos-powers@TalosPowersService.js:222:9 < promise callback*forceQuit@jar:file:///tmp/tmp9VcB2X/profile/extensions/talos-powers@TalosPowersService.js:224:7 < receiveMessage@jar:file:///tmp/tmp9VcB2X/profile/extensions/talos-powers@TalosPowersService.js:55:9 18:47:12 ERROR - PROCESS | 28026 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3360: TypeError: this.tabs is undefined 18:47:13 INFO - TEST-INFO | 28026: exit 0 18:47:13 INFO - Browser initialized. 18:47:13 INFO - Running cycle 1/1 for dromaeo_css test... 18:47:13 INFO - TEST-INFO | started process 28158 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9VcB2X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:47:25 INFO - PROCESS | 28158 | RSS: Main: 146817024 18:47:25 INFO - PROCESS | 28158 | 18:50:25 INFO - PROCESS | 28158 | Cycle 1(1): loaded http://localhost:56023/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56023/tests/dromaeo/cssquery-ext.html) 18:50:26 INFO - PROCESS | 28158 | RSS: Main: 154976256 18:50:26 INFO - PROCESS | 28158 | 18:52:13 INFO - PROCESS | 28158 | ************************* 18:52:13 INFO - PROCESS | 28158 | A coding exception was thrown and uncaught in a Task. 18:52:13 INFO - PROCESS | 28158 | 18:52:13 ERROR - PROCESS | 28158 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:52:13 INFO - PROCESS | 28158 | Full stack: 18:52:13 INFO - PROCESS | 28158 | ************************* 18:52:13 INFO - PROCESS | 28158 | ************************* 18:52:13 INFO - PROCESS | 28158 | A coding exception was thrown and uncaught in a Task. 18:52:13 INFO - PROCESS | 28158 | 18:52:13 ERROR - PROCESS | 28158 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:52:13 INFO - PROCESS | 28158 | Full stack: 18:52:13 INFO - PROCESS | 28158 | ************************* 18:52:13 INFO - PROCESS | 28158 | ************************* 18:52:13 INFO - PROCESS | 28158 | A coding exception was thrown and uncaught in a Task. 18:52:13 INFO - PROCESS | 28158 | 18:52:13 ERROR - PROCESS | 28158 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:52:13 INFO - PROCESS | 28158 | Full stack: 18:52:13 INFO - PROCESS | 28158 | ************************* 18:52:13 INFO - PROCESS | 28158 | ************************* 18:52:13 INFO - PROCESS | 28158 | A coding exception was thrown and uncaught in a Task. 18:52:13 INFO - PROCESS | 28158 | 18:52:13 ERROR - PROCESS | 28158 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:52:13 INFO - PROCESS | 28158 | Full stack: 18:52:13 INFO - PROCESS | 28158 | ************************* 18:53:28 INFO - PROCESS | 28158 | Cycle 1(1): loaded http://localhost:56023/tests/dromaeo/cssquery-ext.html (next: http://localhost:56023/tests/dromaeo/cssquery-jquery.html) 18:53:29 INFO - PROCESS | 28158 | RSS: Main: 152256512 18:53:29 INFO - PROCESS | 28158 | 18:56:31 INFO - PROCESS | 28158 | Cycle 1(1): loaded http://localhost:56023/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56023/tests/dromaeo/cssquery-mootools.html) 18:56:31 INFO - PROCESS | 28158 | RSS: Main: 155058176 18:56:31 INFO - PROCESS | 28158 | 18:59:33 INFO - PROCESS | 28158 | Cycle 1(1): loaded http://localhost:56023/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56023/tests/dromaeo/cssquery-prototype.html) 18:59:34 INFO - PROCESS | 28158 | RSS: Main: 153485312 18:59:34 INFO - PROCESS | 28158 | 19:02:36 INFO - PROCESS | 28158 | Cycle 1(1): loaded http://localhost:56023/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56023/tests/dromaeo/cssquery-yui.html) 19:02:37 INFO - PROCESS | 28158 | RSS: Main: 158613504 19:02:37 INFO - PROCESS | 28158 | 19:05:39 INFO - PROCESS | 28158 | Cycle 1(1): loaded http://localhost:56023/tests/dromaeo/cssquery-yui.html (next: http://localhost:56023/tests/dromaeo/cssquery-dojo.html) 19:05:39 INFO - PROCESS | 28158 | RSS: Main: 157470720 19:05:39 INFO - PROCESS | 28158 | 19:05:39 INFO - PROCESS | 28158 | __start_tp_report 19:05:39 INFO - PROCESS | 28158 | _x_x_mozilla_page_load 19:05:39 INFO - PROCESS | 28158 | _x_x_mozilla_page_load_details 19:05:39 INFO - PROCESS | 28158 | |i|pagename|runs| 19:05:39 INFO - PROCESS | 28158 | |0;dojo.html;3483.285926385091;3501;3519.313733821904;3519.560054993125;3532.4524698671685;5891.734871930763;5924.466797988181;5967.4927631151295;5991.071383935491;5992.9400705992875;5818.2145410369585;5887.558433117522;5948.405159484049;5956.851078723034;5973.910391344122;5279.9208011879755;5325.840224793243;5331.946680533203;5346.866328341784;5362.115250983583;5365.597580181502;5387.380451248117;5390.946090539103;5392.40683524812;5397.163439666858;5161.406438259611;5194.480551944813;5380.623356365056;5381.165919282517;5410.431904650014;5304.20436934459;5314.0700377433795;5330.600204984642;5352.759125839347;5373.167159090347;5259.15853463444;5352.304200453955;5356.785728570852;5365.678059316453;5395.10980688186;5714.485696287313;5935.436133567304;5955.821325360246;6009.1587177795145;6021.7892373767145;6216.471599914013;6234.719437625317;6244.250689917239;6366.745330186787;6385.48916086712;6328.177336946167;6364.968175159141;6399.360063993563;6412.038194270896;6420.101185833987;5897.203877476529;5912.290525137011;5922.940770592239;5942.465178133945;5955.970220148872;6163.506919446433;6194.9690251549355;6359.236891573041;6364.745410183634;6370.426661600478;6208.4722798561725;6267.717952692049;6270.874582508324;6279.529035322369;6282.2147231596055;6342.904856427157;6352.396522330371;6364.236291645032;6365.713542890581;6374.681265936684;6132.478739307209;6156.322804491502;6188.783392581238;6190.2571691397325;6293.685315734195;6333.714982825784;6340.017297318923;6343.429091381798;6347.143135676717;6349.714262858182;4564.748938808331;4596.908061838812;4619.491855895849;4644.883877903079;4718.575328220477;4260.68044896634;4281.314989601648;4309.202797482476;4329.956700433018;4337.783110844445;6021.397860213943;6051.031834906394;6122.602030867979;6229.719662615194;6251.093591429218;6366.649834259068;6394.552381333355;6395.104685344056;6401.231852177675;6444.935550644527;6254.655993920287;6258.874822503524;6260.092286618415;6265.060240963892;6273.560850740496;5242.266082748418;5256.316678831728;5418.187271909166;5420.34955805298;5463.644863083887;6599.934000659932;6669.733210671616;6748.763793267212;6770.32296770319;6778.423833974168;6408.070829729756;6414.518911081781;6442.387973142544;6445.967770161119;6449.871002580016;6392.296847346695;6621.1392518972225;6731.427828634425;6734.326567343226;6745.426638735762;6180.227471566054;6195.194624698941;6196.535259855439;6257.311695713559;6341.746330146927;6390.105385245976;6418.358164183544;6420.293767685457;6426;6437.324080971618;6166.845828854314;6220.284667263322;6224.906626400517;6225.844353891189;6244.344343843831;5955.76176952917;5962.97018514922;6086.178365920544;6102.694865256808;6137.315698286874;6157.32269450369;6206.131141640084;6209.192804935329;6220.409061139185;6227.408396202353;6011.338752737282;6201.0388389799655;6272.184616000073;6279.152314437492;6279.686015699288;5916.822495325147;6082.482988945989;6100.908486372797;6119.418655227746;6122.112293717475 19:05:39 INFO - PROCESS | 28158 | |1;ext.html;774.3534148985597;835.1314632781907;856.09254190558;892.143542199488;892.9776755581106;42233.366499502496;43457;46442.76778616102;46470.53529464709;46497.30254046184;42842;42880.785596071975;42885.57114428855;43025.7848710756;43298.78350608243;8878.866816997734;8958.641654333818;10121.898781012205;10411.427371494565;10594.629187978422;9934.552945117486;10017.499125043754;10029.949850250738;10031.74920626983;10033.548490317917;9965.352252103627;10149.391036537794;10150.238732095086;10154.882962874079;10161.593536258577;9940.155086817593;10030.548625311878;10051.195904327673;10053.49732513375;10072.043155900177;9729.075737804897;9810.411375317432;9818.705438836847;9823.459709715962;9867.16129129025;34727.82636086829;34795;34918.476222856676;34998.650013500046;35020.29959400823;3981.391646142735;4014.116894283253;4060.2488539620263;4101.487314085739;4114.465119534471;26611;26660.46679066408;26846.328841778915;27013;27372.863135684194;3091.180837078176;3095.6105094343375;3176.539401786728;3209.358128374311;3209.518572214163;238500;327442;331784.9999999976;333311;335828;43842;43901.56098438975;44084.11831763347;44110.55889441129;44129.55870441254;44653;44733.77633111813;44827.775861120484;44917.55082449199;44942.775286124015;14057.648558785908;14206.21865797391;14237.216953067473;14263.85736142646;14476.565703028926;12406.81389779154;12504.124711270124;12507;12520.373981300898;12554.183978041397;11664.475098620413;11676.532938682527;11721.824172637418;11734.237274577124;11768.823467647991;5111.131107711698;5257.947420525822;5289.418164001957;5322.3879253885525;5323.52088312046;1235.4193529041336;1267.3409826889965;1285.6271681212531;1286.4403984266874;1312.2389014371643;27397.45205095887;27575.862120689268;27608.585871211948;27703.168904932885;27854;1382.143071295803;1387.6600232942994;1393.4913756478811;1407.6129064507343;1418.5957002254308;14305.713885722436;14517.637059073397;14520.564383068524;14640.633984150269;14730.55808325752;334042;334269;335148;335245;336609;55286.72356638191;55363.72318138464;55794.163087553716;55798.442015580134;56049.7197514018;1473.734727748994;1499.4901733410693;1507.721071601757;1509.7886295918581;1539.9605266445105;27369.566519577405;27395.45209095767;27443;28155.155345339674;28155.71844281531;36818;36824.44763328499;36861;37139.81430092832;37188.07029824276;279629;279869;280888;281709;283208;29767.70232297736;29973.850130749208;30016.399672006002;30290;30444.391112178077;37387.43918841165;38016.23967520579;38496.422553661156;38721.4191787129;38859.805700971316;29030.41939161247;29109.532628173853;29176.854115729286;29342.55986160252;29601;29061;29081;29225;29472.11583652494;29530.557041643962;33524.49713254352;33605;34043.489347659306;35349.29301413906;35918.8204058978;29684.257893552833;29887.55168672515;30055.849720751256;30079.398412032075;30742.38515229638;25092.247232582322;25178.118765843108;25394.365140870887;25511.74488255094;25934.092306769926 19:05:39 INFO - PROCESS | 28158 | |2;jquery.html;452.27184233384264;452.92753159494487;463.46932761987523;473.7796924430139;479.95200479952;20116.798832011675;20500.692489612647;21316;21543.353699389005;21732.13071477143;21195.682064769004;21219.57560848782;21308;21409.892950535224;22277.888610556925;6814;6868.210155832068;6868.244493105779;7091.85816283674;7098.609576473292;6853.6230507322325;6931.16825980883;6958.025876377311;6968.895466568006;6974.546654467469;6736.225334086569;6895.069165662647;6944.4097251733665;6948.444124470056;6970.233274339818;6654.13496245485;6663.50023748216;6949.235584085746;6994.930050699479;7015.263397343282;6512.544121911468;6540.803775886731;6542;6547.639879806608;6564.212294524687;24995.37511562207;25157.62263566048;25377.873110634515;25393.49213015748;25547.23358299254;3142.5600415941785;3170.79389839662;3181.284211052495;3181.316017056321;3209.1816586770456;15993.360265589363;16033.599160021093;16397.508074757778;16780.2448889799;17044.40344587946;2216.1135545781653;2264.615015447378;2295.9655605165935;2316.872572008539;2357.2456813819585;109948.4502577482;110499;110931.44534277357;111384.4430777849;111918;17719.645607088045;18693.532661683294;19425.90287048584;19691.901540492494;20036.89981550112;31746;31839.84080079631;32007.039788806374;32039.51940720891;32200.19499512531;10165.13596344319;10251.282410231212;10482.47587620616;10504.63233786829;10737.785244295226;8625;8665.2634526066;8770.956145219234;8952.194302512806;9009.954950225338;9127.90872091284;9431.952840235756;9487.430754154635;9624.181944534794;9725.519992402034;3511.7324013979032;3882.6893848492055;3931.941020884689;3991.3015222335976;4094.9115950865275;961.990380096204;970.7427531704104;976.1334380374003;977.3012296208245;984.9359791613522;21015.159393624082;21076.683849742265;21172.364829055154;21193.470163246042;21201.681974770392;963.9951800240954;973.0415540692412;976.5263847034183;978.2663002747939;991.8908920018793;10815;11755.412229388667;12076.335801530824;12083.21459105173;12083.818742718691;651664;660309;660685;678362;699625;97819;100512.99487005183;112944.43527782308;116149.4192529032;118391;1175.61204802415;1181.3620644851856;1213.9210951288137;1222.113967373647;1230.2618428942562;18081.005544695166;18321;18528.444146675083;18564.566543835033;18573.628527429104;51120.23319650283;51141.48858511367;52048.219276711636;52264;52488.7375563135;67302.3269767296;67767.98348024882;69294.65352673407;69605.65197174184;70254.64872675604;11262.155338349492;11575.189736718687;11760.70598235051;12058.095642826998;12138.939305303416;13344;13355.79966300487;13716.0398772085;13984.930075349965;14383.496577619733;6543.0185472179555;10675.466226688479;11061.723456913642;11894.226875253082;12085.75828483443;10423.374597524173;10454.477276136315;10656.946715266375;10859.185561082792;11042;11123.777524449628;11647.534098635959;11916;12328.938355308166;12564.434600442819;10933.890661093288;11221.71945701364;11246.606368777053;11290.717732056764;11438.885611143782;10961.45192740344;11187;11769.705757356134;12301.32342721159;12638.557650482557 19:05:39 INFO - PROCESS | 28158 | |3;mootools.html;1517.969640607187;1549.0395954508206;1551.488008957044;1557.0424189123685;1569.3095038183199;10488.265821392506;11102;11192.272502287346;11207.83188252176;11473.770524589503;11776.175667703243;11814.881851181486;11910.523579056828;11915.821262681067;11929.701757456069;2465.4329504214043;2512.196097248881;2512.5351809915132;2519.760622740846;2520.332111990324;2436.2691192642224;2466.642336861154;2496.3010357100043;2499.687539057618;2506.3984643685476;2367.9763202368013;2391.701037370329;2396.269137912936;2482.981977389271;2486.76375744304;2283.6346184610384;2308.3421224950976;2319.083961835074;2362.681038059866;2366.183666635008;2217.0466699319286;2227.5210829671537;2229.9777002230094;2233.8659680419228;2242.260054182116;11572.59495917639;11766.705832354173;11854.703632409173;11873.821892671616;11876.228045177037;5676.290463692038;5815.912761308584;5842.065269556893;5850.034744267191;5863.149843272744;3371.595408550965;3409.6590340965954;3421.6920477157178;3428.3486137633768;3497.1956450016382;1158.2645020412015;1176.1061593189238;1210.3645586067298;1308.5485507499898;1324.6754545136407;14920.104793712411;15152.393904243818;16752.162391880356;16771.329146834112;16977.06626135562;4463.375127482155;4609.838655647103;4700.271457924027;4775.116603428377;4779.856604301876;12668.239905605693;12673.93663031679;12683.11218214716;12693.555725549562;12721.745565088831;5686.43135686428;5690.573207009491;5692.1461780733225;5699.2590963174525;5706.857328566819;5262.210668399694;5263.131583288715;5293.973530132324;5327.413984461706;5359.14253719403;3985.7608543487486;4090.4477895484324;4096.446979657708;4170.47869016373;4187.183499217624;1055.8205105132147;1059.0627294844119;1063.6277302944063;1066.221658189526;1074.1567869222622;979.6424305128577;980.3725615606018;991.4299277915228;992.6525715999343;1003.7942221844504;6357.618542887441;6396.616203027833;6427.453666438405;6450.709718062699;6559.508036897252;1026.7381817636456;1040.8542804007445;1052.3685788526823;1071.0414179309475;1075.9784804304027;4340.392345071693;4417.337399390117;4419.580139886705;4420.513743488214;4453.265211240109;14542.345594448063;15082.698346033018;15104.924475377773;15122.54632361009;15168.08991460516;13182.934085329704;13841.515546955809;14992.550223493312;14992.925035374972;15003.624909377353;8815.074417186102;10616.309939853885;10836.945815270874;10878.728031799268;10924.726881827859;6406.743730250924;7275.563466191834;7369.705211791683;7490.925090749023;7501.249875012455;12558.372081396077;12714.68213294638;12814.743705125658;13050.673733156747;13325.933370333087;13381.464741410624;13428.0600357974;13559.72880542364;13605.931970340085;13732.45070197221;9420.811583768149;9671.70984870455;9676.806463870824;9703.708888733348;9736.853947190939;10173.44046077473;10284.382937023802;10384.688459346231;10400.479976001321;10490.475476226311;9340.392874463138;9363.4381937084;9380.859287110836;9542;9606.51967401641;8824.117588241124;8905.198532132139;9073.13805188506;9115.817683646423;9254.814903702023;8462.703805366782;8540.74377768668;8660.39377243587;8677.826443471222;8679.913200868163;6134.294556126102;6216.906746398718;6225.439710426083;6237.251529816451;6274.874502510015;6062.636241825505;6110.663913484801;6136.570440069152;6143.1706719592285;6243.594166379171 19:05:39 INFO - PROCESS | 28158 | |4;prototype.html;419.3793186084593;429.2509570798956;443.99112017759643;448.2312833490563;457.71621594611344;5221.999999999991;5325.520703136717;5397.91903121453;5450.591205659572;5476.58925580581;5181.481851814826;5258.36899572051;5357.169638705997;5381.408045115034;5393.81121660742;4607.884802879921;4626.583607475327;4629.675922685414;4631.564215093332;4642;4268.59448352406;4484.66365022623;4543.545645435446;4605.9769701151445;4638.652101092432;4463.486699029604;4479.820807167709;4483.932741008887;4489.371487991668;4533.591976722094;4486.282194848808;4520.932186017212;4533.6146427553695;4541.886452838672;4560;4188.633422116494;4189.916201675949;4226.978865105685;4296.312589985619;4334.609885110355;5267.631265811395;5269.235960785664;5277.683338999673;5281.947180528184;5301.443348448396;5289.206619007141;5329.173978033411;5330.334832583708;5334.439883812182;5353.625246232766;5406.54044406226;5744.770209191627;5745.856353591152;5764.682942438164;5768.163616275617;4731.69243999139;4750.334953106568;4765.880852978668;4770.260609605517;4773.424769825984;5960.254968128984;5960.761569537257;5966;5972.552058595623;5975.462208401264;4835.516448355207;4918.90162196754;4928.0677996592685;4929.954069061299;4944.60443164546;4989.151844186497;5002.174641184237;5049.2173713074535;5061.886384995295;5080.441151473335;5217.632546295817;5277.630565860353;5310.371366173768;5343.919841202385;5356.812511562077;5612.550995920316;5668.404817494186;5714.942850571441;5734.451698041589;5750.223719797774;1668.8414600612923;1708.5557754983793;1714.1771949464328;1726.3612463388627;1735.9913200433916;1246.9501219951283;1317.512520367451;1334.3661760663608;1336.1582203212108;1339.1964821107258;5644.491995720405;5664.291963504562;5665.943340566541;5667.234923285386;5694.373618901917;5889.352171261158;5903.136978565392;5926.754821982577;5970.76116955317;5999.020323293303;5296.894062118813;5585.3297604287745;5643.717814109278;5652.576056795757;5686.772529098873;3091.922701932425;3134.73354764843;3134.7962382445066;3150.98424507876;3160.478521044048;5942.851428714231;6184.5052395808225;6190.093654729849;6198.721057552421;6239.625622462667;5946.583739138306;5967.015442451947;5995.940040599626;6054.39456054391;6057.969710151421;6023.608465449819;6149.754009839646;6173.900873702963;6216.689165541705;6226.875462490815;5787.94212057874;5788.855278618068;5808;5854.707264636836;5906.232189815297;5855.94144058571;5872.588918775645;5877.382874798255;5904.940950590439;5906.763729450774;5880.647161170344;6084.421979911901;6191.226096737908;6217.689115544295;6226.5641405101205;4888.606747077066;4931.827386041471;4941.703497790144;4946.678465899705;4947.6536642434685;5729.742161602821;5731.828045158652;5804.94195058044;5955.255593050869;6014.8195554133445;5596.216529685766;5621.269234999424;5640.407757185437;5694.924740640008;5737.426257374229;5575.6933368663495;5625.46558076982;5687.374388817144;5756.65460072397;5761.942380576141;5559.24950131727;5575;5644.379118296902;5646.915296270641;5685.403032681509;5727.39862314451;5758.452946970198;5765.56758243125;5817.243758311392;5829.504492118048;5421.783128674809;5512.862178445571;5573.136163894603;5600.551955843442;5721.8569535761935 19:05:39 INFO - PROCESS | 28158 | |5;yui.html;881.1452890696027;910.6239460370996;918.0910898210774;920.7836158502755;924.3344791749939;16518.504444866645;18103.18535665895;18170.636587268247;18263.26946922125;18330.72503912441;17226.397076102337;17638.823611763877;18435.631287374243;18446.169922353492;18496.907515462437;870.268974061788;875.2560323724847;886.6320477002037;886.76500727307;890.781758469176;884.1997991817416;893.4505279253277;899.1143723432414;899.8470260055774;899.865020246965;945.2343601682625;945.5886689290146;948.0614191949988;949.0225068179786;949.0319873728793;928.9860652090224;933.4492649336889;935.6584846530967;936.8032713130251;939.3377668743519;684.7124207832723;685.475611157465;687.0244253160524;688.2704333406605;688.3838964127078;16211.675766484605;16280.75578866318;16281;17659.11704414774;17923.283068677236;15112;15209;15278.465253716067;15294.694106117926;15960.76058859118;13185.53850615224;13427.932860335635;13544;13564.796528052088;13583.456661733519;3999.2601368746873;4023.6177563131455;4046;4073.735207211522;4091.0386059276047;87223.56388218082;87290;88738.55630721805;89934;91352.54323728406;11768.70578235551;11992.340421276913;12146.45340959659;12433.93783031079;12651.304178270284;23393;23738.762612374;23855.880720596633;24051.27846164618;24131.758682413303;8816.559172041372;8928.10718928115;8951.149640784115;8995.910040899638;9136.908630913606;4506.211413002777;4554.590086892195;4554.795034223468;4659.1147681941;4684.578387945033;3549.680528752425;3664.212194378168;3724.9570120366343;3725.6460636239512;3726.6273372662517;608.9056196289582;615.2261030231311;616.5314361085517;618.3198481670216;620.5221979076086;797.6330887791681;814.8044469327438;824.2211110500639;825.7275099217244;834.1533343656193;10771.622993195357;10934.617288394868;11267.26762760418;11408.543658253577;11536.192466527262;788.2354116506979;799.8840168175582;803.5018288661067;819.1112642782648;822.0874828939872;4777.570018698334;5064.873378165576;5077.339945807095;5090.363704536933;5103.438621751604;72597.6370118146;86545.56727216323;89323.55338223398;90065;91351;76150;76234;77536;78196;79538.20461795424;65929;67195.66402167958;68663.65668171727;68884;69343.30656693368;9574.808503830023;9697.486405971988;9753.512324383895;9796.559154837907;9926.205903527845;46848.765756171;47141.52858471371;47374.526254737015;47439.52560474351;47471.52528474671;52624.73687631537;53189;54014.72992635012;54475;55407.61480962847;12284.201526900722;12486.133735746422;12520;12599.370031498205;12669.239845609292;14634.268286585415;14915.627109322353;14992.325345359703;15211.92394038067;15837.841621584097;14173.149611023371;14287.57137285883;14297.785533216802;14427.49503767363;14740.484083057041;14281;14576.781348279572;14599.781003285172;14610.634734131732;15147.242637868283;13814.861851381358;14631.414743410145;14641.194734289717;14735.189564574051;14816.555503334917;11278.830817537908;11526.711832204262;11855.34795586251;11964.76070478603;12097.939510302393;11795.469203885674;11913.642590722293;11959.820602690792;12106.455209515769;12202.08484363694 19:05:39 INFO - PROCESS | 28158 | __end_tp_report 19:05:39 INFO - PROCESS | 28158 | __start_cc_report 19:05:39 INFO - PROCESS | 28158 | _x_x_mozilla_cycle_collect,341 19:05:39 INFO - PROCESS | 28158 | __end_cc_report 19:05:39 INFO - PROCESS | 28158 | __startTimestamp1491357939875__endTimestamp 19:05:39 INFO - PROCESS | 28158 | 19:05:39 INFO - PROCESS | 28158 | ------- Summary: start ------- 19:05:39 INFO - PROCESS | 28158 | Number of tests: 6 19:05:39 INFO - PROCESS | 28158 | 19:05:39 INFO - PROCESS | 28158 | [#0] dojo.html Cycles:165 Average:5889.10 Median:6163.51 stddev:691.26 (11.2%) stddev-sans-first:667.12 19:05:39 INFO - PROCESS | 28158 | Values: 3483.3 3501.0 3519.3 3519.6 3532.5 5891.7 5924.5 5967.5 5991.1 5992.9 5818.2 5887.6 5948.4 5956.9 5973.9 5279.9 5325.8 5331.9 5346.9 5362.1 5365.6 5387.4 5390.9 5392.4 5397.2 5161.4 5194.5 5380.6 5381.2 5410.4 5304.2 5314.1 5330.6 5352.8 5373.2 5259.2 5352.3 5356.8 5365.7 5395.1 5714.5 5935.4 5955.8 6009.2 6021.8 6216.5 6234.7 6244.3 6366.7 6385.5 6328.2 6365.0 6399.4 6412.0 6420.1 5897.2 5912.3 5922.9 5942.5 5956.0 6163.5 6195.0 6359.2 6364.7 6370.4 6208.5 6267.7 6270.9 6279.5 6282.2 6342.9 6352.4 6364.2 6365.7 6374.7 6132.5 6156.3 6188.8 6190.3 6293.7 6333.7 6340.0 6343.4 6347.1 6349.7 4564.7 4596.9 4619.5 4644.9 4718.6 4260.7 4281.3 4309.2 4330.0 4337.8 6021.4 6051.0 6122.6 6229.7 6251.1 6366.6 6394.6 6395.1 6401.2 6444.9 6254.7 6258.9 6260.1 6265.1 6273.6 5242.3 5256.3 5418.2 5420.3 5463.6 6599.9 6669.7 6748.8 6770.3 6778.4 6408.1 6414.5 6442.4 6446.0 6449.9 6392.3 6621.1 6731.4 6734.3 6745.4 6180.2 6195.2 6196.5 6257.3 6341.7 6390.1 6418.4 6420.3 6426.0 6437.3 6166.8 6220.3 6224.9 6225.8 6244.3 5955.8 5963.0 6086.2 6102.7 6137.3 6157.3 6206.1 6209.2 6220.4 6227.4 6011.3 6201.0 6272.2 6279.2 6279.7 5916.8 6082.5 6100.9 6119.4 6122.1 19:05:39 INFO - PROCESS | 28158 | 19:05:39 INFO - PROCESS | 28158 | [#1] ext.html Cycles:180 Average:45924.06 Median:30036.12 stddev:81673.16 (271.9%) stddev-sans-first:81831.92 19:05:39 INFO - PROCESS | 28158 | Values: 774.4 835.1 856.1 892.1 893.0 42233.4 43457.0 46442.8 46470.5 46497.3 42842.0 42880.8 42885.6 43025.8 43298.8 8878.9 8958.6 10121.9 10411.4 10594.6 9934.6 10017.5 10029.9 10031.7 10033.5 9965.4 10149.4 10150.2 10154.9 10161.6 9940.2 10030.5 10051.2 10053.5 10072.0 9729.1 9810.4 9818.7 9823.5 9867.2 34727.8 34795.0 34918.5 34998.7 35020.3 3981.4 4014.1 4060.2 4101.5 4114.5 26611.0 26660.5 26846.3 27013.0 27372.9 3091.2 3095.6 3176.5 3209.4 3209.5 238500.0 327442.0 331785.0 333311.0 335828.0 43842.0 43901.6 44084.1 44110.6 44129.6 44653.0 44733.8 44827.8 44917.6 44942.8 14057.6 14206.2 14237.2 14263.9 14476.6 12406.8 12504.1 12507.0 12520.4 12554.2 11664.5 11676.5 11721.8 11734.2 11768.8 5111.1 5257.9 5289.4 5322.4 5323.5 1235.4 1267.3 1285.6 1286.4 1312.2 27397.5 27575.9 27608.6 27703.2 27854.0 1382.1 1387.7 1393.5 1407.6 1418.6 14305.7 14517.6 14520.6 14640.6 14730.6 334042.0 334269.0 335148.0 335245.0 336609.0 55286.7 55363.7 55794.2 55798.4 56049.7 1473.7 1499.5 1507.7 1509.8 1540.0 27369.6 27395.5 27443.0 28155.2 28155.7 36818.0 36824.4 36861.0 37139.8 37188.1 279629.0 279869.0 280888.0 281709.0 283208.0 29767.7 29973.9 30016.4 30290.0 30444.4 37387.4 38016.2 38496.4 38721.4 38859.8 29030.4 29109.5 29176.9 29342.6 29601.0 29061.0 29081.0 29225.0 29472.1 29530.6 33524.5 33605.0 34043.5 35349.3 35918.8 29684.3 29887.6 30055.8 30079.4 30742.4 25092.2 25178.1 25394.4 25511.7 25934.1 19:05:39 INFO - PROCESS | 28158 | 19:05:39 INFO - PROCESS | 28158 | [#2] jquery.html Cycles:180 Average:37638.20 Median:2306.42 stddev:110322.20 (4783.3%) stddev-sans-first:110596.35 19:05:39 INFO - PROCESS | 28158 | Values: 452.3 452.9 463.5 473.8 480.0 20116.8 20500.7 21316.0 21543.4 21732.1 21195.7 21219.6 21308.0 21409.9 22277.9 6814.0 6868.2 6868.2 7091.9 7098.6 6853.6 6931.2 6958.0 6968.9 6974.5 6736.2 6895.1 6944.4 6948.4 6970.2 6654.1 6663.5 6949.2 6994.9 7015.3 6512.5 6540.8 6542.0 6547.6 6564.2 24995.4 25157.6 25377.9 25393.5 25547.2 3142.6 3170.8 3181.3 3181.3 3209.2 15993.4 16033.6 16397.5 16780.2 17044.4 2216.1 2264.6 2296.0 2316.9 2357.2 109948.5 110499.0 110931.4 111384.4 111918.0 17719.6 18693.5 19425.9 19691.9 20036.9 31746.0 31839.8 32007.0 32039.5 32200.2 10165.1 10251.3 10482.5 10504.6 10737.8 8625.0 8665.3 8771.0 8952.2 9010.0 9127.9 9432.0 9487.4 9624.2 9725.5 3511.7 3882.7 3931.9 3991.3 4094.9 962.0 970.7 976.1 977.3 984.9 21015.2 21076.7 21172.4 21193.5 21201.7 964.0 973.0 976.5 978.3 991.9 10815.0 11755.4 12076.3 12083.2 12083.8 651664.0 660309.0 660685.0 678362.0 699625.0 97819.0 100513.0 112944.4 116149.4 118391.0 1175.6 1181.4 1213.9 1222.1 1230.3 18081.0 18321.0 18528.4 18564.6 18573.6 51120.2 51141.5 52048.2 52264.0 52488.7 67302.3 67768.0 69294.7 69605.7 70254.6 11262.2 11575.2 11760.7 12058.1 12138.9 13344.0 13355.8 13716.0 13984.9 14383.5 6543.0 10675.5 11061.7 11894.2 12085.8 10423.4 10454.5 10656.9 10859.2 11042.0 11123.8 11647.5 11916.0 12328.9 12564.4 10933.9 11221.7 11246.6 11290.7 11438.9 10961.5 11187.0 11769.7 12301.3 12638.6 19:05:39 INFO - PROCESS | 28158 | 19:05:39 INFO - PROCESS | 28158 | [#3] mootools.html Cycles:180 Average:7060.08 Median:2474.81 stddev:4537.23 (183.3%) stddev-sans-first:4530.85 19:05:39 INFO - PROCESS | 28158 | Values: 1518.0 1549.0 1551.5 1557.0 1569.3 10488.3 11102.0 11192.3 11207.8 11473.8 11776.2 11814.9 11910.5 11915.8 11929.7 2465.4 2512.2 2512.5 2519.8 2520.3 2436.3 2466.6 2496.3 2499.7 2506.4 2368.0 2391.7 2396.3 2483.0 2486.8 2283.6 2308.3 2319.1 2362.7 2366.2 2217.0 2227.5 2230.0 2233.9 2242.3 11572.6 11766.7 11854.7 11873.8 11876.2 5676.3 5815.9 5842.1 5850.0 5863.1 3371.6 3409.7 3421.7 3428.3 3497.2 1158.3 1176.1 1210.4 1308.5 1324.7 14920.1 15152.4 16752.2 16771.3 16977.1 4463.4 4609.8 4700.3 4775.1 4779.9 12668.2 12673.9 12683.1 12693.6 12721.7 5686.4 5690.6 5692.1 5699.3 5706.9 5262.2 5263.1 5294.0 5327.4 5359.1 3985.8 4090.4 4096.4 4170.5 4187.2 1055.8 1059.1 1063.6 1066.2 1074.2 979.6 980.4 991.4 992.7 1003.8 6357.6 6396.6 6427.5 6450.7 6559.5 1026.7 1040.9 1052.4 1071.0 1076.0 4340.4 4417.3 4419.6 4420.5 4453.3 14542.3 15082.7 15104.9 15122.5 15168.1 13182.9 13841.5 14992.6 14992.9 15003.6 8815.1 10616.3 10836.9 10878.7 10924.7 6406.7 7275.6 7369.7 7490.9 7501.2 12558.4 12714.7 12814.7 13050.7 13325.9 13381.5 13428.1 13559.7 13605.9 13732.5 9420.8 9671.7 9676.8 9703.7 9736.9 10173.4 10284.4 10384.7 10400.5 10490.5 9340.4 9363.4 9380.9 9542.0 9606.5 8824.1 8905.2 9073.1 9115.8 9254.8 8462.7 8540.7 8660.4 8677.8 8679.9 6134.3 6216.9 6225.4 6237.3 6274.9 6062.6 6110.7 6136.6 6143.2 6243.6 19:05:39 INFO - PROCESS | 28158 | 19:05:39 INFO - PROCESS | 28158 | [#4] prototype.html Cycles:180 Average:5001.80 Median:5436.19 stddev:1334.21 (24.5%) stddev-sans-first:1292.86 19:05:39 INFO - PROCESS | 28158 | Values: 419.4 429.3 444.0 448.2 457.7 5222.0 5325.5 5397.9 5450.6 5476.6 5181.5 5258.4 5357.2 5381.4 5393.8 4607.9 4626.6 4629.7 4631.6 4642.0 4268.6 4484.7 4543.5 4606.0 4638.7 4463.5 4479.8 4483.9 4489.4 4533.6 4486.3 4520.9 4533.6 4541.9 4560.0 4188.6 4189.9 4227.0 4296.3 4334.6 5267.6 5269.2 5277.7 5281.9 5301.4 5289.2 5329.2 5330.3 5334.4 5353.6 5406.5 5744.8 5745.9 5764.7 5768.2 4731.7 4750.3 4765.9 4770.3 4773.4 5960.3 5960.8 5966.0 5972.6 5975.5 4835.5 4918.9 4928.1 4930.0 4944.6 4989.2 5002.2 5049.2 5061.9 5080.4 5217.6 5277.6 5310.4 5343.9 5356.8 5612.6 5668.4 5714.9 5734.5 5750.2 1668.8 1708.6 1714.2 1726.4 1736.0 1247.0 1317.5 1334.4 1336.2 1339.2 5644.5 5664.3 5665.9 5667.2 5694.4 5889.4 5903.1 5926.8 5970.8 5999.0 5296.9 5585.3 5643.7 5652.6 5686.8 3091.9 3134.7 3134.8 3151.0 3160.5 5942.9 6184.5 6190.1 6198.7 6239.6 5946.6 5967.0 5995.9 6054.4 6058.0 6023.6 6149.8 6173.9 6216.7 6226.9 5787.9 5788.9 5808.0 5854.7 5906.2 5855.9 5872.6 5877.4 5904.9 5906.8 5880.6 6084.4 6191.2 6217.7 6226.6 4888.6 4931.8 4941.7 4946.7 4947.7 5729.7 5731.8 5804.9 5955.3 6014.8 5596.2 5621.3 5640.4 5694.9 5737.4 5575.7 5625.5 5687.4 5756.7 5761.9 5559.2 5575.0 5644.4 5646.9 5685.4 5727.4 5758.5 5765.6 5817.2 5829.5 5421.8 5512.9 5573.1 5600.6 5721.9 19:05:39 INFO - PROCESS | 28158 | 19:05:39 INFO - PROCESS | 28158 | [#5] yui.html Cycles:180 Average:19137.28 Median:46995.15 stddev:24616.23 (52.4%) stddev-sans-first:24647.11 19:05:39 INFO - PROCESS | 28158 | Values: 881.1 910.6 918.1 920.8 924.3 16518.5 18103.2 18170.6 18263.3 18330.7 17226.4 17638.8 18435.6 18446.2 18496.9 870.3 875.3 886.6 886.8 890.8 884.2 893.5 899.1 899.8 899.9 945.2 945.6 948.1 949.0 949.0 929.0 933.4 935.7 936.8 939.3 684.7 685.5 687.0 688.3 688.4 16211.7 16280.8 16281.0 17659.1 17923.3 15112.0 15209.0 15278.5 15294.7 15960.8 13185.5 13427.9 13544.0 13564.8 13583.5 3999.3 4023.6 4046.0 4073.7 4091.0 87223.6 87290.0 88738.6 89934.0 91352.5 11768.7 11992.3 12146.5 12433.9 12651.3 23393.0 23738.8 23855.9 24051.3 24131.8 8816.6 8928.1 8951.1 8995.9 9136.9 4506.2 4554.6 4554.8 4659.1 4684.6 3549.7 3664.2 3725.0 3725.6 3726.6 608.9 615.2 616.5 618.3 620.5 797.6 814.8 824.2 825.7 834.2 10771.6 10934.6 11267.3 11408.5 11536.2 788.2 799.9 803.5 819.1 822.1 4777.6 5064.9 5077.3 5090.4 5103.4 72597.6 86545.6 89323.6 90065.0 91351.0 76150.0 76234.0 77536.0 78196.0 79538.2 65929.0 67195.7 68663.7 68884.0 69343.3 9574.8 9697.5 9753.5 9796.6 9926.2 46848.8 47141.5 47374.5 47439.5 47471.5 52624.7 53189.0 54014.7 54475.0 55407.6 12284.2 12486.1 12520.0 12599.4 12669.2 14634.3 14915.6 14992.3 15211.9 15837.8 14173.1 14287.6 14297.8 14427.5 14740.5 14281.0 14576.8 14599.8 14610.6 15147.2 13814.9 14631.4 14641.2 14735.2 14816.6 11278.8 11526.7 11855.3 11964.8 12097.9 11795.5 11913.6 11959.8 12106.5 12202.1 19:05:39 INFO - PROCESS | 28158 | -------- Summary: end -------- 19:05:39 INFO - PROCESS | 28158 | 19:05:40 INFO - TEST-INFO | 28158: exit 0 19:05:40 INFO - TEST-OK | dromaeo_css | took 1113341ms 19:05:40 INFO - TEST-START | kraken 19:05:40 INFO - operating with platform_type : linux_ 19:05:40 INFO - Initialising browser for kraken test... 19:05:40 INFO - TEST-INFO | started process 28535 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSwQjoS/profile http://localhost:56023/getInfo.html) 19:05:45 INFO - PROCESS | 28535 | __metrics Screen width/height:1600/1200 19:05:45 INFO - PROCESS | 28535 | colorDepth:24 19:05:45 INFO - PROCESS | 28535 | Browser inner width/height: 1024/697 19:05:45 INFO - PROCESS | 28535 | __metrics 19:05:45 ERROR - PROCESS | 28535 | 1491357945605 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 < permitUnload@remote-browser.xml:357:13 < CanCloseWindow@browser.js:6373:36 < canClose@browser.js:5234:12 < forceQuit@jar:file:///tmp/tmpSwQjoS/profile/extensions/talos-powers@TalosPowersService.js:237:7 < whenDone@jar:file:///tmp/tmpSwQjoS/profile/extensions/talos-powers@TalosPowersService.js:222:9 < promise callback*forceQuit@jar:file:///tmp/tmpSwQjoS/profile/extensions/talos-powers@TalosPowersService.js:224:7 < receiveMessage@jar:file:///tmp/tmpSwQjoS/profile/extensions/talos-powers@TalosPowersService.js:55:9 19:05:45 ERROR - PROCESS | 28535 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3360: TypeError: this.tabs is undefined 19:05:46 INFO - TEST-INFO | 28535: exit 0 19:05:46 INFO - Browser initialized. 19:05:46 INFO - Running cycle 1/1 for kraken test... 19:05:46 INFO - TEST-INFO | started process 28665 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSwQjoS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:05:58 INFO - PROCESS | 28665 | RSS: Main: 146817024 19:05:58 INFO - PROCESS | 28665 | 19:06:00 INFO - PROCESS | 28665 | Cycle 1(1): loaded http://localhost:56023/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56023/tests/kraken/driver.html?testName=audio-beat-detection) 19:06:01 INFO - PROCESS | 28665 | RSS: Main: 154193920 19:06:01 INFO - PROCESS | 28665 | 19:06:04 INFO - PROCESS | 28665 | Cycle 1(1): loaded http://localhost:56023/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56023/tests/kraken/driver.html?testName=audio-dft) 19:06:04 INFO - PROCESS | 28665 | RSS: Main: 151928832 19:06:04 INFO - PROCESS | 28665 | 19:06:07 INFO - PROCESS | 28665 | Cycle 1(1): loaded http://localhost:56023/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56023/tests/kraken/driver.html?testName=audio-fft) 19:06:08 INFO - PROCESS | 28665 | RSS: Main: 152383488 19:06:08 INFO - PROCESS | 28665 | 19:06:10 INFO - PROCESS | 28665 | Cycle 1(1): loaded http://localhost:56023/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56023/tests/kraken/driver.html?testName=audio-oscillator) 19:06:11 INFO - PROCESS | 28665 | RSS: Main: 152289280 19:06:11 INFO - PROCESS | 28665 | 19:06:13 INFO - PROCESS | 28665 | Cycle 1(1): loaded http://localhost:56023/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56023/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:06:13 INFO - PROCESS | 28665 | RSS: Main: 152297472 19:06:13 INFO - PROCESS | 28665 | 19:06:16 INFO - PROCESS | 28665 | Cycle 1(1): loaded http://localhost:56023/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56023/tests/kraken/driver.html?testName=imaging-darkroom) 19:06:17 INFO - PROCESS | 28665 | RSS: Main: 155160576 19:06:17 INFO - PROCESS | 28665 | 19:06:20 INFO - PROCESS | 28665 | Cycle 1(1): loaded http://localhost:56023/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56023/tests/kraken/driver.html?testName=imaging-desaturate) 19:06:21 INFO - PROCESS | 28665 | RSS: Main: 153460736 19:06:21 INFO - PROCESS | 28665 | 19:06:24 INFO - PROCESS | 28665 | Cycle 1(1): loaded http://localhost:56023/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56023/tests/kraken/driver.html?testName=json-parse-financial) 19:06:24 INFO - PROCESS | 28665 | RSS: Main: 154226688 19:06:24 INFO - PROCESS | 28665 | 19:06:26 INFO - PROCESS | 28665 | Cycle 1(1): loaded http://localhost:56023/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56023/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:06:27 INFO - PROCESS | 28665 | RSS: Main: 155000832 19:06:27 INFO - PROCESS | 28665 | 19:06:28 INFO - PROCESS | 28665 | Cycle 1(1): loaded http://localhost:56023/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56023/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:06:29 INFO - PROCESS | 28665 | RSS: Main: 154644480 19:06:29 INFO - PROCESS | 28665 | 19:06:31 INFO - PROCESS | 28665 | Cycle 1(1): loaded http://localhost:56023/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56023/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:06:32 INFO - PROCESS | 28665 | RSS: Main: 154726400 19:06:32 INFO - PROCESS | 28665 | 19:06:34 INFO - PROCESS | 28665 | Cycle 1(1): loaded http://localhost:56023/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56023/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:06:35 INFO - PROCESS | 28665 | RSS: Main: 155062272 19:06:35 INFO - PROCESS | 28665 | 19:06:38 INFO - PROCESS | 28665 | Cycle 1(1): loaded http://localhost:56023/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56023/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:06:38 INFO - PROCESS | 28665 | RSS: Main: 155615232 19:06:38 INFO - PROCESS | 28665 | 19:06:40 INFO - PROCESS | 28665 | Cycle 1(1): loaded http://localhost:56023/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56023/tests/kraken/driver.html?testName=ai-astar) 19:06:40 INFO - PROCESS | 28665 | RSS: Main: 157175808 19:06:40 INFO - PROCESS | 28665 | 19:06:40 INFO - PROCESS | 28665 | __start_tp_report 19:06:40 INFO - PROCESS | 28665 | _x_x_mozilla_page_load 19:06:40 INFO - PROCESS | 28665 | _x_x_mozilla_page_load_details 19:06:40 INFO - PROCESS | 28665 | |i|pagename|runs| 19:06:40 INFO - PROCESS | 28665 | |0;ai-astar;105;112;114;112;115;113;114;113;112;112 19:06:40 INFO - PROCESS | 28665 | |1;audio-beat-detection;147;117;121;154;116;117;117;117;133;116 19:06:40 INFO - PROCESS | 28665 | |2;audio-dft;162;163;164;162;162;162;162;163;161;163 19:06:40 INFO - PROCESS | 28665 | |3;audio-fft;77;76;77;106;76;75;76;76;106;75 19:06:40 INFO - PROCESS | 28665 | |4;audio-oscillator;82;81;106;82;83;82;90;83;82;99 19:06:40 INFO - PROCESS | 28665 | |5;imaging-gaussian-blur;113;115;113;115;113;113;114;115;114;113 19:06:40 INFO - PROCESS | 28665 | |6;imaging-darkroom;147;147;147;148;149;147;149;149;147;147 19:06:40 INFO - PROCESS | 28665 | |7;imaging-desaturate;95;95;95;95;94;94;95;95;94;95 19:06:40 INFO - PROCESS | 28665 | |8;json-parse-financial;58;59;60;58;59;59;59;59;59;73 19:06:40 INFO - PROCESS | 28665 | |9;json-stringify-tinderbox;53;52;53;52;52;53;53;52;53;53 19:06:40 INFO - PROCESS | 28665 | |10;stanford-crypto-aes;76;81;81;83;77;84;80;82;84;80 19:06:40 INFO - PROCESS | 28665 | |11;stanford-crypto-ccm;133;125;126;123;126;124;124;140;166;131 19:06:40 INFO - PROCESS | 28665 | |12;stanford-crypto-pbkdf2;166;158;164;162;160;158;158;161;163;162 19:06:40 INFO - PROCESS | 28665 | |13;stanford-crypto-sha256-iterative;65;62;60;61;60;73;59;59;60;59 19:06:40 INFO - PROCESS | 28665 | __end_tp_report 19:06:40 INFO - PROCESS | 28665 | __start_cc_report 19:06:40 INFO - PROCESS | 28665 | _x_x_mozilla_cycle_collect,789 19:06:40 INFO - PROCESS | 28665 | __end_cc_report 19:06:40 INFO - PROCESS | 28665 | __startTimestamp1491358000860__endTimestamp 19:06:40 INFO - PROCESS | 28665 | 19:06:40 INFO - PROCESS | 28665 | ------- Summary: start ------- 19:06:40 INFO - PROCESS | 28665 | Number of tests: 14 19:06:40 INFO - PROCESS | 28665 | 19:06:40 INFO - PROCESS | 28665 | [#0] ai-astar Cycles:10 Average:112.20 Median:113.00 stddev:2.74 (2.4%) stddev-sans-first:1.12 19:06:40 INFO - PROCESS | 28665 | Values: 105.0 112.0 114.0 112.0 115.0 113.0 114.0 113.0 112.0 112.0 19:06:40 INFO - PROCESS | 28665 | 19:06:40 INFO - PROCESS | 28665 | [#1] audio-beat-detection Cycles:10 Average:125.50 Median:119.00 stddev:14.22 (12.0%) stddev-sans-first:12.78 19:06:40 INFO - PROCESS | 28665 | Values: 147.0 117.0 121.0 154.0 116.0 117.0 117.0 117.0 133.0 116.0 19:06:40 INFO - PROCESS | 28665 | 19:06:40 INFO - PROCESS | 28665 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.50 stddev:0.84 (0.5%) stddev-sans-first:0.88 19:06:40 INFO - PROCESS | 28665 | Values: 162.0 163.0 164.0 162.0 162.0 162.0 162.0 163.0 161.0 163.0 19:06:40 INFO - PROCESS | 28665 | 19:06:40 INFO - PROCESS | 28665 | [#3] audio-fft Cycles:10 Average:82.00 Median:76.00 stddev:12.67 (16.7%) stddev-sans-first:13.31 19:06:40 INFO - PROCESS | 28665 | Values: 77.0 76.0 77.0 106.0 76.0 75.0 76.0 76.0 106.0 75.0 19:06:40 INFO - PROCESS | 28665 | 19:06:40 INFO - PROCESS | 28665 | [#4] audio-oscillator Cycles:10 Average:87.00 Median:82.50 stddev:8.71 (10.6%) stddev-sans-first:9.04 19:06:40 INFO - PROCESS | 28665 | Values: 82.0 81.0 106.0 82.0 83.0 82.0 90.0 83.0 82.0 99.0 19:06:40 INFO - PROCESS | 28665 | 19:06:40 INFO - PROCESS | 28665 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.92 (0.8%) stddev-sans-first:0.93 19:06:40 INFO - PROCESS | 28665 | Values: 113.0 115.0 113.0 115.0 113.0 113.0 114.0 115.0 114.0 113.0 19:06:40 INFO - PROCESS | 28665 | 19:06:40 INFO - PROCESS | 28665 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:147.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 19:06:40 INFO - PROCESS | 28665 | Values: 147.0 147.0 147.0 148.0 149.0 147.0 149.0 149.0 147.0 147.0 19:06:40 INFO - PROCESS | 28665 | 19:06:40 INFO - PROCESS | 28665 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 19:06:40 INFO - PROCESS | 28665 | Values: 95.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 94.0 95.0 19:06:40 INFO - PROCESS | 28665 | 19:06:40 INFO - PROCESS | 28665 | [#8] json-parse-financial Cycles:10 Average:60.30 Median:59.00 stddev:4.50 (7.6%) stddev-sans-first:4.69 19:06:40 INFO - PROCESS | 28665 | Values: 58.0 59.0 60.0 58.0 59.0 59.0 59.0 59.0 59.0 73.0 19:06:40 INFO - PROCESS | 28665 | 19:06:40 INFO - PROCESS | 28665 | [#9] json-stringify-tinderbox Cycles:10 Average:52.60 Median:53.00 stddev:0.52 (1.0%) stddev-sans-first:0.53 19:06:40 INFO - PROCESS | 28665 | Values: 53.0 52.0 53.0 52.0 52.0 53.0 53.0 52.0 53.0 53.0 19:06:40 INFO - PROCESS | 28665 | 19:06:40 INFO - PROCESS | 28665 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:81.50 stddev:2.70 (3.3%) stddev-sans-first:2.24 19:06:40 INFO - PROCESS | 28665 | Values: 76.0 81.0 81.0 83.0 77.0 84.0 80.0 82.0 84.0 80.0 19:06:40 INFO - PROCESS | 28665 | 19:06:40 INFO - PROCESS | 28665 | [#11] stanford-crypto-ccm Cycles:10 Average:131.80 Median:128.50 stddev:13.13 (10.2%) stddev-sans-first:13.92 19:06:40 INFO - PROCESS | 28665 | Values: 133.0 125.0 126.0 123.0 126.0 124.0 124.0 140.0 166.0 131.0 19:06:40 INFO - PROCESS | 28665 | 19:06:40 INFO - PROCESS | 28665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.20 Median:162.00 stddev:2.74 (1.7%) stddev-sans-first:2.29 19:06:40 INFO - PROCESS | 28665 | Values: 166.0 158.0 164.0 162.0 160.0 158.0 158.0 161.0 163.0 162.0 19:06:40 INFO - PROCESS | 28665 | 19:06:40 INFO - PROCESS | 28665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.80 Median:60.50 stddev:4.34 (7.2%) stddev-sans-first:4.45 19:06:40 INFO - PROCESS | 28665 | Values: 65.0 62.0 60.0 61.0 60.0 73.0 59.0 59.0 60.0 59.0 19:06:40 INFO - PROCESS | 28665 | -------- Summary: end -------- 19:06:40 INFO - PROCESS | 28665 | 19:06:41 INFO - TEST-INFO | 28665: exit 0 19:06:41 INFO - TEST-OK | kraken | took 61087ms 19:06:41 INFO - SUITE-END | took 1174s 19:06:42 INFO - Completed test suite (00:19:34) 19:06:42 INFO - javascript benchmark 19:06:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7833.048045943813, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3483.285926385091, 3501.0, 3519.313733821904, 3519.560054993125, 3532.4524698671685, 5891.734871930763, 5924.466797988181, 5967.4927631151295, 5991.071383935491, 5992.9400705992875, 5818.2145410369585, 5887.558433117522, 5948.405159484049, 5956.851078723034, 5973.910391344122, 5279.9208011879755, 5325.840224793243, 5331.946680533203, 5346.866328341784, 5362.115250983583, 5365.597580181502, 5387.380451248117, 5390.946090539103, 5392.40683524812, 5397.163439666858, 5161.406438259611, 5194.480551944813, 5380.623356365056, 5381.165919282517, 5410.431904650014, 5304.20436934459, 5314.0700377433795, 5330.600204984642, 5352.759125839347, 5373.167159090347, 5259.15853463444, 5352.304200453955, 5356.785728570852, 5365.678059316453, 5395.10980688186, 5714.485696287313, 5935.436133567304, 5955.821325360246, 6009.1587177795145, 6021.7892373767145, 6216.471599914013, 6234.719437625317, 6244.250689917239, 6366.745330186787, 6385.48916086712, 6328.177336946167, 6364.968175159141, 6399.360063993563, 6412.038194270896, 6420.101185833987, 5897.203877476529, 5912.290525137011, 5922.940770592239, 5942.465178133945, 5955.970220148872, 6163.506919446433, 6194.9690251549355, 6359.236891573041, 6364.745410183634, 6370.426661600478, 6208.4722798561725, 6267.717952692049, 6270.874582508324, 6279.529035322369, 6282.2147231596055, 6342.904856427157, 6352.396522330371, 6364.236291645032, 6365.713542890581, 6374.681265936684, 6132.478739307209, 6156.322804491502, 6188.783392581238, 6190.2571691397325, 6293.685315734195, 6333.714982825784, 6340.017297318923, 6343.429091381798, 6347.143135676717, 6349.714262858182, 4564.748938808331, 4596.908061838812, 4619.491855895849, 4644.883877903079, 4718.575328220477, 4260.68044896634, 4281.314989601648, 4309.202797482476, 4329.956700433018, 4337.783110844445, 6021.397860213943, 6051.031834906394, 6122.602030867979, 6229.719662615194, 6251.093591429218, 6366.649834259068, 6394.552381333355, 6395.104685344056, 6401.231852177675, 6444.935550644527, 6254.655993920287, 6258.874822503524, 6260.092286618415, 6265.060240963892, 6273.560850740496, 5242.266082748418, 5256.316678831728, 5418.187271909166, 5420.34955805298, 5463.644863083887, 6599.934000659932, 6669.733210671616, 6748.763793267212, 6770.32296770319, 6778.423833974168, 6408.070829729756, 6414.518911081781, 6442.387973142544, 6445.967770161119, 6449.871002580016, 6392.296847346695, 6621.1392518972225, 6731.427828634425, 6734.326567343226, 6745.426638735762, 6180.227471566054, 6195.194624698941, 6196.535259855439, 6257.311695713559, 6341.746330146927, 6390.105385245976, 6418.358164183544, 6420.293767685457, 6426.0, 6437.324080971618, 6166.845828854314, 6220.284667263322, 6224.906626400517, 6225.844353891189, 6244.344343843831, 5955.76176952917, 5962.97018514922, 6086.178365920544, 6102.694865256808, 6137.315698286874, 6157.32269450369, 6206.131141640084, 6209.192804935329, 6220.409061139185, 6227.408396202353, 6011.338752737282, 6201.0388389799655, 6272.184616000073, 6279.152314437492, 6279.686015699288, 5916.822495325147, 6082.482988945989, 6100.908486372797, 6119.418655227746, 6122.112293717475], "value": 5841.732032275992, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [774.3534148985597, 835.1314632781907, 856.09254190558, 892.143542199488, 892.9776755581106, 42233.366499502496, 43457.0, 46442.76778616102, 46470.53529464709, 46497.30254046184, 42842.0, 42880.785596071975, 42885.57114428855, 43025.7848710756, 43298.78350608243, 8878.866816997734, 8958.641654333818, 10121.898781012205, 10411.427371494565, 10594.629187978422, 9934.552945117486, 10017.499125043754, 10029.949850250738, 10031.74920626983, 10033.548490317917, 9965.352252103627, 10149.391036537794, 10150.238732095086, 10154.882962874079, 10161.593536258577, 9940.155086817593, 10030.548625311878, 10051.195904327673, 10053.49732513375, 10072.043155900177, 9729.075737804897, 9810.411375317432, 9818.705438836847, 9823.459709715962, 9867.16129129025, 34727.82636086829, 34795.0, 34918.476222856676, 34998.650013500046, 35020.29959400823, 3981.391646142735, 4014.116894283253, 4060.2488539620263, 4101.487314085739, 4114.465119534471, 26611.0, 26660.46679066408, 26846.328841778915, 27013.0, 27372.863135684194, 3091.180837078176, 3095.6105094343375, 3176.539401786728, 3209.358128374311, 3209.518572214163, 238500.0, 327442.0, 331784.9999999976, 333311.0, 335828.0, 43842.0, 43901.56098438975, 44084.11831763347, 44110.55889441129, 44129.55870441254, 44653.0, 44733.77633111813, 44827.775861120484, 44917.55082449199, 44942.775286124015, 14057.648558785908, 14206.21865797391, 14237.216953067473, 14263.85736142646, 14476.565703028926, 12406.81389779154, 12504.124711270124, 12507.0, 12520.373981300898, 12554.183978041397, 11664.475098620413, 11676.532938682527, 11721.824172637418, 11734.237274577124, 11768.823467647991, 5111.131107711698, 5257.947420525822, 5289.418164001957, 5322.3879253885525, 5323.52088312046, 1235.4193529041336, 1267.3409826889965, 1285.6271681212531, 1286.4403984266874, 1312.2389014371643, 27397.45205095887, 27575.862120689268, 27608.585871211948, 27703.168904932885, 27854.0, 1382.143071295803, 1387.6600232942994, 1393.4913756478811, 1407.6129064507343, 1418.5957002254308, 14305.713885722436, 14517.637059073397, 14520.564383068524, 14640.633984150269, 14730.55808325752, 334042.0, 334269.0, 335148.0, 335245.0, 336609.0, 55286.72356638191, 55363.72318138464, 55794.163087553716, 55798.442015580134, 56049.7197514018, 1473.734727748994, 1499.4901733410693, 1507.721071601757, 1509.7886295918581, 1539.9605266445105, 27369.566519577405, 27395.45209095767, 27443.0, 28155.155345339674, 28155.71844281531, 36818.0, 36824.44763328499, 36861.0, 37139.81430092832, 37188.07029824276, 279629.0, 279869.0, 280888.0, 281709.0, 283208.0, 29767.70232297736, 29973.850130749208, 30016.399672006002, 30290.0, 30444.391112178077, 37387.43918841165, 38016.23967520579, 38496.422553661156, 38721.4191787129, 38859.805700971316, 29030.41939161247, 29109.532628173853, 29176.854115729286, 29342.55986160252, 29601.0, 29061.0, 29081.0, 29225.0, 29472.11583652494, 29530.557041643962, 33524.49713254352, 33605.0, 34043.489347659306, 35349.29301413906, 35918.8204058978, 29684.257893552833, 29887.55168672515, 30055.849720751256, 30079.398412032075, 30742.38515229638, 25092.247232582322, 25178.118765843108, 25394.365140870887, 25511.74488255094, 25934.092306769926], "value": 18124.015174479042, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [452.27184233384264, 452.92753159494487, 463.46932761987523, 473.7796924430139, 479.95200479952, 20116.798832011675, 20500.692489612647, 21316.0, 21543.353699389005, 21732.13071477143, 21195.682064769004, 21219.57560848782, 21308.0, 21409.892950535224, 22277.888610556925, 6814.0, 6868.210155832068, 6868.244493105779, 7091.85816283674, 7098.609576473292, 6853.6230507322325, 6931.16825980883, 6958.025876377311, 6968.895466568006, 6974.546654467469, 6736.225334086569, 6895.069165662647, 6944.4097251733665, 6948.444124470056, 6970.233274339818, 6654.13496245485, 6663.50023748216, 6949.235584085746, 6994.930050699479, 7015.263397343282, 6512.544121911468, 6540.803775886731, 6542.0, 6547.639879806608, 6564.212294524687, 24995.37511562207, 25157.62263566048, 25377.873110634515, 25393.49213015748, 25547.23358299254, 3142.5600415941785, 3170.79389839662, 3181.284211052495, 3181.316017056321, 3209.1816586770456, 15993.360265589363, 16033.599160021093, 16397.508074757778, 16780.2448889799, 17044.40344587946, 2216.1135545781653, 2264.615015447378, 2295.9655605165935, 2316.872572008539, 2357.2456813819585, 109948.4502577482, 110499.0, 110931.44534277357, 111384.4430777849, 111918.0, 17719.645607088045, 18693.532661683294, 19425.90287048584, 19691.901540492494, 20036.89981550112, 31746.0, 31839.84080079631, 32007.039788806374, 32039.51940720891, 32200.19499512531, 10165.13596344319, 10251.282410231212, 10482.47587620616, 10504.63233786829, 10737.785244295226, 8625.0, 8665.2634526066, 8770.956145219234, 8952.194302512806, 9009.954950225338, 9127.90872091284, 9431.952840235756, 9487.430754154635, 9624.181944534794, 9725.519992402034, 3511.7324013979032, 3882.6893848492055, 3931.941020884689, 3991.3015222335976, 4094.9115950865275, 961.990380096204, 970.7427531704104, 976.1334380374003, 977.3012296208245, 984.9359791613522, 21015.159393624082, 21076.683849742265, 21172.364829055154, 21193.470163246042, 21201.681974770392, 963.9951800240954, 973.0415540692412, 976.5263847034183, 978.2663002747939, 991.8908920018793, 10815.0, 11755.412229388667, 12076.335801530824, 12083.21459105173, 12083.818742718691, 651664.0, 660309.0, 660685.0, 678362.0, 699625.0, 97819.0, 100512.99487005183, 112944.43527782308, 116149.4192529032, 118391.0, 1175.61204802415, 1181.3620644851856, 1213.9210951288137, 1222.113967373647, 1230.2618428942562, 18081.005544695166, 18321.0, 18528.444146675083, 18564.566543835033, 18573.628527429104, 51120.23319650283, 51141.48858511367, 52048.219276711636, 52264.0, 52488.7375563135, 67302.3269767296, 67767.98348024882, 69294.65352673407, 69605.65197174184, 70254.64872675604, 11262.155338349492, 11575.189736718687, 11760.70598235051, 12058.095642826998, 12138.939305303416, 13344.0, 13355.79966300487, 13716.0398772085, 13984.930075349965, 14383.496577619733, 6543.0185472179555, 10675.466226688479, 11061.723456913642, 11894.226875253082, 12085.75828483443, 10423.374597524173, 10454.477276136315, 10656.946715266375, 10859.185561082792, 11042.0, 11123.777524449628, 11647.534098635959, 11916.0, 12328.938355308166, 12564.434600442819, 10933.890661093288, 11221.71945701364, 11246.606368777053, 11290.717732056764, 11438.885611143782, 10961.45192740344, 11187.0, 11769.705757356134, 12301.32342721159, 12638.557650482557], "value": 11313.473648668582, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1517.969640607187, 1549.0395954508206, 1551.488008957044, 1557.0424189123685, 1569.3095038183199, 10488.265821392506, 11102.0, 11192.272502287346, 11207.83188252176, 11473.770524589503, 11776.175667703243, 11814.881851181486, 11910.523579056828, 11915.821262681067, 11929.701757456069, 2465.4329504214043, 2512.196097248881, 2512.5351809915132, 2519.760622740846, 2520.332111990324, 2436.2691192642224, 2466.642336861154, 2496.3010357100043, 2499.687539057618, 2506.3984643685476, 2367.9763202368013, 2391.701037370329, 2396.269137912936, 2482.981977389271, 2486.76375744304, 2283.6346184610384, 2308.3421224950976, 2319.083961835074, 2362.681038059866, 2366.183666635008, 2217.0466699319286, 2227.5210829671537, 2229.9777002230094, 2233.8659680419228, 2242.260054182116, 11572.59495917639, 11766.705832354173, 11854.703632409173, 11873.821892671616, 11876.228045177037, 5676.290463692038, 5815.912761308584, 5842.065269556893, 5850.034744267191, 5863.149843272744, 3371.595408550965, 3409.6590340965954, 3421.6920477157178, 3428.3486137633768, 3497.1956450016382, 1158.2645020412015, 1176.1061593189238, 1210.3645586067298, 1308.5485507499898, 1324.6754545136407, 14920.104793712411, 15152.393904243818, 16752.162391880356, 16771.329146834112, 16977.06626135562, 4463.375127482155, 4609.838655647103, 4700.271457924027, 4775.116603428377, 4779.856604301876, 12668.239905605693, 12673.93663031679, 12683.11218214716, 12693.555725549562, 12721.745565088831, 5686.43135686428, 5690.573207009491, 5692.1461780733225, 5699.2590963174525, 5706.857328566819, 5262.210668399694, 5263.131583288715, 5293.973530132324, 5327.413984461706, 5359.14253719403, 3985.7608543487486, 4090.4477895484324, 4096.446979657708, 4170.47869016373, 4187.183499217624, 1055.8205105132147, 1059.0627294844119, 1063.6277302944063, 1066.221658189526, 1074.1567869222622, 979.6424305128577, 980.3725615606018, 991.4299277915228, 992.6525715999343, 1003.7942221844504, 6357.618542887441, 6396.616203027833, 6427.453666438405, 6450.709718062699, 6559.508036897252, 1026.7381817636456, 1040.8542804007445, 1052.3685788526823, 1071.0414179309475, 1075.9784804304027, 4340.392345071693, 4417.337399390117, 4419.580139886705, 4420.513743488214, 4453.265211240109, 14542.345594448063, 15082.698346033018, 15104.924475377773, 15122.54632361009, 15168.08991460516, 13182.934085329704, 13841.515546955809, 14992.550223493312, 14992.925035374972, 15003.624909377353, 8815.074417186102, 10616.309939853885, 10836.945815270874, 10878.728031799268, 10924.726881827859, 6406.743730250924, 7275.563466191834, 7369.705211791683, 7490.925090749023, 7501.249875012455, 12558.372081396077, 12714.68213294638, 12814.743705125658, 13050.673733156747, 13325.933370333087, 13381.464741410624, 13428.0600357974, 13559.72880542364, 13605.931970340085, 13732.45070197221, 9420.811583768149, 9671.70984870455, 9676.806463870824, 9703.708888733348, 9736.853947190939, 10173.44046077473, 10284.382937023802, 10384.688459346231, 10400.479976001321, 10490.475476226311, 9340.392874463138, 9363.4381937084, 9380.859287110836, 9542.0, 9606.51967401641, 8824.117588241124, 8905.198532132139, 9073.13805188506, 9115.817683646423, 9254.814903702023, 8462.703805366782, 8540.74377768668, 8660.39377243587, 8677.826443471222, 8679.913200868163, 6134.294556126102, 6216.906746398718, 6225.439710426083, 6237.251529816451, 6274.874502510015, 6062.636241825505, 6110.663913484801, 6136.570440069152, 6143.1706719592285, 6243.594166379171], "value": 5321.264320482384, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [419.3793186084593, 429.2509570798956, 443.99112017759643, 448.2312833490563, 457.71621594611344, 5221.999999999991, 5325.520703136717, 5397.91903121453, 5450.591205659572, 5476.58925580581, 5181.481851814826, 5258.36899572051, 5357.169638705997, 5381.408045115034, 5393.81121660742, 4607.884802879921, 4626.583607475327, 4629.675922685414, 4631.564215093332, 4642.0, 4268.59448352406, 4484.66365022623, 4543.545645435446, 4605.9769701151445, 4638.652101092432, 4463.486699029604, 4479.820807167709, 4483.932741008887, 4489.371487991668, 4533.591976722094, 4486.282194848808, 4520.932186017212, 4533.6146427553695, 4541.886452838672, 4560.0, 4188.633422116494, 4189.916201675949, 4226.978865105685, 4296.312589985619, 4334.609885110355, 5267.631265811395, 5269.235960785664, 5277.683338999673, 5281.947180528184, 5301.443348448396, 5289.206619007141, 5329.173978033411, 5330.334832583708, 5334.439883812182, 5353.625246232766, 5406.54044406226, 5744.770209191627, 5745.856353591152, 5764.682942438164, 5768.163616275617, 4731.69243999139, 4750.334953106568, 4765.880852978668, 4770.260609605517, 4773.424769825984, 5960.254968128984, 5960.761569537257, 5966.0, 5972.552058595623, 5975.462208401264, 4835.516448355207, 4918.90162196754, 4928.0677996592685, 4929.954069061299, 4944.60443164546, 4989.151844186497, 5002.174641184237, 5049.2173713074535, 5061.886384995295, 5080.441151473335, 5217.632546295817, 5277.630565860353, 5310.371366173768, 5343.919841202385, 5356.812511562077, 5612.550995920316, 5668.404817494186, 5714.942850571441, 5734.451698041589, 5750.223719797774, 1668.8414600612923, 1708.5557754983793, 1714.1771949464328, 1726.3612463388627, 1735.9913200433916, 1246.9501219951283, 1317.512520367451, 1334.3661760663608, 1336.1582203212108, 1339.1964821107258, 5644.491995720405, 5664.291963504562, 5665.943340566541, 5667.234923285386, 5694.373618901917, 5889.352171261158, 5903.136978565392, 5926.754821982577, 5970.76116955317, 5999.020323293303, 5296.894062118813, 5585.3297604287745, 5643.717814109278, 5652.576056795757, 5686.772529098873, 3091.922701932425, 3134.73354764843, 3134.7962382445066, 3150.98424507876, 3160.478521044048, 5942.851428714231, 6184.5052395808225, 6190.093654729849, 6198.721057552421, 6239.625622462667, 5946.583739138306, 5967.015442451947, 5995.940040599626, 6054.39456054391, 6057.969710151421, 6023.608465449819, 6149.754009839646, 6173.900873702963, 6216.689165541705, 6226.875462490815, 5787.94212057874, 5788.855278618068, 5808.0, 5854.707264636836, 5906.232189815297, 5855.94144058571, 5872.588918775645, 5877.382874798255, 5904.940950590439, 5906.763729450774, 5880.647161170344, 6084.421979911901, 6191.226096737908, 6217.689115544295, 6226.5641405101205, 4888.606747077066, 4931.827386041471, 4941.703497790144, 4946.678465899705, 4947.6536642434685, 5729.742161602821, 5731.828045158652, 5804.94195058044, 5955.255593050869, 6014.8195554133445, 5596.216529685766, 5621.269234999424, 5640.407757185437, 5694.924740640008, 5737.426257374229, 5575.6933368663495, 5625.46558076982, 5687.374388817144, 5756.65460072397, 5761.942380576141, 5559.24950131727, 5575.0, 5644.379118296902, 5646.915296270641, 5685.403032681509, 5727.39862314451, 5758.452946970198, 5765.56758243125, 5817.243758311392, 5829.504492118048, 5421.783128674809, 5512.862178445571, 5573.136163894603, 5600.551955843442, 5721.8569535761935], "value": 4615.124931671335, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [881.1452890696027, 910.6239460370996, 918.0910898210774, 920.7836158502755, 924.3344791749939, 16518.504444866645, 18103.18535665895, 18170.636587268247, 18263.26946922125, 18330.72503912441, 17226.397076102337, 17638.823611763877, 18435.631287374243, 18446.169922353492, 18496.907515462437, 870.268974061788, 875.2560323724847, 886.6320477002037, 886.76500727307, 890.781758469176, 884.1997991817416, 893.4505279253277, 899.1143723432414, 899.8470260055774, 899.865020246965, 945.2343601682625, 945.5886689290146, 948.0614191949988, 949.0225068179786, 949.0319873728793, 928.9860652090224, 933.4492649336889, 935.6584846530967, 936.8032713130251, 939.3377668743519, 684.7124207832723, 685.475611157465, 687.0244253160524, 688.2704333406605, 688.3838964127078, 16211.675766484605, 16280.75578866318, 16281.0, 17659.11704414774, 17923.283068677236, 15112.0, 15209.0, 15278.465253716067, 15294.694106117926, 15960.76058859118, 13185.53850615224, 13427.932860335635, 13544.0, 13564.796528052088, 13583.456661733519, 3999.2601368746873, 4023.6177563131455, 4046.0, 4073.735207211522, 4091.0386059276047, 87223.56388218082, 87290.0, 88738.55630721805, 89934.0, 91352.54323728406, 11768.70578235551, 11992.340421276913, 12146.45340959659, 12433.93783031079, 12651.304178270284, 23393.0, 23738.762612374, 23855.880720596633, 24051.27846164618, 24131.758682413303, 8816.559172041372, 8928.10718928115, 8951.149640784115, 8995.910040899638, 9136.908630913606, 4506.211413002777, 4554.590086892195, 4554.795034223468, 4659.1147681941, 4684.578387945033, 3549.680528752425, 3664.212194378168, 3724.9570120366343, 3725.6460636239512, 3726.6273372662517, 608.9056196289582, 615.2261030231311, 616.5314361085517, 618.3198481670216, 620.5221979076086, 797.6330887791681, 814.8044469327438, 824.2211110500639, 825.7275099217244, 834.1533343656193, 10771.622993195357, 10934.617288394868, 11267.26762760418, 11408.543658253577, 11536.192466527262, 788.2354116506979, 799.8840168175582, 803.5018288661067, 819.1112642782648, 822.0874828939872, 4777.570018698334, 5064.873378165576, 5077.339945807095, 5090.363704536933, 5103.438621751604, 72597.6370118146, 86545.56727216323, 89323.55338223398, 90065.0, 91351.0, 76150.0, 76234.0, 77536.0, 78196.0, 79538.20461795424, 65929.0, 67195.66402167958, 68663.65668171727, 68884.0, 69343.30656693368, 9574.808503830023, 9697.486405971988, 9753.512324383895, 9796.559154837907, 9926.205903527845, 46848.765756171, 47141.52858471371, 47374.526254737015, 47439.52560474351, 47471.52528474671, 52624.73687631537, 53189.0, 54014.72992635012, 54475.0, 55407.61480962847, 12284.201526900722, 12486.133735746422, 12520.0, 12599.370031498205, 12669.239845609292, 14634.268286585415, 14915.627109322353, 14992.325345359703, 15211.92394038067, 15837.841621584097, 14173.149611023371, 14287.57137285883, 14297.785533216802, 14427.49503767363, 14740.484083057041, 14281.0, 14576.781348279572, 14599.781003285172, 14610.634734131732, 15147.242637868283, 13814.861851381358, 14631.414743410145, 14641.194734289717, 14735.189564574051, 14816.555503334917, 11278.830817537908, 11526.711832204262, 11855.34795586251, 11964.76070478603, 12097.939510302393, 11795.469203885674, 11913.642590722293, 11959.820602690792, 12106.455209515769, 12202.08484363694], "value": 7851.621927386992, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1473.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 114.0, 112.0, 115.0, 113.0, 114.0, 113.0, 112.0, 112.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 117.0, 121.0, 154.0, 116.0, 117.0, 117.0, 117.0, 133.0, 116.0], "value": 125.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 164.0, 162.0, 162.0, 162.0, 162.0, 163.0, 161.0, 163.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 106.0, 76.0, 75.0, 76.0, 76.0, 106.0, 75.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 106.0, 82.0, 83.0, 82.0, 90.0, 83.0, 82.0, 99.0], "value": 87.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 113.0, 115.0, 113.0, 113.0, 114.0, 115.0, 114.0, 113.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 149.0, 147.0, 149.0, 149.0, 147.0, 147.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 60.0, 58.0, 59.0, 59.0, 59.0, 59.0, 59.0, 73.0], "value": 60.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 52.0, 52.0, 53.0, 53.0, 52.0, 53.0, 53.0], "value": 52.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 81.0, 81.0, 83.0, 77.0, 84.0, 80.0, 82.0, 84.0, 80.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 125.0, 126.0, 123.0, 126.0, 124.0, 124.0, 140.0, 166.0, 131.0], "value": 131.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 158.0, 164.0, 162.0, 160.0, 158.0, 158.0, 161.0, 163.0, 162.0], "value": 161.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 60.0, 61.0, 60.0, 73.0, 59.0, 59.0, 60.0, 59.0], "value": 61.8, "unit": "score"}]}]} 19:06:42 INFO - Return code: 0 19:06:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:06:42 ERROR - # TBPL SUCCESS # 19:06:42 INFO - Running post-action listener: _resource_record_post_action 19:06:42 INFO - [mozharness: 2017-04-05 02:06:42.191327Z] Finished run-tests step (success) 19:06:42 INFO - Running post-run listener: _resource_record_post_run 19:06:42 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 266240; Write bytes: 366198784; Read time: 28; Write time: 342024 19:06:42 INFO - TinderboxPrint: CPU usage
13.5% 19:06:42 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 28 19:06:42 INFO - TinderboxPrint: I/O write bytes / time
366,198,784 / 342,024 19:06:42 INFO - TinderboxPrint: CPU idle
8,222.7 (86.5%) 19:06:42 INFO - TinderboxPrint: CPU user
1,222.4 (12.9%) 19:06:42 INFO - TinderboxPrint: Swap in / out
0 / 0 19:06:42 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110096384; Read time: 0; Write time: 139236 19:06:42 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 266240; Write bytes: 255045632; Read time: 28; Write time: 202736 19:06:42 INFO - Running post-run listener: _upload_blobber_files 19:06:42 INFO - Blob upload gear active. 19:06:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:06:42 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:06:42 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:06:42 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:06:43 INFO - (blobuploader) - INFO - Open directory for files ... 19:06:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:06:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:06:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:06:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:06:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:06:44 INFO - (blobuploader) - INFO - Done attempting. 19:06:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:06:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:06:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:06:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:06:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:06:45 INFO - (blobuploader) - INFO - Done attempting. 19:06:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:06:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:06:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:06:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:06:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:06:48 INFO - (blobuploader) - INFO - Done attempting. 19:06:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:06:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:06:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:06:49 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:06:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:06:49 INFO - (blobuploader) - INFO - Done attempting. 19:06:49 INFO - (blobuploader) - INFO - Iteration through files over. 19:06:49 INFO - Return code: 0 19:06:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:06:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:06:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c02710da12cb773227d06bba3d7bb9a7b3d9cc6a9c6fc507b1e1f4e371a014f37ebcbf3ec445953a6d050b83a2d0d595ec3b7884d424c39d686b9236a4bab83", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/086cbb07f18681fb41857ea1591bf509e5962647fdb40c0efb335cce08f5f11d05d1f1a4559ce5d87caad66f21c2d42b8ecfcc91c666172ba1c4a9cb3500eea7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5a203ae7ecd876533890c3ca15713995c5896db8332966f2d908ff96957c61e6dfdceab421903f183aa11a502c54eb0a5e04ec9d77cc58936a4d5153d41c71a2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3a15f4f0175226521eb67c8be7787e8866f8e87aa11d325bccff3ddfa4481334491c861fd95387a7c8ebe1d38cf964fccece6fe043d8f6efb8a6b0a7f7c7be22"} 19:06:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:06:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:06:49 INFO - Contents: 19:06:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c02710da12cb773227d06bba3d7bb9a7b3d9cc6a9c6fc507b1e1f4e371a014f37ebcbf3ec445953a6d050b83a2d0d595ec3b7884d424c39d686b9236a4bab83", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/086cbb07f18681fb41857ea1591bf509e5962647fdb40c0efb335cce08f5f11d05d1f1a4559ce5d87caad66f21c2d42b8ecfcc91c666172ba1c4a9cb3500eea7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5a203ae7ecd876533890c3ca15713995c5896db8332966f2d908ff96957c61e6dfdceab421903f183aa11a502c54eb0a5e04ec9d77cc58936a4d5153d41c71a2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3a15f4f0175226521eb67c8be7787e8866f8e87aa11d325bccff3ddfa4481334491c861fd95387a7c8ebe1d38cf964fccece6fe043d8f6efb8a6b0a7f7c7be22"} 19:06:49 INFO - Running post-run listener: copy_logs_to_upload_dir 19:06:49 INFO - Copying logs to upload dir... 19:06:49 INFO - mkdir: /builds/slave/test/build/upload/logs 19:06:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.959693 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-04-04 19:06:49.670215) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-04 19:06:49.675072) ========= 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=62c568580acbfdaac3eec7be000001dc-1491356757.669321-477141698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c02710da12cb773227d06bba3d7bb9a7b3d9cc6a9c6fc507b1e1f4e371a014f37ebcbf3ec445953a6d050b83a2d0d595ec3b7884d424c39d686b9236a4bab83", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/086cbb07f18681fb41857ea1591bf509e5962647fdb40c0efb335cce08f5f11d05d1f1a4559ce5d87caad66f21c2d42b8ecfcc91c666172ba1c4a9cb3500eea7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5a203ae7ecd876533890c3ca15713995c5896db8332966f2d908ff96957c61e6dfdceab421903f183aa11a502c54eb0a5e04ec9d77cc58936a4d5153d41c71a2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3a15f4f0175226521eb67c8be7787e8866f8e87aa11d325bccff3ddfa4481334491c861fd95387a7c8ebe1d38cf964fccece6fe043d8f6efb8a6b0a7f7c7be22"} build_url:https://queue.taskcluster.net/v1/task/Pv3OoWUGRh2f9yhYeImwbw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011395 build_url: 'https://queue.taskcluster.net/v1/task/Pv3OoWUGRh2f9yhYeImwbw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c02710da12cb773227d06bba3d7bb9a7b3d9cc6a9c6fc507b1e1f4e371a014f37ebcbf3ec445953a6d050b83a2d0d595ec3b7884d424c39d686b9236a4bab83", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/086cbb07f18681fb41857ea1591bf509e5962647fdb40c0efb335cce08f5f11d05d1f1a4559ce5d87caad66f21c2d42b8ecfcc91c666172ba1c4a9cb3500eea7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5a203ae7ecd876533890c3ca15713995c5896db8332966f2d908ff96957c61e6dfdceab421903f183aa11a502c54eb0a5e04ec9d77cc58936a4d5153d41c71a2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3a15f4f0175226521eb67c8be7787e8866f8e87aa11d325bccff3ddfa4481334491c861fd95387a7c8ebe1d38cf964fccece6fe043d8f6efb8a6b0a7f7c7be22"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-04 19:06:49.700815) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 19:06:49.701180) ========= 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=62c568580acbfdaac3eec7be000001dc-1491356757.669321-477141698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004422 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 19:06:49.786654) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-04 19:06:49.786965) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-04 19:06:49.787352) ========= ========= Total master_lag: 0.18 =========