builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-041 starttime: 1478237210.74 results: success (0) buildid: 20161103193337 builduid: 413f2fc371464edd9974e7ed43a07690 revision: 38fcc30d818f99f3798865d551acce5681b0a3c0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-03 22:26:50.742246) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-03 22:26:50.742851) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-03 22:26:50.743243) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-03 22:26:50.758750) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 22:26:50.759127) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1478237210.352212-1379509001 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-03 22:26:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 211M=0s 2016-11-03 22:26:51 (211 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.167617 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 22:26:50.940808) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 22:26:50.941136) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1478237210.352212-1379509001 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016876 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 22:26:50.991198) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 22:26:50.991574) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 38fcc30d818f99f3798865d551acce5681b0a3c0 --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 38fcc30d818f99f3798865d551acce5681b0a3c0 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1478237210.352212-1379509001 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-03 22:26:51,350 truncating revision to first 12 chars 2016-11-03 22:26:51,350 Setting DEBUG logging. 2016-11-03 22:26:51,350 attempt 1/10 2016-11-03 22:26:51,350 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/38fcc30d818f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-03 22:26:51,873 unpacking tar archive at: mozilla-central-38fcc30d818f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.885362 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 22:26:51.890802) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-03 22:26:51.891193) ========= script_repo_revision: 38fcc30d818f99f3798865d551acce5681b0a3c0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-03 22:26:51.891640) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-03 22:26:51.891907) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-03 22:26:51.902270) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-11-03 22:26:51.902541) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=8c6b6742ce8f6f39ef4ce27d000001f1-1478237210.352212-1379509001 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:26:52 INFO - MultiFileLogger online at 20161103 22:26:52 in /builds/slave/test 22:26:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 22:26:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:26:52 INFO - {'append_to_log': False, 22:26:52 INFO - 'base_work_dir': '/builds/slave/test', 22:26:52 INFO - 'blob_upload_branch': 'Firefox', 22:26:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:26:52 INFO - 'branch': 'Firefox', 22:26:52 INFO - 'buildbot_json_path': 'buildprops.json', 22:26:52 INFO - 'config_files': ('talos/linux_config.py',), 22:26:52 INFO - 'default_actions': ('clobber', 22:26:52 INFO - 'read-buildbot-config', 22:26:52 INFO - 'download-and-extract', 22:26:52 INFO - 'populate-webroot', 22:26:52 INFO - 'create-virtualenv', 22:26:52 INFO - 'install', 22:26:52 INFO - 'run-tests'), 22:26:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:26:52 INFO - 'download_minidump_stackwalk': True, 22:26:52 INFO - 'download_symbols': 'ondemand', 22:26:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:26:52 INFO - 'tooltool.py': '/tools/tooltool.py', 22:26:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:26:52 INFO - '/tools/misc-python/virtualenv.py')}, 22:26:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:26:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:26:52 INFO - 'installer_path': 'installer.exe', 22:26:52 INFO - 'log_level': 'info', 22:26:52 INFO - 'log_name': 'talos', 22:26:52 INFO - 'log_to_console': True, 22:26:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:26:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:26:52 INFO - 'opt_config_files': (), 22:26:52 INFO - 'pip_index': False, 22:26:52 INFO - 'sps_profile': False, 22:26:52 INFO - 'sps_profile_interval': 0, 22:26:52 INFO - 'suite': 'dromaeojs-e10s', 22:26:52 INFO - 'system_bits': '32', 22:26:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:26:52 INFO - 'title': 'talos-linux64-ix-041', 22:26:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:26:52 INFO - 'use_talos_json': True, 22:26:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:26:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:26:52 INFO - 'work_dir': 'build'} 22:26:52 INFO - [mozharness: 2016-11-04 05:26:52.361212Z] Running clobber step. 22:26:52 INFO - Running pre-action listener: _resource_record_pre_action 22:26:52 INFO - Running main action method: clobber 22:26:52 INFO - rmtree: /builds/slave/test/build 22:26:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:26:52 INFO - Running post-action listener: _resource_record_post_action 22:26:52 INFO - [mozharness: 2016-11-04 05:26:52.822936Z] Finished clobber step (success) 22:26:52 INFO - [mozharness: 2016-11-04 05:26:52.823035Z] Running read-buildbot-config step. 22:26:52 INFO - Running pre-action listener: _resource_record_pre_action 22:26:52 INFO - Running main action method: read_buildbot_config 22:26:52 INFO - Using buildbot properties: 22:26:52 INFO - { 22:26:52 INFO - "project": "", 22:26:52 INFO - "product": "firefox", 22:26:52 INFO - "script_repo_revision": "production", 22:26:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 22:26:52 INFO - "repository": "", 22:26:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 22:26:52 INFO - "buildid": "20161103193337", 22:26:52 INFO - "pgo_build": "True", 22:26:52 INFO - "basedir": "/builds/slave/test", 22:26:52 INFO - "buildnumber": 156, 22:26:52 INFO - "slavename": "talos-linux64-ix-041", 22:26:52 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:26:52 INFO - "platform": "ubuntu64_hw", 22:26:52 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 22:26:52 INFO - "branch": "mozilla-central", 22:26:52 INFO - "repo_path": "mozilla-central", 22:26:52 INFO - "revision": "38fcc30d818f99f3798865d551acce5681b0a3c0", 22:26:52 INFO - "stage_platform": "linux64-pgo", 22:26:52 INFO - "builduid": "413f2fc371464edd9974e7ed43a07690", 22:26:52 INFO - "slavebuilddir": "test" 22:26:52 INFO - } 22:26:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/cYOYjmA-S368aTKo2xKKNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 22:26:52 INFO - Running post-action listener: _resource_record_post_action 22:26:52 INFO - [mozharness: 2016-11-04 05:26:52.825459Z] Finished read-buildbot-config step (success) 22:26:52 INFO - [mozharness: 2016-11-04 05:26:52.825547Z] Running download-and-extract step. 22:26:52 INFO - Running pre-action listener: _resource_record_pre_action 22:26:52 INFO - Running main action method: download_and_extract 22:26:52 INFO - mkdir: /builds/slave/test/build/tests 22:26:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:26:52 INFO - trying https://queue.taskcluster.net/v1/task/cYOYjmA-S368aTKo2xKKNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:26:52 INFO - Downloading https://queue.taskcluster.net/v1/task/cYOYjmA-S368aTKo2xKKNg/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:26:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cYOYjmA-S368aTKo2xKKNg/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:26:53 INFO - Downloaded 1361 bytes. 22:26:53 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:26:53 INFO - Using the following test package requirements: 22:26:53 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 22:26:53 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:26:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:26:53 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:26:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:26:53 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:26:53 INFO - u'jsshell-linux-x86_64.zip'], 22:26:53 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:26:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:26:53 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 22:26:53 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:26:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:26:53 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:26:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:26:53 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:26:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:26:53 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:26:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:26:53 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:26:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cYOYjmA-S368aTKo2xKKNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 22:26:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cYOYjmA-S368aTKo2xKKNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:26:53 INFO - Fetch https://queue.taskcluster.net/v1/task/cYOYjmA-S368aTKo2xKKNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:26:53 INFO - Http code: 200 22:26:53 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 22:26:53 INFO - x-amz-cf-id: --7GHFBWwSQtpnCaE_wBY6ieLkCt-VKHp8tojgGVkM1N82o4cEKlxw== 22:26:53 INFO - x-amz-version-id: mOEiEQl7Y1ZO9NbFNAiB2pg6kbfmFuZh 22:26:54 INFO - Expected file size: 22003039 22:26:54 INFO - Obtained file size: 22003039 22:26:58 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:26:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cYOYjmA-S368aTKo2xKKNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 22:26:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cYOYjmA-S368aTKo2xKKNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:26:58 INFO - Fetch https://queue.taskcluster.net/v1/task/cYOYjmA-S368aTKo2xKKNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:26:58 INFO - Http code: 200 22:26:58 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 22:26:58 INFO - x-amz-cf-id: 4pAEkZ5uaht7hARpL3b0hPZnTGQgNfG232yEru4pKu3TgscaWBNKaw== 22:26:58 INFO - x-amz-version-id: mOEiEQl7Y1ZO9NbFNAiB2pg6kbfmFuZh 22:26:59 INFO - Expected file size: 22003039 22:26:59 INFO - Obtained file size: 22003039 22:27:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cYOYjmA-S368aTKo2xKKNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 22:27:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cYOYjmA-S368aTKo2xKKNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:27:03 INFO - Fetch https://queue.taskcluster.net/v1/task/cYOYjmA-S368aTKo2xKKNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 22:27:04 INFO - Http code: 200 22:27:04 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 22:27:04 INFO - x-amz-cf-id: BtHNgHpNZ8MiRmD_U7sZEBEHo4a8Bb52l-wNym_ESWPtuYKTvpZ9Xw== 22:27:04 INFO - x-amz-version-id: D89ziDfhgMAGlUQqBBWrk_lqoQT0Ep1b 22:27:04 INFO - Expected file size: 14409038 22:27:04 INFO - Obtained file size: 14409038 22:27:04 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:27:04 INFO - trying https://queue.taskcluster.net/v1/task/cYOYjmA-S368aTKo2xKKNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:27:04 INFO - Downloading https://queue.taskcluster.net/v1/task/cYOYjmA-S368aTKo2xKKNg/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:27:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cYOYjmA-S368aTKo2xKKNg/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:27:05 INFO - Downloaded 59622114 bytes. 22:27:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cYOYjmA-S368aTKo2xKKNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:27:05 INFO - mkdir: /builds/slave/test/properties 22:27:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:27:05 INFO - Writing to file /builds/slave/test/properties/build_url 22:27:05 INFO - Contents: 22:27:05 INFO - build_url:https://queue.taskcluster.net/v1/task/cYOYjmA-S368aTKo2xKKNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:27:06 INFO - Running post-action listener: _resource_record_post_action 22:27:06 INFO - Running post-action listener: set_extra_try_arguments 22:27:06 INFO - [mozharness: 2016-11-04 05:27:06.365663Z] Finished download-and-extract step (success) 22:27:06 INFO - [mozharness: 2016-11-04 05:27:06.365890Z] Running populate-webroot step. 22:27:06 INFO - Running pre-action listener: _resource_record_pre_action 22:27:06 INFO - Running main action method: populate_webroot 22:27:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:27:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:27:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:27:06 INFO - '--tppagecycles', 22:27:06 INFO - '7'], 22:27:06 INFO - 'tests': ['tsvgm']}}, 22:27:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:27:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:27:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:27:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:27:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:27:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:27:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:06 INFO - 'talos_options': ['--disable-e10s'], 22:27:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:27:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:27:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:06 INFO - 'talos_options': ['--disable-e10s'], 22:27:06 INFO - 'tests': ['damp', 'tps']}, 22:27:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:06 INFO - 'tests': ['damp', 'tps']}, 22:27:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:27:06 INFO - 'tests': ['dromaeo_dom']}, 22:27:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:27:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:27:06 INFO - 'tests': ['basic_compositor_video']}, 22:27:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:27:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:27:06 INFO - 'tests': ['a11yr', 22:27:06 INFO - 'ts_paint', 22:27:06 INFO - 'tpaint', 22:27:06 INFO - 'sessionrestore', 22:27:06 INFO - 'sessionrestore_no_auto_restore', 22:27:06 INFO - 'tabpaint']}, 22:27:06 INFO - 'other-e10s': {'tests': ['a11yr', 22:27:06 INFO - 'ts_paint', 22:27:06 INFO - 'tpaint', 22:27:06 INFO - 'sessionrestore', 22:27:06 INFO - 'sessionrestore_no_auto_restore', 22:27:06 INFO - 'tabpaint']}, 22:27:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:27:06 INFO - 'ts_paint', 22:27:06 INFO - 'tpaint', 22:27:06 INFO - 'sessionrestore', 22:27:06 INFO - 'sessionrestore_no_auto_restore', 22:27:06 INFO - 'tabpaint']}, 22:27:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:27:06 INFO - 'ts_paint', 22:27:06 INFO - 'tpaint', 22:27:06 INFO - 'sessionrestore', 22:27:06 INFO - 'sessionrestore_no_auto_restore', 22:27:06 INFO - 'tabpaint']}, 22:27:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:27:06 INFO - 'tests': ['a11yr', 22:27:06 INFO - 'ts_paint', 22:27:06 INFO - 'tpaint', 22:27:06 INFO - 'sessionrestore', 22:27:06 INFO - 'sessionrestore_no_auto_restore', 22:27:06 INFO - 'tabpaint']}, 22:27:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:27:06 INFO - 'tests': ['a11yr', 22:27:06 INFO - 'ts_paint', 22:27:06 INFO - 'tpaint', 22:27:06 INFO - 'sessionrestore', 22:27:06 INFO - 'sessionrestore_no_auto_restore', 22:27:06 INFO - 'tabpaint']}, 22:27:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:27:06 INFO - 'tests': ['tsvgx', 22:27:06 INFO - 'tsvgr_opacity', 22:27:06 INFO - 'tart', 22:27:06 INFO - 'tscrollx', 22:27:06 INFO - 'cart']}, 22:27:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:27:06 INFO - 'tsvgr_opacity', 22:27:06 INFO - 'tart', 22:27:06 INFO - 'tscrollx', 22:27:06 INFO - 'cart']}, 22:27:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:06 INFO - 'talos_options': ['--disable-e10s'], 22:27:06 INFO - 'tests': ['tp5o']}, 22:27:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:06 INFO - 'tests': ['tp5o']}, 22:27:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:06 INFO - 'talos_options': ['--disable-e10s', 22:27:06 INFO - '--xperf_path', 22:27:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:27:06 INFO - 'tests': ['tp5n']}, 22:27:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:06 INFO - 'talos_options': ['--xperf_path', 22:27:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:27:06 INFO - 'tests': ['tp5n']}}, 22:27:06 INFO - 'talos.zip': {'path': '', 22:27:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:27:06 INFO - Running post-action listener: _resource_record_post_action 22:27:06 INFO - [mozharness: 2016-11-04 05:27:06.383832Z] Finished populate-webroot step (success) 22:27:06 INFO - [mozharness: 2016-11-04 05:27:06.383919Z] Running create-virtualenv step. 22:27:06 INFO - Running pre-action listener: _resource_record_pre_action 22:27:06 INFO - Running main action method: create_virtualenv 22:27:06 INFO - Creating virtualenv /builds/slave/test/build/venv 22:27:06 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:27:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:27:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:27:06 INFO - Using real prefix '/usr' 22:27:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:27:06 INFO - Installing distribute.............................................................................................................................................................................................done. 22:27:08 INFO - Installing pip.................done. 22:27:08 INFO - Return code: 0 22:27:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:27:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:27:09 INFO - Reading from file tmpfile_stdout 22:27:09 INFO - Output received: 22:27:09 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:27:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:27: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:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27: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:27:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5d0d977f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230b930>, '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 0x230c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230ccc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1478237210.352212-1379509001', '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:27: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', 'pip>=1.5'] in /builds/slave/test/build 22:27: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 pip>=1.5 22:27:09 INFO - Using env: {'DISPLAY': ':0', 22:27:09 INFO - 'HOME': '/home/cltbld', 22:27:09 INFO - 'LANG': 'en_US.UTF-8', 22:27:09 INFO - 'LANGUAGE': 'en_US:en', 22:27:09 INFO - 'LOGNAME': 'cltbld', 22:27:09 INFO - 'MAIL': '/var/mail/cltbld', 22:27:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:09 INFO - 'MOZ_NO_REMOTE': '1', 22:27:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:09 INFO - 'NO_EM_RESTART': '1', 22:27:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:09 INFO - 'PWD': '/builds/slave/test', 22:27:09 INFO - 'SHELL': '/bin/bash', 22:27:09 INFO - 'SHLVL': '1', 22:27:09 INFO - 'TERM': 'linux', 22:27:09 INFO - 'TMOUT': '86400', 22:27:09 INFO - 'USER': 'cltbld', 22:27:09 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1478237210.352212-1379509001', 22:27:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:09 INFO - '_': '/tools/buildbot/bin/python'} 22:27:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:09 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:27:09 INFO - Cleaning up... 22:27:09 INFO - Return code: 0 22:27:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:27: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:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27: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:27:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27: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', '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 0x7f5d0d977f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230b930>, '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 0x230c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230ccc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1478237210.352212-1379509001', '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:27: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', 'psutil>=3.1.1'] in /builds/slave/test/build 22:27: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 psutil>=3.1.1 22:27:09 INFO - Using env: {'DISPLAY': ':0', 22:27:09 INFO - 'HOME': '/home/cltbld', 22:27:09 INFO - 'LANG': 'en_US.UTF-8', 22:27:09 INFO - 'LANGUAGE': 'en_US:en', 22:27:09 INFO - 'LOGNAME': 'cltbld', 22:27:09 INFO - 'MAIL': '/var/mail/cltbld', 22:27:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:09 INFO - 'MOZ_NO_REMOTE': '1', 22:27:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:09 INFO - 'NO_EM_RESTART': '1', 22:27:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:09 INFO - 'PWD': '/builds/slave/test', 22:27:09 INFO - 'SHELL': '/bin/bash', 22:27:09 INFO - 'SHLVL': '1', 22:27:09 INFO - 'TERM': 'linux', 22:27:09 INFO - 'TMOUT': '86400', 22:27:09 INFO - 'USER': 'cltbld', 22:27:09 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1478237210.352212-1379509001', 22:27:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:09 INFO - '_': '/tools/buildbot/bin/python'} 22:27:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:09 INFO - Downloading/unpacking psutil>=3.1.1 22:27: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:27: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:27: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:27: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:27: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:27: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:27:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:27:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:27:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:27:11 INFO - Installing collected packages: psutil 22:27:11 INFO - Running setup.py install for psutil 22:27:11 INFO - building 'psutil._psutil_linux' extension 22:27:11 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:27:11 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:27:11 INFO - building 'psutil._psutil_posix' extension 22:27:11 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:27:12 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:27:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:27:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:27:12 INFO - Successfully installed psutil 22:27:12 INFO - Cleaning up... 22:27:12 INFO - Return code: 0 22:27:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:27:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:27:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:12 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 0x7f5d0d977f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230b930>, '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 0x230c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230ccc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1478237210.352212-1379509001', '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:27:12 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:27:12 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:27:12 INFO - Using env: {'DISPLAY': ':0', 22:27:12 INFO - 'HOME': '/home/cltbld', 22:27:12 INFO - 'LANG': 'en_US.UTF-8', 22:27:12 INFO - 'LANGUAGE': 'en_US:en', 22:27:12 INFO - 'LOGNAME': 'cltbld', 22:27:12 INFO - 'MAIL': '/var/mail/cltbld', 22:27:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:12 INFO - 'MOZ_NO_REMOTE': '1', 22:27:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:12 INFO - 'NO_EM_RESTART': '1', 22:27:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:12 INFO - 'PWD': '/builds/slave/test', 22:27:12 INFO - 'SHELL': '/bin/bash', 22:27:12 INFO - 'SHLVL': '1', 22:27:12 INFO - 'TERM': 'linux', 22:27:12 INFO - 'TMOUT': '86400', 22:27:12 INFO - 'USER': 'cltbld', 22:27:12 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1478237210.352212-1379509001', 22:27:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:12 INFO - '_': '/tools/buildbot/bin/python'} 22:27:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:27: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:27: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:27: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:27: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:27: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:27: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:27:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:27:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:27:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:27:14 INFO - Installing collected packages: mozsystemmonitor 22:27:14 INFO - Running setup.py install for mozsystemmonitor 22:27:14 INFO - Successfully installed mozsystemmonitor 22:27:14 INFO - Cleaning up... 22:27:14 INFO - Return code: 0 22:27:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:27: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:27:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27: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:27:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27: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', '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 0x7f5d0d977f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230b930>, '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 0x230c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230ccc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1478237210.352212-1379509001', '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:27: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 22:27: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 jsonschema==2.5.1 22:27:14 INFO - Using env: {'DISPLAY': ':0', 22:27:14 INFO - 'HOME': '/home/cltbld', 22:27:14 INFO - 'LANG': 'en_US.UTF-8', 22:27:14 INFO - 'LANGUAGE': 'en_US:en', 22:27:14 INFO - 'LOGNAME': 'cltbld', 22:27:14 INFO - 'MAIL': '/var/mail/cltbld', 22:27:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:14 INFO - 'MOZ_NO_REMOTE': '1', 22:27:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:14 INFO - 'NO_EM_RESTART': '1', 22:27:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:14 INFO - 'PWD': '/builds/slave/test', 22:27:14 INFO - 'SHELL': '/bin/bash', 22:27:14 INFO - 'SHLVL': '1', 22:27:14 INFO - 'TERM': 'linux', 22:27:14 INFO - 'TMOUT': '86400', 22:27:14 INFO - 'USER': 'cltbld', 22:27:14 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1478237210.352212-1379509001', 22:27:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:14 INFO - '_': '/tools/buildbot/bin/python'} 22:27:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:14 INFO - Downloading/unpacking jsonschema==2.5.1 22:27: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:27: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:27: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:27: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:27: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:27: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:27:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:27:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:27: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:27: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:27: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:27: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:27: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:27: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:27:16 INFO - Downloading functools32-3.2.3-2.tar.gz 22:27:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:27:16 INFO - warning: no files found matching '*.txt' 22:27:16 INFO - no previously-included directories found matching 'build' 22:27:16 INFO - no previously-included directories found matching 'dist' 22:27:16 INFO - no previously-included directories found matching '.git*' 22:27:16 INFO - Installing collected packages: jsonschema, functools32 22:27:17 INFO - Running setup.py install for functools32 22:27:17 INFO - warning: no files found matching '*.txt' 22:27:17 INFO - no previously-included directories found matching 'build' 22:27:17 INFO - no previously-included directories found matching 'dist' 22:27:17 INFO - no previously-included directories found matching '.git*' 22:27:17 INFO - Successfully installed jsonschema functools32 22:27:17 INFO - Cleaning up... 22:27:17 INFO - Return code: 0 22:27:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:27:17 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:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:17 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:27:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:17 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 0x7f5d0d977f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230b930>, '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 0x230c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230ccc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1478237210.352212-1379509001', '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:27:17 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:27:17 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:27:17 INFO - Using env: {'DISPLAY': ':0', 22:27:17 INFO - 'HOME': '/home/cltbld', 22:27:17 INFO - 'LANG': 'en_US.UTF-8', 22:27:17 INFO - 'LANGUAGE': 'en_US:en', 22:27:17 INFO - 'LOGNAME': 'cltbld', 22:27:17 INFO - 'MAIL': '/var/mail/cltbld', 22:27:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:17 INFO - 'MOZ_NO_REMOTE': '1', 22:27:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:17 INFO - 'NO_EM_RESTART': '1', 22:27:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:17 INFO - 'PWD': '/builds/slave/test', 22:27:17 INFO - 'SHELL': '/bin/bash', 22:27:17 INFO - 'SHLVL': '1', 22:27:17 INFO - 'TERM': 'linux', 22:27:17 INFO - 'TMOUT': '86400', 22:27:17 INFO - 'USER': 'cltbld', 22:27:17 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1478237210.352212-1379509001', 22:27:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:17 INFO - '_': '/tools/buildbot/bin/python'} 22:27:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:27:17 INFO - Cleaning up... 22:27:17 INFO - Return code: 0 22:27:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:27:17 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:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:17 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:27:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:17 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 0x7f5d0d977f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230b930>, '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 0x230c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230ccc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1478237210.352212-1379509001', '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:27:17 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:27:17 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:27:17 INFO - Using env: {'DISPLAY': ':0', 22:27:17 INFO - 'HOME': '/home/cltbld', 22:27:17 INFO - 'LANG': 'en_US.UTF-8', 22:27:17 INFO - 'LANGUAGE': 'en_US:en', 22:27:17 INFO - 'LOGNAME': 'cltbld', 22:27:17 INFO - 'MAIL': '/var/mail/cltbld', 22:27:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:17 INFO - 'MOZ_NO_REMOTE': '1', 22:27:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:17 INFO - 'NO_EM_RESTART': '1', 22:27:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:17 INFO - 'PWD': '/builds/slave/test', 22:27:17 INFO - 'SHELL': '/bin/bash', 22:27:17 INFO - 'SHLVL': '1', 22:27:17 INFO - 'TERM': 'linux', 22:27:17 INFO - 'TMOUT': '86400', 22:27:17 INFO - 'USER': 'cltbld', 22:27:17 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1478237210.352212-1379509001', 22:27:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:17 INFO - '_': '/tools/buildbot/bin/python'} 22:27:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:17 INFO - Downloading/unpacking blobuploader==1.2.4 22:27: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:27: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:27: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:27: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:27: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:27: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:27:19 INFO - Downloading blobuploader-1.2.4.tar.gz 22:27:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:27:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:27:19 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:27:19 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:27:19 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:27:19 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:27:19 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:27:19 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:27:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:27:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:27:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:20 INFO - Downloading docopt-0.6.1.tar.gz 22:27:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:27:20 INFO - Installing collected packages: blobuploader, requests, docopt 22:27:20 INFO - Running setup.py install for blobuploader 22:27:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:27:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:27:20 INFO - Running setup.py install for requests 22:27:20 INFO - Running setup.py install for docopt 22:27:20 INFO - Successfully installed blobuploader requests docopt 22:27:20 INFO - Cleaning up... 22:27:20 INFO - Return code: 0 22:27:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:27:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:27:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:27:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:21 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 0x7f5d0d977f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230b930>, '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 0x230c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230ccc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1478237210.352212-1379509001', '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:27:21 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:27:21 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:27:21 INFO - Using env: {'DISPLAY': ':0', 22:27:21 INFO - 'HOME': '/home/cltbld', 22:27:21 INFO - 'LANG': 'en_US.UTF-8', 22:27:21 INFO - 'LANGUAGE': 'en_US:en', 22:27:21 INFO - 'LOGNAME': 'cltbld', 22:27:21 INFO - 'MAIL': '/var/mail/cltbld', 22:27:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:21 INFO - 'MOZ_NO_REMOTE': '1', 22:27:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:21 INFO - 'NO_EM_RESTART': '1', 22:27:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:21 INFO - 'PWD': '/builds/slave/test', 22:27:21 INFO - 'SHELL': '/bin/bash', 22:27:21 INFO - 'SHLVL': '1', 22:27:21 INFO - 'TERM': 'linux', 22:27:21 INFO - 'TMOUT': '86400', 22:27:21 INFO - 'USER': 'cltbld', 22:27:21 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1478237210.352212-1379509001', 22:27:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:21 INFO - '_': '/tools/buildbot/bin/python'} 22:27:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:27:21 INFO - Running setup.py (path:/tmp/pip-DrozBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:27:21 INFO - Running setup.py (path:/tmp/pip-jZd4wg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:27:21 INFO - Running setup.py (path:/tmp/pip-UJnwDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:27:21 INFO - Running setup.py (path:/tmp/pip-anQqf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:27:21 INFO - Running setup.py (path:/tmp/pip-Z3mx7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:27:21 INFO - Running setup.py (path:/tmp/pip-TUK9Ip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:27:21 INFO - Running setup.py (path:/tmp/pip-VMrKji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:27:21 INFO - Running setup.py (path:/tmp/pip-s0Szf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:27:21 INFO - Running setup.py (path:/tmp/pip-lx7DHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:27:21 INFO - Running setup.py (path:/tmp/pip-8Dw0Qf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:27:21 INFO - Running setup.py (path:/tmp/pip-XCoQTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:27:21 INFO - Running setup.py (path:/tmp/pip-2XJGet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:27:22 INFO - Running setup.py (path:/tmp/pip-5MlkFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:27:22 INFO - Running setup.py (path:/tmp/pip-9ogd76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:27:22 INFO - Running setup.py (path:/tmp/pip-FP_egB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:27:22 INFO - Running setup.py (path:/tmp/pip-qEwwqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:27:22 INFO - Running setup.py (path:/tmp/pip-OyRM7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:27:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:27:22 INFO - Running setup.py install for manifestparser 22:27:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:27:22 INFO - Running setup.py install for mozcrash 22:27:22 INFO - Running setup.py install for mozdebug 22:27:22 INFO - Running setup.py install for mozdevice 22:27:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:27:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:27:22 INFO - Running setup.py install for mozfile 22:27:22 INFO - Running setup.py install for mozhttpd 22:27:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:27:23 INFO - Running setup.py install for mozinfo 22:27:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:27:23 INFO - Running setup.py install for mozInstall 22:27:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:27:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:27:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:27:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:27:23 INFO - Running setup.py install for mozleak 22:27:23 INFO - Running setup.py install for mozlog 22:27:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:27:23 INFO - Running setup.py install for moznetwork 22:27:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:27:23 INFO - Running setup.py install for mozprocess 22:27:23 INFO - Running setup.py install for mozprofile 22:27:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:27:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:27:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:27:23 INFO - Running setup.py install for mozrunner 22:27:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:27:23 INFO - Running setup.py install for mozscreenshot 22:27:24 INFO - Running setup.py install for moztest 22:27:24 INFO - Running setup.py install for mozversion 22:27:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:27:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:27:24 INFO - Cleaning up... 22:27:24 INFO - Return code: 0 22:27:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:27:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:27:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:27:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:24 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 0x7f5d0d977f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230b930>, '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 0x230c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230ccc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1478237210.352212-1379509001', '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:27:24 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:27:24 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:27:24 INFO - Using env: {'DISPLAY': ':0', 22:27:24 INFO - 'HOME': '/home/cltbld', 22:27:24 INFO - 'LANG': 'en_US.UTF-8', 22:27:24 INFO - 'LANGUAGE': 'en_US:en', 22:27:24 INFO - 'LOGNAME': 'cltbld', 22:27:24 INFO - 'MAIL': '/var/mail/cltbld', 22:27:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:24 INFO - 'MOZ_NO_REMOTE': '1', 22:27:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:24 INFO - 'NO_EM_RESTART': '1', 22:27:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:24 INFO - 'PWD': '/builds/slave/test', 22:27:24 INFO - 'SHELL': '/bin/bash', 22:27:24 INFO - 'SHLVL': '1', 22:27:24 INFO - 'TERM': 'linux', 22:27:24 INFO - 'TMOUT': '86400', 22:27:24 INFO - 'USER': 'cltbld', 22:27:24 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1478237210.352212-1379509001', 22:27:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:24 INFO - '_': '/tools/buildbot/bin/python'} 22:27:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:27:24 INFO - Running setup.py (path:/tmp/pip-CosSi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:27:24 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:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:27:24 INFO - Running setup.py (path:/tmp/pip-ZhVDLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:27:24 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:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:27:24 INFO - Running setup.py (path:/tmp/pip-PZwFW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:27:24 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:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:27:24 INFO - Running setup.py (path:/tmp/pip-cLAx6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:27:24 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:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:27:24 INFO - Running setup.py (path:/tmp/pip-yp5ITL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:27:24 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:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:27:24 INFO - Running setup.py (path:/tmp/pip-Pasl9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:27:24 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:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:27:24 INFO - Running setup.py (path:/tmp/pip-iBGO3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:27:24 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:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:27:24 INFO - Running setup.py (path:/tmp/pip-EXZ_0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:27:25 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:27:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:27:25 INFO - Running setup.py (path:/tmp/pip-kLLw2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:27:25 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:27:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:27:25 INFO - Running setup.py (path:/tmp/pip-G4NPaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:27:25 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:27:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:27:25 INFO - Running setup.py (path:/tmp/pip-Dshtpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:27:25 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:27:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:27:25 INFO - Running setup.py (path:/tmp/pip-WVJu2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:27:25 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:27:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:27:25 INFO - Running setup.py (path:/tmp/pip-1PyXyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:27:25 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:27:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:27:25 INFO - Running setup.py (path:/tmp/pip-ZLZXZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:27:25 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:27:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:27:25 INFO - Running setup.py (path:/tmp/pip-D8aHOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:27:25 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:27:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:27:25 INFO - Running setup.py (path:/tmp/pip-PKGxO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:27:25 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:27:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:27:25 INFO - Running setup.py (path:/tmp/pip-BUmHng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:27:25 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:27:25 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:27:25 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:27:25 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:27:25 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:27:25 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:27:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:27:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:27 INFO - Downloading blessings-1.6.tar.gz 22:27:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:27:27 INFO - Installing collected packages: blessings 22:27:27 INFO - Running setup.py install for blessings 22:27:27 INFO - Successfully installed blessings 22:27:27 INFO - Cleaning up... 22:27:27 INFO - Return code: 0 22:27:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:27:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:27:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:27:28 INFO - Reading from file tmpfile_stdout 22:27:28 INFO - Current package versions: 22:27:28 INFO - argparse == 1.2.1 22:27:28 INFO - blessings == 1.6 22:27:28 INFO - blobuploader == 1.2.4 22:27:28 INFO - docopt == 0.6.1 22:27:28 INFO - functools32 == 3.2.3-2 22:27:28 INFO - jsonschema == 2.5.1 22:27:28 INFO - manifestparser == 1.1 22:27:28 INFO - mozInstall == 1.12 22:27:28 INFO - mozcrash == 0.17 22:27:28 INFO - mozdebug == 0.1 22:27:28 INFO - mozdevice == 0.48 22:27:28 INFO - mozfile == 1.2 22:27:28 INFO - mozhttpd == 0.7 22:27:28 INFO - mozinfo == 0.9 22:27:28 INFO - mozleak == 0.1 22:27:28 INFO - mozlog == 3.4 22:27:28 INFO - moznetwork == 0.27 22:27:28 INFO - mozprocess == 0.23 22:27:28 INFO - mozprofile == 0.28 22:27:28 INFO - mozrunner == 6.12 22:27:28 INFO - mozscreenshot == 0.1 22:27:28 INFO - mozsystemmonitor == 0.3 22:27:28 INFO - moztest == 0.7 22:27:28 INFO - mozversion == 1.4 22:27:28 INFO - psutil == 3.1.1 22:27:28 INFO - requests == 1.2.3 22:27:28 INFO - wsgiref == 0.1.2 22:27:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:27:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:27:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:28 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 0x7f5d0d977f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230b930>, '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 0x230c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230ccc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1478237210.352212-1379509001', '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:27:28 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:27:28 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:27:28 INFO - Using env: {'DISPLAY': ':0', 22:27:28 INFO - 'HOME': '/home/cltbld', 22:27:28 INFO - 'LANG': 'en_US.UTF-8', 22:27:28 INFO - 'LANGUAGE': 'en_US:en', 22:27:28 INFO - 'LOGNAME': 'cltbld', 22:27:28 INFO - 'MAIL': '/var/mail/cltbld', 22:27:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:28 INFO - 'MOZ_NO_REMOTE': '1', 22:27:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:28 INFO - 'NO_EM_RESTART': '1', 22:27:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:28 INFO - 'PWD': '/builds/slave/test', 22:27:28 INFO - 'SHELL': '/bin/bash', 22:27:28 INFO - 'SHLVL': '1', 22:27:28 INFO - 'TERM': 'linux', 22:27:28 INFO - 'TMOUT': '86400', 22:27:28 INFO - 'USER': 'cltbld', 22:27:28 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1478237210.352212-1379509001', 22:27:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:28 INFO - '_': '/tools/buildbot/bin/python'} 22:27:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:28 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:27:28 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:27:28 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:27:28 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:27:28 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:27:28 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:27:28 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:27:28 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:27:28 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:27:28 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:27:28 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:27:28 INFO - Cleaning up... 22:27:28 INFO - Return code: 0 22:27:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:27:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:27:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:28 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 0x7f5d0d977f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230b930>, '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 0x230c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230ccc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1478237210.352212-1379509001', '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:27:28 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:27:28 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:27:28 INFO - Using env: {'DISPLAY': ':0', 22:27:28 INFO - 'HOME': '/home/cltbld', 22:27:28 INFO - 'LANG': 'en_US.UTF-8', 22:27:28 INFO - 'LANGUAGE': 'en_US:en', 22:27:28 INFO - 'LOGNAME': 'cltbld', 22:27:28 INFO - 'MAIL': '/var/mail/cltbld', 22:27:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:28 INFO - 'MOZ_NO_REMOTE': '1', 22:27:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:28 INFO - 'NO_EM_RESTART': '1', 22:27:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:28 INFO - 'PWD': '/builds/slave/test', 22:27:28 INFO - 'SHELL': '/bin/bash', 22:27:28 INFO - 'SHLVL': '1', 22:27:28 INFO - 'TERM': 'linux', 22:27:28 INFO - 'TMOUT': '86400', 22:27:28 INFO - 'USER': 'cltbld', 22:27:28 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1478237210.352212-1379509001', 22:27:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:28 INFO - '_': '/tools/buildbot/bin/python'} 22:27:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:27:28 INFO - Cleaning up... 22:27:28 INFO - Return code: 0 22:27:28 INFO - Running post-action listener: _resource_record_post_action 22:27:28 INFO - Running post-action listener: _start_resource_monitoring 22:27:28 INFO - Starting resource monitoring. 22:27:28 INFO - [mozharness: 2016-11-04 05:27:28.588634Z] Finished create-virtualenv step (success) 22:27:28 INFO - [mozharness: 2016-11-04 05:27:28.589145Z] Running install step. 22:27:28 INFO - Running pre-action listener: _resource_record_pre_action 22:27:28 INFO - Running main action method: install 22:27:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:27:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:27:28 INFO - Reading from file tmpfile_stdout 22:27:28 INFO - Detecting whether we're running mozinstall >=1.0... 22:27:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:27:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:27:28 INFO - Reading from file tmpfile_stdout 22:27:28 INFO - Output received: 22:27:28 INFO - Usage: mozinstall [options] installer 22:27:28 INFO - Options: 22:27:28 INFO - -h, --help show this help message and exit 22:27:28 INFO - -d DEST, --destination=DEST 22:27:28 INFO - Directory to install application into. [default: 22:27:28 INFO - "/builds/slave/test"] 22:27:28 INFO - --app=APP Application being installed. [default: firefox] 22:27:28 INFO - mkdir: /builds/slave/test/build/application 22:27:28 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:27:28 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:27:45 INFO - Reading from file tmpfile_stdout 22:27:45 INFO - Output received: 22:27:45 INFO - /builds/slave/test/build/application/firefox/firefox 22:27:45 INFO - Running post-action listener: _resource_record_post_action 22:27:45 INFO - [mozharness: 2016-11-04 05:27:45.841434Z] Finished install step (success) 22:27:45 INFO - [mozharness: 2016-11-04 05:27:45.841685Z] Running run-tests step. 22:27:45 INFO - Running pre-action listener: _resource_record_pre_action 22:27:45 INFO - Running main action method: run_tests 22:27:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:27:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:27:45 INFO - Python 2.7.3 22:27:45 INFO - Return code: 0 22:27:45 INFO - grabbing minidump binary from tooltool 22:27: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:27:45 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 0x230b930>, '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 0x230c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230ccc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:27:45 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:27:45 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:27:45 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:27:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:27:45 INFO - Return code: 0 22:27:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:27:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:27:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:27:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:27:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:27:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cYOYjmA-S368aTKo2xKKNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 22:27:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cYOYjmA-S368aTKo2xKKNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:27:45 INFO - Using env: {'DISPLAY': ':0', 22:27:45 INFO - 'HOME': '/home/cltbld', 22:27:45 INFO - 'LANG': 'en_US.UTF-8', 22:27:45 INFO - 'LANGUAGE': 'en_US:en', 22:27:45 INFO - 'LOGNAME': 'cltbld', 22:27:45 INFO - 'MAIL': '/var/mail/cltbld', 22:27:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:27:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:27:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:45 INFO - 'MOZ_NO_REMOTE': '1', 22:27:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:27:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:45 INFO - 'NO_EM_RESTART': '1', 22:27:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:45 INFO - 'PWD': '/builds/slave/test', 22:27:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:27:45 INFO - 'SHELL': '/bin/bash', 22:27:45 INFO - 'SHLVL': '1', 22:27:45 INFO - 'TERM': 'linux', 22:27:45 INFO - 'TMOUT': '86400', 22:27:45 INFO - 'USER': 'cltbld', 22:27:45 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1478237210.352212-1379509001', 22:27:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:45 INFO - '_': '/tools/buildbot/bin/python'} 22:27:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cYOYjmA-S368aTKo2xKKNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:27:46 INFO - mozversion application_buildid: 20161103193337 22:27:46 INFO - mozversion application_changeset: 38fcc30d818f99f3798865d551acce5681b0a3c0 22:27:46 INFO - mozversion application_display_name: Nightly 22:27:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:27:46 INFO - mozversion application_name: Firefox 22:27:46 INFO - mozversion application_remotingname: firefox 22:27:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:27:46 INFO - mozversion application_vendor: Mozilla 22:27:46 INFO - mozversion application_version: 52.0a1 22:27:46 INFO - mozversion platform_buildid: 20161103193337 22:27:46 INFO - mozversion platform_changeset: 38fcc30d818f99f3798865d551acce5681b0a3c0 22:27:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:27:46 INFO - mozversion platform_version: 52.0a1 22:27:46 INFO - using testdate: 1478237266 22:27:46 INFO - actual date: 1478237266 22:27:46 INFO - starting webserver on 'localhost:58027' 22:27:46 INFO - SUITE-START | Running 2 tests 22:27:46 INFO - TEST-START | dromaeo_css 22:27:46 INFO - operating with platform_type : linux_ 22:27:46 INFO - Initialising browser for dromaeo_css test... 22:27:46 INFO - TEST-INFO | started process 26974 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzXaoAS/profile http://localhost:58027/getInfo.html) 22:27:50 INFO - PROCESS | 26974 | __metrics Screen width/height:1600/1200 22:27:50 INFO - PROCESS | 26974 | colorDepth:24 22:27:50 INFO - PROCESS | 26974 | Browser inner width/height: 1024/697 22:27:50 INFO - PROCESS | 26974 | __metrics 22:27:51 ERROR - PROCESS | 26974 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3158: TypeError: this.tabs is undefined 22:27:52 INFO - TEST-INFO | 26974: exit 0 22:27:52 INFO - Browser initialized. 22:27:52 INFO - Running cycle 1/1 for dromaeo_css test... 22:27:52 INFO - TEST-INFO | started process 27100 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzXaoAS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:28:04 INFO - PROCESS | 27100 | RSS: Main: 185434112 22:28:04 INFO - PROCESS | 27100 | 22:28:53 INFO - PROCESS | 27100 | 1478237333993 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:31:05 INFO - PROCESS | 27100 | Cycle 1(1): loaded http://localhost:58027/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58027/tests/dromaeo/cssquery-ext.html) 22:31:06 INFO - PROCESS | 27100 | RSS: Main: 198082560 22:31:06 INFO - PROCESS | 27100 | 22:34:08 INFO - PROCESS | 27100 | Cycle 1(1): loaded http://localhost:58027/tests/dromaeo/cssquery-ext.html (next: http://localhost:58027/tests/dromaeo/cssquery-jquery.html) 22:34:09 INFO - PROCESS | 27100 | RSS: Main: 197046272 22:34:09 INFO - PROCESS | 27100 | 22:37:11 INFO - PROCESS | 27100 | Cycle 1(1): loaded http://localhost:58027/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58027/tests/dromaeo/cssquery-mootools.html) 22:37:11 INFO - PROCESS | 27100 | RSS: Main: 198770688 22:37:11 INFO - PROCESS | 27100 | 22:40:13 INFO - PROCESS | 27100 | Cycle 1(1): loaded http://localhost:58027/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58027/tests/dromaeo/cssquery-prototype.html) 22:40:14 INFO - PROCESS | 27100 | RSS: Main: 195776512 22:40:14 INFO - PROCESS | 27100 | 22:43:17 INFO - PROCESS | 27100 | Cycle 1(1): loaded http://localhost:58027/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58027/tests/dromaeo/cssquery-yui.html) 22:43:17 INFO - PROCESS | 27100 | RSS: Main: 199303168 22:43:17 INFO - PROCESS | 27100 | 22:46:20 INFO - PROCESS | 27100 | Cycle 1(1): loaded http://localhost:58027/tests/dromaeo/cssquery-yui.html (next: http://localhost:58027/tests/dromaeo/cssquery-dojo.html) 22:46:20 INFO - PROCESS | 27100 | RSS: Main: 199389184 22:46:20 INFO - PROCESS | 27100 | 22:46:20 INFO - PROCESS | 27100 | __start_tp_report 22:46:20 INFO - PROCESS | 27100 | _x_x_mozilla_page_load 22:46:20 INFO - PROCESS | 27100 | _x_x_mozilla_page_load_details 22:46:20 INFO - PROCESS | 27100 | |i|pagename|runs| 22:46:20 INFO - PROCESS | 27100 | |0;dojo.html;3003.129092563157;3014.9246268843285;3049.5883055787463;3053.1451193665766;3064.770142239332;5327.254184414175;5467.507924286813;5499.917501237484;5510.531604813586;5609.411011843759;5372.0330340538785;5441.2654291670615;5472.835814925548;5487.122060470316;5544.417836127199;4897.706137631753;4929.827456039039;4980.825671101512;5063.569596584276;5109.2591574221715;4902.411710594733;5012.298278241031;5013.473585273548;5055.266986286986;5108.948910510903;4902.48523904992;4956.306117143603;4958.925616115761;4962.206047032493;4999.875003124915;4958.479359667255;4964.578010869081;4975.502449755032;4984.800607975677;5067.467915868818;4920.4833492483485;4935.605151587864;4948.505149485059;4956.529129732669;4996.575291100261;5215.843524694227;5312.335958005249;5400.594955378323;5410.269613602152;5439.945600543983;5803.767849286023;5817.098349755753;5826.796062137805;5828.6211396259105;5835.5915085944;5869.882602347929;5873.236479257712;5877.5591830612875;5878.617889837147;5880.382559831199;5329.760160792774;5383.67697938125;5398.838034858961;5425.294711687456;5448.155535891903;5933.6736479493175;5965.105234214816;5982.700864956735;5987.730552125165;5992.221011268507;5692.800751973661;5698.487136157766;5730.684812335361;5743.56923230751;5744.454276843693;5563.332400112013;5619.297587801525;5712.257406537206;5729.341125770589;5777.884442311214;5645.068563686946;5745.253117094751;5750.827475175752;5770.076787713946;5792.333881603585;5762.884742305214;5765.221695071195;5766.509846663081;5767.22142510764;5785.074388097884;4423.756693381831;4426.0483995940385;4448.221561226773;4454.398656181439;4498.572635599613;3958.6635136013188;3970.9602903971168;3983.980080099639;4015.297322968469;4064.7967601619803;5585.860353491195;5616.466435688685;5618.634788738719;5629.577781666391;5630.380658127603;5877.23595932526;5882.588218824727;5888.440598143169;5908.911366329508;5909.054551271776;5478.890422191534;5492.972535137299;5522.392536820947;5545.833624991256;5565.833025009175;5066.113430149709;5068.974655126774;5075.3402057733;5076.13705670037;5115.693058416507;6033.276006879115;6083.300420451705;6090.390960903963;6090.421409966046;6102.206713127265;5629.690367029689;5689.6586204827845;5774.960507108761;5796.94203057964;5895.616784908967;6074.757009719739;6089.519704738409;6095.451409373178;6096.6476373754385;6100.641728746782;5530.081978602266;5753.309602847517;5762.337331206965;5764.365919748908;5766.452187042224;5748.39641837601;5754;5808.128780682931;5828.883422331445;5832.94167058324;5694.715264236855;5696.800611978727;5701.657900525982;5708.115242137475;5711.885762284648;5628.943710562842;5656.915146272727;5657.15142728594;5663.093904975184;5664.461876121762;5525.254090697705;5623.493885550321;5653.604247702786;5653.915191272216;5657.8019769307875;5672;5730.312362516524;5737.713114344349;5748.597598168255;5783.942160578508;5545.833624991095;5584.525315348241;5590.9440905592055;5612.7754889803955;5621.269234999424 22:46:20 INFO - PROCESS | 27100 | |1;ext.html;565.5023579250259;566.5948846574698;570.3896830391482;577.2409281794442;595.5265563876718;40881.59118408815;42740.14519709608;42786.78606606967;46398.768006159924;46439.767801160946;42961.570384296145;43475.78262108685;43547.56452435475;43685.34471982923;43861.7806910965;8609.311255099592;8644.956775216147;8701.216890479856;8774.824503509926;8795.95602021989;8618.56907154643;8731.60707768152;8769.56152192391;8775.517346545937;8789;8786.86819697705;8816.030236673962;8817;8835.955820220923;8865.911340886572;8742.082081381459;8774.692885749031;8785.736427907173;8802.075782042857;8812.823743525125;8457.873131903027;8550.615222315011;8603.483790972561;8633.827323453495;8656.480611163288;41563.1687366254;41918.371224431656;41928;41930.37104443436;41954;3338.3990881641294;3350.4961944304537;3378;3434.553508043938;3513.0163554204864;31101.688983110107;31446.37107257842;31671.36657266865;31865.362692746246;31885.202869928205;4233.174530966463;4250.213710463574;4281.935770963438;4297.03316753731;4332.978335108304;319108;319872;320167;320494;320913;55924.72037639867;56194.43805561892;56314;56413.71793141008;56491.71754141203;58142;58427;58431.70784146052;58771.41228587745;58778.41221587815;15515.922420387826;15757.842421575637;15890.841091588936;15950.840491595167;16004.279807408695;12314.13801033937;12329.876701232874;12347.876521234673;12436;12438;16221.59446013859;16860.156992150587;16861.156942152844;16884.915575422045;16889.493315200565;6241.7191226394925;6319.652419116901;6364.268109167412;6371.23545174582;6514.576552524166;806.209914284005;880.6301353431575;986.6891929042472;1018.3889666200221;1105.519099191838;29197.270068248465;29200.707992920223;29466.558001629994;29509.85245073761;30003.399932001674;1051.673981065872;1058.88352281249;1104.127739086129;1157.1841851494844;1197.6227488341144;15020.474283400246;15434.450076482248;15477.5356739298;15579.221038948008;15625.921870390575;492324;494715;495928;497190;497326;55512.72243638756;55558;55585.44414555802;55800;55851.441485585434;1334.6396472952442;1353.312224189077;1362.611655678127;1385.7367100251122;1387.361813565751;28451.28871778222;28936.276593085342;29114.41771164607;29760.851195743882;30881.69118308788;48274.517254827006;48741;48840.755796220794;48926.510734892196;48960.75519622379;399698;401702;402140;402613;403445;27050.323741905824;27243.455130897666;27670.308242294104;27793.305167370978;27930.58104128399;45507.54492455166;45560.54439455563;46017.30974035459;46298.53701462942;46648;39194.41208381819;39487;40816.3877541843;41048.589514104475;41189;38712.89349717128;38927;39250.80374598109;40231.396529051504;40439.1912161761;37794.433083503216;38657.42013869738;38806.80596596999;39680.2063958725;39703.2059358817;33890.8305458481;36325.273494529436;36536.63463365439;36844.63155368519;36952.445713313784;27747.861260693568;27869;28161.71838281591;28358.574621381107;28445.573316400685 22:46:20 INFO - PROCESS | 27100 | |2;jquery.html;378.7500249835109;388.5473423461667;398.92688667484464;406.6604385338242;423.8770756480621;14239.430422783102;14770.630734231623;17650.29398824047;19166.52083697908;19290.614187716255;15739.527814165565;18978.81021189788;19074.904625476887;19099.23603055876;19572.608547829033;5457.5633949283965;5463.644863083897;5703.429657034284;5715.771369145229;5742.770289188427;5630.09918413054;5791;5796.217510636052;5798.101294299369;5821.621594596338;5569;5741.598088133832;5787.276590426197;5789.536837053047;5804.187413762077;5798.478136967651;5817.912731309013;5853.5317174625925;5870.324912635059;5888.823335299927;5457.754401051962;5583.357913839879;5634.408387119375;5660.29246344207;5689.459501347365;13074.673133171651;13134.605961821066;13290.136141150795;13368.064235503518;13459;2139.6362618354915;2141.1114387529315;2225.221172589597;2260.8417410781253;2274.2494976657663;9814.558344874498;10132.696019119438;10136.594536218543;11825.822612660817;13913.30433478322;1869.6821540338176;1962.8429725621916;2014.597080583889;2028.6855537391727;2043.2133628552965;80877;82142.17857821405;82403;83652.58173709153;83790.58104709498;10654;10964.890351096386;11034.503447344889;11110.666679999613;11203.719907002227;15417;15502.84497155014;15531.378744850079;15572.766408503881;15589.454369097253;7733.7679869604;7956.9602151988865;8100.2304781045705;8195;8235.8352832943;7605.23947605235;7694.730684426018;7783.532988020737;7857.253560911704;7909.288164065261;4435.645148388121;4472.530384309601;4492.124035812985;4560.68075234737;4623.838165664186;1838.9908050459662;1869.8317151456433;1978.1592823050435;1992.4421162074643;1999.0904138616895;895.2032690905099;930.7859192385654;973.2603221551672;998.5606333213362;1016.8068067067234;17695.46913592594;18345;18395;19073.61852762937;19129.33047343336;922.0502882031384;948.5968463403165;950.8050849575959;980.0738302304396;991.8313886639289;10103.545340459697;10527.420991845522;10532.894671053346;10611.25721199524;10654.307470014424;395718;413655;419808;422744;424373;89425.55287223522;90558.54720726486;91556;92022;92903.53548232216;991.6628346362271;992.9851052234222;993.1756641987133;993.3245393132739;995.5216503492309;16112.355505779638;16510.33958641689;16595.66808663844;16769.580760481087;17191.7421238679;38290;39123.80438097791;40809.79595102005;41822.79088604659;41855.7907210462;48880.75559622179;50990.490095098576;52423.47576524186;52906.73546632396;53962;8096.919030809617;8251.628676709683;8325.7104296319;8393.32853371741;8507.234348908629;9147.63409463614;12230.143889927975;13030.739385212053;13060.934695326463;13129.343532823512;7685.116211635734;9527.666531671359;11516.769664606829;11520.366379849189;11844.822327664919;10226.897731022893;11028.834567481656;11260.774784504429;11281.266717663326;11565.653030409101;11978.281303121841;12001.339926304137;12038.819417708917;12076.698082547655;12352.135350525736;7286.526375785557;7545.471816972759;7598.658060387406;8013.3188678960605;8681.175288347597;10648.041676248866;10947.616833410792;11046.889531104585;11248.550057997916;11310.660680179608 22:46:20 INFO - PROCESS | 27100 | |3;mootools.html;1434.139516290226;1473.0793254216114;1568.7097886890926;1669.7161482547965;1693.5596744846343;7651.579163146025;7905.762827115182;7949.165337639552;8426.115257897924;8427.70503032394;8190.05814331352;8465.068842427328;8466.661333546666;8699.782505437368;8711.215990560848;2319.5708793873105;2321.9883900580517;2324.151684635113;2329.1847853251397;2348.753380895007;2348.43637526994;2354.4349356154485;2397.976020239793;2400.0759707512557;2405.4106743847783;2308.042162502568;2309.3533810532995;2315.073970411832;2329.324495896188;2363.2039649866056;2222.843841473768;2265.6714776357417;2277.9202727904526;2285.554316908212;2291.472961218912;2282.828787840902;2298.885055747206;2308.0536979838184;2308.538292341522;2314.2247347138727;8569.914300856974;8608.096149904233;8679.435836670596;8702.042775294713;8709.869351959725;5181.792728290864;5359;5360.839174824761;5363.892722145535;5370.785168593252;3149.5748074010176;3359.0195715496325;3408.7273018158735;3455.2225749206477;3471.9100000999133;1115.493013361232;1138.584416687903;1158.5250047480577;1163.1218430085232;1180.0323734537683;11942.820857687142;11952.521899124025;11978.041756659446;11989.22070065443;12018.699532511757;4394.846180383671;4710;4731.7634118293945;4783.306420569068;4810.4467986181335;9569.808603827885;9594.42433453981;9595.616175353047;9611.086946740048;9634.325597208268;5174.844754657366;5193.818216362409;5202.453742357074;5214.634975551675;5225.372955245395;4306.246406878784;4323.654107671442;4818.445878723992;4897.975510122498;4914.803407863646;3906.941395879064;3968.1071758854027;3986.60133986599;3995.4805875236034;4083.305838007546;1305.2429590837291;1312.6193403912948;1333.4932725564224;1339.71196192819;1341.1751772659939;952.2857856607544;962.6438217859297;974.4554880514464;976.077606661712;976.1946394224793;5726.856828579235;5864.560157988168;5917.585768996215;5917.733701983335;5959.046552551571;450.05263919449743;450.7543388853083;452.05746019549605;457.71392879450343;459.75862672096747;3819.388897776342;3821.299521712811;3923.803809809498;3951.8221680024467;4068.2270368629866;9779.755506112404;10296.22778291631;10369.274150809371;10409.9479502602;10492.790144197226;10155.882852886176;10342.069213770646;10360.948195258976;10441.425721585234;10446.05985461297;7863.882041769378;8101.230383113595;8116.797080073045;8124.675012999532;8145.3483721302155;5569.972150139223;5657.547396208376;5763.8559036024435;5786.189933409242;5788.363280039276;9574.856377154209;9576.281778866474;9671.468069255978;9751;9786.853197201905;9670.323077384797;9690.56392462355;9711.077447642463;9818.558164882741;9849.606015759577;6819.5908245505425;7000.194977577644;7075.363217310467;7279.1265048194555;7409.2590740927635;7759.068911730628;8043.155468675939;8047.074586422402;8049.758507244792;8061.516309021477;7200.315969982843;7266.38235749946;7385.409167266714;7445.9255407445235;7451.068616422947;6698.196216454056;7087.078679771596;7165.7850264492145;7221.097362829646;7374.926250737424;6284.780032698834;6368.5860419072615;6407.9038814418755;6432.871342573028;6446.935530644633;4584.724916505021;4631.606313463393;4648.488666246778;4736.218523943511;4746.715197088186;4645.419322584677;4706.741129237787;4764.118638051971;4805.879853003703;5037.546620804145 22:46:20 INFO - PROCESS | 27100 | |4;prototype.html;322.311864169997;323.4113912678924;329.95380646709464;332.16791936199814;339.1149100846791;5282.31329927109;5366.838994830152;5436.401995780466;5480.75336609852;5501.339839219294;5185.507376799207;5325.763179464624;5333.333333333324;5360.758765855536;5361.329833770778;4246.554111818261;4249.702520823544;4267.893302667442;4281.1437712457555;4283.3146696528565;4164.458620379346;4231.809568569422;4256.297710877717;4276.465441819772;4303.6772242081815;4219.1139860629155;4225.577442255781;4228.936565951498;4234.74591524508;4245.341971994346;4212.262854000553;4229.767362795045;4231.069164783758;4236.745795252295;4249.660027197848;3690.538682664667;3771.2834561433515;3776.9055773605605;3789.2800367930004;3805.8858234253016;5189.896202075975;5201.427842937273;5224;5233.659812112239;5251.501107394792;4858.174110401205;4861.829835955725;4882.218844984785;4888.462269150391;4913.508649135094;5549.500544950974;5586.804461843816;5713.628614140109;5731.254936858223;5778.248827652378;4104.199681062194;4108.219438306742;4110.445089912853;4113.547509773923;4135.31767258402;5869.8239052828485;5882.588218824684;5899.616524925866;5941.405859414067;5946.137810017566;3883.9609205167512;4239.745615263094;4241.172971270573;4244.596763307481;4250.808713607895;4117.341225403921;4136.627703506699;4152.937705934413;4161.167766446722;4176.561461046546;4774.71351718891;4775.21209000518;4792.784324705397;4806.687565308243;4815.760671287868;5475.72621368938;5720.456556627197;5731.398203188689;5788.726480174355;5791.305043394819;1417.5818133650598;1437.8634029767156;1438.6259572511221;1442.444658806346;1443.141330908108;888.644542183119;912.2291663544295;919.4253591505309;932.1983094538691;932.8320902237526;4797.608693478852;4821.614270858323;4831.323614693945;4841.661083724176;4852.56326930578;5044.890124172676;5069.543741063322;5130.7178105204575;5181.611379146579;5196.636235463557;4607.470140933769;4836.727399145127;4883.389576302962;4887.975560122177;4962.203914005789;2742.71092586484;2743.4101668141448;2745.670519537668;2777.7916656250864;2782.8590277985927;5316.441773613792;5385;5412.945870541323;5435.8256697321385;5450.672959622435;4919.698720758772;5267.367915850046;5275;5300.337457817773;5304.814331498379;5172.5344718975475;5195.298634684269;5204.661696989683;5229.215617657382;5237.831112177078;5019.297298378303;5098.745062746922;5129.563987061141;5170.6380553360905;5237.145755563303;4914.238293064581;5094.541491265655;5127.820526281562;5154.845354639367;5164.535191832753;5271;5311.707856067954;5317.707526086102;5362.705051222064;5408.78364865401;3705.462707907392;3932.5674175840063;4005.4192142138645;4033.616806403387;4105.199486100301;5803.390643982321;5829.883402332014;5840.415958404125;5841.299044114563;5877.441643043904;5436.40199578054;5696.686682232517;5707.971460142673;5721.742521586455;5748.913766293425;5547.306586676666;5580.600341853042;5583.302087239095;5586.804461843816;5605.971970140124;5557.249771280825;5603.8318850432925;5609.915851262316;5663.433656634304;5701.714914254354;5526.778928842962;5635.380108188178;5641.717914104196;5654.7455364509515;5660.858478537904;5531.529819965348;5574.721263936868;5579.218909352613;5595.384507704231;5597.944020559905 22:46:20 INFO - PROCESS | 27100 | |5;yui.html;668.8963210702341;709.2623671381763;728.4847517164299;736.4255880413273;751.4739682222446;11823.822642660367;12779.616611501646;12783.424745886434;12870.099093063489;12883.420246088937;11905.940470297657;12251.387430628478;12282.508699652026;12462.065345099109;12481.188722733015;765.7855800375889;772.5403384985924;778.6885245901628;779.07679399911;779.7154038775834;766.8006318357211;776.343989329016;787.3032366355787;789.8736202207648;799.6801279488222;833.4332653795447;834.1075049696827;835.4778263585259;836.5148214035875;838.2162677896156;829.9792505187388;830.4145577367941;830.6345208108413;830.8629076202419;832.3840358134967;601.4737105033096;602.9306629737592;605.5004621187494;607.7204485936475;608.9878202435926;12422.56521021769;12487;12581.056420768387;12584.370781460982;12587.74824503514;13518.32408379587;13605;13652.86347136526;13663.795043074262;13670.17978921258;9889.505524723807;10111.191104711605;10149.492525373702;10276.94861525695;10464.686059418229;3656.670899619047;3684.8157592120556;3719.2933342664805;3734.0851491384515;3868.6905047596124;59825.70087149536;60489.395106049255;60830;60839;61228.38771612316;10418.270721049605;10561;10599;10627.256092073636;10694;18606.720899186523;18648.906755466134;18679.90660046691;18811.717824232648;18887.811121888604;7209.927900721031;7434.219406962299;7674.270944260286;7682.577458239851;7760.379169666413;4523.954760452353;4525.298578720303;4607.9308810367875;4610.74640894754;4627.953720462752;3355.3624811285777;3426.0920855973186;3474.0446377245953;3477.443609022544;3480.9303813924084;559.7425184415215;560.8681959739458;565.0732798210937;569.4476357932798;569.5358282999342;597.4191492751273;671.6373158494456;681.5944760180602;684.3327755438407;688.6419062087787;8403.159684031549;8736.213740763362;8991.370604057653;9088.40925339864;9151.794626103017;630.3255516597197;650.0671536345266;651.4072194303161;652.6606164794375;656.1142457682187;4020.3969404589548;4263.893402664896;4406.669499787528;4421.734695918255;4531.093781243764;67712;69152;70606.29393705998;76092.23907760851;90260.54869725609;42906.78546607247;55201.44798552043;65477.34522654713;67450;68453.65773171202;40327.798361008005;55018.449815502136;56013;61829;63537.68231158907;8658.870116948377;9063.68277110298;9206.585703643219;9258.35191536586;9279.582418791306;42682.35976460294;42819.785901070296;43907;43936.34095488506;44237.77881110574;56316.71841640765;56363;58831;60280.698596506736;61664.38335616586;11492.885071149181;11497;11579.768404631692;11740.647780566596;12047.879521204675;11048;11156.55373785072;13118.409671564994;13318.267495287851;13345.332733363488;10431.530581123716;10860.891391085988;10927.508262128382;12297.262164270172;12839.422226000039;11988;12207.45066471993;12502.499900004263;12660.17708848922;13016.023798215361;11828.881711182778;11912.821307680219;12146.878531214576;12592.811107833206;13417.127886687334;10235.152021233695;10310.175185985254;10447.268691191544;10631.681049568526;10862.728431788952;10329.276950613385;10852.620158294421;10854.34873907568;10868.51091700891;10916.508757106109 22:46:20 INFO - PROCESS | 27100 | __end_tp_report 22:46:20 INFO - PROCESS | 27100 | __start_cc_report 22:46:20 INFO - PROCESS | 27100 | _x_x_mozilla_cycle_collect,344 22:46:20 INFO - PROCESS | 27100 | __end_cc_report 22:46:20 INFO - PROCESS | 27100 | __startTimestamp1478238380356__endTimestamp 22:46:20 INFO - PROCESS | 27100 | 22:46:20 INFO - PROCESS | 27100 | ------- Summary: start ------- 22:46:20 INFO - PROCESS | 27100 | Number of tests: 6 22:46:20 INFO - PROCESS | 27100 | 22:46:20 INFO - PROCESS | 27100 | [#0] dojo.html Cycles:165 Average:5410.17 Median:5623.49 stddev:621.19 (11.0%) stddev-sans-first:593.70 22:46:20 INFO - PROCESS | 27100 | Values: 3003.1 3014.9 3049.6 3053.1 3064.8 5327.3 5467.5 5499.9 5510.5 5609.4 5372.0 5441.3 5472.8 5487.1 5544.4 4897.7 4929.8 4980.8 5063.6 5109.3 4902.4 5012.3 5013.5 5055.3 5108.9 4902.5 4956.3 4958.9 4962.2 4999.9 4958.5 4964.6 4975.5 4984.8 5067.5 4920.5 4935.6 4948.5 4956.5 4996.6 5215.8 5312.3 5400.6 5410.3 5439.9 5803.8 5817.1 5826.8 5828.6 5835.6 5869.9 5873.2 5877.6 5878.6 5880.4 5329.8 5383.7 5398.8 5425.3 5448.2 5933.7 5965.1 5982.7 5987.7 5992.2 5692.8 5698.5 5730.7 5743.6 5744.5 5563.3 5619.3 5712.3 5729.3 5777.9 5645.1 5745.3 5750.8 5770.1 5792.3 5762.9 5765.2 5766.5 5767.2 5785.1 4423.8 4426.0 4448.2 4454.4 4498.6 3958.7 3971.0 3984.0 4015.3 4064.8 5585.9 5616.5 5618.6 5629.6 5630.4 5877.2 5882.6 5888.4 5908.9 5909.1 5478.9 5493.0 5522.4 5545.8 5565.8 5066.1 5069.0 5075.3 5076.1 5115.7 6033.3 6083.3 6090.4 6090.4 6102.2 5629.7 5689.7 5775.0 5796.9 5895.6 6074.8 6089.5 6095.5 6096.6 6100.6 5530.1 5753.3 5762.3 5764.4 5766.5 5748.4 5754.0 5808.1 5828.9 5832.9 5694.7 5696.8 5701.7 5708.1 5711.9 5628.9 5656.9 5657.2 5663.1 5664.5 5525.3 5623.5 5653.6 5653.9 5657.8 5672.0 5730.3 5737.7 5748.6 5783.9 5545.8 5584.5 5590.9 5612.8 5621.3 22:46:20 INFO - PROCESS | 27100 | 22:46:20 INFO - PROCESS | 27100 | [#1] ext.html Cycles:180 Average:56528.95 Median:40965.09 stddev:109074.25 (266.3%) stddev-sans-first:109299.30 22:46:20 INFO - PROCESS | 27100 | Values: 565.5 566.6 570.4 577.2 595.5 40881.6 42740.1 42786.8 46398.8 46439.8 42961.6 43475.8 43547.6 43685.3 43861.8 8609.3 8645.0 8701.2 8774.8 8796.0 8618.6 8731.6 8769.6 8775.5 8789.0 8786.9 8816.0 8817.0 8836.0 8865.9 8742.1 8774.7 8785.7 8802.1 8812.8 8457.9 8550.6 8603.5 8633.8 8656.5 41563.2 41918.4 41928.0 41930.4 41954.0 3338.4 3350.5 3378.0 3434.6 3513.0 31101.7 31446.4 31671.4 31865.4 31885.2 4233.2 4250.2 4281.9 4297.0 4333.0 319108.0 319872.0 320167.0 320494.0 320913.0 55924.7 56194.4 56314.0 56413.7 56491.7 58142.0 58427.0 58431.7 58771.4 58778.4 15515.9 15757.8 15890.8 15950.8 16004.3 12314.1 12329.9 12347.9 12436.0 12438.0 16221.6 16860.2 16861.2 16884.9 16889.5 6241.7 6319.7 6364.3 6371.2 6514.6 806.2 880.6 986.7 1018.4 1105.5 29197.3 29200.7 29466.6 29509.9 30003.4 1051.7 1058.9 1104.1 1157.2 1197.6 15020.5 15434.5 15477.5 15579.2 15625.9 492324.0 494715.0 495928.0 497190.0 497326.0 55512.7 55558.0 55585.4 55800.0 55851.4 1334.6 1353.3 1362.6 1385.7 1387.4 28451.3 28936.3 29114.4 29760.9 30881.7 48274.5 48741.0 48840.8 48926.5 48960.8 399698.0 401702.0 402140.0 402613.0 403445.0 27050.3 27243.5 27670.3 27793.3 27930.6 45507.5 45560.5 46017.3 46298.5 46648.0 39194.4 39487.0 40816.4 41048.6 41189.0 38712.9 38927.0 39250.8 40231.4 40439.2 37794.4 38657.4 38806.8 39680.2 39703.2 33890.8 36325.3 36536.6 36844.6 36952.4 27747.9 27869.0 28161.7 28358.6 28445.6 22:46:20 INFO - PROCESS | 27100 | 22:46:20 INFO - PROCESS | 27100 | [#2] jquery.html Cycles:180 Average:26241.08 Median:227738.90 stddev:68986.61 (30.3%) stddev-sans-first:69152.80 22:46:20 INFO - PROCESS | 27100 | Values: 378.8 388.5 398.9 406.7 423.9 14239.4 14770.6 17650.3 19166.5 19290.6 15739.5 18978.8 19074.9 19099.2 19572.6 5457.6 5463.6 5703.4 5715.8 5742.8 5630.1 5791.0 5796.2 5798.1 5821.6 5569.0 5741.6 5787.3 5789.5 5804.2 5798.5 5817.9 5853.5 5870.3 5888.8 5457.8 5583.4 5634.4 5660.3 5689.5 13074.7 13134.6 13290.1 13368.1 13459.0 2139.6 2141.1 2225.2 2260.8 2274.2 9814.6 10132.7 10136.6 11825.8 13913.3 1869.7 1962.8 2014.6 2028.7 2043.2 80877.0 82142.2 82403.0 83652.6 83790.6 10654.0 10964.9 11034.5 11110.7 11203.7 15417.0 15502.8 15531.4 15572.8 15589.5 7733.8 7957.0 8100.2 8195.0 8235.8 7605.2 7694.7 7783.5 7857.3 7909.3 4435.6 4472.5 4492.1 4560.7 4623.8 1839.0 1869.8 1978.2 1992.4 1999.1 895.2 930.8 973.3 998.6 1016.8 17695.5 18345.0 18395.0 19073.6 19129.3 922.1 948.6 950.8 980.1 991.8 10103.5 10527.4 10532.9 10611.3 10654.3 395718.0 413655.0 419808.0 422744.0 424373.0 89425.6 90558.5 91556.0 92022.0 92903.5 991.7 993.0 993.2 993.3 995.5 16112.4 16510.3 16595.7 16769.6 17191.7 38290.0 39123.8 40809.8 41822.8 41855.8 48880.8 50990.5 52423.5 52906.7 53962.0 8096.9 8251.6 8325.7 8393.3 8507.2 9147.6 12230.1 13030.7 13060.9 13129.3 7685.1 9527.7 11516.8 11520.4 11844.8 10226.9 11028.8 11260.8 11281.3 11565.7 11978.3 12001.3 12038.8 12076.7 12352.1 7286.5 7545.5 7598.7 8013.3 8681.2 10648.0 10947.6 11046.9 11248.6 11310.7 22:46:20 INFO - PROCESS | 27100 | 22:46:20 INFO - PROCESS | 27100 | [#3] mootools.html Cycles:180 Average:5559.53 Median:4858.21 stddev:3123.39 (64.3%) stddev-sans-first:3116.77 22:46:20 INFO - PROCESS | 27100 | Values: 1434.1 1473.1 1568.7 1669.7 1693.6 7651.6 7905.8 7949.2 8426.1 8427.7 8190.1 8465.1 8466.7 8699.8 8711.2 2319.6 2322.0 2324.2 2329.2 2348.8 2348.4 2354.4 2398.0 2400.1 2405.4 2308.0 2309.4 2315.1 2329.3 2363.2 2222.8 2265.7 2277.9 2285.6 2291.5 2282.8 2298.9 2308.1 2308.5 2314.2 8569.9 8608.1 8679.4 8702.0 8709.9 5181.8 5359.0 5360.8 5363.9 5370.8 3149.6 3359.0 3408.7 3455.2 3471.9 1115.5 1138.6 1158.5 1163.1 1180.0 11942.8 11952.5 11978.0 11989.2 12018.7 4394.8 4710.0 4731.8 4783.3 4810.4 9569.8 9594.4 9595.6 9611.1 9634.3 5174.8 5193.8 5202.5 5214.6 5225.4 4306.2 4323.7 4818.4 4898.0 4914.8 3906.9 3968.1 3986.6 3995.5 4083.3 1305.2 1312.6 1333.5 1339.7 1341.2 952.3 962.6 974.5 976.1 976.2 5726.9 5864.6 5917.6 5917.7 5959.0 450.1 450.8 452.1 457.7 459.8 3819.4 3821.3 3923.8 3951.8 4068.2 9779.8 10296.2 10369.3 10409.9 10492.8 10155.9 10342.1 10360.9 10441.4 10446.1 7863.9 8101.2 8116.8 8124.7 8145.3 5570.0 5657.5 5763.9 5786.2 5788.4 9574.9 9576.3 9671.5 9751.0 9786.9 9670.3 9690.6 9711.1 9818.6 9849.6 6819.6 7000.2 7075.4 7279.1 7409.3 7759.1 8043.2 8047.1 8049.8 8061.5 7200.3 7266.4 7385.4 7445.9 7451.1 6698.2 7087.1 7165.8 7221.1 7374.9 6284.8 6368.6 6407.9 6432.9 6446.9 4584.7 4631.6 4648.5 4736.2 4746.7 4645.4 4706.7 4764.1 4805.9 5037.5 22:46:20 INFO - PROCESS | 27100 | 22:46:20 INFO - PROCESS | 27100 | [#4] prototype.html Cycles:180 Average:4598.68 Median:5159.69 stddev:1325.07 (25.7%) stddev-sans-first:1289.33 22:46:20 INFO - PROCESS | 27100 | Values: 322.3 323.4 330.0 332.2 339.1 5282.3 5366.8 5436.4 5480.8 5501.3 5185.5 5325.8 5333.3 5360.8 5361.3 4246.6 4249.7 4267.9 4281.1 4283.3 4164.5 4231.8 4256.3 4276.5 4303.7 4219.1 4225.6 4228.9 4234.7 4245.3 4212.3 4229.8 4231.1 4236.7 4249.7 3690.5 3771.3 3776.9 3789.3 3805.9 5189.9 5201.4 5224.0 5233.7 5251.5 4858.2 4861.8 4882.2 4888.5 4913.5 5549.5 5586.8 5713.6 5731.3 5778.2 4104.2 4108.2 4110.4 4113.5 4135.3 5869.8 5882.6 5899.6 5941.4 5946.1 3884.0 4239.7 4241.2 4244.6 4250.8 4117.3 4136.6 4152.9 4161.2 4176.6 4774.7 4775.2 4792.8 4806.7 4815.8 5475.7 5720.5 5731.4 5788.7 5791.3 1417.6 1437.9 1438.6 1442.4 1443.1 888.6 912.2 919.4 932.2 932.8 4797.6 4821.6 4831.3 4841.7 4852.6 5044.9 5069.5 5130.7 5181.6 5196.6 4607.5 4836.7 4883.4 4888.0 4962.2 2742.7 2743.4 2745.7 2777.8 2782.9 5316.4 5385.0 5412.9 5435.8 5450.7 4919.7 5267.4 5275.0 5300.3 5304.8 5172.5 5195.3 5204.7 5229.2 5237.8 5019.3 5098.7 5129.6 5170.6 5237.1 4914.2 5094.5 5127.8 5154.8 5164.5 5271.0 5311.7 5317.7 5362.7 5408.8 3705.5 3932.6 4005.4 4033.6 4105.2 5803.4 5829.9 5840.4 5841.3 5877.4 5436.4 5696.7 5708.0 5721.7 5748.9 5547.3 5580.6 5583.3 5586.8 5606.0 5557.2 5603.8 5609.9 5663.4 5701.7 5526.8 5635.4 5641.7 5654.7 5660.9 5531.5 5574.7 5579.2 5595.4 5597.9 22:46:20 INFO - PROCESS | 27100 | 22:46:20 INFO - PROCESS | 27100 | [#5] yui.html Cycles:180 Average:15919.16 Median:4524.63 stddev:20356.62 (449.9%) stddev-sans-first:20381.51 22:46:20 INFO - PROCESS | 27100 | Values: 668.9 709.3 728.5 736.4 751.5 11823.8 12779.6 12783.4 12870.1 12883.4 11905.9 12251.4 12282.5 12462.1 12481.2 765.8 772.5 778.7 779.1 779.7 766.8 776.3 787.3 789.9 799.7 833.4 834.1 835.5 836.5 838.2 830.0 830.4 830.6 830.9 832.4 601.5 602.9 605.5 607.7 609.0 12422.6 12487.0 12581.1 12584.4 12587.7 13518.3 13605.0 13652.9 13663.8 13670.2 9889.5 10111.2 10149.5 10276.9 10464.7 3656.7 3684.8 3719.3 3734.1 3868.7 59825.7 60489.4 60830.0 60839.0 61228.4 10418.3 10561.0 10599.0 10627.3 10694.0 18606.7 18648.9 18679.9 18811.7 18887.8 7209.9 7434.2 7674.3 7682.6 7760.4 4524.0 4525.3 4607.9 4610.7 4628.0 3355.4 3426.1 3474.0 3477.4 3480.9 559.7 560.9 565.1 569.4 569.5 597.4 671.6 681.6 684.3 688.6 8403.2 8736.2 8991.4 9088.4 9151.8 630.3 650.1 651.4 652.7 656.1 4020.4 4263.9 4406.7 4421.7 4531.1 67712.0 69152.0 70606.3 76092.2 90260.5 42906.8 55201.4 65477.3 67450.0 68453.7 40327.8 55018.4 56013.0 61829.0 63537.7 8658.9 9063.7 9206.6 9258.4 9279.6 42682.4 42819.8 43907.0 43936.3 44237.8 56316.7 56363.0 58831.0 60280.7 61664.4 11492.9 11497.0 11579.8 11740.6 12047.9 11048.0 11156.6 13118.4 13318.3 13345.3 10431.5 10860.9 10927.5 12297.3 12839.4 11988.0 12207.5 12502.5 12660.2 13016.0 11828.9 11912.8 12146.9 12592.8 13417.1 10235.2 10310.2 10447.3 10631.7 10862.7 10329.3 10852.6 10854.3 10868.5 10916.5 22:46:20 INFO - PROCESS | 27100 | -------- Summary: end -------- 22:46:20 INFO - PROCESS | 27100 | 22:46:21 INFO - TEST-INFO | 27100: exit 0 22:46:21 INFO - TEST-OK | dromaeo_css | took 1115311ms 22:46:21 INFO - TEST-START | kraken 22:46:21 INFO - operating with platform_type : linux_ 22:46:21 INFO - Initialising browser for kraken test... 22:46:21 INFO - TEST-INFO | started process 27463 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXV6K4O/profile http://localhost:58027/getInfo.html) 22:46:25 INFO - PROCESS | 27463 | __metrics Screen width/height:1600/1200 22:46:25 INFO - PROCESS | 27463 | colorDepth:24 22:46:25 INFO - PROCESS | 27463 | Browser inner width/height: 1024/697 22:46:25 INFO - PROCESS | 27463 | __metrics 22:46:26 ERROR - PROCESS | 27463 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3158: TypeError: this.tabs is undefined 22:46:27 INFO - TEST-INFO | 27463: exit 0 22:46:27 INFO - Browser initialized. 22:46:27 INFO - Running cycle 1/1 for kraken test... 22:46:27 INFO - TEST-INFO | started process 27586 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXV6K4O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:46:39 INFO - PROCESS | 27586 | RSS: Main: 185761792 22:46:39 INFO - PROCESS | 27586 | 22:46:42 INFO - PROCESS | 27586 | Cycle 1(1): loaded http://localhost:58027/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58027/tests/kraken/driver.html?testName=audio-beat-detection) 22:46:43 INFO - PROCESS | 27586 | RSS: Main: 198389760 22:46:43 INFO - PROCESS | 27586 | 22:46:45 INFO - PROCESS | 27586 | Cycle 1(1): loaded http://localhost:58027/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58027/tests/kraken/driver.html?testName=audio-dft) 22:46:46 INFO - PROCESS | 27586 | RSS: Main: 196182016 22:46:46 INFO - PROCESS | 27586 | 22:46:49 INFO - PROCESS | 27586 | Cycle 1(1): loaded http://localhost:58027/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58027/tests/kraken/driver.html?testName=audio-fft) 22:46:50 INFO - PROCESS | 27586 | RSS: Main: 192839680 22:46:50 INFO - PROCESS | 27586 | 22:46:52 INFO - PROCESS | 27586 | Cycle 1(1): loaded http://localhost:58027/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58027/tests/kraken/driver.html?testName=audio-oscillator) 22:46:52 INFO - PROCESS | 27586 | RSS: Main: 193507328 22:46:52 INFO - PROCESS | 27586 | 22:46:54 INFO - PROCESS | 27586 | Cycle 1(1): loaded http://localhost:58027/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58027/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:46:55 INFO - PROCESS | 27586 | RSS: Main: 193794048 22:46:55 INFO - PROCESS | 27586 | 22:46:58 INFO - PROCESS | 27586 | Cycle 1(1): loaded http://localhost:58027/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58027/tests/kraken/driver.html?testName=imaging-darkroom) 22:46:59 INFO - PROCESS | 27586 | RSS: Main: 194187264 22:46:59 INFO - PROCESS | 27586 | 22:47:02 INFO - PROCESS | 27586 | Cycle 1(1): loaded http://localhost:58027/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58027/tests/kraken/driver.html?testName=imaging-desaturate) 22:47:03 INFO - PROCESS | 27586 | RSS: Main: 194015232 22:47:03 INFO - PROCESS | 27586 | 22:47:06 INFO - PROCESS | 27586 | Cycle 1(1): loaded http://localhost:58027/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58027/tests/kraken/driver.html?testName=json-parse-financial) 22:47:06 INFO - PROCESS | 27586 | RSS: Main: 194252800 22:47:06 INFO - PROCESS | 27586 | 22:47:08 INFO - PROCESS | 27586 | Cycle 1(1): loaded http://localhost:58027/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58027/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:47:08 INFO - PROCESS | 27586 | RSS: Main: 193847296 22:47:08 INFO - PROCESS | 27586 | 22:47:10 INFO - PROCESS | 27586 | Cycle 1(1): loaded http://localhost:58027/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58027/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:47:11 INFO - PROCESS | 27586 | RSS: Main: 193740800 22:47:11 INFO - PROCESS | 27586 | 22:47:13 INFO - PROCESS | 27586 | Cycle 1(1): loaded http://localhost:58027/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58027/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:47:13 INFO - PROCESS | 27586 | RSS: Main: 193884160 22:47:13 INFO - PROCESS | 27586 | 22:47:16 INFO - PROCESS | 27586 | Cycle 1(1): loaded http://localhost:58027/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58027/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:47:17 INFO - PROCESS | 27586 | RSS: Main: 193953792 22:47:17 INFO - PROCESS | 27586 | 22:47:20 INFO - PROCESS | 27586 | Cycle 1(1): loaded http://localhost:58027/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58027/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:47:20 INFO - PROCESS | 27586 | RSS: Main: 194846720 22:47:20 INFO - PROCESS | 27586 | 22:47:22 INFO - PROCESS | 27586 | Cycle 1(1): loaded http://localhost:58027/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58027/tests/kraken/driver.html?testName=ai-astar) 22:47:22 INFO - PROCESS | 27586 | RSS: Main: 195526656 22:47:22 INFO - PROCESS | 27586 | 22:47:22 INFO - PROCESS | 27586 | __start_tp_report 22:47:22 INFO - PROCESS | 27586 | _x_x_mozilla_page_load 22:47:22 INFO - PROCESS | 27586 | _x_x_mozilla_page_load_details 22:47:22 INFO - PROCESS | 27586 | |i|pagename|runs| 22:47:22 INFO - PROCESS | 27586 | |0;ai-astar;106;114;116;114;114;116;115;119;116;115 22:47:22 INFO - PROCESS | 27586 | |1;audio-beat-detection;162;127;129;156;127;135;126;124;157;125 22:47:22 INFO - PROCESS | 27586 | |2;audio-dft;164;164;163;176;163;165;163;163;164;164 22:47:22 INFO - PROCESS | 27586 | |3;audio-fft;77;77;76;111;87;77;76;77;113;75 22:47:22 INFO - PROCESS | 27586 | |4;audio-oscillator;84;83;112;84;84;83;97;84;83;105 22:47:22 INFO - PROCESS | 27586 | |5;imaging-gaussian-blur;119;118;118;118;117;118;118;118;117;119 22:47:22 INFO - PROCESS | 27586 | |6;imaging-darkroom;147;149;147;146;149;147;146;147;146;150 22:47:22 INFO - PROCESS | 27586 | |7;imaging-desaturate;86;85;86;86;85;84;85;86;90;85 22:47:22 INFO - PROCESS | 27586 | |8;json-parse-financial;52;52;52;53;55;57;56;53;57;53 22:47:22 INFO - PROCESS | 27586 | |9;json-stringify-tinderbox;62;63;62;64;62;62;62;62;62;62 22:47:22 INFO - PROCESS | 27586 | |10;stanford-crypto-aes;81;81;81;83;81;81;81;81;92;79 22:47:22 INFO - PROCESS | 27586 | |11;stanford-crypto-ccm;139;148;130;137;137;139;135;135;189;135 22:47:22 INFO - PROCESS | 27586 | |12;stanford-crypto-pbkdf2;171;167;169;164;167;165;174;164;168;166 22:47:22 INFO - PROCESS | 27586 | |13;stanford-crypto-sha256-iterative;66;66;66;66;66;64;65;64;66;65 22:47:22 INFO - PROCESS | 27586 | __end_tp_report 22:47:22 INFO - PROCESS | 27586 | __start_cc_report 22:47:22 INFO - PROCESS | 27586 | _x_x_mozilla_cycle_collect,806 22:47:22 INFO - PROCESS | 27586 | __end_cc_report 22:47:22 INFO - PROCESS | 27586 | __startTimestamp1478238442861__endTimestamp 22:47:22 INFO - PROCESS | 27586 | 22:47:22 INFO - PROCESS | 27586 | ------- Summary: start ------- 22:47:22 INFO - PROCESS | 27586 | Number of tests: 14 22:47:22 INFO - PROCESS | 27586 | 22:47:22 INFO - PROCESS | 27586 | [#0] ai-astar Cycles:10 Average:114.50 Median:115.50 stddev:3.34 (2.9%) stddev-sans-first:1.59 22:47:22 INFO - PROCESS | 27586 | Values: 106.0 114.0 116.0 114.0 114.0 116.0 115.0 119.0 116.0 115.0 22:47:22 INFO - PROCESS | 27586 | 22:47:22 INFO - PROCESS | 27586 | [#1] audio-beat-detection Cycles:10 Average:136.80 Median:132.00 stddev:15.23 (11.5%) stddev-sans-first:13.14 22:47:22 INFO - PROCESS | 27586 | Values: 162.0 127.0 129.0 156.0 127.0 135.0 126.0 124.0 157.0 125.0 22:47:22 INFO - PROCESS | 27586 | 22:47:22 INFO - PROCESS | 27586 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.00 stddev:3.96 (2.4%) stddev-sans-first:4.18 22:47:22 INFO - PROCESS | 27586 | Values: 164.0 164.0 163.0 176.0 163.0 165.0 163.0 163.0 164.0 164.0 22:47:22 INFO - PROCESS | 27586 | 22:47:22 INFO - PROCESS | 27586 | [#3] audio-fft Cycles:10 Average:84.60 Median:77.00 stddev:14.83 (19.3%) stddev-sans-first:15.48 22:47:22 INFO - PROCESS | 27586 | Values: 77.0 77.0 76.0 111.0 87.0 77.0 76.0 77.0 113.0 75.0 22:47:22 INFO - PROCESS | 27586 | 22:47:22 INFO - PROCESS | 27586 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:84.00 stddev:10.80 (12.9%) stddev-sans-first:11.24 22:47:22 INFO - PROCESS | 27586 | Values: 84.0 83.0 112.0 84.0 84.0 83.0 97.0 84.0 83.0 105.0 22:47:22 INFO - PROCESS | 27586 | 22:47:22 INFO - PROCESS | 27586 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 22:47:22 INFO - PROCESS | 27586 | Values: 119.0 118.0 118.0 118.0 117.0 118.0 118.0 118.0 117.0 119.0 22:47:22 INFO - PROCESS | 27586 | 22:47:22 INFO - PROCESS | 27586 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:1.43 (1.0%) stddev-sans-first:1.51 22:47:22 INFO - PROCESS | 27586 | Values: 147.0 149.0 147.0 146.0 149.0 147.0 146.0 147.0 146.0 150.0 22:47:22 INFO - PROCESS | 27586 | 22:47:22 INFO - PROCESS | 27586 | [#7] imaging-desaturate Cycles:10 Average:85.80 Median:86.00 stddev:1.62 (1.9%) stddev-sans-first:1.72 22:47:22 INFO - PROCESS | 27586 | Values: 86.0 85.0 86.0 86.0 85.0 84.0 85.0 86.0 90.0 85.0 22:47:22 INFO - PROCESS | 27586 | 22:47:22 INFO - PROCESS | 27586 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:2.05 (3.8%) stddev-sans-first:2.05 22:47:22 INFO - PROCESS | 27586 | Values: 52.0 52.0 52.0 53.0 55.0 57.0 56.0 53.0 57.0 53.0 22:47:22 INFO - PROCESS | 27586 | 22:47:22 INFO - PROCESS | 27586 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 22:47:22 INFO - PROCESS | 27586 | Values: 62.0 63.0 62.0 64.0 62.0 62.0 62.0 62.0 62.0 62.0 22:47:22 INFO - PROCESS | 27586 | 22:47:22 INFO - PROCESS | 27586 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:81.00 stddev:3.60 (4.4%) stddev-sans-first:3.80 22:47:22 INFO - PROCESS | 27586 | Values: 81.0 81.0 81.0 83.0 81.0 81.0 81.0 81.0 92.0 79.0 22:47:22 INFO - PROCESS | 27586 | 22:47:22 INFO - PROCESS | 27586 | [#11] stanford-crypto-ccm Cycles:10 Average:142.40 Median:138.00 stddev:17.00 (12.3%) stddev-sans-first:17.99 22:47:22 INFO - PROCESS | 27586 | Values: 139.0 148.0 130.0 137.0 137.0 139.0 135.0 135.0 189.0 135.0 22:47:22 INFO - PROCESS | 27586 | 22:47:22 INFO - PROCESS | 27586 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.50 Median:167.50 stddev:3.17 (1.9%) stddev-sans-first:3.10 22:47:22 INFO - PROCESS | 27586 | Values: 171.0 167.0 169.0 164.0 167.0 165.0 174.0 164.0 168.0 166.0 22:47:22 INFO - PROCESS | 27586 | 22:47:22 INFO - PROCESS | 27586 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:66.00 stddev:0.84 (1.3%) stddev-sans-first:0.87 22:47:22 INFO - PROCESS | 27586 | Values: 66.0 66.0 66.0 66.0 66.0 64.0 65.0 64.0 66.0 65.0 22:47:22 INFO - PROCESS | 27586 | -------- Summary: end -------- 22:47:22 INFO - PROCESS | 27586 | 22:47:24 INFO - TEST-INFO | 27586: exit 0 22:47:24 INFO - TEST-OK | kraken | took 62647ms 22:47:24 INFO - SUITE-END | took 1177s 22:47:24 INFO - Completed test suite (00:19:38) 22:47:24 INFO - javascript benchmark 22:47:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6946.724823663071, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3003.129092563157, 3014.9246268843285, 3049.5883055787463, 3053.1451193665766, 3064.770142239332, 5327.254184414175, 5467.507924286813, 5499.917501237484, 5510.531604813586, 5609.411011843759, 5372.0330340538785, 5441.2654291670615, 5472.835814925548, 5487.122060470316, 5544.417836127199, 4897.706137631753, 4929.827456039039, 4980.825671101512, 5063.569596584276, 5109.2591574221715, 4902.411710594733, 5012.298278241031, 5013.473585273548, 5055.266986286986, 5108.948910510903, 4902.48523904992, 4956.306117143603, 4958.925616115761, 4962.206047032493, 4999.875003124915, 4958.479359667255, 4964.578010869081, 4975.502449755032, 4984.800607975677, 5067.467915868818, 4920.4833492483485, 4935.605151587864, 4948.505149485059, 4956.529129732669, 4996.575291100261, 5215.843524694227, 5312.335958005249, 5400.594955378323, 5410.269613602152, 5439.945600543983, 5803.767849286023, 5817.098349755753, 5826.796062137805, 5828.6211396259105, 5835.5915085944, 5869.882602347929, 5873.236479257712, 5877.5591830612875, 5878.617889837147, 5880.382559831199, 5329.760160792774, 5383.67697938125, 5398.838034858961, 5425.294711687456, 5448.155535891903, 5933.6736479493175, 5965.105234214816, 5982.700864956735, 5987.730552125165, 5992.221011268507, 5692.800751973661, 5698.487136157766, 5730.684812335361, 5743.56923230751, 5744.454276843693, 5563.332400112013, 5619.297587801525, 5712.257406537206, 5729.341125770589, 5777.884442311214, 5645.068563686946, 5745.253117094751, 5750.827475175752, 5770.076787713946, 5792.333881603585, 5762.884742305214, 5765.221695071195, 5766.509846663081, 5767.22142510764, 5785.074388097884, 4423.756693381831, 4426.0483995940385, 4448.221561226773, 4454.398656181439, 4498.572635599613, 3958.6635136013188, 3970.9602903971168, 3983.980080099639, 4015.297322968469, 4064.7967601619803, 5585.860353491195, 5616.466435688685, 5618.634788738719, 5629.577781666391, 5630.380658127603, 5877.23595932526, 5882.588218824727, 5888.440598143169, 5908.911366329508, 5909.054551271776, 5478.890422191534, 5492.972535137299, 5522.392536820947, 5545.833624991256, 5565.833025009175, 5066.113430149709, 5068.974655126774, 5075.3402057733, 5076.13705670037, 5115.693058416507, 6033.276006879115, 6083.300420451705, 6090.390960903963, 6090.421409966046, 6102.206713127265, 5629.690367029689, 5689.6586204827845, 5774.960507108761, 5796.94203057964, 5895.616784908967, 6074.757009719739, 6089.519704738409, 6095.451409373178, 6096.6476373754385, 6100.641728746782, 5530.081978602266, 5753.309602847517, 5762.337331206965, 5764.365919748908, 5766.452187042224, 5748.39641837601, 5754.0, 5808.128780682931, 5828.883422331445, 5832.94167058324, 5694.715264236855, 5696.800611978727, 5701.657900525982, 5708.115242137475, 5711.885762284648, 5628.943710562842, 5656.915146272727, 5657.15142728594, 5663.093904975184, 5664.461876121762, 5525.254090697705, 5623.493885550321, 5653.604247702786, 5653.915191272216, 5657.8019769307875, 5672.0, 5730.312362516524, 5737.713114344349, 5748.597598168255, 5783.942160578508, 5545.833624991095, 5584.525315348241, 5590.9440905592055, 5612.7754889803955, 5621.269234999424], "value": 5366.876633533634, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.5023579250259, 566.5948846574698, 570.3896830391482, 577.2409281794442, 595.5265563876718, 40881.59118408815, 42740.14519709608, 42786.78606606967, 46398.768006159924, 46439.767801160946, 42961.570384296145, 43475.78262108685, 43547.56452435475, 43685.34471982923, 43861.7806910965, 8609.311255099592, 8644.956775216147, 8701.216890479856, 8774.824503509926, 8795.95602021989, 8618.56907154643, 8731.60707768152, 8769.56152192391, 8775.517346545937, 8789.0, 8786.86819697705, 8816.030236673962, 8817.0, 8835.955820220923, 8865.911340886572, 8742.082081381459, 8774.692885749031, 8785.736427907173, 8802.075782042857, 8812.823743525125, 8457.873131903027, 8550.615222315011, 8603.483790972561, 8633.827323453495, 8656.480611163288, 41563.1687366254, 41918.371224431656, 41928.0, 41930.37104443436, 41954.0, 3338.3990881641294, 3350.4961944304537, 3378.0, 3434.553508043938, 3513.0163554204864, 31101.688983110107, 31446.37107257842, 31671.36657266865, 31865.362692746246, 31885.202869928205, 4233.174530966463, 4250.213710463574, 4281.935770963438, 4297.03316753731, 4332.978335108304, 319108.0, 319872.0, 320167.0, 320494.0, 320913.0, 55924.72037639867, 56194.43805561892, 56314.0, 56413.71793141008, 56491.71754141203, 58142.0, 58427.0, 58431.70784146052, 58771.41228587745, 58778.41221587815, 15515.922420387826, 15757.842421575637, 15890.841091588936, 15950.840491595167, 16004.279807408695, 12314.13801033937, 12329.876701232874, 12347.876521234673, 12436.0, 12438.0, 16221.59446013859, 16860.156992150587, 16861.156942152844, 16884.915575422045, 16889.493315200565, 6241.7191226394925, 6319.652419116901, 6364.268109167412, 6371.23545174582, 6514.576552524166, 806.209914284005, 880.6301353431575, 986.6891929042472, 1018.3889666200221, 1105.519099191838, 29197.270068248465, 29200.707992920223, 29466.558001629994, 29509.85245073761, 30003.399932001674, 1051.673981065872, 1058.88352281249, 1104.127739086129, 1157.1841851494844, 1197.6227488341144, 15020.474283400246, 15434.450076482248, 15477.5356739298, 15579.221038948008, 15625.921870390575, 492324.0, 494715.0, 495928.0, 497190.0, 497326.0, 55512.72243638756, 55558.0, 55585.44414555802, 55800.0, 55851.441485585434, 1334.6396472952442, 1353.312224189077, 1362.611655678127, 1385.7367100251122, 1387.361813565751, 28451.28871778222, 28936.276593085342, 29114.41771164607, 29760.851195743882, 30881.69118308788, 48274.517254827006, 48741.0, 48840.755796220794, 48926.510734892196, 48960.75519622379, 399698.0, 401702.0, 402140.0, 402613.0, 403445.0, 27050.323741905824, 27243.455130897666, 27670.308242294104, 27793.305167370978, 27930.58104128399, 45507.54492455166, 45560.54439455563, 46017.30974035459, 46298.53701462942, 46648.0, 39194.41208381819, 39487.0, 40816.3877541843, 41048.589514104475, 41189.0, 38712.89349717128, 38927.0, 39250.80374598109, 40231.396529051504, 40439.1912161761, 37794.433083503216, 38657.42013869738, 38806.80596596999, 39680.2063958725, 39703.2059358817, 33890.8305458481, 36325.273494529436, 36536.63463365439, 36844.63155368519, 36952.445713313784, 27747.861260693568, 27869.0, 28161.71838281591, 28358.574621381107, 28445.573316400685], "value": 19322.306436867766, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.7500249835109, 388.5473423461667, 398.92688667484464, 406.6604385338242, 423.8770756480621, 14239.430422783102, 14770.630734231623, 17650.29398824047, 19166.52083697908, 19290.614187716255, 15739.527814165565, 18978.81021189788, 19074.904625476887, 19099.23603055876, 19572.608547829033, 5457.5633949283965, 5463.644863083897, 5703.429657034284, 5715.771369145229, 5742.770289188427, 5630.09918413054, 5791.0, 5796.217510636052, 5798.101294299369, 5821.621594596338, 5569.0, 5741.598088133832, 5787.276590426197, 5789.536837053047, 5804.187413762077, 5798.478136967651, 5817.912731309013, 5853.5317174625925, 5870.324912635059, 5888.823335299927, 5457.754401051962, 5583.357913839879, 5634.408387119375, 5660.29246344207, 5689.459501347365, 13074.673133171651, 13134.605961821066, 13290.136141150795, 13368.064235503518, 13459.0, 2139.6362618354915, 2141.1114387529315, 2225.221172589597, 2260.8417410781253, 2274.2494976657663, 9814.558344874498, 10132.696019119438, 10136.594536218543, 11825.822612660817, 13913.30433478322, 1869.6821540338176, 1962.8429725621916, 2014.597080583889, 2028.6855537391727, 2043.2133628552965, 80877.0, 82142.17857821405, 82403.0, 83652.58173709153, 83790.58104709498, 10654.0, 10964.890351096386, 11034.503447344889, 11110.666679999613, 11203.719907002227, 15417.0, 15502.84497155014, 15531.378744850079, 15572.766408503881, 15589.454369097253, 7733.7679869604, 7956.9602151988865, 8100.2304781045705, 8195.0, 8235.8352832943, 7605.23947605235, 7694.730684426018, 7783.532988020737, 7857.253560911704, 7909.288164065261, 4435.645148388121, 4472.530384309601, 4492.124035812985, 4560.68075234737, 4623.838165664186, 1838.9908050459662, 1869.8317151456433, 1978.1592823050435, 1992.4421162074643, 1999.0904138616895, 895.2032690905099, 930.7859192385654, 973.2603221551672, 998.5606333213362, 1016.8068067067234, 17695.46913592594, 18345.0, 18395.0, 19073.61852762937, 19129.33047343336, 922.0502882031384, 948.5968463403165, 950.8050849575959, 980.0738302304396, 991.8313886639289, 10103.545340459697, 10527.420991845522, 10532.894671053346, 10611.25721199524, 10654.307470014424, 395718.0, 413655.0, 419808.0, 422744.0, 424373.0, 89425.55287223522, 90558.54720726486, 91556.0, 92022.0, 92903.53548232216, 991.6628346362271, 992.9851052234222, 993.1756641987133, 993.3245393132739, 995.5216503492309, 16112.355505779638, 16510.33958641689, 16595.66808663844, 16769.580760481087, 17191.7421238679, 38290.0, 39123.80438097791, 40809.79595102005, 41822.79088604659, 41855.7907210462, 48880.75559622179, 50990.490095098576, 52423.47576524186, 52906.73546632396, 53962.0, 8096.919030809617, 8251.628676709683, 8325.7104296319, 8393.32853371741, 8507.234348908629, 9147.63409463614, 12230.143889927975, 13030.739385212053, 13060.934695326463, 13129.343532823512, 7685.116211635734, 9527.666531671359, 11516.769664606829, 11520.366379849189, 11844.822327664919, 10226.897731022893, 11028.834567481656, 11260.774784504429, 11281.266717663326, 11565.653030409101, 11978.281303121841, 12001.339926304137, 12038.819417708917, 12076.698082547655, 12352.135350525736, 7286.526375785557, 7545.471816972759, 7598.658060387406, 8013.3188678960605, 8681.175288347597, 10648.041676248866, 10947.616833410792, 11046.889531104585, 11248.550057997916, 11310.660680179608], "value": 8822.262909315863, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1434.139516290226, 1473.0793254216114, 1568.7097886890926, 1669.7161482547965, 1693.5596744846343, 7651.579163146025, 7905.762827115182, 7949.165337639552, 8426.115257897924, 8427.70503032394, 8190.05814331352, 8465.068842427328, 8466.661333546666, 8699.782505437368, 8711.215990560848, 2319.5708793873105, 2321.9883900580517, 2324.151684635113, 2329.1847853251397, 2348.753380895007, 2348.43637526994, 2354.4349356154485, 2397.976020239793, 2400.0759707512557, 2405.4106743847783, 2308.042162502568, 2309.3533810532995, 2315.073970411832, 2329.324495896188, 2363.2039649866056, 2222.843841473768, 2265.6714776357417, 2277.9202727904526, 2285.554316908212, 2291.472961218912, 2282.828787840902, 2298.885055747206, 2308.0536979838184, 2308.538292341522, 2314.2247347138727, 8569.914300856974, 8608.096149904233, 8679.435836670596, 8702.042775294713, 8709.869351959725, 5181.792728290864, 5359.0, 5360.839174824761, 5363.892722145535, 5370.785168593252, 3149.5748074010176, 3359.0195715496325, 3408.7273018158735, 3455.2225749206477, 3471.9100000999133, 1115.493013361232, 1138.584416687903, 1158.5250047480577, 1163.1218430085232, 1180.0323734537683, 11942.820857687142, 11952.521899124025, 11978.041756659446, 11989.22070065443, 12018.699532511757, 4394.846180383671, 4710.0, 4731.7634118293945, 4783.306420569068, 4810.4467986181335, 9569.808603827885, 9594.42433453981, 9595.616175353047, 9611.086946740048, 9634.325597208268, 5174.844754657366, 5193.818216362409, 5202.453742357074, 5214.634975551675, 5225.372955245395, 4306.246406878784, 4323.654107671442, 4818.445878723992, 4897.975510122498, 4914.803407863646, 3906.941395879064, 3968.1071758854027, 3986.60133986599, 3995.4805875236034, 4083.305838007546, 1305.2429590837291, 1312.6193403912948, 1333.4932725564224, 1339.71196192819, 1341.1751772659939, 952.2857856607544, 962.6438217859297, 974.4554880514464, 976.077606661712, 976.1946394224793, 5726.856828579235, 5864.560157988168, 5917.585768996215, 5917.733701983335, 5959.046552551571, 450.05263919449743, 450.7543388853083, 452.05746019549605, 457.71392879450343, 459.75862672096747, 3819.388897776342, 3821.299521712811, 3923.803809809498, 3951.8221680024467, 4068.2270368629866, 9779.755506112404, 10296.22778291631, 10369.274150809371, 10409.9479502602, 10492.790144197226, 10155.882852886176, 10342.069213770646, 10360.948195258976, 10441.425721585234, 10446.05985461297, 7863.882041769378, 8101.230383113595, 8116.797080073045, 8124.675012999532, 8145.3483721302155, 5569.972150139223, 5657.547396208376, 5763.8559036024435, 5786.189933409242, 5788.363280039276, 9574.856377154209, 9576.281778866474, 9671.468069255978, 9751.0, 9786.853197201905, 9670.323077384797, 9690.56392462355, 9711.077447642463, 9818.558164882741, 9849.606015759577, 6819.5908245505425, 7000.194977577644, 7075.363217310467, 7279.1265048194555, 7409.2590740927635, 7759.068911730628, 8043.155468675939, 8047.074586422402, 8049.758507244792, 8061.516309021477, 7200.315969982843, 7266.38235749946, 7385.409167266714, 7445.9255407445235, 7451.068616422947, 6698.196216454056, 7087.078679771596, 7165.7850264492145, 7221.097362829646, 7374.926250737424, 6284.780032698834, 6368.5860419072615, 6407.9038814418755, 6432.871342573028, 6446.935530644633, 4584.724916505021, 4631.606313463393, 4648.488666246778, 4736.218523943511, 4746.715197088186, 4645.419322584677, 4706.741129237787, 4764.118638051971, 4805.879853003703, 5037.546620804145], "value": 4424.521940942378, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.311864169997, 323.4113912678924, 329.95380646709464, 332.16791936199814, 339.1149100846791, 5282.31329927109, 5366.838994830152, 5436.401995780466, 5480.75336609852, 5501.339839219294, 5185.507376799207, 5325.763179464624, 5333.333333333324, 5360.758765855536, 5361.329833770778, 4246.554111818261, 4249.702520823544, 4267.893302667442, 4281.1437712457555, 4283.3146696528565, 4164.458620379346, 4231.809568569422, 4256.297710877717, 4276.465441819772, 4303.6772242081815, 4219.1139860629155, 4225.577442255781, 4228.936565951498, 4234.74591524508, 4245.341971994346, 4212.262854000553, 4229.767362795045, 4231.069164783758, 4236.745795252295, 4249.660027197848, 3690.538682664667, 3771.2834561433515, 3776.9055773605605, 3789.2800367930004, 3805.8858234253016, 5189.896202075975, 5201.427842937273, 5224.0, 5233.659812112239, 5251.501107394792, 4858.174110401205, 4861.829835955725, 4882.218844984785, 4888.462269150391, 4913.508649135094, 5549.500544950974, 5586.804461843816, 5713.628614140109, 5731.254936858223, 5778.248827652378, 4104.199681062194, 4108.219438306742, 4110.445089912853, 4113.547509773923, 4135.31767258402, 5869.8239052828485, 5882.588218824684, 5899.616524925866, 5941.405859414067, 5946.137810017566, 3883.9609205167512, 4239.745615263094, 4241.172971270573, 4244.596763307481, 4250.808713607895, 4117.341225403921, 4136.627703506699, 4152.937705934413, 4161.167766446722, 4176.561461046546, 4774.71351718891, 4775.21209000518, 4792.784324705397, 4806.687565308243, 4815.760671287868, 5475.72621368938, 5720.456556627197, 5731.398203188689, 5788.726480174355, 5791.305043394819, 1417.5818133650598, 1437.8634029767156, 1438.6259572511221, 1442.444658806346, 1443.141330908108, 888.644542183119, 912.2291663544295, 919.4253591505309, 932.1983094538691, 932.8320902237526, 4797.608693478852, 4821.614270858323, 4831.323614693945, 4841.661083724176, 4852.56326930578, 5044.890124172676, 5069.543741063322, 5130.7178105204575, 5181.611379146579, 5196.636235463557, 4607.470140933769, 4836.727399145127, 4883.389576302962, 4887.975560122177, 4962.203914005789, 2742.71092586484, 2743.4101668141448, 2745.670519537668, 2777.7916656250864, 2782.8590277985927, 5316.441773613792, 5385.0, 5412.945870541323, 5435.8256697321385, 5450.672959622435, 4919.698720758772, 5267.367915850046, 5275.0, 5300.337457817773, 5304.814331498379, 5172.5344718975475, 5195.298634684269, 5204.661696989683, 5229.215617657382, 5237.831112177078, 5019.297298378303, 5098.745062746922, 5129.563987061141, 5170.6380553360905, 5237.145755563303, 4914.238293064581, 5094.541491265655, 5127.820526281562, 5154.845354639367, 5164.535191832753, 5271.0, 5311.707856067954, 5317.707526086102, 5362.705051222064, 5408.78364865401, 3705.462707907392, 3932.5674175840063, 4005.4192142138645, 4033.616806403387, 4105.199486100301, 5803.390643982321, 5829.883402332014, 5840.415958404125, 5841.299044114563, 5877.441643043904, 5436.40199578054, 5696.686682232517, 5707.971460142673, 5721.742521586455, 5748.913766293425, 5547.306586676666, 5580.600341853042, 5583.302087239095, 5586.804461843816, 5605.971970140124, 5557.249771280825, 5603.8318850432925, 5609.915851262316, 5663.433656634304, 5701.714914254354, 5526.778928842962, 5635.380108188178, 5641.717914104196, 5654.7455364509515, 5660.858478537904, 5531.529819965348, 5574.721263936868, 5579.218909352613, 5595.384507704231, 5597.944020559905], "value": 4175.038489864691, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.8963210702341, 709.2623671381763, 728.4847517164299, 736.4255880413273, 751.4739682222446, 11823.822642660367, 12779.616611501646, 12783.424745886434, 12870.099093063489, 12883.420246088937, 11905.940470297657, 12251.387430628478, 12282.508699652026, 12462.065345099109, 12481.188722733015, 765.7855800375889, 772.5403384985924, 778.6885245901628, 779.07679399911, 779.7154038775834, 766.8006318357211, 776.343989329016, 787.3032366355787, 789.8736202207648, 799.6801279488222, 833.4332653795447, 834.1075049696827, 835.4778263585259, 836.5148214035875, 838.2162677896156, 829.9792505187388, 830.4145577367941, 830.6345208108413, 830.8629076202419, 832.3840358134967, 601.4737105033096, 602.9306629737592, 605.5004621187494, 607.7204485936475, 608.9878202435926, 12422.56521021769, 12487.0, 12581.056420768387, 12584.370781460982, 12587.74824503514, 13518.32408379587, 13605.0, 13652.86347136526, 13663.795043074262, 13670.17978921258, 9889.505524723807, 10111.191104711605, 10149.492525373702, 10276.94861525695, 10464.686059418229, 3656.670899619047, 3684.8157592120556, 3719.2933342664805, 3734.0851491384515, 3868.6905047596124, 59825.70087149536, 60489.395106049255, 60830.0, 60839.0, 61228.38771612316, 10418.270721049605, 10561.0, 10599.0, 10627.256092073636, 10694.0, 18606.720899186523, 18648.906755466134, 18679.90660046691, 18811.717824232648, 18887.811121888604, 7209.927900721031, 7434.219406962299, 7674.270944260286, 7682.577458239851, 7760.379169666413, 4523.954760452353, 4525.298578720303, 4607.9308810367875, 4610.74640894754, 4627.953720462752, 3355.3624811285777, 3426.0920855973186, 3474.0446377245953, 3477.443609022544, 3480.9303813924084, 559.7425184415215, 560.8681959739458, 565.0732798210937, 569.4476357932798, 569.5358282999342, 597.4191492751273, 671.6373158494456, 681.5944760180602, 684.3327755438407, 688.6419062087787, 8403.159684031549, 8736.213740763362, 8991.370604057653, 9088.40925339864, 9151.794626103017, 630.3255516597197, 650.0671536345266, 651.4072194303161, 652.6606164794375, 656.1142457682187, 4020.3969404589548, 4263.893402664896, 4406.669499787528, 4421.734695918255, 4531.093781243764, 67712.0, 69152.0, 70606.29393705998, 76092.23907760851, 90260.54869725609, 42906.78546607247, 55201.44798552043, 65477.34522654713, 67450.0, 68453.65773171202, 40327.798361008005, 55018.449815502136, 56013.0, 61829.0, 63537.68231158907, 8658.870116948377, 9063.68277110298, 9206.585703643219, 9258.35191536586, 9279.582418791306, 42682.35976460294, 42819.785901070296, 43907.0, 43936.34095488506, 44237.77881110574, 56316.71841640765, 56363.0, 58831.0, 60280.698596506736, 61664.38335616586, 11492.885071149181, 11497.0, 11579.768404631692, 11740.647780566596, 12047.879521204675, 11048.0, 11156.55373785072, 13118.409671564994, 13318.267495287851, 13345.332733363488, 10431.530581123716, 10860.891391085988, 10927.508262128382, 12297.262164270172, 12839.422226000039, 11988.0, 12207.45066471993, 12502.499900004263, 12660.17708848922, 13016.023798215361, 11828.881711182778, 11912.821307680219, 12146.878531214576, 12592.811107833206, 13417.127886687334, 10235.152021233695, 10310.175185985254, 10447.268691191544, 10631.681049568526, 10862.728431788952, 10329.276950613385, 10852.620158294421, 10854.34873907568, 10868.51091700891, 10916.508757106109], "value": 6648.87491586442, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1515.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 116.0, 114.0, 114.0, 116.0, 115.0, 119.0, 116.0, 115.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 127.0, 129.0, 156.0, 127.0, 135.0, 126.0, 124.0, 157.0, 125.0], "value": 136.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 163.0, 176.0, 163.0, 165.0, 163.0, 163.0, 164.0, 164.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 111.0, 87.0, 77.0, 76.0, 77.0, 113.0, 75.0], "value": 84.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 112.0, 84.0, 84.0, 83.0, 97.0, 84.0, 83.0, 105.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 117.0, 119.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 147.0, 146.0, 149.0, 147.0, 146.0, 147.0, 146.0, 150.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 86.0, 86.0, 85.0, 84.0, 85.0, 86.0, 90.0, 85.0], "value": 85.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 52.0, 53.0, 55.0, 57.0, 56.0, 53.0, 57.0, 53.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 64.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 81.0, 83.0, 81.0, 81.0, 81.0, 81.0, 92.0, 79.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 148.0, 130.0, 137.0, 137.0, 139.0, 135.0, 135.0, 189.0, 135.0], "value": 142.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 167.0, 169.0, 164.0, 167.0, 165.0, 174.0, 164.0, 168.0, 166.0], "value": 167.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 66.0, 64.0, 65.0, 64.0, 66.0, 65.0], "value": 65.4, "unit": "score"}]}]} 22:47:24 INFO - Return code: 0 22:47:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:47:24 ERROR - # TBPL SUCCESS # 22:47:24 INFO - Running post-action listener: _resource_record_post_action 22:47:24 INFO - [mozharness: 2016-11-04 05:47:24.694448Z] Finished run-tests step (success) 22:47:24 INFO - Running post-run listener: _resource_record_post_run 22:47:24 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393801728; Read time: 12; Write time: 305248 22:47:24 INFO - TinderboxPrint: CPU usage
13.4% 22:47:24 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 22:47:24 INFO - TinderboxPrint: I/O write bytes / time
393,801,728 / 305,248 22:47:24 INFO - TinderboxPrint: CPU idle
8,252.9 (86.5%) 22:47:24 INFO - TinderboxPrint: CPU user
1,220.1 (12.8%) 22:47:24 INFO - TinderboxPrint: Swap in / out
0 / 0 22:47:24 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 105467904; Read time: 0; Write time: 80812 22:47:24 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 288333824; Read time: 0; Write time: 224436 22:47:25 INFO - Running post-run listener: _upload_blobber_files 22:47:25 INFO - Blob upload gear active. 22:47:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:47:25 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:47:25 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:47:25 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:47:25 INFO - (blobuploader) - INFO - Open directory for files ... 22:47:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:47:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:47:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:47:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:47:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:47:29 INFO - (blobuploader) - INFO - Done attempting. 22:47:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:47:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:47:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:47:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:47:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:47:32 INFO - (blobuploader) - INFO - Done attempting. 22:47:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:47:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:47:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:47:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:47:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:47:33 INFO - (blobuploader) - INFO - Done attempting. 22:47:33 INFO - (blobuploader) - INFO - Iteration through files over. 22:47:33 INFO - Return code: 0 22:47:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:47:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:47:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd3397a78c5f6b46377adb574f1c38ab5a8d12016e65cb1e819c7d603f9775dfe422d2b22414f76a345f03925eeafd87d6a903ccd9998648d1d01a3173f35b75", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e46f8a86613e1f21426725ecb89ea70c9a117ce41f19450315c660fde2ef1e454ea356d83da42d211a14d1cda899d3f77a9bbe2fdac561a33198927a3406dbdb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/413edf81efaf99d1c75eb7e634b1c404c0312cd81fe9a1fd583f6763dd2a3427ed665c5184661c9eaa81563cacd6d5a7ac64000eee9feefbeb8bc102977d5fc0"} 22:47:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:47:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:47:33 INFO - Contents: 22:47:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd3397a78c5f6b46377adb574f1c38ab5a8d12016e65cb1e819c7d603f9775dfe422d2b22414f76a345f03925eeafd87d6a903ccd9998648d1d01a3173f35b75", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e46f8a86613e1f21426725ecb89ea70c9a117ce41f19450315c660fde2ef1e454ea356d83da42d211a14d1cda899d3f77a9bbe2fdac561a33198927a3406dbdb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/413edf81efaf99d1c75eb7e634b1c404c0312cd81fe9a1fd583f6763dd2a3427ed665c5184661c9eaa81563cacd6d5a7ac64000eee9feefbeb8bc102977d5fc0"} 22:47:33 INFO - Running post-run listener: copy_logs_to_upload_dir 22:47:33 INFO - Copying logs to upload dir... 22:47:33 INFO - mkdir: /builds/slave/test/build/upload/logs 22:47:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.961771 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-11-03 22:47:32.879926) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-03 22:47:32.883715) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1478237210.352212-1379509001 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd3397a78c5f6b46377adb574f1c38ab5a8d12016e65cb1e819c7d603f9775dfe422d2b22414f76a345f03925eeafd87d6a903ccd9998648d1d01a3173f35b75", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e46f8a86613e1f21426725ecb89ea70c9a117ce41f19450315c660fde2ef1e454ea356d83da42d211a14d1cda899d3f77a9bbe2fdac561a33198927a3406dbdb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/413edf81efaf99d1c75eb7e634b1c404c0312cd81fe9a1fd583f6763dd2a3427ed665c5184661c9eaa81563cacd6d5a7ac64000eee9feefbeb8bc102977d5fc0"} build_url:https://queue.taskcluster.net/v1/task/cYOYjmA-S368aTKo2xKKNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011343 build_url: 'https://queue.taskcluster.net/v1/task/cYOYjmA-S368aTKo2xKKNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd3397a78c5f6b46377adb574f1c38ab5a8d12016e65cb1e819c7d603f9775dfe422d2b22414f76a345f03925eeafd87d6a903ccd9998648d1d01a3173f35b75", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e46f8a86613e1f21426725ecb89ea70c9a117ce41f19450315c660fde2ef1e454ea356d83da42d211a14d1cda899d3f77a9bbe2fdac561a33198927a3406dbdb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/413edf81efaf99d1c75eb7e634b1c404c0312cd81fe9a1fd583f6763dd2a3427ed665c5184661c9eaa81563cacd6d5a7ac64000eee9feefbeb8bc102977d5fc0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-03 22:47:32.910034) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 22:47:32.910392) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1478237210.352212-1379509001 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 22:47:32.993479) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-03 22:47:32.993909) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-03 22:47:32.994266) ========= ========= Total master_lag: 0.17 =========