builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-071 starttime: 1494318863.09 results: success (0) revision: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-09 01:34:23.087190) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-09 01:34:23.087642) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-09 01:34:23.087913) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-09 01:34:23.119894) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 01:34:23.120252) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1494311131.977052-1188296730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-09 01:34:23-- 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% 69.2M=0s 2017-05-09 01:34:23 (69.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.148811 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 01:34:23.283173) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 01:34:23.286500) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1494311131.977052-1188296730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016726 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 01:34:23.338232) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 01:34:23.338543) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 --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 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 --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=dbb0bb31bf4a4c7db9ba1648000001b6-1494311131.977052-1188296730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-09 01:34:24,055 truncating revision to first 12 chars 2017-05-09 01:34:24,055 Setting DEBUG logging. 2017-05-09 01:34:24,055 attempt 1/10 2017-05-09 01:34:24,055 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/94b7e538af7d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-09 01:34:24,420 unpacking tar archive at: mozilla-aurora-94b7e538af7d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.680496 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 01:34:24.037561) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-09 01:34:24.037877) ========= script_repo_revision: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-09 01:34:24.038269) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-09 01:34:24.038562) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-09 01:34:24.048585) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-05-09 01:34:24.048849) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora-Non-PGO'] 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=dbb0bb31bf4a4c7db9ba1648000001b6-1494311131.977052-1188296730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:34:24 INFO - MultiFileLogger online at 20170509 01:34:24 in /builds/slave/test 01:34:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO 01:34:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:34:24 INFO - {'append_to_log': False, 01:34:24 INFO - 'base_work_dir': '/builds/slave/test', 01:34:24 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 01:34:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:34:24 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 01:34:24 INFO - 'buildbot_json_path': 'buildprops.json', 01:34:24 INFO - 'config_files': ('talos/linux_config.py',), 01:34:24 INFO - 'default_actions': ('clobber', 01:34:24 INFO - 'read-buildbot-config', 01:34:24 INFO - 'download-and-extract', 01:34:24 INFO - 'populate-webroot', 01:34:24 INFO - 'create-virtualenv', 01:34:24 INFO - 'install', 01:34:24 INFO - 'run-tests'), 01:34:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:34:24 INFO - 'download_minidump_stackwalk': True, 01:34:24 INFO - 'download_symbols': 'ondemand', 01:34:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:34:24 INFO - 'tooltool.py': '/tools/tooltool.py', 01:34:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:34:24 INFO - '/tools/misc-python/virtualenv.py')}, 01:34:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:34:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:34:24 INFO - 'gecko_profile': False, 01:34:24 INFO - 'gecko_profile_interval': 0, 01:34:24 INFO - 'installer_path': 'installer.exe', 01:34:24 INFO - 'log_level': 'info', 01:34:24 INFO - 'log_name': 'talos', 01:34:24 INFO - 'log_to_console': True, 01:34:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:34:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:34:24 INFO - 'opt_config_files': (), 01:34:24 INFO - 'pip_index': False, 01:34:24 INFO - 'suite': 'dromaeojs', 01:34:24 INFO - 'system_bits': '32', 01:34:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:34:24 INFO - 'title': 'talos-linux64-ix-071', 01:34:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:34:24 INFO - 'use_talos_json': True, 01:34:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:34:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:34:24 INFO - 'work_dir': 'build'} 01:34:24 INFO - [mozharness: 2017-05-09 08:34:24.863777Z] Running clobber step. 01:34:24 INFO - Running pre-action listener: _resource_record_pre_action 01:34:24 INFO - Running main action method: clobber 01:34:24 INFO - rmtree: /builds/slave/test/build 01:34:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:34:26 INFO - Running post-action listener: _resource_record_post_action 01:34:26 INFO - [mozharness: 2017-05-09 08:34:26.310006Z] Finished clobber step (success) 01:34:26 INFO - [mozharness: 2017-05-09 08:34:26.310103Z] Running read-buildbot-config step. 01:34:26 INFO - Running pre-action listener: _resource_record_pre_action 01:34:26 INFO - Running main action method: read_buildbot_config 01:34:26 INFO - Using buildbot properties: 01:34:26 INFO - { 01:34:26 INFO - "project": "", 01:34:26 INFO - "product": "firefox", 01:34:26 INFO - "who": "nobody@mozilla.org", 01:34:26 INFO - "installer_path": "public/build/target.tar.bz2", 01:34:26 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 01:34:26 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora", 01:34:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs", 01:34:26 INFO - "stage_platform": "linux64", 01:34:26 INFO - "basedir": "/builds/slave/test", 01:34:26 INFO - "buildnumber": 138, 01:34:26 INFO - "platform": "ubuntu64_hw", 01:34:26 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:34:26 INFO - "slavebuilddir": "test", 01:34:26 INFO - "taskId": "Yiyk43dlQFKesKhOMF1YBg", 01:34:26 INFO - "branch": "mozilla-aurora", 01:34:26 INFO - "script_repo_revision": "production", 01:34:26 INFO - "revision": "94b7e538af7dbb9a6567cad9125c2f5411e7fb80", 01:34:26 INFO - "slavename": "talos-linux64-ix-071", 01:34:26 INFO - "repo_path": "releases/mozilla-aurora" 01:34:26 INFO - } 01:34:26 INFO - Finding installer, test and symbols from parent task. 01:34:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Yiyk43dlQFKesKhOMF1YBg'}, attempt #1 01:34:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Yiyk43dlQFKesKhOMF1YBg'}, attempt #1 01:34:27 INFO - Task dependencies: ae2r3qMpRiGfgwUKRiA_kw 01:34:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ae2r3qMpRiGfgwUKRiA_kw'}, attempt #1 01:34:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ae2r3qMpRiGfgwUKRiA_kw/artifacts/public/build/target.tar.bz2 01:34:27 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ae2r3qMpRiGfgwUKRiA_kw/artifacts/public/build/test_packages.json 01:34:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ae2r3qMpRiGfgwUKRiA_kw/artifacts/public/build/target.crashreporter-symbols.zip 01:34:27 INFO - Running post-action listener: _resource_record_post_action 01:34:27 INFO - [mozharness: 2017-05-09 08:34:27.823097Z] Finished read-buildbot-config step (success) 01:34:27 INFO - [mozharness: 2017-05-09 08:34:27.823314Z] Running download-and-extract step. 01:34:27 INFO - Running pre-action listener: _resource_record_pre_action 01:34:27 INFO - Running main action method: download_and_extract 01:34:27 INFO - mkdir: /builds/slave/test/build/tests 01:34:27 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')]} 01:34:27 INFO - trying https://queue.taskcluster.net/v1/task/ae2r3qMpRiGfgwUKRiA_kw/artifacts/public/build/target.test_packages.json 01:34:27 INFO - Downloading https://queue.taskcluster.net/v1/task/ae2r3qMpRiGfgwUKRiA_kw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 01:34:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ae2r3qMpRiGfgwUKRiA_kw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 01:34:28 INFO - Downloaded 896 bytes. 01:34:28 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 01:34:28 INFO - Using the following test package requirements: 01:34:28 INFO - {u'common': [u'target.common.tests.zip'], 01:34:28 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 01:34:28 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 01:34:28 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 01:34:28 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 01:34:28 INFO - u'mozbase': [u'target.common.tests.zip'], 01:34:28 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 01:34:28 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 01:34:28 INFO - u'web-platform': [u'target.common.tests.zip', 01:34:28 INFO - u'target.web-platform.tests.zip'], 01:34:28 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 01:34:28 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 01:34:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ae2r3qMpRiGfgwUKRiA_kw/artifacts/public/build/target.common.tests.zip 01:34:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ae2r3qMpRiGfgwUKRiA_kw/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:34:28 INFO - Fetch https://queue.taskcluster.net/v1/task/ae2r3qMpRiGfgwUKRiA_kw/artifacts/public/build/target.common.tests.zip into memory 01:34:30 INFO - Expected file size: 59541078 01:34:30 INFO - Obtained file size: 59541078 01:34:40 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 01:34:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ae2r3qMpRiGfgwUKRiA_kw/artifacts/public/build/target.common.tests.zip 01:34:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ae2r3qMpRiGfgwUKRiA_kw/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:34:40 INFO - Fetch https://queue.taskcluster.net/v1/task/ae2r3qMpRiGfgwUKRiA_kw/artifacts/public/build/target.common.tests.zip into memory 01:34:41 INFO - Expected file size: 59541078 01:34:41 INFO - Obtained file size: 59541078 01:34:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ae2r3qMpRiGfgwUKRiA_kw/artifacts/public/build/target.talos.tests.zip 01:34:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ae2r3qMpRiGfgwUKRiA_kw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 01:34:52 INFO - Fetch https://queue.taskcluster.net/v1/task/ae2r3qMpRiGfgwUKRiA_kw/artifacts/public/build/target.talos.tests.zip into memory 01:34:53 INFO - Expected file size: 14404424 01:34:53 INFO - Obtained file size: 14404424 01:34:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:54 INFO - trying https://queue.taskcluster.net/v1/task/ae2r3qMpRiGfgwUKRiA_kw/artifacts/public/build/target.tar.bz2 01:34:54 INFO - Downloading https://queue.taskcluster.net/v1/task/ae2r3qMpRiGfgwUKRiA_kw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 01:34:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ae2r3qMpRiGfgwUKRiA_kw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 01:34:56 INFO - Downloaded 66794191 bytes. 01:34:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ae2r3qMpRiGfgwUKRiA_kw/artifacts/public/build/target.tar.bz2 01:34:56 INFO - mkdir: /builds/slave/test/properties 01:34:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:34:56 INFO - Writing to file /builds/slave/test/properties/build_url 01:34:56 INFO - Contents: 01:34:56 INFO - build_url:https://queue.taskcluster.net/v1/task/ae2r3qMpRiGfgwUKRiA_kw/artifacts/public/build/target.tar.bz2 01:34:56 INFO - Running post-action listener: _resource_record_post_action 01:34:56 INFO - Running post-action listener: set_extra_try_arguments 01:34:56 INFO - [mozharness: 2017-05-09 08:34:56.317885Z] Finished download-and-extract step (success) 01:34:56 INFO - [mozharness: 2017-05-09 08:34:56.318109Z] Running populate-webroot step. 01:34:56 INFO - Running pre-action listener: _resource_record_pre_action 01:34:56 INFO - Running main action method: populate_webroot 01:34:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:34:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:34:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:34:56 INFO - '--tppagecycles', 01:34:56 INFO - '7'], 01:34:56 INFO - 'tests': ['tsvgm']}}, 01:34:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:34:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:34:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:34:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:34:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:34:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:34:56 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:34:56 INFO - 'talos_options': ['--disable-e10s'], 01:34:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:34:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:34:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:34:56 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:34:56 INFO - 'talos_options': ['--disable-e10s'], 01:34:56 INFO - 'tests': ['damp', 'tps']}, 01:34:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:34:56 INFO - 'tests': ['damp', 'tps']}, 01:34:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:34:56 INFO - 'tests': ['dromaeo_dom']}, 01:34:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:34:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:34:56 INFO - 'tests': ['basic_compositor_video']}, 01:34:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:34:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:34:56 INFO - 'tests': ['a11yr', 01:34:56 INFO - 'ts_paint', 01:34:56 INFO - 'tpaint', 01:34:56 INFO - 'sessionrestore', 01:34:56 INFO - 'sessionrestore_no_auto_restore', 01:34:56 INFO - 'tabpaint']}, 01:34:56 INFO - 'other-e10s': {'tests': ['a11yr', 01:34:56 INFO - 'ts_paint', 01:34:56 INFO - 'tpaint', 01:34:56 INFO - 'sessionrestore', 01:34:56 INFO - 'sessionrestore_no_auto_restore', 01:34:56 INFO - 'tabpaint']}, 01:34:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:34:56 INFO - 'ts_paint', 01:34:56 INFO - 'tpaint', 01:34:56 INFO - 'sessionrestore', 01:34:56 INFO - 'sessionrestore_no_auto_restore', 01:34:56 INFO - 'tabpaint']}, 01:34:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:34:56 INFO - 'ts_paint', 01:34:56 INFO - 'tpaint', 01:34:56 INFO - 'sessionrestore', 01:34:56 INFO - 'sessionrestore_no_auto_restore', 01:34:56 INFO - 'tabpaint']}, 01:34:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:34:56 INFO - 'tests': ['a11yr', 01:34:56 INFO - 'ts_paint', 01:34:56 INFO - 'tpaint', 01:34:56 INFO - 'sessionrestore', 01:34:56 INFO - 'sessionrestore_no_auto_restore', 01:34:56 INFO - 'tabpaint']}, 01:34:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:34:56 INFO - 'tests': ['a11yr', 01:34:56 INFO - 'ts_paint', 01:34:56 INFO - 'tpaint', 01:34:56 INFO - 'sessionrestore', 01:34:56 INFO - 'sessionrestore_no_auto_restore', 01:34:56 INFO - 'tabpaint']}, 01:34:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:34:56 INFO - 'tests': ['tsvgx', 01:34:56 INFO - 'tsvgr_opacity', 01:34:56 INFO - 'tart', 01:34:56 INFO - 'tscrollx', 01:34:56 INFO - 'cart', 01:34:56 INFO - 'tsvg_static']}, 01:34:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:34:56 INFO - 'tsvgr_opacity', 01:34:56 INFO - 'tart', 01:34:56 INFO - 'tscrollx', 01:34:56 INFO - 'cart', 01:34:56 INFO - 'tsvg_static']}, 01:34:56 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:34:56 INFO - 'talos_options': ['--disable-e10s'], 01:34:56 INFO - 'tests': ['tp5o']}, 01:34:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:34:56 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:34:56 INFO - 'talos_options': ['--disable-e10s', 01:34:56 INFO - '--xperf_path', 01:34:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:34:56 INFO - 'tests': ['tp5n']}, 01:34:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:34:56 INFO - 'talos_options': ['--xperf_path', 01:34:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:34:56 INFO - 'tests': ['tp5n']}}, 01:34:56 INFO - 'talos.zip': {'path': '', 01:34:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:34:56 INFO - Running post-action listener: _resource_record_post_action 01:34:56 INFO - [mozharness: 2017-05-09 08:34:56.335273Z] Finished populate-webroot step (success) 01:34:56 INFO - [mozharness: 2017-05-09 08:34:56.335363Z] Running create-virtualenv step. 01:34:56 INFO - Running pre-action listener: _resource_record_pre_action 01:34:56 INFO - Running main action method: create_virtualenv 01:34:56 INFO - Creating virtualenv /builds/slave/test/build/venv 01:34:56 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 01:34:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:34:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:34:56 INFO - Using real prefix '/usr' 01:34:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:34:56 INFO - Installing distribute.............................................................................................................................................................................................done. 01:34:58 INFO - Installing pip.................done. 01:34:58 INFO - Return code: 0 01:34:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:34:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:34:59 INFO - Reading from file tmpfile_stdout 01:34:59 INFO - Output received: 01:34:59 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) 01:34:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:34:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2583a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e3310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e0400>, '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 0x27e13b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e1840>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1494311131.977052-1188296730', '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 01:34:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:34:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:34:59 INFO - Using env: {'DISPLAY': ':0', 01:34:59 INFO - 'HOME': '/home/cltbld', 01:34:59 INFO - 'LANG': 'en_US.UTF-8', 01:34:59 INFO - 'LANGUAGE': 'en_US:en', 01:34:59 INFO - 'LOGNAME': 'cltbld', 01:34:59 INFO - 'MAIL': '/var/mail/cltbld', 01:34:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:59 INFO - 'MOZ_NO_REMOTE': '1', 01:34:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:34:59 INFO - 'NO_EM_RESTART': '1', 01:34:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:34:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:59 INFO - 'PWD': '/builds/slave/test', 01:34:59 INFO - 'SHELL': '/bin/bash', 01:34:59 INFO - 'SHLVL': '1', 01:34:59 INFO - 'TERM': 'linux', 01:34:59 INFO - 'TMOUT': '86400', 01:34:59 INFO - 'USER': 'cltbld', 01:34:59 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1494311131.977052-1188296730', 01:34:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:59 INFO - '_': '/tools/buildbot/bin/python'} 01:34:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:59 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 01:34:59 INFO - Cleaning up... 01:34:59 INFO - Return code: 0 01:34:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:34:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2583a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e3310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e0400>, '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 0x27e13b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e1840>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1494311131.977052-1188296730', '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 01:34:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:34:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:34:59 INFO - Using env: {'DISPLAY': ':0', 01:34:59 INFO - 'HOME': '/home/cltbld', 01:34:59 INFO - 'LANG': 'en_US.UTF-8', 01:34:59 INFO - 'LANGUAGE': 'en_US:en', 01:34:59 INFO - 'LOGNAME': 'cltbld', 01:34:59 INFO - 'MAIL': '/var/mail/cltbld', 01:34:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:59 INFO - 'MOZ_NO_REMOTE': '1', 01:34:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:34:59 INFO - 'NO_EM_RESTART': '1', 01:34:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:34:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:59 INFO - 'PWD': '/builds/slave/test', 01:34:59 INFO - 'SHELL': '/bin/bash', 01:34:59 INFO - 'SHLVL': '1', 01:34:59 INFO - 'TERM': 'linux', 01:34:59 INFO - 'TMOUT': '86400', 01:34:59 INFO - 'USER': 'cltbld', 01:34:59 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1494311131.977052-1188296730', 01:34:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:59 INFO - '_': '/tools/buildbot/bin/python'} 01:34:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:59 INFO - Downloading/unpacking psutil>=3.1.1 01:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:34:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:34:59 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 01:34:59 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 01:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:34:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:35:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:35:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:35:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:35:00 INFO - Installing collected packages: psutil 01:35:00 INFO - Running setup.py install for psutil 01:35:00 INFO - building 'psutil._psutil_linux' extension 01:35:00 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 01:35:01 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 01:35:01 INFO - building 'psutil._psutil_posix' extension 01:35:01 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 01:35:01 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 01:35:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:35:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:35:01 INFO - Successfully installed psutil 01:35:01 INFO - Cleaning up... 01:35:01 INFO - Return code: 0 01:35:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:35:01 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')]} 01:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:35:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:01 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')]} 01:35:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:35:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x25451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2583a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e3310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e0400>, '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 0x27e13b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e1840>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1494311131.977052-1188296730', '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 01:35:01 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 01:35:01 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 01:35:01 INFO - Using env: {'DISPLAY': ':0', 01:35:01 INFO - 'HOME': '/home/cltbld', 01:35:01 INFO - 'LANG': 'en_US.UTF-8', 01:35:01 INFO - 'LANGUAGE': 'en_US:en', 01:35:01 INFO - 'LOGNAME': 'cltbld', 01:35:01 INFO - 'MAIL': '/var/mail/cltbld', 01:35:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:35:01 INFO - 'MOZ_NO_REMOTE': '1', 01:35:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:35:01 INFO - 'NO_EM_RESTART': '1', 01:35:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:35:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:35:01 INFO - 'PWD': '/builds/slave/test', 01:35:01 INFO - 'SHELL': '/bin/bash', 01:35:01 INFO - 'SHLVL': '1', 01:35:01 INFO - 'TERM': 'linux', 01:35:01 INFO - 'TMOUT': '86400', 01:35:01 INFO - 'USER': 'cltbld', 01:35:01 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1494311131.977052-1188296730', 01:35:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:35:01 INFO - '_': '/tools/buildbot/bin/python'} 01:35:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:35:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:35:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:35:01 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 01:35:01 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 01:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:35:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:35:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:35:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:35:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:35:02 INFO - Installing collected packages: mozsystemmonitor 01:35:02 INFO - Running setup.py install for mozsystemmonitor 01:35:02 INFO - Successfully installed mozsystemmonitor 01:35:02 INFO - Cleaning up... 01:35:02 INFO - Return code: 0 01:35:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:35:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:35:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:35:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2583a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e3310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e0400>, '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 0x27e13b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e1840>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1494311131.977052-1188296730', '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 01:35:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:35:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:35:02 INFO - Using env: {'DISPLAY': ':0', 01:35:02 INFO - 'HOME': '/home/cltbld', 01:35:02 INFO - 'LANG': 'en_US.UTF-8', 01:35:02 INFO - 'LANGUAGE': 'en_US:en', 01:35:02 INFO - 'LOGNAME': 'cltbld', 01:35:02 INFO - 'MAIL': '/var/mail/cltbld', 01:35:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:35:02 INFO - 'MOZ_NO_REMOTE': '1', 01:35:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:35:02 INFO - 'NO_EM_RESTART': '1', 01:35:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:35:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:35:02 INFO - 'PWD': '/builds/slave/test', 01:35:02 INFO - 'SHELL': '/bin/bash', 01:35:02 INFO - 'SHLVL': '1', 01:35:02 INFO - 'TERM': 'linux', 01:35:02 INFO - 'TMOUT': '86400', 01:35:02 INFO - 'USER': 'cltbld', 01:35:02 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1494311131.977052-1188296730', 01:35:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:35:02 INFO - '_': '/tools/buildbot/bin/python'} 01:35:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:35:03 INFO - Downloading/unpacking jsonschema==2.5.1 01:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:35:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:35:03 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 01:35:03 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 01:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:35:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:35:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:35:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:35:04 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 01:35:04 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 01:35:04 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 01:35:04 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 01:35:04 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 01:35:04 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 01:35:04 INFO - Downloading functools32-3.2.3-2.tar.gz 01:35:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:35:04 INFO - warning: no files found matching '*.txt' 01:35:04 INFO - no previously-included directories found matching 'build' 01:35:04 INFO - no previously-included directories found matching 'dist' 01:35:04 INFO - no previously-included directories found matching '.git*' 01:35:04 INFO - Installing collected packages: jsonschema, functools32 01:35:04 INFO - Running setup.py install for functools32 01:35:04 INFO - warning: no files found matching '*.txt' 01:35:04 INFO - no previously-included directories found matching 'build' 01:35:04 INFO - no previously-included directories found matching 'dist' 01:35:04 INFO - no previously-included directories found matching '.git*' 01:35:04 INFO - Successfully installed jsonschema functools32 01:35:04 INFO - Cleaning up... 01:35:04 INFO - Return code: 0 01:35:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:35:04 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')]} 01:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:35:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:04 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')]} 01:35:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:35:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:04 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 0x25451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2583a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e3310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e0400>, '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 0x27e13b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e1840>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1494311131.977052-1188296730', '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 01:35:04 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 01:35:04 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 01:35:04 INFO - Using env: {'DISPLAY': ':0', 01:35:04 INFO - 'HOME': '/home/cltbld', 01:35:04 INFO - 'LANG': 'en_US.UTF-8', 01:35:04 INFO - 'LANGUAGE': 'en_US:en', 01:35:04 INFO - 'LOGNAME': 'cltbld', 01:35:04 INFO - 'MAIL': '/var/mail/cltbld', 01:35:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:35:04 INFO - 'MOZ_NO_REMOTE': '1', 01:35:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:35:04 INFO - 'NO_EM_RESTART': '1', 01:35:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:35:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:35:04 INFO - 'PWD': '/builds/slave/test', 01:35:04 INFO - 'SHELL': '/bin/bash', 01:35:04 INFO - 'SHLVL': '1', 01:35:04 INFO - 'TERM': 'linux', 01:35:04 INFO - 'TMOUT': '86400', 01:35:04 INFO - 'USER': 'cltbld', 01:35:04 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1494311131.977052-1188296730', 01:35:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:35:04 INFO - '_': '/tools/buildbot/bin/python'} 01:35:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:35:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:35:04 INFO - Cleaning up... 01:35:04 INFO - Return code: 0 01:35:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:35:04 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')]} 01:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:35:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:04 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')]} 01:35:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:35:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:04 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 0x25451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2583a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e3310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e0400>, '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 0x27e13b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e1840>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1494311131.977052-1188296730', '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 01:35:04 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 01:35:04 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 01:35:04 INFO - Using env: {'DISPLAY': ':0', 01:35:04 INFO - 'HOME': '/home/cltbld', 01:35:04 INFO - 'LANG': 'en_US.UTF-8', 01:35:04 INFO - 'LANGUAGE': 'en_US:en', 01:35:04 INFO - 'LOGNAME': 'cltbld', 01:35:04 INFO - 'MAIL': '/var/mail/cltbld', 01:35:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:35:04 INFO - 'MOZ_NO_REMOTE': '1', 01:35:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:35:04 INFO - 'NO_EM_RESTART': '1', 01:35:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:35:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:35:04 INFO - 'PWD': '/builds/slave/test', 01:35:04 INFO - 'SHELL': '/bin/bash', 01:35:04 INFO - 'SHLVL': '1', 01:35:04 INFO - 'TERM': 'linux', 01:35:04 INFO - 'TMOUT': '86400', 01:35:04 INFO - 'USER': 'cltbld', 01:35:04 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1494311131.977052-1188296730', 01:35:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:35:04 INFO - '_': '/tools/buildbot/bin/python'} 01:35:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:35:05 INFO - Downloading/unpacking blobuploader==1.2.4 01:35:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:35:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:35:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:35:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:35:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:35:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:35:06 INFO - Downloading blobuploader-1.2.4.tar.gz 01:35:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:35:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:35:06 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 01:35:06 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 01:35:06 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 01:35:06 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 01:35:06 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 01:35:06 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 01:35:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:35:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:35:06 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 01:35:06 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 01:35:06 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 01:35:06 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 01:35:06 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 01:35:06 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 01:35:06 INFO - Downloading docopt-0.6.1.tar.gz 01:35:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:35:06 INFO - Installing collected packages: blobuploader, requests, docopt 01:35:06 INFO - Running setup.py install for blobuploader 01:35:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:35:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:35:06 INFO - Running setup.py install for requests 01:35:07 INFO - Running setup.py install for docopt 01:35:07 INFO - Successfully installed blobuploader requests docopt 01:35:07 INFO - Cleaning up... 01:35:07 INFO - Return code: 0 01:35:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:35:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:35:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:35:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:35:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:07 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 0x25451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2583a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e3310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e0400>, '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 0x27e13b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e1840>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1494311131.977052-1188296730', '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 01:35:07 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 01:35:07 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 01:35:07 INFO - Using env: {'DISPLAY': ':0', 01:35:07 INFO - 'HOME': '/home/cltbld', 01:35:07 INFO - 'LANG': 'en_US.UTF-8', 01:35:07 INFO - 'LANGUAGE': 'en_US:en', 01:35:07 INFO - 'LOGNAME': 'cltbld', 01:35:07 INFO - 'MAIL': '/var/mail/cltbld', 01:35:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:35:07 INFO - 'MOZ_NO_REMOTE': '1', 01:35:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:35:07 INFO - 'NO_EM_RESTART': '1', 01:35:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:35:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:35:07 INFO - 'PWD': '/builds/slave/test', 01:35:07 INFO - 'SHELL': '/bin/bash', 01:35:07 INFO - 'SHLVL': '1', 01:35:07 INFO - 'TERM': 'linux', 01:35:07 INFO - 'TMOUT': '86400', 01:35:07 INFO - 'USER': 'cltbld', 01:35:07 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1494311131.977052-1188296730', 01:35:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:35:07 INFO - '_': '/tools/buildbot/bin/python'} 01:35:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:35:07 INFO - Running setup.py (path:/tmp/pip-ykO0XJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:35:07 INFO - Running setup.py (path:/tmp/pip-JDA41O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:35:07 INFO - Running setup.py (path:/tmp/pip-EeTBJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:35:07 INFO - Running setup.py (path:/tmp/pip-TlnTxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:35:07 INFO - Running setup.py (path:/tmp/pip-xdpeFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:35:07 INFO - Running setup.py (path:/tmp/pip-93g_iT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:35:08 INFO - Running setup.py (path:/tmp/pip-Ydvilr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:35:08 INFO - Running setup.py (path:/tmp/pip-4ywVd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:35:08 INFO - Running setup.py (path:/tmp/pip-_NfK2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:35:08 INFO - Running setup.py (path:/tmp/pip-K4zmxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:35:08 INFO - Running setup.py (path:/tmp/pip-ck2gIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:35:08 INFO - Running setup.py (path:/tmp/pip-HK1Uhx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:35:08 INFO - Running setup.py (path:/tmp/pip-d8GqMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:35:08 INFO - Running setup.py (path:/tmp/pip-BPt03g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:35:08 INFO - Running setup.py (path:/tmp/pip-xpM2WD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:35:08 INFO - Running setup.py (path:/tmp/pip-W7WmUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:35:08 INFO - Running setup.py (path:/tmp/pip-EFVPw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:35:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:35:08 INFO - Running setup.py install for manifestparser 01:35:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:35:08 INFO - Running setup.py install for mozcrash 01:35:09 INFO - Running setup.py install for mozdebug 01:35:09 INFO - Running setup.py install for mozdevice 01:35:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:35:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:35:09 INFO - Running setup.py install for mozfile 01:35:09 INFO - Running setup.py install for mozhttpd 01:35:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:35:09 INFO - Running setup.py install for mozinfo 01:35:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:35:09 INFO - Running setup.py install for mozInstall 01:35:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:35:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:35:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:35:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:35:09 INFO - Running setup.py install for mozleak 01:35:09 INFO - Running setup.py install for mozlog 01:35:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:35:09 INFO - Running setup.py install for moznetwork 01:35:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:35:09 INFO - Running setup.py install for mozprocess 01:35:10 INFO - Running setup.py install for mozprofile 01:35:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:35:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:35:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:35:10 INFO - Running setup.py install for mozrunner 01:35:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:35:10 INFO - Running setup.py install for mozscreenshot 01:35:10 INFO - Running setup.py install for moztest 01:35:10 INFO - Running setup.py install for mozversion 01:35:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:35:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:35:10 INFO - Cleaning up... 01:35:10 INFO - Return code: 0 01:35:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:35:10 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')]} 01:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:35:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:10 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')]} 01:35:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:35:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:10 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 0x25451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2583a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e3310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e0400>, '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 0x27e13b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e1840>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1494311131.977052-1188296730', '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 01:35:10 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 01:35:10 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 01:35:10 INFO - Using env: {'DISPLAY': ':0', 01:35:10 INFO - 'HOME': '/home/cltbld', 01:35:10 INFO - 'LANG': 'en_US.UTF-8', 01:35:10 INFO - 'LANGUAGE': 'en_US:en', 01:35:10 INFO - 'LOGNAME': 'cltbld', 01:35:10 INFO - 'MAIL': '/var/mail/cltbld', 01:35:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:35:10 INFO - 'MOZ_NO_REMOTE': '1', 01:35:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:35:10 INFO - 'NO_EM_RESTART': '1', 01:35:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:35:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:35:10 INFO - 'PWD': '/builds/slave/test', 01:35:10 INFO - 'SHELL': '/bin/bash', 01:35:10 INFO - 'SHLVL': '1', 01:35:10 INFO - 'TERM': 'linux', 01:35:10 INFO - 'TMOUT': '86400', 01:35:10 INFO - 'USER': 'cltbld', 01:35:10 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1494311131.977052-1188296730', 01:35:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:35:10 INFO - '_': '/tools/buildbot/bin/python'} 01:35:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:35:10 INFO - Running setup.py (path:/tmp/pip-nqoT9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:35:10 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)) 01:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:35:10 INFO - Running setup.py (path:/tmp/pip-r5vat5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:35:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:35:10 INFO - Running setup.py (path:/tmp/pip-_RqkEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:35:11 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)) 01:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:35:11 INFO - Running setup.py (path:/tmp/pip-dBhDoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:35:11 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)) 01:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:35:11 INFO - Running setup.py (path:/tmp/pip-o4OvRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:35:11 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)) 01:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:35:11 INFO - Running setup.py (path:/tmp/pip-vhkMs7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:35:11 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)) 01:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:35:11 INFO - Running setup.py (path:/tmp/pip-0qOwUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:35:11 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)) 01:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:35:11 INFO - Running setup.py (path:/tmp/pip-rw4Lt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:35:11 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)) 01:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:35:11 INFO - Running setup.py (path:/tmp/pip-y01WGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:35:11 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)) 01:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:35:11 INFO - Running setup.py (path:/tmp/pip-4raVfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:35:11 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)) 01:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:35:11 INFO - Running setup.py (path:/tmp/pip-O3Lz5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:35:11 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)) 01:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:35:11 INFO - Running setup.py (path:/tmp/pip-j8Pz5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:35:11 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)) 01:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:35:11 INFO - Running setup.py (path:/tmp/pip-6xFtsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:35:11 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)) 01:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:35:11 INFO - Running setup.py (path:/tmp/pip-5eV8Cs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:35:11 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)) 01:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:35:11 INFO - Running setup.py (path:/tmp/pip-1cOFhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:35:11 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)) 01:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:35:11 INFO - Running setup.py (path:/tmp/pip-mX2bAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:35:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:35:11 INFO - Running setup.py (path:/tmp/pip-sGtIxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:35:12 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)) 01:35:12 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)) 01:35:12 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)) 01:35:12 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)) 01:35:12 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)) 01:35:12 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)) 01:35:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:35:12 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 01:35:12 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 01:35:12 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 01:35:12 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 01:35:12 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 01:35:12 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 01:35:13 INFO - Downloading blessings-1.6.tar.gz 01:35:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:35:13 INFO - Installing collected packages: blessings 01:35:13 INFO - Running setup.py install for blessings 01:35:13 INFO - Successfully installed blessings 01:35:13 INFO - Cleaning up... 01:35:13 INFO - Return code: 0 01:35:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:35:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:35:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:35:13 INFO - Reading from file tmpfile_stdout 01:35:13 INFO - Current package versions: 01:35:13 INFO - argparse == 1.2.1 01:35:13 INFO - blessings == 1.6 01:35:13 INFO - blobuploader == 1.2.4 01:35:13 INFO - docopt == 0.6.1 01:35:13 INFO - functools32 == 3.2.3-2 01:35:13 INFO - jsonschema == 2.5.1 01:35:13 INFO - manifestparser == 1.1 01:35:13 INFO - mozInstall == 1.12 01:35:13 INFO - mozcrash == 1.0 01:35:13 INFO - mozdebug == 0.1 01:35:13 INFO - mozdevice == 0.49 01:35:13 INFO - mozfile == 1.2 01:35:13 INFO - mozhttpd == 0.7 01:35:13 INFO - mozinfo == 0.9 01:35:13 INFO - mozleak == 0.1 01:35:13 INFO - mozlog == 3.4 01:35:13 INFO - moznetwork == 0.27 01:35:13 INFO - mozprocess == 0.25 01:35:13 INFO - mozprofile == 0.28 01:35:13 INFO - mozrunner == 6.13 01:35:13 INFO - mozscreenshot == 0.1 01:35:13 INFO - mozsystemmonitor == 0.3 01:35:13 INFO - moztest == 0.8 01:35:13 INFO - mozversion == 1.4 01:35:13 INFO - psutil == 3.1.1 01:35:13 INFO - requests == 1.2.3 01:35:13 INFO - wsgiref == 0.1.2 01:35:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:35:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:35:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:35:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:35:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:35:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2583a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e3310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e0400>, '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 0x27e13b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e1840>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1494311131.977052-1188296730', '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 01:35:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 01:35:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:35:13 INFO - Using env: {'DISPLAY': ':0', 01:35:13 INFO - 'HOME': '/home/cltbld', 01:35:13 INFO - 'LANG': 'en_US.UTF-8', 01:35:13 INFO - 'LANGUAGE': 'en_US:en', 01:35:13 INFO - 'LOGNAME': 'cltbld', 01:35:13 INFO - 'MAIL': '/var/mail/cltbld', 01:35:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:35:13 INFO - 'MOZ_NO_REMOTE': '1', 01:35:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:35:13 INFO - 'NO_EM_RESTART': '1', 01:35:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:35:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:35:13 INFO - 'PWD': '/builds/slave/test', 01:35:13 INFO - 'SHELL': '/bin/bash', 01:35:13 INFO - 'SHLVL': '1', 01:35:13 INFO - 'TERM': 'linux', 01:35:13 INFO - 'TMOUT': '86400', 01:35:13 INFO - 'USER': 'cltbld', 01:35:13 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1494311131.977052-1188296730', 01:35:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:35:13 INFO - '_': '/tools/buildbot/bin/python'} 01:35:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:35:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:35:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 01:35:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:35:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:35:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 01:35:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 01:35:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 01:35:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 01:35:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 01:35:13 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:35:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:35:13 INFO - Cleaning up... 01:35:13 INFO - Return code: 0 01:35:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:35:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:35:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:35:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:35:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:35:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2583a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e3310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e0400>, '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 0x27e13b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e1840>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1494311131.977052-1188296730', '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 01:35:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:35:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:35:13 INFO - Using env: {'DISPLAY': ':0', 01:35:13 INFO - 'HOME': '/home/cltbld', 01:35:13 INFO - 'LANG': 'en_US.UTF-8', 01:35:13 INFO - 'LANGUAGE': 'en_US:en', 01:35:13 INFO - 'LOGNAME': 'cltbld', 01:35:13 INFO - 'MAIL': '/var/mail/cltbld', 01:35:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:35:13 INFO - 'MOZ_NO_REMOTE': '1', 01:35:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:35:13 INFO - 'NO_EM_RESTART': '1', 01:35:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:35:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:35:13 INFO - 'PWD': '/builds/slave/test', 01:35:13 INFO - 'SHELL': '/bin/bash', 01:35:13 INFO - 'SHLVL': '1', 01:35:13 INFO - 'TERM': 'linux', 01:35:13 INFO - 'TMOUT': '86400', 01:35:13 INFO - 'USER': 'cltbld', 01:35:13 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1494311131.977052-1188296730', 01:35:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:35:13 INFO - '_': '/tools/buildbot/bin/python'} 01:35:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:35:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:35:14 INFO - Cleaning up... 01:35:14 INFO - Return code: 0 01:35:14 INFO - Running post-action listener: _resource_record_post_action 01:35:14 INFO - Running post-action listener: _start_resource_monitoring 01:35:14 INFO - Starting resource monitoring. 01:35:14 INFO - [mozharness: 2017-05-09 08:35:14.113540Z] Finished create-virtualenv step (success) 01:35:14 INFO - [mozharness: 2017-05-09 08:35:14.114063Z] Running install step. 01:35:14 INFO - Running pre-action listener: _resource_record_pre_action 01:35:14 INFO - Running main action method: install 01:35:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:35:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:35:14 INFO - Reading from file tmpfile_stdout 01:35:14 INFO - Detecting whether we're running mozinstall >=1.0... 01:35:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:35:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:35:14 INFO - Reading from file tmpfile_stdout 01:35:14 INFO - Output received: 01:35:14 INFO - Usage: mozinstall [options] installer 01:35:14 INFO - Options: 01:35:14 INFO - -h, --help show this help message and exit 01:35:14 INFO - -d DEST, --destination=DEST 01:35:14 INFO - Directory to install application into. [default: 01:35:14 INFO - "/builds/slave/test"] 01:35:14 INFO - --app=APP Application being installed. [default: firefox] 01:35:14 INFO - mkdir: /builds/slave/test/build/application 01:35:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:35:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 01:35:30 INFO - Reading from file tmpfile_stdout 01:35:30 INFO - Output received: 01:35:30 INFO - /builds/slave/test/build/application/firefox/firefox 01:35:30 INFO - Running post-action listener: _resource_record_post_action 01:35:30 INFO - [mozharness: 2017-05-09 08:35:30.974244Z] Finished install step (success) 01:35:30 INFO - [mozharness: 2017-05-09 08:35:30.974585Z] Running run-tests step. 01:35:30 INFO - Running pre-action listener: _resource_record_pre_action 01:35:30 INFO - Running main action method: run_tests 01:35:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:35:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:35:30 INFO - Python 2.7.3 01:35:30 INFO - Return code: 0 01:35:30 INFO - grabbing minidump binary from tooltool 01:35:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:35:30 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e0400>, '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 0x27e13b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e1840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:35:30 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:35:30 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 01:35:30 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 01:35:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:35:31 INFO - Return code: 0 01:35:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:35:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:35:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:35:31 INFO - ENV: RUST_BACKTRACE is now 1 01:35:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:35:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:35:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ae2r3qMpRiGfgwUKRiA_kw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-071', '--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 01:35:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ae2r3qMpRiGfgwUKRiA_kw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-071 --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 01:35:31 INFO - Using env: {'DISPLAY': ':0', 01:35:31 INFO - 'HOME': '/home/cltbld', 01:35:31 INFO - 'LANG': 'en_US.UTF-8', 01:35:31 INFO - 'LANGUAGE': 'en_US:en', 01:35:31 INFO - 'LOGNAME': 'cltbld', 01:35:31 INFO - 'MAIL': '/var/mail/cltbld', 01:35:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:35:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:35:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:35:31 INFO - 'MOZ_NO_REMOTE': '1', 01:35:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:35:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:35:31 INFO - 'NO_EM_RESTART': '1', 01:35:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:35:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:35:31 INFO - 'PWD': '/builds/slave/test', 01:35:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:35:31 INFO - 'RUST_BACKTRACE': '1', 01:35:31 INFO - 'SHELL': '/bin/bash', 01:35:31 INFO - 'SHLVL': '1', 01:35:31 INFO - 'TERM': 'linux', 01:35:31 INFO - 'TMOUT': '86400', 01:35:31 INFO - 'USER': 'cltbld', 01:35:31 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1494311131.977052-1188296730', 01:35:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:35:31 INFO - '_': '/tools/buildbot/bin/python'} 01:35:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ae2r3qMpRiGfgwUKRiA_kw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-071', '--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 01:35:31 INFO - mozversion application_buildid: 20170509074737 01:35:31 INFO - mozversion application_changeset: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 01:35:31 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:35:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:35:31 INFO - mozversion application_name: Firefox 01:35:31 INFO - mozversion application_remotingname: firefox-dev 01:35:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:35:31 INFO - mozversion application_vendor: Mozilla 01:35:31 INFO - mozversion application_version: 54.0a2 01:35:31 INFO - mozversion platform_buildid: 20170509074737 01:35:31 INFO - mozversion platform_changeset: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 01:35:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:35:31 INFO - mozversion platform_version: 54.0a2 01:35:31 INFO - using testdate: 1494318931 01:35:31 INFO - actual date: 1494318931 01:35:31 INFO - starting webserver on 'localhost:46306' 01:35:31 INFO - SUITE-START | Running 2 tests 01:35:31 INFO - TEST-START | dromaeo_css 01:35:31 INFO - operating with platform_type : linux_ 01:35:31 INFO - Initialising browser for dromaeo_css test... 01:35:31 INFO - TEST-INFO | started process 9691 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTHv1Eb/profile http://localhost:46306/getInfo.html) 01:35:35 INFO - PROCESS | 9691 | __metrics Screen width/height:1600/1200 01:35:35 INFO - PROCESS | 9691 | colorDepth:24 01:35:35 INFO - PROCESS | 9691 | Browser inner width/height: 1024/697 01:35:35 INFO - PROCESS | 9691 | __metrics 01:35:35 INFO - PROCESS | 9691 | 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" 01:35:35 INFO - PROCESS | 9691 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:35:36 INFO - TEST-INFO | 9691: exit 0 01:35:36 INFO - Browser initialized. 01:35:36 INFO - Running cycle 1/1 for dromaeo_css test... 01:35:36 INFO - TEST-INFO | started process 9779 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTHv1Eb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:35:48 INFO - PROCESS | 9779 | RSS: Main: 140206080 01:35:48 INFO - PROCESS | 9779 | 01:38:50 INFO - PROCESS | 9779 | Cycle 1(1): loaded http://localhost:46306/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46306/tests/dromaeo/cssquery-ext.html) 01:38:51 INFO - PROCESS | 9779 | RSS: Main: 264613888 01:38:51 INFO - PROCESS | 9779 | 01:40:39 INFO - PROCESS | 9779 | ************************* 01:40:39 INFO - PROCESS | 9779 | A coding exception was thrown and uncaught in a Task. 01:40:39 INFO - PROCESS | 9779 | 01:40:39 ERROR - PROCESS | 9779 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:40:39 INFO - PROCESS | 9779 | Full stack: 01:40:39 INFO - PROCESS | 9779 | ************************* 01:40:39 INFO - PROCESS | 9779 | ************************* 01:40:39 INFO - PROCESS | 9779 | A coding exception was thrown and uncaught in a Task. 01:40:39 INFO - PROCESS | 9779 | 01:40:39 ERROR - PROCESS | 9779 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:40:39 INFO - PROCESS | 9779 | Full stack: 01:40:39 INFO - PROCESS | 9779 | ************************* 01:40:39 INFO - PROCESS | 9779 | ************************* 01:40:39 INFO - PROCESS | 9779 | A coding exception was thrown and uncaught in a Task. 01:40:39 INFO - PROCESS | 9779 | 01:40:39 ERROR - PROCESS | 9779 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:40:39 INFO - PROCESS | 9779 | Full stack: 01:40:39 INFO - PROCESS | 9779 | ************************* 01:40:39 INFO - PROCESS | 9779 | ************************* 01:40:39 INFO - PROCESS | 9779 | A coding exception was thrown and uncaught in a Task. 01:40:39 INFO - PROCESS | 9779 | 01:40:39 ERROR - PROCESS | 9779 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:40:39 INFO - PROCESS | 9779 | Full stack: 01:40:39 INFO - PROCESS | 9779 | ************************* 01:41:53 INFO - PROCESS | 9779 | Cycle 1(1): loaded http://localhost:46306/tests/dromaeo/cssquery-ext.html (next: http://localhost:46306/tests/dromaeo/cssquery-jquery.html) 01:41:54 INFO - PROCESS | 9779 | RSS: Main: 220225536 01:41:54 INFO - PROCESS | 9779 | 01:44:56 INFO - PROCESS | 9779 | Cycle 1(1): loaded http://localhost:46306/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46306/tests/dromaeo/cssquery-mootools.html) 01:44:56 INFO - PROCESS | 9779 | RSS: Main: 173568000 01:44:56 INFO - PROCESS | 9779 | 01:47:58 INFO - PROCESS | 9779 | Cycle 1(1): loaded http://localhost:46306/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46306/tests/dromaeo/cssquery-prototype.html) 01:47:59 INFO - PROCESS | 9779 | RSS: Main: 183603200 01:47:59 INFO - PROCESS | 9779 | 01:51:02 INFO - PROCESS | 9779 | Cycle 1(1): loaded http://localhost:46306/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46306/tests/dromaeo/cssquery-yui.html) 01:51:02 INFO - PROCESS | 9779 | RSS: Main: 175075328 01:51:02 INFO - PROCESS | 9779 | 01:54:05 INFO - PROCESS | 9779 | Cycle 1(1): loaded http://localhost:46306/tests/dromaeo/cssquery-yui.html (next: http://localhost:46306/tests/dromaeo/cssquery-dojo.html) 01:54:05 INFO - PROCESS | 9779 | RSS: Main: 267153408 01:54:05 INFO - PROCESS | 9779 | 01:54:05 INFO - PROCESS | 9779 | __start_tp_report 01:54:05 INFO - PROCESS | 9779 | _x_x_mozilla_page_load 01:54:05 INFO - PROCESS | 9779 | _x_x_mozilla_page_load_details 01:54:05 INFO - PROCESS | 9779 | |i|pagename|runs| 01:54:05 INFO - PROCESS | 9779 | |0;dojo.html;3349.129226401136;3390.8135052572106;3391.7117045051154;3400.353932752775;3437.1235334989574;5582.9999999999945;5625.4093320201355;5655.7172141392975;5660.575456840738;5675.148727690848;5688.402717714643;5730.541556675456;5748.798792042279;5755.0504166812425;5804.448577385152;5081.187010078379;5084.567811736007;5111.386633603955;5147.356580427447;5182.637215394924;4976.3530741003615;5164.535191832734;5164.845054648366;5169.612279079065;5187.533122019017;5003.849884503453;5009.998000399934;5032.672876263049;5109.667871588354;5121.28302037715;5116.692998420088;5133.255677926717;5136.64043516954;5139.7687104080405;5144.228365745131;5009.674371165863;5045.369328833895;5107.3105130807235;5121.078205922932;5145.536901678867;5455.672659640394;5511.944880551183;5532.30846144232;5599.440055994409;5613.46672066153;6053.848653783691;6079.817605471843;6089.360617135181;6090.36051214625;6115.205023346936;6116.327204007555;6130.785422510236;6135.478484328837;6136;6137.631742095488;5547.417521160301;5583.58123140762;5648.6610803351105;5678.4605462480995;5734.254546908875;6231.345708700521;6242.438180563771;6244.7814326499265;6254.186955695731;6254.593451425734;5949.405059494016;5976.402359763989;5986.042233242661;5993.580449368503;6005.099235114768;5850.795222167204;5880.617759845596;5943.881122377528;6052.636841789506;6087.3303936566945;6014.939850601526;6019.398060194033;6039.486643635252;6044.153818465418;6049.5462840287155;5848.707564621837;5874.618149820248;5881.617694849821;6031.035034394476;6039.396060394013;4545.863624091283;4570.291604801261;4606.055758569552;4610.700304480265;4639.9536004640195;4113.074558224435;4153.937690934638;4166.979165104155;4173.207090652766;4212.789360531961;5708.914366284509;5758.136279558016;5824.446677565625;5837.416258374214;5929.347771745104;6125.203723515914;6135.630783975157;6136.580349164101;6139.492138333381;6139.676133582418;5893.675847828411;5903.173555702119;5904.7342869570975;5911.881762364815;5930.762769489258;5017.247412888096;5052.621053420935;5074.898502030012;5171.974140129275;5178.766955487012;6338.271098823602;6340.397662222082;6348.77779277723;6352.745890164527;6356.046593011085;6025.758969641341;6069.666168360783;6070.9089363658695;6074.240719910012;6080.847978800565;6143.481172719164;6277.058441233851;6339.714712838026;6343.52423568225;6351.269603995414;5948.613340132878;5949.434803693643;5959.67221802805;6059.182010428536;6064.423879731418;6119.724612392542;6125.295591006913;6128.816135515942;6137.048757442603;6137.355577664281;5917.437843404869;5967.9701601491715;5968.552358573038;5968.641881487125;5972.611780234271;5796.565257605781;5830.416958304136;5857.238558987305;5864.648121112747;5921.7631294747725;5929.970350148222;5930.9110363343725;5940.673262970578;5942.494887934401;5957.374475680164;5813.56398270123;5848.239728835224;5930.673812940329;5968.582199246011;5980.37206093354;5778.479936805707;5805.970970145122;5885.176075349369;5912.320083190488;5917.911231331447 01:54:05 INFO - PROCESS | 9779 | |1;ext.html;767.3285874859498;828.950262984221;850.0988951711184;914.7027216154752;925.5557332480405;30224.697753022465;42402;42989;43087.56912430875;43298;43431.348529772076;43441.56558434415;43610.34584481228;43646.56353436465;44044.77977610115;7595.43034272429;7756.0692716874055;8701.347398945089;8810.471371717686;8816.955915220447;10438.947805260963;10688.519016644232;10845;10854.67435976922;10960.56157753689;10794.676159715222;10832.350058996486;10834.891651083506;10836.458177091154;10847.294925829836;10693.144548436107;10703.143748500179;10732.570697172103;10746.979036991512;10764.784704305948;10485.161187105014;10543.683689489328;10560.683179504627;10568.630097946534;10580.259381843274;42565.574344256784;42630.1473970522;42967.14065718668;43007.56992430098;43036.354454683205;4165.770882601456;4182.519010313822;4206.3690446432975;4292.205941900727;4315.892102697427;30069.9475518358;30105.69894301051;30290.242743931358;30563.388732225452;31389.686103138905;4281.400603915455;4330.935035974463;4342.413774140482;4398.252297109499;4456.844010459651;245010;245030;245418;245450.7727461369;246384;45601.54398455973;45685.543144568794;45729.54270457253;45744.77127614341;45836.08327833425;47727;47821.5217847824;47947;48013.279800803015;48015.75992120017;15239.390424383122;15535.06789592628;15536.145511996949;15546.455874044354;15597.064176149468;11919.463624136935;12158.817617735742;13496.797548036788;13499.122557033761;13543.729125417436;11497.942510287396;11581.652550423501;11603.245789023686;12453.377331133406;12932.353382330846;5373.077653313026;5377.085895397791;5446.509814116669;5470.863228419242;5529.889402211933;982.2044144243185;985.9556319965619;990.3562684255292;992.925530585209;1005.4821766790109;28136.577951330746;28458.857705711755;28525;28680.139595811743;28929.710702892702;1047.7537778622018;1052.821020426514;1061.2412125330425;1072.4584085037006;1095.315427857589;14870.256487175599;14950.626234344229;15250.618734531725;15290.235488225544;15328.540143795704;163328;164658;349702;350845;352364;56642.716786416626;57993.13010304849;58116.70941645265;58137.41862581405;58153.70923145442;1477.4976507987121;1483.1397789282405;1511.2292730707418;1518.324345666168;1519.5733620685285;26519.33701657397;27553;27825.721742782313;28025;28107.297317567223;43360.78319608508;43402.565974341116;43522.78238608914;43577.56422435862;43613.34579981239;316803;317090;317903;319171;319906;32165.391730413852;32513.187170320933;32825.67174328226;32843;32852.835735821165;35703;36257;41069.1786164281;43571.78214108909;43602.78198609113;34165.829170853984;34458.655413445544;34505;34507.30985380329;35086.82456587701;33869.32261354809;34471.31057378888;34476.31047379089;34492;35195.82402087973;29104.41791164207;29117.85441072781;29123;29139.12582622525;32665.836670816494;32759.508607370433;33027.83486082554;33137.834310829254;33809.66190338164;34128.829355853064;25965.48069038571;26548;26867.596986044835;26941.730582693923;27090.1872943812 01:54:05 INFO - PROCESS | 9779 | |2;jquery.html;429.7280051048894;430.3093534876521;438.9934150987736;452.4344569288389;455.95668411500895;19672.311469098586;20813.27153549626;21232.04455799489;21315.147394104217;21528.677069843965;21307.467313317175;22560.887195564;22607.095716171334;22801.54396912061;22860.08559657616;6561.409473147416;6589.80230593083;6875.621840798754;6883.414909732679;6885;6654.9334506654795;6731.259561448237;6768.7630932917355;6772.661366931658;6776.661166941658;6457.8708425831455;6694.59832410057;6734.158230221223;6770.289119642441;6798.626075565842;6538.574992625512;6709.228438729536;6797.490188235902;6808.523403361766;6811.080504131928;6500.05749166373;6548.607083575001;6571.080048793173;6576.0793488911595;6577.572457790228;25404.618930716053;25850.870745646338;25959.870200648875;26003.869980650165;26480.73519264802;3617.602063772983;3638.3450978823803;3648.562172539312;3744.850205991757;3780.168362960172;15236.847631523653;15560.144192069432;15709.52871413848;16005.759913601305;16037.759433608506;2206.1947389202987;2237;2308.1575225042907;2310.4108452344544;2333.3933177373833;115829.42085289604;117521;117727.41136294349;118165;118963;17131.828681713272;17361.2178232055;17715.29138834458;17902.46292611224;18175.273708943765;31734;31770.36459270848;31798.682013180034;31806.363872722417;31947.680523194937;10354.948225258826;10473.528691208914;10550.788984220273;10563.735906602396;10766.623168189075;8766.99179594342;8786.341024423195;8855.822883542292;8885.333599979898;8912.509811960404;9108.635654573874;9330.160285574195;9432.245420366355;9529.90470095304;9662.661806836726;3497.3180229854934;3886.1839013807416;3947.3289840448083;3951.4467974483596;3982.7411218270718;1132.5016992523263;1145.2212495503138;1148.9266212880511;1151.6890439581434;1198.3528894396927;20390.388288351372;20553.38339849807;20672.17311307561;20704.48238794012;20833.58332833335;1151.6257216404701;1158.9942050289694;1183.3491579631168;1183.5147589488267;1186.6973921649924;11008.174386920853;11354.545818167346;11408.315501069963;11435.199536032398;11521.769564608661;621656;624319;634668;641272;642186;100767;106262;119965.40017299858;124047;126668;1264.1972347559183;1298.1886321049344;1321.0658191654163;1324.860889606616;1326.8655299718603;19168.329108481135;19358;19421.51446213856;19649.214031438583;19655;49710.75144624254;50159.24761128513;51529;52441.213381800066;52568.737156313975;69001.65499172472;69567.65216173886;69854.30145698477;70740;71577.64211178912;10533.894661053291;11979.28124312544;12103.697407564881;12150.878491214975;12293.56972505958;14194.3612537434;14225.502107426604;14237.21695306768;14328.928355358157;14345.64135896611;11169.664910052712;11291.153163512605;11315.151363647594;11331.603393881174;12587.93706031464;11717.00405465545;11777.941110294736;11819.881801181878;11867.228630139014;11947.76104477923;11623.825642615537;12418.316992565495;12473;12544.686382840137;12680.873191267969;11856.347900865536;11917.165798394375;12038.398080096134;12097.879021209676;12366.072544559014;12406.875931240573;12436.937815310866;12437.63186049552;12450.937745311216;12821.487140514275 01:54:05 INFO - PROCESS | 9779 | |3;mootools.html;1400.5658245943753;1529.220097750147;1534.3172288331689;1541.437375357994;1561.4925149326468;9063.456192628448;10875.728106797334;11185.888141118596;11497.080233581315;11518.308901465918;11079.778404431907;11190.272632278897;11200.103991680666;11203.887961120387;11216.439178041086;1969.812867777566;2027.5843452092286;2335.100986120339;2367.775061369176;2368.3368656776042;2254.537819746948;2336.6611841283;2339.830084957521;2341.625339945609;2357.033616217351;2357.929262122139;2373.92878213653;2377.0491803278655;2384.4873352229265;2384.558856611524;2362.574736547421;2369.893354799021;2380.1788383007834;2381.3332266965276;2384.237044145865;2196.5497073100137;2233.6314508106143;2234.441389652587;2237.8209743220505;2238.250186187629;11016.834747478793;11038.44807759617;11123.332600044023;11130.777384452347;11131.276467029616;5590.357108932484;5700.059490184115;5728.398518155617;5736.024875771129;5740.08158694611;3068.2482791715947;3268.1339445047083;3338.1821453743746;3346.3641908037393;3348.68187522185;1262.8421447319085;1293.95471158509;1337.9464821407132;1343.2880573296168;1412.2867951684334;16599.83400165995;16604.83395166045;16705.498835034967;16728.916355418143;16743.748843767353;4494.10117976406;4706.435227772689;4730.858074257778;4740.715557066587;4771.6898401603785;13815.240161790996;13853.653658658613;13947.302634868216;13956.581302560939;13973.231472268919;5687.260656114679;5753.626014309057;5780.971095144498;5792.913106303409;5799.739011744482;5303.806643505258;5305.973470132702;5377.193420986805;5379.757910894019;5386.434424385383;4108.627120923119;4171.770552619574;4180.163967206571;4248.851290204828;4356.738595684269;1073.8603981482513;1073.8926107389354;1073.9248252622242;1075.2365820267541;1094.6497120921229;989.8267803134422;1021.7649940513724;1028.4395004722444;1035.29082578434;1036.486938965217;6779.898301525481;6810.897836532456;6816.07982922309;6864.176298844171;6872.175338959257;993.6684842311194;1020.7703266764919;1030.1810061001522;1040.6669865643073;1057.0856209378985;4428.114377124588;4455.799489023002;4462.1075784842515;4469.865904022885;4472.552744725566;13490.258035808125;13674.863251367558;14280.214588197749;14779.778303325458;14838.777418338734;13917.791233131511;14175.716485670435;14203.076800007966;14241.359138838778;14315.284235788376;10541.20940929418;10662.573497060186;10693.251472396858;10797.244192906579;10854.240203185858;7273.709051637875;7432.739854105081;7568.091828980558;7580.810479738051;7690;12999.220046797222;13132.27772472485;13159.53941612039;13481.528146514825;13516.6620834476;11006.559737610405;13557.864421356055;13566.728665426834;13571.253581053137;13667.521636742666;8704.34717396185;9503.572339244613;9545.856812147684;9556.665516706882;9820.852687209841;10358.274920755475;10751.6236931707;10964.56141754321;11060.225784195029;11113.888861111285;8934.240589549701;8968.68609598661;8981.416207946462;9141.77145571366;9176.44941303524;8614.913850861662;8691.261242794433;8697.652093916426;8763.3427492937;8821.823563528566;8197.098319184766;8331.541765202972;8341.95829020851;8344.791380215544;8354.707585234488;6382.712777925098;6410.8076757697345;6490.967545162244;6491.1236983008575;6588.868222635425;6402.487800976004;6469.353064693493;6528.183977002875;6582.111414958919;6616.040674102324 01:54:05 INFO - PROCESS | 9779 | |4;prototype.html;392.10304468014215;395.4049156020191;412.29497559173814;416.084613849531;424.82747616578246;5134.332536770219;5160.690358578488;5177.352830896138;5200.817971371008;5238.947610523894;5073.5941124710025;5088.338515992925;5100.387953445583;5102.234664800282;5121.923171152435;4222.30331995222;4301.333293339538;4333.328334108218;4342.869713908572;4347.500037495681;4189.387085971893;4309.267424537836;4312.611864932155;4323.567643235683;4353.41228934093;4259.2546304396765;4266.424032755584;4286.271333873249;4292.914141717164;4336;4252.468441444819;4293.8711838644895;4294.742315461067;4317.438732964694;4324.8053837577545;4066.2680717470844;4095.9795201024103;4116.91766164678;4117.732347397409;4118.929078439627;4829.299751536043;5028.949710502885;5038.697678139287;5069.662921348315;5096.719680417576;5054.21659642756;5068.619853510964;5070.4929507049;5094.936550696973;5147.845564633029;5199.6480914962;5471.23402723619;5512.80705175317;5515.779368825242;5542.944570554324;4501.842435514741;4510.594046535827;4537.820166756667;4545.613622842029;4547.431571053618;5457.290552228224;5526.50261476465;5574.665520068809;5675.772969081232;5684.4315568443235;4596.218642830727;4602.744655119034;4607.838725644587;4643.95356046442;4690.882727931829;4726.692764970266;4763.571278584875;4777.546133117348;4779.259214821708;4781.665283430196;4888.120138375056;4952.90094198114;5013.222950442687;5077.923831142536;5084.923726144111;5415.593830462731;5427.864303392446;5449.100898351807;5459.017376872202;5484.120836560837;1635.6565121324418;1655.180685560655;1663.7421199714063;1671.5988162840831;1683.3098429643787;1240.4916316434428;1269.6698858296909;1285.2673975833873;1296.9365120601205;1297.5208262580666;5305;5318.601104917147;5375.19372094189;5392.73270781366;5453.400125986138;5630.85922851932;5640.238567793377;5649.039663257174;5659.688717120598;5661.631993920382;5251.343582052244;5296.3379577552805;5340.95851308991;5389.703566303812;5414.269073675004;2957.364166704169;2960.5411161270035;2968.2282606522026;2977.0473448496273;2993.1768763589753;5694.288213973254;5893.381194974551;5899.941000590025;5925.496332811759;5949.315828679671;5706.885862282731;5721;5756.30924289088;5766.462756387176;5822.534197264209;5863.824085277449;5885.823425297248;5891.7054147292465;5946.494547963472;5972.492338151305;5347.331583552056;5570.275864137636;5577;5597.468240517144;5617.4101719320515;5333.386660534088;5557.194206840067;5557.583181261502;5564.415736347625;5601.495865372136;5689.573282003784;5697.800576979786;5847.245826252192;5852.8294341131095;5853.795117170878;4600.953990460052;4618.168729628699;4665.510121437336;4694.248920172756;4694.971743225532;5386.407495175606;5544.861378465571;5592.720363981866;5630.465105814941;5650.802221922213;5399;5406.378266499403;5420.593455490775;5443.537299329443;5458.263134476795;5486.369067557282;5486.835394938158;5539.556835453073;5540.944590554042;5551.945780061403;5259.60552958522;5403.675779453245;5463.863403414787;5490.231367608458;5515.538382328606;5473.261109750133;5475.780968761205;5516.862078448071;5519.586031047607;5525.640833345819;5132.923006154836;5291.894162116659;5323.281357016753;5389.83830485086;5423.349198096096 01:54:05 INFO - PROCESS | 9779 | |5;yui.html;811.8335741173056;869.8564736818425;892.705407215619;923.5059243304834;924.1405492891611;14232;16066;16480.258388372524;16542.172891355414;16698.91650541747;16165.353385864551;16409;16579.336826526924;16581.585460363498;16682.33270669172;857.1086070486687;873.6330741088758;875.0461996423896;875.6322344615277;876.9298456123527;843.1357858195369;865.8225063861925;876.8640860666607;877.2937785083005;878.569500944539;915.4324318922244;916.5966974531185;917.4403613795579;917.5962576466367;917.7705573606598;912.2109375390306;912.5072460871122;913.5158366065929;913.8126684029758;913.9177474027337;668.2181847238694;669.5647828911198;669.6417416682052;669.9196096468455;669.9497537684645;16854.831451685448;17123.229454674445;17269.827301726946;17299;17345.306187752474;15436.228188590525;15631.218439078;15684.294206760724;15919.522414327588;16039.117848518326;12534.435950382254;12860.421281042376;12899.484020639164;12956;12998.935005325007;4107;4118.567550407224;4129.2773764591375;4150.501939767217;4189.62293393593;87369.56315218446;88503;88756.55621721914;89597.55201223952;90618.5469072657;10444.766966678402;10766.515506802212;10772.24594278393;10801.945990269998;10905.182111341523;21523;21605.67591486129;21606.78393216079;21733.130674773147;22125.336239912827;8021.679132834622;8117.0665373481625;8187.4678145920325;8194.303484203909;8353.582320883932;4441.0673758511075;4463.196624607602;4570.085982803386;4572.657050721209;4599.931001034987;3512.7541072124704;3550.680438760524;3642.4354225095153;3647.76289541179;3648.635136486383;562.434753073167;565.5758181363977;573.4036601933942;574.0728723112144;582.1616871704732;758.5107605594361;769.714576656973;785.8899754034439;807.0235015631152;809.5952023988006;11143.275687080313;11332.660020199408;11677.240979336317;11683.473792292643;11760.764784704257;693.1266604078897;705.9576425414491;712.1579080858738;718.4324383736789;726.7710671138575;5106.66806657566;5140.7943682253035;5188.377394712658;5197.766100525486;5225.608079394061;66020;66272.33727662759;68475.65762171257;71961.2803871965;81221.59389203016;65390.67304663446;67270.30013349214;68006.65996670084;68144.6592767033;68273.65863170652;53409;54900.72549637226;63254.36745632485;63614;64083.35916640867;11563;12211.75576488483;12272.75454490923;12361.443735032126;12616.432260548114;35488.46767298441;40866.79566602267;41479.37780933349;41877.371839423045;42799.57200427956;49699.50300496949;50585.24122138097;50674.23988640247;50793.74603127108;50913.23630145477;12668.556600518938;12757.936210318889;12776.552820651232;12864.807027894401;12950.80573791375;13698.315084245947;13876.306184690928;13944.651383715489;13983.44066237339;14015.089019213718;13528.72942541124;13602.183868967893;13679.31603419845;13720.93139534296;14368;14019.29903504841;14075.507357242448;14352.49766258176;14425.49510767118;14485.505510301735;14946.925265373604;15003.174825384709;15017.849821501644;15589.610259743597;15714.371425142866;10069.496525173565;10173.186145108522;10286.639967601099;10387.428691422045;10647.520861561403;12378.81431778506;12383.814242786546;12464.688382790502;12760.617181484571;12828.871711282767 01:54:05 INFO - PROCESS | 9779 | __end_tp_report 01:54:05 INFO - PROCESS | 9779 | __start_cc_report 01:54:05 INFO - PROCESS | 9779 | _x_x_mozilla_cycle_collect,1228 01:54:05 INFO - PROCESS | 9779 | __end_cc_report 01:54:05 INFO - PROCESS | 9779 | __startTimestamp1494320045477__endTimestamp 01:54:05 INFO - PROCESS | 9779 | 01:54:05 INFO - PROCESS | 9779 | ------- Summary: start ------- 01:54:05 INFO - PROCESS | 9779 | Number of tests: 6 01:54:05 INFO - PROCESS | 9779 | 01:54:05 INFO - PROCESS | 9779 | [#0] dojo.html Cycles:165 Average:5634.23 Median:5885.18 stddev:643.40 (10.9%) stddev-sans-first:619.89 01:54:05 INFO - PROCESS | 9779 | Values: 3349.1 3390.8 3391.7 3400.4 3437.1 5583.0 5625.4 5655.7 5660.6 5675.1 5688.4 5730.5 5748.8 5755.1 5804.4 5081.2 5084.6 5111.4 5147.4 5182.6 4976.4 5164.5 5164.8 5169.6 5187.5 5003.8 5010.0 5032.7 5109.7 5121.3 5116.7 5133.3 5136.6 5139.8 5144.2 5009.7 5045.4 5107.3 5121.1 5145.5 5455.7 5511.9 5532.3 5599.4 5613.5 6053.8 6079.8 6089.4 6090.4 6115.2 6116.3 6130.8 6135.5 6136.0 6137.6 5547.4 5583.6 5648.7 5678.5 5734.3 6231.3 6242.4 6244.8 6254.2 6254.6 5949.4 5976.4 5986.0 5993.6 6005.1 5850.8 5880.6 5943.9 6052.6 6087.3 6014.9 6019.4 6039.5 6044.2 6049.5 5848.7 5874.6 5881.6 6031.0 6039.4 4545.9 4570.3 4606.1 4610.7 4640.0 4113.1 4153.9 4167.0 4173.2 4212.8 5708.9 5758.1 5824.4 5837.4 5929.3 6125.2 6135.6 6136.6 6139.5 6139.7 5893.7 5903.2 5904.7 5911.9 5930.8 5017.2 5052.6 5074.9 5172.0 5178.8 6338.3 6340.4 6348.8 6352.7 6356.0 6025.8 6069.7 6070.9 6074.2 6080.8 6143.5 6277.1 6339.7 6343.5 6351.3 5948.6 5949.4 5959.7 6059.2 6064.4 6119.7 6125.3 6128.8 6137.0 6137.4 5917.4 5968.0 5968.6 5968.6 5972.6 5796.6 5830.4 5857.2 5864.6 5921.8 5930.0 5930.9 5940.7 5942.5 5957.4 5813.6 5848.2 5930.7 5968.6 5980.4 5778.5 5806.0 5885.2 5912.3 5917.9 01:54:05 INFO - PROCESS | 9779 | 01:54:05 INFO - PROCESS | 9779 | [#1] ext.html Cycles:180 Average:44585.57 Median:32712.67 stddev:74981.95 (229.2%) stddev-sans-first:75120.11 01:54:05 INFO - PROCESS | 9779 | Values: 767.3 829.0 850.1 914.7 925.6 30224.7 42402.0 42989.0 43087.6 43298.0 43431.3 43441.6 43610.3 43646.6 44044.8 7595.4 7756.1 8701.3 8810.5 8817.0 10438.9 10688.5 10845.0 10854.7 10960.6 10794.7 10832.4 10834.9 10836.5 10847.3 10693.1 10703.1 10732.6 10747.0 10764.8 10485.2 10543.7 10560.7 10568.6 10580.3 42565.6 42630.1 42967.1 43007.6 43036.4 4165.8 4182.5 4206.4 4292.2 4315.9 30069.9 30105.7 30290.2 30563.4 31389.7 4281.4 4330.9 4342.4 4398.3 4456.8 245010.0 245030.0 245418.0 245450.8 246384.0 45601.5 45685.5 45729.5 45744.8 45836.1 47727.0 47821.5 47947.0 48013.3 48015.8 15239.4 15535.1 15536.1 15546.5 15597.1 11919.5 12158.8 13496.8 13499.1 13543.7 11497.9 11581.7 11603.2 12453.4 12932.4 5373.1 5377.1 5446.5 5470.9 5529.9 982.2 986.0 990.4 992.9 1005.5 28136.6 28458.9 28525.0 28680.1 28929.7 1047.8 1052.8 1061.2 1072.5 1095.3 14870.3 14950.6 15250.6 15290.2 15328.5 163328.0 164658.0 349702.0 350845.0 352364.0 56642.7 57993.1 58116.7 58137.4 58153.7 1477.5 1483.1 1511.2 1518.3 1519.6 26519.3 27553.0 27825.7 28025.0 28107.3 43360.8 43402.6 43522.8 43577.6 43613.3 316803.0 317090.0 317903.0 319171.0 319906.0 32165.4 32513.2 32825.7 32843.0 32852.8 35703.0 36257.0 41069.2 43571.8 43602.8 34165.8 34458.7 34505.0 34507.3 35086.8 33869.3 34471.3 34476.3 34492.0 35195.8 29104.4 29117.9 29123.0 29139.1 32665.8 32759.5 33027.8 33137.8 33809.7 34128.8 25965.5 26548.0 26867.6 26941.7 27090.2 01:54:05 INFO - PROCESS | 9779 | 01:54:05 INFO - PROCESS | 9779 | [#2] jquery.html Cycles:180 Average:37106.82 Median:20823.43 stddev:104579.62 (502.2%) stddev-sans-first:104836.74 01:54:05 INFO - PROCESS | 9779 | Values: 429.7 430.3 439.0 452.4 456.0 19672.3 20813.3 21232.0 21315.1 21528.7 21307.5 22560.9 22607.1 22801.5 22860.1 6561.4 6589.8 6875.6 6883.4 6885.0 6654.9 6731.3 6768.8 6772.7 6776.7 6457.9 6694.6 6734.2 6770.3 6798.6 6538.6 6709.2 6797.5 6808.5 6811.1 6500.1 6548.6 6571.1 6576.1 6577.6 25404.6 25850.9 25959.9 26003.9 26480.7 3617.6 3638.3 3648.6 3744.9 3780.2 15236.8 15560.1 15709.5 16005.8 16037.8 2206.2 2237.0 2308.2 2310.4 2333.4 115829.4 117521.0 117727.4 118165.0 118963.0 17131.8 17361.2 17715.3 17902.5 18175.3 31734.0 31770.4 31798.7 31806.4 31947.7 10354.9 10473.5 10550.8 10563.7 10766.6 8767.0 8786.3 8855.8 8885.3 8912.5 9108.6 9330.2 9432.2 9529.9 9662.7 3497.3 3886.2 3947.3 3951.4 3982.7 1132.5 1145.2 1148.9 1151.7 1198.4 20390.4 20553.4 20672.2 20704.5 20833.6 1151.6 1159.0 1183.3 1183.5 1186.7 11008.2 11354.5 11408.3 11435.2 11521.8 621656.0 624319.0 634668.0 641272.0 642186.0 100767.0 106262.0 119965.4 124047.0 126668.0 1264.2 1298.2 1321.1 1324.9 1326.9 19168.3 19358.0 19421.5 19649.2 19655.0 49710.8 50159.2 51529.0 52441.2 52568.7 69001.7 69567.7 69854.3 70740.0 71577.6 10533.9 11979.3 12103.7 12150.9 12293.6 14194.4 14225.5 14237.2 14328.9 14345.6 11169.7 11291.2 11315.2 11331.6 12587.9 11717.0 11777.9 11819.9 11867.2 11947.8 11623.8 12418.3 12473.0 12544.7 12680.9 11856.3 11917.2 12038.4 12097.9 12366.1 12406.9 12436.9 12437.6 12450.9 12821.5 01:54:05 INFO - PROCESS | 9779 | 01:54:05 INFO - PROCESS | 9779 | [#3] mootools.html Cycles:180 Average:7047.82 Median:2360.25 stddev:4530.34 (191.9%) stddev-sans-first:4523.18 01:54:05 INFO - PROCESS | 9779 | Values: 1400.6 1529.2 1534.3 1541.4 1561.5 9063.5 10875.7 11185.9 11497.1 11518.3 11079.8 11190.3 11200.1 11203.9 11216.4 1969.8 2027.6 2335.1 2367.8 2368.3 2254.5 2336.7 2339.8 2341.6 2357.0 2357.9 2373.9 2377.0 2384.5 2384.6 2362.6 2369.9 2380.2 2381.3 2384.2 2196.5 2233.6 2234.4 2237.8 2238.3 11016.8 11038.4 11123.3 11130.8 11131.3 5590.4 5700.1 5728.4 5736.0 5740.1 3068.2 3268.1 3338.2 3346.4 3348.7 1262.8 1294.0 1337.9 1343.3 1412.3 16599.8 16604.8 16705.5 16728.9 16743.7 4494.1 4706.4 4730.9 4740.7 4771.7 13815.2 13853.7 13947.3 13956.6 13973.2 5687.3 5753.6 5781.0 5792.9 5799.7 5303.8 5306.0 5377.2 5379.8 5386.4 4108.6 4171.8 4180.2 4248.9 4356.7 1073.9 1073.9 1073.9 1075.2 1094.6 989.8 1021.8 1028.4 1035.3 1036.5 6779.9 6810.9 6816.1 6864.2 6872.2 993.7 1020.8 1030.2 1040.7 1057.1 4428.1 4455.8 4462.1 4469.9 4472.6 13490.3 13674.9 14280.2 14779.8 14838.8 13917.8 14175.7 14203.1 14241.4 14315.3 10541.2 10662.6 10693.3 10797.2 10854.2 7273.7 7432.7 7568.1 7580.8 7690.0 12999.2 13132.3 13159.5 13481.5 13516.7 11006.6 13557.9 13566.7 13571.3 13667.5 8704.3 9503.6 9545.9 9556.7 9820.9 10358.3 10751.6 10964.6 11060.2 11113.9 8934.2 8968.7 8981.4 9141.8 9176.4 8614.9 8691.3 8697.7 8763.3 8821.8 8197.1 8331.5 8342.0 8344.8 8354.7 6382.7 6410.8 6491.0 6491.1 6588.9 6402.5 6469.4 6528.2 6582.1 6616.0 01:54:05 INFO - PROCESS | 9779 | 01:54:05 INFO - PROCESS | 9779 | [#4] prototype.html Cycles:180 Average:4765.31 Median:5219.88 stddev:1270.24 (24.3%) stddev-sans-first:1230.66 01:54:05 INFO - PROCESS | 9779 | Values: 392.1 395.4 412.3 416.1 424.8 5134.3 5160.7 5177.4 5200.8 5238.9 5073.6 5088.3 5100.4 5102.2 5121.9 4222.3 4301.3 4333.3 4342.9 4347.5 4189.4 4309.3 4312.6 4323.6 4353.4 4259.3 4266.4 4286.3 4292.9 4336.0 4252.5 4293.9 4294.7 4317.4 4324.8 4066.3 4096.0 4116.9 4117.7 4118.9 4829.3 5028.9 5038.7 5069.7 5096.7 5054.2 5068.6 5070.5 5094.9 5147.8 5199.6 5471.2 5512.8 5515.8 5542.9 4501.8 4510.6 4537.8 4545.6 4547.4 5457.3 5526.5 5574.7 5675.8 5684.4 4596.2 4602.7 4607.8 4644.0 4690.9 4726.7 4763.6 4777.5 4779.3 4781.7 4888.1 4952.9 5013.2 5077.9 5084.9 5415.6 5427.9 5449.1 5459.0 5484.1 1635.7 1655.2 1663.7 1671.6 1683.3 1240.5 1269.7 1285.3 1296.9 1297.5 5305.0 5318.6 5375.2 5392.7 5453.4 5630.9 5640.2 5649.0 5659.7 5661.6 5251.3 5296.3 5341.0 5389.7 5414.3 2957.4 2960.5 2968.2 2977.0 2993.2 5694.3 5893.4 5899.9 5925.5 5949.3 5706.9 5721.0 5756.3 5766.5 5822.5 5863.8 5885.8 5891.7 5946.5 5972.5 5347.3 5570.3 5577.0 5597.5 5617.4 5333.4 5557.2 5557.6 5564.4 5601.5 5689.6 5697.8 5847.2 5852.8 5853.8 4601.0 4618.2 4665.5 4694.2 4695.0 5386.4 5544.9 5592.7 5630.5 5650.8 5399.0 5406.4 5420.6 5443.5 5458.3 5486.4 5486.8 5539.6 5540.9 5551.9 5259.6 5403.7 5463.9 5490.2 5515.5 5473.3 5475.8 5516.9 5519.6 5525.6 5132.9 5291.9 5323.3 5389.8 5423.3 01:54:05 INFO - PROCESS | 9779 | 01:54:05 INFO - PROCESS | 9779 | [#5] yui.html Cycles:180 Average:17727.81 Median:22814.94 stddev:22110.04 (96.9%) stddev-sans-first:22135.58 01:54:05 INFO - PROCESS | 9779 | Values: 811.8 869.9 892.7 923.5 924.1 14232.0 16066.0 16480.3 16542.2 16698.9 16165.4 16409.0 16579.3 16581.6 16682.3 857.1 873.6 875.0 875.6 876.9 843.1 865.8 876.9 877.3 878.6 915.4 916.6 917.4 917.6 917.8 912.2 912.5 913.5 913.8 913.9 668.2 669.6 669.6 669.9 669.9 16854.8 17123.2 17269.8 17299.0 17345.3 15436.2 15631.2 15684.3 15919.5 16039.1 12534.4 12860.4 12899.5 12956.0 12998.9 4107.0 4118.6 4129.3 4150.5 4189.6 87369.6 88503.0 88756.6 89597.6 90618.5 10444.8 10766.5 10772.2 10801.9 10905.2 21523.0 21605.7 21606.8 21733.1 22125.3 8021.7 8117.1 8187.5 8194.3 8353.6 4441.1 4463.2 4570.1 4572.7 4599.9 3512.8 3550.7 3642.4 3647.8 3648.6 562.4 565.6 573.4 574.1 582.2 758.5 769.7 785.9 807.0 809.6 11143.3 11332.7 11677.2 11683.5 11760.8 693.1 706.0 712.2 718.4 726.8 5106.7 5140.8 5188.4 5197.8 5225.6 66020.0 66272.3 68475.7 71961.3 81221.6 65390.7 67270.3 68006.7 68144.7 68273.7 53409.0 54900.7 63254.4 63614.0 64083.4 11563.0 12211.8 12272.8 12361.4 12616.4 35488.5 40866.8 41479.4 41877.4 42799.6 49699.5 50585.2 50674.2 50793.7 50913.2 12668.6 12757.9 12776.6 12864.8 12950.8 13698.3 13876.3 13944.7 13983.4 14015.1 13528.7 13602.2 13679.3 13720.9 14368.0 14019.3 14075.5 14352.5 14425.5 14485.5 14946.9 15003.2 15017.8 15589.6 15714.4 10069.5 10173.2 10286.6 10387.4 10647.5 12378.8 12383.8 12464.7 12760.6 12828.9 01:54:05 INFO - PROCESS | 9779 | -------- Summary: end -------- 01:54:05 INFO - PROCESS | 9779 | 01:54:06 INFO - TEST-INFO | 9779: exit 0 01:54:06 INFO - TEST-OK | dromaeo_css | took 1115028ms 01:54:06 INFO - TEST-START | kraken 01:54:06 INFO - operating with platform_type : linux_ 01:54:06 INFO - Initialising browser for kraken test... 01:54:06 INFO - TEST-INFO | started process 10107 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSEtBGw/profile http://localhost:46306/getInfo.html) 01:54:10 INFO - PROCESS | 10107 | __metrics Screen width/height:1600/1200 01:54:10 INFO - PROCESS | 10107 | colorDepth:24 01:54:10 INFO - PROCESS | 10107 | Browser inner width/height: 1024/697 01:54:10 INFO - PROCESS | 10107 | __metrics 01:54:10 INFO - PROCESS | 10107 | 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" 01:54:10 INFO - PROCESS | 10107 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:54:11 INFO - TEST-INFO | 10107: exit 0 01:54:11 INFO - Browser initialized. 01:54:11 INFO - Running cycle 1/1 for kraken test... 01:54:11 INFO - TEST-INFO | started process 10201 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSEtBGw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:54:23 INFO - PROCESS | 10201 | RSS: Main: 139939840 01:54:23 INFO - PROCESS | 10201 | 01:54:26 INFO - PROCESS | 10201 | Cycle 1(1): loaded http://localhost:46306/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46306/tests/kraken/driver.html?testName=audio-beat-detection) 01:54:27 INFO - PROCESS | 10201 | RSS: Main: 182947840 01:54:27 INFO - PROCESS | 10201 | 01:54:29 INFO - PROCESS | 10201 | Cycle 1(1): loaded http://localhost:46306/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46306/tests/kraken/driver.html?testName=audio-dft) 01:54:30 INFO - PROCESS | 10201 | RSS: Main: 173752320 01:54:30 INFO - PROCESS | 10201 | 01:54:33 INFO - PROCESS | 10201 | Cycle 1(1): loaded http://localhost:46306/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46306/tests/kraken/driver.html?testName=audio-fft) 01:54:33 INFO - PROCESS | 10201 | RSS: Main: 265277440 01:54:33 INFO - PROCESS | 10201 | 01:54:35 INFO - PROCESS | 10201 | Cycle 1(1): loaded http://localhost:46306/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46306/tests/kraken/driver.html?testName=audio-oscillator) 01:54:36 INFO - PROCESS | 10201 | RSS: Main: 171442176 01:54:36 INFO - PROCESS | 10201 | 01:54:38 INFO - PROCESS | 10201 | Cycle 1(1): loaded http://localhost:46306/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46306/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:54:38 INFO - PROCESS | 10201 | RSS: Main: 175030272 01:54:38 INFO - PROCESS | 10201 | 01:54:41 INFO - PROCESS | 10201 | Cycle 1(1): loaded http://localhost:46306/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46306/tests/kraken/driver.html?testName=imaging-darkroom) 01:54:42 INFO - PROCESS | 10201 | RSS: Main: 212938752 01:54:42 INFO - PROCESS | 10201 | 01:54:45 INFO - PROCESS | 10201 | Cycle 1(1): loaded http://localhost:46306/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46306/tests/kraken/driver.html?testName=imaging-desaturate) 01:54:46 INFO - PROCESS | 10201 | RSS: Main: 212291584 01:54:46 INFO - PROCESS | 10201 | 01:54:49 INFO - PROCESS | 10201 | Cycle 1(1): loaded http://localhost:46306/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46306/tests/kraken/driver.html?testName=json-parse-financial) 01:54:49 INFO - PROCESS | 10201 | RSS: Main: 210259968 01:54:49 INFO - PROCESS | 10201 | 01:54:51 INFO - PROCESS | 10201 | Cycle 1(1): loaded http://localhost:46306/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46306/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:54:52 INFO - PROCESS | 10201 | RSS: Main: 172908544 01:54:52 INFO - PROCESS | 10201 | 01:54:53 INFO - PROCESS | 10201 | Cycle 1(1): loaded http://localhost:46306/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46306/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:54:54 INFO - PROCESS | 10201 | RSS: Main: 178737152 01:54:54 INFO - PROCESS | 10201 | 01:54:56 INFO - PROCESS | 10201 | Cycle 1(1): loaded http://localhost:46306/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46306/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:54:56 INFO - PROCESS | 10201 | RSS: Main: 189173760 01:54:56 INFO - PROCESS | 10201 | 01:54:59 INFO - PROCESS | 10201 | Cycle 1(1): loaded http://localhost:46306/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46306/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:55:00 INFO - PROCESS | 10201 | RSS: Main: 197623808 01:55:00 INFO - PROCESS | 10201 | 01:55:02 INFO - PROCESS | 10201 | Cycle 1(1): loaded http://localhost:46306/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46306/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:55:03 INFO - PROCESS | 10201 | RSS: Main: 194920448 01:55:03 INFO - PROCESS | 10201 | 01:55:05 INFO - PROCESS | 10201 | Cycle 1(1): loaded http://localhost:46306/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46306/tests/kraken/driver.html?testName=ai-astar) 01:55:05 INFO - PROCESS | 10201 | RSS: Main: 245604352 01:55:05 INFO - PROCESS | 10201 | 01:55:05 INFO - PROCESS | 10201 | __start_tp_report 01:55:05 INFO - PROCESS | 10201 | _x_x_mozilla_page_load 01:55:05 INFO - PROCESS | 10201 | _x_x_mozilla_page_load_details 01:55:05 INFO - PROCESS | 10201 | |i|pagename|runs| 01:55:05 INFO - PROCESS | 10201 | |0;ai-astar;103;111;113;112;111;113;113;112;112;113 01:55:05 INFO - PROCESS | 10201 | |1;audio-beat-detection;140;114;122;158;121;116;117;114;134;119 01:55:05 INFO - PROCESS | 10201 | |2;audio-dft;161;161;161;161;160;162;160;161;162;159 01:55:05 INFO - PROCESS | 10201 | |3;audio-fft;75;77;77;111;76;78;76;75;90;76 01:55:05 INFO - PROCESS | 10201 | |4;audio-oscillator;82;82;105;82;83;82;95;82;82;102 01:55:05 INFO - PROCESS | 10201 | |5;imaging-gaussian-blur;113;113;114;113;113;113;113;113;112;113 01:55:05 INFO - PROCESS | 10201 | |6;imaging-darkroom;146;147;147;146;146;148;147;147;146;147 01:55:05 INFO - PROCESS | 10201 | |7;imaging-desaturate;94;94;94;94;94;94;94;94;94;94 01:55:05 INFO - PROCESS | 10201 | |8;json-parse-financial;54;53;54;53;54;53;55;64;52;53 01:55:05 INFO - PROCESS | 10201 | |9;json-stringify-tinderbox;53;54;53;54;54;53;54;54;54;54 01:55:05 INFO - PROCESS | 10201 | |10;stanford-crypto-aes;79;80;80;81;77;77;79;76;79;75 01:55:05 INFO - PROCESS | 10201 | |11;stanford-crypto-ccm;122;133;131;130;121;121;120;129;158;120 01:55:05 INFO - PROCESS | 10201 | |12;stanford-crypto-pbkdf2;163;164;165;162;168;160;160;159;158;156 01:55:05 INFO - PROCESS | 10201 | |13;stanford-crypto-sha256-iterative;60;60;62;61;61;59;60;59;60;59 01:55:05 INFO - PROCESS | 10201 | __end_tp_report 01:55:05 INFO - PROCESS | 10201 | __start_cc_report 01:55:05 INFO - PROCESS | 10201 | _x_x_mozilla_cycle_collect,1650 01:55:05 INFO - PROCESS | 10201 | __end_cc_report 01:55:05 INFO - PROCESS | 10201 | __startTimestamp1494320105377__endTimestamp 01:55:05 INFO - PROCESS | 10201 | 01:55:05 INFO - PROCESS | 10201 | ------- Summary: start ------- 01:55:05 INFO - PROCESS | 10201 | Number of tests: 14 01:55:05 INFO - PROCESS | 10201 | 01:55:05 INFO - PROCESS | 10201 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.50 stddev:3.02 (2.7%) stddev-sans-first:0.83 01:55:05 INFO - PROCESS | 10201 | Values: 103.0 111.0 113.0 112.0 111.0 113.0 113.0 112.0 112.0 113.0 01:55:05 INFO - PROCESS | 10201 | 01:55:05 INFO - PROCESS | 10201 | [#1] audio-beat-detection Cycles:10 Average:125.50 Median:121.50 stddev:14.30 (11.8%) stddev-sans-first:14.17 01:55:05 INFO - PROCESS | 10201 | Values: 140.0 114.0 122.0 158.0 121.0 116.0 117.0 114.0 134.0 119.0 01:55:05 INFO - PROCESS | 10201 | 01:55:05 INFO - PROCESS | 10201 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 01:55:05 INFO - PROCESS | 10201 | Values: 161.0 161.0 161.0 161.0 160.0 162.0 160.0 161.0 162.0 159.0 01:55:05 INFO - PROCESS | 10201 | 01:55:05 INFO - PROCESS | 10201 | [#3] audio-fft Cycles:10 Average:81.10 Median:76.50 stddev:11.40 (14.9%) stddev-sans-first:11.87 01:55:05 INFO - PROCESS | 10201 | Values: 75.0 77.0 77.0 111.0 76.0 78.0 76.0 75.0 90.0 76.0 01:55:05 INFO - PROCESS | 10201 | 01:55:05 INFO - PROCESS | 10201 | [#4] audio-oscillator Cycles:10 Average:87.70 Median:82.00 stddev:9.27 (11.3%) stddev-sans-first:9.60 01:55:05 INFO - PROCESS | 10201 | Values: 82.0 82.0 105.0 82.0 83.0 82.0 95.0 82.0 82.0 102.0 01:55:05 INFO - PROCESS | 10201 | 01:55:05 INFO - PROCESS | 10201 | [#5] imaging-gaussian-blur Cycles:10 Average:113.00 Median:113.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 01:55:05 INFO - PROCESS | 10201 | Values: 113.0 113.0 114.0 113.0 113.0 113.0 113.0 113.0 112.0 113.0 01:55:05 INFO - PROCESS | 10201 | 01:55:05 INFO - PROCESS | 10201 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 01:55:05 INFO - PROCESS | 10201 | Values: 146.0 147.0 147.0 146.0 146.0 148.0 147.0 147.0 146.0 147.0 01:55:05 INFO - PROCESS | 10201 | 01:55:05 INFO - PROCESS | 10201 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 01:55:05 INFO - PROCESS | 10201 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 01:55:05 INFO - PROCESS | 10201 | 01:55:05 INFO - PROCESS | 10201 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.00 stddev:3.44 (6.4%) stddev-sans-first:3.64 01:55:05 INFO - PROCESS | 10201 | Values: 54.0 53.0 54.0 53.0 54.0 53.0 55.0 64.0 52.0 53.0 01:55:05 INFO - PROCESS | 10201 | 01:55:05 INFO - PROCESS | 10201 | [#9] json-stringify-tinderbox Cycles:10 Average:53.70 Median:54.00 stddev:0.48 (0.9%) stddev-sans-first:0.44 01:55:05 INFO - PROCESS | 10201 | Values: 53.0 54.0 53.0 54.0 54.0 53.0 54.0 54.0 54.0 54.0 01:55:05 INFO - PROCESS | 10201 | 01:55:05 INFO - PROCESS | 10201 | [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:79.00 stddev:1.95 (2.5%) stddev-sans-first:2.05 01:55:05 INFO - PROCESS | 10201 | Values: 79.0 80.0 80.0 81.0 77.0 77.0 79.0 76.0 79.0 75.0 01:55:05 INFO - PROCESS | 10201 | 01:55:05 INFO - PROCESS | 10201 | [#11] stanford-crypto-ccm Cycles:10 Average:128.50 Median:129.50 stddev:11.54 (8.9%) stddev-sans-first:12.00 01:55:05 INFO - PROCESS | 10201 | Values: 122.0 133.0 131.0 130.0 121.0 121.0 120.0 129.0 158.0 120.0 01:55:05 INFO - PROCESS | 10201 | 01:55:05 INFO - PROCESS | 10201 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.50 Median:162.50 stddev:3.60 (2.2%) stddev-sans-first:3.77 01:55:05 INFO - PROCESS | 10201 | Values: 163.0 164.0 165.0 162.0 168.0 160.0 160.0 159.0 158.0 156.0 01:55:05 INFO - PROCESS | 10201 | 01:55:05 INFO - PROCESS | 10201 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.10 Median:60.00 stddev:0.99 (1.7%) stddev-sans-first:1.05 01:55:05 INFO - PROCESS | 10201 | Values: 60.0 60.0 62.0 61.0 61.0 59.0 60.0 59.0 60.0 59.0 01:55:05 INFO - PROCESS | 10201 | -------- Summary: end -------- 01:55:05 INFO - PROCESS | 10201 | 01:55:06 INFO - TEST-INFO | 10201: exit 0 01:55:06 INFO - TEST-OK | kraken | took 60102ms 01:55:06 INFO - SUITE-END | took 1175s 01:55:06 INFO - Completed test suite (00:19:35) 01:55:06 INFO - javascript benchmark 01:55:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7719.450375744199, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3349.129226401136, 3390.8135052572106, 3391.7117045051154, 3400.353932752775, 3437.1235334989574, 5582.9999999999945, 5625.4093320201355, 5655.7172141392975, 5660.575456840738, 5675.148727690848, 5688.402717714643, 5730.541556675456, 5748.798792042279, 5755.0504166812425, 5804.448577385152, 5081.187010078379, 5084.567811736007, 5111.386633603955, 5147.356580427447, 5182.637215394924, 4976.3530741003615, 5164.535191832734, 5164.845054648366, 5169.612279079065, 5187.533122019017, 5003.849884503453, 5009.998000399934, 5032.672876263049, 5109.667871588354, 5121.28302037715, 5116.692998420088, 5133.255677926717, 5136.64043516954, 5139.7687104080405, 5144.228365745131, 5009.674371165863, 5045.369328833895, 5107.3105130807235, 5121.078205922932, 5145.536901678867, 5455.672659640394, 5511.944880551183, 5532.30846144232, 5599.440055994409, 5613.46672066153, 6053.848653783691, 6079.817605471843, 6089.360617135181, 6090.36051214625, 6115.205023346936, 6116.327204007555, 6130.785422510236, 6135.478484328837, 6136.0, 6137.631742095488, 5547.417521160301, 5583.58123140762, 5648.6610803351105, 5678.4605462480995, 5734.254546908875, 6231.345708700521, 6242.438180563771, 6244.7814326499265, 6254.186955695731, 6254.593451425734, 5949.405059494016, 5976.402359763989, 5986.042233242661, 5993.580449368503, 6005.099235114768, 5850.795222167204, 5880.617759845596, 5943.881122377528, 6052.636841789506, 6087.3303936566945, 6014.939850601526, 6019.398060194033, 6039.486643635252, 6044.153818465418, 6049.5462840287155, 5848.707564621837, 5874.618149820248, 5881.617694849821, 6031.035034394476, 6039.396060394013, 4545.863624091283, 4570.291604801261, 4606.055758569552, 4610.700304480265, 4639.9536004640195, 4113.074558224435, 4153.937690934638, 4166.979165104155, 4173.207090652766, 4212.789360531961, 5708.914366284509, 5758.136279558016, 5824.446677565625, 5837.416258374214, 5929.347771745104, 6125.203723515914, 6135.630783975157, 6136.580349164101, 6139.492138333381, 6139.676133582418, 5893.675847828411, 5903.173555702119, 5904.7342869570975, 5911.881762364815, 5930.762769489258, 5017.247412888096, 5052.621053420935, 5074.898502030012, 5171.974140129275, 5178.766955487012, 6338.271098823602, 6340.397662222082, 6348.77779277723, 6352.745890164527, 6356.046593011085, 6025.758969641341, 6069.666168360783, 6070.9089363658695, 6074.240719910012, 6080.847978800565, 6143.481172719164, 6277.058441233851, 6339.714712838026, 6343.52423568225, 6351.269603995414, 5948.613340132878, 5949.434803693643, 5959.67221802805, 6059.182010428536, 6064.423879731418, 6119.724612392542, 6125.295591006913, 6128.816135515942, 6137.048757442603, 6137.355577664281, 5917.437843404869, 5967.9701601491715, 5968.552358573038, 5968.641881487125, 5972.611780234271, 5796.565257605781, 5830.416958304136, 5857.238558987305, 5864.648121112747, 5921.7631294747725, 5929.970350148222, 5930.9110363343725, 5940.673262970578, 5942.494887934401, 5957.374475680164, 5813.56398270123, 5848.239728835224, 5930.673812940329, 5968.582199246011, 5980.37206093354, 5778.479936805707, 5805.970970145122, 5885.176075349369, 5912.320083190488, 5917.911231331447], "value": 5591.462354083754, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [767.3285874859498, 828.950262984221, 850.0988951711184, 914.7027216154752, 925.5557332480405, 30224.697753022465, 42402.0, 42989.0, 43087.56912430875, 43298.0, 43431.348529772076, 43441.56558434415, 43610.34584481228, 43646.56353436465, 44044.77977610115, 7595.43034272429, 7756.0692716874055, 8701.347398945089, 8810.471371717686, 8816.955915220447, 10438.947805260963, 10688.519016644232, 10845.0, 10854.67435976922, 10960.56157753689, 10794.676159715222, 10832.350058996486, 10834.891651083506, 10836.458177091154, 10847.294925829836, 10693.144548436107, 10703.143748500179, 10732.570697172103, 10746.979036991512, 10764.784704305948, 10485.161187105014, 10543.683689489328, 10560.683179504627, 10568.630097946534, 10580.259381843274, 42565.574344256784, 42630.1473970522, 42967.14065718668, 43007.56992430098, 43036.354454683205, 4165.770882601456, 4182.519010313822, 4206.3690446432975, 4292.205941900727, 4315.892102697427, 30069.9475518358, 30105.69894301051, 30290.242743931358, 30563.388732225452, 31389.686103138905, 4281.400603915455, 4330.935035974463, 4342.413774140482, 4398.252297109499, 4456.844010459651, 245010.0, 245030.0, 245418.0, 245450.7727461369, 246384.0, 45601.54398455973, 45685.543144568794, 45729.54270457253, 45744.77127614341, 45836.08327833425, 47727.0, 47821.5217847824, 47947.0, 48013.279800803015, 48015.75992120017, 15239.390424383122, 15535.06789592628, 15536.145511996949, 15546.455874044354, 15597.064176149468, 11919.463624136935, 12158.817617735742, 13496.797548036788, 13499.122557033761, 13543.729125417436, 11497.942510287396, 11581.652550423501, 11603.245789023686, 12453.377331133406, 12932.353382330846, 5373.077653313026, 5377.085895397791, 5446.509814116669, 5470.863228419242, 5529.889402211933, 982.2044144243185, 985.9556319965619, 990.3562684255292, 992.925530585209, 1005.4821766790109, 28136.577951330746, 28458.857705711755, 28525.0, 28680.139595811743, 28929.710702892702, 1047.7537778622018, 1052.821020426514, 1061.2412125330425, 1072.4584085037006, 1095.315427857589, 14870.256487175599, 14950.626234344229, 15250.618734531725, 15290.235488225544, 15328.540143795704, 163328.0, 164658.0, 349702.0, 350845.0, 352364.0, 56642.716786416626, 57993.13010304849, 58116.70941645265, 58137.41862581405, 58153.70923145442, 1477.4976507987121, 1483.1397789282405, 1511.2292730707418, 1518.324345666168, 1519.5733620685285, 26519.33701657397, 27553.0, 27825.721742782313, 28025.0, 28107.297317567223, 43360.78319608508, 43402.565974341116, 43522.78238608914, 43577.56422435862, 43613.34579981239, 316803.0, 317090.0, 317903.0, 319171.0, 319906.0, 32165.391730413852, 32513.187170320933, 32825.67174328226, 32843.0, 32852.835735821165, 35703.0, 36257.0, 41069.1786164281, 43571.78214108909, 43602.78198609113, 34165.829170853984, 34458.655413445544, 34505.0, 34507.30985380329, 35086.82456587701, 33869.32261354809, 34471.31057378888, 34476.31047379089, 34492.0, 35195.82402087973, 29104.41791164207, 29117.85441072781, 29123.0, 29139.12582622525, 32665.836670816494, 32759.508607370433, 33027.83486082554, 33137.834310829254, 33809.66190338164, 34128.829355853064, 25965.48069038571, 26548.0, 26867.596986044835, 26941.730582693923, 27090.1872943812], "value": 18584.688623974514, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.7280051048894, 430.3093534876521, 438.9934150987736, 452.4344569288389, 455.95668411500895, 19672.311469098586, 20813.27153549626, 21232.04455799489, 21315.147394104217, 21528.677069843965, 21307.467313317175, 22560.887195564, 22607.095716171334, 22801.54396912061, 22860.08559657616, 6561.409473147416, 6589.80230593083, 6875.621840798754, 6883.414909732679, 6885.0, 6654.9334506654795, 6731.259561448237, 6768.7630932917355, 6772.661366931658, 6776.661166941658, 6457.8708425831455, 6694.59832410057, 6734.158230221223, 6770.289119642441, 6798.626075565842, 6538.574992625512, 6709.228438729536, 6797.490188235902, 6808.523403361766, 6811.080504131928, 6500.05749166373, 6548.607083575001, 6571.080048793173, 6576.0793488911595, 6577.572457790228, 25404.618930716053, 25850.870745646338, 25959.870200648875, 26003.869980650165, 26480.73519264802, 3617.602063772983, 3638.3450978823803, 3648.562172539312, 3744.850205991757, 3780.168362960172, 15236.847631523653, 15560.144192069432, 15709.52871413848, 16005.759913601305, 16037.759433608506, 2206.1947389202987, 2237.0, 2308.1575225042907, 2310.4108452344544, 2333.3933177373833, 115829.42085289604, 117521.0, 117727.41136294349, 118165.0, 118963.0, 17131.828681713272, 17361.2178232055, 17715.29138834458, 17902.46292611224, 18175.273708943765, 31734.0, 31770.36459270848, 31798.682013180034, 31806.363872722417, 31947.680523194937, 10354.948225258826, 10473.528691208914, 10550.788984220273, 10563.735906602396, 10766.623168189075, 8766.99179594342, 8786.341024423195, 8855.822883542292, 8885.333599979898, 8912.509811960404, 9108.635654573874, 9330.160285574195, 9432.245420366355, 9529.90470095304, 9662.661806836726, 3497.3180229854934, 3886.1839013807416, 3947.3289840448083, 3951.4467974483596, 3982.7411218270718, 1132.5016992523263, 1145.2212495503138, 1148.9266212880511, 1151.6890439581434, 1198.3528894396927, 20390.388288351372, 20553.38339849807, 20672.17311307561, 20704.48238794012, 20833.58332833335, 1151.6257216404701, 1158.9942050289694, 1183.3491579631168, 1183.5147589488267, 1186.6973921649924, 11008.174386920853, 11354.545818167346, 11408.315501069963, 11435.199536032398, 11521.769564608661, 621656.0, 624319.0, 634668.0, 641272.0, 642186.0, 100767.0, 106262.0, 119965.40017299858, 124047.0, 126668.0, 1264.1972347559183, 1298.1886321049344, 1321.0658191654163, 1324.860889606616, 1326.8655299718603, 19168.329108481135, 19358.0, 19421.51446213856, 19649.214031438583, 19655.0, 49710.75144624254, 50159.24761128513, 51529.0, 52441.213381800066, 52568.737156313975, 69001.65499172472, 69567.65216173886, 69854.30145698477, 70740.0, 71577.64211178912, 10533.894661053291, 11979.28124312544, 12103.697407564881, 12150.878491214975, 12293.56972505958, 14194.3612537434, 14225.502107426604, 14237.21695306768, 14328.928355358157, 14345.64135896611, 11169.664910052712, 11291.153163512605, 11315.151363647594, 11331.603393881174, 12587.93706031464, 11717.00405465545, 11777.941110294736, 11819.881801181878, 11867.228630139014, 11947.76104477923, 11623.825642615537, 12418.316992565495, 12473.0, 12544.686382840137, 12680.873191267969, 11856.347900865536, 11917.165798394375, 12038.398080096134, 12097.879021209676, 12366.072544559014, 12406.875931240573, 12436.937815310866, 12437.63186049552, 12450.937745311216, 12821.487140514275], "value": 11576.439698948225, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1400.5658245943753, 1529.220097750147, 1534.3172288331689, 1541.437375357994, 1561.4925149326468, 9063.456192628448, 10875.728106797334, 11185.888141118596, 11497.080233581315, 11518.308901465918, 11079.778404431907, 11190.272632278897, 11200.103991680666, 11203.887961120387, 11216.439178041086, 1969.812867777566, 2027.5843452092286, 2335.100986120339, 2367.775061369176, 2368.3368656776042, 2254.537819746948, 2336.6611841283, 2339.830084957521, 2341.625339945609, 2357.033616217351, 2357.929262122139, 2373.92878213653, 2377.0491803278655, 2384.4873352229265, 2384.558856611524, 2362.574736547421, 2369.893354799021, 2380.1788383007834, 2381.3332266965276, 2384.237044145865, 2196.5497073100137, 2233.6314508106143, 2234.441389652587, 2237.8209743220505, 2238.250186187629, 11016.834747478793, 11038.44807759617, 11123.332600044023, 11130.777384452347, 11131.276467029616, 5590.357108932484, 5700.059490184115, 5728.398518155617, 5736.024875771129, 5740.08158694611, 3068.2482791715947, 3268.1339445047083, 3338.1821453743746, 3346.3641908037393, 3348.68187522185, 1262.8421447319085, 1293.95471158509, 1337.9464821407132, 1343.2880573296168, 1412.2867951684334, 16599.83400165995, 16604.83395166045, 16705.498835034967, 16728.916355418143, 16743.748843767353, 4494.10117976406, 4706.435227772689, 4730.858074257778, 4740.715557066587, 4771.6898401603785, 13815.240161790996, 13853.653658658613, 13947.302634868216, 13956.581302560939, 13973.231472268919, 5687.260656114679, 5753.626014309057, 5780.971095144498, 5792.913106303409, 5799.739011744482, 5303.806643505258, 5305.973470132702, 5377.193420986805, 5379.757910894019, 5386.434424385383, 4108.627120923119, 4171.770552619574, 4180.163967206571, 4248.851290204828, 4356.738595684269, 1073.8603981482513, 1073.8926107389354, 1073.9248252622242, 1075.2365820267541, 1094.6497120921229, 989.8267803134422, 1021.7649940513724, 1028.4395004722444, 1035.29082578434, 1036.486938965217, 6779.898301525481, 6810.897836532456, 6816.07982922309, 6864.176298844171, 6872.175338959257, 993.6684842311194, 1020.7703266764919, 1030.1810061001522, 1040.6669865643073, 1057.0856209378985, 4428.114377124588, 4455.799489023002, 4462.1075784842515, 4469.865904022885, 4472.552744725566, 13490.258035808125, 13674.863251367558, 14280.214588197749, 14779.778303325458, 14838.777418338734, 13917.791233131511, 14175.716485670435, 14203.076800007966, 14241.359138838778, 14315.284235788376, 10541.20940929418, 10662.573497060186, 10693.251472396858, 10797.244192906579, 10854.240203185858, 7273.709051637875, 7432.739854105081, 7568.091828980558, 7580.810479738051, 7690.0, 12999.220046797222, 13132.27772472485, 13159.53941612039, 13481.528146514825, 13516.6620834476, 11006.559737610405, 13557.864421356055, 13566.728665426834, 13571.253581053137, 13667.521636742666, 8704.34717396185, 9503.572339244613, 9545.856812147684, 9556.665516706882, 9820.852687209841, 10358.274920755475, 10751.6236931707, 10964.56141754321, 11060.225784195029, 11113.888861111285, 8934.240589549701, 8968.68609598661, 8981.416207946462, 9141.77145571366, 9176.44941303524, 8614.913850861662, 8691.261242794433, 8697.652093916426, 8763.3427492937, 8821.823563528566, 8197.098319184766, 8331.541765202972, 8341.95829020851, 8344.791380215544, 8354.707585234488, 6382.712777925098, 6410.8076757697345, 6490.967545162244, 6491.1236983008575, 6588.868222635425, 6402.487800976004, 6469.353064693493, 6528.183977002875, 6582.111414958919, 6616.040674102324], "value": 5309.850352341127, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.10304468014215, 395.4049156020191, 412.29497559173814, 416.084613849531, 424.82747616578246, 5134.332536770219, 5160.690358578488, 5177.352830896138, 5200.817971371008, 5238.947610523894, 5073.5941124710025, 5088.338515992925, 5100.387953445583, 5102.234664800282, 5121.923171152435, 4222.30331995222, 4301.333293339538, 4333.328334108218, 4342.869713908572, 4347.500037495681, 4189.387085971893, 4309.267424537836, 4312.611864932155, 4323.567643235683, 4353.41228934093, 4259.2546304396765, 4266.424032755584, 4286.271333873249, 4292.914141717164, 4336.0, 4252.468441444819, 4293.8711838644895, 4294.742315461067, 4317.438732964694, 4324.8053837577545, 4066.2680717470844, 4095.9795201024103, 4116.91766164678, 4117.732347397409, 4118.929078439627, 4829.299751536043, 5028.949710502885, 5038.697678139287, 5069.662921348315, 5096.719680417576, 5054.21659642756, 5068.619853510964, 5070.4929507049, 5094.936550696973, 5147.845564633029, 5199.6480914962, 5471.23402723619, 5512.80705175317, 5515.779368825242, 5542.944570554324, 4501.842435514741, 4510.594046535827, 4537.820166756667, 4545.613622842029, 4547.431571053618, 5457.290552228224, 5526.50261476465, 5574.665520068809, 5675.772969081232, 5684.4315568443235, 4596.218642830727, 4602.744655119034, 4607.838725644587, 4643.95356046442, 4690.882727931829, 4726.692764970266, 4763.571278584875, 4777.546133117348, 4779.259214821708, 4781.665283430196, 4888.120138375056, 4952.90094198114, 5013.222950442687, 5077.923831142536, 5084.923726144111, 5415.593830462731, 5427.864303392446, 5449.100898351807, 5459.017376872202, 5484.120836560837, 1635.6565121324418, 1655.180685560655, 1663.7421199714063, 1671.5988162840831, 1683.3098429643787, 1240.4916316434428, 1269.6698858296909, 1285.2673975833873, 1296.9365120601205, 1297.5208262580666, 5305.0, 5318.601104917147, 5375.19372094189, 5392.73270781366, 5453.400125986138, 5630.85922851932, 5640.238567793377, 5649.039663257174, 5659.688717120598, 5661.631993920382, 5251.343582052244, 5296.3379577552805, 5340.95851308991, 5389.703566303812, 5414.269073675004, 2957.364166704169, 2960.5411161270035, 2968.2282606522026, 2977.0473448496273, 2993.1768763589753, 5694.288213973254, 5893.381194974551, 5899.941000590025, 5925.496332811759, 5949.315828679671, 5706.885862282731, 5721.0, 5756.30924289088, 5766.462756387176, 5822.534197264209, 5863.824085277449, 5885.823425297248, 5891.7054147292465, 5946.494547963472, 5972.492338151305, 5347.331583552056, 5570.275864137636, 5577.0, 5597.468240517144, 5617.4101719320515, 5333.386660534088, 5557.194206840067, 5557.583181261502, 5564.415736347625, 5601.495865372136, 5689.573282003784, 5697.800576979786, 5847.245826252192, 5852.8294341131095, 5853.795117170878, 4600.953990460052, 4618.168729628699, 4665.510121437336, 4694.248920172756, 4694.971743225532, 5386.407495175606, 5544.861378465571, 5592.720363981866, 5630.465105814941, 5650.802221922213, 5399.0, 5406.378266499403, 5420.593455490775, 5443.537299329443, 5458.263134476795, 5486.369067557282, 5486.835394938158, 5539.556835453073, 5540.944590554042, 5551.945780061403, 5259.60552958522, 5403.675779453245, 5463.863403414787, 5490.231367608458, 5515.538382328606, 5473.261109750133, 5475.780968761205, 5516.862078448071, 5519.586031047607, 5525.640833345819, 5132.923006154836, 5291.894162116659, 5323.281357016753, 5389.83830485086, 5423.349198096096], "value": 4396.727664272725, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [811.8335741173056, 869.8564736818425, 892.705407215619, 923.5059243304834, 924.1405492891611, 14232.0, 16066.0, 16480.258388372524, 16542.172891355414, 16698.91650541747, 16165.353385864551, 16409.0, 16579.336826526924, 16581.585460363498, 16682.33270669172, 857.1086070486687, 873.6330741088758, 875.0461996423896, 875.6322344615277, 876.9298456123527, 843.1357858195369, 865.8225063861925, 876.8640860666607, 877.2937785083005, 878.569500944539, 915.4324318922244, 916.5966974531185, 917.4403613795579, 917.5962576466367, 917.7705573606598, 912.2109375390306, 912.5072460871122, 913.5158366065929, 913.8126684029758, 913.9177474027337, 668.2181847238694, 669.5647828911198, 669.6417416682052, 669.9196096468455, 669.9497537684645, 16854.831451685448, 17123.229454674445, 17269.827301726946, 17299.0, 17345.306187752474, 15436.228188590525, 15631.218439078, 15684.294206760724, 15919.522414327588, 16039.117848518326, 12534.435950382254, 12860.421281042376, 12899.484020639164, 12956.0, 12998.935005325007, 4107.0, 4118.567550407224, 4129.2773764591375, 4150.501939767217, 4189.62293393593, 87369.56315218446, 88503.0, 88756.55621721914, 89597.55201223952, 90618.5469072657, 10444.766966678402, 10766.515506802212, 10772.24594278393, 10801.945990269998, 10905.182111341523, 21523.0, 21605.67591486129, 21606.78393216079, 21733.130674773147, 22125.336239912827, 8021.679132834622, 8117.0665373481625, 8187.4678145920325, 8194.303484203909, 8353.582320883932, 4441.0673758511075, 4463.196624607602, 4570.085982803386, 4572.657050721209, 4599.931001034987, 3512.7541072124704, 3550.680438760524, 3642.4354225095153, 3647.76289541179, 3648.635136486383, 562.434753073167, 565.5758181363977, 573.4036601933942, 574.0728723112144, 582.1616871704732, 758.5107605594361, 769.714576656973, 785.8899754034439, 807.0235015631152, 809.5952023988006, 11143.275687080313, 11332.660020199408, 11677.240979336317, 11683.473792292643, 11760.764784704257, 693.1266604078897, 705.9576425414491, 712.1579080858738, 718.4324383736789, 726.7710671138575, 5106.66806657566, 5140.7943682253035, 5188.377394712658, 5197.766100525486, 5225.608079394061, 66020.0, 66272.33727662759, 68475.65762171257, 71961.2803871965, 81221.59389203016, 65390.67304663446, 67270.30013349214, 68006.65996670084, 68144.6592767033, 68273.65863170652, 53409.0, 54900.72549637226, 63254.36745632485, 63614.0, 64083.35916640867, 11563.0, 12211.75576488483, 12272.75454490923, 12361.443735032126, 12616.432260548114, 35488.46767298441, 40866.79566602267, 41479.37780933349, 41877.371839423045, 42799.57200427956, 49699.50300496949, 50585.24122138097, 50674.23988640247, 50793.74603127108, 50913.23630145477, 12668.556600518938, 12757.936210318889, 12776.552820651232, 12864.807027894401, 12950.80573791375, 13698.315084245947, 13876.306184690928, 13944.651383715489, 13983.44066237339, 14015.089019213718, 13528.72942541124, 13602.183868967893, 13679.31603419845, 13720.93139534296, 14368.0, 14019.29903504841, 14075.507357242448, 14352.49766258176, 14425.49510767118, 14485.505510301735, 14946.925265373604, 15003.174825384709, 15017.849821501644, 15589.610259743597, 15714.371425142866, 10069.496525173565, 10173.186145108522, 10286.639967601099, 10387.428691422045, 10647.520861561403, 12378.81431778506, 12383.814242786546, 12464.688382790502, 12760.617181484571, 12828.871711282767], "value": 7533.755521131126, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1456.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 113.0, 112.0, 111.0, 113.0, 113.0, 112.0, 112.0, 113.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 114.0, 122.0, 158.0, 121.0, 116.0, 117.0, 114.0, 134.0, 119.0], "value": 125.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 160.0, 162.0, 160.0, 161.0, 162.0, 159.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 111.0, 76.0, 78.0, 76.0, 75.0, 90.0, 76.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 105.0, 82.0, 83.0, 82.0, 95.0, 82.0, 82.0, 102.0], "value": 87.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 112.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 146.0, 148.0, 147.0, 147.0, 146.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 53.0, 54.0, 53.0, 55.0, 64.0, 52.0, 53.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 53.0, 54.0, 54.0, 53.0, 54.0, 54.0, 54.0, 54.0], "value": 53.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 80.0, 81.0, 77.0, 77.0, 79.0, 76.0, 79.0, 75.0], "value": 78.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 133.0, 131.0, 130.0, 121.0, 121.0, 120.0, 129.0, 158.0, 120.0], "value": 128.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 165.0, 162.0, 168.0, 160.0, 160.0, 159.0, 158.0, 156.0], "value": 161.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 62.0, 61.0, 61.0, 59.0, 60.0, 59.0, 60.0, 59.0], "value": 60.1, "unit": "score"}]}]} 01:55:06 INFO - Return code: 0 01:55:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:55:06 ERROR - # TBPL SUCCESS # 01:55:06 INFO - Running post-action listener: _resource_record_post_action 01:55:06 INFO - [mozharness: 2017-05-09 08:55:06.680932Z] Finished run-tests step (success) 01:55:06 INFO - Running post-run listener: _resource_record_post_run 01:55:06 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 266240; Write bytes: 366792704; Read time: 28; Write time: 323536 01:55:06 INFO - TinderboxPrint: CPU usage
13.1% 01:55:06 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 28 01:55:06 INFO - TinderboxPrint: I/O write bytes / time
366,792,704 / 323,536 01:55:06 INFO - TinderboxPrint: CPU idle
8,262.7 (86.8%) 01:55:06 INFO - TinderboxPrint: CPU user
1,203.9 (12.7%) 01:55:06 INFO - TinderboxPrint: Swap in / out
0 / 0 01:55:06 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110186496; Read time: 0; Write time: 136804 01:55:06 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 266240; Write bytes: 256606208; Read time: 28; Write time: 186732 01:55:07 INFO - Running post-run listener: _upload_blobber_files 01:55:07 INFO - Blob upload gear active. 01:55:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:55:07 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 01:55:07 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:55:07 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:55:07 INFO - (blobuploader) - INFO - Open directory for files ... 01:55:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 01:55:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:55:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:55:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 01:55:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:55:08 INFO - (blobuploader) - INFO - Done attempting. 01:55:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:55:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:55:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:55:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:55:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:55:09 INFO - (blobuploader) - INFO - Done attempting. 01:55:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:55:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:55:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:55:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:55:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:55:10 INFO - (blobuploader) - INFO - Done attempting. 01:55:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:55:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:55:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:55:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:55:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:55:13 INFO - (blobuploader) - INFO - Done attempting. 01:55:13 INFO - (blobuploader) - INFO - Iteration through files over. 01:55:13 INFO - Return code: 0 01:55:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:55:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:55:13 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/3aa4e4b83b58b75b5b525bb0eed6916a2c3b85968656c8d79f8e3718c2dab828bd6dd94843788aa459ddf3bfb6c250f1af28f955bdec5836b571bc4cfbf92453", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/7abc3574c0ace31dbffa58b707f22ed134f0ab529f106bd57c71ddc80690f5b4237b541164ed9ff09d985daf563a2d98055e0672aa20292a035b72099ad97880", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/d45c723c2cfb60e48dce7d22e21d83af2b54818efc7c91ffd64f3ce17ed3e8916c6fc1fb40f5ef40c373a15b830448f853610b9d570c980096a26bbbfcbdc18d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/95a56d536b886b266ed0dd55601520725758d7893569a90a86fffea90bf7d3446d0a534d31dc29d7f478004c3d6305326ae25d270f147092e72facda1911c2a1"} 01:55:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:55:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:55:13 INFO - Contents: 01:55:13 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/3aa4e4b83b58b75b5b525bb0eed6916a2c3b85968656c8d79f8e3718c2dab828bd6dd94843788aa459ddf3bfb6c250f1af28f955bdec5836b571bc4cfbf92453", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/7abc3574c0ace31dbffa58b707f22ed134f0ab529f106bd57c71ddc80690f5b4237b541164ed9ff09d985daf563a2d98055e0672aa20292a035b72099ad97880", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/d45c723c2cfb60e48dce7d22e21d83af2b54818efc7c91ffd64f3ce17ed3e8916c6fc1fb40f5ef40c373a15b830448f853610b9d570c980096a26bbbfcbdc18d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/95a56d536b886b266ed0dd55601520725758d7893569a90a86fffea90bf7d3446d0a534d31dc29d7f478004c3d6305326ae25d270f147092e72facda1911c2a1"} 01:55:13 INFO - Running post-run listener: copy_logs_to_upload_dir 01:55:13 INFO - Copying logs to upload dir... 01:55:13 INFO - mkdir: /builds/slave/test/build/upload/logs 01:55:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.922927 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-05-09 01:55:13.011092) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-09 01:55:13.015741) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1494311131.977052-1188296730 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-Non-PGO/sha512/3aa4e4b83b58b75b5b525bb0eed6916a2c3b85968656c8d79f8e3718c2dab828bd6dd94843788aa459ddf3bfb6c250f1af28f955bdec5836b571bc4cfbf92453", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/7abc3574c0ace31dbffa58b707f22ed134f0ab529f106bd57c71ddc80690f5b4237b541164ed9ff09d985daf563a2d98055e0672aa20292a035b72099ad97880", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/d45c723c2cfb60e48dce7d22e21d83af2b54818efc7c91ffd64f3ce17ed3e8916c6fc1fb40f5ef40c373a15b830448f853610b9d570c980096a26bbbfcbdc18d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/95a56d536b886b266ed0dd55601520725758d7893569a90a86fffea90bf7d3446d0a534d31dc29d7f478004c3d6305326ae25d270f147092e72facda1911c2a1"} build_url:https://queue.taskcluster.net/v1/task/ae2r3qMpRiGfgwUKRiA_kw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011340 build_url: 'https://queue.taskcluster.net/v1/task/ae2r3qMpRiGfgwUKRiA_kw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/3aa4e4b83b58b75b5b525bb0eed6916a2c3b85968656c8d79f8e3718c2dab828bd6dd94843788aa459ddf3bfb6c250f1af28f955bdec5836b571bc4cfbf92453", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/7abc3574c0ace31dbffa58b707f22ed134f0ab529f106bd57c71ddc80690f5b4237b541164ed9ff09d985daf563a2d98055e0672aa20292a035b72099ad97880", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/d45c723c2cfb60e48dce7d22e21d83af2b54818efc7c91ffd64f3ce17ed3e8916c6fc1fb40f5ef40c373a15b830448f853610b9d570c980096a26bbbfcbdc18d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/95a56d536b886b266ed0dd55601520725758d7893569a90a86fffea90bf7d3446d0a534d31dc29d7f478004c3d6305326ae25d270f147092e72facda1911c2a1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-09 01:55:13.043726) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 01:55:13.044003) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1494311131.977052-1188296730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004517 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 01:55:13.122823) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-09 01:55:13.123127) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-09 01:55:13.126433) ========= ========= Total master_lag: 0.20 =========