builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-053 starttime: 1475075838.06 results: success (0) buildid: 20160928065829 builduid: a7e34b53d3f44a3f8151d17823acdf8d revision: b1d60f2f68c7cccc96fcf9a2075bb430a500a0f2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 08:17:18.061669) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 08:17:18.062361) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 08:17:18.062904) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 08:17:18.114132) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 08:17:18.114660) ========= 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=920470bf432669ad7e3a5387000001ca-1475072507.983756-744529977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-28 08:17:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 84.9M=0s 2016-09-28 08:17:19 (84.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084875 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 08:17:18.217896) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 08:17:18.218217) ========= 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=920470bf432669ad7e3a5387000001ca-1475072507.983756-744529977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016734 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 08:17:18.269343) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 08:17:18.269694) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b1d60f2f68c7cccc96fcf9a2075bb430a500a0f2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev b1d60f2f68c7cccc96fcf9a2075bb430a500a0f2 --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=920470bf432669ad7e3a5387000001ca-1475072507.983756-744529977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-28 08:17:19,558 truncating revision to first 12 chars 2016-09-28 08:17:19,559 Setting DEBUG logging. 2016-09-28 08:17:19,559 attempt 1/10 2016-09-28 08:17:19,559 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b1d60f2f68c7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-28 08:17:19,867 unpacking tar archive at: mozilla-central-b1d60f2f68c7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.638187 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 08:17:18.921769) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 08:17:18.922143) ========= script_repo_revision: b1d60f2f68c7cccc96fcf9a2075bb430a500a0f2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 08:17:18.922661) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 08:17:18.922982) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 08:17:18.937278) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-09-28 08:17:18.937570) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=920470bf432669ad7e3a5387000001ca-1475072507.983756-744529977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:17:20 INFO - MultiFileLogger online at 20160928 08:17:20 in /builds/slave/test 08:17:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:17:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:17:20 INFO - {'append_to_log': False, 08:17:20 INFO - 'base_work_dir': '/builds/slave/test', 08:17:20 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:17:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:17:20 INFO - 'branch': 'Firefox-Non-PGO', 08:17:20 INFO - 'buildbot_json_path': 'buildprops.json', 08:17:20 INFO - 'config_files': ('talos/linux_config.py',), 08:17:20 INFO - 'default_actions': ('clobber', 08:17:20 INFO - 'read-buildbot-config', 08:17:20 INFO - 'download-and-extract', 08:17:20 INFO - 'populate-webroot', 08:17:20 INFO - 'create-virtualenv', 08:17:20 INFO - 'install', 08:17:20 INFO - 'run-tests'), 08:17:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:17:20 INFO - 'download_minidump_stackwalk': True, 08:17:20 INFO - 'download_symbols': 'ondemand', 08:17:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:17:20 INFO - 'tooltool.py': '/tools/tooltool.py', 08:17:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:17:20 INFO - '/tools/misc-python/virtualenv.py')}, 08:17:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:17:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:17:20 INFO - 'installer_path': 'installer.exe', 08:17:20 INFO - 'log_level': 'info', 08:17:20 INFO - 'log_name': 'talos', 08:17:20 INFO - 'log_to_console': True, 08:17:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:17:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:17:20 INFO - 'opt_config_files': (), 08:17:20 INFO - 'pip_index': False, 08:17:20 INFO - 'sps_profile': False, 08:17:20 INFO - 'sps_profile_interval': 0, 08:17:20 INFO - 'suite': 'dromaeojs', 08:17:20 INFO - 'system_bits': '32', 08:17:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:17:20 INFO - 'title': 'talos-linux64-ix-053', 08:17:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:17:20 INFO - 'use_talos_json': True, 08:17:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:17:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:17:20 INFO - 'work_dir': 'build'} 08:17:20 INFO - [mozharness: 2016-09-28 15:17:20.328747Z] Running clobber step. 08:17:20 INFO - Running pre-action listener: _resource_record_pre_action 08:17:20 INFO - Running main action method: clobber 08:17:20 INFO - rmtree: /builds/slave/test/build 08:17:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:17:20 INFO - Running post-action listener: _resource_record_post_action 08:17:20 INFO - [mozharness: 2016-09-28 15:17:20.784330Z] Finished clobber step (success) 08:17:20 INFO - [mozharness: 2016-09-28 15:17:20.784429Z] Running read-buildbot-config step. 08:17:20 INFO - Running pre-action listener: _resource_record_pre_action 08:17:20 INFO - Running main action method: read_buildbot_config 08:17:20 INFO - Using buildbot properties: 08:17:20 INFO - { 08:17:20 INFO - "project": "", 08:17:20 INFO - "product": "firefox", 08:17:20 INFO - "script_repo_revision": "production", 08:17:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:17:20 INFO - "repository": "", 08:17:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 08:17:20 INFO - "buildid": "20160928065829", 08:17:20 INFO - "pgo_build": "False", 08:17:20 INFO - "basedir": "/builds/slave/test", 08:17:20 INFO - "buildnumber": 759, 08:17:20 INFO - "slavename": "talos-linux64-ix-053", 08:17:20 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:17:20 INFO - "platform": "ubuntu64_hw", 08:17:20 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:17:20 INFO - "branch": "mozilla-central", 08:17:20 INFO - "repo_path": "mozilla-central", 08:17:20 INFO - "revision": "b1d60f2f68c7cccc96fcf9a2075bb430a500a0f2", 08:17:20 INFO - "stage_platform": "linux64", 08:17:20 INFO - "builduid": "a7e34b53d3f44a3f8151d17823acdf8d", 08:17:20 INFO - "slavebuilddir": "test" 08:17:20 INFO - } 08:17:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/cnGGjv6ORcKHkQAzsH7YWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 08:17:20 INFO - Running post-action listener: _resource_record_post_action 08:17:20 INFO - [mozharness: 2016-09-28 15:17:20.786901Z] Finished read-buildbot-config step (success) 08:17:20 INFO - [mozharness: 2016-09-28 15:17:20.786989Z] Running download-and-extract step. 08:17:20 INFO - Running pre-action listener: _resource_record_pre_action 08:17:20 INFO - Running main action method: download_and_extract 08:17:20 INFO - mkdir: /builds/slave/test/build/tests 08:17:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:20 INFO - trying https://queue.taskcluster.net/v1/task/cnGGjv6ORcKHkQAzsH7YWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 08:17:20 INFO - Downloading https://queue.taskcluster.net/v1/task/cnGGjv6ORcKHkQAzsH7YWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 08:17:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cnGGjv6ORcKHkQAzsH7YWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:17:21 INFO - Downloaded 1361 bytes. 08:17:21 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 08:17:21 INFO - Using the following test package requirements: 08:17:21 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 08:17:21 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:17:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:17:21 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:17:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:17:21 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:17:21 INFO - u'jsshell-linux-x86_64.zip'], 08:17:21 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:17:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:17:21 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 08:17:21 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:17:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:17:21 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:17:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:17:21 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:17:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:17:21 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:17:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:17:21 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:17:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cnGGjv6ORcKHkQAzsH7YWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 08:17:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cnGGjv6ORcKHkQAzsH7YWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:17:21 INFO - Fetch https://queue.taskcluster.net/v1/task/cnGGjv6ORcKHkQAzsH7YWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:17:21 INFO - Expected file size: 20415300 08:17:21 INFO - Content-Encoding None 08:17:21 INFO - Content-Type application/zip 08:17:21 INFO - Http code 200 08:17:26 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:17:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cnGGjv6ORcKHkQAzsH7YWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 08:17:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cnGGjv6ORcKHkQAzsH7YWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:17:26 INFO - Fetch https://queue.taskcluster.net/v1/task/cnGGjv6ORcKHkQAzsH7YWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:17:27 INFO - Expected file size: 20415300 08:17:27 INFO - Content-Encoding None 08:17:27 INFO - Content-Type application/zip 08:17:27 INFO - Http code 200 08:17:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cnGGjv6ORcKHkQAzsH7YWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 08:17:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cnGGjv6ORcKHkQAzsH7YWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:17:32 INFO - Fetch https://queue.taskcluster.net/v1/task/cnGGjv6ORcKHkQAzsH7YWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 08:17:33 INFO - Expected file size: 14414067 08:17:33 INFO - Content-Encoding None 08:17:33 INFO - Content-Type application/zip 08:17:33 INFO - Http code 200 08:17:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:33 INFO - trying https://queue.taskcluster.net/v1/task/cnGGjv6ORcKHkQAzsH7YWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:17:33 INFO - Downloading https://queue.taskcluster.net/v1/task/cnGGjv6ORcKHkQAzsH7YWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:17:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cnGGjv6ORcKHkQAzsH7YWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:17:36 INFO - Downloaded 55737403 bytes. 08:17:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cnGGjv6ORcKHkQAzsH7YWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:17:36 INFO - mkdir: /builds/slave/test/properties 08:17:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:17:36 INFO - Writing to file /builds/slave/test/properties/build_url 08:17:36 INFO - Contents: 08:17:36 INFO - build_url:https://queue.taskcluster.net/v1/task/cnGGjv6ORcKHkQAzsH7YWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:17:37 INFO - Running post-action listener: _resource_record_post_action 08:17:37 INFO - Running post-action listener: set_extra_try_arguments 08:17:37 INFO - [mozharness: 2016-09-28 15:17:37.114094Z] Finished download-and-extract step (success) 08:17:37 INFO - [mozharness: 2016-09-28 15:17:37.114320Z] Running populate-webroot step. 08:17:37 INFO - Running pre-action listener: _resource_record_pre_action 08:17:37 INFO - Running main action method: populate_webroot 08:17:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:17:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:17:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:17:37 INFO - '--tppagecycles', 08:17:37 INFO - '7'], 08:17:37 INFO - 'tests': ['tsvgm']}}, 08:17:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:17:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:17:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:17:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:17:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:17:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:17:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:17:37 INFO - 'talos_options': ['--disable-e10s'], 08:17:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:17:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:17:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:17:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:17:37 INFO - 'talos_options': ['--disable-e10s'], 08:17:37 INFO - 'tests': ['damp', 'tps']}, 08:17:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:17:37 INFO - 'tests': ['damp', 'tps']}, 08:17:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:17:37 INFO - 'tests': ['dromaeo_dom']}, 08:17:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:17:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:17:37 INFO - 'tests': ['basic_compositor_video']}, 08:17:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:17:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:17:37 INFO - 'tests': ['a11yr', 08:17:37 INFO - 'ts_paint', 08:17:37 INFO - 'tpaint', 08:17:37 INFO - 'sessionrestore', 08:17:37 INFO - 'sessionrestore_no_auto_restore', 08:17:37 INFO - 'tabpaint']}, 08:17:37 INFO - 'other-e10s': {'tests': ['a11yr', 08:17:37 INFO - 'ts_paint', 08:17:37 INFO - 'tpaint', 08:17:37 INFO - 'sessionrestore', 08:17:37 INFO - 'sessionrestore_no_auto_restore', 08:17:37 INFO - 'tabpaint']}, 08:17:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:17:37 INFO - 'ts_paint', 08:17:37 INFO - 'tpaint', 08:17:37 INFO - 'sessionrestore', 08:17:37 INFO - 'sessionrestore_no_auto_restore', 08:17:37 INFO - 'tabpaint']}, 08:17:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:17:37 INFO - 'ts_paint', 08:17:37 INFO - 'tpaint', 08:17:37 INFO - 'sessionrestore', 08:17:37 INFO - 'sessionrestore_no_auto_restore', 08:17:37 INFO - 'tabpaint']}, 08:17:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:17:37 INFO - 'tests': ['a11yr', 08:17:37 INFO - 'ts_paint', 08:17:37 INFO - 'tpaint', 08:17:37 INFO - 'sessionrestore', 08:17:37 INFO - 'sessionrestore_no_auto_restore', 08:17:37 INFO - 'tabpaint']}, 08:17:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:17:37 INFO - 'tests': ['a11yr', 08:17:37 INFO - 'ts_paint', 08:17:37 INFO - 'tpaint', 08:17:37 INFO - 'sessionrestore', 08:17:37 INFO - 'sessionrestore_no_auto_restore', 08:17:37 INFO - 'tabpaint']}, 08:17:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:17:37 INFO - 'tests': ['tsvgx', 08:17:37 INFO - 'tsvgr_opacity', 08:17:37 INFO - 'tart', 08:17:37 INFO - 'tscrollx', 08:17:37 INFO - 'cart']}, 08:17:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:17:37 INFO - 'tsvgr_opacity', 08:17:37 INFO - 'tart', 08:17:37 INFO - 'tscrollx', 08:17:37 INFO - 'cart']}, 08:17:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:17:37 INFO - 'talos_options': ['--disable-e10s'], 08:17:37 INFO - 'tests': ['tp5o']}, 08:17:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:17:37 INFO - 'tests': ['tp5o']}, 08:17:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:17:37 INFO - 'talos_options': ['--disable-e10s', 08:17:37 INFO - '--xperf_path', 08:17:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:17:37 INFO - 'tests': ['tp5n']}, 08:17:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:17:37 INFO - 'talos_options': ['--xperf_path', 08:17:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:17:37 INFO - 'tests': ['tp5n']}}, 08:17:37 INFO - 'talos.zip': {'path': '', 08:17:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:17:37 INFO - Running post-action listener: _resource_record_post_action 08:17:37 INFO - [mozharness: 2016-09-28 15:17:37.134635Z] Finished populate-webroot step (success) 08:17:37 INFO - [mozharness: 2016-09-28 15:17:37.134723Z] Running create-virtualenv step. 08:17:37 INFO - Running pre-action listener: _resource_record_pre_action 08:17:37 INFO - Running main action method: create_virtualenv 08:17:37 INFO - Creating virtualenv /builds/slave/test/build/venv 08:17:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:17:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:17:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:17:37 INFO - Using real prefix '/usr' 08:17:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:17:37 INFO - Installing distribute.............................................................................................................................................................................................done. 08:17:39 INFO - Installing pip.................done. 08:17:39 INFO - Return code: 0 08:17:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:17:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:17:39 INFO - Reading from file tmpfile_stdout 08:17:39 INFO - Output received: 08:17:39 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:17:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:39 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 0x7fc2920a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf58f60>, '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 0xf59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5a1d0>, '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': '920470bf432669ad7e3a5387000001ca-1475072507.983756-744529977', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:17:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:17:39 INFO - Using env: {'DISPLAY': ':0', 08:17:39 INFO - 'HOME': '/home/cltbld', 08:17:39 INFO - 'LANG': 'en_US.UTF-8', 08:17:39 INFO - 'LANGUAGE': 'en_US:en', 08:17:39 INFO - 'LOGNAME': 'cltbld', 08:17:39 INFO - 'MAIL': '/var/mail/cltbld', 08:17:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:39 INFO - 'MOZ_NO_REMOTE': '1', 08:17:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:39 INFO - 'NO_EM_RESTART': '1', 08:17:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:39 INFO - 'PWD': '/builds/slave/test', 08:17:39 INFO - 'SHELL': '/bin/bash', 08:17:39 INFO - 'SHLVL': '1', 08:17:39 INFO - 'TERM': 'linux', 08:17:39 INFO - 'TMOUT': '86400', 08:17:39 INFO - 'USER': 'cltbld', 08:17:39 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475072507.983756-744529977', 08:17:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:39 INFO - '_': '/tools/buildbot/bin/python'} 08:17:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:17:40 INFO - Cleaning up... 08:17:40 INFO - Return code: 0 08:17:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:17:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:40 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 0x7fc2920a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf58f60>, '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 0xf59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5a1d0>, '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': '920470bf432669ad7e3a5387000001ca-1475072507.983756-744529977', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:17:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:17:40 INFO - Using env: {'DISPLAY': ':0', 08:17:40 INFO - 'HOME': '/home/cltbld', 08:17:40 INFO - 'LANG': 'en_US.UTF-8', 08:17:40 INFO - 'LANGUAGE': 'en_US:en', 08:17:40 INFO - 'LOGNAME': 'cltbld', 08:17:40 INFO - 'MAIL': '/var/mail/cltbld', 08:17:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:40 INFO - 'MOZ_NO_REMOTE': '1', 08:17:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:40 INFO - 'NO_EM_RESTART': '1', 08:17:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:40 INFO - 'PWD': '/builds/slave/test', 08:17:40 INFO - 'SHELL': '/bin/bash', 08:17:40 INFO - 'SHLVL': '1', 08:17:40 INFO - 'TERM': 'linux', 08:17:40 INFO - 'TMOUT': '86400', 08:17:40 INFO - 'USER': 'cltbld', 08:17:40 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475072507.983756-744529977', 08:17:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:40 INFO - '_': '/tools/buildbot/bin/python'} 08:17:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:40 INFO - Downloading/unpacking psutil>=3.1.1 08:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:17:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:17:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:17:42 INFO - Installing collected packages: psutil 08:17:42 INFO - Running setup.py install for psutil 08:17:42 INFO - building 'psutil._psutil_linux' extension 08:17:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:17:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:17:42 INFO - building 'psutil._psutil_posix' extension 08:17:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:17:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:17:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:17:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:17:42 INFO - Successfully installed psutil 08:17:42 INFO - Cleaning up... 08:17:42 INFO - Return code: 0 08:17:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:42 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 0x7fc2920a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf58f60>, '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 0xf59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5a1d0>, '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': '920470bf432669ad7e3a5387000001ca-1475072507.983756-744529977', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:17:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:17:42 INFO - Using env: {'DISPLAY': ':0', 08:17:42 INFO - 'HOME': '/home/cltbld', 08:17:42 INFO - 'LANG': 'en_US.UTF-8', 08:17:42 INFO - 'LANGUAGE': 'en_US:en', 08:17:42 INFO - 'LOGNAME': 'cltbld', 08:17:42 INFO - 'MAIL': '/var/mail/cltbld', 08:17:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:42 INFO - 'MOZ_NO_REMOTE': '1', 08:17:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:42 INFO - 'NO_EM_RESTART': '1', 08:17:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:42 INFO - 'PWD': '/builds/slave/test', 08:17:42 INFO - 'SHELL': '/bin/bash', 08:17:42 INFO - 'SHLVL': '1', 08:17:42 INFO - 'TERM': 'linux', 08:17:42 INFO - 'TMOUT': '86400', 08:17:42 INFO - 'USER': 'cltbld', 08:17:42 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475072507.983756-744529977', 08:17:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:42 INFO - '_': '/tools/buildbot/bin/python'} 08:17:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:17:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:17:45 INFO - Installing collected packages: mozsystemmonitor 08:17:45 INFO - Running setup.py install for mozsystemmonitor 08:17:45 INFO - Successfully installed mozsystemmonitor 08:17:45 INFO - Cleaning up... 08:17:45 INFO - Return code: 0 08:17:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2920a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf58f60>, '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 0xf59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5a1d0>, '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': '920470bf432669ad7e3a5387000001ca-1475072507.983756-744529977', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:17:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:17:45 INFO - Using env: {'DISPLAY': ':0', 08:17:45 INFO - 'HOME': '/home/cltbld', 08:17:45 INFO - 'LANG': 'en_US.UTF-8', 08:17:45 INFO - 'LANGUAGE': 'en_US:en', 08:17:45 INFO - 'LOGNAME': 'cltbld', 08:17:45 INFO - 'MAIL': '/var/mail/cltbld', 08:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:45 INFO - 'MOZ_NO_REMOTE': '1', 08:17:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:45 INFO - 'NO_EM_RESTART': '1', 08:17:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:45 INFO - 'PWD': '/builds/slave/test', 08:17:45 INFO - 'SHELL': '/bin/bash', 08:17:45 INFO - 'SHLVL': '1', 08:17:45 INFO - 'TERM': 'linux', 08:17:45 INFO - 'TMOUT': '86400', 08:17:45 INFO - 'USER': 'cltbld', 08:17:45 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475072507.983756-744529977', 08:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:45 INFO - '_': '/tools/buildbot/bin/python'} 08:17:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:45 INFO - Downloading/unpacking jsonschema==2.5.1 08:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:17:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:47 INFO - Downloading functools32-3.2.3-2.tar.gz 08:17:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:17:47 INFO - warning: no files found matching '*.txt' 08:17:47 INFO - no previously-included directories found matching 'build' 08:17:47 INFO - no previously-included directories found matching 'dist' 08:17:47 INFO - no previously-included directories found matching '.git*' 08:17:47 INFO - Installing collected packages: jsonschema, functools32 08:17:47 INFO - Running setup.py install for functools32 08:17:47 INFO - warning: no files found matching '*.txt' 08:17:47 INFO - no previously-included directories found matching 'build' 08:17:47 INFO - no previously-included directories found matching 'dist' 08:17:47 INFO - no previously-included directories found matching '.git*' 08:17:47 INFO - Successfully installed jsonschema functools32 08:17:47 INFO - Cleaning up... 08:17:47 INFO - Return code: 0 08:17:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:47 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 0x7fc2920a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf58f60>, '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 0xf59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5a1d0>, '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': '920470bf432669ad7e3a5387000001ca-1475072507.983756-744529977', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:17:47 INFO - Using env: {'DISPLAY': ':0', 08:17:47 INFO - 'HOME': '/home/cltbld', 08:17:47 INFO - 'LANG': 'en_US.UTF-8', 08:17:47 INFO - 'LANGUAGE': 'en_US:en', 08:17:47 INFO - 'LOGNAME': 'cltbld', 08:17:47 INFO - 'MAIL': '/var/mail/cltbld', 08:17:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:47 INFO - 'MOZ_NO_REMOTE': '1', 08:17:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:47 INFO - 'NO_EM_RESTART': '1', 08:17:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:47 INFO - 'PWD': '/builds/slave/test', 08:17:47 INFO - 'SHELL': '/bin/bash', 08:17:47 INFO - 'SHLVL': '1', 08:17:47 INFO - 'TERM': 'linux', 08:17:47 INFO - 'TMOUT': '86400', 08:17:47 INFO - 'USER': 'cltbld', 08:17:47 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475072507.983756-744529977', 08:17:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:47 INFO - '_': '/tools/buildbot/bin/python'} 08:17:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:17:48 INFO - Cleaning up... 08:17:48 INFO - Return code: 0 08:17:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:48 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 0x7fc2920a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf58f60>, '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 0xf59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5a1d0>, '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': '920470bf432669ad7e3a5387000001ca-1475072507.983756-744529977', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:17:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:17:48 INFO - Using env: {'DISPLAY': ':0', 08:17:48 INFO - 'HOME': '/home/cltbld', 08:17:48 INFO - 'LANG': 'en_US.UTF-8', 08:17:48 INFO - 'LANGUAGE': 'en_US:en', 08:17:48 INFO - 'LOGNAME': 'cltbld', 08:17:48 INFO - 'MAIL': '/var/mail/cltbld', 08:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:48 INFO - 'MOZ_NO_REMOTE': '1', 08:17:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:48 INFO - 'NO_EM_RESTART': '1', 08:17:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:48 INFO - 'PWD': '/builds/slave/test', 08:17:48 INFO - 'SHELL': '/bin/bash', 08:17:48 INFO - 'SHLVL': '1', 08:17:48 INFO - 'TERM': 'linux', 08:17:48 INFO - 'TMOUT': '86400', 08:17:48 INFO - 'USER': 'cltbld', 08:17:48 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475072507.983756-744529977', 08:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:48 INFO - '_': '/tools/buildbot/bin/python'} 08:17:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:48 INFO - Downloading/unpacking blobuploader==1.2.4 08:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:50 INFO - Downloading blobuploader-1.2.4.tar.gz 08:17:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:17:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:17:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:50 INFO - Downloading docopt-0.6.1.tar.gz 08:17:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:17:50 INFO - Installing collected packages: blobuploader, requests, docopt 08:17:50 INFO - Running setup.py install for blobuploader 08:17:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:17:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:17:50 INFO - Running setup.py install for requests 08:17:51 INFO - Running setup.py install for docopt 08:17:51 INFO - Successfully installed blobuploader requests docopt 08:17:51 INFO - Cleaning up... 08:17:51 INFO - Return code: 0 08:17:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:17:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:51 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 0x7fc2920a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf58f60>, '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 0xf59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5a1d0>, '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': '920470bf432669ad7e3a5387000001ca-1475072507.983756-744529977', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:17:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:17:51 INFO - Using env: {'DISPLAY': ':0', 08:17:51 INFO - 'HOME': '/home/cltbld', 08:17:51 INFO - 'LANG': 'en_US.UTF-8', 08:17:51 INFO - 'LANGUAGE': 'en_US:en', 08:17:51 INFO - 'LOGNAME': 'cltbld', 08:17:51 INFO - 'MAIL': '/var/mail/cltbld', 08:17:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:51 INFO - 'MOZ_NO_REMOTE': '1', 08:17:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:51 INFO - 'NO_EM_RESTART': '1', 08:17:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:51 INFO - 'PWD': '/builds/slave/test', 08:17:51 INFO - 'SHELL': '/bin/bash', 08:17:51 INFO - 'SHLVL': '1', 08:17:51 INFO - 'TERM': 'linux', 08:17:51 INFO - 'TMOUT': '86400', 08:17:51 INFO - 'USER': 'cltbld', 08:17:51 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475072507.983756-744529977', 08:17:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:51 INFO - '_': '/tools/buildbot/bin/python'} 08:17:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:17:51 INFO - Running setup.py (path:/tmp/pip-5eiT7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:17:51 INFO - Running setup.py (path:/tmp/pip-eaDP0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:17:51 INFO - Running setup.py (path:/tmp/pip-edrc_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:17:51 INFO - Running setup.py (path:/tmp/pip-0rWBKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:17:51 INFO - Running setup.py (path:/tmp/pip-TpQ0z0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:17:52 INFO - Running setup.py (path:/tmp/pip-rvLOlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:17:52 INFO - Running setup.py (path:/tmp/pip-enseeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:17:52 INFO - Running setup.py (path:/tmp/pip-yNOQQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:17:52 INFO - Running setup.py (path:/tmp/pip-Z96WJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:17:52 INFO - Running setup.py (path:/tmp/pip-GM2nGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:17:52 INFO - Running setup.py (path:/tmp/pip-3YzahC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:17:52 INFO - Running setup.py (path:/tmp/pip-tWPQ4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:17:52 INFO - Running setup.py (path:/tmp/pip-Y8sJ27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:17:52 INFO - Running setup.py (path:/tmp/pip-ZRjcAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:52 INFO - Running setup.py (path:/tmp/pip-8STKcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:17:52 INFO - Running setup.py (path:/tmp/pip-QSPL2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:17:52 INFO - Running setup.py (path:/tmp/pip-c_D2YM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:17:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:17:52 INFO - Running setup.py install for manifestparser 08:17:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:17:53 INFO - Running setup.py install for mozcrash 08:17:53 INFO - Running setup.py install for mozdebug 08:17:53 INFO - Running setup.py install for mozdevice 08:17:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:17:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:17:53 INFO - Running setup.py install for mozfile 08:17:53 INFO - Running setup.py install for mozhttpd 08:17:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:17:53 INFO - Running setup.py install for mozinfo 08:17:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:17:53 INFO - Running setup.py install for mozInstall 08:17:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:17:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:17:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:17:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:17:53 INFO - Running setup.py install for mozleak 08:17:53 INFO - Running setup.py install for mozlog 08:17:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:17:53 INFO - Running setup.py install for moznetwork 08:17:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:17:54 INFO - Running setup.py install for mozprocess 08:17:54 INFO - Running setup.py install for mozprofile 08:17:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:17:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:17:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:17:54 INFO - Running setup.py install for mozrunner 08:17:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:17:54 INFO - Running setup.py install for mozscreenshot 08:17:54 INFO - Running setup.py install for moztest 08:17:54 INFO - Running setup.py install for mozversion 08:17:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:17:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:17:54 INFO - Cleaning up... 08:17:54 INFO - Return code: 0 08:17:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:54 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 0x7fc2920a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf58f60>, '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 0xf59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5a1d0>, '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': '920470bf432669ad7e3a5387000001ca-1475072507.983756-744529977', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:17:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:17:54 INFO - Using env: {'DISPLAY': ':0', 08:17:54 INFO - 'HOME': '/home/cltbld', 08:17:54 INFO - 'LANG': 'en_US.UTF-8', 08:17:54 INFO - 'LANGUAGE': 'en_US:en', 08:17:54 INFO - 'LOGNAME': 'cltbld', 08:17:54 INFO - 'MAIL': '/var/mail/cltbld', 08:17:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:54 INFO - 'MOZ_NO_REMOTE': '1', 08:17:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:54 INFO - 'NO_EM_RESTART': '1', 08:17:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:54 INFO - 'PWD': '/builds/slave/test', 08:17:54 INFO - 'SHELL': '/bin/bash', 08:17:54 INFO - 'SHLVL': '1', 08:17:54 INFO - 'TERM': 'linux', 08:17:54 INFO - 'TMOUT': '86400', 08:17:54 INFO - 'USER': 'cltbld', 08:17:54 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475072507.983756-744529977', 08:17:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:54 INFO - '_': '/tools/buildbot/bin/python'} 08:17:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:17:54 INFO - Running setup.py (path:/tmp/pip-jek33Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:17:55 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:17:55 INFO - Running setup.py (path:/tmp/pip-B36Igq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:17:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:17:55 INFO - Running setup.py (path:/tmp/pip-wgJFGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:17:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:17:55 INFO - Running setup.py (path:/tmp/pip-KMY0Rd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:17:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:17:55 INFO - Running setup.py (path:/tmp/pip-J5Tfj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:17:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:17:55 INFO - Running setup.py (path:/tmp/pip-Pu_SFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:17:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:17:55 INFO - Running setup.py (path:/tmp/pip-pZ3wKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:17:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:17:55 INFO - Running setup.py (path:/tmp/pip-GsHGlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:17:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:17:55 INFO - Running setup.py (path:/tmp/pip-DMh1RE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:17:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:17:55 INFO - Running setup.py (path:/tmp/pip-_uIwHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:17:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:17:55 INFO - Running setup.py (path:/tmp/pip-tY4jXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:17:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:17:55 INFO - Running setup.py (path:/tmp/pip-wxgUIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:17:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:17:55 INFO - Running setup.py (path:/tmp/pip-WMHNf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:17:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:17:55 INFO - Running setup.py (path:/tmp/pip-VTsSQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:17:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:55 INFO - Running setup.py (path:/tmp/pip-HaPPml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:17:56 INFO - Running setup.py (path:/tmp/pip-bGlDEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:17:56 INFO - Running setup.py (path:/tmp/pip-BySZ3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:17:56 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:17:56 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:17:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:58 INFO - Downloading blessings-1.6.tar.gz 08:17:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:17:58 INFO - Installing collected packages: blessings 08:17:58 INFO - Running setup.py install for blessings 08:17:58 INFO - Successfully installed blessings 08:17:58 INFO - Cleaning up... 08:17:58 INFO - Return code: 0 08:17:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:17:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:17:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:17:58 INFO - Reading from file tmpfile_stdout 08:17:58 INFO - Current package versions: 08:17:58 INFO - argparse == 1.2.1 08:17:58 INFO - blessings == 1.6 08:17:58 INFO - blobuploader == 1.2.4 08:17:58 INFO - docopt == 0.6.1 08:17:58 INFO - functools32 == 3.2.3-2 08:17:58 INFO - jsonschema == 2.5.1 08:17:58 INFO - manifestparser == 1.1 08:17:58 INFO - mozInstall == 1.12 08:17:58 INFO - mozcrash == 0.17 08:17:58 INFO - mozdebug == 0.1 08:17:58 INFO - mozdevice == 0.48 08:17:58 INFO - mozfile == 1.2 08:17:58 INFO - mozhttpd == 0.7 08:17:58 INFO - mozinfo == 0.9 08:17:58 INFO - mozleak == 0.1 08:17:58 INFO - mozlog == 3.4 08:17:58 INFO - moznetwork == 0.27 08:17:58 INFO - mozprocess == 0.23 08:17:58 INFO - mozprofile == 0.28 08:17:58 INFO - mozrunner == 6.12 08:17:58 INFO - mozscreenshot == 0.1 08:17:58 INFO - mozsystemmonitor == 0.3 08:17:58 INFO - moztest == 0.7 08:17:58 INFO - mozversion == 1.4 08:17:58 INFO - psutil == 3.1.1 08:17:58 INFO - requests == 1.2.3 08:17:58 INFO - wsgiref == 0.1.2 08:17:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:58 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 0x7fc2920a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf58f60>, '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 0xf59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5a1d0>, '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': '920470bf432669ad7e3a5387000001ca-1475072507.983756-744529977', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:17:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:17:58 INFO - Using env: {'DISPLAY': ':0', 08:17:58 INFO - 'HOME': '/home/cltbld', 08:17:58 INFO - 'LANG': 'en_US.UTF-8', 08:17:58 INFO - 'LANGUAGE': 'en_US:en', 08:17:58 INFO - 'LOGNAME': 'cltbld', 08:17:58 INFO - 'MAIL': '/var/mail/cltbld', 08:17:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:58 INFO - 'MOZ_NO_REMOTE': '1', 08:17:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:58 INFO - 'NO_EM_RESTART': '1', 08:17:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:58 INFO - 'PWD': '/builds/slave/test', 08:17:58 INFO - 'SHELL': '/bin/bash', 08:17:58 INFO - 'SHLVL': '1', 08:17:58 INFO - 'TERM': 'linux', 08:17:58 INFO - 'TMOUT': '86400', 08:17:58 INFO - 'USER': 'cltbld', 08:17:58 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475072507.983756-744529977', 08:17:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:58 INFO - '_': '/tools/buildbot/bin/python'} 08:17:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:17:58 INFO - Cleaning up... 08:17:58 INFO - Return code: 0 08:17:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:58 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 0x7fc2920a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf58f60>, '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 0xf59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5a1d0>, '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': '920470bf432669ad7e3a5387000001ca-1475072507.983756-744529977', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:17:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:17:58 INFO - Using env: {'DISPLAY': ':0', 08:17:58 INFO - 'HOME': '/home/cltbld', 08:17:58 INFO - 'LANG': 'en_US.UTF-8', 08:17:58 INFO - 'LANGUAGE': 'en_US:en', 08:17:58 INFO - 'LOGNAME': 'cltbld', 08:17:58 INFO - 'MAIL': '/var/mail/cltbld', 08:17:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:58 INFO - 'MOZ_NO_REMOTE': '1', 08:17:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:58 INFO - 'NO_EM_RESTART': '1', 08:17:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:58 INFO - 'PWD': '/builds/slave/test', 08:17:58 INFO - 'SHELL': '/bin/bash', 08:17:58 INFO - 'SHLVL': '1', 08:17:58 INFO - 'TERM': 'linux', 08:17:58 INFO - 'TMOUT': '86400', 08:17:58 INFO - 'USER': 'cltbld', 08:17:58 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475072507.983756-744529977', 08:17:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:58 INFO - '_': '/tools/buildbot/bin/python'} 08:17:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:17:58 INFO - Cleaning up... 08:17:59 INFO - Return code: 0 08:17:59 INFO - Running post-action listener: _resource_record_post_action 08:17:59 INFO - Running post-action listener: _start_resource_monitoring 08:17:59 INFO - Starting resource monitoring. 08:17:59 INFO - [mozharness: 2016-09-28 15:17:59.032926Z] Finished create-virtualenv step (success) 08:17:59 INFO - [mozharness: 2016-09-28 15:17:59.033540Z] Running install step. 08:17:59 INFO - Running pre-action listener: _resource_record_pre_action 08:17:59 INFO - Running main action method: install 08:17:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:17:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:17:59 INFO - Reading from file tmpfile_stdout 08:17:59 INFO - Detecting whether we're running mozinstall >=1.0... 08:17:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:17:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:17:59 INFO - Reading from file tmpfile_stdout 08:17:59 INFO - Output received: 08:17:59 INFO - Usage: mozinstall [options] installer 08:17:59 INFO - Options: 08:17:59 INFO - -h, --help show this help message and exit 08:17:59 INFO - -d DEST, --destination=DEST 08:17:59 INFO - Directory to install application into. [default: 08:17:59 INFO - "/builds/slave/test"] 08:17:59 INFO - --app=APP Application being installed. [default: firefox] 08:17:59 INFO - mkdir: /builds/slave/test/build/application 08:17:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:17:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:18:15 INFO - Reading from file tmpfile_stdout 08:18:15 INFO - Output received: 08:18:15 INFO - /builds/slave/test/build/application/firefox/firefox 08:18:15 INFO - Running post-action listener: _resource_record_post_action 08:18:15 INFO - [mozharness: 2016-09-28 15:18:15.496570Z] Finished install step (success) 08:18:15 INFO - [mozharness: 2016-09-28 15:18:15.496906Z] Running run-tests step. 08:18:15 INFO - Running pre-action listener: _resource_record_pre_action 08:18:15 INFO - Running main action method: run_tests 08:18:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:18:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:18:15 INFO - Python 2.7.3 08:18:15 INFO - Return code: 0 08:18:15 INFO - grabbing minidump binary from tooltool 08:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:18:15 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 0xf58f60>, '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 0xf59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5a1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:18:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:18:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:18:15 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:18:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:18:15 INFO - Return code: 0 08:18:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:18:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:18:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:18:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:18:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:18:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cnGGjv6ORcKHkQAzsH7YWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:18:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cnGGjv6ORcKHkQAzsH7YWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:18:15 INFO - Using env: {'DISPLAY': ':0', 08:18:15 INFO - 'HOME': '/home/cltbld', 08:18:15 INFO - 'LANG': 'en_US.UTF-8', 08:18:15 INFO - 'LANGUAGE': 'en_US:en', 08:18:15 INFO - 'LOGNAME': 'cltbld', 08:18:15 INFO - 'MAIL': '/var/mail/cltbld', 08:18:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:18:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:18:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:15 INFO - 'MOZ_NO_REMOTE': '1', 08:18:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:18:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:15 INFO - 'NO_EM_RESTART': '1', 08:18:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:15 INFO - 'PWD': '/builds/slave/test', 08:18:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:18:15 INFO - 'SHELL': '/bin/bash', 08:18:15 INFO - 'SHLVL': '1', 08:18:15 INFO - 'TERM': 'linux', 08:18:15 INFO - 'TMOUT': '86400', 08:18:15 INFO - 'USER': 'cltbld', 08:18:15 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475072507.983756-744529977', 08:18:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:15 INFO - '_': '/tools/buildbot/bin/python'} 08:18:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cnGGjv6ORcKHkQAzsH7YWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:18:15 INFO - mozversion application_buildid: 20160928065829 08:18:15 INFO - mozversion application_changeset: b1d60f2f68c7cccc96fcf9a2075bb430a500a0f2 08:18:15 INFO - mozversion application_display_name: Nightly 08:18:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:18:15 INFO - mozversion application_name: Firefox 08:18:15 INFO - mozversion application_remotingname: firefox 08:18:15 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:18:15 INFO - mozversion application_vendor: Mozilla 08:18:15 INFO - mozversion application_version: 52.0a1 08:18:15 INFO - mozversion platform_buildid: 20160928065829 08:18:15 INFO - mozversion platform_changeset: b1d60f2f68c7cccc96fcf9a2075bb430a500a0f2 08:18:15 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:18:15 INFO - mozversion platform_version: 52.0a1 08:18:15 INFO - using testdate: 1475075895 08:18:15 INFO - actual date: 1475075895 08:18:15 INFO - starting webserver on 'localhost:33813' 08:18:15 INFO - SUITE-START | Running 2 tests 08:18:15 INFO - TEST-START | dromaeo_css 08:18:15 INFO - operating with platform_type : linux_ 08:18:15 INFO - Initialising browser for dromaeo_css test... 08:18:15 INFO - TEST-INFO | started process 12903 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX0h5XN/profile http://localhost:33813/getInfo.html) 08:18:20 INFO - PROCESS | 12903 | __metrics Screen width/height:1600/1200 08:18:20 INFO - PROCESS | 12903 | colorDepth:24 08:18:20 INFO - PROCESS | 12903 | Browser inner width/height: 1024/697 08:18:20 INFO - PROCESS | 12903 | __metrics 08:18:21 INFO - PROCESS | 12903 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:18:21 INFO - PROCESS | 12903 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:18:22 INFO - PROCESS | 12903 | console.error: PushService: 08:18:22 INFO - PROCESS | 12903 | stateChangeProcessEnqueue: Error transitioning state 08:18:22 INFO - PROCESS | 12903 | UnknownError 08:18:22 INFO - TEST-INFO | 12903: exit 0 08:18:22 INFO - Browser initialized. 08:18:22 INFO - Running cycle 1/1 for dromaeo_css test... 08:18:22 INFO - TEST-INFO | started process 12982 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX0h5XN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:18:34 INFO - PROCESS | 12982 | RSS: Main: 175136768 08:18:34 INFO - PROCESS | 12982 | 08:19:26 INFO - PROCESS | 12982 | 1475075966567 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:21:39 INFO - PROCESS | 12982 | Cycle 1(1): loaded http://localhost:33813/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33813/tests/dromaeo/cssquery-ext.html) 08:21:40 INFO - PROCESS | 12982 | RSS: Main: 305823744 08:21:40 INFO - PROCESS | 12982 | 08:24:43 INFO - PROCESS | 12982 | Cycle 1(1): loaded http://localhost:33813/tests/dromaeo/cssquery-ext.html (next: http://localhost:33813/tests/dromaeo/cssquery-jquery.html) 08:24:44 INFO - PROCESS | 12982 | RSS: Main: 276844544 08:24:44 INFO - PROCESS | 12982 | 08:27:46 INFO - PROCESS | 12982 | Cycle 1(1): loaded http://localhost:33813/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33813/tests/dromaeo/cssquery-mootools.html) 08:27:46 INFO - PROCESS | 12982 | RSS: Main: 223735808 08:27:46 INFO - PROCESS | 12982 | 08:30:49 INFO - PROCESS | 12982 | Cycle 1(1): loaded http://localhost:33813/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33813/tests/dromaeo/cssquery-prototype.html) 08:30:49 INFO - PROCESS | 12982 | RSS: Main: 221601792 08:30:49 INFO - PROCESS | 12982 | 08:33:52 INFO - PROCESS | 12982 | Cycle 1(1): loaded http://localhost:33813/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33813/tests/dromaeo/cssquery-yui.html) 08:33:53 INFO - PROCESS | 12982 | RSS: Main: 222232576 08:33:53 INFO - PROCESS | 12982 | 08:36:56 INFO - PROCESS | 12982 | Cycle 1(1): loaded http://localhost:33813/tests/dromaeo/cssquery-yui.html (next: http://localhost:33813/tests/dromaeo/cssquery-dojo.html) 08:36:56 INFO - PROCESS | 12982 | RSS: Main: 315658240 08:36:56 INFO - PROCESS | 12982 | 08:36:56 INFO - PROCESS | 12982 | __start_tp_report 08:36:56 INFO - PROCESS | 12982 | _x_x_mozilla_page_load 08:36:56 INFO - PROCESS | 12982 | _x_x_mozilla_page_load_details 08:36:56 INFO - PROCESS | 12982 | |i|pagename|runs| 08:36:56 INFO - PROCESS | 12982 | |0;dojo.html;2582.9612555811664;2621.279148234234;2647.5102106110367;2659.0427446119393;2673.5855942328944;4672.626189904808;4725.385699859022;4732.90534189316;4834.202356611155;4879.804807807688;4750.121227572901;4758.191107511722;4764.666473346859;4791.089692958335;4802.6398020148545;4399.450068741407;4405.911881762363;4447.3996010538485;4459.687821852472;4474.172278128541;4523.140603285382;4525.0949810037955;4525.524819893913;4545.772711364435;4554.63562914966;4333.9133217335475;4392.187445322594;4457.821687132511;4492.483364413101;4511.345854851028;4425.358323043173;4444.333349997494;4449.666275029385;4452.599266066037;4452.755098469583;4403.8458653946955;4421.579949904753;4424.247877860771;4425.137098265839;4427.778611069466;4670.929936050962;4705.882352941169;4785.425748910153;4838.080764654739;4861.902761944777;5032.4212715537815;5035.77339019745;5107.540321371057;5114.288279839164;5180.766865491062;5023.472535383805;5137.897242055138;5140.357455318085;5148.073346797575;5150.536451719326;4684.367610372624;4720.33915251865;4752.049590081998;4767.499412561631;4777.259524773665;5194.246834209019;5230.215467679878;5233.084210263189;5238.057149713012;5305.098133317345;4941.555260026615;5015.598752099823;5021.14640511114;5030.974845125751;5033.245013248042;5098.515641014098;5113.105206588906;5148.819791307286;5155.510226528474;5239.816606418757;5131.717755523482;5137.897242055213;5164.819231326961;5188.63679542436;5194.454582268883;5104.3619547556555;5109.054824857413;5111.233315002779;5112.821051263188;5156.587473002151;4247.5540068293;4288.24955632763;4359.215341238608;4370.978145109318;4413.16149931512;3787.772733635991;3790.4314352847296;3802.258559580855;3819.026148332213;3890.824912878927;4374.803133858921;4387.034852332482;4387.978060109679;4389.385486031958;4441.555844415532;5145.691258524501;5187.273781670569;5194.454582268883;5196.1166601677805;5260.132078207053;4278.187144442546;4306.612404883513;4317.481902171759;4328.264195086843;4347.456567929009;4611.9077618447445;4622.86131416058;4645.581897629229;4650.325702773079;4652.232381656989;4377.868663940087;4390.802413891319;4402.757848318373;4410.691251612357;4458.977705111519;5058.1401161803315;5122.436531981404;5126.6923984561045;5129.307543481731;5175.223716442413;4322.848700295601;4360.869173924787;4428.512863585068;4431.8670439886855;4438.023634800339;5060.595152387874;5119.180931051014;5130.204818253177;5139.074966506065;5141.640085194001;5132.127538318569;5150.304708864405;5150.459201783909;5154.226865970135;5220.086484865057;4795.088933102699;4850.975745121252;4936.185529387754;4986.700797952134;4987.875303117451;4831.323614694016;4883.560479556715;4918.92621610669;4937.037277730951;4999.625028122832;4876.758542561754;4878.317035614946;4882.048000639983;4885.511448855228;4941.925871111865;4970.776315065758;4987.326710893983;4992.326035985096;4993.151164302005;5036.043151801146;4761.333413322207;4800.231962885921;4802.399700037496;4810.326554282333;4842.491538388418 08:36:56 INFO - PROCESS | 12982 | |1;ext.html;567.7189791053429;570.4295704295704;576.1990832742488;577.0968434400163;580.1674596953371;27749.306267343327;37761.62238377616;39318.410223846666;39447.40828887569;43662.78168609161;40232.396514052314;40669.7966510167;40721.59278407215;40734.79632601833;40775.796121019426;6832.897506537381;7607.201243869397;7754.108277548098;7756.263155000294;7758.107817600991;7205.279472052805;9638.807223855518;9890.851637225447;9897.653582124627;10329;10023.198144148488;10100.797984040315;10104.44425556594;10110.595576176944;10114.595416183343;9822.263330250224;9872.45701486418;9872.90127098727;9872.999999999964;9890.456024918627;9786.363886347364;9848.178087053919;9856.704298870975;9857.90142098577;9858.704238872846;38304.616953830664;38630.61369386326;38662.22675546473;38665.61334386676;38676;3061.4489391909447;3108.891188808381;3119.4696901526795;3365.2259980204444;3432.3478539077496;27046.1886143416;29227.269318267;29236.122916312546;29251;29368.412631747244;3413.247051000185;3559.48387483816;3600.4959305697225;3611.9097022574383;3737.2338670572467;236084;236517;236673;237135.81432092903;238951;52194.47805521972;52319.476805232225;52356;52596.73701631468;52766.73616631969;54780.72609636926;54874.17688734672;54993.15047946685;55012.72493637506;55026.724866376215;13525;13782.104163229358;13791.51729689456;13791.931040344934;13792.172469651852;9164;9385;10186.236032297607;10329.225308101772;10430.16558675304;16099.919500402422;16258.593535161715;16558.254878530493;16563.6687266254;16782.58043548921;6017.458428741435;6051.488632217581;6082.118092876508;6082.2093127893095;6236.345183755731;759.7218004311379;818.5988865456003;950.9952450237705;976.4629453800381;991.6975322526555;26058.869705651352;27777.722222777513;28159;28267;28290.85854570755;907.4555266839843;934.1032608695729;943.2689665509286;948.6869333120054;1026.14829691356;13816.861831381759;14218.132590006062;14308.785368219485;14401.279936003159;14524.636884077983;334799;341111;341821;342774;342784;47769;47818.760906195246;47855;47877;47968;1078.5470102556944;1108.7505311305215;1109.8834622364698;1178;1178.6876477733408;26596.734032659424;28170.43659126765;28876.133715988555;31379.37241255208;31685.36629267448;45031.54968450405;45459.31811022903;45581.54418455773;45630;45685.77157114193;332469;336107;336242;336338;336373;24490.51018979646;24900.12849550257;31581;32434.35131297408;38821.61178388293;30269.394612108073;33108.337833243684;33537.16157095994;36072.45891311685;44450;36924.630753692116;36951.445728313556;37072.81463592665;37209;37358.25283494369;37134;37184.256314874096;37199.25601487901;38465;38511.422328665656;36960.815195923846;37109.44335835019;37135.07162320964;37183.81408092942;37547;32332.515012275304;33542.83228583841;34060.82969585136;34165.658343416246;34696.30607387787;26122.738772612032;26164.215073547824;26207.475850483264;26468.602970955835;26617.201483955512 08:36:56 INFO - PROCESS | 12982 | |2;jquery.html;349.24562944040866;349.37287568813974;352.1196809039727;370.97217708671855;384.86529714599874;14743.336549855268;15334.923325383372;16703.749443758352;16823.32706691734;16997.19546274863;15034.624134396645;15839.12884791336;15842.366305347801;15925.44260950867;15954.361825526994;4942.085714142886;5291.5766738661005;5511.889762204753;5554.611177217596;5643.266375371196;5586.497215250627;5614.747336369853;5615.213870058195;5624.325080990287;5624.803131890385;5407.864803379907;5566.972165139168;5587.357453892793;5590.8602284943;5605.159226116074;5257.684538927677;5604.859878503029;5627.071533197018;5639.125935480028;5645.858853528674;5326.627136100475;5364.570834333244;5366.275552800361;5378.031954248234;5378.408375078739;12308.384580771015;12337.198082124632;12432.254064756144;12505;12528.123031387806;1876.3995521433146;1911.3692481481078;1941.563148291623;2001.4195883193856;2451.4361696809656;13573.660658483519;13904.930475347559;14691.55925322242;14772.55682329532;15569.455069072641;1828.3874901907877;1853.898035608041;1880.5016670582306;1884.2557189910046;1931.159945423745;72514.63742681306;77489.99999999943;78096;79064;80360.59819700923;15823.446179383896;16077.478936163852;16352.672946541003;16388.508344749676;16718.24767885448;27980.440391192064;28026.439471210462;28029.29926751807;28136.71863281382;28290.151295461168;8304.418690691593;8350;8520.829583408296;8603.784905377415;8831.072737362612;6863.588184708933;6906.516543841883;7049.946280888407;7115.82210444743;7161.1406631203545;8189.262966333059;8317.95841020791;8335.624896879655;8394.706185283485;8641.179087986631;3180.157258326545;3183.649798522161;3197.76016798741;3304.273059926812;3400.59192896854;802.63078983667;826.4008593769469;837.1879277101324;841.9536925469035;898.1018981018981;16233.67532649364;16900.57748556296;16942.830571694125;17090.40183593568;17511.12444377776;831.9750407487785;842.2167384332507;848.2789628815581;853;863.6977058029765;8881.725044787954;9611.231101511863;9674.274429417821;9724.902750972542;9784.755381115529;373452;376971;380458;382039;395254;74379.25620743832;75414.6229268861;75970.24029759632;76779;78401.60799196082;878.7144178142001;885.5793498088357;898.9820203595891;903.051795614602;904.4618452021037;14473.493427729978;14594.708105837612;14691.632709182357;15375.154366509949;15414.84585154179;35567;35946.4608030885;36121.81939090288;36530.63469365379;36685.81657091698;46341.30488042615;47919.051737498565;48056.759716201195;49378.75310623424;49909;5908.734106965111;7351.77944661661;7362.484626076123;7555.055618047744;7581.583012934121;10142.239332050274;11022.44887755593;11058.889411105785;11146.442677865913;11467.617052969561;9617.759556011155;9829.606815727291;9884.505774711379;10049.648262311077;10213.131883789663;9210.309226807882;9242.260619150586;9543.188828949616;9835.065668761456;10150.390976541432;9573.521323933915;9964.202863771026;10213.182945364204;10352.482375881025;10446.05985461312;6765.932340676531;7156.391706704989;7210.278972102958;7269.927300726925;7330.340269375782;9227.21568666644;9734.075262850018;9813.26400519978;9886.802263954825;9890.901090988998 08:36:56 INFO - PROCESS | 12982 | |3;mootools.html;1245.4208792911306;1349.116328804633;1376.724655068986;1429.9285035748217;1662.011103393481;6928.34180752829;7565.394768418527;7828.217178282169;7838.216178382159;8067.273945344918;7921.36629069673;7981.880271795913;7982.521048737065;7983.600819959008;7988.201179882009;2141.1970511058316;2175.662772270293;2178.36827320077;2182.03990244292;2182.879941603211;2102.0435701755664;2131.041031535807;2149.4089125490536;2154.041451554051;2157.352794161753;2096.119629755506;2100.2229175205193;2102.453362125843;2106.420734298065;2176.3906106290183;2127.606392817326;2134.679798030292;2135.487483004068;2136.529963408048;2139.475828422031;2042.611903738285;2114.3445531885163;2120.162535798351;2121.225752600305;2124.9787502124937;7714.807129821799;7879.566623835687;7951.04587449504;7992.600369981477;7998.360131189491;4499.370088187657;4608.354830323758;4620.052889157748;4652.581267685924;4656.32483289921;2818.3658676797763;2865.441238958404;2966.2287805170595;2979.5232762758073;2980.8062475938996;952.8142012307603;966.6954909203648;979.1334668818076;985.5072463768116;992.4541502173776;10776;10879.510422031028;10890.237683362167;10895.400752958583;10903.618373356894;3979.1047014421524;4140.792960351971;4170.103427763045;4336.398161103376;4375.212461756851;8224.177582241848;8349.165083491724;8360.790980225544;8361.080281169066;8365.28895043928;4549.203889319356;4552.863414097583;4555.703879247904;4556.929121656408;4558.589726924526;3554.413521768879;3576.302620988882;4204.1171354016;4265.55211702773;4267.722598031118;3305.8099084329624;3307.8842240521467;3431.605365382963;3435.3129374125274;3442.4492081267376;985.6599473181741;995.5868314649484;1004.1866088468364;1004.7739258666742;1027.9383237005804;784.3607459920147;790.1505881177642;793.484235247094;798.078219656298;800.7677773445636;4931.950680493221;5047.848564543069;5201.141811601119;5208.348956380452;5321;407.9714419990572;420.7917081044902;422.6808759386643;423.2297219061279;423.3480440122177;3608.1881576645046;3615.7468977171347;3688.704903607705;3694.815259237081;3725.1432170600915;9686.612535498642;9947.55236014381;10037.899621003697;10043.146332561668;10054.949725251327;9932.553035113437;9969.601215951281;9977.950110249547;9980.850287245697;10004.649837255662;7337.266273372727;7387.593682347522;7394.075740532434;7431.739889103856;7441.888371674429;5291.126964051043;5339.652922560176;5362.436944120811;5477.507024367826;5521.282233309644;8885.955570222108;9249.630014799333;9263.53682315868;9274.814503710022;9283.907160928304;8951.328650351119;9119.908800912172;9233.353665243369;9277.721668349961;9385;6307.653079080695;6515.218173818982;6848.9657551711925;6982;6991.8951215730785;7233.927660723325;7445;7471.9626401867645;7661.961690191513;7673.961630191813;6693.866122677617;6702.765403210864;6759.898601521079;6856.897146542706;6998.790036298919;6497.837192363462;6669.966650166718;6751.223609284995;6763.830904227434;6831.9658401707675;6290.370962903673;6363.172787537591;6366.808995730135;6413.198350206224;6413.35866413355;4433.268510695699;4457.2645513489915;4475.820967161277;4521.14098321331;4542.772861356985;4398.384226208397;4511.075229577994;4633.536646335474;4653.511381304914;4676.298555216608 08:36:56 INFO - PROCESS | 12982 | |4;prototype.html;286.3371295451031;290.33513254646857;297.0612863351808;306.0954878334523;308.3678459158724;4768.1894078006735;4808.735519546423;4818.469968303484;4833.758312084395;4869.464358920516;4765.499622539635;4766.3088852116425;4783.784729687164;4799.5680388765;4811.951880481194;3784.6026167252453;3805.5729101586903;3809.2381523695235;3810.618938106195;3858.514471928314;3504.351694936432;3812.4090765931323;3832.463455116286;3853.7687738735626;3855.4987851579253;3690.132818787583;3716.312482190803;3728.459373390857;3728.459373390857;3729.832157552903;3694.649008344203;3699.834552116075;3712.978930794053;3714.9257014859686;3717;3028.772842036856;3107.3785242951276;3240.5787247657654;3243.172990887332;3256.853441595134;4516.141933032746;4644.651651126179;4649.604783593365;4653.581177694024;4661.836835710734;4217.683673724483;4217.810198541073;4218.430511880888;4229.767362795045;4237.131388065439;4648.697834640738;4771.832985845479;5009.073321435546;5010.922651629917;5015.4733752956145;3511.877084302037;3522.806245656488;3523.8195204606486;3533.646635336446;3535.2399234164523;5184.377874655028;5203.152880727363;5240;5242.895142097175;5269.86825329366;3615.078155070493;3621.247851632778;3627.3108109459645;3633;3642.7996460194945;3499.1951851073886;3662.08447888028;3694.649008344203;3713.164537978987;3715.294094122108;4184.686148538872;4208.705390622627;4220.345846393814;4224.978875105605;4234.55537168599;5043.571296439771;5045.208950822479;5045.772940217699;5046.697198168048;5066.214736715815;1209.6915286601861;1259.3451405269209;1274.4328773695802;1277.5081593586535;1283.4160456992047;805.7743831727125;806.7700705298962;825.3314814999869;825.8348330333957;828.0808302783905;3925.823337949742;3930.6462418382484;3952.466417033721;3961.2473630010204;3976.5029371328583;4526.343680166357;4535.886602834956;4550.613197878218;4553.5218802025975;4559.726416415026;3830.3105441020884;3831.927060423086;3898.2203559288255;3904.7852368120025;3910.904946614952;2420.1287536486852;2424.4666173441815;2508.924732258035;2688.448867982059;2714.696945466148;4096.9795151024055;4181.456410666594;4287.442632457761;4348.565143485689;4348.695591308578;5254.343207099113;5264.263003179558;5278.419373868871;5283;5295.914337560791;4376.452943382077;4380.627646650007;4381.9842872279105;4384.736915785127;4392.6485881130075;4981.8329026873425;5182.352205974254;5191.610629202901;5200.921986170286;5216.765245564035;5035.5719763819025;5064.44291127983;5071.239314102914;5073.2897394365555;5119.6416250862085;4352.3896158421585;4355.390245365588;4371.30059190528;4374.4531933508315;4379.343098535245;3421.7091547218765;3600.8199590020918;3604.7563590561213;3614.93359458955;3619.6064515161324;5117.8464646060675;5133.743312834418;5137.126688462896;5144.459831717765;5153.896922061613;4900.362952816254;4929.334539837076;4931.432885218246;4946.3817022872145;4970.9254361183885;4713.622910167247;4930.556249937523;4935.679180853233;4938;4942.935380064383;4889.706617602955;4898.530440867797;4906.607471402208;4909.582685471775;4922.4339200992345;4992.2511623256805;5004.274380214775;5019.598432125348;5021.899562008666;5022.522860328263;4777.95222047775;4862.562369386772;4902.548725637182;4915.877103072452;4926.802927882844 08:36:56 INFO - PROCESS | 12982 | |5;yui.html;593.4214141212316;594.8126340202833;645.2901808011187;729.9014633024543;774.4733581164808;12382.752344953096;12817.102802803807;12878;12885.355732213398;12894.806577901327;12984.350782460886;13388.196708197514;13555.52555660552;13624.250666213355;13625.182489050663;748.296601194875;776.510798197135;778.8208711996244;778.9883151752729;779.664744160011;769.0732667136116;771.0477560213133;771.3482107619081;771.4175797273051;771.6411868481155;813.6582635293162;818.1123481023068;819.2749416766175;820.2863508747398;821.3059964330131;809.668036105197;810.4893916832417;810.8094597769549;810.9107998120202;810.9918900810975;593.8871614393295;594.1889321076699;594.586762200271;594.6699581732137;594.8126340202865;11787.410629468579;11957.461914213794;11962.40187990597;11978.460969256404;11983.221090629082;10324.07083362501;10424.478776061167;10671.199660025452;10691.625793097204;11036.061934735557;9839.950800246024;9959.302848800515;9974.800503989953;9990.500474976223;10081.546330415149;3249.0902547286796;3264.836758162106;3265.232670322472;3288;3340.832958352097;61035;61803.38196618021;62034.68982655103;62066.37933620651;63457.365426345605;7416.85166296671;7446.66490007951;7478.700851965969;7660.770176894702;7746.883796743054;16415.425460109076;16760.078195699352;17081;17120.14399280056;17912.552186195448;6688.7324507019175;6729.899051514231;6755.2906944771075;6822.965885170543;6830.180378354629;3710.3877860152775;3749.3063783200196;3755.794144447528;3800.1829606634706;3852.2488114817343;2684.624152618635;2766.695663477016;2793.1201671473423;2795.105566218831;2826.745592896649;483.88144904498625;488.64573184441707;489.49337435753824;502.2842449509507;506.8758154252158;458.7866642011481;464.50530185353165;515.5488947171225;546.0989367543585;546.641949523063;7077.610731409719;7649.38804895607;7996.24035716606;8192;8198.877016844752;493.4621262823468;503.7808553279335;527.527862563004;533.1842281309603;541.3747122074011;3367.3602015617444;3783.0731470789283;3827.119762454651;3829.885103446901;3911.0853985147514;57211.427885721445;57313;57494;57702.42297577055;58584;82013;86377.56811215903;86661;86942.56528717316;88580.5570972141;45785.31322030172;61507.69246153741;76035.61982190053;76316.27627927928;76328.23671763322;7062.024427069966;7203.495755297079;7217.50977018913;7261.745838895613;7344;41696.16607667891;42079.94800130021;42263.57736422597;43798.78100609604;44332.33501497415;37433.43849842309;38409.807950960065;39903;64522;65703.34296656972;9601.087896649808;9606.423614583147;9965.152961998021;10003.199744020316;10158.796824063329;10751.623693171014;10814.783704325711;11187;12148.817767733668;12175;10163.796724065625;10481.895181048092;10586.99423554761;10648.201384896009;10682.57269709203;10251.794964100825;10288.588456461957;11046.944765276123;11059.72350691239;11106;10250.846237306298;10347;10751.462426878781;10768.19238557127;10983.286086404358;9019.278457723498;9080.500572468578;9104.90895091067;9169.908300917172;9357.157855793012;8698.913010870063;8788.516631585324;8881.111888811067;9078.682246121354;9126.315526335418 08:36:56 INFO - PROCESS | 12982 | __end_tp_report 08:36:56 INFO - PROCESS | 12982 | __start_cc_report 08:36:56 INFO - PROCESS | 12982 | _x_x_mozilla_cycle_collect,1028 08:36:56 INFO - PROCESS | 12982 | __end_cc_report 08:36:56 INFO - PROCESS | 12982 | __startTimestamp1475077016801__endTimestamp 08:36:56 INFO - PROCESS | 12982 | 08:36:56 INFO - PROCESS | 12982 | ------- Summary: start ------- 08:36:56 INFO - PROCESS | 12982 | Number of tests: 6 08:36:56 INFO - PROCESS | 12982 | 08:36:56 INFO - PROCESS | 12982 | [#0] dojo.html Cycles:165 Average:4705.66 Median:4800.23 stddev:503.62 (10.5%) stddev-sans-first:476.84 08:36:56 INFO - PROCESS | 12982 | Values: 2583.0 2621.3 2647.5 2659.0 2673.6 4672.6 4725.4 4732.9 4834.2 4879.8 4750.1 4758.2 4764.7 4791.1 4802.6 4399.5 4405.9 4447.4 4459.7 4474.2 4523.1 4525.1 4525.5 4545.8 4554.6 4333.9 4392.2 4457.8 4492.5 4511.3 4425.4 4444.3 4449.7 4452.6 4452.8 4403.8 4421.6 4424.2 4425.1 4427.8 4670.9 4705.9 4785.4 4838.1 4861.9 5032.4 5035.8 5107.5 5114.3 5180.8 5023.5 5137.9 5140.4 5148.1 5150.5 4684.4 4720.3 4752.0 4767.5 4777.3 5194.2 5230.2 5233.1 5238.1 5305.1 4941.6 5015.6 5021.1 5031.0 5033.2 5098.5 5113.1 5148.8 5155.5 5239.8 5131.7 5137.9 5164.8 5188.6 5194.5 5104.4 5109.1 5111.2 5112.8 5156.6 4247.6 4288.2 4359.2 4371.0 4413.2 3787.8 3790.4 3802.3 3819.0 3890.8 4374.8 4387.0 4388.0 4389.4 4441.6 5145.7 5187.3 5194.5 5196.1 5260.1 4278.2 4306.6 4317.5 4328.3 4347.5 4611.9 4622.9 4645.6 4650.3 4652.2 4377.9 4390.8 4402.8 4410.7 4459.0 5058.1 5122.4 5126.7 5129.3 5175.2 4322.8 4360.9 4428.5 4431.9 4438.0 5060.6 5119.2 5130.2 5139.1 5141.6 5132.1 5150.3 5150.5 5154.2 5220.1 4795.1 4851.0 4936.2 4986.7 4987.9 4831.3 4883.6 4918.9 4937.0 4999.6 4876.8 4878.3 4882.0 4885.5 4941.9 4970.8 4987.3 4992.3 4993.2 5036.0 4761.3 4800.2 4802.4 4810.3 4842.5 08:36:56 INFO - PROCESS | 12982 | 08:36:56 INFO - PROCESS | 12982 | [#1] ext.html Cycles:180 Average:46448.91 Median:37016.81 stddev:80821.50 (218.3%) stddev-sans-first:80974.80 08:36:56 INFO - PROCESS | 12982 | Values: 567.7 570.4 576.2 577.1 580.2 27749.3 37761.6 39318.4 39447.4 43662.8 40232.4 40669.8 40721.6 40734.8 40775.8 6832.9 7607.2 7754.1 7756.3 7758.1 7205.3 9638.8 9890.9 9897.7 10329.0 10023.2 10100.8 10104.4 10110.6 10114.6 9822.3 9872.5 9872.9 9873.0 9890.5 9786.4 9848.2 9856.7 9857.9 9858.7 38304.6 38630.6 38662.2 38665.6 38676.0 3061.4 3108.9 3119.5 3365.2 3432.3 27046.2 29227.3 29236.1 29251.0 29368.4 3413.2 3559.5 3600.5 3611.9 3737.2 236084.0 236517.0 236673.0 237135.8 238951.0 52194.5 52319.5 52356.0 52596.7 52766.7 54780.7 54874.2 54993.2 55012.7 55026.7 13525.0 13782.1 13791.5 13791.9 13792.2 9164.0 9385.0 10186.2 10329.2 10430.2 16099.9 16258.6 16558.3 16563.7 16782.6 6017.5 6051.5 6082.1 6082.2 6236.3 759.7 818.6 951.0 976.5 991.7 26058.9 27777.7 28159.0 28267.0 28290.9 907.5 934.1 943.3 948.7 1026.1 13816.9 14218.1 14308.8 14401.3 14524.6 334799.0 341111.0 341821.0 342774.0 342784.0 47769.0 47818.8 47855.0 47877.0 47968.0 1078.5 1108.8 1109.9 1178.0 1178.7 26596.7 28170.4 28876.1 31379.4 31685.4 45031.5 45459.3 45581.5 45630.0 45685.8 332469.0 336107.0 336242.0 336338.0 336373.0 24490.5 24900.1 31581.0 32434.4 38821.6 30269.4 33108.3 33537.2 36072.5 44450.0 36924.6 36951.4 37072.8 37209.0 37358.3 37134.0 37184.3 37199.3 38465.0 38511.4 36960.8 37109.4 37135.1 37183.8 37547.0 32332.5 33542.8 34060.8 34165.7 34696.3 26122.7 26164.2 26207.5 26468.6 26617.2 08:36:56 INFO - PROCESS | 12982 | 08:36:56 INFO - PROCESS | 12982 | [#2] jquery.html Cycles:180 Average:24734.17 Median:5365.42 stddev:63122.62 (1176.5%) stddev-sans-first:63273.14 08:36:56 INFO - PROCESS | 12982 | Values: 349.2 349.4 352.1 371.0 384.9 14743.3 15334.9 16703.7 16823.3 16997.2 15034.6 15839.1 15842.4 15925.4 15954.4 4942.1 5291.6 5511.9 5554.6 5643.3 5586.5 5614.7 5615.2 5624.3 5624.8 5407.9 5567.0 5587.4 5590.9 5605.2 5257.7 5604.9 5627.1 5639.1 5645.9 5326.6 5364.6 5366.3 5378.0 5378.4 12308.4 12337.2 12432.3 12505.0 12528.1 1876.4 1911.4 1941.6 2001.4 2451.4 13573.7 13904.9 14691.6 14772.6 15569.5 1828.4 1853.9 1880.5 1884.3 1931.2 72514.6 77490.0 78096.0 79064.0 80360.6 15823.4 16077.5 16352.7 16388.5 16718.2 27980.4 28026.4 28029.3 28136.7 28290.2 8304.4 8350.0 8520.8 8603.8 8831.1 6863.6 6906.5 7049.9 7115.8 7161.1 8189.3 8318.0 8335.6 8394.7 8641.2 3180.2 3183.6 3197.8 3304.3 3400.6 802.6 826.4 837.2 842.0 898.1 16233.7 16900.6 16942.8 17090.4 17511.1 832.0 842.2 848.3 853.0 863.7 8881.7 9611.2 9674.3 9724.9 9784.8 373452.0 376971.0 380458.0 382039.0 395254.0 74379.3 75414.6 75970.2 76779.0 78401.6 878.7 885.6 899.0 903.1 904.5 14473.5 14594.7 14691.6 15375.2 15414.8 35567.0 35946.5 36121.8 36530.6 36685.8 46341.3 47919.1 48056.8 49378.8 49909.0 5908.7 7351.8 7362.5 7555.1 7581.6 10142.2 11022.4 11058.9 11146.4 11467.6 9617.8 9829.6 9884.5 10049.6 10213.1 9210.3 9242.3 9543.2 9835.1 10150.4 9573.5 9964.2 10213.2 10352.5 10446.1 6765.9 7156.4 7210.3 7269.9 7330.3 9227.2 9734.1 9813.3 9886.8 9890.9 08:36:56 INFO - PROCESS | 12982 | 08:36:56 INFO - PROCESS | 12982 | [#3] mootools.html Cycles:180 Average:5131.07 Median:4666.31 stddev:2958.73 (63.4%) stddev-sans-first:2952.62 08:36:56 INFO - PROCESS | 12982 | Values: 1245.4 1349.1 1376.7 1429.9 1662.0 6928.3 7565.4 7828.2 7838.2 8067.3 7921.4 7981.9 7982.5 7983.6 7988.2 2141.2 2175.7 2178.4 2182.0 2182.9 2102.0 2131.0 2149.4 2154.0 2157.4 2096.1 2100.2 2102.5 2106.4 2176.4 2127.6 2134.7 2135.5 2136.5 2139.5 2042.6 2114.3 2120.2 2121.2 2125.0 7714.8 7879.6 7951.0 7992.6 7998.4 4499.4 4608.4 4620.1 4652.6 4656.3 2818.4 2865.4 2966.2 2979.5 2980.8 952.8 966.7 979.1 985.5 992.5 10776.0 10879.5 10890.2 10895.4 10903.6 3979.1 4140.8 4170.1 4336.4 4375.2 8224.2 8349.2 8360.8 8361.1 8365.3 4549.2 4552.9 4555.7 4556.9 4558.6 3554.4 3576.3 4204.1 4265.6 4267.7 3305.8 3307.9 3431.6 3435.3 3442.4 985.7 995.6 1004.2 1004.8 1027.9 784.4 790.2 793.5 798.1 800.8 4932.0 5047.8 5201.1 5208.3 5321.0 408.0 420.8 422.7 423.2 423.3 3608.2 3615.7 3688.7 3694.8 3725.1 9686.6 9947.6 10037.9 10043.1 10054.9 9932.6 9969.6 9978.0 9980.9 10004.6 7337.3 7387.6 7394.1 7431.7 7441.9 5291.1 5339.7 5362.4 5477.5 5521.3 8886.0 9249.6 9263.5 9274.8 9283.9 8951.3 9119.9 9233.4 9277.7 9385.0 6307.7 6515.2 6849.0 6982.0 6991.9 7233.9 7445.0 7472.0 7662.0 7674.0 6693.9 6702.8 6759.9 6856.9 6998.8 6497.8 6670.0 6751.2 6763.8 6832.0 6290.4 6363.2 6366.8 6413.2 6413.4 4433.3 4457.3 4475.8 4521.1 4542.8 4398.4 4511.1 4633.5 4653.5 4676.3 08:36:56 INFO - PROCESS | 12982 | 08:36:56 INFO - PROCESS | 12982 | [#4] prototype.html Cycles:180 Average:4054.75 Median:4379.99 stddev:1188.48 (27.1%) stddev-sans-first:1157.67 08:36:56 INFO - PROCESS | 12982 | Values: 286.3 290.3 297.1 306.1 308.4 4768.2 4808.7 4818.5 4833.8 4869.5 4765.5 4766.3 4783.8 4799.6 4812.0 3784.6 3805.6 3809.2 3810.6 3858.5 3504.4 3812.4 3832.5 3853.8 3855.5 3690.1 3716.3 3728.5 3728.5 3729.8 3694.6 3699.8 3713.0 3714.9 3717.0 3028.8 3107.4 3240.6 3243.2 3256.9 4516.1 4644.7 4649.6 4653.6 4661.8 4217.7 4217.8 4218.4 4229.8 4237.1 4648.7 4771.8 5009.1 5010.9 5015.5 3511.9 3522.8 3523.8 3533.6 3535.2 5184.4 5203.2 5240.0 5242.9 5269.9 3615.1 3621.2 3627.3 3633.0 3642.8 3499.2 3662.1 3694.6 3713.2 3715.3 4184.7 4208.7 4220.3 4225.0 4234.6 5043.6 5045.2 5045.8 5046.7 5066.2 1209.7 1259.3 1274.4 1277.5 1283.4 805.8 806.8 825.3 825.8 828.1 3925.8 3930.6 3952.5 3961.2 3976.5 4526.3 4535.9 4550.6 4553.5 4559.7 3830.3 3831.9 3898.2 3904.8 3910.9 2420.1 2424.5 2508.9 2688.4 2714.7 4097.0 4181.5 4287.4 4348.6 4348.7 5254.3 5264.3 5278.4 5283.0 5295.9 4376.5 4380.6 4382.0 4384.7 4392.6 4981.8 5182.4 5191.6 5200.9 5216.8 5035.6 5064.4 5071.2 5073.3 5119.6 4352.4 4355.4 4371.3 4374.5 4379.3 3421.7 3600.8 3604.8 3614.9 3619.6 5117.8 5133.7 5137.1 5144.5 5153.9 4900.4 4929.3 4931.4 4946.4 4970.9 4713.6 4930.6 4935.7 4938.0 4942.9 4889.7 4898.5 4906.6 4909.6 4922.4 4992.3 5004.3 5019.6 5021.9 5022.5 4778.0 4862.6 4902.5 4915.9 4926.8 08:36:56 INFO - PROCESS | 12982 | 08:36:56 INFO - PROCESS | 12982 | [#5] yui.html Cycles:180 Average:15582.94 Median:546.37 stddev:21748.58 (3980.6%) stddev-sans-first:21780.47 08:36:56 INFO - PROCESS | 12982 | Values: 593.4 594.8 645.3 729.9 774.5 12382.8 12817.1 12878.0 12885.4 12894.8 12984.4 13388.2 13555.5 13624.3 13625.2 748.3 776.5 778.8 779.0 779.7 769.1 771.0 771.3 771.4 771.6 813.7 818.1 819.3 820.3 821.3 809.7 810.5 810.8 810.9 811.0 593.9 594.2 594.6 594.7 594.8 11787.4 11957.5 11962.4 11978.5 11983.2 10324.1 10424.5 10671.2 10691.6 11036.1 9840.0 9959.3 9974.8 9990.5 10081.5 3249.1 3264.8 3265.2 3288.0 3340.8 61035.0 61803.4 62034.7 62066.4 63457.4 7416.9 7446.7 7478.7 7660.8 7746.9 16415.4 16760.1 17081.0 17120.1 17912.6 6688.7 6729.9 6755.3 6823.0 6830.2 3710.4 3749.3 3755.8 3800.2 3852.2 2684.6 2766.7 2793.1 2795.1 2826.7 483.9 488.6 489.5 502.3 506.9 458.8 464.5 515.5 546.1 546.6 7077.6 7649.4 7996.2 8192.0 8198.9 493.5 503.8 527.5 533.2 541.4 3367.4 3783.1 3827.1 3829.9 3911.1 57211.4 57313.0 57494.0 57702.4 58584.0 82013.0 86377.6 86661.0 86942.6 88580.6 45785.3 61507.7 76035.6 76316.3 76328.2 7062.0 7203.5 7217.5 7261.7 7344.0 41696.2 42079.9 42263.6 43798.8 44332.3 37433.4 38409.8 39903.0 64522.0 65703.3 9601.1 9606.4 9965.2 10003.2 10158.8 10751.6 10814.8 11187.0 12148.8 12175.0 10163.8 10481.9 10587.0 10648.2 10682.6 10251.8 10288.6 11046.9 11059.7 11106.0 10250.8 10347.0 10751.5 10768.2 10983.3 9019.3 9080.5 9104.9 9169.9 9357.2 8698.9 8788.5 8881.1 9078.7 9126.3 08:36:56 INFO - PROCESS | 12982 | -------- Summary: end -------- 08:36:56 INFO - PROCESS | 12982 | 08:36:57 INFO - TEST-INFO | 12982: exit 0 08:36:57 INFO - TEST-OK | dromaeo_css | took 1121988ms 08:36:57 INFO - TEST-START | kraken 08:36:57 INFO - operating with platform_type : linux_ 08:36:57 INFO - Initialising browser for kraken test... 08:36:57 INFO - TEST-INFO | started process 13287 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp4FxGR/profile http://localhost:33813/getInfo.html) 08:37:02 INFO - PROCESS | 13287 | __metrics Screen width/height:1600/1200 08:37:02 INFO - PROCESS | 13287 | colorDepth:24 08:37:02 INFO - PROCESS | 13287 | Browser inner width/height: 1024/697 08:37:02 INFO - PROCESS | 13287 | __metrics 08:37:03 INFO - PROCESS | 13287 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:37:03 INFO - PROCESS | 13287 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:37:03 INFO - PROCESS | 13287 | console.error: PushService: 08:37:03 INFO - PROCESS | 13287 | stateChangeProcessEnqueue: Error transitioning state 08:37:03 INFO - PROCESS | 13287 | UnknownError 08:37:04 INFO - TEST-INFO | 13287: exit 0 08:37:04 INFO - Browser initialized. 08:37:04 INFO - Running cycle 1/1 for kraken test... 08:37:04 INFO - TEST-INFO | started process 13366 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp4FxGR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:37:16 INFO - PROCESS | 13366 | RSS: Main: 175087616 08:37:16 INFO - PROCESS | 13366 | 08:37:19 INFO - PROCESS | 13366 | Cycle 1(1): loaded http://localhost:33813/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33813/tests/kraken/driver.html?testName=audio-beat-detection) 08:37:20 INFO - PROCESS | 13366 | RSS: Main: 242962432 08:37:20 INFO - PROCESS | 13366 | 08:37:23 INFO - PROCESS | 13366 | Cycle 1(1): loaded http://localhost:33813/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33813/tests/kraken/driver.html?testName=audio-dft) 08:37:23 INFO - PROCESS | 13366 | RSS: Main: 218071040 08:37:23 INFO - PROCESS | 13366 | 08:37:27 INFO - PROCESS | 13366 | Cycle 1(1): loaded http://localhost:33813/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33813/tests/kraken/driver.html?testName=audio-fft) 08:37:27 INFO - PROCESS | 13366 | RSS: Main: 300642304 08:37:27 INFO - PROCESS | 13366 | 08:37:29 INFO - PROCESS | 13366 | Cycle 1(1): loaded http://localhost:33813/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33813/tests/kraken/driver.html?testName=audio-oscillator) 08:37:30 INFO - PROCESS | 13366 | RSS: Main: 210124800 08:37:30 INFO - PROCESS | 13366 | 08:37:32 INFO - PROCESS | 13366 | Cycle 1(1): loaded http://localhost:33813/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33813/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:37:33 INFO - PROCESS | 13366 | RSS: Main: 213856256 08:37:33 INFO - PROCESS | 13366 | 08:37:36 INFO - PROCESS | 13366 | Cycle 1(1): loaded http://localhost:33813/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33813/tests/kraken/driver.html?testName=imaging-darkroom) 08:37:37 INFO - PROCESS | 13366 | RSS: Main: 250904576 08:37:37 INFO - PROCESS | 13366 | 08:37:40 INFO - PROCESS | 13366 | Cycle 1(1): loaded http://localhost:33813/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33813/tests/kraken/driver.html?testName=imaging-desaturate) 08:37:41 INFO - PROCESS | 13366 | RSS: Main: 244588544 08:37:41 INFO - PROCESS | 13366 | 08:37:44 INFO - PROCESS | 13366 | Cycle 1(1): loaded http://localhost:33813/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33813/tests/kraken/driver.html?testName=json-parse-financial) 08:37:44 INFO - PROCESS | 13366 | RSS: Main: 247885824 08:37:44 INFO - PROCESS | 13366 | 08:37:46 INFO - PROCESS | 13366 | Cycle 1(1): loaded http://localhost:33813/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33813/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:37:46 INFO - PROCESS | 13366 | RSS: Main: 211365888 08:37:46 INFO - PROCESS | 13366 | 08:37:48 INFO - PROCESS | 13366 | Cycle 1(1): loaded http://localhost:33813/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33813/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:37:49 INFO - PROCESS | 13366 | RSS: Main: 219271168 08:37:49 INFO - PROCESS | 13366 | 08:37:51 INFO - PROCESS | 13366 | Cycle 1(1): loaded http://localhost:33813/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33813/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:37:52 INFO - PROCESS | 13366 | RSS: Main: 222519296 08:37:52 INFO - PROCESS | 13366 | 08:37:55 INFO - PROCESS | 13366 | Cycle 1(1): loaded http://localhost:33813/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33813/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:37:55 INFO - PROCESS | 13366 | RSS: Main: 223965184 08:37:55 INFO - PROCESS | 13366 | 08:37:58 INFO - PROCESS | 13366 | Cycle 1(1): loaded http://localhost:33813/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33813/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:37:59 INFO - PROCESS | 13366 | RSS: Main: 221360128 08:37:59 INFO - PROCESS | 13366 | 08:38:01 INFO - PROCESS | 13366 | Cycle 1(1): loaded http://localhost:33813/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33813/tests/kraken/driver.html?testName=ai-astar) 08:38:01 INFO - PROCESS | 13366 | RSS: Main: 272789504 08:38:01 INFO - PROCESS | 13366 | 08:38:01 INFO - PROCESS | 13366 | __start_tp_report 08:38:01 INFO - PROCESS | 13366 | _x_x_mozilla_page_load 08:38:01 INFO - PROCESS | 13366 | _x_x_mozilla_page_load_details 08:38:01 INFO - PROCESS | 13366 | |i|pagename|runs| 08:38:01 INFO - PROCESS | 13366 | |0;ai-astar;112;114;114;114;114;118;114;114;115;113 08:38:01 INFO - PROCESS | 13366 | |1;audio-beat-detection;147;126;123;156;125;124;128;128;177;124 08:38:01 INFO - PROCESS | 13366 | |2;audio-dft;161;160;161;161;161;163;161;163;163;162 08:38:01 INFO - PROCESS | 13366 | |3;audio-fft;78;77;78;111;77;77;78;77;111;75 08:38:01 INFO - PROCESS | 13366 | |4;audio-oscillator;84;83;122;83;84;84;106;84;83;116 08:38:01 INFO - PROCESS | 13366 | |5;imaging-gaussian-blur;116;116;116;117;117;117;116;117;116;117 08:38:01 INFO - PROCESS | 13366 | |6;imaging-darkroom;147;146;147;147;146;147;147;148;147;146 08:38:01 INFO - PROCESS | 13366 | |7;imaging-desaturate;95;95;96;96;96;96;95;95;96;95 08:38:01 INFO - PROCESS | 13366 | |8;json-parse-financial;66;62;63;63;64;65;65;64;64;64 08:38:01 INFO - PROCESS | 13366 | |9;json-stringify-tinderbox;67;67;68;66;67;67;67;66;67;67 08:38:01 INFO - PROCESS | 13366 | |10;stanford-crypto-aes;92;86;83;82;82;82;83;81;82;81 08:38:01 INFO - PROCESS | 13366 | |11;stanford-crypto-ccm;139;138;133;136;143;141;132;143;170;132 08:38:01 INFO - PROCESS | 13366 | |12;stanford-crypto-pbkdf2;175;173;171;171;177;172;174;176;172;171 08:38:01 INFO - PROCESS | 13366 | |13;stanford-crypto-sha256-iterative;69;69;68;69;70;69;69;68;72;68 08:38:01 INFO - PROCESS | 13366 | __end_tp_report 08:38:01 INFO - PROCESS | 13366 | __start_cc_report 08:38:01 INFO - PROCESS | 13366 | _x_x_mozilla_cycle_collect,1913 08:38:01 INFO - PROCESS | 13366 | __end_cc_report 08:38:01 INFO - PROCESS | 13366 | __startTimestamp1475077081399__endTimestamp 08:38:01 INFO - PROCESS | 13366 | 08:38:01 INFO - PROCESS | 13366 | ------- Summary: start ------- 08:38:01 INFO - PROCESS | 13366 | Number of tests: 14 08:38:01 INFO - PROCESS | 13366 | 08:38:01 INFO - PROCESS | 13366 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.00 stddev:1.55 (1.4%) stddev-sans-first:1.42 08:38:01 INFO - PROCESS | 13366 | Values: 112.0 114.0 114.0 114.0 114.0 118.0 114.0 114.0 115.0 113.0 08:38:01 INFO - PROCESS | 13366 | 08:38:01 INFO - PROCESS | 13366 | [#1] audio-beat-detection Cycles:10 Average:135.80 Median:128.00 stddev:18.28 (14.3%) stddev-sans-first:18.93 08:38:01 INFO - PROCESS | 13366 | Values: 147.0 126.0 123.0 156.0 125.0 124.0 128.0 128.0 177.0 124.0 08:38:01 INFO - PROCESS | 13366 | 08:38:01 INFO - PROCESS | 13366 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:1.07 (0.7%) stddev-sans-first:1.12 08:38:01 INFO - PROCESS | 13366 | Values: 161.0 160.0 161.0 161.0 161.0 163.0 161.0 163.0 163.0 162.0 08:38:01 INFO - PROCESS | 13366 | 08:38:01 INFO - PROCESS | 13366 | [#3] audio-fft Cycles:10 Average:83.90 Median:77.00 stddev:14.31 (18.6%) stddev-sans-first:15.02 08:38:01 INFO - PROCESS | 13366 | Values: 78.0 77.0 78.0 111.0 77.0 77.0 78.0 77.0 111.0 75.0 08:38:01 INFO - PROCESS | 13366 | 08:38:01 INFO - PROCESS | 13366 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:83.50 stddev:15.50 (18.6%) stddev-sans-first:16.10 08:38:01 INFO - PROCESS | 13366 | Values: 84.0 83.0 122.0 83.0 84.0 84.0 106.0 84.0 83.0 116.0 08:38:01 INFO - PROCESS | 13366 | 08:38:01 INFO - PROCESS | 13366 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 08:38:01 INFO - PROCESS | 13366 | Values: 116.0 116.0 116.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 08:38:01 INFO - PROCESS | 13366 | 08:38:01 INFO - PROCESS | 13366 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 08:38:01 INFO - PROCESS | 13366 | Values: 147.0 146.0 147.0 147.0 146.0 147.0 147.0 148.0 147.0 146.0 08:38:01 INFO - PROCESS | 13366 | 08:38:01 INFO - PROCESS | 13366 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 08:38:01 INFO - PROCESS | 13366 | Values: 95.0 95.0 96.0 96.0 96.0 96.0 95.0 95.0 96.0 95.0 08:38:01 INFO - PROCESS | 13366 | 08:38:01 INFO - PROCESS | 13366 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:64.00 stddev:1.15 (1.8%) stddev-sans-first:0.97 08:38:01 INFO - PROCESS | 13366 | Values: 66.0 62.0 63.0 63.0 64.0 65.0 65.0 64.0 64.0 64.0 08:38:01 INFO - PROCESS | 13366 | 08:38:01 INFO - PROCESS | 13366 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:67.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 08:38:01 INFO - PROCESS | 13366 | Values: 67.0 67.0 68.0 66.0 67.0 67.0 67.0 66.0 67.0 67.0 08:38:01 INFO - PROCESS | 13366 | 08:38:01 INFO - PROCESS | 13366 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:82.50 stddev:3.34 (4.0%) stddev-sans-first:1.51 08:38:01 INFO - PROCESS | 13366 | Values: 92.0 86.0 83.0 82.0 82.0 82.0 83.0 81.0 82.0 81.0 08:38:01 INFO - PROCESS | 13366 | 08:38:01 INFO - PROCESS | 13366 | [#11] stanford-crypto-ccm Cycles:10 Average:140.70 Median:140.00 stddev:11.12 (7.9%) stddev-sans-first:11.77 08:38:01 INFO - PROCESS | 13366 | Values: 139.0 138.0 133.0 136.0 143.0 141.0 132.0 143.0 170.0 132.0 08:38:01 INFO - PROCESS | 13366 | 08:38:01 INFO - PROCESS | 13366 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.20 Median:173.50 stddev:2.20 (1.3%) stddev-sans-first:2.24 08:38:01 INFO - PROCESS | 13366 | Values: 175.0 173.0 171.0 171.0 177.0 172.0 174.0 176.0 172.0 171.0 08:38:01 INFO - PROCESS | 13366 | 08:38:01 INFO - PROCESS | 13366 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.00 stddev:1.20 (1.7%) stddev-sans-first:1.27 08:38:01 INFO - PROCESS | 13366 | Values: 69.0 69.0 68.0 69.0 70.0 69.0 69.0 68.0 72.0 68.0 08:38:01 INFO - PROCESS | 13366 | -------- Summary: end -------- 08:38:01 INFO - PROCESS | 13366 | 08:38:02 INFO - TEST-INFO | 13366: exit 0 08:38:02 INFO - TEST-OK | kraken | took 64986ms 08:38:02 INFO - SUITE-END | took 1186s 08:38:03 INFO - Completed test suite (00:19:47) 08:38:03 INFO - javascript benchmark 08:38:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2582.9612555811664, 2621.279148234234, 2647.5102106110367, 2659.0427446119393, 2673.5855942328944, 4672.626189904808, 4725.385699859022, 4732.90534189316, 4834.202356611155, 4879.804807807688, 4750.121227572901, 4758.191107511722, 4764.666473346859, 4791.089692958335, 4802.6398020148545, 4399.450068741407, 4405.911881762363, 4447.3996010538485, 4459.687821852472, 4474.172278128541, 4523.140603285382, 4525.0949810037955, 4525.524819893913, 4545.772711364435, 4554.63562914966, 4333.9133217335475, 4392.187445322594, 4457.821687132511, 4492.483364413101, 4511.345854851028, 4425.358323043173, 4444.333349997494, 4449.666275029385, 4452.599266066037, 4452.755098469583, 4403.8458653946955, 4421.579949904753, 4424.247877860771, 4425.137098265839, 4427.778611069466, 4670.929936050962, 4705.882352941169, 4785.425748910153, 4838.080764654739, 4861.902761944777, 5032.4212715537815, 5035.77339019745, 5107.540321371057, 5114.288279839164, 5180.766865491062, 5023.472535383805, 5137.897242055138, 5140.357455318085, 5148.073346797575, 5150.536451719326, 4684.367610372624, 4720.33915251865, 4752.049590081998, 4767.499412561631, 4777.259524773665, 5194.246834209019, 5230.215467679878, 5233.084210263189, 5238.057149713012, 5305.098133317345, 4941.555260026615, 5015.598752099823, 5021.14640511114, 5030.974845125751, 5033.245013248042, 5098.515641014098, 5113.105206588906, 5148.819791307286, 5155.510226528474, 5239.816606418757, 5131.717755523482, 5137.897242055213, 5164.819231326961, 5188.63679542436, 5194.454582268883, 5104.3619547556555, 5109.054824857413, 5111.233315002779, 5112.821051263188, 5156.587473002151, 4247.5540068293, 4288.24955632763, 4359.215341238608, 4370.978145109318, 4413.16149931512, 3787.772733635991, 3790.4314352847296, 3802.258559580855, 3819.026148332213, 3890.824912878927, 4374.803133858921, 4387.034852332482, 4387.978060109679, 4389.385486031958, 4441.555844415532, 5145.691258524501, 5187.273781670569, 5194.454582268883, 5196.1166601677805, 5260.132078207053, 4278.187144442546, 4306.612404883513, 4317.481902171759, 4328.264195086843, 4347.456567929009, 4611.9077618447445, 4622.86131416058, 4645.581897629229, 4650.325702773079, 4652.232381656989, 4377.868663940087, 4390.802413891319, 4402.757848318373, 4410.691251612357, 4458.977705111519, 5058.1401161803315, 5122.436531981404, 5126.6923984561045, 5129.307543481731, 5175.223716442413, 4322.848700295601, 4360.869173924787, 4428.512863585068, 4431.8670439886855, 4438.023634800339, 5060.595152387874, 5119.180931051014, 5130.204818253177, 5139.074966506065, 5141.640085194001, 5132.127538318569, 5150.304708864405, 5150.459201783909, 5154.226865970135, 5220.086484865057, 4795.088933102699, 4850.975745121252, 4936.185529387754, 4986.700797952134, 4987.875303117451, 4831.323614694016, 4883.560479556715, 4918.92621610669, 4937.037277730951, 4999.625028122832, 4876.758542561754, 4878.317035614946, 4882.048000639983, 4885.511448855228, 4941.925871111865, 4970.776315065758, 4987.326710893983, 4992.326035985096, 4993.151164302005, 5036.043151801146, 4761.333413322207, 4800.231962885921, 4802.399700037496, 4810.326554282333, 4842.491538388418], "value": 4672.961436901859, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.7189791053429, 570.4295704295704, 576.1990832742488, 577.0968434400163, 580.1674596953371, 27749.306267343327, 37761.62238377616, 39318.410223846666, 39447.40828887569, 43662.78168609161, 40232.396514052314, 40669.7966510167, 40721.59278407215, 40734.79632601833, 40775.796121019426, 6832.897506537381, 7607.201243869397, 7754.108277548098, 7756.263155000294, 7758.107817600991, 7205.279472052805, 9638.807223855518, 9890.851637225447, 9897.653582124627, 10329.0, 10023.198144148488, 10100.797984040315, 10104.44425556594, 10110.595576176944, 10114.595416183343, 9822.263330250224, 9872.45701486418, 9872.90127098727, 9872.999999999964, 9890.456024918627, 9786.363886347364, 9848.178087053919, 9856.704298870975, 9857.90142098577, 9858.704238872846, 38304.616953830664, 38630.61369386326, 38662.22675546473, 38665.61334386676, 38676.0, 3061.4489391909447, 3108.891188808381, 3119.4696901526795, 3365.2259980204444, 3432.3478539077496, 27046.1886143416, 29227.269318267, 29236.122916312546, 29251.0, 29368.412631747244, 3413.247051000185, 3559.48387483816, 3600.4959305697225, 3611.9097022574383, 3737.2338670572467, 236084.0, 236517.0, 236673.0, 237135.81432092903, 238951.0, 52194.47805521972, 52319.476805232225, 52356.0, 52596.73701631468, 52766.73616631969, 54780.72609636926, 54874.17688734672, 54993.15047946685, 55012.72493637506, 55026.724866376215, 13525.0, 13782.104163229358, 13791.51729689456, 13791.931040344934, 13792.172469651852, 9164.0, 9385.0, 10186.236032297607, 10329.225308101772, 10430.16558675304, 16099.919500402422, 16258.593535161715, 16558.254878530493, 16563.6687266254, 16782.58043548921, 6017.458428741435, 6051.488632217581, 6082.118092876508, 6082.2093127893095, 6236.345183755731, 759.7218004311379, 818.5988865456003, 950.9952450237705, 976.4629453800381, 991.6975322526555, 26058.869705651352, 27777.722222777513, 28159.0, 28267.0, 28290.85854570755, 907.4555266839843, 934.1032608695729, 943.2689665509286, 948.6869333120054, 1026.14829691356, 13816.861831381759, 14218.132590006062, 14308.785368219485, 14401.279936003159, 14524.636884077983, 334799.0, 341111.0, 341821.0, 342774.0, 342784.0, 47769.0, 47818.760906195246, 47855.0, 47877.0, 47968.0, 1078.5470102556944, 1108.7505311305215, 1109.8834622364698, 1178.0, 1178.6876477733408, 26596.734032659424, 28170.43659126765, 28876.133715988555, 31379.37241255208, 31685.36629267448, 45031.54968450405, 45459.31811022903, 45581.54418455773, 45630.0, 45685.77157114193, 332469.0, 336107.0, 336242.0, 336338.0, 336373.0, 24490.51018979646, 24900.12849550257, 31581.0, 32434.35131297408, 38821.61178388293, 30269.394612108073, 33108.337833243684, 33537.16157095994, 36072.45891311685, 44450.0, 36924.630753692116, 36951.445728313556, 37072.81463592665, 37209.0, 37358.25283494369, 37134.0, 37184.256314874096, 37199.25601487901, 38465.0, 38511.422328665656, 36960.815195923846, 37109.44335835019, 37135.07162320964, 37183.81408092942, 37547.0, 32332.515012275304, 33542.83228583841, 34060.82969585136, 34165.658343416246, 34696.30607387787, 26122.738772612032, 26164.215073547824, 26207.475850483264, 26468.602970955835, 26617.201483955512], "value": 17791.78310475164, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.24562944040866, 349.37287568813974, 352.1196809039727, 370.97217708671855, 384.86529714599874, 14743.336549855268, 15334.923325383372, 16703.749443758352, 16823.32706691734, 16997.19546274863, 15034.624134396645, 15839.12884791336, 15842.366305347801, 15925.44260950867, 15954.361825526994, 4942.085714142886, 5291.5766738661005, 5511.889762204753, 5554.611177217596, 5643.266375371196, 5586.497215250627, 5614.747336369853, 5615.213870058195, 5624.325080990287, 5624.803131890385, 5407.864803379907, 5566.972165139168, 5587.357453892793, 5590.8602284943, 5605.159226116074, 5257.684538927677, 5604.859878503029, 5627.071533197018, 5639.125935480028, 5645.858853528674, 5326.627136100475, 5364.570834333244, 5366.275552800361, 5378.031954248234, 5378.408375078739, 12308.384580771015, 12337.198082124632, 12432.254064756144, 12505.0, 12528.123031387806, 1876.3995521433146, 1911.3692481481078, 1941.563148291623, 2001.4195883193856, 2451.4361696809656, 13573.660658483519, 13904.930475347559, 14691.55925322242, 14772.55682329532, 15569.455069072641, 1828.3874901907877, 1853.898035608041, 1880.5016670582306, 1884.2557189910046, 1931.159945423745, 72514.63742681306, 77489.99999999943, 78096.0, 79064.0, 80360.59819700923, 15823.446179383896, 16077.478936163852, 16352.672946541003, 16388.508344749676, 16718.24767885448, 27980.440391192064, 28026.439471210462, 28029.29926751807, 28136.71863281382, 28290.151295461168, 8304.418690691593, 8350.0, 8520.829583408296, 8603.784905377415, 8831.072737362612, 6863.588184708933, 6906.516543841883, 7049.946280888407, 7115.82210444743, 7161.1406631203545, 8189.262966333059, 8317.95841020791, 8335.624896879655, 8394.706185283485, 8641.179087986631, 3180.157258326545, 3183.649798522161, 3197.76016798741, 3304.273059926812, 3400.59192896854, 802.63078983667, 826.4008593769469, 837.1879277101324, 841.9536925469035, 898.1018981018981, 16233.67532649364, 16900.57748556296, 16942.830571694125, 17090.40183593568, 17511.12444377776, 831.9750407487785, 842.2167384332507, 848.2789628815581, 853.0, 863.6977058029765, 8881.725044787954, 9611.231101511863, 9674.274429417821, 9724.902750972542, 9784.755381115529, 373452.0, 376971.0, 380458.0, 382039.0, 395254.0, 74379.25620743832, 75414.6229268861, 75970.24029759632, 76779.0, 78401.60799196082, 878.7144178142001, 885.5793498088357, 898.9820203595891, 903.051795614602, 904.4618452021037, 14473.493427729978, 14594.708105837612, 14691.632709182357, 15375.154366509949, 15414.84585154179, 35567.0, 35946.4608030885, 36121.81939090288, 36530.63469365379, 36685.81657091698, 46341.30488042615, 47919.051737498565, 48056.759716201195, 49378.75310623424, 49909.0, 5908.734106965111, 7351.77944661661, 7362.484626076123, 7555.055618047744, 7581.583012934121, 10142.239332050274, 11022.44887755593, 11058.889411105785, 11146.442677865913, 11467.617052969561, 9617.759556011155, 9829.606815727291, 9884.505774711379, 10049.648262311077, 10213.131883789663, 9210.309226807882, 9242.260619150586, 9543.188828949616, 9835.065668761456, 10150.390976541432, 9573.521323933915, 9964.202863771026, 10213.182945364204, 10352.482375881025, 10446.05985461312, 6765.932340676531, 7156.391706704989, 7210.278972102958, 7269.927300726925, 7330.340269375782, 9227.21568666644, 9734.075262850018, 9813.26400519978, 9886.802263954825, 9890.901090988998], "value": 8728.741837640131, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1245.4208792911306, 1349.116328804633, 1376.724655068986, 1429.9285035748217, 1662.011103393481, 6928.34180752829, 7565.394768418527, 7828.217178282169, 7838.216178382159, 8067.273945344918, 7921.36629069673, 7981.880271795913, 7982.521048737065, 7983.600819959008, 7988.201179882009, 2141.1970511058316, 2175.662772270293, 2178.36827320077, 2182.03990244292, 2182.879941603211, 2102.0435701755664, 2131.041031535807, 2149.4089125490536, 2154.041451554051, 2157.352794161753, 2096.119629755506, 2100.2229175205193, 2102.453362125843, 2106.420734298065, 2176.3906106290183, 2127.606392817326, 2134.679798030292, 2135.487483004068, 2136.529963408048, 2139.475828422031, 2042.611903738285, 2114.3445531885163, 2120.162535798351, 2121.225752600305, 2124.9787502124937, 7714.807129821799, 7879.566623835687, 7951.04587449504, 7992.600369981477, 7998.360131189491, 4499.370088187657, 4608.354830323758, 4620.052889157748, 4652.581267685924, 4656.32483289921, 2818.3658676797763, 2865.441238958404, 2966.2287805170595, 2979.5232762758073, 2980.8062475938996, 952.8142012307603, 966.6954909203648, 979.1334668818076, 985.5072463768116, 992.4541502173776, 10776.0, 10879.510422031028, 10890.237683362167, 10895.400752958583, 10903.618373356894, 3979.1047014421524, 4140.792960351971, 4170.103427763045, 4336.398161103376, 4375.212461756851, 8224.177582241848, 8349.165083491724, 8360.790980225544, 8361.080281169066, 8365.28895043928, 4549.203889319356, 4552.863414097583, 4555.703879247904, 4556.929121656408, 4558.589726924526, 3554.413521768879, 3576.302620988882, 4204.1171354016, 4265.55211702773, 4267.722598031118, 3305.8099084329624, 3307.8842240521467, 3431.605365382963, 3435.3129374125274, 3442.4492081267376, 985.6599473181741, 995.5868314649484, 1004.1866088468364, 1004.7739258666742, 1027.9383237005804, 784.3607459920147, 790.1505881177642, 793.484235247094, 798.078219656298, 800.7677773445636, 4931.950680493221, 5047.848564543069, 5201.141811601119, 5208.348956380452, 5321.0, 407.9714419990572, 420.7917081044902, 422.6808759386643, 423.2297219061279, 423.3480440122177, 3608.1881576645046, 3615.7468977171347, 3688.704903607705, 3694.815259237081, 3725.1432170600915, 9686.612535498642, 9947.55236014381, 10037.899621003697, 10043.146332561668, 10054.949725251327, 9932.553035113437, 9969.601215951281, 9977.950110249547, 9980.850287245697, 10004.649837255662, 7337.266273372727, 7387.593682347522, 7394.075740532434, 7431.739889103856, 7441.888371674429, 5291.126964051043, 5339.652922560176, 5362.436944120811, 5477.507024367826, 5521.282233309644, 8885.955570222108, 9249.630014799333, 9263.53682315868, 9274.814503710022, 9283.907160928304, 8951.328650351119, 9119.908800912172, 9233.353665243369, 9277.721668349961, 9385.0, 6307.653079080695, 6515.218173818982, 6848.9657551711925, 6982.0, 6991.8951215730785, 7233.927660723325, 7445.0, 7471.9626401867645, 7661.961690191513, 7673.961630191813, 6693.866122677617, 6702.765403210864, 6759.898601521079, 6856.897146542706, 6998.790036298919, 6497.837192363462, 6669.966650166718, 6751.223609284995, 6763.830904227434, 6831.9658401707675, 6290.370962903673, 6363.172787537591, 6366.808995730135, 6413.198350206224, 6413.35866413355, 4433.268510695699, 4457.2645513489915, 4475.820967161277, 4521.14098321331, 4542.772861356985, 4398.384226208397, 4511.075229577994, 4633.536646335474, 4653.511381304914, 4676.298555216608], "value": 4024.127739447261, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.3371295451031, 290.33513254646857, 297.0612863351808, 306.0954878334523, 308.3678459158724, 4768.1894078006735, 4808.735519546423, 4818.469968303484, 4833.758312084395, 4869.464358920516, 4765.499622539635, 4766.3088852116425, 4783.784729687164, 4799.5680388765, 4811.951880481194, 3784.6026167252453, 3805.5729101586903, 3809.2381523695235, 3810.618938106195, 3858.514471928314, 3504.351694936432, 3812.4090765931323, 3832.463455116286, 3853.7687738735626, 3855.4987851579253, 3690.132818787583, 3716.312482190803, 3728.459373390857, 3728.459373390857, 3729.832157552903, 3694.649008344203, 3699.834552116075, 3712.978930794053, 3714.9257014859686, 3717.0, 3028.772842036856, 3107.3785242951276, 3240.5787247657654, 3243.172990887332, 3256.853441595134, 4516.141933032746, 4644.651651126179, 4649.604783593365, 4653.581177694024, 4661.836835710734, 4217.683673724483, 4217.810198541073, 4218.430511880888, 4229.767362795045, 4237.131388065439, 4648.697834640738, 4771.832985845479, 5009.073321435546, 5010.922651629917, 5015.4733752956145, 3511.877084302037, 3522.806245656488, 3523.8195204606486, 3533.646635336446, 3535.2399234164523, 5184.377874655028, 5203.152880727363, 5240.0, 5242.895142097175, 5269.86825329366, 3615.078155070493, 3621.247851632778, 3627.3108109459645, 3633.0, 3642.7996460194945, 3499.1951851073886, 3662.08447888028, 3694.649008344203, 3713.164537978987, 3715.294094122108, 4184.686148538872, 4208.705390622627, 4220.345846393814, 4224.978875105605, 4234.55537168599, 5043.571296439771, 5045.208950822479, 5045.772940217699, 5046.697198168048, 5066.214736715815, 1209.6915286601861, 1259.3451405269209, 1274.4328773695802, 1277.5081593586535, 1283.4160456992047, 805.7743831727125, 806.7700705298962, 825.3314814999869, 825.8348330333957, 828.0808302783905, 3925.823337949742, 3930.6462418382484, 3952.466417033721, 3961.2473630010204, 3976.5029371328583, 4526.343680166357, 4535.886602834956, 4550.613197878218, 4553.5218802025975, 4559.726416415026, 3830.3105441020884, 3831.927060423086, 3898.2203559288255, 3904.7852368120025, 3910.904946614952, 2420.1287536486852, 2424.4666173441815, 2508.924732258035, 2688.448867982059, 2714.696945466148, 4096.9795151024055, 4181.456410666594, 4287.442632457761, 4348.565143485689, 4348.695591308578, 5254.343207099113, 5264.263003179558, 5278.419373868871, 5283.0, 5295.914337560791, 4376.452943382077, 4380.627646650007, 4381.9842872279105, 4384.736915785127, 4392.6485881130075, 4981.8329026873425, 5182.352205974254, 5191.610629202901, 5200.921986170286, 5216.765245564035, 5035.5719763819025, 5064.44291127983, 5071.239314102914, 5073.2897394365555, 5119.6416250862085, 4352.3896158421585, 4355.390245365588, 4371.30059190528, 4374.4531933508315, 4379.343098535245, 3421.7091547218765, 3600.8199590020918, 3604.7563590561213, 3614.93359458955, 3619.6064515161324, 5117.8464646060675, 5133.743312834418, 5137.126688462896, 5144.459831717765, 5153.896922061613, 4900.362952816254, 4929.334539837076, 4931.432885218246, 4946.3817022872145, 4970.9254361183885, 4713.622910167247, 4930.556249937523, 4935.679180853233, 4938.0, 4942.935380064383, 4889.706617602955, 4898.530440867797, 4906.607471402208, 4909.582685471775, 4922.4339200992345, 4992.2511623256805, 5004.274380214775, 5019.598432125348, 5021.899562008666, 5022.522860328263, 4777.95222047775, 4862.562369386772, 4902.548725637182, 4915.877103072452, 4926.802927882844], "value": 3680.4335904715404, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.4214141212316, 594.8126340202833, 645.2901808011187, 729.9014633024543, 774.4733581164808, 12382.752344953096, 12817.102802803807, 12878.0, 12885.355732213398, 12894.806577901327, 12984.350782460886, 13388.196708197514, 13555.52555660552, 13624.250666213355, 13625.182489050663, 748.296601194875, 776.510798197135, 778.8208711996244, 778.9883151752729, 779.664744160011, 769.0732667136116, 771.0477560213133, 771.3482107619081, 771.4175797273051, 771.6411868481155, 813.6582635293162, 818.1123481023068, 819.2749416766175, 820.2863508747398, 821.3059964330131, 809.668036105197, 810.4893916832417, 810.8094597769549, 810.9107998120202, 810.9918900810975, 593.8871614393295, 594.1889321076699, 594.586762200271, 594.6699581732137, 594.8126340202865, 11787.410629468579, 11957.461914213794, 11962.40187990597, 11978.460969256404, 11983.221090629082, 10324.07083362501, 10424.478776061167, 10671.199660025452, 10691.625793097204, 11036.061934735557, 9839.950800246024, 9959.302848800515, 9974.800503989953, 9990.500474976223, 10081.546330415149, 3249.0902547286796, 3264.836758162106, 3265.232670322472, 3288.0, 3340.832958352097, 61035.0, 61803.38196618021, 62034.68982655103, 62066.37933620651, 63457.365426345605, 7416.85166296671, 7446.66490007951, 7478.700851965969, 7660.770176894702, 7746.883796743054, 16415.425460109076, 16760.078195699352, 17081.0, 17120.14399280056, 17912.552186195448, 6688.7324507019175, 6729.899051514231, 6755.2906944771075, 6822.965885170543, 6830.180378354629, 3710.3877860152775, 3749.3063783200196, 3755.794144447528, 3800.1829606634706, 3852.2488114817343, 2684.624152618635, 2766.695663477016, 2793.1201671473423, 2795.105566218831, 2826.745592896649, 483.88144904498625, 488.64573184441707, 489.49337435753824, 502.2842449509507, 506.8758154252158, 458.7866642011481, 464.50530185353165, 515.5488947171225, 546.0989367543585, 546.641949523063, 7077.610731409719, 7649.38804895607, 7996.24035716606, 8192.0, 8198.877016844752, 493.4621262823468, 503.7808553279335, 527.527862563004, 533.1842281309603, 541.3747122074011, 3367.3602015617444, 3783.0731470789283, 3827.119762454651, 3829.885103446901, 3911.0853985147514, 57211.427885721445, 57313.0, 57494.0, 57702.42297577055, 58584.0, 82013.0, 86377.56811215903, 86661.0, 86942.56528717316, 88580.5570972141, 45785.31322030172, 61507.69246153741, 76035.61982190053, 76316.27627927928, 76328.23671763322, 7062.024427069966, 7203.495755297079, 7217.50977018913, 7261.745838895613, 7344.0, 41696.16607667891, 42079.94800130021, 42263.57736422597, 43798.78100609604, 44332.33501497415, 37433.43849842309, 38409.807950960065, 39903.0, 64522.0, 65703.34296656972, 9601.087896649808, 9606.423614583147, 9965.152961998021, 10003.199744020316, 10158.796824063329, 10751.623693171014, 10814.783704325711, 11187.0, 12148.817767733668, 12175.0, 10163.796724065625, 10481.895181048092, 10586.99423554761, 10648.201384896009, 10682.57269709203, 10251.794964100825, 10288.588456461957, 11046.944765276123, 11059.72350691239, 11106.0, 10250.846237306298, 10347.0, 10751.462426878781, 10768.19238557127, 10983.286086404358, 9019.278457723498, 9080.500572468578, 9104.90895091067, 9169.908300917172, 9357.157855793012, 8698.913010870063, 8788.516631585324, 8881.111888811067, 9078.682246121354, 9126.315526335418], "value": 6046.516964390133, "unit": "score"}], "name": "dromaeo_css", "value": 6340.870320559374, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 114.0, 114.0, 114.0, 118.0, 114.0, 114.0, 115.0, 113.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 126.0, 123.0, 156.0, 125.0, 124.0, 128.0, 128.0, 177.0, 124.0], "value": 135.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 161.0, 161.0, 163.0, 161.0, 163.0, 163.0, 162.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 78.0, 111.0, 77.0, 77.0, 78.0, 77.0, 111.0, 75.0], "value": 83.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 122.0, 83.0, 84.0, 84.0, 106.0, 84.0, 83.0, 116.0], "value": 92.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 147.0, 146.0, 147.0, 147.0, 148.0, 147.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 62.0, 63.0, 63.0, 64.0, 65.0, 65.0, 64.0, 64.0, 64.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 66.0, 67.0, 67.0, 67.0, 66.0, 67.0, 67.0], "value": 66.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 86.0, 83.0, 82.0, 82.0, 82.0, 83.0, 81.0, 82.0, 81.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 138.0, 133.0, 136.0, 143.0, 141.0, 132.0, 143.0, 170.0, 132.0], "value": 140.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 173.0, 171.0, 171.0, 177.0, 172.0, 174.0, 176.0, 172.0, 171.0], "value": 173.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 68.0, 69.0, 70.0, 69.0, 69.0, 68.0, 72.0, 68.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1544.5000000000002, "alertThreshold": 2.0}]} 08:38:03 INFO - Return code: 0 08:38:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:38:03 INFO - # TBPL SUCCESS # 08:38:03 INFO - Running post-action listener: _resource_record_post_action 08:38:03 INFO - [mozharness: 2016-09-28 15:38:03.191926Z] Finished run-tests step (success) 08:38:03 INFO - Running post-run listener: _resource_record_post_run 08:38:03 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 0; Write bytes: 390635520; Read time: 0; Write time: 335876 08:38:03 INFO - TinderboxPrint: CPU usage
13.0% 08:38:03 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:38:03 INFO - TinderboxPrint: I/O write bytes / time
390,635,520 / 335,876 08:38:03 INFO - TinderboxPrint: CPU idle
8,355.2 (87.0%) 08:38:03 INFO - TinderboxPrint: CPU user
1,200.9 (12.5%) 08:38:03 INFO - TinderboxPrint: Swap in / out
0 / 0 08:38:03 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99119104; Read time: 0; Write time: 64648 08:38:03 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 291516416; Read time: 0; Write time: 271228 08:38:03 INFO - Running post-run listener: _upload_blobber_files 08:38:03 INFO - Blob upload gear active. 08:38:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:38:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:38:03 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:38:03 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:38:04 INFO - (blobuploader) - INFO - Open directory for files ... 08:38:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:38:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:38:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:38:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:38:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:38:04 INFO - (blobuploader) - INFO - Done attempting. 08:38:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:38:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:38:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:38:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:38:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:38:08 INFO - (blobuploader) - INFO - Done attempting. 08:38:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:38:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:38:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:38:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:38:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:38:09 INFO - (blobuploader) - INFO - Done attempting. 08:38:09 INFO - (blobuploader) - INFO - Iteration through files over. 08:38:09 INFO - Return code: 0 08:38:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:38:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:38:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0bde7353bdcc95f0918d111883046578a4aec6a9e187a4185d36ee648459a6410b014cd4a68f31c7286463797ff0e82b6c4bd795395b32c92784d243b12a942d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b58ad480edcf6f1130e37137d159b6397415ef06ecb37963c564bf3c45170def3448a6e470a121c34066cc095efd10739076c7bcfbecf4b8716711b89c4b9f06", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a5cd448930215664c785f0a2374d28bf15ef93b7f6391f8b303fedf75dd8f7b53fc2f4a7f33a74322dcbe4611e5024e093a8186c2012be882118f33c796bfdb7"} 08:38:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:38:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:38:09 INFO - Contents: 08:38:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0bde7353bdcc95f0918d111883046578a4aec6a9e187a4185d36ee648459a6410b014cd4a68f31c7286463797ff0e82b6c4bd795395b32c92784d243b12a942d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b58ad480edcf6f1130e37137d159b6397415ef06ecb37963c564bf3c45170def3448a6e470a121c34066cc095efd10739076c7bcfbecf4b8716711b89c4b9f06", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a5cd448930215664c785f0a2374d28bf15ef93b7f6391f8b303fedf75dd8f7b53fc2f4a7f33a74322dcbe4611e5024e093a8186c2012be882118f33c796bfdb7"} 08:38:09 INFO - Running post-run listener: copy_logs_to_upload_dir 08:38:09 INFO - Copying logs to upload dir... 08:38:09 INFO - mkdir: /builds/slave/test/build/upload/logs 08:38:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.484708 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-09-28 08:38:08.428411) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 08:38:08.431994) ========= 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=920470bf432669ad7e3a5387000001ca-1475072507.983756-744529977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0bde7353bdcc95f0918d111883046578a4aec6a9e187a4185d36ee648459a6410b014cd4a68f31c7286463797ff0e82b6c4bd795395b32c92784d243b12a942d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b58ad480edcf6f1130e37137d159b6397415ef06ecb37963c564bf3c45170def3448a6e470a121c34066cc095efd10739076c7bcfbecf4b8716711b89c4b9f06", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a5cd448930215664c785f0a2374d28bf15ef93b7f6391f8b303fedf75dd8f7b53fc2f4a7f33a74322dcbe4611e5024e093a8186c2012be882118f33c796bfdb7"} build_url:https://queue.taskcluster.net/v1/task/cnGGjv6ORcKHkQAzsH7YWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011507 build_url: 'https://queue.taskcluster.net/v1/task/cnGGjv6ORcKHkQAzsH7YWg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0bde7353bdcc95f0918d111883046578a4aec6a9e187a4185d36ee648459a6410b014cd4a68f31c7286463797ff0e82b6c4bd795395b32c92784d243b12a942d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b58ad480edcf6f1130e37137d159b6397415ef06ecb37963c564bf3c45170def3448a6e470a121c34066cc095efd10739076c7bcfbecf4b8716711b89c4b9f06", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a5cd448930215664c785f0a2374d28bf15ef93b7f6391f8b303fedf75dd8f7b53fc2f4a7f33a74322dcbe4611e5024e093a8186c2012be882118f33c796bfdb7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 08:38:08.457056) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 08:38:08.457339) ========= 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=920470bf432669ad7e3a5387000001ca-1475072507.983756-744529977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004714 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 08:38:08.539006) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 08:38:08.539279) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 08:38:08.539538) ========= ========= Total master_lag: 0.16 =========