builder: graphics_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-041 starttime: 1479505150.68 results: success (0) buildid: 20161118122222 builduid: 248e36727ef24a59aaffb3e55a1452af revision: e55d50d1193279fc0e8c76194424f6efe99f8b74 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 13:39:10.683095) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 13:39:10.683533) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 13:39:10.683848) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 13:39:10.713023) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 13:39:10.713291) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1479505004.648094-486468445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-18 13:39:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.1M=0s 2016-11-18 13:39:11 (39.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.129038 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 13:39:10.856170) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 13:39:10.856478) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1479505004.648094-486468445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016193 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 13:39:10.905228) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 13:39:10.905606) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev e55d50d1193279fc0e8c76194424f6efe99f8b74 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev e55d50d1193279fc0e8c76194424f6efe99f8b74 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1479505004.648094-486468445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-18 13:39:11,214 truncating revision to first 12 chars 2016-11-18 13:39:11,214 Setting DEBUG logging. 2016-11-18 13:39:11,214 attempt 1/10 2016-11-18 13:39:11,214 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/e55d50d11932?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-18 13:39:11,830 unpacking tar archive at: graphics-e55d50d11932/testing/mozharness/ program finished with exit code 0 elapsedTime=0.940205 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 13:39:11.859017) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 13:39:11.859325) ========= script_repo_revision: e55d50d1193279fc0e8c76194424f6efe99f8b74 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 13:39:11.859718) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 13:39:11.859982) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 13:39:11.869127) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-11-18 13:39:11.869501) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] 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=8c6b6742ce8f6f39ef4ce27d000001f1-1479505004.648094-486468445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:39:12 INFO - MultiFileLogger online at 20161118 13:39:12 in /builds/slave/test 13:39:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 13:39:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:39:12 INFO - {'append_to_log': False, 13:39:12 INFO - 'base_work_dir': '/builds/slave/test', 13:39:12 INFO - 'blob_upload_branch': 'Graphics', 13:39:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:39:12 INFO - 'branch': 'Graphics', 13:39:12 INFO - 'buildbot_json_path': 'buildprops.json', 13:39:12 INFO - 'config_files': ('talos/linux_config.py',), 13:39:12 INFO - 'default_actions': ('clobber', 13:39:12 INFO - 'read-buildbot-config', 13:39:12 INFO - 'download-and-extract', 13:39:12 INFO - 'populate-webroot', 13:39:12 INFO - 'create-virtualenv', 13:39:12 INFO - 'install', 13:39:12 INFO - 'run-tests'), 13:39:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:39:12 INFO - 'download_minidump_stackwalk': True, 13:39:12 INFO - 'download_symbols': 'ondemand', 13:39:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:39:12 INFO - 'tooltool.py': '/tools/tooltool.py', 13:39:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:39:12 INFO - '/tools/misc-python/virtualenv.py')}, 13:39:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:39:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:39:12 INFO - 'installer_path': 'installer.exe', 13:39:12 INFO - 'log_level': 'info', 13:39:12 INFO - 'log_name': 'talos', 13:39:12 INFO - 'log_to_console': True, 13:39:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:39:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:39:12 INFO - 'opt_config_files': (), 13:39:12 INFO - 'pip_index': False, 13:39:12 INFO - 'sps_profile': False, 13:39:12 INFO - 'sps_profile_interval': 0, 13:39:12 INFO - 'suite': 'dromaeojs', 13:39:12 INFO - 'system_bits': '32', 13:39:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:39:12 INFO - 'title': 'talos-linux64-ix-041', 13:39:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:39:12 INFO - 'use_talos_json': True, 13:39:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:39:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:39:12 INFO - 'work_dir': 'build'} 13:39:12 INFO - [mozharness: 2016-11-18 21:39:12.281744Z] Running clobber step. 13:39:12 INFO - Running pre-action listener: _resource_record_pre_action 13:39:12 INFO - Running main action method: clobber 13:39:12 INFO - rmtree: /builds/slave/test/build 13:39:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:39:12 INFO - Running post-action listener: _resource_record_post_action 13:39:12 INFO - [mozharness: 2016-11-18 21:39:12.743931Z] Finished clobber step (success) 13:39:12 INFO - [mozharness: 2016-11-18 21:39:12.744031Z] Running read-buildbot-config step. 13:39:12 INFO - Running pre-action listener: _resource_record_pre_action 13:39:12 INFO - Running main action method: read_buildbot_config 13:39:12 INFO - Using buildbot properties: 13:39:12 INFO - { 13:39:12 INFO - "project": "", 13:39:12 INFO - "product": "firefox", 13:39:12 INFO - "script_repo_revision": "default", 13:39:12 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs", 13:39:12 INFO - "repository": "", 13:39:12 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs", 13:39:12 INFO - "buildid": "20161118122222", 13:39:12 INFO - "pgo_build": "False", 13:39:12 INFO - "basedir": "/builds/slave/test", 13:39:12 INFO - "buildnumber": 12, 13:39:12 INFO - "slavename": "talos-linux64-ix-041", 13:39:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:39:12 INFO - "platform": "ubuntu64_hw", 13:39:12 INFO - "scheduler": "tests-graphics-linux64-talos", 13:39:12 INFO - "branch": "graphics", 13:39:12 INFO - "repo_path": "projects/graphics", 13:39:12 INFO - "revision": "e55d50d1193279fc0e8c76194424f6efe99f8b74", 13:39:12 INFO - "stage_platform": "linux64", 13:39:12 INFO - "builduid": "248e36727ef24a59aaffb3e55a1452af", 13:39:12 INFO - "slavebuilddir": "test" 13:39:12 INFO - } 13:39:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/CV7p2hPaQte1jY8FKm_f1Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 13:39:12 INFO - Running post-action listener: _resource_record_post_action 13:39:12 INFO - [mozharness: 2016-11-18 21:39:12.746475Z] Finished read-buildbot-config step (success) 13:39:12 INFO - [mozharness: 2016-11-18 21:39:12.746564Z] Running download-and-extract step. 13:39:12 INFO - Running pre-action listener: _resource_record_pre_action 13:39:12 INFO - Running main action method: download_and_extract 13:39:12 INFO - mkdir: /builds/slave/test/build/tests 13:39:12 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')]} 13:39:12 INFO - trying https://queue.taskcluster.net/v1/task/CV7p2hPaQte1jY8FKm_f1Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 13:39:12 INFO - Downloading https://queue.taskcluster.net/v1/task/CV7p2hPaQte1jY8FKm_f1Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 13:39:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CV7p2hPaQte1jY8FKm_f1Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:39:13 INFO - Downloaded 1361 bytes. 13:39:13 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 13:39:13 INFO - Using the following test package requirements: 13:39:13 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 13:39:13 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 13:39:13 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:39:13 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 13:39:13 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:39:13 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 13:39:13 INFO - u'jsshell-linux-x86_64.zip'], 13:39:13 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 13:39:13 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:39:13 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 13:39:13 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 13:39:13 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:39:13 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 13:39:13 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:39:13 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 13:39:13 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:39:13 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 13:39:13 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:39:13 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:39:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CV7p2hPaQte1jY8FKm_f1Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 13:39:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CV7p2hPaQte1jY8FKm_f1Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:39:13 INFO - Fetch https://queue.taskcluster.net/v1/task/CV7p2hPaQte1jY8FKm_f1Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:39:13 INFO - Http code: 200 13:39:13 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 13:39:13 INFO - x-amz-cf-id: 74KxIiS5HgWXvZgriWyK4bIbT8drogx28lvUxPsyjPcPiFmVn1JxwQ== 13:39:13 INFO - x-amz-version-id: vGD6Tzo0.caU2JyhuR5kZvABYIT77kSX 13:39:14 INFO - Expected file size: 20320052 13:39:14 INFO - Obtained file size: 20320052 13:39:18 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:39:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CV7p2hPaQte1jY8FKm_f1Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 13:39:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CV7p2hPaQte1jY8FKm_f1Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:39:18 INFO - Fetch https://queue.taskcluster.net/v1/task/CV7p2hPaQte1jY8FKm_f1Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:39:18 INFO - Http code: 200 13:39:18 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 13:39:18 INFO - x-amz-cf-id: 6RsGnO-w3h49EfeF4Bm5LB2pumA98waYvERhk2LW3qd661RlIenjWg== 13:39:18 INFO - x-amz-version-id: vGD6Tzo0.caU2JyhuR5kZvABYIT77kSX 13:39:19 INFO - Expected file size: 20320052 13:39:19 INFO - Obtained file size: 20320052 13:39:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CV7p2hPaQte1jY8FKm_f1Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 13:39:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CV7p2hPaQte1jY8FKm_f1Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:39:23 INFO - Fetch https://queue.taskcluster.net/v1/task/CV7p2hPaQte1jY8FKm_f1Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 13:39:24 INFO - Http code: 200 13:39:24 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 13:39:24 INFO - x-amz-cf-id: YhPeX7IZdgVweLLttZvcKjmdx5TqHzRKiVpYZIJiWDKX0mz685JUbQ== 13:39:24 INFO - x-amz-version-id: GAQcZYKRzfDwLqnX5NHsLllEgGJUYe.U 13:39:24 INFO - Expected file size: 14409392 13:39:24 INFO - Obtained file size: 14409392 13:39:24 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')]} 13:39:24 INFO - trying https://queue.taskcluster.net/v1/task/CV7p2hPaQte1jY8FKm_f1Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 13:39:24 INFO - Downloading https://queue.taskcluster.net/v1/task/CV7p2hPaQte1jY8FKm_f1Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 13:39:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CV7p2hPaQte1jY8FKm_f1Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:39:25 INFO - Downloaded 55706687 bytes. 13:39:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CV7p2hPaQte1jY8FKm_f1Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 13:39:25 INFO - mkdir: /builds/slave/test/properties 13:39:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:39:25 INFO - Writing to file /builds/slave/test/properties/build_url 13:39:25 INFO - Contents: 13:39:25 INFO - build_url:https://queue.taskcluster.net/v1/task/CV7p2hPaQte1jY8FKm_f1Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 13:39:26 INFO - Running post-action listener: _resource_record_post_action 13:39:26 INFO - Running post-action listener: set_extra_try_arguments 13:39:26 INFO - [mozharness: 2016-11-18 21:39:26.556571Z] Finished download-and-extract step (success) 13:39:26 INFO - [mozharness: 2016-11-18 21:39:26.556797Z] Running populate-webroot step. 13:39:26 INFO - Running pre-action listener: _resource_record_pre_action 13:39:26 INFO - Running main action method: populate_webroot 13:39:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:39:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:39:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:39:26 INFO - '--tppagecycles', 13:39:26 INFO - '7'], 13:39:26 INFO - 'tests': ['tsvgm']}}, 13:39:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:39:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:39:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:39:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:39:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:39:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:39:26 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:39:26 INFO - 'talos_options': ['--disable-e10s'], 13:39:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:39:26 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:39:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:39:26 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:39:26 INFO - 'talos_options': ['--disable-e10s'], 13:39:26 INFO - 'tests': ['damp', 'tps']}, 13:39:26 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:39:26 INFO - 'tests': ['damp', 'tps']}, 13:39:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:39:26 INFO - 'tests': ['dromaeo_dom']}, 13:39:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:39:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:39:26 INFO - 'tests': ['basic_compositor_video']}, 13:39:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:39:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:39:26 INFO - 'tests': ['a11yr', 13:39:26 INFO - 'ts_paint', 13:39:26 INFO - 'tpaint', 13:39:26 INFO - 'sessionrestore', 13:39:26 INFO - 'sessionrestore_no_auto_restore', 13:39:26 INFO - 'tabpaint']}, 13:39:26 INFO - 'other-e10s': {'tests': ['a11yr', 13:39:26 INFO - 'ts_paint', 13:39:26 INFO - 'tpaint', 13:39:26 INFO - 'sessionrestore', 13:39:26 INFO - 'sessionrestore_no_auto_restore', 13:39:26 INFO - 'tabpaint']}, 13:39:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:39:26 INFO - 'ts_paint', 13:39:26 INFO - 'tpaint', 13:39:26 INFO - 'sessionrestore', 13:39:26 INFO - 'sessionrestore_no_auto_restore', 13:39:26 INFO - 'tabpaint']}, 13:39:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:39:26 INFO - 'ts_paint', 13:39:26 INFO - 'tpaint', 13:39:26 INFO - 'sessionrestore', 13:39:26 INFO - 'sessionrestore_no_auto_restore', 13:39:26 INFO - 'tabpaint']}, 13:39:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:39:26 INFO - 'tests': ['a11yr', 13:39:26 INFO - 'ts_paint', 13:39:26 INFO - 'tpaint', 13:39:26 INFO - 'sessionrestore', 13:39:26 INFO - 'sessionrestore_no_auto_restore', 13:39:26 INFO - 'tabpaint']}, 13:39:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:39:26 INFO - 'tests': ['a11yr', 13:39:26 INFO - 'ts_paint', 13:39:26 INFO - 'tpaint', 13:39:26 INFO - 'sessionrestore', 13:39:26 INFO - 'sessionrestore_no_auto_restore', 13:39:26 INFO - 'tabpaint']}, 13:39:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:39:26 INFO - 'tests': ['tsvgx', 13:39:26 INFO - 'tsvgr_opacity', 13:39:26 INFO - 'tart', 13:39:26 INFO - 'tscrollx', 13:39:26 INFO - 'cart']}, 13:39:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:39:26 INFO - 'tsvgr_opacity', 13:39:26 INFO - 'tart', 13:39:26 INFO - 'tscrollx', 13:39:26 INFO - 'cart']}, 13:39:26 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:39:26 INFO - 'talos_options': ['--disable-e10s'], 13:39:26 INFO - 'tests': ['tp5o']}, 13:39:26 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:39:26 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:39:26 INFO - 'talos_options': ['--disable-e10s', 13:39:26 INFO - '--xperf_path', 13:39:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:39:26 INFO - 'tests': ['tp5n']}, 13:39:26 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:39:26 INFO - 'talos_options': ['--xperf_path', 13:39:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:39:26 INFO - 'tests': ['tp5n']}}, 13:39:26 INFO - 'talos.zip': {'path': '', 13:39:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:39:26 INFO - Running post-action listener: _resource_record_post_action 13:39:26 INFO - [mozharness: 2016-11-18 21:39:26.572578Z] Finished populate-webroot step (success) 13:39:26 INFO - [mozharness: 2016-11-18 21:39:26.572666Z] Running create-virtualenv step. 13:39:26 INFO - Running pre-action listener: _resource_record_pre_action 13:39:26 INFO - Running main action method: create_virtualenv 13:39:26 INFO - Creating virtualenv /builds/slave/test/build/venv 13:39:26 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 13:39:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:39:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:39:26 INFO - Using real prefix '/usr' 13:39:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:39:27 INFO - Installing distribute.............................................................................................................................................................................................done. 13:39:29 INFO - Installing pip.................done. 13:39:29 INFO - Return code: 0 13:39:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:39:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:39:29 INFO - Reading from file tmpfile_stdout 13:39:29 INFO - Output received: 13:39:29 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) 13:39:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:39:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:39:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:29 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 0x7f4b080e2e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c9130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1857fc0>, '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 0x1858ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1859350>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1479505004.648094-486468445', '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 13:39:29 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 13:39:29 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 13:39:29 INFO - Using env: {'DISPLAY': ':0', 13:39:29 INFO - 'HOME': '/home/cltbld', 13:39:29 INFO - 'LANG': 'en_US.UTF-8', 13:39:29 INFO - 'LANGUAGE': 'en_US:en', 13:39:29 INFO - 'LOGNAME': 'cltbld', 13:39:29 INFO - 'MAIL': '/var/mail/cltbld', 13:39:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:29 INFO - 'MOZ_NO_REMOTE': '1', 13:39:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:39:29 INFO - 'NO_EM_RESTART': '1', 13:39:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:39:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:29 INFO - 'PWD': '/builds/slave/test', 13:39:29 INFO - 'SHELL': '/bin/bash', 13:39:29 INFO - 'SHLVL': '1', 13:39:29 INFO - 'TERM': 'linux', 13:39:29 INFO - 'TMOUT': '86400', 13:39:29 INFO - 'USER': 'cltbld', 13:39:29 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479505004.648094-486468445', 13:39:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:29 INFO - '_': '/tools/buildbot/bin/python'} 13:39:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:29 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 13:39:29 INFO - Cleaning up... 13:39:29 INFO - Return code: 0 13:39:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:39:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:39:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:29 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 0x7f4b080e2e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c9130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1857fc0>, '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 0x1858ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1859350>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1479505004.648094-486468445', '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 13:39:29 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 13:39:29 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 13:39:29 INFO - Using env: {'DISPLAY': ':0', 13:39:29 INFO - 'HOME': '/home/cltbld', 13:39:29 INFO - 'LANG': 'en_US.UTF-8', 13:39:29 INFO - 'LANGUAGE': 'en_US:en', 13:39:29 INFO - 'LOGNAME': 'cltbld', 13:39:29 INFO - 'MAIL': '/var/mail/cltbld', 13:39:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:29 INFO - 'MOZ_NO_REMOTE': '1', 13:39:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:39:29 INFO - 'NO_EM_RESTART': '1', 13:39:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:39:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:29 INFO - 'PWD': '/builds/slave/test', 13:39:29 INFO - 'SHELL': '/bin/bash', 13:39:29 INFO - 'SHLVL': '1', 13:39:29 INFO - 'TERM': 'linux', 13:39:29 INFO - 'TMOUT': '86400', 13:39:29 INFO - 'USER': 'cltbld', 13:39:29 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479505004.648094-486468445', 13:39:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:29 INFO - '_': '/tools/buildbot/bin/python'} 13:39:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:29 INFO - Downloading/unpacking psutil>=3.1.1 13:39:29 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 13:39:29 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 13:39:29 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 13:39:29 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 13:39:29 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 13:39:29 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 13:39:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:39:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:39:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:39:31 INFO - Installing collected packages: psutil 13:39:31 INFO - Running setup.py install for psutil 13:39:31 INFO - building 'psutil._psutil_linux' extension 13:39:31 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 13:39:32 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 13:39:32 INFO - building 'psutil._psutil_posix' extension 13:39:32 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 13:39:32 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 13:39:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:39:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:39:32 INFO - Successfully installed psutil 13:39:32 INFO - Cleaning up... 13:39:32 INFO - Return code: 0 13:39:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:39: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')]} 13:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39: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')]} 13:39:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4b080e2e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c9130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1857fc0>, '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 0x1858ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1859350>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1479505004.648094-486468445', '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 13:39: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:39: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 mozsystemmonitor==0.3 13:39:32 INFO - Using env: {'DISPLAY': ':0', 13:39:32 INFO - 'HOME': '/home/cltbld', 13:39:32 INFO - 'LANG': 'en_US.UTF-8', 13:39:32 INFO - 'LANGUAGE': 'en_US:en', 13:39:32 INFO - 'LOGNAME': 'cltbld', 13:39:32 INFO - 'MAIL': '/var/mail/cltbld', 13:39:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:32 INFO - 'MOZ_NO_REMOTE': '1', 13:39:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:39:32 INFO - 'NO_EM_RESTART': '1', 13:39:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:39:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:32 INFO - 'PWD': '/builds/slave/test', 13:39:32 INFO - 'SHELL': '/bin/bash', 13:39:32 INFO - 'SHLVL': '1', 13:39:32 INFO - 'TERM': 'linux', 13:39:32 INFO - 'TMOUT': '86400', 13:39:32 INFO - 'USER': 'cltbld', 13:39:32 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479505004.648094-486468445', 13:39:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:32 INFO - '_': '/tools/buildbot/bin/python'} 13:39:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:39:32 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 13:39:32 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 13:39:32 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 13:39:32 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 13:39:32 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 13:39:32 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 13:39:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:39:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:39:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:39:34 INFO - Installing collected packages: mozsystemmonitor 13:39:34 INFO - Running setup.py install for mozsystemmonitor 13:39:34 INFO - Successfully installed mozsystemmonitor 13:39:34 INFO - Cleaning up... 13:39:34 INFO - Return code: 0 13:39:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:39:34 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')]} 13:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:34 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')]} 13:39:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:34 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 0x7f4b080e2e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c9130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1857fc0>, '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 0x1858ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1859350>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1479505004.648094-486468445', '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 13:39:34 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 13:39:34 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 13:39:34 INFO - Using env: {'DISPLAY': ':0', 13:39:34 INFO - 'HOME': '/home/cltbld', 13:39:34 INFO - 'LANG': 'en_US.UTF-8', 13:39:34 INFO - 'LANGUAGE': 'en_US:en', 13:39:34 INFO - 'LOGNAME': 'cltbld', 13:39:34 INFO - 'MAIL': '/var/mail/cltbld', 13:39:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:34 INFO - 'MOZ_NO_REMOTE': '1', 13:39:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:39:34 INFO - 'NO_EM_RESTART': '1', 13:39:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:39:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:34 INFO - 'PWD': '/builds/slave/test', 13:39:34 INFO - 'SHELL': '/bin/bash', 13:39:34 INFO - 'SHLVL': '1', 13:39:34 INFO - 'TERM': 'linux', 13:39:34 INFO - 'TMOUT': '86400', 13:39:34 INFO - 'USER': 'cltbld', 13:39:34 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479505004.648094-486468445', 13:39:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:34 INFO - '_': '/tools/buildbot/bin/python'} 13:39:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:34 INFO - Downloading/unpacking jsonschema==2.5.1 13:39:34 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 13:39:34 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 13:39:34 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 13:39:34 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 13:39:34 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 13:39:34 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 13:39:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:39:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:39: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 13:39: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 13:39: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 13:39: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 13:39: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 13:39: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 13:39:37 INFO - Downloading functools32-3.2.3-2.tar.gz 13:39:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:39:37 INFO - warning: no files found matching '*.txt' 13:39:37 INFO - no previously-included directories found matching 'build' 13:39:37 INFO - no previously-included directories found matching 'dist' 13:39:37 INFO - no previously-included directories found matching '.git*' 13:39:37 INFO - Installing collected packages: jsonschema, functools32 13:39:37 INFO - Running setup.py install for functools32 13:39:37 INFO - warning: no files found matching '*.txt' 13:39:37 INFO - no previously-included directories found matching 'build' 13:39:37 INFO - no previously-included directories found matching 'dist' 13:39:37 INFO - no previously-included directories found matching '.git*' 13:39:37 INFO - Successfully installed jsonschema functools32 13:39:37 INFO - Cleaning up... 13:39:37 INFO - Return code: 0 13:39:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:39:37 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')]} 13:39:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:37 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')]} 13:39:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:37 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 0x7f4b080e2e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c9130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1857fc0>, '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 0x1858ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1859350>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1479505004.648094-486468445', '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 13:39:37 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 13:39:37 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 13:39:37 INFO - Using env: {'DISPLAY': ':0', 13:39:37 INFO - 'HOME': '/home/cltbld', 13:39:37 INFO - 'LANG': 'en_US.UTF-8', 13:39:37 INFO - 'LANGUAGE': 'en_US:en', 13:39:37 INFO - 'LOGNAME': 'cltbld', 13:39:37 INFO - 'MAIL': '/var/mail/cltbld', 13:39:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:37 INFO - 'MOZ_NO_REMOTE': '1', 13:39:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:39:37 INFO - 'NO_EM_RESTART': '1', 13:39:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:39:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:37 INFO - 'PWD': '/builds/slave/test', 13:39:37 INFO - 'SHELL': '/bin/bash', 13:39:37 INFO - 'SHLVL': '1', 13:39:37 INFO - 'TERM': 'linux', 13:39:37 INFO - 'TMOUT': '86400', 13:39:37 INFO - 'USER': 'cltbld', 13:39:37 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479505004.648094-486468445', 13:39:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:37 INFO - '_': '/tools/buildbot/bin/python'} 13:39:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:39:37 INFO - Cleaning up... 13:39:37 INFO - Return code: 0 13:39:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:39:37 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')]} 13:39:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:37 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')]} 13:39:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:37 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 0x7f4b080e2e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c9130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1857fc0>, '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 0x1858ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1859350>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1479505004.648094-486468445', '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 13:39:37 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 13:39:37 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 13:39:37 INFO - Using env: {'DISPLAY': ':0', 13:39:37 INFO - 'HOME': '/home/cltbld', 13:39:37 INFO - 'LANG': 'en_US.UTF-8', 13:39:37 INFO - 'LANGUAGE': 'en_US:en', 13:39:37 INFO - 'LOGNAME': 'cltbld', 13:39:37 INFO - 'MAIL': '/var/mail/cltbld', 13:39:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:37 INFO - 'MOZ_NO_REMOTE': '1', 13:39:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:39:37 INFO - 'NO_EM_RESTART': '1', 13:39:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:39:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:37 INFO - 'PWD': '/builds/slave/test', 13:39:37 INFO - 'SHELL': '/bin/bash', 13:39:37 INFO - 'SHLVL': '1', 13:39:37 INFO - 'TERM': 'linux', 13:39:37 INFO - 'TMOUT': '86400', 13:39:37 INFO - 'USER': 'cltbld', 13:39:37 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479505004.648094-486468445', 13:39:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:37 INFO - '_': '/tools/buildbot/bin/python'} 13:39:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:37 INFO - Downloading/unpacking blobuploader==1.2.4 13:39:37 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 13:39:37 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 13:39:37 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 13:39:37 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 13:39:37 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 13:39:37 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 13:39:39 INFO - Downloading blobuploader-1.2.4.tar.gz 13:39:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:39:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:39:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:39:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:39: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 13:39: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 13:39: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 13:39: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 13:39: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 13:39: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 13:39:40 INFO - Downloading docopt-0.6.1.tar.gz 13:39:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:39:40 INFO - Installing collected packages: blobuploader, requests, docopt 13:39:40 INFO - Running setup.py install for blobuploader 13:39:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:39:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:39:40 INFO - Running setup.py install for requests 13:39:40 INFO - Running setup.py install for docopt 13:39:41 INFO - Successfully installed blobuploader requests docopt 13:39:41 INFO - Cleaning up... 13:39:41 INFO - Return code: 0 13:39:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:39: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')]} 13:39:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39: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')]} 13:39:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:41 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 0x7f4b080e2e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c9130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1857fc0>, '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 0x1858ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1859350>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1479505004.648094-486468445', '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 13:39:41 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 13:39:41 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 13:39:41 INFO - Using env: {'DISPLAY': ':0', 13:39:41 INFO - 'HOME': '/home/cltbld', 13:39:41 INFO - 'LANG': 'en_US.UTF-8', 13:39:41 INFO - 'LANGUAGE': 'en_US:en', 13:39:41 INFO - 'LOGNAME': 'cltbld', 13:39:41 INFO - 'MAIL': '/var/mail/cltbld', 13:39:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:41 INFO - 'MOZ_NO_REMOTE': '1', 13:39:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:39:41 INFO - 'NO_EM_RESTART': '1', 13:39:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:39:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:41 INFO - 'PWD': '/builds/slave/test', 13:39:41 INFO - 'SHELL': '/bin/bash', 13:39:41 INFO - 'SHLVL': '1', 13:39:41 INFO - 'TERM': 'linux', 13:39:41 INFO - 'TMOUT': '86400', 13:39:41 INFO - 'USER': 'cltbld', 13:39:41 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479505004.648094-486468445', 13:39:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:41 INFO - '_': '/tools/buildbot/bin/python'} 13:39:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:39:41 INFO - Running setup.py (path:/tmp/pip-O3WAsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:39:41 INFO - Running setup.py (path:/tmp/pip-3tLruI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:39:41 INFO - Running setup.py (path:/tmp/pip-KmO5Fw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:39:41 INFO - Running setup.py (path:/tmp/pip-q4Ixsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:39:41 INFO - Running setup.py (path:/tmp/pip-fV7RER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:39:41 INFO - Running setup.py (path:/tmp/pip-ZE30dv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:39:41 INFO - Running setup.py (path:/tmp/pip-oI4kIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:39:41 INFO - Running setup.py (path:/tmp/pip-G_poHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:39:41 INFO - Running setup.py (path:/tmp/pip-FOy5Di-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:39:42 INFO - Running setup.py (path:/tmp/pip-52mQga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:39:42 INFO - Running setup.py (path:/tmp/pip-GkgKSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:39:42 INFO - Running setup.py (path:/tmp/pip-KWJdsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:39:42 INFO - Running setup.py (path:/tmp/pip-ukHPoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:39:42 INFO - Running setup.py (path:/tmp/pip-8iFa82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:39:42 INFO - Running setup.py (path:/tmp/pip-NABBcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:39:42 INFO - Running setup.py (path:/tmp/pip-OqY25u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:39:42 INFO - Running setup.py (path:/tmp/pip-hySuWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:39:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:39:42 INFO - Running setup.py install for manifestparser 13:39:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:39:42 INFO - Running setup.py install for mozcrash 13:39:42 INFO - Running setup.py install for mozdebug 13:39:42 INFO - Running setup.py install for mozdevice 13:39:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:39:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:39:43 INFO - Running setup.py install for mozfile 13:39:43 INFO - Running setup.py install for mozhttpd 13:39:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:39:43 INFO - Running setup.py install for mozinfo 13:39:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:39:43 INFO - Running setup.py install for mozInstall 13:39:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:39:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:39:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:39:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:39:43 INFO - Running setup.py install for mozleak 13:39:43 INFO - Running setup.py install for mozlog 13:39:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:39:43 INFO - Running setup.py install for moznetwork 13:39:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:39:43 INFO - Running setup.py install for mozprocess 13:39:43 INFO - Running setup.py install for mozprofile 13:39:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:39:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:39:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:39:43 INFO - Running setup.py install for mozrunner 13:39:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:39:44 INFO - Running setup.py install for mozscreenshot 13:39:44 INFO - Running setup.py install for moztest 13:39:44 INFO - Running setup.py install for mozversion 13:39:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:39:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:39:44 INFO - Cleaning up... 13:39:44 INFO - Return code: 0 13:39:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:39: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')]} 13:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39: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')]} 13:39:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:44 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 0x7f4b080e2e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c9130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1857fc0>, '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 0x1858ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1859350>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1479505004.648094-486468445', '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 13:39:44 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 13:39:44 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 13:39:44 INFO - Using env: {'DISPLAY': ':0', 13:39:44 INFO - 'HOME': '/home/cltbld', 13:39:44 INFO - 'LANG': 'en_US.UTF-8', 13:39:44 INFO - 'LANGUAGE': 'en_US:en', 13:39:44 INFO - 'LOGNAME': 'cltbld', 13:39:44 INFO - 'MAIL': '/var/mail/cltbld', 13:39:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:44 INFO - 'MOZ_NO_REMOTE': '1', 13:39:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:39:44 INFO - 'NO_EM_RESTART': '1', 13:39:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:39:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:44 INFO - 'PWD': '/builds/slave/test', 13:39:44 INFO - 'SHELL': '/bin/bash', 13:39:44 INFO - 'SHLVL': '1', 13:39:44 INFO - 'TERM': 'linux', 13:39:44 INFO - 'TMOUT': '86400', 13:39:44 INFO - 'USER': 'cltbld', 13:39:44 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479505004.648094-486468445', 13:39:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:44 INFO - '_': '/tools/buildbot/bin/python'} 13:39:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:39:44 INFO - Running setup.py (path:/tmp/pip-4EhSc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:39:44 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)) 13:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:39:44 INFO - Running setup.py (path:/tmp/pip-utwRcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:39:44 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)) 13:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:39:44 INFO - Running setup.py (path:/tmp/pip-Uszvbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:39:44 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)) 13:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:39:44 INFO - Running setup.py (path:/tmp/pip-vmfRap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:39:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:39:44 INFO - Running setup.py (path:/tmp/pip-HoDvBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:39:45 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)) 13:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:39:45 INFO - Running setup.py (path:/tmp/pip-GIMQGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:39:45 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)) 13:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:39:45 INFO - Running setup.py (path:/tmp/pip-pp3D3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:39:45 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)) 13:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:39:45 INFO - Running setup.py (path:/tmp/pip-eweMPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:39:45 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)) 13:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:39:45 INFO - Running setup.py (path:/tmp/pip-r6K_jW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:39:45 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)) 13:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:39:45 INFO - Running setup.py (path:/tmp/pip-dzTTsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:39:45 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)) 13:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:39:45 INFO - Running setup.py (path:/tmp/pip-Fij8Ix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:39:45 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)) 13:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:39:45 INFO - Running setup.py (path:/tmp/pip-UIFQeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:39:45 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)) 13:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:39:45 INFO - Running setup.py (path:/tmp/pip-QVY8hu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:39:45 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)) 13:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:39:45 INFO - Running setup.py (path:/tmp/pip-NOMiPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:39:45 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)) 13:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:39:45 INFO - Running setup.py (path:/tmp/pip-_J4Ec0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:39:45 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)) 13:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:39:45 INFO - Running setup.py (path:/tmp/pip-k6BMGH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:39:45 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)) 13:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:39:45 INFO - Running setup.py (path:/tmp/pip-awCY3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:39:45 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)) 13:39:45 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)) 13:39:45 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)) 13:39:45 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)) 13:39:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:39:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:39:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:39:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:47 INFO - Downloading blessings-1.6.tar.gz 13:39:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:39:47 INFO - Installing collected packages: blessings 13:39:47 INFO - Running setup.py install for blessings 13:39:47 INFO - Successfully installed blessings 13:39:47 INFO - Cleaning up... 13:39:48 INFO - Return code: 0 13:39:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:39:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:39:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:39:48 INFO - Reading from file tmpfile_stdout 13:39:48 INFO - Current package versions: 13:39:48 INFO - argparse == 1.2.1 13:39:48 INFO - blessings == 1.6 13:39:48 INFO - blobuploader == 1.2.4 13:39:48 INFO - docopt == 0.6.1 13:39:48 INFO - functools32 == 3.2.3-2 13:39:48 INFO - jsonschema == 2.5.1 13:39:48 INFO - manifestparser == 1.1 13:39:48 INFO - mozInstall == 1.12 13:39:48 INFO - mozcrash == 1.0 13:39:48 INFO - mozdebug == 0.1 13:39:48 INFO - mozdevice == 0.49 13:39:48 INFO - mozfile == 1.2 13:39:48 INFO - mozhttpd == 0.7 13:39:48 INFO - mozinfo == 0.9 13:39:48 INFO - mozleak == 0.1 13:39:48 INFO - mozlog == 3.4 13:39:48 INFO - moznetwork == 0.27 13:39:48 INFO - mozprocess == 0.23 13:39:48 INFO - mozprofile == 0.28 13:39:48 INFO - mozrunner == 6.13 13:39:48 INFO - mozscreenshot == 0.1 13:39:48 INFO - mozsystemmonitor == 0.3 13:39:48 INFO - moztest == 0.7 13:39:48 INFO - mozversion == 1.4 13:39:48 INFO - psutil == 3.1.1 13:39:48 INFO - requests == 1.2.3 13:39:48 INFO - wsgiref == 0.1.2 13:39:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:39:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:48 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 0x7f4b080e2e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c9130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1857fc0>, '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 0x1858ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1859350>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1479505004.648094-486468445', '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 13:39:48 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 13:39:48 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 13:39:48 INFO - Using env: {'DISPLAY': ':0', 13:39:48 INFO - 'HOME': '/home/cltbld', 13:39:48 INFO - 'LANG': 'en_US.UTF-8', 13:39:48 INFO - 'LANGUAGE': 'en_US:en', 13:39:48 INFO - 'LOGNAME': 'cltbld', 13:39:48 INFO - 'MAIL': '/var/mail/cltbld', 13:39:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:48 INFO - 'MOZ_NO_REMOTE': '1', 13:39:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:39:48 INFO - 'NO_EM_RESTART': '1', 13:39:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:39:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:48 INFO - 'PWD': '/builds/slave/test', 13:39:48 INFO - 'SHELL': '/bin/bash', 13:39:48 INFO - 'SHLVL': '1', 13:39:48 INFO - 'TERM': 'linux', 13:39:48 INFO - 'TMOUT': '86400', 13:39:48 INFO - 'USER': 'cltbld', 13:39:48 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479505004.648094-486468445', 13:39:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:48 INFO - '_': '/tools/buildbot/bin/python'} 13:39:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:48 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)) 13:39:48 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)) 13:39:48 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)) 13:39:48 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)) 13:39:48 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)) 13:39:48 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)) 13:39:48 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)) 13:39:48 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)) 13:39:48 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)) 13:39:48 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)) 13:39:48 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)) 13:39:48 INFO - Cleaning up... 13:39:48 INFO - Return code: 0 13:39:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:39:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4b080e2e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c9130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1857fc0>, '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 0x1858ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1859350>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1479505004.648094-486468445', '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 13:39:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:39:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:39:48 INFO - Using env: {'DISPLAY': ':0', 13:39:48 INFO - 'HOME': '/home/cltbld', 13:39:48 INFO - 'LANG': 'en_US.UTF-8', 13:39:48 INFO - 'LANGUAGE': 'en_US:en', 13:39:48 INFO - 'LOGNAME': 'cltbld', 13:39:48 INFO - 'MAIL': '/var/mail/cltbld', 13:39:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:48 INFO - 'MOZ_NO_REMOTE': '1', 13:39:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:39:48 INFO - 'NO_EM_RESTART': '1', 13:39:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:39:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:48 INFO - 'PWD': '/builds/slave/test', 13:39:48 INFO - 'SHELL': '/bin/bash', 13:39:48 INFO - 'SHLVL': '1', 13:39:48 INFO - 'TERM': 'linux', 13:39:48 INFO - 'TMOUT': '86400', 13:39:48 INFO - 'USER': 'cltbld', 13:39:48 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479505004.648094-486468445', 13:39:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:48 INFO - '_': '/tools/buildbot/bin/python'} 13:39:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:39:48 INFO - Cleaning up... 13:39:48 INFO - Return code: 0 13:39:48 INFO - Running post-action listener: _resource_record_post_action 13:39:48 INFO - Running post-action listener: _start_resource_monitoring 13:39:48 INFO - Starting resource monitoring. 13:39:48 INFO - [mozharness: 2016-11-18 21:39:48.786638Z] Finished create-virtualenv step (success) 13:39:48 INFO - [mozharness: 2016-11-18 21:39:48.787159Z] Running install step. 13:39:48 INFO - Running pre-action listener: _resource_record_pre_action 13:39:48 INFO - Running main action method: install 13:39:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:39:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:39:48 INFO - Reading from file tmpfile_stdout 13:39:48 INFO - Detecting whether we're running mozinstall >=1.0... 13:39:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:39:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:39:49 INFO - Reading from file tmpfile_stdout 13:39:49 INFO - Output received: 13:39:49 INFO - Usage: mozinstall [options] installer 13:39:49 INFO - Options: 13:39:49 INFO - -h, --help show this help message and exit 13:39:49 INFO - -d DEST, --destination=DEST 13:39:49 INFO - Directory to install application into. [default: 13:39:49 INFO - "/builds/slave/test"] 13:39:49 INFO - --app=APP Application being installed. [default: firefox] 13:39:49 INFO - mkdir: /builds/slave/test/build/application 13:39:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:39:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:40:05 INFO - Reading from file tmpfile_stdout 13:40:05 INFO - Output received: 13:40:05 INFO - /builds/slave/test/build/application/firefox/firefox 13:40:05 INFO - Running post-action listener: _resource_record_post_action 13:40:05 INFO - [mozharness: 2016-11-18 21:40:05.143944Z] Finished install step (success) 13:40:05 INFO - [mozharness: 2016-11-18 21:40:05.144196Z] Running run-tests step. 13:40:05 INFO - Running pre-action listener: _resource_record_pre_action 13:40:05 INFO - Running main action method: run_tests 13:40:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:40:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:40:05 INFO - Python 2.7.3 13:40:05 INFO - Return code: 0 13:40:05 INFO - grabbing minidump binary from tooltool 13:40:05 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')]} 13:40:05 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 0x1857fc0>, '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 0x1858ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1859350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:40:05 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 13:40:05 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 13:40:05 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 13:40:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:40:05 INFO - Return code: 0 13:40:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:40:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:40:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:40:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:40:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:40:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CV7p2hPaQte1jY8FKm_f1Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 13:40:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CV7p2hPaQte1jY8FKm_f1Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 13:40:05 INFO - Using env: {'DISPLAY': ':0', 13:40:05 INFO - 'HOME': '/home/cltbld', 13:40:05 INFO - 'LANG': 'en_US.UTF-8', 13:40:05 INFO - 'LANGUAGE': 'en_US:en', 13:40:05 INFO - 'LOGNAME': 'cltbld', 13:40:05 INFO - 'MAIL': '/var/mail/cltbld', 13:40:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:40:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:40:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:40:05 INFO - 'MOZ_NO_REMOTE': '1', 13:40:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:40:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:40:05 INFO - 'NO_EM_RESTART': '1', 13:40:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:40:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:40:05 INFO - 'PWD': '/builds/slave/test', 13:40:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:40:05 INFO - 'SHELL': '/bin/bash', 13:40:05 INFO - 'SHLVL': '1', 13:40:05 INFO - 'TERM': 'linux', 13:40:05 INFO - 'TMOUT': '86400', 13:40:05 INFO - 'USER': 'cltbld', 13:40:05 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479505004.648094-486468445', 13:40:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:40:05 INFO - '_': '/tools/buildbot/bin/python'} 13:40:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CV7p2hPaQte1jY8FKm_f1Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 13:40:05 INFO - mozversion application_buildid: 20161118122222 13:40:05 INFO - mozversion application_changeset: e55d50d1193279fc0e8c76194424f6efe99f8b74 13:40:05 INFO - mozversion application_display_name: Nightly 13:40:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:40:05 INFO - mozversion application_name: Firefox 13:40:05 INFO - mozversion application_remotingname: firefox 13:40:05 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 13:40:05 INFO - mozversion application_vendor: Mozilla 13:40:05 INFO - mozversion application_version: 53.0a1 13:40:05 INFO - mozversion platform_buildid: 20161118122222 13:40:05 INFO - mozversion platform_changeset: e55d50d1193279fc0e8c76194424f6efe99f8b74 13:40:05 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 13:40:05 INFO - mozversion platform_version: 53.0a1 13:40:05 INFO - using testdate: 1479505205 13:40:05 INFO - actual date: 1479505205 13:40:05 INFO - starting webserver on 'localhost:48404' 13:40:05 INFO - SUITE-START | Running 2 tests 13:40:05 INFO - TEST-START | dromaeo_css 13:40:05 INFO - operating with platform_type : linux_ 13:40:05 INFO - Initialising browser for dromaeo_css test... 13:40:05 INFO - TEST-INFO | started process 15188 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV2SA6Z/profile http://localhost:48404/getInfo.html) 13:40:09 INFO - PROCESS | 15188 | __metrics Screen width/height:1600/1200 13:40:09 INFO - PROCESS | 15188 | colorDepth:24 13:40:09 INFO - PROCESS | 15188 | Browser inner width/height: 1024/697 13:40:09 INFO - PROCESS | 15188 | __metrics 13:40:10 INFO - PROCESS | 15188 | 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" 13:40:10 INFO - PROCESS | 15188 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:40:11 INFO - PROCESS | 15188 | console.error: PushService: 13:40:11 INFO - PROCESS | 15188 | stateChangeProcessEnqueue: Error transitioning state 13:40:11 INFO - PROCESS | 15188 | UnknownError 13:40:11 INFO - TEST-INFO | 15188: exit 0 13:40:11 INFO - Browser initialized. 13:40:11 INFO - Running cycle 1/1 for dromaeo_css test... 13:40:11 INFO - TEST-INFO | started process 15269 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV2SA6Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:40:24 INFO - PROCESS | 15269 | RSS: Main: 175247360 13:40:24 INFO - PROCESS | 15269 | 13:41:15 INFO - PROCESS | 15269 | 1479505275970 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] 13:43:28 INFO - PROCESS | 15269 | Cycle 1(1): loaded http://localhost:48404/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48404/tests/dromaeo/cssquery-ext.html) 13:43:30 INFO - PROCESS | 15269 | RSS: Main: 339963904 13:43:30 INFO - PROCESS | 15269 | 13:46:33 INFO - PROCESS | 15269 | Cycle 1(1): loaded http://localhost:48404/tests/dromaeo/cssquery-ext.html (next: http://localhost:48404/tests/dromaeo/cssquery-jquery.html) 13:46:34 INFO - PROCESS | 15269 | RSS: Main: 284905472 13:46:34 INFO - PROCESS | 15269 | 13:49:36 INFO - PROCESS | 15269 | Cycle 1(1): loaded http://localhost:48404/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48404/tests/dromaeo/cssquery-mootools.html) 13:49:36 INFO - PROCESS | 15269 | RSS: Main: 263114752 13:49:36 INFO - PROCESS | 15269 | 13:52:39 INFO - PROCESS | 15269 | Cycle 1(1): loaded http://localhost:48404/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48404/tests/dromaeo/cssquery-prototype.html) 13:52:39 INFO - PROCESS | 15269 | RSS: Main: 221462528 13:52:39 INFO - PROCESS | 15269 | 13:55:43 INFO - PROCESS | 15269 | Cycle 1(1): loaded http://localhost:48404/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48404/tests/dromaeo/cssquery-yui.html) 13:55:43 INFO - PROCESS | 15269 | RSS: Main: 221233152 13:55:43 INFO - PROCESS | 15269 | 13:58:46 INFO - PROCESS | 15269 | Cycle 1(1): loaded http://localhost:48404/tests/dromaeo/cssquery-yui.html (next: http://localhost:48404/tests/dromaeo/cssquery-dojo.html) 13:58:46 INFO - PROCESS | 15269 | RSS: Main: 318341120 13:58:46 INFO - PROCESS | 15269 | 13:58:46 INFO - PROCESS | 15269 | __start_tp_report 13:58:46 INFO - PROCESS | 15269 | _x_x_mozilla_page_load 13:58:46 INFO - PROCESS | 15269 | _x_x_mozilla_page_load_details 13:58:46 INFO - PROCESS | 15269 | |i|pagename|runs| 13:58:46 INFO - PROCESS | 15269 | |0;dojo.html;2531.658226139471;2556.3736884463306;2565.1022142250204;2593.2090712332742;2606.022741471947;4369;4459.620932220765;4499.032707967786;4505.594496495319;4510.729356238628;4384.276594361926;4418.955810441895;4429.601335879778;4454.710443821149;4455.376247325377;4106.28140075487;4128.752274863503;4155.522114956773;4158.251514727348;4227.175700738358;3874.036831835464;4195.4545909031785;4216.430781844458;4239.08859595187;4273.316269396897;4069.186162767429;4104.322786740185;4185.372194170868;4231.069164783743;4251.574842515754;4154.480689913761;4155.189738001091;4167.395727619478;4173.061061261223;4176.7076304658685;4083.0404854859084;4132.690048246363;4146.730462519927;4149.045719484505;4153.480814898137;4457.732536047847;4466.754328511931;4483;4530.932036019462;4551.112533056055;4795.040991801654;4797.9520204797855;4800.95199048012;4814.15752243356;4847.95152048482;4565.56627120423;4600.17196904557;4818.831340903087;4847.636427267969;4879.853604391838;4378.584034516716;4432.113577284524;4484.529124441952;4484.663650226181;4551.726896386162;4893.412790465167;4894.779734911937;4898.044881248194;4899.657024008286;4949.356583644175;4678.742669153161;4709.976450117728;4717.882052948704;4723.716577005391;4772.0694464579765;4619.95380046202;4635.258358662598;4659.021605462891;4669.743164125938;4670.8365207217585;4658;4674.649401294916;4681.297805329228;4687.226607609706;4688.320193571913;4605.447346318463;4643.95356046442;4648.163330600457;4671.766411679402;4689.577937985598;3886.1839013807416;3935.6064393560414;3943.38877473992;3950.6246906543834;3972.245273398045;3476.4263896457305;3530.841112149908;3536.469529570585;3555.7866528008403;3565.0196196046295;4105.220008198433;4114.115465174942;4135.60711732385;4136.400221967798;4144.254034273799;4691.5308469152815;4701.200795864711;4707.082118986833;4714.717116972924;4716.3868697069165;4143.772092534879;4152.91694166121;4152.958470415318;4154.688398370135;4158.9376159357635;4140.855070072533;4203.264428725022;4206.221848957953;4207.221663992172;4210.305299625588;4530.365748795171;4535.138323718483;4536.183486972377;4543.227651299287;4544.477385100756;4740.288956656529;4749.35883655702;4760.833370832004;4790.257510085942;4798.328234047166;4587.908241835212;4589.5410458955175;4597.517260687579;4599.080183963154;4650.139724151043;4471.8658440246845;4491.865244042684;4497.8200871964755;4623.283391074388;4687.601553867823;4714.175019371528;4752.453467851241;4759.6430267729365;4801.063792560417;4806.7836947336755;4623.329617205419;4628.467726211394;4638.466576343763;4641.234196357698;4702.318163866152;4461.152381047591;4506.526814684411;4634.76826158684;4644.187267228289;4671.976640116778;4495.21333766596;4505.909881802411;4513.300438432048;4525.253333199985;4526.8189272428735;4618.399608050931;4629.490756016903;4660.953390466188;4715.434147902273;4722.858314250578;4485.48416932057;4504.729716217037;4522.344260082204;4538.228501154746;4579 13:58:46 INFO - PROCESS | 15269 | |1;ext.html;545.7844151560134;556.95822813289;564.8136115082024;565.3554947360008;576.7174084698499;27526.724732752667;30246.848765756167;37558.812205939;38544.61455385445;38724.41913371302;38554.421683674766;38946.61053389465;39009;39011.21977560447;39068.80465597675;7588.354989825858;7743.496672716284;7746.961265193666;7749.263819937097;7755.302022817945;7665.8850117248285;7748.41886858485;7752.728654497094;7757.379409647243;7759.262870027338;7743.728969486069;7804.726834560792;7806.180351063142;7806.492577982442;7808.1801410851895;7717.421193410489;7770.184130666255;7773;7778.1055178654615;7778.222177782233;7603.885941710879;7660.042494688164;7664.3102120808835;7668.731594394169;7668.846623067508;37067.814660926524;37165.62834371676;37252.25495490075;37313;37394;2826;2903.7096290371005;2980.8658610362368;3031.3028003559084;3169.0334447993355;27978;28152.718472815213;28225.294367640767;28734.568981465294;29242.85378573115;3366;3371.089805752458;3375.0718552398043;3421.298633780069;3552.609212986569;243638;244247;244279;244532;244714;51141.74429127905;51335.989482050645;51438.48561514412;51476.22785658218;51499;54286.45713542814;58489;59879;59987.70006150028;60029.399706003256;13294.3352832358;13476.797848032287;13476.93261533686;13949.58151255464;13956.371963261678;10162.491875406347;10170.135538479311;10197.898021019695;10212.540435680412;10386.844197337046;18338.724919126224;18850.15174317159;18932.81067189338;18955.81044189568;18969.81030189708;7060.435165186773;7125.750598729123;7185.820354491179;7345.632718364061;7423.62881855905;785.3128512551517;844.8690452979798;869.9304055675531;892.7321803458937;906.8095699902963;26853.865730671223;26976.865115674296;27463.313417164332;27587.44825103527;27978;888.9333300002396;917.6696389299847;922.3727865051695;941.7174847545709;1041.729150420896;13933.721325573635;14658.633534161518;14779.408823646934;14940;15010.324535395934;355763;359371;360176;360215;360669;49022.75488622534;49438.75280623574;49556.25665615019;49582.752086239336;49888.75055624771;1040.7502199472071;1101.9338839669485;1103.1395511501041;1170.4381896689636;1172.0740614914293;26803.597946030433;28532.144035678964;29907.70092299049;31560.684393155774;32106.678933211304;46718;47636.2854557175;47700.522994770996;47703.28445073396;47713.76143119401;316310;317756;317985;319052;322369;36731.44902826513;38214.6178538211;38222.42666360062;38237;38280.42579361256;40737.38893916653;41032;41262.58737412588;42139.7893010533;42228.155436891706;35607.465888012215;35734.8213258932;35801.10497237486;35979.82010089933;36076.09809754777;35276.647233527336;35326.47010294796;35724.28551429009;36166.819165904;37097.629023709414;29284.560731588615;32122.357552848345;32923;35606.821965890005;36090;30436.543451847796;32574.511382329758;32595;32784.50823237701;33069.66930330666;24642.753572464047;25139.74301284965;25183.37041573975;25505.48989020246;25825.354366140244 13:58:46 INFO - PROCESS | 15269 | |2;jquery.html;328.31218597039197;342.3802916720735;343.56367413385004;346.13121066124023;348.49642266924303;15584.610384740387;15661.608459788496;17037.57406064849;17055.31778728851;17100.315987360522;13687.863121368784;13864.445422183126;15357.078575285463;15446.304916278767;15468.767968480483;4768.976155119228;4775.641826862981;4793.5925446337105;4822.204336284509;4999.425066117388;4813.061453016663;4904.337914381548;4908.631852611068;4912.410510738699;4914.606831453475;4656.674032817704;4827;4863.100326439602;4865.321464094882;4877.780499877514;4782.569568738812;4795.6882802618065;4817.927731084019;4820.903581928342;4868.464468908417;4108.322126849066;4257;4262.2754131797665;4263;4264.9147017059795;19480.70778938317;19514.70727939082;19586.474434601765;19794.604107917905;19848.603027939505;1754.97367539487;1785.8214178582039;1839.6320735852748;2031.2179810772811;2250.313654335427;12080.335581543099;12751.553695620609;12821;13196.538121165713;13379.26414047227;1582.8179759327709;1646.6377396972646;1649.6971259182794;1707.641395306987;1749.9037552934583;65241.67379163121;66005;66691.333086669;67425.3257467424;69321;8425.452345597516;8452.154784521621;8652.3510736695;8881.24509416694;9045.366824322235;11832.112591555668;11867.643970680894;11878.227915185485;11886;11900.107491937966;6878.58728476293;7006.719731210796;7050.506464547535;7194.316539928698;7201.099862517185;6463.838404039842;6515.902261466082;6664.833379165462;6669.499787515956;6702.798916032527;5751.9137212941005;5776.451237132465;5805.158252053428;5808.3901190375245;5989.940100599026;1501.9849801502064;1551.2476448922264;1565.5381662409616;1573.244842475618;1603.5670369000538;806.7575933063134;817.8650522663813;825.1665817524344;832.9708460203864;917.3899356927568;16352.509424717278;16537.91731041337;16814.91592542054;17567.73648395275;17581.7362739559;834.9916500834914;861.9310455163571;869.9391042627082;884.7699598104539;902.7788191893028;9284.814303714023;9653.372530785477;9704.175145112744;9777.41335519871;10088.44513551747;366708;367544;380888;384341;385299;61255;64497;64965.350346496874;65243.67378163079;65393.346066538725;916.2715641065369;944.9480278584743;977.2524019125375;978.7944531648291;980.1032055669126;14905;14984.167446677016;15029.699406012038;15531.922340388677;15592.610184745472;31794.84102579472;32661.34677306488;33621.66378336185;33907.83046084754;35357.292854143285;42655.360169598105;43230.783846080565;43476.95661303678;44733.77633111813;45644.54355456536;7023.68393422287;7122.197398867099;7132.251113632994;7210.783676489714;7374.151972523228;11277.32336059839;11731.530738770694;12036.518539258332;12122.09084318662;12154.939225303817;10185;10624.150067994697;10667.839982400425;10771.569137234423;11018.559257629606;6810.761623343159;6850.246472887879;7138.571685698875;7169.820754481179;7700;6925.168979722465;7248.746293879689;7416.814579635552;7455.888161677471;7478.813029674302;10246.692599222035;10841.839272567859;11091;11132.777344453227;11411.657650270505;10825.350478971286;10962.671119866416;11389.373584452604;11639.301641901513;11694.88305116972 13:58:46 INFO - PROCESS | 15269 | |3;mootools.html;1168.76624675065;1290.2645492069519;1313.4680454415961;1345.8990575706825;1567.192895658736;5754.223179870722;6353.142325786018;6564.967175164124;6570.540062195648;6727.024581435689;6516.837079073026;6569.113169722086;6571.671416429183;6578.9013164802445;6581.90127148092;1990.940271791845;2031.5733695923873;2032.278541117904;2032.3090149349218;2033.6237796007713;1964.9607007859834;1995.8403327733747;2001.6997450382414;2009.2867032203576;2011.8692285001428;1967.2327792161068;1972.447714639903;1998.2906068345746;1999.5001249687577;2000.0599718132528;1941.1652989214633;1955.9706604400944;1957.0508303472805;1957.9902100489478;1959.2750682247517;1948.0844003318418;1956.2566224834472;1962.1170473286936;1982.7918068602878;1983.1769815526538;6534.509911756637;6543.803685889383;6618.073469714244;6629.171353580802;6632.801015969529;3923.4899463069905;4114.835406583733;4117.711760176789;4139.8965025874295;4150.813213405404;2587.386739393208;2732.1120635793445;2778.7776977841722;2794.8602569871628;2796.9720302796914;848.6902280667512;853.5433543054498;858.0304256190527;865.7489328094845;898.9841479128543;8380.790480237982;8467.195616416431;8482.36382271326;8487.575621218975;8495.74512764618;3253.430649636304;3495.1961048958374;3551.3785087609567;3566.8751593694615;3569.7858128511853;6962.060121883481;6965.547239429421;6970.721171153198;6973.442124630017;6977.092977912839;3967.1668949520345;4005.6581045349553;4010;4012.7792971386853;4013.2174226026227;3280.6555311692405;3384.2554637979606;3654.744167908221;3762.360398732222;3764.1154328732728;2834.588984597222;2859.2994716294643;2956.1427186116216;2957.06852341516;2971.6136902203007;859.8710193470904;860.6471346747928;870;875.1467319363696;878.8198419324024;789.1083076123944;799.5003123048095;801.3629164813987;811.0996793559144;811.4806523824757;4480.14877173336;4541.091781643684;4568.497465278817;4646.628269738413;4851.151048566487;363.8271820885058;372.9403295472711;376.5744708479455;379.1828609346862;379.9392097264466;3231.0952933178746;3246.1722260823813;3273.8035717857006;3279.8524066417067;3351.0784534253276;7520.247975202436;7890.802729931797;7909.406794490436;7916.881246781303;7927.603619818986;7883.881741773878;7895.763127106196;7899.447038707351;7904.84190316202;7905.130435652074;6161.784337548164;6217.782377616762;6225.564210505221;6226.159468471698;6241.7191226394925;4530.093981203839;4654.2785868190485;4677.064587082529;4716.905661886674;4734.976325118352;7199.676014579251;7206.495545311778;7323.157836848831;7391.6304184791625;7393.297636724503;7257.52826066304;7419.851602967802;7444.367228785614;7452.180260171485;7494.662740176815;5460.972695136499;5463;5468.7539060741565;5514.641548299348;5539.667619942817;6202.937970620236;6265.216847894013;6273.090401891609;6275.717592708431;6278;5728.455796699307;5849.181114644039;5854.326752423526;5874;5900.468957793819;5720.170575266647;5728.513076388554;5798.159266906359;5814.476697097281;5852.18069470283;5248.3701955765555;5374.758135883816;5377.838664840061;5490.313710786152;5502.422245664307;3858.4405261237525;3950.0717331426517;3953.6244056814558;3964.524257089168;3964.6431821135084;4002.519697636302;4062.370332598452;4160.771157586361;4164.312888373384;4185.162967406592 13:58:46 INFO - PROCESS | 15269 | |4;prototype.html;275.2979901251807;277.45203223633325;281.149522693851;281.9483327189584;282.7709555260238;4629.444466664001;4629.930551041729;4639.327297541863;4647.44230692317;4698.718076915383;4567.703099298552;4582.564656357649;4584.977075114628;4596.448426188854;4604.631629469643;3406.914827129317;3482.89551313461;3520.524729161556;3596.4425514045233;3639.2357604903004;3600.5859326177433;3611.0791748104198;3617.981910090446;3620.583632882226;3646.3436581415335;3375.6961873431387;3585.9282814343696;3592;3598.2263813280138;3598.6401359864067;3483.982580087096;3522.718182545403;3568.125809176742;3575.785452872836;3619.9728152234834;3168;3181.284211052495;3188.4260833050043;3190.8512935343256;3207.4547326954475;4458.598726114666;4467.664925130628;4482.394876691637;4482.843100491467;4506.233940230136;3975.403689446577;4086.6934979876332;4094.7715685294293;4108.383742438628;4109.8972525686795;4727.361806156159;4755.738434386108;4763.833265835679;4776.188048031843;4776.5701086902345;3465.3589086018915;3466.843992020365;3467.2025434150037;3479.9826000869834;3487.0995307557187;4829.251466022772;4972.87567810804;5007.899842003176;5034.647574669774;5056.317397151374;3534.929301413957;3550.6626870447267;3560.8041557714573;3566.8751593694096;3573.76770509916;3628.582712987987;3629.4011488104693;3629.764065335745;3630;3641.2353405785084;4045.130296986162;4097.528784189797;4098.221337945781;4101.692373072032;4124.628783409507;4540.704854184468;4780.569748722632;4845;4852.320675105488;4856.368672072608;1195.2231049817688;1217.31221859649;1217.3748046358035;1218.250775772911;1219.3537425164677;774.7023735243445;791.2404092071561;833.2087506851997;845.8858054162732;846.3821410370464;4244.72409293395;4357.716748411343;4365.236083685342;4365.628921541641;4381.7151885128005;4949.752512374367;4955.4796746341835;4964.2305442655725;4989.600831933437;4989.750512474362;4346.891327716832;4347.913041739147;4370.213361594943;4376.693631445832;4390.473143222834;2448.9551224727197;2568.4349443122483;2573.5073657278735;2577.755113264237;2580.3033181041014;4659.34593219409;4665.346851440801;4666.4633567139535;4671.18254305502;4671.32265821454;4761.881288172654;4909;4915.837031706038;4921.630877684188;4931.58081563064;4571.611413029929;4592.862214133581;4605.4933957264675;4616.422947131608;4622.86131416058;4752.5485078917445;4759.857204283877;4761.285807128958;4776.188048031773;4779.713217206979;4647.209974304444;4677.368555245134;4687.906241875212;4709.929351059668;4711.905761884812;4379.934300985424;4550.567696068868;4568.81724731007;4572.88567785808;4596.172688916027;3284.802911825298;3323.883664071746;3361.1261072120938;3362.882299119519;3379.6620337966006;4810.302506136521;4813.5186481352985;4815.855524334275;4836.371271734793;4840.757962101951;4439.977800111108;4630.467496237841;4671.532846715301;4682.367880336111;4682.635269189174;4637.466691330405;4670.813167473263;4675.906481870412;4685.344051832678;4695.624350052056;4557.658175636907;4598.724076555417;4607.111084455491;4608.700434471749;4618.214903466486;4423.955760442354;4613.261878099488;4690.906181876411;4727.338172655762;4772.76136193182;4691.648126390466;4701.224297990793;4708.717476951257;4714.693544919569;4726.3146843708155 13:58:46 INFO - PROCESS | 15269 | |5;yui.html;642.2613993907007;671.5165081141579;704.6723273677738;729.8686236477432;739.0835364148458;11944.522219111235;12786.552470663528;12996.805047924288;13012.674683132915;13026.413811378487;11702.473388697508;12009.519619215222;12074;12083.154179207459;12098.637040888787;603.6770327874588;621.8538643418793;736.2269616902245;738.4092725819349;770.0066913681344;749.9100107987049;760.3574979142616;760.6196901549225;760.9277118673717;760.9315161635452;806.5160903457937;811.7402431222012;812.2689579378548;812.3054788156101;813.0081300812999;631.9526035547352;650.3626446082865;777.2033665492859;797.7168105322585;798.8242586630961;588.167742644158;591.3967752892027;592.8754961458098;593.0659211741481;593.4125216036136;12194.329311887843;12198.329091899943;12211;12235.143539952207;12269.693257668541;11633.825492617618;11784.705382365424;12012;12140.817887731691;12223;10980.615678451295;10983.176261780318;11277.548898044068;11381.772364552662;11768.117391195608;3852.0947577319307;3880.8447662093763;3924.7056470764805;3947.921041579152;3963.365861462152;50396.74801626005;50554.747226264;50669.239961400606;51239.975200496156;53073.46926530763;9125.680601178927;9258.814823703487;9421.811563768686;9438.056194380508;9564.378315409476;16949;17261.827381726274;17267.568310792078;17271.222794974256;17639.206235719423;6507;6580.736770529221;6626.734930602818;6657.500687448364;6695.899561506581;3547.414676578387;3627.3108109459117;3638.199596088856;3658.8719394821055;3675.0628589709454;2531.5949448088586;2609.647697560843;2616.489784492044;2616.6859976802907;2626.5797472404324;452.1048324317869;459.0726732001405;462.29500012480565;469.061876247505;471.14252061248885;489.97060176389533;504.18825690638045;509.55159459675247;514.0669684522579;535.1197280473676;6566.388337042724;6636.502262330248;6681.866362672719;6700.932990670129;6725.798226053226;444.5732097186672;506.38474253781834;512.7231295100678;531.6012990257307;535.823178351151;3139.8901038464;3200.5274277408807;3223.3714425686767;3305.388503126929;3342.364950659367;41272.93635318282;50974;69752;74615;74619;36250.456243156375;44750.77624611856;61359;61526.69236653788;62037.68981155156;55495.722521387135;56312.155317670266;56426;56506.7174664124;56859.14711279334;6176.8764624706355;6383.808485745435;6415.294317625151;6548.967255163694;6597.1423714916755;36759.22130123067;38654.80672596619;39311.41032884566;39753;39911.40132898067;46827;48785;52335.47664523306;52673;55773;8741.694040708799;8878.600462979311;8907.376483646083;8954.552272386225;9365;9753.9024609753;9786.85319720219;9809.117179453884;9830.606775728891;9862.802743944938;9077.500737459502;9157.771055723393;9421.387609805615;9512.809743804946;9701.272404569827;9247.72256832296;9261.212796912068;9407.43555386679;9475.763105922408;9556.378835375679;8950.418222815497;9124.908750912671;9194.12655797698;9216.400933939272;9250.907490925005;7096.78709638691;7422.608868069368;7458.589777562286;7630.2751238632245;7696.076470823537;7018.263082376481;7517.699292028257;7877.133515313197;7964.058212222954;8148.144444833207 13:58:46 INFO - PROCESS | 15269 | __end_tp_report 13:58:46 INFO - PROCESS | 15269 | __start_cc_report 13:58:46 INFO - PROCESS | 15269 | _x_x_mozilla_cycle_collect,1950 13:58:46 INFO - PROCESS | 15269 | __end_cc_report 13:58:46 INFO - PROCESS | 15269 | __startTimestamp1479506326830__endTimestamp 13:58:46 INFO - PROCESS | 15269 | 13:58:46 INFO - PROCESS | 15269 | ------- Summary: start ------- 13:58:46 INFO - PROCESS | 15269 | Number of tests: 6 13:58:46 INFO - PROCESS | 15269 | 13:58:46 INFO - PROCESS | 15269 | [#0] dojo.html Cycles:165 Average:4399.89 Median:4522.34 stddev:441.16 (9.8%) stddev-sans-first:417.46 13:58:46 INFO - PROCESS | 15269 | Values: 2531.7 2556.4 2565.1 2593.2 2606.0 4369.0 4459.6 4499.0 4505.6 4510.7 4384.3 4419.0 4429.6 4454.7 4455.4 4106.3 4128.8 4155.5 4158.3 4227.2 3874.0 4195.5 4216.4 4239.1 4273.3 4069.2 4104.3 4185.4 4231.1 4251.6 4154.5 4155.2 4167.4 4173.1 4176.7 4083.0 4132.7 4146.7 4149.0 4153.5 4457.7 4466.8 4483.0 4530.9 4551.1 4795.0 4798.0 4801.0 4814.2 4848.0 4565.6 4600.2 4818.8 4847.6 4879.9 4378.6 4432.1 4484.5 4484.7 4551.7 4893.4 4894.8 4898.0 4899.7 4949.4 4678.7 4710.0 4717.9 4723.7 4772.1 4620.0 4635.3 4659.0 4669.7 4670.8 4658.0 4674.6 4681.3 4687.2 4688.3 4605.4 4644.0 4648.2 4671.8 4689.6 3886.2 3935.6 3943.4 3950.6 3972.2 3476.4 3530.8 3536.5 3555.8 3565.0 4105.2 4114.1 4135.6 4136.4 4144.3 4691.5 4701.2 4707.1 4714.7 4716.4 4143.8 4152.9 4153.0 4154.7 4158.9 4140.9 4203.3 4206.2 4207.2 4210.3 4530.4 4535.1 4536.2 4543.2 4544.5 4740.3 4749.4 4760.8 4790.3 4798.3 4587.9 4589.5 4597.5 4599.1 4650.1 4471.9 4491.9 4497.8 4623.3 4687.6 4714.2 4752.5 4759.6 4801.1 4806.8 4623.3 4628.5 4638.5 4641.2 4702.3 4461.2 4506.5 4634.8 4644.2 4672.0 4495.2 4505.9 4513.3 4525.3 4526.8 4618.4 4629.5 4661.0 4715.4 4722.9 4485.5 4504.7 4522.3 4538.2 4579.0 13:58:46 INFO - PROCESS | 15269 | 13:58:46 INFO - PROCESS | 15269 | [#1] ext.html Cycles:180 Average:46679.27 Median:36128.41 stddev:81699.97 (226.1%) stddev-sans-first:81855.73 13:58:46 INFO - PROCESS | 15269 | Values: 545.8 557.0 564.8 565.4 576.7 27526.7 30246.8 37558.8 38544.6 38724.4 38554.4 38946.6 39009.0 39011.2 39068.8 7588.4 7743.5 7747.0 7749.3 7755.3 7665.9 7748.4 7752.7 7757.4 7759.3 7743.7 7804.7 7806.2 7806.5 7808.2 7717.4 7770.2 7773.0 7778.1 7778.2 7603.9 7660.0 7664.3 7668.7 7668.8 37067.8 37165.6 37252.3 37313.0 37394.0 2826.0 2903.7 2980.9 3031.3 3169.0 27978.0 28152.7 28225.3 28734.6 29242.9 3366.0 3371.1 3375.1 3421.3 3552.6 243638.0 244247.0 244279.0 244532.0 244714.0 51141.7 51336.0 51438.5 51476.2 51499.0 54286.5 58489.0 59879.0 59987.7 60029.4 13294.3 13476.8 13476.9 13949.6 13956.4 10162.5 10170.1 10197.9 10212.5 10386.8 18338.7 18850.2 18932.8 18955.8 18969.8 7060.4 7125.8 7185.8 7345.6 7423.6 785.3 844.9 869.9 892.7 906.8 26853.9 26976.9 27463.3 27587.4 27978.0 888.9 917.7 922.4 941.7 1041.7 13933.7 14658.6 14779.4 14940.0 15010.3 355763.0 359371.0 360176.0 360215.0 360669.0 49022.8 49438.8 49556.3 49582.8 49888.8 1040.8 1101.9 1103.1 1170.4 1172.1 26803.6 28532.1 29907.7 31560.7 32106.7 46718.0 47636.3 47700.5 47703.3 47713.8 316310.0 317756.0 317985.0 319052.0 322369.0 36731.4 38214.6 38222.4 38237.0 38280.4 40737.4 41032.0 41262.6 42139.8 42228.2 35607.5 35734.8 35801.1 35979.8 36076.1 35276.6 35326.5 35724.3 36166.8 37097.6 29284.6 32122.4 32923.0 35606.8 36090.0 30436.5 32574.5 32595.0 32784.5 33069.7 24642.8 25139.7 25183.4 25505.5 25825.4 13:58:46 INFO - PROCESS | 15269 | 13:58:46 INFO - PROCESS | 15269 | [#2] jquery.html Cycles:180 Average:23038.94 Median:23460.14 stddev:61975.18 (264.2%) stddev-sans-first:62125.58 13:58:46 INFO - PROCESS | 15269 | Values: 328.3 342.4 343.6 346.1 348.5 15584.6 15661.6 17037.6 17055.3 17100.3 13687.9 13864.4 15357.1 15446.3 15468.8 4769.0 4775.6 4793.6 4822.2 4999.4 4813.1 4904.3 4908.6 4912.4 4914.6 4656.7 4827.0 4863.1 4865.3 4877.8 4782.6 4795.7 4817.9 4820.9 4868.5 4108.3 4257.0 4262.3 4263.0 4264.9 19480.7 19514.7 19586.5 19794.6 19848.6 1755.0 1785.8 1839.6 2031.2 2250.3 12080.3 12751.6 12821.0 13196.5 13379.3 1582.8 1646.6 1649.7 1707.6 1749.9 65241.7 66005.0 66691.3 67425.3 69321.0 8425.5 8452.2 8652.4 8881.2 9045.4 11832.1 11867.6 11878.2 11886.0 11900.1 6878.6 7006.7 7050.5 7194.3 7201.1 6463.8 6515.9 6664.8 6669.5 6702.8 5751.9 5776.5 5805.2 5808.4 5989.9 1502.0 1551.2 1565.5 1573.2 1603.6 806.8 817.9 825.2 833.0 917.4 16352.5 16537.9 16814.9 17567.7 17581.7 835.0 861.9 869.9 884.8 902.8 9284.8 9653.4 9704.2 9777.4 10088.4 366708.0 367544.0 380888.0 384341.0 385299.0 61255.0 64497.0 64965.4 65243.7 65393.3 916.3 944.9 977.3 978.8 980.1 14905.0 14984.2 15029.7 15531.9 15592.6 31794.8 32661.3 33621.7 33907.8 35357.3 42655.4 43230.8 43477.0 44733.8 45644.5 7023.7 7122.2 7132.3 7210.8 7374.2 11277.3 11731.5 12036.5 12122.1 12154.9 10185.0 10624.2 10667.8 10771.6 11018.6 6810.8 6850.2 7138.6 7169.8 7700.0 6925.2 7248.7 7416.8 7455.9 7478.8 10246.7 10841.8 11091.0 11132.8 11411.7 10825.4 10962.7 11389.4 11639.3 11694.9 13:58:46 INFO - PROCESS | 15269 | 13:58:46 INFO - PROCESS | 15269 | [#3] mootools.html Cycles:180 Average:4333.43 Median:5311.56 stddev:2317.12 (43.6%) stddev-sans-first:2311.41 13:58:46 INFO - PROCESS | 15269 | Values: 1168.8 1290.3 1313.5 1345.9 1567.2 5754.2 6353.1 6565.0 6570.5 6727.0 6516.8 6569.1 6571.7 6578.9 6581.9 1990.9 2031.6 2032.3 2032.3 2033.6 1965.0 1995.8 2001.7 2009.3 2011.9 1967.2 1972.4 1998.3 1999.5 2000.1 1941.2 1956.0 1957.1 1958.0 1959.3 1948.1 1956.3 1962.1 1982.8 1983.2 6534.5 6543.8 6618.1 6629.2 6632.8 3923.5 4114.8 4117.7 4139.9 4150.8 2587.4 2732.1 2778.8 2794.9 2797.0 848.7 853.5 858.0 865.7 899.0 8380.8 8467.2 8482.4 8487.6 8495.7 3253.4 3495.2 3551.4 3566.9 3569.8 6962.1 6965.5 6970.7 6973.4 6977.1 3967.2 4005.7 4010.0 4012.8 4013.2 3280.7 3384.3 3654.7 3762.4 3764.1 2834.6 2859.3 2956.1 2957.1 2971.6 859.9 860.6 870.0 875.1 878.8 789.1 799.5 801.4 811.1 811.5 4480.1 4541.1 4568.5 4646.6 4851.2 363.8 372.9 376.6 379.2 379.9 3231.1 3246.2 3273.8 3279.9 3351.1 7520.2 7890.8 7909.4 7916.9 7927.6 7883.9 7895.8 7899.4 7904.8 7905.1 6161.8 6217.8 6225.6 6226.2 6241.7 4530.1 4654.3 4677.1 4716.9 4735.0 7199.7 7206.5 7323.2 7391.6 7393.3 7257.5 7419.9 7444.4 7452.2 7494.7 5461.0 5463.0 5468.8 5514.6 5539.7 6202.9 6265.2 6273.1 6275.7 6278.0 5728.5 5849.2 5854.3 5874.0 5900.5 5720.2 5728.5 5798.2 5814.5 5852.2 5248.4 5374.8 5377.8 5490.3 5502.4 3858.4 3950.1 3953.6 3964.5 3964.6 4002.5 4062.4 4160.8 4164.3 4185.2 13:58:46 INFO - PROCESS | 15269 | 13:58:46 INFO - PROCESS | 15269 | [#4] prototype.html Cycles:180 Average:3961.05 Median:4562.68 stddev:1138.54 (25.0%) stddev-sans-first:1107.62 13:58:46 INFO - PROCESS | 15269 | Values: 275.3 277.5 281.1 281.9 282.8 4629.4 4629.9 4639.3 4647.4 4698.7 4567.7 4582.6 4585.0 4596.4 4604.6 3406.9 3482.9 3520.5 3596.4 3639.2 3600.6 3611.1 3618.0 3620.6 3646.3 3375.7 3585.9 3592.0 3598.2 3598.6 3484.0 3522.7 3568.1 3575.8 3620.0 3168.0 3181.3 3188.4 3190.9 3207.5 4458.6 4467.7 4482.4 4482.8 4506.2 3975.4 4086.7 4094.8 4108.4 4109.9 4727.4 4755.7 4763.8 4776.2 4776.6 3465.4 3466.8 3467.2 3480.0 3487.1 4829.3 4972.9 5007.9 5034.6 5056.3 3534.9 3550.7 3560.8 3566.9 3573.8 3628.6 3629.4 3629.8 3630.0 3641.2 4045.1 4097.5 4098.2 4101.7 4124.6 4540.7 4780.6 4845.0 4852.3 4856.4 1195.2 1217.3 1217.4 1218.3 1219.4 774.7 791.2 833.2 845.9 846.4 4244.7 4357.7 4365.2 4365.6 4381.7 4949.8 4955.5 4964.2 4989.6 4989.8 4346.9 4347.9 4370.2 4376.7 4390.5 2449.0 2568.4 2573.5 2577.8 2580.3 4659.3 4665.3 4666.5 4671.2 4671.3 4761.9 4909.0 4915.8 4921.6 4931.6 4571.6 4592.9 4605.5 4616.4 4622.9 4752.5 4759.9 4761.3 4776.2 4779.7 4647.2 4677.4 4687.9 4709.9 4711.9 4379.9 4550.6 4568.8 4572.9 4596.2 3284.8 3323.9 3361.1 3362.9 3379.7 4810.3 4813.5 4815.9 4836.4 4840.8 4440.0 4630.5 4671.5 4682.4 4682.6 4637.5 4670.8 4675.9 4685.3 4695.6 4557.7 4598.7 4607.1 4608.7 4618.2 4424.0 4613.3 4690.9 4727.3 4772.8 4691.6 4701.2 4708.7 4714.7 4726.3 13:58:46 INFO - PROCESS | 15269 | 13:58:46 INFO - PROCESS | 15269 | [#5] yui.html Cycles:180 Average:13906.81 Median:592.14 stddev:18178.27 (3069.9%) stddev-sans-first:18201.97 13:58:46 INFO - PROCESS | 15269 | Values: 642.3 671.5 704.7 729.9 739.1 11944.5 12786.6 12996.8 13012.7 13026.4 11702.5 12009.5 12074.0 12083.2 12098.6 603.7 621.9 736.2 738.4 770.0 749.9 760.4 760.6 760.9 760.9 806.5 811.7 812.3 812.3 813.0 632.0 650.4 777.2 797.7 798.8 588.2 591.4 592.9 593.1 593.4 12194.3 12198.3 12211.0 12235.1 12269.7 11633.8 11784.7 12012.0 12140.8 12223.0 10980.6 10983.2 11277.5 11381.8 11768.1 3852.1 3880.8 3924.7 3947.9 3963.4 50396.7 50554.7 50669.2 51240.0 53073.5 9125.7 9258.8 9421.8 9438.1 9564.4 16949.0 17261.8 17267.6 17271.2 17639.2 6507.0 6580.7 6626.7 6657.5 6695.9 3547.4 3627.3 3638.2 3658.9 3675.1 2531.6 2609.6 2616.5 2616.7 2626.6 452.1 459.1 462.3 469.1 471.1 490.0 504.2 509.6 514.1 535.1 6566.4 6636.5 6681.9 6700.9 6725.8 444.6 506.4 512.7 531.6 535.8 3139.9 3200.5 3223.4 3305.4 3342.4 41272.9 50974.0 69752.0 74615.0 74619.0 36250.5 44750.8 61359.0 61526.7 62037.7 55495.7 56312.2 56426.0 56506.7 56859.1 6176.9 6383.8 6415.3 6549.0 6597.1 36759.2 38654.8 39311.4 39753.0 39911.4 46827.0 48785.0 52335.5 52673.0 55773.0 8741.7 8878.6 8907.4 8954.6 9365.0 9753.9 9786.9 9809.1 9830.6 9862.8 9077.5 9157.8 9421.4 9512.8 9701.3 9247.7 9261.2 9407.4 9475.8 9556.4 8950.4 9124.9 9194.1 9216.4 9250.9 7096.8 7422.6 7458.6 7630.3 7696.1 7018.3 7517.7 7877.1 7964.1 8148.1 13:58:46 INFO - PROCESS | 15269 | -------- Summary: end -------- 13:58:46 INFO - PROCESS | 15269 | 13:58:47 INFO - TEST-INFO | 15269: exit 0 13:58:47 INFO - TEST-OK | dromaeo_css | took 1122467ms 13:58:47 INFO - TEST-START | kraken 13:58:47 INFO - operating with platform_type : linux_ 13:58:47 INFO - Initialising browser for kraken test... 13:58:47 INFO - TEST-INFO | started process 15564 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5oJ7Mn/profile http://localhost:48404/getInfo.html) 13:58:52 INFO - PROCESS | 15564 | __metrics Screen width/height:1600/1200 13:58:52 INFO - PROCESS | 15564 | colorDepth:24 13:58:52 INFO - PROCESS | 15564 | Browser inner width/height: 1024/697 13:58:52 INFO - PROCESS | 15564 | __metrics 13:58:52 INFO - PROCESS | 15564 | 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" 13:58:52 INFO - PROCESS | 15564 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:58:53 INFO - PROCESS | 15564 | console.error: PushService: 13:58:53 INFO - PROCESS | 15564 | stateChangeProcessEnqueue: Error transitioning state 13:58:53 INFO - PROCESS | 15564 | UnknownError 13:58:54 INFO - TEST-INFO | 15564: exit 0 13:58:54 INFO - Browser initialized. 13:58:54 INFO - Running cycle 1/1 for kraken test... 13:58:54 INFO - TEST-INFO | started process 15645 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5oJ7Mn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:59:06 INFO - PROCESS | 15645 | RSS: Main: 175624192 13:59:06 INFO - PROCESS | 15645 | 13:59:09 INFO - PROCESS | 15645 | Cycle 1(1): loaded http://localhost:48404/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48404/tests/kraken/driver.html?testName=audio-beat-detection) 13:59:10 INFO - PROCESS | 15645 | RSS: Main: 236105728 13:59:10 INFO - PROCESS | 15645 | 13:59:13 INFO - PROCESS | 15645 | Cycle 1(1): loaded http://localhost:48404/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48404/tests/kraken/driver.html?testName=audio-dft) 13:59:13 INFO - PROCESS | 15645 | RSS: Main: 218984448 13:59:13 INFO - PROCESS | 15645 | 13:59:16 INFO - PROCESS | 15645 | Cycle 1(1): loaded http://localhost:48404/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48404/tests/kraken/driver.html?testName=audio-fft) 13:59:17 INFO - PROCESS | 15645 | RSS: Main: 299790336 13:59:17 INFO - PROCESS | 15645 | 13:59:19 INFO - PROCESS | 15645 | Cycle 1(1): loaded http://localhost:48404/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48404/tests/kraken/driver.html?testName=audio-oscillator) 13:59:20 INFO - PROCESS | 15645 | RSS: Main: 209338368 13:59:20 INFO - PROCESS | 15645 | 13:59:22 INFO - PROCESS | 15645 | Cycle 1(1): loaded http://localhost:48404/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48404/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:59:23 INFO - PROCESS | 15645 | RSS: Main: 215166976 13:59:23 INFO - PROCESS | 15645 | 13:59:26 INFO - PROCESS | 15645 | Cycle 1(1): loaded http://localhost:48404/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48404/tests/kraken/driver.html?testName=imaging-darkroom) 13:59:27 INFO - PROCESS | 15645 | RSS: Main: 254144512 13:59:27 INFO - PROCESS | 15645 | 13:59:30 INFO - PROCESS | 15645 | Cycle 1(1): loaded http://localhost:48404/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48404/tests/kraken/driver.html?testName=imaging-desaturate) 13:59:31 INFO - PROCESS | 15645 | RSS: Main: 249450496 13:59:31 INFO - PROCESS | 15645 | 13:59:34 INFO - PROCESS | 15645 | Cycle 1(1): loaded http://localhost:48404/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48404/tests/kraken/driver.html?testName=json-parse-financial) 13:59:34 INFO - PROCESS | 15645 | RSS: Main: 251252736 13:59:34 INFO - PROCESS | 15645 | 13:59:36 INFO - PROCESS | 15645 | Cycle 1(1): loaded http://localhost:48404/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48404/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:59:37 INFO - PROCESS | 15645 | RSS: Main: 214491136 13:59:37 INFO - PROCESS | 15645 | 13:59:38 INFO - PROCESS | 15645 | Cycle 1(1): loaded http://localhost:48404/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48404/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:59:39 INFO - PROCESS | 15645 | RSS: Main: 221810688 13:59:39 INFO - PROCESS | 15645 | 13:59:41 INFO - PROCESS | 15645 | Cycle 1(1): loaded http://localhost:48404/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48404/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:59:42 INFO - PROCESS | 15645 | RSS: Main: 230141952 13:59:42 INFO - PROCESS | 15645 | 13:59:45 INFO - PROCESS | 15645 | Cycle 1(1): loaded http://localhost:48404/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48404/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:59:46 INFO - PROCESS | 15645 | RSS: Main: 240013312 13:59:46 INFO - PROCESS | 15645 | 13:59:49 INFO - PROCESS | 15645 | Cycle 1(1): loaded http://localhost:48404/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48404/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:59:49 INFO - PROCESS | 15645 | RSS: Main: 235315200 13:59:49 INFO - PROCESS | 15645 | 13:59:51 INFO - PROCESS | 15645 | Cycle 1(1): loaded http://localhost:48404/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48404/tests/kraken/driver.html?testName=ai-astar) 13:59:51 INFO - PROCESS | 15645 | RSS: Main: 287367168 13:59:51 INFO - PROCESS | 15645 | 13:59:51 INFO - PROCESS | 15645 | __start_tp_report 13:59:51 INFO - PROCESS | 15645 | _x_x_mozilla_page_load 13:59:51 INFO - PROCESS | 15645 | _x_x_mozilla_page_load_details 13:59:51 INFO - PROCESS | 15645 | |i|pagename|runs| 13:59:51 INFO - PROCESS | 15645 | |0;ai-astar;110;115;115;118;116;115;116;116;114;116 13:59:51 INFO - PROCESS | 15645 | |1;audio-beat-detection;157;134;134;170;128;128;130;127;168;130 13:59:51 INFO - PROCESS | 15645 | |2;audio-dft;161;161;160;162;162;162;161;162;161;161 13:59:51 INFO - PROCESS | 15645 | |3;audio-fft;76;77;77;110;77;77;77;76;104;76 13:59:51 INFO - PROCESS | 15645 | |4;audio-oscillator;83;82;112;84;82;83;108;83;83;120 13:59:51 INFO - PROCESS | 15645 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;118;117;116 13:59:51 INFO - PROCESS | 15645 | |6;imaging-darkroom;146;148;147;146;146;146;146;147;147;147 13:59:51 INFO - PROCESS | 15645 | |7;imaging-desaturate;95;95;95;95;95;96;95;95;96;96 13:59:51 INFO - PROCESS | 15645 | |8;json-parse-financial;67;66;67;67;68;68;69;67;68;68 13:59:51 INFO - PROCESS | 15645 | |9;json-stringify-tinderbox;65;66;66;66;65;65;65;65;66;67 13:59:51 INFO - PROCESS | 15645 | |10;stanford-crypto-aes;86;84;85;84;84;84;85;85;91;84 13:59:51 INFO - PROCESS | 15645 | |11;stanford-crypto-ccm;157;157;155;141;136;143;144;146;206;151 13:59:51 INFO - PROCESS | 15645 | |12;stanford-crypto-pbkdf2;182;180;184;180;180;178;178;177;178;177 13:59:51 INFO - PROCESS | 15645 | |13;stanford-crypto-sha256-iterative;72;72;72;71;70;71;71;70;70;71 13:59:51 INFO - PROCESS | 15645 | __end_tp_report 13:59:51 INFO - PROCESS | 15645 | __start_cc_report 13:59:51 INFO - PROCESS | 15645 | _x_x_mozilla_cycle_collect,1988 13:59:51 INFO - PROCESS | 15645 | __end_cc_report 13:59:51 INFO - PROCESS | 15645 | __startTimestamp1479506391769__endTimestamp 13:59:51 INFO - PROCESS | 15645 | 13:59:51 INFO - PROCESS | 15645 | ------- Summary: start ------- 13:59:51 INFO - PROCESS | 15645 | Number of tests: 14 13:59:51 INFO - PROCESS | 15645 | 13:59:51 INFO - PROCESS | 15645 | [#0] ai-astar Cycles:10 Average:115.10 Median:116.00 stddev:2.08 (1.8%) stddev-sans-first:1.12 13:59:51 INFO - PROCESS | 15645 | Values: 110.0 115.0 115.0 118.0 116.0 115.0 116.0 116.0 114.0 116.0 13:59:51 INFO - PROCESS | 15645 | 13:59:51 INFO - PROCESS | 15645 | [#1] audio-beat-detection Cycles:10 Average:140.60 Median:134.00 stddev:17.32 (12.9%) stddev-sans-first:17.32 13:59:51 INFO - PROCESS | 15645 | Values: 157.0 134.0 134.0 170.0 128.0 128.0 130.0 127.0 168.0 130.0 13:59:51 INFO - PROCESS | 15645 | 13:59:51 INFO - PROCESS | 15645 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.67 (0.4%) stddev-sans-first:0.71 13:59:51 INFO - PROCESS | 15645 | Values: 161.0 161.0 160.0 162.0 162.0 162.0 161.0 162.0 161.0 161.0 13:59:51 INFO - PROCESS | 15645 | 13:59:51 INFO - PROCESS | 15645 | [#3] audio-fft Cycles:10 Average:82.70 Median:77.00 stddev:12.89 (16.7%) stddev-sans-first:13.45 13:59:51 INFO - PROCESS | 15645 | Values: 76.0 77.0 77.0 110.0 77.0 77.0 77.0 76.0 104.0 76.0 13:59:51 INFO - PROCESS | 15645 | 13:59:51 INFO - PROCESS | 15645 | [#4] audio-oscillator Cycles:10 Average:92.00 Median:83.00 stddev:15.01 (18.1%) stddev-sans-first:15.56 13:59:51 INFO - PROCESS | 15645 | Values: 83.0 82.0 112.0 84.0 82.0 83.0 108.0 83.0 83.0 120.0 13:59:51 INFO - PROCESS | 15645 | 13:59:51 INFO - PROCESS | 15645 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 13:59:51 INFO - PROCESS | 15645 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 118.0 117.0 116.0 13:59:51 INFO - PROCESS | 15645 | 13:59:51 INFO - PROCESS | 15645 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 13:59:51 INFO - PROCESS | 15645 | Values: 146.0 148.0 147.0 146.0 146.0 146.0 146.0 147.0 147.0 147.0 13:59:51 INFO - PROCESS | 15645 | 13:59:51 INFO - PROCESS | 15645 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 13:59:51 INFO - PROCESS | 15645 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 96.0 13:59:51 INFO - PROCESS | 15645 | 13:59:51 INFO - PROCESS | 15645 | [#8] json-parse-financial Cycles:10 Average:67.50 Median:68.00 stddev:0.85 (1.2%) stddev-sans-first:0.88 13:59:51 INFO - PROCESS | 15645 | Values: 67.0 66.0 67.0 67.0 68.0 68.0 69.0 67.0 68.0 68.0 13:59:51 INFO - PROCESS | 15645 | 13:59:51 INFO - PROCESS | 15645 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 13:59:51 INFO - PROCESS | 15645 | Values: 65.0 66.0 66.0 66.0 65.0 65.0 65.0 65.0 66.0 67.0 13:59:51 INFO - PROCESS | 15645 | 13:59:51 INFO - PROCESS | 15645 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:85.00 stddev:2.15 (2.5%) stddev-sans-first:2.26 13:59:51 INFO - PROCESS | 15645 | Values: 86.0 84.0 85.0 84.0 84.0 84.0 85.0 85.0 91.0 84.0 13:59:51 INFO - PROCESS | 15645 | 13:59:51 INFO - PROCESS | 15645 | [#11] stanford-crypto-ccm Cycles:10 Average:153.60 Median:153.00 stddev:19.74 (12.9%) stddev-sans-first:20.90 13:59:51 INFO - PROCESS | 15645 | Values: 157.0 157.0 155.0 141.0 136.0 143.0 144.0 146.0 206.0 151.0 13:59:51 INFO - PROCESS | 15645 | 13:59:51 INFO - PROCESS | 15645 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.40 Median:180.00 stddev:2.27 (1.3%) stddev-sans-first:2.20 13:59:51 INFO - PROCESS | 15645 | Values: 182.0 180.0 184.0 180.0 180.0 178.0 178.0 177.0 178.0 177.0 13:59:51 INFO - PROCESS | 15645 | 13:59:51 INFO - PROCESS | 15645 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:71.00 stddev:0.82 (1.1%) stddev-sans-first:0.78 13:59:51 INFO - PROCESS | 15645 | Values: 72.0 72.0 72.0 71.0 70.0 71.0 71.0 70.0 70.0 71.0 13:59:51 INFO - PROCESS | 15645 | -------- Summary: end -------- 13:59:51 INFO - PROCESS | 15645 | 13:59:53 INFO - TEST-INFO | 15645: exit 0 13:59:53 INFO - TEST-OK | kraken | took 65237ms 13:59:53 INFO - SUITE-END | took 1187s 13:59:53 INFO - Completed test suite (00:19:47) 13:59:53 INFO - javascript benchmark 13:59:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2531.658226139471, 2556.3736884463306, 2565.1022142250204, 2593.2090712332742, 2606.022741471947, 4369.0, 4459.620932220765, 4499.032707967786, 4505.594496495319, 4510.729356238628, 4384.276594361926, 4418.955810441895, 4429.601335879778, 4454.710443821149, 4455.376247325377, 4106.28140075487, 4128.752274863503, 4155.522114956773, 4158.251514727348, 4227.175700738358, 3874.036831835464, 4195.4545909031785, 4216.430781844458, 4239.08859595187, 4273.316269396897, 4069.186162767429, 4104.322786740185, 4185.372194170868, 4231.069164783743, 4251.574842515754, 4154.480689913761, 4155.189738001091, 4167.395727619478, 4173.061061261223, 4176.7076304658685, 4083.0404854859084, 4132.690048246363, 4146.730462519927, 4149.045719484505, 4153.480814898137, 4457.732536047847, 4466.754328511931, 4483.0, 4530.932036019462, 4551.112533056055, 4795.040991801654, 4797.9520204797855, 4800.95199048012, 4814.15752243356, 4847.95152048482, 4565.56627120423, 4600.17196904557, 4818.831340903087, 4847.636427267969, 4879.853604391838, 4378.584034516716, 4432.113577284524, 4484.529124441952, 4484.663650226181, 4551.726896386162, 4893.412790465167, 4894.779734911937, 4898.044881248194, 4899.657024008286, 4949.356583644175, 4678.742669153161, 4709.976450117728, 4717.882052948704, 4723.716577005391, 4772.0694464579765, 4619.95380046202, 4635.258358662598, 4659.021605462891, 4669.743164125938, 4670.8365207217585, 4658.0, 4674.649401294916, 4681.297805329228, 4687.226607609706, 4688.320193571913, 4605.447346318463, 4643.95356046442, 4648.163330600457, 4671.766411679402, 4689.577937985598, 3886.1839013807416, 3935.6064393560414, 3943.38877473992, 3950.6246906543834, 3972.245273398045, 3476.4263896457305, 3530.841112149908, 3536.469529570585, 3555.7866528008403, 3565.0196196046295, 4105.220008198433, 4114.115465174942, 4135.60711732385, 4136.400221967798, 4144.254034273799, 4691.5308469152815, 4701.200795864711, 4707.082118986833, 4714.717116972924, 4716.3868697069165, 4143.772092534879, 4152.91694166121, 4152.958470415318, 4154.688398370135, 4158.9376159357635, 4140.855070072533, 4203.264428725022, 4206.221848957953, 4207.221663992172, 4210.305299625588, 4530.365748795171, 4535.138323718483, 4536.183486972377, 4543.227651299287, 4544.477385100756, 4740.288956656529, 4749.35883655702, 4760.833370832004, 4790.257510085942, 4798.328234047166, 4587.908241835212, 4589.5410458955175, 4597.517260687579, 4599.080183963154, 4650.139724151043, 4471.8658440246845, 4491.865244042684, 4497.8200871964755, 4623.283391074388, 4687.601553867823, 4714.175019371528, 4752.453467851241, 4759.6430267729365, 4801.063792560417, 4806.7836947336755, 4623.329617205419, 4628.467726211394, 4638.466576343763, 4641.234196357698, 4702.318163866152, 4461.152381047591, 4506.526814684411, 4634.76826158684, 4644.187267228289, 4671.976640116778, 4495.21333766596, 4505.909881802411, 4513.300438432048, 4525.253333199985, 4526.8189272428735, 4618.399608050931, 4629.490756016903, 4660.953390466188, 4715.434147902273, 4722.858314250578, 4485.48416932057, 4504.729716217037, 4522.344260082204, 4538.228501154746, 4579.0], "value": 4373.309861519325, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.7844151560134, 556.95822813289, 564.8136115082024, 565.3554947360008, 576.7174084698499, 27526.724732752667, 30246.848765756167, 37558.812205939, 38544.61455385445, 38724.41913371302, 38554.421683674766, 38946.61053389465, 39009.0, 39011.21977560447, 39068.80465597675, 7588.354989825858, 7743.496672716284, 7746.961265193666, 7749.263819937097, 7755.302022817945, 7665.8850117248285, 7748.41886858485, 7752.728654497094, 7757.379409647243, 7759.262870027338, 7743.728969486069, 7804.726834560792, 7806.180351063142, 7806.492577982442, 7808.1801410851895, 7717.421193410489, 7770.184130666255, 7773.0, 7778.1055178654615, 7778.222177782233, 7603.885941710879, 7660.042494688164, 7664.3102120808835, 7668.731594394169, 7668.846623067508, 37067.814660926524, 37165.62834371676, 37252.25495490075, 37313.0, 37394.0, 2826.0, 2903.7096290371005, 2980.8658610362368, 3031.3028003559084, 3169.0334447993355, 27978.0, 28152.718472815213, 28225.294367640767, 28734.568981465294, 29242.85378573115, 3366.0, 3371.089805752458, 3375.0718552398043, 3421.298633780069, 3552.609212986569, 243638.0, 244247.0, 244279.0, 244532.0, 244714.0, 51141.74429127905, 51335.989482050645, 51438.48561514412, 51476.22785658218, 51499.0, 54286.45713542814, 58489.0, 59879.0, 59987.70006150028, 60029.399706003256, 13294.3352832358, 13476.797848032287, 13476.93261533686, 13949.58151255464, 13956.371963261678, 10162.491875406347, 10170.135538479311, 10197.898021019695, 10212.540435680412, 10386.844197337046, 18338.724919126224, 18850.15174317159, 18932.81067189338, 18955.81044189568, 18969.81030189708, 7060.435165186773, 7125.750598729123, 7185.820354491179, 7345.632718364061, 7423.62881855905, 785.3128512551517, 844.8690452979798, 869.9304055675531, 892.7321803458937, 906.8095699902963, 26853.865730671223, 26976.865115674296, 27463.313417164332, 27587.44825103527, 27978.0, 888.9333300002396, 917.6696389299847, 922.3727865051695, 941.7174847545709, 1041.729150420896, 13933.721325573635, 14658.633534161518, 14779.408823646934, 14940.0, 15010.324535395934, 355763.0, 359371.0, 360176.0, 360215.0, 360669.0, 49022.75488622534, 49438.75280623574, 49556.25665615019, 49582.752086239336, 49888.75055624771, 1040.7502199472071, 1101.9338839669485, 1103.1395511501041, 1170.4381896689636, 1172.0740614914293, 26803.597946030433, 28532.144035678964, 29907.70092299049, 31560.684393155774, 32106.678933211304, 46718.0, 47636.2854557175, 47700.522994770996, 47703.28445073396, 47713.76143119401, 316310.0, 317756.0, 317985.0, 319052.0, 322369.0, 36731.44902826513, 38214.6178538211, 38222.42666360062, 38237.0, 38280.42579361256, 40737.38893916653, 41032.0, 41262.58737412588, 42139.7893010533, 42228.155436891706, 35607.465888012215, 35734.8213258932, 35801.10497237486, 35979.82010089933, 36076.09809754777, 35276.647233527336, 35326.47010294796, 35724.28551429009, 36166.819165904, 37097.629023709414, 29284.560731588615, 32122.357552848345, 32923.0, 35606.821965890005, 36090.0, 30436.543451847796, 32574.511382329758, 32595.0, 32784.50823237701, 33069.66930330666, 24642.753572464047, 25139.74301284965, 25183.37041573975, 25505.48989020246, 25825.354366140244], "value": 17448.001429693264, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.31218597039197, 342.3802916720735, 343.56367413385004, 346.13121066124023, 348.49642266924303, 15584.610384740387, 15661.608459788496, 17037.57406064849, 17055.31778728851, 17100.315987360522, 13687.863121368784, 13864.445422183126, 15357.078575285463, 15446.304916278767, 15468.767968480483, 4768.976155119228, 4775.641826862981, 4793.5925446337105, 4822.204336284509, 4999.425066117388, 4813.061453016663, 4904.337914381548, 4908.631852611068, 4912.410510738699, 4914.606831453475, 4656.674032817704, 4827.0, 4863.100326439602, 4865.321464094882, 4877.780499877514, 4782.569568738812, 4795.6882802618065, 4817.927731084019, 4820.903581928342, 4868.464468908417, 4108.322126849066, 4257.0, 4262.2754131797665, 4263.0, 4264.9147017059795, 19480.70778938317, 19514.70727939082, 19586.474434601765, 19794.604107917905, 19848.603027939505, 1754.97367539487, 1785.8214178582039, 1839.6320735852748, 2031.2179810772811, 2250.313654335427, 12080.335581543099, 12751.553695620609, 12821.0, 13196.538121165713, 13379.26414047227, 1582.8179759327709, 1646.6377396972646, 1649.6971259182794, 1707.641395306987, 1749.9037552934583, 65241.67379163121, 66005.0, 66691.333086669, 67425.3257467424, 69321.0, 8425.452345597516, 8452.154784521621, 8652.3510736695, 8881.24509416694, 9045.366824322235, 11832.112591555668, 11867.643970680894, 11878.227915185485, 11886.0, 11900.107491937966, 6878.58728476293, 7006.719731210796, 7050.506464547535, 7194.316539928698, 7201.099862517185, 6463.838404039842, 6515.902261466082, 6664.833379165462, 6669.499787515956, 6702.798916032527, 5751.9137212941005, 5776.451237132465, 5805.158252053428, 5808.3901190375245, 5989.940100599026, 1501.9849801502064, 1551.2476448922264, 1565.5381662409616, 1573.244842475618, 1603.5670369000538, 806.7575933063134, 817.8650522663813, 825.1665817524344, 832.9708460203864, 917.3899356927568, 16352.509424717278, 16537.91731041337, 16814.91592542054, 17567.73648395275, 17581.7362739559, 834.9916500834914, 861.9310455163571, 869.9391042627082, 884.7699598104539, 902.7788191893028, 9284.814303714023, 9653.372530785477, 9704.175145112744, 9777.41335519871, 10088.44513551747, 366708.0, 367544.0, 380888.0, 384341.0, 385299.0, 61255.0, 64497.0, 64965.350346496874, 65243.67378163079, 65393.346066538725, 916.2715641065369, 944.9480278584743, 977.2524019125375, 978.7944531648291, 980.1032055669126, 14905.0, 14984.167446677016, 15029.699406012038, 15531.922340388677, 15592.610184745472, 31794.84102579472, 32661.34677306488, 33621.66378336185, 33907.83046084754, 35357.292854143285, 42655.360169598105, 43230.783846080565, 43476.95661303678, 44733.77633111813, 45644.54355456536, 7023.68393422287, 7122.197398867099, 7132.251113632994, 7210.783676489714, 7374.151972523228, 11277.32336059839, 11731.530738770694, 12036.518539258332, 12122.09084318662, 12154.939225303817, 10185.0, 10624.150067994697, 10667.839982400425, 10771.569137234423, 11018.559257629606, 6810.761623343159, 6850.246472887879, 7138.571685698875, 7169.820754481179, 7700.0, 6925.168979722465, 7248.746293879689, 7416.814579635552, 7455.888161677471, 7478.813029674302, 10246.692599222035, 10841.839272567859, 11091.0, 11132.777344453227, 11411.657650270505, 10825.350478971286, 10962.671119866416, 11389.373584452604, 11639.301641901513, 11694.88305116972], "value": 7856.775768686755, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1168.76624675065, 1290.2645492069519, 1313.4680454415961, 1345.8990575706825, 1567.192895658736, 5754.223179870722, 6353.142325786018, 6564.967175164124, 6570.540062195648, 6727.024581435689, 6516.837079073026, 6569.113169722086, 6571.671416429183, 6578.9013164802445, 6581.90127148092, 1990.940271791845, 2031.5733695923873, 2032.278541117904, 2032.3090149349218, 2033.6237796007713, 1964.9607007859834, 1995.8403327733747, 2001.6997450382414, 2009.2867032203576, 2011.8692285001428, 1967.2327792161068, 1972.447714639903, 1998.2906068345746, 1999.5001249687577, 2000.0599718132528, 1941.1652989214633, 1955.9706604400944, 1957.0508303472805, 1957.9902100489478, 1959.2750682247517, 1948.0844003318418, 1956.2566224834472, 1962.1170473286936, 1982.7918068602878, 1983.1769815526538, 6534.509911756637, 6543.803685889383, 6618.073469714244, 6629.171353580802, 6632.801015969529, 3923.4899463069905, 4114.835406583733, 4117.711760176789, 4139.8965025874295, 4150.813213405404, 2587.386739393208, 2732.1120635793445, 2778.7776977841722, 2794.8602569871628, 2796.9720302796914, 848.6902280667512, 853.5433543054498, 858.0304256190527, 865.7489328094845, 898.9841479128543, 8380.790480237982, 8467.195616416431, 8482.36382271326, 8487.575621218975, 8495.74512764618, 3253.430649636304, 3495.1961048958374, 3551.3785087609567, 3566.8751593694615, 3569.7858128511853, 6962.060121883481, 6965.547239429421, 6970.721171153198, 6973.442124630017, 6977.092977912839, 3967.1668949520345, 4005.6581045349553, 4010.0, 4012.7792971386853, 4013.2174226026227, 3280.6555311692405, 3384.2554637979606, 3654.744167908221, 3762.360398732222, 3764.1154328732728, 2834.588984597222, 2859.2994716294643, 2956.1427186116216, 2957.06852341516, 2971.6136902203007, 859.8710193470904, 860.6471346747928, 870.0, 875.1467319363696, 878.8198419324024, 789.1083076123944, 799.5003123048095, 801.3629164813987, 811.0996793559144, 811.4806523824757, 4480.14877173336, 4541.091781643684, 4568.497465278817, 4646.628269738413, 4851.151048566487, 363.8271820885058, 372.9403295472711, 376.5744708479455, 379.1828609346862, 379.9392097264466, 3231.0952933178746, 3246.1722260823813, 3273.8035717857006, 3279.8524066417067, 3351.0784534253276, 7520.247975202436, 7890.802729931797, 7909.406794490436, 7916.881246781303, 7927.603619818986, 7883.881741773878, 7895.763127106196, 7899.447038707351, 7904.84190316202, 7905.130435652074, 6161.784337548164, 6217.782377616762, 6225.564210505221, 6226.159468471698, 6241.7191226394925, 4530.093981203839, 4654.2785868190485, 4677.064587082529, 4716.905661886674, 4734.976325118352, 7199.676014579251, 7206.495545311778, 7323.157836848831, 7391.6304184791625, 7393.297636724503, 7257.52826066304, 7419.851602967802, 7444.367228785614, 7452.180260171485, 7494.662740176815, 5460.972695136499, 5463.0, 5468.7539060741565, 5514.641548299348, 5539.667619942817, 6202.937970620236, 6265.216847894013, 6273.090401891609, 6275.717592708431, 6278.0, 5728.455796699307, 5849.181114644039, 5854.326752423526, 5874.0, 5900.468957793819, 5720.170575266647, 5728.513076388554, 5798.159266906359, 5814.476697097281, 5852.18069470283, 5248.3701955765555, 5374.758135883816, 5377.838664840061, 5490.313710786152, 5502.422245664307, 3858.4405261237525, 3950.0717331426517, 3953.6244056814558, 3964.524257089168, 3964.6431821135084, 4002.519697636302, 4062.370332598452, 4160.771157586361, 4164.312888373384, 4185.162967406592], "value": 3496.0500425221385, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [275.2979901251807, 277.45203223633325, 281.149522693851, 281.9483327189584, 282.7709555260238, 4629.444466664001, 4629.930551041729, 4639.327297541863, 4647.44230692317, 4698.718076915383, 4567.703099298552, 4582.564656357649, 4584.977075114628, 4596.448426188854, 4604.631629469643, 3406.914827129317, 3482.89551313461, 3520.524729161556, 3596.4425514045233, 3639.2357604903004, 3600.5859326177433, 3611.0791748104198, 3617.981910090446, 3620.583632882226, 3646.3436581415335, 3375.6961873431387, 3585.9282814343696, 3592.0, 3598.2263813280138, 3598.6401359864067, 3483.982580087096, 3522.718182545403, 3568.125809176742, 3575.785452872836, 3619.9728152234834, 3168.0, 3181.284211052495, 3188.4260833050043, 3190.8512935343256, 3207.4547326954475, 4458.598726114666, 4467.664925130628, 4482.394876691637, 4482.843100491467, 4506.233940230136, 3975.403689446577, 4086.6934979876332, 4094.7715685294293, 4108.383742438628, 4109.8972525686795, 4727.361806156159, 4755.738434386108, 4763.833265835679, 4776.188048031843, 4776.5701086902345, 3465.3589086018915, 3466.843992020365, 3467.2025434150037, 3479.9826000869834, 3487.0995307557187, 4829.251466022772, 4972.87567810804, 5007.899842003176, 5034.647574669774, 5056.317397151374, 3534.929301413957, 3550.6626870447267, 3560.8041557714573, 3566.8751593694096, 3573.76770509916, 3628.582712987987, 3629.4011488104693, 3629.764065335745, 3630.0, 3641.2353405785084, 4045.130296986162, 4097.528784189797, 4098.221337945781, 4101.692373072032, 4124.628783409507, 4540.704854184468, 4780.569748722632, 4845.0, 4852.320675105488, 4856.368672072608, 1195.2231049817688, 1217.31221859649, 1217.3748046358035, 1218.250775772911, 1219.3537425164677, 774.7023735243445, 791.2404092071561, 833.2087506851997, 845.8858054162732, 846.3821410370464, 4244.72409293395, 4357.716748411343, 4365.236083685342, 4365.628921541641, 4381.7151885128005, 4949.752512374367, 4955.4796746341835, 4964.2305442655725, 4989.600831933437, 4989.750512474362, 4346.891327716832, 4347.913041739147, 4370.213361594943, 4376.693631445832, 4390.473143222834, 2448.9551224727197, 2568.4349443122483, 2573.5073657278735, 2577.755113264237, 2580.3033181041014, 4659.34593219409, 4665.346851440801, 4666.4633567139535, 4671.18254305502, 4671.32265821454, 4761.881288172654, 4909.0, 4915.837031706038, 4921.630877684188, 4931.58081563064, 4571.611413029929, 4592.862214133581, 4605.4933957264675, 4616.422947131608, 4622.86131416058, 4752.5485078917445, 4759.857204283877, 4761.285807128958, 4776.188048031773, 4779.713217206979, 4647.209974304444, 4677.368555245134, 4687.906241875212, 4709.929351059668, 4711.905761884812, 4379.934300985424, 4550.567696068868, 4568.81724731007, 4572.88567785808, 4596.172688916027, 3284.802911825298, 3323.883664071746, 3361.1261072120938, 3362.882299119519, 3379.6620337966006, 4810.302506136521, 4813.5186481352985, 4815.855524334275, 4836.371271734793, 4840.757962101951, 4439.977800111108, 4630.467496237841, 4671.532846715301, 4682.367880336111, 4682.635269189174, 4637.466691330405, 4670.813167473263, 4675.906481870412, 4685.344051832678, 4695.624350052056, 4557.658175636907, 4598.724076555417, 4607.111084455491, 4608.700434471749, 4618.214903466486, 4423.955760442354, 4613.261878099488, 4690.906181876411, 4727.338172655762, 4772.76136193182, 4691.648126390466, 4701.224297990793, 4708.717476951257, 4714.693544919569, 4726.3146843708155], "value": 3597.4242593581016, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [642.2613993907007, 671.5165081141579, 704.6723273677738, 729.8686236477432, 739.0835364148458, 11944.522219111235, 12786.552470663528, 12996.805047924288, 13012.674683132915, 13026.413811378487, 11702.473388697508, 12009.519619215222, 12074.0, 12083.154179207459, 12098.637040888787, 603.6770327874588, 621.8538643418793, 736.2269616902245, 738.4092725819349, 770.0066913681344, 749.9100107987049, 760.3574979142616, 760.6196901549225, 760.9277118673717, 760.9315161635452, 806.5160903457937, 811.7402431222012, 812.2689579378548, 812.3054788156101, 813.0081300812999, 631.9526035547352, 650.3626446082865, 777.2033665492859, 797.7168105322585, 798.8242586630961, 588.167742644158, 591.3967752892027, 592.8754961458098, 593.0659211741481, 593.4125216036136, 12194.329311887843, 12198.329091899943, 12211.0, 12235.143539952207, 12269.693257668541, 11633.825492617618, 11784.705382365424, 12012.0, 12140.817887731691, 12223.0, 10980.615678451295, 10983.176261780318, 11277.548898044068, 11381.772364552662, 11768.117391195608, 3852.0947577319307, 3880.8447662093763, 3924.7056470764805, 3947.921041579152, 3963.365861462152, 50396.74801626005, 50554.747226264, 50669.239961400606, 51239.975200496156, 53073.46926530763, 9125.680601178927, 9258.814823703487, 9421.811563768686, 9438.056194380508, 9564.378315409476, 16949.0, 17261.827381726274, 17267.568310792078, 17271.222794974256, 17639.206235719423, 6507.0, 6580.736770529221, 6626.734930602818, 6657.500687448364, 6695.899561506581, 3547.414676578387, 3627.3108109459117, 3638.199596088856, 3658.8719394821055, 3675.0628589709454, 2531.5949448088586, 2609.647697560843, 2616.489784492044, 2616.6859976802907, 2626.5797472404324, 452.1048324317869, 459.0726732001405, 462.29500012480565, 469.061876247505, 471.14252061248885, 489.97060176389533, 504.18825690638045, 509.55159459675247, 514.0669684522579, 535.1197280473676, 6566.388337042724, 6636.502262330248, 6681.866362672719, 6700.932990670129, 6725.798226053226, 444.5732097186672, 506.38474253781834, 512.7231295100678, 531.6012990257307, 535.823178351151, 3139.8901038464, 3200.5274277408807, 3223.3714425686767, 3305.388503126929, 3342.364950659367, 41272.93635318282, 50974.0, 69752.0, 74615.0, 74619.0, 36250.456243156375, 44750.77624611856, 61359.0, 61526.69236653788, 62037.68981155156, 55495.722521387135, 56312.155317670266, 56426.0, 56506.7174664124, 56859.14711279334, 6176.8764624706355, 6383.808485745435, 6415.294317625151, 6548.967255163694, 6597.1423714916755, 36759.22130123067, 38654.80672596619, 39311.41032884566, 39753.0, 39911.40132898067, 46827.0, 48785.0, 52335.47664523306, 52673.0, 55773.0, 8741.694040708799, 8878.600462979311, 8907.376483646083, 8954.552272386225, 9365.0, 9753.9024609753, 9786.85319720219, 9809.117179453884, 9830.606775728891, 9862.802743944938, 9077.500737459502, 9157.771055723393, 9421.387609805615, 9512.809743804946, 9701.272404569827, 9247.72256832296, 9261.212796912068, 9407.43555386679, 9475.763105922408, 9556.378835375679, 8950.418222815497, 9124.908750912671, 9194.12655797698, 9216.400933939272, 9250.907490925005, 7096.78709638691, 7422.608868069368, 7458.589777562286, 7630.2751238632245, 7696.076470823537, 7018.263082376481, 7517.699292028257, 7877.133515313197, 7964.058212222954, 8148.144444833207], "value": 5704.110595204043, "unit": "score"}], "name": "dromaeo_css", "value": 5919.290340218396, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 115.0, 115.0, 118.0, 116.0, 115.0, 116.0, 116.0, 114.0, 116.0], "value": 115.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 134.0, 134.0, 170.0, 128.0, 128.0, 130.0, 127.0, 168.0, 130.0], "value": 140.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 162.0, 162.0, 162.0, 161.0, 162.0, 161.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 110.0, 77.0, 77.0, 77.0, 76.0, 104.0, 76.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 112.0, 84.0, 82.0, 83.0, 108.0, 83.0, 83.0, 120.0], "value": 92.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 67.0, 68.0, 68.0, 69.0, 67.0, 68.0, 68.0], "value": 67.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 65.0, 65.0, 65.0, 65.0, 66.0, 67.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 85.0, 84.0, 84.0, 84.0, 85.0, 85.0, 91.0, 84.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 157.0, 155.0, 141.0, 136.0, 143.0, 144.0, 146.0, 206.0, 151.0], "value": 153.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 180.0, 184.0, 180.0, 180.0, 178.0, 178.0, 177.0, 178.0, 177.0], "value": 179.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 72.0, 71.0, 70.0, 71.0, 71.0, 70.0, 70.0, 71.0], "value": 71.0, "unit": "score"}], "name": "kraken", "value": 1572.8, "alertThreshold": 2.0}]} 13:59:53 INFO - Return code: 0 13:59:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:59:53 INFO - # TBPL SUCCESS # 13:59:53 INFO - Running post-action listener: _resource_record_post_action 13:59:53 INFO - [mozharness: 2016-11-18 21:59:53.589925Z] Finished run-tests step (success) 13:59:53 INFO - Running post-run listener: _resource_record_post_run 13:59:53 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 400510976; Read time: 12; Write time: 313656 13:59:53 INFO - TinderboxPrint: CPU usage
13.1% 13:59:53 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 13:59:53 INFO - TinderboxPrint: I/O write bytes / time
400,510,976 / 313,656 13:59:53 INFO - TinderboxPrint: CPU idle
8,348.5 (86.9%) 13:59:53 INFO - TinderboxPrint: CPU user
1,207.7 (12.6%) 13:59:53 INFO - TinderboxPrint: Swap in / out
0 / 0 13:59:53 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110342144; Read time: 0; Write time: 76712 13:59:53 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 290168832; Read time: 0; Write time: 236944 13:59:54 INFO - Running post-run listener: _upload_blobber_files 13:59:54 INFO - Blob upload gear active. 13:59:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:59:54 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 13:59:54 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:59:54 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:59:54 INFO - (blobuploader) - INFO - Open directory for files ... 13:59:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:59:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:59:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:59:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:59:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:59:57 INFO - (blobuploader) - INFO - Done attempting. 13:59:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:59:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:59:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:59:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:59:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:59:58 INFO - (blobuploader) - INFO - Done attempting. 13:59:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:59:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:59:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:59:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:59:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:59:59 INFO - (blobuploader) - INFO - Done attempting. 13:59:59 INFO - (blobuploader) - INFO - Iteration through files over. 13:59:59 INFO - Return code: 0 13:59:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:59:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:59:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/62d28d8027e9c94ba374bafa5050a46531ce80a9339a59fb1cc0966ee7cf07599a456ba7a6ff66a9f7538b7ccf13f6e5f22446c93672c4e256e6d1fbb0684ec0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9d9347eb92a1c5bbfe891152864d486da2361074a0cf75b22f79cfd7745f1e9c2765f8dd654da5a383367d3b8fb5023d01d5f824c014762c80370c64bf03592d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d66031b0ec8baa37959035d108e8604ad34950c16702f8b3c2652c0467c9500685ce171a5d88f000fa3a0e19a4cd41dd3bb03b86a147fe2cea31d284c1efe209"} 13:59:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:59:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:59:59 INFO - Contents: 13:59:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/62d28d8027e9c94ba374bafa5050a46531ce80a9339a59fb1cc0966ee7cf07599a456ba7a6ff66a9f7538b7ccf13f6e5f22446c93672c4e256e6d1fbb0684ec0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9d9347eb92a1c5bbfe891152864d486da2361074a0cf75b22f79cfd7745f1e9c2765f8dd654da5a383367d3b8fb5023d01d5f824c014762c80370c64bf03592d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d66031b0ec8baa37959035d108e8604ad34950c16702f8b3c2652c0467c9500685ce171a5d88f000fa3a0e19a4cd41dd3bb03b86a147fe2cea31d284c1efe209"} 13:59:59 INFO - Running post-run listener: copy_logs_to_upload_dir 13:59:59 INFO - Copying logs to upload dir... 13:59:59 INFO - mkdir: /builds/slave/test/build/upload/logs 13:59:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.182651 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-11-18 13:59:59.066662) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 13:59:59.069929) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1479505004.648094-486468445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/62d28d8027e9c94ba374bafa5050a46531ce80a9339a59fb1cc0966ee7cf07599a456ba7a6ff66a9f7538b7ccf13f6e5f22446c93672c4e256e6d1fbb0684ec0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9d9347eb92a1c5bbfe891152864d486da2361074a0cf75b22f79cfd7745f1e9c2765f8dd654da5a383367d3b8fb5023d01d5f824c014762c80370c64bf03592d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d66031b0ec8baa37959035d108e8604ad34950c16702f8b3c2652c0467c9500685ce171a5d88f000fa3a0e19a4cd41dd3bb03b86a147fe2cea31d284c1efe209"} build_url:https://queue.taskcluster.net/v1/task/CV7p2hPaQte1jY8FKm_f1Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011743 build_url: 'https://queue.taskcluster.net/v1/task/CV7p2hPaQte1jY8FKm_f1Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/62d28d8027e9c94ba374bafa5050a46531ce80a9339a59fb1cc0966ee7cf07599a456ba7a6ff66a9f7538b7ccf13f6e5f22446c93672c4e256e6d1fbb0684ec0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9d9347eb92a1c5bbfe891152864d486da2361074a0cf75b22f79cfd7745f1e9c2765f8dd654da5a383367d3b8fb5023d01d5f824c014762c80370c64bf03592d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d66031b0ec8baa37959035d108e8604ad34950c16702f8b3c2652c0467c9500685ce171a5d88f000fa3a0e19a4cd41dd3bb03b86a147fe2cea31d284c1efe209"}' ========= master_lag: 0.79 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 13:59:59.869666) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 13:59:59.869960) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1479505004.648094-486468445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004542 ========= master_lag: 0.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 13:59:59.900002) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 13:59:59.900277) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 13:59:59.900538) ========= ========= Total master_lag: 0.89 =========