builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-041 starttime: 1476940492.58 results: success (0) buildid: 20161019193001 builduid: 951179c8af224085a9996653bfcd43a4 revision: 998ad5a74da80fe63664a8dcf30d8f269ffe4e65 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 22:14:52.576961) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 22:14:52.577588) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 22:14:52.577921) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 22:14:52.593799) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 22:14:52.594359) ========= 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-1476940283.656760-1317964367 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-19 22:14:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 32.7M=0s 2016-10-19 22:14:52 (32.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.092221 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 22:14:52.703182) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 22:14:52.703497) ========= 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-1476940283.656760-1317964367 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015863 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 22:14:52.758246) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 22:14:52.758614) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 998ad5a74da80fe63664a8dcf30d8f269ffe4e65 --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 998ad5a74da80fe63664a8dcf30d8f269ffe4e65 --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-1476940283.656760-1317964367 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-19 22:14:52,961 truncating revision to first 12 chars 2016-10-19 22:14:52,961 Setting DEBUG logging. 2016-10-19 22:14:52,961 attempt 1/10 2016-10-19 22:14:52,961 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/998ad5a74da8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-19 22:14:53,292 unpacking tar archive at: mozilla-central-998ad5a74da8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.651556 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 22:14:53.424784) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 22:14:53.425124) ========= script_repo_revision: 998ad5a74da80fe63664a8dcf30d8f269ffe4e65 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 22:14:53.425549) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 22:14:53.425876) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 22:14:53.436232) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-10-19 22:14:53.436557) ========= /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-1476940283.656760-1317964367 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:14:53 INFO - MultiFileLogger online at 20161019 22:14:53 in /builds/slave/test 22:14:53 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:14:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:14:53 INFO - {'append_to_log': False, 22:14:53 INFO - 'base_work_dir': '/builds/slave/test', 22:14:53 INFO - 'blob_upload_branch': 'Firefox', 22:14:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:14:53 INFO - 'branch': 'Firefox', 22:14:53 INFO - 'buildbot_json_path': 'buildprops.json', 22:14:53 INFO - 'config_files': ('talos/linux_config.py',), 22:14:53 INFO - 'default_actions': ('clobber', 22:14:53 INFO - 'read-buildbot-config', 22:14:53 INFO - 'download-and-extract', 22:14:53 INFO - 'populate-webroot', 22:14:53 INFO - 'create-virtualenv', 22:14:53 INFO - 'install', 22:14:53 INFO - 'run-tests'), 22:14:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:14:53 INFO - 'download_minidump_stackwalk': True, 22:14:53 INFO - 'download_symbols': 'ondemand', 22:14:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:14:53 INFO - 'tooltool.py': '/tools/tooltool.py', 22:14:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:14:53 INFO - '/tools/misc-python/virtualenv.py')}, 22:14:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:14:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:14:53 INFO - 'installer_path': 'installer.exe', 22:14:53 INFO - 'log_level': 'info', 22:14:53 INFO - 'log_name': 'talos', 22:14:53 INFO - 'log_to_console': True, 22:14:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:14:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:14:53 INFO - 'opt_config_files': (), 22:14:53 INFO - 'pip_index': False, 22:14:53 INFO - 'sps_profile': False, 22:14:53 INFO - 'sps_profile_interval': 0, 22:14:53 INFO - 'suite': 'dromaeojs-e10s', 22:14:53 INFO - 'system_bits': '32', 22:14:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:14:53 INFO - 'title': 'talos-linux64-ix-041', 22:14:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:14:53 INFO - 'use_talos_json': True, 22:14:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:14:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:14:53 INFO - 'work_dir': 'build'} 22:14:53 INFO - [mozharness: 2016-10-20 05:14:53.730647Z] Running clobber step. 22:14:53 INFO - Running pre-action listener: _resource_record_pre_action 22:14:53 INFO - Running main action method: clobber 22:14:53 INFO - rmtree: /builds/slave/test/build 22:14:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:14:54 INFO - Running post-action listener: _resource_record_post_action 22:14:54 INFO - [mozharness: 2016-10-20 05:14:54.700903Z] Finished clobber step (success) 22:14:54 INFO - [mozharness: 2016-10-20 05:14:54.701002Z] Running read-buildbot-config step. 22:14:54 INFO - Running pre-action listener: _resource_record_pre_action 22:14:54 INFO - Running main action method: read_buildbot_config 22:14:54 INFO - Using buildbot properties: 22:14:54 INFO - { 22:14:54 INFO - "project": "", 22:14:54 INFO - "product": "firefox", 22:14:54 INFO - "script_repo_revision": "production", 22:14:54 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 22:14:54 INFO - "repository": "", 22:14:54 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 22:14:54 INFO - "buildid": "20161019193001", 22:14:54 INFO - "pgo_build": "True", 22:14:54 INFO - "basedir": "/builds/slave/test", 22:14:54 INFO - "buildnumber": 199, 22:14:54 INFO - "slavename": "talos-linux64-ix-041", 22:14:54 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:14:54 INFO - "platform": "ubuntu64_hw", 22:14:54 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 22:14:54 INFO - "branch": "mozilla-central", 22:14:54 INFO - "repo_path": "mozilla-central", 22:14:54 INFO - "revision": "998ad5a74da80fe63664a8dcf30d8f269ffe4e65", 22:14:54 INFO - "stage_platform": "linux64-pgo", 22:14:54 INFO - "builduid": "951179c8af224085a9996653bfcd43a4", 22:14:54 INFO - "slavebuilddir": "test" 22:14:54 INFO - } 22:14:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/P8kw7l04T0Gj3BpiNWZcEA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 22:14:54 INFO - Running post-action listener: _resource_record_post_action 22:14:54 INFO - [mozharness: 2016-10-20 05:14:54.703419Z] Finished read-buildbot-config step (success) 22:14:54 INFO - [mozharness: 2016-10-20 05:14:54.703505Z] Running download-and-extract step. 22:14:54 INFO - Running pre-action listener: _resource_record_pre_action 22:14:54 INFO - Running main action method: download_and_extract 22:14:54 INFO - mkdir: /builds/slave/test/build/tests 22:14:54 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:14:54 INFO - trying https://queue.taskcluster.net/v1/task/P8kw7l04T0Gj3BpiNWZcEA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:14:54 INFO - Downloading https://queue.taskcluster.net/v1/task/P8kw7l04T0Gj3BpiNWZcEA/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:14:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P8kw7l04T0Gj3BpiNWZcEA/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:14:55 INFO - Downloaded 1361 bytes. 22:14:55 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:14:55 INFO - Using the following test package requirements: 22:14:55 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 22:14:55 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:14:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:14:55 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:14:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:14:55 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:14:55 INFO - u'jsshell-linux-x86_64.zip'], 22:14:55 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:14:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:14:55 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 22:14:55 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:14:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:14:55 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:14:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:14:55 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:14:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:14:55 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:14:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:14:55 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:14:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P8kw7l04T0Gj3BpiNWZcEA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 22:14:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P8kw7l04T0Gj3BpiNWZcEA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:14:55 INFO - Fetch https://queue.taskcluster.net/v1/task/P8kw7l04T0Gj3BpiNWZcEA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:14:55 INFO - Http code: 200 22:14:55 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 22:14:55 INFO - x-amz-cf-id: S4FqX8VXtPu6AcKA7tXOGT-BoF0JZsIAFHgf2WhZYQvhUzOomh70yA== 22:14:55 INFO - x-amz-version-id: IDW8OUyz7_sRd_Hfd0i16kI1RBpWCbu_ 22:14:56 INFO - Expected file size: 22115692 22:14:56 INFO - Obtained file size: 22115692 22:15:00 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:15:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P8kw7l04T0Gj3BpiNWZcEA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 22:15:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P8kw7l04T0Gj3BpiNWZcEA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:15:00 INFO - Fetch https://queue.taskcluster.net/v1/task/P8kw7l04T0Gj3BpiNWZcEA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:15:00 INFO - Http code: 200 22:15:00 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 22:15:00 INFO - x-amz-cf-id: 0ocUlNlGU4jCyKRsOF_Gqxn-4pVADY5HFTicpiUOfrmV1Vrq5AssvA== 22:15:00 INFO - x-amz-version-id: IDW8OUyz7_sRd_Hfd0i16kI1RBpWCbu_ 22:15:01 INFO - Expected file size: 22115692 22:15:01 INFO - Obtained file size: 22115692 22:15:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P8kw7l04T0Gj3BpiNWZcEA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 22:15:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P8kw7l04T0Gj3BpiNWZcEA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:15:05 INFO - Fetch https://queue.taskcluster.net/v1/task/P8kw7l04T0Gj3BpiNWZcEA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 22:15:06 INFO - Http code: 200 22:15:06 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 22:15:06 INFO - x-amz-cf-id: 4r_HYtcL6PZZVKrUiDx9doJ-3Qua8AaNYog6vrmxgdR8dz2UV1NUkg== 22:15:06 INFO - x-amz-version-id: s9o1KLXhn3FAMek.aU34iXwR9DEUkZti 22:15:06 INFO - Expected file size: 14409028 22:15:06 INFO - Obtained file size: 14409028 22:15:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:15:06 INFO - trying https://queue.taskcluster.net/v1/task/P8kw7l04T0Gj3BpiNWZcEA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:15:06 INFO - Downloading https://queue.taskcluster.net/v1/task/P8kw7l04T0Gj3BpiNWZcEA/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:15:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P8kw7l04T0Gj3BpiNWZcEA/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:15:08 INFO - Downloaded 59479693 bytes. 22:15:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P8kw7l04T0Gj3BpiNWZcEA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:15:08 INFO - mkdir: /builds/slave/test/properties 22:15:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:15:08 INFO - Writing to file /builds/slave/test/properties/build_url 22:15:08 INFO - Contents: 22:15:08 INFO - build_url:https://queue.taskcluster.net/v1/task/P8kw7l04T0Gj3BpiNWZcEA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:15:08 INFO - Running post-action listener: _resource_record_post_action 22:15:08 INFO - Running post-action listener: set_extra_try_arguments 22:15:08 INFO - [mozharness: 2016-10-20 05:15:08.983238Z] Finished download-and-extract step (success) 22:15:08 INFO - [mozharness: 2016-10-20 05:15:08.983463Z] Running populate-webroot step. 22:15:08 INFO - Running pre-action listener: _resource_record_pre_action 22:15:08 INFO - Running main action method: populate_webroot 22:15:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:15:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:15:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:15:08 INFO - '--tppagecycles', 22:15:08 INFO - '7'], 22:15:08 INFO - 'tests': ['tsvgm']}}, 22:15:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:15:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:15:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:15:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:15:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:15:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:15:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:15:08 INFO - 'talos_options': ['--disable-e10s'], 22:15:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:15:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:15:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:15:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:15:08 INFO - 'talos_options': ['--disable-e10s'], 22:15:08 INFO - 'tests': ['damp', 'tps']}, 22:15:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:15:08 INFO - 'tests': ['damp', 'tps']}, 22:15:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:15:08 INFO - 'tests': ['dromaeo_dom']}, 22:15:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:15:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:15:08 INFO - 'tests': ['basic_compositor_video']}, 22:15:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:15:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:15:08 INFO - 'tests': ['a11yr', 22:15:08 INFO - 'ts_paint', 22:15:08 INFO - 'tpaint', 22:15:08 INFO - 'sessionrestore', 22:15:08 INFO - 'sessionrestore_no_auto_restore', 22:15:08 INFO - 'tabpaint']}, 22:15:08 INFO - 'other-e10s': {'tests': ['a11yr', 22:15:08 INFO - 'ts_paint', 22:15:08 INFO - 'tpaint', 22:15:08 INFO - 'sessionrestore', 22:15:08 INFO - 'sessionrestore_no_auto_restore', 22:15:08 INFO - 'tabpaint']}, 22:15:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:15:08 INFO - 'ts_paint', 22:15:08 INFO - 'tpaint', 22:15:08 INFO - 'sessionrestore', 22:15:08 INFO - 'sessionrestore_no_auto_restore', 22:15:08 INFO - 'tabpaint']}, 22:15:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:15:08 INFO - 'ts_paint', 22:15:08 INFO - 'tpaint', 22:15:08 INFO - 'sessionrestore', 22:15:08 INFO - 'sessionrestore_no_auto_restore', 22:15:08 INFO - 'tabpaint']}, 22:15:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:15:08 INFO - 'tests': ['a11yr', 22:15:08 INFO - 'ts_paint', 22:15:08 INFO - 'tpaint', 22:15:08 INFO - 'sessionrestore', 22:15:08 INFO - 'sessionrestore_no_auto_restore', 22:15:08 INFO - 'tabpaint']}, 22:15:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:15:08 INFO - 'tests': ['a11yr', 22:15:08 INFO - 'ts_paint', 22:15:08 INFO - 'tpaint', 22:15:08 INFO - 'sessionrestore', 22:15:08 INFO - 'sessionrestore_no_auto_restore', 22:15:08 INFO - 'tabpaint']}, 22:15:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:15:08 INFO - 'tests': ['tsvgx', 22:15:08 INFO - 'tsvgr_opacity', 22:15:08 INFO - 'tart', 22:15:08 INFO - 'tscrollx', 22:15:08 INFO - 'cart']}, 22:15:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:15:08 INFO - 'tsvgr_opacity', 22:15:08 INFO - 'tart', 22:15:08 INFO - 'tscrollx', 22:15:08 INFO - 'cart']}, 22:15:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:15:08 INFO - 'talos_options': ['--disable-e10s'], 22:15:08 INFO - 'tests': ['tp5o']}, 22:15:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:15:08 INFO - 'tests': ['tp5o']}, 22:15:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:15:08 INFO - 'talos_options': ['--disable-e10s', 22:15:08 INFO - '--xperf_path', 22:15:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:15:08 INFO - 'tests': ['tp5n']}, 22:15:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:15:09 INFO - 'talos_options': ['--xperf_path', 22:15:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:15:09 INFO - 'tests': ['tp5n']}}, 22:15:09 INFO - 'talos.zip': {'path': '', 22:15:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:15:09 INFO - Running post-action listener: _resource_record_post_action 22:15:09 INFO - [mozharness: 2016-10-20 05:15:09.000483Z] Finished populate-webroot step (success) 22:15:09 INFO - [mozharness: 2016-10-20 05:15:09.000571Z] Running create-virtualenv step. 22:15:09 INFO - Running pre-action listener: _resource_record_pre_action 22:15:09 INFO - Running main action method: create_virtualenv 22:15:09 INFO - Creating virtualenv /builds/slave/test/build/venv 22:15:09 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:15:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:15:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:15:09 INFO - Using real prefix '/usr' 22:15:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:15:09 INFO - Installing distribute.............................................................................................................................................................................................done. 22:15:11 INFO - Installing pip.................done. 22:15:11 INFO - Return code: 0 22:15:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:15:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:15:11 INFO - Reading from file tmpfile_stdout 22:15:11 INFO - Output received: 22:15:11 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:15:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:15:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:15:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:15:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:15:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85a42c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b57b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1444790>, '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 0x1445690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1445b20>, '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-1476940283.656760-1317964367', '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:15:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:15:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:15:11 INFO - Using env: {'DISPLAY': ':0', 22:15:11 INFO - 'HOME': '/home/cltbld', 22:15:11 INFO - 'LANG': 'en_US.UTF-8', 22:15:11 INFO - 'LANGUAGE': 'en_US:en', 22:15:11 INFO - 'LOGNAME': 'cltbld', 22:15:11 INFO - 'MAIL': '/var/mail/cltbld', 22:15:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:11 INFO - 'MOZ_NO_REMOTE': '1', 22:15:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:15:11 INFO - 'NO_EM_RESTART': '1', 22:15:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:15:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:15:11 INFO - 'PWD': '/builds/slave/test', 22:15:11 INFO - 'SHELL': '/bin/bash', 22:15:11 INFO - 'SHLVL': '1', 22:15:11 INFO - 'TERM': 'linux', 22:15:11 INFO - 'TMOUT': '86400', 22:15:11 INFO - 'USER': 'cltbld', 22:15:11 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476940283.656760-1317964367', 22:15:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:11 INFO - '_': '/tools/buildbot/bin/python'} 22:15:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:15:11 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:15:11 INFO - Cleaning up... 22:15:12 INFO - Return code: 0 22:15:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:15: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:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:15:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15: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:15:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:15:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15: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', '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 0x7f85a42c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b57b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1444790>, '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 0x1445690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1445b20>, '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-1476940283.656760-1317964367', '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:15: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', 'psutil>=3.1.1'] in /builds/slave/test/build 22:15: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 psutil>=3.1.1 22:15:12 INFO - Using env: {'DISPLAY': ':0', 22:15:12 INFO - 'HOME': '/home/cltbld', 22:15:12 INFO - 'LANG': 'en_US.UTF-8', 22:15:12 INFO - 'LANGUAGE': 'en_US:en', 22:15:12 INFO - 'LOGNAME': 'cltbld', 22:15:12 INFO - 'MAIL': '/var/mail/cltbld', 22:15:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:12 INFO - 'MOZ_NO_REMOTE': '1', 22:15:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:15:12 INFO - 'NO_EM_RESTART': '1', 22:15:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:15:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:15:12 INFO - 'PWD': '/builds/slave/test', 22:15:12 INFO - 'SHELL': '/bin/bash', 22:15:12 INFO - 'SHLVL': '1', 22:15:12 INFO - 'TERM': 'linux', 22:15:12 INFO - 'TMOUT': '86400', 22:15:12 INFO - 'USER': 'cltbld', 22:15:12 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476940283.656760-1317964367', 22:15:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:12 INFO - '_': '/tools/buildbot/bin/python'} 22:15:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:15:12 INFO - Downloading/unpacking psutil>=3.1.1 22:15: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:15: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:15: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:15: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:15: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:15: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:15:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:15:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:15:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:15:14 INFO - Installing collected packages: psutil 22:15:14 INFO - Running setup.py install for psutil 22:15:14 INFO - building 'psutil._psutil_linux' extension 22:15:14 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:15:14 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:15:14 INFO - building 'psutil._psutil_posix' extension 22:15:14 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:15:14 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:15:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:15:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:15:14 INFO - Successfully installed psutil 22:15:14 INFO - Cleaning up... 22:15:14 INFO - Return code: 0 22:15:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:15: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:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:15:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15: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:15:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:15:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85a42c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b57b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1444790>, '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 0x1445690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1445b20>, '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-1476940283.656760-1317964367', '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:15: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:15: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 mozsystemmonitor==0.3 22:15:14 INFO - Using env: {'DISPLAY': ':0', 22:15:14 INFO - 'HOME': '/home/cltbld', 22:15:14 INFO - 'LANG': 'en_US.UTF-8', 22:15:14 INFO - 'LANGUAGE': 'en_US:en', 22:15:14 INFO - 'LOGNAME': 'cltbld', 22:15:14 INFO - 'MAIL': '/var/mail/cltbld', 22:15:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:14 INFO - 'MOZ_NO_REMOTE': '1', 22:15:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:15:14 INFO - 'NO_EM_RESTART': '1', 22:15:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:15:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:15:14 INFO - 'PWD': '/builds/slave/test', 22:15:14 INFO - 'SHELL': '/bin/bash', 22:15:14 INFO - 'SHLVL': '1', 22:15:14 INFO - 'TERM': 'linux', 22:15:14 INFO - 'TMOUT': '86400', 22:15:14 INFO - 'USER': 'cltbld', 22:15:14 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476940283.656760-1317964367', 22:15:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:14 INFO - '_': '/tools/buildbot/bin/python'} 22:15:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:15:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:15:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:15:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:15:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:15:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:15:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:15:17 INFO - Installing collected packages: mozsystemmonitor 22:15:17 INFO - Running setup.py install for mozsystemmonitor 22:15:17 INFO - Successfully installed mozsystemmonitor 22:15:17 INFO - Cleaning up... 22:15:17 INFO - Return code: 0 22:15:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:15: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:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:15:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15: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:15:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:15:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15: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', '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 0x7f85a42c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b57b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1444790>, '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 0x1445690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1445b20>, '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-1476940283.656760-1317964367', '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:15: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 22:15: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 jsonschema==2.5.1 22:15:17 INFO - Using env: {'DISPLAY': ':0', 22:15:17 INFO - 'HOME': '/home/cltbld', 22:15:17 INFO - 'LANG': 'en_US.UTF-8', 22:15:17 INFO - 'LANGUAGE': 'en_US:en', 22:15:17 INFO - 'LOGNAME': 'cltbld', 22:15:17 INFO - 'MAIL': '/var/mail/cltbld', 22:15:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:17 INFO - 'MOZ_NO_REMOTE': '1', 22:15:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:15:17 INFO - 'NO_EM_RESTART': '1', 22:15:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:15:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:15:17 INFO - 'PWD': '/builds/slave/test', 22:15:17 INFO - 'SHELL': '/bin/bash', 22:15:17 INFO - 'SHLVL': '1', 22:15:17 INFO - 'TERM': 'linux', 22:15:17 INFO - 'TMOUT': '86400', 22:15:17 INFO - 'USER': 'cltbld', 22:15:17 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476940283.656760-1317964367', 22:15:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:17 INFO - '_': '/tools/buildbot/bin/python'} 22:15:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:15:17 INFO - Downloading/unpacking jsonschema==2.5.1 22:15: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:15: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:15: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:15: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:15: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:15: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:15:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:15:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:15: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:15: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:15: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:15: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:15: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:15: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:15:19 INFO - Downloading functools32-3.2.3-2.tar.gz 22:15:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:15:19 INFO - warning: no files found matching '*.txt' 22:15:19 INFO - no previously-included directories found matching 'build' 22:15:19 INFO - no previously-included directories found matching 'dist' 22:15:19 INFO - no previously-included directories found matching '.git*' 22:15:19 INFO - Installing collected packages: jsonschema, functools32 22:15:19 INFO - Running setup.py install for functools32 22:15:19 INFO - warning: no files found matching '*.txt' 22:15:19 INFO - no previously-included directories found matching 'build' 22:15:19 INFO - no previously-included directories found matching 'dist' 22:15:19 INFO - no previously-included directories found matching '.git*' 22:15:19 INFO - Successfully installed jsonschema functools32 22:15:19 INFO - Cleaning up... 22:15:19 INFO - Return code: 0 22:15:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:15:19 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:15:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:15:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:19 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:15:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:15:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:19 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 0x7f85a42c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b57b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1444790>, '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 0x1445690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1445b20>, '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-1476940283.656760-1317964367', '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:15:19 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:15:19 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:15:19 INFO - Using env: {'DISPLAY': ':0', 22:15:19 INFO - 'HOME': '/home/cltbld', 22:15:19 INFO - 'LANG': 'en_US.UTF-8', 22:15:19 INFO - 'LANGUAGE': 'en_US:en', 22:15:19 INFO - 'LOGNAME': 'cltbld', 22:15:19 INFO - 'MAIL': '/var/mail/cltbld', 22:15:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:19 INFO - 'MOZ_NO_REMOTE': '1', 22:15:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:15:19 INFO - 'NO_EM_RESTART': '1', 22:15:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:15:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:15:19 INFO - 'PWD': '/builds/slave/test', 22:15:19 INFO - 'SHELL': '/bin/bash', 22:15:19 INFO - 'SHLVL': '1', 22:15:19 INFO - 'TERM': 'linux', 22:15:19 INFO - 'TMOUT': '86400', 22:15:19 INFO - 'USER': 'cltbld', 22:15:19 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476940283.656760-1317964367', 22:15:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:19 INFO - '_': '/tools/buildbot/bin/python'} 22:15:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:15:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:15:20 INFO - Cleaning up... 22:15:20 INFO - Return code: 0 22:15:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:15: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:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:15:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15: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:15:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:15:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f85a42c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b57b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1444790>, '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 0x1445690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1445b20>, '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-1476940283.656760-1317964367', '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:15:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:15:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:15:20 INFO - Using env: {'DISPLAY': ':0', 22:15:20 INFO - 'HOME': '/home/cltbld', 22:15:20 INFO - 'LANG': 'en_US.UTF-8', 22:15:20 INFO - 'LANGUAGE': 'en_US:en', 22:15:20 INFO - 'LOGNAME': 'cltbld', 22:15:20 INFO - 'MAIL': '/var/mail/cltbld', 22:15:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:20 INFO - 'MOZ_NO_REMOTE': '1', 22:15:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:15:20 INFO - 'NO_EM_RESTART': '1', 22:15:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:15:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:15:20 INFO - 'PWD': '/builds/slave/test', 22:15:20 INFO - 'SHELL': '/bin/bash', 22:15:20 INFO - 'SHLVL': '1', 22:15:20 INFO - 'TERM': 'linux', 22:15:20 INFO - 'TMOUT': '86400', 22:15:20 INFO - 'USER': 'cltbld', 22:15:20 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476940283.656760-1317964367', 22:15:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:20 INFO - '_': '/tools/buildbot/bin/python'} 22:15:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:15:20 INFO - Downloading/unpacking blobuploader==1.2.4 22:15: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:15: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:15: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:15: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:15: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:15: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:15:22 INFO - Downloading blobuploader-1.2.4.tar.gz 22:15:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:15:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:15:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:15:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:15:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:15:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:15:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:15:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:15:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:15:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:15:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:15:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:15:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:15:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:15:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:15:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:15:22 INFO - Downloading docopt-0.6.1.tar.gz 22:15:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:15:23 INFO - Installing collected packages: blobuploader, requests, docopt 22:15:23 INFO - Running setup.py install for blobuploader 22:15:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:15:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:15:23 INFO - Running setup.py install for requests 22:15:23 INFO - Running setup.py install for docopt 22:15:23 INFO - Successfully installed blobuploader requests docopt 22:15:23 INFO - Cleaning up... 22:15:23 INFO - Return code: 0 22:15:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:15:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:15:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:15:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:15:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:15:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:23 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 0x7f85a42c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b57b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1444790>, '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 0x1445690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1445b20>, '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-1476940283.656760-1317964367', '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:15:23 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:15:23 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:15:23 INFO - Using env: {'DISPLAY': ':0', 22:15:23 INFO - 'HOME': '/home/cltbld', 22:15:23 INFO - 'LANG': 'en_US.UTF-8', 22:15:23 INFO - 'LANGUAGE': 'en_US:en', 22:15:23 INFO - 'LOGNAME': 'cltbld', 22:15:23 INFO - 'MAIL': '/var/mail/cltbld', 22:15:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:23 INFO - 'MOZ_NO_REMOTE': '1', 22:15:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:15:23 INFO - 'NO_EM_RESTART': '1', 22:15:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:15:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:15:23 INFO - 'PWD': '/builds/slave/test', 22:15:23 INFO - 'SHELL': '/bin/bash', 22:15:23 INFO - 'SHLVL': '1', 22:15:23 INFO - 'TERM': 'linux', 22:15:23 INFO - 'TMOUT': '86400', 22:15:23 INFO - 'USER': 'cltbld', 22:15:23 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476940283.656760-1317964367', 22:15:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:23 INFO - '_': '/tools/buildbot/bin/python'} 22:15:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:15:23 INFO - Running setup.py (path:/tmp/pip-How8EG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:15:23 INFO - Running setup.py (path:/tmp/pip-wF5wHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:15:24 INFO - Running setup.py (path:/tmp/pip-K3s3Cb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:15:24 INFO - Running setup.py (path:/tmp/pip-rs_lTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:15:24 INFO - Running setup.py (path:/tmp/pip-mYt7ZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:15:24 INFO - Running setup.py (path:/tmp/pip-0RrdDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:15:24 INFO - Running setup.py (path:/tmp/pip-g7IfwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:15:24 INFO - Running setup.py (path:/tmp/pip-ztR7PG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:15:24 INFO - Running setup.py (path:/tmp/pip-6Oa_LS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:15:24 INFO - Running setup.py (path:/tmp/pip-hux3ck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:15:24 INFO - Running setup.py (path:/tmp/pip-Z5jTkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:15:24 INFO - Running setup.py (path:/tmp/pip-JFIzQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:15:24 INFO - Running setup.py (path:/tmp/pip-eMQ0nb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:15:24 INFO - Running setup.py (path:/tmp/pip-vRl9hh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:15:24 INFO - Running setup.py (path:/tmp/pip-dlDrwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:15:24 INFO - Running setup.py (path:/tmp/pip-iISb3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:15:25 INFO - Running setup.py (path:/tmp/pip-KUwyCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:15:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:15:25 INFO - Running setup.py install for manifestparser 22:15:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:15:25 INFO - Running setup.py install for mozcrash 22:15:25 INFO - Running setup.py install for mozdebug 22:15:25 INFO - Running setup.py install for mozdevice 22:15:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:15:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:15:25 INFO - Running setup.py install for mozfile 22:15:25 INFO - Running setup.py install for mozhttpd 22:15:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:15:25 INFO - Running setup.py install for mozinfo 22:15:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:15:25 INFO - Running setup.py install for mozInstall 22:15:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:15:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:15:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:15:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:15:25 INFO - Running setup.py install for mozleak 22:15:25 INFO - Running setup.py install for mozlog 22:15:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:15:26 INFO - Running setup.py install for moznetwork 22:15:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:15:26 INFO - Running setup.py install for mozprocess 22:15:26 INFO - Running setup.py install for mozprofile 22:15:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:15:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:15:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:15:26 INFO - Running setup.py install for mozrunner 22:15:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:15:26 INFO - Running setup.py install for mozscreenshot 22:15:26 INFO - Running setup.py install for moztest 22:15:26 INFO - Running setup.py install for mozversion 22:15:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:15:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:15:26 INFO - Cleaning up... 22:15:26 INFO - Return code: 0 22:15:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:15:26 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:15:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:15:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:26 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:15:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:15:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:26 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 0x7f85a42c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b57b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1444790>, '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 0x1445690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1445b20>, '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-1476940283.656760-1317964367', '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:15:26 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:15:26 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:15:26 INFO - Using env: {'DISPLAY': ':0', 22:15:26 INFO - 'HOME': '/home/cltbld', 22:15:26 INFO - 'LANG': 'en_US.UTF-8', 22:15:26 INFO - 'LANGUAGE': 'en_US:en', 22:15:26 INFO - 'LOGNAME': 'cltbld', 22:15:26 INFO - 'MAIL': '/var/mail/cltbld', 22:15:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:26 INFO - 'MOZ_NO_REMOTE': '1', 22:15:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:15:26 INFO - 'NO_EM_RESTART': '1', 22:15:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:15:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:15:26 INFO - 'PWD': '/builds/slave/test', 22:15:26 INFO - 'SHELL': '/bin/bash', 22:15:26 INFO - 'SHLVL': '1', 22:15:26 INFO - 'TERM': 'linux', 22:15:26 INFO - 'TMOUT': '86400', 22:15:26 INFO - 'USER': 'cltbld', 22:15:26 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476940283.656760-1317964367', 22:15:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:26 INFO - '_': '/tools/buildbot/bin/python'} 22:15:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:15:27 INFO - Running setup.py (path:/tmp/pip-H3nc0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:15:27 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:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:15:27 INFO - Running setup.py (path:/tmp/pip-YzoUa4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:15:27 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:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:15:27 INFO - Running setup.py (path:/tmp/pip-whu_nl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:15:27 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:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:15:27 INFO - Running setup.py (path:/tmp/pip-2lb9t8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:15:27 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:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:15:27 INFO - Running setup.py (path:/tmp/pip-E91_hG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:15:27 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:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:15:27 INFO - Running setup.py (path:/tmp/pip-zMgmfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:15:27 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:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:15:27 INFO - Running setup.py (path:/tmp/pip-iVj6Zs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:15:27 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:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:15:27 INFO - Running setup.py (path:/tmp/pip-raxMGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:15:27 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:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:15:27 INFO - Running setup.py (path:/tmp/pip-Ivh56O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:15:27 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:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:15:27 INFO - Running setup.py (path:/tmp/pip-aO60pt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:15:27 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:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:15:27 INFO - Running setup.py (path:/tmp/pip-wPZFfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:15:27 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:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:15:27 INFO - Running setup.py (path:/tmp/pip-cLXvsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:15:28 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:15:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:15:28 INFO - Running setup.py (path:/tmp/pip-a7bd7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:15:28 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:15:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:15:28 INFO - Running setup.py (path:/tmp/pip-juRWLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:15:28 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:15:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:15:28 INFO - Running setup.py (path:/tmp/pip-WT1ChJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:15:28 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:15:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:15:28 INFO - Running setup.py (path:/tmp/pip-VI_fBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:15:28 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:15:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:15:28 INFO - Running setup.py (path:/tmp/pip-9j2PJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:15:28 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:15:28 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:15:28 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:15:28 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:15:28 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:15:28 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:15:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:15:28 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:15:28 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:15:28 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:15:28 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:15:28 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:15:28 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:15:30 INFO - Downloading blessings-1.6.tar.gz 22:15:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:15:30 INFO - Installing collected packages: blessings 22:15:30 INFO - Running setup.py install for blessings 22:15:30 INFO - Successfully installed blessings 22:15:30 INFO - Cleaning up... 22:15:30 INFO - Return code: 0 22:15:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:15:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:15:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:15:30 INFO - Reading from file tmpfile_stdout 22:15:30 INFO - Current package versions: 22:15:30 INFO - argparse == 1.2.1 22:15:30 INFO - blessings == 1.6 22:15:30 INFO - blobuploader == 1.2.4 22:15:30 INFO - docopt == 0.6.1 22:15:30 INFO - functools32 == 3.2.3-2 22:15:30 INFO - jsonschema == 2.5.1 22:15:30 INFO - manifestparser == 1.1 22:15:30 INFO - mozInstall == 1.12 22:15:30 INFO - mozcrash == 0.17 22:15:30 INFO - mozdebug == 0.1 22:15:30 INFO - mozdevice == 0.48 22:15:30 INFO - mozfile == 1.2 22:15:30 INFO - mozhttpd == 0.7 22:15:30 INFO - mozinfo == 0.9 22:15:30 INFO - mozleak == 0.1 22:15:30 INFO - mozlog == 3.4 22:15:30 INFO - moznetwork == 0.27 22:15:30 INFO - mozprocess == 0.23 22:15:30 INFO - mozprofile == 0.28 22:15:30 INFO - mozrunner == 6.12 22:15:30 INFO - mozscreenshot == 0.1 22:15:30 INFO - mozsystemmonitor == 0.3 22:15:30 INFO - moztest == 0.7 22:15:30 INFO - mozversion == 1.4 22:15:30 INFO - psutil == 3.1.1 22:15:30 INFO - requests == 1.2.3 22:15:30 INFO - wsgiref == 0.1.2 22:15:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:15:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:15:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:15:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:15:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:30 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 0x7f85a42c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b57b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1444790>, '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 0x1445690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1445b20>, '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-1476940283.656760-1317964367', '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:15:30 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:15:30 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:15:30 INFO - Using env: {'DISPLAY': ':0', 22:15:30 INFO - 'HOME': '/home/cltbld', 22:15:30 INFO - 'LANG': 'en_US.UTF-8', 22:15:30 INFO - 'LANGUAGE': 'en_US:en', 22:15:30 INFO - 'LOGNAME': 'cltbld', 22:15:30 INFO - 'MAIL': '/var/mail/cltbld', 22:15:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:30 INFO - 'MOZ_NO_REMOTE': '1', 22:15:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:15:30 INFO - 'NO_EM_RESTART': '1', 22:15:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:15:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:15:30 INFO - 'PWD': '/builds/slave/test', 22:15:30 INFO - 'SHELL': '/bin/bash', 22:15:30 INFO - 'SHLVL': '1', 22:15:30 INFO - 'TERM': 'linux', 22:15:30 INFO - 'TMOUT': '86400', 22:15:30 INFO - 'USER': 'cltbld', 22:15:30 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476940283.656760-1317964367', 22:15:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:30 INFO - '_': '/tools/buildbot/bin/python'} 22:15:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:15:30 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:15:30 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:15:30 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:15:30 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:15:30 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:15:30 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:15:30 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:15:30 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:15:30 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:15:30 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:15:30 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:15:30 INFO - Cleaning up... 22:15:30 INFO - Return code: 0 22:15:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:15:31 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:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:15:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:31 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:15:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:15:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:31 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 0x7f85a42c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b57b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1444790>, '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 0x1445690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1445b20>, '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-1476940283.656760-1317964367', '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:15:31 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:15:31 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:15:31 INFO - Using env: {'DISPLAY': ':0', 22:15:31 INFO - 'HOME': '/home/cltbld', 22:15:31 INFO - 'LANG': 'en_US.UTF-8', 22:15:31 INFO - 'LANGUAGE': 'en_US:en', 22:15:31 INFO - 'LOGNAME': 'cltbld', 22:15:31 INFO - 'MAIL': '/var/mail/cltbld', 22:15:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:31 INFO - 'MOZ_NO_REMOTE': '1', 22:15:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:15:31 INFO - 'NO_EM_RESTART': '1', 22:15:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:15:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:15:31 INFO - 'PWD': '/builds/slave/test', 22:15:31 INFO - 'SHELL': '/bin/bash', 22:15:31 INFO - 'SHLVL': '1', 22:15:31 INFO - 'TERM': 'linux', 22:15:31 INFO - 'TMOUT': '86400', 22:15:31 INFO - 'USER': 'cltbld', 22:15:31 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476940283.656760-1317964367', 22:15:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:31 INFO - '_': '/tools/buildbot/bin/python'} 22:15:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:15:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:15:31 INFO - Cleaning up... 22:15:31 INFO - Return code: 0 22:15:31 INFO - Running post-action listener: _resource_record_post_action 22:15:31 INFO - Running post-action listener: _start_resource_monitoring 22:15:31 INFO - Starting resource monitoring. 22:15:31 INFO - [mozharness: 2016-10-20 05:15:31.254234Z] Finished create-virtualenv step (success) 22:15:31 INFO - [mozharness: 2016-10-20 05:15:31.254746Z] Running install step. 22:15:31 INFO - Running pre-action listener: _resource_record_pre_action 22:15:31 INFO - Running main action method: install 22:15:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:15:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:15:31 INFO - Reading from file tmpfile_stdout 22:15:31 INFO - Detecting whether we're running mozinstall >=1.0... 22:15:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:15:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:15:31 INFO - Reading from file tmpfile_stdout 22:15:31 INFO - Output received: 22:15:31 INFO - Usage: mozinstall [options] installer 22:15:31 INFO - Options: 22:15:31 INFO - -h, --help show this help message and exit 22:15:31 INFO - -d DEST, --destination=DEST 22:15:31 INFO - Directory to install application into. [default: 22:15:31 INFO - "/builds/slave/test"] 22:15:31 INFO - --app=APP Application being installed. [default: firefox] 22:15:31 INFO - mkdir: /builds/slave/test/build/application 22:15:31 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:15:31 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:15:48 INFO - Reading from file tmpfile_stdout 22:15:48 INFO - Output received: 22:15:48 INFO - /builds/slave/test/build/application/firefox/firefox 22:15:48 INFO - Running post-action listener: _resource_record_post_action 22:15:48 INFO - [mozharness: 2016-10-20 05:15:48.489557Z] Finished install step (success) 22:15:48 INFO - [mozharness: 2016-10-20 05:15:48.489800Z] Running run-tests step. 22:15:48 INFO - Running pre-action listener: _resource_record_pre_action 22:15:48 INFO - Running main action method: run_tests 22:15:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:15:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:15:48 INFO - Python 2.7.3 22:15:48 INFO - Return code: 0 22:15:48 INFO - grabbing minidump binary from tooltool 22:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:15:48 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 0x1444790>, '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 0x1445690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1445b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:15:48 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:15:48 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:15:48 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:15:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:15:48 INFO - Return code: 0 22:15:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:15:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:15:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:15:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:15:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:15:48 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/P8kw7l04T0Gj3BpiNWZcEA/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:15:48 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/P8kw7l04T0Gj3BpiNWZcEA/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:15:48 INFO - Using env: {'DISPLAY': ':0', 22:15:48 INFO - 'HOME': '/home/cltbld', 22:15:48 INFO - 'LANG': 'en_US.UTF-8', 22:15:48 INFO - 'LANGUAGE': 'en_US:en', 22:15:48 INFO - 'LOGNAME': 'cltbld', 22:15:48 INFO - 'MAIL': '/var/mail/cltbld', 22:15:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:15:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:15:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:48 INFO - 'MOZ_NO_REMOTE': '1', 22:15:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:15:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:15:48 INFO - 'NO_EM_RESTART': '1', 22:15:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:15:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:15:48 INFO - 'PWD': '/builds/slave/test', 22:15:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:15:48 INFO - 'SHELL': '/bin/bash', 22:15:48 INFO - 'SHLVL': '1', 22:15:48 INFO - 'TERM': 'linux', 22:15:48 INFO - 'TMOUT': '86400', 22:15:48 INFO - 'USER': 'cltbld', 22:15:48 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476940283.656760-1317964367', 22:15:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:48 INFO - '_': '/tools/buildbot/bin/python'} 22:15:48 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/P8kw7l04T0Gj3BpiNWZcEA/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:15:48 INFO - mozversion application_buildid: 20161019193001 22:15:48 INFO - mozversion application_changeset: 998ad5a74da80fe63664a8dcf30d8f269ffe4e65 22:15:48 INFO - mozversion application_display_name: Nightly 22:15:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:15:48 INFO - mozversion application_name: Firefox 22:15:48 INFO - mozversion application_remotingname: firefox 22:15:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:15:48 INFO - mozversion application_vendor: Mozilla 22:15:48 INFO - mozversion application_version: 52.0a1 22:15:48 INFO - mozversion platform_buildid: 20161019193001 22:15:48 INFO - mozversion platform_changeset: 998ad5a74da80fe63664a8dcf30d8f269ffe4e65 22:15:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:15:48 INFO - mozversion platform_version: 52.0a1 22:15:48 INFO - using testdate: 1476940548 22:15:48 INFO - actual date: 1476940548 22:15:48 INFO - starting webserver on 'localhost:40385' 22:15:48 INFO - SUITE-START | Running 2 tests 22:15:48 INFO - TEST-START | dromaeo_css 22:15:48 INFO - operating with platform_type : linux_ 22:15:48 INFO - Initialising browser for dromaeo_css test... 22:15:48 INFO - TEST-INFO | started process 7751 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOTzTeS/profile http://localhost:40385/getInfo.html) 22:15:53 INFO - PROCESS | 7751 | __metrics Screen width/height:1600/1200 22:15:53 INFO - PROCESS | 7751 | colorDepth:24 22:15:53 INFO - PROCESS | 7751 | Browser inner width/height: 1024/697 22:15:53 INFO - PROCESS | 7751 | __metrics 22:15:53 ERROR - PROCESS | 7751 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 22:15:54 INFO - TEST-INFO | 7751: exit 0 22:15:54 INFO - Browser initialized. 22:15:54 INFO - Running cycle 1/1 for dromaeo_css test... 22:15:54 INFO - TEST-INFO | started process 7876 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOTzTeS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:16:06 INFO - PROCESS | 7876 | RSS: Main: 182341632 22:16:06 INFO - PROCESS | 7876 | 22:16:56 INFO - PROCESS | 7876 | 1476940616542 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:19:07 INFO - PROCESS | 7876 | Cycle 1(1): loaded http://localhost:40385/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40385/tests/dromaeo/cssquery-ext.html) 22:19:08 INFO - PROCESS | 7876 | RSS: Main: 196313088 22:19:08 INFO - PROCESS | 7876 | 22:22:11 INFO - PROCESS | 7876 | Cycle 1(1): loaded http://localhost:40385/tests/dromaeo/cssquery-ext.html (next: http://localhost:40385/tests/dromaeo/cssquery-jquery.html) 22:22:11 INFO - PROCESS | 7876 | RSS: Main: 194486272 22:22:11 INFO - PROCESS | 7876 | 22:25:13 INFO - PROCESS | 7876 | Cycle 1(1): loaded http://localhost:40385/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40385/tests/dromaeo/cssquery-mootools.html) 22:25:14 INFO - PROCESS | 7876 | RSS: Main: 196354048 22:25:14 INFO - PROCESS | 7876 | 22:28:16 INFO - PROCESS | 7876 | Cycle 1(1): loaded http://localhost:40385/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40385/tests/dromaeo/cssquery-prototype.html) 22:28:16 INFO - PROCESS | 7876 | RSS: Main: 193089536 22:28:16 INFO - PROCESS | 7876 | 22:31:19 INFO - PROCESS | 7876 | Cycle 1(1): loaded http://localhost:40385/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40385/tests/dromaeo/cssquery-yui.html) 22:31:19 INFO - PROCESS | 7876 | RSS: Main: 196714496 22:31:19 INFO - PROCESS | 7876 | 22:34:22 INFO - PROCESS | 7876 | Cycle 1(1): loaded http://localhost:40385/tests/dromaeo/cssquery-yui.html (next: http://localhost:40385/tests/dromaeo/cssquery-dojo.html) 22:34:23 INFO - PROCESS | 7876 | RSS: Main: 196386816 22:34:23 INFO - PROCESS | 7876 | 22:34:23 INFO - PROCESS | 7876 | __start_tp_report 22:34:23 INFO - PROCESS | 7876 | _x_x_mozilla_page_load 22:34:23 INFO - PROCESS | 7876 | _x_x_mozilla_page_load_details 22:34:23 INFO - PROCESS | 7876 | |i|pagename|runs| 22:34:23 INFO - PROCESS | 7876 | |0;dojo.html;3106.5961425014752;3135.4983202687577;3169.5721077654525;3180.4275230458506;3192.6807319268078;5483.506484416407;5501.587380946425;5545.3622833374175;5567.220589117527;5570.220169176318;5504.559635229182;5513.255710479084;5527.751251193696;5549.667019978804;5552.333719953601;4956.479569645189;4985.052839960405;5007.84976450707;5029.47190544993;5051.747412629354;5040.143175660129;5110.029094472038;5114.6164037697135;5116.283720279164;5146.588272938156;4886.560209581119;4937.210046392596;5009.724465154415;5054.064997975386;5065.822696205633;4887;4907.288443175756;4938.432080310774;4969.4036715594;5021.598272138257;4904.264360345941;4932.679375840559;4935.777889994959;4938.08645400602;4971.7762700678195;5298.364196296469;5419.864503387447;5431.266778984826;5434.91847622286;5474.042042642522;5699.544036477072;5794.246747922743;5803.941960580382;5855.736491857877;5987.91018134724;5937.7921772737745;5962.3739507351975;5978.910316345258;5981.581289309706;5987.6108052976415;5497.642653227527;5508.476694713996;5526.088195447786;5540.750666220029;5541.972290138564;5795.217645617788;5816.2148110005455;5932.40675932412;5990.400959904062;6006.729697163638;5736.971315143398;5745.626534275259;5791.160281759206;5807.738651760681;5855.2973643163095;5705.657660540381;5785.04584554303;5873.618214816023;5880.470757631833;5896.911546326808;5764.769409223584;5783.971080144656;5820.505257053198;5836.562257830679;5928.288605367384;5784.537237021028;5858;5876.882462350729;5886.293644762656;5888.882222355614;4469.262571675702;4499.910001799945;4509.346144808985;4510.188166130128;4561.24739417999;3926.489556357655;3963.246983073207;3965.365541513344;4037.6164264394833;4060.4315395844606;5538.196961440569;5640.492355687926;5646.717664116778;5647.802326918538;5710.628809127394;5895.233619629421;5943.286805583271;5945.375735547792;5957.046872500379;5957.6127551709;5396.406395296514;5438.102713052381;5491.2312276281355;5531.363893152339;5614.69119198448;4914.778834952435;4914.975425122923;4926.359573255526;4962.677425967373;4972.627052971042;6004.54965877561;6007.30915944672;6020.458158765732;6021;6022.90965635507;5748.885022299447;5802.042662960733;5846.619969701956;5861.062230043172;5942.049272116441;5973.954557952427;5976;5996.340402555803;6019.699015049143;6038.064100064497;5748.051571490824;5859.44335288147;5865.5600829937075;5869.413058694267;5938.020226662552;5963.612365196248;5964.761409543569;5965.880682386415;5970.5522085844605;5973.462388384893;5570.053090974463;5805.796797112081;5807.274090738658;5808.07070868659;5812.389699081705;5586.994341018493;5591.524720398812;5592.664440133605;5651.208830763779;5657.660540367591;5593.972030139823;5605.551555875439;5621.213030175697;5686.601937864475;5714.485696287354;5861;5885.234919460443;5893.381194974638;5900.43945825146;5950.702464876652;5645;5713.485786279255;5728.398518155534;5758.107493338539;5764.394738552392 22:34:23 INFO - PROCESS | 7876 | |1;ext.html;577.3014652270753;579.1515429895205;584.1588113117111;587.7766448749475;588.529176658673;39547.209055818865;41413.58586414135;41421.79289103554;44636.55363446364;44638.33042504365;41992;42107;42548.57451425493;42626.36060459088;42938.78530607351;8703.912960870373;8870.979837318726;8899.421537600068;8900.109989001114;8905.821883562325;8751.781205469882;8753.518556479392;8761.474311541297;8770.649174033031;8784.121587841197;8776.60505277264;8816.206541411271;8816.955915220415;8841.11588841114;8879.911200888006;8839.24866386358;8872.15714507124;8881;8890.244329232022;8902.554872256425;8541.82916341676;8608.354373422018;8658.783530411727;8679.826403471958;8725.825483490358;40507;40770.38844417336;40805.59194408048;40883.18233635311;40897;3113.9065828025196;3228.176814912206;3237.919052023695;3266.4610339293986;3286.342731453719;29914.55128173079;30063.398732025456;30147.698523014707;30159.246018849484;30928.845355773075;4214.883055990165;4293.098449325646;4323.502797178333;4425.867223983286;4500.347449619787;229200;229977;230306;231119.9999999983;231169;55805;55969.720151398986;56116.71941640266;56262.71868640713;56274.43725562774;57767.422325776206;57931.13103303454;57955.71022144862;57981.420185798444;58409.41590584125;14987.775183372258;15148.772768408482;15156.848431515764;15220.771688424682;15223.923880380527;11500.309981401142;11578.47896844644;11605.941970290263;11618.593349232737;11630.476628551736;16074.678506429806;16313.755293670605;16413.42553010663;16517.174141293126;17053.232604532826;5800.9129863052085;5985.700714964321;6026.337102918676;6119.716198660955;6231.719572619243;909.8544232922833;989.7228775942604;1057.9206559508068;1101.5703875488566;1112.799696054718;29850.552241716392;30806;30988.84505577503;31476;32126.83936580302;1059.3908502610875;1088.6244245735209;1092.7869065532304;1109.3233127792041;1130.4347826086957;14977.700445991019;16205.918970405073;16286.51140465788;16440.342386304652;16624.58438539022;495729;502412;503688;503834;504256;53691;54022;54119.72940135274;54419.45580544223;54901.1764823528;1310.7313000834806;1348.6560926963562;1368.9110207836459;1373.9931300343435;1381.5717127690448;27875;29923.401531968804;30239.546406804355;30480.695193047784;30574;48907.75546122246;49838.750806245735;50011.74994125006;50177.74911125421;50179.49820501894;330867;333651;333661;334085;337287;26285.605715913895;26872.193834185007;27139.18582442451;27236.727632723418;27257.31856703598;44560;44713.77643111894;45249;45319.546804531536;45710.77144614256;37436.812815935744;37758.244835103695;38203.80898095492;39473.210535789694;39853;37380;38033.61966380301;38158;38676.41985370166;39013.21973560456;38117.61882381252;39307;39605;41148.79425602972;41617.79191104025;30616.540751888293;34256.82871585726;34894;35485.64514354926;35807.641923581476;27396.712394512786;27459.588106178824;27619.86190069037;27741.28146771478;27812.582811258253 22:34:23 INFO - PROCESS | 7876 | |2;jquery.html;373.1901773152261;373.4584851964651;375.2326492323199;392.0668808236397;394.3650722337037;17251;18723.812761872377;19085.522861928443;19423.611527769455;19652.213911443527;18378.908105459454;18411.53971150722;18882.905585472054;18895.149718262677;18930.242790288372;5464.508194262516;5544.500994910457;5777.133429985514;5785;5785.595008349417;5591.189277554752;5706.258186435757;5717.171010203539;5721;5726.284214473191;5500.28496295483;5579.581531385163;5634.0703783875615;5663.745131469073;5672.744726487318;5581.776728930838;5617.101263797773;5656.547476201915;5664.971675141598;5697.088465845465;5007.5993920486635;5019.723915184663;5032.169692000815;5042.470540593222;5087.796488140507;21971;22129.446763831034;22156.667649985262;22199.889000555057;22235.666465003036;2196.3081629286726;2264.8074913632363;2294.265834932822;2439.4633180700216;2813.141991692533;13639.181649101085;14100.153990760587;14125.364358603887;14572.70854582913;15006.399744010227;1588.7140314743342;1647.2422685564654;1678.2951160512614;1679.9160041997973;1752.8860624059523;75703.62148189278;81538.59230703868;81971.18028819695;82454;82815.23401957707;10450.320729152581;10617.469126543796;10818.188635852342;10920.2901811382;11585.073194144617;14718.541142831426;14843.851561484464;14914.030588011745;14935.327910244065;14963.40146394132;7294.197638259787;7626.42801789868;7774.65014074368;7820.804479888048;7832.765017049498;7056.54132481387;7073.398761105261;7267.491275610657;7368.336849683555;7379.114506259283;4490.865274041718;4490.865274041784;4508.594226519564;4545.727256364628;4613.261878099488;1867.2530987604796;1895.5829717462411;1934.6324198402258;1972.4122081724063;1981.346155768593;909.4634165842052;941.924646028316;953.68051702679;965.3676841668719;1035.4253389368973;17568.209430575655;18802.341918032802;18857.905710471634;19105.80894191068;19231.807681923;906.5286051253312;953.8283109040301;957.5403806173076;958.5063692198523;962.4225464721111;9925.950370248103;10033.648822291185;11278.943605281922;11693.707657308636;11727.824082638766;426552;429100;442861;444393;450044;57116.714416428484;73481;95083;96302.55546166813;96850.51574742081;1019.2559431614962;1048.7430579507916;1060.0141868062622;1097.4238524774398;1099.2250463423268;16222.26999785036;16794.66410671755;17405.912970435067;17440.73838892392;17806.46580602532;35860.92417227487;41221.587784122974;41260.58739412567;42059.7897010513;42417.151656967304;54143.72928135334;56859.71570142123;57335;58358;60117.69941150266;8029;8131.918680813116;8291.559949373706;8514.361422893431;8573.528455934984;9175.541222938693;11871.940640296743;12547.874521254671;12892.935535322264;12985.48058077704;11413.828792568283;11641.53433862636;11884.643460696192;11922.821157682469;11982.64052078439;11229.66311010671;11294.491747871201;11400.315981041163;11521.423928803693;11600;11214.990650841464;11499.942500287445;11570.132240082195;11837.585684501;12168.087393445705;7003.369696727319;7355.485116042039;7422.628868556442;7673.6546855390525;8904.688335908471;9724.416535007922;11309.321440713584;11643.41782910834;11952.34262115592;12101.818472723093 22:34:23 INFO - PROCESS | 7876 | |3;mootools.html;1431.5776845830483;1461;1596.6886457140854;1715.305301352951;1766.0639860873741;7353.852922941538;7590.58251796151;8277.627506762195;8868.201861832435;8884.777880552982;8292.875606865902;8556.786080347994;8559.186877246651;8730.476171429718;8849.469031858092;2183.912643494258;2225.5771403433378;2225.6772767948637;2228.821694264455;2230.565039817236;2177.7822217778175;2194.813440857529;2222.388843068153;2230.386643672987;2234.486068204314;2144.549644574641;2148.5702859428097;2152.9138834446603;2156.1267686586957;2162.0378931375544;2097.6119417907735;2118.936431907045;2120.7985241402043;2128.797764212413;2140.5076832328496;2162.091921393003;2162.318869556085;2175.4996350839237;2187.978120218809;2203.6584329428965;8681.435706679045;8799.296056315543;8818.86771698425;8827.823443531093;8848.778780530474;4999.32509111269;5016.423111342206;5073.162928116893;5083.872903177413;5146;3141.2303985523463;3265.510173473998;3300.669933006704;3315.7347412207205;3348.5814273215847;1010.6361709784471;1030.5311083457009;1056.1920131099714;1068.9518971646294;1078.1859695929602;11472.369019703912;11588.478518466689;11607.76784464306;11623.825642615368;11728.413579321084;4458.509563947963;4494.191045611821;4605.746683932349;4621.168189725814;4647.86056418308;9968.252381071303;10024.899751002542;10030.799384012278;10038.498075096362;10044.748881277881;5189;5192.350956130484;5203.895922081537;5204.271402003723;5215.791368345223;3982.6415622593527;4516.3902873112365;4574.268117101315;4825.469198388175;4830.806767729251;3740.495033170542;3754.2679177560112;3898.181381909774;3899.5515515715488;3902.0929407590957;1196.796544587405;1207.3902679146975;1208.945597448117;1210.7396909664287;1215.1554669504785;873.6811063961735;880.7093659092612;882.3250213586612;898.869663898731;916.5783739479914;5348.171033489815;5455.399906010336;5479.671219726829;5509.862253443615;5558.138488534284;406.3275279412577;417.8433087592153;436.89296122449565;437.4728452215073;438.0538037838254;3556.751027428107;3717.665410113049;3735.533058367704;3850.364689826203;3869.729118961702;10723.624673136559;11106.833397499044;11131.165162612837;11153.10775137987;11209.887901120885;10361.740956475998;11115.944420278009;11142.721431964104;11159.832602510969;11159.939805718444;8042.557659328793;8396.748097557083;8397.664093436317;8400.873986890201;8417.368697347601;5784.971075144597;5873.5594830388745;5916.171735957056;5920.644761314335;6028.487578555872;9662.420254784736;9666.516674166403;9691.176250018827;9693.224542036762;9699.9030009699;9625.470599117116;9937.602495900372;10470.581176752845;10473.371597704163;10648.307859989076;7493.550386976799;7578.962105189439;7853.214678532101;7899.68401263943;7923.326517246099;8861.64553417856;8952.776180595276;8958.552072396484;8963.372563920462;8974.237189838937;7553.622318884144;7572.621368931421;7763.573003484863;7777;8059.153788852086;7673;7692.461527693008;7761.844763104594;7784.88322675149;7871.921280787119;6731.1922569292;6853.040574319699;6854.074699915447;6858.485613578901;6871.793846184622;4790.976045119752;4844.273358996038;4910.92633610489;4963.354763880672;5090.592752579859;4946.604271658331;4948.05986862495;4987.60099192071;5007.098722230034;5187.4553171916405 22:34:23 INFO - PROCESS | 7876 | |4;prototype.html;311.778637167611;314.5690404146319;321.9517072439133;322.8708516593362;325.96088469383676;5413.296271484712;5574.944250557493;5637.294098832558;5666.575006874486;5681.630694004892;5430.429804870481;5498.945010549904;5538.224648549196;5538.501534861862;5543.673795722574;4296.334068219431;4296.377025331325;4306.892327691801;4314.870553883373;4318.935215971763;4216.346466297713;4256.2764330063965;4272.658187345005;4333.4799824021;4336.6530677545725;4232.703710740249;4240.936385954213;4246.617804397603;4249.575042495741;4254.723442976197;4197.748135111872;4211.073563815956;4236.563975713962;4246.426732391149;4252.278541733293;3723.920063181674;3738.7195960302815;3739.607341229159;3748.812559372048;3762.435634654796;5063.620228482879;5315.521603055705;5357.312446579315;5365.382980957162;5372.489613486712;4848.22428411456;4849.442314133849;4861.51384861511;4870.172070747982;4875.195592727196;5398.541124004464;5781.392953739839;5789.565782566325;5789.652620842763;5795.362510123883;3980.870234424569;4000.9199816003515;4003.499562554681;4009.7393669411395;4013.137175507251;5922.170896074553;5942.3166335871065;5982.820515384546;6004.6997650117755;6011.609245399035;4002.399640053957;4136.875893723193;4151.709380343347;4152.190322887008;4172.602178270253;4117.649999749995;4123.443335149776;4130.690198235145;4169.91660166795;4230.767307798039;4787.210110331756;4800.73595952219;4820.794801299675;4820.855374338776;4828.275758636162;5697.436153730755;5788.507976822018;5806.4193580641595;5808.680522571215;5858.794942177004;1409.936552855124;1425.4369524037947;1439.4961763382732;1439.6904665496968;1439.820022497188;838.6477679374677;871.8953725552974;871.930245580352;876.5179151466668;888.311558542135;4869.123557759566;4888.877778055506;4912.975435122801;4918.8770280743265;4925.162722337212;5196;5238.738063096906;5250.2411692082815;5274.7626356814035;5286.5726253911225;4732.81679580105;4852.4662287148385;4981.501849814989;5011.273365362002;5033.395992480926;2785.220138361262;2785.2340606333014;2785.6378670773074;2799.740116947382;2818.0969357440094;5273;5273.472652734696;5314.362276526842;5395.676259424368;5428.6199966002005;4987.950120498748;5125.384953805493;5215.269862219292;5244.685318880879;5253.317068781034;5243.449437809051;5293.655912365684;5315.521603055744;5321.467853214647;5321.760520776575;5139.357580302462;5185.896282074413;5210.869728256824;5271.8682032947945;5272.62372231055;4932.53140951609;5072.807890145887;5102.744862756922;5104.642675012714;5148.06947394727;5273.683578985273;5281.8679533010445;5299.284596579412;5308.309919710413;5329.840104796862;3662.1689155422287;3678.5585729712607;3944.994026523333;4127.690423218331;4164.459150114477;5901.232839730807;5917.822465326047;5933.258342707161;5968.164456976114;6002.939970600238;5706.828795136153;5734.534150315238;5783.797567085132;5814.389489103583;5862.472377486047;5469.425710300361;5626;5627.634203776742;5638.2670252866865;5684.346300175533;5729.455701708331;5732.254806875079;5789.334226563999;5796.594413318426;5812.94187058124;5532.30846144232;5723.170140329712;5769.68266745333;5786.132080188006;5817.360090389969;5647.576431767716;5715.2855893013375;5744.569157313134;5766.077427611562;5766.567507437043 22:34:23 INFO - PROCESS | 7876 | |5;yui.html;687.1891168421263;788.8027993001749;791.6041979010497;807.8909347238122;811.8619834628113;14998.100113993169;15663.765043524341;15681.921590392047;15726.606834829136;15806.525804225863;14860.405583776663;14953.7009259815;14973.475928342483;15011.474598389059;15024.774628380583;780.1457404142483;793.7817100297422;806.818465845186;809.5830647216688;816.7549735079482;803.3733687723585;808.5270116981573;809.2676128104075;811.2455416462687;813.5484805932705;841.3563623827777;843.2874221283037;843.886075379822;844.6959094725894;848.3425345357366;833.1626715151294;838.4466252273501;839.2866063845744;842.103160134461;844.0293662288386;617.7652492053036;618.4990157972057;619.6437048697018;622.1072760588524;625.1841347042108;15402.537923862303;15607.45373911919;15651.139187344692;15687.607809804733;15714.68570628581;14008.089474184248;14035.263123690884;14047.578572642837;14153.638600111079;14244.145351278956;11442.141839361999;11513.39283484583;11559.190856639954;11690.824637630443;11781.175317727762;3482.2861313430685;3483.6864682178725;3493.353729560014;3505.0886769439876;3693.778373297611;60374.39625603732;61844.07233891495;75661.62169189118;78167.60916195382;78335.60832195803;11052.834207486894;11179.105671546256;11311.943440282746;11316.37759923212;11364.772704546029;20799;20811.167553298;20814.271500497714;20846.166153353697;20876.895615521826;7892.921070789219;7944.483608565425;8030.879536806952;8120.4977079240525;8303;4482.9775851121185;4551.5676010778925;4591.943852913849;4607.493175750665;4703.0593881223895;3212.903612891617;3284.6058472983395;3296.423125952949;3298.620658624289;3307.1732066983254;584.9912251316233;586;586.4721750424652;598.4912824099481;616.1281786272464;695.2942763095463;696.1715558485387;700.6531766775479;707.5507053021369;707.9079719636414;8315.168483151636;8384.329253659693;8983.371164018456;9060.54697265134;9128.908710912805;672.3008071605573;684.6953105867841;687.8108520156997;712.3377494299821;713.5076797010047;4087.3664581989838;4237.385579091015;4257.361395790656;4487.439070116236;4545.3863728396245;66069.33930660631;83208;84210;106181.46909265404;121831.39084304699;97860.51069744748;99044.51433228508;99445;100329.49835250922;102263.4886825576;84933;87610;88951.55524222337;91836;93877.5306123465;8122.268995790408;8324;8396.706115285935;8412.831743365221;8720.345974052098;52438.47561524336;53331.200351941494;54079.459205407446;54081;55140;63968.28333024965;72751;74525.62737186279;79573.60213198897;81543.59228203821;12452.626421207378;12566.623001309976;12711.872881271069;12763.425645845773;12820.679483013;14327.426902924184;14600.488982885548;14807;15497.45758898433;15716.528504144893;12792.936035319764;13341.66645833862;13647.317634118055;13884.166949983033;14429.062110962754;13614;13817.585472435843;13907.30463476802;14064.226467543975;14499.347529360994;12404.751904962031;13590;13659.112157709716;13719.519816806363;13824.723505530033;10795.676129716121;11207.383593902414;11318.26431281964;11348.375839328915;11482.82775758381;9339.439633622005;10383.792324153626;10399.948000260252;11254.549818007188;11309.912758942452 22:34:23 INFO - PROCESS | 7876 | __end_tp_report 22:34:23 INFO - PROCESS | 7876 | __start_cc_report 22:34:23 INFO - PROCESS | 7876 | _x_x_mozilla_cycle_collect,319 22:34:23 INFO - PROCESS | 7876 | __end_cc_report 22:34:23 INFO - PROCESS | 7876 | __startTimestamp1476941663054__endTimestamp 22:34:23 INFO - PROCESS | 7876 | 22:34:23 INFO - PROCESS | 7876 | ------- Summary: start ------- 22:34:23 INFO - PROCESS | 7876 | Number of tests: 6 22:34:23 INFO - PROCESS | 7876 | 22:34:23 INFO - PROCESS | 7876 | [#0] dojo.html Cycles:165 Average:5453.84 Median:5651.21 stddev:624.47 (11.1%) stddev-sans-first:598.63 22:34:23 INFO - PROCESS | 7876 | Values: 3106.6 3135.5 3169.6 3180.4 3192.7 5483.5 5501.6 5545.4 5567.2 5570.2 5504.6 5513.3 5527.8 5549.7 5552.3 4956.5 4985.1 5007.8 5029.5 5051.7 5040.1 5110.0 5114.6 5116.3 5146.6 4886.6 4937.2 5009.7 5054.1 5065.8 4887.0 4907.3 4938.4 4969.4 5021.6 4904.3 4932.7 4935.8 4938.1 4971.8 5298.4 5419.9 5431.3 5434.9 5474.0 5699.5 5794.2 5803.9 5855.7 5987.9 5937.8 5962.4 5978.9 5981.6 5987.6 5497.6 5508.5 5526.1 5540.8 5542.0 5795.2 5816.2 5932.4 5990.4 6006.7 5737.0 5745.6 5791.2 5807.7 5855.3 5705.7 5785.0 5873.6 5880.5 5896.9 5764.8 5784.0 5820.5 5836.6 5928.3 5784.5 5858.0 5876.9 5886.3 5888.9 4469.3 4499.9 4509.3 4510.2 4561.2 3926.5 3963.2 3965.4 4037.6 4060.4 5538.2 5640.5 5646.7 5647.8 5710.6 5895.2 5943.3 5945.4 5957.0 5957.6 5396.4 5438.1 5491.2 5531.4 5614.7 4914.8 4915.0 4926.4 4962.7 4972.6 6004.5 6007.3 6020.5 6021.0 6022.9 5748.9 5802.0 5846.6 5861.1 5942.0 5974.0 5976.0 5996.3 6019.7 6038.1 5748.1 5859.4 5865.6 5869.4 5938.0 5963.6 5964.8 5965.9 5970.6 5973.5 5570.1 5805.8 5807.3 5808.1 5812.4 5587.0 5591.5 5592.7 5651.2 5657.7 5594.0 5605.6 5621.2 5686.6 5714.5 5861.0 5885.2 5893.4 5900.4 5950.7 5645.0 5713.5 5728.4 5758.1 5764.4 22:34:23 INFO - PROCESS | 7876 | 22:34:23 INFO - PROCESS | 7876 | [#1] ext.html Cycles:180 Average:52018.39 Median:39729.00 stddev:98835.59 (248.8%) stddev-sans-first:99037.38 22:34:23 INFO - PROCESS | 7876 | Values: 577.3 579.2 584.2 587.8 588.5 39547.2 41413.6 41421.8 44636.6 44638.3 41992.0 42107.0 42548.6 42626.4 42938.8 8703.9 8871.0 8899.4 8900.1 8905.8 8751.8 8753.5 8761.5 8770.6 8784.1 8776.6 8816.2 8817.0 8841.1 8879.9 8839.2 8872.2 8881.0 8890.2 8902.6 8541.8 8608.4 8658.8 8679.8 8725.8 40507.0 40770.4 40805.6 40883.2 40897.0 3113.9 3228.2 3237.9 3266.5 3286.3 29914.6 30063.4 30147.7 30159.2 30928.8 4214.9 4293.1 4323.5 4425.9 4500.3 229200.0 229977.0 230306.0 231120.0 231169.0 55805.0 55969.7 56116.7 56262.7 56274.4 57767.4 57931.1 57955.7 57981.4 58409.4 14987.8 15148.8 15156.8 15220.8 15223.9 11500.3 11578.5 11605.9 11618.6 11630.5 16074.7 16313.8 16413.4 16517.2 17053.2 5800.9 5985.7 6026.3 6119.7 6231.7 909.9 989.7 1057.9 1101.6 1112.8 29850.6 30806.0 30988.8 31476.0 32126.8 1059.4 1088.6 1092.8 1109.3 1130.4 14977.7 16205.9 16286.5 16440.3 16624.6 495729.0 502412.0 503688.0 503834.0 504256.0 53691.0 54022.0 54119.7 54419.5 54901.2 1310.7 1348.7 1368.9 1374.0 1381.6 27875.0 29923.4 30239.5 30480.7 30574.0 48907.8 49838.8 50011.7 50177.7 50179.5 330867.0 333651.0 333661.0 334085.0 337287.0 26285.6 26872.2 27139.2 27236.7 27257.3 44560.0 44713.8 45249.0 45319.5 45710.8 37436.8 37758.2 38203.8 39473.2 39853.0 37380.0 38033.6 38158.0 38676.4 39013.2 38117.6 39307.0 39605.0 41148.8 41617.8 30616.5 34256.8 34894.0 35485.6 35807.6 27396.7 27459.6 27619.9 27741.3 27812.6 22:34:23 INFO - PROCESS | 7876 | 22:34:23 INFO - PROCESS | 7876 | [#2] jquery.html Cycles:180 Average:27171.25 Median:374.35 stddev:72513.75 (19370.8%) stddev-sans-first:72689.25 22:34:23 INFO - PROCESS | 7876 | Values: 373.2 373.5 375.2 392.1 394.4 17251.0 18723.8 19085.5 19423.6 19652.2 18378.9 18411.5 18882.9 18895.1 18930.2 5464.5 5544.5 5777.1 5785.0 5785.6 5591.2 5706.3 5717.2 5721.0 5726.3 5500.3 5579.6 5634.1 5663.7 5672.7 5581.8 5617.1 5656.5 5665.0 5697.1 5007.6 5019.7 5032.2 5042.5 5087.8 21971.0 22129.4 22156.7 22199.9 22235.7 2196.3 2264.8 2294.3 2439.5 2813.1 13639.2 14100.2 14125.4 14572.7 15006.4 1588.7 1647.2 1678.3 1679.9 1752.9 75703.6 81538.6 81971.2 82454.0 82815.2 10450.3 10617.5 10818.2 10920.3 11585.1 14718.5 14843.9 14914.0 14935.3 14963.4 7294.2 7626.4 7774.7 7820.8 7832.8 7056.5 7073.4 7267.5 7368.3 7379.1 4490.9 4490.9 4508.6 4545.7 4613.3 1867.3 1895.6 1934.6 1972.4 1981.3 909.5 941.9 953.7 965.4 1035.4 17568.2 18802.3 18857.9 19105.8 19231.8 906.5 953.8 957.5 958.5 962.4 9926.0 10033.6 11278.9 11693.7 11727.8 426552.0 429100.0 442861.0 444393.0 450044.0 57116.7 73481.0 95083.0 96302.6 96850.5 1019.3 1048.7 1060.0 1097.4 1099.2 16222.3 16794.7 17405.9 17440.7 17806.5 35860.9 41221.6 41260.6 42059.8 42417.2 54143.7 56859.7 57335.0 58358.0 60117.7 8029.0 8131.9 8291.6 8514.4 8573.5 9175.5 11871.9 12547.9 12892.9 12985.5 11413.8 11641.5 11884.6 11922.8 11982.6 11229.7 11294.5 11400.3 11521.4 11600.0 11215.0 11499.9 11570.1 11837.6 12168.1 7003.4 7355.5 7422.6 7673.7 8904.7 9724.4 11309.3 11643.4 11952.3 12101.8 22:34:23 INFO - PROCESS | 7876 | 22:34:23 INFO - PROCESS | 7876 | [#3] mootools.html Cycles:180 Average:5670.47 Median:4808.22 stddev:3311.00 (68.9%) stddev-sans-first:3304.96 22:34:23 INFO - PROCESS | 7876 | Values: 1431.6 1461.0 1596.7 1715.3 1766.1 7353.9 7590.6 8277.6 8868.2 8884.8 8292.9 8556.8 8559.2 8730.5 8849.5 2183.9 2225.6 2225.7 2228.8 2230.6 2177.8 2194.8 2222.4 2230.4 2234.5 2144.5 2148.6 2152.9 2156.1 2162.0 2097.6 2118.9 2120.8 2128.8 2140.5 2162.1 2162.3 2175.5 2188.0 2203.7 8681.4 8799.3 8818.9 8827.8 8848.8 4999.3 5016.4 5073.2 5083.9 5146.0 3141.2 3265.5 3300.7 3315.7 3348.6 1010.6 1030.5 1056.2 1069.0 1078.2 11472.4 11588.5 11607.8 11623.8 11728.4 4458.5 4494.2 4605.7 4621.2 4647.9 9968.3 10024.9 10030.8 10038.5 10044.7 5189.0 5192.4 5203.9 5204.3 5215.8 3982.6 4516.4 4574.3 4825.5 4830.8 3740.5 3754.3 3898.2 3899.6 3902.1 1196.8 1207.4 1208.9 1210.7 1215.2 873.7 880.7 882.3 898.9 916.6 5348.2 5455.4 5479.7 5509.9 5558.1 406.3 417.8 436.9 437.5 438.1 3556.8 3717.7 3735.5 3850.4 3869.7 10723.6 11106.8 11131.2 11153.1 11209.9 10361.7 11115.9 11142.7 11159.8 11159.9 8042.6 8396.7 8397.7 8400.9 8417.4 5785.0 5873.6 5916.2 5920.6 6028.5 9662.4 9666.5 9691.2 9693.2 9699.9 9625.5 9937.6 10470.6 10473.4 10648.3 7493.6 7579.0 7853.2 7899.7 7923.3 8861.6 8952.8 8958.6 8963.4 8974.2 7553.6 7572.6 7763.6 7777.0 8059.2 7673.0 7692.5 7761.8 7784.9 7871.9 6731.2 6853.0 6854.1 6858.5 6871.8 4791.0 4844.3 4910.9 4963.4 5090.6 4946.6 4948.1 4987.6 5007.1 5187.5 22:34:23 INFO - PROCESS | 7876 | 22:34:23 INFO - PROCESS | 7876 | [#4] prototype.html Cycles:180 Average:4638.51 Median:5203.43 stddev:1360.27 (26.1%) stddev-sans-first:1324.75 22:34:23 INFO - PROCESS | 7876 | Values: 311.8 314.6 322.0 322.9 326.0 5413.3 5574.9 5637.3 5666.6 5681.6 5430.4 5498.9 5538.2 5538.5 5543.7 4296.3 4296.4 4306.9 4314.9 4318.9 4216.3 4256.3 4272.7 4333.5 4336.7 4232.7 4240.9 4246.6 4249.6 4254.7 4197.7 4211.1 4236.6 4246.4 4252.3 3723.9 3738.7 3739.6 3748.8 3762.4 5063.6 5315.5 5357.3 5365.4 5372.5 4848.2 4849.4 4861.5 4870.2 4875.2 5398.5 5781.4 5789.6 5789.7 5795.4 3980.9 4000.9 4003.5 4009.7 4013.1 5922.2 5942.3 5982.8 6004.7 6011.6 4002.4 4136.9 4151.7 4152.2 4172.6 4117.6 4123.4 4130.7 4169.9 4230.8 4787.2 4800.7 4820.8 4820.9 4828.3 5697.4 5788.5 5806.4 5808.7 5858.8 1409.9 1425.4 1439.5 1439.7 1439.8 838.6 871.9 871.9 876.5 888.3 4869.1 4888.9 4913.0 4918.9 4925.2 5196.0 5238.7 5250.2 5274.8 5286.6 4732.8 4852.5 4981.5 5011.3 5033.4 2785.2 2785.2 2785.6 2799.7 2818.1 5273.0 5273.5 5314.4 5395.7 5428.6 4988.0 5125.4 5215.3 5244.7 5253.3 5243.4 5293.7 5315.5 5321.5 5321.8 5139.4 5185.9 5210.9 5271.9 5272.6 4932.5 5072.8 5102.7 5104.6 5148.1 5273.7 5281.9 5299.3 5308.3 5329.8 3662.2 3678.6 3945.0 4127.7 4164.5 5901.2 5917.8 5933.3 5968.2 6002.9 5706.8 5734.5 5783.8 5814.4 5862.5 5469.4 5626.0 5627.6 5638.3 5684.3 5729.5 5732.3 5789.3 5796.6 5812.9 5532.3 5723.2 5769.7 5786.1 5817.4 5647.6 5715.3 5744.6 5766.1 5766.6 22:34:23 INFO - PROCESS | 7876 | 22:34:23 INFO - PROCESS | 7876 | [#5] yui.html Cycles:180 Average:20075.23 Median:4599.72 stddev:28461.21 (618.8%) stddev-sans-first:28503.82 22:34:23 INFO - PROCESS | 7876 | Values: 687.2 788.8 791.6 807.9 811.9 14998.1 15663.8 15681.9 15726.6 15806.5 14860.4 14953.7 14973.5 15011.5 15024.8 780.1 793.8 806.8 809.6 816.8 803.4 808.5 809.3 811.2 813.5 841.4 843.3 843.9 844.7 848.3 833.2 838.4 839.3 842.1 844.0 617.8 618.5 619.6 622.1 625.2 15402.5 15607.5 15651.1 15687.6 15714.7 14008.1 14035.3 14047.6 14153.6 14244.1 11442.1 11513.4 11559.2 11690.8 11781.2 3482.3 3483.7 3493.4 3505.1 3693.8 60374.4 61844.1 75661.6 78167.6 78335.6 11052.8 11179.1 11311.9 11316.4 11364.8 20799.0 20811.2 20814.3 20846.2 20876.9 7892.9 7944.5 8030.9 8120.5 8303.0 4483.0 4551.6 4591.9 4607.5 4703.1 3212.9 3284.6 3296.4 3298.6 3307.2 585.0 586.0 586.5 598.5 616.1 695.3 696.2 700.7 707.6 707.9 8315.2 8384.3 8983.4 9060.5 9128.9 672.3 684.7 687.8 712.3 713.5 4087.4 4237.4 4257.4 4487.4 4545.4 66069.3 83208.0 84210.0 106181.5 121831.4 97860.5 99044.5 99445.0 100329.5 102263.5 84933.0 87610.0 88951.6 91836.0 93877.5 8122.3 8324.0 8396.7 8412.8 8720.3 52438.5 53331.2 54079.5 54081.0 55140.0 63968.3 72751.0 74525.6 79573.6 81543.6 12452.6 12566.6 12711.9 12763.4 12820.7 14327.4 14600.5 14807.0 15497.5 15716.5 12792.9 13341.7 13647.3 13884.2 14429.1 13614.0 13817.6 13907.3 14064.2 14499.3 12404.8 13590.0 13659.1 13719.5 13824.7 10795.7 11207.4 11318.3 11348.4 11482.8 9339.4 10383.8 10399.9 11254.5 11309.9 22:34:23 INFO - PROCESS | 7876 | -------- Summary: end -------- 22:34:23 INFO - PROCESS | 7876 | 22:34:24 INFO - TEST-INFO | 7876: exit 0 22:34:24 INFO - TEST-OK | dromaeo_css | took 1115308ms 22:34:24 INFO - TEST-START | kraken 22:34:24 INFO - operating with platform_type : linux_ 22:34:24 INFO - Initialising browser for kraken test... 22:34:24 INFO - TEST-INFO | started process 8238 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGiFZcy/profile http://localhost:40385/getInfo.html) 22:34:28 INFO - PROCESS | 8238 | __metrics Screen width/height:1600/1200 22:34:28 INFO - PROCESS | 8238 | colorDepth:24 22:34:28 INFO - PROCESS | 8238 | Browser inner width/height: 1024/697 22:34:28 INFO - PROCESS | 8238 | __metrics 22:34:29 ERROR - PROCESS | 8238 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 22:34:30 INFO - TEST-INFO | 8238: exit 0 22:34:30 INFO - Browser initialized. 22:34:30 INFO - Running cycle 1/1 for kraken test... 22:34:30 INFO - TEST-INFO | started process 8359 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGiFZcy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:34:42 INFO - PROCESS | 8359 | RSS: Main: 182231040 22:34:42 INFO - PROCESS | 8359 | 22:34:45 INFO - PROCESS | 8359 | Cycle 1(1): loaded http://localhost:40385/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40385/tests/kraken/driver.html?testName=audio-beat-detection) 22:34:46 INFO - PROCESS | 8359 | RSS: Main: 196718592 22:34:46 INFO - PROCESS | 8359 | 22:34:48 INFO - PROCESS | 8359 | Cycle 1(1): loaded http://localhost:40385/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40385/tests/kraken/driver.html?testName=audio-dft) 22:34:49 INFO - PROCESS | 8359 | RSS: Main: 193974272 22:34:49 INFO - PROCESS | 8359 | 22:34:52 INFO - PROCESS | 8359 | Cycle 1(1): loaded http://localhost:40385/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40385/tests/kraken/driver.html?testName=audio-fft) 22:34:52 INFO - PROCESS | 8359 | RSS: Main: 190951424 22:34:52 INFO - PROCESS | 8359 | 22:34:55 INFO - PROCESS | 8359 | Cycle 1(1): loaded http://localhost:40385/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40385/tests/kraken/driver.html?testName=audio-oscillator) 22:34:55 INFO - PROCESS | 8359 | RSS: Main: 191467520 22:34:55 INFO - PROCESS | 8359 | 22:34:57 INFO - PROCESS | 8359 | Cycle 1(1): loaded http://localhost:40385/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40385/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:34:58 INFO - PROCESS | 8359 | RSS: Main: 192245760 22:34:58 INFO - PROCESS | 8359 | 22:35:01 INFO - PROCESS | 8359 | Cycle 1(1): loaded http://localhost:40385/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40385/tests/kraken/driver.html?testName=imaging-darkroom) 22:35:02 INFO - PROCESS | 8359 | RSS: Main: 191680512 22:35:02 INFO - PROCESS | 8359 | 22:35:05 INFO - PROCESS | 8359 | Cycle 1(1): loaded http://localhost:40385/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40385/tests/kraken/driver.html?testName=imaging-desaturate) 22:35:06 INFO - PROCESS | 8359 | RSS: Main: 192221184 22:35:06 INFO - PROCESS | 8359 | 22:35:08 INFO - PROCESS | 8359 | Cycle 1(1): loaded http://localhost:40385/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40385/tests/kraken/driver.html?testName=json-parse-financial) 22:35:09 INFO - PROCESS | 8359 | RSS: Main: 191819776 22:35:09 INFO - PROCESS | 8359 | 22:35:11 INFO - PROCESS | 8359 | Cycle 1(1): loaded http://localhost:40385/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40385/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:35:11 INFO - PROCESS | 8359 | RSS: Main: 191881216 22:35:11 INFO - PROCESS | 8359 | 22:35:13 INFO - PROCESS | 8359 | Cycle 1(1): loaded http://localhost:40385/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40385/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:35:14 INFO - PROCESS | 8359 | RSS: Main: 191516672 22:35:14 INFO - PROCESS | 8359 | 22:35:16 INFO - PROCESS | 8359 | Cycle 1(1): loaded http://localhost:40385/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40385/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:35:16 INFO - PROCESS | 8359 | RSS: Main: 192659456 22:35:16 INFO - PROCESS | 8359 | 22:35:19 INFO - PROCESS | 8359 | Cycle 1(1): loaded http://localhost:40385/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40385/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:35:20 INFO - PROCESS | 8359 | RSS: Main: 191655936 22:35:20 INFO - PROCESS | 8359 | 22:35:23 INFO - PROCESS | 8359 | Cycle 1(1): loaded http://localhost:40385/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40385/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:35:23 INFO - PROCESS | 8359 | RSS: Main: 191979520 22:35:23 INFO - PROCESS | 8359 | 22:35:25 INFO - PROCESS | 8359 | Cycle 1(1): loaded http://localhost:40385/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40385/tests/kraken/driver.html?testName=ai-astar) 22:35:25 INFO - PROCESS | 8359 | RSS: Main: 193601536 22:35:25 INFO - PROCESS | 8359 | 22:35:25 INFO - PROCESS | 8359 | __start_tp_report 22:35:25 INFO - PROCESS | 8359 | _x_x_mozilla_page_load 22:35:25 INFO - PROCESS | 8359 | _x_x_mozilla_page_load_details 22:35:25 INFO - PROCESS | 8359 | |i|pagename|runs| 22:35:25 INFO - PROCESS | 8359 | |0;ai-astar;106;112;112;111;114;113;113;112;113;113 22:35:25 INFO - PROCESS | 8359 | |1;audio-beat-detection;159;124;125;160;125;126;126;129;154;123 22:35:25 INFO - PROCESS | 8359 | |2;audio-dft;162;167;165;168;167;163;164;165;163;164 22:35:25 INFO - PROCESS | 8359 | |3;audio-fft;77;77;76;114;76;77;75;75;106;77 22:35:25 INFO - PROCESS | 8359 | |4;audio-oscillator;83;83;112;83;85;83;105;84;85;109 22:35:25 INFO - PROCESS | 8359 | |5;imaging-gaussian-blur;118;118;117;118;118;117;117;117;118;118 22:35:25 INFO - PROCESS | 8359 | |6;imaging-darkroom;148;147;146;146;149;146;149;147;148;147 22:35:25 INFO - PROCESS | 8359 | |7;imaging-desaturate;87;86;86;86;85;86;85;84;85;84 22:35:25 INFO - PROCESS | 8359 | |8;json-parse-financial;52;53;55;55;55;56;54;54;55;53 22:35:25 INFO - PROCESS | 8359 | |9;json-stringify-tinderbox;62;62;61;61;63;61;62;60;61;62 22:35:25 INFO - PROCESS | 8359 | |10;stanford-crypto-aes;81;89;81;87;81;90;82;83;81;81 22:35:25 INFO - PROCESS | 8359 | |11;stanford-crypto-ccm;142;136;149;150;146;144;147;144;175;140 22:35:25 INFO - PROCESS | 8359 | |12;stanford-crypto-pbkdf2;169;172;169;176;171;174;171;170;176;174 22:35:25 INFO - PROCESS | 8359 | |13;stanford-crypto-sha256-iterative;69;67;69;67;67;70;65;68;66;75 22:35:25 INFO - PROCESS | 8359 | __end_tp_report 22:35:25 INFO - PROCESS | 8359 | __start_cc_report 22:35:25 INFO - PROCESS | 8359 | _x_x_mozilla_cycle_collect,797 22:35:25 INFO - PROCESS | 8359 | __end_cc_report 22:35:25 INFO - PROCESS | 8359 | __startTimestamp1476941725843__endTimestamp 22:35:25 INFO - PROCESS | 8359 | 22:35:25 INFO - PROCESS | 8359 | ------- Summary: start ------- 22:35:25 INFO - PROCESS | 8359 | Number of tests: 14 22:35:25 INFO - PROCESS | 8359 | 22:35:25 INFO - PROCESS | 8359 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:2.23 (2.0%) stddev-sans-first:0.88 22:35:25 INFO - PROCESS | 8359 | Values: 106.0 112.0 112.0 111.0 114.0 113.0 113.0 112.0 113.0 113.0 22:35:25 INFO - PROCESS | 8359 | 22:35:25 INFO - PROCESS | 8359 | [#1] audio-beat-detection Cycles:10 Average:135.10 Median:127.50 stddev:15.72 (12.3%) stddev-sans-first:14.10 22:35:25 INFO - PROCESS | 8359 | Values: 159.0 124.0 125.0 160.0 125.0 126.0 126.0 129.0 154.0 123.0 22:35:25 INFO - PROCESS | 8359 | 22:35:25 INFO - PROCESS | 8359 | [#2] audio-dft Cycles:10 Average:164.80 Median:165.00 stddev:1.99 (1.2%) stddev-sans-first:1.83 22:35:25 INFO - PROCESS | 8359 | Values: 162.0 167.0 165.0 168.0 167.0 163.0 164.0 165.0 163.0 164.0 22:35:25 INFO - PROCESS | 8359 | 22:35:25 INFO - PROCESS | 8359 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.50 stddev:14.38 (18.8%) stddev-sans-first:15.08 22:35:25 INFO - PROCESS | 8359 | Values: 77.0 77.0 76.0 114.0 76.0 77.0 75.0 75.0 106.0 77.0 22:35:25 INFO - PROCESS | 8359 | 22:35:25 INFO - PROCESS | 8359 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:83.00 stddev:12.19 (14.7%) stddev-sans-first:12.56 22:35:25 INFO - PROCESS | 8359 | Values: 83.0 83.0 112.0 83.0 85.0 83.0 105.0 84.0 85.0 109.0 22:35:25 INFO - PROCESS | 8359 | 22:35:25 INFO - PROCESS | 8359 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 22:35:25 INFO - PROCESS | 8359 | Values: 118.0 118.0 117.0 118.0 118.0 117.0 117.0 117.0 118.0 118.0 22:35:25 INFO - PROCESS | 8359 | 22:35:25 INFO - PROCESS | 8359 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:1.16 (0.8%) stddev-sans-first:1.20 22:35:25 INFO - PROCESS | 8359 | Values: 148.0 147.0 146.0 146.0 149.0 146.0 149.0 147.0 148.0 147.0 22:35:25 INFO - PROCESS | 8359 | 22:35:25 INFO - PROCESS | 8359 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:86.00 stddev:0.97 (1.1%) stddev-sans-first:0.83 22:35:25 INFO - PROCESS | 8359 | Values: 87.0 86.0 86.0 86.0 85.0 86.0 85.0 84.0 85.0 84.0 22:35:25 INFO - PROCESS | 8359 | 22:35:25 INFO - PROCESS | 8359 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:55.00 stddev:1.23 (2.2%) stddev-sans-first:1.01 22:35:25 INFO - PROCESS | 8359 | Values: 52.0 53.0 55.0 55.0 55.0 56.0 54.0 54.0 55.0 53.0 22:35:25 INFO - PROCESS | 8359 | 22:35:25 INFO - PROCESS | 8359 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:62.00 stddev:0.85 (1.4%) stddev-sans-first:0.88 22:35:25 INFO - PROCESS | 8359 | Values: 62.0 62.0 61.0 61.0 63.0 61.0 62.0 60.0 61.0 62.0 22:35:25 INFO - PROCESS | 8359 | 22:35:25 INFO - PROCESS | 8359 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:82.50 stddev:3.63 (4.4%) stddev-sans-first:3.72 22:35:25 INFO - PROCESS | 8359 | Values: 81.0 89.0 81.0 87.0 81.0 90.0 82.0 83.0 81.0 81.0 22:35:25 INFO - PROCESS | 8359 | 22:35:25 INFO - PROCESS | 8359 | [#11] stanford-crypto-ccm Cycles:10 Average:147.30 Median:146.50 stddev:10.59 (7.2%) stddev-sans-first:11.06 22:35:25 INFO - PROCESS | 8359 | Values: 142.0 136.0 149.0 150.0 146.0 144.0 147.0 144.0 175.0 140.0 22:35:25 INFO - PROCESS | 8359 | 22:35:25 INFO - PROCESS | 8359 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.20 Median:173.00 stddev:2.66 (1.5%) stddev-sans-first:2.55 22:35:25 INFO - PROCESS | 8359 | Values: 169.0 172.0 169.0 176.0 171.0 174.0 171.0 170.0 176.0 174.0 22:35:25 INFO - PROCESS | 8359 | 22:35:25 INFO - PROCESS | 8359 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:2.79 (4.1%) stddev-sans-first:2.95 22:35:25 INFO - PROCESS | 8359 | Values: 69.0 67.0 69.0 67.0 67.0 70.0 65.0 68.0 66.0 75.0 22:35:25 INFO - PROCESS | 8359 | -------- Summary: end -------- 22:35:25 INFO - PROCESS | 8359 | 22:35:26 INFO - PROCESS | 8359 | [Parent 8359] WARNING: pipe error (77): Connection reset by peer: file /builds/slave/m-cen-l64-pgo-0000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 322 22:35:26 INFO - TEST-INFO | 8359: exit 0 22:35:26 INFO - TEST-OK | kraken | took 62894ms 22:35:26 INFO - SUITE-END | took 1178s 22:35:26 INFO - Completed test suite (00:19:38) 22:35:26 INFO - javascript benchmark 22:35:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7074.111886702247, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3106.5961425014752, 3135.4983202687577, 3169.5721077654525, 3180.4275230458506, 3192.6807319268078, 5483.506484416407, 5501.587380946425, 5545.3622833374175, 5567.220589117527, 5570.220169176318, 5504.559635229182, 5513.255710479084, 5527.751251193696, 5549.667019978804, 5552.333719953601, 4956.479569645189, 4985.052839960405, 5007.84976450707, 5029.47190544993, 5051.747412629354, 5040.143175660129, 5110.029094472038, 5114.6164037697135, 5116.283720279164, 5146.588272938156, 4886.560209581119, 4937.210046392596, 5009.724465154415, 5054.064997975386, 5065.822696205633, 4887.0, 4907.288443175756, 4938.432080310774, 4969.4036715594, 5021.598272138257, 4904.264360345941, 4932.679375840559, 4935.777889994959, 4938.08645400602, 4971.7762700678195, 5298.364196296469, 5419.864503387447, 5431.266778984826, 5434.91847622286, 5474.042042642522, 5699.544036477072, 5794.246747922743, 5803.941960580382, 5855.736491857877, 5987.91018134724, 5937.7921772737745, 5962.3739507351975, 5978.910316345258, 5981.581289309706, 5987.6108052976415, 5497.642653227527, 5508.476694713996, 5526.088195447786, 5540.750666220029, 5541.972290138564, 5795.217645617788, 5816.2148110005455, 5932.40675932412, 5990.400959904062, 6006.729697163638, 5736.971315143398, 5745.626534275259, 5791.160281759206, 5807.738651760681, 5855.2973643163095, 5705.657660540381, 5785.04584554303, 5873.618214816023, 5880.470757631833, 5896.911546326808, 5764.769409223584, 5783.971080144656, 5820.505257053198, 5836.562257830679, 5928.288605367384, 5784.537237021028, 5858.0, 5876.882462350729, 5886.293644762656, 5888.882222355614, 4469.262571675702, 4499.910001799945, 4509.346144808985, 4510.188166130128, 4561.24739417999, 3926.489556357655, 3963.246983073207, 3965.365541513344, 4037.6164264394833, 4060.4315395844606, 5538.196961440569, 5640.492355687926, 5646.717664116778, 5647.802326918538, 5710.628809127394, 5895.233619629421, 5943.286805583271, 5945.375735547792, 5957.046872500379, 5957.6127551709, 5396.406395296514, 5438.102713052381, 5491.2312276281355, 5531.363893152339, 5614.69119198448, 4914.778834952435, 4914.975425122923, 4926.359573255526, 4962.677425967373, 4972.627052971042, 6004.54965877561, 6007.30915944672, 6020.458158765732, 6021.0, 6022.90965635507, 5748.885022299447, 5802.042662960733, 5846.619969701956, 5861.062230043172, 5942.049272116441, 5973.954557952427, 5976.0, 5996.340402555803, 6019.699015049143, 6038.064100064497, 5748.051571490824, 5859.44335288147, 5865.5600829937075, 5869.413058694267, 5938.020226662552, 5963.612365196248, 5964.761409543569, 5965.880682386415, 5970.5522085844605, 5973.462388384893, 5570.053090974463, 5805.796797112081, 5807.274090738658, 5808.07070868659, 5812.389699081705, 5586.994341018493, 5591.524720398812, 5592.664440133605, 5651.208830763779, 5657.660540367591, 5593.972030139823, 5605.551555875439, 5621.213030175697, 5686.601937864475, 5714.485696287354, 5861.0, 5885.234919460443, 5893.381194974638, 5900.43945825146, 5950.702464876652, 5645.0, 5713.485786279255, 5728.398518155534, 5758.107493338539, 5764.394738552392], "value": 5411.150206315484, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.3014652270753, 579.1515429895205, 584.1588113117111, 587.7766448749475, 588.529176658673, 39547.209055818865, 41413.58586414135, 41421.79289103554, 44636.55363446364, 44638.33042504365, 41992.0, 42107.0, 42548.57451425493, 42626.36060459088, 42938.78530607351, 8703.912960870373, 8870.979837318726, 8899.421537600068, 8900.109989001114, 8905.821883562325, 8751.781205469882, 8753.518556479392, 8761.474311541297, 8770.649174033031, 8784.121587841197, 8776.60505277264, 8816.206541411271, 8816.955915220415, 8841.11588841114, 8879.911200888006, 8839.24866386358, 8872.15714507124, 8881.0, 8890.244329232022, 8902.554872256425, 8541.82916341676, 8608.354373422018, 8658.783530411727, 8679.826403471958, 8725.825483490358, 40507.0, 40770.38844417336, 40805.59194408048, 40883.18233635311, 40897.0, 3113.9065828025196, 3228.176814912206, 3237.919052023695, 3266.4610339293986, 3286.342731453719, 29914.55128173079, 30063.398732025456, 30147.698523014707, 30159.246018849484, 30928.845355773075, 4214.883055990165, 4293.098449325646, 4323.502797178333, 4425.867223983286, 4500.347449619787, 229200.0, 229977.0, 230306.0, 231119.9999999983, 231169.0, 55805.0, 55969.720151398986, 56116.71941640266, 56262.71868640713, 56274.43725562774, 57767.422325776206, 57931.13103303454, 57955.71022144862, 57981.420185798444, 58409.41590584125, 14987.775183372258, 15148.772768408482, 15156.848431515764, 15220.771688424682, 15223.923880380527, 11500.309981401142, 11578.47896844644, 11605.941970290263, 11618.593349232737, 11630.476628551736, 16074.678506429806, 16313.755293670605, 16413.42553010663, 16517.174141293126, 17053.232604532826, 5800.9129863052085, 5985.700714964321, 6026.337102918676, 6119.716198660955, 6231.719572619243, 909.8544232922833, 989.7228775942604, 1057.9206559508068, 1101.5703875488566, 1112.799696054718, 29850.552241716392, 30806.0, 30988.84505577503, 31476.0, 32126.83936580302, 1059.3908502610875, 1088.6244245735209, 1092.7869065532304, 1109.3233127792041, 1130.4347826086957, 14977.700445991019, 16205.918970405073, 16286.51140465788, 16440.342386304652, 16624.58438539022, 495729.0, 502412.0, 503688.0, 503834.0, 504256.0, 53691.0, 54022.0, 54119.72940135274, 54419.45580544223, 54901.1764823528, 1310.7313000834806, 1348.6560926963562, 1368.9110207836459, 1373.9931300343435, 1381.5717127690448, 27875.0, 29923.401531968804, 30239.546406804355, 30480.695193047784, 30574.0, 48907.75546122246, 49838.750806245735, 50011.74994125006, 50177.74911125421, 50179.49820501894, 330867.0, 333651.0, 333661.0, 334085.0, 337287.0, 26285.605715913895, 26872.193834185007, 27139.18582442451, 27236.727632723418, 27257.31856703598, 44560.0, 44713.77643111894, 45249.0, 45319.546804531536, 45710.77144614256, 37436.812815935744, 37758.244835103695, 38203.80898095492, 39473.210535789694, 39853.0, 37380.0, 38033.61966380301, 38158.0, 38676.41985370166, 39013.21973560456, 38117.61882381252, 39307.0, 39605.0, 41148.79425602972, 41617.79191104025, 30616.540751888293, 34256.82871585726, 34894.0, 35485.64514354926, 35807.641923581476, 27396.712394512786, 27459.588106178824, 27619.86190069037, 27741.28146771478, 27812.582811258253], "value": 18890.479486013985, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.1901773152261, 373.4584851964651, 375.2326492323199, 392.0668808236397, 394.3650722337037, 17251.0, 18723.812761872377, 19085.522861928443, 19423.611527769455, 19652.213911443527, 18378.908105459454, 18411.53971150722, 18882.905585472054, 18895.149718262677, 18930.242790288372, 5464.508194262516, 5544.500994910457, 5777.133429985514, 5785.0, 5785.595008349417, 5591.189277554752, 5706.258186435757, 5717.171010203539, 5721.0, 5726.284214473191, 5500.28496295483, 5579.581531385163, 5634.0703783875615, 5663.745131469073, 5672.744726487318, 5581.776728930838, 5617.101263797773, 5656.547476201915, 5664.971675141598, 5697.088465845465, 5007.5993920486635, 5019.723915184663, 5032.169692000815, 5042.470540593222, 5087.796488140507, 21971.0, 22129.446763831034, 22156.667649985262, 22199.889000555057, 22235.666465003036, 2196.3081629286726, 2264.8074913632363, 2294.265834932822, 2439.4633180700216, 2813.141991692533, 13639.181649101085, 14100.153990760587, 14125.364358603887, 14572.70854582913, 15006.399744010227, 1588.7140314743342, 1647.2422685564654, 1678.2951160512614, 1679.9160041997973, 1752.8860624059523, 75703.62148189278, 81538.59230703868, 81971.18028819695, 82454.0, 82815.23401957707, 10450.320729152581, 10617.469126543796, 10818.188635852342, 10920.2901811382, 11585.073194144617, 14718.541142831426, 14843.851561484464, 14914.030588011745, 14935.327910244065, 14963.40146394132, 7294.197638259787, 7626.42801789868, 7774.65014074368, 7820.804479888048, 7832.765017049498, 7056.54132481387, 7073.398761105261, 7267.491275610657, 7368.336849683555, 7379.114506259283, 4490.865274041718, 4490.865274041784, 4508.594226519564, 4545.727256364628, 4613.261878099488, 1867.2530987604796, 1895.5829717462411, 1934.6324198402258, 1972.4122081724063, 1981.346155768593, 909.4634165842052, 941.924646028316, 953.68051702679, 965.3676841668719, 1035.4253389368973, 17568.209430575655, 18802.341918032802, 18857.905710471634, 19105.80894191068, 19231.807681923, 906.5286051253312, 953.8283109040301, 957.5403806173076, 958.5063692198523, 962.4225464721111, 9925.950370248103, 10033.648822291185, 11278.943605281922, 11693.707657308636, 11727.824082638766, 426552.0, 429100.0, 442861.0, 444393.0, 450044.0, 57116.714416428484, 73481.0, 95083.0, 96302.55546166813, 96850.51574742081, 1019.2559431614962, 1048.7430579507916, 1060.0141868062622, 1097.4238524774398, 1099.2250463423268, 16222.26999785036, 16794.66410671755, 17405.912970435067, 17440.73838892392, 17806.46580602532, 35860.92417227487, 41221.587784122974, 41260.58739412567, 42059.7897010513, 42417.151656967304, 54143.72928135334, 56859.71570142123, 57335.0, 58358.0, 60117.69941150266, 8029.0, 8131.918680813116, 8291.559949373706, 8514.361422893431, 8573.528455934984, 9175.541222938693, 11871.940640296743, 12547.874521254671, 12892.935535322264, 12985.48058077704, 11413.828792568283, 11641.53433862636, 11884.643460696192, 11922.821157682469, 11982.64052078439, 11229.66311010671, 11294.491747871201, 11400.315981041163, 11521.423928803693, 11600.0, 11214.990650841464, 11499.942500287445, 11570.132240082195, 11837.585684501, 12168.087393445705, 7003.369696727319, 7355.485116042039, 7422.628868556442, 7673.6546855390525, 8904.688335908471, 9724.416535007922, 11309.321440713584, 11643.41782910834, 11952.34262115592, 12101.818472723093], "value": 8993.254135320689, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1431.5776845830483, 1461.0, 1596.6886457140854, 1715.305301352951, 1766.0639860873741, 7353.852922941538, 7590.58251796151, 8277.627506762195, 8868.201861832435, 8884.777880552982, 8292.875606865902, 8556.786080347994, 8559.186877246651, 8730.476171429718, 8849.469031858092, 2183.912643494258, 2225.5771403433378, 2225.6772767948637, 2228.821694264455, 2230.565039817236, 2177.7822217778175, 2194.813440857529, 2222.388843068153, 2230.386643672987, 2234.486068204314, 2144.549644574641, 2148.5702859428097, 2152.9138834446603, 2156.1267686586957, 2162.0378931375544, 2097.6119417907735, 2118.936431907045, 2120.7985241402043, 2128.797764212413, 2140.5076832328496, 2162.091921393003, 2162.318869556085, 2175.4996350839237, 2187.978120218809, 2203.6584329428965, 8681.435706679045, 8799.296056315543, 8818.86771698425, 8827.823443531093, 8848.778780530474, 4999.32509111269, 5016.423111342206, 5073.162928116893, 5083.872903177413, 5146.0, 3141.2303985523463, 3265.510173473998, 3300.669933006704, 3315.7347412207205, 3348.5814273215847, 1010.6361709784471, 1030.5311083457009, 1056.1920131099714, 1068.9518971646294, 1078.1859695929602, 11472.369019703912, 11588.478518466689, 11607.76784464306, 11623.825642615368, 11728.413579321084, 4458.509563947963, 4494.191045611821, 4605.746683932349, 4621.168189725814, 4647.86056418308, 9968.252381071303, 10024.899751002542, 10030.799384012278, 10038.498075096362, 10044.748881277881, 5189.0, 5192.350956130484, 5203.895922081537, 5204.271402003723, 5215.791368345223, 3982.6415622593527, 4516.3902873112365, 4574.268117101315, 4825.469198388175, 4830.806767729251, 3740.495033170542, 3754.2679177560112, 3898.181381909774, 3899.5515515715488, 3902.0929407590957, 1196.796544587405, 1207.3902679146975, 1208.945597448117, 1210.7396909664287, 1215.1554669504785, 873.6811063961735, 880.7093659092612, 882.3250213586612, 898.869663898731, 916.5783739479914, 5348.171033489815, 5455.399906010336, 5479.671219726829, 5509.862253443615, 5558.138488534284, 406.3275279412577, 417.8433087592153, 436.89296122449565, 437.4728452215073, 438.0538037838254, 3556.751027428107, 3717.665410113049, 3735.533058367704, 3850.364689826203, 3869.729118961702, 10723.624673136559, 11106.833397499044, 11131.165162612837, 11153.10775137987, 11209.887901120885, 10361.740956475998, 11115.944420278009, 11142.721431964104, 11159.832602510969, 11159.939805718444, 8042.557659328793, 8396.748097557083, 8397.664093436317, 8400.873986890201, 8417.368697347601, 5784.971075144597, 5873.5594830388745, 5916.171735957056, 5920.644761314335, 6028.487578555872, 9662.420254784736, 9666.516674166403, 9691.176250018827, 9693.224542036762, 9699.9030009699, 9625.470599117116, 9937.602495900372, 10470.581176752845, 10473.371597704163, 10648.307859989076, 7493.550386976799, 7578.962105189439, 7853.214678532101, 7899.68401263943, 7923.326517246099, 8861.64553417856, 8952.776180595276, 8958.552072396484, 8963.372563920462, 8974.237189838937, 7553.622318884144, 7572.621368931421, 7763.573003484863, 7777.0, 8059.153788852086, 7673.0, 7692.461527693008, 7761.844763104594, 7784.88322675149, 7871.921280787119, 6731.1922569292, 6853.040574319699, 6854.074699915447, 6858.485613578901, 6871.793846184622, 4790.976045119752, 4844.273358996038, 4910.92633610489, 4963.354763880672, 5090.592752579859, 4946.604271658331, 4948.05986862495, 4987.60099192071, 5007.098722230034, 5187.4553171916405], "value": 4410.458358143826, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.778637167611, 314.5690404146319, 321.9517072439133, 322.8708516593362, 325.96088469383676, 5413.296271484712, 5574.944250557493, 5637.294098832558, 5666.575006874486, 5681.630694004892, 5430.429804870481, 5498.945010549904, 5538.224648549196, 5538.501534861862, 5543.673795722574, 4296.334068219431, 4296.377025331325, 4306.892327691801, 4314.870553883373, 4318.935215971763, 4216.346466297713, 4256.2764330063965, 4272.658187345005, 4333.4799824021, 4336.6530677545725, 4232.703710740249, 4240.936385954213, 4246.617804397603, 4249.575042495741, 4254.723442976197, 4197.748135111872, 4211.073563815956, 4236.563975713962, 4246.426732391149, 4252.278541733293, 3723.920063181674, 3738.7195960302815, 3739.607341229159, 3748.812559372048, 3762.435634654796, 5063.620228482879, 5315.521603055705, 5357.312446579315, 5365.382980957162, 5372.489613486712, 4848.22428411456, 4849.442314133849, 4861.51384861511, 4870.172070747982, 4875.195592727196, 5398.541124004464, 5781.392953739839, 5789.565782566325, 5789.652620842763, 5795.362510123883, 3980.870234424569, 4000.9199816003515, 4003.499562554681, 4009.7393669411395, 4013.137175507251, 5922.170896074553, 5942.3166335871065, 5982.820515384546, 6004.6997650117755, 6011.609245399035, 4002.399640053957, 4136.875893723193, 4151.709380343347, 4152.190322887008, 4172.602178270253, 4117.649999749995, 4123.443335149776, 4130.690198235145, 4169.91660166795, 4230.767307798039, 4787.210110331756, 4800.73595952219, 4820.794801299675, 4820.855374338776, 4828.275758636162, 5697.436153730755, 5788.507976822018, 5806.4193580641595, 5808.680522571215, 5858.794942177004, 1409.936552855124, 1425.4369524037947, 1439.4961763382732, 1439.6904665496968, 1439.820022497188, 838.6477679374677, 871.8953725552974, 871.930245580352, 876.5179151466668, 888.311558542135, 4869.123557759566, 4888.877778055506, 4912.975435122801, 4918.8770280743265, 4925.162722337212, 5196.0, 5238.738063096906, 5250.2411692082815, 5274.7626356814035, 5286.5726253911225, 4732.81679580105, 4852.4662287148385, 4981.501849814989, 5011.273365362002, 5033.395992480926, 2785.220138361262, 2785.2340606333014, 2785.6378670773074, 2799.740116947382, 2818.0969357440094, 5273.0, 5273.472652734696, 5314.362276526842, 5395.676259424368, 5428.6199966002005, 4987.950120498748, 5125.384953805493, 5215.269862219292, 5244.685318880879, 5253.317068781034, 5243.449437809051, 5293.655912365684, 5315.521603055744, 5321.467853214647, 5321.760520776575, 5139.357580302462, 5185.896282074413, 5210.869728256824, 5271.8682032947945, 5272.62372231055, 4932.53140951609, 5072.807890145887, 5102.744862756922, 5104.642675012714, 5148.06947394727, 5273.683578985273, 5281.8679533010445, 5299.284596579412, 5308.309919710413, 5329.840104796862, 3662.1689155422287, 3678.5585729712607, 3944.994026523333, 4127.690423218331, 4164.459150114477, 5901.232839730807, 5917.822465326047, 5933.258342707161, 5968.164456976114, 6002.939970600238, 5706.828795136153, 5734.534150315238, 5783.797567085132, 5814.389489103583, 5862.472377486047, 5469.425710300361, 5626.0, 5627.634203776742, 5638.2670252866865, 5684.346300175533, 5729.455701708331, 5732.254806875079, 5789.334226563999, 5796.594413318426, 5812.94187058124, 5532.30846144232, 5723.170140329712, 5769.68266745333, 5786.132080188006, 5817.360090389969, 5647.576431767716, 5715.2855893013375, 5744.569157313134, 5766.077427611562, 5766.567507437043], "value": 4196.139315860525, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [687.1891168421263, 788.8027993001749, 791.6041979010497, 807.8909347238122, 811.8619834628113, 14998.100113993169, 15663.765043524341, 15681.921590392047, 15726.606834829136, 15806.525804225863, 14860.405583776663, 14953.7009259815, 14973.475928342483, 15011.474598389059, 15024.774628380583, 780.1457404142483, 793.7817100297422, 806.818465845186, 809.5830647216688, 816.7549735079482, 803.3733687723585, 808.5270116981573, 809.2676128104075, 811.2455416462687, 813.5484805932705, 841.3563623827777, 843.2874221283037, 843.886075379822, 844.6959094725894, 848.3425345357366, 833.1626715151294, 838.4466252273501, 839.2866063845744, 842.103160134461, 844.0293662288386, 617.7652492053036, 618.4990157972057, 619.6437048697018, 622.1072760588524, 625.1841347042108, 15402.537923862303, 15607.45373911919, 15651.139187344692, 15687.607809804733, 15714.68570628581, 14008.089474184248, 14035.263123690884, 14047.578572642837, 14153.638600111079, 14244.145351278956, 11442.141839361999, 11513.39283484583, 11559.190856639954, 11690.824637630443, 11781.175317727762, 3482.2861313430685, 3483.6864682178725, 3493.353729560014, 3505.0886769439876, 3693.778373297611, 60374.39625603732, 61844.07233891495, 75661.62169189118, 78167.60916195382, 78335.60832195803, 11052.834207486894, 11179.105671546256, 11311.943440282746, 11316.37759923212, 11364.772704546029, 20799.0, 20811.167553298, 20814.271500497714, 20846.166153353697, 20876.895615521826, 7892.921070789219, 7944.483608565425, 8030.879536806952, 8120.4977079240525, 8303.0, 4482.9775851121185, 4551.5676010778925, 4591.943852913849, 4607.493175750665, 4703.0593881223895, 3212.903612891617, 3284.6058472983395, 3296.423125952949, 3298.620658624289, 3307.1732066983254, 584.9912251316233, 586.0, 586.4721750424652, 598.4912824099481, 616.1281786272464, 695.2942763095463, 696.1715558485387, 700.6531766775479, 707.5507053021369, 707.9079719636414, 8315.168483151636, 8384.329253659693, 8983.371164018456, 9060.54697265134, 9128.908710912805, 672.3008071605573, 684.6953105867841, 687.8108520156997, 712.3377494299821, 713.5076797010047, 4087.3664581989838, 4237.385579091015, 4257.361395790656, 4487.439070116236, 4545.3863728396245, 66069.33930660631, 83208.0, 84210.0, 106181.46909265404, 121831.39084304699, 97860.51069744748, 99044.51433228508, 99445.0, 100329.49835250922, 102263.4886825576, 84933.0, 87610.0, 88951.55524222337, 91836.0, 93877.5306123465, 8122.268995790408, 8324.0, 8396.706115285935, 8412.831743365221, 8720.345974052098, 52438.47561524336, 53331.200351941494, 54079.459205407446, 54081.0, 55140.0, 63968.28333024965, 72751.0, 74525.62737186279, 79573.60213198897, 81543.59228203821, 12452.626421207378, 12566.623001309976, 12711.872881271069, 12763.425645845773, 12820.679483013, 14327.426902924184, 14600.488982885548, 14807.0, 15497.45758898433, 15716.528504144893, 12792.936035319764, 13341.66645833862, 13647.317634118055, 13884.166949983033, 14429.062110962754, 13614.0, 13817.585472435843, 13907.30463476802, 14064.226467543975, 14499.347529360994, 12404.751904962031, 13590.0, 13659.112157709716, 13719.519816806363, 13824.723505530033, 10795.676129716121, 11207.383593902414, 11318.26431281964, 11348.375839328915, 11482.82775758381, 9339.439633622005, 10383.792324153626, 10399.948000260252, 11254.549818007188, 11309.912758942452], "value": 7365.536371903143, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1523.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 112.0, 112.0, 111.0, 114.0, 113.0, 113.0, 112.0, 113.0, 113.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 124.0, 125.0, 160.0, 125.0, 126.0, 126.0, 129.0, 154.0, 123.0], "value": 135.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 167.0, 165.0, 168.0, 167.0, 163.0, 164.0, 165.0, 163.0, 164.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 114.0, 76.0, 77.0, 75.0, 75.0, 106.0, 77.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 112.0, 83.0, 85.0, 83.0, 105.0, 84.0, 85.0, 109.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 146.0, 149.0, 146.0, 149.0, 147.0, 148.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 86.0, 86.0, 85.0, 86.0, 85.0, 84.0, 85.0, 84.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 55.0, 55.0, 55.0, 56.0, 54.0, 54.0, 55.0, 53.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 61.0, 63.0, 61.0, 62.0, 60.0, 61.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 89.0, 81.0, 87.0, 81.0, 90.0, 82.0, 83.0, 81.0, 81.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 136.0, 149.0, 150.0, 146.0, 144.0, 147.0, 144.0, 175.0, 140.0], "value": 147.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 172.0, 169.0, 176.0, 171.0, 174.0, 171.0, 170.0, 176.0, 174.0], "value": 172.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 69.0, 67.0, 67.0, 70.0, 65.0, 68.0, 66.0, 75.0], "value": 68.3, "unit": "score"}]}]} 22:35:27 INFO - Return code: 0 22:35:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:35:27 ERROR - # TBPL SUCCESS # 22:35:27 INFO - Running post-action listener: _resource_record_post_action 22:35:27 INFO - [mozharness: 2016-10-20 05:35:27.138708Z] Finished run-tests step (success) 22:35:27 INFO - Running post-run listener: _resource_record_post_run 22:35:27 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 408813568; Read time: 4; Write time: 258768 22:35:27 INFO - TinderboxPrint: CPU usage
13.5% 22:35:27 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 22:35:27 INFO - TinderboxPrint: I/O write bytes / time
408,813,568 / 258,768 22:35:27 INFO - TinderboxPrint: CPU idle
8,245.3 (86.5%) 22:35:27 INFO - TinderboxPrint: CPU user
1,222.4 (12.8%) 22:35:27 INFO - TinderboxPrint: Swap in / out
0 / 0 22:35:27 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 120590336; Read time: 0; Write time: 68240 22:35:27 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 288223232; Read time: 0; Write time: 190528 22:35:27 INFO - Running post-run listener: _upload_blobber_files 22:35:27 INFO - Blob upload gear active. 22:35:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:35:27 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:35:27 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:35:27 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:35:28 INFO - (blobuploader) - INFO - Open directory for files ... 22:35:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:35:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:35:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:35:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:35:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:35:31 INFO - (blobuploader) - INFO - Done attempting. 22:35:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:35:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:35:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:35:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:35:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:35:32 INFO - (blobuploader) - INFO - Done attempting. 22:35:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:35:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:35:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:35:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:35:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:35:33 INFO - (blobuploader) - INFO - Done attempting. 22:35:33 INFO - (blobuploader) - INFO - Iteration through files over. 22:35:33 INFO - Return code: 0 22:35:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:35:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:35:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ec52326d2ed4a8d4c3ea056bff8ab04f9a33b6fd8ce89d0e00c93ee56b712ae3a07f0f4738df71a3e05755474789ea01bde3635543b37bf5f5b67cb38b140441", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1e889a2a85d1bc96d804ed13120f37cae5b5409c6a3a2d26eddb692c753871f3fa114d3145d1b3e7b2203704fda072a6c5111b54b180fedd4e9717ccc5c9d06", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73157f5fa8bae5c64f2f0b79d97f6bec488752611dc992f589ab54427c16d1e30014d2583884ac940d1dfd86ad57884e55b39ae9582d66c94dcf88088706094a"} 22:35:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:35:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:35:33 INFO - Contents: 22:35:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ec52326d2ed4a8d4c3ea056bff8ab04f9a33b6fd8ce89d0e00c93ee56b712ae3a07f0f4738df71a3e05755474789ea01bde3635543b37bf5f5b67cb38b140441", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1e889a2a85d1bc96d804ed13120f37cae5b5409c6a3a2d26eddb692c753871f3fa114d3145d1b3e7b2203704fda072a6c5111b54b180fedd4e9717ccc5c9d06", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73157f5fa8bae5c64f2f0b79d97f6bec488752611dc992f589ab54427c16d1e30014d2583884ac940d1dfd86ad57884e55b39ae9582d66c94dcf88088706094a"} 22:35:33 INFO - Running post-run listener: copy_logs_to_upload_dir 22:35:33 INFO - Copying logs to upload dir... 22:35:33 INFO - mkdir: /builds/slave/test/build/upload/logs 22:35:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.733915 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-10-19 22:35:33.194348) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 22:35:33.198160) ========= 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-1476940283.656760-1317964367 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/ec52326d2ed4a8d4c3ea056bff8ab04f9a33b6fd8ce89d0e00c93ee56b712ae3a07f0f4738df71a3e05755474789ea01bde3635543b37bf5f5b67cb38b140441", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1e889a2a85d1bc96d804ed13120f37cae5b5409c6a3a2d26eddb692c753871f3fa114d3145d1b3e7b2203704fda072a6c5111b54b180fedd4e9717ccc5c9d06", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73157f5fa8bae5c64f2f0b79d97f6bec488752611dc992f589ab54427c16d1e30014d2583884ac940d1dfd86ad57884e55b39ae9582d66c94dcf88088706094a"} build_url:https://queue.taskcluster.net/v1/task/P8kw7l04T0Gj3BpiNWZcEA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011299 build_url: 'https://queue.taskcluster.net/v1/task/P8kw7l04T0Gj3BpiNWZcEA/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/ec52326d2ed4a8d4c3ea056bff8ab04f9a33b6fd8ce89d0e00c93ee56b712ae3a07f0f4738df71a3e05755474789ea01bde3635543b37bf5f5b67cb38b140441", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1e889a2a85d1bc96d804ed13120f37cae5b5409c6a3a2d26eddb692c753871f3fa114d3145d1b3e7b2203704fda072a6c5111b54b180fedd4e9717ccc5c9d06", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73157f5fa8bae5c64f2f0b79d97f6bec488752611dc992f589ab54427c16d1e30014d2583884ac940d1dfd86ad57884e55b39ae9582d66c94dcf88088706094a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 22:35:33.228447) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 22:35:33.229211) ========= 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-1476940283.656760-1317964367 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004427 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 22:35:33.314736) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 22:35:33.315606) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 22:35:33.316528) ========= ========= Total master_lag: 0.19 =========