builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-010 starttime: 1477358701.65 results: success (0) buildid: 20161024153034 builduid: 930ec12c87dd4713a31345699116da5e revision: b6571211c807e209e550833eb47dfc08a4c6ae53 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 18:25:01.650726) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 18:25:01.651210) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 18:25:01.651507) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 18:25:01.666290) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 18:25:01.666710) ========= 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=eca2ab57546de7b41f256b19000001ef-1477358701.335046-502799588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-24 18:25:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 112M=0s 2016-10-24 18:25:02 (112 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124077 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 18:25:01.804427) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 18:25:01.804738) ========= 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=eca2ab57546de7b41f256b19000001ef-1477358701.335046-502799588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019994 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 18:25:01.854202) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-24 18:25:01.854571) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b6571211c807e209e550833eb47dfc08a4c6ae53 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev b6571211c807e209e550833eb47dfc08a4c6ae53 --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=eca2ab57546de7b41f256b19000001ef-1477358701.335046-502799588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-24 18:25:02,342 truncating revision to first 12 chars 2016-10-24 18:25:02,342 Setting DEBUG logging. 2016-10-24 18:25:02,342 attempt 1/10 2016-10-24 18:25:02,342 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b6571211c807?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-24 18:25:03,573 unpacking tar archive at: fx-team-b6571211c807/testing/mozharness/ program finished with exit code 0 elapsedTime=1.556416 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-24 18:25:03.424293) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 18:25:03.424618) ========= script_repo_revision: b6571211c807e209e550833eb47dfc08a4c6ae53 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 18:25:03.425021) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 18:25:03.425333) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 18:25:03.435793) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-10-24 18:25:03.436201) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=eca2ab57546de7b41f256b19000001ef-1477358701.335046-502799588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:25:04 INFO - MultiFileLogger online at 20161024 18:25:04 in /builds/slave/test 18:25:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 18:25:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:25:04 INFO - {'append_to_log': False, 18:25:04 INFO - 'base_work_dir': '/builds/slave/test', 18:25:04 INFO - 'blob_upload_branch': 'Fx-Team', 18:25:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:25:04 INFO - 'branch': 'Fx-Team', 18:25:04 INFO - 'buildbot_json_path': 'buildprops.json', 18:25:04 INFO - 'config_files': ('talos/linux_config.py',), 18:25:04 INFO - 'default_actions': ('clobber', 18:25:04 INFO - 'read-buildbot-config', 18:25:04 INFO - 'download-and-extract', 18:25:04 INFO - 'populate-webroot', 18:25:04 INFO - 'create-virtualenv', 18:25:04 INFO - 'install', 18:25:04 INFO - 'run-tests'), 18:25:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:25:04 INFO - 'download_minidump_stackwalk': True, 18:25:04 INFO - 'download_symbols': 'ondemand', 18:25:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:25:04 INFO - 'tooltool.py': '/tools/tooltool.py', 18:25:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:25:04 INFO - '/tools/misc-python/virtualenv.py')}, 18:25:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:25:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:25:04 INFO - 'installer_path': 'installer.exe', 18:25:04 INFO - 'log_level': 'info', 18:25:04 INFO - 'log_name': 'talos', 18:25:04 INFO - 'log_to_console': True, 18:25:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:25:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:25:04 INFO - 'opt_config_files': (), 18:25:04 INFO - 'pip_index': False, 18:25:04 INFO - 'sps_profile': False, 18:25:04 INFO - 'sps_profile_interval': 0, 18:25:04 INFO - 'suite': 'dromaeojs', 18:25:04 INFO - 'system_bits': '32', 18:25:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:25:04 INFO - 'title': 'talos-linux64-ix-010', 18:25:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:25:04 INFO - 'use_talos_json': True, 18:25:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:25:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:25:04 INFO - 'work_dir': 'build'} 18:25:04 INFO - [mozharness: 2016-10-25 01:25:04.015898Z] Running clobber step. 18:25:04 INFO - Running pre-action listener: _resource_record_pre_action 18:25:04 INFO - Running main action method: clobber 18:25:04 INFO - rmtree: /builds/slave/test/build 18:25:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:25:05 INFO - Running post-action listener: _resource_record_post_action 18:25:05 INFO - [mozharness: 2016-10-25 01:25:05.009662Z] Finished clobber step (success) 18:25:05 INFO - [mozharness: 2016-10-25 01:25:05.009761Z] Running read-buildbot-config step. 18:25:05 INFO - Running pre-action listener: _resource_record_pre_action 18:25:05 INFO - Running main action method: read_buildbot_config 18:25:05 INFO - Using buildbot properties: 18:25:05 INFO - { 18:25:05 INFO - "project": "", 18:25:05 INFO - "product": "firefox", 18:25:05 INFO - "script_repo_revision": "production", 18:25:05 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 18:25:05 INFO - "repository": "", 18:25:05 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 18:25:05 INFO - "buildid": "20161024153034", 18:25:05 INFO - "pgo_build": "True", 18:25:05 INFO - "basedir": "/builds/slave/test", 18:25:05 INFO - "buildnumber": 554, 18:25:05 INFO - "slavename": "talos-linux64-ix-010", 18:25:05 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:25:05 INFO - "platform": "ubuntu64_hw", 18:25:05 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 18:25:05 INFO - "branch": "fx-team", 18:25:05 INFO - "repo_path": "integration/fx-team", 18:25:05 INFO - "revision": "b6571211c807e209e550833eb47dfc08a4c6ae53", 18:25:05 INFO - "stage_platform": "linux64-pgo", 18:25:05 INFO - "builduid": "930ec12c87dd4713a31345699116da5e", 18:25:05 INFO - "slavebuilddir": "test" 18:25:05 INFO - } 18:25:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/A1zJoKVlRpal6RWe7ODFUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 18:25:05 INFO - Running post-action listener: _resource_record_post_action 18:25:05 INFO - [mozharness: 2016-10-25 01:25:05.012210Z] Finished read-buildbot-config step (success) 18:25:05 INFO - [mozharness: 2016-10-25 01:25:05.012299Z] Running download-and-extract step. 18:25:05 INFO - Running pre-action listener: _resource_record_pre_action 18:25:05 INFO - Running main action method: download_and_extract 18:25:05 INFO - mkdir: /builds/slave/test/build/tests 18:25:05 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')]} 18:25:05 INFO - trying https://queue.taskcluster.net/v1/task/A1zJoKVlRpal6RWe7ODFUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:25:05 INFO - Downloading https://queue.taskcluster.net/v1/task/A1zJoKVlRpal6RWe7ODFUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:25:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A1zJoKVlRpal6RWe7ODFUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:25:05 INFO - Downloaded 1361 bytes. 18:25:05 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:25:05 INFO - Using the following test package requirements: 18:25:05 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:25:05 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:25:05 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:25:05 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:05 INFO - u'jsshell-linux-x86_64.zip'], 18:25:05 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:25:05 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:25:05 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:25:05 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:25:05 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:25:05 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:25:05 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:25:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A1zJoKVlRpal6RWe7ODFUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:25:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A1zJoKVlRpal6RWe7ODFUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:25:05 INFO - Fetch https://queue.taskcluster.net/v1/task/A1zJoKVlRpal6RWe7ODFUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:25:06 INFO - Http code: 200 18:25:06 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 18:25:06 INFO - x-amz-cf-id: 4wFGXh8DkzqFhNWl-iPLLj0JCHx9b3hUtUosNEMyjd8Qrve5-zNoMQ== 18:25:06 INFO - x-amz-version-id: LNO64c5x9TRe1X4kr4IU6L8x5CvMWxdC 18:25:06 INFO - Expected file size: 22021843 18:25:06 INFO - Obtained file size: 22021843 18:25:10 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:25:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A1zJoKVlRpal6RWe7ODFUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:25:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A1zJoKVlRpal6RWe7ODFUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:25:10 INFO - Fetch https://queue.taskcluster.net/v1/task/A1zJoKVlRpal6RWe7ODFUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:25:11 INFO - Http code: 200 18:25:11 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 18:25:11 INFO - x-amz-cf-id: 6mhsrj5yRiCYFZgp-n1VCthZswfjLYDZTE7YWlixPcLhur_KkdgQDg== 18:25:11 INFO - x-amz-version-id: LNO64c5x9TRe1X4kr4IU6L8x5CvMWxdC 18:25:11 INFO - Expected file size: 22021843 18:25:11 INFO - Obtained file size: 22021843 18:25:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A1zJoKVlRpal6RWe7ODFUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 18:25:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A1zJoKVlRpal6RWe7ODFUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:25:15 INFO - Fetch https://queue.taskcluster.net/v1/task/A1zJoKVlRpal6RWe7ODFUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 18:25:16 INFO - Http code: 200 18:25:16 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 18:25:16 INFO - x-amz-cf-id: 0qIaiR6n5waoFyREcCFUGB3LAskQeflNHKC7C7i5LA7eIKHkpZZDNA== 18:25:16 INFO - x-amz-version-id: EGuGnNifks35v3iX7kK8CZfvMTI8W0Jy 18:25:16 INFO - Expected file size: 14409028 18:25:16 INFO - Obtained file size: 14409028 18:25:16 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')]} 18:25:16 INFO - trying https://queue.taskcluster.net/v1/task/A1zJoKVlRpal6RWe7ODFUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:25:16 INFO - Downloading https://queue.taskcluster.net/v1/task/A1zJoKVlRpal6RWe7ODFUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:25:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A1zJoKVlRpal6RWe7ODFUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:25:18 INFO - Downloaded 59396065 bytes. 18:25:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A1zJoKVlRpal6RWe7ODFUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:25:18 INFO - mkdir: /builds/slave/test/properties 18:25:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:25:18 INFO - Writing to file /builds/slave/test/properties/build_url 18:25:18 INFO - Contents: 18:25:18 INFO - build_url:https://queue.taskcluster.net/v1/task/A1zJoKVlRpal6RWe7ODFUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:25:18 INFO - Running post-action listener: _resource_record_post_action 18:25:18 INFO - Running post-action listener: set_extra_try_arguments 18:25:18 INFO - [mozharness: 2016-10-25 01:25:18.697468Z] Finished download-and-extract step (success) 18:25:18 INFO - [mozharness: 2016-10-25 01:25:18.697773Z] Running populate-webroot step. 18:25:18 INFO - Running pre-action listener: _resource_record_pre_action 18:25:18 INFO - Running main action method: populate_webroot 18:25:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:25:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:25:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:25:18 INFO - '--tppagecycles', 18:25:18 INFO - '7'], 18:25:18 INFO - 'tests': ['tsvgm']}}, 18:25:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:25:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:25:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:25:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:25:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:25:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:25:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:25:18 INFO - 'talos_options': ['--disable-e10s'], 18:25:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:25:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:25:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:25:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:25:18 INFO - 'talos_options': ['--disable-e10s'], 18:25:18 INFO - 'tests': ['damp', 'tps']}, 18:25:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:25:18 INFO - 'tests': ['damp', 'tps']}, 18:25:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:25:18 INFO - 'tests': ['dromaeo_dom']}, 18:25:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:25:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:25:18 INFO - 'tests': ['basic_compositor_video']}, 18:25:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:25:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:25:18 INFO - 'tests': ['a11yr', 18:25:18 INFO - 'ts_paint', 18:25:18 INFO - 'tpaint', 18:25:18 INFO - 'sessionrestore', 18:25:18 INFO - 'sessionrestore_no_auto_restore', 18:25:18 INFO - 'tabpaint']}, 18:25:18 INFO - 'other-e10s': {'tests': ['a11yr', 18:25:18 INFO - 'ts_paint', 18:25:18 INFO - 'tpaint', 18:25:18 INFO - 'sessionrestore', 18:25:18 INFO - 'sessionrestore_no_auto_restore', 18:25:18 INFO - 'tabpaint']}, 18:25:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:25:18 INFO - 'ts_paint', 18:25:18 INFO - 'tpaint', 18:25:18 INFO - 'sessionrestore', 18:25:18 INFO - 'sessionrestore_no_auto_restore', 18:25:18 INFO - 'tabpaint']}, 18:25:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:25:18 INFO - 'ts_paint', 18:25:18 INFO - 'tpaint', 18:25:18 INFO - 'sessionrestore', 18:25:18 INFO - 'sessionrestore_no_auto_restore', 18:25:18 INFO - 'tabpaint']}, 18:25:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:25:18 INFO - 'tests': ['a11yr', 18:25:18 INFO - 'ts_paint', 18:25:18 INFO - 'tpaint', 18:25:18 INFO - 'sessionrestore', 18:25:18 INFO - 'sessionrestore_no_auto_restore', 18:25:18 INFO - 'tabpaint']}, 18:25:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:25:18 INFO - 'tests': ['a11yr', 18:25:18 INFO - 'ts_paint', 18:25:18 INFO - 'tpaint', 18:25:18 INFO - 'sessionrestore', 18:25:18 INFO - 'sessionrestore_no_auto_restore', 18:25:18 INFO - 'tabpaint']}, 18:25:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:25:18 INFO - 'tests': ['tsvgx', 18:25:18 INFO - 'tsvgr_opacity', 18:25:18 INFO - 'tart', 18:25:18 INFO - 'tscrollx', 18:25:18 INFO - 'cart']}, 18:25:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:25:18 INFO - 'tsvgr_opacity', 18:25:18 INFO - 'tart', 18:25:18 INFO - 'tscrollx', 18:25:18 INFO - 'cart']}, 18:25:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:25:18 INFO - 'talos_options': ['--disable-e10s'], 18:25:18 INFO - 'tests': ['tp5o']}, 18:25:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:25:18 INFO - 'tests': ['tp5o']}, 18:25:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:25:18 INFO - 'talos_options': ['--disable-e10s', 18:25:18 INFO - '--xperf_path', 18:25:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:25:18 INFO - 'tests': ['tp5n']}, 18:25:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:25:18 INFO - 'talos_options': ['--xperf_path', 18:25:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:25:18 INFO - 'tests': ['tp5n']}}, 18:25:18 INFO - 'talos.zip': {'path': '', 18:25:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:25:18 INFO - Running post-action listener: _resource_record_post_action 18:25:18 INFO - [mozharness: 2016-10-25 01:25:18.716804Z] Finished populate-webroot step (success) 18:25:18 INFO - [mozharness: 2016-10-25 01:25:18.716897Z] Running create-virtualenv step. 18:25:18 INFO - Running pre-action listener: _resource_record_pre_action 18:25:18 INFO - Running main action method: create_virtualenv 18:25:18 INFO - Creating virtualenv /builds/slave/test/build/venv 18:25:18 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 18:25:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:25:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:25:18 INFO - Using real prefix '/usr' 18:25:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:25:19 INFO - Installing distribute.............................................................................................................................................................................................done. 18:25:21 INFO - Installing pip.................done. 18:25:21 INFO - Return code: 0 18:25:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:25:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:25:21 INFO - Reading from file tmpfile_stdout 18:25:21 INFO - Output received: 18:25:21 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) 18:25:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:25: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')]} 18:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25: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')]} 18:25:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbba5fa7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20927b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2121790>, '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 0x2122690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2122b20>, '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': 'eca2ab57546de7b41f256b19000001ef-1477358701.335046-502799588', '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 18:25: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', 'pip>=1.5'] in /builds/slave/test/build 18:25: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 pip>=1.5 18:25:21 INFO - Using env: {'DISPLAY': ':0', 18:25:21 INFO - 'HOME': '/home/cltbld', 18:25:21 INFO - 'LANG': 'en_US.UTF-8', 18:25:21 INFO - 'LANGUAGE': 'en_US:en', 18:25:21 INFO - 'LOGNAME': 'cltbld', 18:25:21 INFO - 'MAIL': '/var/mail/cltbld', 18:25:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:21 INFO - 'MOZ_NO_REMOTE': '1', 18:25:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:21 INFO - 'NO_EM_RESTART': '1', 18:25:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:21 INFO - 'PWD': '/builds/slave/test', 18:25:21 INFO - 'SHELL': '/bin/bash', 18:25:21 INFO - 'SHLVL': '1', 18:25:21 INFO - 'TERM': 'linux', 18:25:21 INFO - 'TMOUT': '86400', 18:25:21 INFO - 'USER': 'cltbld', 18:25:21 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1477358701.335046-502799588', 18:25:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:21 INFO - '_': '/tools/buildbot/bin/python'} 18:25:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:21 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 18:25:21 INFO - Cleaning up... 18:25:21 INFO - Return code: 0 18:25:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:25: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')]} 18:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25: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')]} 18:25:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25: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', '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 0x7fbba5fa7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20927b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2121790>, '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 0x2122690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2122b20>, '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': 'eca2ab57546de7b41f256b19000001ef-1477358701.335046-502799588', '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 18:25: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', 'psutil>=3.1.1'] in /builds/slave/test/build 18:25: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 psutil>=3.1.1 18:25:21 INFO - Using env: {'DISPLAY': ':0', 18:25:21 INFO - 'HOME': '/home/cltbld', 18:25:21 INFO - 'LANG': 'en_US.UTF-8', 18:25:21 INFO - 'LANGUAGE': 'en_US:en', 18:25:21 INFO - 'LOGNAME': 'cltbld', 18:25:21 INFO - 'MAIL': '/var/mail/cltbld', 18:25:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:21 INFO - 'MOZ_NO_REMOTE': '1', 18:25:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:21 INFO - 'NO_EM_RESTART': '1', 18:25:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:21 INFO - 'PWD': '/builds/slave/test', 18:25:21 INFO - 'SHELL': '/bin/bash', 18:25:21 INFO - 'SHLVL': '1', 18:25:21 INFO - 'TERM': 'linux', 18:25:21 INFO - 'TMOUT': '86400', 18:25:21 INFO - 'USER': 'cltbld', 18:25:21 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1477358701.335046-502799588', 18:25:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:21 INFO - '_': '/tools/buildbot/bin/python'} 18:25:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:21 INFO - Downloading/unpacking psutil>=3.1.1 18:25: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 18:25: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 18:25: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 18:25: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 18:25: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 18:25: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 18:25:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:25:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:25:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:25:24 INFO - Installing collected packages: psutil 18:25:24 INFO - Running setup.py install for psutil 18:25:24 INFO - building 'psutil._psutil_linux' extension 18:25:24 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 18:25:24 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 18:25:24 INFO - building 'psutil._psutil_posix' extension 18:25:24 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 18:25:24 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 18:25:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:25:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:25:24 INFO - Successfully installed psutil 18:25:24 INFO - Cleaning up... 18:25:24 INFO - Return code: 0 18:25:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:25: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')]} 18:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25: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')]} 18:25:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbba5fa7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20927b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2121790>, '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 0x2122690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2122b20>, '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': 'eca2ab57546de7b41f256b19000001ef-1477358701.335046-502799588', '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 18:25: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:25: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 mozsystemmonitor==0.3 18:25:24 INFO - Using env: {'DISPLAY': ':0', 18:25:24 INFO - 'HOME': '/home/cltbld', 18:25:24 INFO - 'LANG': 'en_US.UTF-8', 18:25:24 INFO - 'LANGUAGE': 'en_US:en', 18:25:24 INFO - 'LOGNAME': 'cltbld', 18:25:24 INFO - 'MAIL': '/var/mail/cltbld', 18:25:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:24 INFO - 'MOZ_NO_REMOTE': '1', 18:25:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:24 INFO - 'NO_EM_RESTART': '1', 18:25:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:24 INFO - 'PWD': '/builds/slave/test', 18:25:24 INFO - 'SHELL': '/bin/bash', 18:25:24 INFO - 'SHLVL': '1', 18:25:24 INFO - 'TERM': 'linux', 18:25:24 INFO - 'TMOUT': '86400', 18:25:24 INFO - 'USER': 'cltbld', 18:25:24 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1477358701.335046-502799588', 18:25:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:24 INFO - '_': '/tools/buildbot/bin/python'} 18:25:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:25: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 18:25: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 18:25: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 18:25: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 18:25: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 18:25: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 18:25:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:25:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:25:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:25:26 INFO - Installing collected packages: mozsystemmonitor 18:25:26 INFO - Running setup.py install for mozsystemmonitor 18:25:26 INFO - Successfully installed mozsystemmonitor 18:25:26 INFO - Cleaning up... 18:25:26 INFO - Return code: 0 18:25:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:25:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:25:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:25:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:26 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 0x7fbba5fa7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20927b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2121790>, '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 0x2122690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2122b20>, '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': 'eca2ab57546de7b41f256b19000001ef-1477358701.335046-502799588', '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 18:25:26 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 18:25:26 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 18:25:26 INFO - Using env: {'DISPLAY': ':0', 18:25:26 INFO - 'HOME': '/home/cltbld', 18:25:26 INFO - 'LANG': 'en_US.UTF-8', 18:25:26 INFO - 'LANGUAGE': 'en_US:en', 18:25:26 INFO - 'LOGNAME': 'cltbld', 18:25:26 INFO - 'MAIL': '/var/mail/cltbld', 18:25:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:26 INFO - 'MOZ_NO_REMOTE': '1', 18:25:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:26 INFO - 'NO_EM_RESTART': '1', 18:25:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:26 INFO - 'PWD': '/builds/slave/test', 18:25:26 INFO - 'SHELL': '/bin/bash', 18:25:26 INFO - 'SHLVL': '1', 18:25:26 INFO - 'TERM': 'linux', 18:25:26 INFO - 'TMOUT': '86400', 18:25:26 INFO - 'USER': 'cltbld', 18:25:26 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1477358701.335046-502799588', 18:25:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:26 INFO - '_': '/tools/buildbot/bin/python'} 18:25:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:27 INFO - Downloading/unpacking jsonschema==2.5.1 18:25:27 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 18:25:27 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 18:25:27 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 18:25:27 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 18:25:27 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 18:25:27 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 18:25:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:25:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:25:29 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 18:25:29 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 18:25:29 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 18:25:29 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 18:25:29 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 18:25:29 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 18:25:29 INFO - Downloading functools32-3.2.3-2.tar.gz 18:25:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:25:29 INFO - warning: no files found matching '*.txt' 18:25:29 INFO - no previously-included directories found matching 'build' 18:25:29 INFO - no previously-included directories found matching 'dist' 18:25:29 INFO - no previously-included directories found matching '.git*' 18:25:29 INFO - Installing collected packages: jsonschema, functools32 18:25:29 INFO - Running setup.py install for functools32 18:25:29 INFO - warning: no files found matching '*.txt' 18:25:29 INFO - no previously-included directories found matching 'build' 18:25:29 INFO - no previously-included directories found matching 'dist' 18:25:29 INFO - no previously-included directories found matching '.git*' 18:25:29 INFO - Successfully installed jsonschema functools32 18:25:29 INFO - Cleaning up... 18:25:29 INFO - Return code: 0 18:25:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:25:29 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')]} 18:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:29 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')]} 18:25:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:29 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 0x7fbba5fa7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20927b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2121790>, '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 0x2122690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2122b20>, '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': 'eca2ab57546de7b41f256b19000001ef-1477358701.335046-502799588', '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 18:25:29 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 18:25:29 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 18:25:29 INFO - Using env: {'DISPLAY': ':0', 18:25:29 INFO - 'HOME': '/home/cltbld', 18:25:29 INFO - 'LANG': 'en_US.UTF-8', 18:25:29 INFO - 'LANGUAGE': 'en_US:en', 18:25:29 INFO - 'LOGNAME': 'cltbld', 18:25:29 INFO - 'MAIL': '/var/mail/cltbld', 18:25:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:29 INFO - 'MOZ_NO_REMOTE': '1', 18:25:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:29 INFO - 'NO_EM_RESTART': '1', 18:25:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:29 INFO - 'PWD': '/builds/slave/test', 18:25:29 INFO - 'SHELL': '/bin/bash', 18:25:29 INFO - 'SHLVL': '1', 18:25:29 INFO - 'TERM': 'linux', 18:25:29 INFO - 'TMOUT': '86400', 18:25:29 INFO - 'USER': 'cltbld', 18:25:29 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1477358701.335046-502799588', 18:25:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:29 INFO - '_': '/tools/buildbot/bin/python'} 18:25:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:25:29 INFO - Cleaning up... 18:25:29 INFO - Return code: 0 18:25:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:25:29 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')]} 18:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:29 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')]} 18:25:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:29 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 0x7fbba5fa7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20927b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2121790>, '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 0x2122690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2122b20>, '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': 'eca2ab57546de7b41f256b19000001ef-1477358701.335046-502799588', '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 18:25:29 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 18:25:29 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 18:25:29 INFO - Using env: {'DISPLAY': ':0', 18:25:29 INFO - 'HOME': '/home/cltbld', 18:25:29 INFO - 'LANG': 'en_US.UTF-8', 18:25:29 INFO - 'LANGUAGE': 'en_US:en', 18:25:29 INFO - 'LOGNAME': 'cltbld', 18:25:29 INFO - 'MAIL': '/var/mail/cltbld', 18:25:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:29 INFO - 'MOZ_NO_REMOTE': '1', 18:25:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:29 INFO - 'NO_EM_RESTART': '1', 18:25:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:29 INFO - 'PWD': '/builds/slave/test', 18:25:29 INFO - 'SHELL': '/bin/bash', 18:25:29 INFO - 'SHLVL': '1', 18:25:29 INFO - 'TERM': 'linux', 18:25:29 INFO - 'TMOUT': '86400', 18:25:29 INFO - 'USER': 'cltbld', 18:25:29 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1477358701.335046-502799588', 18:25:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:29 INFO - '_': '/tools/buildbot/bin/python'} 18:25:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:29 INFO - Downloading/unpacking blobuploader==1.2.4 18:25:29 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 18:25:29 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 18:25:29 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 18:25:29 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 18:25:29 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 18:25:29 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 18:25:31 INFO - Downloading blobuploader-1.2.4.tar.gz 18:25:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:25:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:25:31 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 18:25:31 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 18:25:31 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 18:25:31 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 18:25:31 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 18:25:31 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 18:25:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:25:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:25: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 18:25: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 18:25: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 18:25: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 18:25: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 18:25: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 18:25:32 INFO - Downloading docopt-0.6.1.tar.gz 18:25:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:25:32 INFO - Installing collected packages: blobuploader, requests, docopt 18:25:32 INFO - Running setup.py install for blobuploader 18:25:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:25:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:25:32 INFO - Running setup.py install for requests 18:25:33 INFO - Running setup.py install for docopt 18:25:33 INFO - Successfully installed blobuploader requests docopt 18:25:33 INFO - Cleaning up... 18:25:33 INFO - Return code: 0 18:25:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:25:33 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')]} 18:25:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:33 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')]} 18:25:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:33 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 0x7fbba5fa7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20927b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2121790>, '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 0x2122690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2122b20>, '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': 'eca2ab57546de7b41f256b19000001ef-1477358701.335046-502799588', '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 18:25:33 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 18:25:33 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 18:25:33 INFO - Using env: {'DISPLAY': ':0', 18:25:33 INFO - 'HOME': '/home/cltbld', 18:25:33 INFO - 'LANG': 'en_US.UTF-8', 18:25:33 INFO - 'LANGUAGE': 'en_US:en', 18:25:33 INFO - 'LOGNAME': 'cltbld', 18:25:33 INFO - 'MAIL': '/var/mail/cltbld', 18:25:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:33 INFO - 'MOZ_NO_REMOTE': '1', 18:25:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:33 INFO - 'NO_EM_RESTART': '1', 18:25:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:33 INFO - 'PWD': '/builds/slave/test', 18:25:33 INFO - 'SHELL': '/bin/bash', 18:25:33 INFO - 'SHLVL': '1', 18:25:33 INFO - 'TERM': 'linux', 18:25:33 INFO - 'TMOUT': '86400', 18:25:33 INFO - 'USER': 'cltbld', 18:25:33 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1477358701.335046-502799588', 18:25:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:33 INFO - '_': '/tools/buildbot/bin/python'} 18:25:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:25:33 INFO - Running setup.py (path:/tmp/pip-Is9tpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:25:33 INFO - Running setup.py (path:/tmp/pip-yF5tUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:25:33 INFO - Running setup.py (path:/tmp/pip-vSQfP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:25:33 INFO - Running setup.py (path:/tmp/pip-nVCg1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:25:33 INFO - Running setup.py (path:/tmp/pip-znUfKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:25:33 INFO - Running setup.py (path:/tmp/pip-ujGLHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:25:33 INFO - Running setup.py (path:/tmp/pip-mLFIYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:25:34 INFO - Running setup.py (path:/tmp/pip-ziJJER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:25:34 INFO - Running setup.py (path:/tmp/pip-5FRyRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:25:34 INFO - Running setup.py (path:/tmp/pip-iaSZVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:25:34 INFO - Running setup.py (path:/tmp/pip-TIayf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:25:34 INFO - Running setup.py (path:/tmp/pip-m3F0mc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:25:34 INFO - Running setup.py (path:/tmp/pip-LWmUbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:25:34 INFO - Running setup.py (path:/tmp/pip-fWwjMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:25:34 INFO - Running setup.py (path:/tmp/pip-EvOfnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:25:34 INFO - Running setup.py (path:/tmp/pip-vCd0AY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:25:34 INFO - Running setup.py (path:/tmp/pip-ydMspI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:25:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:25:34 INFO - Running setup.py install for manifestparser 18:25:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:25:34 INFO - Running setup.py install for mozcrash 18:25:34 INFO - Running setup.py install for mozdebug 18:25:35 INFO - Running setup.py install for mozdevice 18:25:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:25:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:25:35 INFO - Running setup.py install for mozfile 18:25:35 INFO - Running setup.py install for mozhttpd 18:25:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:25:35 INFO - Running setup.py install for mozinfo 18:25:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:25:35 INFO - Running setup.py install for mozInstall 18:25:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:25:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:25:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:25:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:25:35 INFO - Running setup.py install for mozleak 18:25:35 INFO - Running setup.py install for mozlog 18:25:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:25:35 INFO - Running setup.py install for moznetwork 18:25:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:25:35 INFO - Running setup.py install for mozprocess 18:25:35 INFO - Running setup.py install for mozprofile 18:25:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:25:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:25:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:25:36 INFO - Running setup.py install for mozrunner 18:25:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:25:36 INFO - Running setup.py install for mozscreenshot 18:25:36 INFO - Running setup.py install for moztest 18:25:36 INFO - Running setup.py install for mozversion 18:25:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:25:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:25:36 INFO - Cleaning up... 18:25:36 INFO - Return code: 0 18:25:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:25:36 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')]} 18:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:36 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')]} 18:25:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:36 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 0x7fbba5fa7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20927b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2121790>, '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 0x2122690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2122b20>, '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': 'eca2ab57546de7b41f256b19000001ef-1477358701.335046-502799588', '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 18:25:36 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 18:25:36 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 18:25:36 INFO - Using env: {'DISPLAY': ':0', 18:25:36 INFO - 'HOME': '/home/cltbld', 18:25:36 INFO - 'LANG': 'en_US.UTF-8', 18:25:36 INFO - 'LANGUAGE': 'en_US:en', 18:25:36 INFO - 'LOGNAME': 'cltbld', 18:25:36 INFO - 'MAIL': '/var/mail/cltbld', 18:25:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:36 INFO - 'MOZ_NO_REMOTE': '1', 18:25:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:36 INFO - 'NO_EM_RESTART': '1', 18:25:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:36 INFO - 'PWD': '/builds/slave/test', 18:25:36 INFO - 'SHELL': '/bin/bash', 18:25:36 INFO - 'SHLVL': '1', 18:25:36 INFO - 'TERM': 'linux', 18:25:36 INFO - 'TMOUT': '86400', 18:25:36 INFO - 'USER': 'cltbld', 18:25:36 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1477358701.335046-502799588', 18:25:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:36 INFO - '_': '/tools/buildbot/bin/python'} 18:25:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:25:36 INFO - Running setup.py (path:/tmp/pip-ceDtkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:25:36 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)) 18:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:25:36 INFO - Running setup.py (path:/tmp/pip-GCLlAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:25:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:25:36 INFO - Running setup.py (path:/tmp/pip-U88Zw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:25:36 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)) 18:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:25:36 INFO - Running setup.py (path:/tmp/pip-sag4Xe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:25:37 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)) 18:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:25:37 INFO - Running setup.py (path:/tmp/pip-UpcKTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:25:37 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)) 18:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:25:37 INFO - Running setup.py (path:/tmp/pip-A0NQNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:25:37 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)) 18:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:25:37 INFO - Running setup.py (path:/tmp/pip-pS7cU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:25:37 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)) 18:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:25:37 INFO - Running setup.py (path:/tmp/pip-Ctl0xc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:25:37 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)) 18:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:25:37 INFO - Running setup.py (path:/tmp/pip-eXWIg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:25:37 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)) 18:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:25:37 INFO - Running setup.py (path:/tmp/pip-2BfDm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:25:37 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)) 18:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:25:37 INFO - Running setup.py (path:/tmp/pip-R3Gf4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:25:37 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)) 18:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:25:37 INFO - Running setup.py (path:/tmp/pip-Brmdrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:25:37 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)) 18:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:25:37 INFO - Running setup.py (path:/tmp/pip-NfP86S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:25:37 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)) 18:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:25:37 INFO - Running setup.py (path:/tmp/pip-MCuyaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:25:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:25:37 INFO - Running setup.py (path:/tmp/pip-zDF4Mh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:25:37 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)) 18:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:25:37 INFO - Running setup.py (path:/tmp/pip-madGi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:25:37 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)) 18:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:25:37 INFO - Running setup.py (path:/tmp/pip-ErQQKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:25:38 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)) 18:25:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:25:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:25:38 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)) 18:25:38 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)) 18:25:38 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)) 18:25:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:25:38 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 18:25:38 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 18:25:38 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 18:25:38 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 18:25:38 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 18:25:38 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 18:25:39 INFO - Downloading blessings-1.6.tar.gz 18:25:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:25:40 INFO - Installing collected packages: blessings 18:25:40 INFO - Running setup.py install for blessings 18:25:40 INFO - Successfully installed blessings 18:25:40 INFO - Cleaning up... 18:25:40 INFO - Return code: 0 18:25:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:25:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:25:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:25:40 INFO - Reading from file tmpfile_stdout 18:25:40 INFO - Current package versions: 18:25:40 INFO - argparse == 1.2.1 18:25:40 INFO - blessings == 1.6 18:25:40 INFO - blobuploader == 1.2.4 18:25:40 INFO - docopt == 0.6.1 18:25:40 INFO - functools32 == 3.2.3-2 18:25:40 INFO - jsonschema == 2.5.1 18:25:40 INFO - manifestparser == 1.1 18:25:40 INFO - mozInstall == 1.12 18:25:40 INFO - mozcrash == 0.17 18:25:40 INFO - mozdebug == 0.1 18:25:40 INFO - mozdevice == 0.48 18:25:40 INFO - mozfile == 1.2 18:25:40 INFO - mozhttpd == 0.7 18:25:40 INFO - mozinfo == 0.9 18:25:40 INFO - mozleak == 0.1 18:25:40 INFO - mozlog == 3.4 18:25:40 INFO - moznetwork == 0.27 18:25:40 INFO - mozprocess == 0.23 18:25:40 INFO - mozprofile == 0.28 18:25:40 INFO - mozrunner == 6.12 18:25:40 INFO - mozscreenshot == 0.1 18:25:40 INFO - mozsystemmonitor == 0.3 18:25:40 INFO - moztest == 0.7 18:25:40 INFO - mozversion == 1.4 18:25:40 INFO - psutil == 3.1.1 18:25:40 INFO - requests == 1.2.3 18:25:40 INFO - wsgiref == 0.1.2 18:25:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:25:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:25:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:40 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 0x7fbba5fa7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20927b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2121790>, '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 0x2122690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2122b20>, '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': 'eca2ab57546de7b41f256b19000001ef-1477358701.335046-502799588', '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 18:25:40 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 18:25:40 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 18:25:40 INFO - Using env: {'DISPLAY': ':0', 18:25:40 INFO - 'HOME': '/home/cltbld', 18:25:40 INFO - 'LANG': 'en_US.UTF-8', 18:25:40 INFO - 'LANGUAGE': 'en_US:en', 18:25:40 INFO - 'LOGNAME': 'cltbld', 18:25:40 INFO - 'MAIL': '/var/mail/cltbld', 18:25:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:40 INFO - 'MOZ_NO_REMOTE': '1', 18:25:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:40 INFO - 'NO_EM_RESTART': '1', 18:25:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:40 INFO - 'PWD': '/builds/slave/test', 18:25:40 INFO - 'SHELL': '/bin/bash', 18:25:40 INFO - 'SHLVL': '1', 18:25:40 INFO - 'TERM': 'linux', 18:25:40 INFO - 'TMOUT': '86400', 18:25:40 INFO - 'USER': 'cltbld', 18:25:40 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1477358701.335046-502799588', 18:25:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:40 INFO - '_': '/tools/buildbot/bin/python'} 18:25:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:40 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)) 18:25:40 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)) 18:25:40 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)) 18:25:40 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)) 18:25:40 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)) 18:25:40 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)) 18:25:40 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)) 18:25:40 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)) 18:25:40 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)) 18:25:40 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)) 18:25:40 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)) 18:25:40 INFO - Cleaning up... 18:25:40 INFO - Return code: 0 18:25:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:25:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:25:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbba5fa7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20927b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2121790>, '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 0x2122690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2122b20>, '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': 'eca2ab57546de7b41f256b19000001ef-1477358701.335046-502799588', '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 18:25:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:25:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:25:40 INFO - Using env: {'DISPLAY': ':0', 18:25:40 INFO - 'HOME': '/home/cltbld', 18:25:40 INFO - 'LANG': 'en_US.UTF-8', 18:25:40 INFO - 'LANGUAGE': 'en_US:en', 18:25:40 INFO - 'LOGNAME': 'cltbld', 18:25:40 INFO - 'MAIL': '/var/mail/cltbld', 18:25:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:40 INFO - 'MOZ_NO_REMOTE': '1', 18:25:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:40 INFO - 'NO_EM_RESTART': '1', 18:25:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:40 INFO - 'PWD': '/builds/slave/test', 18:25:40 INFO - 'SHELL': '/bin/bash', 18:25:40 INFO - 'SHLVL': '1', 18:25:40 INFO - 'TERM': 'linux', 18:25:40 INFO - 'TMOUT': '86400', 18:25:40 INFO - 'USER': 'cltbld', 18:25:40 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1477358701.335046-502799588', 18:25:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:40 INFO - '_': '/tools/buildbot/bin/python'} 18:25:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:25:40 INFO - Cleaning up... 18:25:40 INFO - Return code: 0 18:25:40 INFO - Running post-action listener: _resource_record_post_action 18:25:40 INFO - Running post-action listener: _start_resource_monitoring 18:25:40 INFO - Starting resource monitoring. 18:25:40 INFO - [mozharness: 2016-10-25 01:25:40.895072Z] Finished create-virtualenv step (success) 18:25:40 INFO - [mozharness: 2016-10-25 01:25:40.895595Z] Running install step. 18:25:40 INFO - Running pre-action listener: _resource_record_pre_action 18:25:40 INFO - Running main action method: install 18:25:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:25:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:25:41 INFO - Reading from file tmpfile_stdout 18:25:41 INFO - Detecting whether we're running mozinstall >=1.0... 18:25:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:25:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:25:41 INFO - Reading from file tmpfile_stdout 18:25:41 INFO - Output received: 18:25:41 INFO - Usage: mozinstall [options] installer 18:25:41 INFO - Options: 18:25:41 INFO - -h, --help show this help message and exit 18:25:41 INFO - -d DEST, --destination=DEST 18:25:41 INFO - Directory to install application into. [default: 18:25:41 INFO - "/builds/slave/test"] 18:25:41 INFO - --app=APP Application being installed. [default: firefox] 18:25:41 INFO - mkdir: /builds/slave/test/build/application 18:25:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:25:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:25:58 INFO - Reading from file tmpfile_stdout 18:25:58 INFO - Output received: 18:25:58 INFO - /builds/slave/test/build/application/firefox/firefox 18:25:58 INFO - Running post-action listener: _resource_record_post_action 18:25:58 INFO - [mozharness: 2016-10-25 01:25:58.109603Z] Finished install step (success) 18:25:58 INFO - [mozharness: 2016-10-25 01:25:58.109848Z] Running run-tests step. 18:25:58 INFO - Running pre-action listener: _resource_record_pre_action 18:25:58 INFO - Running main action method: run_tests 18:25:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:25:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:25:58 INFO - Python 2.7.3 18:25:58 INFO - Return code: 0 18:25:58 INFO - grabbing minidump binary from tooltool 18:25: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')]} 18:25:58 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 0x2121790>, '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 0x2122690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2122b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:25:58 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 18:25:58 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 18:25:58 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 18:25:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:25:58 INFO - Return code: 0 18:25:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:25:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:25:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:25:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:25:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:25:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A1zJoKVlRpal6RWe7ODFUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 18:25:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/A1zJoKVlRpal6RWe7ODFUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 18:25:58 INFO - Using env: {'DISPLAY': ':0', 18:25:58 INFO - 'HOME': '/home/cltbld', 18:25:58 INFO - 'LANG': 'en_US.UTF-8', 18:25:58 INFO - 'LANGUAGE': 'en_US:en', 18:25:58 INFO - 'LOGNAME': 'cltbld', 18:25:58 INFO - 'MAIL': '/var/mail/cltbld', 18:25:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:25:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:25:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:58 INFO - 'MOZ_NO_REMOTE': '1', 18:25:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:25:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:58 INFO - 'NO_EM_RESTART': '1', 18:25:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:58 INFO - 'PWD': '/builds/slave/test', 18:25:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:25:58 INFO - 'SHELL': '/bin/bash', 18:25:58 INFO - 'SHLVL': '1', 18:25:58 INFO - 'TERM': 'linux', 18:25:58 INFO - 'TMOUT': '86400', 18:25:58 INFO - 'USER': 'cltbld', 18:25:58 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1477358701.335046-502799588', 18:25:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:58 INFO - '_': '/tools/buildbot/bin/python'} 18:25:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A1zJoKVlRpal6RWe7ODFUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 18:25:58 INFO - mozversion application_buildid: 20161024153034 18:25:58 INFO - mozversion application_changeset: b6571211c807e209e550833eb47dfc08a4c6ae53 18:25:58 INFO - mozversion application_display_name: Nightly 18:25:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:25:58 INFO - mozversion application_name: Firefox 18:25:58 INFO - mozversion application_remotingname: firefox 18:25:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:25:58 INFO - mozversion application_vendor: Mozilla 18:25:58 INFO - mozversion application_version: 52.0a1 18:25:58 INFO - mozversion platform_buildid: 20161024153034 18:25:58 INFO - mozversion platform_changeset: b6571211c807e209e550833eb47dfc08a4c6ae53 18:25:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:25:58 INFO - mozversion platform_version: 52.0a1 18:25:58 INFO - using testdate: 1477358758 18:25:58 INFO - actual date: 1477358758 18:25:58 INFO - starting webserver on 'localhost:51734' 18:25:58 INFO - SUITE-START | Running 2 tests 18:25:58 INFO - TEST-START | dromaeo_css 18:25:58 INFO - operating with platform_type : linux_ 18:25:58 INFO - Initialising browser for dromaeo_css test... 18:25:58 INFO - TEST-INFO | started process 9018 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm018Cb/profile http://localhost:51734/getInfo.html) 18:26:02 INFO - PROCESS | 9018 | __metrics Screen width/height:1600/1200 18:26:02 INFO - PROCESS | 9018 | colorDepth:24 18:26:02 INFO - PROCESS | 9018 | Browser inner width/height: 1024/697 18:26:02 INFO - PROCESS | 9018 | __metrics 18:26:03 INFO - PROCESS | 9018 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:26:03 INFO - PROCESS | 9018 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:26:04 INFO - PROCESS | 9018 | console.error: PushService: 18:26:04 INFO - PROCESS | 9018 | stateChangeProcessEnqueue: Error transitioning state 18:26:04 INFO - PROCESS | 9018 | UnknownError 18:26:04 INFO - TEST-INFO | 9018: exit 0 18:26:04 INFO - Browser initialized. 18:26:04 INFO - Running cycle 1/1 for dromaeo_css test... 18:26:04 INFO - TEST-INFO | started process 9099 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm018Cb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:26:17 INFO - PROCESS | 9099 | RSS: Main: 171884544 18:26:17 INFO - PROCESS | 9099 | 18:27:08 INFO - PROCESS | 9099 | 1477358828108 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] 18:29:19 INFO - PROCESS | 9099 | Cycle 1(1): loaded http://localhost:51734/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51734/tests/dromaeo/cssquery-ext.html) 18:29:21 INFO - PROCESS | 9099 | RSS: Main: 294891520 18:29:21 INFO - PROCESS | 9099 | 18:32:23 INFO - PROCESS | 9099 | Cycle 1(1): loaded http://localhost:51734/tests/dromaeo/cssquery-ext.html (next: http://localhost:51734/tests/dromaeo/cssquery-jquery.html) 18:32:24 INFO - PROCESS | 9099 | RSS: Main: 279953408 18:32:24 INFO - PROCESS | 9099 | 18:35:26 INFO - PROCESS | 9099 | Cycle 1(1): loaded http://localhost:51734/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51734/tests/dromaeo/cssquery-mootools.html) 18:35:26 INFO - PROCESS | 9099 | RSS: Main: 212975616 18:35:26 INFO - PROCESS | 9099 | 18:38:29 INFO - PROCESS | 9099 | Cycle 1(1): loaded http://localhost:51734/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51734/tests/dromaeo/cssquery-prototype.html) 18:38:29 INFO - PROCESS | 9099 | RSS: Main: 245080064 18:38:29 INFO - PROCESS | 9099 | 18:41:32 INFO - PROCESS | 9099 | Cycle 1(1): loaded http://localhost:51734/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51734/tests/dromaeo/cssquery-yui.html) 18:41:33 INFO - PROCESS | 9099 | RSS: Main: 215121920 18:41:33 INFO - PROCESS | 9099 | 18:44:36 INFO - PROCESS | 9099 | Cycle 1(1): loaded http://localhost:51734/tests/dromaeo/cssquery-yui.html (next: http://localhost:51734/tests/dromaeo/cssquery-dojo.html) 18:44:36 INFO - PROCESS | 9099 | RSS: Main: 303144960 18:44:36 INFO - PROCESS | 9099 | 18:44:36 INFO - PROCESS | 9099 | __start_tp_report 18:44:36 INFO - PROCESS | 9099 | _x_x_mozilla_page_load 18:44:36 INFO - PROCESS | 9099 | _x_x_mozilla_page_load_details 18:44:36 INFO - PROCESS | 9099 | |i|pagename|runs| 18:44:36 INFO - PROCESS | 9099 | |0;dojo.html;3054.6945305469458;3110.502319628861;3113.0193988893498;3135.4983202687577;3165.0346644273486;5308.23030660554;5376.946230537694;5392.91910621341;5473.78104875805;5520.751566179517;5394.757235924383;5404.270423492827;5409;5423;5432.945670543293;4915.778789954452;4929.137400954836;4950.207966725325;4972.129877271481;4989.2017277235645;4907.8773030674165;4916.655834091615;4961.900761984758;5062.924056139161;5073.239014147889;4936.407631084275;4939.950600494003;4949.430815456215;4952.232403977389;5008.799648014094;4986.925196122061;4990.82532111378;5004.924926126111;5006.3241462402475;5065.797368105272;4833.63747718919;4843.128236917353;4887.682300650446;4914.434839993375;4966.5778408835295;5339.733013349317;5352.652077614982;5359.1425371940695;5359.919601205946;5452.345718513764;5756.251687280626;5763.366029736726;5763.88472230553;5764.74058667361;5766.682832444214;5668.489835914787;5737.569682273846;5743.770249190027;5816.738246778905;5825.533957283407;5327.200919862052;5376;5379.78480860769;5380.704061276668;5381.219723140122;5860.853478663067;5874.50066744323;5876.382979787061;5878.794242201502;5944.108383742473;5742.511886489611;5796.014677504834;5810.302763668386;5870.559708021916;5877;5883.588148829626;5887.322957859901;5891.970540147272;5898.439648233411;5899.911501327398;5686.317641883001;5724.542036637143;5872.442117998783;5875.471207591338;5879.647221166743;5724.627899186539;5776.1624564437925;5779.075347944308;5788.652680839163;5855.063189889597;4411.18393097278;4417.315316126005;4419.690621656518;4421.204183247047;4470.642348612103;3902.921941561153;3915.647591716759;3917.275304068756;3918.921621567553;3994.6604538614542;5408.945910540844;5410.3507579090765;5454.427285135083;5482.972585137049;5558.610897237236;5757.165211044375;5760.51035661965;5773.278340207474;5776.537876969833;5792.913106303409;5360.195970604363;5362.731863406814;5372.597055220874;5377.650452720561;5431.293931788921;4963.280324352949;4968.080905032581;4970.105381031449;4973.651844370859;5030.924536131961;5734.05388110957;5801.7389217485315;5875.559333050124;5908.940910590925;5910.822675319747;5796.82609521715;5800.535957123504;5802.593818432838;5804.361520232856;5858.970705146447;5903.675297858659;5942.108683697307;5961.076033214858;5968.343482216866;5970.671613061323;5608.6073974821375;5658.236138121466;5663.830085097454;5673.801416950387;5739.770409183586;5810.6513609183585;5837.241158649518;5854.326752423355;5916.55625828056;5916.674582897982;5680.375158732619;5680.7443665036;5688.857778555569;5691.686957217393;5711.7429715662065;5437.429069947599;5526.143447765603;5698.031334673033;5707.914381284367;5711.457411545896;5621.606487545832;5692.2600061993335;5701.828945131652;5710.172025056427;5715.371309155907;5758.539316854558;5763;5763.394843541536;5766.221560089334;5770.5095066919785;5428.809991650273;5632.239647647515;5641.323041235078;5643.830685079454;5715.51418129447 18:44:36 INFO - PROCESS | 9099 | |1;ext.html;565.593552430917;577.2149876168412;615.6121643364679;617.9073139029142;643.9710213040413;31958.520622190685;35121;35138.29723405534;35139;35225.47161792572;35793.642063579355;43669.78165109178;44884.55115448844;44971.77514112425;47548.52451475484;8787.516686582252;8898.288136949028;8906.198442140207;8913.68802091927;8923.464592124461;8919.152680495376;8991.640334386617;9015.684451044215;9017.45895246284;9021.413608115485;9003.549822508881;9041.3671043027;9044.186023257906;9044.683436079738;9047.909520904772;8995.55022248885;9000.189982901538;9016.459012459274;9054.773630659252;9065.728028159167;8881.555922203928;8976.775580610472;8977.192052715222;8981.865272020925;8985;41732.79133604343;42034.369484457755;42111.789441052904;42127.57872421298;42169.36745948813;3226.838658067087;3261.2010057536054;3332.900012999614;3473.774204676688;3910.921781564353;32014.199645009063;32419.027429177164;32434.6756532434;32952.34095318104;33317.666823331696;4066.1867626474823;4193.601607847249;4200.05498762779;4200.579942005775;4259.595338442843;329774;334338;334367;334413;335802;58386.70166229222;58747.70626146842;58781.118283225784;58855.411445884994;58875.41124588785;35654.28691426209;36572.26855462876;36606.45090323647;38030.23939521194;62258.37741622526;14636.780448293284;14820.3330850112;14839.258037098101;14875.925620372045;14881.553553393416;11335.829962550568;11408.657740267805;11428.314301141958;11458.541658333574;11461.713457163638;19189.682321477554;19190.712139317922;19243.903780481007;19285.51786205328;19426.4172074838;6919.757808476679;6950.965245173843;7250.6374681265725;7282.599457029914;7351.154617219088;868.674247157316;1010.777628921636;1051.321897376188;1089.7711480589007;1125.6566747142037;31829.20426989344;31979.040628781175;32326.35347293041;32792.50811237833;32925;1000.7240768020831;1008.1531513528671;1076.967690969272;1096.1121491591678;1165.1901928160016;15860.603484912739;16724.49826505207;16801;16842.410515631895;16985.0350370165;471428;475087;475812;477083;477988;56633.150502741664;57300.42699573034;57331.14003289954;57349;57405.712971435714;1267.1193520503346;1280.699035726585;1282.3972732815562;1286.7233544787728;1288.2077522323702;29638.851805741695;31242.375152497276;31351.84324078365;31433.52849707302;32060;50993.23510147425;51461;51502.22746658728;51540.48459515357;51597.48402515927;393156;396426;397024;397610;398395;27333.86333068322;27975.72024279731;28052;28464.43071138607;28469.715302846707;46951.29573056338;47770.52229477661;48066.35635039966;48149.51850481451;48173.27740083831;37512.43731344087;40284.59715402809;40686.79656601698;40866;41854;39634.603653964245;40252.59747402606;40937.59062409457;41655.58344416517;42122.57877421186;31981.6801831988;35549.111272218404;39897.80051099726;42552.78723606486;42683.57316426796;34048.65951340455;36324.455133172494;37292.627073728916;37314;37562.24875502529;27438.5884211733;28098.157055288375;28167.295817604725;29583.668734907413;29598.408031839674 18:44:36 INFO - PROCESS | 9099 | |2;jquery.html;364.38237187966394;369.44767572479145;384.84606157536984;384.97690138591685;407.7390470099137;13953.162810231393;14590;18375;18423.907880460578;18430.90784546077;18003.369882054132;18937.147828347723;18977.620447591038;19603.901980490078;19698.70451943222;3802.391617341226;5176.094183517879;5325.174597937326;5329.067413202674;5333.413324534298;4059.8985025374454;5541.251930989325;5757.222774925373;5811.215485909412;5904.527637788967;5892.764289428439;5893.58744887858;5902.675352855591;5950.404959504037;6379.330170332118;6412.551121421502;6421.261554921197;6445.806625801233;6453.580517266362;6456.612603243797;4886.1204983103025;5151.330327057459;5185.274061631375;5214.556762675177;5725.713714314309;10697.732556686067;10779.892201077968;10782.784344313148;10813.945930270376;20995;2158.4495953531905;2207.3819330587303;2379.2862141357696;2844.48799216141;2930.912072637824;9866.358686685415;10416.739581510446;10536.367817930948;11114;14772.113673179536;1874.240932422371;1924.7497825282765;1952.248384372027;1963;1976.7529058867642;53749.46250537484;65732.35005111598;72879;73173.26826731718;82649.58675206585;9858.80282394348;10190.745231369276;10719.732006699895;10731.83902241467;10833.83749243762;14911.478098266509;14984.175870327237;15032.624184395478;15054.096754194565;15060.774088388684;6953.687084081229;7203.207647158808;7209.495335326582;7398.371138453184;7464.589447580435;6623.834404139935;6727.226368967534;6890.724371025203;6922.550034247758;6932.896006559906;4420.955790442119;4552.544745525487;4605.309203619484;4668.393108895822;4730.810767569327;1892.5555489010144;1905.3617038292327;1935.3516571948555;1953.599512100016;1961.4213806926991;820.5979070255531;872.7599910024794;892.2817132208635;912.9726108216764;1025.9384436933808;19173.233070677015;19337.613247734967;19376.4187074388;19471.707924381146;19808.523934508186;934.4253284230285;949.8480243161061;977.2035790830593;1011.5397494140149;1015.3653966271081;10221.642242521477;10676.199285053652;10902.72743181411;10937.289076210021;10940.288881222696;424278;425981;426489;431367;433049;90647.54676226576;92716;94406.52796735973;95103;97575;976.7899901521207;978.1881038737973;1011.2971484817981;1013.8175128476945;1019.5310157327564;12748;16363.918180409022;16681.83318166803;17033;17908.820911790714;41003;41382.79308603438;41901.371479427224;41986.79006604947;42408.78795606002;53160.468395315555;53855.73072134771;54288.45711542992;54330;54342.72828635832;7679.961600191963;7913.089994650689;8002.359811214972;8065.838683226185;8355.206255405727;10969.835452468378;12802.615921522369;13052.282124483245;13135.671608209872;13446.327683615977;11117.27737697047;11133.665990020312;11312.321260724053;11322.150838686966;11348.602798901999;11228.10175185967;11346.943265283951;11375.92271759261;11382.715432114263;11589.82615260755;11071.667849964513;11131.554737810397;11262.09903207725;11438.485268163118;11907.464164112462;7234.6020968847215;7288.927110728825;7539.32146106853;7713.997180366741;7900.525968441682;9933.503324833584;11011.779764404828;11352.943235284101;11498.022668072972;11507.309561426342 18:44:36 INFO - PROCESS | 9099 | |3;mootools.html;1386.7919812028194;1445.7903603977422;1556.3463345394932;1693.2465053051383;1762.6650936322098;7878.527288362702;8170.346372290217;8196.139405362426;8810.823783524334;8811.559422028897;8542.572871356422;8807.691730789424;8835.955820220906;9026.097390260971;9026.90973090269;2271.136967952176;2301.5166814968875;2317.918872839451;2317.9536409271805;2322.6632138339933;1970.9901450492728;2040.77551469339;2239.8208143348493;2295.3228797504776;2306.1928325086255;2164.9242276520326;2238.1159442020394;2241.1371621925514;2244.36035729817;2257.2776711452343;2281.566502364562;2302.9424264393356;2310.260716570698;2311.144876395736;2315.4211447138214;2187.2344679362254;2211.2936416588177;2225.499262665903;2228.353777404551;2231.0964059555745;8837.337199709984;9032.367734258605;9032.909670903273;9039.096090390974;9039.412438191497;5193.350831146106;5349.251104845324;5351.785928562853;5354.491323324278;5362.4637536246455;3088.7992280501694;3281.2289112058647;3308.2391050058623;3319.219983303946;3329.51722000311;981.6073570571829;1027.9640212592524;1034.3328553083295;1034.7051090439263;1036.5231993283098;12488.188267762656;12529.185602935871;12550.435230414654;12568.685782855411;12644.683882902817;4364.101615797138;4422.84520041797;4613.30800379939;4628.449469427712;4638.0491999140095;10531.894681053245;10554.788904222027;10556.26106172576;10556.683299501028;10567.410984308739;5330.866728331823;5331.546818520392;5345.091334473072;5345.893082138336;5354.223637572608;4713.198756211452;4829.5653391194255;4916.311716359713;4916.901661966741;4940.975295123501;3905.7851818150275;3920.313945059603;3967.722259441869;4044.3326851069833;4060.3503439449546;1149.5344385523877;1212.2362911365783;1296.857345691973;1301.3298151452009;1308.285307985933;838.5681374092347;855.4012191465998;870.4864130163234;878.5782824244399;885.7829831691276;5428.212909128154;5625.831225063254;5643.181738647873;5650.7739690412745;5904.7342869570975;944.2163004706215;984.6455276100598;997.481309718942;1026.810040142576;1071.4000159910474;3858.093348063203;3897.8440862365187;3969.4244334571326;3974.900627484336;3981.7411868228473;11067.446627668583;11453.312801231952;11483.196176267747;11500.654980350602;11504.769904602028;11339.262947908359;11339.489722962486;11369.829452558219;11371.488283027284;11389.37358445277;8135.75592732219;8268.338532917352;8287.295579875657;8330.375221858507;8390.874136887951;5627.465390787868;5668.348139963792;5688.914666279927;5760.884782304247;5921.585489015728;10001.849972250568;10118.392896426238;10206.387616743019;10290.485475726333;10370.792584148425;10108.595656173964;10241.283110182514;10368.118709909742;10576.101031412416;10578.735531611463;7235;7434.3309102181065;7509.586972716553;7663.923360766321;7696.037995250594;8301.294389976678;8368.581570921308;8371.497710137412;8423.241908228289;8440.07159212474;7235.529690570096;7239.167495738057;7301.817454563678;7346.302101300368;7411.4070874331;7231.963840180765;7321.926780732125;7385.9630701846145;7425.665845037094;7426.368758655359;6322.33615470369;6428.228612566522;6434.324395938359;6435.227772667123;6436.16329877113;4727.432708074915;4902.534259245366;4962.578180854668;5080.26336181259;5089.745512724275;5007.899842003212;5043.268726034631;5201.635885487979;5226.738663066907;5255.78976840922 18:44:36 INFO - PROCESS | 9099 | |4;prototype.html;315.4120441775233;326.5053444032291;327.9770416070876;331.4613752651941;335.3728527653288;5052.595792336604;5239.240310155025;5254.6847189168675;5301.231321458391;5302.575793936486;5098.9745051274695;5185.870353241171;5189.584833213344;5231;5238.8690282742955;4103.41484864535;4103.610157035077;4113.321301985169;4127.690423218256;4130.586941305868;3910.8435662573606;4110.362893751459;4123.422860712055;4158.480189976253;4178.895527611804;4076.1236334188293;4079.0822065035427;4090.6522945549664;4106.527749308823;4113.71204015719;4041.373587094005;4063.8780836574656;4080.81636326366;4081.795910204478;4098.6516146127615;3571.178628915338;3582.570091589026;3594.155373487228;3600.459931010343;3610;5030.748462576893;5064.848054558369;5082.415522214956;5089.6691715038405;5090.33825602673;4632.606228470584;4638.234691275936;4658.557437043475;4664.48404268614;4667.15991121598;5442.619016668835;5447.727613619303;5454.53636440903;5457.454254574551;5461.644993075477;3777.8085936726097;3896.610338966109;3902.375619900802;3913.66733827625;3920.980395098035;5605.523530499912;5605.635633683838;5620.353659329147;5629.915551266734;5661.631993920423;3971.940420893689;3973.8609148679657;4009.3384591542654;4035.5875443595096;4040.454538637305;3839.347310957144;4033.657139143147;4045.130296986162;4077.1845630873945;4086.693497987603;4642.860714178512;4648.86053418398;4655.37152484417;4659.627229821606;4661.370714953506;5491.341039075257;5526.115821468546;5534.588679886603;5545.528630066489;5565.1930470082425;1337.2110454831695;1360.333436616051;1363.4069179906771;1388.298909050923;1397.6086695725214;941.9784494189922;944.8204841080172;962.3600305796707;972.7276362618478;973.8247115519274;5191.819435836957;5235.73821308933;5241.50205730455;5259.921101183485;5276.36683597963;5558;5576.386597474275;5583.525400340935;5584.720763961785;5602.067286786052;5116.744162791845;5260.684358938476;5287.286216360819;5294.311739473844;5338.252644629755;3005.6844031376827;3015.5374643297982;3021.425929073469;3030.636323641133;3032.3177285110673;5845.707714614337;5856.355800861902;5871.7651293947765;5876.41235876409;5886.735096920649;5484.846213427295;5619.4099619540175;5634.211210430543;5644.604877658525;5742.799002034909;5690.687012214368;5734.913976290359;5747.827565173052;5755.424457554211;5770.451807078405;5341.145416733304;5551.639143455663;5564.527015203591;5638.830835074954;5641.830745077655;5491.28613280271;5495;5520.585956053232;5551.528120109674;5556.555475562026;5743.960893882779;5758.712064396847;5763.596548241583;5800.854978625568;5810.302763668218;3955.4024403561834;3976.58245884178;3988.1824226034173;4051.513818341818;4082.2243773682903;5307.310049693515;5496.780128794963;5519.586031047607;5526.972365138148;5533.833984980457;5371.5702743781185;5389.784408623768;5463.699496527729;5464.672119672832;5475.4524547544925;5471.917921231265;5472.671639701631;5476.72616369172;5526.198701188386;5533.667979921218;5239.773096433924;5445.863853403696;5448.645838020516;5473.863153421196;5487.560995120461;5494.862628434321;5496.6701997880255;5501.707098831691;5516.420775818481;5533.225348451139;5390.622656414013;5429.348478182644;5437.347518297672;5470.374220374322;5494.835154945358 18:44:36 INFO - PROCESS | 9099 | |5;yui.html;781.5896654256514;787.582581231947;794.4053159453474;802.8835818806277;804.6057431858384;15057.322420491077;15624.921875390635;16393.098379589148;16418.83581164188;16433.67132657346;14882.627934301621;14938.925305373485;15140.091594504338;15147.166905820175;15162.469313574027;802.1697543042952;817.448222449847;820.8604537228656;820.8809722590221;822.0587427395628;675.6959368284291;694.503430047516;798.3652995868299;817.8159914019328;821.40858581821;860.9870851937226;867.1761826265042;868.583080121542;868.6351732272461;872.4067634008871;862.2067697718114;862.4006315610653;863.0980625246601;863.2317237658489;863.6502216602255;512.1038183179436;528.1734086155155;631.1889222349305;632.6804963493406;633.293877326782;13132.409041593151;13547.661308467268;13626.523071692443;13963.58109256724;13991.370388332549;14752.852471475255;15697;15772.92113539425;15812.604684882856;15980.283351830216;11353.091752659768;11469.713257168554;11522;11634.941825290904;11651;3760.0787806987464;3891.7664940103687;4018.6985976051915;4018.9799051004557;4019.095703466726;75398.62300688462;77592;78109.60945195294;78154.21845781527;78164.60917695431;11559.479823407966;11657;11829.467673954692;12052.819207711891;12499.312537810325;22711.318660440214;22713.545729085658;22768.772312276997;22930.42673933165;23751;8094.51432914027;8146.429749917449;8149.877751833727;8249.257566818895;8472.915270847336;4358.171947329997;4381.058072514361;4398.604125628709;4488.685791994529;4688.929666055012;3745.9063523412133;3913.412988051758;3915.1973845362204;3920.4119382092344;3928.273269445162;519.92821391873;629.6348118091496;634.5843472525503;634.8063840528683;636.4303947966637;542.5822116969911;595.8599729063667;621.2669050520338;624.1106423346713;630.7918386932301;9269.397489163182;9956.850647240153;10053.949730251303;10160.237982151368;10211.285210035374;566.5977156219049;586.1647152807233;623.7785586116863;642.8296501427126;672.7779832655212;4077.347624380085;4672.2991551266905;4727.810887564528;4874.147024270738;5013.172826483662;112134;113678.43160784143;115720;117949.41025294819;118093;99548.50225748825;101732;102434;103100.48449757702;106320;65715.67142164354;85186.57406712927;85429.57285213534;85831.57084214539;86376;9170.724878253663;9463.668771592962;9547.801486501821;9571.808563828823;9647.517624118906;48694;49787.75106124446;49944.250836238214;50568.49431505785;52317;65749.67125164343;74035;74583.62708186424;75454.24545754472;77253;12088.15382923187;12192.634220973385;12195.634130976085;12364.752704946031;12466.569019041563;13199.736005279648;13305.80041299362;13390.17748891924;13734.862651373758;13774.449022039407;12683.175593586388;12688.365581721062;13003.739925201633;13648.112872663245;13684.863151368758;12209.511619535118;12346;12424.440900159696;12568.434420451285;12792.6801829955;12960.222386656831;13080.542181023618;13294.401751920994;13862.584122476343;13965.35211127815;9358.300687906492;9589.280803939593;9674.467904265333;9715.611375544899;9970.30207885441;8404.148278026212;9820.607175712892;9874.259430542881;10154.54304556282;10198.541065652213 18:44:36 INFO - PROCESS | 9099 | __end_tp_report 18:44:36 INFO - PROCESS | 9099 | __start_cc_report 18:44:36 INFO - PROCESS | 9099 | _x_x_mozilla_cycle_collect,1198 18:44:36 INFO - PROCESS | 9099 | __end_cc_report 18:44:36 INFO - PROCESS | 9099 | __startTimestamp1477359876468__endTimestamp 18:44:36 INFO - PROCESS | 9099 | 18:44:36 INFO - PROCESS | 9099 | ------- Summary: start ------- 18:44:36 INFO - PROCESS | 9099 | Number of tests: 6 18:44:36 INFO - PROCESS | 9099 | 18:44:36 INFO - PROCESS | 9099 | [#0] dojo.html Cycles:165 Average:5383.67 Median:5643.83 stddev:611.73 (10.8%) stddev-sans-first:585.69 18:44:36 INFO - PROCESS | 9099 | Values: 3054.7 3110.5 3113.0 3135.5 3165.0 5308.2 5376.9 5392.9 5473.8 5520.8 5394.8 5404.3 5409.0 5423.0 5432.9 4915.8 4929.1 4950.2 4972.1 4989.2 4907.9 4916.7 4961.9 5062.9 5073.2 4936.4 4940.0 4949.4 4952.2 5008.8 4986.9 4990.8 5004.9 5006.3 5065.8 4833.6 4843.1 4887.7 4914.4 4966.6 5339.7 5352.7 5359.1 5359.9 5452.3 5756.3 5763.4 5763.9 5764.7 5766.7 5668.5 5737.6 5743.8 5816.7 5825.5 5327.2 5376.0 5379.8 5380.7 5381.2 5860.9 5874.5 5876.4 5878.8 5944.1 5742.5 5796.0 5810.3 5870.6 5877.0 5883.6 5887.3 5892.0 5898.4 5899.9 5686.3 5724.5 5872.4 5875.5 5879.6 5724.6 5776.2 5779.1 5788.7 5855.1 4411.2 4417.3 4419.7 4421.2 4470.6 3902.9 3915.6 3917.3 3918.9 3994.7 5408.9 5410.4 5454.4 5483.0 5558.6 5757.2 5760.5 5773.3 5776.5 5792.9 5360.2 5362.7 5372.6 5377.7 5431.3 4963.3 4968.1 4970.1 4973.7 5030.9 5734.1 5801.7 5875.6 5908.9 5910.8 5796.8 5800.5 5802.6 5804.4 5859.0 5903.7 5942.1 5961.1 5968.3 5970.7 5608.6 5658.2 5663.8 5673.8 5739.8 5810.7 5837.2 5854.3 5916.6 5916.7 5680.4 5680.7 5688.9 5691.7 5711.7 5437.4 5526.1 5698.0 5707.9 5711.5 5621.6 5692.3 5701.8 5710.2 5715.4 5758.5 5763.0 5763.4 5766.2 5770.5 5428.8 5632.2 5641.3 5643.8 5715.5 18:44:36 INFO - PROCESS | 9099 | 18:44:36 INFO - PROCESS | 9099 | [#1] ext.html Cycles:180 Average:56040.23 Median:397317.00 stddev:107318.62 (27.0%) stddev-sans-first:107538.85 18:44:36 INFO - PROCESS | 9099 | Values: 565.6 577.2 615.6 617.9 644.0 31958.5 35121.0 35138.3 35139.0 35225.5 35793.6 43669.8 44884.6 44971.8 47548.5 8787.5 8898.3 8906.2 8913.7 8923.5 8919.2 8991.6 9015.7 9017.5 9021.4 9003.5 9041.4 9044.2 9044.7 9047.9 8995.6 9000.2 9016.5 9054.8 9065.7 8881.6 8976.8 8977.2 8981.9 8985.0 41732.8 42034.4 42111.8 42127.6 42169.4 3226.8 3261.2 3332.9 3473.8 3910.9 32014.2 32419.0 32434.7 32952.3 33317.7 4066.2 4193.6 4200.1 4200.6 4259.6 329774.0 334338.0 334367.0 334413.0 335802.0 58386.7 58747.7 58781.1 58855.4 58875.4 35654.3 36572.3 36606.5 38030.2 62258.4 14636.8 14820.3 14839.3 14875.9 14881.6 11335.8 11408.7 11428.3 11458.5 11461.7 19189.7 19190.7 19243.9 19285.5 19426.4 6919.8 6951.0 7250.6 7282.6 7351.2 868.7 1010.8 1051.3 1089.8 1125.7 31829.2 31979.0 32326.4 32792.5 32925.0 1000.7 1008.2 1077.0 1096.1 1165.2 15860.6 16724.5 16801.0 16842.4 16985.0 471428.0 475087.0 475812.0 477083.0 477988.0 56633.2 57300.4 57331.1 57349.0 57405.7 1267.1 1280.7 1282.4 1286.7 1288.2 29638.9 31242.4 31351.8 31433.5 32060.0 50993.2 51461.0 51502.2 51540.5 51597.5 393156.0 396426.0 397024.0 397610.0 398395.0 27333.9 27975.7 28052.0 28464.4 28469.7 46951.3 47770.5 48066.4 48149.5 48173.3 37512.4 40284.6 40686.8 40866.0 41854.0 39634.6 40252.6 40937.6 41655.6 42122.6 31981.7 35549.1 39897.8 42552.8 42683.6 34048.7 36324.5 37292.6 37314.0 37562.2 27438.6 28098.2 28167.3 29583.7 29598.4 18:44:36 INFO - PROCESS | 9099 | 18:44:36 INFO - PROCESS | 9099 | [#2] jquery.html Cycles:180 Average:26363.65 Median:2093.62 stddev:70902.13 (3386.6%) stddev-sans-first:71074.16 18:44:36 INFO - PROCESS | 9099 | Values: 364.4 369.4 384.8 385.0 407.7 13953.2 14590.0 18375.0 18423.9 18430.9 18003.4 18937.1 18977.6 19603.9 19698.7 3802.4 5176.1 5325.2 5329.1 5333.4 4059.9 5541.3 5757.2 5811.2 5904.5 5892.8 5893.6 5902.7 5950.4 6379.3 6412.6 6421.3 6445.8 6453.6 6456.6 4886.1 5151.3 5185.3 5214.6 5725.7 10697.7 10779.9 10782.8 10813.9 20995.0 2158.4 2207.4 2379.3 2844.5 2930.9 9866.4 10416.7 10536.4 11114.0 14772.1 1874.2 1924.7 1952.2 1963.0 1976.8 53749.5 65732.4 72879.0 73173.3 82649.6 9858.8 10190.7 10719.7 10731.8 10833.8 14911.5 14984.2 15032.6 15054.1 15060.8 6953.7 7203.2 7209.5 7398.4 7464.6 6623.8 6727.2 6890.7 6922.6 6932.9 4421.0 4552.5 4605.3 4668.4 4730.8 1892.6 1905.4 1935.4 1953.6 1961.4 820.6 872.8 892.3 913.0 1025.9 19173.2 19337.6 19376.4 19471.7 19808.5 934.4 949.8 977.2 1011.5 1015.4 10221.6 10676.2 10902.7 10937.3 10940.3 424278.0 425981.0 426489.0 431367.0 433049.0 90647.5 92716.0 94406.5 95103.0 97575.0 976.8 978.2 1011.3 1013.8 1019.5 12748.0 16363.9 16681.8 17033.0 17908.8 41003.0 41382.8 41901.4 41986.8 42408.8 53160.5 53855.7 54288.5 54330.0 54342.7 7680.0 7913.1 8002.4 8065.8 8355.2 10969.8 12802.6 13052.3 13135.7 13446.3 11117.3 11133.7 11312.3 11322.2 11348.6 11228.1 11346.9 11375.9 11382.7 11589.8 11071.7 11131.6 11262.1 11438.5 11907.5 7234.6 7288.9 7539.3 7714.0 7900.5 9933.5 11011.8 11352.9 11498.0 11507.3 18:44:36 INFO - PROCESS | 9099 | 18:44:36 INFO - PROCESS | 9099 | [#3] mootools.html Cycles:180 Average:5766.10 Median:4675.62 stddev:3373.42 (72.1%) stddev-sans-first:3366.83 18:44:36 INFO - PROCESS | 9099 | Values: 1386.8 1445.8 1556.3 1693.2 1762.7 7878.5 8170.3 8196.1 8810.8 8811.6 8542.6 8807.7 8836.0 9026.1 9026.9 2271.1 2301.5 2317.9 2318.0 2322.7 1971.0 2040.8 2239.8 2295.3 2306.2 2164.9 2238.1 2241.1 2244.4 2257.3 2281.6 2302.9 2310.3 2311.1 2315.4 2187.2 2211.3 2225.5 2228.4 2231.1 8837.3 9032.4 9032.9 9039.1 9039.4 5193.4 5349.3 5351.8 5354.5 5362.5 3088.8 3281.2 3308.2 3319.2 3329.5 981.6 1028.0 1034.3 1034.7 1036.5 12488.2 12529.2 12550.4 12568.7 12644.7 4364.1 4422.8 4613.3 4628.4 4638.0 10531.9 10554.8 10556.3 10556.7 10567.4 5330.9 5331.5 5345.1 5345.9 5354.2 4713.2 4829.6 4916.3 4916.9 4941.0 3905.8 3920.3 3967.7 4044.3 4060.4 1149.5 1212.2 1296.9 1301.3 1308.3 838.6 855.4 870.5 878.6 885.8 5428.2 5625.8 5643.2 5650.8 5904.7 944.2 984.6 997.5 1026.8 1071.4 3858.1 3897.8 3969.4 3974.9 3981.7 11067.4 11453.3 11483.2 11500.7 11504.8 11339.3 11339.5 11369.8 11371.5 11389.4 8135.8 8268.3 8287.3 8330.4 8390.9 5627.5 5668.3 5688.9 5760.9 5921.6 10001.8 10118.4 10206.4 10290.5 10370.8 10108.6 10241.3 10368.1 10576.1 10578.7 7235.0 7434.3 7509.6 7663.9 7696.0 8301.3 8368.6 8371.5 8423.2 8440.1 7235.5 7239.2 7301.8 7346.3 7411.4 7232.0 7321.9 7386.0 7425.7 7426.4 6322.3 6428.2 6434.3 6435.2 6436.2 4727.4 4902.5 4962.6 5080.3 5089.7 5007.9 5043.3 5201.6 5226.7 5255.8 18:44:36 INFO - PROCESS | 9099 | 18:44:36 INFO - PROCESS | 9099 | [#4] prototype.html Cycles:180 Average:4608.55 Median:5281.83 stddev:1348.59 (25.5%) stddev-sans-first:1313.31 18:44:36 INFO - PROCESS | 9099 | Values: 315.4 326.5 328.0 331.5 335.4 5052.6 5239.2 5254.7 5301.2 5302.6 5099.0 5185.9 5189.6 5231.0 5238.9 4103.4 4103.6 4113.3 4127.7 4130.6 3910.8 4110.4 4123.4 4158.5 4178.9 4076.1 4079.1 4090.7 4106.5 4113.7 4041.4 4063.9 4080.8 4081.8 4098.7 3571.2 3582.6 3594.2 3600.5 3610.0 5030.7 5064.8 5082.4 5089.7 5090.3 4632.6 4638.2 4658.6 4664.5 4667.2 5442.6 5447.7 5454.5 5457.5 5461.6 3777.8 3896.6 3902.4 3913.7 3921.0 5605.5 5605.6 5620.4 5629.9 5661.6 3971.9 3973.9 4009.3 4035.6 4040.5 3839.3 4033.7 4045.1 4077.2 4086.7 4642.9 4648.9 4655.4 4659.6 4661.4 5491.3 5526.1 5534.6 5545.5 5565.2 1337.2 1360.3 1363.4 1388.3 1397.6 942.0 944.8 962.4 972.7 973.8 5191.8 5235.7 5241.5 5259.9 5276.4 5558.0 5576.4 5583.5 5584.7 5602.1 5116.7 5260.7 5287.3 5294.3 5338.3 3005.7 3015.5 3021.4 3030.6 3032.3 5845.7 5856.4 5871.8 5876.4 5886.7 5484.8 5619.4 5634.2 5644.6 5742.8 5690.7 5734.9 5747.8 5755.4 5770.5 5341.1 5551.6 5564.5 5638.8 5641.8 5491.3 5495.0 5520.6 5551.5 5556.6 5744.0 5758.7 5763.6 5800.9 5810.3 3955.4 3976.6 3988.2 4051.5 4082.2 5307.3 5496.8 5519.6 5527.0 5533.8 5371.6 5389.8 5463.7 5464.7 5475.5 5471.9 5472.7 5476.7 5526.2 5533.7 5239.8 5445.9 5448.6 5473.9 5487.6 5494.9 5496.7 5501.7 5516.4 5533.2 5390.6 5429.3 5437.3 5470.4 5494.8 18:44:36 INFO - PROCESS | 9099 | 18:44:36 INFO - PROCESS | 9099 | [#5] yui.html Cycles:180 Average:20638.41 Median:4708.37 stddev:30041.44 (638.0%) stddev-sans-first:30088.71 18:44:36 INFO - PROCESS | 9099 | Values: 781.6 787.6 794.4 802.9 804.6 15057.3 15624.9 16393.1 16418.8 16433.7 14882.6 14938.9 15140.1 15147.2 15162.5 802.2 817.4 820.9 820.9 822.1 675.7 694.5 798.4 817.8 821.4 861.0 867.2 868.6 868.6 872.4 862.2 862.4 863.1 863.2 863.7 512.1 528.2 631.2 632.7 633.3 13132.4 13547.7 13626.5 13963.6 13991.4 14752.9 15697.0 15772.9 15812.6 15980.3 11353.1 11469.7 11522.0 11634.9 11651.0 3760.1 3891.8 4018.7 4019.0 4019.1 75398.6 77592.0 78109.6 78154.2 78164.6 11559.5 11657.0 11829.5 12052.8 12499.3 22711.3 22713.5 22768.8 22930.4 23751.0 8094.5 8146.4 8149.9 8249.3 8472.9 4358.2 4381.1 4398.6 4488.7 4688.9 3745.9 3913.4 3915.2 3920.4 3928.3 519.9 629.6 634.6 634.8 636.4 542.6 595.9 621.3 624.1 630.8 9269.4 9956.9 10053.9 10160.2 10211.3 566.6 586.2 623.8 642.8 672.8 4077.3 4672.3 4727.8 4874.1 5013.2 112134.0 113678.4 115720.0 117949.4 118093.0 99548.5 101732.0 102434.0 103100.5 106320.0 65715.7 85186.6 85429.6 85831.6 86376.0 9170.7 9463.7 9547.8 9571.8 9647.5 48694.0 49787.8 49944.3 50568.5 52317.0 65749.7 74035.0 74583.6 75454.2 77253.0 12088.2 12192.6 12195.6 12364.8 12466.6 13199.7 13305.8 13390.2 13734.9 13774.4 12683.2 12688.4 13003.7 13648.1 13684.9 12209.5 12346.0 12424.4 12568.4 12792.7 12960.2 13080.5 13294.4 13862.6 13965.4 9358.3 9589.3 9674.5 9715.6 9970.3 8404.1 9820.6 9874.3 10154.5 10198.5 18:44:36 INFO - PROCESS | 9099 | -------- Summary: end -------- 18:44:36 INFO - PROCESS | 9099 | 18:44:37 INFO - TEST-INFO | 9099: exit 0 18:44:37 INFO - TEST-OK | dromaeo_css | took 1118974ms 18:44:37 INFO - TEST-START | kraken 18:44:37 INFO - operating with platform_type : linux_ 18:44:37 INFO - Initialising browser for kraken test... 18:44:37 INFO - TEST-INFO | started process 9413 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKT2xtg/profile http://localhost:51734/getInfo.html) 18:44:41 INFO - PROCESS | 9413 | __metrics Screen width/height:1600/1200 18:44:41 INFO - PROCESS | 9413 | colorDepth:24 18:44:41 INFO - PROCESS | 9413 | Browser inner width/height: 1024/697 18:44:41 INFO - PROCESS | 9413 | __metrics 18:44:42 INFO - PROCESS | 9413 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:44:42 INFO - PROCESS | 9413 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:44:43 INFO - PROCESS | 9413 | console.error: PushService: 18:44:43 INFO - PROCESS | 9413 | stateChangeProcessEnqueue: Error transitioning state 18:44:43 INFO - PROCESS | 9413 | UnknownError 18:44:43 INFO - TEST-INFO | 9413: exit 0 18:44:43 INFO - Browser initialized. 18:44:43 INFO - Running cycle 1/1 for kraken test... 18:44:43 INFO - TEST-INFO | started process 9496 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKT2xtg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:44:56 INFO - PROCESS | 9496 | RSS: Main: 172650496 18:44:56 INFO - PROCESS | 9496 | 18:44:58 INFO - PROCESS | 9496 | Cycle 1(1): loaded http://localhost:51734/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51734/tests/kraken/driver.html?testName=audio-beat-detection) 18:44:59 INFO - PROCESS | 9496 | RSS: Main: 229445632 18:44:59 INFO - PROCESS | 9496 | 18:45:02 INFO - PROCESS | 9496 | Cycle 1(1): loaded http://localhost:51734/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51734/tests/kraken/driver.html?testName=audio-dft) 18:45:02 INFO - PROCESS | 9496 | RSS: Main: 216498176 18:45:02 INFO - PROCESS | 9496 | 18:45:05 INFO - PROCESS | 9496 | Cycle 1(1): loaded http://localhost:51734/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51734/tests/kraken/driver.html?testName=audio-fft) 18:45:06 INFO - PROCESS | 9496 | RSS: Main: 298196992 18:45:06 INFO - PROCESS | 9496 | 18:45:08 INFO - PROCESS | 9496 | Cycle 1(1): loaded http://localhost:51734/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51734/tests/kraken/driver.html?testName=audio-oscillator) 18:45:09 INFO - PROCESS | 9496 | RSS: Main: 207515648 18:45:09 INFO - PROCESS | 9496 | 18:45:11 INFO - PROCESS | 9496 | Cycle 1(1): loaded http://localhost:51734/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51734/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:45:11 INFO - PROCESS | 9496 | RSS: Main: 211906560 18:45:11 INFO - PROCESS | 9496 | 18:45:14 INFO - PROCESS | 9496 | Cycle 1(1): loaded http://localhost:51734/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51734/tests/kraken/driver.html?testName=imaging-darkroom) 18:45:15 INFO - PROCESS | 9496 | RSS: Main: 248471552 18:45:15 INFO - PROCESS | 9496 | 18:45:18 INFO - PROCESS | 9496 | Cycle 1(1): loaded http://localhost:51734/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51734/tests/kraken/driver.html?testName=imaging-desaturate) 18:45:19 INFO - PROCESS | 9496 | RSS: Main: 247803904 18:45:19 INFO - PROCESS | 9496 | 18:45:22 INFO - PROCESS | 9496 | Cycle 1(1): loaded http://localhost:51734/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51734/tests/kraken/driver.html?testName=json-parse-financial) 18:45:22 INFO - PROCESS | 9496 | RSS: Main: 246575104 18:45:22 INFO - PROCESS | 9496 | 18:45:24 INFO - PROCESS | 9496 | Cycle 1(1): loaded http://localhost:51734/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51734/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:45:24 INFO - PROCESS | 9496 | RSS: Main: 208658432 18:45:24 INFO - PROCESS | 9496 | 18:45:26 INFO - PROCESS | 9496 | Cycle 1(1): loaded http://localhost:51734/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51734/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:45:27 INFO - PROCESS | 9496 | RSS: Main: 216465408 18:45:27 INFO - PROCESS | 9496 | 18:45:29 INFO - PROCESS | 9496 | Cycle 1(1): loaded http://localhost:51734/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51734/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:45:29 INFO - PROCESS | 9496 | RSS: Main: 225832960 18:45:29 INFO - PROCESS | 9496 | 18:45:32 INFO - PROCESS | 9496 | Cycle 1(1): loaded http://localhost:51734/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51734/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:45:33 INFO - PROCESS | 9496 | RSS: Main: 229453824 18:45:33 INFO - PROCESS | 9496 | 18:45:35 INFO - PROCESS | 9496 | Cycle 1(1): loaded http://localhost:51734/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51734/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:45:36 INFO - PROCESS | 9496 | RSS: Main: 231456768 18:45:36 INFO - PROCESS | 9496 | 18:45:38 INFO - PROCESS | 9496 | Cycle 1(1): loaded http://localhost:51734/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51734/tests/kraken/driver.html?testName=ai-astar) 18:45:38 INFO - PROCESS | 9496 | RSS: Main: 282243072 18:45:38 INFO - PROCESS | 9496 | 18:45:38 INFO - PROCESS | 9496 | __start_tp_report 18:45:38 INFO - PROCESS | 9496 | _x_x_mozilla_page_load 18:45:38 INFO - PROCESS | 9496 | _x_x_mozilla_page_load_details 18:45:38 INFO - PROCESS | 9496 | |i|pagename|runs| 18:45:38 INFO - PROCESS | 9496 | |0;ai-astar;104;112;113;111;112;112;113;113;114;111 18:45:38 INFO - PROCESS | 9496 | |1;audio-beat-detection;150;123;122;168;132;122;120;126;162;129 18:45:38 INFO - PROCESS | 9496 | |2;audio-dft;163;161;163;162;163;163;164;162;161;162 18:45:38 INFO - PROCESS | 9496 | |3;audio-fft;75;76;76;114;75;81;75;75;105;74 18:45:38 INFO - PROCESS | 9496 | |4;audio-oscillator;85;84;115;83;83;84;107;83;82;115 18:45:38 INFO - PROCESS | 9496 | |5;imaging-gaussian-blur;116;117;116;116;117;117;117;117;117;117 18:45:38 INFO - PROCESS | 9496 | |6;imaging-darkroom;145;147;146;146;146;147;147;146;146;146 18:45:38 INFO - PROCESS | 9496 | |7;imaging-desaturate;84;84;84;86;85;85;84;84;84;84 18:45:38 INFO - PROCESS | 9496 | |8;json-parse-financial;52;60;52;53;54;52;54;53;53;53 18:45:38 INFO - PROCESS | 9496 | |9;json-stringify-tinderbox;59;60;58;59;60;59;59;60;59;60 18:45:38 INFO - PROCESS | 9496 | |10;stanford-crypto-aes;81;81;89;84;81;87;80;79;85;79 18:45:38 INFO - PROCESS | 9496 | |11;stanford-crypto-ccm;134;135;132;130;131;134;132;138;186;145 18:45:38 INFO - PROCESS | 9496 | |12;stanford-crypto-pbkdf2;167;168;170;170;166;176;168;168;167;166 18:45:38 INFO - PROCESS | 9496 | |13;stanford-crypto-sha256-iterative;66;66;66;65;65;67;66;65;73;65 18:45:38 INFO - PROCESS | 9496 | __end_tp_report 18:45:38 INFO - PROCESS | 9496 | __start_cc_report 18:45:38 INFO - PROCESS | 9496 | _x_x_mozilla_cycle_collect,1699 18:45:38 INFO - PROCESS | 9496 | __end_cc_report 18:45:38 INFO - PROCESS | 9496 | __startTimestamp1477359938524__endTimestamp 18:45:38 INFO - PROCESS | 9496 | 18:45:38 INFO - PROCESS | 9496 | ------- Summary: start ------- 18:45:38 INFO - PROCESS | 9496 | Number of tests: 14 18:45:38 INFO - PROCESS | 9496 | 18:45:38 INFO - PROCESS | 9496 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.50 stddev:2.80 (2.5%) stddev-sans-first:1.00 18:45:38 INFO - PROCESS | 9496 | Values: 104.0 112.0 113.0 111.0 112.0 112.0 113.0 113.0 114.0 111.0 18:45:38 INFO - PROCESS | 9496 | 18:45:38 INFO - PROCESS | 9496 | [#1] audio-beat-detection Cycles:10 Average:135.40 Median:130.50 stddev:17.87 (13.7%) stddev-sans-first:18.16 18:45:38 INFO - PROCESS | 9496 | Values: 150.0 123.0 122.0 168.0 132.0 122.0 120.0 126.0 162.0 129.0 18:45:38 INFO - PROCESS | 9496 | 18:45:38 INFO - PROCESS | 9496 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 18:45:38 INFO - PROCESS | 9496 | Values: 163.0 161.0 163.0 162.0 163.0 163.0 164.0 162.0 161.0 162.0 18:45:38 INFO - PROCESS | 9496 | 18:45:38 INFO - PROCESS | 9496 | [#3] audio-fft Cycles:10 Average:82.60 Median:75.00 stddev:14.46 (19.3%) stddev-sans-first:15.08 18:45:38 INFO - PROCESS | 9496 | Values: 75.0 76.0 76.0 114.0 75.0 81.0 75.0 75.0 105.0 74.0 18:45:38 INFO - PROCESS | 9496 | 18:45:38 INFO - PROCESS | 9496 | [#4] audio-oscillator Cycles:10 Average:92.10 Median:83.00 stddev:14.15 (17.1%) stddev-sans-first:14.78 18:45:38 INFO - PROCESS | 9496 | Values: 85.0 84.0 115.0 83.0 83.0 84.0 107.0 83.0 82.0 115.0 18:45:38 INFO - PROCESS | 9496 | 18:45:38 INFO - PROCESS | 9496 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 18:45:38 INFO - PROCESS | 9496 | Values: 116.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 18:45:38 INFO - PROCESS | 9496 | 18:45:38 INFO - PROCESS | 9496 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 18:45:38 INFO - PROCESS | 9496 | Values: 145.0 147.0 146.0 146.0 146.0 147.0 147.0 146.0 146.0 146.0 18:45:38 INFO - PROCESS | 9496 | 18:45:38 INFO - PROCESS | 9496 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.00 stddev:0.70 (0.8%) stddev-sans-first:0.73 18:45:38 INFO - PROCESS | 9496 | Values: 84.0 84.0 84.0 86.0 85.0 85.0 84.0 84.0 84.0 84.0 18:45:38 INFO - PROCESS | 9496 | 18:45:38 INFO - PROCESS | 9496 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:53.00 stddev:2.37 (4.5%) stddev-sans-first:2.44 18:45:38 INFO - PROCESS | 9496 | Values: 52.0 60.0 52.0 53.0 54.0 52.0 54.0 53.0 53.0 53.0 18:45:38 INFO - PROCESS | 9496 | 18:45:38 INFO - PROCESS | 9496 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.50 stddev:0.67 (1.1%) stddev-sans-first:0.71 18:45:38 INFO - PROCESS | 9496 | Values: 59.0 60.0 58.0 59.0 60.0 59.0 59.0 60.0 59.0 60.0 18:45:38 INFO - PROCESS | 9496 | 18:45:38 INFO - PROCESS | 9496 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:82.50 stddev:3.47 (4.2%) stddev-sans-first:3.63 18:45:38 INFO - PROCESS | 9496 | Values: 81.0 81.0 89.0 84.0 81.0 87.0 80.0 79.0 85.0 79.0 18:45:38 INFO - PROCESS | 9496 | 18:45:38 INFO - PROCESS | 9496 | [#11] stanford-crypto-ccm Cycles:10 Average:139.70 Median:134.50 stddev:16.83 (12.5%) stddev-sans-first:17.73 18:45:38 INFO - PROCESS | 9496 | Values: 134.0 135.0 132.0 130.0 131.0 134.0 132.0 138.0 186.0 145.0 18:45:38 INFO - PROCESS | 9496 | 18:45:38 INFO - PROCESS | 9496 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.60 Median:168.00 stddev:2.95 (1.8%) stddev-sans-first:3.07 18:45:38 INFO - PROCESS | 9496 | Values: 167.0 168.0 170.0 170.0 166.0 176.0 168.0 168.0 167.0 166.0 18:45:38 INFO - PROCESS | 9496 | 18:45:38 INFO - PROCESS | 9496 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.00 stddev:2.41 (3.7%) stddev-sans-first:2.55 18:45:38 INFO - PROCESS | 9496 | Values: 66.0 66.0 66.0 65.0 65.0 67.0 66.0 65.0 73.0 65.0 18:45:38 INFO - PROCESS | 9496 | -------- Summary: end -------- 18:45:38 INFO - PROCESS | 9496 | 18:45:39 INFO - TEST-INFO | 9496: exit 0 18:45:39 INFO - TEST-OK | kraken | took 62419ms 18:45:39 INFO - SUITE-END | took 1181s 18:45:40 INFO - Completed test suite (00:19:41) 18:45:40 INFO - javascript benchmark 18:45:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3054.6945305469458, 3110.502319628861, 3113.0193988893498, 3135.4983202687577, 3165.0346644273486, 5308.23030660554, 5376.946230537694, 5392.91910621341, 5473.78104875805, 5520.751566179517, 5394.757235924383, 5404.270423492827, 5409.0, 5423.0, 5432.945670543293, 4915.778789954452, 4929.137400954836, 4950.207966725325, 4972.129877271481, 4989.2017277235645, 4907.8773030674165, 4916.655834091615, 4961.900761984758, 5062.924056139161, 5073.239014147889, 4936.407631084275, 4939.950600494003, 4949.430815456215, 4952.232403977389, 5008.799648014094, 4986.925196122061, 4990.82532111378, 5004.924926126111, 5006.3241462402475, 5065.797368105272, 4833.63747718919, 4843.128236917353, 4887.682300650446, 4914.434839993375, 4966.5778408835295, 5339.733013349317, 5352.652077614982, 5359.1425371940695, 5359.919601205946, 5452.345718513764, 5756.251687280626, 5763.366029736726, 5763.88472230553, 5764.74058667361, 5766.682832444214, 5668.489835914787, 5737.569682273846, 5743.770249190027, 5816.738246778905, 5825.533957283407, 5327.200919862052, 5376.0, 5379.78480860769, 5380.704061276668, 5381.219723140122, 5860.853478663067, 5874.50066744323, 5876.382979787061, 5878.794242201502, 5944.108383742473, 5742.511886489611, 5796.014677504834, 5810.302763668386, 5870.559708021916, 5877.0, 5883.588148829626, 5887.322957859901, 5891.970540147272, 5898.439648233411, 5899.911501327398, 5686.317641883001, 5724.542036637143, 5872.442117998783, 5875.471207591338, 5879.647221166743, 5724.627899186539, 5776.1624564437925, 5779.075347944308, 5788.652680839163, 5855.063189889597, 4411.18393097278, 4417.315316126005, 4419.690621656518, 4421.204183247047, 4470.642348612103, 3902.921941561153, 3915.647591716759, 3917.275304068756, 3918.921621567553, 3994.6604538614542, 5408.945910540844, 5410.3507579090765, 5454.427285135083, 5482.972585137049, 5558.610897237236, 5757.165211044375, 5760.51035661965, 5773.278340207474, 5776.537876969833, 5792.913106303409, 5360.195970604363, 5362.731863406814, 5372.597055220874, 5377.650452720561, 5431.293931788921, 4963.280324352949, 4968.080905032581, 4970.105381031449, 4973.651844370859, 5030.924536131961, 5734.05388110957, 5801.7389217485315, 5875.559333050124, 5908.940910590925, 5910.822675319747, 5796.82609521715, 5800.535957123504, 5802.593818432838, 5804.361520232856, 5858.970705146447, 5903.675297858659, 5942.108683697307, 5961.076033214858, 5968.343482216866, 5970.671613061323, 5608.6073974821375, 5658.236138121466, 5663.830085097454, 5673.801416950387, 5739.770409183586, 5810.6513609183585, 5837.241158649518, 5854.326752423355, 5916.55625828056, 5916.674582897982, 5680.375158732619, 5680.7443665036, 5688.857778555569, 5691.686957217393, 5711.7429715662065, 5437.429069947599, 5526.143447765603, 5698.031334673033, 5707.914381284367, 5711.457411545896, 5621.606487545832, 5692.2600061993335, 5701.828945131652, 5710.172025056427, 5715.371309155907, 5758.539316854558, 5763.0, 5763.394843541536, 5766.221560089334, 5770.5095066919785, 5428.809991650273, 5632.239647647515, 5641.323041235078, 5643.830685079454, 5715.51418129447], "value": 5342.036022849639, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.593552430917, 577.2149876168412, 615.6121643364679, 617.9073139029142, 643.9710213040413, 31958.520622190685, 35121.0, 35138.29723405534, 35139.0, 35225.47161792572, 35793.642063579355, 43669.78165109178, 44884.55115448844, 44971.77514112425, 47548.52451475484, 8787.516686582252, 8898.288136949028, 8906.198442140207, 8913.68802091927, 8923.464592124461, 8919.152680495376, 8991.640334386617, 9015.684451044215, 9017.45895246284, 9021.413608115485, 9003.549822508881, 9041.3671043027, 9044.186023257906, 9044.683436079738, 9047.909520904772, 8995.55022248885, 9000.189982901538, 9016.459012459274, 9054.773630659252, 9065.728028159167, 8881.555922203928, 8976.775580610472, 8977.192052715222, 8981.865272020925, 8985.0, 41732.79133604343, 42034.369484457755, 42111.789441052904, 42127.57872421298, 42169.36745948813, 3226.838658067087, 3261.2010057536054, 3332.900012999614, 3473.774204676688, 3910.921781564353, 32014.199645009063, 32419.027429177164, 32434.6756532434, 32952.34095318104, 33317.666823331696, 4066.1867626474823, 4193.601607847249, 4200.05498762779, 4200.579942005775, 4259.595338442843, 329774.0, 334338.0, 334367.0, 334413.0, 335802.0, 58386.70166229222, 58747.70626146842, 58781.118283225784, 58855.411445884994, 58875.41124588785, 35654.28691426209, 36572.26855462876, 36606.45090323647, 38030.23939521194, 62258.37741622526, 14636.780448293284, 14820.3330850112, 14839.258037098101, 14875.925620372045, 14881.553553393416, 11335.829962550568, 11408.657740267805, 11428.314301141958, 11458.541658333574, 11461.713457163638, 19189.682321477554, 19190.712139317922, 19243.903780481007, 19285.51786205328, 19426.4172074838, 6919.757808476679, 6950.965245173843, 7250.6374681265725, 7282.599457029914, 7351.154617219088, 868.674247157316, 1010.777628921636, 1051.321897376188, 1089.7711480589007, 1125.6566747142037, 31829.20426989344, 31979.040628781175, 32326.35347293041, 32792.50811237833, 32925.0, 1000.7240768020831, 1008.1531513528671, 1076.967690969272, 1096.1121491591678, 1165.1901928160016, 15860.603484912739, 16724.49826505207, 16801.0, 16842.410515631895, 16985.0350370165, 471428.0, 475087.0, 475812.0, 477083.0, 477988.0, 56633.150502741664, 57300.42699573034, 57331.14003289954, 57349.0, 57405.712971435714, 1267.1193520503346, 1280.699035726585, 1282.3972732815562, 1286.7233544787728, 1288.2077522323702, 29638.851805741695, 31242.375152497276, 31351.84324078365, 31433.52849707302, 32060.0, 50993.23510147425, 51461.0, 51502.22746658728, 51540.48459515357, 51597.48402515927, 393156.0, 396426.0, 397024.0, 397610.0, 398395.0, 27333.86333068322, 27975.72024279731, 28052.0, 28464.43071138607, 28469.715302846707, 46951.29573056338, 47770.52229477661, 48066.35635039966, 48149.51850481451, 48173.27740083831, 37512.43731344087, 40284.59715402809, 40686.79656601698, 40866.0, 41854.0, 39634.603653964245, 40252.59747402606, 40937.59062409457, 41655.58344416517, 42122.57877421186, 31981.6801831988, 35549.111272218404, 39897.80051099726, 42552.78723606486, 42683.57316426796, 34048.65951340455, 36324.455133172494, 37292.627073728916, 37314.0, 37562.24875502529, 27438.5884211733, 28098.157055288375, 28167.295817604725, 29583.668734907413, 29598.408031839674], "value": 19408.565945808885, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.38237187966394, 369.44767572479145, 384.84606157536984, 384.97690138591685, 407.7390470099137, 13953.162810231393, 14590.0, 18375.0, 18423.907880460578, 18430.90784546077, 18003.369882054132, 18937.147828347723, 18977.620447591038, 19603.901980490078, 19698.70451943222, 3802.391617341226, 5176.094183517879, 5325.174597937326, 5329.067413202674, 5333.413324534298, 4059.8985025374454, 5541.251930989325, 5757.222774925373, 5811.215485909412, 5904.527637788967, 5892.764289428439, 5893.58744887858, 5902.675352855591, 5950.404959504037, 6379.330170332118, 6412.551121421502, 6421.261554921197, 6445.806625801233, 6453.580517266362, 6456.612603243797, 4886.1204983103025, 5151.330327057459, 5185.274061631375, 5214.556762675177, 5725.713714314309, 10697.732556686067, 10779.892201077968, 10782.784344313148, 10813.945930270376, 20995.0, 2158.4495953531905, 2207.3819330587303, 2379.2862141357696, 2844.48799216141, 2930.912072637824, 9866.358686685415, 10416.739581510446, 10536.367817930948, 11114.0, 14772.113673179536, 1874.240932422371, 1924.7497825282765, 1952.248384372027, 1963.0, 1976.7529058867642, 53749.46250537484, 65732.35005111598, 72879.0, 73173.26826731718, 82649.58675206585, 9858.80282394348, 10190.745231369276, 10719.732006699895, 10731.83902241467, 10833.83749243762, 14911.478098266509, 14984.175870327237, 15032.624184395478, 15054.096754194565, 15060.774088388684, 6953.687084081229, 7203.207647158808, 7209.495335326582, 7398.371138453184, 7464.589447580435, 6623.834404139935, 6727.226368967534, 6890.724371025203, 6922.550034247758, 6932.896006559906, 4420.955790442119, 4552.544745525487, 4605.309203619484, 4668.393108895822, 4730.810767569327, 1892.5555489010144, 1905.3617038292327, 1935.3516571948555, 1953.599512100016, 1961.4213806926991, 820.5979070255531, 872.7599910024794, 892.2817132208635, 912.9726108216764, 1025.9384436933808, 19173.233070677015, 19337.613247734967, 19376.4187074388, 19471.707924381146, 19808.523934508186, 934.4253284230285, 949.8480243161061, 977.2035790830593, 1011.5397494140149, 1015.3653966271081, 10221.642242521477, 10676.199285053652, 10902.72743181411, 10937.289076210021, 10940.288881222696, 424278.0, 425981.0, 426489.0, 431367.0, 433049.0, 90647.54676226576, 92716.0, 94406.52796735973, 95103.0, 97575.0, 976.7899901521207, 978.1881038737973, 1011.2971484817981, 1013.8175128476945, 1019.5310157327564, 12748.0, 16363.918180409022, 16681.83318166803, 17033.0, 17908.820911790714, 41003.0, 41382.79308603438, 41901.371479427224, 41986.79006604947, 42408.78795606002, 53160.468395315555, 53855.73072134771, 54288.45711542992, 54330.0, 54342.72828635832, 7679.961600191963, 7913.089994650689, 8002.359811214972, 8065.838683226185, 8355.206255405727, 10969.835452468378, 12802.615921522369, 13052.282124483245, 13135.671608209872, 13446.327683615977, 11117.27737697047, 11133.665990020312, 11312.321260724053, 11322.150838686966, 11348.602798901999, 11228.10175185967, 11346.943265283951, 11375.92271759261, 11382.715432114263, 11589.82615260755, 11071.667849964513, 11131.554737810397, 11262.09903207725, 11438.485268163118, 11907.464164112462, 7234.6020968847215, 7288.927110728825, 7539.32146106853, 7713.997180366741, 7900.525968441682, 9933.503324833584, 11011.779764404828, 11352.943235284101, 11498.022668072972, 11507.309561426342], "value": 8730.944319877093, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1386.7919812028194, 1445.7903603977422, 1556.3463345394932, 1693.2465053051383, 1762.6650936322098, 7878.527288362702, 8170.346372290217, 8196.139405362426, 8810.823783524334, 8811.559422028897, 8542.572871356422, 8807.691730789424, 8835.955820220906, 9026.097390260971, 9026.90973090269, 2271.136967952176, 2301.5166814968875, 2317.918872839451, 2317.9536409271805, 2322.6632138339933, 1970.9901450492728, 2040.77551469339, 2239.8208143348493, 2295.3228797504776, 2306.1928325086255, 2164.9242276520326, 2238.1159442020394, 2241.1371621925514, 2244.36035729817, 2257.2776711452343, 2281.566502364562, 2302.9424264393356, 2310.260716570698, 2311.144876395736, 2315.4211447138214, 2187.2344679362254, 2211.2936416588177, 2225.499262665903, 2228.353777404551, 2231.0964059555745, 8837.337199709984, 9032.367734258605, 9032.909670903273, 9039.096090390974, 9039.412438191497, 5193.350831146106, 5349.251104845324, 5351.785928562853, 5354.491323324278, 5362.4637536246455, 3088.7992280501694, 3281.2289112058647, 3308.2391050058623, 3319.219983303946, 3329.51722000311, 981.6073570571829, 1027.9640212592524, 1034.3328553083295, 1034.7051090439263, 1036.5231993283098, 12488.188267762656, 12529.185602935871, 12550.435230414654, 12568.685782855411, 12644.683882902817, 4364.101615797138, 4422.84520041797, 4613.30800379939, 4628.449469427712, 4638.0491999140095, 10531.894681053245, 10554.788904222027, 10556.26106172576, 10556.683299501028, 10567.410984308739, 5330.866728331823, 5331.546818520392, 5345.091334473072, 5345.893082138336, 5354.223637572608, 4713.198756211452, 4829.5653391194255, 4916.311716359713, 4916.901661966741, 4940.975295123501, 3905.7851818150275, 3920.313945059603, 3967.722259441869, 4044.3326851069833, 4060.3503439449546, 1149.5344385523877, 1212.2362911365783, 1296.857345691973, 1301.3298151452009, 1308.285307985933, 838.5681374092347, 855.4012191465998, 870.4864130163234, 878.5782824244399, 885.7829831691276, 5428.212909128154, 5625.831225063254, 5643.181738647873, 5650.7739690412745, 5904.7342869570975, 944.2163004706215, 984.6455276100598, 997.481309718942, 1026.810040142576, 1071.4000159910474, 3858.093348063203, 3897.8440862365187, 3969.4244334571326, 3974.900627484336, 3981.7411868228473, 11067.446627668583, 11453.312801231952, 11483.196176267747, 11500.654980350602, 11504.769904602028, 11339.262947908359, 11339.489722962486, 11369.829452558219, 11371.488283027284, 11389.37358445277, 8135.75592732219, 8268.338532917352, 8287.295579875657, 8330.375221858507, 8390.874136887951, 5627.465390787868, 5668.348139963792, 5688.914666279927, 5760.884782304247, 5921.585489015728, 10001.849972250568, 10118.392896426238, 10206.387616743019, 10290.485475726333, 10370.792584148425, 10108.595656173964, 10241.283110182514, 10368.118709909742, 10576.101031412416, 10578.735531611463, 7235.0, 7434.3309102181065, 7509.586972716553, 7663.923360766321, 7696.037995250594, 8301.294389976678, 8368.581570921308, 8371.497710137412, 8423.241908228289, 8440.07159212474, 7235.529690570096, 7239.167495738057, 7301.817454563678, 7346.302101300368, 7411.4070874331, 7231.963840180765, 7321.926780732125, 7385.9630701846145, 7425.665845037094, 7426.368758655359, 6322.33615470369, 6428.228612566522, 6434.324395938359, 6435.227772667123, 6436.16329877113, 4727.432708074915, 4902.534259245366, 4962.578180854668, 5080.26336181259, 5089.745512724275, 5007.899842003212, 5043.268726034631, 5201.635885487979, 5226.738663066907, 5255.78976840922], "value": 4571.065711805577, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.4120441775233, 326.5053444032291, 327.9770416070876, 331.4613752651941, 335.3728527653288, 5052.595792336604, 5239.240310155025, 5254.6847189168675, 5301.231321458391, 5302.575793936486, 5098.9745051274695, 5185.870353241171, 5189.584833213344, 5231.0, 5238.8690282742955, 4103.41484864535, 4103.610157035077, 4113.321301985169, 4127.690423218256, 4130.586941305868, 3910.8435662573606, 4110.362893751459, 4123.422860712055, 4158.480189976253, 4178.895527611804, 4076.1236334188293, 4079.0822065035427, 4090.6522945549664, 4106.527749308823, 4113.71204015719, 4041.373587094005, 4063.8780836574656, 4080.81636326366, 4081.795910204478, 4098.6516146127615, 3571.178628915338, 3582.570091589026, 3594.155373487228, 3600.459931010343, 3610.0, 5030.748462576893, 5064.848054558369, 5082.415522214956, 5089.6691715038405, 5090.33825602673, 4632.606228470584, 4638.234691275936, 4658.557437043475, 4664.48404268614, 4667.15991121598, 5442.619016668835, 5447.727613619303, 5454.53636440903, 5457.454254574551, 5461.644993075477, 3777.8085936726097, 3896.610338966109, 3902.375619900802, 3913.66733827625, 3920.980395098035, 5605.523530499912, 5605.635633683838, 5620.353659329147, 5629.915551266734, 5661.631993920423, 3971.940420893689, 3973.8609148679657, 4009.3384591542654, 4035.5875443595096, 4040.454538637305, 3839.347310957144, 4033.657139143147, 4045.130296986162, 4077.1845630873945, 4086.693497987603, 4642.860714178512, 4648.86053418398, 4655.37152484417, 4659.627229821606, 4661.370714953506, 5491.341039075257, 5526.115821468546, 5534.588679886603, 5545.528630066489, 5565.1930470082425, 1337.2110454831695, 1360.333436616051, 1363.4069179906771, 1388.298909050923, 1397.6086695725214, 941.9784494189922, 944.8204841080172, 962.3600305796707, 972.7276362618478, 973.8247115519274, 5191.819435836957, 5235.73821308933, 5241.50205730455, 5259.921101183485, 5276.36683597963, 5558.0, 5576.386597474275, 5583.525400340935, 5584.720763961785, 5602.067286786052, 5116.744162791845, 5260.684358938476, 5287.286216360819, 5294.311739473844, 5338.252644629755, 3005.6844031376827, 3015.5374643297982, 3021.425929073469, 3030.636323641133, 3032.3177285110673, 5845.707714614337, 5856.355800861902, 5871.7651293947765, 5876.41235876409, 5886.735096920649, 5484.846213427295, 5619.4099619540175, 5634.211210430543, 5644.604877658525, 5742.799002034909, 5690.687012214368, 5734.913976290359, 5747.827565173052, 5755.424457554211, 5770.451807078405, 5341.145416733304, 5551.639143455663, 5564.527015203591, 5638.830835074954, 5641.830745077655, 5491.28613280271, 5495.0, 5520.585956053232, 5551.528120109674, 5556.555475562026, 5743.960893882779, 5758.712064396847, 5763.596548241583, 5800.854978625568, 5810.302763668218, 3955.4024403561834, 3976.58245884178, 3988.1824226034173, 4051.513818341818, 4082.2243773682903, 5307.310049693515, 5496.780128794963, 5519.586031047607, 5526.972365138148, 5533.833984980457, 5371.5702743781185, 5389.784408623768, 5463.699496527729, 5464.672119672832, 5475.4524547544925, 5471.917921231265, 5472.671639701631, 5476.72616369172, 5526.198701188386, 5533.667979921218, 5239.773096433924, 5445.863853403696, 5448.645838020516, 5473.863153421196, 5487.560995120461, 5494.862628434321, 5496.6701997880255, 5501.707098831691, 5516.420775818481, 5533.225348451139, 5390.622656414013, 5429.348478182644, 5437.347518297672, 5470.374220374322, 5494.835154945358], "value": 4179.041467458461, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [781.5896654256514, 787.582581231947, 794.4053159453474, 802.8835818806277, 804.6057431858384, 15057.322420491077, 15624.921875390635, 16393.098379589148, 16418.83581164188, 16433.67132657346, 14882.627934301621, 14938.925305373485, 15140.091594504338, 15147.166905820175, 15162.469313574027, 802.1697543042952, 817.448222449847, 820.8604537228656, 820.8809722590221, 822.0587427395628, 675.6959368284291, 694.503430047516, 798.3652995868299, 817.8159914019328, 821.40858581821, 860.9870851937226, 867.1761826265042, 868.583080121542, 868.6351732272461, 872.4067634008871, 862.2067697718114, 862.4006315610653, 863.0980625246601, 863.2317237658489, 863.6502216602255, 512.1038183179436, 528.1734086155155, 631.1889222349305, 632.6804963493406, 633.293877326782, 13132.409041593151, 13547.661308467268, 13626.523071692443, 13963.58109256724, 13991.370388332549, 14752.852471475255, 15697.0, 15772.92113539425, 15812.604684882856, 15980.283351830216, 11353.091752659768, 11469.713257168554, 11522.0, 11634.941825290904, 11651.0, 3760.0787806987464, 3891.7664940103687, 4018.6985976051915, 4018.9799051004557, 4019.095703466726, 75398.62300688462, 77592.0, 78109.60945195294, 78154.21845781527, 78164.60917695431, 11559.479823407966, 11657.0, 11829.467673954692, 12052.819207711891, 12499.312537810325, 22711.318660440214, 22713.545729085658, 22768.772312276997, 22930.42673933165, 23751.0, 8094.51432914027, 8146.429749917449, 8149.877751833727, 8249.257566818895, 8472.915270847336, 4358.171947329997, 4381.058072514361, 4398.604125628709, 4488.685791994529, 4688.929666055012, 3745.9063523412133, 3913.412988051758, 3915.1973845362204, 3920.4119382092344, 3928.273269445162, 519.92821391873, 629.6348118091496, 634.5843472525503, 634.8063840528683, 636.4303947966637, 542.5822116969911, 595.8599729063667, 621.2669050520338, 624.1106423346713, 630.7918386932301, 9269.397489163182, 9956.850647240153, 10053.949730251303, 10160.237982151368, 10211.285210035374, 566.5977156219049, 586.1647152807233, 623.7785586116863, 642.8296501427126, 672.7779832655212, 4077.347624380085, 4672.2991551266905, 4727.810887564528, 4874.147024270738, 5013.172826483662, 112134.0, 113678.43160784143, 115720.0, 117949.41025294819, 118093.0, 99548.50225748825, 101732.0, 102434.0, 103100.48449757702, 106320.0, 65715.67142164354, 85186.57406712927, 85429.57285213534, 85831.57084214539, 86376.0, 9170.724878253663, 9463.668771592962, 9547.801486501821, 9571.808563828823, 9647.517624118906, 48694.0, 49787.75106124446, 49944.250836238214, 50568.49431505785, 52317.0, 65749.67125164343, 74035.0, 74583.62708186424, 75454.24545754472, 77253.0, 12088.15382923187, 12192.634220973385, 12195.634130976085, 12364.752704946031, 12466.569019041563, 13199.736005279648, 13305.80041299362, 13390.17748891924, 13734.862651373758, 13774.449022039407, 12683.175593586388, 12688.365581721062, 13003.739925201633, 13648.112872663245, 13684.863151368758, 12209.511619535118, 12346.0, 12424.440900159696, 12568.434420451285, 12792.6801829955, 12960.222386656831, 13080.542181023618, 13294.401751920994, 13862.584122476343, 13965.35211127815, 9358.300687906492, 9589.280803939593, 9674.467904265333, 9715.611375544899, 9970.30207885441, 8404.148278026212, 9820.607175712892, 9874.259430542881, 10154.54304556282, 10198.541065652213], "value": 7392.180771847576, "unit": "score"}], "name": "dromaeo_css", "value": 7097.608265233842, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 113.0, 111.0, 112.0, 112.0, 113.0, 113.0, 114.0, 111.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 123.0, 122.0, 168.0, 132.0, 122.0, 120.0, 126.0, 162.0, 129.0], "value": 135.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 163.0, 162.0, 163.0, 163.0, 164.0, 162.0, 161.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 114.0, 75.0, 81.0, 75.0, 75.0, 105.0, 74.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 115.0, 83.0, 83.0, 84.0, 107.0, 83.0, 82.0, 115.0], "value": 92.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 86.0, 85.0, 85.0, 84.0, 84.0, 84.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 60.0, 52.0, 53.0, 54.0, 52.0, 54.0, 53.0, 53.0, 53.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 58.0, 59.0, 60.0, 59.0, 59.0, 60.0, 59.0, 60.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 89.0, 84.0, 81.0, 87.0, 80.0, 79.0, 85.0, 79.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 135.0, 132.0, 130.0, 131.0, 134.0, 132.0, 138.0, 186.0, 145.0], "value": 139.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 168.0, 170.0, 170.0, 166.0, 176.0, 168.0, 168.0, 167.0, 166.0], "value": 168.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 65.0, 65.0, 67.0, 66.0, 65.0, 73.0, 65.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1501.5, "alertThreshold": 2.0}]} 18:45:40 INFO - Return code: 0 18:45:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:45:40 INFO - # TBPL SUCCESS # 18:45:40 INFO - Running post-action listener: _resource_record_post_action 18:45:40 INFO - [mozharness: 2016-10-25 01:45:40.310019Z] Finished run-tests step (success) 18:45:40 INFO - Running post-run listener: _resource_record_post_run 18:45:40 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 391999488; Read time: 0; Write time: 452680 18:45:40 INFO - TinderboxPrint: CPU usage
13.1% 18:45:40 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 18:45:40 INFO - TinderboxPrint: I/O write bytes / time
391,999,488 / 452,680 18:45:40 INFO - TinderboxPrint: CPU idle
8,315.4 (86.9%) 18:45:40 INFO - TinderboxPrint: CPU user
1,197.7 (12.5%) 18:45:40 INFO - TinderboxPrint: Swap in / out
0 / 0 18:45:40 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103366656; Read time: 0; Write time: 147908 18:45:40 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 288186368; Read time: 0; Write time: 304768 18:45:40 INFO - Running post-run listener: _upload_blobber_files 18:45:40 INFO - Blob upload gear active. 18:45:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:45:40 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 18:45:40 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:45:40 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:45:41 INFO - (blobuploader) - INFO - Open directory for files ... 18:45:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:45:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:45:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:45:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:45:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:45:42 INFO - (blobuploader) - INFO - Done attempting. 18:45:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:45:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:45:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:45:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:45:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:45:45 INFO - (blobuploader) - INFO - Done attempting. 18:45:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:45:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:45:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:45:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:45:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:45:46 INFO - (blobuploader) - INFO - Done attempting. 18:45:46 INFO - (blobuploader) - INFO - Iteration through files over. 18:45:46 INFO - Return code: 0 18:45:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:45:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:45:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5242427fb2bb113bd6bfd1ed46b9ea90c52212266ce317c4a25d253195ddf4be0212b805bc3c256b9346765cbcb7270e3deaa2a642c20e98a5f0f68402279aba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a925c9a94f80e248f053676bcccba0484250958a0ca901579a96c3e0a51672b7d40e536fbddc8f01bcee46b5802a089726852adda83b66fec9e68281a37488dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/96a188fc6cb832a86256a3b40a16ac96bf75d07ceadd6657125d98651b43407962282c34c06f7db81b4263f8c25c4cd817e03034cb142fdc3562da2bd3b9729f"} 18:45:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:45:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:45:46 INFO - Contents: 18:45:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5242427fb2bb113bd6bfd1ed46b9ea90c52212266ce317c4a25d253195ddf4be0212b805bc3c256b9346765cbcb7270e3deaa2a642c20e98a5f0f68402279aba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a925c9a94f80e248f053676bcccba0484250958a0ca901579a96c3e0a51672b7d40e536fbddc8f01bcee46b5802a089726852adda83b66fec9e68281a37488dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/96a188fc6cb832a86256a3b40a16ac96bf75d07ceadd6657125d98651b43407962282c34c06f7db81b4263f8c25c4cd817e03034cb142fdc3562da2bd3b9729f"} 18:45:46 INFO - Running post-run listener: copy_logs_to_upload_dir 18:45:46 INFO - Copying logs to upload dir... 18:45:46 INFO - mkdir: /builds/slave/test/build/upload/logs 18:45:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.684271 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-10-24 18:45:46.132785) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 18:45:46.136825) ========= 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=eca2ab57546de7b41f256b19000001ef-1477358701.335046-502799588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5242427fb2bb113bd6bfd1ed46b9ea90c52212266ce317c4a25d253195ddf4be0212b805bc3c256b9346765cbcb7270e3deaa2a642c20e98a5f0f68402279aba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a925c9a94f80e248f053676bcccba0484250958a0ca901579a96c3e0a51672b7d40e536fbddc8f01bcee46b5802a089726852adda83b66fec9e68281a37488dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/96a188fc6cb832a86256a3b40a16ac96bf75d07ceadd6657125d98651b43407962282c34c06f7db81b4263f8c25c4cd817e03034cb142fdc3562da2bd3b9729f"} build_url:https://queue.taskcluster.net/v1/task/A1zJoKVlRpal6RWe7ODFUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011341 build_url: 'https://queue.taskcluster.net/v1/task/A1zJoKVlRpal6RWe7ODFUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5242427fb2bb113bd6bfd1ed46b9ea90c52212266ce317c4a25d253195ddf4be0212b805bc3c256b9346765cbcb7270e3deaa2a642c20e98a5f0f68402279aba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a925c9a94f80e248f053676bcccba0484250958a0ca901579a96c3e0a51672b7d40e536fbddc8f01bcee46b5802a089726852adda83b66fec9e68281a37488dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/96a188fc6cb832a86256a3b40a16ac96bf75d07ceadd6657125d98651b43407962282c34c06f7db81b4263f8c25c4cd817e03034cb142fdc3562da2bd3b9729f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 18:45:46.163157) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 18:45:46.163499) ========= 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=eca2ab57546de7b41f256b19000001ef-1477358701.335046-502799588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004441 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 18:45:46.245749) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 18:45:46.246145) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 18:45:46.246626) ========= ========= Total master_lag: 0.16 =========