builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-034 starttime: 1477632583.56 results: success (0) buildid: 20161027193003 builduid: 92935c4f490d41b08867adb1f0b13e95 revision: 944cb0fd05526894fcd90fbe7d1e625ee53cd73d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-27 22:29:43.559950) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-27 22:29:43.560420) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-27 22:29:43.560764) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-27 22:29:43.586181) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 22:29:43.586500) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1477632500.574355-767230091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-27 22:29:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 122M=0s 2016-10-27 22:29:44 (122 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.083863 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 22:29:43.684814) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 22:29:43.685164) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1477632500.574355-767230091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014291 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 22:29:43.735583) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 22:29:43.735983) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 944cb0fd05526894fcd90fbe7d1e625ee53cd73d --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 944cb0fd05526894fcd90fbe7d1e625ee53cd73d --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=d6bbd613908ccac0c6c9cb47000001f7-1477632500.574355-767230091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-27 22:29:44,162 truncating revision to first 12 chars 2016-10-27 22:29:44,162 Setting DEBUG logging. 2016-10-27 22:29:44,162 attempt 1/10 2016-10-27 22:29:44,162 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/944cb0fd0552?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-27 22:29:44,464 unpacking tar archive at: mozilla-central-944cb0fd0552/testing/mozharness/ program finished with exit code 0 elapsedTime=0.635875 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 22:29:44.386149) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-27 22:29:44.386522) ========= script_repo_revision: 944cb0fd05526894fcd90fbe7d1e625ee53cd73d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-27 22:29:44.386977) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-27 22:29:44.387303) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-27 22:29:44.396768) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-27 22:29:44.397132) ========= /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=d6bbd613908ccac0c6c9cb47000001f7-1477632500.574355-767230091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:29:44 INFO - MultiFileLogger online at 20161027 22:29:44 in /builds/slave/test 22:29:44 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 22:29:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:29:44 INFO - {'append_to_log': False, 22:29:44 INFO - 'base_work_dir': '/builds/slave/test', 22:29:44 INFO - 'blob_upload_branch': 'Firefox', 22:29:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:29:44 INFO - 'branch': 'Firefox', 22:29:44 INFO - 'buildbot_json_path': 'buildprops.json', 22:29:44 INFO - 'config_files': ('talos/linux_config.py',), 22:29:44 INFO - 'default_actions': ('clobber', 22:29:44 INFO - 'read-buildbot-config', 22:29:44 INFO - 'download-and-extract', 22:29:44 INFO - 'populate-webroot', 22:29:44 INFO - 'create-virtualenv', 22:29:44 INFO - 'install', 22:29:44 INFO - 'run-tests'), 22:29:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:29:44 INFO - 'download_minidump_stackwalk': True, 22:29:44 INFO - 'download_symbols': 'ondemand', 22:29:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:29:44 INFO - 'tooltool.py': '/tools/tooltool.py', 22:29:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:29:44 INFO - '/tools/misc-python/virtualenv.py')}, 22:29:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:29:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:29:44 INFO - 'installer_path': 'installer.exe', 22:29:44 INFO - 'log_level': 'info', 22:29:44 INFO - 'log_name': 'talos', 22:29:44 INFO - 'log_to_console': True, 22:29:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:29:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:29:44 INFO - 'opt_config_files': (), 22:29:44 INFO - 'pip_index': False, 22:29:44 INFO - 'sps_profile': False, 22:29:44 INFO - 'sps_profile_interval': 0, 22:29:44 INFO - 'suite': 'dromaeojs', 22:29:44 INFO - 'system_bits': '32', 22:29:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:29:44 INFO - 'title': 'talos-linux64-ix-034', 22:29:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:29:44 INFO - 'use_talos_json': True, 22:29:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:29:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:29:44 INFO - 'work_dir': 'build'} 22:29:44 INFO - [mozharness: 2016-10-28 05:29:44.917786Z] Running clobber step. 22:29:44 INFO - Running pre-action listener: _resource_record_pre_action 22:29:44 INFO - Running main action method: clobber 22:29:44 INFO - rmtree: /builds/slave/test/build 22:29:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:29:45 INFO - Running post-action listener: _resource_record_post_action 22:29:45 INFO - [mozharness: 2016-10-28 05:29:45.377803Z] Finished clobber step (success) 22:29:45 INFO - [mozharness: 2016-10-28 05:29:45.377905Z] Running read-buildbot-config step. 22:29:45 INFO - Running pre-action listener: _resource_record_pre_action 22:29:45 INFO - Running main action method: read_buildbot_config 22:29:45 INFO - Using buildbot properties: 22:29:45 INFO - { 22:29:45 INFO - "project": "", 22:29:45 INFO - "product": "firefox", 22:29:45 INFO - "script_repo_revision": "production", 22:29:45 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 22:29:45 INFO - "repository": "", 22:29:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 22:29:45 INFO - "buildid": "20161027193003", 22:29:45 INFO - "pgo_build": "True", 22:29:45 INFO - "basedir": "/builds/slave/test", 22:29:45 INFO - "buildnumber": 47, 22:29:45 INFO - "slavename": "talos-linux64-ix-034", 22:29:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:29:45 INFO - "platform": "ubuntu64_hw", 22:29:45 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 22:29:45 INFO - "branch": "mozilla-central", 22:29:45 INFO - "repo_path": "mozilla-central", 22:29:45 INFO - "revision": "944cb0fd05526894fcd90fbe7d1e625ee53cd73d", 22:29:45 INFO - "stage_platform": "linux64-pgo", 22:29:45 INFO - "builduid": "92935c4f490d41b08867adb1f0b13e95", 22:29:45 INFO - "slavebuilddir": "test" 22:29:45 INFO - } 22:29:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/fAlwTkYtRMCI02P5y53a2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 22:29:45 INFO - Running post-action listener: _resource_record_post_action 22:29:45 INFO - [mozharness: 2016-10-28 05:29:45.380350Z] Finished read-buildbot-config step (success) 22:29:45 INFO - [mozharness: 2016-10-28 05:29:45.380439Z] Running download-and-extract step. 22:29:45 INFO - Running pre-action listener: _resource_record_pre_action 22:29:45 INFO - Running main action method: download_and_extract 22:29:45 INFO - mkdir: /builds/slave/test/build/tests 22:29:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:29:45 INFO - trying https://queue.taskcluster.net/v1/task/fAlwTkYtRMCI02P5y53a2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:29:45 INFO - Downloading https://queue.taskcluster.net/v1/task/fAlwTkYtRMCI02P5y53a2g/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 22:29:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fAlwTkYtRMCI02P5y53a2g/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 22:29:46 INFO - Downloaded 1361 bytes. 22:29:46 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:29:46 INFO - Using the following test package requirements: 22:29:46 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 22:29:46 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:29:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:29:46 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:29:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:29:46 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:29:46 INFO - u'jsshell-linux-x86_64.zip'], 22:29:46 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:29:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:29:46 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 22:29:46 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:29:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:29:46 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:29:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:29:46 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:29:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:29:46 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:29:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:29:46 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:29:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fAlwTkYtRMCI02P5y53a2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 22:29:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fAlwTkYtRMCI02P5y53a2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:29:46 INFO - Fetch https://queue.taskcluster.net/v1/task/fAlwTkYtRMCI02P5y53a2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:29:47 INFO - Http code: 200 22:29:47 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 22:29:47 INFO - x-amz-cf-id: Co0UIeegmgmG22oyRcvN5iEON_npRs_g92Wuwx9qtnMciDN4rTVUQg== 22:29:47 INFO - x-amz-version-id: D3zH_7Gv4Ohr23hx20N1LkD6aX_whCMP 22:29:48 INFO - Expected file size: 21992894 22:29:48 INFO - Obtained file size: 21992894 22:29:52 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 22:29:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fAlwTkYtRMCI02P5y53a2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 22:29:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fAlwTkYtRMCI02P5y53a2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:29:52 INFO - Fetch https://queue.taskcluster.net/v1/task/fAlwTkYtRMCI02P5y53a2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:29:53 INFO - Http code: 200 22:29:53 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 22:29:53 INFO - x-amz-cf-id: RF7nWK57SlYzBVa1Zu2Vk7zffUHyBtYgdDI6IiOO4mcQ3qeH3TUwCA== 22:29:53 INFO - x-amz-version-id: D3zH_7Gv4Ohr23hx20N1LkD6aX_whCMP 22:29:53 INFO - Expected file size: 21992894 22:29:53 INFO - Obtained file size: 21992894 22:29:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fAlwTkYtRMCI02P5y53a2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 22:29:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fAlwTkYtRMCI02P5y53a2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:29:57 INFO - Fetch https://queue.taskcluster.net/v1/task/fAlwTkYtRMCI02P5y53a2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 22:29:58 INFO - Http code: 200 22:29:58 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 22:29:58 INFO - x-amz-cf-id: ySj_TOWQv-t8El3cwOJ3LVtZshezy9uubL11Mex_U2QirVILGZkYGQ== 22:29:58 INFO - x-amz-version-id: perkL7WBeVhkgo7KTTEOjSaBxyPWvK9A 22:29:59 INFO - Expected file size: 14409028 22:29:59 INFO - Obtained file size: 14409028 22:29:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:29:59 INFO - trying https://queue.taskcluster.net/v1/task/fAlwTkYtRMCI02P5y53a2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:29:59 INFO - Downloading https://queue.taskcluster.net/v1/task/fAlwTkYtRMCI02P5y53a2g/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 22:29:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fAlwTkYtRMCI02P5y53a2g/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 22:30:02 INFO - Downloaded 59398981 bytes. 22:30:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fAlwTkYtRMCI02P5y53a2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:30:02 INFO - mkdir: /builds/slave/test/properties 22:30:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:30:02 INFO - Writing to file /builds/slave/test/properties/build_url 22:30:02 INFO - Contents: 22:30:02 INFO - build_url:https://queue.taskcluster.net/v1/task/fAlwTkYtRMCI02P5y53a2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:30:03 INFO - Running post-action listener: _resource_record_post_action 22:30:03 INFO - Running post-action listener: set_extra_try_arguments 22:30:03 INFO - [mozharness: 2016-10-28 05:30:03.733673Z] Finished download-and-extract step (success) 22:30:03 INFO - [mozharness: 2016-10-28 05:30:03.733902Z] Running populate-webroot step. 22:30:03 INFO - Running pre-action listener: _resource_record_pre_action 22:30:03 INFO - Running main action method: populate_webroot 22:30:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:30:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:30:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:30:03 INFO - '--tppagecycles', 22:30:03 INFO - '7'], 22:30:03 INFO - 'tests': ['tsvgm']}}, 22:30:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:30:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:30:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:30:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:30:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:30:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:30:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:30:03 INFO - 'talos_options': ['--disable-e10s'], 22:30:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:30:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:30:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:30:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:30:03 INFO - 'talos_options': ['--disable-e10s'], 22:30:03 INFO - 'tests': ['damp', 'tps']}, 22:30:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:30:03 INFO - 'tests': ['damp', 'tps']}, 22:30:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:30:03 INFO - 'tests': ['dromaeo_dom']}, 22:30:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:30:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:30:03 INFO - 'tests': ['basic_compositor_video']}, 22:30:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:30:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:30:03 INFO - 'tests': ['a11yr', 22:30:03 INFO - 'ts_paint', 22:30:03 INFO - 'tpaint', 22:30:03 INFO - 'sessionrestore', 22:30:03 INFO - 'sessionrestore_no_auto_restore', 22:30:03 INFO - 'tabpaint']}, 22:30:03 INFO - 'other-e10s': {'tests': ['a11yr', 22:30:03 INFO - 'ts_paint', 22:30:03 INFO - 'tpaint', 22:30:03 INFO - 'sessionrestore', 22:30:03 INFO - 'sessionrestore_no_auto_restore', 22:30:03 INFO - 'tabpaint']}, 22:30:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:30:03 INFO - 'ts_paint', 22:30:03 INFO - 'tpaint', 22:30:03 INFO - 'sessionrestore', 22:30:03 INFO - 'sessionrestore_no_auto_restore', 22:30:03 INFO - 'tabpaint']}, 22:30:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:30:03 INFO - 'ts_paint', 22:30:03 INFO - 'tpaint', 22:30:03 INFO - 'sessionrestore', 22:30:03 INFO - 'sessionrestore_no_auto_restore', 22:30:03 INFO - 'tabpaint']}, 22:30:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:30:03 INFO - 'tests': ['a11yr', 22:30:03 INFO - 'ts_paint', 22:30:03 INFO - 'tpaint', 22:30:03 INFO - 'sessionrestore', 22:30:03 INFO - 'sessionrestore_no_auto_restore', 22:30:03 INFO - 'tabpaint']}, 22:30:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:30:03 INFO - 'tests': ['a11yr', 22:30:03 INFO - 'ts_paint', 22:30:03 INFO - 'tpaint', 22:30:03 INFO - 'sessionrestore', 22:30:03 INFO - 'sessionrestore_no_auto_restore', 22:30:03 INFO - 'tabpaint']}, 22:30:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:30:03 INFO - 'tests': ['tsvgx', 22:30:03 INFO - 'tsvgr_opacity', 22:30:03 INFO - 'tart', 22:30:03 INFO - 'tscrollx', 22:30:03 INFO - 'cart']}, 22:30:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:30:03 INFO - 'tsvgr_opacity', 22:30:03 INFO - 'tart', 22:30:03 INFO - 'tscrollx', 22:30:03 INFO - 'cart']}, 22:30:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:30:03 INFO - 'talos_options': ['--disable-e10s'], 22:30:03 INFO - 'tests': ['tp5o']}, 22:30:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:30:03 INFO - 'tests': ['tp5o']}, 22:30:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:30:03 INFO - 'talos_options': ['--disable-e10s', 22:30:03 INFO - '--xperf_path', 22:30:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:30:03 INFO - 'tests': ['tp5n']}, 22:30:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:30:03 INFO - 'talos_options': ['--xperf_path', 22:30:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:30:03 INFO - 'tests': ['tp5n']}}, 22:30:03 INFO - 'talos.zip': {'path': '', 22:30:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:30:03 INFO - Running post-action listener: _resource_record_post_action 22:30:03 INFO - [mozharness: 2016-10-28 05:30:03.752899Z] Finished populate-webroot step (success) 22:30:03 INFO - [mozharness: 2016-10-28 05:30:03.752987Z] Running create-virtualenv step. 22:30:03 INFO - Running pre-action listener: _resource_record_pre_action 22:30:03 INFO - Running main action method: create_virtualenv 22:30:03 INFO - Creating virtualenv /builds/slave/test/build/venv 22:30:03 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 22:30:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:30:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:30:03 INFO - Using real prefix '/usr' 22:30:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:30:04 INFO - Installing distribute.............................................................................................................................................................................................done. 22:30:06 INFO - Installing pip.................done. 22:30:06 INFO - Return code: 0 22:30:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:30:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:30:06 INFO - Reading from file tmpfile_stdout 22:30:06 INFO - Output received: 22:30:06 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) 22:30:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:30:06 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')]} 22:30:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:30:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:06 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')]} 22:30:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:30:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:06 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 0x7f67f8593f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a83790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a80930>, '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 0x1a81830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a81cc0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1477632500.574355-767230091', '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 22:30:06 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 22:30:06 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 22:30:06 INFO - Using env: {'DISPLAY': ':0', 22:30:06 INFO - 'HOME': '/home/cltbld', 22:30:06 INFO - 'LANG': 'en_US.UTF-8', 22:30:06 INFO - 'LANGUAGE': 'en_US:en', 22:30:06 INFO - 'LOGNAME': 'cltbld', 22:30:06 INFO - 'MAIL': '/var/mail/cltbld', 22:30:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:06 INFO - 'MOZ_NO_REMOTE': '1', 22:30:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:06 INFO - 'NO_EM_RESTART': '1', 22:30:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:06 INFO - 'PWD': '/builds/slave/test', 22:30:06 INFO - 'SHELL': '/bin/bash', 22:30:06 INFO - 'SHLVL': '1', 22:30:06 INFO - 'TERM': 'linux', 22:30:06 INFO - 'TMOUT': '86400', 22:30:06 INFO - 'USER': 'cltbld', 22:30:06 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1477632500.574355-767230091', 22:30:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:06 INFO - '_': '/tools/buildbot/bin/python'} 22:30:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:30:06 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 22:30:06 INFO - Cleaning up... 22:30:06 INFO - Return code: 0 22:30:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:30:06 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')]} 22:30:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:30:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:06 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')]} 22:30:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:30:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:06 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 0x7f67f8593f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a83790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a80930>, '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 0x1a81830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a81cc0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1477632500.574355-767230091', '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 22:30:06 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 22:30:06 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 22:30:06 INFO - Using env: {'DISPLAY': ':0', 22:30:06 INFO - 'HOME': '/home/cltbld', 22:30:06 INFO - 'LANG': 'en_US.UTF-8', 22:30:06 INFO - 'LANGUAGE': 'en_US:en', 22:30:06 INFO - 'LOGNAME': 'cltbld', 22:30:06 INFO - 'MAIL': '/var/mail/cltbld', 22:30:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:06 INFO - 'MOZ_NO_REMOTE': '1', 22:30:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:06 INFO - 'NO_EM_RESTART': '1', 22:30:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:06 INFO - 'PWD': '/builds/slave/test', 22:30:06 INFO - 'SHELL': '/bin/bash', 22:30:06 INFO - 'SHLVL': '1', 22:30:06 INFO - 'TERM': 'linux', 22:30:06 INFO - 'TMOUT': '86400', 22:30:06 INFO - 'USER': 'cltbld', 22:30:06 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1477632500.574355-767230091', 22:30:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:06 INFO - '_': '/tools/buildbot/bin/python'} 22:30:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:30:06 INFO - Downloading/unpacking psutil>=3.1.1 22:30:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:30:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:30:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:30:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:30:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:30:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:30:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:30:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:30:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:30:09 INFO - Installing collected packages: psutil 22:30:09 INFO - Running setup.py install for psutil 22:30:09 INFO - building 'psutil._psutil_linux' extension 22:30:09 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 22:30:09 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 22:30:09 INFO - building 'psutil._psutil_posix' extension 22:30:09 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 22:30:09 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 22:30:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:30:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:30:09 INFO - Successfully installed psutil 22:30:09 INFO - Cleaning up... 22:30:09 INFO - Return code: 0 22:30:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:30:09 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')]} 22:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:30:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:09 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')]} 22:30:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:30:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:09 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 0x7f67f8593f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a83790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a80930>, '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 0x1a81830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a81cc0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1477632500.574355-767230091', '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 22:30:09 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 22:30:09 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 22:30:09 INFO - Using env: {'DISPLAY': ':0', 22:30:09 INFO - 'HOME': '/home/cltbld', 22:30:09 INFO - 'LANG': 'en_US.UTF-8', 22:30:09 INFO - 'LANGUAGE': 'en_US:en', 22:30:09 INFO - 'LOGNAME': 'cltbld', 22:30:09 INFO - 'MAIL': '/var/mail/cltbld', 22:30:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:09 INFO - 'MOZ_NO_REMOTE': '1', 22:30:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:09 INFO - 'NO_EM_RESTART': '1', 22:30:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:09 INFO - 'PWD': '/builds/slave/test', 22:30:09 INFO - 'SHELL': '/bin/bash', 22:30:09 INFO - 'SHLVL': '1', 22:30:09 INFO - 'TERM': 'linux', 22:30:09 INFO - 'TMOUT': '86400', 22:30:09 INFO - 'USER': 'cltbld', 22:30:09 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1477632500.574355-767230091', 22:30:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:09 INFO - '_': '/tools/buildbot/bin/python'} 22:30:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:30:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:30:09 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 22:30:09 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 22:30:09 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 22:30:09 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 22:30:09 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 22:30:09 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 22:30:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:30:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:30:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:30:11 INFO - Installing collected packages: mozsystemmonitor 22:30:11 INFO - Running setup.py install for mozsystemmonitor 22:30:11 INFO - Successfully installed mozsystemmonitor 22:30:11 INFO - Cleaning up... 22:30:11 INFO - Return code: 0 22:30:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:30:11 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')]} 22:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:30:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:11 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')]} 22:30:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:30:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:11 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 0x7f67f8593f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a83790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a80930>, '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 0x1a81830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a81cc0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1477632500.574355-767230091', '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 22:30:11 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 22:30:11 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 22:30:11 INFO - Using env: {'DISPLAY': ':0', 22:30:11 INFO - 'HOME': '/home/cltbld', 22:30:11 INFO - 'LANG': 'en_US.UTF-8', 22:30:11 INFO - 'LANGUAGE': 'en_US:en', 22:30:11 INFO - 'LOGNAME': 'cltbld', 22:30:11 INFO - 'MAIL': '/var/mail/cltbld', 22:30:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:11 INFO - 'MOZ_NO_REMOTE': '1', 22:30:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:11 INFO - 'NO_EM_RESTART': '1', 22:30:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:11 INFO - 'PWD': '/builds/slave/test', 22:30:11 INFO - 'SHELL': '/bin/bash', 22:30:11 INFO - 'SHLVL': '1', 22:30:11 INFO - 'TERM': 'linux', 22:30:11 INFO - 'TMOUT': '86400', 22:30:11 INFO - 'USER': 'cltbld', 22:30:11 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1477632500.574355-767230091', 22:30:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:11 INFO - '_': '/tools/buildbot/bin/python'} 22:30:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:30:12 INFO - Downloading/unpacking jsonschema==2.5.1 22:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:30:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:30:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:30:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:30:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:30:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:30:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:30:14 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 22:30:14 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 22:30:14 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 22:30:14 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 22:30:14 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 22:30:14 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 22:30:14 INFO - Downloading functools32-3.2.3-2.tar.gz 22:30:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:30:14 INFO - warning: no files found matching '*.txt' 22:30:14 INFO - no previously-included directories found matching 'build' 22:30:14 INFO - no previously-included directories found matching 'dist' 22:30:14 INFO - no previously-included directories found matching '.git*' 22:30:14 INFO - Installing collected packages: jsonschema, functools32 22:30:14 INFO - Running setup.py install for functools32 22:30:14 INFO - warning: no files found matching '*.txt' 22:30:14 INFO - no previously-included directories found matching 'build' 22:30:14 INFO - no previously-included directories found matching 'dist' 22:30:14 INFO - no previously-included directories found matching '.git*' 22:30:14 INFO - Successfully installed jsonschema functools32 22:30:14 INFO - Cleaning up... 22:30:14 INFO - Return code: 0 22:30:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:30:14 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')]} 22:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:30:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:14 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')]} 22:30:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:30:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:14 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 0x7f67f8593f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a83790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a80930>, '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 0x1a81830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a81cc0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1477632500.574355-767230091', '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 22:30:14 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 22:30:14 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 22:30:14 INFO - Using env: {'DISPLAY': ':0', 22:30:14 INFO - 'HOME': '/home/cltbld', 22:30:14 INFO - 'LANG': 'en_US.UTF-8', 22:30:14 INFO - 'LANGUAGE': 'en_US:en', 22:30:14 INFO - 'LOGNAME': 'cltbld', 22:30:14 INFO - 'MAIL': '/var/mail/cltbld', 22:30:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:14 INFO - 'MOZ_NO_REMOTE': '1', 22:30:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:14 INFO - 'NO_EM_RESTART': '1', 22:30:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:14 INFO - 'PWD': '/builds/slave/test', 22:30:14 INFO - 'SHELL': '/bin/bash', 22:30:14 INFO - 'SHLVL': '1', 22:30:14 INFO - 'TERM': 'linux', 22:30:14 INFO - 'TMOUT': '86400', 22:30:14 INFO - 'USER': 'cltbld', 22:30:14 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1477632500.574355-767230091', 22:30:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:14 INFO - '_': '/tools/buildbot/bin/python'} 22:30:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:30:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:30:14 INFO - Cleaning up... 22:30:14 INFO - Return code: 0 22:30:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:30:14 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')]} 22:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:30:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:14 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')]} 22:30:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:30:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:14 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 0x7f67f8593f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a83790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a80930>, '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 0x1a81830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a81cc0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1477632500.574355-767230091', '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 22:30:14 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 22:30:14 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 22:30:14 INFO - Using env: {'DISPLAY': ':0', 22:30:14 INFO - 'HOME': '/home/cltbld', 22:30:14 INFO - 'LANG': 'en_US.UTF-8', 22:30:14 INFO - 'LANGUAGE': 'en_US:en', 22:30:14 INFO - 'LOGNAME': 'cltbld', 22:30:14 INFO - 'MAIL': '/var/mail/cltbld', 22:30:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:14 INFO - 'MOZ_NO_REMOTE': '1', 22:30:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:14 INFO - 'NO_EM_RESTART': '1', 22:30:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:14 INFO - 'PWD': '/builds/slave/test', 22:30:14 INFO - 'SHELL': '/bin/bash', 22:30:14 INFO - 'SHLVL': '1', 22:30:14 INFO - 'TERM': 'linux', 22:30:14 INFO - 'TMOUT': '86400', 22:30:14 INFO - 'USER': 'cltbld', 22:30:14 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1477632500.574355-767230091', 22:30:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:14 INFO - '_': '/tools/buildbot/bin/python'} 22:30:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:30:14 INFO - Downloading/unpacking blobuploader==1.2.4 22:30:14 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 22:30:14 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 22:30:14 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 22:30:14 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 22:30:14 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 22:30:14 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 22:30:16 INFO - Downloading blobuploader-1.2.4.tar.gz 22:30:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:30:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:30:16 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 22:30:16 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 22:30:16 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 22:30:16 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 22:30:16 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 22:30:16 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 22:30:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:30:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:30:17 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 22:30:17 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 22:30:17 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 22:30:17 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 22:30:17 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 22:30:17 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 22:30:17 INFO - Downloading docopt-0.6.1.tar.gz 22:30:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:30:17 INFO - Installing collected packages: blobuploader, requests, docopt 22:30:17 INFO - Running setup.py install for blobuploader 22:30:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:30:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:30:17 INFO - Running setup.py install for requests 22:30:18 INFO - Running setup.py install for docopt 22:30:18 INFO - Successfully installed blobuploader requests docopt 22:30:18 INFO - Cleaning up... 22:30:18 INFO - Return code: 0 22:30:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:30: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')]} 22:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:30:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30: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')]} 22:30:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:30:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:18 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 0x7f67f8593f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a83790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a80930>, '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 0x1a81830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a81cc0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1477632500.574355-767230091', '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 22:30:18 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 22:30:18 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 22:30:18 INFO - Using env: {'DISPLAY': ':0', 22:30:18 INFO - 'HOME': '/home/cltbld', 22:30:18 INFO - 'LANG': 'en_US.UTF-8', 22:30:18 INFO - 'LANGUAGE': 'en_US:en', 22:30:18 INFO - 'LOGNAME': 'cltbld', 22:30:18 INFO - 'MAIL': '/var/mail/cltbld', 22:30:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:18 INFO - 'MOZ_NO_REMOTE': '1', 22:30:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:18 INFO - 'NO_EM_RESTART': '1', 22:30:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:18 INFO - 'PWD': '/builds/slave/test', 22:30:18 INFO - 'SHELL': '/bin/bash', 22:30:18 INFO - 'SHLVL': '1', 22:30:18 INFO - 'TERM': 'linux', 22:30:18 INFO - 'TMOUT': '86400', 22:30:18 INFO - 'USER': 'cltbld', 22:30:18 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1477632500.574355-767230091', 22:30:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:18 INFO - '_': '/tools/buildbot/bin/python'} 22:30:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:30:18 INFO - Running setup.py (path:/tmp/pip-bn1Di7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:30:18 INFO - Running setup.py (path:/tmp/pip-t3IhHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:30:18 INFO - Running setup.py (path:/tmp/pip-icSAk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:30:18 INFO - Running setup.py (path:/tmp/pip-O6OHBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:30:18 INFO - Running setup.py (path:/tmp/pip-Z2sd8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:30:18 INFO - Running setup.py (path:/tmp/pip-rrK3Sr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:30:18 INFO - Running setup.py (path:/tmp/pip-VL0uFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:30:19 INFO - Running setup.py (path:/tmp/pip-NzMZRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:30:19 INFO - Running setup.py (path:/tmp/pip-He50FQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:30:19 INFO - Running setup.py (path:/tmp/pip-9k_XIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:30:19 INFO - Running setup.py (path:/tmp/pip-IH65Lm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:30:19 INFO - Running setup.py (path:/tmp/pip-MXEzRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:30:19 INFO - Running setup.py (path:/tmp/pip-Z5hZJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:30:19 INFO - Running setup.py (path:/tmp/pip-55zuSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:30:19 INFO - Running setup.py (path:/tmp/pip-gman4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:30:19 INFO - Running setup.py (path:/tmp/pip-PO_QNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:30:19 INFO - Running setup.py (path:/tmp/pip-yGPZLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:30:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:30:19 INFO - Running setup.py install for manifestparser 22:30:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:30:19 INFO - Running setup.py install for mozcrash 22:30:19 INFO - Running setup.py install for mozdebug 22:30:20 INFO - Running setup.py install for mozdevice 22:30:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:30:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:30:20 INFO - Running setup.py install for mozfile 22:30:20 INFO - Running setup.py install for mozhttpd 22:30:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:30:20 INFO - Running setup.py install for mozinfo 22:30:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:30:20 INFO - Running setup.py install for mozInstall 22:30:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:30:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:30:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:30:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:30:20 INFO - Running setup.py install for mozleak 22:30:20 INFO - Running setup.py install for mozlog 22:30:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:30:20 INFO - Running setup.py install for moznetwork 22:30:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:30:20 INFO - Running setup.py install for mozprocess 22:30:20 INFO - Running setup.py install for mozprofile 22:30:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:30:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:30:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:30:21 INFO - Running setup.py install for mozrunner 22:30:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:30:21 INFO - Running setup.py install for mozscreenshot 22:30:21 INFO - Running setup.py install for moztest 22:30:21 INFO - Running setup.py install for mozversion 22:30:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:30:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:30:21 INFO - Cleaning up... 22:30:21 INFO - Return code: 0 22:30:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:30:21 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')]} 22:30:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:30:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:21 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')]} 22:30:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:30:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:21 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 0x7f67f8593f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a83790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a80930>, '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 0x1a81830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a81cc0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1477632500.574355-767230091', '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 22:30:21 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 22:30:21 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 22:30:21 INFO - Using env: {'DISPLAY': ':0', 22:30:21 INFO - 'HOME': '/home/cltbld', 22:30:21 INFO - 'LANG': 'en_US.UTF-8', 22:30:21 INFO - 'LANGUAGE': 'en_US:en', 22:30:21 INFO - 'LOGNAME': 'cltbld', 22:30:21 INFO - 'MAIL': '/var/mail/cltbld', 22:30:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:21 INFO - 'MOZ_NO_REMOTE': '1', 22:30:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:21 INFO - 'NO_EM_RESTART': '1', 22:30:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:21 INFO - 'PWD': '/builds/slave/test', 22:30:21 INFO - 'SHELL': '/bin/bash', 22:30:21 INFO - 'SHLVL': '1', 22:30:21 INFO - 'TERM': 'linux', 22:30:21 INFO - 'TMOUT': '86400', 22:30:21 INFO - 'USER': 'cltbld', 22:30:21 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1477632500.574355-767230091', 22:30:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:21 INFO - '_': '/tools/buildbot/bin/python'} 22:30:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:30:21 INFO - Running setup.py (path:/tmp/pip-HLjzJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:30:21 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)) 22:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:30:21 INFO - Running setup.py (path:/tmp/pip-V95X52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:30:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:30:21 INFO - Running setup.py (path:/tmp/pip-y7gKsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:30:21 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)) 22:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:30:21 INFO - Running setup.py (path:/tmp/pip-MT0pog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:30:22 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)) 22:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:30:22 INFO - Running setup.py (path:/tmp/pip-NPNDKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:30:22 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)) 22:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:30:22 INFO - Running setup.py (path:/tmp/pip-zwLx9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:30:22 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)) 22:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:30:22 INFO - Running setup.py (path:/tmp/pip-iHw60T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:30:22 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)) 22:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:30:22 INFO - Running setup.py (path:/tmp/pip-MdENJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:30:22 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)) 22:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:30:22 INFO - Running setup.py (path:/tmp/pip-SMek3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:30:22 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)) 22:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:30:22 INFO - Running setup.py (path:/tmp/pip-2X1gwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:30:22 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)) 22:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:30:22 INFO - Running setup.py (path:/tmp/pip-0i7ltJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:30:22 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)) 22:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:30:22 INFO - Running setup.py (path:/tmp/pip-VULu86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:30:22 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)) 22:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:30:22 INFO - Running setup.py (path:/tmp/pip-tmGIXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:30:22 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)) 22:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:30:22 INFO - Running setup.py (path:/tmp/pip-wGmRWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:30:22 INFO - Running setup.py (path:/tmp/pip-IhiykP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:30:22 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)) 22:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:30:22 INFO - Running setup.py (path:/tmp/pip-sPZ3Uh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:30:22 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)) 22:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:30:22 INFO - Running setup.py (path:/tmp/pip-hxCQeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:30:23 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)) 22:30:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:30:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:30:23 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)) 22:30:23 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)) 22:30:23 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)) 22:30:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:30: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 22:30: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 22:30: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 22:30: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 22:30: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 22:30: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 22:30:24 INFO - Downloading blessings-1.6.tar.gz 22:30:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:30:25 INFO - Installing collected packages: blessings 22:30:25 INFO - Running setup.py install for blessings 22:30:25 INFO - Successfully installed blessings 22:30:25 INFO - Cleaning up... 22:30:25 INFO - Return code: 0 22:30:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:30:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:30:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:30:25 INFO - Reading from file tmpfile_stdout 22:30:25 INFO - Current package versions: 22:30:25 INFO - argparse == 1.2.1 22:30:25 INFO - blessings == 1.6 22:30:25 INFO - blobuploader == 1.2.4 22:30:25 INFO - docopt == 0.6.1 22:30:25 INFO - functools32 == 3.2.3-2 22:30:25 INFO - jsonschema == 2.5.1 22:30:25 INFO - manifestparser == 1.1 22:30:25 INFO - mozInstall == 1.12 22:30:25 INFO - mozcrash == 0.17 22:30:25 INFO - mozdebug == 0.1 22:30:25 INFO - mozdevice == 0.48 22:30:25 INFO - mozfile == 1.2 22:30:25 INFO - mozhttpd == 0.7 22:30:25 INFO - mozinfo == 0.9 22:30:25 INFO - mozleak == 0.1 22:30:25 INFO - mozlog == 3.4 22:30:25 INFO - moznetwork == 0.27 22:30:25 INFO - mozprocess == 0.23 22:30:25 INFO - mozprofile == 0.28 22:30:25 INFO - mozrunner == 6.12 22:30:25 INFO - mozscreenshot == 0.1 22:30:25 INFO - mozsystemmonitor == 0.3 22:30:25 INFO - moztest == 0.7 22:30:25 INFO - mozversion == 1.4 22:30:25 INFO - psutil == 3.1.1 22:30:25 INFO - requests == 1.2.3 22:30:25 INFO - wsgiref == 0.1.2 22:30:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:30:25 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')]} 22:30:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:30:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:25 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')]} 22:30:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:30:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:25 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 0x7f67f8593f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a83790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a80930>, '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 0x1a81830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a81cc0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1477632500.574355-767230091', '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 22:30:25 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 22:30:25 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 22:30:25 INFO - Using env: {'DISPLAY': ':0', 22:30:25 INFO - 'HOME': '/home/cltbld', 22:30:25 INFO - 'LANG': 'en_US.UTF-8', 22:30:25 INFO - 'LANGUAGE': 'en_US:en', 22:30:25 INFO - 'LOGNAME': 'cltbld', 22:30:25 INFO - 'MAIL': '/var/mail/cltbld', 22:30:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:25 INFO - 'MOZ_NO_REMOTE': '1', 22:30:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:25 INFO - 'NO_EM_RESTART': '1', 22:30:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:25 INFO - 'PWD': '/builds/slave/test', 22:30:25 INFO - 'SHELL': '/bin/bash', 22:30:25 INFO - 'SHLVL': '1', 22:30:25 INFO - 'TERM': 'linux', 22:30:25 INFO - 'TMOUT': '86400', 22:30:25 INFO - 'USER': 'cltbld', 22:30:25 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1477632500.574355-767230091', 22:30:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:25 INFO - '_': '/tools/buildbot/bin/python'} 22:30:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:30:25 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)) 22:30:25 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)) 22:30:25 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)) 22:30:25 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)) 22:30:25 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)) 22:30:25 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)) 22:30:25 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)) 22:30:25 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)) 22:30:25 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)) 22:30:25 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)) 22:30:25 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)) 22:30:25 INFO - Cleaning up... 22:30:25 INFO - Return code: 0 22:30:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:30:25 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')]} 22:30:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:30:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:25 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')]} 22:30:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:30:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:25 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 0x7f67f8593f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a83790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a80930>, '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 0x1a81830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a81cc0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1477632500.574355-767230091', '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 22:30:25 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 22:30:25 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 22:30:25 INFO - Using env: {'DISPLAY': ':0', 22:30:25 INFO - 'HOME': '/home/cltbld', 22:30:25 INFO - 'LANG': 'en_US.UTF-8', 22:30:25 INFO - 'LANGUAGE': 'en_US:en', 22:30:25 INFO - 'LOGNAME': 'cltbld', 22:30:25 INFO - 'MAIL': '/var/mail/cltbld', 22:30:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:25 INFO - 'MOZ_NO_REMOTE': '1', 22:30:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:25 INFO - 'NO_EM_RESTART': '1', 22:30:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:25 INFO - 'PWD': '/builds/slave/test', 22:30:25 INFO - 'SHELL': '/bin/bash', 22:30:25 INFO - 'SHLVL': '1', 22:30:25 INFO - 'TERM': 'linux', 22:30:25 INFO - 'TMOUT': '86400', 22:30:25 INFO - 'USER': 'cltbld', 22:30:25 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1477632500.574355-767230091', 22:30:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:25 INFO - '_': '/tools/buildbot/bin/python'} 22:30:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:30:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:30:25 INFO - Cleaning up... 22:30:25 INFO - Return code: 0 22:30:25 INFO - Running post-action listener: _resource_record_post_action 22:30:25 INFO - Running post-action listener: _start_resource_monitoring 22:30:25 INFO - Starting resource monitoring. 22:30:25 INFO - [mozharness: 2016-10-28 05:30:25.929799Z] Finished create-virtualenv step (success) 22:30:25 INFO - [mozharness: 2016-10-28 05:30:25.930267Z] Running install step. 22:30:25 INFO - Running pre-action listener: _resource_record_pre_action 22:30:25 INFO - Running main action method: install 22:30:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:30:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:30:26 INFO - Reading from file tmpfile_stdout 22:30:26 INFO - Detecting whether we're running mozinstall >=1.0... 22:30:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:30:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:30:26 INFO - Reading from file tmpfile_stdout 22:30:26 INFO - Output received: 22:30:26 INFO - Usage: mozinstall [options] installer 22:30:26 INFO - Options: 22:30:26 INFO - -h, --help show this help message and exit 22:30:26 INFO - -d DEST, --destination=DEST 22:30:26 INFO - Directory to install application into. [default: 22:30:26 INFO - "/builds/slave/test"] 22:30:26 INFO - --app=APP Application being installed. [default: firefox] 22:30:26 INFO - mkdir: /builds/slave/test/build/application 22:30:26 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'] 22:30:26 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 22:30:43 INFO - Reading from file tmpfile_stdout 22:30:43 INFO - Output received: 22:30:43 INFO - /builds/slave/test/build/application/firefox/firefox 22:30:43 INFO - Running post-action listener: _resource_record_post_action 22:30:43 INFO - [mozharness: 2016-10-28 05:30:43.097902Z] Finished install step (success) 22:30:43 INFO - [mozharness: 2016-10-28 05:30:43.098146Z] Running run-tests step. 22:30:43 INFO - Running pre-action listener: _resource_record_pre_action 22:30:43 INFO - Running main action method: run_tests 22:30:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:30:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:30:43 INFO - Python 2.7.3 22:30:43 INFO - Return code: 0 22:30:43 INFO - grabbing minidump binary from tooltool 22:30:43 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')]} 22:30:43 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 0x1a80930>, '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 0x1a81830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a81cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:30:43 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 22:30:43 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 22:30:43 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 22:30:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:30:43 INFO - Return code: 0 22:30:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:30:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:30:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:30:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:30:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:30:43 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/fAlwTkYtRMCI02P5y53a2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 22:30:43 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/fAlwTkYtRMCI02P5y53a2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --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 22:30:43 INFO - Using env: {'DISPLAY': ':0', 22:30:43 INFO - 'HOME': '/home/cltbld', 22:30:43 INFO - 'LANG': 'en_US.UTF-8', 22:30:43 INFO - 'LANGUAGE': 'en_US:en', 22:30:43 INFO - 'LOGNAME': 'cltbld', 22:30:43 INFO - 'MAIL': '/var/mail/cltbld', 22:30:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:30:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:30:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:43 INFO - 'MOZ_NO_REMOTE': '1', 22:30:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:30:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:43 INFO - 'NO_EM_RESTART': '1', 22:30:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:43 INFO - 'PWD': '/builds/slave/test', 22:30:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:30:43 INFO - 'SHELL': '/bin/bash', 22:30:43 INFO - 'SHLVL': '1', 22:30:43 INFO - 'TERM': 'linux', 22:30:43 INFO - 'TMOUT': '86400', 22:30:43 INFO - 'USER': 'cltbld', 22:30:43 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1477632500.574355-767230091', 22:30:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:43 INFO - '_': '/tools/buildbot/bin/python'} 22:30:43 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/fAlwTkYtRMCI02P5y53a2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 22:30:43 INFO - mozversion application_buildid: 20161027193003 22:30:43 INFO - mozversion application_changeset: 944cb0fd05526894fcd90fbe7d1e625ee53cd73d 22:30:43 INFO - mozversion application_display_name: Nightly 22:30:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:30:43 INFO - mozversion application_name: Firefox 22:30:43 INFO - mozversion application_remotingname: firefox 22:30:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:30:43 INFO - mozversion application_vendor: Mozilla 22:30:43 INFO - mozversion application_version: 52.0a1 22:30:43 INFO - mozversion platform_buildid: 20161027193003 22:30:43 INFO - mozversion platform_changeset: 944cb0fd05526894fcd90fbe7d1e625ee53cd73d 22:30:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:30:43 INFO - mozversion platform_version: 52.0a1 22:30:43 INFO - using testdate: 1477632643 22:30:43 INFO - actual date: 1477632643 22:30:43 INFO - starting webserver on 'localhost:40625' 22:30:43 INFO - SUITE-START | Running 2 tests 22:30:43 INFO - TEST-START | dromaeo_css 22:30:43 INFO - operating with platform_type : linux_ 22:30:43 INFO - Initialising browser for dromaeo_css test... 22:30:43 INFO - TEST-INFO | started process 8793 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn0Y276/profile http://localhost:40625/getInfo.html) 22:30:47 INFO - PROCESS | 8793 | __metrics Screen width/height:1600/1200 22:30:47 INFO - PROCESS | 8793 | colorDepth:24 22:30:47 INFO - PROCESS | 8793 | Browser inner width/height: 1024/697 22:30:47 INFO - PROCESS | 8793 | __metrics 22:30:48 INFO - PROCESS | 8793 | 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" 22:30:48 INFO - PROCESS | 8793 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:30:49 INFO - PROCESS | 8793 | console.error: PushService: 22:30:49 INFO - PROCESS | 8793 | stateChangeProcessEnqueue: Error transitioning state 22:30:49 INFO - PROCESS | 8793 | UnknownError 22:30:49 INFO - TEST-INFO | 8793: exit 0 22:30:49 INFO - Browser initialized. 22:30:49 INFO - Running cycle 1/1 for dromaeo_css test... 22:30:49 INFO - TEST-INFO | started process 8875 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn0Y276/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:31:01 INFO - PROCESS | 8875 | RSS: Main: 172236800 22:31:01 INFO - PROCESS | 8875 | 22:31:53 INFO - PROCESS | 8875 | 1477632713036 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] 22:34:03 INFO - PROCESS | 8875 | Cycle 1(1): loaded http://localhost:40625/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40625/tests/dromaeo/cssquery-ext.html) 22:34:06 INFO - PROCESS | 8875 | RSS: Main: 409317376 22:34:06 INFO - PROCESS | 8875 | 22:37:09 INFO - PROCESS | 8875 | Cycle 1(1): loaded http://localhost:40625/tests/dromaeo/cssquery-ext.html (next: http://localhost:40625/tests/dromaeo/cssquery-jquery.html) 22:37:09 INFO - PROCESS | 8875 | RSS: Main: 282304512 22:37:09 INFO - PROCESS | 8875 | 22:40:11 INFO - PROCESS | 8875 | Cycle 1(1): loaded http://localhost:40625/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40625/tests/dromaeo/cssquery-mootools.html) 22:40:12 INFO - PROCESS | 8875 | RSS: Main: 220999680 22:40:12 INFO - PROCESS | 8875 | 22:43:14 INFO - PROCESS | 8875 | Cycle 1(1): loaded http://localhost:40625/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40625/tests/dromaeo/cssquery-prototype.html) 22:43:15 INFO - PROCESS | 8875 | RSS: Main: 237920256 22:43:15 INFO - PROCESS | 8875 | 22:46:17 INFO - PROCESS | 8875 | Cycle 1(1): loaded http://localhost:40625/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40625/tests/dromaeo/cssquery-yui.html) 22:46:18 INFO - PROCESS | 8875 | RSS: Main: 221671424 22:46:18 INFO - PROCESS | 8875 | 22:49:21 INFO - PROCESS | 8875 | Cycle 1(1): loaded http://localhost:40625/tests/dromaeo/cssquery-yui.html (next: http://localhost:40625/tests/dromaeo/cssquery-dojo.html) 22:49:21 INFO - PROCESS | 8875 | RSS: Main: 312680448 22:49:21 INFO - PROCESS | 8875 | 22:49:21 INFO - PROCESS | 8875 | __start_tp_report 22:49:21 INFO - PROCESS | 8875 | _x_x_mozilla_page_load 22:49:21 INFO - PROCESS | 8875 | _x_x_mozilla_page_load_details 22:49:21 INFO - PROCESS | 8875 | |i|pagename|runs| 22:49:21 INFO - PROCESS | 8875 | |0;dojo.html;3060.8928687495936;3085.7839951203423;3091.3353628969776;3122.0477754284934;3135.764817638676;5131.153359695646;5201.739913004353;5365.570754339653;5435.891282174354;5437.6465529740535;5226.18994055921;5254.4220135785035;5257.815976440826;5258.474152584739;5268.236105764671;4782.904341913159;4805.303231031498;4824.4210694716685;4856.781444834974;4875.439324477695;4907.2148456247005;4933.112039832847;4945.159322915113;4945.431275403321;4945.554900058994;4924.2121260598315;4930.309756634074;4968.602511799066;5000.07498612756;5039.44566097729;5024.648274620778;5031.32077169581;5035.093683137071;5037.395512538482;5106.872328191787;4745.335653008581;4784.258439941815;4890.902181956341;4960.156773348539;4960.50394960501;5344.599155063347;5380;5380.838574842761;5381.677099374011;5465.508104270635;5790.392008839095;5821.330546987108;5822.951868663639;5826.242588463515;5829.7376618052285;5529.30883639545;5605.187247849039;5733.426657334275;5864.44287792659;5872.17789509469;5379.67721936685;5392.91910621341;5395.271638328775;5472.069748142785;5478.972605136949;5887.558433117448;5888.676122813286;5891.175235467038;5895.528357731371;5898.292204935436;5423.376311724202;5469.644473109315;5653.717314134276;5666.716664166775;5687;5540.196671482612;5604.467575580314;5606.6636001840025;5611.410801865745;5613.522850557748;5562.3881373048935;5600.27196464457;5609.046462101453;5613.129964855454;5614.747336369873;5616.971915140398;5624.71876406178;5624.831255062355;5627.099664053731;5628.85927851807;4267.146570685875;4268.701190916606;4271.658267338606;4272.188284226049;4272.380504826845;3777.131259810259;3811.1234416083903;3847.480590120354;3866.6906647468136;3911.8630847920185;5309.707966061904;5311.017461769585;5312.9734351328;5316.0962636351915;5380.381256155592;5614.185943038318;5614.6631202128;5621.409751976065;5629.24005259293;5639.041362968305;5192.9740351298005;5236.73816309183;5257.553107985864;5383.219433182245;5474.7262636868;4973.950260497349;4975.2288395298065;4977.701337919736;5005.249212618136;5029.874253143701;5986.191864098465;5991.161237426677;6004.669743164168;6016.729247183887;6021.939780602225;5593.972030139823;5622.297212848394;5625.240592520121;5778.219940308005;5783.595148339744;5858.882822343615;5917.260342457193;5927.851803704942;5952.791652292149;6020.90968635462;5651;5661.547076233974;5664.85837854057;5665.3201615806365;5667.234923285304;5446.942597528856;5743.10981797822;5744.540436764965;5744.597878148489;5751.194832723339;5436.864078398072;5497;5501.944980550144;5507.504324610644;5510;5422.6475279106735;5486.780528778964;5493.862653433696;5495.148252020943;5514.751836167302;5491.039068162976;5496.285482887199;5510;5511.063119269654;5513.228148059355;5586.581006424616;5617.887642247214;5617.943820561742;5620.269364982526;5627.155926611041;5450.618456707993;5466.4260252674485;5476.205950137128;5477.397486276586;5480.314960629921 22:49:21 INFO - PROCESS | 8875 | |1;ext.html;594.7264258441116;617.080549980529;630.6153246519622;649.4155260265763;651.9348065193482;31327.060188194362;41943.79028104859;43351.78324108375;43407.56592434075;46869.76565117178;44395.556044439545;44829.327560086625;44845.10309793802;44862.1027579449;44895.55104448955;8673.089325620813;8850.73447796567;8863.069377715312;8864.689735859247;8868;8017.118117007125;8210.220029097227;10404.843927341097;10655.84016239757;10662;10744.838827417596;10800.837987430195;10807.189460790432;10821.945890270537;10828.24202305835;10477.214208934322;10528.789424211473;10538.841917371246;10542.47287635615;10547.84178237327;10562.207834412373;10649.893501065046;10653.414062226575;10654.520546575346;10664.200184986157;40900.79549602263;41031.79484102561;41186.1762764746;41217.793911030254;41236;3057.9235519111976;3168.984155079233;3326.0354497196026;3457.4468085106264;3642.7085833133287;30429.087127386214;30611.846940765376;30917.690823091933;30998.225044373845;31094;4238.258304796648;4283.593058659422;4313.978430107861;4557.179707652621;4570.040291538781;314924.99999999773;319672;320451;320918;321925;56698.43301566932;57262.14106788402;57272;57291.71354143286;57352;60723.69638151781;60738.392616074154;60792.39207607956;60812.39187608156;60877;14893.77659335111;15046.172460514557;15064.472743454146;15078.24608769579;15093.39626414931;10836.078933290759;11209.21535492524;11517.942410287895;11584;11600.709982250512;19488.51278718015;19629.92035438036;19715;20227.797722022886;20512.282070127472;6985.476089293222;7116.893246601305;7127.643617819088;7193.201699575106;7311.232320606367;927.8793756811572;1042.6819819954987;1075.8655168103987;1078.5200585739271;1086.0768346905068;31337.045961267286;31498.212544686565;31716.841415793235;32031.679683203336;32169.51745723816;1048.2819268800895;1049.192122066005;1049.3127001813825;1084.717973326925;1148.735790768128;15546.300416481285;16496;16528.25622846975;16537.338506459848;16763.413280535366;510745;516370;517926;519614;521399;50518.494815052116;50857.49142508602;50915;50918.23622645663;51048;1184.6120096523935;1211.3458732284644;1279.6928737103215;1297.7145028093805;1346.077936613423;28109.437811243253;32033;32315.676843231267;32372.676273236964;32468.35063298768;49084.263736044704;49807.501924980286;49814.25278620751;49833.25250121324;49837.75081124716;372283;373113;374531;375580;375610;26720.866395667897;27564.31089222705;27907.302317442227;29373.55939660864;42319.3652095225;45088.54911450975;45150.54849451595;45297.320540191264;45399.77300113478;46786.532134678215;37980.24039519249;38316.425253621775;38334;38799.22401552009;38974.22051558896;37776.62223377731;38010;38170.809145954096;38892;39586;37696.41342844404;38528.80735596304;38951.415728763524;39318;39454.40818387784;31857.522137168424;33843.830780845936;34056.65943340535;34590.13524661904;35141.64858351384;25734.49077292845;26066.86966565155;26483.73516264813;26583.867080664473;26944.461110778066 22:49:21 INFO - PROCESS | 8875 | |2;jquery.html;363.184650459718;378.60814057450546;392.4701652768762;392.7231301932137;415.60932723240154;14100.08075023408;16025.439109631165;18818.623627527442;19400.708989365154;19466.1240244189;18360.908195459037;18386.908065459687;18452.169652365643;18666.06669666518;18672.90663546684;4085.5097388313443;5463.644863083907;5661.179129026309;5700.942990570083;5708.571857110713;4216.051388437608;6123.755049798003;6352.301246862841;6410.038494225857;6510.93489065108;6273.654948977804;6439.388258115471;6492.545521813475;6518.380753828403;6538.836529086763;6434.80695579131;6456.128422662974;6473.74105035798;6475.158229430168;6480.546361754679;4990.151674215392;5218.373795144569;5222.660527065728;5261.1319132343115;5293.285406470154;13610.86389136106;13737.931310343485;13755;13866.306684665726;13944.16335019902;1934.6807776716967;2236.7651396603446;2245.348848833836;2547.46503234321;2612.2946804362905;9417.105374989365;9951.90048099517;10219;10582.047615714622;13230.27233502157;1666.5417010322258;1693.4327000454862;1717.381742572673;1720.053970316321;1838.7241913712917;72598;76592;77994.22005779926;78876;80396.19603804004;10496.68509944703;10544.57821687124;10836.620718274822;10861.83707244392;10999.395033273247;15168.165750883807;15184.088954662755;15188.46840360582;15226.162561059247;15258.618534536503;7476.214997425301;7550.735724249625;7635.389168866477;7704.8844267336035;7752.332402166313;7067.116610423697;7144.571325720473;7168.17565979919;7332.96333518329;7336.96331518339;4562.771861406916;4564.6348292136545;4634.304854271819;4678.415198100238;4722.220833562493;1903.666858299792;1906.895120768371;1950;1963.783983761785;1984.434436185709;851.2806678356778;899.9460032398077;917.6696389299847;936.7798567336671;1015.5277795824977;18489.90755046216;19479.61040779205;19656.90171549133;19748;20076.196952122045;896.1262768800367;914.4741773480275;951.305546950716;977.4868194198103;992.3847214726916;10330.896691032993;10740.78518429627;10854.728631784268;10965.83551246732;11012.724681883017;156321;244702;425788;435429;438015;83278.58360708157;83419.5829020851;85731;86997.5650121758;88090.55954720185;987.8271302522173;991.3209451525728;1024.9743756406149;1044.5143008501084;1050.9737256568646;15231.619209519851;15925.124118173148;16006.359745610045;16236.18819059066;16827;41941.79029104957;42743;43337.13325733405;43476.78261608672;43874.12251754883;57875.42124578869;58226.12660810176;58673.413265868505;58823.70588147032;58932.410675892694;5788.855278618068;8420.621072051896;8572.385422446214;8572.785680358042;8825.205731484197;11341.376224307742;13070.477180912658;13378.866211337761;13517.459301628218;13524.256165910969;11118.555257789598;11313.490892910004;11313.604023859125;11793.587224447103;12025.518979241082;11040.337579744919;11100.777984440427;11177.88822111801;11272.774544509228;11275.097992160443;11194.832077519006;11440.828387574027;11724.296542207494;11738.823917641072;11767.176297659082;8354.749357519284;8649.783755406164;8711.085336039625;8718.041015488165;8956.104389560991;9832.55753491109;11404.657860264206;11594.188406811441;11771.587994420153;11841.526338946345 22:49:21 INFO - PROCESS | 8875 | |3;mootools.html;1287.5236162619833;1425.481861817165;1447.51508244738;1544.1815837606073;1716.8969861808284;7234.1319041715005;7863.646135923883;8143.226393492616;8152.347812175011;8411.074781774;8257.25684688378;8326.875096873551;8332.958335208315;8377.664893404257;8384.287335576468;2257.9661305080435;2285.131649973008;2288.9084436622516;2289.3132060381904;2293.977060229393;2254.346239590525;2309.58427483053;2313.1903833658253;2315.6063469210276;2319.072371051576;2210.613142700029;2228.1198926424054;2247.494313779403;2291.129370839079;2297.8506397084134;2171.7936796004356;2181.7818218178213;2187.387531491177;2197.3298144065975;2197.9450513737124;2207.834412419059;2233.1625640384855;2237.8992945317336;2238.3173132194675;2240.451089483087;8193.79515512111;8287.834243315161;8347.248747612683;8378.706745263886;8508.064112947572;5007.974960125176;5113.309703190059;5122.462141475166;5123.820666276662;5136.998285334361;3349.464085746293;3441.1569165554347;3486.4944583035317;3495.16116132129;3496.2657841853243;1096.3915027159924;1096.6216655253925;1152.8097863852454;1197.461142485885;1214.7266864955402;11420.14348923834;11455.713607159805;11505.654830355103;11506.654800356002;11522.884771152349;4094.5086589609436;4383.298672212431;4387.517373089022;4447.666425018137;4494.910101797946;9084.591193396313;9090.181883630372;9091.81816363669;9095.31785116119;9096.272298216127;5170.767315470813;5205.687658740488;5207.531322181022;5213.113770658997;5215.374155101336;4202.424090965887;4369.300911854088;4514.571115743999;4611.262198048296;4855.077535268288;3513.543239378864;3600.6939410149907;3661.176235347026;3672.594450634785;3685;1089.596849165798;1092.6285063078592;1098.9175811814146;1108.196557495809;1122.5060973171778;841.1672444280241;849.3841964575633;865.3207232322596;916.5371487398821;918.150710592699;5550.306211723535;5583.553315734732;5609.27079479665;5748.252727145445;5838.9124163137585;868.6959564152496;877.7454538183982;897.4839467306325;915.6017132547363;930.6361840924112;3478.2867429370385;3556.28874225156;3578.9284214315567;3647.9817600911824;3671.1005803578296;10460.895391046144;10839.187060970458;10841.403722795165;10846.349219046882;10881.075108615856;10692.679219623424;10774.73063173427;10817;10831;10841.945790270998;7351.191368949411;7676.155622881479;8074.959625201836;8245.464044837066;8251.876221856677;5302.098643230583;5374.57003439716;5378.408375078817;5524.309461317335;5622.465865742748;9376.578053987723;9392.154706076486;9435.24518038569;9484.099010593982;9797.951010244904;9212.216961558343;9528.52357382142;9576.712698619052;9674.08096230857;9844;6711.3288671132495;6948.895766563404;6952.860942781015;7207.315305046012;7323.304286092813;7622.771316860503;7687.577183254751;7693.230676932262;7922.445428820158;7925.167857374892;7024.648767561704;7151.60666163366;7177.928220717726;7186.748463803742;7264.963675181591;7011;7023.15948032388;7075.327843854826;7198.7840364789145;7253.238409966877;6259.812205633838;6421.229452465734;6446.871062578816;6449.3873082057125;6453.128827608213;4857;4930.161872481615;4964.180910149785;4980.377452818398;5033.572146367454;4722.244440889442;4762.59517940965;4885.853424397274;4899.314096026488;5035.823746168867 22:49:21 INFO - PROCESS | 8875 | |4;prototype.html;328.3891960952628;334.6352475801376;334.71381968417;338.15967321206796;345.0562710985456;5086.237064440326;5184;5207.921881171786;5322.201669749539;5337.5196232339085;5103.515166059227;5192.896142077157;5219.765110570024;5222.686638801674;5227.3465816772905;4144.440500532435;4158.896027599304;4165;4168.958310416902;4172.833086676529;4005.8597949071786;4129.256733787917;4165.229432554972;4171.311733563958;4184.769837658928;4073.450084238634;4082.2447847148374;4087.384074192519;4089.161721847014;4104.610062044101;4073.124278280184;4085.3259212229946;4095.2219078375015;4098.774567398792;4101.794910254505;3635.581908080578;3637.744977982592;3647.9270414591824;3648.708103351752;3649.908752281214;4951.62862785289;5083.364579427572;5110.463401342842;5113.465960211922;5123.513266239701;4663.743494107823;4677.906441871178;4678.578927896506;4680.782996420955;4696.178168820477;5443.618946673734;5456.345238571357;5497.8075767348355;5499.340079190522;5507.449255074461;3759.154190307186;3930.272899513599;3956.5252169739815;3960.128771670228;3962.643362097396;5671.015144699363;5691.345495268097;5702.942970570282;5704.828855134353;5714.257146570961;4064.288749468831;4065.329220678555;4065.654419374386;4075.021994721305;4075.9796201018803;3854.1286741377294;4031.274370613259;4061.1065565575527;4088.9182216355507;4127.318992366286;4643;4648.372469716613;4656;4657.650676199299;4659.324397962344;5508.779648814003;5519.917201241985;5524.502794748492;5527.231285988445;5536;1305.3799445263423;1321.4053675845907;1397.6791931624516;1399.132537826554;1411.7670584353466;877.5085951866974;895.8477058899872;905.9501727404925;910.5976795734626;913.8674892140602;4641.698289611165;4663.976680116578;4671;4688.390509233778;4688.789004494806;4790.592799612072;4842.498825364149;4952.830188679248;4960.727160006162;4966.354373931438;4599.2871104978785;4635.284944570463;4644.629834198852;4693.81224751013;4698.600618947427;2823.3929705113087;3017.5624534442823;3026.6077604301827;3034.9544756828664;3035.195673146618;5828.6794226317115;5834.912476312858;5850.473457388855;5853.88292234153;5881.5882888198275;5554;5716.914246286309;5741.282339707536;5833.979053665592;5836.416358364129;5799.187394113936;5799.999000344958;5803.084981955944;5807.477327040587;5810.099434587646;5617.314805558398;5621.634593751393;5636.492715655447;5659.490645841894;5671.262735844314;5419.509634850448;5673.375928647928;5691.7438715257085;5697.57268204878;5699.658020518782;5704.172894930295;5787.826365209051;5790.536757059341;5832.708364581669;5852.853678658068;3956.1296514766705;3970.900727481836;4037.5558688543647;4047;4061.1268577256033;5469.480399362054;5640.492355688008;5699.316082070178;5712.485876271156;5725.312962444534;5405.486478784509;5426.585169599491;5512.50387465114;5524.972375138099;5557.972210138923;5505.311836020497;5508.531774799187;5536.7231638417115;5548.472895074961;5574.247476590608;5338.893222135458;5487.259220005249;5495.148252020943;5541.916871246854;5557.916631250454;5531.7234138292115;5540.085885828954;5567.524605979338;5572.4706152915405;5596.524295434933;5434.10337294342;5461.699606521679;5464.147775818118;5467.343918729619;5471.9179212311055 22:49:21 INFO - PROCESS | 8875 | |5;yui.html;595.5384576952864;632.4118569730152;645.6900687669921;687.3298533929419;689.9753865509718;12240.632781016573;12935.353232338393;12941.288229147392;12948.48206071756;12955.676108097303;11258;11272;11273.549058037668;11287.209895307331;11292.096632269418;637.6907200007993;655.4854439265177;661.2230629010917;777.9222077792218;795.08168065884;652.9118568993173;654.5581732330681;750.7034721285116;783.2559068884553;785.721069020498;836.9288610468118;837.7026155714725;839.0686338164633;839.4166054592062;843.6583183810567;834.9958250208771;836.1178956201205;836.1387770596295;836.297510091523;836.3267569606464;496.84101087651965;506.5137468030695;588.7144734803617;607.3865395950078;617.4874853871275;12294.692632684166;12315.4458049388;12323.383830808514;12323.69190770229;12407.255564666058;11201.551937922473;11408.657740267805;11584.2470239435;11745.765084698258;12029.39853007355;10815.621453249178;10944.288621239593;11006.449677516091;11023.44882755859;11524.827127593093;4088.5707000764787;4181.770002649853;4226.619604235603;4355.194289056535;4363.934540981888;56542.43457565413;59259.99999999957;59409;63172.36827631665;64258;8605.409285308302;9006.909930900607;9304.488253146143;9525.809483810284;9550.665726699672;17143.314267429414;17289.65420691579;17326.480205593853;17327.91336043312;17340.91329543344;6537.738490460329;6699.899501507482;6761.323867613298;6995.335443132894;7017.508784381471;4173.853915112956;4174.269502836992;4183.623473887304;4294.57054294568;4301.096769678403;3172.952405713916;3208.1498402923244;3214.8392580370887;3262.8205448700073;3271.705546500779;577.4543056811273;590.6485641043572;605.4097255176168;608.8538750699801;616.9136320915076;598.6019297167335;610.4585920550645;665.9245318810086;666.1939053744926;674.4907594765921;8537.74386768398;8623.698170564001;8878.822423551623;9045.864312035324;9054.86417703735;625.8185126313409;643.810076027573;695.2282965907838;726.4333819620705;754.4417131322782;4133.8966525836495;4142.813573389205;4236.152769446061;4236.9364459533135;4265.53079161292;48614.756926215145;61294.69352653208;71340.2865971344;79896;84599;27777.166684999484;27891.860540697166;51984;67402.98895516571;67577.3242267581;63988.36011639824;64422.67788661121;66016.66991665203;67120.6643966777;67348;8561.743147705578;8789.692360767342;8886.911130888608;8990.280777537911;9217.124373184537;32352.83823580867;33945.49081763825;35825.46261806023;43037.56962430335;45441.318380224984;56184.719076404355;61472.38527614845;62089.37910620836;63036;64829.67585162044;11194.496247669038;11310.547578097114;11533.769324613293;11587.304761714324;12024.75950480968;11611;11623.12826537996;11701.180917335705;11977;12422.440990155284;10512.31669941482;11046.889531104585;11052.060574850906;11097.38964356968;11440.885591143982;10781.9460902695;11080.94181068659;11270.380129092979;11418.143639226924;11424.257423267461;10546.57813687444;10645.254832161674;10676.946615267185;10952.568834373204;11424.48589813477;8792.560371981503;8985.685501007434;9175.31185161129;9640.42157470554;9981.950090249502;8496.235338819535;8814.647414103363;9819.950900245452;9914.553845077133;9940.552675129491 22:49:21 INFO - PROCESS | 8875 | __end_tp_report 22:49:21 INFO - PROCESS | 8875 | __start_cc_report 22:49:21 INFO - PROCESS | 8875 | _x_x_mozilla_cycle_collect,2542 22:49:21 INFO - PROCESS | 8875 | __end_cc_report 22:49:21 INFO - PROCESS | 8875 | __startTimestamp1477633761743__endTimestamp 22:49:21 INFO - PROCESS | 8875 | 22:49:21 INFO - PROCESS | 8875 | ------- Summary: start ------- 22:49:21 INFO - PROCESS | 8875 | Number of tests: 6 22:49:21 INFO - PROCESS | 8875 | 22:49:21 INFO - PROCESS | 8875 | [#0] dojo.html Cycles:165 Average:5298.75 Median:5477.40 stddev:599.58 (10.9%) stddev-sans-first:575.15 22:49:21 INFO - PROCESS | 8875 | Values: 3060.9 3085.8 3091.3 3122.0 3135.8 5131.2 5201.7 5365.6 5435.9 5437.6 5226.2 5254.4 5257.8 5258.5 5268.2 4782.9 4805.3 4824.4 4856.8 4875.4 4907.2 4933.1 4945.2 4945.4 4945.6 4924.2 4930.3 4968.6 5000.1 5039.4 5024.6 5031.3 5035.1 5037.4 5106.9 4745.3 4784.3 4890.9 4960.2 4960.5 5344.6 5380.0 5380.8 5381.7 5465.5 5790.4 5821.3 5823.0 5826.2 5829.7 5529.3 5605.2 5733.4 5864.4 5872.2 5379.7 5392.9 5395.3 5472.1 5479.0 5887.6 5888.7 5891.2 5895.5 5898.3 5423.4 5469.6 5653.7 5666.7 5687.0 5540.2 5604.5 5606.7 5611.4 5613.5 5562.4 5600.3 5609.0 5613.1 5614.7 5617.0 5624.7 5624.8 5627.1 5628.9 4267.1 4268.7 4271.7 4272.2 4272.4 3777.1 3811.1 3847.5 3866.7 3911.9 5309.7 5311.0 5313.0 5316.1 5380.4 5614.2 5614.7 5621.4 5629.2 5639.0 5193.0 5236.7 5257.6 5383.2 5474.7 4974.0 4975.2 4977.7 5005.2 5029.9 5986.2 5991.2 6004.7 6016.7 6021.9 5594.0 5622.3 5625.2 5778.2 5783.6 5858.9 5917.3 5927.9 5952.8 6020.9 5651.0 5661.5 5664.9 5665.3 5667.2 5446.9 5743.1 5744.5 5744.6 5751.2 5436.9 5497.0 5501.9 5507.5 5510.0 5422.6 5486.8 5493.9 5495.1 5514.8 5491.0 5496.3 5510.0 5511.1 5513.2 5586.6 5617.9 5617.9 5620.3 5627.2 5450.6 5466.4 5476.2 5477.4 5480.3 22:49:21 INFO - PROCESS | 8875 | 22:49:21 INFO - PROCESS | 8875 | [#1] ext.html Cycles:180 Average:56529.37 Median:19392.18 stddev:109091.01 (562.6%) stddev-sans-first:109316.20 22:49:21 INFO - PROCESS | 8875 | Values: 594.7 617.1 630.6 649.4 651.9 31327.1 41943.8 43351.8 43407.6 46869.8 44395.6 44829.3 44845.1 44862.1 44895.6 8673.1 8850.7 8863.1 8864.7 8868.0 8017.1 8210.2 10404.8 10655.8 10662.0 10744.8 10800.8 10807.2 10821.9 10828.2 10477.2 10528.8 10538.8 10542.5 10547.8 10562.2 10649.9 10653.4 10654.5 10664.2 40900.8 41031.8 41186.2 41217.8 41236.0 3057.9 3169.0 3326.0 3457.4 3642.7 30429.1 30611.8 30917.7 30998.2 31094.0 4238.3 4283.6 4314.0 4557.2 4570.0 314925.0 319672.0 320451.0 320918.0 321925.0 56698.4 57262.1 57272.0 57291.7 57352.0 60723.7 60738.4 60792.4 60812.4 60877.0 14893.8 15046.2 15064.5 15078.2 15093.4 10836.1 11209.2 11517.9 11584.0 11600.7 19488.5 19629.9 19715.0 20227.8 20512.3 6985.5 7116.9 7127.6 7193.2 7311.2 927.9 1042.7 1075.9 1078.5 1086.1 31337.0 31498.2 31716.8 32031.7 32169.5 1048.3 1049.2 1049.3 1084.7 1148.7 15546.3 16496.0 16528.3 16537.3 16763.4 510745.0 516370.0 517926.0 519614.0 521399.0 50518.5 50857.5 50915.0 50918.2 51048.0 1184.6 1211.3 1279.7 1297.7 1346.1 28109.4 32033.0 32315.7 32372.7 32468.4 49084.3 49807.5 49814.3 49833.3 49837.8 372283.0 373113.0 374531.0 375580.0 375610.0 26720.9 27564.3 27907.3 29373.6 42319.4 45088.5 45150.5 45297.3 45399.8 46786.5 37980.2 38316.4 38334.0 38799.2 38974.2 37776.6 38010.0 38170.8 38892.0 39586.0 37696.4 38528.8 38951.4 39318.0 39454.4 31857.5 33843.8 34056.7 34590.1 35141.6 25734.5 26066.9 26483.7 26583.9 26944.5 22:49:21 INFO - PROCESS | 8875 | 22:49:21 INFO - PROCESS | 8875 | [#2] jquery.html Cycles:180 Average:24181.88 Median:392.60 stddev:60294.85 (15358.0%) stddev-sans-first:60437.47 22:49:21 INFO - PROCESS | 8875 | Values: 363.2 378.6 392.5 392.7 415.6 14100.1 16025.4 18818.6 19400.7 19466.1 18360.9 18386.9 18452.2 18666.1 18672.9 4085.5 5463.6 5661.2 5700.9 5708.6 4216.1 6123.8 6352.3 6410.0 6510.9 6273.7 6439.4 6492.5 6518.4 6538.8 6434.8 6456.1 6473.7 6475.2 6480.5 4990.2 5218.4 5222.7 5261.1 5293.3 13610.9 13737.9 13755.0 13866.3 13944.2 1934.7 2236.8 2245.3 2547.5 2612.3 9417.1 9951.9 10219.0 10582.0 13230.3 1666.5 1693.4 1717.4 1720.1 1838.7 72598.0 76592.0 77994.2 78876.0 80396.2 10496.7 10544.6 10836.6 10861.8 10999.4 15168.2 15184.1 15188.5 15226.2 15258.6 7476.2 7550.7 7635.4 7704.9 7752.3 7067.1 7144.6 7168.2 7333.0 7337.0 4562.8 4564.6 4634.3 4678.4 4722.2 1903.7 1906.9 1950.0 1963.8 1984.4 851.3 899.9 917.7 936.8 1015.5 18489.9 19479.6 19656.9 19748.0 20076.2 896.1 914.5 951.3 977.5 992.4 10330.9 10740.8 10854.7 10965.8 11012.7 156321.0 244702.0 425788.0 435429.0 438015.0 83278.6 83419.6 85731.0 86997.6 88090.6 987.8 991.3 1025.0 1044.5 1051.0 15231.6 15925.1 16006.4 16236.2 16827.0 41941.8 42743.0 43337.1 43476.8 43874.1 57875.4 58226.1 58673.4 58823.7 58932.4 5788.9 8420.6 8572.4 8572.8 8825.2 11341.4 13070.5 13378.9 13517.5 13524.3 11118.6 11313.5 11313.6 11793.6 12025.5 11040.3 11100.8 11177.9 11272.8 11275.1 11194.8 11440.8 11724.3 11738.8 11767.2 8354.7 8649.8 8711.1 8718.0 8956.1 9832.6 11404.7 11594.2 11771.6 11841.5 22:49:21 INFO - PROCESS | 8875 | 22:49:21 INFO - PROCESS | 8875 | [#3] mootools.html Cycles:180 Average:5466.07 Median:5074.57 stddev:3098.06 (61.1%) stddev-sans-first:3090.84 22:49:21 INFO - PROCESS | 8875 | Values: 1287.5 1425.5 1447.5 1544.2 1716.9 7234.1 7863.6 8143.2 8152.3 8411.1 8257.3 8326.9 8333.0 8377.7 8384.3 2258.0 2285.1 2288.9 2289.3 2294.0 2254.3 2309.6 2313.2 2315.6 2319.1 2210.6 2228.1 2247.5 2291.1 2297.9 2171.8 2181.8 2187.4 2197.3 2197.9 2207.8 2233.2 2237.9 2238.3 2240.5 8193.8 8287.8 8347.2 8378.7 8508.1 5008.0 5113.3 5122.5 5123.8 5137.0 3349.5 3441.2 3486.5 3495.2 3496.3 1096.4 1096.6 1152.8 1197.5 1214.7 11420.1 11455.7 11505.7 11506.7 11522.9 4094.5 4383.3 4387.5 4447.7 4494.9 9084.6 9090.2 9091.8 9095.3 9096.3 5170.8 5205.7 5207.5 5213.1 5215.4 4202.4 4369.3 4514.6 4611.3 4855.1 3513.5 3600.7 3661.2 3672.6 3685.0 1089.6 1092.6 1098.9 1108.2 1122.5 841.2 849.4 865.3 916.5 918.2 5550.3 5583.6 5609.3 5748.3 5838.9 868.7 877.7 897.5 915.6 930.6 3478.3 3556.3 3578.9 3648.0 3671.1 10460.9 10839.2 10841.4 10846.3 10881.1 10692.7 10774.7 10817.0 10831.0 10841.9 7351.2 7676.2 8075.0 8245.5 8251.9 5302.1 5374.6 5378.4 5524.3 5622.5 9376.6 9392.2 9435.2 9484.1 9798.0 9212.2 9528.5 9576.7 9674.1 9844.0 6711.3 6948.9 6952.9 7207.3 7323.3 7622.8 7687.6 7693.2 7922.4 7925.2 7024.6 7151.6 7177.9 7186.7 7265.0 7011.0 7023.2 7075.3 7198.8 7253.2 6259.8 6421.2 6446.9 6449.4 6453.1 4857.0 4930.2 4964.2 4980.4 5033.6 4722.2 4762.6 4885.9 4899.3 5035.8 22:49:21 INFO - PROCESS | 8875 | 22:49:21 INFO - PROCESS | 8875 | [#4] prototype.html Cycles:180 Average:4587.01 Median:5118.49 stddev:1350.34 (26.4%) stddev-sans-first:1315.76 22:49:21 INFO - PROCESS | 8875 | Values: 328.4 334.6 334.7 338.2 345.1 5086.2 5184.0 5207.9 5322.2 5337.5 5103.5 5192.9 5219.8 5222.7 5227.3 4144.4 4158.9 4165.0 4169.0 4172.8 4005.9 4129.3 4165.2 4171.3 4184.8 4073.5 4082.2 4087.4 4089.2 4104.6 4073.1 4085.3 4095.2 4098.8 4101.8 3635.6 3637.7 3647.9 3648.7 3649.9 4951.6 5083.4 5110.5 5113.5 5123.5 4663.7 4677.9 4678.6 4680.8 4696.2 5443.6 5456.3 5497.8 5499.3 5507.4 3759.2 3930.3 3956.5 3960.1 3962.6 5671.0 5691.3 5702.9 5704.8 5714.3 4064.3 4065.3 4065.7 4075.0 4076.0 3854.1 4031.3 4061.1 4088.9 4127.3 4643.0 4648.4 4656.0 4657.7 4659.3 5508.8 5519.9 5524.5 5527.2 5536.0 1305.4 1321.4 1397.7 1399.1 1411.8 877.5 895.8 906.0 910.6 913.9 4641.7 4664.0 4671.0 4688.4 4688.8 4790.6 4842.5 4952.8 4960.7 4966.4 4599.3 4635.3 4644.6 4693.8 4698.6 2823.4 3017.6 3026.6 3035.0 3035.2 5828.7 5834.9 5850.5 5853.9 5881.6 5554.0 5716.9 5741.3 5834.0 5836.4 5799.2 5800.0 5803.1 5807.5 5810.1 5617.3 5621.6 5636.5 5659.5 5671.3 5419.5 5673.4 5691.7 5697.6 5699.7 5704.2 5787.8 5790.5 5832.7 5852.9 3956.1 3970.9 4037.6 4047.0 4061.1 5469.5 5640.5 5699.3 5712.5 5725.3 5405.5 5426.6 5512.5 5525.0 5558.0 5505.3 5508.5 5536.7 5548.5 5574.2 5338.9 5487.3 5495.1 5541.9 5557.9 5531.7 5540.1 5567.5 5572.5 5596.5 5434.1 5461.7 5464.1 5467.3 5471.9 22:49:21 INFO - PROCESS | 8875 | 22:49:21 INFO - PROCESS | 8875 | [#5] yui.html Cycles:180 Average:15306.51 Median:29925.32 stddev:20216.54 (67.6%) stddev-sans-first:20243.08 22:49:21 INFO - PROCESS | 8875 | Values: 595.5 632.4 645.7 687.3 690.0 12240.6 12935.4 12941.3 12948.5 12955.7 11258.0 11272.0 11273.5 11287.2 11292.1 637.7 655.5 661.2 777.9 795.1 652.9 654.6 750.7 783.3 785.7 836.9 837.7 839.1 839.4 843.7 835.0 836.1 836.1 836.3 836.3 496.8 506.5 588.7 607.4 617.5 12294.7 12315.4 12323.4 12323.7 12407.3 11201.6 11408.7 11584.2 11745.8 12029.4 10815.6 10944.3 11006.4 11023.4 11524.8 4088.6 4181.8 4226.6 4355.2 4363.9 56542.4 59260.0 59409.0 63172.4 64258.0 8605.4 9006.9 9304.5 9525.8 9550.7 17143.3 17289.7 17326.5 17327.9 17340.9 6537.7 6699.9 6761.3 6995.3 7017.5 4173.9 4174.3 4183.6 4294.6 4301.1 3173.0 3208.1 3214.8 3262.8 3271.7 577.5 590.6 605.4 608.9 616.9 598.6 610.5 665.9 666.2 674.5 8537.7 8623.7 8878.8 9045.9 9054.9 625.8 643.8 695.2 726.4 754.4 4133.9 4142.8 4236.2 4236.9 4265.5 48614.8 61294.7 71340.3 79896.0 84599.0 27777.2 27891.9 51984.0 67403.0 67577.3 63988.4 64422.7 66016.7 67120.7 67348.0 8561.7 8789.7 8886.9 8990.3 9217.1 32352.8 33945.5 35825.5 43037.6 45441.3 56184.7 61472.4 62089.4 63036.0 64829.7 11194.5 11310.5 11533.8 11587.3 12024.8 11611.0 11623.1 11701.2 11977.0 12422.4 10512.3 11046.9 11052.1 11097.4 11440.9 10781.9 11080.9 11270.4 11418.1 11424.3 10546.6 10645.3 10676.9 10952.6 11424.5 8792.6 8985.7 9175.3 9640.4 9982.0 8496.2 8814.6 9820.0 9914.6 9940.6 22:49:21 INFO - PROCESS | 8875 | -------- Summary: end -------- 22:49:21 INFO - PROCESS | 8875 | 22:49:22 INFO - TEST-INFO | 8875: exit 0 22:49:22 INFO - TEST-OK | dromaeo_css | took 1119377ms 22:49:22 INFO - TEST-START | kraken 22:49:22 INFO - operating with platform_type : linux_ 22:49:22 INFO - Initialising browser for kraken test... 22:49:22 INFO - TEST-INFO | started process 9178 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBvwts2/profile http://localhost:40625/getInfo.html) 22:49:26 INFO - PROCESS | 9178 | __metrics Screen width/height:1600/1200 22:49:26 INFO - PROCESS | 9178 | colorDepth:24 22:49:26 INFO - PROCESS | 9178 | Browser inner width/height: 1024/697 22:49:26 INFO - PROCESS | 9178 | __metrics 22:49:27 INFO - PROCESS | 9178 | 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" 22:49:27 INFO - PROCESS | 9178 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:49:28 INFO - PROCESS | 9178 | console.error: PushService: 22:49:28 INFO - PROCESS | 9178 | stateChangeProcessEnqueue: Error transitioning state 22:49:28 INFO - PROCESS | 9178 | UnknownError 22:49:29 INFO - TEST-INFO | 9178: exit 0 22:49:29 INFO - Browser initialized. 22:49:29 INFO - Running cycle 1/1 for kraken test... 22:49:29 INFO - TEST-INFO | started process 9264 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBvwts2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:49:41 INFO - PROCESS | 9264 | RSS: Main: 171941888 22:49:41 INFO - PROCESS | 9264 | 22:49:43 INFO - PROCESS | 9264 | Cycle 1(1): loaded http://localhost:40625/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40625/tests/kraken/driver.html?testName=audio-beat-detection) 22:49:44 INFO - PROCESS | 9264 | RSS: Main: 237993984 22:49:44 INFO - PROCESS | 9264 | 22:49:47 INFO - PROCESS | 9264 | Cycle 1(1): loaded http://localhost:40625/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40625/tests/kraken/driver.html?testName=audio-dft) 22:49:47 INFO - PROCESS | 9264 | RSS: Main: 215961600 22:49:47 INFO - PROCESS | 9264 | 22:49:51 INFO - PROCESS | 9264 | Cycle 1(1): loaded http://localhost:40625/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40625/tests/kraken/driver.html?testName=audio-fft) 22:49:51 INFO - PROCESS | 9264 | RSS: Main: 297996288 22:49:51 INFO - PROCESS | 9264 | 22:49:53 INFO - PROCESS | 9264 | Cycle 1(1): loaded http://localhost:40625/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40625/tests/kraken/driver.html?testName=audio-oscillator) 22:49:54 INFO - PROCESS | 9264 | RSS: Main: 208789504 22:49:54 INFO - PROCESS | 9264 | 22:49:56 INFO - PROCESS | 9264 | Cycle 1(1): loaded http://localhost:40625/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40625/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:49:57 INFO - PROCESS | 9264 | RSS: Main: 211660800 22:49:57 INFO - PROCESS | 9264 | 22:49:59 INFO - PROCESS | 9264 | Cycle 1(1): loaded http://localhost:40625/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40625/tests/kraken/driver.html?testName=imaging-darkroom) 22:50:00 INFO - PROCESS | 9264 | RSS: Main: 247918592 22:50:00 INFO - PROCESS | 9264 | 22:50:03 INFO - PROCESS | 9264 | Cycle 1(1): loaded http://localhost:40625/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40625/tests/kraken/driver.html?testName=imaging-desaturate) 22:50:04 INFO - PROCESS | 9264 | RSS: Main: 247103488 22:50:04 INFO - PROCESS | 9264 | 22:50:07 INFO - PROCESS | 9264 | Cycle 1(1): loaded http://localhost:40625/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40625/tests/kraken/driver.html?testName=json-parse-financial) 22:50:07 INFO - PROCESS | 9264 | RSS: Main: 246951936 22:50:07 INFO - PROCESS | 9264 | 22:50:09 INFO - PROCESS | 9264 | Cycle 1(1): loaded http://localhost:40625/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40625/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:50:09 INFO - PROCESS | 9264 | RSS: Main: 208801792 22:50:09 INFO - PROCESS | 9264 | 22:50:11 INFO - PROCESS | 9264 | Cycle 1(1): loaded http://localhost:40625/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40625/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:50:12 INFO - PROCESS | 9264 | RSS: Main: 216584192 22:50:12 INFO - PROCESS | 9264 | 22:50:14 INFO - PROCESS | 9264 | Cycle 1(1): loaded http://localhost:40625/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40625/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:50:14 INFO - PROCESS | 9264 | RSS: Main: 225509376 22:50:14 INFO - PROCESS | 9264 | 22:50:17 INFO - PROCESS | 9264 | Cycle 1(1): loaded http://localhost:40625/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40625/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:50:18 INFO - PROCESS | 9264 | RSS: Main: 234348544 22:50:18 INFO - PROCESS | 9264 | 22:50:21 INFO - PROCESS | 9264 | Cycle 1(1): loaded http://localhost:40625/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40625/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:50:21 INFO - PROCESS | 9264 | RSS: Main: 231223296 22:50:21 INFO - PROCESS | 9264 | 22:50:23 INFO - PROCESS | 9264 | Cycle 1(1): loaded http://localhost:40625/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40625/tests/kraken/driver.html?testName=ai-astar) 22:50:23 INFO - PROCESS | 9264 | RSS: Main: 281493504 22:50:23 INFO - PROCESS | 9264 | 22:50:23 INFO - PROCESS | 9264 | __start_tp_report 22:50:23 INFO - PROCESS | 9264 | _x_x_mozilla_page_load 22:50:23 INFO - PROCESS | 9264 | _x_x_mozilla_page_load_details 22:50:23 INFO - PROCESS | 9264 | |i|pagename|runs| 22:50:23 INFO - PROCESS | 9264 | |0;ai-astar;104;110;112;111;111;111;110;110;111;110 22:50:23 INFO - PROCESS | 9264 | |1;audio-beat-detection;157;126;125;160;129;129;129;121;158;123 22:50:23 INFO - PROCESS | 9264 | |2;audio-dft;159;162;160;160;164;159;161;161;161;162 22:50:23 INFO - PROCESS | 9264 | |3;audio-fft;76;75;75;111;77;75;76;75;103;75 22:50:23 INFO - PROCESS | 9264 | |4;audio-oscillator;83;82;128;83;84;82;109;82;82;118 22:50:23 INFO - PROCESS | 9264 | |5;imaging-gaussian-blur;117;117;116;116;117;117;117;116;117;117 22:50:23 INFO - PROCESS | 9264 | |6;imaging-darkroom;145;145;147;147;147;146;147;146;145;146 22:50:23 INFO - PROCESS | 9264 | |7;imaging-desaturate;85;84;85;84;84;85;84;84;85;84 22:50:23 INFO - PROCESS | 9264 | |8;json-parse-financial;56;56;57;55;56;55;57;56;57;56 22:50:23 INFO - PROCESS | 9264 | |9;json-stringify-tinderbox;62;63;62;62;63;62;63;62;62;63 22:50:23 INFO - PROCESS | 9264 | |10;stanford-crypto-aes;81;80;80;80;80;81;80;79;80;88 22:50:23 INFO - PROCESS | 9264 | |11;stanford-crypto-ccm;136;129;133;130;135;135;131;134;178;131 22:50:23 INFO - PROCESS | 9264 | |12;stanford-crypto-pbkdf2;170;171;165;166;165;166;165;164;163;167 22:50:23 INFO - PROCESS | 9264 | |13;stanford-crypto-sha256-iterative;67;66;66;67;64;66;66;66;66;65 22:50:23 INFO - PROCESS | 9264 | __end_tp_report 22:50:23 INFO - PROCESS | 9264 | __start_cc_report 22:50:23 INFO - PROCESS | 9264 | _x_x_mozilla_cycle_collect,1708 22:50:23 INFO - PROCESS | 9264 | __end_cc_report 22:50:23 INFO - PROCESS | 9264 | __startTimestamp1477633823594__endTimestamp 22:50:23 INFO - PROCESS | 9264 | 22:50:23 INFO - PROCESS | 9264 | ------- Summary: start ------- 22:50:23 INFO - PROCESS | 9264 | Number of tests: 14 22:50:23 INFO - PROCESS | 9264 | 22:50:23 INFO - PROCESS | 9264 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:2.21 (2.0%) stddev-sans-first:0.71 22:50:23 INFO - PROCESS | 9264 | Values: 104.0 110.0 112.0 111.0 111.0 111.0 110.0 110.0 111.0 110.0 22:50:23 INFO - PROCESS | 9264 | 22:50:23 INFO - PROCESS | 9264 | [#1] audio-beat-detection Cycles:10 Average:135.70 Median:129.00 stddev:15.85 (12.3%) stddev-sans-first:14.82 22:50:23 INFO - PROCESS | 9264 | Values: 157.0 126.0 125.0 160.0 129.0 129.0 129.0 121.0 158.0 123.0 22:50:23 INFO - PROCESS | 9264 | 22:50:23 INFO - PROCESS | 9264 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.52 (0.9%) stddev-sans-first:1.45 22:50:23 INFO - PROCESS | 9264 | Values: 159.0 162.0 160.0 160.0 164.0 159.0 161.0 161.0 161.0 162.0 22:50:23 INFO - PROCESS | 9264 | 22:50:23 INFO - PROCESS | 9264 | [#3] audio-fft Cycles:10 Average:81.80 Median:75.00 stddev:13.43 (17.9%) stddev-sans-first:14.08 22:50:23 INFO - PROCESS | 9264 | Values: 76.0 75.0 75.0 111.0 77.0 75.0 76.0 75.0 103.0 75.0 22:50:23 INFO - PROCESS | 9264 | 22:50:23 INFO - PROCESS | 9264 | [#4] audio-oscillator Cycles:10 Average:93.30 Median:82.00 stddev:17.86 (21.8%) stddev-sans-first:18.55 22:50:23 INFO - PROCESS | 9264 | Values: 83.0 82.0 128.0 83.0 84.0 82.0 109.0 82.0 82.0 118.0 22:50:23 INFO - PROCESS | 9264 | 22:50:23 INFO - PROCESS | 9264 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 22:50:23 INFO - PROCESS | 9264 | Values: 117.0 117.0 116.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 22:50:23 INFO - PROCESS | 9264 | 22:50:23 INFO - PROCESS | 9264 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.50 stddev:0.88 (0.6%) stddev-sans-first:0.83 22:50:23 INFO - PROCESS | 9264 | Values: 145.0 145.0 147.0 147.0 147.0 146.0 147.0 146.0 145.0 146.0 22:50:23 INFO - PROCESS | 9264 | 22:50:23 INFO - PROCESS | 9264 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.50 22:50:23 INFO - PROCESS | 9264 | Values: 85.0 84.0 85.0 84.0 84.0 85.0 84.0 84.0 85.0 84.0 22:50:23 INFO - PROCESS | 9264 | 22:50:23 INFO - PROCESS | 9264 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.00 stddev:0.74 (1.3%) stddev-sans-first:0.78 22:50:23 INFO - PROCESS | 9264 | Values: 56.0 56.0 57.0 55.0 56.0 55.0 57.0 56.0 57.0 56.0 22:50:23 INFO - PROCESS | 9264 | 22:50:23 INFO - PROCESS | 9264 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:62.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 22:50:23 INFO - PROCESS | 9264 | Values: 62.0 63.0 62.0 62.0 63.0 62.0 63.0 62.0 62.0 63.0 22:50:23 INFO - PROCESS | 9264 | 22:50:23 INFO - PROCESS | 9264 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:80.00 stddev:2.56 (3.2%) stddev-sans-first:2.71 22:50:23 INFO - PROCESS | 9264 | Values: 81.0 80.0 80.0 80.0 80.0 81.0 80.0 79.0 80.0 88.0 22:50:23 INFO - PROCESS | 9264 | 22:50:23 INFO - PROCESS | 9264 | [#11] stanford-crypto-ccm Cycles:10 Average:137.20 Median:134.50 stddev:14.53 (10.8%) stddev-sans-first:15.40 22:50:23 INFO - PROCESS | 9264 | Values: 136.0 129.0 133.0 130.0 135.0 135.0 131.0 134.0 178.0 131.0 22:50:23 INFO - PROCESS | 9264 | 22:50:23 INFO - PROCESS | 9264 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.20 Median:166.00 stddev:2.53 (1.5%) stddev-sans-first:2.28 22:50:23 INFO - PROCESS | 9264 | Values: 170.0 171.0 165.0 166.0 165.0 166.0 165.0 164.0 163.0 167.0 22:50:23 INFO - PROCESS | 9264 | 22:50:23 INFO - PROCESS | 9264 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:0.88 (1.3%) stddev-sans-first:0.83 22:50:23 INFO - PROCESS | 9264 | Values: 67.0 66.0 66.0 67.0 64.0 66.0 66.0 66.0 66.0 65.0 22:50:23 INFO - PROCESS | 9264 | -------- Summary: end -------- 22:50:23 INFO - PROCESS | 9264 | 22:50:24 INFO - TEST-INFO | 9264: exit 0 22:50:24 INFO - TEST-OK | kraken | took 62157ms 22:50:24 INFO - SUITE-END | took 1181s 22:50:25 INFO - Completed test suite (00:19:41) 22:50:25 INFO - javascript benchmark 22:50:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3060.8928687495936, 3085.7839951203423, 3091.3353628969776, 3122.0477754284934, 3135.764817638676, 5131.153359695646, 5201.739913004353, 5365.570754339653, 5435.891282174354, 5437.6465529740535, 5226.18994055921, 5254.4220135785035, 5257.815976440826, 5258.474152584739, 5268.236105764671, 4782.904341913159, 4805.303231031498, 4824.4210694716685, 4856.781444834974, 4875.439324477695, 4907.2148456247005, 4933.112039832847, 4945.159322915113, 4945.431275403321, 4945.554900058994, 4924.2121260598315, 4930.309756634074, 4968.602511799066, 5000.07498612756, 5039.44566097729, 5024.648274620778, 5031.32077169581, 5035.093683137071, 5037.395512538482, 5106.872328191787, 4745.335653008581, 4784.258439941815, 4890.902181956341, 4960.156773348539, 4960.50394960501, 5344.599155063347, 5380.0, 5380.838574842761, 5381.677099374011, 5465.508104270635, 5790.392008839095, 5821.330546987108, 5822.951868663639, 5826.242588463515, 5829.7376618052285, 5529.30883639545, 5605.187247849039, 5733.426657334275, 5864.44287792659, 5872.17789509469, 5379.67721936685, 5392.91910621341, 5395.271638328775, 5472.069748142785, 5478.972605136949, 5887.558433117448, 5888.676122813286, 5891.175235467038, 5895.528357731371, 5898.292204935436, 5423.376311724202, 5469.644473109315, 5653.717314134276, 5666.716664166775, 5687.0, 5540.196671482612, 5604.467575580314, 5606.6636001840025, 5611.410801865745, 5613.522850557748, 5562.3881373048935, 5600.27196464457, 5609.046462101453, 5613.129964855454, 5614.747336369873, 5616.971915140398, 5624.71876406178, 5624.831255062355, 5627.099664053731, 5628.85927851807, 4267.146570685875, 4268.701190916606, 4271.658267338606, 4272.188284226049, 4272.380504826845, 3777.131259810259, 3811.1234416083903, 3847.480590120354, 3866.6906647468136, 3911.8630847920185, 5309.707966061904, 5311.017461769585, 5312.9734351328, 5316.0962636351915, 5380.381256155592, 5614.185943038318, 5614.6631202128, 5621.409751976065, 5629.24005259293, 5639.041362968305, 5192.9740351298005, 5236.73816309183, 5257.553107985864, 5383.219433182245, 5474.7262636868, 4973.950260497349, 4975.2288395298065, 4977.701337919736, 5005.249212618136, 5029.874253143701, 5986.191864098465, 5991.161237426677, 6004.669743164168, 6016.729247183887, 6021.939780602225, 5593.972030139823, 5622.297212848394, 5625.240592520121, 5778.219940308005, 5783.595148339744, 5858.882822343615, 5917.260342457193, 5927.851803704942, 5952.791652292149, 6020.90968635462, 5651.0, 5661.547076233974, 5664.85837854057, 5665.3201615806365, 5667.234923285304, 5446.942597528856, 5743.10981797822, 5744.540436764965, 5744.597878148489, 5751.194832723339, 5436.864078398072, 5497.0, 5501.944980550144, 5507.504324610644, 5510.0, 5422.6475279106735, 5486.780528778964, 5493.862653433696, 5495.148252020943, 5514.751836167302, 5491.039068162976, 5496.285482887199, 5510.0, 5511.063119269654, 5513.228148059355, 5586.581006424616, 5617.887642247214, 5617.943820561742, 5620.269364982526, 5627.155926611041, 5450.618456707993, 5466.4260252674485, 5476.205950137128, 5477.397486276586, 5480.314960629921], "value": 5258.351822423149, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.7264258441116, 617.080549980529, 630.6153246519622, 649.4155260265763, 651.9348065193482, 31327.060188194362, 41943.79028104859, 43351.78324108375, 43407.56592434075, 46869.76565117178, 44395.556044439545, 44829.327560086625, 44845.10309793802, 44862.1027579449, 44895.55104448955, 8673.089325620813, 8850.73447796567, 8863.069377715312, 8864.689735859247, 8868.0, 8017.118117007125, 8210.220029097227, 10404.843927341097, 10655.84016239757, 10662.0, 10744.838827417596, 10800.837987430195, 10807.189460790432, 10821.945890270537, 10828.24202305835, 10477.214208934322, 10528.789424211473, 10538.841917371246, 10542.47287635615, 10547.84178237327, 10562.207834412373, 10649.893501065046, 10653.414062226575, 10654.520546575346, 10664.200184986157, 40900.79549602263, 41031.79484102561, 41186.1762764746, 41217.793911030254, 41236.0, 3057.9235519111976, 3168.984155079233, 3326.0354497196026, 3457.4468085106264, 3642.7085833133287, 30429.087127386214, 30611.846940765376, 30917.690823091933, 30998.225044373845, 31094.0, 4238.258304796648, 4283.593058659422, 4313.978430107861, 4557.179707652621, 4570.040291538781, 314924.99999999773, 319672.0, 320451.0, 320918.0, 321925.0, 56698.43301566932, 57262.14106788402, 57272.0, 57291.71354143286, 57352.0, 60723.69638151781, 60738.392616074154, 60792.39207607956, 60812.39187608156, 60877.0, 14893.77659335111, 15046.172460514557, 15064.472743454146, 15078.24608769579, 15093.39626414931, 10836.078933290759, 11209.21535492524, 11517.942410287895, 11584.0, 11600.709982250512, 19488.51278718015, 19629.92035438036, 19715.0, 20227.797722022886, 20512.282070127472, 6985.476089293222, 7116.893246601305, 7127.643617819088, 7193.201699575106, 7311.232320606367, 927.8793756811572, 1042.6819819954987, 1075.8655168103987, 1078.5200585739271, 1086.0768346905068, 31337.045961267286, 31498.212544686565, 31716.841415793235, 32031.679683203336, 32169.51745723816, 1048.2819268800895, 1049.192122066005, 1049.3127001813825, 1084.717973326925, 1148.735790768128, 15546.300416481285, 16496.0, 16528.25622846975, 16537.338506459848, 16763.413280535366, 510745.0, 516370.0, 517926.0, 519614.0, 521399.0, 50518.494815052116, 50857.49142508602, 50915.0, 50918.23622645663, 51048.0, 1184.6120096523935, 1211.3458732284644, 1279.6928737103215, 1297.7145028093805, 1346.077936613423, 28109.437811243253, 32033.0, 32315.676843231267, 32372.676273236964, 32468.35063298768, 49084.263736044704, 49807.501924980286, 49814.25278620751, 49833.25250121324, 49837.75081124716, 372283.0, 373113.0, 374531.0, 375580.0, 375610.0, 26720.866395667897, 27564.31089222705, 27907.302317442227, 29373.55939660864, 42319.3652095225, 45088.54911450975, 45150.54849451595, 45297.320540191264, 45399.77300113478, 46786.532134678215, 37980.24039519249, 38316.425253621775, 38334.0, 38799.22401552009, 38974.22051558896, 37776.62223377731, 38010.0, 38170.809145954096, 38892.0, 39586.0, 37696.41342844404, 38528.80735596304, 38951.415728763524, 39318.0, 39454.40818387784, 31857.522137168424, 33843.830780845936, 34056.65943340535, 34590.13524661904, 35141.64858351384, 25734.49077292845, 26066.86966565155, 26483.73516264813, 26583.867080664473, 26944.461110778066], "value": 19810.938153458705, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.184650459718, 378.60814057450546, 392.4701652768762, 392.7231301932137, 415.60932723240154, 14100.08075023408, 16025.439109631165, 18818.623627527442, 19400.708989365154, 19466.1240244189, 18360.908195459037, 18386.908065459687, 18452.169652365643, 18666.06669666518, 18672.90663546684, 4085.5097388313443, 5463.644863083907, 5661.179129026309, 5700.942990570083, 5708.571857110713, 4216.051388437608, 6123.755049798003, 6352.301246862841, 6410.038494225857, 6510.93489065108, 6273.654948977804, 6439.388258115471, 6492.545521813475, 6518.380753828403, 6538.836529086763, 6434.80695579131, 6456.128422662974, 6473.74105035798, 6475.158229430168, 6480.546361754679, 4990.151674215392, 5218.373795144569, 5222.660527065728, 5261.1319132343115, 5293.285406470154, 13610.86389136106, 13737.931310343485, 13755.0, 13866.306684665726, 13944.16335019902, 1934.6807776716967, 2236.7651396603446, 2245.348848833836, 2547.46503234321, 2612.2946804362905, 9417.105374989365, 9951.90048099517, 10219.0, 10582.047615714622, 13230.27233502157, 1666.5417010322258, 1693.4327000454862, 1717.381742572673, 1720.053970316321, 1838.7241913712917, 72598.0, 76592.0, 77994.22005779926, 78876.0, 80396.19603804004, 10496.68509944703, 10544.57821687124, 10836.620718274822, 10861.83707244392, 10999.395033273247, 15168.165750883807, 15184.088954662755, 15188.46840360582, 15226.162561059247, 15258.618534536503, 7476.214997425301, 7550.735724249625, 7635.389168866477, 7704.8844267336035, 7752.332402166313, 7067.116610423697, 7144.571325720473, 7168.17565979919, 7332.96333518329, 7336.96331518339, 4562.771861406916, 4564.6348292136545, 4634.304854271819, 4678.415198100238, 4722.220833562493, 1903.666858299792, 1906.895120768371, 1950.0, 1963.783983761785, 1984.434436185709, 851.2806678356778, 899.9460032398077, 917.6696389299847, 936.7798567336671, 1015.5277795824977, 18489.90755046216, 19479.61040779205, 19656.90171549133, 19748.0, 20076.196952122045, 896.1262768800367, 914.4741773480275, 951.305546950716, 977.4868194198103, 992.3847214726916, 10330.896691032993, 10740.78518429627, 10854.728631784268, 10965.83551246732, 11012.724681883017, 156321.0, 244702.0, 425788.0, 435429.0, 438015.0, 83278.58360708157, 83419.5829020851, 85731.0, 86997.5650121758, 88090.55954720185, 987.8271302522173, 991.3209451525728, 1024.9743756406149, 1044.5143008501084, 1050.9737256568646, 15231.619209519851, 15925.124118173148, 16006.359745610045, 16236.18819059066, 16827.0, 41941.79029104957, 42743.0, 43337.13325733405, 43476.78261608672, 43874.12251754883, 57875.42124578869, 58226.12660810176, 58673.413265868505, 58823.70588147032, 58932.410675892694, 5788.855278618068, 8420.621072051896, 8572.385422446214, 8572.785680358042, 8825.205731484197, 11341.376224307742, 13070.477180912658, 13378.866211337761, 13517.459301628218, 13524.256165910969, 11118.555257789598, 11313.490892910004, 11313.604023859125, 11793.587224447103, 12025.518979241082, 11040.337579744919, 11100.777984440427, 11177.88822111801, 11272.774544509228, 11275.097992160443, 11194.832077519006, 11440.828387574027, 11724.296542207494, 11738.823917641072, 11767.176297659082, 8354.749357519284, 8649.783755406164, 8711.085336039625, 8718.041015488165, 8956.104389560991, 9832.55753491109, 11404.657860264206, 11594.188406811441, 11771.587994420153, 11841.526338946345], "value": 8815.56144301731, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1287.5236162619833, 1425.481861817165, 1447.51508244738, 1544.1815837606073, 1716.8969861808284, 7234.1319041715005, 7863.646135923883, 8143.226393492616, 8152.347812175011, 8411.074781774, 8257.25684688378, 8326.875096873551, 8332.958335208315, 8377.664893404257, 8384.287335576468, 2257.9661305080435, 2285.131649973008, 2288.9084436622516, 2289.3132060381904, 2293.977060229393, 2254.346239590525, 2309.58427483053, 2313.1903833658253, 2315.6063469210276, 2319.072371051576, 2210.613142700029, 2228.1198926424054, 2247.494313779403, 2291.129370839079, 2297.8506397084134, 2171.7936796004356, 2181.7818218178213, 2187.387531491177, 2197.3298144065975, 2197.9450513737124, 2207.834412419059, 2233.1625640384855, 2237.8992945317336, 2238.3173132194675, 2240.451089483087, 8193.79515512111, 8287.834243315161, 8347.248747612683, 8378.706745263886, 8508.064112947572, 5007.974960125176, 5113.309703190059, 5122.462141475166, 5123.820666276662, 5136.998285334361, 3349.464085746293, 3441.1569165554347, 3486.4944583035317, 3495.16116132129, 3496.2657841853243, 1096.3915027159924, 1096.6216655253925, 1152.8097863852454, 1197.461142485885, 1214.7266864955402, 11420.14348923834, 11455.713607159805, 11505.654830355103, 11506.654800356002, 11522.884771152349, 4094.5086589609436, 4383.298672212431, 4387.517373089022, 4447.666425018137, 4494.910101797946, 9084.591193396313, 9090.181883630372, 9091.81816363669, 9095.31785116119, 9096.272298216127, 5170.767315470813, 5205.687658740488, 5207.531322181022, 5213.113770658997, 5215.374155101336, 4202.424090965887, 4369.300911854088, 4514.571115743999, 4611.262198048296, 4855.077535268288, 3513.543239378864, 3600.6939410149907, 3661.176235347026, 3672.594450634785, 3685.0, 1089.596849165798, 1092.6285063078592, 1098.9175811814146, 1108.196557495809, 1122.5060973171778, 841.1672444280241, 849.3841964575633, 865.3207232322596, 916.5371487398821, 918.150710592699, 5550.306211723535, 5583.553315734732, 5609.27079479665, 5748.252727145445, 5838.9124163137585, 868.6959564152496, 877.7454538183982, 897.4839467306325, 915.6017132547363, 930.6361840924112, 3478.2867429370385, 3556.28874225156, 3578.9284214315567, 3647.9817600911824, 3671.1005803578296, 10460.895391046144, 10839.187060970458, 10841.403722795165, 10846.349219046882, 10881.075108615856, 10692.679219623424, 10774.73063173427, 10817.0, 10831.0, 10841.945790270998, 7351.191368949411, 7676.155622881479, 8074.959625201836, 8245.464044837066, 8251.876221856677, 5302.098643230583, 5374.57003439716, 5378.408375078817, 5524.309461317335, 5622.465865742748, 9376.578053987723, 9392.154706076486, 9435.24518038569, 9484.099010593982, 9797.951010244904, 9212.216961558343, 9528.52357382142, 9576.712698619052, 9674.08096230857, 9844.0, 6711.3288671132495, 6948.895766563404, 6952.860942781015, 7207.315305046012, 7323.304286092813, 7622.771316860503, 7687.577183254751, 7693.230676932262, 7922.445428820158, 7925.167857374892, 7024.648767561704, 7151.60666163366, 7177.928220717726, 7186.748463803742, 7264.963675181591, 7011.0, 7023.15948032388, 7075.327843854826, 7198.7840364789145, 7253.238409966877, 6259.812205633838, 6421.229452465734, 6446.871062578816, 6449.3873082057125, 6453.128827608213, 4857.0, 4930.161872481615, 4964.180910149785, 4980.377452818398, 5033.572146367454, 4722.244440889442, 4762.59517940965, 4885.853424397274, 4899.314096026488, 5035.823746168867], "value": 4385.220681739819, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.3891960952628, 334.6352475801376, 334.71381968417, 338.15967321206796, 345.0562710985456, 5086.237064440326, 5184.0, 5207.921881171786, 5322.201669749539, 5337.5196232339085, 5103.515166059227, 5192.896142077157, 5219.765110570024, 5222.686638801674, 5227.3465816772905, 4144.440500532435, 4158.896027599304, 4165.0, 4168.958310416902, 4172.833086676529, 4005.8597949071786, 4129.256733787917, 4165.229432554972, 4171.311733563958, 4184.769837658928, 4073.450084238634, 4082.2447847148374, 4087.384074192519, 4089.161721847014, 4104.610062044101, 4073.124278280184, 4085.3259212229946, 4095.2219078375015, 4098.774567398792, 4101.794910254505, 3635.581908080578, 3637.744977982592, 3647.9270414591824, 3648.708103351752, 3649.908752281214, 4951.62862785289, 5083.364579427572, 5110.463401342842, 5113.465960211922, 5123.513266239701, 4663.743494107823, 4677.906441871178, 4678.578927896506, 4680.782996420955, 4696.178168820477, 5443.618946673734, 5456.345238571357, 5497.8075767348355, 5499.340079190522, 5507.449255074461, 3759.154190307186, 3930.272899513599, 3956.5252169739815, 3960.128771670228, 3962.643362097396, 5671.015144699363, 5691.345495268097, 5702.942970570282, 5704.828855134353, 5714.257146570961, 4064.288749468831, 4065.329220678555, 4065.654419374386, 4075.021994721305, 4075.9796201018803, 3854.1286741377294, 4031.274370613259, 4061.1065565575527, 4088.9182216355507, 4127.318992366286, 4643.0, 4648.372469716613, 4656.0, 4657.650676199299, 4659.324397962344, 5508.779648814003, 5519.917201241985, 5524.502794748492, 5527.231285988445, 5536.0, 1305.3799445263423, 1321.4053675845907, 1397.6791931624516, 1399.132537826554, 1411.7670584353466, 877.5085951866974, 895.8477058899872, 905.9501727404925, 910.5976795734626, 913.8674892140602, 4641.698289611165, 4663.976680116578, 4671.0, 4688.390509233778, 4688.789004494806, 4790.592799612072, 4842.498825364149, 4952.830188679248, 4960.727160006162, 4966.354373931438, 4599.2871104978785, 4635.284944570463, 4644.629834198852, 4693.81224751013, 4698.600618947427, 2823.3929705113087, 3017.5624534442823, 3026.6077604301827, 3034.9544756828664, 3035.195673146618, 5828.6794226317115, 5834.912476312858, 5850.473457388855, 5853.88292234153, 5881.5882888198275, 5554.0, 5716.914246286309, 5741.282339707536, 5833.979053665592, 5836.416358364129, 5799.187394113936, 5799.999000344958, 5803.084981955944, 5807.477327040587, 5810.099434587646, 5617.314805558398, 5621.634593751393, 5636.492715655447, 5659.490645841894, 5671.262735844314, 5419.509634850448, 5673.375928647928, 5691.7438715257085, 5697.57268204878, 5699.658020518782, 5704.172894930295, 5787.826365209051, 5790.536757059341, 5832.708364581669, 5852.853678658068, 3956.1296514766705, 3970.900727481836, 4037.5558688543647, 4047.0, 4061.1268577256033, 5469.480399362054, 5640.492355688008, 5699.316082070178, 5712.485876271156, 5725.312962444534, 5405.486478784509, 5426.585169599491, 5512.50387465114, 5524.972375138099, 5557.972210138923, 5505.311836020497, 5508.531774799187, 5536.7231638417115, 5548.472895074961, 5574.247476590608, 5338.893222135458, 5487.259220005249, 5495.148252020943, 5541.916871246854, 5557.916631250454, 5531.7234138292115, 5540.085885828954, 5567.524605979338, 5572.4706152915405, 5596.524295434933, 5434.10337294342, 5461.699606521679, 5464.147775818118, 5467.343918729619, 5471.9179212311055], "value": 4157.350400202213, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.5384576952864, 632.4118569730152, 645.6900687669921, 687.3298533929419, 689.9753865509718, 12240.632781016573, 12935.353232338393, 12941.288229147392, 12948.48206071756, 12955.676108097303, 11258.0, 11272.0, 11273.549058037668, 11287.209895307331, 11292.096632269418, 637.6907200007993, 655.4854439265177, 661.2230629010917, 777.9222077792218, 795.08168065884, 652.9118568993173, 654.5581732330681, 750.7034721285116, 783.2559068884553, 785.721069020498, 836.9288610468118, 837.7026155714725, 839.0686338164633, 839.4166054592062, 843.6583183810567, 834.9958250208771, 836.1178956201205, 836.1387770596295, 836.297510091523, 836.3267569606464, 496.84101087651965, 506.5137468030695, 588.7144734803617, 607.3865395950078, 617.4874853871275, 12294.692632684166, 12315.4458049388, 12323.383830808514, 12323.69190770229, 12407.255564666058, 11201.551937922473, 11408.657740267805, 11584.2470239435, 11745.765084698258, 12029.39853007355, 10815.621453249178, 10944.288621239593, 11006.449677516091, 11023.44882755859, 11524.827127593093, 4088.5707000764787, 4181.770002649853, 4226.619604235603, 4355.194289056535, 4363.934540981888, 56542.43457565413, 59259.99999999957, 59409.0, 63172.36827631665, 64258.0, 8605.409285308302, 9006.909930900607, 9304.488253146143, 9525.809483810284, 9550.665726699672, 17143.314267429414, 17289.65420691579, 17326.480205593853, 17327.91336043312, 17340.91329543344, 6537.738490460329, 6699.899501507482, 6761.323867613298, 6995.335443132894, 7017.508784381471, 4173.853915112956, 4174.269502836992, 4183.623473887304, 4294.57054294568, 4301.096769678403, 3172.952405713916, 3208.1498402923244, 3214.8392580370887, 3262.8205448700073, 3271.705546500779, 577.4543056811273, 590.6485641043572, 605.4097255176168, 608.8538750699801, 616.9136320915076, 598.6019297167335, 610.4585920550645, 665.9245318810086, 666.1939053744926, 674.4907594765921, 8537.74386768398, 8623.698170564001, 8878.822423551623, 9045.864312035324, 9054.86417703735, 625.8185126313409, 643.810076027573, 695.2282965907838, 726.4333819620705, 754.4417131322782, 4133.8966525836495, 4142.813573389205, 4236.152769446061, 4236.9364459533135, 4265.53079161292, 48614.756926215145, 61294.69352653208, 71340.2865971344, 79896.0, 84599.0, 27777.166684999484, 27891.860540697166, 51984.0, 67402.98895516571, 67577.3242267581, 63988.36011639824, 64422.67788661121, 66016.66991665203, 67120.6643966777, 67348.0, 8561.743147705578, 8789.692360767342, 8886.911130888608, 8990.280777537911, 9217.124373184537, 32352.83823580867, 33945.49081763825, 35825.46261806023, 43037.56962430335, 45441.318380224984, 56184.719076404355, 61472.38527614845, 62089.37910620836, 63036.0, 64829.67585162044, 11194.496247669038, 11310.547578097114, 11533.769324613293, 11587.304761714324, 12024.75950480968, 11611.0, 11623.12826537996, 11701.180917335705, 11977.0, 12422.440990155284, 10512.31669941482, 11046.889531104585, 11052.060574850906, 11097.38964356968, 11440.885591143982, 10781.9460902695, 11080.94181068659, 11270.380129092979, 11418.143639226924, 11424.257423267461, 10546.57813687444, 10645.254832161674, 10676.946615267185, 10952.568834373204, 11424.48589813477, 8792.560371981503, 8985.685501007434, 9175.31185161129, 9640.42157470554, 9981.950090249502, 8496.235338819535, 8814.647414103363, 9819.950900245452, 9914.553845077133, 9940.552675129491], "value": 6359.351722799194, "unit": "score"}], "name": "dromaeo_css", "value": 6884.601001257464, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 110.0, 112.0, 111.0, 111.0, 111.0, 110.0, 110.0, 111.0, 110.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 126.0, 125.0, 160.0, 129.0, 129.0, 129.0, 121.0, 158.0, 123.0], "value": 135.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 162.0, 160.0, 160.0, 164.0, 159.0, 161.0, 161.0, 161.0, 162.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 111.0, 77.0, 75.0, 76.0, 75.0, 103.0, 75.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 128.0, 83.0, 84.0, 82.0, 109.0, 82.0, 82.0, 118.0], "value": 93.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 145.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 85.0, 84.0, 84.0, 85.0, 84.0, 84.0, 85.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 55.0, 56.0, 55.0, 57.0, 56.0, 57.0, 56.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 63.0, 62.0, 63.0, 62.0, 62.0, 63.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 80.0, 80.0, 80.0, 81.0, 80.0, 79.0, 80.0, 88.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 129.0, 133.0, 130.0, 135.0, 135.0, 131.0, 134.0, 178.0, 131.0], "value": 137.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 171.0, 165.0, 166.0, 165.0, 166.0, 165.0, 164.0, 163.0, 167.0], "value": 166.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 67.0, 64.0, 66.0, 66.0, 66.0, 66.0, 65.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1497.6000000000004, "alertThreshold": 2.0}]} 22:50:25 INFO - Return code: 0 22:50:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:50:25 INFO - # TBPL SUCCESS # 22:50:25 INFO - Running post-action listener: _resource_record_post_action 22:50:25 INFO - [mozharness: 2016-10-28 05:50:25.390733Z] Finished run-tests step (success) 22:50:25 INFO - Running post-run listener: _resource_record_post_run 22:50:25 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 391118848; Read time: 0; Write time: 308092 22:50:25 INFO - TinderboxPrint: CPU usage
13.1% 22:50:25 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 22:50:25 INFO - TinderboxPrint: I/O write bytes / time
391,118,848 / 308,092 22:50:25 INFO - TinderboxPrint: CPU idle
8,314.9 (86.9%) 22:50:25 INFO - TinderboxPrint: CPU user
1,199.3 (12.5%) 22:50:25 INFO - TinderboxPrint: Swap in / out
0 / 0 22:50:25 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 102817792; Read time: 0; Write time: 85092 22:50:25 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 287789056; Read time: 0; Write time: 222932 22:50:26 INFO - Running post-run listener: _upload_blobber_files 22:50:26 INFO - Blob upload gear active. 22:50:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:50:26 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 22:50:26 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'] 22:50:26 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 22:50:26 INFO - (blobuploader) - INFO - Open directory for files ... 22:50:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:50:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:50:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:50:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:50:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:50:27 INFO - (blobuploader) - INFO - Done attempting. 22:50:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:50:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:50:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:50:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:50:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:50:27 INFO - (blobuploader) - INFO - Done attempting. 22:50:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:50:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:50:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:50:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:50:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:50:30 INFO - (blobuploader) - INFO - Done attempting. 22:50:30 INFO - (blobuploader) - INFO - Iteration through files over. 22:50:30 INFO - Return code: 0 22:50:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:50:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:50:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f297d84453d0626e93e3d4c863ec991be13a4367590156bb9639ec78087fb40d18c7fc19e036b2112b07f8c40317b8e4f20a83e3042f9f86203e24f70747b3e7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be0ce8ae84813038249da6b9651248c2d7a5813da9358d014d4ef479b4dde943fa78dbdf216cbd0f07e9aa0f3be80f07b374ab290b42e9af17280d362bc3852b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df338a24bae657f4edb381bbc67017fee998f51df58d2fd487fc75a4f51e02ad61fce99d5ab2a7ec4f449432c2378387500cbfada65d0679f9722e25cb6e302b"} 22:50:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:50:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:50:30 INFO - Contents: 22:50:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f297d84453d0626e93e3d4c863ec991be13a4367590156bb9639ec78087fb40d18c7fc19e036b2112b07f8c40317b8e4f20a83e3042f9f86203e24f70747b3e7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be0ce8ae84813038249da6b9651248c2d7a5813da9358d014d4ef479b4dde943fa78dbdf216cbd0f07e9aa0f3be80f07b374ab290b42e9af17280d362bc3852b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df338a24bae657f4edb381bbc67017fee998f51df58d2fd487fc75a4f51e02ad61fce99d5ab2a7ec4f449432c2378387500cbfada65d0679f9722e25cb6e302b"} 22:50:30 INFO - Running post-run listener: copy_logs_to_upload_dir 22:50:30 INFO - Copying logs to upload dir... 22:50:30 INFO - mkdir: /builds/slave/test/build/upload/logs 22:50:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.233005 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-27 22:50:30.638514) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-27 22:50:30.641920) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1477632500.574355-767230091 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/f297d84453d0626e93e3d4c863ec991be13a4367590156bb9639ec78087fb40d18c7fc19e036b2112b07f8c40317b8e4f20a83e3042f9f86203e24f70747b3e7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be0ce8ae84813038249da6b9651248c2d7a5813da9358d014d4ef479b4dde943fa78dbdf216cbd0f07e9aa0f3be80f07b374ab290b42e9af17280d362bc3852b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df338a24bae657f4edb381bbc67017fee998f51df58d2fd487fc75a4f51e02ad61fce99d5ab2a7ec4f449432c2378387500cbfada65d0679f9722e25cb6e302b"} build_url:https://queue.taskcluster.net/v1/task/fAlwTkYtRMCI02P5y53a2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011424 build_url: 'https://queue.taskcluster.net/v1/task/fAlwTkYtRMCI02P5y53a2g/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/f297d84453d0626e93e3d4c863ec991be13a4367590156bb9639ec78087fb40d18c7fc19e036b2112b07f8c40317b8e4f20a83e3042f9f86203e24f70747b3e7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be0ce8ae84813038249da6b9651248c2d7a5813da9358d014d4ef479b4dde943fa78dbdf216cbd0f07e9aa0f3be80f07b374ab290b42e9af17280d362bc3852b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df338a24bae657f4edb381bbc67017fee998f51df58d2fd487fc75a4f51e02ad61fce99d5ab2a7ec4f449432c2378387500cbfada65d0679f9722e25cb6e302b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-27 22:50:30.667107) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 22:50:30.667451) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1477632500.574355-767230091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004495 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 22:50:30.751666) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-27 22:50:30.751991) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-27 22:50:30.752366) ========= ========= Total master_lag: 0.17 =========