builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-002 starttime: 1478823190.87 results: success (0) buildid: 20161110133014 builduid: 7906caadde4f4355ab621da60378213e revision: d38d06f85ef5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-10 16:13:10.869350) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-10 16:13:10.869791) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-10 16:13:10.870064) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-10 16:13:10.884666) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 16:13:10.884952) ========= 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=a0d2d2de893abaa8702a9954000001a7-1478822497.277586-596989545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-10 16:13:11-- 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% 45.5M=0s 2016-11-10 16:13:11 (45.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124668 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 16:13:11.027938) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 16:13:11.028438) ========= 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=a0d2d2de893abaa8702a9954000001a7-1478822497.277586-596989545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014558 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 16:13:11.079037) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 16:13:11.079406) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d38d06f85ef5 --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 d38d06f85ef5 --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=a0d2d2de893abaa8702a9954000001a7-1478822497.277586-596989545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-10 16:13:11,592 Setting DEBUG logging. 2016-11-10 16:13:11,592 attempt 1/10 2016-11-10 16:13:11,592 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d38d06f85ef5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-10 16:13:11,892 unpacking tar archive at: mozilla-central-d38d06f85ef5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.634318 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 16:13:11.726860) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-10 16:13:11.727143) ========= script_repo_revision: d38d06f85ef5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-10 16:13:11.727528) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-10 16:13:11.727794) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-10 16:13:11.735844) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-11-10 16:13:11.736128) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1478822497.277586-596989545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:13:12 INFO - MultiFileLogger online at 20161110 16:13:12 in /builds/slave/test 16:13:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:13:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:13:12 INFO - {'append_to_log': False, 16:13:12 INFO - 'base_work_dir': '/builds/slave/test', 16:13:12 INFO - 'blob_upload_branch': 'Firefox', 16:13:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:13:12 INFO - 'branch': 'Firefox', 16:13:12 INFO - 'buildbot_json_path': 'buildprops.json', 16:13:12 INFO - 'config_files': ('talos/linux_config.py',), 16:13:12 INFO - 'default_actions': ('clobber', 16:13:12 INFO - 'read-buildbot-config', 16:13:12 INFO - 'download-and-extract', 16:13:12 INFO - 'populate-webroot', 16:13:12 INFO - 'create-virtualenv', 16:13:12 INFO - 'install', 16:13:12 INFO - 'run-tests'), 16:13:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:13:12 INFO - 'download_minidump_stackwalk': True, 16:13:12 INFO - 'download_symbols': 'ondemand', 16:13:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:13:12 INFO - 'tooltool.py': '/tools/tooltool.py', 16:13:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:13:12 INFO - '/tools/misc-python/virtualenv.py')}, 16:13:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:13:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:13:12 INFO - 'installer_path': 'installer.exe', 16:13:12 INFO - 'log_level': 'info', 16:13:12 INFO - 'log_name': 'talos', 16:13:12 INFO - 'log_to_console': True, 16:13:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:13:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:13:12 INFO - 'opt_config_files': (), 16:13:12 INFO - 'pip_index': False, 16:13:12 INFO - 'sps_profile': False, 16:13:12 INFO - 'sps_profile_interval': 0, 16:13:12 INFO - 'suite': 'dromaeojs', 16:13:12 INFO - 'system_bits': '32', 16:13:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:13:12 INFO - 'title': 'talos-linux64-ix-002', 16:13:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:13:12 INFO - 'use_talos_json': True, 16:13:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:13:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:13:12 INFO - 'work_dir': 'build'} 16:13:12 INFO - [mozharness: 2016-11-11 00:13:12.342577Z] Running clobber step. 16:13:12 INFO - Running pre-action listener: _resource_record_pre_action 16:13:12 INFO - Running main action method: clobber 16:13:12 INFO - rmtree: /builds/slave/test/build 16:13:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:13:12 INFO - Running post-action listener: _resource_record_post_action 16:13:12 INFO - [mozharness: 2016-11-11 00:13:12.799913Z] Finished clobber step (success) 16:13:12 INFO - [mozharness: 2016-11-11 00:13:12.800012Z] Running read-buildbot-config step. 16:13:12 INFO - Running pre-action listener: _resource_record_pre_action 16:13:12 INFO - Running main action method: read_buildbot_config 16:13:12 INFO - Using buildbot properties: 16:13:12 INFO - { 16:13:12 INFO - "project": "", 16:13:12 INFO - "product": "firefox", 16:13:12 INFO - "script_repo_revision": "production", 16:13:12 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 16:13:12 INFO - "repository": "", 16:13:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 16:13:12 INFO - "buildid": "20161110133014", 16:13:12 INFO - "pgo_build": "True", 16:13:12 INFO - "basedir": "/builds/slave/test", 16:13:12 INFO - "buildnumber": 77, 16:13:12 INFO - "slavename": "talos-linux64-ix-002", 16:13:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:13:12 INFO - "platform": "ubuntu64_hw", 16:13:12 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 16:13:12 INFO - "branch": "mozilla-central", 16:13:12 INFO - "repo_path": "mozilla-central", 16:13:12 INFO - "revision": "d38d06f85ef5", 16:13:12 INFO - "stage_platform": "linux64-pgo", 16:13:12 INFO - "builduid": "7906caadde4f4355ab621da60378213e", 16:13:12 INFO - "slavebuilddir": "test" 16:13:12 INFO - } 16:13:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/W9uUc71YTL6aH49pyykCFw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 16:13:12 INFO - Running post-action listener: _resource_record_post_action 16:13:12 INFO - [mozharness: 2016-11-11 00:13:12.802415Z] Finished read-buildbot-config step (success) 16:13:12 INFO - [mozharness: 2016-11-11 00:13:12.802503Z] Running download-and-extract step. 16:13:12 INFO - Running pre-action listener: _resource_record_pre_action 16:13:12 INFO - Running main action method: download_and_extract 16:13:12 INFO - mkdir: /builds/slave/test/build/tests 16:13: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')]} 16:13:12 INFO - trying https://queue.taskcluster.net/v1/task/W9uUc71YTL6aH49pyykCFw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:13:12 INFO - Downloading https://queue.taskcluster.net/v1/task/W9uUc71YTL6aH49pyykCFw/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 16:13:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W9uUc71YTL6aH49pyykCFw/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 16:13:13 INFO - Downloaded 1361 bytes. 16:13:13 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:13:13 INFO - Using the following test package requirements: 16:13:13 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 16:13:13 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:13:13 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:13:13 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:13 INFO - u'jsshell-linux-x86_64.zip'], 16:13:13 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:13:13 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 16:13:13 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:13:13 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:13:13 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:13:13 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:13:13 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:13:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W9uUc71YTL6aH49pyykCFw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 16:13:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W9uUc71YTL6aH49pyykCFw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:13:13 INFO - Fetch https://queue.taskcluster.net/v1/task/W9uUc71YTL6aH49pyykCFw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:13:13 INFO - Http code: 200 16:13:13 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 16:13:13 INFO - x-amz-cf-id: UA9NPVoOPKYqop7nTUkOnnH3-KXJWobPCWmYl_j918hH1xHs9WS-jQ== 16:13:13 INFO - x-amz-version-id: lXvMA1fRqW8jGNktlE_7yS9Dh0h0o0nf 16:13:14 INFO - Expected file size: 21969270 16:13:14 INFO - Obtained file size: 21969270 16:13:18 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 16:13:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W9uUc71YTL6aH49pyykCFw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 16:13:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W9uUc71YTL6aH49pyykCFw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:13:18 INFO - Fetch https://queue.taskcluster.net/v1/task/W9uUc71YTL6aH49pyykCFw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:13:18 INFO - Http code: 200 16:13:18 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 16:13:18 INFO - x-amz-cf-id: FHApf6ezMryUnYM70bBgwJXu5FJP6HcMnPv8C7tnrXsuzbJvZhMcHA== 16:13:18 INFO - x-amz-version-id: lXvMA1fRqW8jGNktlE_7yS9Dh0h0o0nf 16:13:19 INFO - Expected file size: 21969270 16:13:19 INFO - Obtained file size: 21969270 16:13:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W9uUc71YTL6aH49pyykCFw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 16:13:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W9uUc71YTL6aH49pyykCFw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:13:23 INFO - Fetch https://queue.taskcluster.net/v1/task/W9uUc71YTL6aH49pyykCFw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 16:13:24 INFO - Http code: 200 16:13:24 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 16:13:24 INFO - x-amz-cf-id: _7lgqu7Ja1R8gpllf1f7c7tpuvvfSvT3EDFfMhBjqkxDOMOzk8c2sQ== 16:13:24 INFO - x-amz-version-id: L19gyCp4srpd8eSVrgTVHG3.ziQMyO2E 16:13:25 INFO - Expected file size: 14409038 16:13:25 INFO - Obtained file size: 14409038 16:13:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:25 INFO - trying https://queue.taskcluster.net/v1/task/W9uUc71YTL6aH49pyykCFw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:13:25 INFO - Downloading https://queue.taskcluster.net/v1/task/W9uUc71YTL6aH49pyykCFw/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 16:13:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W9uUc71YTL6aH49pyykCFw/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 16:13:28 INFO - Downloaded 59355260 bytes. 16:13:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W9uUc71YTL6aH49pyykCFw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:13:28 INFO - mkdir: /builds/slave/test/properties 16:13:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:13:28 INFO - Writing to file /builds/slave/test/properties/build_url 16:13:28 INFO - Contents: 16:13:28 INFO - build_url:https://queue.taskcluster.net/v1/task/W9uUc71YTL6aH49pyykCFw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:13:29 INFO - Running post-action listener: _resource_record_post_action 16:13:29 INFO - Running post-action listener: set_extra_try_arguments 16:13:29 INFO - [mozharness: 2016-11-11 00:13:29.183642Z] Finished download-and-extract step (success) 16:13:29 INFO - [mozharness: 2016-11-11 00:13:29.183868Z] Running populate-webroot step. 16:13:29 INFO - Running pre-action listener: _resource_record_pre_action 16:13:29 INFO - Running main action method: populate_webroot 16:13:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:13:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:13:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:13:29 INFO - '--tppagecycles', 16:13:29 INFO - '7'], 16:13:29 INFO - 'tests': ['tsvgm']}}, 16:13:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:13:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:13:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:13:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:13:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:13:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:13:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:29 INFO - 'talos_options': ['--disable-e10s'], 16:13:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:13:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:13:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:29 INFO - 'talos_options': ['--disable-e10s'], 16:13:29 INFO - 'tests': ['damp', 'tps']}, 16:13:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:29 INFO - 'tests': ['damp', 'tps']}, 16:13:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:13:29 INFO - 'tests': ['dromaeo_dom']}, 16:13:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:13:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:13:29 INFO - 'tests': ['basic_compositor_video']}, 16:13:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:13:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:13:29 INFO - 'tests': ['a11yr', 16:13:29 INFO - 'ts_paint', 16:13:29 INFO - 'tpaint', 16:13:29 INFO - 'sessionrestore', 16:13:29 INFO - 'sessionrestore_no_auto_restore', 16:13:29 INFO - 'tabpaint']}, 16:13:29 INFO - 'other-e10s': {'tests': ['a11yr', 16:13:29 INFO - 'ts_paint', 16:13:29 INFO - 'tpaint', 16:13:29 INFO - 'sessionrestore', 16:13:29 INFO - 'sessionrestore_no_auto_restore', 16:13:29 INFO - 'tabpaint']}, 16:13:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:13:29 INFO - 'ts_paint', 16:13:29 INFO - 'tpaint', 16:13:29 INFO - 'sessionrestore', 16:13:29 INFO - 'sessionrestore_no_auto_restore', 16:13:29 INFO - 'tabpaint']}, 16:13:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:13:29 INFO - 'ts_paint', 16:13:29 INFO - 'tpaint', 16:13:29 INFO - 'sessionrestore', 16:13:29 INFO - 'sessionrestore_no_auto_restore', 16:13:29 INFO - 'tabpaint']}, 16:13:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:13:29 INFO - 'tests': ['a11yr', 16:13:29 INFO - 'ts_paint', 16:13:29 INFO - 'tpaint', 16:13:29 INFO - 'sessionrestore', 16:13:29 INFO - 'sessionrestore_no_auto_restore', 16:13:29 INFO - 'tabpaint']}, 16:13:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:13:29 INFO - 'tests': ['a11yr', 16:13:29 INFO - 'ts_paint', 16:13:29 INFO - 'tpaint', 16:13:29 INFO - 'sessionrestore', 16:13:29 INFO - 'sessionrestore_no_auto_restore', 16:13:29 INFO - 'tabpaint']}, 16:13:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:13:29 INFO - 'tests': ['tsvgx', 16:13:29 INFO - 'tsvgr_opacity', 16:13:29 INFO - 'tart', 16:13:29 INFO - 'tscrollx', 16:13:29 INFO - 'cart']}, 16:13:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:13:29 INFO - 'tsvgr_opacity', 16:13:29 INFO - 'tart', 16:13:29 INFO - 'tscrollx', 16:13:29 INFO - 'cart']}, 16:13:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:29 INFO - 'talos_options': ['--disable-e10s'], 16:13:29 INFO - 'tests': ['tp5o']}, 16:13:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:29 INFO - 'tests': ['tp5o']}, 16:13:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:29 INFO - 'talos_options': ['--disable-e10s', 16:13:29 INFO - '--xperf_path', 16:13:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:13:29 INFO - 'tests': ['tp5n']}, 16:13:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:29 INFO - 'talos_options': ['--xperf_path', 16:13:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:13:29 INFO - 'tests': ['tp5n']}}, 16:13:29 INFO - 'talos.zip': {'path': '', 16:13:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:13:29 INFO - Running post-action listener: _resource_record_post_action 16:13:29 INFO - [mozharness: 2016-11-11 00:13:29.198998Z] Finished populate-webroot step (success) 16:13:29 INFO - [mozharness: 2016-11-11 00:13:29.199086Z] Running create-virtualenv step. 16:13:29 INFO - Running pre-action listener: _resource_record_pre_action 16:13:29 INFO - Running main action method: create_virtualenv 16:13:29 INFO - Creating virtualenv /builds/slave/test/build/venv 16:13:29 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 16:13:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:13:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:13:29 INFO - Using real prefix '/usr' 16:13:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:13:29 INFO - Installing distribute.............................................................................................................................................................................................done. 16:13:31 INFO - Installing pip.................done. 16:13:31 INFO - Return code: 0 16:13:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:13:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:13:31 INFO - Reading from file tmpfile_stdout 16:13:31 INFO - Output received: 16:13:31 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) 16:13:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:13: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')]} 16:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13: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')]} 16:13:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b646b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21717b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2200790>, '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 0x2201690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2201b20>, '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': 'a0d2d2de893abaa8702a9954000001a7-1478822497.277586-596989545', '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 16:13: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', 'pip>=1.5'] in /builds/slave/test/build 16:13: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 pip>=1.5 16:13:31 INFO - Using env: {'DISPLAY': ':0', 16:13:31 INFO - 'HOME': '/home/cltbld', 16:13:31 INFO - 'LANG': 'en_US.UTF-8', 16:13:31 INFO - 'LANGUAGE': 'en_US:en', 16:13:31 INFO - 'LOGNAME': 'cltbld', 16:13:31 INFO - 'MAIL': '/var/mail/cltbld', 16:13:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:31 INFO - 'MOZ_NO_REMOTE': '1', 16:13:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:31 INFO - 'NO_EM_RESTART': '1', 16:13:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:31 INFO - 'PWD': '/builds/slave/test', 16:13:31 INFO - 'SHELL': '/bin/bash', 16:13:31 INFO - 'SHLVL': '1', 16:13:31 INFO - 'TERM': 'linux', 16:13:31 INFO - 'TMOUT': '86400', 16:13:31 INFO - 'USER': 'cltbld', 16:13:31 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1478822497.277586-596989545', 16:13:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:31 INFO - '_': '/tools/buildbot/bin/python'} 16:13:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:32 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 16:13:32 INFO - Cleaning up... 16:13:32 INFO - Return code: 0 16:13:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:13:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9b646b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21717b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2200790>, '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 0x2201690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2201b20>, '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': 'a0d2d2de893abaa8702a9954000001a7-1478822497.277586-596989545', '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 16:13:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:13:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:13:32 INFO - Using env: {'DISPLAY': ':0', 16:13:32 INFO - 'HOME': '/home/cltbld', 16:13:32 INFO - 'LANG': 'en_US.UTF-8', 16:13:32 INFO - 'LANGUAGE': 'en_US:en', 16:13:32 INFO - 'LOGNAME': 'cltbld', 16:13:32 INFO - 'MAIL': '/var/mail/cltbld', 16:13:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:32 INFO - 'MOZ_NO_REMOTE': '1', 16:13:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:32 INFO - 'NO_EM_RESTART': '1', 16:13:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:32 INFO - 'PWD': '/builds/slave/test', 16:13:32 INFO - 'SHELL': '/bin/bash', 16:13:32 INFO - 'SHLVL': '1', 16:13:32 INFO - 'TERM': 'linux', 16:13:32 INFO - 'TMOUT': '86400', 16:13:32 INFO - 'USER': 'cltbld', 16:13:32 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1478822497.277586-596989545', 16:13:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:32 INFO - '_': '/tools/buildbot/bin/python'} 16:13:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:32 INFO - Downloading/unpacking psutil>=3.1.1 16:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:13:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:13:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:13:34 INFO - Installing collected packages: psutil 16:13:34 INFO - Running setup.py install for psutil 16:13:34 INFO - building 'psutil._psutil_linux' extension 16:13:34 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 16:13:34 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 16:13:34 INFO - building 'psutil._psutil_posix' extension 16:13:34 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 16:13:34 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 16:13:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:13:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:13:34 INFO - Successfully installed psutil 16:13:34 INFO - Cleaning up... 16:13:34 INFO - Return code: 0 16:13:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:35 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 0x7f9b646b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21717b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2200790>, '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 0x2201690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2201b20>, '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': 'a0d2d2de893abaa8702a9954000001a7-1478822497.277586-596989545', '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 16:13:35 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 16:13:35 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 16:13:35 INFO - Using env: {'DISPLAY': ':0', 16:13:35 INFO - 'HOME': '/home/cltbld', 16:13:35 INFO - 'LANG': 'en_US.UTF-8', 16:13:35 INFO - 'LANGUAGE': 'en_US:en', 16:13:35 INFO - 'LOGNAME': 'cltbld', 16:13:35 INFO - 'MAIL': '/var/mail/cltbld', 16:13:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:35 INFO - 'MOZ_NO_REMOTE': '1', 16:13:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:35 INFO - 'NO_EM_RESTART': '1', 16:13:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:35 INFO - 'PWD': '/builds/slave/test', 16:13:35 INFO - 'SHELL': '/bin/bash', 16:13:35 INFO - 'SHLVL': '1', 16:13:35 INFO - 'TERM': 'linux', 16:13:35 INFO - 'TMOUT': '86400', 16:13:35 INFO - 'USER': 'cltbld', 16:13:35 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1478822497.277586-596989545', 16:13:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:35 INFO - '_': '/tools/buildbot/bin/python'} 16:13:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:13:35 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 16:13:35 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 16:13:35 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 16:13:35 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 16:13:35 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 16:13:35 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 16:13:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:13:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:13:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:13:37 INFO - Installing collected packages: mozsystemmonitor 16:13:37 INFO - Running setup.py install for mozsystemmonitor 16:13:37 INFO - Successfully installed mozsystemmonitor 16:13:37 INFO - Cleaning up... 16:13:37 INFO - Return code: 0 16:13:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9b646b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21717b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2200790>, '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 0x2201690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2201b20>, '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': 'a0d2d2de893abaa8702a9954000001a7-1478822497.277586-596989545', '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 16:13:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:13:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:13:37 INFO - Using env: {'DISPLAY': ':0', 16:13:37 INFO - 'HOME': '/home/cltbld', 16:13:37 INFO - 'LANG': 'en_US.UTF-8', 16:13:37 INFO - 'LANGUAGE': 'en_US:en', 16:13:37 INFO - 'LOGNAME': 'cltbld', 16:13:37 INFO - 'MAIL': '/var/mail/cltbld', 16:13:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:37 INFO - 'MOZ_NO_REMOTE': '1', 16:13:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:37 INFO - 'NO_EM_RESTART': '1', 16:13:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:37 INFO - 'PWD': '/builds/slave/test', 16:13:37 INFO - 'SHELL': '/bin/bash', 16:13:37 INFO - 'SHLVL': '1', 16:13:37 INFO - 'TERM': 'linux', 16:13:37 INFO - 'TMOUT': '86400', 16:13:37 INFO - 'USER': 'cltbld', 16:13:37 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1478822497.277586-596989545', 16:13:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:37 INFO - '_': '/tools/buildbot/bin/python'} 16:13:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:37 INFO - Downloading/unpacking jsonschema==2.5.1 16:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:13:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:39 INFO - Downloading functools32-3.2.3-2.tar.gz 16:13:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:13:39 INFO - warning: no files found matching '*.txt' 16:13:39 INFO - no previously-included directories found matching 'build' 16:13:39 INFO - no previously-included directories found matching 'dist' 16:13:39 INFO - no previously-included directories found matching '.git*' 16:13:39 INFO - Installing collected packages: jsonschema, functools32 16:13:39 INFO - Running setup.py install for functools32 16:13:39 INFO - warning: no files found matching '*.txt' 16:13:39 INFO - no previously-included directories found matching 'build' 16:13:39 INFO - no previously-included directories found matching 'dist' 16:13:39 INFO - no previously-included directories found matching '.git*' 16:13:39 INFO - Successfully installed jsonschema functools32 16:13:39 INFO - Cleaning up... 16:13:39 INFO - Return code: 0 16:13:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:13:39 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')]} 16:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:39 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')]} 16:13:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:39 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 0x7f9b646b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21717b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2200790>, '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 0x2201690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2201b20>, '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': 'a0d2d2de893abaa8702a9954000001a7-1478822497.277586-596989545', '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 16:13:39 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 16:13:39 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 16:13:39 INFO - Using env: {'DISPLAY': ':0', 16:13:39 INFO - 'HOME': '/home/cltbld', 16:13:39 INFO - 'LANG': 'en_US.UTF-8', 16:13:39 INFO - 'LANGUAGE': 'en_US:en', 16:13:39 INFO - 'LOGNAME': 'cltbld', 16:13:39 INFO - 'MAIL': '/var/mail/cltbld', 16:13:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:39 INFO - 'MOZ_NO_REMOTE': '1', 16:13:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:39 INFO - 'NO_EM_RESTART': '1', 16:13:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:39 INFO - 'PWD': '/builds/slave/test', 16:13:39 INFO - 'SHELL': '/bin/bash', 16:13:39 INFO - 'SHLVL': '1', 16:13:39 INFO - 'TERM': 'linux', 16:13:39 INFO - 'TMOUT': '86400', 16:13:39 INFO - 'USER': 'cltbld', 16:13:39 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1478822497.277586-596989545', 16:13:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:39 INFO - '_': '/tools/buildbot/bin/python'} 16:13:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:13:40 INFO - Cleaning up... 16:13:40 INFO - Return code: 0 16:13:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:13:40 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')]} 16:13:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:40 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')]} 16:13:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:40 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 0x7f9b646b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21717b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2200790>, '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 0x2201690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2201b20>, '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': 'a0d2d2de893abaa8702a9954000001a7-1478822497.277586-596989545', '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 16:13:40 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 16:13:40 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 16:13:40 INFO - Using env: {'DISPLAY': ':0', 16:13:40 INFO - 'HOME': '/home/cltbld', 16:13:40 INFO - 'LANG': 'en_US.UTF-8', 16:13:40 INFO - 'LANGUAGE': 'en_US:en', 16:13:40 INFO - 'LOGNAME': 'cltbld', 16:13:40 INFO - 'MAIL': '/var/mail/cltbld', 16:13:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:40 INFO - 'MOZ_NO_REMOTE': '1', 16:13:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:40 INFO - 'NO_EM_RESTART': '1', 16:13:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:40 INFO - 'PWD': '/builds/slave/test', 16:13:40 INFO - 'SHELL': '/bin/bash', 16:13:40 INFO - 'SHLVL': '1', 16:13:40 INFO - 'TERM': 'linux', 16:13:40 INFO - 'TMOUT': '86400', 16:13:40 INFO - 'USER': 'cltbld', 16:13:40 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1478822497.277586-596989545', 16:13:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:40 INFO - '_': '/tools/buildbot/bin/python'} 16:13:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:40 INFO - Downloading/unpacking blobuploader==1.2.4 16:13:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:42 INFO - Downloading blobuploader-1.2.4.tar.gz 16:13:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:13:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:13:42 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 16:13:42 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 16:13:42 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 16:13:42 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 16:13:42 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 16:13:42 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 16:13:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:13:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:13:42 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 16:13:42 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 16:13:42 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 16:13:42 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 16:13:42 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 16:13:42 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 16:13:42 INFO - Downloading docopt-0.6.1.tar.gz 16:13:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:13:43 INFO - Installing collected packages: blobuploader, requests, docopt 16:13:43 INFO - Running setup.py install for blobuploader 16:13:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:13:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:13:43 INFO - Running setup.py install for requests 16:13:43 INFO - Running setup.py install for docopt 16:13:43 INFO - Successfully installed blobuploader requests docopt 16:13:43 INFO - Cleaning up... 16:13:43 INFO - Return code: 0 16:13:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:13:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:43 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 0x7f9b646b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21717b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2200790>, '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 0x2201690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2201b20>, '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': 'a0d2d2de893abaa8702a9954000001a7-1478822497.277586-596989545', '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 16:13:43 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 16:13:43 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 16:13:43 INFO - Using env: {'DISPLAY': ':0', 16:13:43 INFO - 'HOME': '/home/cltbld', 16:13:43 INFO - 'LANG': 'en_US.UTF-8', 16:13:43 INFO - 'LANGUAGE': 'en_US:en', 16:13:43 INFO - 'LOGNAME': 'cltbld', 16:13:43 INFO - 'MAIL': '/var/mail/cltbld', 16:13:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:43 INFO - 'MOZ_NO_REMOTE': '1', 16:13:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:43 INFO - 'NO_EM_RESTART': '1', 16:13:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:43 INFO - 'PWD': '/builds/slave/test', 16:13:43 INFO - 'SHELL': '/bin/bash', 16:13:43 INFO - 'SHLVL': '1', 16:13:43 INFO - 'TERM': 'linux', 16:13:43 INFO - 'TMOUT': '86400', 16:13:43 INFO - 'USER': 'cltbld', 16:13:43 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1478822497.277586-596989545', 16:13:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:43 INFO - '_': '/tools/buildbot/bin/python'} 16:13:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:13:43 INFO - Running setup.py (path:/tmp/pip-mk73Rw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:13:43 INFO - Running setup.py (path:/tmp/pip-gRtGpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:13:44 INFO - Running setup.py (path:/tmp/pip-DoZQZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:13:44 INFO - Running setup.py (path:/tmp/pip-4Dinz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:13:44 INFO - Running setup.py (path:/tmp/pip-8Ict9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:13:44 INFO - Running setup.py (path:/tmp/pip-AwY4jC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:13:44 INFO - Running setup.py (path:/tmp/pip-xI0Sxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:13:44 INFO - Running setup.py (path:/tmp/pip-fMfwzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:13:44 INFO - Running setup.py (path:/tmp/pip-rZ3LLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:13:44 INFO - Running setup.py (path:/tmp/pip-bq19XU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:13:44 INFO - Running setup.py (path:/tmp/pip-POb4wx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:13:44 INFO - Running setup.py (path:/tmp/pip-3xNBfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:13:44 INFO - Running setup.py (path:/tmp/pip-plGaDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:13:44 INFO - Running setup.py (path:/tmp/pip-BluLQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:13:44 INFO - Running setup.py (path:/tmp/pip-S4fojI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:13:44 INFO - Running setup.py (path:/tmp/pip-6RmP5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:13:45 INFO - Running setup.py (path:/tmp/pip-kVP496-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:13:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:13:45 INFO - Running setup.py install for manifestparser 16:13:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:13:45 INFO - Running setup.py install for mozcrash 16:13:45 INFO - Running setup.py install for mozdebug 16:13:45 INFO - Running setup.py install for mozdevice 16:13:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:13:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:13:45 INFO - Running setup.py install for mozfile 16:13:45 INFO - Running setup.py install for mozhttpd 16:13:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:13:45 INFO - Running setup.py install for mozinfo 16:13:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:13:45 INFO - Running setup.py install for mozInstall 16:13:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:13:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:13:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:13:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:13:45 INFO - Running setup.py install for mozleak 16:13:46 INFO - Running setup.py install for mozlog 16:13:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:13:46 INFO - Running setup.py install for moznetwork 16:13:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:13:46 INFO - Running setup.py install for mozprocess 16:13:46 INFO - Running setup.py install for mozprofile 16:13:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:13:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:13:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:13:46 INFO - Running setup.py install for mozrunner 16:13:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:13:46 INFO - Running setup.py install for mozscreenshot 16:13:46 INFO - Running setup.py install for moztest 16:13:46 INFO - Running setup.py install for mozversion 16:13:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:13:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:13:46 INFO - Cleaning up... 16:13:46 INFO - Return code: 0 16:13:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:13:46 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')]} 16:13:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:46 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')]} 16:13:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:46 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 0x7f9b646b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21717b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2200790>, '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 0x2201690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2201b20>, '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': 'a0d2d2de893abaa8702a9954000001a7-1478822497.277586-596989545', '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 16:13:46 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 16:13:46 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 16:13:46 INFO - Using env: {'DISPLAY': ':0', 16:13:46 INFO - 'HOME': '/home/cltbld', 16:13:46 INFO - 'LANG': 'en_US.UTF-8', 16:13:46 INFO - 'LANGUAGE': 'en_US:en', 16:13:46 INFO - 'LOGNAME': 'cltbld', 16:13:46 INFO - 'MAIL': '/var/mail/cltbld', 16:13:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:46 INFO - 'MOZ_NO_REMOTE': '1', 16:13:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:46 INFO - 'NO_EM_RESTART': '1', 16:13:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:46 INFO - 'PWD': '/builds/slave/test', 16:13:46 INFO - 'SHELL': '/bin/bash', 16:13:46 INFO - 'SHLVL': '1', 16:13:46 INFO - 'TERM': 'linux', 16:13:46 INFO - 'TMOUT': '86400', 16:13:46 INFO - 'USER': 'cltbld', 16:13:46 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1478822497.277586-596989545', 16:13:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:46 INFO - '_': '/tools/buildbot/bin/python'} 16:13:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:13:47 INFO - Running setup.py (path:/tmp/pip-Xb2XnZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:13:47 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)) 16:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:13:47 INFO - Running setup.py (path:/tmp/pip-XyaTxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:13:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:13:47 INFO - Running setup.py (path:/tmp/pip-zeE2Vz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:13:47 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)) 16:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:13:47 INFO - Running setup.py (path:/tmp/pip-UYDpY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:13:47 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)) 16:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:13:47 INFO - Running setup.py (path:/tmp/pip-lFNNce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:13:47 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)) 16:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:13:47 INFO - Running setup.py (path:/tmp/pip-PgfRfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:13:47 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)) 16:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:13:47 INFO - Running setup.py (path:/tmp/pip-1alObA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:13:47 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)) 16:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:13:47 INFO - Running setup.py (path:/tmp/pip-EJz6qe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:13:47 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)) 16:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:13:47 INFO - Running setup.py (path:/tmp/pip-pkP7tQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:13:47 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)) 16:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:13:47 INFO - Running setup.py (path:/tmp/pip-r8CXz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:13:47 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)) 16:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:13:47 INFO - Running setup.py (path:/tmp/pip-dbLa9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:13:47 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)) 16:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:13:47 INFO - Running setup.py (path:/tmp/pip-OABOn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:13:48 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)) 16:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:13:48 INFO - Running setup.py (path:/tmp/pip-XGsQa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:13:48 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)) 16:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:13:48 INFO - Running setup.py (path:/tmp/pip-ksD492-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:13:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:13:48 INFO - Running setup.py (path:/tmp/pip-ShLOB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:13:48 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)) 16:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:13:48 INFO - Running setup.py (path:/tmp/pip-LoMnZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:13:48 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)) 16:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:13:48 INFO - Running setup.py (path:/tmp/pip-TJiIuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:13:48 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)) 16:13:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:13:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:13:48 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)) 16:13:48 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)) 16:13:48 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)) 16:13:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:13:48 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 16:13:48 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 16:13:48 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 16:13:48 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 16:13:48 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 16:13:48 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 16:13:50 INFO - Downloading blessings-1.6.tar.gz 16:13:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:13:50 INFO - Installing collected packages: blessings 16:13:50 INFO - Running setup.py install for blessings 16:13:50 INFO - Successfully installed blessings 16:13:50 INFO - Cleaning up... 16:13:50 INFO - Return code: 0 16:13:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:13:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:13:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:13:50 INFO - Reading from file tmpfile_stdout 16:13:50 INFO - Current package versions: 16:13:50 INFO - argparse == 1.2.1 16:13:50 INFO - blessings == 1.6 16:13:50 INFO - blobuploader == 1.2.4 16:13:50 INFO - docopt == 0.6.1 16:13:50 INFO - functools32 == 3.2.3-2 16:13:50 INFO - jsonschema == 2.5.1 16:13:50 INFO - manifestparser == 1.1 16:13:50 INFO - mozInstall == 1.12 16:13:50 INFO - mozcrash == 1.0 16:13:50 INFO - mozdebug == 0.1 16:13:50 INFO - mozdevice == 0.48 16:13:50 INFO - mozfile == 1.2 16:13:50 INFO - mozhttpd == 0.7 16:13:50 INFO - mozinfo == 0.9 16:13:50 INFO - mozleak == 0.1 16:13:50 INFO - mozlog == 3.4 16:13:50 INFO - moznetwork == 0.27 16:13:50 INFO - mozprocess == 0.23 16:13:50 INFO - mozprofile == 0.28 16:13:50 INFO - mozrunner == 6.13 16:13:50 INFO - mozscreenshot == 0.1 16:13:50 INFO - mozsystemmonitor == 0.3 16:13:50 INFO - moztest == 0.7 16:13:50 INFO - mozversion == 1.4 16:13:50 INFO - psutil == 3.1.1 16:13:50 INFO - requests == 1.2.3 16:13:50 INFO - wsgiref == 0.1.2 16:13:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:13:50 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')]} 16:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:50 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')]} 16:13:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:50 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 0x7f9b646b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21717b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2200790>, '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 0x2201690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2201b20>, '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': 'a0d2d2de893abaa8702a9954000001a7-1478822497.277586-596989545', '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 16:13:50 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 16:13:50 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 16:13:50 INFO - Using env: {'DISPLAY': ':0', 16:13:50 INFO - 'HOME': '/home/cltbld', 16:13:50 INFO - 'LANG': 'en_US.UTF-8', 16:13:50 INFO - 'LANGUAGE': 'en_US:en', 16:13:50 INFO - 'LOGNAME': 'cltbld', 16:13:50 INFO - 'MAIL': '/var/mail/cltbld', 16:13:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:50 INFO - 'MOZ_NO_REMOTE': '1', 16:13:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:50 INFO - 'NO_EM_RESTART': '1', 16:13:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:50 INFO - 'PWD': '/builds/slave/test', 16:13:50 INFO - 'SHELL': '/bin/bash', 16:13:50 INFO - 'SHLVL': '1', 16:13:50 INFO - 'TERM': 'linux', 16:13:50 INFO - 'TMOUT': '86400', 16:13:50 INFO - 'USER': 'cltbld', 16:13:50 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1478822497.277586-596989545', 16:13:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:50 INFO - '_': '/tools/buildbot/bin/python'} 16:13:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:51 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)) 16:13:51 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)) 16:13:51 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)) 16:13:51 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)) 16:13:51 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)) 16:13:51 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)) 16:13:51 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)) 16:13:51 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)) 16:13:51 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)) 16:13:51 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)) 16:13:51 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)) 16:13:51 INFO - Cleaning up... 16:13:51 INFO - Return code: 0 16:13:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:13:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:51 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 0x7f9b646b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21717b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2200790>, '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 0x2201690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2201b20>, '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': 'a0d2d2de893abaa8702a9954000001a7-1478822497.277586-596989545', '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 16:13:51 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 16:13:51 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 16:13:51 INFO - Using env: {'DISPLAY': ':0', 16:13:51 INFO - 'HOME': '/home/cltbld', 16:13:51 INFO - 'LANG': 'en_US.UTF-8', 16:13:51 INFO - 'LANGUAGE': 'en_US:en', 16:13:51 INFO - 'LOGNAME': 'cltbld', 16:13:51 INFO - 'MAIL': '/var/mail/cltbld', 16:13:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:51 INFO - 'MOZ_NO_REMOTE': '1', 16:13:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:51 INFO - 'NO_EM_RESTART': '1', 16:13:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:51 INFO - 'PWD': '/builds/slave/test', 16:13:51 INFO - 'SHELL': '/bin/bash', 16:13:51 INFO - 'SHLVL': '1', 16:13:51 INFO - 'TERM': 'linux', 16:13:51 INFO - 'TMOUT': '86400', 16:13:51 INFO - 'USER': 'cltbld', 16:13:51 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1478822497.277586-596989545', 16:13:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:51 INFO - '_': '/tools/buildbot/bin/python'} 16:13:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:13:51 INFO - Cleaning up... 16:13:51 INFO - Return code: 0 16:13:51 INFO - Running post-action listener: _resource_record_post_action 16:13:51 INFO - Running post-action listener: _start_resource_monitoring 16:13:51 INFO - Starting resource monitoring. 16:13:51 INFO - [mozharness: 2016-11-11 00:13:51.305445Z] Finished create-virtualenv step (success) 16:13:51 INFO - [mozharness: 2016-11-11 00:13:51.305952Z] Running install step. 16:13:51 INFO - Running pre-action listener: _resource_record_pre_action 16:13:51 INFO - Running main action method: install 16:13:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:13:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:13:51 INFO - Reading from file tmpfile_stdout 16:13:51 INFO - Detecting whether we're running mozinstall >=1.0... 16:13:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:13:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:13:51 INFO - Reading from file tmpfile_stdout 16:13:51 INFO - Output received: 16:13:51 INFO - Usage: mozinstall [options] installer 16:13:51 INFO - Options: 16:13:51 INFO - -h, --help show this help message and exit 16:13:51 INFO - -d DEST, --destination=DEST 16:13:51 INFO - Directory to install application into. [default: 16:13:51 INFO - "/builds/slave/test"] 16:13:51 INFO - --app=APP Application being installed. [default: firefox] 16:13:51 INFO - mkdir: /builds/slave/test/build/application 16:13:51 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'] 16:13:51 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 16:14:08 INFO - Reading from file tmpfile_stdout 16:14:08 INFO - Output received: 16:14:08 INFO - /builds/slave/test/build/application/firefox/firefox 16:14:08 INFO - Running post-action listener: _resource_record_post_action 16:14:08 INFO - [mozharness: 2016-11-11 00:14:08.468717Z] Finished install step (success) 16:14:08 INFO - [mozharness: 2016-11-11 00:14:08.468957Z] Running run-tests step. 16:14:08 INFO - Running pre-action listener: _resource_record_pre_action 16:14:08 INFO - Running main action method: run_tests 16:14:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:14:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:14:08 INFO - Python 2.7.3 16:14:08 INFO - Return code: 0 16:14:08 INFO - grabbing minidump binary from tooltool 16:14:08 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')]} 16:14:08 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 0x2200790>, '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 0x2201690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2201b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:14:08 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 16:14:08 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 16:14:08 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 16:14:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:14:08 INFO - Return code: 0 16:14:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:14:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:14:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:14:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:14:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:14:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W9uUc71YTL6aH49pyykCFw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:14:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/W9uUc71YTL6aH49pyykCFw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:14:08 INFO - Using env: {'DISPLAY': ':0', 16:14:08 INFO - 'HOME': '/home/cltbld', 16:14:08 INFO - 'LANG': 'en_US.UTF-8', 16:14:08 INFO - 'LANGUAGE': 'en_US:en', 16:14:08 INFO - 'LOGNAME': 'cltbld', 16:14:08 INFO - 'MAIL': '/var/mail/cltbld', 16:14:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:14:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:14:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:08 INFO - 'MOZ_NO_REMOTE': '1', 16:14:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:14:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:08 INFO - 'NO_EM_RESTART': '1', 16:14:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:08 INFO - 'PWD': '/builds/slave/test', 16:14:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:14:08 INFO - 'SHELL': '/bin/bash', 16:14:08 INFO - 'SHLVL': '1', 16:14:08 INFO - 'TERM': 'linux', 16:14:08 INFO - 'TMOUT': '86400', 16:14:08 INFO - 'USER': 'cltbld', 16:14:08 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1478822497.277586-596989545', 16:14:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:08 INFO - '_': '/tools/buildbot/bin/python'} 16:14:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W9uUc71YTL6aH49pyykCFw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:14:08 INFO - mozversion application_buildid: 20161110133014 16:14:08 INFO - mozversion application_changeset: d38d06f85ef59c5dbb5d4a1a8d895957a78714de 16:14:08 INFO - mozversion application_display_name: Nightly 16:14:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:14:08 INFO - mozversion application_name: Firefox 16:14:08 INFO - mozversion application_remotingname: firefox 16:14:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:14:08 INFO - mozversion application_vendor: Mozilla 16:14:08 INFO - mozversion application_version: 52.0a1 16:14:08 INFO - mozversion platform_buildid: 20161110133014 16:14:08 INFO - mozversion platform_changeset: d38d06f85ef59c5dbb5d4a1a8d895957a78714de 16:14:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:14:08 INFO - mozversion platform_version: 52.0a1 16:14:08 INFO - using testdate: 1478823248 16:14:08 INFO - actual date: 1478823248 16:14:08 INFO - starting webserver on 'localhost:46240' 16:14:08 INFO - SUITE-START | Running 2 tests 16:14:08 INFO - TEST-START | dromaeo_css 16:14:08 INFO - operating with platform_type : linux_ 16:14:08 INFO - Initialising browser for dromaeo_css test... 16:14:08 INFO - TEST-INFO | started process 1291 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSfMXNu/profile http://localhost:46240/getInfo.html) 16:14:12 INFO - PROCESS | 1291 | __metrics Screen width/height:1600/1200 16:14:12 INFO - PROCESS | 1291 | colorDepth:24 16:14:12 INFO - PROCESS | 1291 | Browser inner width/height: 1024/697 16:14:12 INFO - PROCESS | 1291 | __metrics 16:14:13 INFO - PROCESS | 1291 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:14:13 INFO - PROCESS | 1291 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:14:14 INFO - PROCESS | 1291 | console.error: PushService: 16:14:14 INFO - PROCESS | 1291 | stateChangeProcessEnqueue: Error transitioning state 16:14:14 INFO - PROCESS | 1291 | UnknownError 16:14:14 INFO - TEST-INFO | 1291: exit 0 16:14:14 INFO - Browser initialized. 16:14:14 INFO - Running cycle 1/1 for dromaeo_css test... 16:14:14 INFO - TEST-INFO | started process 1373 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSfMXNu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:14:26 INFO - PROCESS | 1373 | RSS: Main: 172728320 16:14:26 INFO - PROCESS | 1373 | 16:15:18 INFO - PROCESS | 1373 | 1478823318210 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] 16:17:29 INFO - PROCESS | 1373 | Cycle 1(1): loaded http://localhost:46240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46240/tests/dromaeo/cssquery-ext.html) 16:17:30 INFO - PROCESS | 1373 | RSS: Main: 292950016 16:17:30 INFO - PROCESS | 1373 | 16:20:32 INFO - PROCESS | 1373 | Cycle 1(1): loaded http://localhost:46240/tests/dromaeo/cssquery-ext.html (next: http://localhost:46240/tests/dromaeo/cssquery-jquery.html) 16:20:33 INFO - PROCESS | 1373 | RSS: Main: 283754496 16:20:33 INFO - PROCESS | 1373 | 16:23:35 INFO - PROCESS | 1373 | Cycle 1(1): loaded http://localhost:46240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46240/tests/dromaeo/cssquery-mootools.html) 16:23:36 INFO - PROCESS | 1373 | RSS: Main: 256032768 16:23:36 INFO - PROCESS | 1373 | 16:26:38 INFO - PROCESS | 1373 | Cycle 1(1): loaded http://localhost:46240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46240/tests/dromaeo/cssquery-prototype.html) 16:26:38 INFO - PROCESS | 1373 | RSS: Main: 269332480 16:26:38 INFO - PROCESS | 1373 | 16:29:41 INFO - PROCESS | 1373 | Cycle 1(1): loaded http://localhost:46240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46240/tests/dromaeo/cssquery-yui.html) 16:29:42 INFO - PROCESS | 1373 | RSS: Main: 216121344 16:29:42 INFO - PROCESS | 1373 | 16:32:45 INFO - PROCESS | 1373 | Cycle 1(1): loaded http://localhost:46240/tests/dromaeo/cssquery-yui.html (next: http://localhost:46240/tests/dromaeo/cssquery-dojo.html) 16:32:45 INFO - PROCESS | 1373 | RSS: Main: 299630592 16:32:45 INFO - PROCESS | 1373 | 16:32:45 INFO - PROCESS | 1373 | __start_tp_report 16:32:45 INFO - PROCESS | 1373 | _x_x_mozilla_page_load 16:32:45 INFO - PROCESS | 1373 | _x_x_mozilla_page_load_details 16:32:45 INFO - PROCESS | 1373 | |i|pagename|runs| 16:32:45 INFO - PROCESS | 1373 | |0;dojo.html;3003.759699224062;3026.863791129399;3053.618297712785;3060.7398371138465;3064.4637188492006;5107.872303192422;5211.009908117455;5245.055889939809;5303.284056652351;5367.865803354918;5225.843224703265;5250.18622113572;5326.121190003654;5351.277577527033;5404;4669.252919532875;4759.381280433538;4793.712377257359;4830.830920917769;4838.588719958808;4843;4852.757362131897;4918.2376731606655;4936.234883593049;4981.626378021645;4667.043256132485;4819.9036019279765;4877.756112194376;4888.291197776321;4968.826091086813;4707.6233901287815;4749.620030397595;4753.500882407332;4760.976195119037;4814.422269327668;4765.952340476586;4805.903881922377;4830.130576496229;4835.540623640749;4838.395200599925;5238.13570760824;5289.006799866076;5292.497212764782;5294.126469132589;5353.250544923714;5365.3293338332705;5637;5640.32316122068;5641.576881733887;5648.858778530528;5454.945450545483;5541.833744987616;5604.691741954191;5614.438556144353;5704.087346024658;5285.709285989269;5291.1005129128525;5291.232771248186;5293.629445938747;5301.867453313621;5768.509676677446;5771.119475534046;5778.88442231153;5782.450667186695;5783.624064435799;5361.98122356751;5412.134058550691;5432.782688692408;5505;5505.284313039279;5549.417311182267;5581.804636837691;5583.497485226349;5601.831945041656;5621.409751975983;5586.13414920688;5593;5593;5594.300712410949;5594.636348637407;5382.973085134549;5398.406175320712;5400.4599540046465;5436.70098144598;5639.718014099279;4277.721948073366;4281;4282.400463935051;4303.591158839905;4353.891152721144;3902.90242743928;3915.0212446888277;3931.941020884689;3940.0346915005434;3951.92096158081;5348.304720386325;5385.111456609694;5386.111291636836;5390.730463476811;5434.728263586805;5448.455154484599;5462.016836969384;5619.072852979212;5653.208550802891;5659.349174844863;5399.406065332811;5449.782008719607;5452.890942181134;5482.17767334895;5498.780048798003;4951.628627852925;4961.3798275215595;4962.975185124052;4968.527989840959;5010.724410157476;5707;5747.48272655463;5786.623869448473;5905.379935106752;5908.261467316585;5640.915386269127;5692.658440493584;5698.971505142447;5732.254806875247;5752.906947679928;5844.444777746107;5889.734961926638;5890.646561206341;5902.586818922806;5904.763809447574;5350.170723537858;5394.1099718546;5526.47498487643;5544.833654990357;5580.832575022756;5606.607537472338;5659;5663.150527420919;5702.51528620072;5772.624779389326;5598.776048957996;5599.552035837205;5601.411851755507;5602.887942241214;5607.971960140337;5371.462853714597;5584.46947539983;5586.413426590312;5586.798838249796;5591.832245032656;5376.1398176291605;5443.618946673695;5459.344878614433;5494.532964698045;5583.581231407579;5551.139573366135;5578.358488773681;5580.720963951868;5590.748416321194;5604.159376093618;5262.736863156751;5303.734813259244;5419.34967803866;5445.918311225256;5469.753861076181 16:32:45 INFO - PROCESS | 1373 | |1;ext.html;553.029990889655;567.2738894215403;573.5125143627916;583.7489879351878;588.5056552495903;33466.49800252998;41111.79444102779;42255.57744422555;42342.15315693688;45246.09507809842;43053.35419968695;43589.34615980755;43622.56377436232;43652.781736091354;43676;7853.096893857194;8078.39412044099;8477.448965817233;8624.439411438269;8635.913640863573;9984;10213.387196768217;10224.693259202237;10497.68506944789;10511.84232236517;10335.483225838716;10393.84409233862;10403.84394234087;10407.635732749355;10410.479476026207;10188.337758045704;10246.48767561619;10270.640527581574;10277.845832312447;10287.639932602398;10188.388696678223;10248.436336001518;10252.026057524523;10257.487125643687;10259.076683098558;40243.59756402457;40520.594794052275;40553.79723101395;40584.188316233805;40627.374905003766;3510.666486683761;3532.3994920863515;3565.447355659877;3811;3914.725969182158;29637.407251854842;30607.387852243053;30699.539506907415;30734.23164420885;30781.692183078332;4036.4550785643855;4146.170765846812;4164.666826653891;4307.267764480046;4325.178216138924;328959.9999999976;330144.4449444282;330151.8893677443;330495;331342;55872;56007.71996139993;56028.71985640046;56080;56154.15768763472;58593.41406585965;58753.11870321949;58761;58784.7060764702;58809.70595146997;16294.266757995918;16301.510954671141;16375.836241637431;16384.590385240463;16495.83504164943;11342.432878356049;11950.282983020872;11963.46164422603;12189.207701499374;12268.263904165779;14891.32989015497;15897.52307430779;16552;16577.834221657627;16594;4848.879547674762;6396.456301214449;6397.200349956255;6464.159659244362;6544.9672751635935;947.5120313038791;993.4734590666958;1009.2884516415909;1009.4145395670494;1065.4246706778408;31607.20981975469;32430.675693242767;34102.14744631404;34126.65873341284;34191;1084.251866212311;1091.1489038549944;1093.2074246171462;1117.5473933056962;1128.4019469681082;15195.848041519665;16044.839551604335;16140.677186456205;16182.514524564282;16299;470409;476189;476229;476728;477201;53866.46133538693;54217.1867421989;54229.45770542323;54240.186397204074;54287.18569221465;1315.6776589735575;1372.2384076837252;1377.421482977152;1382.1154461144874;1399.0416564653244;26991.46017079687;27595;27646.723532764416;28086.57870131909;30575.388492230475;47069;47471.52528474671;47557.28664070111;47564.2865357013;47613.28580071371;335066;335099;335977;336535;336784;26646.402735630443;26828;26951.595726063733;27036.459270814867;27242.45515089727;34797.82601086979;38070.2385952285;41660.79169604133;43002;44269.335959961274;36403.359664033385;37823.24353512859;38283;38627;39400.802995984835;37268.627313726516;37910;38912;41510.79244603758;42823.35764963466;39249.215015700094;39535;40508.59491405048;40776.59223407728;40847.79576102101;31183;35754.28491430209;35866.85395224306;36363.27273454569;36380.27239455143;27400.45199095967;27583.31041723973;27691.861540692167;27785.41679121593;27909.581356279265 16:32:45 INFO - PROCESS | 1373 | |2;jquery.html;387.9476270703454;394.899300678327;401.8995251187203;403.1372862075159;417.8259091951616;14022.439102435916;15520.223988800572;17093.316267349306;18854.151563179654;18863.62272754544;14554.563363099123;15651.843481565182;17387.304507819703;17438.302467901267;17586.384476543324;5243.318368612075;5645.350784659755;5677.43225677431;5682;5683.630564013347;5461.563074954014;5626.887462250753;5646.265985421889;5670.461306175906;5671.177679236508;5608.186812912125;5644.463775941279;5650.858728531778;5657.773689052433;5664.320281566218;5437.456254374571;5573.526250268732;5654.095344744842;5656.660600363992;5657.32112146543;5045.798168073273;5062.544371006627;5063.113955057887;5064.113780088506;5069.467705890902;21289.893550532302;21532.677009844865;21993.23023694179;22187;22546.43633909149;2236.7427745809277;2248.415411992877;2301.2060839010683;2366.0890557135626;2899.275181204699;13584.388702508411;13657.180569165783;13758.93120534401;13962.93018534911;14085.859141408557;1862.7764668239897;1931.5557421792926;1931.6819816220452;1945.5194924559078;1961.0586918279305;73454.63272683656;75336.24663753348;75435.62282188609;76256;77994;10251.897481025095;10428.530716117793;10638.361698298128;10662.413567253876;10694.679159625224;14662.340194691264;14674.266286685623;14682.55952321432;14686.265686715835;14693.55919322422;6788.524803263823;7127.536710113826;7624.428167887319;7911.747553307829;8193.83612327762;7907.604619768988;7987.480813747088;7989.680412783539;8291;8319.792005199919;6342.904856427157;6390.360963903572;6436.195475565554;6471.2234531856475;6496.415322620986;1724.8792584519215;1730.3424698614697;1840.2550809103411;1851.6111616560672;1888.9622207555772;439.75373790676684;445.4721155430825;451.93221016847735;465.06521890999335;874.8469017921839;11508.94245528767;11642.88357116418;11757.588484403004;11881.22772019816;12053.939730301292;458.3582983822675;466.26795930388965;467.1661084963324;471.3707200886786;473.79153172604634;6032.728527216198;6176.104464852661;6219.129321894939;6269.188229400642;6404.807855764335;452046;464363;467330;468313;468663;91346;94040;95007.52496237613;96231;96388;475.8025419450958;483.8645179349788;484.04884402149946;484.5542101266843;485.2357536879429;10377.250028742239;10704.357738535402;10736.624218152327;10852.511636976513;10868.728281793019;37256.81371593125;38215.235695286494;39644;40016;41035.58964410318;57236;57345;58448;58658.413415867006;59501.70249148727;8060.959695201486;8116.553589552395;8188.549629770419;8377.958110209654;8475.449095808754;10363.94818025905;12179.269243845398;12477.875221247672;12594.937025314815;12697.36513174319;10783.299085559414;10956.506957186786;10987;11364.772704546029;11584.94207528957;10713.857228554165;10929.398883061507;11143.2199746017;11330.886691133313;11370.260933039326;10856.185786066235;10933.234673573092;11043;11168.66494005181;11651.47568359409;8004.639791209293;8279.793005174919;8298.87551686713;8408.789780255542;8442.620082096197;10985.285956412808;11056.12045952174;11137.944310278397;11242.550297988317;12076.275423474619 16:32:45 INFO - PROCESS | 1373 | |3;mootools.html;1290.6515240884955;1434.8421673615903;1444.6099553120657;1574.4410734189362;1733.3066773290682;7062.223155452903;7561.092668879735;7883.881741773878;7889.487183333086;8134.145914678962;7902;7996.640151193195;7997.000374953131;8001.1198768135455;8009.59952002399;2184.0826852721857;2209.7458792238936;2209.7900699433526;2210.635245184543;2211.9336419907427;2181.6182168120595;2233.129079658934;2248.190651365507;2251;2253.695751073609;2179;2188.6607575825774;2209.8232141428725;2211.469247380625;2222.6443768996965;2140.475583482041;2144.517483566185;2145.227718021511;2151.7955794199606;2157.611629906616;2085.4265077103764;2119.4065661614773;2123.214410668047;2124.649432843579;2127.968080478794;7235;7396.223396543393;7877.6848926042885;7942.3646108311195;8034.156413576548;4756.143894099061;4861.173600487926;4866.926996095061;4882.462929077798;4885.560299573055;3202.4876019836715;3207.2302647364463;3207.7273431758326;3283.0479161043268;3286.1291757684235;1024.2062401638716;1025.5333823110466;1070.5182667799522;1085.7502774361863;1095.9780804383947;10898.782024359469;10924.2899211551;10985.121190304837;10986.505607247693;11010.559577616887;3999.680025597945;4228.365745138254;4297.968487563025;4311.676624253194;4317.676174286941;8828.735137945872;8846.690365837165;8847.557622118868;8855.601497932608;8910.688125915562;4886.804527818847;4889.046635905964;4891.437484689235;4891.510848915151;4893.045856058035;3880.864169754045;4145.730527515701;4198.685098617616;4584.679072464895;4616.30755386688;3408.556887604645;3415.214500664861;3469.5489586354115;3528.929421411609;3533.2403533239963;1078.5577913055608;1079.1690398393193;1083.7266212200632;1086.103964229498;1089.0470838016736;810.8094597769638;857.1043259793531;888.5379602606738;907.577976241051;917.4862077236769;5373.140297552372;5397.514223719884;5546.889062218733;5558.333000040021;5749.425057494301;894.4275663575316;949.4303417949313;977.9070988256104;983.4541829284673;1031.9113335431043;3618.565772107311;3647.2887786881834;3667.9266414671556;3736.8878933632036;3883.533975922851;9452.716418507456;9820.459874706818;9854.260930430246;9867.654632087842;9890.406575605486;9224.815503690023;9533.237341012702;9770.071843174886;9791.902080979242;9809.705708828747;7437.776866694008;7581.583012934231;7615.428842836809;7620.237976202447;7625.733099341496;5336.412994570672;5347.358317001829;5423.186522021729;5445.393608885309;5576.972115139399;8610.78473038179;8970.147835955573;9023.819523609622;9060.864087038568;9107.726768196964;9156.954215228881;9207.539623018689;9208.861867072133;9213.631454741735;9233.030531794066;6978.546394484342;7118.928810711826;7120.860662294008;7124.750633727795;7124.857502850017;7290.380317673057;7426.962865185639;7467.77596672079;7489.21363256872;7494.475386722877;6762.256151823197;6835.453163746789;6862.588244705334;6945.722171113099;6989.30106989297;6824.624645644537;6864.21061577925;6938.548994315353;6945.513814032969;6986.755463558751;5863.149843272787;5972.34304226526;5976.163337132718;5979.372165922516;5979.760809567742;4605.194091033989;4637.536246375335;4717.080169366941;4782.736949467812;4794.880127996828;4597.885052873705;4785.282207668738;4931.3835770528685;4982.526659967298;5001.549860512426 16:32:45 INFO - PROCESS | 1373 | |4;prototype.html;317.58079335277444;330.6528145447281;340.69337596163456;340.8227721584776;342.6727475261123;5056.5701915337195;5241.50617074134;5243.134882744347;5251.894962100756;5286.497782710641;5167.767450464728;5177.4045984711765;5198.350206224222;5213.035588416136;5214.634975551703;4113.9794301028605;4123.711340206187;4128.772917489537;4133.979330103345;4137.503499580054;4002.6384433184417;4093.97953010236;4098.959010409888;4114.238865809834;4127.906104882209;4090.9590904090874;4111.753294802306;4114.218298523286;4116.629503344699;4121.289664789124;4099.836006559734;4104.774237416941;4105.815238314253;4113.321301985184;4136.607022332873;3675.246574452231;3703.092742278159;3705.1478160023075;3706.314331848617;3714.647108524686;4960.553550180465;5094.522588449346;5104.566111880457;5118.820841270538;5146.536811686966;4685.453800245945;4688.648351373627;4695.413073365829;4714.387129673155;4721.843148428623;5240.384134946875;5396.030448886128;5406.243125962368;5409.756560954766;5417.891642167135;3996.320625493644;4004.619561141687;4013.1572369802375;4023.2556976959354;4045.6763458923215;5366.168243922199;5536.529395001429;5671.801486947978;5673.319201695782;5680.608250978496;3953.347697629859;4037.333839916381;4039.8486431367505;4047.1872048925716;4062.857799976987;4113.91772164555;4121.598656456819;4134.462519872397;4146.0464093258715;4155.8337666493;4531.592156705912;4692.178868697964;4696.929546056812;4697.271922851964;4701.764911754399;5377.4084850666395;5401.891962160735;5416.51251387377;5423.864403389868;5438.320209973754;1390.1589538329367;1402.5932479580808;1404.7401230772339;1417.3126033873564;1422.3457209683454;939.8731171291925;973.1582181413027;978.9314747967574;980.9754756131153;988.4267125067587;5090.919993404012;5123.974380128076;5130.179171332569;5183.637145399861;5187.688738675692;5374.408815030343;5394.460553944574;5396.9730151348995;5447.4552544746;5476.315460567429;4977.203647416469;5044.9495505045215;5124.744437612809;5140.871478213;5178.430372659004;2842.644669416323;2851.1731597836397;2860.156253905103;2863.608886579688;2869.842158681251;5590.183190463115;5592.636478628876;5600.719964001783;5602.719864006865;5636.350011240743;5411.918821217685;5495.230667706524;5696.23100881384;5719.28508936383;5722.170285308607;5828.329742079631;5838.153467747153;5848.502877255396;5868.002439585366;5872.324682661463;5431.4840090191365;5600.131979543177;5683.516901063291;5725.16985037159;5731.140328950691;5507.614466987273;5530.225768392509;5572.442755724395;5592.161175823497;5611.270534830446;5508.697021663686;5669.54643628517;5670.4329567044615;5783.334916484658;5784.016717158009;4025.959740402676;4056.9188616228103;4061.4160477413243;4088.158729682842;4092.140650463436;5658.886822263449;5670.829875103754;5681.8863622726485;5684.431556844448;5703.431556322044;5249.317588713443;5440.42875498067;5489.286392768914;5498.893125384146;5576.665400076008;5452.963936851986;5484.945150548443;5486.561075113901;5492.80775172867;5498.532624726943;5243.5542978847225;5451.56387488992;5471.2887324647545;5520.598539635272;5529.861753456034;5455.863603409946;5481.629592601849;5485.259489968803;5492.873960838098;5502.972485137549;5310.920336195038;5335.733213339395;5355.544778693855;5364.624476286623;5392.487713667196 16:32:45 INFO - PROCESS | 1373 | |5;yui.html;695.883186788132;721.8087206890175;734.9522281051729;759.1118391481967;765.2347652347653;14343.928280358597;15135.24323783809;15199.544013679593;15258.465953691622;15260.542183734491;13656.24890631015;13892.79160812586;13893.513727019556;13896.374663140157;13907.304634768247;651.1860174781523;669.4778073102988;751.8308380614345;759.2445516710881;770.7186876789959;766.6741634805213;771.3944553525483;771.4831063187678;772.4168252969;773.5899973014283;818.8403261364036;820.3191351178538;820.4953953318695;820.6266148902235;820.6717313074788;813.877918312252;814.3322475570035;814.5316443045243;814.6334149632689;814.816666250092;496.781416176881;503.27025812571554;570.8744076303207;587.4243241623233;593.4184499190817;13734.175949442966;14150.716985660332;14155.363008664532;14160.36278367476;14193.78709319361;12933.741325173443;12951.611451656465;13092.738145237043;13179.802302965463;13453.798193027014;11862.288262704265;11947.761044779056;11998.880011199864;12122.939385303105;12285.877141228562;4097.713160078795;4100.671946244323;4148.813303401324;4161.604647558477;4332.371806088131;56591;57378;58248.417515825146;58579.70710146464;58808.41191588072;9116.225120864801;9244.630214791467;9282.164605185566;9479.194268487256;9657.46883921391;18051.819481805014;18106.63786724258;18135.36526221576;18148.183331750104;18173;7484.101907770993;7525.548467091882;7658.578778167254;7660.693572257047;7865.567393793396;4155.8961025974595;4252.829886804555;4262.850800221977;4304.612584867315;4341.305391137403;3155.25851424915;3228.935421291608;3229.6770322967513;3230.353929214167;3231.079142444392;565.5673409841474;575.5481946671842;582.8193260089386;589.6196952965313;597.1520440973827;536.9436209198057;560.0646919644204;659.120074700271;672.1933679584421;675.5203805298195;8292.58537073144;8433.325333973267;8651.134886511425;8761.299096072298;8770.824583508294;606.263389981175;640.5870395160908;642.9421352078335;644.1512858097198;664.4584663499329;4084.509858816961;4237.364395340724;4264.104538047045;4303.892402689895;4365.454318210223;87010;87805.12194877969;88890;88896.555517222;93162.53418732862;62095.6895215521;63505;66964;70527.64736176287;71059;62372.68813655902;63797.68101159464;64054.35945640484;65301.67349163319;65773.67113164403;9007.414518056305;9506.762330941505;9655.179309758469;9671.758206044906;9712.854307185538;44438.333424998;44943.55056449524;45022;45609;46380.30429543492;55344.72327638336;62581.68709156607;62814;62906.37093629005;64568;11529.423528823692;11991.400429978292;12002.879971200176;12645.810312845499;12667.87332126667;12828.743425131632;13052.49958949684;13094.803577946528;13275.80086298687;13602.523911663044;11073.446327683423;12606.936965315115;12626.936865315614;13321.733565328834;13470.93264533671;10854.131669466582;11185.776284474428;11266.098712102848;11679.124065695276;11842.526298947945;11360.318380897173;11519.596814111466;11600.419979000848;11631.360275184947;12047.690842723336;9319.953400232955;9660.95169524176;9678.806423871623;9771.413715177112;9939.503024848873;9783.767093953156;10869.347839129678;11112.277701949348;11136.832947505633;11302.886971130183 16:32:45 INFO - PROCESS | 1373 | __end_tp_report 16:32:45 INFO - PROCESS | 1373 | __start_cc_report 16:32:45 INFO - PROCESS | 1373 | _x_x_mozilla_cycle_collect,1132 16:32:45 INFO - PROCESS | 1373 | __end_cc_report 16:32:45 INFO - PROCESS | 1373 | __startTimestamp1478824365366__endTimestamp 16:32:45 INFO - PROCESS | 1373 | 16:32:45 INFO - PROCESS | 1373 | ------- Summary: start ------- 16:32:45 INFO - PROCESS | 1373 | Number of tests: 6 16:32:45 INFO - PROCESS | 1373 | 16:32:45 INFO - PROCESS | 1373 | [#0] dojo.html Cycles:165 Average:5244.35 Median:5419.35 stddev:584.01 (10.8%) stddev-sans-first:558.72 16:32:45 INFO - PROCESS | 1373 | Values: 3003.8 3026.9 3053.6 3060.7 3064.5 5107.9 5211.0 5245.1 5303.3 5367.9 5225.8 5250.2 5326.1 5351.3 5404.0 4669.3 4759.4 4793.7 4830.8 4838.6 4843.0 4852.8 4918.2 4936.2 4981.6 4667.0 4819.9 4877.8 4888.3 4968.8 4707.6 4749.6 4753.5 4761.0 4814.4 4766.0 4805.9 4830.1 4835.5 4838.4 5238.1 5289.0 5292.5 5294.1 5353.3 5365.3 5637.0 5640.3 5641.6 5648.9 5454.9 5541.8 5604.7 5614.4 5704.1 5285.7 5291.1 5291.2 5293.6 5301.9 5768.5 5771.1 5778.9 5782.5 5783.6 5362.0 5412.1 5432.8 5505.0 5505.3 5549.4 5581.8 5583.5 5601.8 5621.4 5586.1 5593.0 5593.0 5594.3 5594.6 5383.0 5398.4 5400.5 5436.7 5639.7 4277.7 4281.0 4282.4 4303.6 4353.9 3902.9 3915.0 3931.9 3940.0 3951.9 5348.3 5385.1 5386.1 5390.7 5434.7 5448.5 5462.0 5619.1 5653.2 5659.3 5399.4 5449.8 5452.9 5482.2 5498.8 4951.6 4961.4 4963.0 4968.5 5010.7 5707.0 5747.5 5786.6 5905.4 5908.3 5640.9 5692.7 5699.0 5732.3 5752.9 5844.4 5889.7 5890.6 5902.6 5904.8 5350.2 5394.1 5526.5 5544.8 5580.8 5606.6 5659.0 5663.2 5702.5 5772.6 5598.8 5599.6 5601.4 5602.9 5608.0 5371.5 5584.5 5586.4 5586.8 5591.8 5376.1 5443.6 5459.3 5494.5 5583.6 5551.1 5578.4 5580.7 5590.7 5604.2 5262.7 5303.7 5419.3 5445.9 5469.8 16:32:45 INFO - PROCESS | 1373 | 16:32:45 INFO - PROCESS | 1373 | [#1] ext.html Cycles:180 Average:54186.78 Median:3521.53 stddev:102001.35 (2896.5%) stddev-sans-first:102208.00 16:32:45 INFO - PROCESS | 1373 | Values: 553.0 567.3 573.5 583.7 588.5 33466.5 41111.8 42255.6 42342.2 45246.1 43053.4 43589.3 43622.6 43652.8 43676.0 7853.1 8078.4 8477.4 8624.4 8635.9 9984.0 10213.4 10224.7 10497.7 10511.8 10335.5 10393.8 10403.8 10407.6 10410.5 10188.3 10246.5 10270.6 10277.8 10287.6 10188.4 10248.4 10252.0 10257.5 10259.1 40243.6 40520.6 40553.8 40584.2 40627.4 3510.7 3532.4 3565.4 3811.0 3914.7 29637.4 30607.4 30699.5 30734.2 30781.7 4036.5 4146.2 4164.7 4307.3 4325.2 328960.0 330144.4 330151.9 330495.0 331342.0 55872.0 56007.7 56028.7 56080.0 56154.2 58593.4 58753.1 58761.0 58784.7 58809.7 16294.3 16301.5 16375.8 16384.6 16495.8 11342.4 11950.3 11963.5 12189.2 12268.3 14891.3 15897.5 16552.0 16577.8 16594.0 4848.9 6396.5 6397.2 6464.2 6545.0 947.5 993.5 1009.3 1009.4 1065.4 31607.2 32430.7 34102.1 34126.7 34191.0 1084.3 1091.1 1093.2 1117.5 1128.4 15195.8 16044.8 16140.7 16182.5 16299.0 470409.0 476189.0 476229.0 476728.0 477201.0 53866.5 54217.2 54229.5 54240.2 54287.2 1315.7 1372.2 1377.4 1382.1 1399.0 26991.5 27595.0 27646.7 28086.6 30575.4 47069.0 47471.5 47557.3 47564.3 47613.3 335066.0 335099.0 335977.0 336535.0 336784.0 26646.4 26828.0 26951.6 27036.5 27242.5 34797.8 38070.2 41660.8 43002.0 44269.3 36403.4 37823.2 38283.0 38627.0 39400.8 37268.6 37910.0 38912.0 41510.8 42823.4 39249.2 39535.0 40508.6 40776.6 40847.8 31183.0 35754.3 35866.9 36363.3 36380.3 27400.5 27583.3 27691.9 27785.4 27909.6 16:32:45 INFO - PROCESS | 1373 | 16:32:45 INFO - PROCESS | 1373 | [#2] jquery.html Cycles:180 Average:27382.92 Median:442.61 stddev:76781.59 (17347.3%) stddev-sans-first:76970.23 16:32:45 INFO - PROCESS | 1373 | Values: 387.9 394.9 401.9 403.1 417.8 14022.4 15520.2 17093.3 18854.2 18863.6 14554.6 15651.8 17387.3 17438.3 17586.4 5243.3 5645.4 5677.4 5682.0 5683.6 5461.6 5626.9 5646.3 5670.5 5671.2 5608.2 5644.5 5650.9 5657.8 5664.3 5437.5 5573.5 5654.1 5656.7 5657.3 5045.8 5062.5 5063.1 5064.1 5069.5 21289.9 21532.7 21993.2 22187.0 22546.4 2236.7 2248.4 2301.2 2366.1 2899.3 13584.4 13657.2 13758.9 13962.9 14085.9 1862.8 1931.6 1931.7 1945.5 1961.1 73454.6 75336.2 75435.6 76256.0 77994.0 10251.9 10428.5 10638.4 10662.4 10694.7 14662.3 14674.3 14682.6 14686.3 14693.6 6788.5 7127.5 7624.4 7911.7 8193.8 7907.6 7987.5 7989.7 8291.0 8319.8 6342.9 6390.4 6436.2 6471.2 6496.4 1724.9 1730.3 1840.3 1851.6 1889.0 439.8 445.5 451.9 465.1 874.8 11508.9 11642.9 11757.6 11881.2 12053.9 458.4 466.3 467.2 471.4 473.8 6032.7 6176.1 6219.1 6269.2 6404.8 452046.0 464363.0 467330.0 468313.0 468663.0 91346.0 94040.0 95007.5 96231.0 96388.0 475.8 483.9 484.0 484.6 485.2 10377.3 10704.4 10736.6 10852.5 10868.7 37256.8 38215.2 39644.0 40016.0 41035.6 57236.0 57345.0 58448.0 58658.4 59501.7 8061.0 8116.6 8188.5 8378.0 8475.4 10363.9 12179.3 12477.9 12594.9 12697.4 10783.3 10956.5 10987.0 11364.8 11584.9 10713.9 10929.4 11143.2 11330.9 11370.3 10856.2 10933.2 11043.0 11168.7 11651.5 8004.6 8279.8 8298.9 8408.8 8442.6 10985.3 11056.1 11137.9 11242.6 12076.3 16:32:45 INFO - PROCESS | 1373 | 16:32:45 INFO - PROCESS | 1373 | [#3] mootools.html Cycles:180 Average:5227.68 Median:5168.98 stddev:2895.45 (56.0%) stddev-sans-first:2888.45 16:32:45 INFO - PROCESS | 1373 | Values: 1290.7 1434.8 1444.6 1574.4 1733.3 7062.2 7561.1 7883.9 7889.5 8134.1 7902.0 7996.6 7997.0 8001.1 8009.6 2184.1 2209.7 2209.8 2210.6 2211.9 2181.6 2233.1 2248.2 2251.0 2253.7 2179.0 2188.7 2209.8 2211.5 2222.6 2140.5 2144.5 2145.2 2151.8 2157.6 2085.4 2119.4 2123.2 2124.6 2128.0 7235.0 7396.2 7877.7 7942.4 8034.2 4756.1 4861.2 4866.9 4882.5 4885.6 3202.5 3207.2 3207.7 3283.0 3286.1 1024.2 1025.5 1070.5 1085.8 1096.0 10898.8 10924.3 10985.1 10986.5 11010.6 3999.7 4228.4 4298.0 4311.7 4317.7 8828.7 8846.7 8847.6 8855.6 8910.7 4886.8 4889.0 4891.4 4891.5 4893.0 3880.9 4145.7 4198.7 4584.7 4616.3 3408.6 3415.2 3469.5 3528.9 3533.2 1078.6 1079.2 1083.7 1086.1 1089.0 810.8 857.1 888.5 907.6 917.5 5373.1 5397.5 5546.9 5558.3 5749.4 894.4 949.4 977.9 983.5 1031.9 3618.6 3647.3 3667.9 3736.9 3883.5 9452.7 9820.5 9854.3 9867.7 9890.4 9224.8 9533.2 9770.1 9791.9 9809.7 7437.8 7581.6 7615.4 7620.2 7625.7 5336.4 5347.4 5423.2 5445.4 5577.0 8610.8 8970.1 9023.8 9060.9 9107.7 9157.0 9207.5 9208.9 9213.6 9233.0 6978.5 7118.9 7120.9 7124.8 7124.9 7290.4 7427.0 7467.8 7489.2 7494.5 6762.3 6835.5 6862.6 6945.7 6989.3 6824.6 6864.2 6938.5 6945.5 6986.8 5863.1 5972.3 5976.2 5979.4 5979.8 4605.2 4637.5 4717.1 4782.7 4794.9 4597.9 4785.3 4931.4 4982.5 5001.5 16:32:45 INFO - PROCESS | 1373 | 16:32:45 INFO - PROCESS | 1373 | [#4] prototype.html Cycles:180 Average:4602.18 Median:5227.51 stddev:1332.34 (25.5%) stddev-sans-first:1296.69 16:32:45 INFO - PROCESS | 1373 | Values: 317.6 330.7 340.7 340.8 342.7 5056.6 5241.5 5243.1 5251.9 5286.5 5167.8 5177.4 5198.4 5213.0 5214.6 4114.0 4123.7 4128.8 4134.0 4137.5 4002.6 4094.0 4099.0 4114.2 4127.9 4091.0 4111.8 4114.2 4116.6 4121.3 4099.8 4104.8 4105.8 4113.3 4136.6 3675.2 3703.1 3705.1 3706.3 3714.6 4960.6 5094.5 5104.6 5118.8 5146.5 4685.5 4688.6 4695.4 4714.4 4721.8 5240.4 5396.0 5406.2 5409.8 5417.9 3996.3 4004.6 4013.2 4023.3 4045.7 5366.2 5536.5 5671.8 5673.3 5680.6 3953.3 4037.3 4039.8 4047.2 4062.9 4113.9 4121.6 4134.5 4146.0 4155.8 4531.6 4692.2 4696.9 4697.3 4701.8 5377.4 5401.9 5416.5 5423.9 5438.3 1390.2 1402.6 1404.7 1417.3 1422.3 939.9 973.2 978.9 981.0 988.4 5090.9 5124.0 5130.2 5183.6 5187.7 5374.4 5394.5 5397.0 5447.5 5476.3 4977.2 5044.9 5124.7 5140.9 5178.4 2842.6 2851.2 2860.2 2863.6 2869.8 5590.2 5592.6 5600.7 5602.7 5636.4 5411.9 5495.2 5696.2 5719.3 5722.2 5828.3 5838.2 5848.5 5868.0 5872.3 5431.5 5600.1 5683.5 5725.2 5731.1 5507.6 5530.2 5572.4 5592.2 5611.3 5508.7 5669.5 5670.4 5783.3 5784.0 4026.0 4056.9 4061.4 4088.2 4092.1 5658.9 5670.8 5681.9 5684.4 5703.4 5249.3 5440.4 5489.3 5498.9 5576.7 5453.0 5484.9 5486.6 5492.8 5498.5 5243.6 5451.6 5471.3 5520.6 5529.9 5455.9 5481.6 5485.3 5492.9 5503.0 5310.9 5335.7 5355.5 5364.6 5392.5 16:32:45 INFO - PROCESS | 1373 | 16:32:45 INFO - PROCESS | 1373 | [#5] yui.html Cycles:180 Average:16945.92 Median:28580.94 stddev:22447.87 (78.5%) stddev-sans-first:22477.68 16:32:45 INFO - PROCESS | 1373 | Values: 695.9 721.8 735.0 759.1 765.2 14343.9 15135.2 15199.5 15258.5 15260.5 13656.2 13892.8 13893.5 13896.4 13907.3 651.2 669.5 751.8 759.2 770.7 766.7 771.4 771.5 772.4 773.6 818.8 820.3 820.5 820.6 820.7 813.9 814.3 814.5 814.6 814.8 496.8 503.3 570.9 587.4 593.4 13734.2 14150.7 14155.4 14160.4 14193.8 12933.7 12951.6 13092.7 13179.8 13453.8 11862.3 11947.8 11998.9 12122.9 12285.9 4097.7 4100.7 4148.8 4161.6 4332.4 56591.0 57378.0 58248.4 58579.7 58808.4 9116.2 9244.6 9282.2 9479.2 9657.5 18051.8 18106.6 18135.4 18148.2 18173.0 7484.1 7525.5 7658.6 7660.7 7865.6 4155.9 4252.8 4262.9 4304.6 4341.3 3155.3 3228.9 3229.7 3230.4 3231.1 565.6 575.5 582.8 589.6 597.2 536.9 560.1 659.1 672.2 675.5 8292.6 8433.3 8651.1 8761.3 8770.8 606.3 640.6 642.9 644.2 664.5 4084.5 4237.4 4264.1 4303.9 4365.5 87010.0 87805.1 88890.0 88896.6 93162.5 62095.7 63505.0 66964.0 70527.6 71059.0 62372.7 63797.7 64054.4 65301.7 65773.7 9007.4 9506.8 9655.2 9671.8 9712.9 44438.3 44943.6 45022.0 45609.0 46380.3 55344.7 62581.7 62814.0 62906.4 64568.0 11529.4 11991.4 12002.9 12645.8 12667.9 12828.7 13052.5 13094.8 13275.8 13602.5 11073.4 12606.9 12626.9 13321.7 13470.9 10854.1 11185.8 11266.1 11679.1 11842.5 11360.3 11519.6 11600.4 11631.4 12047.7 9320.0 9661.0 9678.8 9771.4 9939.5 9783.8 10869.3 11112.3 11136.8 11302.9 16:32:45 INFO - PROCESS | 1373 | -------- Summary: end -------- 16:32:45 INFO - PROCESS | 1373 | 16:32:46 INFO - TEST-INFO | 1373: exit 0 16:32:46 INFO - TEST-OK | dromaeo_css | took 1117552ms 16:32:46 INFO - TEST-START | kraken 16:32:46 INFO - operating with platform_type : linux_ 16:32:46 INFO - Initialising browser for kraken test... 16:32:46 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6Ty9qu/profile http://localhost:46240/getInfo.html) 16:32:50 INFO - PROCESS | 1680 | __metrics Screen width/height:1600/1200 16:32:50 INFO - PROCESS | 1680 | colorDepth:24 16:32:50 INFO - PROCESS | 1680 | Browser inner width/height: 1024/697 16:32:50 INFO - PROCESS | 1680 | __metrics 16:32:51 INFO - PROCESS | 1680 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:32:51 INFO - PROCESS | 1680 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:32:51 INFO - PROCESS | 1680 | console.error: PushService: 16:32:51 INFO - PROCESS | 1680 | stateChangeProcessEnqueue: Error transitioning state 16:32:51 INFO - PROCESS | 1680 | UnknownError 16:32:52 INFO - TEST-INFO | 1680: exit 0 16:32:52 INFO - Browser initialized. 16:32:52 INFO - Running cycle 1/1 for kraken test... 16:32:52 INFO - TEST-INFO | started process 1764 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6Ty9qu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:33:04 INFO - PROCESS | 1764 | RSS: Main: 173142016 16:33:04 INFO - PROCESS | 1764 | 16:33:06 INFO - PROCESS | 1764 | Cycle 1(1): loaded http://localhost:46240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46240/tests/kraken/driver.html?testName=audio-beat-detection) 16:33:07 INFO - PROCESS | 1764 | RSS: Main: 238153728 16:33:07 INFO - PROCESS | 1764 | 16:33:10 INFO - PROCESS | 1764 | Cycle 1(1): loaded http://localhost:46240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46240/tests/kraken/driver.html?testName=audio-dft) 16:33:10 INFO - PROCESS | 1764 | RSS: Main: 216625152 16:33:10 INFO - PROCESS | 1764 | 16:33:14 INFO - PROCESS | 1764 | Cycle 1(1): loaded http://localhost:46240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46240/tests/kraken/driver.html?testName=audio-fft) 16:33:14 INFO - PROCESS | 1764 | RSS: Main: 297332736 16:33:14 INFO - PROCESS | 1764 | 16:33:16 INFO - PROCESS | 1764 | Cycle 1(1): loaded http://localhost:46240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46240/tests/kraken/driver.html?testName=audio-oscillator) 16:33:17 INFO - PROCESS | 1764 | RSS: Main: 209137664 16:33:17 INFO - PROCESS | 1764 | 16:33:19 INFO - PROCESS | 1764 | Cycle 1(1): loaded http://localhost:46240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:33:20 INFO - PROCESS | 1764 | RSS: Main: 212381696 16:33:20 INFO - PROCESS | 1764 | 16:33:23 INFO - PROCESS | 1764 | Cycle 1(1): loaded http://localhost:46240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46240/tests/kraken/driver.html?testName=imaging-darkroom) 16:33:23 INFO - PROCESS | 1764 | RSS: Main: 248201216 16:33:23 INFO - PROCESS | 1764 | 16:33:27 INFO - PROCESS | 1764 | Cycle 1(1): loaded http://localhost:46240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46240/tests/kraken/driver.html?testName=imaging-desaturate) 16:33:27 INFO - PROCESS | 1764 | RSS: Main: 247545856 16:33:27 INFO - PROCESS | 1764 | 16:33:30 INFO - PROCESS | 1764 | Cycle 1(1): loaded http://localhost:46240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46240/tests/kraken/driver.html?testName=json-parse-financial) 16:33:30 INFO - PROCESS | 1764 | RSS: Main: 246026240 16:33:30 INFO - PROCESS | 1764 | 16:33:32 INFO - PROCESS | 1764 | Cycle 1(1): loaded http://localhost:46240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:33:32 INFO - PROCESS | 1764 | RSS: Main: 208822272 16:33:32 INFO - PROCESS | 1764 | 16:33:34 INFO - PROCESS | 1764 | Cycle 1(1): loaded http://localhost:46240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46240/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:33:35 INFO - PROCESS | 1764 | RSS: Main: 217247744 16:33:35 INFO - PROCESS | 1764 | 16:33:37 INFO - PROCESS | 1764 | Cycle 1(1): loaded http://localhost:46240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:33:37 INFO - PROCESS | 1764 | RSS: Main: 225476608 16:33:37 INFO - PROCESS | 1764 | 16:33:40 INFO - PROCESS | 1764 | Cycle 1(1): loaded http://localhost:46240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:33:41 INFO - PROCESS | 1764 | RSS: Main: 234336256 16:33:41 INFO - PROCESS | 1764 | 16:33:44 INFO - PROCESS | 1764 | Cycle 1(1): loaded http://localhost:46240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:33:44 INFO - PROCESS | 1764 | RSS: Main: 231198720 16:33:44 INFO - PROCESS | 1764 | 16:33:46 INFO - PROCESS | 1764 | Cycle 1(1): loaded http://localhost:46240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46240/tests/kraken/driver.html?testName=ai-astar) 16:33:46 INFO - PROCESS | 1764 | RSS: Main: 282554368 16:33:46 INFO - PROCESS | 1764 | 16:33:46 INFO - PROCESS | 1764 | __start_tp_report 16:33:46 INFO - PROCESS | 1764 | _x_x_mozilla_page_load 16:33:46 INFO - PROCESS | 1764 | _x_x_mozilla_page_load_details 16:33:46 INFO - PROCESS | 1764 | |i|pagename|runs| 16:33:46 INFO - PROCESS | 1764 | |0;ai-astar;104;112;110;112;112;110;112;112;111;112 16:33:46 INFO - PROCESS | 1764 | |1;audio-beat-detection;146;122;126;167;134;129;123;122;157;122 16:33:46 INFO - PROCESS | 1764 | |2;audio-dft;162;160;162;160;161;161;161;161;161;162 16:33:46 INFO - PROCESS | 1764 | |3;audio-fft;75;77;75;118;76;77;75;75;97;75 16:33:46 INFO - PROCESS | 1764 | |4;audio-oscillator;83;83;121;83;83;83;102;82;82;114 16:33:46 INFO - PROCESS | 1764 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;117;116 16:33:46 INFO - PROCESS | 1764 | |6;imaging-darkroom;146;146;146;146;146;146;147;146;146;146 16:33:46 INFO - PROCESS | 1764 | |7;imaging-desaturate;85;85;85;85;84;85;85;85;85;84 16:33:46 INFO - PROCESS | 1764 | |8;json-parse-financial;53;52;53;52;53;54;53;53;52;54 16:33:46 INFO - PROCESS | 1764 | |9;json-stringify-tinderbox;61;62;61;62;62;61;62;62;62;63 16:33:46 INFO - PROCESS | 1764 | |10;stanford-crypto-aes;83;81;81;82;90;80;81;79;80;80 16:33:46 INFO - PROCESS | 1764 | |11;stanford-crypto-ccm;136;132;142;140;148;143;149;138;178;147 16:33:46 INFO - PROCESS | 1764 | |12;stanford-crypto-pbkdf2;165;166;166;167;167;166;168;166;174;168 16:33:46 INFO - PROCESS | 1764 | |13;stanford-crypto-sha256-iterative;69;66;70;65;65;65;64;63;72;64 16:33:46 INFO - PROCESS | 1764 | __end_tp_report 16:33:46 INFO - PROCESS | 1764 | __start_cc_report 16:33:46 INFO - PROCESS | 1764 | _x_x_mozilla_cycle_collect,1655 16:33:46 INFO - PROCESS | 1764 | __end_cc_report 16:33:46 INFO - PROCESS | 1764 | __startTimestamp1478824426693__endTimestamp 16:33:46 INFO - PROCESS | 1764 | 16:33:46 INFO - PROCESS | 1764 | ------- Summary: start ------- 16:33:46 INFO - PROCESS | 1764 | Number of tests: 14 16:33:46 INFO - PROCESS | 1764 | 16:33:46 INFO - PROCESS | 1764 | [#0] ai-astar Cycles:10 Average:110.70 Median:112.00 stddev:2.50 (2.2%) stddev-sans-first:0.88 16:33:46 INFO - PROCESS | 1764 | Values: 104.0 112.0 110.0 112.0 112.0 110.0 112.0 112.0 111.0 112.0 16:33:46 INFO - PROCESS | 1764 | 16:33:46 INFO - PROCESS | 1764 | [#1] audio-beat-detection Cycles:10 Average:134.80 Median:131.50 stddev:16.32 (12.4%) stddev-sans-first:16.80 16:33:46 INFO - PROCESS | 1764 | Values: 146.0 122.0 126.0 167.0 134.0 129.0 123.0 122.0 157.0 122.0 16:33:46 INFO - PROCESS | 1764 | 16:33:46 INFO - PROCESS | 1764 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 16:33:46 INFO - PROCESS | 1764 | Values: 162.0 160.0 162.0 160.0 161.0 161.0 161.0 161.0 161.0 162.0 16:33:46 INFO - PROCESS | 1764 | 16:33:46 INFO - PROCESS | 1764 | [#3] audio-fft Cycles:10 Average:82.00 Median:75.50 stddev:14.34 (19.0%) stddev-sans-first:14.99 16:33:46 INFO - PROCESS | 1764 | Values: 75.0 77.0 75.0 118.0 76.0 77.0 75.0 75.0 97.0 75.0 16:33:46 INFO - PROCESS | 1764 | 16:33:46 INFO - PROCESS | 1764 | [#4] audio-oscillator Cycles:10 Average:91.60 Median:83.00 stddev:15.01 (18.1%) stddev-sans-first:15.60 16:33:46 INFO - PROCESS | 1764 | Values: 83.0 83.0 121.0 83.0 83.0 83.0 102.0 82.0 82.0 114.0 16:33:46 INFO - PROCESS | 1764 | 16:33:46 INFO - PROCESS | 1764 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 16:33:46 INFO - PROCESS | 1764 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 16:33:46 INFO - PROCESS | 1764 | 16:33:46 INFO - PROCESS | 1764 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 16:33:46 INFO - PROCESS | 1764 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 16:33:46 INFO - PROCESS | 1764 | 16:33:46 INFO - PROCESS | 1764 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 16:33:46 INFO - PROCESS | 1764 | Values: 85.0 85.0 85.0 85.0 84.0 85.0 85.0 85.0 85.0 84.0 16:33:46 INFO - PROCESS | 1764 | 16:33:46 INFO - PROCESS | 1764 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:0.74 (1.4%) stddev-sans-first:0.78 16:33:46 INFO - PROCESS | 1764 | Values: 53.0 52.0 53.0 52.0 53.0 54.0 53.0 53.0 52.0 54.0 16:33:46 INFO - PROCESS | 1764 | 16:33:46 INFO - PROCESS | 1764 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 16:33:46 INFO - PROCESS | 1764 | Values: 61.0 62.0 61.0 62.0 62.0 61.0 62.0 62.0 62.0 63.0 16:33:46 INFO - PROCESS | 1764 | 16:33:46 INFO - PROCESS | 1764 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:81.00 stddev:3.13 (3.9%) stddev-sans-first:3.28 16:33:46 INFO - PROCESS | 1764 | Values: 83.0 81.0 81.0 82.0 90.0 80.0 81.0 79.0 80.0 80.0 16:33:46 INFO - PROCESS | 1764 | 16:33:46 INFO - PROCESS | 1764 | [#11] stanford-crypto-ccm Cycles:10 Average:145.30 Median:145.00 stddev:12.71 (8.8%) stddev-sans-first:13.03 16:33:46 INFO - PROCESS | 1764 | Values: 136.0 132.0 142.0 140.0 148.0 143.0 149.0 138.0 178.0 147.0 16:33:46 INFO - PROCESS | 1764 | 16:33:46 INFO - PROCESS | 1764 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.30 Median:167.00 stddev:2.54 (1.5%) stddev-sans-first:2.55 16:33:46 INFO - PROCESS | 1764 | Values: 165.0 166.0 166.0 167.0 167.0 166.0 168.0 166.0 174.0 168.0 16:33:46 INFO - PROCESS | 1764 | 16:33:46 INFO - PROCESS | 1764 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:65.50 stddev:2.98 (4.6%) stddev-sans-first:3.00 16:33:46 INFO - PROCESS | 1764 | Values: 69.0 66.0 70.0 65.0 65.0 65.0 64.0 63.0 72.0 64.0 16:33:46 INFO - PROCESS | 1764 | -------- Summary: end -------- 16:33:46 INFO - PROCESS | 1764 | 16:33:47 INFO - TEST-INFO | 1764: exit 0 16:33:47 INFO - TEST-OK | kraken | took 61649ms 16:33:47 INFO - SUITE-END | took 1179s 16:33:48 INFO - Completed test suite (00:19:39) 16:33:48 INFO - javascript benchmark 16:33:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3003.759699224062, 3026.863791129399, 3053.618297712785, 3060.7398371138465, 3064.4637188492006, 5107.872303192422, 5211.009908117455, 5245.055889939809, 5303.284056652351, 5367.865803354918, 5225.843224703265, 5250.18622113572, 5326.121190003654, 5351.277577527033, 5404.0, 4669.252919532875, 4759.381280433538, 4793.712377257359, 4830.830920917769, 4838.588719958808, 4843.0, 4852.757362131897, 4918.2376731606655, 4936.234883593049, 4981.626378021645, 4667.043256132485, 4819.9036019279765, 4877.756112194376, 4888.291197776321, 4968.826091086813, 4707.6233901287815, 4749.620030397595, 4753.500882407332, 4760.976195119037, 4814.422269327668, 4765.952340476586, 4805.903881922377, 4830.130576496229, 4835.540623640749, 4838.395200599925, 5238.13570760824, 5289.006799866076, 5292.497212764782, 5294.126469132589, 5353.250544923714, 5365.3293338332705, 5637.0, 5640.32316122068, 5641.576881733887, 5648.858778530528, 5454.945450545483, 5541.833744987616, 5604.691741954191, 5614.438556144353, 5704.087346024658, 5285.709285989269, 5291.1005129128525, 5291.232771248186, 5293.629445938747, 5301.867453313621, 5768.509676677446, 5771.119475534046, 5778.88442231153, 5782.450667186695, 5783.624064435799, 5361.98122356751, 5412.134058550691, 5432.782688692408, 5505.0, 5505.284313039279, 5549.417311182267, 5581.804636837691, 5583.497485226349, 5601.831945041656, 5621.409751975983, 5586.13414920688, 5593.0, 5593.0, 5594.300712410949, 5594.636348637407, 5382.973085134549, 5398.406175320712, 5400.4599540046465, 5436.70098144598, 5639.718014099279, 4277.721948073366, 4281.0, 4282.400463935051, 4303.591158839905, 4353.891152721144, 3902.90242743928, 3915.0212446888277, 3931.941020884689, 3940.0346915005434, 3951.92096158081, 5348.304720386325, 5385.111456609694, 5386.111291636836, 5390.730463476811, 5434.728263586805, 5448.455154484599, 5462.016836969384, 5619.072852979212, 5653.208550802891, 5659.349174844863, 5399.406065332811, 5449.782008719607, 5452.890942181134, 5482.17767334895, 5498.780048798003, 4951.628627852925, 4961.3798275215595, 4962.975185124052, 4968.527989840959, 5010.724410157476, 5707.0, 5747.48272655463, 5786.623869448473, 5905.379935106752, 5908.261467316585, 5640.915386269127, 5692.658440493584, 5698.971505142447, 5732.254806875247, 5752.906947679928, 5844.444777746107, 5889.734961926638, 5890.646561206341, 5902.586818922806, 5904.763809447574, 5350.170723537858, 5394.1099718546, 5526.47498487643, 5544.833654990357, 5580.832575022756, 5606.607537472338, 5659.0, 5663.150527420919, 5702.51528620072, 5772.624779389326, 5598.776048957996, 5599.552035837205, 5601.411851755507, 5602.887942241214, 5607.971960140337, 5371.462853714597, 5584.46947539983, 5586.413426590312, 5586.798838249796, 5591.832245032656, 5376.1398176291605, 5443.618946673695, 5459.344878614433, 5494.532964698045, 5583.581231407579, 5551.139573366135, 5578.358488773681, 5580.720963951868, 5590.748416321194, 5604.159376093618, 5262.736863156751, 5303.734813259244, 5419.34967803866, 5445.918311225256, 5469.753861076181], "value": 5205.552226662741, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.029990889655, 567.2738894215403, 573.5125143627916, 583.7489879351878, 588.5056552495903, 33466.49800252998, 41111.79444102779, 42255.57744422555, 42342.15315693688, 45246.09507809842, 43053.35419968695, 43589.34615980755, 43622.56377436232, 43652.781736091354, 43676.0, 7853.096893857194, 8078.39412044099, 8477.448965817233, 8624.439411438269, 8635.913640863573, 9984.0, 10213.387196768217, 10224.693259202237, 10497.68506944789, 10511.84232236517, 10335.483225838716, 10393.84409233862, 10403.84394234087, 10407.635732749355, 10410.479476026207, 10188.337758045704, 10246.48767561619, 10270.640527581574, 10277.845832312447, 10287.639932602398, 10188.388696678223, 10248.436336001518, 10252.026057524523, 10257.487125643687, 10259.076683098558, 40243.59756402457, 40520.594794052275, 40553.79723101395, 40584.188316233805, 40627.374905003766, 3510.666486683761, 3532.3994920863515, 3565.447355659877, 3811.0, 3914.725969182158, 29637.407251854842, 30607.387852243053, 30699.539506907415, 30734.23164420885, 30781.692183078332, 4036.4550785643855, 4146.170765846812, 4164.666826653891, 4307.267764480046, 4325.178216138924, 328959.9999999976, 330144.4449444282, 330151.8893677443, 330495.0, 331342.0, 55872.0, 56007.71996139993, 56028.71985640046, 56080.0, 56154.15768763472, 58593.41406585965, 58753.11870321949, 58761.0, 58784.7060764702, 58809.70595146997, 16294.266757995918, 16301.510954671141, 16375.836241637431, 16384.590385240463, 16495.83504164943, 11342.432878356049, 11950.282983020872, 11963.46164422603, 12189.207701499374, 12268.263904165779, 14891.32989015497, 15897.52307430779, 16552.0, 16577.834221657627, 16594.0, 4848.879547674762, 6396.456301214449, 6397.200349956255, 6464.159659244362, 6544.9672751635935, 947.5120313038791, 993.4734590666958, 1009.2884516415909, 1009.4145395670494, 1065.4246706778408, 31607.20981975469, 32430.675693242767, 34102.14744631404, 34126.65873341284, 34191.0, 1084.251866212311, 1091.1489038549944, 1093.2074246171462, 1117.5473933056962, 1128.4019469681082, 15195.848041519665, 16044.839551604335, 16140.677186456205, 16182.514524564282, 16299.0, 470409.0, 476189.0, 476229.0, 476728.0, 477201.0, 53866.46133538693, 54217.1867421989, 54229.45770542323, 54240.186397204074, 54287.18569221465, 1315.6776589735575, 1372.2384076837252, 1377.421482977152, 1382.1154461144874, 1399.0416564653244, 26991.46017079687, 27595.0, 27646.723532764416, 28086.57870131909, 30575.388492230475, 47069.0, 47471.52528474671, 47557.28664070111, 47564.2865357013, 47613.28580071371, 335066.0, 335099.0, 335977.0, 336535.0, 336784.0, 26646.402735630443, 26828.0, 26951.595726063733, 27036.459270814867, 27242.45515089727, 34797.82601086979, 38070.2385952285, 41660.79169604133, 43002.0, 44269.335959961274, 36403.359664033385, 37823.24353512859, 38283.0, 38627.0, 39400.802995984835, 37268.627313726516, 37910.0, 38912.0, 41510.79244603758, 42823.35764963466, 39249.215015700094, 39535.0, 40508.59491405048, 40776.59223407728, 40847.79576102101, 31183.0, 35754.28491430209, 35866.85395224306, 36363.27273454569, 36380.27239455143, 27400.45199095967, 27583.31041723973, 27691.861540692167, 27785.41679121593, 27909.581356279265], "value": 19398.444372928734, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.9476270703454, 394.899300678327, 401.8995251187203, 403.1372862075159, 417.8259091951616, 14022.439102435916, 15520.223988800572, 17093.316267349306, 18854.151563179654, 18863.62272754544, 14554.563363099123, 15651.843481565182, 17387.304507819703, 17438.302467901267, 17586.384476543324, 5243.318368612075, 5645.350784659755, 5677.43225677431, 5682.0, 5683.630564013347, 5461.563074954014, 5626.887462250753, 5646.265985421889, 5670.461306175906, 5671.177679236508, 5608.186812912125, 5644.463775941279, 5650.858728531778, 5657.773689052433, 5664.320281566218, 5437.456254374571, 5573.526250268732, 5654.095344744842, 5656.660600363992, 5657.32112146543, 5045.798168073273, 5062.544371006627, 5063.113955057887, 5064.113780088506, 5069.467705890902, 21289.893550532302, 21532.677009844865, 21993.23023694179, 22187.0, 22546.43633909149, 2236.7427745809277, 2248.415411992877, 2301.2060839010683, 2366.0890557135626, 2899.275181204699, 13584.388702508411, 13657.180569165783, 13758.93120534401, 13962.93018534911, 14085.859141408557, 1862.7764668239897, 1931.5557421792926, 1931.6819816220452, 1945.5194924559078, 1961.0586918279305, 73454.63272683656, 75336.24663753348, 75435.62282188609, 76256.0, 77994.0, 10251.897481025095, 10428.530716117793, 10638.361698298128, 10662.413567253876, 10694.679159625224, 14662.340194691264, 14674.266286685623, 14682.55952321432, 14686.265686715835, 14693.55919322422, 6788.524803263823, 7127.536710113826, 7624.428167887319, 7911.747553307829, 8193.83612327762, 7907.604619768988, 7987.480813747088, 7989.680412783539, 8291.0, 8319.792005199919, 6342.904856427157, 6390.360963903572, 6436.195475565554, 6471.2234531856475, 6496.415322620986, 1724.8792584519215, 1730.3424698614697, 1840.2550809103411, 1851.6111616560672, 1888.9622207555772, 439.75373790676684, 445.4721155430825, 451.93221016847735, 465.06521890999335, 874.8469017921839, 11508.94245528767, 11642.88357116418, 11757.588484403004, 11881.22772019816, 12053.939730301292, 458.3582983822675, 466.26795930388965, 467.1661084963324, 471.3707200886786, 473.79153172604634, 6032.728527216198, 6176.104464852661, 6219.129321894939, 6269.188229400642, 6404.807855764335, 452046.0, 464363.0, 467330.0, 468313.0, 468663.0, 91346.0, 94040.0, 95007.52496237613, 96231.0, 96388.0, 475.8025419450958, 483.8645179349788, 484.04884402149946, 484.5542101266843, 485.2357536879429, 10377.250028742239, 10704.357738535402, 10736.624218152327, 10852.511636976513, 10868.728281793019, 37256.81371593125, 38215.235695286494, 39644.0, 40016.0, 41035.58964410318, 57236.0, 57345.0, 58448.0, 58658.413415867006, 59501.70249148727, 8060.959695201486, 8116.553589552395, 8188.549629770419, 8377.958110209654, 8475.449095808754, 10363.94818025905, 12179.269243845398, 12477.875221247672, 12594.937025314815, 12697.36513174319, 10783.299085559414, 10956.506957186786, 10987.0, 11364.772704546029, 11584.94207528957, 10713.857228554165, 10929.398883061507, 11143.2199746017, 11330.886691133313, 11370.260933039326, 10856.185786066235, 10933.234673573092, 11043.0, 11168.66494005181, 11651.47568359409, 8004.639791209293, 8279.793005174919, 8298.87551686713, 8408.789780255542, 8442.620082096197, 10985.285956412808, 11056.12045952174, 11137.944310278397, 11242.550297988317, 12076.275423474619], "value": 8203.535460801819, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1290.6515240884955, 1434.8421673615903, 1444.6099553120657, 1574.4410734189362, 1733.3066773290682, 7062.223155452903, 7561.092668879735, 7883.881741773878, 7889.487183333086, 8134.145914678962, 7902.0, 7996.640151193195, 7997.000374953131, 8001.1198768135455, 8009.59952002399, 2184.0826852721857, 2209.7458792238936, 2209.7900699433526, 2210.635245184543, 2211.9336419907427, 2181.6182168120595, 2233.129079658934, 2248.190651365507, 2251.0, 2253.695751073609, 2179.0, 2188.6607575825774, 2209.8232141428725, 2211.469247380625, 2222.6443768996965, 2140.475583482041, 2144.517483566185, 2145.227718021511, 2151.7955794199606, 2157.611629906616, 2085.4265077103764, 2119.4065661614773, 2123.214410668047, 2124.649432843579, 2127.968080478794, 7235.0, 7396.223396543393, 7877.6848926042885, 7942.3646108311195, 8034.156413576548, 4756.143894099061, 4861.173600487926, 4866.926996095061, 4882.462929077798, 4885.560299573055, 3202.4876019836715, 3207.2302647364463, 3207.7273431758326, 3283.0479161043268, 3286.1291757684235, 1024.2062401638716, 1025.5333823110466, 1070.5182667799522, 1085.7502774361863, 1095.9780804383947, 10898.782024359469, 10924.2899211551, 10985.121190304837, 10986.505607247693, 11010.559577616887, 3999.680025597945, 4228.365745138254, 4297.968487563025, 4311.676624253194, 4317.676174286941, 8828.735137945872, 8846.690365837165, 8847.557622118868, 8855.601497932608, 8910.688125915562, 4886.804527818847, 4889.046635905964, 4891.437484689235, 4891.510848915151, 4893.045856058035, 3880.864169754045, 4145.730527515701, 4198.685098617616, 4584.679072464895, 4616.30755386688, 3408.556887604645, 3415.214500664861, 3469.5489586354115, 3528.929421411609, 3533.2403533239963, 1078.5577913055608, 1079.1690398393193, 1083.7266212200632, 1086.103964229498, 1089.0470838016736, 810.8094597769638, 857.1043259793531, 888.5379602606738, 907.577976241051, 917.4862077236769, 5373.140297552372, 5397.514223719884, 5546.889062218733, 5558.333000040021, 5749.425057494301, 894.4275663575316, 949.4303417949313, 977.9070988256104, 983.4541829284673, 1031.9113335431043, 3618.565772107311, 3647.2887786881834, 3667.9266414671556, 3736.8878933632036, 3883.533975922851, 9452.716418507456, 9820.459874706818, 9854.260930430246, 9867.654632087842, 9890.406575605486, 9224.815503690023, 9533.237341012702, 9770.071843174886, 9791.902080979242, 9809.705708828747, 7437.776866694008, 7581.583012934231, 7615.428842836809, 7620.237976202447, 7625.733099341496, 5336.412994570672, 5347.358317001829, 5423.186522021729, 5445.393608885309, 5576.972115139399, 8610.78473038179, 8970.147835955573, 9023.819523609622, 9060.864087038568, 9107.726768196964, 9156.954215228881, 9207.539623018689, 9208.861867072133, 9213.631454741735, 9233.030531794066, 6978.546394484342, 7118.928810711826, 7120.860662294008, 7124.750633727795, 7124.857502850017, 7290.380317673057, 7426.962865185639, 7467.77596672079, 7489.21363256872, 7494.475386722877, 6762.256151823197, 6835.453163746789, 6862.588244705334, 6945.722171113099, 6989.30106989297, 6824.624645644537, 6864.21061577925, 6938.548994315353, 6945.513814032969, 6986.755463558751, 5863.149843272787, 5972.34304226526, 5976.163337132718, 5979.372165922516, 5979.760809567742, 4605.194091033989, 4637.536246375335, 4717.080169366941, 4782.736949467812, 4794.880127996828, 4597.885052873705, 4785.282207668738, 4931.3835770528685, 4982.526659967298, 5001.549860512426], "value": 4231.259531819262, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.58079335277444, 330.6528145447281, 340.69337596163456, 340.8227721584776, 342.6727475261123, 5056.5701915337195, 5241.50617074134, 5243.134882744347, 5251.894962100756, 5286.497782710641, 5167.767450464728, 5177.4045984711765, 5198.350206224222, 5213.035588416136, 5214.634975551703, 4113.9794301028605, 4123.711340206187, 4128.772917489537, 4133.979330103345, 4137.503499580054, 4002.6384433184417, 4093.97953010236, 4098.959010409888, 4114.238865809834, 4127.906104882209, 4090.9590904090874, 4111.753294802306, 4114.218298523286, 4116.629503344699, 4121.289664789124, 4099.836006559734, 4104.774237416941, 4105.815238314253, 4113.321301985184, 4136.607022332873, 3675.246574452231, 3703.092742278159, 3705.1478160023075, 3706.314331848617, 3714.647108524686, 4960.553550180465, 5094.522588449346, 5104.566111880457, 5118.820841270538, 5146.536811686966, 4685.453800245945, 4688.648351373627, 4695.413073365829, 4714.387129673155, 4721.843148428623, 5240.384134946875, 5396.030448886128, 5406.243125962368, 5409.756560954766, 5417.891642167135, 3996.320625493644, 4004.619561141687, 4013.1572369802375, 4023.2556976959354, 4045.6763458923215, 5366.168243922199, 5536.529395001429, 5671.801486947978, 5673.319201695782, 5680.608250978496, 3953.347697629859, 4037.333839916381, 4039.8486431367505, 4047.1872048925716, 4062.857799976987, 4113.91772164555, 4121.598656456819, 4134.462519872397, 4146.0464093258715, 4155.8337666493, 4531.592156705912, 4692.178868697964, 4696.929546056812, 4697.271922851964, 4701.764911754399, 5377.4084850666395, 5401.891962160735, 5416.51251387377, 5423.864403389868, 5438.320209973754, 1390.1589538329367, 1402.5932479580808, 1404.7401230772339, 1417.3126033873564, 1422.3457209683454, 939.8731171291925, 973.1582181413027, 978.9314747967574, 980.9754756131153, 988.4267125067587, 5090.919993404012, 5123.974380128076, 5130.179171332569, 5183.637145399861, 5187.688738675692, 5374.408815030343, 5394.460553944574, 5396.9730151348995, 5447.4552544746, 5476.315460567429, 4977.203647416469, 5044.9495505045215, 5124.744437612809, 5140.871478213, 5178.430372659004, 2842.644669416323, 2851.1731597836397, 2860.156253905103, 2863.608886579688, 2869.842158681251, 5590.183190463115, 5592.636478628876, 5600.719964001783, 5602.719864006865, 5636.350011240743, 5411.918821217685, 5495.230667706524, 5696.23100881384, 5719.28508936383, 5722.170285308607, 5828.329742079631, 5838.153467747153, 5848.502877255396, 5868.002439585366, 5872.324682661463, 5431.4840090191365, 5600.131979543177, 5683.516901063291, 5725.16985037159, 5731.140328950691, 5507.614466987273, 5530.225768392509, 5572.442755724395, 5592.161175823497, 5611.270534830446, 5508.697021663686, 5669.54643628517, 5670.4329567044615, 5783.334916484658, 5784.016717158009, 4025.959740402676, 4056.9188616228103, 4061.4160477413243, 4088.158729682842, 4092.140650463436, 5658.886822263449, 5670.829875103754, 5681.8863622726485, 5684.431556844448, 5703.431556322044, 5249.317588713443, 5440.42875498067, 5489.286392768914, 5498.893125384146, 5576.665400076008, 5452.963936851986, 5484.945150548443, 5486.561075113901, 5492.80775172867, 5498.532624726943, 5243.5542978847225, 5451.56387488992, 5471.2887324647545, 5520.598539635272, 5529.861753456034, 5455.863603409946, 5481.629592601849, 5485.259489968803, 5492.873960838098, 5502.972485137549, 5310.920336195038, 5335.733213339395, 5355.544778693855, 5364.624476286623, 5392.487713667196], "value": 4181.3253493114, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [695.883186788132, 721.8087206890175, 734.9522281051729, 759.1118391481967, 765.2347652347653, 14343.928280358597, 15135.24323783809, 15199.544013679593, 15258.465953691622, 15260.542183734491, 13656.24890631015, 13892.79160812586, 13893.513727019556, 13896.374663140157, 13907.304634768247, 651.1860174781523, 669.4778073102988, 751.8308380614345, 759.2445516710881, 770.7186876789959, 766.6741634805213, 771.3944553525483, 771.4831063187678, 772.4168252969, 773.5899973014283, 818.8403261364036, 820.3191351178538, 820.4953953318695, 820.6266148902235, 820.6717313074788, 813.877918312252, 814.3322475570035, 814.5316443045243, 814.6334149632689, 814.816666250092, 496.781416176881, 503.27025812571554, 570.8744076303207, 587.4243241623233, 593.4184499190817, 13734.175949442966, 14150.716985660332, 14155.363008664532, 14160.36278367476, 14193.78709319361, 12933.741325173443, 12951.611451656465, 13092.738145237043, 13179.802302965463, 13453.798193027014, 11862.288262704265, 11947.761044779056, 11998.880011199864, 12122.939385303105, 12285.877141228562, 4097.713160078795, 4100.671946244323, 4148.813303401324, 4161.604647558477, 4332.371806088131, 56591.0, 57378.0, 58248.417515825146, 58579.70710146464, 58808.41191588072, 9116.225120864801, 9244.630214791467, 9282.164605185566, 9479.194268487256, 9657.46883921391, 18051.819481805014, 18106.63786724258, 18135.36526221576, 18148.183331750104, 18173.0, 7484.101907770993, 7525.548467091882, 7658.578778167254, 7660.693572257047, 7865.567393793396, 4155.8961025974595, 4252.829886804555, 4262.850800221977, 4304.612584867315, 4341.305391137403, 3155.25851424915, 3228.935421291608, 3229.6770322967513, 3230.353929214167, 3231.079142444392, 565.5673409841474, 575.5481946671842, 582.8193260089386, 589.6196952965313, 597.1520440973827, 536.9436209198057, 560.0646919644204, 659.120074700271, 672.1933679584421, 675.5203805298195, 8292.58537073144, 8433.325333973267, 8651.134886511425, 8761.299096072298, 8770.824583508294, 606.263389981175, 640.5870395160908, 642.9421352078335, 644.1512858097198, 664.4584663499329, 4084.509858816961, 4237.364395340724, 4264.104538047045, 4303.892402689895, 4365.454318210223, 87010.0, 87805.12194877969, 88890.0, 88896.555517222, 93162.53418732862, 62095.6895215521, 63505.0, 66964.0, 70527.64736176287, 71059.0, 62372.68813655902, 63797.68101159464, 64054.35945640484, 65301.67349163319, 65773.67113164403, 9007.414518056305, 9506.762330941505, 9655.179309758469, 9671.758206044906, 9712.854307185538, 44438.333424998, 44943.55056449524, 45022.0, 45609.0, 46380.30429543492, 55344.72327638336, 62581.68709156607, 62814.0, 62906.37093629005, 64568.0, 11529.423528823692, 11991.400429978292, 12002.879971200176, 12645.810312845499, 12667.87332126667, 12828.743425131632, 13052.49958949684, 13094.803577946528, 13275.80086298687, 13602.523911663044, 11073.446327683423, 12606.936965315115, 12626.936865315614, 13321.733565328834, 13470.93264533671, 10854.131669466582, 11185.776284474428, 11266.098712102848, 11679.124065695276, 11842.526298947945, 11360.318380897173, 11519.596814111466, 11600.419979000848, 11631.360275184947, 12047.690842723336, 9319.953400232955, 9660.95169524176, 9678.806423871623, 9771.413715177112, 9939.503024848873, 9783.767093953156, 10869.347839129678, 11112.277701949348, 11136.832947505633, 11302.886971130183], "value": 6752.2536093878025, "unit": "score"}], "name": "dromaeo_css", "value": 6801.200783383071, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 110.0, 112.0, 112.0, 110.0, 112.0, 112.0, 111.0, 112.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 122.0, 126.0, 167.0, 134.0, 129.0, 123.0, 122.0, 157.0, 122.0], "value": 134.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 162.0, 160.0, 161.0, 161.0, 161.0, 161.0, 161.0, 162.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 75.0, 118.0, 76.0, 77.0, 75.0, 75.0, 97.0, 75.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 121.0, 83.0, 83.0, 83.0, 102.0, 82.0, 82.0, 114.0], "value": 91.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 84.0, 85.0, 85.0, 85.0, 85.0, 84.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 52.0, 53.0, 54.0, 53.0, 53.0, 52.0, 54.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 62.0, 62.0, 61.0, 62.0, 62.0, 62.0, 63.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 81.0, 82.0, 90.0, 80.0, 81.0, 79.0, 80.0, 80.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 132.0, 142.0, 140.0, 148.0, 143.0, 149.0, 138.0, 178.0, 147.0], "value": 145.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 166.0, 167.0, 167.0, 166.0, 168.0, 166.0, 174.0, 168.0], "value": 167.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 70.0, 65.0, 65.0, 65.0, 64.0, 63.0, 72.0, 64.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1503.1999999999998, "alertThreshold": 2.0}]} 16:33:48 INFO - Return code: 0 16:33:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:33:48 INFO - # TBPL SUCCESS # 16:33:48 INFO - Running post-action listener: _resource_record_post_action 16:33:48 INFO - [mozharness: 2016-11-11 00:33:48.510554Z] Finished run-tests step (success) 16:33:48 INFO - Running post-run listener: _resource_record_post_run 16:33:48 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 8192; Write bytes: 401735680; Read time: 200; Write time: 241948 16:33:48 INFO - TinderboxPrint: CPU usage
13.1% 16:33:48 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 200 16:33:48 INFO - TinderboxPrint: I/O write bytes / time
401,735,680 / 241,948 16:33:48 INFO - TinderboxPrint: CPU idle
8,300.0 (86.9%) 16:33:48 INFO - TinderboxPrint: CPU user
1,201.6 (12.6%) 16:33:48 INFO - TinderboxPrint: Swap in / out
0 / 0 16:33:48 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103563264; Read time: 0; Write time: 62096 16:33:48 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 286535680; Read time: 188; Write time: 176556 16:33:49 INFO - Running post-run listener: _upload_blobber_files 16:33:49 INFO - Blob upload gear active. 16:33:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:33:49 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 16:33:49 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'] 16:33:49 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 16:33:49 INFO - (blobuploader) - INFO - Open directory for files ... 16:33:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:33:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:33:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:33:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:33:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:33:50 INFO - (blobuploader) - INFO - Done attempting. 16:33:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:33:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:33:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:33:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:33:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:33:53 INFO - (blobuploader) - INFO - Done attempting. 16:33:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:33:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:33:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:33:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:33:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:33:54 INFO - (blobuploader) - INFO - Done attempting. 16:33:54 INFO - (blobuploader) - INFO - Iteration through files over. 16:33:54 INFO - Return code: 0 16:33:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:33:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:33:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/604ef5cfc37de4a6b6be539b6b1c3061a59e88725d521f2c4f60d96689bbaf0eaaf10d98046a413d7b2d46320554e0a28064d750b2ce78dbeba536f140a0b896", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/edf8f121d571228abd35906f7c5f7c1830f8b01fed0a71cd8c8a9911df37710fab53e2dd6534970af3a2709233f8120d08a6d68745d3398bf92d19da9ca730ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de95487605d6259a7bf7474d27df2804aebb558f1fc63352efcb33528cc34006807953ae508e175b8fc2e362d360e912aefb4d3e3a8f24f78285c33ef66a1b95"} 16:33:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:33:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:33:54 INFO - Contents: 16:33:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/604ef5cfc37de4a6b6be539b6b1c3061a59e88725d521f2c4f60d96689bbaf0eaaf10d98046a413d7b2d46320554e0a28064d750b2ce78dbeba536f140a0b896", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/edf8f121d571228abd35906f7c5f7c1830f8b01fed0a71cd8c8a9911df37710fab53e2dd6534970af3a2709233f8120d08a6d68745d3398bf92d19da9ca730ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de95487605d6259a7bf7474d27df2804aebb558f1fc63352efcb33528cc34006807953ae508e175b8fc2e362d360e912aefb4d3e3a8f24f78285c33ef66a1b95"} 16:33:54 INFO - Running post-run listener: copy_logs_to_upload_dir 16:33:54 INFO - Copying logs to upload dir... 16:33:54 INFO - mkdir: /builds/slave/test/build/upload/logs 16:33:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.593623 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-11-10 16:33:54.381982) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-10 16:33:54.385736) ========= 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=a0d2d2de893abaa8702a9954000001a7-1478822497.277586-596989545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/604ef5cfc37de4a6b6be539b6b1c3061a59e88725d521f2c4f60d96689bbaf0eaaf10d98046a413d7b2d46320554e0a28064d750b2ce78dbeba536f140a0b896", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/edf8f121d571228abd35906f7c5f7c1830f8b01fed0a71cd8c8a9911df37710fab53e2dd6534970af3a2709233f8120d08a6d68745d3398bf92d19da9ca730ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de95487605d6259a7bf7474d27df2804aebb558f1fc63352efcb33528cc34006807953ae508e175b8fc2e362d360e912aefb4d3e3a8f24f78285c33ef66a1b95"} build_url:https://queue.taskcluster.net/v1/task/W9uUc71YTL6aH49pyykCFw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011212 build_url: 'https://queue.taskcluster.net/v1/task/W9uUc71YTL6aH49pyykCFw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/604ef5cfc37de4a6b6be539b6b1c3061a59e88725d521f2c4f60d96689bbaf0eaaf10d98046a413d7b2d46320554e0a28064d750b2ce78dbeba536f140a0b896", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/edf8f121d571228abd35906f7c5f7c1830f8b01fed0a71cd8c8a9911df37710fab53e2dd6534970af3a2709233f8120d08a6d68745d3398bf92d19da9ca730ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de95487605d6259a7bf7474d27df2804aebb558f1fc63352efcb33528cc34006807953ae508e175b8fc2e362d360e912aefb4d3e3a8f24f78285c33ef66a1b95"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-10 16:33:54.415741) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 16:33:54.416112) ========= 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=a0d2d2de893abaa8702a9954000001a7-1478822497.277586-596989545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004475 ========= master_lag: 0.78 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 16:33:55.198786) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-10 16:33:55.199359) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-10 16:33:55.202733) ========= ========= Total master_lag: 0.92 =========