builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-075 starttime: 1491412300.98 results: success (0) revision: 632c2b8c17297a8d4c70fc33a518808d81fc18c7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 10:11:40.977947) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 10:11:40.978390) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 10:11:40.978672) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 10:11:40.994922) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 10:11:40.995420) ========= 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=fcadb68e09dcf59683000ff6000001dc-1491411124.720911-595787288 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-05 10:11:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 96.8M=0s 2017-04-05 10:11:42 (96.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122869 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 10:11:41.132819) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 10:11:41.133168) ========= 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=fcadb68e09dcf59683000ff6000001dc-1491411124.720911-595787288 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013833 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 10:11:41.182755) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 10:11:41.183111) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 632c2b8c17297a8d4c70fc33a518808d81fc18c7 --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 632c2b8c17297a8d4c70fc33a518808d81fc18c7 --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=fcadb68e09dcf59683000ff6000001dc-1491411124.720911-595787288 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-05 10:11:42,495 truncating revision to first 12 chars 2017-04-05 10:11:42,495 Setting DEBUG logging. 2017-04-05 10:11:42,495 attempt 1/10 2017-04-05 10:11:42,495 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/632c2b8c1729?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-05 10:11:42,826 unpacking tar archive at: mozilla-aurora-632c2b8c1729/testing/mozharness/ program finished with exit code 0 elapsedTime=0.624293 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 10:11:41.821130) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 10:11:41.821453) ========= script_repo_revision: 632c2b8c17297a8d4c70fc33a518808d81fc18c7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 10:11:41.821910) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 10:11:41.822297) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 10:11:41.832630) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-04-05 10:11:41.833099) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fcadb68e09dcf59683000ff6000001dc-1491411124.720911-595787288 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:11:43 INFO - MultiFileLogger online at 20170405 10:11:43 in /builds/slave/test 10:11:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 10:11:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:11:43 INFO - {'append_to_log': False, 10:11:43 INFO - 'base_work_dir': '/builds/slave/test', 10:11:43 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:11:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:11:43 INFO - 'branch': 'Mozilla-Aurora', 10:11:43 INFO - 'buildbot_json_path': 'buildprops.json', 10:11:43 INFO - 'config_files': ('talos/linux_config.py',), 10:11:43 INFO - 'default_actions': ('clobber', 10:11:43 INFO - 'read-buildbot-config', 10:11:43 INFO - 'download-and-extract', 10:11:43 INFO - 'populate-webroot', 10:11:43 INFO - 'create-virtualenv', 10:11:43 INFO - 'install', 10:11:43 INFO - 'run-tests'), 10:11:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:11:43 INFO - 'download_minidump_stackwalk': True, 10:11:43 INFO - 'download_symbols': 'ondemand', 10:11:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:11:43 INFO - 'tooltool.py': '/tools/tooltool.py', 10:11:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:11:43 INFO - '/tools/misc-python/virtualenv.py')}, 10:11:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:11:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:11:43 INFO - 'gecko_profile': False, 10:11:43 INFO - 'gecko_profile_interval': 0, 10:11:43 INFO - 'installer_path': 'installer.exe', 10:11:43 INFO - 'log_level': 'info', 10:11:43 INFO - 'log_name': 'talos', 10:11:43 INFO - 'log_to_console': True, 10:11:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:11:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:11:43 INFO - 'opt_config_files': (), 10:11:43 INFO - 'pip_index': False, 10:11:43 INFO - 'suite': 'dromaeojs', 10:11:43 INFO - 'system_bits': '32', 10:11:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:11:43 INFO - 'title': 'talos-linux64-ix-075', 10:11:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:11:43 INFO - 'use_talos_json': True, 10:11:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:11:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:11:43 INFO - 'work_dir': 'build'} 10:11:43 INFO - [mozharness: 2017-04-05 17:11:43.243453Z] Running clobber step. 10:11:43 INFO - Running pre-action listener: _resource_record_pre_action 10:11:43 INFO - Running main action method: clobber 10:11:43 INFO - rmtree: /builds/slave/test/build 10:11:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:11:44 INFO - Running post-action listener: _resource_record_post_action 10:11:44 INFO - [mozharness: 2017-04-05 17:11:44.179652Z] Finished clobber step (success) 10:11:44 INFO - [mozharness: 2017-04-05 17:11:44.179753Z] Running read-buildbot-config step. 10:11:44 INFO - Running pre-action listener: _resource_record_pre_action 10:11:44 INFO - Running main action method: read_buildbot_config 10:11:44 INFO - Using buildbot properties: 10:11:44 INFO - { 10:11:44 INFO - "project": "", 10:11:44 INFO - "product": "firefox", 10:11:44 INFO - "who": "rjesup@wgate.com", 10:11:44 INFO - "installer_path": "public/build/target.tar.bz2", 10:11:44 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 10:11:44 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 10:11:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 10:11:44 INFO - "stage_platform": "linux64-pgo", 10:11:44 INFO - "basedir": "/builds/slave/test", 10:11:44 INFO - "buildnumber": 1138, 10:11:44 INFO - "platform": "ubuntu64_hw", 10:11:44 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:11:44 INFO - "slavebuilddir": "test", 10:11:44 INFO - "taskId": "ZAFq9GmiRCGQM14qn3HJAQ", 10:11:44 INFO - "branch": "mozilla-aurora", 10:11:44 INFO - "script_repo_revision": "production", 10:11:44 INFO - "revision": "632c2b8c17297a8d4c70fc33a518808d81fc18c7", 10:11:44 INFO - "slavename": "talos-linux64-ix-075", 10:11:44 INFO - "repo_path": "releases/mozilla-aurora" 10:11:44 INFO - } 10:11:44 INFO - Finding installer, test and symbols from parent task. 10:11:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZAFq9GmiRCGQM14qn3HJAQ'}, attempt #1 10:11:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZAFq9GmiRCGQM14qn3HJAQ'}, attempt #1 10:11:45 INFO - Task dependencies: W_1QANj4QjW8tVgX6f2oKQ 10:11:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W_1QANj4QjW8tVgX6f2oKQ'}, attempt #1 10:11:45 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/W_1QANj4QjW8tVgX6f2oKQ/artifacts/public/build/target.tar.bz2 10:11:45 INFO - Set test_url: https://queue.taskcluster.net/v1/task/W_1QANj4QjW8tVgX6f2oKQ/artifacts/public/build/test_packages.json 10:11:45 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/W_1QANj4QjW8tVgX6f2oKQ/artifacts/public/build/target.crashreporter-symbols.zip 10:11:45 INFO - Running post-action listener: _resource_record_post_action 10:11:45 INFO - [mozharness: 2017-04-05 17:11:45.533378Z] Finished read-buildbot-config step (success) 10:11:45 INFO - [mozharness: 2017-04-05 17:11:45.533593Z] Running download-and-extract step. 10:11:45 INFO - Running pre-action listener: _resource_record_pre_action 10:11:45 INFO - Running main action method: download_and_extract 10:11:45 INFO - mkdir: /builds/slave/test/build/tests 10:11: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')]} 10:11:45 INFO - trying https://queue.taskcluster.net/v1/task/W_1QANj4QjW8tVgX6f2oKQ/artifacts/public/build/target.test_packages.json 10:11:45 INFO - Downloading https://queue.taskcluster.net/v1/task/W_1QANj4QjW8tVgX6f2oKQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:11:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W_1QANj4QjW8tVgX6f2oKQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:11:46 INFO - Downloaded 896 bytes. 10:11:46 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:11:46 INFO - Using the following test package requirements: 10:11:46 INFO - {u'common': [u'target.common.tests.zip'], 10:11:46 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:11:46 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:11:46 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:11:46 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:11:46 INFO - u'mozbase': [u'target.common.tests.zip'], 10:11:46 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:11:46 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:11:46 INFO - u'web-platform': [u'target.common.tests.zip', 10:11:46 INFO - u'target.web-platform.tests.zip'], 10:11:46 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:11:46 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:11:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W_1QANj4QjW8tVgX6f2oKQ/artifacts/public/build/target.common.tests.zip 10:11:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W_1QANj4QjW8tVgX6f2oKQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:11:46 INFO - Fetch https://queue.taskcluster.net/v1/task/W_1QANj4QjW8tVgX6f2oKQ/artifacts/public/build/target.common.tests.zip into memory 10:11:48 INFO - Expected file size: 59541640 10:11:48 INFO - Obtained file size: 59541640 10:11:58 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:11:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W_1QANj4QjW8tVgX6f2oKQ/artifacts/public/build/target.common.tests.zip 10:11:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W_1QANj4QjW8tVgX6f2oKQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:11:58 INFO - Fetch https://queue.taskcluster.net/v1/task/W_1QANj4QjW8tVgX6f2oKQ/artifacts/public/build/target.common.tests.zip into memory 10:11:59 INFO - Expected file size: 59541640 10:11:59 INFO - Obtained file size: 59541640 10:12:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W_1QANj4QjW8tVgX6f2oKQ/artifacts/public/build/target.talos.tests.zip 10:12:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W_1QANj4QjW8tVgX6f2oKQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:12:09 INFO - Fetch https://queue.taskcluster.net/v1/task/W_1QANj4QjW8tVgX6f2oKQ/artifacts/public/build/target.talos.tests.zip into memory 10:12:11 INFO - Expected file size: 14404438 10:12:11 INFO - Obtained file size: 14404438 10:12:11 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')]} 10:12:11 INFO - trying https://queue.taskcluster.net/v1/task/W_1QANj4QjW8tVgX6f2oKQ/artifacts/public/build/target.tar.bz2 10:12:11 INFO - Downloading https://queue.taskcluster.net/v1/task/W_1QANj4QjW8tVgX6f2oKQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:12:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W_1QANj4QjW8tVgX6f2oKQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:12:13 INFO - Downloaded 66778924 bytes. 10:12:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W_1QANj4QjW8tVgX6f2oKQ/artifacts/public/build/target.tar.bz2 10:12:13 INFO - mkdir: /builds/slave/test/properties 10:12:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:12:13 INFO - Writing to file /builds/slave/test/properties/build_url 10:12:13 INFO - Contents: 10:12:13 INFO - build_url:https://queue.taskcluster.net/v1/task/W_1QANj4QjW8tVgX6f2oKQ/artifacts/public/build/target.tar.bz2 10:12:13 INFO - Running post-action listener: _resource_record_post_action 10:12:13 INFO - Running post-action listener: set_extra_try_arguments 10:12:13 INFO - [mozharness: 2017-04-05 17:12:13.787406Z] Finished download-and-extract step (success) 10:12:13 INFO - [mozharness: 2017-04-05 17:12:13.787501Z] Running populate-webroot step. 10:12:13 INFO - Running pre-action listener: _resource_record_pre_action 10:12:13 INFO - Running main action method: populate_webroot 10:12:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:12:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:12:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:12:13 INFO - '--tppagecycles', 10:12:13 INFO - '7'], 10:12:13 INFO - 'tests': ['tsvgm']}}, 10:12:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:12:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:12:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:12:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:12:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:12:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:12:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:12:13 INFO - 'talos_options': ['--disable-e10s'], 10:12:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:12:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:12:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:12:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:12:13 INFO - 'talos_options': ['--disable-e10s'], 10:12:13 INFO - 'tests': ['damp', 'tps']}, 10:12:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:12:13 INFO - 'tests': ['damp', 'tps']}, 10:12:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:12:13 INFO - 'tests': ['dromaeo_dom']}, 10:12:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:12:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:12:13 INFO - 'tests': ['basic_compositor_video']}, 10:12:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:12:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:12:13 INFO - 'tests': ['a11yr', 10:12:13 INFO - 'ts_paint', 10:12:13 INFO - 'tpaint', 10:12:13 INFO - 'sessionrestore', 10:12:13 INFO - 'sessionrestore_no_auto_restore', 10:12:13 INFO - 'tabpaint']}, 10:12:13 INFO - 'other-e10s': {'tests': ['a11yr', 10:12:13 INFO - 'ts_paint', 10:12:13 INFO - 'tpaint', 10:12:13 INFO - 'sessionrestore', 10:12:13 INFO - 'sessionrestore_no_auto_restore', 10:12:13 INFO - 'tabpaint']}, 10:12:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:12:13 INFO - 'ts_paint', 10:12:13 INFO - 'tpaint', 10:12:13 INFO - 'sessionrestore', 10:12:13 INFO - 'sessionrestore_no_auto_restore', 10:12:13 INFO - 'tabpaint']}, 10:12:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:12:13 INFO - 'ts_paint', 10:12:13 INFO - 'tpaint', 10:12:13 INFO - 'sessionrestore', 10:12:13 INFO - 'sessionrestore_no_auto_restore', 10:12:13 INFO - 'tabpaint']}, 10:12:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:12:13 INFO - 'tests': ['a11yr', 10:12:13 INFO - 'ts_paint', 10:12:13 INFO - 'tpaint', 10:12:13 INFO - 'sessionrestore', 10:12:13 INFO - 'sessionrestore_no_auto_restore', 10:12:13 INFO - 'tabpaint']}, 10:12:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:12:13 INFO - 'tests': ['a11yr', 10:12:13 INFO - 'ts_paint', 10:12:13 INFO - 'tpaint', 10:12:13 INFO - 'sessionrestore', 10:12:13 INFO - 'sessionrestore_no_auto_restore', 10:12:13 INFO - 'tabpaint']}, 10:12:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:12:13 INFO - 'tests': ['tsvgx', 10:12:13 INFO - 'tsvgr_opacity', 10:12:13 INFO - 'tart', 10:12:13 INFO - 'tscrollx', 10:12:13 INFO - 'cart', 10:12:13 INFO - 'tsvg_static']}, 10:12:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:12:13 INFO - 'tsvgr_opacity', 10:12:13 INFO - 'tart', 10:12:13 INFO - 'tscrollx', 10:12:13 INFO - 'cart', 10:12:13 INFO - 'tsvg_static']}, 10:12:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:12:13 INFO - 'talos_options': ['--disable-e10s'], 10:12:13 INFO - 'tests': ['tp5o']}, 10:12:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:12:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:12:13 INFO - 'talos_options': ['--disable-e10s', 10:12:13 INFO - '--xperf_path', 10:12:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:12:13 INFO - 'tests': ['tp5n']}, 10:12:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:12:13 INFO - 'talos_options': ['--xperf_path', 10:12:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:12:13 INFO - 'tests': ['tp5n']}}, 10:12:13 INFO - 'talos.zip': {'path': '', 10:12:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:12:13 INFO - Running post-action listener: _resource_record_post_action 10:12:13 INFO - [mozharness: 2017-04-05 17:12:13.800539Z] Finished populate-webroot step (success) 10:12:13 INFO - [mozharness: 2017-04-05 17:12:13.800629Z] Running create-virtualenv step. 10:12:13 INFO - Running pre-action listener: _resource_record_pre_action 10:12:13 INFO - Running main action method: create_virtualenv 10:12:13 INFO - Creating virtualenv /builds/slave/test/build/venv 10:12:13 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 10:12:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:12:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:12:13 INFO - Using real prefix '/usr' 10:12:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:12:14 INFO - Installing distribute.............................................................................................................................................................................................done. 10:12:16 INFO - Installing pip.................done. 10:12:16 INFO - Return code: 0 10:12:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:12:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:12:16 INFO - Reading from file tmpfile_stdout 10:12:16 INFO - Output received: 10:12:16 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) 10:12:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:12:16 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')]} 10:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:16 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')]} 10:12:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x13611f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1459a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15feb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fc290>, '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 0x15fcb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fd040>, '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': 'fcadb68e09dcf59683000ff6000001dc-1491411124.720911-595787288', '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 10:12:16 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 10:12:16 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 10:12:16 INFO - Using env: {'DISPLAY': ':0', 10:12:16 INFO - 'HOME': '/home/cltbld', 10:12:16 INFO - 'LANG': 'en_US.UTF-8', 10:12:16 INFO - 'LANGUAGE': 'en_US:en', 10:12:16 INFO - 'LOGNAME': 'cltbld', 10:12:16 INFO - 'MAIL': '/var/mail/cltbld', 10:12:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:16 INFO - 'MOZ_NO_REMOTE': '1', 10:12:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:16 INFO - 'NO_EM_RESTART': '1', 10:12:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:16 INFO - 'PWD': '/builds/slave/test', 10:12:16 INFO - 'SHELL': '/bin/bash', 10:12:16 INFO - 'SHLVL': '1', 10:12:16 INFO - 'TERM': 'linux', 10:12:16 INFO - 'TMOUT': '86400', 10:12:16 INFO - 'USER': 'cltbld', 10:12:16 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1491411124.720911-595787288', 10:12:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:16 INFO - '_': '/tools/buildbot/bin/python'} 10:12:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:16 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 10:12:16 INFO - Cleaning up... 10:12:16 INFO - Return code: 0 10:12:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:12:16 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')]} 10:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:16 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')]} 10:12:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x13611f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1459a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15feb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fc290>, '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 0x15fcb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fd040>, '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': 'fcadb68e09dcf59683000ff6000001dc-1491411124.720911-595787288', '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 10:12:16 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 10:12:16 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 10:12:16 INFO - Using env: {'DISPLAY': ':0', 10:12:16 INFO - 'HOME': '/home/cltbld', 10:12:16 INFO - 'LANG': 'en_US.UTF-8', 10:12:16 INFO - 'LANGUAGE': 'en_US:en', 10:12:16 INFO - 'LOGNAME': 'cltbld', 10:12:16 INFO - 'MAIL': '/var/mail/cltbld', 10:12:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:16 INFO - 'MOZ_NO_REMOTE': '1', 10:12:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:16 INFO - 'NO_EM_RESTART': '1', 10:12:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:16 INFO - 'PWD': '/builds/slave/test', 10:12:16 INFO - 'SHELL': '/bin/bash', 10:12:16 INFO - 'SHLVL': '1', 10:12:16 INFO - 'TERM': 'linux', 10:12:16 INFO - 'TMOUT': '86400', 10:12:16 INFO - 'USER': 'cltbld', 10:12:16 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1491411124.720911-595787288', 10:12:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:16 INFO - '_': '/tools/buildbot/bin/python'} 10:12:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:17 INFO - Downloading/unpacking psutil>=3.1.1 10:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:17 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 10:12:17 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 10:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:12:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:12:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:12:19 INFO - Installing collected packages: psutil 10:12:19 INFO - Running setup.py install for psutil 10:12:19 INFO - building 'psutil._psutil_linux' extension 10:12:19 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 10:12:19 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 10:12:19 INFO - building 'psutil._psutil_posix' extension 10:12:19 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 10:12:19 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 10:12:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:12:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:12:19 INFO - Successfully installed psutil 10:12:19 INFO - Cleaning up... 10:12:19 INFO - Return code: 0 10:12:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:12:19 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')]} 10:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:19 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')]} 10:12:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:19 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 0x13611f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1459a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15feb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fc290>, '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 0x15fcb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fd040>, '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': 'fcadb68e09dcf59683000ff6000001dc-1491411124.720911-595787288', '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 10:12:19 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 10:12:19 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 10:12:19 INFO - Using env: {'DISPLAY': ':0', 10:12:19 INFO - 'HOME': '/home/cltbld', 10:12:19 INFO - 'LANG': 'en_US.UTF-8', 10:12:19 INFO - 'LANGUAGE': 'en_US:en', 10:12:19 INFO - 'LOGNAME': 'cltbld', 10:12:19 INFO - 'MAIL': '/var/mail/cltbld', 10:12:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:19 INFO - 'MOZ_NO_REMOTE': '1', 10:12:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:19 INFO - 'NO_EM_RESTART': '1', 10:12:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:19 INFO - 'PWD': '/builds/slave/test', 10:12:19 INFO - 'SHELL': '/bin/bash', 10:12:19 INFO - 'SHLVL': '1', 10:12:19 INFO - 'TERM': 'linux', 10:12:19 INFO - 'TMOUT': '86400', 10:12:19 INFO - 'USER': 'cltbld', 10:12:19 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1491411124.720911-595787288', 10:12:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:19 INFO - '_': '/tools/buildbot/bin/python'} 10:12:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:12:19 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 10:12:19 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 10:12:19 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 10:12:19 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 10:12:19 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 10:12:19 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 10:12:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:12:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:12:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:12:22 INFO - Installing collected packages: mozsystemmonitor 10:12:22 INFO - Running setup.py install for mozsystemmonitor 10:12:22 INFO - Successfully installed mozsystemmonitor 10:12:22 INFO - Cleaning up... 10:12:22 INFO - Return code: 0 10:12:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:12:22 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')]} 10:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:22 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')]} 10:12:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:22 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 0x13611f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1459a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15feb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fc290>, '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 0x15fcb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fd040>, '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': 'fcadb68e09dcf59683000ff6000001dc-1491411124.720911-595787288', '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 10:12:22 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 10:12:22 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 10:12:22 INFO - Using env: {'DISPLAY': ':0', 10:12:22 INFO - 'HOME': '/home/cltbld', 10:12:22 INFO - 'LANG': 'en_US.UTF-8', 10:12:22 INFO - 'LANGUAGE': 'en_US:en', 10:12:22 INFO - 'LOGNAME': 'cltbld', 10:12:22 INFO - 'MAIL': '/var/mail/cltbld', 10:12:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:22 INFO - 'MOZ_NO_REMOTE': '1', 10:12:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:22 INFO - 'NO_EM_RESTART': '1', 10:12:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:22 INFO - 'PWD': '/builds/slave/test', 10:12:22 INFO - 'SHELL': '/bin/bash', 10:12:22 INFO - 'SHLVL': '1', 10:12:22 INFO - 'TERM': 'linux', 10:12:22 INFO - 'TMOUT': '86400', 10:12:22 INFO - 'USER': 'cltbld', 10:12:22 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1491411124.720911-595787288', 10:12:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:22 INFO - '_': '/tools/buildbot/bin/python'} 10:12:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:22 INFO - Downloading/unpacking jsonschema==2.5.1 10:12:22 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 10:12:22 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 10:12:22 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 10:12:22 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 10:12:22 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 10:12:22 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 10:12:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:12:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:12:24 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 10:12:24 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 10:12:24 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 10:12:24 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 10:12:24 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 10:12:24 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 10:12:24 INFO - Downloading functools32-3.2.3-2.tar.gz 10:12:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:12:25 INFO - warning: no files found matching '*.txt' 10:12:25 INFO - no previously-included directories found matching 'build' 10:12:25 INFO - no previously-included directories found matching 'dist' 10:12:25 INFO - no previously-included directories found matching '.git*' 10:12:25 INFO - Installing collected packages: jsonschema, functools32 10:12:25 INFO - Running setup.py install for functools32 10:12:25 INFO - warning: no files found matching '*.txt' 10:12:25 INFO - no previously-included directories found matching 'build' 10:12:25 INFO - no previously-included directories found matching 'dist' 10:12:25 INFO - no previously-included directories found matching '.git*' 10:12:25 INFO - Successfully installed jsonschema functools32 10:12:25 INFO - Cleaning up... 10:12:25 INFO - Return code: 0 10:12:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:12:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:12:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x13611f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1459a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15feb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fc290>, '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 0x15fcb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fd040>, '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': 'fcadb68e09dcf59683000ff6000001dc-1491411124.720911-595787288', '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 10:12:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:12:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:12:25 INFO - Using env: {'DISPLAY': ':0', 10:12:25 INFO - 'HOME': '/home/cltbld', 10:12:25 INFO - 'LANG': 'en_US.UTF-8', 10:12:25 INFO - 'LANGUAGE': 'en_US:en', 10:12:25 INFO - 'LOGNAME': 'cltbld', 10:12:25 INFO - 'MAIL': '/var/mail/cltbld', 10:12:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:25 INFO - 'MOZ_NO_REMOTE': '1', 10:12:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:25 INFO - 'NO_EM_RESTART': '1', 10:12:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:25 INFO - 'PWD': '/builds/slave/test', 10:12:25 INFO - 'SHELL': '/bin/bash', 10:12:25 INFO - 'SHLVL': '1', 10:12:25 INFO - 'TERM': 'linux', 10:12:25 INFO - 'TMOUT': '86400', 10:12:25 INFO - 'USER': 'cltbld', 10:12:25 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1491411124.720911-595787288', 10:12:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:25 INFO - '_': '/tools/buildbot/bin/python'} 10:12:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:12:25 INFO - Cleaning up... 10:12:25 INFO - Return code: 0 10:12:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:12:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:12:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x13611f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1459a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15feb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fc290>, '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 0x15fcb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fd040>, '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': 'fcadb68e09dcf59683000ff6000001dc-1491411124.720911-595787288', '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 10:12:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:12:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:12:25 INFO - Using env: {'DISPLAY': ':0', 10:12:25 INFO - 'HOME': '/home/cltbld', 10:12:25 INFO - 'LANG': 'en_US.UTF-8', 10:12:25 INFO - 'LANGUAGE': 'en_US:en', 10:12:25 INFO - 'LOGNAME': 'cltbld', 10:12:25 INFO - 'MAIL': '/var/mail/cltbld', 10:12:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:25 INFO - 'MOZ_NO_REMOTE': '1', 10:12:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:25 INFO - 'NO_EM_RESTART': '1', 10:12:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:25 INFO - 'PWD': '/builds/slave/test', 10:12:25 INFO - 'SHELL': '/bin/bash', 10:12:25 INFO - 'SHLVL': '1', 10:12:25 INFO - 'TERM': 'linux', 10:12:25 INFO - 'TMOUT': '86400', 10:12:25 INFO - 'USER': 'cltbld', 10:12:25 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1491411124.720911-595787288', 10:12:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:25 INFO - '_': '/tools/buildbot/bin/python'} 10:12:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:25 INFO - Downloading/unpacking blobuploader==1.2.4 10:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:25 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 10:12:25 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 10:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:27 INFO - Downloading blobuploader-1.2.4.tar.gz 10:12:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:12:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:12:27 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 10:12:27 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 10:12:27 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 10:12:27 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 10:12:27 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 10:12:27 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 10:12:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:12:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:12:28 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 10:12:28 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 10:12:28 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 10:12:28 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 10:12:28 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 10:12:28 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 10:12:28 INFO - Downloading docopt-0.6.1.tar.gz 10:12:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:12:28 INFO - Installing collected packages: blobuploader, requests, docopt 10:12:28 INFO - Running setup.py install for blobuploader 10:12:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:12:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:12:28 INFO - Running setup.py install for requests 10:12:28 INFO - Running setup.py install for docopt 10:12:28 INFO - Successfully installed blobuploader requests docopt 10:12:28 INFO - Cleaning up... 10:12:29 INFO - Return code: 0 10:12:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:12:29 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')]} 10:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:29 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')]} 10:12:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:29 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 0x13611f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1459a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15feb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fc290>, '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 0x15fcb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fd040>, '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': 'fcadb68e09dcf59683000ff6000001dc-1491411124.720911-595787288', '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 10:12:29 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 10:12:29 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 10:12:29 INFO - Using env: {'DISPLAY': ':0', 10:12:29 INFO - 'HOME': '/home/cltbld', 10:12:29 INFO - 'LANG': 'en_US.UTF-8', 10:12:29 INFO - 'LANGUAGE': 'en_US:en', 10:12:29 INFO - 'LOGNAME': 'cltbld', 10:12:29 INFO - 'MAIL': '/var/mail/cltbld', 10:12:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:29 INFO - 'MOZ_NO_REMOTE': '1', 10:12:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:29 INFO - 'NO_EM_RESTART': '1', 10:12:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:29 INFO - 'PWD': '/builds/slave/test', 10:12:29 INFO - 'SHELL': '/bin/bash', 10:12:29 INFO - 'SHLVL': '1', 10:12:29 INFO - 'TERM': 'linux', 10:12:29 INFO - 'TMOUT': '86400', 10:12:29 INFO - 'USER': 'cltbld', 10:12:29 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1491411124.720911-595787288', 10:12:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:29 INFO - '_': '/tools/buildbot/bin/python'} 10:12:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:12:29 INFO - Running setup.py (path:/tmp/pip-oNVZmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:12:29 INFO - Running setup.py (path:/tmp/pip-So9C8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:12:29 INFO - Running setup.py (path:/tmp/pip-aOY3Ib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:12:29 INFO - Running setup.py (path:/tmp/pip-70rG8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:12:29 INFO - Running setup.py (path:/tmp/pip-LkFuqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:12:29 INFO - Running setup.py (path:/tmp/pip-J4wXSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:12:29 INFO - Running setup.py (path:/tmp/pip-PvCXXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:12:29 INFO - Running setup.py (path:/tmp/pip-QtK1F4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:12:29 INFO - Running setup.py (path:/tmp/pip-s1AC1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:12:29 INFO - Running setup.py (path:/tmp/pip-LFwE6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:12:30 INFO - Running setup.py (path:/tmp/pip-SG2HGH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:12:30 INFO - Running setup.py (path:/tmp/pip-fJV3yp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:12:30 INFO - Running setup.py (path:/tmp/pip-k6NvCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:12:30 INFO - Running setup.py (path:/tmp/pip-U3qRy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:30 INFO - Running setup.py (path:/tmp/pip-atXUBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:12:30 INFO - Running setup.py (path:/tmp/pip-BZa8FI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:12:30 INFO - Running setup.py (path:/tmp/pip-2Tt0xE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:12:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:12:30 INFO - Running setup.py install for manifestparser 10:12:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:12:30 INFO - Running setup.py install for mozcrash 10:12:30 INFO - Running setup.py install for mozdebug 10:12:30 INFO - Running setup.py install for mozdevice 10:12:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:12:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:12:30 INFO - Running setup.py install for mozfile 10:12:31 INFO - Running setup.py install for mozhttpd 10:12:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:12:31 INFO - Running setup.py install for mozinfo 10:12:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:12:31 INFO - Running setup.py install for mozInstall 10:12:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:12:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:12:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:12:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:12:31 INFO - Running setup.py install for mozleak 10:12:31 INFO - Running setup.py install for mozlog 10:12:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:12:31 INFO - Running setup.py install for moznetwork 10:12:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:12:31 INFO - Running setup.py install for mozprocess 10:12:31 INFO - Running setup.py install for mozprofile 10:12:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:12:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:12:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:12:31 INFO - Running setup.py install for mozrunner 10:12:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:12:32 INFO - Running setup.py install for mozscreenshot 10:12:32 INFO - Running setup.py install for moztest 10:12:32 INFO - Running setup.py install for mozversion 10:12:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:12:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:12:32 INFO - Cleaning up... 10:12:32 INFO - Return code: 0 10:12:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:12:32 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')]} 10:12:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:32 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')]} 10:12:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:32 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 0x13611f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1459a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15feb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fc290>, '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 0x15fcb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fd040>, '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': 'fcadb68e09dcf59683000ff6000001dc-1491411124.720911-595787288', '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 10:12:32 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 10:12:32 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 10:12:32 INFO - Using env: {'DISPLAY': ':0', 10:12:32 INFO - 'HOME': '/home/cltbld', 10:12:32 INFO - 'LANG': 'en_US.UTF-8', 10:12:32 INFO - 'LANGUAGE': 'en_US:en', 10:12:32 INFO - 'LOGNAME': 'cltbld', 10:12:32 INFO - 'MAIL': '/var/mail/cltbld', 10:12:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:32 INFO - 'MOZ_NO_REMOTE': '1', 10:12:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:32 INFO - 'NO_EM_RESTART': '1', 10:12:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:32 INFO - 'PWD': '/builds/slave/test', 10:12:32 INFO - 'SHELL': '/bin/bash', 10:12:32 INFO - 'SHLVL': '1', 10:12:32 INFO - 'TERM': 'linux', 10:12:32 INFO - 'TMOUT': '86400', 10:12:32 INFO - 'USER': 'cltbld', 10:12:32 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1491411124.720911-595787288', 10:12:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:32 INFO - '_': '/tools/buildbot/bin/python'} 10:12:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:12:32 INFO - Running setup.py (path:/tmp/pip-AnseNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:12:32 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)) 10:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:12:32 INFO - Running setup.py (path:/tmp/pip-9Q4B92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:12:32 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)) 10:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:12:32 INFO - Running setup.py (path:/tmp/pip-gJvs3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:12:32 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)) 10:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:12:32 INFO - Running setup.py (path:/tmp/pip-A1yfTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:12:32 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)) 10:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:12:32 INFO - Running setup.py (path:/tmp/pip-9wWZKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:12:32 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)) 10:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:12:32 INFO - Running setup.py (path:/tmp/pip-i4qDFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:12:33 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)) 10:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:12:33 INFO - Running setup.py (path:/tmp/pip-Y1mKns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:12:33 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)) 10:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:12:33 INFO - Running setup.py (path:/tmp/pip-yWPE7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:12:33 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)) 10:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:12:33 INFO - Running setup.py (path:/tmp/pip-hoZLpd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:12:33 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)) 10:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:12:33 INFO - Running setup.py (path:/tmp/pip-GYBfda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:12:33 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)) 10:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:12:33 INFO - Running setup.py (path:/tmp/pip-ZI_rtM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:12:33 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)) 10:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:12:33 INFO - Running setup.py (path:/tmp/pip-jKC2wd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:12:33 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)) 10:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:12:33 INFO - Running setup.py (path:/tmp/pip-SPXR36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:12:33 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)) 10:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:12:33 INFO - Running setup.py (path:/tmp/pip-KfjPOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:12:33 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)) 10:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:33 INFO - Running setup.py (path:/tmp/pip-Srqg1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:33 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)) 10:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:12:33 INFO - Running setup.py (path:/tmp/pip-eQNRi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:12:33 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)) 10:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:12:33 INFO - Running setup.py (path:/tmp/pip-zDbW6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:12:33 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)) 10:12:33 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)) 10:12:33 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)) 10:12:33 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)) 10:12:33 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)) 10:12:33 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)) 10:12:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:12: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 10:12: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 10:12: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 10:12: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 10:12: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 10:12: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 10:12:35 INFO - Downloading blessings-1.6.tar.gz 10:12:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:12:35 INFO - Installing collected packages: blessings 10:12:35 INFO - Running setup.py install for blessings 10:12:35 INFO - Successfully installed blessings 10:12:35 INFO - Cleaning up... 10:12:36 INFO - Return code: 0 10:12:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:12:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:12:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:12:36 INFO - Reading from file tmpfile_stdout 10:12:36 INFO - Current package versions: 10:12:36 INFO - argparse == 1.2.1 10:12:36 INFO - blessings == 1.6 10:12:36 INFO - blobuploader == 1.2.4 10:12:36 INFO - docopt == 0.6.1 10:12:36 INFO - functools32 == 3.2.3-2 10:12:36 INFO - jsonschema == 2.5.1 10:12:36 INFO - manifestparser == 1.1 10:12:36 INFO - mozInstall == 1.12 10:12:36 INFO - mozcrash == 1.0 10:12:36 INFO - mozdebug == 0.1 10:12:36 INFO - mozdevice == 0.49 10:12:36 INFO - mozfile == 1.2 10:12:36 INFO - mozhttpd == 0.7 10:12:36 INFO - mozinfo == 0.9 10:12:36 INFO - mozleak == 0.1 10:12:36 INFO - mozlog == 3.4 10:12:36 INFO - moznetwork == 0.27 10:12:36 INFO - mozprocess == 0.25 10:12:36 INFO - mozprofile == 0.28 10:12:36 INFO - mozrunner == 6.13 10:12:36 INFO - mozscreenshot == 0.1 10:12:36 INFO - mozsystemmonitor == 0.3 10:12:36 INFO - moztest == 0.8 10:12:36 INFO - mozversion == 1.4 10:12:36 INFO - psutil == 3.1.1 10:12:36 INFO - requests == 1.2.3 10:12:36 INFO - wsgiref == 0.1.2 10:12:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:12:36 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')]} 10:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:36 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')]} 10:12:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:36 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 0x13611f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1459a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15feb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fc290>, '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 0x15fcb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fd040>, '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': 'fcadb68e09dcf59683000ff6000001dc-1491411124.720911-595787288', '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 10:12:36 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 10:12:36 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 10:12:36 INFO - Using env: {'DISPLAY': ':0', 10:12:36 INFO - 'HOME': '/home/cltbld', 10:12:36 INFO - 'LANG': 'en_US.UTF-8', 10:12:36 INFO - 'LANGUAGE': 'en_US:en', 10:12:36 INFO - 'LOGNAME': 'cltbld', 10:12:36 INFO - 'MAIL': '/var/mail/cltbld', 10:12:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:36 INFO - 'MOZ_NO_REMOTE': '1', 10:12:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:36 INFO - 'NO_EM_RESTART': '1', 10:12:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:36 INFO - 'PWD': '/builds/slave/test', 10:12:36 INFO - 'SHELL': '/bin/bash', 10:12:36 INFO - 'SHLVL': '1', 10:12:36 INFO - 'TERM': 'linux', 10:12:36 INFO - 'TMOUT': '86400', 10:12:36 INFO - 'USER': 'cltbld', 10:12:36 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1491411124.720911-595787288', 10:12:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:36 INFO - '_': '/tools/buildbot/bin/python'} 10:12:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:36 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)) 10:12:36 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)) 10:12:36 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)) 10:12:36 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)) 10:12:36 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)) 10:12:36 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)) 10:12:36 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)) 10:12:36 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)) 10:12:36 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)) 10:12:36 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)) 10:12:36 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)) 10:12:36 INFO - Cleaning up... 10:12:36 INFO - Return code: 0 10:12:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:12:36 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')]} 10:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:36 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')]} 10:12:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:36 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 0x13611f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1459a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15feb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fc290>, '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 0x15fcb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fd040>, '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': 'fcadb68e09dcf59683000ff6000001dc-1491411124.720911-595787288', '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 10:12:36 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 10:12:36 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 10:12:36 INFO - Using env: {'DISPLAY': ':0', 10:12:36 INFO - 'HOME': '/home/cltbld', 10:12:36 INFO - 'LANG': 'en_US.UTF-8', 10:12:36 INFO - 'LANGUAGE': 'en_US:en', 10:12:36 INFO - 'LOGNAME': 'cltbld', 10:12:36 INFO - 'MAIL': '/var/mail/cltbld', 10:12:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:36 INFO - 'MOZ_NO_REMOTE': '1', 10:12:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:36 INFO - 'NO_EM_RESTART': '1', 10:12:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:36 INFO - 'PWD': '/builds/slave/test', 10:12:36 INFO - 'SHELL': '/bin/bash', 10:12:36 INFO - 'SHLVL': '1', 10:12:36 INFO - 'TERM': 'linux', 10:12:36 INFO - 'TMOUT': '86400', 10:12:36 INFO - 'USER': 'cltbld', 10:12:36 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1491411124.720911-595787288', 10:12:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:36 INFO - '_': '/tools/buildbot/bin/python'} 10:12:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:12:36 INFO - Cleaning up... 10:12:36 INFO - Return code: 0 10:12:36 INFO - Running post-action listener: _resource_record_post_action 10:12:36 INFO - Running post-action listener: _start_resource_monitoring 10:12:36 INFO - Starting resource monitoring. 10:12:36 INFO - [mozharness: 2017-04-05 17:12:36.788013Z] Finished create-virtualenv step (success) 10:12:36 INFO - [mozharness: 2017-04-05 17:12:36.788588Z] Running install step. 10:12:36 INFO - Running pre-action listener: _resource_record_pre_action 10:12:36 INFO - Running main action method: install 10:12:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:12:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:12:36 INFO - Reading from file tmpfile_stdout 10:12:36 INFO - Detecting whether we're running mozinstall >=1.0... 10:12:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:12:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:12:37 INFO - Reading from file tmpfile_stdout 10:12:37 INFO - Output received: 10:12:37 INFO - Usage: mozinstall [options] installer 10:12:37 INFO - Options: 10:12:37 INFO - -h, --help show this help message and exit 10:12:37 INFO - -d DEST, --destination=DEST 10:12:37 INFO - Directory to install application into. [default: 10:12:37 INFO - "/builds/slave/test"] 10:12:37 INFO - --app=APP Application being installed. [default: firefox] 10:12:37 INFO - mkdir: /builds/slave/test/build/application 10:12:37 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'] 10:12:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:12:53 INFO - Reading from file tmpfile_stdout 10:12:53 INFO - Output received: 10:12:53 INFO - /builds/slave/test/build/application/firefox/firefox 10:12:53 INFO - Running post-action listener: _resource_record_post_action 10:12:53 INFO - [mozharness: 2017-04-05 17:12:53.655491Z] Finished install step (success) 10:12:53 INFO - [mozharness: 2017-04-05 17:12:53.655766Z] Running run-tests step. 10:12:53 INFO - Running pre-action listener: _resource_record_pre_action 10:12:53 INFO - Running main action method: run_tests 10:12:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:12:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:12:53 INFO - Python 2.7.3 10:12:53 INFO - Return code: 0 10:12:53 INFO - grabbing minidump binary from tooltool 10:12:53 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')]} 10:12:53 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 0x15fc290>, '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 0x15fcb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fd040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:12:53 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 10:12:53 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 10:12:53 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 10:12:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:12:53 INFO - Return code: 0 10:12:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:12:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:12:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:12:53 INFO - ENV: RUST_BACKTRACE is now 1 10:12:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:12:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:12:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W_1QANj4QjW8tVgX6f2oKQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-075', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:12:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/W_1QANj4QjW8tVgX6f2oKQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-075 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:12:53 INFO - Using env: {'DISPLAY': ':0', 10:12:53 INFO - 'HOME': '/home/cltbld', 10:12:53 INFO - 'LANG': 'en_US.UTF-8', 10:12:53 INFO - 'LANGUAGE': 'en_US:en', 10:12:53 INFO - 'LOGNAME': 'cltbld', 10:12:53 INFO - 'MAIL': '/var/mail/cltbld', 10:12:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:12:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:12:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:53 INFO - 'MOZ_NO_REMOTE': '1', 10:12:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:12:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:53 INFO - 'NO_EM_RESTART': '1', 10:12:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:53 INFO - 'PWD': '/builds/slave/test', 10:12:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:12:53 INFO - 'RUST_BACKTRACE': '1', 10:12:53 INFO - 'SHELL': '/bin/bash', 10:12:53 INFO - 'SHLVL': '1', 10:12:53 INFO - 'TERM': 'linux', 10:12:53 INFO - 'TMOUT': '86400', 10:12:53 INFO - 'USER': 'cltbld', 10:12:53 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1491411124.720911-595787288', 10:12:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:53 INFO - '_': '/tools/buildbot/bin/python'} 10:12:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W_1QANj4QjW8tVgX6f2oKQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-075', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:12:53 INFO - mozversion application_buildid: 20170405162434 10:12:53 INFO - mozversion application_changeset: 632c2b8c17297a8d4c70fc33a518808d81fc18c7 10:12:53 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:12:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:12:53 INFO - mozversion application_name: Firefox 10:12:53 INFO - mozversion application_remotingname: firefox-dev 10:12:53 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:12:53 INFO - mozversion application_vendor: Mozilla 10:12:53 INFO - mozversion application_version: 54.0a2 10:12:53 INFO - mozversion platform_buildid: 20170405162434 10:12:53 INFO - mozversion platform_changeset: 632c2b8c17297a8d4c70fc33a518808d81fc18c7 10:12:53 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:12:53 INFO - mozversion platform_version: 54.0a2 10:12:53 INFO - using testdate: 1491412373 10:12:53 INFO - actual date: 1491412373 10:12:53 INFO - starting webserver on 'localhost:54047' 10:12:53 INFO - SUITE-START | Running 2 tests 10:12:53 INFO - TEST-START | dromaeo_css 10:12:53 INFO - operating with platform_type : linux_ 10:12:53 INFO - Initialising browser for dromaeo_css test... 10:12:53 INFO - TEST-INFO | started process 28293 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6kgNVe/profile http://localhost:54047/getInfo.html) 10:12:58 INFO - PROCESS | 28293 | __metrics Screen width/height:1600/1200 10:12:58 INFO - PROCESS | 28293 | colorDepth:24 10:12:58 INFO - PROCESS | 28293 | Browser inner width/height: 1024/697 10:12:58 INFO - PROCESS | 28293 | __metrics 10:12:59 ERROR - PROCESS | 28293 | 1491412379147 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4954:11 < observe@XPIProvider.jsm:2917:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 10:12:59 INFO - PROCESS | 28293 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:12:59 INFO - PROCESS | 28293 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:13:00 INFO - TEST-INFO | 28293: exit 0 10:13:00 INFO - Browser initialized. 10:13:00 INFO - Running cycle 1/1 for dromaeo_css test... 10:13:00 INFO - TEST-INFO | started process 28385 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6kgNVe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:13:12 INFO - PROCESS | 28385 | RSS: Main: 139747328 10:13:12 INFO - PROCESS | 28385 | 10:16:13 INFO - PROCESS | 28385 | Cycle 1(1): loaded http://localhost:54047/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54047/tests/dromaeo/cssquery-ext.html) 10:16:14 INFO - PROCESS | 28385 | RSS: Main: 259395584 10:16:14 INFO - PROCESS | 28385 | 10:18:02 INFO - PROCESS | 28385 | ************************* 10:18:02 INFO - PROCESS | 28385 | A coding exception was thrown and uncaught in a Task. 10:18:02 INFO - PROCESS | 28385 | 10:18:02 ERROR - PROCESS | 28385 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:18:02 INFO - PROCESS | 28385 | Full stack: 10:18:02 INFO - PROCESS | 28385 | ************************* 10:18:02 INFO - PROCESS | 28385 | ************************* 10:18:02 INFO - PROCESS | 28385 | A coding exception was thrown and uncaught in a Task. 10:18:02 INFO - PROCESS | 28385 | 10:18:02 ERROR - PROCESS | 28385 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:18:02 INFO - PROCESS | 28385 | Full stack: 10:18:02 INFO - PROCESS | 28385 | ************************* 10:18:02 INFO - PROCESS | 28385 | ************************* 10:18:02 INFO - PROCESS | 28385 | A coding exception was thrown and uncaught in a Task. 10:18:02 INFO - PROCESS | 28385 | 10:18:02 ERROR - PROCESS | 28385 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:18:02 INFO - PROCESS | 28385 | Full stack: 10:18:02 INFO - PROCESS | 28385 | ************************* 10:18:02 INFO - PROCESS | 28385 | ************************* 10:18:02 INFO - PROCESS | 28385 | A coding exception was thrown and uncaught in a Task. 10:18:02 INFO - PROCESS | 28385 | 10:18:02 ERROR - PROCESS | 28385 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:18:02 INFO - PROCESS | 28385 | Full stack: 10:18:02 INFO - PROCESS | 28385 | ************************* 10:19:17 INFO - PROCESS | 28385 | Cycle 1(1): loaded http://localhost:54047/tests/dromaeo/cssquery-ext.html (next: http://localhost:54047/tests/dromaeo/cssquery-jquery.html) 10:19:17 INFO - PROCESS | 28385 | RSS: Main: 230150144 10:19:17 INFO - PROCESS | 28385 | 10:22:19 INFO - PROCESS | 28385 | Cycle 1(1): loaded http://localhost:54047/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54047/tests/dromaeo/cssquery-mootools.html) 10:22:20 INFO - PROCESS | 28385 | RSS: Main: 217788416 10:22:20 INFO - PROCESS | 28385 | 10:25:22 INFO - PROCESS | 28385 | Cycle 1(1): loaded http://localhost:54047/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54047/tests/dromaeo/cssquery-prototype.html) 10:25:22 INFO - PROCESS | 28385 | RSS: Main: 211804160 10:25:22 INFO - PROCESS | 28385 | 10:28:25 INFO - PROCESS | 28385 | Cycle 1(1): loaded http://localhost:54047/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54047/tests/dromaeo/cssquery-yui.html) 10:28:26 INFO - PROCESS | 28385 | RSS: Main: 174759936 10:28:26 INFO - PROCESS | 28385 | 10:31:28 INFO - PROCESS | 28385 | Cycle 1(1): loaded http://localhost:54047/tests/dromaeo/cssquery-yui.html (next: http://localhost:54047/tests/dromaeo/cssquery-dojo.html) 10:31:28 INFO - PROCESS | 28385 | RSS: Main: 260894720 10:31:28 INFO - PROCESS | 28385 | 10:31:28 INFO - PROCESS | 28385 | __start_tp_report 10:31:28 INFO - PROCESS | 28385 | _x_x_mozilla_page_load 10:31:28 INFO - PROCESS | 28385 | _x_x_mozilla_page_load_details 10:31:28 INFO - PROCESS | 28385 | |i|pagename|runs| 10:31:28 INFO - PROCESS | 28385 | |0;dojo.html;3399.116229780257;3425.5718035245577;3426.760126791125;3434.501997210403;3471.5486986691726;5806.983777838877;5873.119032145175;5887.087501437273;5905.173275741395;5925.051991681332;5891.263592050994;5940.435658612436;5946.405359464052;5947.524198064155;5964.493018093456;5335.279737235472;5339.439358867302;5354.27717258171;5384.7846086156505;5462.590305727086;5238.580913526927;5260.579153667697;5436.429174936634;5447.754851031713;5448.128299472085;5291.28567643369;5326.813561525348;5348.277982472356;5356.330458692663;5362.731863406833;5240.187770895536;5244;5323.733813309358;5340;5359.08895487768;5233.764480598382;5295.735213239361;5320.388155362144;5327.973360133214;5332.120200166968;5772.249607550992;5825.9417405825825;5832.766689332421;5864;5877.647341159502;6088.878222435571;6118.418750218767;6118.847028824271;6179;6218.751249950042;6350.777722779727;6354.777582784581;6372.681365931685;6376.585521941059;6376.936230637681;5866.472017518444;5896.823095307148;5909.645421274738;5920.052791553331;5928.7332070056955;6158.661273629904;6190.102435146879;6350.587211831308;6410.415806722797;6457.2896981332015;6216.689165541705;6220;6222.222222222223;6232.563720539519;6234.594751341239;6321.431071203614;6321.620702757849;6324.08300796382;6327.810165695037;6332.588381755171;5948.791792287249;5978.8206353809455;6275.96862015687;6276.6547839869245;6334.936650633527;6147.784827531104;6166.7224974876235;6167.537434692326;6167.753289868355;6168.19813424252;4652.534746525321;4677.789499472532;4682.274247491644;4736.194846876039;4809.879753006133;4257.829686812493;4262.616364527207;4278.465191851019;4284.464441944757;4313.568643135662;5826.796062137805;6050.969745151334;6056.242969628796;6095.085737139376;6103.755849766048;6110.680268050674;6241.625502469867;6268.4671802896355;6358.554901156875;6359.491240700733;6124.448799608057;6130.969345153246;6137.539684523678;6137.9079313810325;6142.324344322121;5339.305890234323;5346.973265133727;5348.839534813962;5352.411234764173;5373.704446255493;6426.935730642634;6500.057491663777;6505.967470162619;6514.739410423625;6516.446102081376;6379.808605741835;6389;6391.96804015977;6392.840178995376;6400.935990640034;6518.641474718936;6647.567908085959;6650.700718467584;6656.400923916871;6656.866862662623;6056.454919057306;6099.268087829489;6137.96931015342;6141.263048434216;6270.874582508415;6330.841728956813;6345.428911397997;6346.619202847659;6353.52348573868;6354.52341074412;6158.291796443466;6162.537809664383;6166.321704612399;6166.660833654192;6168.907466388097;5951.226340575698;5983.581149319506;6110.511159107172;6115.052166914135;6195.473384762346;6117.3576774439825;6153.507719382528;6169.84575385619;6170.259568851767;6171.228596425447;6215.223097112861;6216.067589861557;6221.471174949999;6230.376962303733;6231.906521402273;5794.855128621818;5804.477597016289;5809.593328466966;5898.380670029585;5906.143609176559 10:31:28 INFO - PROCESS | 28385 | |1;ext.html;748.7828529726377;827.8840962265282;850.0437008365586;919.9540022998848;932.0586207929989;31863.681363186362;32213.19467013323;34319.82840085802;34387.82806085972;34413.827930860374;43591.56408435915;44706.552934470645;44721.552784472144;44822.55177448224;49698.503014969836;8929.776755581113;9042.547872606376;9065.818683626323;9065.909340906606;9067.047959964208;7709.113451953013;7832.686692532292;8932;9023.729288121367;9026.729198124067;10708.78582428351;10884.29252098615;10889.509972051237;10900.236983411165;10901.34591924487;10761.677149685522;10783;10833.83749243762;10840.403777792219;10842.72893177669;10513.053825155772;10574.312669676447;10574.841377379269;10575;10577.894221057768;42633.57366426358;42686.78656606728;42751.14497710028;42836.35745463821;42940.57059429397;4172.374143878412;4217.894552636178;4239.236937351276;4320.438343015419;4359.542248063939;29876.55185172224;29886.85056574703;30149;30215;31227.843860780777;4341.956580434186;4354.521002689701;4419.513853476115;4422.579854913778;4536.296873984537;246826;246967;247089;247183;249775.9999999982;46658.5334146661;47097;47104.7644761774;47155.29267060997;47163;48817.51182488201;48938.26592601114;48956.26565601519;48965.510344896094;48981.75509122503;15897.52307430779;16070.633996110228;16165.757513637305;16210.83789162117;16231.918840405722;14201.573952781433;14252.572422827332;14254.429822807178;14260.643483912778;14276.928615357065;10974.725631859268;11281.774364512663;12095.697607559881;12696.301703406216;13344.5329413472;5284.154535274414;5312.654677445954;5365.812196573102;5431.592630552725;5475.945240547623;1042.2391654092555;1042.5048102151418;1047.5233768635253;1049.4280617063719;1064.6380230721436;28954.42091158207;29208.853955730086;29345.413091738472;29830.40339193204;29906.700932990825;1107.385401102396;1112.6550769261555;1125.8480105185859;1134.461130962786;1146.3866831245243;15031.699366012837;15704.214789260492;15721.528354149394;15726;15902.92048539773;341808;343783;344265;345576;346626;49792.25311620328;50938.23592646113;57616;58534.707326463096;58705.5323616913;1553.2466753624483;1572.0410549564756;1584.3187429405236;1586.8175159856532;1588.5075626555804;27821;31724.841375793898;33137.834310829254;33145;33764.32471350608;48244.27633585569;48779;48790.75604622096;48852.82456640307;48873.511264886896;349140;350862;351957;352282;352440;33529.49705754367;34060.659393405746;34077;34188.658113419544;34341.65658343385;32708.836455817567;32992.83503582467;36889.26221475609;39198.804005979786;40989.77030689084;31561.526577100904;31607.20981975469;31688.841555792074;32001.199970000005;32519.349613007133;31573.52639710452;31634.683653163174;31722.206944826565;31983;32109.233992130656;34901;34963.65036349706;35305.41125649403;35347;35923;29462.558061629523;29837.70162298349;29841.55237671393;29927.401451971273;30408.543871842383;23527;24417.877910610332;24506;24827.255182344557;24839.503209935338 10:31:28 INFO - PROCESS | 28385 | |2;jquery.html;420.26663472240944;458.5093949474062;462.93981782368286;473.7465455981049;486.81501029608745;18911.62176756464;19981;20708.171673133074;20795.68806467904;20861.37415877526;21045.05297261623;21507.56984860302;22558.887205563948;22644.320670379915;22764.430889227777;6446.097546343516;6491.610503369813;6659.766908158215;6679.732810687567;6732.865342693143;6606.339366063403;6705.597664140143;6715.764948226813;6717.966410167943;6719.193696756396;6481.125048118514;6569.572977756455;6608.273089960125;6617.305182955793;6715.764948226813;6479.449246814026;6608.140941677551;6646.501512386566;6697.464202863784;6698.698558564876;6396.648184349859;6445.83885402864;6447.355264473562;6456.160699109133;6456.709448074848;25088.372790680198;25371.619425708628;25630.615540766903;25678.358041048938;25940.35149121268;3150.0077475595112;3192.5051616999403;3200.2159470929773;3200.679932006804;3253.6420993690676;16227.269772860249;16347.59131021734;16353.182340882908;16380.26288817006;16392.426265080783;2267.183813827021;2274.3859158027403;2284.3375421127853;2303.735070466901;2360.3509035015336;116988.41505792501;121815.3909230457;122669.38665306795;123134;125154.37422812919;13950.262464074565;16069.152047514452;17743.467695969142;18352;18768.49852011836;32655.18362040968;32867;32957.67042329594;33025.83487082549;33329.16677083044;10906.672799816019;10972.670819875417;10987.450627468754;11060.281200288391;11073.114150867912;9331.300152488591;9362.672306469378;9392.154706076486;9641.228701703987;9641.710748677551;8995.775105622412;9361.531923403938;9392.154706076486;9594.712158635113;9604.51977401141;3583.874564390234;3643.180284435981;3825.7895815730403;3825.923481530354;3895.1235971906094;969.2391472693902;974.6101559376306;984.5520288268821;987.0918754745651;1000.0699349604937;20930.47673808167;20961.58076838455;21074;21125.471863203235;21220.893895530422;970.7233438470003;973.1533565797802;982.3025651787168;992.3648864726581;995.9302848800514;11015.669529914116;11800.58697945585;11860.525578976916;11883.70290742721;11968.940155299168;676935;708954;719836;737240;742031;106341;106838.46580767202;108509;109551;111302;1269.581038257373;1285.9035572332114;1299.155548893208;1315.1714419915393;1368.2953279061092;14156.646083847987;18116.456506304832;19528.85182629938;19625.214991400186;19841.843268373184;54033.459665404414;54190;54221;54401;54444.45555544552;65386;66529;67060;67788.3221167782;68054;9277.536123193679;12465.626031219077;12554.560590379293;12647.241165530098;12829.679258018625;13764.93117534406;13920.303984800921;14023.929880350533;14311;14396.712065758835;12182.208156469802;12433.689157771129;12530.624081277576;12606.369681516071;12776.10567260283;10141.797164056825;11096.889031109586;11139.10887129044;11221.60724374643;11472.082233421474;12749.808752868528;12956.222626642431;13080.672983175496;13334.133281336683;13349.466021359425;12147.939260303641;12366.44351004189;12450.19073760239;12521.686957826127;12793.360331983178;12228.388580571114;12311;12333.321667308384;12552.874471255536;12673.873261267268 10:31:28 INFO - PROCESS | 28385 | |3;mootools.html;1566.5065504366116;1572.606848287928;1599.312295712843;1616.4100103462235;1622.6673531925956;10917;11617.825732614017;11618.941905290472;11626.883731162687;11627.941860290686;11308.321500709962;11395.202335836495;11583.131265155105;11584.131190160751;11625.534978600866;2423.0671191591186;2461.4707837814867;2462.335169504233;2463.5811911975006;2473.51766405551;2342.156823543523;2409.3013026222375;2446.706395232575;2450.7304196538366;2454.9140780072703;2267.8639281643154;2280.2247235939776;2281.361218858714;2382.5473160099614;2390.8445951013127;2088.8120069193847;2148.2481131603968;2151.698762173297;2155.698202251686;2208.514126892081;2221.9888900555557;2231.8995645196005;2232.586971410294;2241.4732537853592;2242.226431881015;11162.386068766215;11233.550657973672;11247.943760281229;11255.155863310203;11258.380789056599;5923.763049478016;6078.149059131725;6087.421694938974;6089.512838972872;6090.5736598438125;3535.9116022099397;3559.199180184464;3574.4102223133414;3675.44868269759;3832.080300727805;1264.7913094339424;1316.091667082734;1364.911280766747;1370.5545697648304;1457.7959085728007;15135.772963405447;15532.534023979299;16899.831001690072;17961;18190.090495475175;4773.928391074137;4776.068666610047;4922.729249891218;4924;4939.53074457926;13136.737265254642;13142.211467311992;13173;13182.802257966137;13198.868011319764;5114.462981386975;5273.868153296122;5799.18811366409;5938.970305148447;5989.850253743604;5482.616216864782;5539.8892022160135;5622.803201887996;5625.634333768292;5636.070048442043;4158.752867467526;4173.707840451139;4231.217224813419;4266.189424009428;4272.423222864935;1092.0771947704177;1092.1099304067159;1092.4264761000538;1110.3892858927718;1117.1956191542076;1123.5842738186923;1128.351198061118;1144.9885501144881;1152.124385467051;1170.4908364861312;7541.773746787605;7638.809029774189;7756.92243077562;7763.262490063548;7846.607669616496;1055.4511653939908;1068.3803394031443;1076.7415820203096;1090.983635245472;1093.9562417503212;4775.71345719258;4852.80588776445;4890.706557606555;4941.876453088702;5017.67385119966;13468.191908485522;13649.658758531115;14001.089929154572;14006.369713362923;14030.158190508602;13603.931980340036;13761.518346857813;13810.171389716648;13831.654208644663;13856.237906915216;8821.867671984797;10138.087572118544;10305.227107966932;10318.793624127475;10428.217883658755;7092.25531319204;7815.843683126419;7830.530168189927;7836;7947.721829735931;13026.348682566024;13153.868461315264;13423.127496712683;13479.595612131652;13503.662408439475;12823.294718790556;12929.353532323534;13030.934845325713;13282.667933301746;13858.099223550436;9877.30858839903;9975.950120249352;10159.288849780445;10166.745831354276;10174;11554.422278885853;11573.074154067486;11624.476898539755;11627;11639.359835209145;9576.856347154937;9680.225581953568;9754.073363030784;9812.754681133028;9943.453110078726;9486.241100712065;9564.13922746956;9625.51872406391;9642.903570964201;9753;8853.203211710977;8884.244839188483;8927.10728927128;8929.821403572023;8931.464112153291;6753.966230168818;6856.828579285558;6893.482988775962;6905.37851593359;6981.5112942093565;6491.350864913471;6554.967225163844;6626.867462650624;6704.899426508508;6808.251092379934 10:31:28 INFO - PROCESS | 28385 | |4;prototype.html;416.33802254415474;427.80107250128685;438.4979198817354;441.4922838735455;453.9273716205408;5317.867053323664;5356.4911333423315;5370.409254981949;5410.242566040757;5422.810201642943;5111.463296353876;5254.92117618236;5264.315638966938;5291.973540132303;5317.760700768465;4457.924032417638;4460.7323560586465;4466.3747075409465;4466.955330446703;4470.2400591899295;4464.352668863013;4476.932846007313;4486;4486.327050942352;4519.983003824146;4280.159531401496;4431.490378606453;4461.286194208928;4496.168208881351;4506.616937560311;4450.821967121327;4465.709728867613;4470.7317560946285;4499.515159997226;4550.635949124062;4266.954596123969;4273.871783846458;4288.69979101463;4295.6778241632;4300.204462174508;5170.121079416508;5190.351206099238;5202.866824601895;5207.270982062514;5311.150215965427;5141.5886729061585;5148.124818780816;5159.968006398735;5179.559737422323;5218.582513398919;5564.805231816867;5587.463447551915;5594.776208951637;5595.720213989325;5599.992001439739;4548.340490628841;4615.238485649864;4622.791974361162;4665.690483210798;4675.696079754805;5472.452754724496;5581.330240371181;5653.180288858092;5712.714364281769;5776.353739184355;4683.672142949961;4704.388429504143;4723.362346083235;4737.123632128068;4753.691010084333;4553.544645535486;4610.423697037871;4723.692959957661;4796.688215265996;4805.783739731721;5067.239914012927;5073.543381095719;5084.389873215164;5093.490650934877;5109.540141387293;5516.089845175581;5551.361593416808;5560.332760068818;5570.248016517799;5621.18492818539;1594.2985086561876;1648.2253340929983;1656.1719140429784;1663.4427466798759;1664.9833501664828;1274.1526884621808;1285.6785803549112;1296.4230917241925;1298.5261727938857;1300.3238316075588;5474.671519708831;5490.835274941758;5525.254090697705;5542.806001789918;5568.16477528374;5733.48062763368;5736.42635736423;5747.827565173052;5779.2775903012125;5829.047269164877;5270.183121616155;5426.457354264621;5428.67427954324;5438.320209973754;5453.836384908459;2983.731464168235;3000.234940090263;3001.6247969003875;3008.9619081416877;3010.9311194526067;5657.405972372924;5913.438223368773;5933.643981361132;5944.940550594525;5972.940270597325;5828.6502809831545;5829.358770535237;5850.180974663551;5851.648901065864;5859.187589956845;5924.7926322578505;5949.464548190597;5957.642541447441;5960.6721630309885;5969.671668058299;5489.862753431196;5707.4577915098;5708.885822283614;5731.369549349652;5747.4252574742195;5425.782968681208;5429.751157233779;5486.286782718221;5570.5543556516195;5587.832365029056;5878.882422351615;5933.2880054393745;5945.613535120204;5981.355127340016;6008.24896887889;4599.563041511051;4738.393883364067;4769.37684273655;4775.7373344464995;4837.548735379442;5735.36910939788;5769.365369809234;5781.277340332458;5799.739011744566;5831.446012628793;5566.52684521804;5583.939051580187;5586.469285417878;5608.747606357642;5610.747516361856;5305.540976231568;5554.611177217717;5560.805371811967;5597.5521958242425;5608.663480191201;5502.81689436757;5523.337199536081;5529.45645003303;5553.389517040013;5563.276774019351;5387.973060134675;5526.628756458476;5608.635438696471;5618.775248989995;5655.915161272666;5423.945760542344;5427.864303392446;5450.454954504517;5465.836024919259;5505.174223866452 10:31:28 INFO - PROCESS | 28385 | |5;yui.html;810.6676262732277;842.650300125448;883.7658020624534;930.897601263861;937.5406051034995;17228.913855430736;18747.06264686767;18793.718094228596;18822.435326940198;18829.152688129034;15870.12714300716;16434.75347869783;16746.581335466588;16958.152092395394;17010.40463583775;880.9339299552544;908.9636414543444;911.9908800912006;913.0276255787599;913.7030465098836;895.789489469974;897.9595918183664;899.8695189197563;900.0234745301356;900.5587262241487;939.8214339275515;942.0955882352949;942.4675058591907;943.0616536546112;945.6359301668873;935.7099299217265;939.6758118449125;940.1820416237882;940.2900809888524;940.7648087978006;685.1469919949644;691.4537515362857;691.8270432391902;691.9100516932766;692.069166970424;16025.599360016093;16155;16582.50252492427;16730.330786768514;16763.49709508717;14260;14387.280635968264;14721.337539810735;14746;14788.18664973426;12723.10938234324;12879.356032198446;12981.221126732426;13022.283774392405;13396.062275640708;4002.1795531915886;4043.3328500797334;4072.2669919414493;4113.876583702494;4156.04410985472;48071.51928480705;49872.251916221285;53584.464155358335;63052.684736576484;84236;12576.622701318975;14006.43974241019;14009.369578368998;14091.78862317066;14258.429662813578;26133.869330653604;26157;26302.86848565745;26306.86846565755;26479.867600661873;9502.144806967406;9591.664291749756;9728;9737.56180971858;9745.220382369393;5138.3577052868395;5145.922811157836;5204.375474943031;5210.583153347723;5221.242919776611;3643.4899114124046;3692.280005398975;3769.6418840210135;3775.5469343678383;3940.330143875548;631.9241690997018;636.723025483916;643.5623775832386;651.941325280727;653.4282502810041;833.3916241143878;849.7833052571679;853.2619284319019;876.2858270509514;891.6210610490516;11059.612913547988;11788;11823.408829558659;11938;12078.758424831454;844.4173520270994;846.593635055177;847.186700767258;868.465893475508;871.638270117894;5576.553875689935;5633.802816901376;5639.802606908821;5655.80204692842;5685.658860468385;79187;81191.5940420294;82546.58726706328;83729.16270837336;85646;57492;71154.64422677853;73237;74590.25409745942;75266.62366688241;64939.35060649428;67068.66465667641;67996.6600166996;69037;69839.65080174668;10511.159107271553;10793.352398856094;10973.451327433757;11031.724206894893;11036.172287078341;46901.53098469108;47037;47812.760936195096;48106;48231.27653085277;53623;54647.726761365935;55114;56008.15987760105;56959.71520142373;13436.798448023483;13803.17180969145;13986.860131398962;14021.369038393093;14193.219372934587;13960.232187229394;14186.3616137272;14385.640229644903;14494.637634059232;14549.490767823076;13465.798013030007;13748.587542373745;13876.23680697531;14235.35940882642;15394.230288485307;14180.361883715465;14441.277936102942;14571.854281457474;14676.339564719827;15025.398984040954;14054.578362649137;14130.15219086858;14177.929110354382;14288.499902503363;14492.565223043326;9913;10016.499175041074;10096.192304615466;10332.328398654063;10368.688939331832;11033.779324413626;11272.943635281772;11318.830217546578;11354.886451135713;11365.374904380338 10:31:28 INFO - PROCESS | 28385 | __end_tp_report 10:31:28 INFO - PROCESS | 28385 | __start_cc_report 10:31:28 INFO - PROCESS | 28385 | _x_x_mozilla_cycle_collect,1198 10:31:28 INFO - PROCESS | 28385 | __end_cc_report 10:31:28 INFO - PROCESS | 28385 | __startTimestamp1491413488953__endTimestamp 10:31:28 INFO - PROCESS | 28385 | 10:31:28 INFO - PROCESS | 28385 | ------- Summary: start ------- 10:31:28 INFO - PROCESS | 28385 | Number of tests: 6 10:31:28 INFO - PROCESS | 28385 | 10:31:28 INFO - PROCESS | 28385 | [#0] dojo.html Cycles:165 Average:5836.34 Median:6110.51 stddev:670.22 (11.0%) stddev-sans-first:644.43 10:31:28 INFO - PROCESS | 28385 | Values: 3399.1 3425.6 3426.8 3434.5 3471.5 5807.0 5873.1 5887.1 5905.2 5925.1 5891.3 5940.4 5946.4 5947.5 5964.5 5335.3 5339.4 5354.3 5384.8 5462.6 5238.6 5260.6 5436.4 5447.8 5448.1 5291.3 5326.8 5348.3 5356.3 5362.7 5240.2 5244.0 5323.7 5340.0 5359.1 5233.8 5295.7 5320.4 5328.0 5332.1 5772.2 5825.9 5832.8 5864.0 5877.6 6088.9 6118.4 6118.8 6179.0 6218.8 6350.8 6354.8 6372.7 6376.6 6376.9 5866.5 5896.8 5909.6 5920.1 5928.7 6158.7 6190.1 6350.6 6410.4 6457.3 6216.7 6220.0 6222.2 6232.6 6234.6 6321.4 6321.6 6324.1 6327.8 6332.6 5948.8 5978.8 6276.0 6276.7 6334.9 6147.8 6166.7 6167.5 6167.8 6168.2 4652.5 4677.8 4682.3 4736.2 4809.9 4257.8 4262.6 4278.5 4284.5 4313.6 5826.8 6051.0 6056.2 6095.1 6103.8 6110.7 6241.6 6268.5 6358.6 6359.5 6124.4 6131.0 6137.5 6137.9 6142.3 5339.3 5347.0 5348.8 5352.4 5373.7 6426.9 6500.1 6506.0 6514.7 6516.4 6379.8 6389.0 6392.0 6392.8 6400.9 6518.6 6647.6 6650.7 6656.4 6656.9 6056.5 6099.3 6138.0 6141.3 6270.9 6330.8 6345.4 6346.6 6353.5 6354.5 6158.3 6162.5 6166.3 6166.7 6168.9 5951.2 5983.6 6110.5 6115.1 6195.5 6117.4 6153.5 6169.8 6170.3 6171.2 6215.2 6216.1 6221.5 6230.4 6231.9 5794.9 5804.5 5809.6 5898.4 5906.1 10:31:28 INFO - PROCESS | 28385 | 10:31:28 INFO - PROCESS | 28385 | [#1] ext.html Cycles:180 Average:47412.16 Median:33065.33 stddev:83396.34 (252.2%) stddev-sans-first:83556.70 10:31:28 INFO - PROCESS | 28385 | Values: 748.8 827.9 850.0 920.0 932.1 31863.7 32213.2 34319.8 34387.8 34413.8 43591.6 44706.6 44721.6 44822.6 49698.5 8929.8 9042.5 9065.8 9065.9 9067.0 7709.1 7832.7 8932.0 9023.7 9026.7 10708.8 10884.3 10889.5 10900.2 10901.3 10761.7 10783.0 10833.8 10840.4 10842.7 10513.1 10574.3 10574.8 10575.0 10577.9 42633.6 42686.8 42751.1 42836.4 42940.6 4172.4 4217.9 4239.2 4320.4 4359.5 29876.6 29886.9 30149.0 30215.0 31227.8 4342.0 4354.5 4419.5 4422.6 4536.3 246826.0 246967.0 247089.0 247183.0 249776.0 46658.5 47097.0 47104.8 47155.3 47163.0 48817.5 48938.3 48956.3 48965.5 48981.8 15897.5 16070.6 16165.8 16210.8 16231.9 14201.6 14252.6 14254.4 14260.6 14276.9 10974.7 11281.8 12095.7 12696.3 13344.5 5284.2 5312.7 5365.8 5431.6 5475.9 1042.2 1042.5 1047.5 1049.4 1064.6 28954.4 29208.9 29345.4 29830.4 29906.7 1107.4 1112.7 1125.8 1134.5 1146.4 15031.7 15704.2 15721.5 15726.0 15902.9 341808.0 343783.0 344265.0 345576.0 346626.0 49792.3 50938.2 57616.0 58534.7 58705.5 1553.2 1572.0 1584.3 1586.8 1588.5 27821.0 31724.8 33137.8 33145.0 33764.3 48244.3 48779.0 48790.8 48852.8 48873.5 349140.0 350862.0 351957.0 352282.0 352440.0 33529.5 34060.7 34077.0 34188.7 34341.7 32708.8 32992.8 36889.3 39198.8 40989.8 31561.5 31607.2 31688.8 32001.2 32519.3 31573.5 31634.7 31722.2 31983.0 32109.2 34901.0 34963.7 35305.4 35347.0 35923.0 29462.6 29837.7 29841.6 29927.4 30408.5 23527.0 24417.9 24506.0 24827.3 24839.5 10:31:28 INFO - PROCESS | 28385 | 10:31:28 INFO - PROCESS | 28385 | [#2] jquery.html Cycles:180 Average:39367.30 Median:12519.41 stddev:118025.23 (942.7%) stddev-sans-first:118320.09 10:31:28 INFO - PROCESS | 28385 | Values: 420.3 458.5 462.9 473.7 486.8 18911.6 19981.0 20708.2 20795.7 20861.4 21045.1 21507.6 22558.9 22644.3 22764.4 6446.1 6491.6 6659.8 6679.7 6732.9 6606.3 6705.6 6715.8 6718.0 6719.2 6481.1 6569.6 6608.3 6617.3 6715.8 6479.4 6608.1 6646.5 6697.5 6698.7 6396.6 6445.8 6447.4 6456.2 6456.7 25088.4 25371.6 25630.6 25678.4 25940.4 3150.0 3192.5 3200.2 3200.7 3253.6 16227.3 16347.6 16353.2 16380.3 16392.4 2267.2 2274.4 2284.3 2303.7 2360.4 116988.4 121815.4 122669.4 123134.0 125154.4 13950.3 16069.2 17743.5 18352.0 18768.5 32655.2 32867.0 32957.7 33025.8 33329.2 10906.7 10972.7 10987.5 11060.3 11073.1 9331.3 9362.7 9392.2 9641.2 9641.7 8995.8 9361.5 9392.2 9594.7 9604.5 3583.9 3643.2 3825.8 3825.9 3895.1 969.2 974.6 984.6 987.1 1000.1 20930.5 20961.6 21074.0 21125.5 21220.9 970.7 973.2 982.3 992.4 995.9 11015.7 11800.6 11860.5 11883.7 11968.9 676935.0 708954.0 719836.0 737240.0 742031.0 106341.0 106838.5 108509.0 109551.0 111302.0 1269.6 1285.9 1299.2 1315.2 1368.3 14156.6 18116.5 19528.9 19625.2 19841.8 54033.5 54190.0 54221.0 54401.0 54444.5 65386.0 66529.0 67060.0 67788.3 68054.0 9277.5 12465.6 12554.6 12647.2 12829.7 13764.9 13920.3 14023.9 14311.0 14396.7 12182.2 12433.7 12530.6 12606.4 12776.1 10141.8 11096.9 11139.1 11221.6 11472.1 12749.8 12956.2 13080.7 13334.1 13349.5 12147.9 12366.4 12450.2 12521.7 12793.4 12228.4 12311.0 12333.3 12552.9 12673.9 10:31:28 INFO - PROCESS | 28385 | 10:31:28 INFO - PROCESS | 28385 | [#3] mootools.html Cycles:180 Average:7217.79 Median:2241.85 stddev:4513.78 (201.3%) stddev-sans-first:4506.47 10:31:28 INFO - PROCESS | 28385 | Values: 1566.5 1572.6 1599.3 1616.4 1622.7 10917.0 11617.8 11618.9 11626.9 11627.9 11308.3 11395.2 11583.1 11584.1 11625.5 2423.1 2461.5 2462.3 2463.6 2473.5 2342.2 2409.3 2446.7 2450.7 2454.9 2267.9 2280.2 2281.4 2382.5 2390.8 2088.8 2148.2 2151.7 2155.7 2208.5 2222.0 2231.9 2232.6 2241.5 2242.2 11162.4 11233.6 11247.9 11255.2 11258.4 5923.8 6078.1 6087.4 6089.5 6090.6 3535.9 3559.2 3574.4 3675.4 3832.1 1264.8 1316.1 1364.9 1370.6 1457.8 15135.8 15532.5 16899.8 17961.0 18190.1 4773.9 4776.1 4922.7 4924.0 4939.5 13136.7 13142.2 13173.0 13182.8 13198.9 5114.5 5273.9 5799.2 5939.0 5989.9 5482.6 5539.9 5622.8 5625.6 5636.1 4158.8 4173.7 4231.2 4266.2 4272.4 1092.1 1092.1 1092.4 1110.4 1117.2 1123.6 1128.4 1145.0 1152.1 1170.5 7541.8 7638.8 7756.9 7763.3 7846.6 1055.5 1068.4 1076.7 1091.0 1094.0 4775.7 4852.8 4890.7 4941.9 5017.7 13468.2 13649.7 14001.1 14006.4 14030.2 13603.9 13761.5 13810.2 13831.7 13856.2 8821.9 10138.1 10305.2 10318.8 10428.2 7092.3 7815.8 7830.5 7836.0 7947.7 13026.3 13153.9 13423.1 13479.6 13503.7 12823.3 12929.4 13030.9 13282.7 13858.1 9877.3 9976.0 10159.3 10166.7 10174.0 11554.4 11573.1 11624.5 11627.0 11639.4 9576.9 9680.2 9754.1 9812.8 9943.5 9486.2 9564.1 9625.5 9642.9 9753.0 8853.2 8884.2 8927.1 8929.8 8931.5 6754.0 6856.8 6893.5 6905.4 6981.5 6491.4 6555.0 6626.9 6704.9 6808.3 10:31:28 INFO - PROCESS | 28385 | 10:31:28 INFO - PROCESS | 28385 | [#4] prototype.html Cycles:180 Average:4865.34 Median:5399.11 stddev:1291.89 (23.9%) stddev-sans-first:1251.61 10:31:28 INFO - PROCESS | 28385 | Values: 416.3 427.8 438.5 441.5 453.9 5317.9 5356.5 5370.4 5410.2 5422.8 5111.5 5254.9 5264.3 5292.0 5317.8 4457.9 4460.7 4466.4 4467.0 4470.2 4464.4 4476.9 4486.0 4486.3 4520.0 4280.2 4431.5 4461.3 4496.2 4506.6 4450.8 4465.7 4470.7 4499.5 4550.6 4267.0 4273.9 4288.7 4295.7 4300.2 5170.1 5190.4 5202.9 5207.3 5311.2 5141.6 5148.1 5160.0 5179.6 5218.6 5564.8 5587.5 5594.8 5595.7 5600.0 4548.3 4615.2 4622.8 4665.7 4675.7 5472.5 5581.3 5653.2 5712.7 5776.4 4683.7 4704.4 4723.4 4737.1 4753.7 4553.5 4610.4 4723.7 4796.7 4805.8 5067.2 5073.5 5084.4 5093.5 5109.5 5516.1 5551.4 5560.3 5570.2 5621.2 1594.3 1648.2 1656.2 1663.4 1665.0 1274.2 1285.7 1296.4 1298.5 1300.3 5474.7 5490.8 5525.3 5542.8 5568.2 5733.5 5736.4 5747.8 5779.3 5829.0 5270.2 5426.5 5428.7 5438.3 5453.8 2983.7 3000.2 3001.6 3009.0 3010.9 5657.4 5913.4 5933.6 5944.9 5972.9 5828.7 5829.4 5850.2 5851.6 5859.2 5924.8 5949.5 5957.6 5960.7 5969.7 5489.9 5707.5 5708.9 5731.4 5747.4 5425.8 5429.8 5486.3 5570.6 5587.8 5878.9 5933.3 5945.6 5981.4 6008.2 4599.6 4738.4 4769.4 4775.7 4837.5 5735.4 5769.4 5781.3 5799.7 5831.4 5566.5 5583.9 5586.5 5608.7 5610.7 5305.5 5554.6 5560.8 5597.6 5608.7 5502.8 5523.3 5529.5 5553.4 5563.3 5388.0 5526.6 5608.6 5618.8 5655.9 5423.9 5427.9 5450.5 5465.8 5505.2 10:31:28 INFO - PROCESS | 28385 | 10:31:28 INFO - PROCESS | 28385 | [#5] yui.html Cycles:180 Average:18153.92 Median:47424.88 stddev:22072.19 (46.5%) stddev-sans-first:22095.68 10:31:28 INFO - PROCESS | 28385 | Values: 810.7 842.7 883.8 930.9 937.5 17228.9 18747.1 18793.7 18822.4 18829.2 15870.1 16434.8 16746.6 16958.2 17010.4 880.9 909.0 912.0 913.0 913.7 895.8 898.0 899.9 900.0 900.6 939.8 942.1 942.5 943.1 945.6 935.7 939.7 940.2 940.3 940.8 685.1 691.5 691.8 691.9 692.1 16025.6 16155.0 16582.5 16730.3 16763.5 14260.0 14387.3 14721.3 14746.0 14788.2 12723.1 12879.4 12981.2 13022.3 13396.1 4002.2 4043.3 4072.3 4113.9 4156.0 48071.5 49872.3 53584.5 63052.7 84236.0 12576.6 14006.4 14009.4 14091.8 14258.4 26133.9 26157.0 26302.9 26306.9 26479.9 9502.1 9591.7 9728.0 9737.6 9745.2 5138.4 5145.9 5204.4 5210.6 5221.2 3643.5 3692.3 3769.6 3775.5 3940.3 631.9 636.7 643.6 651.9 653.4 833.4 849.8 853.3 876.3 891.6 11059.6 11788.0 11823.4 11938.0 12078.8 844.4 846.6 847.2 868.5 871.6 5576.6 5633.8 5639.8 5655.8 5685.7 79187.0 81191.6 82546.6 83729.2 85646.0 57492.0 71154.6 73237.0 74590.3 75266.6 64939.4 67068.7 67996.7 69037.0 69839.7 10511.2 10793.4 10973.5 11031.7 11036.2 46901.5 47037.0 47812.8 48106.0 48231.3 53623.0 54647.7 55114.0 56008.2 56959.7 13436.8 13803.2 13986.9 14021.4 14193.2 13960.2 14186.4 14385.6 14494.6 14549.5 13465.8 13748.6 13876.2 14235.4 15394.2 14180.4 14441.3 14571.9 14676.3 15025.4 14054.6 14130.2 14177.9 14288.5 14492.6 9913.0 10016.5 10096.2 10332.3 10368.7 11033.8 11272.9 11318.8 11354.9 11365.4 10:31:28 INFO - PROCESS | 28385 | -------- Summary: end -------- 10:31:28 INFO - PROCESS | 28385 | 10:31:29 INFO - TEST-INFO | 28385: exit 0 10:31:29 INFO - TEST-OK | dromaeo_css | took 1115872ms 10:31:29 INFO - TEST-START | kraken 10:31:29 INFO - operating with platform_type : linux_ 10:31:29 INFO - Initialising browser for kraken test... 10:31:29 INFO - TEST-INFO | started process 28713 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVXudcQ/profile http://localhost:54047/getInfo.html) 10:31:33 INFO - PROCESS | 28713 | __metrics Screen width/height:1600/1200 10:31:33 INFO - PROCESS | 28713 | colorDepth:24 10:31:33 INFO - PROCESS | 28713 | Browser inner width/height: 1024/697 10:31:33 INFO - PROCESS | 28713 | __metrics 10:31:34 ERROR - PROCESS | 28713 | 1491413494793 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4954:11 < observe@XPIProvider.jsm:2917:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 10:31:34 INFO - PROCESS | 28713 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:31:34 INFO - PROCESS | 28713 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:31:35 INFO - TEST-INFO | 28713: exit 0 10:31:35 INFO - Browser initialized. 10:31:35 INFO - Running cycle 1/1 for kraken test... 10:31:35 INFO - TEST-INFO | started process 28803 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVXudcQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:31:47 INFO - PROCESS | 28803 | RSS: Main: 139759616 10:31:47 INFO - PROCESS | 28803 | 10:31:50 INFO - PROCESS | 28803 | Cycle 1(1): loaded http://localhost:54047/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54047/tests/kraken/driver.html?testName=audio-beat-detection) 10:31:51 INFO - PROCESS | 28803 | RSS: Main: 184188928 10:31:51 INFO - PROCESS | 28803 | 10:31:53 INFO - PROCESS | 28803 | Cycle 1(1): loaded http://localhost:54047/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54047/tests/kraken/driver.html?testName=audio-dft) 10:31:54 INFO - PROCESS | 28803 | RSS: Main: 174026752 10:31:54 INFO - PROCESS | 28803 | 10:31:57 INFO - PROCESS | 28803 | Cycle 1(1): loaded http://localhost:54047/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54047/tests/kraken/driver.html?testName=audio-fft) 10:31:57 INFO - PROCESS | 28803 | RSS: Main: 265474048 10:31:57 INFO - PROCESS | 28803 | 10:31:59 INFO - PROCESS | 28803 | Cycle 1(1): loaded http://localhost:54047/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54047/tests/kraken/driver.html?testName=audio-oscillator) 10:32:00 INFO - PROCESS | 28803 | RSS: Main: 172027904 10:32:00 INFO - PROCESS | 28803 | 10:32:02 INFO - PROCESS | 28803 | Cycle 1(1): loaded http://localhost:54047/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54047/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:32:03 INFO - PROCESS | 28803 | RSS: Main: 174391296 10:32:03 INFO - PROCESS | 28803 | 10:32:05 INFO - PROCESS | 28803 | Cycle 1(1): loaded http://localhost:54047/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54047/tests/kraken/driver.html?testName=imaging-darkroom) 10:32:06 INFO - PROCESS | 28803 | RSS: Main: 214040576 10:32:06 INFO - PROCESS | 28803 | 10:32:09 INFO - PROCESS | 28803 | Cycle 1(1): loaded http://localhost:54047/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54047/tests/kraken/driver.html?testName=imaging-desaturate) 10:32:10 INFO - PROCESS | 28803 | RSS: Main: 212021248 10:32:10 INFO - PROCESS | 28803 | 10:32:13 INFO - PROCESS | 28803 | Cycle 1(1): loaded http://localhost:54047/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54047/tests/kraken/driver.html?testName=json-parse-financial) 10:32:13 INFO - PROCESS | 28803 | RSS: Main: 210354176 10:32:13 INFO - PROCESS | 28803 | 10:32:15 INFO - PROCESS | 28803 | Cycle 1(1): loaded http://localhost:54047/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54047/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:32:16 INFO - PROCESS | 28803 | RSS: Main: 172912640 10:32:16 INFO - PROCESS | 28803 | 10:32:17 INFO - PROCESS | 28803 | Cycle 1(1): loaded http://localhost:54047/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54047/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:32:18 INFO - PROCESS | 28803 | RSS: Main: 179990528 10:32:18 INFO - PROCESS | 28803 | 10:32:20 INFO - PROCESS | 28803 | Cycle 1(1): loaded http://localhost:54047/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54047/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:32:20 INFO - PROCESS | 28803 | RSS: Main: 189980672 10:32:20 INFO - PROCESS | 28803 | 10:32:23 INFO - PROCESS | 28803 | Cycle 1(1): loaded http://localhost:54047/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54047/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:32:24 INFO - PROCESS | 28803 | RSS: Main: 199143424 10:32:24 INFO - PROCESS | 28803 | 10:32:26 INFO - PROCESS | 28803 | Cycle 1(1): loaded http://localhost:54047/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54047/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:32:27 INFO - PROCESS | 28803 | RSS: Main: 194949120 10:32:27 INFO - PROCESS | 28803 | 10:32:29 INFO - PROCESS | 28803 | Cycle 1(1): loaded http://localhost:54047/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54047/tests/kraken/driver.html?testName=ai-astar) 10:32:29 INFO - PROCESS | 28803 | RSS: Main: 245649408 10:32:29 INFO - PROCESS | 28803 | 10:32:29 INFO - PROCESS | 28803 | __start_tp_report 10:32:29 INFO - PROCESS | 28803 | _x_x_mozilla_page_load 10:32:29 INFO - PROCESS | 28803 | _x_x_mozilla_page_load_details 10:32:29 INFO - PROCESS | 28803 | |i|pagename|runs| 10:32:29 INFO - PROCESS | 28803 | |0;ai-astar;105;112;112;113;111;114;113;114;112;113 10:32:29 INFO - PROCESS | 28803 | |1;audio-beat-detection;137;116;115;153;121;121;117;119;139;116 10:32:29 INFO - PROCESS | 28803 | |2;audio-dft;161;162;161;162;164;162;162;161;161;161 10:32:29 INFO - PROCESS | 28803 | |3;audio-fft;76;75;76;117;76;77;76;77;100;75 10:32:29 INFO - PROCESS | 28803 | |4;audio-oscillator;82;82;106;83;82;83;97;83;82;109 10:32:29 INFO - PROCESS | 28803 | |5;imaging-gaussian-blur;113;113;114;112;113;113;113;113;114;113 10:32:29 INFO - PROCESS | 28803 | |6;imaging-darkroom;147;147;147;146;147;147;146;147;147;146 10:32:29 INFO - PROCESS | 28803 | |7;imaging-desaturate;93;94;95;94;94;93;94;94;94;94 10:32:29 INFO - PROCESS | 28803 | |8;json-parse-financial;53;54;54;54;54;54;56;55;54;55 10:32:29 INFO - PROCESS | 28803 | |9;json-stringify-tinderbox;53;53;54;53;53;53;54;54;54;54 10:32:29 INFO - PROCESS | 28803 | |10;stanford-crypto-aes;79;84;75;76;80;76;76;79;75;79 10:32:29 INFO - PROCESS | 28803 | |11;stanford-crypto-ccm;140;121;120;121;119;119;130;126;156;141 10:32:29 INFO - PROCESS | 28803 | |12;stanford-crypto-pbkdf2;157;160;163;162;160;163;166;164;162;156 10:32:29 INFO - PROCESS | 28803 | |13;stanford-crypto-sha256-iterative;63;64;59;59;66;59;60;59;59;59 10:32:29 INFO - PROCESS | 28803 | __end_tp_report 10:32:29 INFO - PROCESS | 28803 | __start_cc_report 10:32:29 INFO - PROCESS | 28803 | _x_x_mozilla_cycle_collect,1688 10:32:29 INFO - PROCESS | 28803 | __end_cc_report 10:32:29 INFO - PROCESS | 28803 | __startTimestamp1491413549335__endTimestamp 10:32:29 INFO - PROCESS | 28803 | 10:32:29 INFO - PROCESS | 28803 | ------- Summary: start ------- 10:32:29 INFO - PROCESS | 28803 | Number of tests: 14 10:32:29 INFO - PROCESS | 28803 | 10:32:29 INFO - PROCESS | 28803 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:2.60 (2.3%) stddev-sans-first:1.00 10:32:29 INFO - PROCESS | 28803 | Values: 105.0 112.0 112.0 113.0 111.0 114.0 113.0 114.0 112.0 113.0 10:32:29 INFO - PROCESS | 28803 | 10:32:29 INFO - PROCESS | 28803 | [#1] audio-beat-detection Cycles:10 Average:125.40 Median:121.00 stddev:12.98 (10.7%) stddev-sans-first:13.07 10:32:29 INFO - PROCESS | 28803 | Values: 137.0 116.0 115.0 153.0 121.0 121.0 117.0 119.0 139.0 116.0 10:32:29 INFO - PROCESS | 28803 | 10:32:29 INFO - PROCESS | 28803 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 10:32:29 INFO - PROCESS | 28803 | Values: 161.0 162.0 161.0 162.0 164.0 162.0 162.0 161.0 161.0 161.0 10:32:29 INFO - PROCESS | 28803 | 10:32:29 INFO - PROCESS | 28803 | [#3] audio-fft Cycles:10 Average:82.50 Median:76.00 stddev:14.29 (18.8%) stddev-sans-first:14.96 10:32:29 INFO - PROCESS | 28803 | Values: 76.0 75.0 76.0 117.0 76.0 77.0 76.0 77.0 100.0 75.0 10:32:29 INFO - PROCESS | 28803 | 10:32:29 INFO - PROCESS | 28803 | [#4] audio-oscillator Cycles:10 Average:88.90 Median:82.50 stddev:10.84 (13.1%) stddev-sans-first:11.20 10:32:29 INFO - PROCESS | 28803 | Values: 82.0 82.0 106.0 83.0 82.0 83.0 97.0 83.0 82.0 109.0 10:32:29 INFO - PROCESS | 28803 | 10:32:29 INFO - PROCESS | 28803 | [#5] imaging-gaussian-blur Cycles:10 Average:113.10 Median:113.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 10:32:29 INFO - PROCESS | 28803 | Values: 113.0 113.0 114.0 112.0 113.0 113.0 113.0 113.0 114.0 113.0 10:32:29 INFO - PROCESS | 28803 | 10:32:29 INFO - PROCESS | 28803 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 10:32:29 INFO - PROCESS | 28803 | Values: 147.0 147.0 147.0 146.0 147.0 147.0 146.0 147.0 147.0 146.0 10:32:29 INFO - PROCESS | 28803 | 10:32:29 INFO - PROCESS | 28803 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 10:32:29 INFO - PROCESS | 28803 | Values: 93.0 94.0 95.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 10:32:29 INFO - PROCESS | 28803 | 10:32:29 INFO - PROCESS | 28803 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.00 stddev:0.82 (1.5%) stddev-sans-first:0.73 10:32:29 INFO - PROCESS | 28803 | Values: 53.0 54.0 54.0 54.0 54.0 54.0 56.0 55.0 54.0 55.0 10:32:29 INFO - PROCESS | 28803 | 10:32:29 INFO - PROCESS | 28803 | [#9] json-stringify-tinderbox Cycles:10 Average:53.50 Median:54.00 stddev:0.53 (1.0%) stddev-sans-first:0.53 10:32:29 INFO - PROCESS | 28803 | Values: 53.0 53.0 54.0 53.0 53.0 53.0 54.0 54.0 54.0 54.0 10:32:29 INFO - PROCESS | 28803 | 10:32:29 INFO - PROCESS | 28803 | [#10] stanford-crypto-aes Cycles:10 Average:77.90 Median:79.00 stddev:2.85 (3.6%) stddev-sans-first:2.99 10:32:29 INFO - PROCESS | 28803 | Values: 79.0 84.0 75.0 76.0 80.0 76.0 76.0 79.0 75.0 79.0 10:32:29 INFO - PROCESS | 28803 | 10:32:29 INFO - PROCESS | 28803 | [#11] stanford-crypto-ccm Cycles:10 Average:129.30 Median:128.00 stddev:12.53 (9.8%) stddev-sans-first:12.67 10:32:29 INFO - PROCESS | 28803 | Values: 140.0 121.0 120.0 121.0 119.0 119.0 130.0 126.0 156.0 141.0 10:32:29 INFO - PROCESS | 28803 | 10:32:29 INFO - PROCESS | 28803 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.30 Median:162.50 stddev:3.09 (1.9%) stddev-sans-first:2.86 10:32:29 INFO - PROCESS | 28803 | Values: 157.0 160.0 163.0 162.0 160.0 163.0 166.0 164.0 162.0 156.0 10:32:29 INFO - PROCESS | 28803 | 10:32:29 INFO - PROCESS | 28803 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.70 Median:59.50 stddev:2.63 (4.4%) stddev-sans-first:2.65 10:32:29 INFO - PROCESS | 28803 | Values: 63.0 64.0 59.0 59.0 66.0 59.0 60.0 59.0 59.0 59.0 10:32:29 INFO - PROCESS | 28803 | -------- Summary: end -------- 10:32:29 INFO - PROCESS | 28803 | 10:32:30 INFO - TEST-INFO | 28803: exit 0 10:32:30 INFO - TEST-OK | kraken | took 60572ms 10:32:30 INFO - SUITE-END | took 1176s 10:32:30 INFO - Completed test suite (00:19:36) 10:32:30 INFO - javascript benchmark 10:32:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7893.318519472604, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3399.116229780257, 3425.5718035245577, 3426.760126791125, 3434.501997210403, 3471.5486986691726, 5806.983777838877, 5873.119032145175, 5887.087501437273, 5905.173275741395, 5925.051991681332, 5891.263592050994, 5940.435658612436, 5946.405359464052, 5947.524198064155, 5964.493018093456, 5335.279737235472, 5339.439358867302, 5354.27717258171, 5384.7846086156505, 5462.590305727086, 5238.580913526927, 5260.579153667697, 5436.429174936634, 5447.754851031713, 5448.128299472085, 5291.28567643369, 5326.813561525348, 5348.277982472356, 5356.330458692663, 5362.731863406833, 5240.187770895536, 5244.0, 5323.733813309358, 5340.0, 5359.08895487768, 5233.764480598382, 5295.735213239361, 5320.388155362144, 5327.973360133214, 5332.120200166968, 5772.249607550992, 5825.9417405825825, 5832.766689332421, 5864.0, 5877.647341159502, 6088.878222435571, 6118.418750218767, 6118.847028824271, 6179.0, 6218.751249950042, 6350.777722779727, 6354.777582784581, 6372.681365931685, 6376.585521941059, 6376.936230637681, 5866.472017518444, 5896.823095307148, 5909.645421274738, 5920.052791553331, 5928.7332070056955, 6158.661273629904, 6190.102435146879, 6350.587211831308, 6410.415806722797, 6457.2896981332015, 6216.689165541705, 6220.0, 6222.222222222223, 6232.563720539519, 6234.594751341239, 6321.431071203614, 6321.620702757849, 6324.08300796382, 6327.810165695037, 6332.588381755171, 5948.791792287249, 5978.8206353809455, 6275.96862015687, 6276.6547839869245, 6334.936650633527, 6147.784827531104, 6166.7224974876235, 6167.537434692326, 6167.753289868355, 6168.19813424252, 4652.534746525321, 4677.789499472532, 4682.274247491644, 4736.194846876039, 4809.879753006133, 4257.829686812493, 4262.616364527207, 4278.465191851019, 4284.464441944757, 4313.568643135662, 5826.796062137805, 6050.969745151334, 6056.242969628796, 6095.085737139376, 6103.755849766048, 6110.680268050674, 6241.625502469867, 6268.4671802896355, 6358.554901156875, 6359.491240700733, 6124.448799608057, 6130.969345153246, 6137.539684523678, 6137.9079313810325, 6142.324344322121, 5339.305890234323, 5346.973265133727, 5348.839534813962, 5352.411234764173, 5373.704446255493, 6426.935730642634, 6500.057491663777, 6505.967470162619, 6514.739410423625, 6516.446102081376, 6379.808605741835, 6389.0, 6391.96804015977, 6392.840178995376, 6400.935990640034, 6518.641474718936, 6647.567908085959, 6650.700718467584, 6656.400923916871, 6656.866862662623, 6056.454919057306, 6099.268087829489, 6137.96931015342, 6141.263048434216, 6270.874582508415, 6330.841728956813, 6345.428911397997, 6346.619202847659, 6353.52348573868, 6354.52341074412, 6158.291796443466, 6162.537809664383, 6166.321704612399, 6166.660833654192, 6168.907466388097, 5951.226340575698, 5983.581149319506, 6110.511159107172, 6115.052166914135, 6195.473384762346, 6117.3576774439825, 6153.507719382528, 6169.84575385619, 6170.259568851767, 6171.228596425447, 6215.223097112861, 6216.067589861557, 6221.471174949999, 6230.376962303733, 6231.906521402273, 5794.855128621818, 5804.477597016289, 5809.593328466966, 5898.380670029585, 5906.143609176559], "value": 5790.898294550801, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [748.7828529726377, 827.8840962265282, 850.0437008365586, 919.9540022998848, 932.0586207929989, 31863.681363186362, 32213.19467013323, 34319.82840085802, 34387.82806085972, 34413.827930860374, 43591.56408435915, 44706.552934470645, 44721.552784472144, 44822.55177448224, 49698.503014969836, 8929.776755581113, 9042.547872606376, 9065.818683626323, 9065.909340906606, 9067.047959964208, 7709.113451953013, 7832.686692532292, 8932.0, 9023.729288121367, 9026.729198124067, 10708.78582428351, 10884.29252098615, 10889.509972051237, 10900.236983411165, 10901.34591924487, 10761.677149685522, 10783.0, 10833.83749243762, 10840.403777792219, 10842.72893177669, 10513.053825155772, 10574.312669676447, 10574.841377379269, 10575.0, 10577.894221057768, 42633.57366426358, 42686.78656606728, 42751.14497710028, 42836.35745463821, 42940.57059429397, 4172.374143878412, 4217.894552636178, 4239.236937351276, 4320.438343015419, 4359.542248063939, 29876.55185172224, 29886.85056574703, 30149.0, 30215.0, 31227.843860780777, 4341.956580434186, 4354.521002689701, 4419.513853476115, 4422.579854913778, 4536.296873984537, 246826.0, 246967.0, 247089.0, 247183.0, 249775.9999999982, 46658.5334146661, 47097.0, 47104.7644761774, 47155.29267060997, 47163.0, 48817.51182488201, 48938.26592601114, 48956.26565601519, 48965.510344896094, 48981.75509122503, 15897.52307430779, 16070.633996110228, 16165.757513637305, 16210.83789162117, 16231.918840405722, 14201.573952781433, 14252.572422827332, 14254.429822807178, 14260.643483912778, 14276.928615357065, 10974.725631859268, 11281.774364512663, 12095.697607559881, 12696.301703406216, 13344.5329413472, 5284.154535274414, 5312.654677445954, 5365.812196573102, 5431.592630552725, 5475.945240547623, 1042.2391654092555, 1042.5048102151418, 1047.5233768635253, 1049.4280617063719, 1064.6380230721436, 28954.42091158207, 29208.853955730086, 29345.413091738472, 29830.40339193204, 29906.700932990825, 1107.385401102396, 1112.6550769261555, 1125.8480105185859, 1134.461130962786, 1146.3866831245243, 15031.699366012837, 15704.214789260492, 15721.528354149394, 15726.0, 15902.92048539773, 341808.0, 343783.0, 344265.0, 345576.0, 346626.0, 49792.25311620328, 50938.23592646113, 57616.0, 58534.707326463096, 58705.5323616913, 1553.2466753624483, 1572.0410549564756, 1584.3187429405236, 1586.8175159856532, 1588.5075626555804, 27821.0, 31724.841375793898, 33137.834310829254, 33145.0, 33764.32471350608, 48244.27633585569, 48779.0, 48790.75604622096, 48852.82456640307, 48873.511264886896, 349140.0, 350862.0, 351957.0, 352282.0, 352440.0, 33529.49705754367, 34060.659393405746, 34077.0, 34188.658113419544, 34341.65658343385, 32708.836455817567, 32992.83503582467, 36889.26221475609, 39198.804005979786, 40989.77030689084, 31561.526577100904, 31607.20981975469, 31688.841555792074, 32001.199970000005, 32519.349613007133, 31573.52639710452, 31634.683653163174, 31722.206944826565, 31983.0, 32109.233992130656, 34901.0, 34963.65036349706, 35305.41125649403, 35347.0, 35923.0, 29462.558061629523, 29837.70162298349, 29841.55237671393, 29927.401451971273, 30408.543871842383, 23527.0, 24417.877910610332, 24506.0, 24827.255182344557, 24839.503209935338], "value": 18802.00146426073, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [420.26663472240944, 458.5093949474062, 462.93981782368286, 473.7465455981049, 486.81501029608745, 18911.62176756464, 19981.0, 20708.171673133074, 20795.68806467904, 20861.37415877526, 21045.05297261623, 21507.56984860302, 22558.887205563948, 22644.320670379915, 22764.430889227777, 6446.097546343516, 6491.610503369813, 6659.766908158215, 6679.732810687567, 6732.865342693143, 6606.339366063403, 6705.597664140143, 6715.764948226813, 6717.966410167943, 6719.193696756396, 6481.125048118514, 6569.572977756455, 6608.273089960125, 6617.305182955793, 6715.764948226813, 6479.449246814026, 6608.140941677551, 6646.501512386566, 6697.464202863784, 6698.698558564876, 6396.648184349859, 6445.83885402864, 6447.355264473562, 6456.160699109133, 6456.709448074848, 25088.372790680198, 25371.619425708628, 25630.615540766903, 25678.358041048938, 25940.35149121268, 3150.0077475595112, 3192.5051616999403, 3200.2159470929773, 3200.679932006804, 3253.6420993690676, 16227.269772860249, 16347.59131021734, 16353.182340882908, 16380.26288817006, 16392.426265080783, 2267.183813827021, 2274.3859158027403, 2284.3375421127853, 2303.735070466901, 2360.3509035015336, 116988.41505792501, 121815.3909230457, 122669.38665306795, 123134.0, 125154.37422812919, 13950.262464074565, 16069.152047514452, 17743.467695969142, 18352.0, 18768.49852011836, 32655.18362040968, 32867.0, 32957.67042329594, 33025.83487082549, 33329.16677083044, 10906.672799816019, 10972.670819875417, 10987.450627468754, 11060.281200288391, 11073.114150867912, 9331.300152488591, 9362.672306469378, 9392.154706076486, 9641.228701703987, 9641.710748677551, 8995.775105622412, 9361.531923403938, 9392.154706076486, 9594.712158635113, 9604.51977401141, 3583.874564390234, 3643.180284435981, 3825.7895815730403, 3825.923481530354, 3895.1235971906094, 969.2391472693902, 974.6101559376306, 984.5520288268821, 987.0918754745651, 1000.0699349604937, 20930.47673808167, 20961.58076838455, 21074.0, 21125.471863203235, 21220.893895530422, 970.7233438470003, 973.1533565797802, 982.3025651787168, 992.3648864726581, 995.9302848800514, 11015.669529914116, 11800.58697945585, 11860.525578976916, 11883.70290742721, 11968.940155299168, 676935.0, 708954.0, 719836.0, 737240.0, 742031.0, 106341.0, 106838.46580767202, 108509.0, 109551.0, 111302.0, 1269.581038257373, 1285.9035572332114, 1299.155548893208, 1315.1714419915393, 1368.2953279061092, 14156.646083847987, 18116.456506304832, 19528.85182629938, 19625.214991400186, 19841.843268373184, 54033.459665404414, 54190.0, 54221.0, 54401.0, 54444.45555544552, 65386.0, 66529.0, 67060.0, 67788.3221167782, 68054.0, 9277.536123193679, 12465.626031219077, 12554.560590379293, 12647.241165530098, 12829.679258018625, 13764.93117534406, 13920.303984800921, 14023.929880350533, 14311.0, 14396.712065758835, 12182.208156469802, 12433.689157771129, 12530.624081277576, 12606.369681516071, 12776.10567260283, 10141.797164056825, 11096.889031109586, 11139.10887129044, 11221.60724374643, 11472.082233421474, 12749.808752868528, 12956.222626642431, 13080.672983175496, 13334.133281336683, 13349.466021359425, 12147.939260303641, 12366.44351004189, 12450.19073760239, 12521.686957826127, 12793.360331983178, 12228.388580571114, 12311.0, 12333.321667308384, 12552.874471255536, 12673.873261267268], "value": 11492.880464210417, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1566.5065504366116, 1572.606848287928, 1599.312295712843, 1616.4100103462235, 1622.6673531925956, 10917.0, 11617.825732614017, 11618.941905290472, 11626.883731162687, 11627.941860290686, 11308.321500709962, 11395.202335836495, 11583.131265155105, 11584.131190160751, 11625.534978600866, 2423.0671191591186, 2461.4707837814867, 2462.335169504233, 2463.5811911975006, 2473.51766405551, 2342.156823543523, 2409.3013026222375, 2446.706395232575, 2450.7304196538366, 2454.9140780072703, 2267.8639281643154, 2280.2247235939776, 2281.361218858714, 2382.5473160099614, 2390.8445951013127, 2088.8120069193847, 2148.2481131603968, 2151.698762173297, 2155.698202251686, 2208.514126892081, 2221.9888900555557, 2231.8995645196005, 2232.586971410294, 2241.4732537853592, 2242.226431881015, 11162.386068766215, 11233.550657973672, 11247.943760281229, 11255.155863310203, 11258.380789056599, 5923.763049478016, 6078.149059131725, 6087.421694938974, 6089.512838972872, 6090.5736598438125, 3535.9116022099397, 3559.199180184464, 3574.4102223133414, 3675.44868269759, 3832.080300727805, 1264.7913094339424, 1316.091667082734, 1364.911280766747, 1370.5545697648304, 1457.7959085728007, 15135.772963405447, 15532.534023979299, 16899.831001690072, 17961.0, 18190.090495475175, 4773.928391074137, 4776.068666610047, 4922.729249891218, 4924.0, 4939.53074457926, 13136.737265254642, 13142.211467311992, 13173.0, 13182.802257966137, 13198.868011319764, 5114.462981386975, 5273.868153296122, 5799.18811366409, 5938.970305148447, 5989.850253743604, 5482.616216864782, 5539.8892022160135, 5622.803201887996, 5625.634333768292, 5636.070048442043, 4158.752867467526, 4173.707840451139, 4231.217224813419, 4266.189424009428, 4272.423222864935, 1092.0771947704177, 1092.1099304067159, 1092.4264761000538, 1110.3892858927718, 1117.1956191542076, 1123.5842738186923, 1128.351198061118, 1144.9885501144881, 1152.124385467051, 1170.4908364861312, 7541.773746787605, 7638.809029774189, 7756.92243077562, 7763.262490063548, 7846.607669616496, 1055.4511653939908, 1068.3803394031443, 1076.7415820203096, 1090.983635245472, 1093.9562417503212, 4775.71345719258, 4852.80588776445, 4890.706557606555, 4941.876453088702, 5017.67385119966, 13468.191908485522, 13649.658758531115, 14001.089929154572, 14006.369713362923, 14030.158190508602, 13603.931980340036, 13761.518346857813, 13810.171389716648, 13831.654208644663, 13856.237906915216, 8821.867671984797, 10138.087572118544, 10305.227107966932, 10318.793624127475, 10428.217883658755, 7092.25531319204, 7815.843683126419, 7830.530168189927, 7836.0, 7947.721829735931, 13026.348682566024, 13153.868461315264, 13423.127496712683, 13479.595612131652, 13503.662408439475, 12823.294718790556, 12929.353532323534, 13030.934845325713, 13282.667933301746, 13858.099223550436, 9877.30858839903, 9975.950120249352, 10159.288849780445, 10166.745831354276, 10174.0, 11554.422278885853, 11573.074154067486, 11624.476898539755, 11627.0, 11639.359835209145, 9576.856347154937, 9680.225581953568, 9754.073363030784, 9812.754681133028, 9943.453110078726, 9486.241100712065, 9564.13922746956, 9625.51872406391, 9642.903570964201, 9753.0, 8853.203211710977, 8884.244839188483, 8927.10728927128, 8929.821403572023, 8931.464112153291, 6753.966230168818, 6856.828579285558, 6893.482988775962, 6905.37851593359, 6981.5112942093565, 6491.350864913471, 6554.967225163844, 6626.867462650624, 6704.899426508508, 6808.251092379934], "value": 5479.024947121801, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.33802254415474, 427.80107250128685, 438.4979198817354, 441.4922838735455, 453.9273716205408, 5317.867053323664, 5356.4911333423315, 5370.409254981949, 5410.242566040757, 5422.810201642943, 5111.463296353876, 5254.92117618236, 5264.315638966938, 5291.973540132303, 5317.760700768465, 4457.924032417638, 4460.7323560586465, 4466.3747075409465, 4466.955330446703, 4470.2400591899295, 4464.352668863013, 4476.932846007313, 4486.0, 4486.327050942352, 4519.983003824146, 4280.159531401496, 4431.490378606453, 4461.286194208928, 4496.168208881351, 4506.616937560311, 4450.821967121327, 4465.709728867613, 4470.7317560946285, 4499.515159997226, 4550.635949124062, 4266.954596123969, 4273.871783846458, 4288.69979101463, 4295.6778241632, 4300.204462174508, 5170.121079416508, 5190.351206099238, 5202.866824601895, 5207.270982062514, 5311.150215965427, 5141.5886729061585, 5148.124818780816, 5159.968006398735, 5179.559737422323, 5218.582513398919, 5564.805231816867, 5587.463447551915, 5594.776208951637, 5595.720213989325, 5599.992001439739, 4548.340490628841, 4615.238485649864, 4622.791974361162, 4665.690483210798, 4675.696079754805, 5472.452754724496, 5581.330240371181, 5653.180288858092, 5712.714364281769, 5776.353739184355, 4683.672142949961, 4704.388429504143, 4723.362346083235, 4737.123632128068, 4753.691010084333, 4553.544645535486, 4610.423697037871, 4723.692959957661, 4796.688215265996, 4805.783739731721, 5067.239914012927, 5073.543381095719, 5084.389873215164, 5093.490650934877, 5109.540141387293, 5516.089845175581, 5551.361593416808, 5560.332760068818, 5570.248016517799, 5621.18492818539, 1594.2985086561876, 1648.2253340929983, 1656.1719140429784, 1663.4427466798759, 1664.9833501664828, 1274.1526884621808, 1285.6785803549112, 1296.4230917241925, 1298.5261727938857, 1300.3238316075588, 5474.671519708831, 5490.835274941758, 5525.254090697705, 5542.806001789918, 5568.16477528374, 5733.48062763368, 5736.42635736423, 5747.827565173052, 5779.2775903012125, 5829.047269164877, 5270.183121616155, 5426.457354264621, 5428.67427954324, 5438.320209973754, 5453.836384908459, 2983.731464168235, 3000.234940090263, 3001.6247969003875, 3008.9619081416877, 3010.9311194526067, 5657.405972372924, 5913.438223368773, 5933.643981361132, 5944.940550594525, 5972.940270597325, 5828.6502809831545, 5829.358770535237, 5850.180974663551, 5851.648901065864, 5859.187589956845, 5924.7926322578505, 5949.464548190597, 5957.642541447441, 5960.6721630309885, 5969.671668058299, 5489.862753431196, 5707.4577915098, 5708.885822283614, 5731.369549349652, 5747.4252574742195, 5425.782968681208, 5429.751157233779, 5486.286782718221, 5570.5543556516195, 5587.832365029056, 5878.882422351615, 5933.2880054393745, 5945.613535120204, 5981.355127340016, 6008.24896887889, 4599.563041511051, 4738.393883364067, 4769.37684273655, 4775.7373344464995, 4837.548735379442, 5735.36910939788, 5769.365369809234, 5781.277340332458, 5799.739011744566, 5831.446012628793, 5566.52684521804, 5583.939051580187, 5586.469285417878, 5608.747606357642, 5610.747516361856, 5305.540976231568, 5554.611177217717, 5560.805371811967, 5597.5521958242425, 5608.663480191201, 5502.81689436757, 5523.337199536081, 5529.45645003303, 5553.389517040013, 5563.276774019351, 5387.973060134675, 5526.628756458476, 5608.635438696471, 5618.775248989995, 5655.915161272666, 5423.945760542344, 5427.864303392446, 5450.454954504517, 5465.836024919259, 5505.174223866452], "value": 4492.119592778568, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [810.6676262732277, 842.650300125448, 883.7658020624534, 930.897601263861, 937.5406051034995, 17228.913855430736, 18747.06264686767, 18793.718094228596, 18822.435326940198, 18829.152688129034, 15870.12714300716, 16434.75347869783, 16746.581335466588, 16958.152092395394, 17010.40463583775, 880.9339299552544, 908.9636414543444, 911.9908800912006, 913.0276255787599, 913.7030465098836, 895.789489469974, 897.9595918183664, 899.8695189197563, 900.0234745301356, 900.5587262241487, 939.8214339275515, 942.0955882352949, 942.4675058591907, 943.0616536546112, 945.6359301668873, 935.7099299217265, 939.6758118449125, 940.1820416237882, 940.2900809888524, 940.7648087978006, 685.1469919949644, 691.4537515362857, 691.8270432391902, 691.9100516932766, 692.069166970424, 16025.599360016093, 16155.0, 16582.50252492427, 16730.330786768514, 16763.49709508717, 14260.0, 14387.280635968264, 14721.337539810735, 14746.0, 14788.18664973426, 12723.10938234324, 12879.356032198446, 12981.221126732426, 13022.283774392405, 13396.062275640708, 4002.1795531915886, 4043.3328500797334, 4072.2669919414493, 4113.876583702494, 4156.04410985472, 48071.51928480705, 49872.251916221285, 53584.464155358335, 63052.684736576484, 84236.0, 12576.622701318975, 14006.43974241019, 14009.369578368998, 14091.78862317066, 14258.429662813578, 26133.869330653604, 26157.0, 26302.86848565745, 26306.86846565755, 26479.867600661873, 9502.144806967406, 9591.664291749756, 9728.0, 9737.56180971858, 9745.220382369393, 5138.3577052868395, 5145.922811157836, 5204.375474943031, 5210.583153347723, 5221.242919776611, 3643.4899114124046, 3692.280005398975, 3769.6418840210135, 3775.5469343678383, 3940.330143875548, 631.9241690997018, 636.723025483916, 643.5623775832386, 651.941325280727, 653.4282502810041, 833.3916241143878, 849.7833052571679, 853.2619284319019, 876.2858270509514, 891.6210610490516, 11059.612913547988, 11788.0, 11823.408829558659, 11938.0, 12078.758424831454, 844.4173520270994, 846.593635055177, 847.186700767258, 868.465893475508, 871.638270117894, 5576.553875689935, 5633.802816901376, 5639.802606908821, 5655.80204692842, 5685.658860468385, 79187.0, 81191.5940420294, 82546.58726706328, 83729.16270837336, 85646.0, 57492.0, 71154.64422677853, 73237.0, 74590.25409745942, 75266.62366688241, 64939.35060649428, 67068.66465667641, 67996.6600166996, 69037.0, 69839.65080174668, 10511.159107271553, 10793.352398856094, 10973.451327433757, 11031.724206894893, 11036.172287078341, 46901.53098469108, 47037.0, 47812.760936195096, 48106.0, 48231.27653085277, 53623.0, 54647.726761365935, 55114.0, 56008.15987760105, 56959.71520142373, 13436.798448023483, 13803.17180969145, 13986.860131398962, 14021.369038393093, 14193.219372934587, 13960.232187229394, 14186.3616137272, 14385.640229644903, 14494.637634059232, 14549.490767823076, 13465.798013030007, 13748.587542373745, 13876.23680697531, 14235.35940882642, 15394.230288485307, 14180.361883715465, 14441.277936102942, 14571.854281457474, 14676.339564719827, 15025.398984040954, 14054.578362649137, 14130.15219086858, 14177.929110354382, 14288.499902503363, 14492.565223043326, 9913.0, 10016.499175041074, 10096.192304615466, 10332.328398654063, 10368.688939331832, 11033.779324413626, 11272.943635281772, 11318.830217546578, 11354.886451135713, 11365.374904380338], "value": 7852.12616717921, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1461.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 112.0, 113.0, 111.0, 114.0, 113.0, 114.0, 112.0, 113.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 116.0, 115.0, 153.0, 121.0, 121.0, 117.0, 119.0, 139.0, 116.0], "value": 125.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 162.0, 164.0, 162.0, 162.0, 161.0, 161.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 117.0, 76.0, 77.0, 76.0, 77.0, 100.0, 75.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 106.0, 83.0, 82.0, 83.0, 97.0, 83.0, 82.0, 109.0], "value": 88.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 112.0, 113.0, 113.0, 113.0, 113.0, 114.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 146.0, 147.0, 147.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 95.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 54.0, 54.0, 54.0, 56.0, 55.0, 54.0, 55.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 53.0, 53.0, 53.0, 54.0, 54.0, 54.0, 54.0], "value": 53.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 84.0, 75.0, 76.0, 80.0, 76.0, 76.0, 79.0, 75.0, 79.0], "value": 77.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 121.0, 120.0, 121.0, 119.0, 119.0, 130.0, 126.0, 156.0, 141.0], "value": 129.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 160.0, 163.0, 162.0, 160.0, 163.0, 166.0, 164.0, 162.0, 156.0], "value": 161.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 59.0, 59.0, 66.0, 59.0, 60.0, 59.0, 59.0, 59.0], "value": 60.7, "unit": "score"}]}]} 10:32:30 INFO - Return code: 0 10:32:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:32:30 ERROR - # TBPL SUCCESS # 10:32:30 INFO - Running post-action listener: _resource_record_post_action 10:32:30 INFO - [mozharness: 2017-04-05 17:32:30.643556Z] Finished run-tests step (success) 10:32:30 INFO - Running post-run listener: _resource_record_post_run 10:32:30 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 363782144; Read time: 0; Write time: 325732 10:32:30 INFO - TinderboxPrint: CPU usage
13.1% 10:32:30 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 10:32:30 INFO - TinderboxPrint: I/O write bytes / time
363,782,144 / 325,732 10:32:30 INFO - TinderboxPrint: CPU idle
8,269.8 (86.8%) 10:32:30 INFO - TinderboxPrint: CPU user
1,201.8 (12.6%) 10:32:30 INFO - TinderboxPrint: Swap in / out
0 / 0 10:32:30 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 111132672; Read time: 0; Write time: 128160 10:32:30 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 252649472; Read time: 0; Write time: 197572 10:32:31 INFO - Running post-run listener: _upload_blobber_files 10:32:31 INFO - Blob upload gear active. 10:32:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:32:31 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 10:32:31 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'] 10:32:31 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 10:32:31 INFO - (blobuploader) - INFO - Open directory for files ... 10:32:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:32:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:32:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:32:32 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:32:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:32:32 INFO - (blobuploader) - INFO - Done attempting. 10:32:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:32:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:32:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:32:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:32:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:32:35 INFO - (blobuploader) - INFO - Done attempting. 10:32:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:32:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:32:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:32:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:32:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:32:36 INFO - (blobuploader) - INFO - Done attempting. 10:32:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:32:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:32:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:32:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:32:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:32:37 INFO - (blobuploader) - INFO - Done attempting. 10:32:37 INFO - (blobuploader) - INFO - Iteration through files over. 10:32:37 INFO - Return code: 0 10:32:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:32:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:32:37 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6fd9bc027e46e1ce2c760cebc9a5fefc287845a77cddf7867e68785ae0ec6232f5256da384799a668b5bbeab12211d0a6b5b12a20863ec8009f407e7b1c9a59d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6c3f723050129d45a4f0bcbabbe17e1a4a3f6d385e9f71360953a08442e9fde30f5b7a327cb028ead63356e2e68725cf910adda9390fd974578144709f58a315", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/76f6c8df91deee001034091568dc89346d7982fa76f54e2cacddd7da51ea5c02c82adebb6dd856cfded7bb79838e53727ba9002cc09e0b02d8784603223f223a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8193ec34daf81293a2e3cb462d6befd816c5f51600e19c7614c7541c4dac25b46122a99b78fb85a0815a74e45a707b00a90ede08c089f2ce8a4cdc05acca00ff"} 10:32:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:32:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:32:37 INFO - Contents: 10:32:37 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6fd9bc027e46e1ce2c760cebc9a5fefc287845a77cddf7867e68785ae0ec6232f5256da384799a668b5bbeab12211d0a6b5b12a20863ec8009f407e7b1c9a59d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6c3f723050129d45a4f0bcbabbe17e1a4a3f6d385e9f71360953a08442e9fde30f5b7a327cb028ead63356e2e68725cf910adda9390fd974578144709f58a315", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/76f6c8df91deee001034091568dc89346d7982fa76f54e2cacddd7da51ea5c02c82adebb6dd856cfded7bb79838e53727ba9002cc09e0b02d8784603223f223a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8193ec34daf81293a2e3cb462d6befd816c5f51600e19c7614c7541c4dac25b46122a99b78fb85a0815a74e45a707b00a90ede08c089f2ce8a4cdc05acca00ff"} 10:32:37 INFO - Running post-run listener: copy_logs_to_upload_dir 10:32:37 INFO - Copying logs to upload dir... 10:32:37 INFO - mkdir: /builds/slave/test/build/upload/logs 10:32:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.782947 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-04-05 10:32:36.612609) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 10:32:36.618107) ========= 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=fcadb68e09dcf59683000ff6000001dc-1491411124.720911-595787288 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6fd9bc027e46e1ce2c760cebc9a5fefc287845a77cddf7867e68785ae0ec6232f5256da384799a668b5bbeab12211d0a6b5b12a20863ec8009f407e7b1c9a59d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6c3f723050129d45a4f0bcbabbe17e1a4a3f6d385e9f71360953a08442e9fde30f5b7a327cb028ead63356e2e68725cf910adda9390fd974578144709f58a315", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/76f6c8df91deee001034091568dc89346d7982fa76f54e2cacddd7da51ea5c02c82adebb6dd856cfded7bb79838e53727ba9002cc09e0b02d8784603223f223a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8193ec34daf81293a2e3cb462d6befd816c5f51600e19c7614c7541c4dac25b46122a99b78fb85a0815a74e45a707b00a90ede08c089f2ce8a4cdc05acca00ff"} build_url:https://queue.taskcluster.net/v1/task/W_1QANj4QjW8tVgX6f2oKQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011441 build_url: 'https://queue.taskcluster.net/v1/task/W_1QANj4QjW8tVgX6f2oKQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6fd9bc027e46e1ce2c760cebc9a5fefc287845a77cddf7867e68785ae0ec6232f5256da384799a668b5bbeab12211d0a6b5b12a20863ec8009f407e7b1c9a59d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6c3f723050129d45a4f0bcbabbe17e1a4a3f6d385e9f71360953a08442e9fde30f5b7a327cb028ead63356e2e68725cf910adda9390fd974578144709f58a315", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/76f6c8df91deee001034091568dc89346d7982fa76f54e2cacddd7da51ea5c02c82adebb6dd856cfded7bb79838e53727ba9002cc09e0b02d8784603223f223a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8193ec34daf81293a2e3cb462d6befd816c5f51600e19c7614c7541c4dac25b46122a99b78fb85a0815a74e45a707b00a90ede08c089f2ce8a4cdc05acca00ff"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 10:32:36.643116) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 10:32:36.643412) ========= 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=fcadb68e09dcf59683000ff6000001dc-1491411124.720911-595787288 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004591 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 10:32:36.726727) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 10:32:36.727039) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 10:32:36.727327) ========= ========= Total master_lag: 0.15 =========