builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-045 starttime: 1478802116.95 results: success (0) buildid: 20161110073137 builduid: 6fa4ed4caf8b4ab2881acf4422011b74 revision: d2e33428e45718bbeff192e80fd3a75ad264210d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-10 10:21:56.951143) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-10 10:21:56.951731) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-10 10:21:56.952007) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-10 10:21:56.963153) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 10:21:56.963426) ========= 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=4300f881736b422476174874000001bc-1478802116.540826-738079626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-10 10:21:57-- 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% 46.0M=0s 2016-11-10 10:21:57 (46.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.065872 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 10:21:57.040622) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 10:21:57.040954) ========= 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=4300f881736b422476174874000001bc-1478802116.540826-738079626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016883 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 10:21:57.090051) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 10:21:57.090419) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d2e33428e45718bbeff192e80fd3a75ad264210d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev d2e33428e45718bbeff192e80fd3a75ad264210d --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=4300f881736b422476174874000001bc-1478802116.540826-738079626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-10 10:21:57,467 truncating revision to first 12 chars 2016-11-10 10:21:57,467 Setting DEBUG logging. 2016-11-10 10:21:57,467 attempt 1/10 2016-11-10 10:21:57,467 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d2e33428e457?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-10 10:21:57,823 unpacking tar archive at: mozilla-central-d2e33428e457/testing/mozharness/ program finished with exit code 0 elapsedTime=0.662320 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 10:21:57.766931) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-10 10:21:57.767274) ========= script_repo_revision: d2e33428e45718bbeff192e80fd3a75ad264210d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-10 10:21:57.767662) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-10 10:21:57.767927) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-10 10:21:57.776571) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-11-10 10:21:57.776887) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=4300f881736b422476174874000001bc-1478802116.540826-738079626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:21:58 INFO - MultiFileLogger online at 20161110 10:21:58 in /builds/slave/test 10:21:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:21:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:21:58 INFO - {'append_to_log': False, 10:21:58 INFO - 'base_work_dir': '/builds/slave/test', 10:21:58 INFO - 'blob_upload_branch': 'Firefox', 10:21:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:21:58 INFO - 'branch': 'Firefox', 10:21:58 INFO - 'buildbot_json_path': 'buildprops.json', 10:21:58 INFO - 'config_files': ('talos/linux_config.py',), 10:21:58 INFO - 'default_actions': ('clobber', 10:21:58 INFO - 'read-buildbot-config', 10:21:58 INFO - 'download-and-extract', 10:21:58 INFO - 'populate-webroot', 10:21:58 INFO - 'create-virtualenv', 10:21:58 INFO - 'install', 10:21:58 INFO - 'run-tests'), 10:21:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:21:58 INFO - 'download_minidump_stackwalk': True, 10:21:58 INFO - 'download_symbols': 'ondemand', 10:21:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:21:58 INFO - 'tooltool.py': '/tools/tooltool.py', 10:21:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:21:58 INFO - '/tools/misc-python/virtualenv.py')}, 10:21:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:21:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:21:58 INFO - 'installer_path': 'installer.exe', 10:21:58 INFO - 'log_level': 'info', 10:21:58 INFO - 'log_name': 'talos', 10:21:58 INFO - 'log_to_console': True, 10:21:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:21:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:21:58 INFO - 'opt_config_files': (), 10:21:58 INFO - 'pip_index': False, 10:21:58 INFO - 'sps_profile': False, 10:21:58 INFO - 'sps_profile_interval': 0, 10:21:58 INFO - 'suite': 'dromaeojs', 10:21:58 INFO - 'system_bits': '32', 10:21:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:21:58 INFO - 'title': 'talos-linux64-ix-045', 10:21:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:21:58 INFO - 'use_talos_json': True, 10:21:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:21:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:21:58 INFO - 'work_dir': 'build'} 10:21:58 INFO - [mozharness: 2016-11-10 18:21:58.249707Z] Running clobber step. 10:21:58 INFO - Running pre-action listener: _resource_record_pre_action 10:21:58 INFO - Running main action method: clobber 10:21:58 INFO - rmtree: /builds/slave/test/build 10:21:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:21:58 INFO - Running post-action listener: _resource_record_post_action 10:21:58 INFO - [mozharness: 2016-11-10 18:21:58.764060Z] Finished clobber step (success) 10:21:58 INFO - [mozharness: 2016-11-10 18:21:58.764161Z] Running read-buildbot-config step. 10:21:58 INFO - Running pre-action listener: _resource_record_pre_action 10:21:58 INFO - Running main action method: read_buildbot_config 10:21:58 INFO - Using buildbot properties: 10:21:58 INFO - { 10:21:58 INFO - "project": "", 10:21:58 INFO - "product": "firefox", 10:21:58 INFO - "script_repo_revision": "production", 10:21:58 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:21:58 INFO - "repository": "", 10:21:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 10:21:58 INFO - "buildid": "20161110073137", 10:21:58 INFO - "pgo_build": "True", 10:21:58 INFO - "basedir": "/builds/slave/test", 10:21:58 INFO - "buildnumber": 76, 10:21:58 INFO - "slavename": "talos-linux64-ix-045", 10:21:58 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:21:58 INFO - "platform": "ubuntu64_hw", 10:21:58 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:21:58 INFO - "branch": "mozilla-central", 10:21:58 INFO - "repo_path": "mozilla-central", 10:21:58 INFO - "revision": "d2e33428e45718bbeff192e80fd3a75ad264210d", 10:21:58 INFO - "stage_platform": "linux64-pgo", 10:21:58 INFO - "builduid": "6fa4ed4caf8b4ab2881acf4422011b74", 10:21:58 INFO - "slavebuilddir": "test" 10:21:58 INFO - } 10:21:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/HnyHyHa4Tam-EWg24SDqAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 10:21:58 INFO - Running post-action listener: _resource_record_post_action 10:21:58 INFO - [mozharness: 2016-11-10 18:21:58.766628Z] Finished read-buildbot-config step (success) 10:21:58 INFO - [mozharness: 2016-11-10 18:21:58.766718Z] Running download-and-extract step. 10:21:58 INFO - Running pre-action listener: _resource_record_pre_action 10:21:58 INFO - Running main action method: download_and_extract 10:21:58 INFO - mkdir: /builds/slave/test/build/tests 10:21:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:21:58 INFO - trying https://queue.taskcluster.net/v1/task/HnyHyHa4Tam-EWg24SDqAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:21:58 INFO - Downloading https://queue.taskcluster.net/v1/task/HnyHyHa4Tam-EWg24SDqAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:21:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HnyHyHa4Tam-EWg24SDqAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:21:59 INFO - Downloaded 1361 bytes. 10:21:59 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:21:59 INFO - Using the following test package requirements: 10:21:59 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:21:59 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:21:59 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:21:59 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:21:59 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:21:59 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:21:59 INFO - u'jsshell-linux-x86_64.zip'], 10:21:59 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:21:59 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:21:59 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:21:59 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:21:59 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:21:59 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:21:59 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:21:59 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:21:59 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:21:59 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:21:59 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:21:59 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:21:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HnyHyHa4Tam-EWg24SDqAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:21:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HnyHyHa4Tam-EWg24SDqAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:21:59 INFO - Fetch https://queue.taskcluster.net/v1/task/HnyHyHa4Tam-EWg24SDqAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:21:59 INFO - Http code: 200 10:21:59 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 10:21:59 INFO - x-amz-cf-id: y9vIoWYG2MkNY9GzfHXjzpbAFXPYRVajX-aLn6IzvjSvSiBL_h7fkg== 10:21:59 INFO - x-amz-version-id: tYrssWMgtyA6Mbldcvxn6CWG7Mo9m9TB 10:22:00 INFO - Expected file size: 21961055 10:22:00 INFO - Obtained file size: 21961055 10:22:04 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:22:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HnyHyHa4Tam-EWg24SDqAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:22:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HnyHyHa4Tam-EWg24SDqAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:22:04 INFO - Fetch https://queue.taskcluster.net/v1/task/HnyHyHa4Tam-EWg24SDqAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:22:04 INFO - Http code: 200 10:22:04 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 10:22:04 INFO - x-amz-cf-id: IvPrq0b5f4AVJr_YPR4aXIvHixL2mw6NqpWMqPtoVkCq9pr8buz6Yw== 10:22:04 INFO - x-amz-version-id: tYrssWMgtyA6Mbldcvxn6CWG7Mo9m9TB 10:22:05 INFO - Expected file size: 21961055 10:22:05 INFO - Obtained file size: 21961055 10:22:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HnyHyHa4Tam-EWg24SDqAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 10:22:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HnyHyHa4Tam-EWg24SDqAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:22:09 INFO - Fetch https://queue.taskcluster.net/v1/task/HnyHyHa4Tam-EWg24SDqAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 10:22:10 INFO - Http code: 200 10:22:10 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 10:22:10 INFO - x-amz-cf-id: wwc7XI06qV0aTblZURwbw_LOrIvmOuLjVOVW_-S37Ov7aHLdUm7HAQ== 10:22:10 INFO - x-amz-version-id: 1LckNVo5n1ck_rumUjGdO3qOylv4tkPl 10:22:10 INFO - Expected file size: 14409038 10:22:10 INFO - Obtained file size: 14409038 10:22:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:22:10 INFO - trying https://queue.taskcluster.net/v1/task/HnyHyHa4Tam-EWg24SDqAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:22:10 INFO - Downloading https://queue.taskcluster.net/v1/task/HnyHyHa4Tam-EWg24SDqAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:22:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HnyHyHa4Tam-EWg24SDqAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:22:11 INFO - Downloaded 59350127 bytes. 10:22:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HnyHyHa4Tam-EWg24SDqAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:22:11 INFO - mkdir: /builds/slave/test/properties 10:22:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:22:11 INFO - Writing to file /builds/slave/test/properties/build_url 10:22:11 INFO - Contents: 10:22:11 INFO - build_url:https://queue.taskcluster.net/v1/task/HnyHyHa4Tam-EWg24SDqAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:22:12 INFO - Running post-action listener: _resource_record_post_action 10:22:12 INFO - Running post-action listener: set_extra_try_arguments 10:22:12 INFO - [mozharness: 2016-11-10 18:22:12.578745Z] Finished download-and-extract step (success) 10:22:12 INFO - [mozharness: 2016-11-10 18:22:12.578974Z] Running populate-webroot step. 10:22:12 INFO - Running pre-action listener: _resource_record_pre_action 10:22:12 INFO - Running main action method: populate_webroot 10:22:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:22:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:22:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:22:12 INFO - '--tppagecycles', 10:22:12 INFO - '7'], 10:22:12 INFO - 'tests': ['tsvgm']}}, 10:22:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:22:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:22:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:22:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:22:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:22:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:22:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:22:12 INFO - 'talos_options': ['--disable-e10s'], 10:22:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:22:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:22:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:22:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:22:12 INFO - 'talos_options': ['--disable-e10s'], 10:22:12 INFO - 'tests': ['damp', 'tps']}, 10:22:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:22:12 INFO - 'tests': ['damp', 'tps']}, 10:22:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:22:12 INFO - 'tests': ['dromaeo_dom']}, 10:22:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:22:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:22:12 INFO - 'tests': ['basic_compositor_video']}, 10:22:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:22:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:22:12 INFO - 'tests': ['a11yr', 10:22:12 INFO - 'ts_paint', 10:22:12 INFO - 'tpaint', 10:22:12 INFO - 'sessionrestore', 10:22:12 INFO - 'sessionrestore_no_auto_restore', 10:22:12 INFO - 'tabpaint']}, 10:22:12 INFO - 'other-e10s': {'tests': ['a11yr', 10:22:12 INFO - 'ts_paint', 10:22:12 INFO - 'tpaint', 10:22:12 INFO - 'sessionrestore', 10:22:12 INFO - 'sessionrestore_no_auto_restore', 10:22:12 INFO - 'tabpaint']}, 10:22:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:22:12 INFO - 'ts_paint', 10:22:12 INFO - 'tpaint', 10:22:12 INFO - 'sessionrestore', 10:22:12 INFO - 'sessionrestore_no_auto_restore', 10:22:12 INFO - 'tabpaint']}, 10:22:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:22:12 INFO - 'ts_paint', 10:22:12 INFO - 'tpaint', 10:22:12 INFO - 'sessionrestore', 10:22:12 INFO - 'sessionrestore_no_auto_restore', 10:22:12 INFO - 'tabpaint']}, 10:22:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:22:12 INFO - 'tests': ['a11yr', 10:22:12 INFO - 'ts_paint', 10:22:12 INFO - 'tpaint', 10:22:12 INFO - 'sessionrestore', 10:22:12 INFO - 'sessionrestore_no_auto_restore', 10:22:12 INFO - 'tabpaint']}, 10:22:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:22:12 INFO - 'tests': ['a11yr', 10:22:12 INFO - 'ts_paint', 10:22:12 INFO - 'tpaint', 10:22:12 INFO - 'sessionrestore', 10:22:12 INFO - 'sessionrestore_no_auto_restore', 10:22:12 INFO - 'tabpaint']}, 10:22:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:22:12 INFO - 'tests': ['tsvgx', 10:22:12 INFO - 'tsvgr_opacity', 10:22:12 INFO - 'tart', 10:22:12 INFO - 'tscrollx', 10:22:12 INFO - 'cart']}, 10:22:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:22:12 INFO - 'tsvgr_opacity', 10:22:12 INFO - 'tart', 10:22:12 INFO - 'tscrollx', 10:22:12 INFO - 'cart']}, 10:22:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:22:12 INFO - 'talos_options': ['--disable-e10s'], 10:22:12 INFO - 'tests': ['tp5o']}, 10:22:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:22:12 INFO - 'tests': ['tp5o']}, 10:22:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:22:12 INFO - 'talos_options': ['--disable-e10s', 10:22:12 INFO - '--xperf_path', 10:22:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:22:12 INFO - 'tests': ['tp5n']}, 10:22:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:22:12 INFO - 'talos_options': ['--xperf_path', 10:22:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:22:12 INFO - 'tests': ['tp5n']}}, 10:22:12 INFO - 'talos.zip': {'path': '', 10:22:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:22:12 INFO - Running post-action listener: _resource_record_post_action 10:22:12 INFO - [mozharness: 2016-11-10 18:22:12.596609Z] Finished populate-webroot step (success) 10:22:12 INFO - [mozharness: 2016-11-10 18:22:12.596698Z] Running create-virtualenv step. 10:22:12 INFO - Running pre-action listener: _resource_record_pre_action 10:22:12 INFO - Running main action method: create_virtualenv 10:22:12 INFO - Creating virtualenv /builds/slave/test/build/venv 10:22:12 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:22:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:22:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:22:12 INFO - Using real prefix '/usr' 10:22:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:22:13 INFO - Installing distribute.............................................................................................................................................................................................done. 10:22:15 INFO - Installing pip.................done. 10:22:15 INFO - Return code: 0 10:22:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:22:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:22:15 INFO - Reading from file tmpfile_stdout 10:22:15 INFO - Output received: 10:22:15 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 10:22:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:22:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:22:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:22:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:22:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:15 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 0x7f37de66df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce2930>, '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 0xce3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce3cc0>, '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': '4300f881736b422476174874000001bc-1478802116.540826-738079626', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:22:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:22:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:22:15 INFO - Using env: {'DISPLAY': ':0', 10:22:15 INFO - 'HOME': '/home/cltbld', 10:22:15 INFO - 'LANG': 'en_US.UTF-8', 10:22:15 INFO - 'LANGUAGE': 'en_US:en', 10:22:15 INFO - 'LOGNAME': 'cltbld', 10:22:15 INFO - 'MAIL': '/var/mail/cltbld', 10:22:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:15 INFO - 'MOZ_NO_REMOTE': '1', 10:22:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:22:15 INFO - 'NO_EM_RESTART': '1', 10:22:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:22:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:15 INFO - 'PWD': '/builds/slave/test', 10:22:15 INFO - 'SHELL': '/bin/bash', 10:22:15 INFO - 'SHLVL': '1', 10:22:15 INFO - 'TERM': 'linux', 10:22:15 INFO - 'TMOUT': '86400', 10:22:15 INFO - 'USER': 'cltbld', 10:22:15 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1478802116.540826-738079626', 10:22:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:15 INFO - '_': '/tools/buildbot/bin/python'} 10:22:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:22:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:22:15 INFO - Cleaning up... 10:22:15 INFO - Return code: 0 10:22:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:22:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:22:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:22:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:22:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:15 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 0x7f37de66df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce2930>, '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 0xce3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce3cc0>, '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': '4300f881736b422476174874000001bc-1478802116.540826-738079626', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:22:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:22:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:22:15 INFO - Using env: {'DISPLAY': ':0', 10:22:15 INFO - 'HOME': '/home/cltbld', 10:22:15 INFO - 'LANG': 'en_US.UTF-8', 10:22:15 INFO - 'LANGUAGE': 'en_US:en', 10:22:15 INFO - 'LOGNAME': 'cltbld', 10:22:15 INFO - 'MAIL': '/var/mail/cltbld', 10:22:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:15 INFO - 'MOZ_NO_REMOTE': '1', 10:22:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:22:15 INFO - 'NO_EM_RESTART': '1', 10:22:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:22:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:15 INFO - 'PWD': '/builds/slave/test', 10:22:15 INFO - 'SHELL': '/bin/bash', 10:22:15 INFO - 'SHLVL': '1', 10:22:15 INFO - 'TERM': 'linux', 10:22:15 INFO - 'TMOUT': '86400', 10:22:15 INFO - 'USER': 'cltbld', 10:22:15 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1478802116.540826-738079626', 10:22:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:15 INFO - '_': '/tools/buildbot/bin/python'} 10:22:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:22:15 INFO - Downloading/unpacking psutil>=3.1.1 10:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:22:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:22:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:22:17 INFO - Installing collected packages: psutil 10:22:17 INFO - Running setup.py install for psutil 10:22:17 INFO - building 'psutil._psutil_linux' extension 10:22:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:22:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:22:18 INFO - building 'psutil._psutil_posix' extension 10:22:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:22:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:22:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:22:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:22:18 INFO - Successfully installed psutil 10:22:18 INFO - Cleaning up... 10:22:18 INFO - Return code: 0 10:22:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:22:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:22:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:22:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:22:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:18 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 0x7f37de66df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce2930>, '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 0xce3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce3cc0>, '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': '4300f881736b422476174874000001bc-1478802116.540826-738079626', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:22:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:22:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:22:18 INFO - Using env: {'DISPLAY': ':0', 10:22:18 INFO - 'HOME': '/home/cltbld', 10:22:18 INFO - 'LANG': 'en_US.UTF-8', 10:22:18 INFO - 'LANGUAGE': 'en_US:en', 10:22:18 INFO - 'LOGNAME': 'cltbld', 10:22:18 INFO - 'MAIL': '/var/mail/cltbld', 10:22:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:18 INFO - 'MOZ_NO_REMOTE': '1', 10:22:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:22:18 INFO - 'NO_EM_RESTART': '1', 10:22:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:22:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:18 INFO - 'PWD': '/builds/slave/test', 10:22:18 INFO - 'SHELL': '/bin/bash', 10:22:18 INFO - 'SHLVL': '1', 10:22:18 INFO - 'TERM': 'linux', 10:22:18 INFO - 'TMOUT': '86400', 10:22:18 INFO - 'USER': 'cltbld', 10:22:18 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1478802116.540826-738079626', 10:22:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:18 INFO - '_': '/tools/buildbot/bin/python'} 10:22:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:22:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:22:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:22:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:22:20 INFO - Installing collected packages: mozsystemmonitor 10:22:20 INFO - Running setup.py install for mozsystemmonitor 10:22:20 INFO - Successfully installed mozsystemmonitor 10:22:20 INFO - Cleaning up... 10:22:20 INFO - Return code: 0 10:22:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:22:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:22:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:22:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:22:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:20 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 0x7f37de66df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce2930>, '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 0xce3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce3cc0>, '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': '4300f881736b422476174874000001bc-1478802116.540826-738079626', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:22:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:22:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:22:20 INFO - Using env: {'DISPLAY': ':0', 10:22:20 INFO - 'HOME': '/home/cltbld', 10:22:20 INFO - 'LANG': 'en_US.UTF-8', 10:22:20 INFO - 'LANGUAGE': 'en_US:en', 10:22:20 INFO - 'LOGNAME': 'cltbld', 10:22:20 INFO - 'MAIL': '/var/mail/cltbld', 10:22:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:20 INFO - 'MOZ_NO_REMOTE': '1', 10:22:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:22:20 INFO - 'NO_EM_RESTART': '1', 10:22:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:22:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:20 INFO - 'PWD': '/builds/slave/test', 10:22:20 INFO - 'SHELL': '/bin/bash', 10:22:20 INFO - 'SHLVL': '1', 10:22:20 INFO - 'TERM': 'linux', 10:22:20 INFO - 'TMOUT': '86400', 10:22:20 INFO - 'USER': 'cltbld', 10:22:20 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1478802116.540826-738079626', 10:22:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:20 INFO - '_': '/tools/buildbot/bin/python'} 10:22:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:22:20 INFO - Downloading/unpacking jsonschema==2.5.1 10:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:22:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:22:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:23 INFO - Downloading functools32-3.2.3-2.tar.gz 10:22:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:22:23 INFO - warning: no files found matching '*.txt' 10:22:23 INFO - no previously-included directories found matching 'build' 10:22:23 INFO - no previously-included directories found matching 'dist' 10:22:23 INFO - no previously-included directories found matching '.git*' 10:22:23 INFO - Installing collected packages: jsonschema, functools32 10:22:23 INFO - Running setup.py install for functools32 10:22:23 INFO - warning: no files found matching '*.txt' 10:22:23 INFO - no previously-included directories found matching 'build' 10:22:23 INFO - no previously-included directories found matching 'dist' 10:22:23 INFO - no previously-included directories found matching '.git*' 10:22:23 INFO - Successfully installed jsonschema functools32 10:22:23 INFO - Cleaning up... 10:22:23 INFO - Return code: 0 10:22:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:22:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:22:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:22:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:22:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:23 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 0x7f37de66df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce2930>, '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 0xce3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce3cc0>, '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': '4300f881736b422476174874000001bc-1478802116.540826-738079626', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:22:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:22:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:22:23 INFO - Using env: {'DISPLAY': ':0', 10:22:23 INFO - 'HOME': '/home/cltbld', 10:22:23 INFO - 'LANG': 'en_US.UTF-8', 10:22:23 INFO - 'LANGUAGE': 'en_US:en', 10:22:23 INFO - 'LOGNAME': 'cltbld', 10:22:23 INFO - 'MAIL': '/var/mail/cltbld', 10:22:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:23 INFO - 'MOZ_NO_REMOTE': '1', 10:22:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:22:23 INFO - 'NO_EM_RESTART': '1', 10:22:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:22:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:23 INFO - 'PWD': '/builds/slave/test', 10:22:23 INFO - 'SHELL': '/bin/bash', 10:22:23 INFO - 'SHLVL': '1', 10:22:23 INFO - 'TERM': 'linux', 10:22:23 INFO - 'TMOUT': '86400', 10:22:23 INFO - 'USER': 'cltbld', 10:22:23 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1478802116.540826-738079626', 10:22:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:23 INFO - '_': '/tools/buildbot/bin/python'} 10:22:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:22:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:22:23 INFO - Cleaning up... 10:22:23 INFO - Return code: 0 10:22:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:22:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:22:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:22:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:22:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:23 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 0x7f37de66df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce2930>, '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 0xce3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce3cc0>, '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': '4300f881736b422476174874000001bc-1478802116.540826-738079626', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:22:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:22:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:22:23 INFO - Using env: {'DISPLAY': ':0', 10:22:23 INFO - 'HOME': '/home/cltbld', 10:22:23 INFO - 'LANG': 'en_US.UTF-8', 10:22:23 INFO - 'LANGUAGE': 'en_US:en', 10:22:23 INFO - 'LOGNAME': 'cltbld', 10:22:23 INFO - 'MAIL': '/var/mail/cltbld', 10:22:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:23 INFO - 'MOZ_NO_REMOTE': '1', 10:22:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:22:23 INFO - 'NO_EM_RESTART': '1', 10:22:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:22:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:23 INFO - 'PWD': '/builds/slave/test', 10:22:23 INFO - 'SHELL': '/bin/bash', 10:22:23 INFO - 'SHLVL': '1', 10:22:23 INFO - 'TERM': 'linux', 10:22:23 INFO - 'TMOUT': '86400', 10:22:23 INFO - 'USER': 'cltbld', 10:22:23 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1478802116.540826-738079626', 10:22:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:23 INFO - '_': '/tools/buildbot/bin/python'} 10:22:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:22:23 INFO - Downloading/unpacking blobuploader==1.2.4 10:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:25 INFO - Downloading blobuploader-1.2.4.tar.gz 10:22:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:22:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:22:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:22:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:26 INFO - Downloading docopt-0.6.1.tar.gz 10:22:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:22:26 INFO - Installing collected packages: blobuploader, requests, docopt 10:22:26 INFO - Running setup.py install for blobuploader 10:22:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:22:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:22:26 INFO - Running setup.py install for requests 10:22:26 INFO - Running setup.py install for docopt 10:22:27 INFO - Successfully installed blobuploader requests docopt 10:22:27 INFO - Cleaning up... 10:22:27 INFO - Return code: 0 10:22:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:22:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:22:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:22:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:22:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:22:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:27 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 0x7f37de66df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce2930>, '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 0xce3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce3cc0>, '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': '4300f881736b422476174874000001bc-1478802116.540826-738079626', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:22:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:22:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:22:27 INFO - Using env: {'DISPLAY': ':0', 10:22:27 INFO - 'HOME': '/home/cltbld', 10:22:27 INFO - 'LANG': 'en_US.UTF-8', 10:22:27 INFO - 'LANGUAGE': 'en_US:en', 10:22:27 INFO - 'LOGNAME': 'cltbld', 10:22:27 INFO - 'MAIL': '/var/mail/cltbld', 10:22:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:27 INFO - 'MOZ_NO_REMOTE': '1', 10:22:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:22:27 INFO - 'NO_EM_RESTART': '1', 10:22:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:22:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:27 INFO - 'PWD': '/builds/slave/test', 10:22:27 INFO - 'SHELL': '/bin/bash', 10:22:27 INFO - 'SHLVL': '1', 10:22:27 INFO - 'TERM': 'linux', 10:22:27 INFO - 'TMOUT': '86400', 10:22:27 INFO - 'USER': 'cltbld', 10:22:27 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1478802116.540826-738079626', 10:22:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:27 INFO - '_': '/tools/buildbot/bin/python'} 10:22:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:22:27 INFO - Running setup.py (path:/tmp/pip-7dNE6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:22:27 INFO - Running setup.py (path:/tmp/pip-X4ng5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:22:27 INFO - Running setup.py (path:/tmp/pip-ucRah7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:22:27 INFO - Running setup.py (path:/tmp/pip-C_TECe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:22:27 INFO - Running setup.py (path:/tmp/pip-xZGqbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:22:27 INFO - Running setup.py (path:/tmp/pip-5Tm9fS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:22:27 INFO - Running setup.py (path:/tmp/pip-PX6EuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:22:27 INFO - Running setup.py (path:/tmp/pip-DgAMXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:22:27 INFO - Running setup.py (path:/tmp/pip-7YfEjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:22:27 INFO - Running setup.py (path:/tmp/pip-f04qWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:22:28 INFO - Running setup.py (path:/tmp/pip-V_ocK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:22:28 INFO - Running setup.py (path:/tmp/pip-O8pLuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:22:28 INFO - Running setup.py (path:/tmp/pip-ETyDDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:22:28 INFO - Running setup.py (path:/tmp/pip-GL4agD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:22:28 INFO - Running setup.py (path:/tmp/pip-Um0hGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:22:28 INFO - Running setup.py (path:/tmp/pip-MSdcAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:22:28 INFO - Running setup.py (path:/tmp/pip-S2NbhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:22:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:22:28 INFO - Running setup.py install for manifestparser 10:22:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:22:28 INFO - Running setup.py install for mozcrash 10:22:28 INFO - Running setup.py install for mozdebug 10:22:28 INFO - Running setup.py install for mozdevice 10:22:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:22:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:22:29 INFO - Running setup.py install for mozfile 10:22:29 INFO - Running setup.py install for mozhttpd 10:22:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:22:29 INFO - Running setup.py install for mozinfo 10:22:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:22:29 INFO - Running setup.py install for mozInstall 10:22:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:22:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:22:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:22:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:22:29 INFO - Running setup.py install for mozleak 10:22:29 INFO - Running setup.py install for mozlog 10:22:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:22:29 INFO - Running setup.py install for moznetwork 10:22:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:22:29 INFO - Running setup.py install for mozprocess 10:22:29 INFO - Running setup.py install for mozprofile 10:22:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:22:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:22:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:22:29 INFO - Running setup.py install for mozrunner 10:22:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:22:30 INFO - Running setup.py install for mozscreenshot 10:22:30 INFO - Running setup.py install for moztest 10:22:30 INFO - Running setup.py install for mozversion 10:22:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:22:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:22:30 INFO - Cleaning up... 10:22:30 INFO - Return code: 0 10:22:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:22:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:22:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:22:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:22:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:30 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 0x7f37de66df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce2930>, '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 0xce3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce3cc0>, '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': '4300f881736b422476174874000001bc-1478802116.540826-738079626', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:22:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:22:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:22:30 INFO - Using env: {'DISPLAY': ':0', 10:22:30 INFO - 'HOME': '/home/cltbld', 10:22:30 INFO - 'LANG': 'en_US.UTF-8', 10:22:30 INFO - 'LANGUAGE': 'en_US:en', 10:22:30 INFO - 'LOGNAME': 'cltbld', 10:22:30 INFO - 'MAIL': '/var/mail/cltbld', 10:22:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:30 INFO - 'MOZ_NO_REMOTE': '1', 10:22:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:22:30 INFO - 'NO_EM_RESTART': '1', 10:22:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:22:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:30 INFO - 'PWD': '/builds/slave/test', 10:22:30 INFO - 'SHELL': '/bin/bash', 10:22:30 INFO - 'SHLVL': '1', 10:22:30 INFO - 'TERM': 'linux', 10:22:30 INFO - 'TMOUT': '86400', 10:22:30 INFO - 'USER': 'cltbld', 10:22:30 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1478802116.540826-738079626', 10:22:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:30 INFO - '_': '/tools/buildbot/bin/python'} 10:22:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:22:30 INFO - Running setup.py (path:/tmp/pip-X_wRrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:22:30 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:22:30 INFO - Running setup.py (path:/tmp/pip-oBMAij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:22:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:22:30 INFO - Running setup.py (path:/tmp/pip-_DONiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:22:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:22:30 INFO - Running setup.py (path:/tmp/pip-XSGb1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:22:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:22:30 INFO - Running setup.py (path:/tmp/pip-65D7d1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:22:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:22:30 INFO - Running setup.py (path:/tmp/pip-u070p2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:22:31 INFO - Running setup.py (path:/tmp/pip-Yn7qZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:22:31 INFO - Running setup.py (path:/tmp/pip-M1BWGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:22:31 INFO - Running setup.py (path:/tmp/pip-68oeka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:22:31 INFO - Running setup.py (path:/tmp/pip-nJZE16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:22:31 INFO - Running setup.py (path:/tmp/pip-lTF2ck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:22:31 INFO - Running setup.py (path:/tmp/pip-oNjmif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:22:31 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)) 10:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:22:31 INFO - Running setup.py (path:/tmp/pip-m_efFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:22:31 INFO - Running setup.py (path:/tmp/pip-7Bu6DO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:22:31 INFO - Running setup.py (path:/tmp/pip-C2gcS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:22:31 INFO - Running setup.py (path:/tmp/pip-v_Ld3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:22:31 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)) 10:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:22:31 INFO - Running setup.py (path:/tmp/pip-w0PtnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:22:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:33 INFO - Downloading blessings-1.6.tar.gz 10:22:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:22:33 INFO - Installing collected packages: blessings 10:22:33 INFO - Running setup.py install for blessings 10:22:33 INFO - Successfully installed blessings 10:22:33 INFO - Cleaning up... 10:22:34 INFO - Return code: 0 10:22:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:22:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:22:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:22:34 INFO - Reading from file tmpfile_stdout 10:22:34 INFO - Current package versions: 10:22:34 INFO - argparse == 1.2.1 10:22:34 INFO - blessings == 1.6 10:22:34 INFO - blobuploader == 1.2.4 10:22:34 INFO - docopt == 0.6.1 10:22:34 INFO - functools32 == 3.2.3-2 10:22:34 INFO - jsonschema == 2.5.1 10:22:34 INFO - manifestparser == 1.1 10:22:34 INFO - mozInstall == 1.12 10:22:34 INFO - mozcrash == 1.0 10:22:34 INFO - mozdebug == 0.1 10:22:34 INFO - mozdevice == 0.48 10:22:34 INFO - mozfile == 1.2 10:22:34 INFO - mozhttpd == 0.7 10:22:34 INFO - mozinfo == 0.9 10:22:34 INFO - mozleak == 0.1 10:22:34 INFO - mozlog == 3.4 10:22:34 INFO - moznetwork == 0.27 10:22:34 INFO - mozprocess == 0.23 10:22:34 INFO - mozprofile == 0.28 10:22:34 INFO - mozrunner == 6.13 10:22:34 INFO - mozscreenshot == 0.1 10:22:34 INFO - mozsystemmonitor == 0.3 10:22:34 INFO - moztest == 0.7 10:22:34 INFO - mozversion == 1.4 10:22:34 INFO - psutil == 3.1.1 10:22:34 INFO - requests == 1.2.3 10:22:34 INFO - wsgiref == 0.1.2 10:22:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:22: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')]} 10:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:22:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22: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')]} 10:22:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:22:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:34 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 0x7f37de66df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce2930>, '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 0xce3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce3cc0>, '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': '4300f881736b422476174874000001bc-1478802116.540826-738079626', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:22:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:22:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:22:34 INFO - Using env: {'DISPLAY': ':0', 10:22:34 INFO - 'HOME': '/home/cltbld', 10:22:34 INFO - 'LANG': 'en_US.UTF-8', 10:22:34 INFO - 'LANGUAGE': 'en_US:en', 10:22:34 INFO - 'LOGNAME': 'cltbld', 10:22:34 INFO - 'MAIL': '/var/mail/cltbld', 10:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:34 INFO - 'MOZ_NO_REMOTE': '1', 10:22:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:22:34 INFO - 'NO_EM_RESTART': '1', 10:22:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:34 INFO - 'PWD': '/builds/slave/test', 10:22:34 INFO - 'SHELL': '/bin/bash', 10:22:34 INFO - 'SHLVL': '1', 10:22:34 INFO - 'TERM': 'linux', 10:22:34 INFO - 'TMOUT': '86400', 10:22:34 INFO - 'USER': 'cltbld', 10:22:34 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1478802116.540826-738079626', 10:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:34 INFO - '_': '/tools/buildbot/bin/python'} 10:22:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:22:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:22:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:22:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:22:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:22:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:22:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:22:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:22:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:22:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:22:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:22:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:22:34 INFO - Cleaning up... 10:22:34 INFO - Return code: 0 10:22:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:22: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')]} 10:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:22:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22: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')]} 10:22:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:22:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f37de66df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce2930>, '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 0xce3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce3cc0>, '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': '4300f881736b422476174874000001bc-1478802116.540826-738079626', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:22: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'] in /builds/slave/test/build 10:22: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 10:22:34 INFO - Using env: {'DISPLAY': ':0', 10:22:34 INFO - 'HOME': '/home/cltbld', 10:22:34 INFO - 'LANG': 'en_US.UTF-8', 10:22:34 INFO - 'LANGUAGE': 'en_US:en', 10:22:34 INFO - 'LOGNAME': 'cltbld', 10:22:34 INFO - 'MAIL': '/var/mail/cltbld', 10:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:34 INFO - 'MOZ_NO_REMOTE': '1', 10:22:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:22:34 INFO - 'NO_EM_RESTART': '1', 10:22:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:34 INFO - 'PWD': '/builds/slave/test', 10:22:34 INFO - 'SHELL': '/bin/bash', 10:22:34 INFO - 'SHLVL': '1', 10:22:34 INFO - 'TERM': 'linux', 10:22:34 INFO - 'TMOUT': '86400', 10:22:34 INFO - 'USER': 'cltbld', 10:22:34 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1478802116.540826-738079626', 10:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:34 INFO - '_': '/tools/buildbot/bin/python'} 10:22:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:22:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:22:34 INFO - Cleaning up... 10:22:34 INFO - Return code: 0 10:22:34 INFO - Running post-action listener: _resource_record_post_action 10:22:34 INFO - Running post-action listener: _start_resource_monitoring 10:22:34 INFO - Starting resource monitoring. 10:22:34 INFO - [mozharness: 2016-11-10 18:22:34.714887Z] Finished create-virtualenv step (success) 10:22:34 INFO - [mozharness: 2016-11-10 18:22:34.715388Z] Running install step. 10:22:34 INFO - Running pre-action listener: _resource_record_pre_action 10:22:34 INFO - Running main action method: install 10:22:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:22:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:22:34 INFO - Reading from file tmpfile_stdout 10:22:34 INFO - Detecting whether we're running mozinstall >=1.0... 10:22:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:22:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:22:35 INFO - Reading from file tmpfile_stdout 10:22:35 INFO - Output received: 10:22:35 INFO - Usage: mozinstall [options] installer 10:22:35 INFO - Options: 10:22:35 INFO - -h, --help show this help message and exit 10:22:35 INFO - -d DEST, --destination=DEST 10:22:35 INFO - Directory to install application into. [default: 10:22:35 INFO - "/builds/slave/test"] 10:22:35 INFO - --app=APP Application being installed. [default: firefox] 10:22:35 INFO - mkdir: /builds/slave/test/build/application 10:22:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:22:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:22:51 INFO - Reading from file tmpfile_stdout 10:22:51 INFO - Output received: 10:22:51 INFO - /builds/slave/test/build/application/firefox/firefox 10:22:51 INFO - Running post-action listener: _resource_record_post_action 10:22:51 INFO - [mozharness: 2016-11-10 18:22:51.872824Z] Finished install step (success) 10:22:51 INFO - [mozharness: 2016-11-10 18:22:51.873069Z] Running run-tests step. 10:22:51 INFO - Running pre-action listener: _resource_record_pre_action 10:22:51 INFO - Running main action method: run_tests 10:22:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:22:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:22:51 INFO - Python 2.7.3 10:22:51 INFO - Return code: 0 10:22:51 INFO - grabbing minidump binary from tooltool 10:22:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:22:51 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 0xce2930>, '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 0xce3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce3cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:22:51 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:22:51 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:22:51 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:22:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:22:51 INFO - Return code: 0 10:22:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:22:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:22:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:22:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:22:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:22:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HnyHyHa4Tam-EWg24SDqAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:22:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HnyHyHa4Tam-EWg24SDqAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:22:51 INFO - Using env: {'DISPLAY': ':0', 10:22:51 INFO - 'HOME': '/home/cltbld', 10:22:51 INFO - 'LANG': 'en_US.UTF-8', 10:22:51 INFO - 'LANGUAGE': 'en_US:en', 10:22:51 INFO - 'LOGNAME': 'cltbld', 10:22:51 INFO - 'MAIL': '/var/mail/cltbld', 10:22:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:22:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:22:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:51 INFO - 'MOZ_NO_REMOTE': '1', 10:22:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:22:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:22:51 INFO - 'NO_EM_RESTART': '1', 10:22:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:22:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:51 INFO - 'PWD': '/builds/slave/test', 10:22:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:22:51 INFO - 'SHELL': '/bin/bash', 10:22:51 INFO - 'SHLVL': '1', 10:22:51 INFO - 'TERM': 'linux', 10:22:51 INFO - 'TMOUT': '86400', 10:22:51 INFO - 'USER': 'cltbld', 10:22:51 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1478802116.540826-738079626', 10:22:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:51 INFO - '_': '/tools/buildbot/bin/python'} 10:22:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HnyHyHa4Tam-EWg24SDqAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:22:52 INFO - mozversion application_buildid: 20161110073137 10:22:52 INFO - mozversion application_changeset: d2e33428e45718bbeff192e80fd3a75ad264210d 10:22:52 INFO - mozversion application_display_name: Nightly 10:22:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:22:52 INFO - mozversion application_name: Firefox 10:22:52 INFO - mozversion application_remotingname: firefox 10:22:52 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:22:52 INFO - mozversion application_vendor: Mozilla 10:22:52 INFO - mozversion application_version: 52.0a1 10:22:52 INFO - mozversion platform_buildid: 20161110073137 10:22:52 INFO - mozversion platform_changeset: d2e33428e45718bbeff192e80fd3a75ad264210d 10:22:52 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:22:52 INFO - mozversion platform_version: 52.0a1 10:22:52 INFO - using testdate: 1478802172 10:22:52 INFO - actual date: 1478802172 10:22:52 INFO - starting webserver on 'localhost:58218' 10:22:52 INFO - SUITE-START | Running 2 tests 10:22:52 INFO - TEST-START | dromaeo_css 10:22:52 INFO - operating with platform_type : linux_ 10:22:52 INFO - Initialising browser for dromaeo_css test... 10:22:52 INFO - TEST-INFO | started process 22578 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ1M_Uc/profile http://localhost:58218/getInfo.html) 10:22:56 INFO - PROCESS | 22578 | __metrics Screen width/height:1600/1200 10:22:56 INFO - PROCESS | 22578 | colorDepth:24 10:22:56 INFO - PROCESS | 22578 | Browser inner width/height: 1024/697 10:22:56 INFO - PROCESS | 22578 | __metrics 10:22:56 INFO - PROCESS | 22578 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:22:56 INFO - PROCESS | 22578 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:22:57 INFO - PROCESS | 22578 | console.error: PushService: 10:22:57 INFO - PROCESS | 22578 | stateChangeProcessEnqueue: Error transitioning state 10:22:57 INFO - PROCESS | 22578 | UnknownError 10:22:58 INFO - TEST-INFO | 22578: exit 0 10:22:58 INFO - Browser initialized. 10:22:58 INFO - Running cycle 1/1 for dromaeo_css test... 10:22:58 INFO - TEST-INFO | started process 22662 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ1M_Uc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:23:10 INFO - PROCESS | 22662 | RSS: Main: 173002752 10:23:10 INFO - PROCESS | 22662 | 10:24:01 INFO - PROCESS | 22662 | 1478802241838 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] 10:26:11 INFO - PROCESS | 22662 | Cycle 1(1): loaded http://localhost:58218/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58218/tests/dromaeo/cssquery-ext.html) 10:26:15 INFO - PROCESS | 22662 | RSS: Main: 434675712 10:26:15 INFO - PROCESS | 22662 | 10:29:17 INFO - PROCESS | 22662 | Cycle 1(1): loaded http://localhost:58218/tests/dromaeo/cssquery-ext.html (next: http://localhost:58218/tests/dromaeo/cssquery-jquery.html) 10:29:18 INFO - PROCESS | 22662 | RSS: Main: 286265344 10:29:18 INFO - PROCESS | 22662 | 10:32:20 INFO - PROCESS | 22662 | Cycle 1(1): loaded http://localhost:58218/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58218/tests/dromaeo/cssquery-mootools.html) 10:32:21 INFO - PROCESS | 22662 | RSS: Main: 222060544 10:32:21 INFO - PROCESS | 22662 | 10:35:23 INFO - PROCESS | 22662 | Cycle 1(1): loaded http://localhost:58218/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58218/tests/dromaeo/cssquery-prototype.html) 10:35:23 INFO - PROCESS | 22662 | RSS: Main: 257478656 10:35:23 INFO - PROCESS | 22662 | 10:38:26 INFO - PROCESS | 22662 | Cycle 1(1): loaded http://localhost:58218/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58218/tests/dromaeo/cssquery-yui.html) 10:38:27 INFO - PROCESS | 22662 | RSS: Main: 221466624 10:38:27 INFO - PROCESS | 22662 | 10:41:29 INFO - PROCESS | 22662 | Cycle 1(1): loaded http://localhost:58218/tests/dromaeo/cssquery-yui.html (next: http://localhost:58218/tests/dromaeo/cssquery-dojo.html) 10:41:30 INFO - PROCESS | 22662 | RSS: Main: 314310656 10:41:30 INFO - PROCESS | 22662 | 10:41:30 INFO - PROCESS | 22662 | __start_tp_report 10:41:30 INFO - PROCESS | 22662 | _x_x_mozilla_page_load 10:41:30 INFO - PROCESS | 22662 | _x_x_mozilla_page_load_details 10:41:30 INFO - PROCESS | 22662 | |i|pagename|runs| 10:41:30 INFO - PROCESS | 22662 | |0;dojo.html;2991.2073300575344;3001.5797788309656;3041.2396900774797;3058.2507285714987;3062.111987523618;5070.2901593776805;5144.279800827878;5228.607854410915;5269.446708095647;5335.573154147669;5189.143791274435;5238.738063096849;5303.734813259341;5317.069512835248;5347.812826551071;4681.531846815308;4714.646401519883;4752.928706069411;4761.666683332168;4814.590759785422;4809.519048095198;4821.927671084936;4865.026994601077;4871.074495845778;4918.655694101414;4685.086408150378;4790.42514898211;4805.327254184417;4829.034193161382;4899.191633380506;4710.858674239778;4762.047590481918;4780.49804770501;4783.473817880031;4795.952040479586;4674.041821426599;4719.882002949919;4749.786259618291;4781.402324709411;4791.856244312677;5250.317458730341;5279.52484276417;5284.445133260991;5290.867728306785;5304.310439642861;5660.7355159701465;5663.037283661787;5670.829875103754;5673.886522269573;5721.256236689245;5568.443155684439;5630.239917611111;5636.859078523029;5679.772809087632;5702.486776190121;5253.448387919251;5316.255724198615;5316.308879845634;5318.70747108905;5321.068812957795;5739.569532285095;5778.451047150514;5837.474627283565;5883.117532370093;5900.881982360329;5620.57845661577;5626.324841019104;5626.831195064155;5628.85927851807;5669.744861481243;5682.801101961411;5685.1756495307945;5686.175504551817;5686.289213848269;5695.5443564514735;5424.996375670514;5468.781248750085;5474;5675.460831221028;5679.119736440858;5543.695096769717;5555.416681248492;5609.4390560943575;5633.183188437653;5655.321361436654;4256.084941737541;4260.062786187033;4262.722923009995;4364.10535840152;4368.27923392643;3859.5368555772925;3871.2257548490416;3874.050857539921;3883.4951456311064;3900.258950799339;5240.895182096337;5284.709340986283;5315.73421328932;5412.3505179377935;5462;5449.373322067933;5550.278463799761;5585.888282234332;5600.85997850057;5672.177534257509;5280.630355875129;5285.418603953562;5307.230451584576;5310.840674779763;5318.202269659582;4709.905801883943;4834.20235661112;4838.612910967114;4847.2729090635985;4876.926846097312;5654.46282603152;5782.132680098019;5827.300723912988;5839.386864379179;5930.258717660293;5674.233978412862;5678.858028549319;5678.914816277676;5683.431656834449;5683.602147849776;5859.765609375577;5869.647821130746;5869.765209391577;5871.089981052944;5874.647521148574;5433.157860531624;5461.235427040297;5504.669719816824;5582.106862901916;5584.636998595079;5625.803096891589;5664.5751568631695;5680.2615659965595;5685.374608793112;5689.6586204827845;5491.752871120889;5492.91760623583;5498.065328894178;5500.312460942382;5502.862428439321;5476.096444086681;5477.780888764564;5483.259759932358;5483.533899618417;5488.917666235089;5476.04169270384;5481.917771233514;5484.2596249507405;5485.232067510631;5494.697791621499;5446.101393270224;5488.286522752176;5490.5607551395;5492.91760623583;5493.313335833021;5412.918806217988;5423.83728488146;5444.537214336668;5491.890162196813;5508.586855985737 10:41:30 INFO - PROCESS | 22662 | |1;ext.html;588.599134060935;591.9319278282999;595.9927722149567;596.7732261740538;600.2856600645232;41420;42846.78576607117;42958.57041429585;45828.0834383313;45859.31211031837;43322.7833860831;43660.78169609147;43718.12563748723;43735.343969840476;43757.56242437575;7880.054393472791;8529.360297977646;8681.95659021704;8684.60919258635;8687.95656021719;7838.294553490185;10022.599096036187;10182.490875456235;10197.286189966706;10514.421706806123;10341.741456463573;10400.843987340197;10404.63583774568;10407.583696652126;10434.165266778677;10196.439195844225;10232.795344093076;10272.845907311395;10274.743131421737;10306.227032972558;10090.688210532657;10157.136643385322;10172.694819155437;10174.643887463903;10184.847227291597;40871.79564102161;41216.1756764866;41232.175356493004;41242.79378603118;41272.174556509;3376.5272861799367;3414.5902491701154;3462.7056700180515;3563.4832949222478;3590.622984586607;30772;30913.845430772926;31045.0686479406;31112.688873111205;31383.529247061313;4086.6934979876332;4191.245575796355;4236.51280102789;4344.348347747831;4369.60673539383;243582;243721;243996;244142;244476.776161193;56628.15057774137;56791.14813277804;56842.14736778952;57151.714241428526;57234.42765572374;54436.45563544314;54931.725341373836;54953.45046549563;54960.45039549634;55033.724831375584;14167.291635418187;14313.28433578317;14325.78511322331;14327.713445731028;14336.354864031144;8975.28197744179;9172.954135229282;10124.949375253223;10143.391396516232;11244.26912250701;18735.531611709815;19384.327712178412;19431.014048607503;19589.27803717289;19624;7060.576365418091;7153.6780844862105;7274.781756547312;7320.9633951830965;7361.521501102411;877.2061284537504;1030.4796077980723;1032.1794173631981;1042.4943902207424;1098.203802243383;30857.537136942963;30949.381012380076;31028.68971310303;31037.913673021787;31151.221219469695;1070.8661417322835;1076.612419528969;1078.665613659768;1133.727905302738;1165.8950694437542;15780.368785248691;16306.347746090261;16382.918085409736;16479.752803707954;16773.32906683719;515393;517237;517810;517912;519164;56715.43284567101;57089.42910570841;57397;57408.42591574114;57553.13670294949;1215.2526196389158;1234.6542967969162;1284.9678758031123;1290.6902343437507;1319.2150670351125;28324.291892702848;31464.842675786476;32052;32179.51730723994;32513.187170319987;48655.5134448651;48673.513264866895;49189;49201.753991229816;49304.260436094206;388795.2325244164;393846.61533846386;393962;395411.3670906378;396798;28033.299167520974;28542.42915141727;28596.857015714788;29847.70152298449;41603;45180.322295166254;45405.77297113493;45949.31076033929;46459;46893;38531;38923;39416.2116757669;40360.79819600883;40618.79690601528;39335.803320983214;39742.80128599339;40223.79888100541;40397.990050248976;41374.58625413707;38592.80703596464;39284.214315714096;40060.399094014196;40062.599374005884;40141.59858401379;30871.38257234798;34691;35520;36139.27721445504;36216.637833621324;26736.305477809034;26834.865825671528;26866.59700104539;26947.326316842235;27097.593536097367 10:41:30 INFO - PROCESS | 22662 | |2;jquery.html;382.8258142545139;393.7204584744831;403.7577453527884;407.54151579473097;419.1010282943087;13232.999999999987;15262;18476.907615461903;18894.716579251322;19306.613867722637;17923.73114403285;18284.360047398342;18560.72158917614;18924.526886827836;18940.337088201915;5406.702631355274;5433.1035379162395;5691.4877661010505;5700.344460387047;5702.600817942745;5267.815626453075;5688.089905615102;5707.571932105088;5718.628289161191;5722.599418040739;5669.886602267973;5676.886462270752;5677.261955945722;5679.062954612484;6051.697415129248;6307.684615769193;6343.46080583151;6406.03909413587;6411.871762564746;6414.102025716404;5458.317710286215;5601.319604118748;5625.971870140664;5660.547156227533;5661.348944871352;13996.440142394293;14101.64745881351;14170.504032358922;19004.61990760177;22768.886155569115;2140.4327853118934;2324.1633012115626;2340.9699732117815;2385.2367242482414;2786.763125134366;9690.273229507744;9919.950400247953;10219.386836789816;10314.896851031468;10422.843657345145;1852.351676913083;1857.5541869951114;1887.3488646416963;1903.381401044666;1932.1884808380514;79203;81816.59091704563;82381.58809205976;82526.17473825245;83535;10620.300751879662;10785.78428431427;11079.833802492969;11578.305301681758;11686.76626467466;15146.772798408032;15297;15299.617509562127;15308;15326.23368831554;6961.199462061826;7116.750913717995;7196.208417074117;7379.6679149438405;7420.183779784327;6608.603483790988;6628.204615446178;6629.834254143589;6845.562431889359;6861.519693621399;4552.70407423523;4619.5611416915335;4638.652101092432;4659.370984916993;4744.335792988984;1911.7705875295053;1939.3697048459308;1969.2221572479077;1973.8124878136555;1976.6540855350543;876.9429987050949;926.8563372677246;937.7186843946789;987.3236832769433;1052.5894900988621;17617.647647047244;18846.623067538574;18856.717149242773;18903.338383156522;19413;929.4841363043575;929.6420877962033;964.8070385922844;971.8560456921853;980.2648013989508;10022.599096036078;10533.36799792015;10541.367517948947;10630.681079567625;10635.04284614373;406364;411594;421053;421333;432621;86525.97241146062;90145.54927225322;90744;90963.54518227366;91194;975.6926568131016;977.6871401151706;979.7060881735451;981.8919918808925;992.9156021738233;15779.368825246862;16126.193690315671;16334.509964701077;16405.343786248417;16564;39646;41009.589904100576;41810.620601408475;41858.37212441877;42520.57479425166;54490.72754636202;55765.72117139388;56368.718156408955;56536.71731641315;57110;8364.66541338364;8579.528125953133;8615.439996400213;8801.295896328407;8859.734207973772;11743.295402275891;12209.877901221229;12248.75502489963;12647.683807904508;12833.280995319472;10800.479317072006;11092.833607496055;11222;11251.662450126509;11260.662180134608;10820.621278255223;11042;11355.886441135483;11464.197506174487;11613.361265130161;11208.383538905438;11223.214374993671;11853.288802671867;11913.761724765283;11935.820962685393;8515.148485151436;8585.527795971282;8590.441621294596;8849.159329863653;8925.375223734276;10438.843417348899;11203.215774896005;11259.380734059705;11317.830232546683;11606.361650108987 10:41:30 INFO - PROCESS | 22662 | |3;mootools.html;1337.97324053519;1422.551896152712;1471.41143542583;1597.8801589880761;1748.466717651116;7124.643767811608;7591.127020392656;7787.4548781585245;7798.25916537928;8011.6795328186945;7762.534247945127;7763.650635721392;7773.339266162383;7777;7779.8833017504785;2260.1863329201433;2283.8743869087193;2288.8054515366216;2292.083166733303;2292.197730794225;2206.6028114939304;2257.6500642400374;2265.954680906381;2274.3290729234914;2278.065992942894;2234.2850287907877;2237.9104835806547;2257.164849005862;2257.3340864444945;2261.2650888461235;2164.1496520475084;2177.096504950444;2188.0372636040092;2189.6496560550313;2193.638049721794;2199.439143018536;2210.458437682778;2210.9668354974688;2216.1910902520626;2221.144859229192;7856.057273127204;7953.244441778022;8241.629126689253;8282.627281772275;8386.8322633547;5073.061483625541;5277.762500687479;5284.313039304904;5291.1798671206025;5298.15229563268;3289.1283809790184;3439.638837922032;3469.1153755792366;3497.352989696889;3526.3299973005046;1092.83607458881;1093.420487141808;1095.5727266366123;1131.6831287239586;1164.90680745541;11407.942960285229;11463.770724585545;11501.884981150166;11593.76812463746;11625.186236963416;4048.39274108886;4360.760158191267;4413.22768515515;4430.357598148251;4454.844080457168;9175.58709858058;9190.172884440433;9196.448213107235;9200.815983680423;9214.262858971266;5002.449730529639;5068.594512438996;5081.669691470117;5084.237364395296;5087.643864929493;4135.751854888656;4274.187904298174;4557.361969324297;4679.532046795293;4733.621310295168;3522.6653467920505;3548.91127721809;3605.2428989911887;3684.392075307544;3698.8890333290046;1154.8036833738286;1155.9768804623861;1164.7845148647527;1166.1428849795393;1166.3177041430688;817.9856977348046;835.1314632781839;890.3589415620743;906.3202598051462;922.5064590444215;5503.642263252876;5628.774849005994;5694.715264236772;5708.029634962067;5796.1305804129715;893.4862454088925;926.4580220570907;933.2021121940643;933.8085692433035;946.8201041802035;3537.858485660596;3752.380857158593;3781.2248489059675;3794.924101517954;3917.0794863207125;10136.645217417503;10429;10469.424181670081;10470.424126672953;10482.737931551772;9702.175315098155;10144.797104057878;10347.12049475803;10419.374837509773;10525.526351314209;7746.225377462321;7904.56524891125;7925.207479252029;7939.087004994384;7947.086085100172;5494;5622.746976385991;5677.801276955287;5766.625169363978;5954.46409823118;9557.522123893916;9583.137517623447;9584.712458626253;9598.32811703202;9607.903920960702;9106.089391061107;9324.160825525463;9469.431834089977;9699.272554558578;9702.175315098013;6774.42417394527;6894.517383783087;6895.241523432318;7333.559986400833;7487.176410594721;7453.664585093576;7512.13610434807;7754.069511658637;7999.360051195774;8014.078380986028;7251.1298644163035;7335.633218339169;7346.52247603904;7449.366803821736;7527.247275272429;7125.608091555015;7191.640417978975;7208.96395518019;7381.335679788845;7439.665215065444;6509.153810004858;6606.900896486461;6626.53614246998;6628.668566571556;6648.634325112165;5004.1492946198505;5032.974835125801;5104.310918026167;5121.8719532012;5217.165253559412;5020.698758074527;5076.898462030665;5213.713245771519;5234.895302093861;5279.39286982002 10:41:30 INFO - PROCESS | 22662 | |4;prototype.html;316.6501016376905;325.7426632959962;332.87849934773817;337.1083484184332;337.80576168703004;4981.178105612578;5082.161443361841;5108.872278193047;5155.716435596036;5170.715610641418;4939.9012019759675;5005.699658020512;5067.7212753298645;5080.390353157617;5087.160618497953;4034.69739769517;4041.7979101044903;4047.4738284023038;4054.0067683417606;4057.5536690963972;3737.514123163985;3830.9464897153366;4037.636612704856;4044.402461027907;4071.4503542021894;3989.7033464124274;4010.9598904011023;4012.5786792386816;4024.1750441159493;4029.0934539728473;4002.8198731057173;4009.67922566194;4015.5984401559904;4017.5580686124504;4025.1949610077954;3577.7853328800356;3580.122869896892;3609.4224924012033;3614.530111085542;3624.4925710400566;4930.235813448885;5011.3485246918035;5012.020252000476;5018.322526458918;5029.220470827027;4632.2588385858435;4644.535546445362;4648.697834640738;4649.8372556960685;4654.185517534452;5367.892642147174;5370.301860758115;5370.597205209625;5375.865603359908;5432.402435732066;3817.9236415271816;3924.941125883114;3954.485916830822;3956.8615098471705;3959.713093244678;5506.174073888908;5516.9448305516835;5520.420355862617;5522.779088836442;5525.171224316345;4043.959560404417;4044.838206471767;4050.5341885683524;4056.918861622751;4078.877633670935;3935.2916475034767;4000.439938408625;4033.979830100831;4069.9557916876342;4123.876283711494;4536.79584418702;4538.818447262072;4547.272436410159;4549.431321084864;4564.178447879413;5289.206619007103;5320.627556071116;5324.242999810053;5327.387350454747;5333.253344531769;1275.113795911851;1311.5016293808483;1335.3657012918786;1371.1156304183944;1374.5257886029503;946.1815529566875;949.2263804998904;958.1951161024773;963.9084286992864;975.4295584109578;4954.430240522386;4995.300657907896;5004.874878128076;5012.774425150877;5027.4218464877;5311.203319502106;5321.467853214647;5337.893242135136;5343.19852022192;5358.535073866065;4768.356271903318;4975.992150994194;4988.276699878497;5021.07110184617;5032.270320803463;2769.3907340385085;2811.4658214939095;2823.8704518192885;2833.334166470878;2847.5301575239855;5478.835634930959;5487.917681234785;5501.504864562208;5530.86172845674;5535.418781028015;5125.820596279187;5354.732263386815;5358.437364076716;5374.381946076173;5410.3507579090765;5488.91766623501;5493.807716729895;5500.147477141049;5508.834734958038;5516.310461192351;5233.607479439133;5362.946370536245;5367.4364191759305;5368.919466207932;5376.892462150657;5034.295198672262;5174.6119041071315;5190.584753219658;5202.583793296603;5214.165733482776;5438.483344082306;5438.483344082306;5438.564914806885;5444.183372494158;5462.831557696447;3933.213357328603;3943.447917291524;3953.7627742335553;3969.483967084376;3973.245083434254;5150.639455238097;5202.505761952609;5211.879445919146;5293;5309.920351194813;5168.9741551292;5202.869928251824;5289.518934698291;5317.813876514303;5320.920186197132;5263.6052296078715;5272.367315922113;5275.235090911719;5284.9471505284455;5291.4443983382735;5131.692098474104;5210.739463026757;5259.21111833228;5274.630775845654;5304.9469505306;5298.470152984825;5330.280412144466;5344.35867695879;5353.197020446808;5355.196720491957;5232.555232805102;5253.842384728464;5255.842324730264;5256.316678831728;5273.709945953009 10:41:30 INFO - PROCESS | 22662 | |5;yui.html;725.285593690215;754.5962909843234;758.4311766175368;774.8256642255493;802.2258520527691;13045.478180872766;13405.262710550916;13406.597802065942;13443.1261967972;13447.260400677958;13157.539486117988;13238.205707657547;13277.535286264983;13324;13363.265020423873;656.1437324291797;672.2235817630644;756.6632848382473;772.6136931534232;772.7449941519285;760.4030835793903;765.7549584133079;768.1281745219161;768.4044865229436;770.0220719685996;800.0799081056803;800.2317774936068;800.4556901307109;800.5956991719173;801.4029547986758;689.0938415982966;796.80079980005;797.2067792546395;797.8603744344746;801.3749275565068;523.2256260734135;585.6076428792719;598.1954271504819;604.5586721693145;605.1346574398608;12302.938485307606;12303.138780285384;12307.26156430617;12331;12341.5063397464;13294;13377.933110334483;13662.316884155753;13865;13948.790768138486;11082.168837337233;11234.887651123548;11273.39273871443;11378.60174893883;11489.482973266224;4193.622573968358;4203.55862634422;4224.408582798411;4283.612944263323;4356.411884395598;61185.38814611886;61420;62232.68883655598;62929.37070629281;64080.35919640837;10471.214658900613;10507.00250784016;10584.523696433678;10588;10670.35977841332;17934;17958.551036223937;18013.7297940531;18105.909470452563;18116.547086322684;7665.8850117248285;7731.342835858903;7790.493617914817;7805.297523222937;7975.60121993898;4380.8904777380185;4404.2512772828695;4428.844990425384;4466.307722303049;4549.7497637629585;3336.9165770855925;3439.9312013759586;3440.8623655054016;3441.9311613767586;3444.0528854565196;575.2665351676645;588.1031427073747;588.8498432899669;610.4536439886277;619.9721012554446;564.6075977195892;612.7365232949875;639.341478277375;651.3291309950758;673.7776533743853;8569.700060497977;8829.205371516595;9367.203787677987;9597.376170549032;9747;567.5544697412512;623.1462895832739;629.380060640269;671.6809515480107;714.8034290570134;3909.237698648793;4285.314349704033;4309.892252693645;4316.568343165721;4403.873249992541;82817;83176.58411707902;84565.57717211498;84743;88532;47280.290795638095;59509.702451487465;72092;75583.62208189034;75743.24256757472;65783.67108164428;66022.03867767949;66865.66567167133;67963.66018169878;71114.64442677857;8293;8445.11326310753;8521.829563408573;8528.360372972176;8593.226609605166;41508.169836602494;41901.580984189764;43645.10791043169;43812.780936095114;44051.77974110109;57091.42908570861;57259.427405727074;61176;63170.36829631645;64928.675356622916;10657.413842238751;10832.458377081271;10928.94535527349;10991.945040275068;11316.773664526829;10834.152297566981;10887.129029677766;11093.112550996062;11115.110791136527;11348.773024539298;10759.30064545802;10787.244892857425;10880.727981800519;10894.400807955639;10995.835062474229;10901.672949811518;11099;11105.555777768799;11177.608783692533;11374.374409407563;10947.45262736844;11147.554097835995;11175;11185.32888026721;11243.775124497628;9569.808603828023;9611.944474980717;9623.267811793945;9635.084666956627;9955.800883982425;9774.657886973922;9950.701478955643;9967.950160249153;9989.850152247867;9998.300118991892 10:41:30 INFO - PROCESS | 22662 | __end_tp_report 10:41:30 INFO - PROCESS | 22662 | __start_cc_report 10:41:30 INFO - PROCESS | 22662 | _x_x_mozilla_cycle_collect,3056 10:41:30 INFO - PROCESS | 22662 | __end_cc_report 10:41:30 INFO - PROCESS | 22662 | __startTimestamp1478803290090__endTimestamp 10:41:30 INFO - PROCESS | 22662 | 10:41:30 INFO - PROCESS | 22662 | ------- Summary: start ------- 10:41:30 INFO - PROCESS | 22662 | Number of tests: 6 10:41:30 INFO - PROCESS | 22662 | 10:41:30 INFO - PROCESS | 22662 | [#0] dojo.html Cycles:165 Average:5236.14 Median:5462.00 stddev:599.60 (11.0%) stddev-sans-first:574.99 10:41:30 INFO - PROCESS | 22662 | Values: 2991.2 3001.6 3041.2 3058.3 3062.1 5070.3 5144.3 5228.6 5269.4 5335.6 5189.1 5238.7 5303.7 5317.1 5347.8 4681.5 4714.6 4752.9 4761.7 4814.6 4809.5 4821.9 4865.0 4871.1 4918.7 4685.1 4790.4 4805.3 4829.0 4899.2 4710.9 4762.0 4780.5 4783.5 4796.0 4674.0 4719.9 4749.8 4781.4 4791.9 5250.3 5279.5 5284.4 5290.9 5304.3 5660.7 5663.0 5670.8 5673.9 5721.3 5568.4 5630.2 5636.9 5679.8 5702.5 5253.4 5316.3 5316.3 5318.7 5321.1 5739.6 5778.5 5837.5 5883.1 5900.9 5620.6 5626.3 5626.8 5628.9 5669.7 5682.8 5685.2 5686.2 5686.3 5695.5 5425.0 5468.8 5474.0 5675.5 5679.1 5543.7 5555.4 5609.4 5633.2 5655.3 4256.1 4260.1 4262.7 4364.1 4368.3 3859.5 3871.2 3874.1 3883.5 3900.3 5240.9 5284.7 5315.7 5412.4 5462.0 5449.4 5550.3 5585.9 5600.9 5672.2 5280.6 5285.4 5307.2 5310.8 5318.2 4709.9 4834.2 4838.6 4847.3 4876.9 5654.5 5782.1 5827.3 5839.4 5930.3 5674.2 5678.9 5678.9 5683.4 5683.6 5859.8 5869.6 5869.8 5871.1 5874.6 5433.2 5461.2 5504.7 5582.1 5584.6 5625.8 5664.6 5680.3 5685.4 5689.7 5491.8 5492.9 5498.1 5500.3 5502.9 5476.1 5477.8 5483.3 5483.5 5488.9 5476.0 5481.9 5484.3 5485.2 5494.7 5446.1 5488.3 5490.6 5492.9 5493.3 5412.9 5423.8 5444.5 5491.9 5508.6 10:41:30 INFO - PROCESS | 22662 | 10:41:30 INFO - PROCESS | 22662 | [#1] ext.html Cycles:180 Average:55040.25 Median:38561.90 stddev:106363.97 (275.8%) stddev-sans-first:106583.78 10:41:30 INFO - PROCESS | 22662 | Values: 588.6 591.9 596.0 596.8 600.3 41420.0 42846.8 42958.6 45828.1 45859.3 43322.8 43660.8 43718.1 43735.3 43757.6 7880.1 8529.4 8682.0 8684.6 8688.0 7838.3 10022.6 10182.5 10197.3 10514.4 10341.7 10400.8 10404.6 10407.6 10434.2 10196.4 10232.8 10272.8 10274.7 10306.2 10090.7 10157.1 10172.7 10174.6 10184.8 40871.8 41216.2 41232.2 41242.8 41272.2 3376.5 3414.6 3462.7 3563.5 3590.6 30772.0 30913.8 31045.1 31112.7 31383.5 4086.7 4191.2 4236.5 4344.3 4369.6 243582.0 243721.0 243996.0 244142.0 244476.8 56628.2 56791.1 56842.1 57151.7 57234.4 54436.5 54931.7 54953.5 54960.5 55033.7 14167.3 14313.3 14325.8 14327.7 14336.4 8975.3 9173.0 10124.9 10143.4 11244.3 18735.5 19384.3 19431.0 19589.3 19624.0 7060.6 7153.7 7274.8 7321.0 7361.5 877.2 1030.5 1032.2 1042.5 1098.2 30857.5 30949.4 31028.7 31037.9 31151.2 1070.9 1076.6 1078.7 1133.7 1165.9 15780.4 16306.3 16382.9 16479.8 16773.3 515393.0 517237.0 517810.0 517912.0 519164.0 56715.4 57089.4 57397.0 57408.4 57553.1 1215.3 1234.7 1285.0 1290.7 1319.2 28324.3 31464.8 32052.0 32179.5 32513.2 48655.5 48673.5 49189.0 49201.8 49304.3 388795.2 393846.6 393962.0 395411.4 396798.0 28033.3 28542.4 28596.9 29847.7 41603.0 45180.3 45405.8 45949.3 46459.0 46893.0 38531.0 38923.0 39416.2 40360.8 40618.8 39335.8 39742.8 40223.8 40398.0 41374.6 38592.8 39284.2 40060.4 40062.6 40141.6 30871.4 34691.0 35520.0 36139.3 36216.6 26736.3 26834.9 26866.6 26947.3 27097.6 10:41:30 INFO - PROCESS | 22662 | 10:41:30 INFO - PROCESS | 22662 | [#2] jquery.html Cycles:180 Average:26501.81 Median:226301.79 stddev:69496.24 (30.7%) stddev-sans-first:69663.53 10:41:30 INFO - PROCESS | 22662 | Values: 382.8 393.7 403.8 407.5 419.1 13233.0 15262.0 18476.9 18894.7 19306.6 17923.7 18284.4 18560.7 18924.5 18940.3 5406.7 5433.1 5691.5 5700.3 5702.6 5267.8 5688.1 5707.6 5718.6 5722.6 5669.9 5676.9 5677.3 5679.1 6051.7 6307.7 6343.5 6406.0 6411.9 6414.1 5458.3 5601.3 5626.0 5660.5 5661.3 13996.4 14101.6 14170.5 19004.6 22768.9 2140.4 2324.2 2341.0 2385.2 2786.8 9690.3 9920.0 10219.4 10314.9 10422.8 1852.4 1857.6 1887.3 1903.4 1932.2 79203.0 81816.6 82381.6 82526.2 83535.0 10620.3 10785.8 11079.8 11578.3 11686.8 15146.8 15297.0 15299.6 15308.0 15326.2 6961.2 7116.8 7196.2 7379.7 7420.2 6608.6 6628.2 6629.8 6845.6 6861.5 4552.7 4619.6 4638.7 4659.4 4744.3 1911.8 1939.4 1969.2 1973.8 1976.7 876.9 926.9 937.7 987.3 1052.6 17617.6 18846.6 18856.7 18903.3 19413.0 929.5 929.6 964.8 971.9 980.3 10022.6 10533.4 10541.4 10630.7 10635.0 406364.0 411594.0 421053.0 421333.0 432621.0 86526.0 90145.5 90744.0 90963.5 91194.0 975.7 977.7 979.7 981.9 992.9 15779.4 16126.2 16334.5 16405.3 16564.0 39646.0 41009.6 41810.6 41858.4 42520.6 54490.7 55765.7 56368.7 56536.7 57110.0 8364.7 8579.5 8615.4 8801.3 8859.7 11743.3 12209.9 12248.8 12647.7 12833.3 10800.5 11092.8 11222.0 11251.7 11260.7 10820.6 11042.0 11355.9 11464.2 11613.4 11208.4 11223.2 11853.3 11913.8 11935.8 8515.1 8585.5 8590.4 8849.2 8925.4 10438.8 11203.2 11259.4 11317.8 11606.4 10:41:30 INFO - PROCESS | 22662 | 10:41:30 INFO - PROCESS | 22662 | [#3] mootools.html Cycles:180 Average:5452.34 Median:5167.79 stddev:3038.10 (58.8%) stddev-sans-first:3030.88 10:41:30 INFO - PROCESS | 22662 | Values: 1338.0 1422.6 1471.4 1597.9 1748.5 7124.6 7591.1 7787.5 7798.3 8011.7 7762.5 7763.7 7773.3 7777.0 7779.9 2260.2 2283.9 2288.8 2292.1 2292.2 2206.6 2257.7 2266.0 2274.3 2278.1 2234.3 2237.9 2257.2 2257.3 2261.3 2164.1 2177.1 2188.0 2189.6 2193.6 2199.4 2210.5 2211.0 2216.2 2221.1 7856.1 7953.2 8241.6 8282.6 8386.8 5073.1 5277.8 5284.3 5291.2 5298.2 3289.1 3439.6 3469.1 3497.4 3526.3 1092.8 1093.4 1095.6 1131.7 1164.9 11407.9 11463.8 11501.9 11593.8 11625.2 4048.4 4360.8 4413.2 4430.4 4454.8 9175.6 9190.2 9196.4 9200.8 9214.3 5002.4 5068.6 5081.7 5084.2 5087.6 4135.8 4274.2 4557.4 4679.5 4733.6 3522.7 3548.9 3605.2 3684.4 3698.9 1154.8 1156.0 1164.8 1166.1 1166.3 818.0 835.1 890.4 906.3 922.5 5503.6 5628.8 5694.7 5708.0 5796.1 893.5 926.5 933.2 933.8 946.8 3537.9 3752.4 3781.2 3794.9 3917.1 10136.6 10429.0 10469.4 10470.4 10482.7 9702.2 10144.8 10347.1 10419.4 10525.5 7746.2 7904.6 7925.2 7939.1 7947.1 5494.0 5622.7 5677.8 5766.6 5954.5 9557.5 9583.1 9584.7 9598.3 9607.9 9106.1 9324.2 9469.4 9699.3 9702.2 6774.4 6894.5 6895.2 7333.6 7487.2 7453.7 7512.1 7754.1 7999.4 8014.1 7251.1 7335.6 7346.5 7449.4 7527.2 7125.6 7191.6 7209.0 7381.3 7439.7 6509.2 6606.9 6626.5 6628.7 6648.6 5004.1 5033.0 5104.3 5121.9 5217.2 5020.7 5076.9 5213.7 5234.9 5279.4 10:41:30 INFO - PROCESS | 22662 | 10:41:30 INFO - PROCESS | 22662 | [#4] prototype.html Cycles:180 Average:4465.18 Median:5081.28 stddev:1278.28 (25.2%) stddev-sans-first:1243.37 10:41:30 INFO - PROCESS | 22662 | Values: 316.7 325.7 332.9 337.1 337.8 4981.2 5082.2 5108.9 5155.7 5170.7 4939.9 5005.7 5067.7 5080.4 5087.2 4034.7 4041.8 4047.5 4054.0 4057.6 3737.5 3830.9 4037.6 4044.4 4071.5 3989.7 4011.0 4012.6 4024.2 4029.1 4002.8 4009.7 4015.6 4017.6 4025.2 3577.8 3580.1 3609.4 3614.5 3624.5 4930.2 5011.3 5012.0 5018.3 5029.2 4632.3 4644.5 4648.7 4649.8 4654.2 5367.9 5370.3 5370.6 5375.9 5432.4 3817.9 3924.9 3954.5 3956.9 3959.7 5506.2 5516.9 5520.4 5522.8 5525.2 4044.0 4044.8 4050.5 4056.9 4078.9 3935.3 4000.4 4034.0 4070.0 4123.9 4536.8 4538.8 4547.3 4549.4 4564.2 5289.2 5320.6 5324.2 5327.4 5333.3 1275.1 1311.5 1335.4 1371.1 1374.5 946.2 949.2 958.2 963.9 975.4 4954.4 4995.3 5004.9 5012.8 5027.4 5311.2 5321.5 5337.9 5343.2 5358.5 4768.4 4976.0 4988.3 5021.1 5032.3 2769.4 2811.5 2823.9 2833.3 2847.5 5478.8 5487.9 5501.5 5530.9 5535.4 5125.8 5354.7 5358.4 5374.4 5410.4 5488.9 5493.8 5500.1 5508.8 5516.3 5233.6 5362.9 5367.4 5368.9 5376.9 5034.3 5174.6 5190.6 5202.6 5214.2 5438.5 5438.5 5438.6 5444.2 5462.8 3933.2 3943.4 3953.8 3969.5 3973.2 5150.6 5202.5 5211.9 5293.0 5309.9 5169.0 5202.9 5289.5 5317.8 5320.9 5263.6 5272.4 5275.2 5284.9 5291.4 5131.7 5210.7 5259.2 5274.6 5304.9 5298.5 5330.3 5344.4 5353.2 5355.2 5232.6 5253.8 5255.8 5256.3 5273.7 10:41:30 INFO - PROCESS | 22662 | 10:41:30 INFO - PROCESS | 22662 | [#5] yui.html Cycles:180 Average:16660.48 Median:28917.35 stddev:22443.11 (77.6%) stddev-sans-first:22474.17 10:41:30 INFO - PROCESS | 22662 | Values: 725.3 754.6 758.4 774.8 802.2 13045.5 13405.3 13406.6 13443.1 13447.3 13157.5 13238.2 13277.5 13324.0 13363.3 656.1 672.2 756.7 772.6 772.7 760.4 765.8 768.1 768.4 770.0 800.1 800.2 800.5 800.6 801.4 689.1 796.8 797.2 797.9 801.4 523.2 585.6 598.2 604.6 605.1 12302.9 12303.1 12307.3 12331.0 12341.5 13294.0 13377.9 13662.3 13865.0 13948.8 11082.2 11234.9 11273.4 11378.6 11489.5 4193.6 4203.6 4224.4 4283.6 4356.4 61185.4 61420.0 62232.7 62929.4 64080.4 10471.2 10507.0 10584.5 10588.0 10670.4 17934.0 17958.6 18013.7 18105.9 18116.5 7665.9 7731.3 7790.5 7805.3 7975.6 4380.9 4404.3 4428.8 4466.3 4549.7 3336.9 3439.9 3440.9 3441.9 3444.1 575.3 588.1 588.8 610.5 620.0 564.6 612.7 639.3 651.3 673.8 8569.7 8829.2 9367.2 9597.4 9747.0 567.6 623.1 629.4 671.7 714.8 3909.2 4285.3 4309.9 4316.6 4403.9 82817.0 83176.6 84565.6 84743.0 88532.0 47280.3 59509.7 72092.0 75583.6 75743.2 65783.7 66022.0 66865.7 67963.7 71114.6 8293.0 8445.1 8521.8 8528.4 8593.2 41508.2 41901.6 43645.1 43812.8 44051.8 57091.4 57259.4 61176.0 63170.4 64928.7 10657.4 10832.5 10928.9 10991.9 11316.8 10834.2 10887.1 11093.1 11115.1 11348.8 10759.3 10787.2 10880.7 10894.4 10995.8 10901.7 11099.0 11105.6 11177.6 11374.4 10947.5 11147.6 11175.0 11185.3 11243.8 9569.8 9611.9 9623.3 9635.1 9955.8 9774.7 9950.7 9968.0 9989.9 9998.3 10:41:30 INFO - PROCESS | 22662 | -------- Summary: end -------- 10:41:30 INFO - PROCESS | 22662 | 10:41:31 INFO - TEST-INFO | 22662: exit 0 10:41:31 INFO - TEST-OK | dromaeo_css | took 1118914ms 10:41:31 INFO - TEST-START | kraken 10:41:31 INFO - operating with platform_type : linux_ 10:41:31 INFO - Initialising browser for kraken test... 10:41:31 INFO - TEST-INFO | started process 22971 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCo6FtR/profile http://localhost:58218/getInfo.html) 10:41:35 INFO - PROCESS | 22971 | __metrics Screen width/height:1600/1200 10:41:35 INFO - PROCESS | 22971 | colorDepth:24 10:41:35 INFO - PROCESS | 22971 | Browser inner width/height: 1024/697 10:41:35 INFO - PROCESS | 22971 | __metrics 10:41:36 INFO - PROCESS | 22971 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:41:36 INFO - PROCESS | 22971 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:41:36 INFO - PROCESS | 22971 | console.error: PushService: 10:41:36 INFO - PROCESS | 22971 | stateChangeProcessEnqueue: Error transitioning state 10:41:36 INFO - PROCESS | 22971 | UnknownError 10:41:37 INFO - TEST-INFO | 22971: exit 0 10:41:37 INFO - Browser initialized. 10:41:37 INFO - Running cycle 1/1 for kraken test... 10:41:37 INFO - TEST-INFO | started process 23053 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCo6FtR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:41:49 INFO - PROCESS | 23053 | RSS: Main: 172740608 10:41:49 INFO - PROCESS | 23053 | 10:41:52 INFO - PROCESS | 23053 | Cycle 1(1): loaded http://localhost:58218/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58218/tests/kraken/driver.html?testName=audio-beat-detection) 10:41:52 INFO - PROCESS | 23053 | RSS: Main: 229449728 10:41:52 INFO - PROCESS | 23053 | 10:41:55 INFO - PROCESS | 23053 | Cycle 1(1): loaded http://localhost:58218/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58218/tests/kraken/driver.html?testName=audio-dft) 10:41:56 INFO - PROCESS | 23053 | RSS: Main: 215891968 10:41:56 INFO - PROCESS | 23053 | 10:41:59 INFO - PROCESS | 23053 | Cycle 1(1): loaded http://localhost:58218/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58218/tests/kraken/driver.html?testName=audio-fft) 10:41:59 INFO - PROCESS | 23053 | RSS: Main: 297074688 10:41:59 INFO - PROCESS | 23053 | 10:42:01 INFO - PROCESS | 23053 | Cycle 1(1): loaded http://localhost:58218/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58218/tests/kraken/driver.html?testName=audio-oscillator) 10:42:02 INFO - PROCESS | 23053 | RSS: Main: 208445440 10:42:02 INFO - PROCESS | 23053 | 10:42:04 INFO - PROCESS | 23053 | Cycle 1(1): loaded http://localhost:58218/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58218/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:42:05 INFO - PROCESS | 23053 | RSS: Main: 212267008 10:42:05 INFO - PROCESS | 23053 | 10:42:08 INFO - PROCESS | 23053 | Cycle 1(1): loaded http://localhost:58218/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58218/tests/kraken/driver.html?testName=imaging-darkroom) 10:42:08 INFO - PROCESS | 23053 | RSS: Main: 248369152 10:42:08 INFO - PROCESS | 23053 | 10:42:12 INFO - PROCESS | 23053 | Cycle 1(1): loaded http://localhost:58218/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58218/tests/kraken/driver.html?testName=imaging-desaturate) 10:42:12 INFO - PROCESS | 23053 | RSS: Main: 246882304 10:42:12 INFO - PROCESS | 23053 | 10:42:15 INFO - PROCESS | 23053 | Cycle 1(1): loaded http://localhost:58218/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58218/tests/kraken/driver.html?testName=json-parse-financial) 10:42:16 INFO - PROCESS | 23053 | RSS: Main: 246468608 10:42:16 INFO - PROCESS | 23053 | 10:42:17 INFO - PROCESS | 23053 | Cycle 1(1): loaded http://localhost:58218/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58218/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:42:18 INFO - PROCESS | 23053 | RSS: Main: 208764928 10:42:18 INFO - PROCESS | 23053 | 10:42:19 INFO - PROCESS | 23053 | Cycle 1(1): loaded http://localhost:58218/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58218/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:42:20 INFO - PROCESS | 23053 | RSS: Main: 214999040 10:42:20 INFO - PROCESS | 23053 | 10:42:22 INFO - PROCESS | 23053 | Cycle 1(1): loaded http://localhost:58218/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58218/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:42:23 INFO - PROCESS | 23053 | RSS: Main: 225046528 10:42:23 INFO - PROCESS | 23053 | 10:42:25 INFO - PROCESS | 23053 | Cycle 1(1): loaded http://localhost:58218/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58218/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:42:26 INFO - PROCESS | 23053 | RSS: Main: 233648128 10:42:26 INFO - PROCESS | 23053 | 10:42:29 INFO - PROCESS | 23053 | Cycle 1(1): loaded http://localhost:58218/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58218/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:42:29 INFO - PROCESS | 23053 | RSS: Main: 231006208 10:42:29 INFO - PROCESS | 23053 | 10:42:31 INFO - PROCESS | 23053 | Cycle 1(1): loaded http://localhost:58218/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58218/tests/kraken/driver.html?testName=ai-astar) 10:42:31 INFO - PROCESS | 23053 | RSS: Main: 279793664 10:42:31 INFO - PROCESS | 23053 | 10:42:31 INFO - PROCESS | 23053 | __start_tp_report 10:42:31 INFO - PROCESS | 23053 | _x_x_mozilla_page_load 10:42:31 INFO - PROCESS | 23053 | _x_x_mozilla_page_load_details 10:42:31 INFO - PROCESS | 23053 | |i|pagename|runs| 10:42:31 INFO - PROCESS | 23053 | |0;ai-astar;104;112;112;115;112;112;113;113;114;112 10:42:31 INFO - PROCESS | 23053 | |1;audio-beat-detection;148;121;123;173;125;131;125;128;153;127 10:42:31 INFO - PROCESS | 23053 | |2;audio-dft;160;159;161;160;161;161;160;161;160;162 10:42:31 INFO - PROCESS | 23053 | |3;audio-fft;76;76;76;104;77;78;74;75;101;75 10:42:31 INFO - PROCESS | 23053 | |4;audio-oscillator;83;82;109;84;82;82;106;82;83;117 10:42:31 INFO - PROCESS | 23053 | |5;imaging-gaussian-blur;117;117;117;117;116;116;117;117;117;117 10:42:31 INFO - PROCESS | 23053 | |6;imaging-darkroom;147;146;147;147;147;146;146;146;146;146 10:42:31 INFO - PROCESS | 23053 | |7;imaging-desaturate;85;84;85;85;85;85;85;84;85;85 10:42:31 INFO - PROCESS | 23053 | |8;json-parse-financial;54;53;53;53;54;54;55;54;54;54 10:42:31 INFO - PROCESS | 23053 | |9;json-stringify-tinderbox;63;64;63;64;64;63;63;63;64;65 10:42:31 INFO - PROCESS | 23053 | |10;stanford-crypto-aes;89;81;85;80;79;79;78;91;85;80 10:42:31 INFO - PROCESS | 23053 | |11;stanford-crypto-ccm;137;140;135;131;140;144;130;129;176;133 10:42:31 INFO - PROCESS | 23053 | |12;stanford-crypto-pbkdf2;167;164;164;164;169;163;167;162;161;161 10:42:31 INFO - PROCESS | 23053 | |13;stanford-crypto-sha256-iterative;65;68;65;71;63;62;64;64;64;63 10:42:31 INFO - PROCESS | 23053 | __end_tp_report 10:42:31 INFO - PROCESS | 23053 | __start_cc_report 10:42:31 INFO - PROCESS | 23053 | _x_x_mozilla_cycle_collect,1703 10:42:31 INFO - PROCESS | 23053 | __end_cc_report 10:42:31 INFO - PROCESS | 23053 | __startTimestamp1478803351859__endTimestamp 10:42:31 INFO - PROCESS | 23053 | 10:42:31 INFO - PROCESS | 23053 | ------- Summary: start ------- 10:42:31 INFO - PROCESS | 23053 | Number of tests: 14 10:42:31 INFO - PROCESS | 23053 | 10:42:31 INFO - PROCESS | 23053 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.50 stddev:2.96 (2.6%) stddev-sans-first:1.09 10:42:31 INFO - PROCESS | 23053 | Values: 104.0 112.0 112.0 115.0 112.0 112.0 113.0 113.0 114.0 112.0 10:42:31 INFO - PROCESS | 23053 | 10:42:31 INFO - PROCESS | 23053 | [#1] audio-beat-detection Cycles:10 Average:135.40 Median:129.50 stddev:17.01 (13.1%) stddev-sans-first:17.42 10:42:31 INFO - PROCESS | 23053 | Values: 148.0 121.0 123.0 173.0 125.0 131.0 125.0 128.0 153.0 127.0 10:42:31 INFO - PROCESS | 23053 | 10:42:31 INFO - PROCESS | 23053 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 10:42:31 INFO - PROCESS | 23053 | Values: 160.0 159.0 161.0 160.0 161.0 161.0 160.0 161.0 160.0 162.0 10:42:31 INFO - PROCESS | 23053 | 10:42:31 INFO - PROCESS | 23053 | [#3] audio-fft Cycles:10 Average:81.20 Median:76.00 stddev:11.30 (14.9%) stddev-sans-first:11.83 10:42:31 INFO - PROCESS | 23053 | Values: 76.0 76.0 76.0 104.0 77.0 78.0 74.0 75.0 101.0 75.0 10:42:31 INFO - PROCESS | 23053 | 10:42:31 INFO - PROCESS | 23053 | [#4] audio-oscillator Cycles:10 Average:91.00 Median:82.00 stddev:13.85 (16.9%) stddev-sans-first:14.38 10:42:31 INFO - PROCESS | 23053 | Values: 83.0 82.0 109.0 84.0 82.0 82.0 106.0 82.0 83.0 117.0 10:42:31 INFO - PROCESS | 23053 | 10:42:31 INFO - PROCESS | 23053 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:42:31 INFO - PROCESS | 23053 | Values: 117.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 10:42:31 INFO - PROCESS | 23053 | 10:42:31 INFO - PROCESS | 23053 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 10:42:31 INFO - PROCESS | 23053 | Values: 147.0 146.0 147.0 147.0 147.0 146.0 146.0 146.0 146.0 146.0 10:42:31 INFO - PROCESS | 23053 | 10:42:31 INFO - PROCESS | 23053 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 10:42:31 INFO - PROCESS | 23053 | Values: 85.0 84.0 85.0 85.0 85.0 85.0 85.0 84.0 85.0 85.0 10:42:31 INFO - PROCESS | 23053 | 10:42:31 INFO - PROCESS | 23053 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:0.63 (1.2%) stddev-sans-first:0.67 10:42:31 INFO - PROCESS | 23053 | Values: 54.0 53.0 53.0 53.0 54.0 54.0 55.0 54.0 54.0 54.0 10:42:31 INFO - PROCESS | 23053 | 10:42:31 INFO - PROCESS | 23053 | [#9] json-stringify-tinderbox Cycles:10 Average:63.60 Median:64.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 10:42:31 INFO - PROCESS | 23053 | Values: 63.0 64.0 63.0 64.0 64.0 63.0 63.0 63.0 64.0 65.0 10:42:31 INFO - PROCESS | 23053 | 10:42:31 INFO - PROCESS | 23053 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:83.00 stddev:4.55 (5.5%) stddev-sans-first:4.21 10:42:31 INFO - PROCESS | 23053 | Values: 89.0 81.0 85.0 80.0 79.0 79.0 78.0 91.0 85.0 80.0 10:42:31 INFO - PROCESS | 23053 | 10:42:31 INFO - PROCESS | 23053 | [#11] stanford-crypto-ccm Cycles:10 Average:139.50 Median:138.50 stddev:13.72 (9.9%) stddev-sans-first:14.52 10:42:31 INFO - PROCESS | 23053 | Values: 137.0 140.0 135.0 131.0 140.0 144.0 130.0 129.0 176.0 133.0 10:42:31 INFO - PROCESS | 23053 | 10:42:31 INFO - PROCESS | 23053 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.20 Median:164.00 stddev:2.70 (1.6%) stddev-sans-first:2.67 10:42:31 INFO - PROCESS | 23053 | Values: 167.0 164.0 164.0 164.0 169.0 163.0 167.0 162.0 161.0 161.0 10:42:31 INFO - PROCESS | 23053 | 10:42:31 INFO - PROCESS | 23053 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:64.50 stddev:2.69 (4.2%) stddev-sans-first:2.85 10:42:31 INFO - PROCESS | 23053 | Values: 65.0 68.0 65.0 71.0 63.0 62.0 64.0 64.0 64.0 63.0 10:42:31 INFO - PROCESS | 23053 | -------- Summary: end -------- 10:42:31 INFO - PROCESS | 23053 | 10:42:33 INFO - TEST-INFO | 23053: exit 0 10:42:33 INFO - TEST-OK | kraken | took 62073ms 10:42:33 INFO - SUITE-END | took 1180s 10:42:33 INFO - Completed test suite (00:19:41) 10:42:33 INFO - javascript benchmark 10:42:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2991.2073300575344, 3001.5797788309656, 3041.2396900774797, 3058.2507285714987, 3062.111987523618, 5070.2901593776805, 5144.279800827878, 5228.607854410915, 5269.446708095647, 5335.573154147669, 5189.143791274435, 5238.738063096849, 5303.734813259341, 5317.069512835248, 5347.812826551071, 4681.531846815308, 4714.646401519883, 4752.928706069411, 4761.666683332168, 4814.590759785422, 4809.519048095198, 4821.927671084936, 4865.026994601077, 4871.074495845778, 4918.655694101414, 4685.086408150378, 4790.42514898211, 4805.327254184417, 4829.034193161382, 4899.191633380506, 4710.858674239778, 4762.047590481918, 4780.49804770501, 4783.473817880031, 4795.952040479586, 4674.041821426599, 4719.882002949919, 4749.786259618291, 4781.402324709411, 4791.856244312677, 5250.317458730341, 5279.52484276417, 5284.445133260991, 5290.867728306785, 5304.310439642861, 5660.7355159701465, 5663.037283661787, 5670.829875103754, 5673.886522269573, 5721.256236689245, 5568.443155684439, 5630.239917611111, 5636.859078523029, 5679.772809087632, 5702.486776190121, 5253.448387919251, 5316.255724198615, 5316.308879845634, 5318.70747108905, 5321.068812957795, 5739.569532285095, 5778.451047150514, 5837.474627283565, 5883.117532370093, 5900.881982360329, 5620.57845661577, 5626.324841019104, 5626.831195064155, 5628.85927851807, 5669.744861481243, 5682.801101961411, 5685.1756495307945, 5686.175504551817, 5686.289213848269, 5695.5443564514735, 5424.996375670514, 5468.781248750085, 5474.0, 5675.460831221028, 5679.119736440858, 5543.695096769717, 5555.416681248492, 5609.4390560943575, 5633.183188437653, 5655.321361436654, 4256.084941737541, 4260.062786187033, 4262.722923009995, 4364.10535840152, 4368.27923392643, 3859.5368555772925, 3871.2257548490416, 3874.050857539921, 3883.4951456311064, 3900.258950799339, 5240.895182096337, 5284.709340986283, 5315.73421328932, 5412.3505179377935, 5462.0, 5449.373322067933, 5550.278463799761, 5585.888282234332, 5600.85997850057, 5672.177534257509, 5280.630355875129, 5285.418603953562, 5307.230451584576, 5310.840674779763, 5318.202269659582, 4709.905801883943, 4834.20235661112, 4838.612910967114, 4847.2729090635985, 4876.926846097312, 5654.46282603152, 5782.132680098019, 5827.300723912988, 5839.386864379179, 5930.258717660293, 5674.233978412862, 5678.858028549319, 5678.914816277676, 5683.431656834449, 5683.602147849776, 5859.765609375577, 5869.647821130746, 5869.765209391577, 5871.089981052944, 5874.647521148574, 5433.157860531624, 5461.235427040297, 5504.669719816824, 5582.106862901916, 5584.636998595079, 5625.803096891589, 5664.5751568631695, 5680.2615659965595, 5685.374608793112, 5689.6586204827845, 5491.752871120889, 5492.91760623583, 5498.065328894178, 5500.312460942382, 5502.862428439321, 5476.096444086681, 5477.780888764564, 5483.259759932358, 5483.533899618417, 5488.917666235089, 5476.04169270384, 5481.917771233514, 5484.2596249507405, 5485.232067510631, 5494.697791621499, 5446.101393270224, 5488.286522752176, 5490.5607551395, 5492.91760623583, 5493.313335833021, 5412.918806217988, 5423.83728488146, 5444.537214336668, 5491.890162196813, 5508.586855985737], "value": 5195.303666353541, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.599134060935, 591.9319278282999, 595.9927722149567, 596.7732261740538, 600.2856600645232, 41420.0, 42846.78576607117, 42958.57041429585, 45828.0834383313, 45859.31211031837, 43322.7833860831, 43660.78169609147, 43718.12563748723, 43735.343969840476, 43757.56242437575, 7880.054393472791, 8529.360297977646, 8681.95659021704, 8684.60919258635, 8687.95656021719, 7838.294553490185, 10022.599096036187, 10182.490875456235, 10197.286189966706, 10514.421706806123, 10341.741456463573, 10400.843987340197, 10404.63583774568, 10407.583696652126, 10434.165266778677, 10196.439195844225, 10232.795344093076, 10272.845907311395, 10274.743131421737, 10306.227032972558, 10090.688210532657, 10157.136643385322, 10172.694819155437, 10174.643887463903, 10184.847227291597, 40871.79564102161, 41216.1756764866, 41232.175356493004, 41242.79378603118, 41272.174556509, 3376.5272861799367, 3414.5902491701154, 3462.7056700180515, 3563.4832949222478, 3590.622984586607, 30772.0, 30913.845430772926, 31045.0686479406, 31112.688873111205, 31383.529247061313, 4086.6934979876332, 4191.245575796355, 4236.51280102789, 4344.348347747831, 4369.60673539383, 243582.0, 243721.0, 243996.0, 244142.0, 244476.776161193, 56628.15057774137, 56791.14813277804, 56842.14736778952, 57151.714241428526, 57234.42765572374, 54436.45563544314, 54931.725341373836, 54953.45046549563, 54960.45039549634, 55033.724831375584, 14167.291635418187, 14313.28433578317, 14325.78511322331, 14327.713445731028, 14336.354864031144, 8975.28197744179, 9172.954135229282, 10124.949375253223, 10143.391396516232, 11244.26912250701, 18735.531611709815, 19384.327712178412, 19431.014048607503, 19589.27803717289, 19624.0, 7060.576365418091, 7153.6780844862105, 7274.781756547312, 7320.9633951830965, 7361.521501102411, 877.2061284537504, 1030.4796077980723, 1032.1794173631981, 1042.4943902207424, 1098.203802243383, 30857.537136942963, 30949.381012380076, 31028.68971310303, 31037.913673021787, 31151.221219469695, 1070.8661417322835, 1076.612419528969, 1078.665613659768, 1133.727905302738, 1165.8950694437542, 15780.368785248691, 16306.347746090261, 16382.918085409736, 16479.752803707954, 16773.32906683719, 515393.0, 517237.0, 517810.0, 517912.0, 519164.0, 56715.43284567101, 57089.42910570841, 57397.0, 57408.42591574114, 57553.13670294949, 1215.2526196389158, 1234.6542967969162, 1284.9678758031123, 1290.6902343437507, 1319.2150670351125, 28324.291892702848, 31464.842675786476, 32052.0, 32179.51730723994, 32513.187170319987, 48655.5134448651, 48673.513264866895, 49189.0, 49201.753991229816, 49304.260436094206, 388795.2325244164, 393846.61533846386, 393962.0, 395411.3670906378, 396798.0, 28033.299167520974, 28542.42915141727, 28596.857015714788, 29847.70152298449, 41603.0, 45180.322295166254, 45405.77297113493, 45949.31076033929, 46459.0, 46893.0, 38531.0, 38923.0, 39416.2116757669, 40360.79819600883, 40618.79690601528, 39335.803320983214, 39742.80128599339, 40223.79888100541, 40397.990050248976, 41374.58625413707, 38592.80703596464, 39284.214315714096, 40060.399094014196, 40062.599374005884, 40141.59858401379, 30871.38257234798, 34691.0, 35520.0, 36139.27721445504, 36216.637833621324, 26736.305477809034, 26834.865825671528, 26866.59700104539, 26947.326316842235, 27097.593536097367], "value": 19581.06828013182, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.8258142545139, 393.7204584744831, 403.7577453527884, 407.54151579473097, 419.1010282943087, 13232.999999999987, 15262.0, 18476.907615461903, 18894.716579251322, 19306.613867722637, 17923.73114403285, 18284.360047398342, 18560.72158917614, 18924.526886827836, 18940.337088201915, 5406.702631355274, 5433.1035379162395, 5691.4877661010505, 5700.344460387047, 5702.600817942745, 5267.815626453075, 5688.089905615102, 5707.571932105088, 5718.628289161191, 5722.599418040739, 5669.886602267973, 5676.886462270752, 5677.261955945722, 5679.062954612484, 6051.697415129248, 6307.684615769193, 6343.46080583151, 6406.03909413587, 6411.871762564746, 6414.102025716404, 5458.317710286215, 5601.319604118748, 5625.971870140664, 5660.547156227533, 5661.348944871352, 13996.440142394293, 14101.64745881351, 14170.504032358922, 19004.61990760177, 22768.886155569115, 2140.4327853118934, 2324.1633012115626, 2340.9699732117815, 2385.2367242482414, 2786.763125134366, 9690.273229507744, 9919.950400247953, 10219.386836789816, 10314.896851031468, 10422.843657345145, 1852.351676913083, 1857.5541869951114, 1887.3488646416963, 1903.381401044666, 1932.1884808380514, 79203.0, 81816.59091704563, 82381.58809205976, 82526.17473825245, 83535.0, 10620.300751879662, 10785.78428431427, 11079.833802492969, 11578.305301681758, 11686.76626467466, 15146.772798408032, 15297.0, 15299.617509562127, 15308.0, 15326.23368831554, 6961.199462061826, 7116.750913717995, 7196.208417074117, 7379.6679149438405, 7420.183779784327, 6608.603483790988, 6628.204615446178, 6629.834254143589, 6845.562431889359, 6861.519693621399, 4552.70407423523, 4619.5611416915335, 4638.652101092432, 4659.370984916993, 4744.335792988984, 1911.7705875295053, 1939.3697048459308, 1969.2221572479077, 1973.8124878136555, 1976.6540855350543, 876.9429987050949, 926.8563372677246, 937.7186843946789, 987.3236832769433, 1052.5894900988621, 17617.647647047244, 18846.623067538574, 18856.717149242773, 18903.338383156522, 19413.0, 929.4841363043575, 929.6420877962033, 964.8070385922844, 971.8560456921853, 980.2648013989508, 10022.599096036078, 10533.36799792015, 10541.367517948947, 10630.681079567625, 10635.04284614373, 406364.0, 411594.0, 421053.0, 421333.0, 432621.0, 86525.97241146062, 90145.54927225322, 90744.0, 90963.54518227366, 91194.0, 975.6926568131016, 977.6871401151706, 979.7060881735451, 981.8919918808925, 992.9156021738233, 15779.368825246862, 16126.193690315671, 16334.509964701077, 16405.343786248417, 16564.0, 39646.0, 41009.589904100576, 41810.620601408475, 41858.37212441877, 42520.57479425166, 54490.72754636202, 55765.72117139388, 56368.718156408955, 56536.71731641315, 57110.0, 8364.66541338364, 8579.528125953133, 8615.439996400213, 8801.295896328407, 8859.734207973772, 11743.295402275891, 12209.877901221229, 12248.75502489963, 12647.683807904508, 12833.280995319472, 10800.479317072006, 11092.833607496055, 11222.0, 11251.662450126509, 11260.662180134608, 10820.621278255223, 11042.0, 11355.886441135483, 11464.197506174487, 11613.361265130161, 11208.383538905438, 11223.214374993671, 11853.288802671867, 11913.761724765283, 11935.820962685393, 8515.148485151436, 8585.527795971282, 8590.441621294596, 8849.159329863653, 8925.375223734276, 10438.843417348899, 11203.215774896005, 11259.380734059705, 11317.830232546683, 11606.361650108987], "value": 8891.312290070655, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1337.97324053519, 1422.551896152712, 1471.41143542583, 1597.8801589880761, 1748.466717651116, 7124.643767811608, 7591.127020392656, 7787.4548781585245, 7798.25916537928, 8011.6795328186945, 7762.534247945127, 7763.650635721392, 7773.339266162383, 7777.0, 7779.8833017504785, 2260.1863329201433, 2283.8743869087193, 2288.8054515366216, 2292.083166733303, 2292.197730794225, 2206.6028114939304, 2257.6500642400374, 2265.954680906381, 2274.3290729234914, 2278.065992942894, 2234.2850287907877, 2237.9104835806547, 2257.164849005862, 2257.3340864444945, 2261.2650888461235, 2164.1496520475084, 2177.096504950444, 2188.0372636040092, 2189.6496560550313, 2193.638049721794, 2199.439143018536, 2210.458437682778, 2210.9668354974688, 2216.1910902520626, 2221.144859229192, 7856.057273127204, 7953.244441778022, 8241.629126689253, 8282.627281772275, 8386.8322633547, 5073.061483625541, 5277.762500687479, 5284.313039304904, 5291.1798671206025, 5298.15229563268, 3289.1283809790184, 3439.638837922032, 3469.1153755792366, 3497.352989696889, 3526.3299973005046, 1092.83607458881, 1093.420487141808, 1095.5727266366123, 1131.6831287239586, 1164.90680745541, 11407.942960285229, 11463.770724585545, 11501.884981150166, 11593.76812463746, 11625.186236963416, 4048.39274108886, 4360.760158191267, 4413.22768515515, 4430.357598148251, 4454.844080457168, 9175.58709858058, 9190.172884440433, 9196.448213107235, 9200.815983680423, 9214.262858971266, 5002.449730529639, 5068.594512438996, 5081.669691470117, 5084.237364395296, 5087.643864929493, 4135.751854888656, 4274.187904298174, 4557.361969324297, 4679.532046795293, 4733.621310295168, 3522.6653467920505, 3548.91127721809, 3605.2428989911887, 3684.392075307544, 3698.8890333290046, 1154.8036833738286, 1155.9768804623861, 1164.7845148647527, 1166.1428849795393, 1166.3177041430688, 817.9856977348046, 835.1314632781839, 890.3589415620743, 906.3202598051462, 922.5064590444215, 5503.642263252876, 5628.774849005994, 5694.715264236772, 5708.029634962067, 5796.1305804129715, 893.4862454088925, 926.4580220570907, 933.2021121940643, 933.8085692433035, 946.8201041802035, 3537.858485660596, 3752.380857158593, 3781.2248489059675, 3794.924101517954, 3917.0794863207125, 10136.645217417503, 10429.0, 10469.424181670081, 10470.424126672953, 10482.737931551772, 9702.175315098155, 10144.797104057878, 10347.12049475803, 10419.374837509773, 10525.526351314209, 7746.225377462321, 7904.56524891125, 7925.207479252029, 7939.087004994384, 7947.086085100172, 5494.0, 5622.746976385991, 5677.801276955287, 5766.625169363978, 5954.46409823118, 9557.522123893916, 9583.137517623447, 9584.712458626253, 9598.32811703202, 9607.903920960702, 9106.089391061107, 9324.160825525463, 9469.431834089977, 9699.272554558578, 9702.175315098013, 6774.42417394527, 6894.517383783087, 6895.241523432318, 7333.559986400833, 7487.176410594721, 7453.664585093576, 7512.13610434807, 7754.069511658637, 7999.360051195774, 8014.078380986028, 7251.1298644163035, 7335.633218339169, 7346.52247603904, 7449.366803821736, 7527.247275272429, 7125.608091555015, 7191.640417978975, 7208.96395518019, 7381.335679788845, 7439.665215065444, 6509.153810004858, 6606.900896486461, 6626.53614246998, 6628.668566571556, 6648.634325112165, 5004.1492946198505, 5032.974835125801, 5104.310918026167, 5121.8719532012, 5217.165253559412, 5020.698758074527, 5076.898462030665, 5213.713245771519, 5234.895302093861, 5279.39286982002], "value": 4394.238196368397, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.6501016376905, 325.7426632959962, 332.87849934773817, 337.1083484184332, 337.80576168703004, 4981.178105612578, 5082.161443361841, 5108.872278193047, 5155.716435596036, 5170.715610641418, 4939.9012019759675, 5005.699658020512, 5067.7212753298645, 5080.390353157617, 5087.160618497953, 4034.69739769517, 4041.7979101044903, 4047.4738284023038, 4054.0067683417606, 4057.5536690963972, 3737.514123163985, 3830.9464897153366, 4037.636612704856, 4044.402461027907, 4071.4503542021894, 3989.7033464124274, 4010.9598904011023, 4012.5786792386816, 4024.1750441159493, 4029.0934539728473, 4002.8198731057173, 4009.67922566194, 4015.5984401559904, 4017.5580686124504, 4025.1949610077954, 3577.7853328800356, 3580.122869896892, 3609.4224924012033, 3614.530111085542, 3624.4925710400566, 4930.235813448885, 5011.3485246918035, 5012.020252000476, 5018.322526458918, 5029.220470827027, 4632.2588385858435, 4644.535546445362, 4648.697834640738, 4649.8372556960685, 4654.185517534452, 5367.892642147174, 5370.301860758115, 5370.597205209625, 5375.865603359908, 5432.402435732066, 3817.9236415271816, 3924.941125883114, 3954.485916830822, 3956.8615098471705, 3959.713093244678, 5506.174073888908, 5516.9448305516835, 5520.420355862617, 5522.779088836442, 5525.171224316345, 4043.959560404417, 4044.838206471767, 4050.5341885683524, 4056.918861622751, 4078.877633670935, 3935.2916475034767, 4000.439938408625, 4033.979830100831, 4069.9557916876342, 4123.876283711494, 4536.79584418702, 4538.818447262072, 4547.272436410159, 4549.431321084864, 4564.178447879413, 5289.206619007103, 5320.627556071116, 5324.242999810053, 5327.387350454747, 5333.253344531769, 1275.113795911851, 1311.5016293808483, 1335.3657012918786, 1371.1156304183944, 1374.5257886029503, 946.1815529566875, 949.2263804998904, 958.1951161024773, 963.9084286992864, 975.4295584109578, 4954.430240522386, 4995.300657907896, 5004.874878128076, 5012.774425150877, 5027.4218464877, 5311.203319502106, 5321.467853214647, 5337.893242135136, 5343.19852022192, 5358.535073866065, 4768.356271903318, 4975.992150994194, 4988.276699878497, 5021.07110184617, 5032.270320803463, 2769.3907340385085, 2811.4658214939095, 2823.8704518192885, 2833.334166470878, 2847.5301575239855, 5478.835634930959, 5487.917681234785, 5501.504864562208, 5530.86172845674, 5535.418781028015, 5125.820596279187, 5354.732263386815, 5358.437364076716, 5374.381946076173, 5410.3507579090765, 5488.91766623501, 5493.807716729895, 5500.147477141049, 5508.834734958038, 5516.310461192351, 5233.607479439133, 5362.946370536245, 5367.4364191759305, 5368.919466207932, 5376.892462150657, 5034.295198672262, 5174.6119041071315, 5190.584753219658, 5202.583793296603, 5214.165733482776, 5438.483344082306, 5438.483344082306, 5438.564914806885, 5444.183372494158, 5462.831557696447, 3933.213357328603, 3943.447917291524, 3953.7627742335553, 3969.483967084376, 3973.245083434254, 5150.639455238097, 5202.505761952609, 5211.879445919146, 5293.0, 5309.920351194813, 5168.9741551292, 5202.869928251824, 5289.518934698291, 5317.813876514303, 5320.920186197132, 5263.6052296078715, 5272.367315922113, 5275.235090911719, 5284.9471505284455, 5291.4443983382735, 5131.692098474104, 5210.739463026757, 5259.21111833228, 5274.630775845654, 5304.9469505306, 5298.470152984825, 5330.280412144466, 5344.35867695879, 5353.197020446808, 5355.196720491957, 5232.555232805102, 5253.842384728464, 5255.842324730264, 5256.316678831728, 5273.709945953009], "value": 4061.8133623723193, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.285593690215, 754.5962909843234, 758.4311766175368, 774.8256642255493, 802.2258520527691, 13045.478180872766, 13405.262710550916, 13406.597802065942, 13443.1261967972, 13447.260400677958, 13157.539486117988, 13238.205707657547, 13277.535286264983, 13324.0, 13363.265020423873, 656.1437324291797, 672.2235817630644, 756.6632848382473, 772.6136931534232, 772.7449941519285, 760.4030835793903, 765.7549584133079, 768.1281745219161, 768.4044865229436, 770.0220719685996, 800.0799081056803, 800.2317774936068, 800.4556901307109, 800.5956991719173, 801.4029547986758, 689.0938415982966, 796.80079980005, 797.2067792546395, 797.8603744344746, 801.3749275565068, 523.2256260734135, 585.6076428792719, 598.1954271504819, 604.5586721693145, 605.1346574398608, 12302.938485307606, 12303.138780285384, 12307.26156430617, 12331.0, 12341.5063397464, 13294.0, 13377.933110334483, 13662.316884155753, 13865.0, 13948.790768138486, 11082.168837337233, 11234.887651123548, 11273.39273871443, 11378.60174893883, 11489.482973266224, 4193.622573968358, 4203.55862634422, 4224.408582798411, 4283.612944263323, 4356.411884395598, 61185.38814611886, 61420.0, 62232.68883655598, 62929.37070629281, 64080.35919640837, 10471.214658900613, 10507.00250784016, 10584.523696433678, 10588.0, 10670.35977841332, 17934.0, 17958.551036223937, 18013.7297940531, 18105.909470452563, 18116.547086322684, 7665.8850117248285, 7731.342835858903, 7790.493617914817, 7805.297523222937, 7975.60121993898, 4380.8904777380185, 4404.2512772828695, 4428.844990425384, 4466.307722303049, 4549.7497637629585, 3336.9165770855925, 3439.9312013759586, 3440.8623655054016, 3441.9311613767586, 3444.0528854565196, 575.2665351676645, 588.1031427073747, 588.8498432899669, 610.4536439886277, 619.9721012554446, 564.6075977195892, 612.7365232949875, 639.341478277375, 651.3291309950758, 673.7776533743853, 8569.700060497977, 8829.205371516595, 9367.203787677987, 9597.376170549032, 9747.0, 567.5544697412512, 623.1462895832739, 629.380060640269, 671.6809515480107, 714.8034290570134, 3909.237698648793, 4285.314349704033, 4309.892252693645, 4316.568343165721, 4403.873249992541, 82817.0, 83176.58411707902, 84565.57717211498, 84743.0, 88532.0, 47280.290795638095, 59509.702451487465, 72092.0, 75583.62208189034, 75743.24256757472, 65783.67108164428, 66022.03867767949, 66865.66567167133, 67963.66018169878, 71114.64442677857, 8293.0, 8445.11326310753, 8521.829563408573, 8528.360372972176, 8593.226609605166, 41508.169836602494, 41901.580984189764, 43645.10791043169, 43812.780936095114, 44051.77974110109, 57091.42908570861, 57259.427405727074, 61176.0, 63170.36829631645, 64928.675356622916, 10657.413842238751, 10832.458377081271, 10928.94535527349, 10991.945040275068, 11316.773664526829, 10834.152297566981, 10887.129029677766, 11093.112550996062, 11115.110791136527, 11348.773024539298, 10759.30064545802, 10787.244892857425, 10880.727981800519, 10894.400807955639, 10995.835062474229, 10901.672949811518, 11099.0, 11105.555777768799, 11177.608783692533, 11374.374409407563, 10947.45262736844, 11147.554097835995, 11175.0, 11185.32888026721, 11243.775124497628, 9569.808603828023, 9611.944474980717, 9623.267811793945, 9635.084666956627, 9955.800883982425, 9774.657886973922, 9950.701478955643, 9967.950160249153, 9989.850152247867, 9998.300118991892], "value": 6635.209871525954, "unit": "score"}], "name": "dromaeo_css", "value": 6891.596657005507, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 112.0, 115.0, 112.0, 112.0, 113.0, 113.0, 114.0, 112.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 121.0, 123.0, 173.0, 125.0, 131.0, 125.0, 128.0, 153.0, 127.0], "value": 135.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 161.0, 160.0, 161.0, 161.0, 160.0, 161.0, 160.0, 162.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 104.0, 77.0, 78.0, 74.0, 75.0, 101.0, 75.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 109.0, 84.0, 82.0, 82.0, 106.0, 82.0, 83.0, 117.0], "value": 91.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 85.0, 85.0, 85.0, 85.0, 85.0, 84.0, 85.0, 85.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 53.0, 54.0, 54.0, 55.0, 54.0, 54.0, 54.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 64.0, 64.0, 63.0, 63.0, 63.0, 64.0, 65.0], "value": 63.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 81.0, 85.0, 80.0, 79.0, 79.0, 78.0, 91.0, 85.0, 80.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 140.0, 135.0, 131.0, 140.0, 144.0, 130.0, 129.0, 176.0, 133.0], "value": 139.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 164.0, 164.0, 164.0, 169.0, 163.0, 167.0, 162.0, 161.0, 161.0], "value": 164.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 65.0, 71.0, 63.0, 62.0, 64.0, 64.0, 64.0, 63.0], "value": 64.9, "unit": "score"}], "name": "kraken", "value": 1496.7, "alertThreshold": 2.0}]} 10:42:33 INFO - Return code: 0 10:42:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:42:33 INFO - # TBPL SUCCESS # 10:42:33 INFO - Running post-action listener: _resource_record_post_action 10:42:33 INFO - [mozharness: 2016-11-10 18:42:33.665185Z] Finished run-tests step (success) 10:42:33 INFO - Running post-run listener: _resource_record_post_run 10:42:33 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 20480; Write bytes: 398475264; Read time: 240; Write time: 316436 10:42:33 INFO - TinderboxPrint: CPU usage
13.1% 10:42:33 INFO - TinderboxPrint: I/O read bytes / time
20,480 / 240 10:42:33 INFO - TinderboxPrint: I/O write bytes / time
398,475,264 / 316,436 10:42:33 INFO - TinderboxPrint: CPU idle
8,303.2 (86.9%) 10:42:33 INFO - TinderboxPrint: CPU user
1,204.6 (12.6%) 10:42:33 INFO - TinderboxPrint: Swap in / out
0 / 0 10:42:33 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110575616; Read time: 0; Write time: 102148 10:42:33 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 16384; Write bytes: 287555584; Read time: 224; Write time: 214248 10:42:34 INFO - Running post-run listener: _upload_blobber_files 10:42:34 INFO - Blob upload gear active. 10:42:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:42:34 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:42:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:42:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:42:34 INFO - (blobuploader) - INFO - Open directory for files ... 10:42:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:42:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:42:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:42:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:42:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:42:35 INFO - (blobuploader) - INFO - Done attempting. 10:42:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:42:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:42:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:42:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:42:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:42:39 INFO - (blobuploader) - INFO - Done attempting. 10:42:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:42:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:42:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:42:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:42:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:42:39 INFO - (blobuploader) - INFO - Done attempting. 10:42:39 INFO - (blobuploader) - INFO - Iteration through files over. 10:42:39 INFO - Return code: 0 10:42:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:42:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:42:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/badad09a8ba99258baeb20a0db23ceef93e38008ccb0a2ed35435c7d3cc9542fbb11941f7ad9568952097d9dae9092caedb18b793c41f63e10f95919d9da1f02", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38e0087f95cf2c2863dd4d4fdbabf08eac3d555ec6b76bba93e88c26daa77320f0f65259b00a289994bef2742be6882c4d6c05f05e0a31c424dd43bc349d1d0f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32b7984a16f93f069c080d12af08135f9854306ae1bdb1bec0de76d160aaf4d2590db9e5c7efa8045107bb5df07bebc7480467f726a600e4dd581da58c554223"} 10:42:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:42:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:42:39 INFO - Contents: 10:42:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/badad09a8ba99258baeb20a0db23ceef93e38008ccb0a2ed35435c7d3cc9542fbb11941f7ad9568952097d9dae9092caedb18b793c41f63e10f95919d9da1f02", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38e0087f95cf2c2863dd4d4fdbabf08eac3d555ec6b76bba93e88c26daa77320f0f65259b00a289994bef2742be6882c4d6c05f05e0a31c424dd43bc349d1d0f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32b7984a16f93f069c080d12af08135f9854306ae1bdb1bec0de76d160aaf4d2590db9e5c7efa8045107bb5df07bebc7480467f726a600e4dd581da58c554223"} 10:42:39 INFO - Running post-run listener: copy_logs_to_upload_dir 10:42:39 INFO - Copying logs to upload dir... 10:42:39 INFO - mkdir: /builds/slave/test/build/upload/logs 10:42:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.916633 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-11-10 10:42:39.710677) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-10 10:42:39.716603) ========= 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=4300f881736b422476174874000001bc-1478802116.540826-738079626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/badad09a8ba99258baeb20a0db23ceef93e38008ccb0a2ed35435c7d3cc9542fbb11941f7ad9568952097d9dae9092caedb18b793c41f63e10f95919d9da1f02", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38e0087f95cf2c2863dd4d4fdbabf08eac3d555ec6b76bba93e88c26daa77320f0f65259b00a289994bef2742be6882c4d6c05f05e0a31c424dd43bc349d1d0f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32b7984a16f93f069c080d12af08135f9854306ae1bdb1bec0de76d160aaf4d2590db9e5c7efa8045107bb5df07bebc7480467f726a600e4dd581da58c554223"} build_url:https://queue.taskcluster.net/v1/task/HnyHyHa4Tam-EWg24SDqAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011349 build_url: 'https://queue.taskcluster.net/v1/task/HnyHyHa4Tam-EWg24SDqAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/badad09a8ba99258baeb20a0db23ceef93e38008ccb0a2ed35435c7d3cc9542fbb11941f7ad9568952097d9dae9092caedb18b793c41f63e10f95919d9da1f02", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38e0087f95cf2c2863dd4d4fdbabf08eac3d555ec6b76bba93e88c26daa77320f0f65259b00a289994bef2742be6882c4d6c05f05e0a31c424dd43bc349d1d0f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32b7984a16f93f069c080d12af08135f9854306ae1bdb1bec0de76d160aaf4d2590db9e5c7efa8045107bb5df07bebc7480467f726a600e4dd581da58c554223"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-10 10:42:39.741517) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 10:42:39.741809) ========= 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=4300f881736b422476174874000001bc-1478802116.540826-738079626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004431 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 10:42:39.824699) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-10 10:42:39.824987) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-10 10:42:39.825263) ========= ========= Total master_lag: 0.17 =========