builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-025 starttime: 1482190556.99 results: success (0) buildid: 20161219135323 builduid: 4afc5ef055a6416b9325d90248da76cc revision: e4865528325e8f9cc0a690ef9bcd3d6f79ca0866 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-19 15:35:56.991974) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-19 15:35:56.992423) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-19 15:35:56.992845) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-19 15:35:57.008628) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 15:35:57.008963) ========= 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=232498196343f89f466a4a9a000001c8-1482188026.708001-1231760579 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-19 15:35:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 46.2M=0s 2016-12-19 15:35:57 (46.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.069871 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 15:35:57.092941) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 15:35:57.093250) ========= 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=232498196343f89f466a4a9a000001c8-1482188026.708001-1231760579 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021900 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 15:35:57.148145) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 15:35:57.148564) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e4865528325e8f9cc0a690ef9bcd3d6f79ca0866 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e4865528325e8f9cc0a690ef9bcd3d6f79ca0866 --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=232498196343f89f466a4a9a000001c8-1482188026.708001-1231760579 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-19 15:35:57,562 truncating revision to first 12 chars 2016-12-19 15:35:57,562 Setting DEBUG logging. 2016-12-19 15:35:57,562 attempt 1/10 2016-12-19 15:35:57,562 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/e4865528325e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-19 15:35:57,864 unpacking tar archive at: mozilla-aurora-e4865528325e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.600167 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 15:35:57.762373) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-19 15:35:57.762705) ========= script_repo_revision: e4865528325e8f9cc0a690ef9bcd3d6f79ca0866 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-19 15:35:57.763203) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-19 15:35:57.763500) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-19 15:35:57.773578) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-12-19 15:35:57.773892) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=232498196343f89f466a4a9a000001c8-1482188026.708001-1231760579 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:35:58 INFO - MultiFileLogger online at 20161219 15:35:58 in /builds/slave/test 15:35:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 15:35:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:35:58 INFO - {'append_to_log': False, 15:35:58 INFO - 'base_work_dir': '/builds/slave/test', 15:35:58 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:35:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:35:58 INFO - 'branch': 'Mozilla-Aurora', 15:35:58 INFO - 'buildbot_json_path': 'buildprops.json', 15:35:58 INFO - 'config_files': ('talos/linux_config.py',), 15:35:58 INFO - 'default_actions': ('clobber', 15:35:58 INFO - 'read-buildbot-config', 15:35:58 INFO - 'download-and-extract', 15:35:58 INFO - 'populate-webroot', 15:35:58 INFO - 'create-virtualenv', 15:35:58 INFO - 'install', 15:35:58 INFO - 'run-tests'), 15:35:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:35:58 INFO - 'download_minidump_stackwalk': True, 15:35:58 INFO - 'download_symbols': 'ondemand', 15:35:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:35:58 INFO - 'tooltool.py': '/tools/tooltool.py', 15:35:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:35:58 INFO - '/tools/misc-python/virtualenv.py')}, 15:35:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:35:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:35:58 INFO - 'installer_path': 'installer.exe', 15:35:58 INFO - 'log_level': 'info', 15:35:58 INFO - 'log_name': 'talos', 15:35:58 INFO - 'log_to_console': True, 15:35:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:35:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:35:58 INFO - 'opt_config_files': (), 15:35:58 INFO - 'pip_index': False, 15:35:58 INFO - 'sps_profile': False, 15:35:58 INFO - 'sps_profile_interval': 0, 15:35:58 INFO - 'suite': 'dromaeojs', 15:35:58 INFO - 'system_bits': '32', 15:35:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:35:58 INFO - 'title': 'talos-linux64-ix-025', 15:35:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:35:58 INFO - 'use_talos_json': True, 15:35:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:35:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:35:58 INFO - 'work_dir': 'build'} 15:35:58 INFO - [mozharness: 2016-12-19 23:35:58.279915Z] Running clobber step. 15:35:58 INFO - Running pre-action listener: _resource_record_pre_action 15:35:58 INFO - Running main action method: clobber 15:35:58 INFO - rmtree: /builds/slave/test/build 15:35:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:35:58 INFO - Running post-action listener: _resource_record_post_action 15:35:58 INFO - [mozharness: 2016-12-19 23:35:58.739171Z] Finished clobber step (success) 15:35:58 INFO - [mozharness: 2016-12-19 23:35:58.739269Z] Running read-buildbot-config step. 15:35:58 INFO - Running pre-action listener: _resource_record_pre_action 15:35:58 INFO - Running main action method: read_buildbot_config 15:35:58 INFO - Using buildbot properties: 15:35:58 INFO - { 15:35:58 INFO - "project": "", 15:35:58 INFO - "product": "firefox", 15:35:58 INFO - "script_repo_revision": "production", 15:35:58 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 15:35:58 INFO - "repository": "", 15:35:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 15:35:58 INFO - "buildid": "20161219135323", 15:35:58 INFO - "pgo_build": "True", 15:35:58 INFO - "basedir": "/builds/slave/test", 15:35:58 INFO - "buildnumber": 649, 15:35:58 INFO - "slavename": "talos-linux64-ix-025", 15:35:58 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:35:58 INFO - "platform": "ubuntu64_hw", 15:35:58 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 15:35:58 INFO - "branch": "mozilla-aurora", 15:35:58 INFO - "repo_path": "releases/mozilla-aurora", 15:35:58 INFO - "revision": "e4865528325e8f9cc0a690ef9bcd3d6f79ca0866", 15:35:58 INFO - "stage_platform": "linux64-pgo", 15:35:58 INFO - "builduid": "4afc5ef055a6416b9325d90248da76cc", 15:35:58 INFO - "slavebuilddir": "test" 15:35:58 INFO - } 15:35:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/Vf8FnyBhTLKS9owecASzbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 15:35:58 INFO - Running post-action listener: _resource_record_post_action 15:35:58 INFO - [mozharness: 2016-12-19 23:35:58.741697Z] Finished read-buildbot-config step (success) 15:35:58 INFO - [mozharness: 2016-12-19 23:35:58.741785Z] Running download-and-extract step. 15:35:58 INFO - Running pre-action listener: _resource_record_pre_action 15:35:58 INFO - Running main action method: download_and_extract 15:35:58 INFO - mkdir: /builds/slave/test/build/tests 15:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:35:58 INFO - trying https://queue.taskcluster.net/v1/task/Vf8FnyBhTLKS9owecASzbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 15:35:58 INFO - Downloading https://queue.taskcluster.net/v1/task/Vf8FnyBhTLKS9owecASzbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 15:35:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Vf8FnyBhTLKS9owecASzbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:35:59 INFO - Downloaded 1361 bytes. 15:35:59 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 15:35:59 INFO - Using the following test package requirements: 15:35:59 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 15:35:59 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:35:59 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 15:35:59 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:35:59 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 15:35:59 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:35:59 INFO - u'jsshell-linux-x86_64.zip'], 15:35:59 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:35:59 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 15:35:59 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 15:35:59 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:35:59 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 15:35:59 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:35:59 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 15:35:59 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:35:59 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 15:35:59 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:35:59 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 15:35:59 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:35:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vf8FnyBhTLKS9owecASzbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 15:35:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vf8FnyBhTLKS9owecASzbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:35:59 INFO - Fetch https://queue.taskcluster.net/v1/task/Vf8FnyBhTLKS9owecASzbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 15:35:59 INFO - Http code: 200 15:35:59 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 15:35:59 INFO - x-amz-cf-id: 2PM4tcXULqm9SxNIYt6YTVDuaZaglE42fb5oW7YY8qs5QLYKykzX8A== 15:35:59 INFO - x-amz-version-id: tqcoH6Erhw6c0SQ7e4oc22iGJqgPCN7G 15:36:00 INFO - Expected file size: 21939531 15:36:00 INFO - Obtained file size: 21939531 15:36:04 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:36:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vf8FnyBhTLKS9owecASzbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 15:36:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vf8FnyBhTLKS9owecASzbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:36:04 INFO - Fetch https://queue.taskcluster.net/v1/task/Vf8FnyBhTLKS9owecASzbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 15:36:04 INFO - Http code: 200 15:36:04 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 15:36:04 INFO - x-amz-cf-id: 1VL5Ofemyncro1N8INVAPmST3jUJndsjr_oJR-2tCGH02QripWFUBg== 15:36:04 INFO - x-amz-version-id: tqcoH6Erhw6c0SQ7e4oc22iGJqgPCN7G 15:36:04 INFO - Expected file size: 21939531 15:36:04 INFO - Obtained file size: 21939531 15:36:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vf8FnyBhTLKS9owecASzbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 15:36:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vf8FnyBhTLKS9owecASzbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:36:09 INFO - Fetch https://queue.taskcluster.net/v1/task/Vf8FnyBhTLKS9owecASzbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 15:36:10 INFO - Http code: 200 15:36:10 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 15:36:10 INFO - x-amz-cf-id: u9NkKgUSK0uKm4QZURn40pulp8X4dnknKhr0TP8OVeUsnP8v8BA9vA== 15:36:10 INFO - x-amz-version-id: U97HVSMyZZaumn9cqiWY7lmOYbpRoTUZ 15:36:10 INFO - Expected file size: 14409038 15:36:10 INFO - Obtained file size: 14409038 15:36:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:36:11 INFO - trying https://queue.taskcluster.net/v1/task/Vf8FnyBhTLKS9owecASzbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 15:36:11 INFO - Downloading https://queue.taskcluster.net/v1/task/Vf8FnyBhTLKS9owecASzbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 15:36:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Vf8FnyBhTLKS9owecASzbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:36:12 INFO - Downloaded 63959311 bytes. 15:36:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Vf8FnyBhTLKS9owecASzbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 15:36:12 INFO - mkdir: /builds/slave/test/properties 15:36:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:36:12 INFO - Writing to file /builds/slave/test/properties/build_url 15:36:12 INFO - Contents: 15:36:12 INFO - build_url:https://queue.taskcluster.net/v1/task/Vf8FnyBhTLKS9owecASzbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 15:36:12 INFO - Running post-action listener: _resource_record_post_action 15:36:12 INFO - Running post-action listener: set_extra_try_arguments 15:36:12 INFO - [mozharness: 2016-12-19 23:36:12.959834Z] Finished download-and-extract step (success) 15:36:12 INFO - [mozharness: 2016-12-19 23:36:12.960059Z] Running populate-webroot step. 15:36:12 INFO - Running pre-action listener: _resource_record_pre_action 15:36:12 INFO - Running main action method: populate_webroot 15:36:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:36:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:36:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:36:12 INFO - '--tppagecycles', 15:36:12 INFO - '7'], 15:36:12 INFO - 'tests': ['tsvgm']}}, 15:36:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:36:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:36:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:36:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:36:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:36:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:36:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:36:12 INFO - 'talos_options': ['--disable-e10s'], 15:36:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:36:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:36:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:36:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:36:12 INFO - 'talos_options': ['--disable-e10s'], 15:36:12 INFO - 'tests': ['damp', 'tps']}, 15:36:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:36:12 INFO - 'tests': ['damp', 'tps']}, 15:36:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:36:12 INFO - 'tests': ['dromaeo_dom']}, 15:36:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:36:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:36:12 INFO - 'tests': ['basic_compositor_video']}, 15:36:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:36:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:36:12 INFO - 'tests': ['a11yr', 15:36:12 INFO - 'ts_paint', 15:36:12 INFO - 'tpaint', 15:36:12 INFO - 'sessionrestore', 15:36:12 INFO - 'sessionrestore_no_auto_restore', 15:36:12 INFO - 'tabpaint']}, 15:36:12 INFO - 'other-e10s': {'tests': ['a11yr', 15:36:12 INFO - 'ts_paint', 15:36:12 INFO - 'tpaint', 15:36:12 INFO - 'sessionrestore', 15:36:12 INFO - 'sessionrestore_no_auto_restore', 15:36:12 INFO - 'tabpaint']}, 15:36:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:36:12 INFO - 'ts_paint', 15:36:12 INFO - 'tpaint', 15:36:12 INFO - 'sessionrestore', 15:36:12 INFO - 'sessionrestore_no_auto_restore', 15:36:12 INFO - 'tabpaint']}, 15:36:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:36:12 INFO - 'ts_paint', 15:36:12 INFO - 'tpaint', 15:36:12 INFO - 'sessionrestore', 15:36:12 INFO - 'sessionrestore_no_auto_restore', 15:36:12 INFO - 'tabpaint']}, 15:36:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:36:12 INFO - 'tests': ['a11yr', 15:36:12 INFO - 'ts_paint', 15:36:12 INFO - 'tpaint', 15:36:12 INFO - 'sessionrestore', 15:36:12 INFO - 'sessionrestore_no_auto_restore', 15:36:12 INFO - 'tabpaint']}, 15:36:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:36:12 INFO - 'tests': ['a11yr', 15:36:12 INFO - 'ts_paint', 15:36:12 INFO - 'tpaint', 15:36:12 INFO - 'sessionrestore', 15:36:12 INFO - 'sessionrestore_no_auto_restore', 15:36:12 INFO - 'tabpaint']}, 15:36:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:36:12 INFO - 'tests': ['tsvgx', 15:36:12 INFO - 'tsvgr_opacity', 15:36:12 INFO - 'tart', 15:36:12 INFO - 'tscrollx', 15:36:12 INFO - 'cart']}, 15:36:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:36:12 INFO - 'tsvgr_opacity', 15:36:12 INFO - 'tart', 15:36:12 INFO - 'tscrollx', 15:36:12 INFO - 'cart']}, 15:36:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:36:12 INFO - 'talos_options': ['--disable-e10s'], 15:36:12 INFO - 'tests': ['tp5o']}, 15:36:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:36:12 INFO - 'tests': ['tp5o']}, 15:36:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:36:12 INFO - 'talos_options': ['--disable-e10s', 15:36:12 INFO - '--xperf_path', 15:36:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:36:12 INFO - 'tests': ['tp5n']}, 15:36:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:36:12 INFO - 'talos_options': ['--xperf_path', 15:36:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:36:12 INFO - 'tests': ['tp5n']}}, 15:36:12 INFO - 'talos.zip': {'path': '', 15:36:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:36:12 INFO - Running post-action listener: _resource_record_post_action 15:36:12 INFO - [mozharness: 2016-12-19 23:36:12.976296Z] Finished populate-webroot step (success) 15:36:12 INFO - [mozharness: 2016-12-19 23:36:12.976383Z] Running create-virtualenv step. 15:36:12 INFO - Running pre-action listener: _resource_record_pre_action 15:36:12 INFO - Running main action method: create_virtualenv 15:36:12 INFO - Creating virtualenv /builds/slave/test/build/venv 15:36:12 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:36:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:36:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:36:13 INFO - Using real prefix '/usr' 15:36:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:36:13 INFO - Installing distribute.............................................................................................................................................................................................done. 15:36:15 INFO - Installing pip.................done. 15:36:15 INFO - Return code: 0 15:36:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:36:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:36:15 INFO - Reading from file tmpfile_stdout 15:36:15 INFO - Output received: 15:36:15 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 15:36:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:36:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:36:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:36:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:36:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd75ca08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1499f60>, '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 0x149ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149b1d0>, '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': '232498196343f89f466a4a9a000001c8-1482188026.708001-1231760579', '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 15:36:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:36:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:36:15 INFO - Using env: {'DISPLAY': ':0', 15:36:15 INFO - 'HOME': '/home/cltbld', 15:36:15 INFO - 'LANG': 'en_US.UTF-8', 15:36:15 INFO - 'LANGUAGE': 'en_US:en', 15:36:15 INFO - 'LOGNAME': 'cltbld', 15:36:15 INFO - 'MAIL': '/var/mail/cltbld', 15:36:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:15 INFO - 'MOZ_NO_REMOTE': '1', 15:36:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:36:15 INFO - 'NO_EM_RESTART': '1', 15:36:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:36:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:36:15 INFO - 'PWD': '/builds/slave/test', 15:36:15 INFO - 'SHELL': '/bin/bash', 15:36:15 INFO - 'SHLVL': '1', 15:36:15 INFO - 'TERM': 'linux', 15:36:15 INFO - 'TMOUT': '86400', 15:36:15 INFO - 'USER': 'cltbld', 15:36:15 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1482188026.708001-1231760579', 15:36:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:15 INFO - '_': '/tools/buildbot/bin/python'} 15:36:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:36:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:36:15 INFO - Cleaning up... 15:36:15 INFO - Return code: 0 15:36:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:36:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:36:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:36:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:36:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd75ca08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1499f60>, '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 0x149ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149b1d0>, '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': '232498196343f89f466a4a9a000001c8-1482188026.708001-1231760579', '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 15:36:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:36:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:36:15 INFO - Using env: {'DISPLAY': ':0', 15:36:15 INFO - 'HOME': '/home/cltbld', 15:36:15 INFO - 'LANG': 'en_US.UTF-8', 15:36:15 INFO - 'LANGUAGE': 'en_US:en', 15:36:15 INFO - 'LOGNAME': 'cltbld', 15:36:15 INFO - 'MAIL': '/var/mail/cltbld', 15:36:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:15 INFO - 'MOZ_NO_REMOTE': '1', 15:36:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:36:15 INFO - 'NO_EM_RESTART': '1', 15:36:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:36:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:36:15 INFO - 'PWD': '/builds/slave/test', 15:36:15 INFO - 'SHELL': '/bin/bash', 15:36:15 INFO - 'SHLVL': '1', 15:36:15 INFO - 'TERM': 'linux', 15:36:15 INFO - 'TMOUT': '86400', 15:36:15 INFO - 'USER': 'cltbld', 15:36:15 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1482188026.708001-1231760579', 15:36:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:15 INFO - '_': '/tools/buildbot/bin/python'} 15:36:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:36:16 INFO - Downloading/unpacking psutil>=3.1.1 15:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:36:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:36:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:36:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:36:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:36:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:36:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:36:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:36:18 INFO - Installing collected packages: psutil 15:36:18 INFO - Running setup.py install for psutil 15:36:18 INFO - building 'psutil._psutil_linux' extension 15:36:18 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 15:36:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:36:18 INFO - building 'psutil._psutil_posix' extension 15:36:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:36:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:36:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:36:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:36:18 INFO - Successfully installed psutil 15:36:18 INFO - Cleaning up... 15:36:18 INFO - Return code: 0 15:36:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:36:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:36:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:36:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:36:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd75ca08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1499f60>, '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 0x149ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149b1d0>, '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': '232498196343f89f466a4a9a000001c8-1482188026.708001-1231760579', '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 15:36:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:36:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:36:18 INFO - Using env: {'DISPLAY': ':0', 15:36:18 INFO - 'HOME': '/home/cltbld', 15:36:18 INFO - 'LANG': 'en_US.UTF-8', 15:36:18 INFO - 'LANGUAGE': 'en_US:en', 15:36:18 INFO - 'LOGNAME': 'cltbld', 15:36:18 INFO - 'MAIL': '/var/mail/cltbld', 15:36:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:18 INFO - 'MOZ_NO_REMOTE': '1', 15:36:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:36:18 INFO - 'NO_EM_RESTART': '1', 15:36:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:36:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:36:18 INFO - 'PWD': '/builds/slave/test', 15:36:18 INFO - 'SHELL': '/bin/bash', 15:36:18 INFO - 'SHLVL': '1', 15:36:18 INFO - 'TERM': 'linux', 15:36:18 INFO - 'TMOUT': '86400', 15:36:18 INFO - 'USER': 'cltbld', 15:36:18 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1482188026.708001-1231760579', 15:36:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:18 INFO - '_': '/tools/buildbot/bin/python'} 15:36:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:36:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:36:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:36:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:36:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:36:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:36:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:36:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:36:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:36:21 INFO - Installing collected packages: mozsystemmonitor 15:36:21 INFO - Running setup.py install for mozsystemmonitor 15:36:21 INFO - Successfully installed mozsystemmonitor 15:36:21 INFO - Cleaning up... 15:36:21 INFO - Return code: 0 15:36:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:36:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:36:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:36:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:36:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:36:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:21 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 0x7fd75ca08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1499f60>, '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 0x149ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149b1d0>, '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': '232498196343f89f466a4a9a000001c8-1482188026.708001-1231760579', '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 15:36:21 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 15:36:21 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 15:36:21 INFO - Using env: {'DISPLAY': ':0', 15:36:21 INFO - 'HOME': '/home/cltbld', 15:36:21 INFO - 'LANG': 'en_US.UTF-8', 15:36:21 INFO - 'LANGUAGE': 'en_US:en', 15:36:21 INFO - 'LOGNAME': 'cltbld', 15:36:21 INFO - 'MAIL': '/var/mail/cltbld', 15:36:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:21 INFO - 'MOZ_NO_REMOTE': '1', 15:36:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:36:21 INFO - 'NO_EM_RESTART': '1', 15:36:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:36:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:36:21 INFO - 'PWD': '/builds/slave/test', 15:36:21 INFO - 'SHELL': '/bin/bash', 15:36:21 INFO - 'SHLVL': '1', 15:36:21 INFO - 'TERM': 'linux', 15:36:21 INFO - 'TMOUT': '86400', 15:36:21 INFO - 'USER': 'cltbld', 15:36:21 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1482188026.708001-1231760579', 15:36:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:21 INFO - '_': '/tools/buildbot/bin/python'} 15:36:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:36:21 INFO - Downloading/unpacking jsonschema==2.5.1 15:36:21 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 15:36:21 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 15:36:21 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 15:36:21 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 15:36:21 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 15:36:21 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 15:36:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:36:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:36:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:36:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:36:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:36:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:36:23 INFO - Downloading functools32-3.2.3-2.tar.gz 15:36:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:36:23 INFO - warning: no files found matching '*.txt' 15:36:23 INFO - no previously-included directories found matching 'build' 15:36:23 INFO - no previously-included directories found matching 'dist' 15:36:23 INFO - no previously-included directories found matching '.git*' 15:36:23 INFO - Installing collected packages: jsonschema, functools32 15:36:23 INFO - Running setup.py install for functools32 15:36:23 INFO - warning: no files found matching '*.txt' 15:36:23 INFO - no previously-included directories found matching 'build' 15:36:23 INFO - no previously-included directories found matching 'dist' 15:36:23 INFO - no previously-included directories found matching '.git*' 15:36:23 INFO - Successfully installed jsonschema functools32 15:36:23 INFO - Cleaning up... 15:36:23 INFO - Return code: 0 15:36:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:36:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:36:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:36:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:36:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:24 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 0x7fd75ca08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1499f60>, '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 0x149ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149b1d0>, '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': '232498196343f89f466a4a9a000001c8-1482188026.708001-1231760579', '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 15:36:24 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 15:36:24 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 15:36:24 INFO - Using env: {'DISPLAY': ':0', 15:36:24 INFO - 'HOME': '/home/cltbld', 15:36:24 INFO - 'LANG': 'en_US.UTF-8', 15:36:24 INFO - 'LANGUAGE': 'en_US:en', 15:36:24 INFO - 'LOGNAME': 'cltbld', 15:36:24 INFO - 'MAIL': '/var/mail/cltbld', 15:36:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:24 INFO - 'MOZ_NO_REMOTE': '1', 15:36:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:36:24 INFO - 'NO_EM_RESTART': '1', 15:36:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:36:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:36:24 INFO - 'PWD': '/builds/slave/test', 15:36:24 INFO - 'SHELL': '/bin/bash', 15:36:24 INFO - 'SHLVL': '1', 15:36:24 INFO - 'TERM': 'linux', 15:36:24 INFO - 'TMOUT': '86400', 15:36:24 INFO - 'USER': 'cltbld', 15:36:24 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1482188026.708001-1231760579', 15:36:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:24 INFO - '_': '/tools/buildbot/bin/python'} 15:36:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:36:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:36:24 INFO - Cleaning up... 15:36:24 INFO - Return code: 0 15:36:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:36:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:36:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:36:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:36:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:24 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 0x7fd75ca08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1499f60>, '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 0x149ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149b1d0>, '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': '232498196343f89f466a4a9a000001c8-1482188026.708001-1231760579', '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 15:36:24 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 15:36:24 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 15:36:24 INFO - Using env: {'DISPLAY': ':0', 15:36:24 INFO - 'HOME': '/home/cltbld', 15:36:24 INFO - 'LANG': 'en_US.UTF-8', 15:36:24 INFO - 'LANGUAGE': 'en_US:en', 15:36:24 INFO - 'LOGNAME': 'cltbld', 15:36:24 INFO - 'MAIL': '/var/mail/cltbld', 15:36:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:24 INFO - 'MOZ_NO_REMOTE': '1', 15:36:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:36:24 INFO - 'NO_EM_RESTART': '1', 15:36:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:36:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:36:24 INFO - 'PWD': '/builds/slave/test', 15:36:24 INFO - 'SHELL': '/bin/bash', 15:36:24 INFO - 'SHLVL': '1', 15:36:24 INFO - 'TERM': 'linux', 15:36:24 INFO - 'TMOUT': '86400', 15:36:24 INFO - 'USER': 'cltbld', 15:36:24 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1482188026.708001-1231760579', 15:36:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:24 INFO - '_': '/tools/buildbot/bin/python'} 15:36:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:36:24 INFO - Downloading/unpacking blobuploader==1.2.4 15:36:24 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 15:36:24 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 15:36:24 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 15:36:24 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 15:36:24 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 15:36:24 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 15:36:26 INFO - Downloading blobuploader-1.2.4.tar.gz 15:36:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:36:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:36:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:36:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:36:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:36:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:36:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:36:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:36:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:36:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:36:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:36:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:36:27 INFO - Downloading docopt-0.6.1.tar.gz 15:36:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:36:27 INFO - Installing collected packages: blobuploader, requests, docopt 15:36:27 INFO - Running setup.py install for blobuploader 15:36:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:36:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:36:27 INFO - Running setup.py install for requests 15:36:27 INFO - Running setup.py install for docopt 15:36:27 INFO - Successfully installed blobuploader requests docopt 15:36:27 INFO - Cleaning up... 15:36:27 INFO - Return code: 0 15:36:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:36:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:36:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:36:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd75ca08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1499f60>, '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 0x149ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149b1d0>, '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': '232498196343f89f466a4a9a000001c8-1482188026.708001-1231760579', '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 15:36:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:36:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:36:27 INFO - Using env: {'DISPLAY': ':0', 15:36:27 INFO - 'HOME': '/home/cltbld', 15:36:27 INFO - 'LANG': 'en_US.UTF-8', 15:36:27 INFO - 'LANGUAGE': 'en_US:en', 15:36:27 INFO - 'LOGNAME': 'cltbld', 15:36:27 INFO - 'MAIL': '/var/mail/cltbld', 15:36:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:27 INFO - 'MOZ_NO_REMOTE': '1', 15:36:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:36:27 INFO - 'NO_EM_RESTART': '1', 15:36:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:36:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:36:27 INFO - 'PWD': '/builds/slave/test', 15:36:27 INFO - 'SHELL': '/bin/bash', 15:36:27 INFO - 'SHLVL': '1', 15:36:27 INFO - 'TERM': 'linux', 15:36:27 INFO - 'TMOUT': '86400', 15:36:27 INFO - 'USER': 'cltbld', 15:36:27 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1482188026.708001-1231760579', 15:36:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:27 INFO - '_': '/tools/buildbot/bin/python'} 15:36:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:36:28 INFO - Running setup.py (path:/tmp/pip-G5Uc5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:36:28 INFO - Running setup.py (path:/tmp/pip-s3W2Lv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:36:28 INFO - Running setup.py (path:/tmp/pip-kK6bUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:36:28 INFO - Running setup.py (path:/tmp/pip-yvZpWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:36:28 INFO - Running setup.py (path:/tmp/pip-uPSOHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:36:28 INFO - Running setup.py (path:/tmp/pip-fSq7o4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:36:28 INFO - Running setup.py (path:/tmp/pip-2RO8Kz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:36:28 INFO - Running setup.py (path:/tmp/pip-LqhYH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:36:28 INFO - Running setup.py (path:/tmp/pip-RlKIlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:36:28 INFO - Running setup.py (path:/tmp/pip-9LR99X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:36:28 INFO - Running setup.py (path:/tmp/pip-lhfslM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:36:28 INFO - Running setup.py (path:/tmp/pip-QZTWO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:36:28 INFO - Running setup.py (path:/tmp/pip-0NDfbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:36:29 INFO - Running setup.py (path:/tmp/pip-0yafpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:36:29 INFO - Running setup.py (path:/tmp/pip-D_287O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:36:29 INFO - Running setup.py (path:/tmp/pip-ugy1M_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:36:29 INFO - Running setup.py (path:/tmp/pip-9ZqyKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:36:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:36:29 INFO - Running setup.py install for manifestparser 15:36:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:36:29 INFO - Running setup.py install for mozcrash 15:36:29 INFO - Running setup.py install for mozdebug 15:36:29 INFO - Running setup.py install for mozdevice 15:36:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:36:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:36:29 INFO - Running setup.py install for mozfile 15:36:29 INFO - Running setup.py install for mozhttpd 15:36:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:36:29 INFO - Running setup.py install for mozinfo 15:36:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:36:29 INFO - Running setup.py install for mozInstall 15:36:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:36:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:36:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:36:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:36:30 INFO - Running setup.py install for mozleak 15:36:30 INFO - Running setup.py install for mozlog 15:36:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:36:30 INFO - Running setup.py install for moznetwork 15:36:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:36:30 INFO - Running setup.py install for mozprocess 15:36:30 INFO - Running setup.py install for mozprofile 15:36:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:36:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:36:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:36:30 INFO - Running setup.py install for mozrunner 15:36:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:36:30 INFO - Running setup.py install for mozscreenshot 15:36:30 INFO - Running setup.py install for moztest 15:36:30 INFO - Running setup.py install for mozversion 15:36:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:36:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:36:31 INFO - Cleaning up... 15:36:31 INFO - Return code: 0 15:36:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:36: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')]} 15:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:36:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36: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')]} 15:36:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:36:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:31 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 0x7fd75ca08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1499f60>, '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 0x149ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149b1d0>, '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': '232498196343f89f466a4a9a000001c8-1482188026.708001-1231760579', '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 15:36:31 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 15:36:31 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 15:36:31 INFO - Using env: {'DISPLAY': ':0', 15:36:31 INFO - 'HOME': '/home/cltbld', 15:36:31 INFO - 'LANG': 'en_US.UTF-8', 15:36:31 INFO - 'LANGUAGE': 'en_US:en', 15:36:31 INFO - 'LOGNAME': 'cltbld', 15:36:31 INFO - 'MAIL': '/var/mail/cltbld', 15:36:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:31 INFO - 'MOZ_NO_REMOTE': '1', 15:36:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:36:31 INFO - 'NO_EM_RESTART': '1', 15:36:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:36:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:36:31 INFO - 'PWD': '/builds/slave/test', 15:36:31 INFO - 'SHELL': '/bin/bash', 15:36:31 INFO - 'SHLVL': '1', 15:36:31 INFO - 'TERM': 'linux', 15:36:31 INFO - 'TMOUT': '86400', 15:36:31 INFO - 'USER': 'cltbld', 15:36:31 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1482188026.708001-1231760579', 15:36:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:31 INFO - '_': '/tools/buildbot/bin/python'} 15:36:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:36:31 INFO - Running setup.py (path:/tmp/pip-ZZB5Sh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:36:31 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)) 15:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:36:31 INFO - Running setup.py (path:/tmp/pip-uK3GKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:36:31 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)) 15:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:36:31 INFO - Running setup.py (path:/tmp/pip-8jAZJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:36:31 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)) 15:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:36:31 INFO - Running setup.py (path:/tmp/pip-VtqRuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:36:31 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)) 15:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:36:31 INFO - Running setup.py (path:/tmp/pip-6DdEOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:36:31 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)) 15:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:36:31 INFO - Running setup.py (path:/tmp/pip-9F12ui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:36:31 INFO - Running setup.py (path:/tmp/pip-KKmIa1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:36:31 INFO - Running setup.py (path:/tmp/pip-DVXOg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:36:31 INFO - Running setup.py (path:/tmp/pip-SxOywe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:36:31 INFO - Running setup.py (path:/tmp/pip-wjd5Dn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:36:32 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)) 15:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:36:32 INFO - Running setup.py (path:/tmp/pip-qEzVD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:36:32 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)) 15:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:36:32 INFO - Running setup.py (path:/tmp/pip-VaG91U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:36:32 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)) 15:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:36:32 INFO - Running setup.py (path:/tmp/pip-N8Nqa5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:36:32 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)) 15:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:36:32 INFO - Running setup.py (path:/tmp/pip-ac9GBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:36:32 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)) 15:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:36:32 INFO - Running setup.py (path:/tmp/pip-4AzvXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:36:32 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)) 15:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:36:32 INFO - Running setup.py (path:/tmp/pip-OpjgdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:36:32 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)) 15:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:36:32 INFO - Running setup.py (path:/tmp/pip-paywdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:36:32 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)) 15:36:32 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)) 15:36:32 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)) 15:36:32 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)) 15:36:32 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)) 15:36:32 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)) 15:36:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:36: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 15:36: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 15:36: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 15:36: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 15:36: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 15:36: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 15:36:34 INFO - Downloading blessings-1.6.tar.gz 15:36:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:36:34 INFO - Installing collected packages: blessings 15:36:34 INFO - Running setup.py install for blessings 15:36:34 INFO - Successfully installed blessings 15:36:34 INFO - Cleaning up... 15:36:34 INFO - Return code: 0 15:36:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:36:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:36:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:36:35 INFO - Reading from file tmpfile_stdout 15:36:35 INFO - Current package versions: 15:36:35 INFO - argparse == 1.2.1 15:36:35 INFO - blessings == 1.6 15:36:35 INFO - blobuploader == 1.2.4 15:36:35 INFO - docopt == 0.6.1 15:36:35 INFO - functools32 == 3.2.3-2 15:36:35 INFO - jsonschema == 2.5.1 15:36:35 INFO - manifestparser == 1.1 15:36:35 INFO - mozInstall == 1.12 15:36:35 INFO - mozcrash == 1.0 15:36:35 INFO - mozdebug == 0.1 15:36:35 INFO - mozdevice == 0.48 15:36:35 INFO - mozfile == 1.2 15:36:35 INFO - mozhttpd == 0.7 15:36:35 INFO - mozinfo == 0.9 15:36:35 INFO - mozleak == 0.1 15:36:35 INFO - mozlog == 3.4 15:36:35 INFO - moznetwork == 0.27 15:36:35 INFO - mozprocess == 0.23 15:36:35 INFO - mozprofile == 0.28 15:36:35 INFO - mozrunner == 6.13 15:36:35 INFO - mozscreenshot == 0.1 15:36:35 INFO - mozsystemmonitor == 0.3 15:36:35 INFO - moztest == 0.7 15:36:35 INFO - mozversion == 1.4 15:36:35 INFO - psutil == 3.1.1 15:36:35 INFO - requests == 1.2.3 15:36:35 INFO - wsgiref == 0.1.2 15:36:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:36:35 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')]} 15:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:36:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:35 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')]} 15:36:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:36:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:35 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 0x7fd75ca08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1499f60>, '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 0x149ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149b1d0>, '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': '232498196343f89f466a4a9a000001c8-1482188026.708001-1231760579', '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 15:36:35 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 15:36:35 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 15:36:35 INFO - Using env: {'DISPLAY': ':0', 15:36:35 INFO - 'HOME': '/home/cltbld', 15:36:35 INFO - 'LANG': 'en_US.UTF-8', 15:36:35 INFO - 'LANGUAGE': 'en_US:en', 15:36:35 INFO - 'LOGNAME': 'cltbld', 15:36:35 INFO - 'MAIL': '/var/mail/cltbld', 15:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:35 INFO - 'MOZ_NO_REMOTE': '1', 15:36:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:36:35 INFO - 'NO_EM_RESTART': '1', 15:36:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:36:35 INFO - 'PWD': '/builds/slave/test', 15:36:35 INFO - 'SHELL': '/bin/bash', 15:36:35 INFO - 'SHLVL': '1', 15:36:35 INFO - 'TERM': 'linux', 15:36:35 INFO - 'TMOUT': '86400', 15:36:35 INFO - 'USER': 'cltbld', 15:36:35 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1482188026.708001-1231760579', 15:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:35 INFO - '_': '/tools/buildbot/bin/python'} 15:36:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:36:35 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)) 15:36:35 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)) 15:36:35 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)) 15:36:35 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)) 15:36:35 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)) 15:36:35 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)) 15:36:35 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)) 15:36:35 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)) 15:36:35 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)) 15:36:35 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)) 15:36:35 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)) 15:36:35 INFO - Cleaning up... 15:36:35 INFO - Return code: 0 15:36:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:36:35 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')]} 15:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:36:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:35 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')]} 15:36:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:36:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd75ca08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1499f60>, '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 0x149ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149b1d0>, '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': '232498196343f89f466a4a9a000001c8-1482188026.708001-1231760579', '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 15:36: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', 'jsonschema'] in /builds/slave/test/build 15:36: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 jsonschema 15:36:35 INFO - Using env: {'DISPLAY': ':0', 15:36:35 INFO - 'HOME': '/home/cltbld', 15:36:35 INFO - 'LANG': 'en_US.UTF-8', 15:36:35 INFO - 'LANGUAGE': 'en_US:en', 15:36:35 INFO - 'LOGNAME': 'cltbld', 15:36:35 INFO - 'MAIL': '/var/mail/cltbld', 15:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:35 INFO - 'MOZ_NO_REMOTE': '1', 15:36:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:36:35 INFO - 'NO_EM_RESTART': '1', 15:36:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:36:35 INFO - 'PWD': '/builds/slave/test', 15:36:35 INFO - 'SHELL': '/bin/bash', 15:36:35 INFO - 'SHLVL': '1', 15:36:35 INFO - 'TERM': 'linux', 15:36:35 INFO - 'TMOUT': '86400', 15:36:35 INFO - 'USER': 'cltbld', 15:36:35 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1482188026.708001-1231760579', 15:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:35 INFO - '_': '/tools/buildbot/bin/python'} 15:36:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:36:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:36:35 INFO - Cleaning up... 15:36:35 INFO - Return code: 0 15:36:35 INFO - Running post-action listener: _resource_record_post_action 15:36:35 INFO - Running post-action listener: _start_resource_monitoring 15:36:35 INFO - Starting resource monitoring. 15:36:35 INFO - [mozharness: 2016-12-19 23:36:35.528472Z] Finished create-virtualenv step (success) 15:36:35 INFO - [mozharness: 2016-12-19 23:36:35.529035Z] Running install step. 15:36:35 INFO - Running pre-action listener: _resource_record_pre_action 15:36:35 INFO - Running main action method: install 15:36:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:36:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:36:35 INFO - Reading from file tmpfile_stdout 15:36:35 INFO - Detecting whether we're running mozinstall >=1.0... 15:36:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:36:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:36:35 INFO - Reading from file tmpfile_stdout 15:36:35 INFO - Output received: 15:36:35 INFO - Usage: mozinstall [options] installer 15:36:35 INFO - Options: 15:36:35 INFO - -h, --help show this help message and exit 15:36:35 INFO - -d DEST, --destination=DEST 15:36:35 INFO - Directory to install application into. [default: 15:36:35 INFO - "/builds/slave/test"] 15:36:35 INFO - --app=APP Application being installed. [default: firefox] 15:36:35 INFO - mkdir: /builds/slave/test/build/application 15:36:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:36:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:36:51 INFO - Reading from file tmpfile_stdout 15:36:51 INFO - Output received: 15:36:51 INFO - /builds/slave/test/build/application/firefox/firefox 15:36:51 INFO - Running post-action listener: _resource_record_post_action 15:36:51 INFO - [mozharness: 2016-12-19 23:36:51.777635Z] Finished install step (success) 15:36:51 INFO - [mozharness: 2016-12-19 23:36:51.777877Z] Running run-tests step. 15:36:51 INFO - Running pre-action listener: _resource_record_pre_action 15:36:51 INFO - Running main action method: run_tests 15:36:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:36:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:36:51 INFO - Python 2.7.3 15:36:51 INFO - Return code: 0 15:36:51 INFO - grabbing minidump binary from tooltool 15:36: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')]} 15:36:51 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1499f60>, '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 0x149ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149b1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:36:51 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:36:51 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:36:51 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:36:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:36:51 INFO - Return code: 0 15:36:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:36:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:36:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:36:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:36:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:36:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vf8FnyBhTLKS9owecASzbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 15:36:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Vf8FnyBhTLKS9owecASzbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 15:36:51 INFO - Using env: {'DISPLAY': ':0', 15:36:51 INFO - 'HOME': '/home/cltbld', 15:36:51 INFO - 'LANG': 'en_US.UTF-8', 15:36:51 INFO - 'LANGUAGE': 'en_US:en', 15:36:51 INFO - 'LOGNAME': 'cltbld', 15:36:51 INFO - 'MAIL': '/var/mail/cltbld', 15:36:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:36:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:36:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:51 INFO - 'MOZ_NO_REMOTE': '1', 15:36:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:36:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:36:51 INFO - 'NO_EM_RESTART': '1', 15:36:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:36:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:36:51 INFO - 'PWD': '/builds/slave/test', 15:36:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:36:51 INFO - 'SHELL': '/bin/bash', 15:36:51 INFO - 'SHLVL': '1', 15:36:51 INFO - 'TERM': 'linux', 15:36:51 INFO - 'TMOUT': '86400', 15:36:51 INFO - 'USER': 'cltbld', 15:36:51 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1482188026.708001-1231760579', 15:36:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:51 INFO - '_': '/tools/buildbot/bin/python'} 15:36:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vf8FnyBhTLKS9owecASzbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 15:36:52 INFO - mozversion application_buildid: 20161219135323 15:36:52 INFO - mozversion application_changeset: e4865528325e8f9cc0a690ef9bcd3d6f79ca0866 15:36:52 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:36:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:36:52 INFO - mozversion application_name: Firefox 15:36:52 INFO - mozversion application_remotingname: firefox-dev 15:36:52 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:36:52 INFO - mozversion application_vendor: Mozilla 15:36:52 INFO - mozversion application_version: 52.0a2 15:36:52 INFO - mozversion platform_buildid: 20161219135323 15:36:52 INFO - mozversion platform_changeset: e4865528325e8f9cc0a690ef9bcd3d6f79ca0866 15:36:52 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:36:52 INFO - mozversion platform_version: 52.0a2 15:36:52 INFO - using testdate: 1482190612 15:36:52 INFO - actual date: 1482190612 15:36:52 INFO - starting webserver on 'localhost:60080' 15:36:52 INFO - SUITE-START | Running 2 tests 15:36:52 INFO - TEST-START | dromaeo_css 15:36:52 INFO - operating with platform_type : linux_ 15:36:52 INFO - Initialising browser for dromaeo_css test... 15:36:52 INFO - TEST-INFO | started process 30433 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBucFqj/profile http://localhost:60080/getInfo.html) 15:36:56 INFO - PROCESS | 30433 | __metrics Screen width/height:1600/1200 15:36:56 INFO - PROCESS | 30433 | colorDepth:24 15:36:56 INFO - PROCESS | 30433 | Browser inner width/height: 1024/697 15:36:56 INFO - PROCESS | 30433 | __metrics 15:36:56 INFO - PROCESS | 30433 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:36:56 INFO - PROCESS | 30433 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:36:57 INFO - PROCESS | 30433 | console.error: PushService: 15:36:57 INFO - PROCESS | 30433 | stateChangeProcessEnqueue: Error transitioning state 15:36:57 INFO - PROCESS | 30433 | UnknownError 15:36:57 INFO - TEST-INFO | 30433: exit 0 15:36:57 INFO - Browser initialized. 15:36:57 INFO - Running cycle 1/1 for dromaeo_css test... 15:36:57 INFO - TEST-INFO | started process 30528 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBucFqj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:37:09 INFO - PROCESS | 30528 | RSS: Main: 144371712 15:37:09 INFO - PROCESS | 30528 | 15:38:01 INFO - PROCESS | 30528 | 1482190681002 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] 15:40:11 INFO - PROCESS | 30528 | Cycle 1(1): loaded http://localhost:60080/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60080/tests/dromaeo/cssquery-ext.html) 15:40:12 INFO - PROCESS | 30528 | RSS: Main: 247226368 15:40:12 INFO - PROCESS | 30528 | 15:43:14 INFO - PROCESS | 30528 | Cycle 1(1): loaded http://localhost:60080/tests/dromaeo/cssquery-ext.html (next: http://localhost:60080/tests/dromaeo/cssquery-jquery.html) 15:43:15 INFO - PROCESS | 30528 | RSS: Main: 229933056 15:43:15 INFO - PROCESS | 30528 | 15:46:17 INFO - PROCESS | 30528 | Cycle 1(1): loaded http://localhost:60080/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60080/tests/dromaeo/cssquery-mootools.html) 15:46:17 INFO - PROCESS | 30528 | RSS: Main: 178221056 15:46:17 INFO - PROCESS | 30528 | 15:49:19 INFO - PROCESS | 30528 | Cycle 1(1): loaded http://localhost:60080/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60080/tests/dromaeo/cssquery-prototype.html) 15:49:20 INFO - PROCESS | 30528 | RSS: Main: 221958144 15:49:20 INFO - PROCESS | 30528 | 15:52:23 INFO - PROCESS | 30528 | Cycle 1(1): loaded http://localhost:60080/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60080/tests/dromaeo/cssquery-yui.html) 15:52:23 INFO - PROCESS | 30528 | RSS: Main: 176553984 15:52:23 INFO - PROCESS | 30528 | 15:55:26 INFO - PROCESS | 30528 | Cycle 1(1): loaded http://localhost:60080/tests/dromaeo/cssquery-yui.html (next: http://localhost:60080/tests/dromaeo/cssquery-dojo.html) 15:55:26 INFO - PROCESS | 30528 | RSS: Main: 261259264 15:55:26 INFO - PROCESS | 30528 | 15:55:26 INFO - PROCESS | 30528 | __start_tp_report 15:55:26 INFO - PROCESS | 30528 | _x_x_mozilla_page_load 15:55:26 INFO - PROCESS | 30528 | _x_x_mozilla_page_load_details 15:55:26 INFO - PROCESS | 30528 | |i|pagename|runs| 15:55:26 INFO - PROCESS | 30528 | |0;dojo.html;3225.5161725741145;3239.125436132246;3247.5453436518883;3252.12192707969;3286.638469768325;5520.834374968752;5565.276514053177;5589.189567512708;5606.187102870086;5613.859653508664;5592.832215033545;5631.568708629917;5639.323281206261;5648.802291919784;5678.801241956532;5053.494650534944;5074.594032477411;5097.872553186163;5141.794328226866;5162.406323272815;4920.581750551208;4948.1093403187415;5098.107831129556;5146.742662866842;5147.202183661539;5033.697978121306;5042.647014708972;5059.266406371074;5064.442911279756;5081.339425874631;5085.313482679828;5105.43840177582;5182.714950677711;5183.792648294101;5218.086834803894;4796.5203479651755;5105.770240339194;5122.308488354061;5128.333316668846;5159.14874045782;5377.247185394048;5416.241726158301;5439.428859969686;5489.039418101856;5490.011797876381;5916.911246331266;5919.260092488439;5948.048312270016;6030.4572588467245;6032.547558933054;6009.789657362015;6046.062860256668;6049.3950604939155;6049.48579370754;6064.272287325505;5466.8359949201185;5511;5514.3658479275;5559.388467268597;5569.275994120739;6068.423499767515;6089.451949324493;6093.360197179232;6095.299040610386;6107.541934354941;5860.472557469848;5862.091375836752;5866.882662346729;5868.149118377897;5872.471477567039;5750.453706897838;5796;5881.647101173943;5918.378570250062;5921.378255283219;5911.379305172981;5934.9406505934385;5935.614185077956;5936.376680448577;5973.761049557969;5965.850853728692;6013.849653758691;6014.849628759229;6027.276726792813;6029.758809647565;4500.639948804088;4536.3422303765765;4572.817087316536;4581.450225972838;4666.533346665374;4105.3020986432375;4130.297849365615;4137.606927341898;4150.501939767187;4162.8334866605;5665.461781130786;5675.971620141873;5677.886442271214;5680.5455563554815;5684.516816070598;5807.680577568274;5861.208736820475;5875.941240587625;5982.102684597346;5986.820395388146;5585.050541407971;5609.5792815539;5649.971750141223;5668;5683.460071293221;4892.951070489321;4922.360093187935;4931.112399768004;4931.18635425158;4952.158133117378;5965;6092.695365231632;6188.350223226586;6198.6280823150755;6201.286852011986;5838.4453476919625;5867;5882.235309409921;5962.55280853929;5993.760249589967;6177.042558403455;6181.196444462191;6182.443580077815;6183.0107182850525;6186.19579454668;5611.8877622448135;5647.774089036392;5853.619514731528;5854;5855.970720146372;5961.940380596138;5973.641581505123;5989.041753319448;6064.6058006231215;6109.144719739151;5910.70446477683;5920.407959204045;5923.644581325134;5924.822255332347;5938.317093534299;5669.54643628517;5865.765369385177;5869.8239052828485;5933.584649074523;5935.2877654681715;5676.063449530946;5765.077587585966;5804.448577385142;5817.854553636193;5901.645901245939;5941.732622032106;5952.732127054206;5957.672328022;5959.4934430573885;5960.642361458326;5526;5563.471470210324;5791.044477661308;5799.536037116936;5801.332846722681 15:55:26 INFO - PROCESS | 30528 | |1;ext.html;572.7766171193235;616.9876602467949;648.1800522339241;654.8821212181808;659.4930583616438;35596.82201588992;37816;37964.620353796454;37979.62020379799;37990.05024874379;37713.811430942806;47699.04601907969;49385.75307123459;49582.75208623952;52655.21017184745;8934.01725810162;9056.184943355096;9066.320025998044;9066.592003359832;9074.137956894085;8955.552222388887;9078.455292682427;9082.409643373192;9084.863727044067;9089.091090890892;8405.41162118652;8588.527630980325;10709.839352409681;10945.781084378308;10949.781004379907;10826.296290741117;10850.077743391743;10893.346399216072;10911.127109831194;10912.290701104443;10745.14038876888;10812.459377031195;10827.945860270727;10838.295510791773;10855;45847;46186.538134618895;46197.53802461999;46214.30678539824;46257.30614040792;3490.685838274542;3587.4798154267746;3772.396416573335;3893.3965235388278;4110.034141976633;33208.501872471694;33497.6650233497;33535.16162095967;33536.6646333536;33722.6627733722;4484.484284307314;4521.208788462039;4556.544345565417;4574.771261436915;4721.929171062437;375062;376479;376913;377206;377877;39556.208875822325;67272.32727672759;67763.66118169476;67842.3215767836;67859.66070169717;40217.59782402197;42099.368509472384;42406.151876962904;42440;42452.363214551806;14594.63513412152;14752.55742327732;14756.262186890612;14763.40946362155;14764.335604897806;11727.296362218294;11842;11843.644690659294;11844.585439509576;11847.111466640037;8947.19475247231;9127.497987610745;9625.759356016015;9642.711534063179;9701.854472182922;3526.594441639193;3576.588692300367;3581.194231297937;3656.835442405098;3701.5188025556504;1059.941703206331;1112.6828853776635;1121.876593574706;1123.326004397355;1131.1290306463977;34571.308573828384;34822.30355392878;35000.82499587486;35073.82463087719;35524;986.4081551069445;1082.4749996251812;1132.6885106595587;1136.471540733563;1163.784699830534;16911;18556.257749690132;18579.90710046441;19184.34319649806;19401.90299048524;548151;552242;552976;553009;554407;64653.35346646473;65399.673001634685;65442.67278663576;65466.34533654602;65491.67254163794;1382.377929931535;1411.089847048648;1422.3528294625921;1428.9356978935973;1442.8629280218363;32398.83800580982;34406.65864460437;34649.82675086709;34710.479342809376;34919.47620785741;58089.4191058084;58771;58844.41155588561;58869.70565147147;58903.705481472316;481085;481980;484666;485202;486951;31968.520472193402;32058.519122212718;32118;32382.19044523906;32480;43492.56507435012;45777;52105.47894521006;52270.73864630653;52278;42316;43091.353629696205;44047;44727.552724473644;45090.0981980352;43424.34863477114;45028;45344.09311813811;45566.77216613896;45808;44144.779276103414;45240.54759452363;45468.31797523106;45570.772146139054;45920.08159836718;37275.62724372721;38678.41982370323;39778;40224.798876005436;40584.18831623292;29468.55797163087;29539.75972823335;30010.84994575013;30210.84894575513;30281.848590756905 15:55:26 INFO - PROCESS | 30528 | |2;jquery.html;427.333359958465;432.61049675790184;434.09058023440895;437.9693421460498;442.56407438672903;19025.52436189096;19680.311189108383;20246.797532024677;20414.591708165848;20475.897620511914;16473.67052658946;18270.17784199711;18750.156242969064;19936.40190794275;20117.491188160875;5616.775328986846;5743.483086522212;5790.044642633981;5791.478766910977;5796.536277097843;5646.153077038436;5714.77140914365;5754.798582049629;5768.538516918637;5794.478496935275;5684.801031963882;5732.283464566929;5735.799247026355;5736.684482353469;5737.540996720252;5622.718864056801;5648.6893220872835;5670.518005969498;5727.856803579903;5738.426157384249;5175.0167468180925;5182.896342073175;5186.1442861927735;5186.533212010937;5188.143956247215;22986.195483158175;23834.880825595934;23853;24139.275821725376;24346.02615895362;2488.5271798358253;2531.556977528925;2597.9870100649377;2615.882285297147;2861.0415510803905;15012.699746005019;15236.314365853563;15273;15630.609234769108;15978.920105399515;1943.9028048597654;2033.6542787725973;2052.2509284111343;2063.66981282994;2065.308121779206;85364.57317713372;88197.55901220453;89027;89341.55329223377;90081.54959225161;11143.052840508486;11173.553057877756;11205.551777928791;11539.71150721222;11615.477303521362;14581.781273280909;14592.416303347747;14597.12417254947;14598.781018284733;14631.487897923522;8047.436679432501;8101.432899696964;8141.104478507359;8288.668453261922;8309.792255193548;7537.54774713519;7552.320291173821;7710.691572337156;7801.063872335242;7871.842563148705;6849.486288528281;6919.688614012382;7064;7094.858102837914;7128.358447739728;1966.4002479243968;2053.435305291057;2059.6292667320026;2106.104905415192;2154.396768904709;1029.4080903480528;1063.9787204255872;1075.8278675411896;1079.266099052636;1121.2263538158645;19533.511662208275;21145.471363216042;21374.465638359165;21395.67906481404;21493.89253053756;1053.8788039375418;1074.1621535202555;1087.9292845964987;1094.8850370710961;1156.6876943225282;11271.830922536168;11968.341741204144;12088.879111208775;12200.206986545845;12329.198602090835;390857;393640;394954;532989;538136;100629;103068;103809;105250.47374763078;107385.46307268414;1035.140833108518;1036.3937096798456;1081.291753901196;1083.5070043130356;1092.7705181911888;17681;17792.199351028976;18293.90853045726;18336.449906502825;18688.439346819618;30767.38465230638;40649.59350406458;40694;42903.785481072395;43228.56771432371;61431.6928415373;61907.38092619197;62206;62666;63870.68064659647;8828.690995815115;8978.326625502983;9025.458472491671;9055.18503334703;9250.074992500697;12857.485700571873;13182.868171318163;13587.59237222885;14070.296485175904;14474.710505790035;12305.323207223331;12624.621261362174;12672.176308539916;12787.424565894744;12877.742445151232;12313.938430307791;12450.439730212343;12505.124641275024;12734.808977865154;12743.80884286755;12242.877571224173;12548.121631486074;12551.87448125507;12676.429560669976;12696.047796415121;8870.15733505316;9275.86086208721;9338.906610934075;9340.53297335144;9409.529523523934;11354.318740875575;12423.565175218824;12639.494420223456;12658.11393202467;12964.22214667123 15:55:26 INFO - PROCESS | 30528 | |3;mootools.html;1332.540273605607;1512.2212060788695;1530.9638181218977;1697.7538256952741;1824.5256233379318;7675.424343174263;8700.260477859381;8820.514871682055;8845.823083538342;9059.773505662362;8779.253763430115;8868.068852770462;8880.822383552326;8885.733427997155;8978.102189781019;2479.913203037894;2500.4499010217723;2505.285993491855;2509.5231905937903;2514.094925826701;2406.7713567211085;2482.888270027853;2486.5151295497294;2486.6021436570154;2489.103922587867;2454.7299797022315;2465.6055031195015;2486.266551367342;2486.428121532049;2490.5392502387026;2368.5499755046485;2387.8328517003815;2427.8421902576365;2452.497238066192;2458.532878753031;2379.9286021419384;2402.3393566769278;2408.3497455686866;2436.0377650827822;2437.9756202437925;8825.602847871862;8918.331125165638;9022.097790220925;9040.728778136667;9130;5297.152455607084;5564.721763911829;5566.387697353329;5566.415526369713;5575.553955683536;3535.275268569937;3677.6506231908193;3728.7203459740626;3752.137008488036;3758.924821503582;1084.9566017359375;1098.34099540276;1128.751674631588;1138.618562781469;1143.1197977557317;12111.697207569792;12129.696757581043;12208.694782630506;12233.143679942408;12241.387930603434;4290.935635965463;4629.837955671603;4673.205555055649;4757.35775670287;4775;9990.450525221037;10017.599296028224;10063.899361006297;10095.848562271573;10097.495125243708;5345.893082138413;5359.410464848864;5359.490848369399;5388.218708287276;5392.73036348181;4385.605295523418;4536.274196128604;4673.883152921204;5055.34280543527;5180.248863914711;4019.9598004019585;4080.8571699990953;4177.26897792885;4190.434291370687;4200.474940632421;1209.4678341529698;1240;1266.702324953635;1285.710715089116;1291.1026836348647;935.8689783430325;1015.5836107196014;1022.7903279827617;1027.291169093323;1032.4373216596973;5816.185733997244;5977.312609049928;6219.284782250009;6278.752641122112;6284.308726040132;470.454273043275;475.4926881784751;477.22212793146946;505.4768314794244;506.1395627433378;4084.0402505411203;4096.508418989741;4167.374893765898;4182.895427614273;4249.46881639795;10999.945000275107;11295.209335346612;11328.037116844996;11367.431628418712;11408.429578521042;11285.37930413835;11318.886811131782;11323.094152467782;11327.150463715254;11328.773424531464;8047.470980513801;8374.958125209336;8387.077421483631;8567.914320856837;8688.131186881388;5871.442212989759;5895.9115613266695;5996.970015150071;6044.969775151096;6113.083037544404;9871.111599956039;9964.601415943282;9966.700998969753;9988.300818942895;10080.04239597237;9313.674021409219;9376.859347109936;10038.224198665725;10238;10329.225308101772;7685.769426917202;8084.87872681922;8189.631466584137;8189.836203276021;8201.507909525448;8308.792280193044;8314.792130196793;8394.832103357776;8400.747977560683;8403.537805420761;7554.622268886644;7656.885146722915;7794.142644309235;7813.609319534115;7974.5215287082965;7634.312911837961;7745.92254077452;7758.107817601048;7846.0976987647155;8020.478668886503;7228.530145540523;7313.524620899624;7319.5242309249725;7341.77974660761;7342;5301.734913254399;5312.282841816305;5335.519803217729;5337.466253374631;5358.758855851574;5349.732513374238;5369.812056578001;5461.863453413696;5479.986202552541;5562.944370556243 15:55:26 INFO - PROCESS | 30528 | |4;prototype.html;356.58814069749434;356.7609701499995;360.58532687409473;370.35003568736863;371.6859253930428;5160.483951604838;5298.947010529893;5322.2282768998475;5352.2506849041165;5355.705436201012;5110.667806592569;5191.338771593092;5205.089109405848;5212.687238765677;5214.243934629477;4180.143070670505;4194.448054219935;4204.003098528206;4204.11713540157;4220.345846393814;4055.858044968427;4174.895627609304;4182.6235638792505;4185.644220241283;4197.916041679165;4094.7747873866924;4104.733192342503;4108.096218831867;4115.238680844053;4128.545859955402;4119.196756632457;4127.153933443637;4128.174365126986;4143.047099167178;4150.439690641755;3663.9267214655556;3718.51659284294;3760.943585846187;3770;3777.8299976501125;5083.847484575469;5131;5135.229715542661;5142.537171654531;5147.7683504242395;4810.302506136591;4813.350197723333;4816.879578010543;4817.7591120444185;4826.951730482685;5332.226827110087;5514.972425137888;5516.972415137939;5528.889422211533;5543.750531226065;4109;4114.938275925863;4131.731437456586;4143.19207754488;4143.937840932388;5710.857228569277;5742.454466825645;5747.252857128588;5750.482456578928;5757.4818266355815;4057.2696914555663;4221.261279276115;4258.063226090255;4260.190563792869;4280.764557949343;4284.464441944757;4300.569943005675;4313.396124542566;4326.372675961968;4332.631726303236;4792.784324705397;4822.180229361017;4830.637702172281;4839.879003024953;4846.248831431134;5276.261323414648;5492.022871766161;5558.583106267046;5566.4990150886615;5616.438356164433;1347.649611101101;1368.5210176438168;1425.4818618171614;1440.0999375390381;1443.6968236670416;1007.8387458006683;1030.8402197659375;1038.159091136182;1056.5456853553046;1058.962936297226;5078.162103252996;5080.771365288497;5094.949050509522;5098.923516147261;5125.641205115606;5410.72749445234;5414.269073675082;5414.6209765316835;5418.620696551282;5433.864153396117;5027.3464449621315;5092.312537807348;5149.48505149482;5157.974210128926;5375.9462405376225;2914.621099257083;2917.9574297991066;2919.7591023815216;2936.8678409471627;2943.2641839540115;5735.426457354231;5742.712864356766;5753.971230143822;5771.769129234867;5775.249217601685;5471.835844924659;5555.30558680165;5573.972130139324;5591.580631452657;5620.297462817148;5638.605297629127;5650.237217975603;5674.9355348112385;5675.290588676416;5676.120201368794;5377;5500.4224556420995;5520.254765606592;5520.503154716095;5542.972285138549;5397.676139431646;5412.512873841373;5428.371488553339;5441.727913604224;5460.918086228789;5676.77292908279;5686.601937864475;5699.116636921284;5712.7714891403875;5737.967165910176;3837.2901013312626;4008.699347549004;4034.515858097047;4037.333839916498;4052.5005747873474;5343.225232341367;5439.891202175855;5442.918356224581;5447.809326673548;5495.890082198413;5370.194470829407;5382.73086345689;5400.648957817729;5401.567874569946;5406.729663516887;5432.2123292123215;5451.236826844166;5454.400015998316;5506.862328441821;5507.173923911445;5300.840974770763;5451.945480545302;5460.5085542301385;5487.807926722546;5495.587830912617;5549.361823390362;5553.444655534414;5553.888922221452;5562.3034974331595;5567.4432556744005;5278.287431196893;5422.159565267232;5439.184122381516;5442.809501667422;5442.972785136049 15:55:26 INFO - PROCESS | 30528 | |5;yui.html;761.463168466231;777.7666699990006;842.768238734348;868.5092922498784;885.3006125161123;14297.07069040513;15409.229538523072;15580.987235829663;15585.142817145052;15618;14241;14355.210463424508;14371.856281437182;14380.424783008668;14473.638159046002;727.6725473536903;755.3843617451787;831.3432388413146;854.1757204297851;866.7963028688254;855.7988872614931;857.9356548258875;858.4463021351224;858.5707146426787;859.2824991132412;753.107567532473;899.1772528136747;899.5412339706764;901.4546199549244;902.7923577577161;774.3185996323256;868.4832524647825;902.9503377314245;905.6196397513061;910.7222297199352;658.0819756439739;658.3679667519187;659.5383231737754;660.2341284110457;660.2374257732326;14768.704625907529;14810.629734256621;14980.850191498164;15010.549683509513;15025.248737563079;14020;14595.270236488239;14790.482333118289;15226.695466090616;15445.382184712598;12494.875051249463;12979.67550811228;13118.081734278605;13224.933875330562;13417.865821341758;4426.535213802569;4438.889027774331;4475.172093162775;4534.841280555198;4591.724496530219;66752.46675246663;69737.65131174363;70041.64979175123;70695.29304706938;72031.63984180045;11557.653270401901;11626.302421854547;11769.882301176878;11847.111466639864;12047.759044819055;21625.35123946284;21653.458663533223;21654.242101526685;21656.350309490426;21705.67441488379;8423.705170319132;8475.957620211982;8696.086910874394;8723.214910658071;8963.372563920462;4796.640251981115;4798.448178459522;4838.491958344323;4964.503549645006;5002.049610573979;3607.494950706903;3743.5882052974694;3745.0450135215347;3745.9438108428394;3746.3256613809776;615.1848800339478;616.4020899727258;620.602814198913;631.6778442994014;648.5751832549688;671.1107782188523;703.3107554596422;727.2364017781414;733.0470388494936;756.9091708994956;9337.766555836159;9531.428114313163;9625.422474651543;9943.651972181084;9944.751381215383;623.6632218601995;666.2005593288073;711.5339452658517;758.6775620361435;760.8896709977022;4588.449386073693;4751.453582838018;4764.809407623657;4782.593479554207;4865.2045121330675;53942.46057539453;70318;95107.52446237863;95866.5206673976;98775;74397.26279093981;76512.61743691246;76853.23146768572;84283.57858210792;84680;44047;55714.72142639342;66653.33346666569;69870.30129698638;70453.2954670457;9361.251099911855;9441.669541566012;9514.715513405601;9701.175400091071;9745.756356090871;45645.315320270885;45958.310625339975;46134.76932615315;46909.53090469052;48017.27974080322;65259.67370163119;65875.6706216485;67054.32945670481;68030.61892833727;68827.65586172037;11979;12112.939435302767;12199.87800122023;12259.632211033684;12575.434105465092;10997.450127493434;13519.526816561372;14036.228007459687;14241.50154744579;14431.927840360731;11127.443627818739;11324.225430537314;11661.06711463098;13355.933220333836;14201.928990354982;11723.941380293043;11857.822132668189;11907.642770716893;12011.75976480483;12479.438425270702;12419.316937568521;12668.239905605693;12850.35748212567;12880.935595321964;13234.602961911158;10751.677449676523;11071;11071.94464027707;11314.886851131383;11499.13756468285;10973.114773683063;11242.718932026764;11342.489587968395;11407.429628518375;11413.258138220988 15:55:26 INFO - PROCESS | 30528 | __end_tp_report 15:55:26 INFO - PROCESS | 30528 | __start_cc_report 15:55:26 INFO - PROCESS | 30528 | _x_x_mozilla_cycle_collect,1057 15:55:26 INFO - PROCESS | 30528 | __end_cc_report 15:55:26 INFO - PROCESS | 30528 | __startTimestamp1482191726627__endTimestamp 15:55:26 INFO - PROCESS | 30528 | 15:55:26 INFO - PROCESS | 30528 | ------- Summary: start ------- 15:55:26 INFO - PROCESS | 30528 | Number of tests: 6 15:55:26 INFO - PROCESS | 30528 | 15:55:26 INFO - PROCESS | 30528 | [#0] dojo.html Cycles:165 Average:5536.92 Median:5765.08 stddev:626.31 (10.9%) stddev-sans-first:601.41 15:55:26 INFO - PROCESS | 30528 | Values: 3225.5 3239.1 3247.5 3252.1 3286.6 5520.8 5565.3 5589.2 5606.2 5613.9 5592.8 5631.6 5639.3 5648.8 5678.8 5053.5 5074.6 5097.9 5141.8 5162.4 4920.6 4948.1 5098.1 5146.7 5147.2 5033.7 5042.6 5059.3 5064.4 5081.3 5085.3 5105.4 5182.7 5183.8 5218.1 4796.5 5105.8 5122.3 5128.3 5159.1 5377.2 5416.2 5439.4 5489.0 5490.0 5916.9 5919.3 5948.0 6030.5 6032.5 6009.8 6046.1 6049.4 6049.5 6064.3 5466.8 5511.0 5514.4 5559.4 5569.3 6068.4 6089.5 6093.4 6095.3 6107.5 5860.5 5862.1 5866.9 5868.1 5872.5 5750.5 5796.0 5881.6 5918.4 5921.4 5911.4 5934.9 5935.6 5936.4 5973.8 5965.9 6013.8 6014.8 6027.3 6029.8 4500.6 4536.3 4572.8 4581.5 4666.5 4105.3 4130.3 4137.6 4150.5 4162.8 5665.5 5676.0 5677.9 5680.5 5684.5 5807.7 5861.2 5875.9 5982.1 5986.8 5585.1 5609.6 5650.0 5668.0 5683.5 4893.0 4922.4 4931.1 4931.2 4952.2 5965.0 6092.7 6188.4 6198.6 6201.3 5838.4 5867.0 5882.2 5962.6 5993.8 6177.0 6181.2 6182.4 6183.0 6186.2 5611.9 5647.8 5853.6 5854.0 5856.0 5961.9 5973.6 5989.0 6064.6 6109.1 5910.7 5920.4 5923.6 5924.8 5938.3 5669.5 5865.8 5869.8 5933.6 5935.3 5676.1 5765.1 5804.4 5817.9 5901.6 5941.7 5952.7 5957.7 5959.5 5960.6 5526.0 5563.5 5791.0 5799.5 5801.3 15:55:26 INFO - PROCESS | 30528 | 15:55:26 INFO - PROCESS | 30528 | [#1] ext.html Cycles:180 Average:63325.02 Median:39997.80 stddev:126479.31 (316.2%) stddev-sans-first:126746.36 15:55:26 INFO - PROCESS | 30528 | Values: 572.8 617.0 648.2 654.9 659.5 35596.8 37816.0 37964.6 37979.6 37990.1 37713.8 47699.0 49385.8 49582.8 52655.2 8934.0 9056.2 9066.3 9066.6 9074.1 8955.6 9078.5 9082.4 9084.9 9089.1 8405.4 8588.5 10709.8 10945.8 10949.8 10826.3 10850.1 10893.3 10911.1 10912.3 10745.1 10812.5 10827.9 10838.3 10855.0 45847.0 46186.5 46197.5 46214.3 46257.3 3490.7 3587.5 3772.4 3893.4 4110.0 33208.5 33497.7 33535.2 33536.7 33722.7 4484.5 4521.2 4556.5 4574.8 4721.9 375062.0 376479.0 376913.0 377206.0 377877.0 39556.2 67272.3 67763.7 67842.3 67859.7 40217.6 42099.4 42406.2 42440.0 42452.4 14594.6 14752.6 14756.3 14763.4 14764.3 11727.3 11842.0 11843.6 11844.6 11847.1 8947.2 9127.5 9625.8 9642.7 9701.9 3526.6 3576.6 3581.2 3656.8 3701.5 1059.9 1112.7 1121.9 1123.3 1131.1 34571.3 34822.3 35000.8 35073.8 35524.0 986.4 1082.5 1132.7 1136.5 1163.8 16911.0 18556.3 18579.9 19184.3 19401.9 548151.0 552242.0 552976.0 553009.0 554407.0 64653.4 65399.7 65442.7 65466.3 65491.7 1382.4 1411.1 1422.4 1428.9 1442.9 32398.8 34406.7 34649.8 34710.5 34919.5 58089.4 58771.0 58844.4 58869.7 58903.7 481085.0 481980.0 484666.0 485202.0 486951.0 31968.5 32058.5 32118.0 32382.2 32480.0 43492.6 45777.0 52105.5 52270.7 52278.0 42316.0 43091.4 44047.0 44727.6 45090.1 43424.3 45028.0 45344.1 45566.8 45808.0 44144.8 45240.5 45468.3 45570.8 45920.1 37275.6 38678.4 39778.0 40224.8 40584.2 29468.6 29539.8 30010.8 30210.8 30281.8 15:55:26 INFO - PROCESS | 30528 | 15:55:26 INFO - PROCESS | 30528 | [#2] jquery.html Cycles:180 Average:28972.50 Median:21259.97 stddev:75771.43 (356.4%) stddev-sans-first:75953.68 15:55:26 INFO - PROCESS | 30528 | Values: 427.3 432.6 434.1 438.0 442.6 19025.5 19680.3 20246.8 20414.6 20475.9 16473.7 18270.2 18750.2 19936.4 20117.5 5616.8 5743.5 5790.0 5791.5 5796.5 5646.2 5714.8 5754.8 5768.5 5794.5 5684.8 5732.3 5735.8 5736.7 5737.5 5622.7 5648.7 5670.5 5727.9 5738.4 5175.0 5182.9 5186.1 5186.5 5188.1 22986.2 23834.9 23853.0 24139.3 24346.0 2488.5 2531.6 2598.0 2615.9 2861.0 15012.7 15236.3 15273.0 15630.6 15978.9 1943.9 2033.7 2052.3 2063.7 2065.3 85364.6 88197.6 89027.0 89341.6 90081.5 11143.1 11173.6 11205.6 11539.7 11615.5 14581.8 14592.4 14597.1 14598.8 14631.5 8047.4 8101.4 8141.1 8288.7 8309.8 7537.5 7552.3 7710.7 7801.1 7871.8 6849.5 6919.7 7064.0 7094.9 7128.4 1966.4 2053.4 2059.6 2106.1 2154.4 1029.4 1064.0 1075.8 1079.3 1121.2 19533.5 21145.5 21374.5 21395.7 21493.9 1053.9 1074.2 1087.9 1094.9 1156.7 11271.8 11968.3 12088.9 12200.2 12329.2 390857.0 393640.0 394954.0 532989.0 538136.0 100629.0 103068.0 103809.0 105250.5 107385.5 1035.1 1036.4 1081.3 1083.5 1092.8 17681.0 17792.2 18293.9 18336.4 18688.4 30767.4 40649.6 40694.0 42903.8 43228.6 61431.7 61907.4 62206.0 62666.0 63870.7 8828.7 8978.3 9025.5 9055.2 9250.1 12857.5 13182.9 13587.6 14070.3 14474.7 12305.3 12624.6 12672.2 12787.4 12877.7 12313.9 12450.4 12505.1 12734.8 12743.8 12242.9 12548.1 12551.9 12676.4 12696.0 8870.2 9275.9 9338.9 9340.5 9409.5 11354.3 12423.6 12639.5 12658.1 12964.2 15:55:26 INFO - PROCESS | 30528 | 15:55:26 INFO - PROCESS | 30528 | [#3] mootools.html Cycles:180 Average:5881.42 Median:2617.29 stddev:3303.40 (126.2%) stddev-sans-first:3294.98 15:55:26 INFO - PROCESS | 30528 | Values: 1332.5 1512.2 1531.0 1697.8 1824.5 7675.4 8700.3 8820.5 8845.8 9059.8 8779.3 8868.1 8880.8 8885.7 8978.1 2479.9 2500.4 2505.3 2509.5 2514.1 2406.8 2482.9 2486.5 2486.6 2489.1 2454.7 2465.6 2486.3 2486.4 2490.5 2368.5 2387.8 2427.8 2452.5 2458.5 2379.9 2402.3 2408.3 2436.0 2438.0 8825.6 8918.3 9022.1 9040.7 9130.0 5297.2 5564.7 5566.4 5566.4 5575.6 3535.3 3677.7 3728.7 3752.1 3758.9 1085.0 1098.3 1128.8 1138.6 1143.1 12111.7 12129.7 12208.7 12233.1 12241.4 4290.9 4629.8 4673.2 4757.4 4775.0 9990.5 10017.6 10063.9 10095.8 10097.5 5345.9 5359.4 5359.5 5388.2 5392.7 4385.6 4536.3 4673.9 5055.3 5180.2 4020.0 4080.9 4177.3 4190.4 4200.5 1209.5 1240.0 1266.7 1285.7 1291.1 935.9 1015.6 1022.8 1027.3 1032.4 5816.2 5977.3 6219.3 6278.8 6284.3 470.5 475.5 477.2 505.5 506.1 4084.0 4096.5 4167.4 4182.9 4249.5 10999.9 11295.2 11328.0 11367.4 11408.4 11285.4 11318.9 11323.1 11327.2 11328.8 8047.5 8375.0 8387.1 8567.9 8688.1 5871.4 5895.9 5997.0 6045.0 6113.1 9871.1 9964.6 9966.7 9988.3 10080.0 9313.7 9376.9 10038.2 10238.0 10329.2 7685.8 8084.9 8189.6 8189.8 8201.5 8308.8 8314.8 8394.8 8400.7 8403.5 7554.6 7656.9 7794.1 7813.6 7974.5 7634.3 7745.9 7758.1 7846.1 8020.5 7228.5 7313.5 7319.5 7341.8 7342.0 5301.7 5312.3 5335.5 5337.5 5358.8 5349.7 5369.8 5461.9 5480.0 5562.9 15:55:26 INFO - PROCESS | 30528 | 15:55:26 INFO - PROCESS | 30528 | [#4] prototype.html Cycles:180 Average:4630.28 Median:5175.91 stddev:1314.41 (25.4%) stddev-sans-first:1278.36 15:55:26 INFO - PROCESS | 30528 | Values: 356.6 356.8 360.6 370.4 371.7 5160.5 5298.9 5322.2 5352.3 5355.7 5110.7 5191.3 5205.1 5212.7 5214.2 4180.1 4194.4 4204.0 4204.1 4220.3 4055.9 4174.9 4182.6 4185.6 4197.9 4094.8 4104.7 4108.1 4115.2 4128.5 4119.2 4127.2 4128.2 4143.0 4150.4 3663.9 3718.5 3760.9 3770.0 3777.8 5083.8 5131.0 5135.2 5142.5 5147.8 4810.3 4813.4 4816.9 4817.8 4827.0 5332.2 5515.0 5517.0 5528.9 5543.8 4109.0 4114.9 4131.7 4143.2 4143.9 5710.9 5742.5 5747.3 5750.5 5757.5 4057.3 4221.3 4258.1 4260.2 4280.8 4284.5 4300.6 4313.4 4326.4 4332.6 4792.8 4822.2 4830.6 4839.9 4846.2 5276.3 5492.0 5558.6 5566.5 5616.4 1347.6 1368.5 1425.5 1440.1 1443.7 1007.8 1030.8 1038.2 1056.5 1059.0 5078.2 5080.8 5094.9 5098.9 5125.6 5410.7 5414.3 5414.6 5418.6 5433.9 5027.3 5092.3 5149.5 5158.0 5375.9 2914.6 2918.0 2919.8 2936.9 2943.3 5735.4 5742.7 5754.0 5771.8 5775.2 5471.8 5555.3 5574.0 5591.6 5620.3 5638.6 5650.2 5674.9 5675.3 5676.1 5377.0 5500.4 5520.3 5520.5 5543.0 5397.7 5412.5 5428.4 5441.7 5460.9 5676.8 5686.6 5699.1 5712.8 5738.0 3837.3 4008.7 4034.5 4037.3 4052.5 5343.2 5439.9 5442.9 5447.8 5495.9 5370.2 5382.7 5400.6 5401.6 5406.7 5432.2 5451.2 5454.4 5506.9 5507.2 5300.8 5451.9 5460.5 5487.8 5495.6 5549.4 5553.4 5553.9 5562.3 5567.4 5278.3 5422.2 5439.2 5442.8 5443.0 15:55:26 INFO - PROCESS | 30528 | 15:55:26 INFO - PROCESS | 30528 | [#5] yui.html Cycles:180 Average:18073.98 Median:26407.86 stddev:23743.22 (89.9%) stddev-sans-first:23774.24 15:55:26 INFO - PROCESS | 30528 | Values: 761.5 777.8 842.8 868.5 885.3 14297.1 15409.2 15581.0 15585.1 15618.0 14241.0 14355.2 14371.9 14380.4 14473.6 727.7 755.4 831.3 854.2 866.8 855.8 857.9 858.4 858.6 859.3 753.1 899.2 899.5 901.5 902.8 774.3 868.5 903.0 905.6 910.7 658.1 658.4 659.5 660.2 660.2 14768.7 14810.6 14980.9 15010.5 15025.2 14020.0 14595.3 14790.5 15226.7 15445.4 12494.9 12979.7 13118.1 13224.9 13417.9 4426.5 4438.9 4475.2 4534.8 4591.7 66752.5 69737.7 70041.6 70695.3 72031.6 11557.7 11626.3 11769.9 11847.1 12047.8 21625.4 21653.5 21654.2 21656.4 21705.7 8423.7 8476.0 8696.1 8723.2 8963.4 4796.6 4798.4 4838.5 4964.5 5002.0 3607.5 3743.6 3745.0 3745.9 3746.3 615.2 616.4 620.6 631.7 648.6 671.1 703.3 727.2 733.0 756.9 9337.8 9531.4 9625.4 9943.7 9944.8 623.7 666.2 711.5 758.7 760.9 4588.4 4751.5 4764.8 4782.6 4865.2 53942.5 70318.0 95107.5 95866.5 98775.0 74397.3 76512.6 76853.2 84283.6 84680.0 44047.0 55714.7 66653.3 69870.3 70453.3 9361.3 9441.7 9514.7 9701.2 9745.8 45645.3 45958.3 46134.8 46909.5 48017.3 65259.7 65875.7 67054.3 68030.6 68827.7 11979.0 12112.9 12199.9 12259.6 12575.4 10997.5 13519.5 14036.2 14241.5 14431.9 11127.4 11324.2 11661.1 13355.9 14201.9 11723.9 11857.8 11907.6 12011.8 12479.4 12419.3 12668.2 12850.4 12880.9 13234.6 10751.7 11071.0 11071.9 11314.9 11499.1 10973.1 11242.7 11342.5 11407.4 11413.3 15:55:26 INFO - PROCESS | 30528 | -------- Summary: end -------- 15:55:26 INFO - PROCESS | 30528 | 15:55:27 INFO - TEST-INFO | 30528: exit 0 15:55:27 INFO - TEST-OK | dromaeo_css | took 1115351ms 15:55:27 INFO - TEST-START | kraken 15:55:27 INFO - operating with platform_type : linux_ 15:55:27 INFO - Initialising browser for kraken test... 15:55:27 INFO - TEST-INFO | started process 30843 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPsAFer/profile http://localhost:60080/getInfo.html) 15:55:31 INFO - PROCESS | 30843 | __metrics Screen width/height:1600/1200 15:55:31 INFO - PROCESS | 30843 | colorDepth:24 15:55:31 INFO - PROCESS | 30843 | Browser inner width/height: 1024/697 15:55:31 INFO - PROCESS | 30843 | __metrics 15:55:31 INFO - PROCESS | 30843 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:55:31 INFO - PROCESS | 30843 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:55:32 INFO - PROCESS | 30843 | console.error: PushService: 15:55:32 INFO - PROCESS | 30843 | stateChangeProcessEnqueue: Error transitioning state 15:55:32 INFO - PROCESS | 30843 | UnknownError 15:55:33 INFO - TEST-INFO | 30843: exit 0 15:55:33 INFO - Browser initialized. 15:55:33 INFO - Running cycle 1/1 for kraken test... 15:55:33 INFO - TEST-INFO | started process 30942 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPsAFer/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:55:44 INFO - PROCESS | 30942 | RSS: Main: 144781312 15:55:44 INFO - PROCESS | 30942 | 15:55:47 INFO - PROCESS | 30942 | Cycle 1(1): loaded http://localhost:60080/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60080/tests/kraken/driver.html?testName=audio-beat-detection) 15:55:48 INFO - PROCESS | 30942 | RSS: Main: 186478592 15:55:48 INFO - PROCESS | 30942 | 15:55:50 INFO - PROCESS | 30942 | Cycle 1(1): loaded http://localhost:60080/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60080/tests/kraken/driver.html?testName=audio-dft) 15:55:51 INFO - PROCESS | 30942 | RSS: Main: 175026176 15:55:51 INFO - PROCESS | 30942 | 15:55:54 INFO - PROCESS | 30942 | Cycle 1(1): loaded http://localhost:60080/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60080/tests/kraken/driver.html?testName=audio-fft) 15:55:54 INFO - PROCESS | 30942 | RSS: Main: 266432512 15:55:54 INFO - PROCESS | 30942 | 15:55:56 INFO - PROCESS | 30942 | Cycle 1(1): loaded http://localhost:60080/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60080/tests/kraken/driver.html?testName=audio-oscillator) 15:55:57 INFO - PROCESS | 30942 | RSS: Main: 172908544 15:55:57 INFO - PROCESS | 30942 | 15:55:59 INFO - PROCESS | 30942 | Cycle 1(1): loaded http://localhost:60080/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60080/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:56:00 INFO - PROCESS | 30942 | RSS: Main: 174673920 15:56:00 INFO - PROCESS | 30942 | 15:56:03 INFO - PROCESS | 30942 | Cycle 1(1): loaded http://localhost:60080/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60080/tests/kraken/driver.html?testName=imaging-darkroom) 15:56:03 INFO - PROCESS | 30942 | RSS: Main: 213889024 15:56:03 INFO - PROCESS | 30942 | 15:56:06 INFO - PROCESS | 30942 | Cycle 1(1): loaded http://localhost:60080/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60080/tests/kraken/driver.html?testName=imaging-desaturate) 15:56:07 INFO - PROCESS | 30942 | RSS: Main: 212606976 15:56:07 INFO - PROCESS | 30942 | 15:56:10 INFO - PROCESS | 30942 | Cycle 1(1): loaded http://localhost:60080/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60080/tests/kraken/driver.html?testName=json-parse-financial) 15:56:10 INFO - PROCESS | 30942 | RSS: Main: 211476480 15:56:10 INFO - PROCESS | 30942 | 15:56:12 INFO - PROCESS | 30942 | Cycle 1(1): loaded http://localhost:60080/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60080/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:56:12 INFO - PROCESS | 30942 | RSS: Main: 173588480 15:56:12 INFO - PROCESS | 30942 | 15:56:14 INFO - PROCESS | 30942 | Cycle 1(1): loaded http://localhost:60080/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60080/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:56:15 INFO - PROCESS | 30942 | RSS: Main: 180871168 15:56:15 INFO - PROCESS | 30942 | 15:56:17 INFO - PROCESS | 30942 | Cycle 1(1): loaded http://localhost:60080/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60080/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:56:17 INFO - PROCESS | 30942 | RSS: Main: 189497344 15:56:17 INFO - PROCESS | 30942 | 15:56:20 INFO - PROCESS | 30942 | Cycle 1(1): loaded http://localhost:60080/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60080/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:56:20 INFO - PROCESS | 30942 | RSS: Main: 197939200 15:56:20 INFO - PROCESS | 30942 | 15:56:23 INFO - PROCESS | 30942 | Cycle 1(1): loaded http://localhost:60080/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60080/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:56:24 INFO - PROCESS | 30942 | RSS: Main: 195035136 15:56:24 INFO - PROCESS | 30942 | 15:56:25 INFO - PROCESS | 30942 | Cycle 1(1): loaded http://localhost:60080/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60080/tests/kraken/driver.html?testName=ai-astar) 15:56:26 INFO - PROCESS | 30942 | RSS: Main: 246157312 15:56:26 INFO - PROCESS | 30942 | 15:56:26 INFO - PROCESS | 30942 | __start_tp_report 15:56:26 INFO - PROCESS | 30942 | _x_x_mozilla_page_load 15:56:26 INFO - PROCESS | 30942 | _x_x_mozilla_page_load_details 15:56:26 INFO - PROCESS | 30942 | |i|pagename|runs| 15:56:26 INFO - PROCESS | 30942 | |0;ai-astar;101;110;110;109;112;110;110;110;110;109 15:56:26 INFO - PROCESS | 30942 | |1;audio-beat-detection;147;118;116;155;118;118;119;116;152;121 15:56:26 INFO - PROCESS | 30942 | |2;audio-dft;161;159;160;160;161;161;160;162;162;160 15:56:26 INFO - PROCESS | 30942 | |3;audio-fft;76;76;75;107;75;75;75;76;106;76 15:56:26 INFO - PROCESS | 30942 | |4;audio-oscillator;82;80;122;81;82;81;101;82;82;114 15:56:26 INFO - PROCESS | 30942 | |5;imaging-gaussian-blur;117;118;117;117;117;116;118;118;117;117 15:56:26 INFO - PROCESS | 30942 | |6;imaging-darkroom;146;147;146;147;147;146;146;147;147;145 15:56:26 INFO - PROCESS | 30942 | |7;imaging-desaturate;85;85;85;84;84;85;85;84;85;85 15:56:26 INFO - PROCESS | 30942 | |8;json-parse-financial;50;52;49;51;50;52;51;50;51;50 15:56:26 INFO - PROCESS | 30942 | |9;json-stringify-tinderbox;58;59;58;58;58;57;58;58;60;61 15:56:26 INFO - PROCESS | 30942 | |10;stanford-crypto-aes;75;82;76;76;77;83;74;76;75;74 15:56:26 INFO - PROCESS | 30942 | |11;stanford-crypto-ccm;121;130;123;123;121;130;119;128;168;122 15:56:26 INFO - PROCESS | 30942 | |12;stanford-crypto-pbkdf2;158;155;157;160;155;160;156;159;154;160 15:56:26 INFO - PROCESS | 30942 | |13;stanford-crypto-sha256-iterative;63;63;63;64;62;64;63;62;63;61 15:56:26 INFO - PROCESS | 30942 | __end_tp_report 15:56:26 INFO - PROCESS | 30942 | __start_cc_report 15:56:26 INFO - PROCESS | 30942 | _x_x_mozilla_cycle_collect,1615 15:56:26 INFO - PROCESS | 30942 | __end_cc_report 15:56:26 INFO - PROCESS | 30942 | __startTimestamp1482191786118__endTimestamp 15:56:26 INFO - PROCESS | 30942 | 15:56:26 INFO - PROCESS | 30942 | ------- Summary: start ------- 15:56:26 INFO - PROCESS | 30942 | Number of tests: 14 15:56:26 INFO - PROCESS | 30942 | 15:56:26 INFO - PROCESS | 30942 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.00 stddev:2.96 (2.7%) stddev-sans-first:0.87 15:56:26 INFO - PROCESS | 30942 | Values: 101.0 110.0 110.0 109.0 112.0 110.0 110.0 110.0 110.0 109.0 15:56:26 INFO - PROCESS | 30942 | 15:56:26 INFO - PROCESS | 30942 | [#1] audio-beat-detection Cycles:10 Average:128.00 Median:120.00 stddev:16.28 (13.6%) stddev-sans-first:15.74 15:56:26 INFO - PROCESS | 30942 | Values: 147.0 118.0 116.0 155.0 118.0 118.0 119.0 116.0 152.0 121.0 15:56:26 INFO - PROCESS | 30942 | 15:56:26 INFO - PROCESS | 30942 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 15:56:26 INFO - PROCESS | 30942 | Values: 161.0 159.0 160.0 160.0 161.0 161.0 160.0 162.0 162.0 160.0 15:56:26 INFO - PROCESS | 30942 | 15:56:26 INFO - PROCESS | 30942 | [#3] audio-fft Cycles:10 Average:81.70 Median:75.50 stddev:13.08 (17.3%) stddev-sans-first:13.71 15:56:26 INFO - PROCESS | 30942 | Values: 76.0 76.0 75.0 107.0 75.0 75.0 75.0 76.0 106.0 76.0 15:56:26 INFO - PROCESS | 30942 | 15:56:26 INFO - PROCESS | 30942 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:81.50 stddev:15.76 (19.3%) stddev-sans-first:16.39 15:56:26 INFO - PROCESS | 30942 | Values: 82.0 80.0 122.0 81.0 82.0 81.0 101.0 82.0 82.0 114.0 15:56:26 INFO - PROCESS | 30942 | 15:56:26 INFO - PROCESS | 30942 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 15:56:26 INFO - PROCESS | 30942 | Values: 117.0 118.0 117.0 117.0 117.0 116.0 118.0 118.0 117.0 117.0 15:56:26 INFO - PROCESS | 30942 | 15:56:26 INFO - PROCESS | 30942 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 15:56:26 INFO - PROCESS | 30942 | Values: 146.0 147.0 146.0 147.0 147.0 146.0 146.0 147.0 147.0 145.0 15:56:26 INFO - PROCESS | 30942 | 15:56:26 INFO - PROCESS | 30942 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 15:56:26 INFO - PROCESS | 30942 | Values: 85.0 85.0 85.0 84.0 84.0 85.0 85.0 84.0 85.0 85.0 15:56:26 INFO - PROCESS | 30942 | 15:56:26 INFO - PROCESS | 30942 | [#8] json-parse-financial Cycles:10 Average:50.60 Median:51.00 stddev:0.97 (1.9%) stddev-sans-first:1.00 15:56:26 INFO - PROCESS | 30942 | Values: 50.0 52.0 49.0 51.0 50.0 52.0 51.0 50.0 51.0 50.0 15:56:26 INFO - PROCESS | 30942 | 15:56:26 INFO - PROCESS | 30942 | [#9] json-stringify-tinderbox Cycles:10 Average:58.50 Median:58.00 stddev:1.18 (2.0%) stddev-sans-first:1.24 15:56:26 INFO - PROCESS | 30942 | Values: 58.0 59.0 58.0 58.0 58.0 57.0 58.0 58.0 60.0 61.0 15:56:26 INFO - PROCESS | 30942 | 15:56:26 INFO - PROCESS | 30942 | [#10] stanford-crypto-aes Cycles:10 Average:76.80 Median:76.00 stddev:3.16 (4.2%) stddev-sans-first:3.28 15:56:26 INFO - PROCESS | 30942 | Values: 75.0 82.0 76.0 76.0 77.0 83.0 74.0 76.0 75.0 74.0 15:56:26 INFO - PROCESS | 30942 | 15:56:26 INFO - PROCESS | 30942 | [#11] stanford-crypto-ccm Cycles:10 Average:128.50 Median:125.50 stddev:14.42 (11.5%) stddev-sans-first:15.03 15:56:26 INFO - PROCESS | 30942 | Values: 121.0 130.0 123.0 123.0 121.0 130.0 119.0 128.0 168.0 122.0 15:56:26 INFO - PROCESS | 30942 | 15:56:26 INFO - PROCESS | 30942 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.40 Median:158.50 stddev:2.32 (1.5%) stddev-sans-first:2.45 15:56:26 INFO - PROCESS | 30942 | Values: 158.0 155.0 157.0 160.0 155.0 160.0 156.0 159.0 154.0 160.0 15:56:26 INFO - PROCESS | 30942 | 15:56:26 INFO - PROCESS | 30942 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:63.00 stddev:0.92 (1.5%) stddev-sans-first:0.97 15:56:26 INFO - PROCESS | 30942 | Values: 63.0 63.0 63.0 64.0 62.0 64.0 63.0 62.0 63.0 61.0 15:56:26 INFO - PROCESS | 30942 | -------- Summary: end -------- 15:56:26 INFO - PROCESS | 30942 | 15:56:27 INFO - TEST-INFO | 30942: exit 0 15:56:27 INFO - TEST-OK | kraken | took 59866ms 15:56:27 INFO - SUITE-END | took 1175s 15:56:27 INFO - Completed test suite (00:19:35) 15:56:27 INFO - javascript benchmark 15:56:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3225.5161725741145, 3239.125436132246, 3247.5453436518883, 3252.12192707969, 3286.638469768325, 5520.834374968752, 5565.276514053177, 5589.189567512708, 5606.187102870086, 5613.859653508664, 5592.832215033545, 5631.568708629917, 5639.323281206261, 5648.802291919784, 5678.801241956532, 5053.494650534944, 5074.594032477411, 5097.872553186163, 5141.794328226866, 5162.406323272815, 4920.581750551208, 4948.1093403187415, 5098.107831129556, 5146.742662866842, 5147.202183661539, 5033.697978121306, 5042.647014708972, 5059.266406371074, 5064.442911279756, 5081.339425874631, 5085.313482679828, 5105.43840177582, 5182.714950677711, 5183.792648294101, 5218.086834803894, 4796.5203479651755, 5105.770240339194, 5122.308488354061, 5128.333316668846, 5159.14874045782, 5377.247185394048, 5416.241726158301, 5439.428859969686, 5489.039418101856, 5490.011797876381, 5916.911246331266, 5919.260092488439, 5948.048312270016, 6030.4572588467245, 6032.547558933054, 6009.789657362015, 6046.062860256668, 6049.3950604939155, 6049.48579370754, 6064.272287325505, 5466.8359949201185, 5511.0, 5514.3658479275, 5559.388467268597, 5569.275994120739, 6068.423499767515, 6089.451949324493, 6093.360197179232, 6095.299040610386, 6107.541934354941, 5860.472557469848, 5862.091375836752, 5866.882662346729, 5868.149118377897, 5872.471477567039, 5750.453706897838, 5796.0, 5881.647101173943, 5918.378570250062, 5921.378255283219, 5911.379305172981, 5934.9406505934385, 5935.614185077956, 5936.376680448577, 5973.761049557969, 5965.850853728692, 6013.849653758691, 6014.849628759229, 6027.276726792813, 6029.758809647565, 4500.639948804088, 4536.3422303765765, 4572.817087316536, 4581.450225972838, 4666.533346665374, 4105.3020986432375, 4130.297849365615, 4137.606927341898, 4150.501939767187, 4162.8334866605, 5665.461781130786, 5675.971620141873, 5677.886442271214, 5680.5455563554815, 5684.516816070598, 5807.680577568274, 5861.208736820475, 5875.941240587625, 5982.102684597346, 5986.820395388146, 5585.050541407971, 5609.5792815539, 5649.971750141223, 5668.0, 5683.460071293221, 4892.951070489321, 4922.360093187935, 4931.112399768004, 4931.18635425158, 4952.158133117378, 5965.0, 6092.695365231632, 6188.350223226586, 6198.6280823150755, 6201.286852011986, 5838.4453476919625, 5867.0, 5882.235309409921, 5962.55280853929, 5993.760249589967, 6177.042558403455, 6181.196444462191, 6182.443580077815, 6183.0107182850525, 6186.19579454668, 5611.8877622448135, 5647.774089036392, 5853.619514731528, 5854.0, 5855.970720146372, 5961.940380596138, 5973.641581505123, 5989.041753319448, 6064.6058006231215, 6109.144719739151, 5910.70446477683, 5920.407959204045, 5923.644581325134, 5924.822255332347, 5938.317093534299, 5669.54643628517, 5865.765369385177, 5869.8239052828485, 5933.584649074523, 5935.2877654681715, 5676.063449530946, 5765.077587585966, 5804.448577385142, 5817.854553636193, 5901.645901245939, 5941.732622032106, 5952.732127054206, 5957.672328022, 5959.4934430573885, 5960.642361458326, 5526.0, 5563.471470210324, 5791.044477661308, 5799.536037116936, 5801.332846722681], "value": 5495.177472845276, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.7766171193235, 616.9876602467949, 648.1800522339241, 654.8821212181808, 659.4930583616438, 35596.82201588992, 37816.0, 37964.620353796454, 37979.62020379799, 37990.05024874379, 37713.811430942806, 47699.04601907969, 49385.75307123459, 49582.75208623952, 52655.21017184745, 8934.01725810162, 9056.184943355096, 9066.320025998044, 9066.592003359832, 9074.137956894085, 8955.552222388887, 9078.455292682427, 9082.409643373192, 9084.863727044067, 9089.091090890892, 8405.41162118652, 8588.527630980325, 10709.839352409681, 10945.781084378308, 10949.781004379907, 10826.296290741117, 10850.077743391743, 10893.346399216072, 10911.127109831194, 10912.290701104443, 10745.14038876888, 10812.459377031195, 10827.945860270727, 10838.295510791773, 10855.0, 45847.0, 46186.538134618895, 46197.53802461999, 46214.30678539824, 46257.30614040792, 3490.685838274542, 3587.4798154267746, 3772.396416573335, 3893.3965235388278, 4110.034141976633, 33208.501872471694, 33497.6650233497, 33535.16162095967, 33536.6646333536, 33722.6627733722, 4484.484284307314, 4521.208788462039, 4556.544345565417, 4574.771261436915, 4721.929171062437, 375062.0, 376479.0, 376913.0, 377206.0, 377877.0, 39556.208875822325, 67272.32727672759, 67763.66118169476, 67842.3215767836, 67859.66070169717, 40217.59782402197, 42099.368509472384, 42406.151876962904, 42440.0, 42452.363214551806, 14594.63513412152, 14752.55742327732, 14756.262186890612, 14763.40946362155, 14764.335604897806, 11727.296362218294, 11842.0, 11843.644690659294, 11844.585439509576, 11847.111466640037, 8947.19475247231, 9127.497987610745, 9625.759356016015, 9642.711534063179, 9701.854472182922, 3526.594441639193, 3576.588692300367, 3581.194231297937, 3656.835442405098, 3701.5188025556504, 1059.941703206331, 1112.6828853776635, 1121.876593574706, 1123.326004397355, 1131.1290306463977, 34571.308573828384, 34822.30355392878, 35000.82499587486, 35073.82463087719, 35524.0, 986.4081551069445, 1082.4749996251812, 1132.6885106595587, 1136.471540733563, 1163.784699830534, 16911.0, 18556.257749690132, 18579.90710046441, 19184.34319649806, 19401.90299048524, 548151.0, 552242.0, 552976.0, 553009.0, 554407.0, 64653.35346646473, 65399.673001634685, 65442.67278663576, 65466.34533654602, 65491.67254163794, 1382.377929931535, 1411.089847048648, 1422.3528294625921, 1428.9356978935973, 1442.8629280218363, 32398.83800580982, 34406.65864460437, 34649.82675086709, 34710.479342809376, 34919.47620785741, 58089.4191058084, 58771.0, 58844.41155588561, 58869.70565147147, 58903.705481472316, 481085.0, 481980.0, 484666.0, 485202.0, 486951.0, 31968.520472193402, 32058.519122212718, 32118.0, 32382.19044523906, 32480.0, 43492.56507435012, 45777.0, 52105.47894521006, 52270.73864630653, 52278.0, 42316.0, 43091.353629696205, 44047.0, 44727.552724473644, 45090.0981980352, 43424.34863477114, 45028.0, 45344.09311813811, 45566.77216613896, 45808.0, 44144.779276103414, 45240.54759452363, 45468.31797523106, 45570.772146139054, 45920.08159836718, 37275.62724372721, 38678.41982370323, 39778.0, 40224.798876005436, 40584.18831623292, 29468.55797163087, 29539.75972823335, 30010.84994575013, 30210.84894575513, 30281.848590756905], "value": 20255.94992543239, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.333359958465, 432.61049675790184, 434.09058023440895, 437.9693421460498, 442.56407438672903, 19025.52436189096, 19680.311189108383, 20246.797532024677, 20414.591708165848, 20475.897620511914, 16473.67052658946, 18270.17784199711, 18750.156242969064, 19936.40190794275, 20117.491188160875, 5616.775328986846, 5743.483086522212, 5790.044642633981, 5791.478766910977, 5796.536277097843, 5646.153077038436, 5714.77140914365, 5754.798582049629, 5768.538516918637, 5794.478496935275, 5684.801031963882, 5732.283464566929, 5735.799247026355, 5736.684482353469, 5737.540996720252, 5622.718864056801, 5648.6893220872835, 5670.518005969498, 5727.856803579903, 5738.426157384249, 5175.0167468180925, 5182.896342073175, 5186.1442861927735, 5186.533212010937, 5188.143956247215, 22986.195483158175, 23834.880825595934, 23853.0, 24139.275821725376, 24346.02615895362, 2488.5271798358253, 2531.556977528925, 2597.9870100649377, 2615.882285297147, 2861.0415510803905, 15012.699746005019, 15236.314365853563, 15273.0, 15630.609234769108, 15978.920105399515, 1943.9028048597654, 2033.6542787725973, 2052.2509284111343, 2063.66981282994, 2065.308121779206, 85364.57317713372, 88197.55901220453, 89027.0, 89341.55329223377, 90081.54959225161, 11143.052840508486, 11173.553057877756, 11205.551777928791, 11539.71150721222, 11615.477303521362, 14581.781273280909, 14592.416303347747, 14597.12417254947, 14598.781018284733, 14631.487897923522, 8047.436679432501, 8101.432899696964, 8141.104478507359, 8288.668453261922, 8309.792255193548, 7537.54774713519, 7552.320291173821, 7710.691572337156, 7801.063872335242, 7871.842563148705, 6849.486288528281, 6919.688614012382, 7064.0, 7094.858102837914, 7128.358447739728, 1966.4002479243968, 2053.435305291057, 2059.6292667320026, 2106.104905415192, 2154.396768904709, 1029.4080903480528, 1063.9787204255872, 1075.8278675411896, 1079.266099052636, 1121.2263538158645, 19533.511662208275, 21145.471363216042, 21374.465638359165, 21395.67906481404, 21493.89253053756, 1053.8788039375418, 1074.1621535202555, 1087.9292845964987, 1094.8850370710961, 1156.6876943225282, 11271.830922536168, 11968.341741204144, 12088.879111208775, 12200.206986545845, 12329.198602090835, 390857.0, 393640.0, 394954.0, 532989.0, 538136.0, 100629.0, 103068.0, 103809.0, 105250.47374763078, 107385.46307268414, 1035.140833108518, 1036.3937096798456, 1081.291753901196, 1083.5070043130356, 1092.7705181911888, 17681.0, 17792.199351028976, 18293.90853045726, 18336.449906502825, 18688.439346819618, 30767.38465230638, 40649.59350406458, 40694.0, 42903.785481072395, 43228.56771432371, 61431.6928415373, 61907.38092619197, 62206.0, 62666.0, 63870.68064659647, 8828.690995815115, 8978.326625502983, 9025.458472491671, 9055.18503334703, 9250.074992500697, 12857.485700571873, 13182.868171318163, 13587.59237222885, 14070.296485175904, 14474.710505790035, 12305.323207223331, 12624.621261362174, 12672.176308539916, 12787.424565894744, 12877.742445151232, 12313.938430307791, 12450.439730212343, 12505.124641275024, 12734.808977865154, 12743.80884286755, 12242.877571224173, 12548.121631486074, 12551.87448125507, 12676.429560669976, 12696.047796415121, 8870.15733505316, 9275.86086208721, 9338.906610934075, 9340.53297335144, 9409.529523523934, 11354.318740875575, 12423.565175218824, 12639.494420223456, 12658.11393202467, 12964.22214667123], "value": 9775.394234477386, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1332.540273605607, 1512.2212060788695, 1530.9638181218977, 1697.7538256952741, 1824.5256233379318, 7675.424343174263, 8700.260477859381, 8820.514871682055, 8845.823083538342, 9059.773505662362, 8779.253763430115, 8868.068852770462, 8880.822383552326, 8885.733427997155, 8978.102189781019, 2479.913203037894, 2500.4499010217723, 2505.285993491855, 2509.5231905937903, 2514.094925826701, 2406.7713567211085, 2482.888270027853, 2486.5151295497294, 2486.6021436570154, 2489.103922587867, 2454.7299797022315, 2465.6055031195015, 2486.266551367342, 2486.428121532049, 2490.5392502387026, 2368.5499755046485, 2387.8328517003815, 2427.8421902576365, 2452.497238066192, 2458.532878753031, 2379.9286021419384, 2402.3393566769278, 2408.3497455686866, 2436.0377650827822, 2437.9756202437925, 8825.602847871862, 8918.331125165638, 9022.097790220925, 9040.728778136667, 9130.0, 5297.152455607084, 5564.721763911829, 5566.387697353329, 5566.415526369713, 5575.553955683536, 3535.275268569937, 3677.6506231908193, 3728.7203459740626, 3752.137008488036, 3758.924821503582, 1084.9566017359375, 1098.34099540276, 1128.751674631588, 1138.618562781469, 1143.1197977557317, 12111.697207569792, 12129.696757581043, 12208.694782630506, 12233.143679942408, 12241.387930603434, 4290.935635965463, 4629.837955671603, 4673.205555055649, 4757.35775670287, 4775.0, 9990.450525221037, 10017.599296028224, 10063.899361006297, 10095.848562271573, 10097.495125243708, 5345.893082138413, 5359.410464848864, 5359.490848369399, 5388.218708287276, 5392.73036348181, 4385.605295523418, 4536.274196128604, 4673.883152921204, 5055.34280543527, 5180.248863914711, 4019.9598004019585, 4080.8571699990953, 4177.26897792885, 4190.434291370687, 4200.474940632421, 1209.4678341529698, 1240.0, 1266.702324953635, 1285.710715089116, 1291.1026836348647, 935.8689783430325, 1015.5836107196014, 1022.7903279827617, 1027.291169093323, 1032.4373216596973, 5816.185733997244, 5977.312609049928, 6219.284782250009, 6278.752641122112, 6284.308726040132, 470.454273043275, 475.4926881784751, 477.22212793146946, 505.4768314794244, 506.1395627433378, 4084.0402505411203, 4096.508418989741, 4167.374893765898, 4182.895427614273, 4249.46881639795, 10999.945000275107, 11295.209335346612, 11328.037116844996, 11367.431628418712, 11408.429578521042, 11285.37930413835, 11318.886811131782, 11323.094152467782, 11327.150463715254, 11328.773424531464, 8047.470980513801, 8374.958125209336, 8387.077421483631, 8567.914320856837, 8688.131186881388, 5871.442212989759, 5895.9115613266695, 5996.970015150071, 6044.969775151096, 6113.083037544404, 9871.111599956039, 9964.601415943282, 9966.700998969753, 9988.300818942895, 10080.04239597237, 9313.674021409219, 9376.859347109936, 10038.224198665725, 10238.0, 10329.225308101772, 7685.769426917202, 8084.87872681922, 8189.631466584137, 8189.836203276021, 8201.507909525448, 8308.792280193044, 8314.792130196793, 8394.832103357776, 8400.747977560683, 8403.537805420761, 7554.622268886644, 7656.885146722915, 7794.142644309235, 7813.609319534115, 7974.5215287082965, 7634.312911837961, 7745.92254077452, 7758.107817601048, 7846.0976987647155, 8020.478668886503, 7228.530145540523, 7313.524620899624, 7319.5242309249725, 7341.77974660761, 7342.0, 5301.734913254399, 5312.282841816305, 5335.519803217729, 5337.466253374631, 5358.758855851574, 5349.732513374238, 5369.812056578001, 5461.863453413696, 5479.986202552541, 5562.944370556243], "value": 4658.715103574365, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.58814069749434, 356.7609701499995, 360.58532687409473, 370.35003568736863, 371.6859253930428, 5160.483951604838, 5298.947010529893, 5322.2282768998475, 5352.2506849041165, 5355.705436201012, 5110.667806592569, 5191.338771593092, 5205.089109405848, 5212.687238765677, 5214.243934629477, 4180.143070670505, 4194.448054219935, 4204.003098528206, 4204.11713540157, 4220.345846393814, 4055.858044968427, 4174.895627609304, 4182.6235638792505, 4185.644220241283, 4197.916041679165, 4094.7747873866924, 4104.733192342503, 4108.096218831867, 4115.238680844053, 4128.545859955402, 4119.196756632457, 4127.153933443637, 4128.174365126986, 4143.047099167178, 4150.439690641755, 3663.9267214655556, 3718.51659284294, 3760.943585846187, 3770.0, 3777.8299976501125, 5083.847484575469, 5131.0, 5135.229715542661, 5142.537171654531, 5147.7683504242395, 4810.302506136591, 4813.350197723333, 4816.879578010543, 4817.7591120444185, 4826.951730482685, 5332.226827110087, 5514.972425137888, 5516.972415137939, 5528.889422211533, 5543.750531226065, 4109.0, 4114.938275925863, 4131.731437456586, 4143.19207754488, 4143.937840932388, 5710.857228569277, 5742.454466825645, 5747.252857128588, 5750.482456578928, 5757.4818266355815, 4057.2696914555663, 4221.261279276115, 4258.063226090255, 4260.190563792869, 4280.764557949343, 4284.464441944757, 4300.569943005675, 4313.396124542566, 4326.372675961968, 4332.631726303236, 4792.784324705397, 4822.180229361017, 4830.637702172281, 4839.879003024953, 4846.248831431134, 5276.261323414648, 5492.022871766161, 5558.583106267046, 5566.4990150886615, 5616.438356164433, 1347.649611101101, 1368.5210176438168, 1425.4818618171614, 1440.0999375390381, 1443.6968236670416, 1007.8387458006683, 1030.8402197659375, 1038.159091136182, 1056.5456853553046, 1058.962936297226, 5078.162103252996, 5080.771365288497, 5094.949050509522, 5098.923516147261, 5125.641205115606, 5410.72749445234, 5414.269073675082, 5414.6209765316835, 5418.620696551282, 5433.864153396117, 5027.3464449621315, 5092.312537807348, 5149.48505149482, 5157.974210128926, 5375.9462405376225, 2914.621099257083, 2917.9574297991066, 2919.7591023815216, 2936.8678409471627, 2943.2641839540115, 5735.426457354231, 5742.712864356766, 5753.971230143822, 5771.769129234867, 5775.249217601685, 5471.835844924659, 5555.30558680165, 5573.972130139324, 5591.580631452657, 5620.297462817148, 5638.605297629127, 5650.237217975603, 5674.9355348112385, 5675.290588676416, 5676.120201368794, 5377.0, 5500.4224556420995, 5520.254765606592, 5520.503154716095, 5542.972285138549, 5397.676139431646, 5412.512873841373, 5428.371488553339, 5441.727913604224, 5460.918086228789, 5676.77292908279, 5686.601937864475, 5699.116636921284, 5712.7714891403875, 5737.967165910176, 3837.2901013312626, 4008.699347549004, 4034.515858097047, 4037.333839916498, 4052.5005747873474, 5343.225232341367, 5439.891202175855, 5442.918356224581, 5447.809326673548, 5495.890082198413, 5370.194470829407, 5382.73086345689, 5400.648957817729, 5401.567874569946, 5406.729663516887, 5432.2123292123215, 5451.236826844166, 5454.400015998316, 5506.862328441821, 5507.173923911445, 5300.840974770763, 5451.945480545302, 5460.5085542301385, 5487.807926722546, 5495.587830912617, 5549.361823390362, 5553.444655534414, 5553.888922221452, 5562.3034974331595, 5567.4432556744005, 5278.287431196893, 5422.159565267232, 5439.184122381516, 5442.809501667422, 5442.972785136049], "value": 4224.730719907517, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [761.463168466231, 777.7666699990006, 842.768238734348, 868.5092922498784, 885.3006125161123, 14297.07069040513, 15409.229538523072, 15580.987235829663, 15585.142817145052, 15618.0, 14241.0, 14355.210463424508, 14371.856281437182, 14380.424783008668, 14473.638159046002, 727.6725473536903, 755.3843617451787, 831.3432388413146, 854.1757204297851, 866.7963028688254, 855.7988872614931, 857.9356548258875, 858.4463021351224, 858.5707146426787, 859.2824991132412, 753.107567532473, 899.1772528136747, 899.5412339706764, 901.4546199549244, 902.7923577577161, 774.3185996323256, 868.4832524647825, 902.9503377314245, 905.6196397513061, 910.7222297199352, 658.0819756439739, 658.3679667519187, 659.5383231737754, 660.2341284110457, 660.2374257732326, 14768.704625907529, 14810.629734256621, 14980.850191498164, 15010.549683509513, 15025.248737563079, 14020.0, 14595.270236488239, 14790.482333118289, 15226.695466090616, 15445.382184712598, 12494.875051249463, 12979.67550811228, 13118.081734278605, 13224.933875330562, 13417.865821341758, 4426.535213802569, 4438.889027774331, 4475.172093162775, 4534.841280555198, 4591.724496530219, 66752.46675246663, 69737.65131174363, 70041.64979175123, 70695.29304706938, 72031.63984180045, 11557.653270401901, 11626.302421854547, 11769.882301176878, 11847.111466639864, 12047.759044819055, 21625.35123946284, 21653.458663533223, 21654.242101526685, 21656.350309490426, 21705.67441488379, 8423.705170319132, 8475.957620211982, 8696.086910874394, 8723.214910658071, 8963.372563920462, 4796.640251981115, 4798.448178459522, 4838.491958344323, 4964.503549645006, 5002.049610573979, 3607.494950706903, 3743.5882052974694, 3745.0450135215347, 3745.9438108428394, 3746.3256613809776, 615.1848800339478, 616.4020899727258, 620.602814198913, 631.6778442994014, 648.5751832549688, 671.1107782188523, 703.3107554596422, 727.2364017781414, 733.0470388494936, 756.9091708994956, 9337.766555836159, 9531.428114313163, 9625.422474651543, 9943.651972181084, 9944.751381215383, 623.6632218601995, 666.2005593288073, 711.5339452658517, 758.6775620361435, 760.8896709977022, 4588.449386073693, 4751.453582838018, 4764.809407623657, 4782.593479554207, 4865.2045121330675, 53942.46057539453, 70318.0, 95107.52446237863, 95866.5206673976, 98775.0, 74397.26279093981, 76512.61743691246, 76853.23146768572, 84283.57858210792, 84680.0, 44047.0, 55714.72142639342, 66653.33346666569, 69870.30129698638, 70453.2954670457, 9361.251099911855, 9441.669541566012, 9514.715513405601, 9701.175400091071, 9745.756356090871, 45645.315320270885, 45958.310625339975, 46134.76932615315, 46909.53090469052, 48017.27974080322, 65259.67370163119, 65875.6706216485, 67054.32945670481, 68030.61892833727, 68827.65586172037, 11979.0, 12112.939435302767, 12199.87800122023, 12259.632211033684, 12575.434105465092, 10997.450127493434, 13519.526816561372, 14036.228007459687, 14241.50154744579, 14431.927840360731, 11127.443627818739, 11324.225430537314, 11661.06711463098, 13355.933220333836, 14201.928990354982, 11723.941380293043, 11857.822132668189, 11907.642770716893, 12011.75976480483, 12479.438425270702, 12419.316937568521, 12668.239905605693, 12850.35748212567, 12880.935595321964, 13234.602961911158, 10751.677449676523, 11071.0, 11071.94464027707, 11314.886851131383, 11499.13756468285, 10973.114773683063, 11242.718932026764, 11342.489587968395, 11407.429628518375, 11413.258138220988], "value": 7355.716803659578, "unit": "score"}], "name": "dromaeo_css", "value": 7349.097865089801, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 110.0, 109.0, 112.0, 110.0, 110.0, 110.0, 110.0, 109.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 118.0, 116.0, 155.0, 118.0, 118.0, 119.0, 116.0, 152.0, 121.0], "value": 128.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 160.0, 160.0, 161.0, 161.0, 160.0, 162.0, 162.0, 160.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 107.0, 75.0, 75.0, 75.0, 76.0, 106.0, 76.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 122.0, 81.0, 82.0, 81.0, 101.0, 82.0, 82.0, 114.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 116.0, 118.0, 118.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 145.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 84.0, 84.0, 85.0, 85.0, 84.0, 85.0, 85.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 52.0, 49.0, 51.0, 50.0, 52.0, 51.0, 50.0, 51.0, 50.0], "value": 50.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 58.0, 58.0, 57.0, 58.0, 58.0, 60.0, 61.0], "value": 58.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 82.0, 76.0, 76.0, 77.0, 83.0, 74.0, 76.0, 75.0, 74.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 130.0, 123.0, 123.0, 121.0, 130.0, 119.0, 128.0, 168.0, 122.0], "value": 128.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 155.0, 157.0, 160.0, 155.0, 160.0, 156.0, 159.0, 154.0, 160.0], "value": 157.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 64.0, 62.0, 64.0, 63.0, 62.0, 63.0, 61.0], "value": 62.8, "unit": "score"}], "name": "kraken", "value": 1453.0, "alertThreshold": 2.0}]} 15:56:27 INFO - Return code: 0 15:56:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:56:27 INFO - # TBPL SUCCESS # 15:56:27 INFO - Running post-action listener: _resource_record_post_action 15:56:27 INFO - [mozharness: 2016-12-19 23:56:27.427123Z] Finished run-tests step (success) 15:56:27 INFO - Running post-run listener: _resource_record_post_run 15:56:27 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 266240; Write bytes: 367288320; Read time: 24; Write time: 272424 15:56:27 INFO - TinderboxPrint: CPU usage
13.0% 15:56:27 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 24 15:56:27 INFO - TinderboxPrint: I/O write bytes / time
367,288,320 / 272,424 15:56:27 INFO - TinderboxPrint: CPU idle
8,269.9 (87.0%) 15:56:27 INFO - TinderboxPrint: CPU user
1,193.3 (12.6%) 15:56:27 INFO - TinderboxPrint: Swap in / out
0 / 0 15:56:27 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 118575104; Read time: 0; Write time: 77340 15:56:27 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 262144; Write bytes: 247541760; Read time: 12; Write time: 195060 15:56:28 INFO - Running post-run listener: _upload_blobber_files 15:56:28 INFO - Blob upload gear active. 15:56:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:56:28 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 15:56:28 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:56:28 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:56:28 INFO - (blobuploader) - INFO - Open directory for files ... 15:56:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:56:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:56:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:56:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:56:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:56:29 INFO - (blobuploader) - INFO - Done attempting. 15:56:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:56:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:56:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:56:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:56:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:56:33 INFO - (blobuploader) - INFO - Done attempting. 15:56:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:56:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:56:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:56:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:56:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:56:34 INFO - (blobuploader) - INFO - Done attempting. 15:56:34 INFO - (blobuploader) - INFO - Iteration through files over. 15:56:34 INFO - Return code: 0 15:56:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:56:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:56:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4f9636f01390a24b70e14c877b2747ac76ea0aa6fc024a92d8424a62464a66fafb7a05a80e2d217e455fdd60ea7c8cc38993308f67d3c9ea9c8ae6e00ae3f1d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/674cd2a9e97089fbfdae7262480e965dbd9e61c0552167901bf65454b8f88894680181a32603a8cc1de181f37a37ae6714b6af0ed4aaad679590603cc4020e60", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/12c543600bb30119adf6d154fd0d90db75acb7fff7dea08435e54fe85aa019fa91661ce24c016d62c0b4ecf572948dc82ee8d5e5e945d25907f18793c994b6dc"} 15:56:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:56:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:56:34 INFO - Contents: 15:56:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4f9636f01390a24b70e14c877b2747ac76ea0aa6fc024a92d8424a62464a66fafb7a05a80e2d217e455fdd60ea7c8cc38993308f67d3c9ea9c8ae6e00ae3f1d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/674cd2a9e97089fbfdae7262480e965dbd9e61c0552167901bf65454b8f88894680181a32603a8cc1de181f37a37ae6714b6af0ed4aaad679590603cc4020e60", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/12c543600bb30119adf6d154fd0d90db75acb7fff7dea08435e54fe85aa019fa91661ce24c016d62c0b4ecf572948dc82ee8d5e5e945d25907f18793c994b6dc"} 15:56:34 INFO - Running post-run listener: copy_logs_to_upload_dir 15:56:34 INFO - Copying logs to upload dir... 15:56:34 INFO - mkdir: /builds/slave/test/build/upload/logs 15:56:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.405527 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-12-19 15:56:34.197608) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-19 15:56:34.201948) ========= 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=232498196343f89f466a4a9a000001c8-1482188026.708001-1231760579 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4f9636f01390a24b70e14c877b2747ac76ea0aa6fc024a92d8424a62464a66fafb7a05a80e2d217e455fdd60ea7c8cc38993308f67d3c9ea9c8ae6e00ae3f1d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/674cd2a9e97089fbfdae7262480e965dbd9e61c0552167901bf65454b8f88894680181a32603a8cc1de181f37a37ae6714b6af0ed4aaad679590603cc4020e60", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/12c543600bb30119adf6d154fd0d90db75acb7fff7dea08435e54fe85aa019fa91661ce24c016d62c0b4ecf572948dc82ee8d5e5e945d25907f18793c994b6dc"} build_url:https://queue.taskcluster.net/v1/task/Vf8FnyBhTLKS9owecASzbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011358 build_url: 'https://queue.taskcluster.net/v1/task/Vf8FnyBhTLKS9owecASzbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4f9636f01390a24b70e14c877b2747ac76ea0aa6fc024a92d8424a62464a66fafb7a05a80e2d217e455fdd60ea7c8cc38993308f67d3c9ea9c8ae6e00ae3f1d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/674cd2a9e97089fbfdae7262480e965dbd9e61c0552167901bf65454b8f88894680181a32603a8cc1de181f37a37ae6714b6af0ed4aaad679590603cc4020e60", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/12c543600bb30119adf6d154fd0d90db75acb7fff7dea08435e54fe85aa019fa91661ce24c016d62c0b4ecf572948dc82ee8d5e5e945d25907f18793c994b6dc"}' ========= master_lag: 0.27 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-19 15:56:34.484964) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 15:56:34.485371) ========= 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=232498196343f89f466a4a9a000001c8-1482188026.708001-1231760579 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004586 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 15:56:34.566382) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-19 15:56:34.566701) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-19 15:56:34.566985) ========= ========= Total master_lag: 0.43 =========