builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-009 starttime: 1479401294.57 results: success (0) buildid: 20161117060328 builduid: 90eed37f8d6b4a1c8ca3e39364311e86 revision: 64936ba0330a72cf5e05bca5f44b84562705fea0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 08:48:14.569237) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 08:48:14.569744) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 08:48:14.570028) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 08:48:14.585347) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 08:48:14.585761) ========= 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=17051fcd5208b27b50bedfeb000001dd-1479400414.195924-1745930207 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-17 08:48:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-11-17 08:48:14 (221 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.105005 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 08:48:14.704960) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 08:48:14.705281) ========= 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=17051fcd5208b27b50bedfeb000001dd-1479400414.195924-1745930207 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020597 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 08:48:14.755508) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 08:48:14.755891) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 64936ba0330a72cf5e05bca5f44b84562705fea0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 64936ba0330a72cf5e05bca5f44b84562705fea0 --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=17051fcd5208b27b50bedfeb000001dd-1479400414.195924-1745930207 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-17 08:48:14,828 truncating revision to first 12 chars 2016-11-17 08:48:14,828 Setting DEBUG logging. 2016-11-17 08:48:14,828 attempt 1/10 2016-11-17 08:48:14,828 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/64936ba0330a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-17 08:48:15,160 unpacking tar archive at: mozilla-aurora-64936ba0330a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.695597 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 08:48:15.465102) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 08:48:15.465442) ========= script_repo_revision: 64936ba0330a72cf5e05bca5f44b84562705fea0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 08:48:15.465859) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 08:48:15.466134) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 08:48:15.476177) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-11-17 08:48:15.476535) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=17051fcd5208b27b50bedfeb000001dd-1479400414.195924-1745930207 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:48:15 INFO - MultiFileLogger online at 20161117 08:48:15 in /builds/slave/test 08:48:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:48:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:48:15 INFO - {'append_to_log': False, 08:48:15 INFO - 'base_work_dir': '/builds/slave/test', 08:48:15 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:48:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:48:15 INFO - 'branch': 'Mozilla-Aurora', 08:48:15 INFO - 'buildbot_json_path': 'buildprops.json', 08:48:15 INFO - 'config_files': ('talos/linux_config.py',), 08:48:15 INFO - 'default_actions': ('clobber', 08:48:15 INFO - 'read-buildbot-config', 08:48:15 INFO - 'download-and-extract', 08:48:15 INFO - 'populate-webroot', 08:48:15 INFO - 'create-virtualenv', 08:48:15 INFO - 'install', 08:48:15 INFO - 'run-tests'), 08:48:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:48:15 INFO - 'download_minidump_stackwalk': True, 08:48:15 INFO - 'download_symbols': 'ondemand', 08:48:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:48:15 INFO - 'tooltool.py': '/tools/tooltool.py', 08:48:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:48:15 INFO - '/tools/misc-python/virtualenv.py')}, 08:48:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:48:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:48:15 INFO - 'installer_path': 'installer.exe', 08:48:15 INFO - 'log_level': 'info', 08:48:15 INFO - 'log_name': 'talos', 08:48:15 INFO - 'log_to_console': True, 08:48:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:48:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:48:15 INFO - 'opt_config_files': (), 08:48:15 INFO - 'pip_index': False, 08:48:15 INFO - 'sps_profile': False, 08:48:15 INFO - 'sps_profile_interval': 0, 08:48:15 INFO - 'suite': 'dromaeojs', 08:48:15 INFO - 'system_bits': '32', 08:48:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:48:15 INFO - 'title': 'talos-linux64-ix-009', 08:48:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:48:15 INFO - 'use_talos_json': True, 08:48:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:48:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:48:15 INFO - 'work_dir': 'build'} 08:48:15 INFO - [mozharness: 2016-11-17 16:48:15.651514Z] Running clobber step. 08:48:15 INFO - Running pre-action listener: _resource_record_pre_action 08:48:15 INFO - Running main action method: clobber 08:48:15 INFO - rmtree: /builds/slave/test/build 08:48:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:48:16 INFO - Running post-action listener: _resource_record_post_action 08:48:16 INFO - [mozharness: 2016-11-17 16:48:16.110632Z] Finished clobber step (success) 08:48:16 INFO - [mozharness: 2016-11-17 16:48:16.110731Z] Running read-buildbot-config step. 08:48:16 INFO - Running pre-action listener: _resource_record_pre_action 08:48:16 INFO - Running main action method: read_buildbot_config 08:48:16 INFO - Using buildbot properties: 08:48:16 INFO - { 08:48:16 INFO - "project": "", 08:48:16 INFO - "product": "firefox", 08:48:16 INFO - "script_repo_revision": "production", 08:48:16 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 08:48:16 INFO - "repository": "", 08:48:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 08:48:16 INFO - "buildid": "20161117060328", 08:48:16 INFO - "pgo_build": "True", 08:48:16 INFO - "basedir": "/builds/slave/test", 08:48:16 INFO - "buildnumber": 910, 08:48:16 INFO - "slavename": "talos-linux64-ix-009", 08:48:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:48:16 INFO - "platform": "ubuntu64_hw", 08:48:16 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:48:16 INFO - "branch": "mozilla-aurora", 08:48:16 INFO - "repo_path": "releases/mozilla-aurora", 08:48:16 INFO - "revision": "64936ba0330a72cf5e05bca5f44b84562705fea0", 08:48:16 INFO - "stage_platform": "linux64-pgo", 08:48:16 INFO - "builduid": "90eed37f8d6b4a1c8ca3e39364311e86", 08:48:16 INFO - "slavebuilddir": "test" 08:48:16 INFO - } 08:48:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/Op72mYFhRGewYngggjmFPg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 08:48:16 INFO - Running post-action listener: _resource_record_post_action 08:48:16 INFO - [mozharness: 2016-11-17 16:48:16.113188Z] Finished read-buildbot-config step (success) 08:48:16 INFO - [mozharness: 2016-11-17 16:48:16.113276Z] Running download-and-extract step. 08:48:16 INFO - Running pre-action listener: _resource_record_pre_action 08:48:16 INFO - Running main action method: download_and_extract 08:48:16 INFO - mkdir: /builds/slave/test/build/tests 08:48:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:16 INFO - trying https://queue.taskcluster.net/v1/task/Op72mYFhRGewYngggjmFPg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:48:16 INFO - Downloading https://queue.taskcluster.net/v1/task/Op72mYFhRGewYngggjmFPg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:48:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Op72mYFhRGewYngggjmFPg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:48:16 INFO - Downloaded 1361 bytes. 08:48:16 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:48:16 INFO - Using the following test package requirements: 08:48:16 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:48:16 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:48:16 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:48:16 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:48:16 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 08:48:16 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:48:16 INFO - u'jsshell-linux-x86_64.zip'], 08:48:16 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:48:16 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:48:16 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:48:16 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:48:16 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:48:16 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:48:16 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:48:16 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:48:16 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:48:16 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:48:16 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:48:16 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:48:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Op72mYFhRGewYngggjmFPg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:48:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Op72mYFhRGewYngggjmFPg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:48:16 INFO - Fetch https://queue.taskcluster.net/v1/task/Op72mYFhRGewYngggjmFPg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:48:17 INFO - Http code: 200 08:48:17 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 08:48:17 INFO - x-amz-cf-id: PEnd5L9bdjw132pZxBHk-_FXcheSK9_dT_98wV8tlZsASQMh7jvUHw== 08:48:17 INFO - x-amz-version-id: W6DosISho9Rl9vjeeoZ_noYTqwmoqxQK 08:48:17 INFO - Expected file size: 21999432 08:48:17 INFO - Obtained file size: 21999432 08:48:21 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:48:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Op72mYFhRGewYngggjmFPg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:48:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Op72mYFhRGewYngggjmFPg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:48:21 INFO - Fetch https://queue.taskcluster.net/v1/task/Op72mYFhRGewYngggjmFPg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:48:22 INFO - Http code: 200 08:48:22 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 08:48:22 INFO - x-amz-cf-id: AeuOZ3ONgWa3XN4qXzlAPYzZsYfwg-99WS0CUVDK3qLWRQKHx0Go4Q== 08:48:22 INFO - x-amz-version-id: W6DosISho9Rl9vjeeoZ_noYTqwmoqxQK 08:48:22 INFO - Expected file size: 21999432 08:48:22 INFO - Obtained file size: 21999432 08:48:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Op72mYFhRGewYngggjmFPg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 08:48:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Op72mYFhRGewYngggjmFPg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:48:27 INFO - Fetch https://queue.taskcluster.net/v1/task/Op72mYFhRGewYngggjmFPg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 08:48:27 INFO - Http code: 200 08:48:27 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 08:48:27 INFO - x-amz-cf-id: oX7w72bSF4r1RE-s0DyhbQ-LAbKcIsNnUWrgkiHQT0qugLqe35G2ow== 08:48:27 INFO - x-amz-version-id: Sd8isQ1aIFX5XhZpz3nlpxUUTeFY.TB9 08:48:27 INFO - Expected file size: 14409038 08:48:27 INFO - Obtained file size: 14409038 08:48:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:28 INFO - trying https://queue.taskcluster.net/v1/task/Op72mYFhRGewYngggjmFPg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:48:28 INFO - Downloading https://queue.taskcluster.net/v1/task/Op72mYFhRGewYngggjmFPg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:48:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Op72mYFhRGewYngggjmFPg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:48:29 INFO - Downloaded 63915778 bytes. 08:48:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Op72mYFhRGewYngggjmFPg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:48:29 INFO - mkdir: /builds/slave/test/properties 08:48:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:48:29 INFO - Writing to file /builds/slave/test/properties/build_url 08:48:29 INFO - Contents: 08:48:29 INFO - build_url:https://queue.taskcluster.net/v1/task/Op72mYFhRGewYngggjmFPg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:48:30 INFO - Running post-action listener: _resource_record_post_action 08:48:30 INFO - Running post-action listener: set_extra_try_arguments 08:48:30 INFO - [mozharness: 2016-11-17 16:48:30.074450Z] Finished download-and-extract step (success) 08:48:30 INFO - [mozharness: 2016-11-17 16:48:30.074678Z] Running populate-webroot step. 08:48:30 INFO - Running pre-action listener: _resource_record_pre_action 08:48:30 INFO - Running main action method: populate_webroot 08:48:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:48:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:48:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:48:30 INFO - '--tppagecycles', 08:48:30 INFO - '7'], 08:48:30 INFO - 'tests': ['tsvgm']}}, 08:48:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:48:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:48:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:48:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:48:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:48:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:48:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:30 INFO - 'talos_options': ['--disable-e10s'], 08:48:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:48:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:48:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:30 INFO - 'talos_options': ['--disable-e10s'], 08:48:30 INFO - 'tests': ['damp', 'tps']}, 08:48:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:30 INFO - 'tests': ['damp', 'tps']}, 08:48:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:48:30 INFO - 'tests': ['dromaeo_dom']}, 08:48:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:48:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:48:30 INFO - 'tests': ['basic_compositor_video']}, 08:48:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:48:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:48:30 INFO - 'tests': ['a11yr', 08:48:30 INFO - 'ts_paint', 08:48:30 INFO - 'tpaint', 08:48:30 INFO - 'sessionrestore', 08:48:30 INFO - 'sessionrestore_no_auto_restore', 08:48:30 INFO - 'tabpaint']}, 08:48:30 INFO - 'other-e10s': {'tests': ['a11yr', 08:48:30 INFO - 'ts_paint', 08:48:30 INFO - 'tpaint', 08:48:30 INFO - 'sessionrestore', 08:48:30 INFO - 'sessionrestore_no_auto_restore', 08:48:30 INFO - 'tabpaint']}, 08:48:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:48:30 INFO - 'ts_paint', 08:48:30 INFO - 'tpaint', 08:48:30 INFO - 'sessionrestore', 08:48:30 INFO - 'sessionrestore_no_auto_restore', 08:48:30 INFO - 'tabpaint']}, 08:48:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:48:30 INFO - 'ts_paint', 08:48:30 INFO - 'tpaint', 08:48:30 INFO - 'sessionrestore', 08:48:30 INFO - 'sessionrestore_no_auto_restore', 08:48:30 INFO - 'tabpaint']}, 08:48:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:48:30 INFO - 'tests': ['a11yr', 08:48:30 INFO - 'ts_paint', 08:48:30 INFO - 'tpaint', 08:48:30 INFO - 'sessionrestore', 08:48:30 INFO - 'sessionrestore_no_auto_restore', 08:48:30 INFO - 'tabpaint']}, 08:48:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:48:30 INFO - 'tests': ['a11yr', 08:48:30 INFO - 'ts_paint', 08:48:30 INFO - 'tpaint', 08:48:30 INFO - 'sessionrestore', 08:48:30 INFO - 'sessionrestore_no_auto_restore', 08:48:30 INFO - 'tabpaint']}, 08:48:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:48:30 INFO - 'tests': ['tsvgx', 08:48:30 INFO - 'tsvgr_opacity', 08:48:30 INFO - 'tart', 08:48:30 INFO - 'tscrollx', 08:48:30 INFO - 'cart']}, 08:48:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:48:30 INFO - 'tsvgr_opacity', 08:48:30 INFO - 'tart', 08:48:30 INFO - 'tscrollx', 08:48:30 INFO - 'cart']}, 08:48:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:30 INFO - 'talos_options': ['--disable-e10s'], 08:48:30 INFO - 'tests': ['tp5o']}, 08:48:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:30 INFO - 'tests': ['tp5o']}, 08:48:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:30 INFO - 'talos_options': ['--disable-e10s', 08:48:30 INFO - '--xperf_path', 08:48:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:48:30 INFO - 'tests': ['tp5n']}, 08:48:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:30 INFO - 'talos_options': ['--xperf_path', 08:48:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:48:30 INFO - 'tests': ['tp5n']}}, 08:48:30 INFO - 'talos.zip': {'path': '', 08:48:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:48:30 INFO - Running post-action listener: _resource_record_post_action 08:48:30 INFO - [mozharness: 2016-11-17 16:48:30.092528Z] Finished populate-webroot step (success) 08:48:30 INFO - [mozharness: 2016-11-17 16:48:30.092616Z] Running create-virtualenv step. 08:48:30 INFO - Running pre-action listener: _resource_record_pre_action 08:48:30 INFO - Running main action method: create_virtualenv 08:48:30 INFO - Creating virtualenv /builds/slave/test/build/venv 08:48:30 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:48:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:48:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:48:30 INFO - Using real prefix '/usr' 08:48:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:48:30 INFO - Installing distribute.............................................................................................................................................................................................done. 08:48:32 INFO - Installing pip.................done. 08:48:32 INFO - Return code: 0 08:48:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:48:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:48:32 INFO - Reading from file tmpfile_stdout 08:48:32 INFO - Output received: 08:48:32 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:48:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:48:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:32 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 0x7fca2f80bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2039ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2036f60>, '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 0x2037d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20381d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1479400414.195924-1745930207', '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:48:32 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:48:32 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:48:32 INFO - Using env: {'DISPLAY': ':0', 08:48:32 INFO - 'HOME': '/home/cltbld', 08:48:32 INFO - 'LANG': 'en_US.UTF-8', 08:48:32 INFO - 'LANGUAGE': 'en_US:en', 08:48:32 INFO - 'LOGNAME': 'cltbld', 08:48:32 INFO - 'MAIL': '/var/mail/cltbld', 08:48:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:32 INFO - 'MOZ_NO_REMOTE': '1', 08:48:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:32 INFO - 'NO_EM_RESTART': '1', 08:48:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:32 INFO - 'PWD': '/builds/slave/test', 08:48:32 INFO - 'SHELL': '/bin/bash', 08:48:32 INFO - 'SHLVL': '1', 08:48:32 INFO - 'TERM': 'linux', 08:48:32 INFO - 'TMOUT': '86400', 08:48:32 INFO - 'USER': 'cltbld', 08:48:32 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1479400414.195924-1745930207', 08:48:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:32 INFO - '_': '/tools/buildbot/bin/python'} 08:48:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:33 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:48:33 INFO - Cleaning up... 08:48:33 INFO - Return code: 0 08:48:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:48: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:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48: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:48:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fca2f80bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2039ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2036f60>, '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 0x2037d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20381d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1479400414.195924-1745930207', '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:48:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:48:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:48:33 INFO - Using env: {'DISPLAY': ':0', 08:48:33 INFO - 'HOME': '/home/cltbld', 08:48:33 INFO - 'LANG': 'en_US.UTF-8', 08:48:33 INFO - 'LANGUAGE': 'en_US:en', 08:48:33 INFO - 'LOGNAME': 'cltbld', 08:48:33 INFO - 'MAIL': '/var/mail/cltbld', 08:48:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:33 INFO - 'MOZ_NO_REMOTE': '1', 08:48:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:33 INFO - 'NO_EM_RESTART': '1', 08:48:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:33 INFO - 'PWD': '/builds/slave/test', 08:48:33 INFO - 'SHELL': '/bin/bash', 08:48:33 INFO - 'SHLVL': '1', 08:48:33 INFO - 'TERM': 'linux', 08:48:33 INFO - 'TMOUT': '86400', 08:48:33 INFO - 'USER': 'cltbld', 08:48:33 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1479400414.195924-1745930207', 08:48:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:33 INFO - '_': '/tools/buildbot/bin/python'} 08:48:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:33 INFO - Downloading/unpacking psutil>=3.1.1 08:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:48:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:48:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:48:35 INFO - Installing collected packages: psutil 08:48:35 INFO - Running setup.py install for psutil 08:48:35 INFO - building 'psutil._psutil_linux' extension 08:48:35 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:48:35 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:48:35 INFO - building 'psutil._psutil_posix' extension 08:48:35 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:48:35 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:48:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:48:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:48:35 INFO - Successfully installed psutil 08:48:35 INFO - Cleaning up... 08:48:35 INFO - Return code: 0 08:48:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca2f80bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2039ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2036f60>, '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 0x2037d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20381d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1479400414.195924-1745930207', '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:48:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:48:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:48:35 INFO - Using env: {'DISPLAY': ':0', 08:48:35 INFO - 'HOME': '/home/cltbld', 08:48:35 INFO - 'LANG': 'en_US.UTF-8', 08:48:35 INFO - 'LANGUAGE': 'en_US:en', 08:48:35 INFO - 'LOGNAME': 'cltbld', 08:48:35 INFO - 'MAIL': '/var/mail/cltbld', 08:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:35 INFO - 'MOZ_NO_REMOTE': '1', 08:48:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:35 INFO - 'NO_EM_RESTART': '1', 08:48:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:35 INFO - 'PWD': '/builds/slave/test', 08:48:35 INFO - 'SHELL': '/bin/bash', 08:48:35 INFO - 'SHLVL': '1', 08:48:35 INFO - 'TERM': 'linux', 08:48:35 INFO - 'TMOUT': '86400', 08:48:35 INFO - 'USER': 'cltbld', 08:48:35 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1479400414.195924-1745930207', 08:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:35 INFO - '_': '/tools/buildbot/bin/python'} 08:48:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:48:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:48:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:48:38 INFO - Installing collected packages: mozsystemmonitor 08:48:38 INFO - Running setup.py install for mozsystemmonitor 08:48:38 INFO - Successfully installed mozsystemmonitor 08:48:38 INFO - Cleaning up... 08:48:38 INFO - Return code: 0 08:48:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:48:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fca2f80bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2039ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2036f60>, '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 0x2037d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20381d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1479400414.195924-1745930207', '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:48:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:48:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:48:38 INFO - Using env: {'DISPLAY': ':0', 08:48:38 INFO - 'HOME': '/home/cltbld', 08:48:38 INFO - 'LANG': 'en_US.UTF-8', 08:48:38 INFO - 'LANGUAGE': 'en_US:en', 08:48:38 INFO - 'LOGNAME': 'cltbld', 08:48:38 INFO - 'MAIL': '/var/mail/cltbld', 08:48:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:38 INFO - 'MOZ_NO_REMOTE': '1', 08:48:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:38 INFO - 'NO_EM_RESTART': '1', 08:48:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:38 INFO - 'PWD': '/builds/slave/test', 08:48:38 INFO - 'SHELL': '/bin/bash', 08:48:38 INFO - 'SHLVL': '1', 08:48:38 INFO - 'TERM': 'linux', 08:48:38 INFO - 'TMOUT': '86400', 08:48:38 INFO - 'USER': 'cltbld', 08:48:38 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1479400414.195924-1745930207', 08:48:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:38 INFO - '_': '/tools/buildbot/bin/python'} 08:48:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:38 INFO - Downloading/unpacking jsonschema==2.5.1 08:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:48:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:48: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:48: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:48: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:48: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:48: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:48: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:48:40 INFO - Downloading functools32-3.2.3-2.tar.gz 08:48:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:48:40 INFO - warning: no files found matching '*.txt' 08:48:40 INFO - no previously-included directories found matching 'build' 08:48:40 INFO - no previously-included directories found matching 'dist' 08:48:40 INFO - no previously-included directories found matching '.git*' 08:48:40 INFO - Installing collected packages: jsonschema, functools32 08:48:40 INFO - Running setup.py install for functools32 08:48:40 INFO - warning: no files found matching '*.txt' 08:48:40 INFO - no previously-included directories found matching 'build' 08:48:40 INFO - no previously-included directories found matching 'dist' 08:48:40 INFO - no previously-included directories found matching '.git*' 08:48:40 INFO - Successfully installed jsonschema functools32 08:48:40 INFO - Cleaning up... 08:48:40 INFO - Return code: 0 08:48:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:48: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:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48: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:48:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48: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', '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 0x7fca2f80bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2039ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2036f60>, '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 0x2037d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20381d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1479400414.195924-1745930207', '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:48: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:48: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 functools32==3.2.3-2 08:48:40 INFO - Using env: {'DISPLAY': ':0', 08:48:40 INFO - 'HOME': '/home/cltbld', 08:48:40 INFO - 'LANG': 'en_US.UTF-8', 08:48:40 INFO - 'LANGUAGE': 'en_US:en', 08:48:40 INFO - 'LOGNAME': 'cltbld', 08:48:40 INFO - 'MAIL': '/var/mail/cltbld', 08:48:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:40 INFO - 'MOZ_NO_REMOTE': '1', 08:48:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:40 INFO - 'NO_EM_RESTART': '1', 08:48:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:40 INFO - 'PWD': '/builds/slave/test', 08:48:40 INFO - 'SHELL': '/bin/bash', 08:48:40 INFO - 'SHLVL': '1', 08:48:40 INFO - 'TERM': 'linux', 08:48:40 INFO - 'TMOUT': '86400', 08:48:40 INFO - 'USER': 'cltbld', 08:48:40 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1479400414.195924-1745930207', 08:48:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:40 INFO - '_': '/tools/buildbot/bin/python'} 08:48:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:48:41 INFO - Cleaning up... 08:48:41 INFO - Return code: 0 08:48:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:48:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:41 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 0x7fca2f80bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2039ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2036f60>, '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 0x2037d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20381d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1479400414.195924-1745930207', '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:48:41 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:48:41 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:48:41 INFO - Using env: {'DISPLAY': ':0', 08:48:41 INFO - 'HOME': '/home/cltbld', 08:48:41 INFO - 'LANG': 'en_US.UTF-8', 08:48:41 INFO - 'LANGUAGE': 'en_US:en', 08:48:41 INFO - 'LOGNAME': 'cltbld', 08:48:41 INFO - 'MAIL': '/var/mail/cltbld', 08:48:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:41 INFO - 'MOZ_NO_REMOTE': '1', 08:48:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:41 INFO - 'NO_EM_RESTART': '1', 08:48:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:41 INFO - 'PWD': '/builds/slave/test', 08:48:41 INFO - 'SHELL': '/bin/bash', 08:48:41 INFO - 'SHLVL': '1', 08:48:41 INFO - 'TERM': 'linux', 08:48:41 INFO - 'TMOUT': '86400', 08:48:41 INFO - 'USER': 'cltbld', 08:48:41 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1479400414.195924-1745930207', 08:48:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:41 INFO - '_': '/tools/buildbot/bin/python'} 08:48:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:41 INFO - Downloading/unpacking blobuploader==1.2.4 08:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:43 INFO - Downloading blobuploader-1.2.4.tar.gz 08:48:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:48:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:48: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:48: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:48: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:48: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:48: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:48: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:48:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:48:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:48: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:48: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:48: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:48: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:48: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:48: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:48:43 INFO - Downloading docopt-0.6.1.tar.gz 08:48:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:48:44 INFO - Installing collected packages: blobuploader, requests, docopt 08:48:44 INFO - Running setup.py install for blobuploader 08:48:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:48:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:48:44 INFO - Running setup.py install for requests 08:48:44 INFO - Running setup.py install for docopt 08:48:44 INFO - Successfully installed blobuploader requests docopt 08:48:44 INFO - Cleaning up... 08:48:44 INFO - Return code: 0 08:48:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48:44 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:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:44 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:48:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:44 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 0x7fca2f80bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2039ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2036f60>, '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 0x2037d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20381d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1479400414.195924-1745930207', '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:48:44 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:48:44 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:48:44 INFO - Using env: {'DISPLAY': ':0', 08:48:44 INFO - 'HOME': '/home/cltbld', 08:48:44 INFO - 'LANG': 'en_US.UTF-8', 08:48:44 INFO - 'LANGUAGE': 'en_US:en', 08:48:44 INFO - 'LOGNAME': 'cltbld', 08:48:44 INFO - 'MAIL': '/var/mail/cltbld', 08:48:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:44 INFO - 'MOZ_NO_REMOTE': '1', 08:48:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:44 INFO - 'NO_EM_RESTART': '1', 08:48:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:44 INFO - 'PWD': '/builds/slave/test', 08:48:44 INFO - 'SHELL': '/bin/bash', 08:48:44 INFO - 'SHLVL': '1', 08:48:44 INFO - 'TERM': 'linux', 08:48:44 INFO - 'TMOUT': '86400', 08:48:44 INFO - 'USER': 'cltbld', 08:48:44 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1479400414.195924-1745930207', 08:48:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:44 INFO - '_': '/tools/buildbot/bin/python'} 08:48:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:48:44 INFO - Running setup.py (path:/tmp/pip-FgCiAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:48:44 INFO - Running setup.py (path:/tmp/pip-WUcku2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:48:45 INFO - Running setup.py (path:/tmp/pip-r82yG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:48:45 INFO - Running setup.py (path:/tmp/pip-GXv8fx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:48:45 INFO - Running setup.py (path:/tmp/pip-KBstVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:48:45 INFO - Running setup.py (path:/tmp/pip-Ool1NT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:48:45 INFO - Running setup.py (path:/tmp/pip-bNvWyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:48:45 INFO - Running setup.py (path:/tmp/pip-556Smc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:48:45 INFO - Running setup.py (path:/tmp/pip-krmkTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:48:45 INFO - Running setup.py (path:/tmp/pip-U_xIxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:48:45 INFO - Running setup.py (path:/tmp/pip-D0e4QF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:48:45 INFO - Running setup.py (path:/tmp/pip-ptqxYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:48:45 INFO - Running setup.py (path:/tmp/pip-qeUMr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:48:45 INFO - Running setup.py (path:/tmp/pip-1rIktI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:45 INFO - Running setup.py (path:/tmp/pip-84UI34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:48:45 INFO - Running setup.py (path:/tmp/pip-27lI4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:48:46 INFO - Running setup.py (path:/tmp/pip-vWL79M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:48:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:48:46 INFO - Running setup.py install for manifestparser 08:48:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:48:46 INFO - Running setup.py install for mozcrash 08:48:46 INFO - Running setup.py install for mozdebug 08:48:46 INFO - Running setup.py install for mozdevice 08:48:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:48:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:48:46 INFO - Running setup.py install for mozfile 08:48:46 INFO - Running setup.py install for mozhttpd 08:48:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:48:46 INFO - Running setup.py install for mozinfo 08:48:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:48:46 INFO - Running setup.py install for mozInstall 08:48:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:48:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:48:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:48:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:48:46 INFO - Running setup.py install for mozleak 08:48:47 INFO - Running setup.py install for mozlog 08:48:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:48:47 INFO - Running setup.py install for moznetwork 08:48:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:48:47 INFO - Running setup.py install for mozprocess 08:48:47 INFO - Running setup.py install for mozprofile 08:48:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:48:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:48:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:48:47 INFO - Running setup.py install for mozrunner 08:48:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:48:47 INFO - Running setup.py install for mozscreenshot 08:48:47 INFO - Running setup.py install for moztest 08:48:47 INFO - Running setup.py install for mozversion 08:48:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:48:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:48:47 INFO - Cleaning up... 08:48:47 INFO - Return code: 0 08:48:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48: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:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48: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:48:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:47 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 0x7fca2f80bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2039ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2036f60>, '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 0x2037d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20381d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1479400414.195924-1745930207', '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:48:47 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:48:47 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:48:47 INFO - Using env: {'DISPLAY': ':0', 08:48:47 INFO - 'HOME': '/home/cltbld', 08:48:47 INFO - 'LANG': 'en_US.UTF-8', 08:48:47 INFO - 'LANGUAGE': 'en_US:en', 08:48:47 INFO - 'LOGNAME': 'cltbld', 08:48:47 INFO - 'MAIL': '/var/mail/cltbld', 08:48:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:47 INFO - 'MOZ_NO_REMOTE': '1', 08:48:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:47 INFO - 'NO_EM_RESTART': '1', 08:48:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:47 INFO - 'PWD': '/builds/slave/test', 08:48:47 INFO - 'SHELL': '/bin/bash', 08:48:47 INFO - 'SHLVL': '1', 08:48:47 INFO - 'TERM': 'linux', 08:48:47 INFO - 'TMOUT': '86400', 08:48:47 INFO - 'USER': 'cltbld', 08:48:47 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1479400414.195924-1745930207', 08:48:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:47 INFO - '_': '/tools/buildbot/bin/python'} 08:48:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:48:48 INFO - Running setup.py (path:/tmp/pip-uklv3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:48:48 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:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:48:48 INFO - Running setup.py (path:/tmp/pip-8nrDTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:48:48 INFO - Running setup.py (path:/tmp/pip-jXaeAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:48:48 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:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:48:48 INFO - Running setup.py (path:/tmp/pip-Fl3RvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:48:48 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:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:48:48 INFO - Running setup.py (path:/tmp/pip-Eok5_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:48:48 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:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:48:48 INFO - Running setup.py (path:/tmp/pip-MkAI1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:48:48 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:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:48:48 INFO - Running setup.py (path:/tmp/pip-WA3STm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:48:48 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:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:48:48 INFO - Running setup.py (path:/tmp/pip-Zxkv_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:48:48 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:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:48:48 INFO - Running setup.py (path:/tmp/pip-11Vy3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:48:48 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:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:48:48 INFO - Running setup.py (path:/tmp/pip-H2W7m1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:48:48 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:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:48:48 INFO - Running setup.py (path:/tmp/pip-IhUlo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:48:48 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:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:48:48 INFO - Running setup.py (path:/tmp/pip-EDY7dN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:48:49 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:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:48:49 INFO - Running setup.py (path:/tmp/pip-C5BRoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:48:49 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:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:48:49 INFO - Running setup.py (path:/tmp/pip-blakXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:49 INFO - Running setup.py (path:/tmp/pip-6yeEGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:49 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:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:48:49 INFO - Running setup.py (path:/tmp/pip-PlR_Df-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:48:49 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:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:48:49 INFO - Running setup.py (path:/tmp/pip-1husbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:48:49 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:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:48:49 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:48:49 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:48:49 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:48:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:48:49 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:48:49 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:48:49 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:48:49 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:48:49 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:48:49 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:48:51 INFO - Downloading blessings-1.6.tar.gz 08:48:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:48:51 INFO - Installing collected packages: blessings 08:48:51 INFO - Running setup.py install for blessings 08:48:51 INFO - Successfully installed blessings 08:48:51 INFO - Cleaning up... 08:48:51 INFO - Return code: 0 08:48:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:48:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:48:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:48:51 INFO - Reading from file tmpfile_stdout 08:48:51 INFO - Current package versions: 08:48:51 INFO - argparse == 1.2.1 08:48:51 INFO - blessings == 1.6 08:48:51 INFO - blobuploader == 1.2.4 08:48:51 INFO - docopt == 0.6.1 08:48:51 INFO - functools32 == 3.2.3-2 08:48:51 INFO - jsonschema == 2.5.1 08:48:51 INFO - manifestparser == 1.1 08:48:51 INFO - mozInstall == 1.12 08:48:51 INFO - mozcrash == 1.0 08:48:51 INFO - mozdebug == 0.1 08:48:51 INFO - mozdevice == 0.48 08:48:51 INFO - mozfile == 1.2 08:48:51 INFO - mozhttpd == 0.7 08:48:51 INFO - mozinfo == 0.9 08:48:51 INFO - mozleak == 0.1 08:48:51 INFO - mozlog == 3.4 08:48:51 INFO - moznetwork == 0.27 08:48:51 INFO - mozprocess == 0.23 08:48:51 INFO - mozprofile == 0.28 08:48:51 INFO - mozrunner == 6.13 08:48:51 INFO - mozscreenshot == 0.1 08:48:51 INFO - mozsystemmonitor == 0.3 08:48:51 INFO - moztest == 0.7 08:48:51 INFO - mozversion == 1.4 08:48:51 INFO - psutil == 3.1.1 08:48:51 INFO - requests == 1.2.3 08:48:51 INFO - wsgiref == 0.1.2 08:48:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48: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:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48: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:48:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:51 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 0x7fca2f80bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2039ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2036f60>, '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 0x2037d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20381d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1479400414.195924-1745930207', '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:48:51 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:48:51 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:48:51 INFO - Using env: {'DISPLAY': ':0', 08:48:51 INFO - 'HOME': '/home/cltbld', 08:48:51 INFO - 'LANG': 'en_US.UTF-8', 08:48:51 INFO - 'LANGUAGE': 'en_US:en', 08:48:51 INFO - 'LOGNAME': 'cltbld', 08:48:51 INFO - 'MAIL': '/var/mail/cltbld', 08:48:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:51 INFO - 'MOZ_NO_REMOTE': '1', 08:48:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:51 INFO - 'NO_EM_RESTART': '1', 08:48:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:51 INFO - 'PWD': '/builds/slave/test', 08:48:51 INFO - 'SHELL': '/bin/bash', 08:48:51 INFO - 'SHLVL': '1', 08:48:51 INFO - 'TERM': 'linux', 08:48:51 INFO - 'TMOUT': '86400', 08:48:51 INFO - 'USER': 'cltbld', 08:48:51 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1479400414.195924-1745930207', 08:48:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:51 INFO - '_': '/tools/buildbot/bin/python'} 08:48:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:52 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:48:52 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:48:52 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:48:52 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:48:52 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:48:52 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:48:52 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:48:52 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:48:52 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:48:52 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:48:52 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:48:52 INFO - Cleaning up... 08:48:52 INFO - Return code: 0 08:48:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:48:52 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:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:52 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:48:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:52 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 0x7fca2f80bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2039ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2036f60>, '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 0x2037d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20381d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1479400414.195924-1745930207', '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:48:52 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:48:52 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:48:52 INFO - Using env: {'DISPLAY': ':0', 08:48:52 INFO - 'HOME': '/home/cltbld', 08:48:52 INFO - 'LANG': 'en_US.UTF-8', 08:48:52 INFO - 'LANGUAGE': 'en_US:en', 08:48:52 INFO - 'LOGNAME': 'cltbld', 08:48:52 INFO - 'MAIL': '/var/mail/cltbld', 08:48:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:52 INFO - 'MOZ_NO_REMOTE': '1', 08:48:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:52 INFO - 'NO_EM_RESTART': '1', 08:48:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:52 INFO - 'PWD': '/builds/slave/test', 08:48:52 INFO - 'SHELL': '/bin/bash', 08:48:52 INFO - 'SHLVL': '1', 08:48:52 INFO - 'TERM': 'linux', 08:48:52 INFO - 'TMOUT': '86400', 08:48:52 INFO - 'USER': 'cltbld', 08:48:52 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1479400414.195924-1745930207', 08:48:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:52 INFO - '_': '/tools/buildbot/bin/python'} 08:48:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:48:52 INFO - Cleaning up... 08:48:52 INFO - Return code: 0 08:48:52 INFO - Running post-action listener: _resource_record_post_action 08:48:52 INFO - Running post-action listener: _start_resource_monitoring 08:48:52 INFO - Starting resource monitoring. 08:48:52 INFO - [mozharness: 2016-11-17 16:48:52.321742Z] Finished create-virtualenv step (success) 08:48:52 INFO - [mozharness: 2016-11-17 16:48:52.322246Z] Running install step. 08:48:52 INFO - Running pre-action listener: _resource_record_pre_action 08:48:52 INFO - Running main action method: install 08:48:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:48:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:48:52 INFO - Reading from file tmpfile_stdout 08:48:52 INFO - Detecting whether we're running mozinstall >=1.0... 08:48:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:48:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:48:52 INFO - Reading from file tmpfile_stdout 08:48:52 INFO - Output received: 08:48:52 INFO - Usage: mozinstall [options] installer 08:48:52 INFO - Options: 08:48:52 INFO - -h, --help show this help message and exit 08:48:52 INFO - -d DEST, --destination=DEST 08:48:52 INFO - Directory to install application into. [default: 08:48:52 INFO - "/builds/slave/test"] 08:48:52 INFO - --app=APP Application being installed. [default: firefox] 08:48:52 INFO - mkdir: /builds/slave/test/build/application 08:48:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:48:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:49:08 INFO - Reading from file tmpfile_stdout 08:49:08 INFO - Output received: 08:49:08 INFO - /builds/slave/test/build/application/firefox/firefox 08:49:08 INFO - Running post-action listener: _resource_record_post_action 08:49:08 INFO - [mozharness: 2016-11-17 16:49:08.519936Z] Finished install step (success) 08:49:08 INFO - [mozharness: 2016-11-17 16:49:08.520177Z] Running run-tests step. 08:49:08 INFO - Running pre-action listener: _resource_record_pre_action 08:49:08 INFO - Running main action method: run_tests 08:49:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:49:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:49:08 INFO - Python 2.7.3 08:49:08 INFO - Return code: 0 08:49:08 INFO - grabbing minidump binary from tooltool 08:49:08 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:49:08 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 0x2036f60>, '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 0x2037d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20381d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:49:08 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:49:08 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:49:08 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:49:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:49:08 INFO - Return code: 0 08:49:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:49:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:49:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:49:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:49:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:49:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Op72mYFhRGewYngggjmFPg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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:49:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Op72mYFhRGewYngggjmFPg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --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:49:08 INFO - Using env: {'DISPLAY': ':0', 08:49:08 INFO - 'HOME': '/home/cltbld', 08:49:08 INFO - 'LANG': 'en_US.UTF-8', 08:49:08 INFO - 'LANGUAGE': 'en_US:en', 08:49:08 INFO - 'LOGNAME': 'cltbld', 08:49:08 INFO - 'MAIL': '/var/mail/cltbld', 08:49:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:49:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:49:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:08 INFO - 'MOZ_NO_REMOTE': '1', 08:49:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:49:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:08 INFO - 'NO_EM_RESTART': '1', 08:49:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:08 INFO - 'PWD': '/builds/slave/test', 08:49:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:49:08 INFO - 'SHELL': '/bin/bash', 08:49:08 INFO - 'SHLVL': '1', 08:49:08 INFO - 'TERM': 'linux', 08:49:08 INFO - 'TMOUT': '86400', 08:49:08 INFO - 'USER': 'cltbld', 08:49:08 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1479400414.195924-1745930207', 08:49:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:08 INFO - '_': '/tools/buildbot/bin/python'} 08:49:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Op72mYFhRGewYngggjmFPg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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:49:08 INFO - mozversion application_buildid: 20161117060328 08:49:08 INFO - mozversion application_changeset: 64936ba0330a72cf5e05bca5f44b84562705fea0 08:49:08 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:49:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:49:08 INFO - mozversion application_name: Firefox 08:49:08 INFO - mozversion application_remotingname: firefox-dev 08:49:08 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:49:08 INFO - mozversion application_vendor: Mozilla 08:49:08 INFO - mozversion application_version: 52.0a2 08:49:08 INFO - mozversion platform_buildid: 20161117060328 08:49:08 INFO - mozversion platform_changeset: 64936ba0330a72cf5e05bca5f44b84562705fea0 08:49:08 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:49:08 INFO - mozversion platform_version: 52.0a2 08:49:08 INFO - using testdate: 1479401348 08:49:08 INFO - actual date: 1479401348 08:49:08 INFO - starting webserver on 'localhost:47582' 08:49:08 INFO - SUITE-START | Running 2 tests 08:49:08 INFO - TEST-START | dromaeo_css 08:49:08 INFO - operating with platform_type : linux_ 08:49:08 INFO - Initialising browser for dromaeo_css test... 08:49:08 INFO - TEST-INFO | started process 7210 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLDmJaV/profile http://localhost:47582/getInfo.html) 08:49:12 ERROR - PROCESS | 7210 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 08:49:13 INFO - PROCESS | 7210 | __metrics Screen width/height:1600/1200 08:49:13 INFO - PROCESS | 7210 | colorDepth:24 08:49:13 INFO - PROCESS | 7210 | Browser inner width/height: 1024/697 08:49:13 INFO - PROCESS | 7210 | __metrics 08:49:13 INFO - PROCESS | 7210 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:49:13 INFO - PROCESS | 7210 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:49:14 INFO - PROCESS | 7210 | console.error: PushService: 08:49:14 INFO - PROCESS | 7210 | stateChangeProcessEnqueue: Error transitioning state 08:49:14 INFO - PROCESS | 7210 | UnknownError 08:49:14 INFO - TEST-INFO | 7210: exit 0 08:49:14 INFO - Browser initialized. 08:49:14 INFO - Running cycle 1/1 for dromaeo_css test... 08:49:14 INFO - TEST-INFO | started process 7304 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLDmJaV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:49:26 INFO - PROCESS | 7304 | RSS: Main: 144642048 08:49:26 INFO - PROCESS | 7304 | 08:50:17 INFO - PROCESS | 7304 | 1479401417992 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:52:28 INFO - PROCESS | 7304 | Cycle 1(1): loaded http://localhost:47582/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47582/tests/dromaeo/cssquery-ext.html) 08:52:29 INFO - PROCESS | 7304 | RSS: Main: 239116288 08:52:29 INFO - PROCESS | 7304 | 08:55:31 INFO - PROCESS | 7304 | Cycle 1(1): loaded http://localhost:47582/tests/dromaeo/cssquery-ext.html (next: http://localhost:47582/tests/dromaeo/cssquery-jquery.html) 08:55:32 INFO - PROCESS | 7304 | RSS: Main: 227098624 08:55:32 INFO - PROCESS | 7304 | 08:58:34 INFO - PROCESS | 7304 | Cycle 1(1): loaded http://localhost:47582/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47582/tests/dromaeo/cssquery-mootools.html) 08:58:34 INFO - PROCESS | 7304 | RSS: Main: 175833088 08:58:34 INFO - PROCESS | 7304 | 09:01:36 INFO - PROCESS | 7304 | Cycle 1(1): loaded http://localhost:47582/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47582/tests/dromaeo/cssquery-prototype.html) 09:01:37 INFO - PROCESS | 7304 | RSS: Main: 227270656 09:01:37 INFO - PROCESS | 7304 | 09:04:40 INFO - PROCESS | 7304 | Cycle 1(1): loaded http://localhost:47582/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47582/tests/dromaeo/cssquery-yui.html) 09:04:40 INFO - PROCESS | 7304 | RSS: Main: 174616576 09:04:40 INFO - PROCESS | 7304 | 09:07:43 INFO - PROCESS | 7304 | Cycle 1(1): loaded http://localhost:47582/tests/dromaeo/cssquery-yui.html (next: http://localhost:47582/tests/dromaeo/cssquery-dojo.html) 09:07:43 INFO - PROCESS | 7304 | RSS: Main: 268472320 09:07:43 INFO - PROCESS | 7304 | 09:07:43 INFO - PROCESS | 7304 | __start_tp_report 09:07:43 INFO - PROCESS | 7304 | _x_x_mozilla_page_load 09:07:43 INFO - PROCESS | 7304 | _x_x_mozilla_page_load_details 09:07:43 INFO - PROCESS | 7304 | |i|pagename|runs| 09:07:43 INFO - PROCESS | 7304 | |0;dojo.html;3175.4601717707997;3209.6790320967907;3219.2434777827216;3233.822139782311;3234.916303038482;5560.805371811983;5635.549156067515;5641.802536911209;5643.0688936325505;5657.9717101414535;5623.4938855503;5674.971625141879;5678.034734095203;5682.943170568293;5710.114932185507;5146.845594632167;5163.483651634844;5190.351206099238;5203.4016088149965;5256.684598924076;4933.506649335056;5242.370915490146;5249.763760630781;5257.08001099806;5272.393674727398;4948.901021979558;5058.822941197059;5100.923486147711;5107.438181799999;5117.283580298743;5128.205128205134;5161.638685292012;5164.147915593922;5206.140986737184;5222.712750798704;5028;5086.186210206386;5150.587952963754;5163.870903227412;5189.117849965515;5359.839204823861;5398.48714372138;5407.080796264644;5418.83743487696;5473.261109750172;5844.707764611752;5859.150423188614;5859.44335288147;5937.406259374071;5948.286205655306;5991.191189189447;6004.039353703431;6016.939830601726;6018.277806663228;6025.126356678301;5437.265969094161;5498.120300751901;5544.029794785896;5599.468050535193;5681.971590142023;6125.356837531995;6126.448619624255;6137.140800287963;6144.078388241799;6146.5390095743;5896.7641294348605;5912.674802885796;5914.99445094335;5916.970415147896;5919.585629005928;5741.483266506035;5784.855378615568;5877.882442351214;5903.439173278532;5982.282126144891;5937.673427961504;5945.583809133405;5978.252718410199;5981;6013.759449621966;5891.7937872175125;5942.61373010753;5957.851053723692;5969.731362088716;5970.223870896755;4490.101979604027;4519.593236608721;4591.563801438858;4632.930506042412;4643.048175124091;4063.878083657495;4077.062275676611;4106.630403263661;4118.094019315746;4134.131832315187;5579.9163012554845;5581.386047534768;5588.21764952907;5615.438456154352;5668.121441176624;5735.053716136791;5754.1944127822135;5981.5214782817275;6002.789902353396;6022.09668549721;5618.269624948731;5663.9716801415725;5668.8866222675315;5707.0868661014865;5750.137479378043;5149.845504634867;5155.355580552431;5157.045946499909;5161.535461808456;5163.7676304566385;6005.849853753691;6180.505559555315;6253.499720022387;6255.280642726054;6255.655938923312;5818.2436283282905;5851;5867.970660146842;5882.911756323573;6019.187409699634;6190.371860497454;6201.503879689704;6211.565190436626;6215.564910456224;6218.720157593009;5908.9954707698935;5909.438603332676;5910.881782364415;5915;5917.289925209003;5816.447437493432;5818.50542703858;5901.7639294427745;5914.142449344907;5963.970180149072;5849.385814489588;5863.149843272787;5869.853253668693;5871.882562348815;5900.586958912835;5812.099124635688;5858.677772722541;5859.355470898283;5868;5869.266341707286;5605.159226116115;5609.1305847593685;5793.15999180125;5860.326062502867;5863.824085277449;5939.673317967553;5955.583109182316;5960.433758792908;5962.37395073511;5991.730372133352;5540;5773.884522309446;5805.10020946754;5807.128930660266;5811.62224455426 09:07:43 INFO - PROCESS | 7304 | |1;ext.html;595.743830153034;622.7477871462057;651.7360469010051;654.6792071884778;681.8261343357443;32700.182495437624;42696.78651606741;43586.56413435865;43613;43623.56376436235;44045.33931991023;44432;44545;44575.331370029475;44578.7771061145;8277;8688.56557172142;8806.823863522726;8821.73534793954;8823.470591764482;8182.959085204566;10226.284160108795;10484.895151048506;10505.527251273672;10747.731306717356;10505.579776808956;10554.208434367414;10560.102391296748;10566;10568.841467377995;10371.222158338118;10380.221483388701;10381.740456488573;10431.426271555061;10438.269321147485;10301;10361.792764144675;10362.740931476697;10375.584976600927;10377.688669339932;42177.78911105425;42503.36244956328;42556.36165457521;42561.78719106385;42562.78718606387;3640.672339489459;3646.398344273192;3739.4951681522916;3786.772793632391;4113.526944401402;32495;32579;32749;32967.83516082404;33050.83474582636;3805.5813860475328;3807.7905715185652;3816.732828701992;3835.654791068789;3876.9030774230587;345189;345406;345600;346436;346896;59281.70359148177;59563.40436595665;59685.403145968856;59713;59774;38092.61907380946;38687.61312386896;38928.22143557113;41263.587364125975;41271.38092928608;19146.617067658568;19309.22763089489;19337.613247734967;19348.4195474136;19352.516187095152;12821.230726156275;13002.08985371015;14611.926940365443;15046.54860354191;15168;19068.523286917938;19583.81894430666;19715.901420492806;19725.70411443801;19786.50533736668;7335.926640733631;7388.556686598821;7424.96287518559;7572.848543029108;7585.1656317805;996.3822430093244;1053.2364036073939;1120.3501968858043;1122.8484154639182;1136.0797753819434;32131.196720081716;32261.677383226335;32388.190295242806;32600;32978.34043319168;1042.6924057403085;1094.5402930769096;1117.536222467667;1137.86914504833;1165.452237448398;15181.772273415907;17198.91400542989;17497;18013.459596212135;18162.727559086623;551451;552619;553787;554188;554364;58817.70591147017;59212.40787592069;59216;59229;59349.40650593525;1307.3985966455537;1359.8368195816367;1364.6042647632273;1426.450816435659;1429.2425014742203;29591.26021849471;33034.66965330316;33529.83235083809;35530.46704299489;35880.10299742423;55569;56087.15869262046;56207.15689264583;56216;56238.71880640734;351398;354680;354874;355339;355904;26241.081562145235;27148.864255678596;27913.720862791113;28935.276618084717;30019.24951876133;47420.52579474161;47611.761941190074;47914.52085479101;47978.76010619925;48062.759686201345;40830.79584602058;41440.585594143675;41794.37308440437;41829.58170418257;42686;41781.164376712906;41888;41903.58096418997;43106;43435.34846977361;37432.06419839526;38934.80532597319;41543.169136617704;41576.168476630904;41613.79193104136;34514.82742586271;36095.81952090223;36231.63768362282;37963.43054854124;40041.1991760169;28694.713052869203;28887.7111228885;29108;29132.56301155442;29174.56238156387 09:07:43 INFO - PROCESS | 7304 | |2;jquery.html;432.5069420860222;434.7565363396498;436.8405531980827;437.4488144937378;454.6158496070821;18703.71944420833;19323;19939.401817945447;20028;20109.798902010974;19697.21211151552;19727.40817775469;19973.90013049933;20156.294529691462;20214.797852021475;5662.745176467059;5930.940690593104;5957.344692083867;5957.553183511232;5960;5577.9163312550345;5817.476427121579;5882.323532793719;5900.498457631106;5920.644761314335;5945.108233764927;5949.107633854913;5950.523958083343;5954.374790646984;5960.135780311853;5786.421357864222;5835.533157347423;5909;5925.970370148165;5965.791197308095;5751.913721294142;5760.596758226926;5765.942340576583;5767.480926716616;5767.8558036049435;20100.296489622793;22769;23364;23478.882605586863;23651.172208972774;2319.2694301295205;2486.353548077495;2514.9371265718505;2536.581464058428;2916.1397387770658;10811.135109191246;11375;11415.372154531497;11431;11438.02776763976;1953.1894263880472;1959.1477707197273;2002.9699554506549;2014.5870096630156;2065.5972085443195;64976.675116624116;76346.23653763447;79437;83837;87752.56123719404;11143.721406964729;11584.710382240342;11730.237534560398;11884.821727674092;12043.337616431005;16934.745978810326;16935.407260745815;16936.661266774594;16941.407050753412;16956.321747129976;8739.38824282294;9111.316651251183;9192.402493838013;9194.310426718022;9354.766130846647;8630.741077767678;8764.1674040966;8860.955695221483;9151.542422878829;9265.768355791024;4964.032013757354;5025.296458495814;5039.647224694309;5141.1491862929315;5212.635115541876;2071.2957594417667;2095.5913596848773;2097.842661800371;2127.88296643683;2141.967870481944;915.949622770754;981.6711401680517;1002.5137808163036;1002.6540843409012;1039.7608550033535;19516;20081.698774518394;20120.597588048156;20211;20440.182392704126;1000.8098461292332;1007.808516381885;1028.5011769291887;1052.221356196409;1060.5598676549146;10486.37081775096;11092.889071109186;11124.850418827413;11276.1542884284;11335.659930201942;434269;441430;442584;443088;464885;94680.52659736657;95501.5224923871;95694.52152739192;96650;98006.5099674497;1016.922062613632;1037.8339465685453;1085.8914108589079;1095.912327013837;1098.1489345756943;17517.386891458736;18002;18209.45371638853;18239.726404104214;18446.16992235326;43686.56313436825;44108.33837492376;44210;44860.32709509294;44869;59625;59779.402205977385;59807.401925980186;60307.396926030175;62787;5648.519875810603;8806.691765788166;9074.45553266806;9134.862977055216;9259.398139120936;13192.142510736772;13237.205767653972;13260;13281.66795830112;13503.797443038558;11162.44187790591;11355.886441135483;11688.357140357022;11868.347240901488;12469.937650312053;10964.232503724663;11034.668959931216;11081.113510918945;11342.60300889465;11708.765824683289;11215.158863085464;11422.657320280405;11593.88406115928;11604.709882253012;11917.344546049704;9045.864312035457;9107.362484626012;9155.450672959643;9157.130072643089;9510.048995100435;10527.789444211227;11230.21388502797;11241.55033798639;11278.605248816251;11443.771124577628 09:07:43 INFO - PROCESS | 7304 | |3;mootools.html;1270.9745805083892;1522.8857835662325;1527.745229535743;1712.2893998990412;1853.1197681101478;7584.9241507584975;8307.293880020197;8544.70093546726;8545.743627691163;8908.643654253821;8780.69267575635;8784.297256219503;8805.691800786974;8828.33787465941;8865.86701199481;2416.9879150604224;2446;2446.6085426331792;2447.596146635803;2448.1186772761794;2391.940201494959;2417.830751847371;2420.5279970405777;2428.5871401861727;2434.525267572824;2343.8828058597087;2350.200931683236;2363.0902102690416;2376.66726658268;2378.52429514097;2299.6435552489393;2303.0557471436714;2340.6254999200046;2342.695449591542;2344.566255242777;2328.196772113618;2332.8133749300014;2359.834811563191;2362.7519110493495;2367.0531787285054;8643.17889800468;8834.823303533958;8839.513826739527;8844;8844.20402163802;5346.812861549827;5522.088855338864;5531.3915469298345;5640.548756099543;5646.604737668365;3277.2789986202997;3332.683395077464;3399.2351720862857;3425.8629654813776;3590.8204589770667;1047.2250534604339;1126.1441304608556;1137.4767606900837;1141.9379976621822;1145.873953865074;11952.760944781143;11995.700107497296;12114.636560903098;12156.209846360047;12177.51289948401;4464.330350447459;4726.621870250372;4783.808647654055;4802.807887684454;4805.471398146201;9485.905140948502;9486.098820612031;9531.332806703464;9572.76068098303;9580.856287155699;5469.699166545878;5476.3702174250475;5485.369182543979;5487.64330318528;5488;4307.332363483665;4482.372467854503;4659.464161621389;5160.767765450564;5199;4027.637512623878;4028.536718277377;4115.218108559424;4115.42384066231;4180.665546756313;1264.7660182866016;1303.1985329022582;1305.9869401306055;1309.5351150341683;1317.2228385252747;933.2627224492575;1001.8397056471075;1006.8993100690019;1029.7374169586708;1035.2804800663466;5985.40145985398;6114.419130182626;6145.8156255312415;6249.968750156311;6355.504472540085;490.87237318296786;494.9480304568041;508.63938963273836;527.3566249175999;529.6213207556616;4095.9795201023803;4200.096979149497;4205.9789701051295;4298.828046878152;4307.978460107742;10367.429791361397;10554.841677374845;10768.569257229623;10892;11091.611793587346;10791.190660700478;10914.508847101899;10917.290376125526;10918.399488028235;10930.781384372427;8287.917120828835;8511.361647876434;8515.531645759418;8521.744347669704;8523.40336176474;6262.3111457738705;6351.364863513611;6360.9045864313;6409.262934762375;6409.455196308366;9849.45827979468;10022.498875056071;10031.247656425943;10136.44249566281;10159.847602285823;8990.86513702308;9271.165595096474;10347.017033381817;10355.689329320132;10356.119729822749;7416.555006699616;7731.7680469586;7743.845123097619;7809.570473623778;7907.367410607253;8288.875666865122;8334.08325084228;8364.121767214356;8366.498010119412;8378.958105209435;7476.25237476248;7532.096148462219;7542.245775422414;7563.7352692655495;7780.572068536285;7399.334059934632;7463.440241981764;7520.8495830082;7541.283578060075;7632.69469221225;7064.788056358112;7195.676194571152;7198.5680859148615;7203.171635262012;7204.819879503054;5362.705051222064;5433.5924805640525;5444.673319600836;5460.972695136499;5565.010295467642;5402.918956215739;5492.340919089735;5510.834674959758;5548.500634942875;5653.689047102284 09:07:43 INFO - PROCESS | 7304 | |4;prototype.html;354.9183687751817;358.8241761536847;366.0720074610862;366.2199515032979;371.8954704527554;5348.73256337183;5375.543078838304;5378.784848606056;5379;5381.5963802714805;5078.898422031566;5160.3033590465275;5186.844394668166;5200.453952335007;5304.840854774363;4216.7680777557225;4229.900225941246;4230.555791641879;4241.1093670329265;4255.723377980436;4244.511881133662;4248.787560621972;4249.958760103764;4254.595813397722;4273.978630106861;3968.5436174839974;3995.9021513705393;4214;4226.640735537483;4249.553796851333;4226.90100573853;4241.639460645849;4241.703080784347;4241.724287921275;4250.489941207075;3804.923901521982;3814.6185381461632;3817.8663746769007;3824.8278827452555;3825.3114439401174;4977.178765503724;5164.934026389436;5171.224316352577;5171.3277273954145;5251;4795.232762757977;4806.759662016885;4815.879603009953;4843.975780121112;4848.248521479177;5510.476504732044;5526.513069118912;5535.308086489189;5569.359523654791;5573.052581061229;3882.2041481496226;4088.5093788745244;4103.651189648884;4182.519010313822;4198.874033778991;5746.626469279525;5749.511291540182;5772.682502462363;5779;5782.797602083907;4189.162167566499;4194.30793919006;4200;4204.474440694913;4205.789710514462;4189.664826813848;4227.7528129201955;4270.338097594878;4286.421333120051;4295.463067116611;4756.405449318835;4761.976190119027;4762.64280178988;4804.351412559329;4850.733209673502;5540.587150276654;5540.972295138498;5590.692511911802;5599.844060036834;5609.80365687199;1380.792881067848;1402.9298535073206;1406.1352268355092;1413.519403402848;1426.4650755966513;910.922571581423;934.8971613122551;958.3435346787334;986.7385142937128;997.481309718942;5180.326557547494;5202.505761952684;5202.583793296527;5219.138842091088;5272.736363181825;5444.891102177934;5469.003813608084;5479.561635069185;5497.45025497455;5513.436252142773;5041.8487445376695;5145.6621278467865;5148.7691054099805;5173.689578625294;5237.502437268454;2882.164172390025;2907.4766542022217;2909.3453972855937;2921.28428535006;2921.4887394705843;5579.358373787067;5630.6058575900115;5644.858878527987;5654.491095801315;5664.376918538957;5858.648481091063;5869.354371019184;5894.38108998549;5903.35063143054;5904.881902361929;5985.311689155716;5986.161937328778;5990.281166260077;6000.489958353589;6002.519798416203;5584.916226256691;5726.427357264407;5731.799387021434;5776.595638305278;5813.651180928989;5667.716614169192;5702.6863522506665;5715;5740.39725828782;5748.148740343896;5782.306123265235;5892.827112742156;5970.402874749498;5980.790672326448;5981.342052374148;4179.137290955584;4205.747655140702;4221;4222.556631553765;4229.429027081304;5740.282464691913;5762.366139724711;5765.91351129725;5771.1920331154515;5795.275590551181;5381.515663590296;5632.788950375689;5675.0919852825;5680.857978550569;5690.800821971211;5640.351359593699;5642.802501912413;5643.548516118783;5648.378678345297;5653.265075540154;5392.460753924733;5477.20580515831;5607.719614019201;5609.4390560943575;5637.238972738792;5497.285352904097;5611.57913156523;5626.2685850839125;5634.4365563443325;5649.774009039593;5509.779608815763;5516.696581687886;5549.250851135206;5550.52820510245;5571.609987301013 09:07:43 INFO - PROCESS | 7304 | |5;yui.html;815.4210510537519;821.5317269156579;841.4026041510527;858.7767180533061;883.0418995390002;16789.748153777688;17311;17406.39077632283;17463.214155363006;17464.738028929576;16192.518608499171;16335;16706.498805035837;16756.83243167568;16762.497125086265;715.4312321704258;731.9743808966688;841.2680967558217;856.0070318430621;857.6097875466647;804.4811096842533;829.266099501939;834.2908527751423;834.3992325525612;834.8747687846811;882.0077412910475;882.386741214856;884.6903583745702;885.026470882031;887.0685779931047;744.9627518624047;770.9190534993801;873.2359185712502;880.7313769300392;880.9119088091204;571.8856228754224;572.0104219699942;619.7118339971935;637.4740838808002;643.3694978920684;15261.465848695243;15314.004589701633;15434.151121688303;15476.22618869052;15489.767653485207;13788.172709637454;13789.448422063106;13835.30823458823;13846.515371962034;13877.167369957835;12641.115121941468;12705.809412858815;12708.364581770875;12855.164414313133;13012.414441350162;4365.126974605092;4388.89027774305;4457.064016556527;4464.531224221442;4553.339765733983;60789.08816367758;64110.35889641137;64508;64640.3535964639;65323;11282.210245282915;11365.147613928988;11436.370999595103;11505.022073123711;11607.6517704469;19870.205191792455;19917;19920.70118948217;19921.20315187405;19980;8182.651861007665;8230.547319897343;8241.217084376975;8415.452995555392;8505.74482765518;4701.365315682339;4824.614030877521;4864.927026094611;4874.073925954058;4949.529794669501;3646.9817650911577;3757.8496860125833;3759.1166075972124;3759.9248015039548;3761.022134245116;660.3165723476179;671.3689132215702;672.2873753820966;673.1652750589332;700.2542292458515;623.8814625221194;672.2974491656231;743.3124359967009;761.77146855943;788.5938741548107;9141.222996045277;9227.26181905446;9476.431414115175;9586.137247647745;9613.182879455324;701.6035939694057;759.6012093650767;769.5882702754;787.8818177273455;796.1719811396199;4352.912941741148;4560.3843481129625;4650.395448591661;4722.5513576210205;4749.9050019000115;78794.6060269695;90855;92128.53935730412;92961.53519232495;93941.5302923481;45277.547224527334;45827.31259031117;68599;72117;72156.99999999895;64182;64732;64738.35261647418;66393.33606663968;66815.66592167008;10143.08712215904;10343.741406464898;10542.8418573723;10657.14742820588;10666.306690065121;45170.322445164005;45722.91077192837;46336.53663463457;46787.766061169474;48358.758206208746;49999;62979.68510157603;63268.68365658142;64464.67767661132;65762.67118664568;12810.487580496676;12851.807222891477;12909.289989050316;13291.933540332237;13461.798073028716;13814.930925345308;14028.78956815669;14535.781963270349;14776.63058423548;14880.553583392515;13511.662208444868;13683.794743079061;13956.720865582834;14000.789988149982;14145.292735363397;13488.595342139752;13823.723525529233;14073.366698498798;14343.928280358532;14475.348609312396;13785.862141378459;13994.230317332644;14665;14938.327775249922;14941.477048303257;10617.628383006559;10645.89354106449;11439.485223165144;11561.884381156417;11579.189456737948;10103.494825258855;11655.650330490098;11867.05063594893;12168;12176.147669663393 09:07:43 INFO - PROCESS | 7304 | __end_tp_report 09:07:43 INFO - PROCESS | 7304 | __start_cc_report 09:07:43 INFO - PROCESS | 7304 | _x_x_mozilla_cycle_collect,1011 09:07:43 INFO - PROCESS | 7304 | __end_cc_report 09:07:43 INFO - PROCESS | 7304 | __startTimestamp1479402463945__endTimestamp 09:07:43 INFO - PROCESS | 7304 | 09:07:43 INFO - PROCESS | 7304 | ------- Summary: start ------- 09:07:43 INFO - PROCESS | 7304 | Number of tests: 6 09:07:43 INFO - PROCESS | 7304 | 09:07:43 INFO - PROCESS | 7304 | [#0] dojo.html Cycles:165 Average:5552.61 Median:5784.86 stddev:620.86 (10.7%) stddev-sans-first:594.09 09:07:43 INFO - PROCESS | 7304 | Values: 3175.5 3209.7 3219.2 3233.8 3234.9 5560.8 5635.5 5641.8 5643.1 5658.0 5623.5 5675.0 5678.0 5682.9 5710.1 5146.8 5163.5 5190.4 5203.4 5256.7 4933.5 5242.4 5249.8 5257.1 5272.4 4948.9 5058.8 5100.9 5107.4 5117.3 5128.2 5161.6 5164.1 5206.1 5222.7 5028.0 5086.2 5150.6 5163.9 5189.1 5359.8 5398.5 5407.1 5418.8 5473.3 5844.7 5859.2 5859.4 5937.4 5948.3 5991.2 6004.0 6016.9 6018.3 6025.1 5437.3 5498.1 5544.0 5599.5 5682.0 6125.4 6126.4 6137.1 6144.1 6146.5 5896.8 5912.7 5915.0 5917.0 5919.6 5741.5 5784.9 5877.9 5903.4 5982.3 5937.7 5945.6 5978.3 5981.0 6013.8 5891.8 5942.6 5957.9 5969.7 5970.2 4490.1 4519.6 4591.6 4632.9 4643.0 4063.9 4077.1 4106.6 4118.1 4134.1 5579.9 5581.4 5588.2 5615.4 5668.1 5735.1 5754.2 5981.5 6002.8 6022.1 5618.3 5664.0 5668.9 5707.1 5750.1 5149.8 5155.4 5157.0 5161.5 5163.8 6005.8 6180.5 6253.5 6255.3 6255.7 5818.2 5851.0 5868.0 5882.9 6019.2 6190.4 6201.5 6211.6 6215.6 6218.7 5909.0 5909.4 5910.9 5915.0 5917.3 5816.4 5818.5 5901.8 5914.1 5964.0 5849.4 5863.1 5869.9 5871.9 5900.6 5812.1 5858.7 5859.4 5868.0 5869.3 5605.2 5609.1 5793.2 5860.3 5863.8 5939.7 5955.6 5960.4 5962.4 5991.7 5540.0 5773.9 5805.1 5807.1 5811.6 09:07:43 INFO - PROCESS | 7304 | 09:07:43 INFO - PROCESS | 7304 | [#1] ext.html Cycles:180 Average:58353.25 Median:36163.73 stddev:113555.57 (314.0%) stddev-sans-first:113791.32 09:07:43 INFO - PROCESS | 7304 | Values: 595.7 622.7 651.7 654.7 681.8 32700.2 42696.8 43586.6 43613.0 43623.6 44045.3 44432.0 44545.0 44575.3 44578.8 8277.0 8688.6 8806.8 8821.7 8823.5 8183.0 10226.3 10484.9 10505.5 10747.7 10505.6 10554.2 10560.1 10566.0 10568.8 10371.2 10380.2 10381.7 10431.4 10438.3 10301.0 10361.8 10362.7 10375.6 10377.7 42177.8 42503.4 42556.4 42561.8 42562.8 3640.7 3646.4 3739.5 3786.8 4113.5 32495.0 32579.0 32749.0 32967.8 33050.8 3805.6 3807.8 3816.7 3835.7 3876.9 345189.0 345406.0 345600.0 346436.0 346896.0 59281.7 59563.4 59685.4 59713.0 59774.0 38092.6 38687.6 38928.2 41263.6 41271.4 19146.6 19309.2 19337.6 19348.4 19352.5 12821.2 13002.1 14611.9 15046.5 15168.0 19068.5 19583.8 19715.9 19725.7 19786.5 7335.9 7388.6 7425.0 7572.8 7585.2 996.4 1053.2 1120.4 1122.8 1136.1 32131.2 32261.7 32388.2 32600.0 32978.3 1042.7 1094.5 1117.5 1137.9 1165.5 15181.8 17198.9 17497.0 18013.5 18162.7 551451.0 552619.0 553787.0 554188.0 554364.0 58817.7 59212.4 59216.0 59229.0 59349.4 1307.4 1359.8 1364.6 1426.5 1429.2 29591.3 33034.7 33529.8 35530.5 35880.1 55569.0 56087.2 56207.2 56216.0 56238.7 351398.0 354680.0 354874.0 355339.0 355904.0 26241.1 27148.9 27913.7 28935.3 30019.2 47420.5 47611.8 47914.5 47978.8 48062.8 40830.8 41440.6 41794.4 41829.6 42686.0 41781.2 41888.0 41903.6 43106.0 43435.3 37432.1 38934.8 41543.2 41576.2 41613.8 34514.8 36095.8 36231.6 37963.4 40041.2 28694.7 28887.7 29108.0 29132.6 29174.6 09:07:43 INFO - PROCESS | 7304 | 09:07:43 INFO - PROCESS | 7304 | [#2] jquery.html Cycles:180 Average:28198.57 Median:12841.63 stddev:73755.19 (574.3%) stddev-sans-first:73932.62 09:07:43 INFO - PROCESS | 7304 | Values: 432.5 434.8 436.8 437.4 454.6 18703.7 19323.0 19939.4 20028.0 20109.8 19697.2 19727.4 19973.9 20156.3 20214.8 5662.7 5930.9 5957.3 5957.6 5960.0 5577.9 5817.5 5882.3 5900.5 5920.6 5945.1 5949.1 5950.5 5954.4 5960.1 5786.4 5835.5 5909.0 5926.0 5965.8 5751.9 5760.6 5765.9 5767.5 5767.9 20100.3 22769.0 23364.0 23478.9 23651.2 2319.3 2486.4 2514.9 2536.6 2916.1 10811.1 11375.0 11415.4 11431.0 11438.0 1953.2 1959.1 2003.0 2014.6 2065.6 64976.7 76346.2 79437.0 83837.0 87752.6 11143.7 11584.7 11730.2 11884.8 12043.3 16934.7 16935.4 16936.7 16941.4 16956.3 8739.4 9111.3 9192.4 9194.3 9354.8 8630.7 8764.2 8861.0 9151.5 9265.8 4964.0 5025.3 5039.6 5141.1 5212.6 2071.3 2095.6 2097.8 2127.9 2142.0 915.9 981.7 1002.5 1002.7 1039.8 19516.0 20081.7 20120.6 20211.0 20440.2 1000.8 1007.8 1028.5 1052.2 1060.6 10486.4 11092.9 11124.9 11276.2 11335.7 434269.0 441430.0 442584.0 443088.0 464885.0 94680.5 95501.5 95694.5 96650.0 98006.5 1016.9 1037.8 1085.9 1095.9 1098.1 17517.4 18002.0 18209.5 18239.7 18446.2 43686.6 44108.3 44210.0 44860.3 44869.0 59625.0 59779.4 59807.4 60307.4 62787.0 5648.5 8806.7 9074.5 9134.9 9259.4 13192.1 13237.2 13260.0 13281.7 13503.8 11162.4 11355.9 11688.4 11868.3 12469.9 10964.2 11034.7 11081.1 11342.6 11708.8 11215.2 11422.7 11593.9 11604.7 11917.3 9045.9 9107.4 9155.5 9157.1 9510.0 10527.8 11230.2 11241.6 11278.6 11443.8 09:07:43 INFO - PROCESS | 7304 | 09:07:43 INFO - PROCESS | 7304 | [#3] mootools.html Cycles:180 Average:5807.50 Median:501.79 stddev:3227.18 (643.1%) stddev-sans-first:3218.22 09:07:43 INFO - PROCESS | 7304 | Values: 1271.0 1522.9 1527.7 1712.3 1853.1 7584.9 8307.3 8544.7 8545.7 8908.6 8780.7 8784.3 8805.7 8828.3 8865.9 2417.0 2446.0 2446.6 2447.6 2448.1 2391.9 2417.8 2420.5 2428.6 2434.5 2343.9 2350.2 2363.1 2376.7 2378.5 2299.6 2303.1 2340.6 2342.7 2344.6 2328.2 2332.8 2359.8 2362.8 2367.1 8643.2 8834.8 8839.5 8844.0 8844.2 5346.8 5522.1 5531.4 5640.5 5646.6 3277.3 3332.7 3399.2 3425.9 3590.8 1047.2 1126.1 1137.5 1141.9 1145.9 11952.8 11995.7 12114.6 12156.2 12177.5 4464.3 4726.6 4783.8 4802.8 4805.5 9485.9 9486.1 9531.3 9572.8 9580.9 5469.7 5476.4 5485.4 5487.6 5488.0 4307.3 4482.4 4659.5 5160.8 5199.0 4027.6 4028.5 4115.2 4115.4 4180.7 1264.8 1303.2 1306.0 1309.5 1317.2 933.3 1001.8 1006.9 1029.7 1035.3 5985.4 6114.4 6145.8 6250.0 6355.5 490.9 494.9 508.6 527.4 529.6 4096.0 4200.1 4206.0 4298.8 4308.0 10367.4 10554.8 10768.6 10892.0 11091.6 10791.2 10914.5 10917.3 10918.4 10930.8 8287.9 8511.4 8515.5 8521.7 8523.4 6262.3 6351.4 6360.9 6409.3 6409.5 9849.5 10022.5 10031.2 10136.4 10159.8 8990.9 9271.2 10347.0 10355.7 10356.1 7416.6 7731.8 7743.8 7809.6 7907.4 8288.9 8334.1 8364.1 8366.5 8379.0 7476.3 7532.1 7542.2 7563.7 7780.6 7399.3 7463.4 7520.8 7541.3 7632.7 7064.8 7195.7 7198.6 7203.2 7204.8 5362.7 5433.6 5444.7 5461.0 5565.0 5402.9 5492.3 5510.8 5548.5 5653.7 09:07:43 INFO - PROCESS | 7304 | 09:07:43 INFO - PROCESS | 7304 | [#4] prototype.html Cycles:180 Average:4714.05 Median:5362.14 stddev:1367.82 (25.5%) stddev-sans-first:1331.95 09:07:43 INFO - PROCESS | 7304 | Values: 354.9 358.8 366.1 366.2 371.9 5348.7 5375.5 5378.8 5379.0 5381.6 5078.9 5160.3 5186.8 5200.5 5304.8 4216.8 4229.9 4230.6 4241.1 4255.7 4244.5 4248.8 4250.0 4254.6 4274.0 3968.5 3995.9 4214.0 4226.6 4249.6 4226.9 4241.6 4241.7 4241.7 4250.5 3804.9 3814.6 3817.9 3824.8 3825.3 4977.2 5164.9 5171.2 5171.3 5251.0 4795.2 4806.8 4815.9 4844.0 4848.2 5510.5 5526.5 5535.3 5569.4 5573.1 3882.2 4088.5 4103.7 4182.5 4198.9 5746.6 5749.5 5772.7 5779.0 5782.8 4189.2 4194.3 4200.0 4204.5 4205.8 4189.7 4227.8 4270.3 4286.4 4295.5 4756.4 4762.0 4762.6 4804.4 4850.7 5540.6 5541.0 5590.7 5599.8 5609.8 1380.8 1402.9 1406.1 1413.5 1426.5 910.9 934.9 958.3 986.7 997.5 5180.3 5202.5 5202.6 5219.1 5272.7 5444.9 5469.0 5479.6 5497.5 5513.4 5041.8 5145.7 5148.8 5173.7 5237.5 2882.2 2907.5 2909.3 2921.3 2921.5 5579.4 5630.6 5644.9 5654.5 5664.4 5858.6 5869.4 5894.4 5903.4 5904.9 5985.3 5986.2 5990.3 6000.5 6002.5 5584.9 5726.4 5731.8 5776.6 5813.7 5667.7 5702.7 5715.0 5740.4 5748.1 5782.3 5892.8 5970.4 5980.8 5981.3 4179.1 4205.7 4221.0 4222.6 4229.4 5740.3 5762.4 5765.9 5771.2 5795.3 5381.5 5632.8 5675.1 5680.9 5690.8 5640.4 5642.8 5643.5 5648.4 5653.3 5392.5 5477.2 5607.7 5609.4 5637.2 5497.3 5611.6 5626.3 5634.4 5649.8 5509.8 5516.7 5549.3 5550.5 5571.6 09:07:43 INFO - PROCESS | 7304 | 09:07:43 INFO - PROCESS | 7304 | [#5] yui.html Cycles:180 Average:17781.51 Median:46081.92 stddev:22511.80 (48.9%) stddev-sans-first:22538.91 09:07:43 INFO - PROCESS | 7304 | Values: 815.4 821.5 841.4 858.8 883.0 16789.7 17311.0 17406.4 17463.2 17464.7 16192.5 16335.0 16706.5 16756.8 16762.5 715.4 732.0 841.3 856.0 857.6 804.5 829.3 834.3 834.4 834.9 882.0 882.4 884.7 885.0 887.1 745.0 770.9 873.2 880.7 880.9 571.9 572.0 619.7 637.5 643.4 15261.5 15314.0 15434.2 15476.2 15489.8 13788.2 13789.4 13835.3 13846.5 13877.2 12641.1 12705.8 12708.4 12855.2 13012.4 4365.1 4388.9 4457.1 4464.5 4553.3 60789.1 64110.4 64508.0 64640.4 65323.0 11282.2 11365.1 11436.4 11505.0 11607.7 19870.2 19917.0 19920.7 19921.2 19980.0 8182.7 8230.5 8241.2 8415.5 8505.7 4701.4 4824.6 4864.9 4874.1 4949.5 3647.0 3757.8 3759.1 3759.9 3761.0 660.3 671.4 672.3 673.2 700.3 623.9 672.3 743.3 761.8 788.6 9141.2 9227.3 9476.4 9586.1 9613.2 701.6 759.6 769.6 787.9 796.2 4352.9 4560.4 4650.4 4722.6 4749.9 78794.6 90855.0 92128.5 92961.5 93941.5 45277.5 45827.3 68599.0 72117.0 72157.0 64182.0 64732.0 64738.4 66393.3 66815.7 10143.1 10343.7 10542.8 10657.1 10666.3 45170.3 45722.9 46336.5 46787.8 48358.8 49999.0 62979.7 63268.7 64464.7 65762.7 12810.5 12851.8 12909.3 13291.9 13461.8 13814.9 14028.8 14535.8 14776.6 14880.6 13511.7 13683.8 13956.7 14000.8 14145.3 13488.6 13823.7 14073.4 14343.9 14475.3 13785.9 13994.2 14665.0 14938.3 14941.5 10617.6 10645.9 11439.5 11561.9 11579.2 10103.5 11655.7 11867.1 12168.0 12176.1 09:07:43 INFO - PROCESS | 7304 | -------- Summary: end -------- 09:07:43 INFO - PROCESS | 7304 | 09:07:44 INFO - TEST-INFO | 7304: exit 0 09:07:44 INFO - TEST-OK | dromaeo_css | took 1115969ms 09:07:44 INFO - TEST-START | kraken 09:07:44 INFO - operating with platform_type : linux_ 09:07:44 INFO - Initialising browser for kraken test... 09:07:44 INFO - TEST-INFO | started process 7619 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfV6hK8/profile http://localhost:47582/getInfo.html) 09:07:47 ERROR - PROCESS | 7619 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 09:07:49 INFO - PROCESS | 7619 | __metrics Screen width/height:1600/1200 09:07:49 INFO - PROCESS | 7619 | colorDepth:24 09:07:49 INFO - PROCESS | 7619 | Browser inner width/height: 1024/697 09:07:49 INFO - PROCESS | 7619 | __metrics 09:07:49 INFO - PROCESS | 7619 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:07:49 INFO - PROCESS | 7619 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:07:50 INFO - PROCESS | 7619 | console.error: PushService: 09:07:50 INFO - PROCESS | 7619 | stateChangeProcessEnqueue: Error transitioning state 09:07:50 INFO - PROCESS | 7619 | UnknownError 09:07:50 INFO - TEST-INFO | 7619: exit 0 09:07:50 INFO - Browser initialized. 09:07:50 INFO - Running cycle 1/1 for kraken test... 09:07:50 INFO - TEST-INFO | started process 7714 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfV6hK8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:08:02 INFO - PROCESS | 7714 | RSS: Main: 144707584 09:08:02 INFO - PROCESS | 7714 | 09:08:04 INFO - PROCESS | 7714 | Cycle 1(1): loaded http://localhost:47582/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47582/tests/kraken/driver.html?testName=audio-beat-detection) 09:08:05 INFO - PROCESS | 7714 | RSS: Main: 185413632 09:08:05 INFO - PROCESS | 7714 | 09:08:08 INFO - PROCESS | 7714 | Cycle 1(1): loaded http://localhost:47582/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47582/tests/kraken/driver.html?testName=audio-dft) 09:08:08 INFO - PROCESS | 7714 | RSS: Main: 175099904 09:08:08 INFO - PROCESS | 7714 | 09:08:11 INFO - PROCESS | 7714 | Cycle 1(1): loaded http://localhost:47582/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47582/tests/kraken/driver.html?testName=audio-fft) 09:08:12 INFO - PROCESS | 7714 | RSS: Main: 266067968 09:08:12 INFO - PROCESS | 7714 | 09:08:14 INFO - PROCESS | 7714 | Cycle 1(1): loaded http://localhost:47582/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47582/tests/kraken/driver.html?testName=audio-oscillator) 09:08:14 INFO - PROCESS | 7714 | RSS: Main: 172613632 09:08:14 INFO - PROCESS | 7714 | 09:08:17 INFO - PROCESS | 7714 | Cycle 1(1): loaded http://localhost:47582/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47582/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:08:17 INFO - PROCESS | 7714 | RSS: Main: 175149056 09:08:17 INFO - PROCESS | 7714 | 09:08:20 INFO - PROCESS | 7714 | Cycle 1(1): loaded http://localhost:47582/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47582/tests/kraken/driver.html?testName=imaging-darkroom) 09:08:21 INFO - PROCESS | 7714 | RSS: Main: 213774336 09:08:21 INFO - PROCESS | 7714 | 09:08:24 INFO - PROCESS | 7714 | Cycle 1(1): loaded http://localhost:47582/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47582/tests/kraken/driver.html?testName=imaging-desaturate) 09:08:25 INFO - PROCESS | 7714 | RSS: Main: 212226048 09:08:25 INFO - PROCESS | 7714 | 09:08:27 INFO - PROCESS | 7714 | Cycle 1(1): loaded http://localhost:47582/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47582/tests/kraken/driver.html?testName=json-parse-financial) 09:08:28 INFO - PROCESS | 7714 | RSS: Main: 210882560 09:08:28 INFO - PROCESS | 7714 | 09:08:29 INFO - PROCESS | 7714 | Cycle 1(1): loaded http://localhost:47582/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47582/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:08:30 INFO - PROCESS | 7714 | RSS: Main: 173477888 09:08:30 INFO - PROCESS | 7714 | 09:08:32 INFO - PROCESS | 7714 | Cycle 1(1): loaded http://localhost:47582/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47582/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:08:32 INFO - PROCESS | 7714 | RSS: Main: 180289536 09:08:32 INFO - PROCESS | 7714 | 09:08:34 INFO - PROCESS | 7714 | Cycle 1(1): loaded http://localhost:47582/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47582/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:08:35 INFO - PROCESS | 7714 | RSS: Main: 189972480 09:08:35 INFO - PROCESS | 7714 | 09:08:37 INFO - PROCESS | 7714 | Cycle 1(1): loaded http://localhost:47582/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47582/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:08:38 INFO - PROCESS | 7714 | RSS: Main: 198627328 09:08:38 INFO - PROCESS | 7714 | 09:08:41 INFO - PROCESS | 7714 | Cycle 1(1): loaded http://localhost:47582/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47582/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:08:41 INFO - PROCESS | 7714 | RSS: Main: 195284992 09:08:41 INFO - PROCESS | 7714 | 09:08:43 INFO - PROCESS | 7714 | Cycle 1(1): loaded http://localhost:47582/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47582/tests/kraken/driver.html?testName=ai-astar) 09:08:43 INFO - PROCESS | 7714 | RSS: Main: 246784000 09:08:43 INFO - PROCESS | 7714 | 09:08:43 INFO - PROCESS | 7714 | __start_tp_report 09:08:43 INFO - PROCESS | 7714 | _x_x_mozilla_page_load 09:08:43 INFO - PROCESS | 7714 | _x_x_mozilla_page_load_details 09:08:43 INFO - PROCESS | 7714 | |i|pagename|runs| 09:08:43 INFO - PROCESS | 7714 | |0;ai-astar;102;111;110;111;111;110;112;112;110;111 09:08:43 INFO - PROCESS | 7714 | |1;audio-beat-detection;144;125;121;158;123;122;123;125;161;119 09:08:43 INFO - PROCESS | 7714 | |2;audio-dft;163;162;162;161;162;161;162;161;160;161 09:08:43 INFO - PROCESS | 7714 | |3;audio-fft;74;73;76;112;76;77;75;83;97;74 09:08:43 INFO - PROCESS | 7714 | |4;audio-oscillator;81;82;121;82;82;83;103;82;82;114 09:08:43 INFO - PROCESS | 7714 | |5;imaging-gaussian-blur;117;116;117;116;117;117;117;116;117;116 09:08:43 INFO - PROCESS | 7714 | |6;imaging-darkroom;146;146;146;146;146;146;146;146;146;146 09:08:43 INFO - PROCESS | 7714 | |7;imaging-desaturate;86;85;84;85;84;85;85;85;85;85 09:08:43 INFO - PROCESS | 7714 | |8;json-parse-financial;53;51;52;51;51;52;53;54;51;52 09:08:43 INFO - PROCESS | 7714 | |9;json-stringify-tinderbox;59;59;59;61;60;59;59;59;61;59 09:08:43 INFO - PROCESS | 7714 | |10;stanford-crypto-aes;75;74;77;74;73;84;75;74;73;76 09:08:43 INFO - PROCESS | 7714 | |11;stanford-crypto-ccm;141;144;131;127;135;123;126;139;168;128 09:08:43 INFO - PROCESS | 7714 | |12;stanford-crypto-pbkdf2;154;160;153;152;161;157;154;152;155;158 09:08:43 INFO - PROCESS | 7714 | |13;stanford-crypto-sha256-iterative;62;61;61;62;61;62;64;65;60;59 09:08:43 INFO - PROCESS | 7714 | __end_tp_report 09:08:43 INFO - PROCESS | 7714 | __start_cc_report 09:08:43 INFO - PROCESS | 7714 | _x_x_mozilla_cycle_collect,1670 09:08:43 INFO - PROCESS | 7714 | __end_cc_report 09:08:43 INFO - PROCESS | 7714 | __startTimestamp1479402523890__endTimestamp 09:08:43 INFO - PROCESS | 7714 | 09:08:43 INFO - PROCESS | 7714 | ------- Summary: start ------- 09:08:43 INFO - PROCESS | 7714 | Number of tests: 14 09:08:43 INFO - PROCESS | 7714 | 09:08:43 INFO - PROCESS | 7714 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:2.91 (2.6%) stddev-sans-first:0.78 09:08:43 INFO - PROCESS | 7714 | Values: 102.0 111.0 110.0 111.0 111.0 110.0 112.0 112.0 110.0 111.0 09:08:43 INFO - PROCESS | 7714 | 09:08:43 INFO - PROCESS | 7714 | [#1] audio-beat-detection Cycles:10 Average:132.10 Median:125.00 stddev:16.02 (12.8%) stddev-sans-first:16.41 09:08:43 INFO - PROCESS | 7714 | Values: 144.0 125.0 121.0 158.0 123.0 122.0 123.0 125.0 161.0 119.0 09:08:43 INFO - PROCESS | 7714 | 09:08:43 INFO - PROCESS | 7714 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.85 (0.5%) stddev-sans-first:0.71 09:08:43 INFO - PROCESS | 7714 | Values: 163.0 162.0 162.0 161.0 162.0 161.0 162.0 161.0 160.0 161.0 09:08:43 INFO - PROCESS | 7714 | 09:08:43 INFO - PROCESS | 7714 | [#3] audio-fft Cycles:10 Average:81.70 Median:76.00 stddev:12.82 (16.9%) stddev-sans-first:13.30 09:08:43 INFO - PROCESS | 7714 | Values: 74.0 73.0 76.0 112.0 76.0 77.0 75.0 83.0 97.0 74.0 09:08:43 INFO - PROCESS | 7714 | 09:08:43 INFO - PROCESS | 7714 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:82.00 stddev:15.43 (18.8%) stddev-sans-first:15.91 09:08:43 INFO - PROCESS | 7714 | Values: 81.0 82.0 121.0 82.0 82.0 83.0 103.0 82.0 82.0 114.0 09:08:43 INFO - PROCESS | 7714 | 09:08:43 INFO - PROCESS | 7714 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 09:08:43 INFO - PROCESS | 7714 | Values: 117.0 116.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 116.0 09:08:43 INFO - PROCESS | 7714 | 09:08:43 INFO - PROCESS | 7714 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 09:08:43 INFO - PROCESS | 7714 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 09:08:43 INFO - PROCESS | 7714 | 09:08:43 INFO - PROCESS | 7714 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.00 stddev:0.57 (0.7%) stddev-sans-first:0.44 09:08:43 INFO - PROCESS | 7714 | Values: 86.0 85.0 84.0 85.0 84.0 85.0 85.0 85.0 85.0 85.0 09:08:43 INFO - PROCESS | 7714 | 09:08:43 INFO - PROCESS | 7714 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:52.00 stddev:1.05 (2.0%) stddev-sans-first:1.05 09:08:43 INFO - PROCESS | 7714 | Values: 53.0 51.0 52.0 51.0 51.0 52.0 53.0 54.0 51.0 52.0 09:08:43 INFO - PROCESS | 7714 | 09:08:43 INFO - PROCESS | 7714 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:59.00 stddev:0.85 (1.4%) stddev-sans-first:0.88 09:08:43 INFO - PROCESS | 7714 | Values: 59.0 59.0 59.0 61.0 60.0 59.0 59.0 59.0 61.0 59.0 09:08:43 INFO - PROCESS | 7714 | 09:08:43 INFO - PROCESS | 7714 | [#10] stanford-crypto-aes Cycles:10 Average:75.50 Median:75.00 stddev:3.24 (4.3%) stddev-sans-first:3.43 09:08:43 INFO - PROCESS | 7714 | Values: 75.0 74.0 77.0 74.0 73.0 84.0 75.0 74.0 73.0 76.0 09:08:43 INFO - PROCESS | 7714 | 09:08:43 INFO - PROCESS | 7714 | [#11] stanford-crypto-ccm Cycles:10 Average:136.20 Median:137.00 stddev:13.17 (9.6%) stddev-sans-first:13.86 09:08:43 INFO - PROCESS | 7714 | Values: 141.0 144.0 131.0 127.0 135.0 123.0 126.0 139.0 168.0 128.0 09:08:43 INFO - PROCESS | 7714 | 09:08:43 INFO - PROCESS | 7714 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.60 Median:156.00 stddev:3.24 (2.1%) stddev-sans-first:3.38 09:08:43 INFO - PROCESS | 7714 | Values: 154.0 160.0 153.0 152.0 161.0 157.0 154.0 152.0 155.0 158.0 09:08:43 INFO - PROCESS | 7714 | 09:08:43 INFO - PROCESS | 7714 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.70 Median:62.00 stddev:1.77 (2.8%) stddev-sans-first:1.87 09:08:43 INFO - PROCESS | 7714 | Values: 62.0 61.0 61.0 62.0 61.0 62.0 64.0 65.0 60.0 59.0 09:08:43 INFO - PROCESS | 7714 | -------- Summary: end -------- 09:08:43 INFO - PROCESS | 7714 | 09:08:44 INFO - TEST-INFO | 7714: exit 0 09:08:44 INFO - TEST-OK | kraken | took 60168ms 09:08:44 INFO - SUITE-END | took 1176s 09:08:45 INFO - Completed test suite (00:19:36) 09:08:45 INFO - javascript benchmark 09:08:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3175.4601717707997, 3209.6790320967907, 3219.2434777827216, 3233.822139782311, 3234.916303038482, 5560.805371811983, 5635.549156067515, 5641.802536911209, 5643.0688936325505, 5657.9717101414535, 5623.4938855503, 5674.971625141879, 5678.034734095203, 5682.943170568293, 5710.114932185507, 5146.845594632167, 5163.483651634844, 5190.351206099238, 5203.4016088149965, 5256.684598924076, 4933.506649335056, 5242.370915490146, 5249.763760630781, 5257.08001099806, 5272.393674727398, 4948.901021979558, 5058.822941197059, 5100.923486147711, 5107.438181799999, 5117.283580298743, 5128.205128205134, 5161.638685292012, 5164.147915593922, 5206.140986737184, 5222.712750798704, 5028.0, 5086.186210206386, 5150.587952963754, 5163.870903227412, 5189.117849965515, 5359.839204823861, 5398.48714372138, 5407.080796264644, 5418.83743487696, 5473.261109750172, 5844.707764611752, 5859.150423188614, 5859.44335288147, 5937.406259374071, 5948.286205655306, 5991.191189189447, 6004.039353703431, 6016.939830601726, 6018.277806663228, 6025.126356678301, 5437.265969094161, 5498.120300751901, 5544.029794785896, 5599.468050535193, 5681.971590142023, 6125.356837531995, 6126.448619624255, 6137.140800287963, 6144.078388241799, 6146.5390095743, 5896.7641294348605, 5912.674802885796, 5914.99445094335, 5916.970415147896, 5919.585629005928, 5741.483266506035, 5784.855378615568, 5877.882442351214, 5903.439173278532, 5982.282126144891, 5937.673427961504, 5945.583809133405, 5978.252718410199, 5981.0, 6013.759449621966, 5891.7937872175125, 5942.61373010753, 5957.851053723692, 5969.731362088716, 5970.223870896755, 4490.101979604027, 4519.593236608721, 4591.563801438858, 4632.930506042412, 4643.048175124091, 4063.878083657495, 4077.062275676611, 4106.630403263661, 4118.094019315746, 4134.131832315187, 5579.9163012554845, 5581.386047534768, 5588.21764952907, 5615.438456154352, 5668.121441176624, 5735.053716136791, 5754.1944127822135, 5981.5214782817275, 6002.789902353396, 6022.09668549721, 5618.269624948731, 5663.9716801415725, 5668.8866222675315, 5707.0868661014865, 5750.137479378043, 5149.845504634867, 5155.355580552431, 5157.045946499909, 5161.535461808456, 5163.7676304566385, 6005.849853753691, 6180.505559555315, 6253.499720022387, 6255.280642726054, 6255.655938923312, 5818.2436283282905, 5851.0, 5867.970660146842, 5882.911756323573, 6019.187409699634, 6190.371860497454, 6201.503879689704, 6211.565190436626, 6215.564910456224, 6218.720157593009, 5908.9954707698935, 5909.438603332676, 5910.881782364415, 5915.0, 5917.289925209003, 5816.447437493432, 5818.50542703858, 5901.7639294427745, 5914.142449344907, 5963.970180149072, 5849.385814489588, 5863.149843272787, 5869.853253668693, 5871.882562348815, 5900.586958912835, 5812.099124635688, 5858.677772722541, 5859.355470898283, 5868.0, 5869.266341707286, 5605.159226116115, 5609.1305847593685, 5793.15999180125, 5860.326062502867, 5863.824085277449, 5939.673317967553, 5955.583109182316, 5960.433758792908, 5962.37395073511, 5991.730372133352, 5540.0, 5773.884522309446, 5805.10020946754, 5807.128930660266, 5811.62224455426], "value": 5511.071031228713, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.743830153034, 622.7477871462057, 651.7360469010051, 654.6792071884778, 681.8261343357443, 32700.182495437624, 42696.78651606741, 43586.56413435865, 43613.0, 43623.56376436235, 44045.33931991023, 44432.0, 44545.0, 44575.331370029475, 44578.7771061145, 8277.0, 8688.56557172142, 8806.823863522726, 8821.73534793954, 8823.470591764482, 8182.959085204566, 10226.284160108795, 10484.895151048506, 10505.527251273672, 10747.731306717356, 10505.579776808956, 10554.208434367414, 10560.102391296748, 10566.0, 10568.841467377995, 10371.222158338118, 10380.221483388701, 10381.740456488573, 10431.426271555061, 10438.269321147485, 10301.0, 10361.792764144675, 10362.740931476697, 10375.584976600927, 10377.688669339932, 42177.78911105425, 42503.36244956328, 42556.36165457521, 42561.78719106385, 42562.78718606387, 3640.672339489459, 3646.398344273192, 3739.4951681522916, 3786.772793632391, 4113.526944401402, 32495.0, 32579.0, 32749.0, 32967.83516082404, 33050.83474582636, 3805.5813860475328, 3807.7905715185652, 3816.732828701992, 3835.654791068789, 3876.9030774230587, 345189.0, 345406.0, 345600.0, 346436.0, 346896.0, 59281.70359148177, 59563.40436595665, 59685.403145968856, 59713.0, 59774.0, 38092.61907380946, 38687.61312386896, 38928.22143557113, 41263.587364125975, 41271.38092928608, 19146.617067658568, 19309.22763089489, 19337.613247734967, 19348.4195474136, 19352.516187095152, 12821.230726156275, 13002.08985371015, 14611.926940365443, 15046.54860354191, 15168.0, 19068.523286917938, 19583.81894430666, 19715.901420492806, 19725.70411443801, 19786.50533736668, 7335.926640733631, 7388.556686598821, 7424.96287518559, 7572.848543029108, 7585.1656317805, 996.3822430093244, 1053.2364036073939, 1120.3501968858043, 1122.8484154639182, 1136.0797753819434, 32131.196720081716, 32261.677383226335, 32388.190295242806, 32600.0, 32978.34043319168, 1042.6924057403085, 1094.5402930769096, 1117.536222467667, 1137.86914504833, 1165.452237448398, 15181.772273415907, 17198.91400542989, 17497.0, 18013.459596212135, 18162.727559086623, 551451.0, 552619.0, 553787.0, 554188.0, 554364.0, 58817.70591147017, 59212.40787592069, 59216.0, 59229.0, 59349.40650593525, 1307.3985966455537, 1359.8368195816367, 1364.6042647632273, 1426.450816435659, 1429.2425014742203, 29591.26021849471, 33034.66965330316, 33529.83235083809, 35530.46704299489, 35880.10299742423, 55569.0, 56087.15869262046, 56207.15689264583, 56216.0, 56238.71880640734, 351398.0, 354680.0, 354874.0, 355339.0, 355904.0, 26241.081562145235, 27148.864255678596, 27913.720862791113, 28935.276618084717, 30019.24951876133, 47420.52579474161, 47611.761941190074, 47914.52085479101, 47978.76010619925, 48062.759686201345, 40830.79584602058, 41440.585594143675, 41794.37308440437, 41829.58170418257, 42686.0, 41781.164376712906, 41888.0, 41903.58096418997, 43106.0, 43435.34846977361, 37432.06419839526, 38934.80532597319, 41543.169136617704, 41576.168476630904, 41613.79193104136, 34514.82742586271, 36095.81952090223, 36231.63768362282, 37963.43054854124, 40041.1991760169, 28694.713052869203, 28887.7111228885, 29108.0, 29132.56301155442, 29174.56238156387], "value": 20471.487087380214, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [432.5069420860222, 434.7565363396498, 436.8405531980827, 437.4488144937378, 454.6158496070821, 18703.71944420833, 19323.0, 19939.401817945447, 20028.0, 20109.798902010974, 19697.21211151552, 19727.40817775469, 19973.90013049933, 20156.294529691462, 20214.797852021475, 5662.745176467059, 5930.940690593104, 5957.344692083867, 5957.553183511232, 5960.0, 5577.9163312550345, 5817.476427121579, 5882.323532793719, 5900.498457631106, 5920.644761314335, 5945.108233764927, 5949.107633854913, 5950.523958083343, 5954.374790646984, 5960.135780311853, 5786.421357864222, 5835.533157347423, 5909.0, 5925.970370148165, 5965.791197308095, 5751.913721294142, 5760.596758226926, 5765.942340576583, 5767.480926716616, 5767.8558036049435, 20100.296489622793, 22769.0, 23364.0, 23478.882605586863, 23651.172208972774, 2319.2694301295205, 2486.353548077495, 2514.9371265718505, 2536.581464058428, 2916.1397387770658, 10811.135109191246, 11375.0, 11415.372154531497, 11431.0, 11438.02776763976, 1953.1894263880472, 1959.1477707197273, 2002.9699554506549, 2014.5870096630156, 2065.5972085443195, 64976.675116624116, 76346.23653763447, 79437.0, 83837.0, 87752.56123719404, 11143.721406964729, 11584.710382240342, 11730.237534560398, 11884.821727674092, 12043.337616431005, 16934.745978810326, 16935.407260745815, 16936.661266774594, 16941.407050753412, 16956.321747129976, 8739.38824282294, 9111.316651251183, 9192.402493838013, 9194.310426718022, 9354.766130846647, 8630.741077767678, 8764.1674040966, 8860.955695221483, 9151.542422878829, 9265.768355791024, 4964.032013757354, 5025.296458495814, 5039.647224694309, 5141.1491862929315, 5212.635115541876, 2071.2957594417667, 2095.5913596848773, 2097.842661800371, 2127.88296643683, 2141.967870481944, 915.949622770754, 981.6711401680517, 1002.5137808163036, 1002.6540843409012, 1039.7608550033535, 19516.0, 20081.698774518394, 20120.597588048156, 20211.0, 20440.182392704126, 1000.8098461292332, 1007.808516381885, 1028.5011769291887, 1052.221356196409, 1060.5598676549146, 10486.37081775096, 11092.889071109186, 11124.850418827413, 11276.1542884284, 11335.659930201942, 434269.0, 441430.0, 442584.0, 443088.0, 464885.0, 94680.52659736657, 95501.5224923871, 95694.52152739192, 96650.0, 98006.5099674497, 1016.922062613632, 1037.8339465685453, 1085.8914108589079, 1095.912327013837, 1098.1489345756943, 17517.386891458736, 18002.0, 18209.45371638853, 18239.726404104214, 18446.16992235326, 43686.56313436825, 44108.33837492376, 44210.0, 44860.32709509294, 44869.0, 59625.0, 59779.402205977385, 59807.401925980186, 60307.396926030175, 62787.0, 5648.519875810603, 8806.691765788166, 9074.45553266806, 9134.862977055216, 9259.398139120936, 13192.142510736772, 13237.205767653972, 13260.0, 13281.66795830112, 13503.797443038558, 11162.44187790591, 11355.886441135483, 11688.357140357022, 11868.347240901488, 12469.937650312053, 10964.232503724663, 11034.668959931216, 11081.113510918945, 11342.60300889465, 11708.765824683289, 11215.158863085464, 11422.657320280405, 11593.88406115928, 11604.709882253012, 11917.344546049704, 9045.864312035457, 9107.362484626012, 9155.450672959643, 9157.130072643089, 9510.048995100435, 10527.789444211227, 11230.21388502797, 11241.55033798639, 11278.605248816251, 11443.771124577628], "value": 9540.379405239566, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1270.9745805083892, 1522.8857835662325, 1527.745229535743, 1712.2893998990412, 1853.1197681101478, 7584.9241507584975, 8307.293880020197, 8544.70093546726, 8545.743627691163, 8908.643654253821, 8780.69267575635, 8784.297256219503, 8805.691800786974, 8828.33787465941, 8865.86701199481, 2416.9879150604224, 2446.0, 2446.6085426331792, 2447.596146635803, 2448.1186772761794, 2391.940201494959, 2417.830751847371, 2420.5279970405777, 2428.5871401861727, 2434.525267572824, 2343.8828058597087, 2350.200931683236, 2363.0902102690416, 2376.66726658268, 2378.52429514097, 2299.6435552489393, 2303.0557471436714, 2340.6254999200046, 2342.695449591542, 2344.566255242777, 2328.196772113618, 2332.8133749300014, 2359.834811563191, 2362.7519110493495, 2367.0531787285054, 8643.17889800468, 8834.823303533958, 8839.513826739527, 8844.0, 8844.20402163802, 5346.812861549827, 5522.088855338864, 5531.3915469298345, 5640.548756099543, 5646.604737668365, 3277.2789986202997, 3332.683395077464, 3399.2351720862857, 3425.8629654813776, 3590.8204589770667, 1047.2250534604339, 1126.1441304608556, 1137.4767606900837, 1141.9379976621822, 1145.873953865074, 11952.760944781143, 11995.700107497296, 12114.636560903098, 12156.209846360047, 12177.51289948401, 4464.330350447459, 4726.621870250372, 4783.808647654055, 4802.807887684454, 4805.471398146201, 9485.905140948502, 9486.098820612031, 9531.332806703464, 9572.76068098303, 9580.856287155699, 5469.699166545878, 5476.3702174250475, 5485.369182543979, 5487.64330318528, 5488.0, 4307.332363483665, 4482.372467854503, 4659.464161621389, 5160.767765450564, 5199.0, 4027.637512623878, 4028.536718277377, 4115.218108559424, 4115.42384066231, 4180.665546756313, 1264.7660182866016, 1303.1985329022582, 1305.9869401306055, 1309.5351150341683, 1317.2228385252747, 933.2627224492575, 1001.8397056471075, 1006.8993100690019, 1029.7374169586708, 1035.2804800663466, 5985.40145985398, 6114.419130182626, 6145.8156255312415, 6249.968750156311, 6355.504472540085, 490.87237318296786, 494.9480304568041, 508.63938963273836, 527.3566249175999, 529.6213207556616, 4095.9795201023803, 4200.096979149497, 4205.9789701051295, 4298.828046878152, 4307.978460107742, 10367.429791361397, 10554.841677374845, 10768.569257229623, 10892.0, 11091.611793587346, 10791.190660700478, 10914.508847101899, 10917.290376125526, 10918.399488028235, 10930.781384372427, 8287.917120828835, 8511.361647876434, 8515.531645759418, 8521.744347669704, 8523.40336176474, 6262.3111457738705, 6351.364863513611, 6360.9045864313, 6409.262934762375, 6409.455196308366, 9849.45827979468, 10022.498875056071, 10031.247656425943, 10136.44249566281, 10159.847602285823, 8990.86513702308, 9271.165595096474, 10347.017033381817, 10355.689329320132, 10356.119729822749, 7416.555006699616, 7731.7680469586, 7743.845123097619, 7809.570473623778, 7907.367410607253, 8288.875666865122, 8334.08325084228, 8364.121767214356, 8366.498010119412, 8378.958105209435, 7476.25237476248, 7532.096148462219, 7542.245775422414, 7563.7352692655495, 7780.572068536285, 7399.334059934632, 7463.440241981764, 7520.8495830082, 7541.283578060075, 7632.69469221225, 7064.788056358112, 7195.676194571152, 7198.5680859148615, 7203.171635262012, 7204.819879503054, 5362.705051222064, 5433.5924805640525, 5444.673319600836, 5460.972695136499, 5565.010295467642, 5402.918956215739, 5492.340919089735, 5510.834674959758, 5548.500634942875, 5653.689047102284], "value": 4616.438649403616, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.9183687751817, 358.8241761536847, 366.0720074610862, 366.2199515032979, 371.8954704527554, 5348.73256337183, 5375.543078838304, 5378.784848606056, 5379.0, 5381.5963802714805, 5078.898422031566, 5160.3033590465275, 5186.844394668166, 5200.453952335007, 5304.840854774363, 4216.7680777557225, 4229.900225941246, 4230.555791641879, 4241.1093670329265, 4255.723377980436, 4244.511881133662, 4248.787560621972, 4249.958760103764, 4254.595813397722, 4273.978630106861, 3968.5436174839974, 3995.9021513705393, 4214.0, 4226.640735537483, 4249.553796851333, 4226.90100573853, 4241.639460645849, 4241.703080784347, 4241.724287921275, 4250.489941207075, 3804.923901521982, 3814.6185381461632, 3817.8663746769007, 3824.8278827452555, 3825.3114439401174, 4977.178765503724, 5164.934026389436, 5171.224316352577, 5171.3277273954145, 5251.0, 4795.232762757977, 4806.759662016885, 4815.879603009953, 4843.975780121112, 4848.248521479177, 5510.476504732044, 5526.513069118912, 5535.308086489189, 5569.359523654791, 5573.052581061229, 3882.2041481496226, 4088.5093788745244, 4103.651189648884, 4182.519010313822, 4198.874033778991, 5746.626469279525, 5749.511291540182, 5772.682502462363, 5779.0, 5782.797602083907, 4189.162167566499, 4194.30793919006, 4200.0, 4204.474440694913, 4205.789710514462, 4189.664826813848, 4227.7528129201955, 4270.338097594878, 4286.421333120051, 4295.463067116611, 4756.405449318835, 4761.976190119027, 4762.64280178988, 4804.351412559329, 4850.733209673502, 5540.587150276654, 5540.972295138498, 5590.692511911802, 5599.844060036834, 5609.80365687199, 1380.792881067848, 1402.9298535073206, 1406.1352268355092, 1413.519403402848, 1426.4650755966513, 910.922571581423, 934.8971613122551, 958.3435346787334, 986.7385142937128, 997.481309718942, 5180.326557547494, 5202.505761952684, 5202.583793296527, 5219.138842091088, 5272.736363181825, 5444.891102177934, 5469.003813608084, 5479.561635069185, 5497.45025497455, 5513.436252142773, 5041.8487445376695, 5145.6621278467865, 5148.7691054099805, 5173.689578625294, 5237.502437268454, 2882.164172390025, 2907.4766542022217, 2909.3453972855937, 2921.28428535006, 2921.4887394705843, 5579.358373787067, 5630.6058575900115, 5644.858878527987, 5654.491095801315, 5664.376918538957, 5858.648481091063, 5869.354371019184, 5894.38108998549, 5903.35063143054, 5904.881902361929, 5985.311689155716, 5986.161937328778, 5990.281166260077, 6000.489958353589, 6002.519798416203, 5584.916226256691, 5726.427357264407, 5731.799387021434, 5776.595638305278, 5813.651180928989, 5667.716614169192, 5702.6863522506665, 5715.0, 5740.39725828782, 5748.148740343896, 5782.306123265235, 5892.827112742156, 5970.402874749498, 5980.790672326448, 5981.342052374148, 4179.137290955584, 4205.747655140702, 4221.0, 4222.556631553765, 4229.429027081304, 5740.282464691913, 5762.366139724711, 5765.91351129725, 5771.1920331154515, 5795.275590551181, 5381.515663590296, 5632.788950375689, 5675.0919852825, 5680.857978550569, 5690.800821971211, 5640.351359593699, 5642.802501912413, 5643.548516118783, 5648.378678345297, 5653.265075540154, 5392.460753924733, 5477.20580515831, 5607.719614019201, 5609.4390560943575, 5637.238972738792, 5497.285352904097, 5611.57913156523, 5626.2685850839125, 5634.4365563443325, 5649.774009039593, 5509.779608815763, 5516.696581687886, 5549.250851135206, 5550.52820510245, 5571.609987301013], "value": 4283.8191012086245, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [815.4210510537519, 821.5317269156579, 841.4026041510527, 858.7767180533061, 883.0418995390002, 16789.748153777688, 17311.0, 17406.39077632283, 17463.214155363006, 17464.738028929576, 16192.518608499171, 16335.0, 16706.498805035837, 16756.83243167568, 16762.497125086265, 715.4312321704258, 731.9743808966688, 841.2680967558217, 856.0070318430621, 857.6097875466647, 804.4811096842533, 829.266099501939, 834.2908527751423, 834.3992325525612, 834.8747687846811, 882.0077412910475, 882.386741214856, 884.6903583745702, 885.026470882031, 887.0685779931047, 744.9627518624047, 770.9190534993801, 873.2359185712502, 880.7313769300392, 880.9119088091204, 571.8856228754224, 572.0104219699942, 619.7118339971935, 637.4740838808002, 643.3694978920684, 15261.465848695243, 15314.004589701633, 15434.151121688303, 15476.22618869052, 15489.767653485207, 13788.172709637454, 13789.448422063106, 13835.30823458823, 13846.515371962034, 13877.167369957835, 12641.115121941468, 12705.809412858815, 12708.364581770875, 12855.164414313133, 13012.414441350162, 4365.126974605092, 4388.89027774305, 4457.064016556527, 4464.531224221442, 4553.339765733983, 60789.08816367758, 64110.35889641137, 64508.0, 64640.3535964639, 65323.0, 11282.210245282915, 11365.147613928988, 11436.370999595103, 11505.022073123711, 11607.6517704469, 19870.205191792455, 19917.0, 19920.70118948217, 19921.20315187405, 19980.0, 8182.651861007665, 8230.547319897343, 8241.217084376975, 8415.452995555392, 8505.74482765518, 4701.365315682339, 4824.614030877521, 4864.927026094611, 4874.073925954058, 4949.529794669501, 3646.9817650911577, 3757.8496860125833, 3759.1166075972124, 3759.9248015039548, 3761.022134245116, 660.3165723476179, 671.3689132215702, 672.2873753820966, 673.1652750589332, 700.2542292458515, 623.8814625221194, 672.2974491656231, 743.3124359967009, 761.77146855943, 788.5938741548107, 9141.222996045277, 9227.26181905446, 9476.431414115175, 9586.137247647745, 9613.182879455324, 701.6035939694057, 759.6012093650767, 769.5882702754, 787.8818177273455, 796.1719811396199, 4352.912941741148, 4560.3843481129625, 4650.395448591661, 4722.5513576210205, 4749.9050019000115, 78794.6060269695, 90855.0, 92128.53935730412, 92961.53519232495, 93941.5302923481, 45277.547224527334, 45827.31259031117, 68599.0, 72117.0, 72156.99999999895, 64182.0, 64732.0, 64738.35261647418, 66393.33606663968, 66815.66592167008, 10143.08712215904, 10343.741406464898, 10542.8418573723, 10657.14742820588, 10666.306690065121, 45170.322445164005, 45722.91077192837, 46336.53663463457, 46787.766061169474, 48358.758206208746, 49999.0, 62979.68510157603, 63268.68365658142, 64464.67767661132, 65762.67118664568, 12810.487580496676, 12851.807222891477, 12909.289989050316, 13291.933540332237, 13461.798073028716, 13814.930925345308, 14028.78956815669, 14535.781963270349, 14776.63058423548, 14880.553583392515, 13511.662208444868, 13683.794743079061, 13956.720865582834, 14000.789988149982, 14145.292735363397, 13488.595342139752, 13823.723525529233, 14073.366698498798, 14343.928280358532, 14475.348609312396, 13785.862141378459, 13994.230317332644, 14665.0, 14938.327775249922, 14941.477048303257, 10617.628383006559, 10645.89354106449, 11439.485223165144, 11561.884381156417, 11579.189456737948, 10103.494825258855, 11655.650330490098, 11867.05063594893, 12168.0, 12176.147669663393], "value": 7427.36306758551, "unit": "score"}], "name": "dromaeo_css", "value": 7353.512447756382, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 110.0, 111.0, 111.0, 110.0, 112.0, 112.0, 110.0, 111.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 125.0, 121.0, 158.0, 123.0, 122.0, 123.0, 125.0, 161.0, 119.0], "value": 132.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 161.0, 162.0, 161.0, 162.0, 161.0, 160.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 76.0, 112.0, 76.0, 77.0, 75.0, 83.0, 97.0, 74.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 121.0, 82.0, 82.0, 83.0, 103.0, 82.0, 82.0, 114.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 84.0, 85.0, 84.0, 85.0, 85.0, 85.0, 85.0, 85.0], "value": 84.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 52.0, 51.0, 51.0, 52.0, 53.0, 54.0, 51.0, 52.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 61.0, 60.0, 59.0, 59.0, 59.0, 61.0, 59.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 77.0, 74.0, 73.0, 84.0, 75.0, 74.0, 73.0, 76.0], "value": 75.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 144.0, 131.0, 127.0, 135.0, 123.0, 126.0, 139.0, 168.0, 128.0], "value": 136.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 160.0, 153.0, 152.0, 161.0, 157.0, 154.0, 152.0, 155.0, 158.0], "value": 155.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 62.0, 61.0, 62.0, 64.0, 65.0, 60.0, 59.0], "value": 61.7, "unit": "score"}], "name": "kraken", "value": 1464.5, "alertThreshold": 2.0}]} 09:08:45 INFO - Return code: 0 09:08:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:08:45 ERROR - # TBPL SUCCESS # 09:08:45 INFO - Running post-action listener: _resource_record_post_action 09:08:45 INFO - [mozharness: 2016-11-17 17:08:45.219755Z] Finished run-tests step (success) 09:08:45 INFO - Running post-run listener: _resource_record_post_run 09:08:45 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 360448; Write bytes: 366235648; Read time: 844; Write time: 354272 09:08:45 INFO - TinderboxPrint: CPU usage
12.9% 09:08:45 INFO - TinderboxPrint: I/O read bytes / time
360,448 / 844 09:08:45 INFO - TinderboxPrint: I/O write bytes / time
366,235,648 / 354,272 09:08:45 INFO - TinderboxPrint: CPU idle
8,280.7 (87.0%) 09:08:45 INFO - TinderboxPrint: CPU user
1,187.5 (12.5%) 09:08:45 INFO - TinderboxPrint: Swap in / out
0 / 0 09:08:45 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 32768; Write bytes: 118575104; Read time: 444; Write time: 104476 09:08:45 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 323584; Write bytes: 247095296; Read time: 392; Write time: 249780 09:08:45 INFO - Running post-run listener: _upload_blobber_files 09:08:45 INFO - Blob upload gear active. 09:08:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:08:45 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 09:08:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:08:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:08:46 INFO - (blobuploader) - INFO - Open directory for files ... 09:08:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:08:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:08:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:47 INFO - (blobuploader) - INFO - Done attempting. 09:08:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:08:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:08:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:47 INFO - (blobuploader) - INFO - Done attempting. 09:08:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:08:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:08:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:51 INFO - (blobuploader) - INFO - Done attempting. 09:08:51 INFO - (blobuploader) - INFO - Iteration through files over. 09:08:52 INFO - Return code: 0 09:08:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:08:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:08:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bde66671629847619e9eaf4b4cc9a4c880a96ff9afc35617a70a5e7f0e3e02bc908fe08b02d49b44149945184a1ca23f0735356cee60d63d62d69df8a7b60756", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/abaee8a7a6546d1828b1f5a0e1f0a2dbf454352cb78a9d34d8cbbfa1c50d58844d041125b4e1ce4aa301f3aac00bdc74ad34cde9b5a94cdfc6c75ee7511451c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4aa37b20e823d1435599b50fcc699dff6d604f9b473ea817893c1d38f0d41cc00f54d535e472a0f750fc3191cec994002442b8552f7439f8bf7b4b2da0e9e004"} 09:08:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:08:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:08:52 INFO - Contents: 09:08:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bde66671629847619e9eaf4b4cc9a4c880a96ff9afc35617a70a5e7f0e3e02bc908fe08b02d49b44149945184a1ca23f0735356cee60d63d62d69df8a7b60756", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/abaee8a7a6546d1828b1f5a0e1f0a2dbf454352cb78a9d34d8cbbfa1c50d58844d041125b4e1ce4aa301f3aac00bdc74ad34cde9b5a94cdfc6c75ee7511451c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4aa37b20e823d1435599b50fcc699dff6d604f9b473ea817893c1d38f0d41cc00f54d535e472a0f750fc3191cec994002442b8552f7439f8bf7b4b2da0e9e004"} 09:08:52 INFO - Running post-run listener: copy_logs_to_upload_dir 09:08:52 INFO - Copying logs to upload dir... 09:08:52 INFO - mkdir: /builds/slave/test/build/upload/logs 09:08:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.538139 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-11-17 09:08:52.031577) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 09:08:52.035100) ========= 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=17051fcd5208b27b50bedfeb000001dd-1479400414.195924-1745930207 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bde66671629847619e9eaf4b4cc9a4c880a96ff9afc35617a70a5e7f0e3e02bc908fe08b02d49b44149945184a1ca23f0735356cee60d63d62d69df8a7b60756", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/abaee8a7a6546d1828b1f5a0e1f0a2dbf454352cb78a9d34d8cbbfa1c50d58844d041125b4e1ce4aa301f3aac00bdc74ad34cde9b5a94cdfc6c75ee7511451c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4aa37b20e823d1435599b50fcc699dff6d604f9b473ea817893c1d38f0d41cc00f54d535e472a0f750fc3191cec994002442b8552f7439f8bf7b4b2da0e9e004"} build_url:https://queue.taskcluster.net/v1/task/Op72mYFhRGewYngggjmFPg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011713 build_url: 'https://queue.taskcluster.net/v1/task/Op72mYFhRGewYngggjmFPg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bde66671629847619e9eaf4b4cc9a4c880a96ff9afc35617a70a5e7f0e3e02bc908fe08b02d49b44149945184a1ca23f0735356cee60d63d62d69df8a7b60756", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/abaee8a7a6546d1828b1f5a0e1f0a2dbf454352cb78a9d34d8cbbfa1c50d58844d041125b4e1ce4aa301f3aac00bdc74ad34cde9b5a94cdfc6c75ee7511451c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4aa37b20e823d1435599b50fcc699dff6d604f9b473ea817893c1d38f0d41cc00f54d535e472a0f750fc3191cec994002442b8552f7439f8bf7b4b2da0e9e004"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 09:08:52.060791) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 09:08:52.061115) ========= 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=17051fcd5208b27b50bedfeb000001dd-1479400414.195924-1745930207 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004433 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 09:08:52.146836) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 09:08:52.147215) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 09:08:52.147535) ========= ========= Total master_lag: 0.17 =========