builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-020 starttime: 1476990111.82 results: success (0) buildid: 20161020111749 builduid: bf104b38a1d84e8bbe5091877d07c95a revision: ba53dda46a532a144ab53c6bc119fe08fe83cb40 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 12:01:51.825317) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 12:01:51.825747) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 12:01:51.826046) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 12:01:51.840844) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 12:01:51.841168) ========= 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=af724c981e2a0f424dbabf99000001e7-1476989674.459868-749303686 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-20 12:01:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 104M=0s 2016-10-20 12:01:51 (104 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.108980 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 12:01:51.963889) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 12:01:51.964221) ========= 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=af724c981e2a0f424dbabf99000001e7-1476989674.459868-749303686 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018885 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 12:01:52.013675) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 12:01:52.013993) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ba53dda46a532a144ab53c6bc119fe08fe83cb40 --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 ba53dda46a532a144ab53c6bc119fe08fe83cb40 --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=af724c981e2a0f424dbabf99000001e7-1476989674.459868-749303686 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-20 12:01:52,114 truncating revision to first 12 chars 2016-10-20 12:01:52,114 Setting DEBUG logging. 2016-10-20 12:01:52,114 attempt 1/10 2016-10-20 12:01:52,114 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ba53dda46a53?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-20 12:01:52,412 unpacking tar archive at: fx-team-ba53dda46a53/testing/mozharness/ program finished with exit code 0 elapsedTime=0.582393 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 12:01:52.613068) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 12:01:52.613415) ========= script_repo_revision: ba53dda46a532a144ab53c6bc119fe08fe83cb40 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 12:01:52.613866) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 12:01:52.614156) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 12:01:52.623330) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-20 12:01:52.623643) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=af724c981e2a0f424dbabf99000001e7-1476989674.459868-749303686 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:01:52 INFO - MultiFileLogger online at 20161020 12:01:52 in /builds/slave/test 12:01:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 12:01:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:01:52 INFO - {'append_to_log': False, 12:01:52 INFO - 'base_work_dir': '/builds/slave/test', 12:01:52 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:01:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:01:52 INFO - 'branch': 'Fx-Team-Non-PGO', 12:01:52 INFO - 'buildbot_json_path': 'buildprops.json', 12:01:52 INFO - 'config_files': ('talos/linux_config.py',), 12:01:52 INFO - 'default_actions': ('clobber', 12:01:52 INFO - 'read-buildbot-config', 12:01:52 INFO - 'download-and-extract', 12:01:52 INFO - 'populate-webroot', 12:01:52 INFO - 'create-virtualenv', 12:01:52 INFO - 'install', 12:01:52 INFO - 'run-tests'), 12:01:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:01:52 INFO - 'download_minidump_stackwalk': True, 12:01:52 INFO - 'download_symbols': 'ondemand', 12:01:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:01:52 INFO - 'tooltool.py': '/tools/tooltool.py', 12:01:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:01:52 INFO - '/tools/misc-python/virtualenv.py')}, 12:01:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:01:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:01:52 INFO - 'installer_path': 'installer.exe', 12:01:52 INFO - 'log_level': 'info', 12:01:52 INFO - 'log_name': 'talos', 12:01:52 INFO - 'log_to_console': True, 12:01:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:01:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:01:52 INFO - 'opt_config_files': (), 12:01:52 INFO - 'pip_index': False, 12:01:52 INFO - 'sps_profile': False, 12:01:52 INFO - 'sps_profile_interval': 0, 12:01:52 INFO - 'suite': 'dromaeojs', 12:01:52 INFO - 'system_bits': '32', 12:01:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:01:52 INFO - 'title': 'talos-linux64-ix-020', 12:01:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:01:52 INFO - 'use_talos_json': True, 12:01:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:01:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:01:52 INFO - 'work_dir': 'build'} 12:01:52 INFO - [mozharness: 2016-10-20 19:01:52.824193Z] Running clobber step. 12:01:52 INFO - Running pre-action listener: _resource_record_pre_action 12:01:52 INFO - Running main action method: clobber 12:01:52 INFO - rmtree: /builds/slave/test/build 12:01:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:01:53 INFO - Running post-action listener: _resource_record_post_action 12:01:53 INFO - [mozharness: 2016-10-20 19:01:53.279434Z] Finished clobber step (success) 12:01:53 INFO - [mozharness: 2016-10-20 19:01:53.279534Z] Running read-buildbot-config step. 12:01:53 INFO - Running pre-action listener: _resource_record_pre_action 12:01:53 INFO - Running main action method: read_buildbot_config 12:01:53 INFO - Using buildbot properties: 12:01:53 INFO - { 12:01:53 INFO - "project": "", 12:01:53 INFO - "product": "firefox", 12:01:53 INFO - "script_repo_revision": "production", 12:01:53 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:01:53 INFO - "repository": "", 12:01:53 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 12:01:53 INFO - "buildid": "20161020111749", 12:01:53 INFO - "pgo_build": "False", 12:01:53 INFO - "basedir": "/builds/slave/test", 12:01:53 INFO - "buildnumber": 2211, 12:01:53 INFO - "slavename": "talos-linux64-ix-020", 12:01:53 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:01:53 INFO - "platform": "ubuntu64_hw", 12:01:53 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:01:53 INFO - "branch": "fx-team", 12:01:53 INFO - "repo_path": "integration/fx-team", 12:01:53 INFO - "revision": "ba53dda46a532a144ab53c6bc119fe08fe83cb40", 12:01:53 INFO - "stage_platform": "linux64", 12:01:53 INFO - "builduid": "bf104b38a1d84e8bbe5091877d07c95a", 12:01:53 INFO - "slavebuilddir": "test" 12:01:53 INFO - } 12:01:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/U-aWYEleS52Ruqp8S_LGMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 12:01:53 INFO - Running post-action listener: _resource_record_post_action 12:01:53 INFO - [mozharness: 2016-10-20 19:01:53.281976Z] Finished read-buildbot-config step (success) 12:01:53 INFO - [mozharness: 2016-10-20 19:01:53.282064Z] Running download-and-extract step. 12:01:53 INFO - Running pre-action listener: _resource_record_pre_action 12:01:53 INFO - Running main action method: download_and_extract 12:01:53 INFO - mkdir: /builds/slave/test/build/tests 12:01:53 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')]} 12:01:53 INFO - trying https://queue.taskcluster.net/v1/task/U-aWYEleS52Ruqp8S_LGMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:01:53 INFO - Downloading https://queue.taskcluster.net/v1/task/U-aWYEleS52Ruqp8S_LGMQ/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 12:01:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U-aWYEleS52Ruqp8S_LGMQ/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 12:01:53 INFO - Downloaded 1361 bytes. 12:01:53 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:01:53 INFO - Using the following test package requirements: 12:01:53 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:01:53 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:01:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:01:53 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:01:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:01:53 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:01:53 INFO - u'jsshell-linux-x86_64.zip'], 12:01:53 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:01:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:01:53 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:01:53 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:01:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:01:53 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:01:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:01:53 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:01:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:01:53 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:01:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:01:53 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:01:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U-aWYEleS52Ruqp8S_LGMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:01:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U-aWYEleS52Ruqp8S_LGMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:01:53 INFO - Fetch https://queue.taskcluster.net/v1/task/U-aWYEleS52Ruqp8S_LGMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:01:54 INFO - Http code: 200 12:01:54 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 12:01:54 INFO - x-amz-cf-id: 1rkNSllvZKd6TqaHZ-bimLIsnaN7DJHKhMYRyeIPkvBtQ8306-_4cg== 12:01:54 INFO - x-amz-version-id: W9wWa.887Wu8jGCrMoJtmeFSVhk0NPTG 12:01:54 INFO - Expected file size: 20549955 12:01:54 INFO - Obtained file size: 20549955 12:01:58 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:01:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U-aWYEleS52Ruqp8S_LGMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:01:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U-aWYEleS52Ruqp8S_LGMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:01:58 INFO - Fetch https://queue.taskcluster.net/v1/task/U-aWYEleS52Ruqp8S_LGMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:01:59 INFO - Http code: 200 12:01:59 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 12:01:59 INFO - x-amz-cf-id: qt_8JC6hZIOiagmlma8ZTCOVX9k6wqvJ8BrT7PhhDOH0g33o9LcRWw== 12:01:59 INFO - x-amz-version-id: W9wWa.887Wu8jGCrMoJtmeFSVhk0NPTG 12:01:59 INFO - Expected file size: 20549955 12:01:59 INFO - Obtained file size: 20549955 12:02:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U-aWYEleS52Ruqp8S_LGMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 12:02:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U-aWYEleS52Ruqp8S_LGMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:02:04 INFO - Fetch https://queue.taskcluster.net/v1/task/U-aWYEleS52Ruqp8S_LGMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 12:02:04 INFO - Http code: 200 12:02:04 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 12:02:04 INFO - x-amz-cf-id: iapvsfUHmwSzVWBRgbD6FnCQeEBi4cJAFYBESi3AhcSGKjfpl7l_yw== 12:02:04 INFO - x-amz-version-id: 9LvTT4plTsyy6AxT69gdBE8ZjbHNP5Et 12:02:05 INFO - Expected file size: 14409028 12:02:05 INFO - Obtained file size: 14409028 12:02: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')]} 12:02:05 INFO - trying https://queue.taskcluster.net/v1/task/U-aWYEleS52Ruqp8S_LGMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:02:05 INFO - Downloading https://queue.taskcluster.net/v1/task/U-aWYEleS52Ruqp8S_LGMQ/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 12:02:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U-aWYEleS52Ruqp8S_LGMQ/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 12:02:07 INFO - Downloaded 55525667 bytes. 12:02:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U-aWYEleS52Ruqp8S_LGMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:02:07 INFO - mkdir: /builds/slave/test/properties 12:02:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:02:07 INFO - Writing to file /builds/slave/test/properties/build_url 12:02:07 INFO - Contents: 12:02:07 INFO - build_url:https://queue.taskcluster.net/v1/task/U-aWYEleS52Ruqp8S_LGMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:02:08 INFO - Running post-action listener: _resource_record_post_action 12:02:08 INFO - Running post-action listener: set_extra_try_arguments 12:02:08 INFO - [mozharness: 2016-10-20 19:02:08.595471Z] Finished download-and-extract step (success) 12:02:08 INFO - [mozharness: 2016-10-20 19:02:08.595697Z] Running populate-webroot step. 12:02:08 INFO - Running pre-action listener: _resource_record_pre_action 12:02:08 INFO - Running main action method: populate_webroot 12:02:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:02:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:02:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:02:08 INFO - '--tppagecycles', 12:02:08 INFO - '7'], 12:02:08 INFO - 'tests': ['tsvgm']}}, 12:02:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:02:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:02:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:02:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:02:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:02:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:02:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:02:08 INFO - 'talos_options': ['--disable-e10s'], 12:02:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:02:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:02:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:02:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:02:08 INFO - 'talos_options': ['--disable-e10s'], 12:02:08 INFO - 'tests': ['damp', 'tps']}, 12:02:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:02:08 INFO - 'tests': ['damp', 'tps']}, 12:02:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:02:08 INFO - 'tests': ['dromaeo_dom']}, 12:02:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:02:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:02:08 INFO - 'tests': ['basic_compositor_video']}, 12:02:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:02:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:02:08 INFO - 'tests': ['a11yr', 12:02:08 INFO - 'ts_paint', 12:02:08 INFO - 'tpaint', 12:02:08 INFO - 'sessionrestore', 12:02:08 INFO - 'sessionrestore_no_auto_restore', 12:02:08 INFO - 'tabpaint']}, 12:02:08 INFO - 'other-e10s': {'tests': ['a11yr', 12:02:08 INFO - 'ts_paint', 12:02:08 INFO - 'tpaint', 12:02:08 INFO - 'sessionrestore', 12:02:08 INFO - 'sessionrestore_no_auto_restore', 12:02:08 INFO - 'tabpaint']}, 12:02:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:02:08 INFO - 'ts_paint', 12:02:08 INFO - 'tpaint', 12:02:08 INFO - 'sessionrestore', 12:02:08 INFO - 'sessionrestore_no_auto_restore', 12:02:08 INFO - 'tabpaint']}, 12:02:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:02:08 INFO - 'ts_paint', 12:02:08 INFO - 'tpaint', 12:02:08 INFO - 'sessionrestore', 12:02:08 INFO - 'sessionrestore_no_auto_restore', 12:02:08 INFO - 'tabpaint']}, 12:02:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:02:08 INFO - 'tests': ['a11yr', 12:02:08 INFO - 'ts_paint', 12:02:08 INFO - 'tpaint', 12:02:08 INFO - 'sessionrestore', 12:02:08 INFO - 'sessionrestore_no_auto_restore', 12:02:08 INFO - 'tabpaint']}, 12:02:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:02:08 INFO - 'tests': ['a11yr', 12:02:08 INFO - 'ts_paint', 12:02:08 INFO - 'tpaint', 12:02:08 INFO - 'sessionrestore', 12:02:08 INFO - 'sessionrestore_no_auto_restore', 12:02:08 INFO - 'tabpaint']}, 12:02:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:02:08 INFO - 'tests': ['tsvgx', 12:02:08 INFO - 'tsvgr_opacity', 12:02:08 INFO - 'tart', 12:02:08 INFO - 'tscrollx', 12:02:08 INFO - 'cart']}, 12:02:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:02:08 INFO - 'tsvgr_opacity', 12:02:08 INFO - 'tart', 12:02:08 INFO - 'tscrollx', 12:02:08 INFO - 'cart']}, 12:02:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:02:08 INFO - 'talos_options': ['--disable-e10s'], 12:02:08 INFO - 'tests': ['tp5o']}, 12:02:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:02:08 INFO - 'tests': ['tp5o']}, 12:02:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:02:08 INFO - 'talos_options': ['--disable-e10s', 12:02:08 INFO - '--xperf_path', 12:02:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:02:08 INFO - 'tests': ['tp5n']}, 12:02:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:02:08 INFO - 'talos_options': ['--xperf_path', 12:02:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:02:08 INFO - 'tests': ['tp5n']}}, 12:02:08 INFO - 'talos.zip': {'path': '', 12:02:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:02:08 INFO - Running post-action listener: _resource_record_post_action 12:02:08 INFO - [mozharness: 2016-10-20 19:02:08.612582Z] Finished populate-webroot step (success) 12:02:08 INFO - [mozharness: 2016-10-20 19:02:08.612669Z] Running create-virtualenv step. 12:02:08 INFO - Running pre-action listener: _resource_record_pre_action 12:02:08 INFO - Running main action method: create_virtualenv 12:02:08 INFO - Creating virtualenv /builds/slave/test/build/venv 12:02:08 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 12:02:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:02:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:02:08 INFO - Using real prefix '/usr' 12:02:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:02:09 INFO - Installing distribute.............................................................................................................................................................................................done. 12:02:11 INFO - Installing pip.................done. 12:02:11 INFO - Return code: 0 12:02:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:02:11 INFO - Reading from file tmpfile_stdout 12:02:11 INFO - Output received: 12:02:11 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 12:02:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:02:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:02:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f08a74f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2abeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abbf60>, '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 0x2abcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abd1d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1476989674.459868-749303686', '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 12:02:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:02:11 INFO - Using env: {'DISPLAY': ':0', 12:02:11 INFO - 'HOME': '/home/cltbld', 12:02:11 INFO - 'LANG': 'en_US.UTF-8', 12:02:11 INFO - 'LANGUAGE': 'en_US:en', 12:02:11 INFO - 'LOGNAME': 'cltbld', 12:02:11 INFO - 'MAIL': '/var/mail/cltbld', 12:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:02:11 INFO - 'MOZ_NO_REMOTE': '1', 12:02:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:02:11 INFO - 'NO_EM_RESTART': '1', 12:02:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:02:11 INFO - 'PWD': '/builds/slave/test', 12:02:11 INFO - 'SHELL': '/bin/bash', 12:02:11 INFO - 'SHLVL': '1', 12:02:11 INFO - 'TERM': 'linux', 12:02:11 INFO - 'TMOUT': '86400', 12:02:11 INFO - 'USER': 'cltbld', 12:02:11 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1476989674.459868-749303686', 12:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:02:11 INFO - '_': '/tools/buildbot/bin/python'} 12:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:02:11 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:02:11 INFO - Cleaning up... 12:02:11 INFO - Return code: 0 12:02:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:02:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:02:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f08a74f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2abeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abbf60>, '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 0x2abcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abd1d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1476989674.459868-749303686', '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 12:02:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:02:11 INFO - Using env: {'DISPLAY': ':0', 12:02:11 INFO - 'HOME': '/home/cltbld', 12:02:11 INFO - 'LANG': 'en_US.UTF-8', 12:02:11 INFO - 'LANGUAGE': 'en_US:en', 12:02:11 INFO - 'LOGNAME': 'cltbld', 12:02:11 INFO - 'MAIL': '/var/mail/cltbld', 12:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:02:11 INFO - 'MOZ_NO_REMOTE': '1', 12:02:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:02:11 INFO - 'NO_EM_RESTART': '1', 12:02:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:02:11 INFO - 'PWD': '/builds/slave/test', 12:02:11 INFO - 'SHELL': '/bin/bash', 12:02:11 INFO - 'SHLVL': '1', 12:02:11 INFO - 'TERM': 'linux', 12:02:11 INFO - 'TMOUT': '86400', 12:02:11 INFO - 'USER': 'cltbld', 12:02:11 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1476989674.459868-749303686', 12:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:02:11 INFO - '_': '/tools/buildbot/bin/python'} 12:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:02:11 INFO - Downloading/unpacking psutil>=3.1.1 12:02:11 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 12:02:11 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 12:02:11 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 12:02:11 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 12:02:11 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 12:02:11 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 12:02:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:02:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:02:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:02:13 INFO - Installing collected packages: psutil 12:02:13 INFO - Running setup.py install for psutil 12:02:13 INFO - building 'psutil._psutil_linux' extension 12:02:13 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 12:02:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:02:14 INFO - building 'psutil._psutil_posix' extension 12:02:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:02:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:02:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:02:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:02:14 INFO - Successfully installed psutil 12:02:14 INFO - Cleaning up... 12:02:14 INFO - Return code: 0 12:02:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:02:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:02:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:02:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f08a74f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2abeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abbf60>, '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 0x2abcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abd1d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1476989674.459868-749303686', '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 12:02:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:02:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:02:14 INFO - Using env: {'DISPLAY': ':0', 12:02:14 INFO - 'HOME': '/home/cltbld', 12:02:14 INFO - 'LANG': 'en_US.UTF-8', 12:02:14 INFO - 'LANGUAGE': 'en_US:en', 12:02:14 INFO - 'LOGNAME': 'cltbld', 12:02:14 INFO - 'MAIL': '/var/mail/cltbld', 12:02:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:02:14 INFO - 'MOZ_NO_REMOTE': '1', 12:02:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:02:14 INFO - 'NO_EM_RESTART': '1', 12:02:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:02:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:02:14 INFO - 'PWD': '/builds/slave/test', 12:02:14 INFO - 'SHELL': '/bin/bash', 12:02:14 INFO - 'SHLVL': '1', 12:02:14 INFO - 'TERM': 'linux', 12:02:14 INFO - 'TMOUT': '86400', 12:02:14 INFO - 'USER': 'cltbld', 12:02:14 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1476989674.459868-749303686', 12:02:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:02:14 INFO - '_': '/tools/buildbot/bin/python'} 12:02:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:02:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:02:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:02:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:02:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:02:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:02:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:02:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:02:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:02:16 INFO - Installing collected packages: mozsystemmonitor 12:02:16 INFO - Running setup.py install for mozsystemmonitor 12:02:16 INFO - Successfully installed mozsystemmonitor 12:02:16 INFO - Cleaning up... 12:02:16 INFO - Return code: 0 12:02:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:02: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')]} 12:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:02:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02: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')]} 12:02:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:02:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:16 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 0x7f08a74f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2abeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abbf60>, '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 0x2abcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abd1d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1476989674.459868-749303686', '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 12:02:16 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 12:02:16 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 12:02:16 INFO - Using env: {'DISPLAY': ':0', 12:02:16 INFO - 'HOME': '/home/cltbld', 12:02:16 INFO - 'LANG': 'en_US.UTF-8', 12:02:16 INFO - 'LANGUAGE': 'en_US:en', 12:02:16 INFO - 'LOGNAME': 'cltbld', 12:02:16 INFO - 'MAIL': '/var/mail/cltbld', 12:02:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:02:16 INFO - 'MOZ_NO_REMOTE': '1', 12:02:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:02:16 INFO - 'NO_EM_RESTART': '1', 12:02:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:02:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:02:16 INFO - 'PWD': '/builds/slave/test', 12:02:16 INFO - 'SHELL': '/bin/bash', 12:02:16 INFO - 'SHLVL': '1', 12:02:16 INFO - 'TERM': 'linux', 12:02:16 INFO - 'TMOUT': '86400', 12:02:16 INFO - 'USER': 'cltbld', 12:02:16 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1476989674.459868-749303686', 12:02:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:02:16 INFO - '_': '/tools/buildbot/bin/python'} 12:02:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:02:16 INFO - Downloading/unpacking jsonschema==2.5.1 12:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:02:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:02:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:02:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:02:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:02:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:02:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:02:18 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 12:02:18 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 12:02:18 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 12:02:18 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 12:02:18 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 12:02:18 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 12:02:19 INFO - Downloading functools32-3.2.3-2.tar.gz 12:02:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:02:19 INFO - warning: no files found matching '*.txt' 12:02:19 INFO - no previously-included directories found matching 'build' 12:02:19 INFO - no previously-included directories found matching 'dist' 12:02:19 INFO - no previously-included directories found matching '.git*' 12:02:19 INFO - Installing collected packages: jsonschema, functools32 12:02:19 INFO - Running setup.py install for functools32 12:02:19 INFO - warning: no files found matching '*.txt' 12:02:19 INFO - no previously-included directories found matching 'build' 12:02:19 INFO - no previously-included directories found matching 'dist' 12:02:19 INFO - no previously-included directories found matching '.git*' 12:02:19 INFO - Successfully installed jsonschema functools32 12:02:19 INFO - Cleaning up... 12:02:19 INFO - Return code: 0 12:02:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:02:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:02:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f08a74f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2abeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abbf60>, '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 0x2abcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abd1d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1476989674.459868-749303686', '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 12:02:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:02:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:02:19 INFO - Using env: {'DISPLAY': ':0', 12:02:19 INFO - 'HOME': '/home/cltbld', 12:02:19 INFO - 'LANG': 'en_US.UTF-8', 12:02:19 INFO - 'LANGUAGE': 'en_US:en', 12:02:19 INFO - 'LOGNAME': 'cltbld', 12:02:19 INFO - 'MAIL': '/var/mail/cltbld', 12:02:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:02:19 INFO - 'MOZ_NO_REMOTE': '1', 12:02:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:02:19 INFO - 'NO_EM_RESTART': '1', 12:02:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:02:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:02:19 INFO - 'PWD': '/builds/slave/test', 12:02:19 INFO - 'SHELL': '/bin/bash', 12:02:19 INFO - 'SHLVL': '1', 12:02:19 INFO - 'TERM': 'linux', 12:02:19 INFO - 'TMOUT': '86400', 12:02:19 INFO - 'USER': 'cltbld', 12:02:19 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1476989674.459868-749303686', 12:02:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:02:19 INFO - '_': '/tools/buildbot/bin/python'} 12:02:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:02:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:02:19 INFO - Cleaning up... 12:02:19 INFO - Return code: 0 12:02:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:02:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:02:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f08a74f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2abeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abbf60>, '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 0x2abcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abd1d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1476989674.459868-749303686', '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 12:02:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:02:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:02:19 INFO - Using env: {'DISPLAY': ':0', 12:02:19 INFO - 'HOME': '/home/cltbld', 12:02:19 INFO - 'LANG': 'en_US.UTF-8', 12:02:19 INFO - 'LANGUAGE': 'en_US:en', 12:02:19 INFO - 'LOGNAME': 'cltbld', 12:02:19 INFO - 'MAIL': '/var/mail/cltbld', 12:02:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:02:19 INFO - 'MOZ_NO_REMOTE': '1', 12:02:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:02:19 INFO - 'NO_EM_RESTART': '1', 12:02:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:02:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:02:19 INFO - 'PWD': '/builds/slave/test', 12:02:19 INFO - 'SHELL': '/bin/bash', 12:02:19 INFO - 'SHLVL': '1', 12:02:19 INFO - 'TERM': 'linux', 12:02:19 INFO - 'TMOUT': '86400', 12:02:19 INFO - 'USER': 'cltbld', 12:02:19 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1476989674.459868-749303686', 12:02:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:02:19 INFO - '_': '/tools/buildbot/bin/python'} 12:02:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:02:19 INFO - Downloading/unpacking blobuploader==1.2.4 12:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:02:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:02:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:02:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:02:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:02:21 INFO - Downloading blobuploader-1.2.4.tar.gz 12:02:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:02:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:02: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 12:02: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 12:02: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 12:02: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 12:02: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 12:02: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 12:02:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:02:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:02:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:02:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:02:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:02:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:02:22 INFO - Downloading docopt-0.6.1.tar.gz 12:02:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:02:22 INFO - Installing collected packages: blobuploader, requests, docopt 12:02:22 INFO - Running setup.py install for blobuploader 12:02:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:02:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:02:22 INFO - Running setup.py install for requests 12:02:22 INFO - Running setup.py install for docopt 12:02:23 INFO - Successfully installed blobuploader requests docopt 12:02:23 INFO - Cleaning up... 12:02:23 INFO - Return code: 0 12:02:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:02:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:02:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:02:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f08a74f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2abeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abbf60>, '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 0x2abcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abd1d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1476989674.459868-749303686', '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 12:02:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:02:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:02:23 INFO - Using env: {'DISPLAY': ':0', 12:02:23 INFO - 'HOME': '/home/cltbld', 12:02:23 INFO - 'LANG': 'en_US.UTF-8', 12:02:23 INFO - 'LANGUAGE': 'en_US:en', 12:02:23 INFO - 'LOGNAME': 'cltbld', 12:02:23 INFO - 'MAIL': '/var/mail/cltbld', 12:02:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:02:23 INFO - 'MOZ_NO_REMOTE': '1', 12:02:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:02:23 INFO - 'NO_EM_RESTART': '1', 12:02:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:02:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:02:23 INFO - 'PWD': '/builds/slave/test', 12:02:23 INFO - 'SHELL': '/bin/bash', 12:02:23 INFO - 'SHLVL': '1', 12:02:23 INFO - 'TERM': 'linux', 12:02:23 INFO - 'TMOUT': '86400', 12:02:23 INFO - 'USER': 'cltbld', 12:02:23 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1476989674.459868-749303686', 12:02:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:02:23 INFO - '_': '/tools/buildbot/bin/python'} 12:02:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:02:23 INFO - Running setup.py (path:/tmp/pip-F1qr4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:02:23 INFO - Running setup.py (path:/tmp/pip-EbA8p7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:02:23 INFO - Running setup.py (path:/tmp/pip-0QPzTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:02:23 INFO - Running setup.py (path:/tmp/pip-osgxwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:02:23 INFO - Running setup.py (path:/tmp/pip-pAbrb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:02:23 INFO - Running setup.py (path:/tmp/pip-noaXNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:02:23 INFO - Running setup.py (path:/tmp/pip-8kgGyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:02:23 INFO - Running setup.py (path:/tmp/pip-6VLtVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:02:23 INFO - Running setup.py (path:/tmp/pip-pNnP3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:02:23 INFO - Running setup.py (path:/tmp/pip-G7XEag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:02:24 INFO - Running setup.py (path:/tmp/pip-10BHOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:02:24 INFO - Running setup.py (path:/tmp/pip-Lo1Oce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:02:24 INFO - Running setup.py (path:/tmp/pip-g51A4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:02:24 INFO - Running setup.py (path:/tmp/pip-jWnAst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:02:24 INFO - Running setup.py (path:/tmp/pip-9w_pLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:02:24 INFO - Running setup.py (path:/tmp/pip-rq_RZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:02:24 INFO - Running setup.py (path:/tmp/pip-jUQHrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:02:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:02:24 INFO - Running setup.py install for manifestparser 12:02:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:02:24 INFO - Running setup.py install for mozcrash 12:02:24 INFO - Running setup.py install for mozdebug 12:02:24 INFO - Running setup.py install for mozdevice 12:02:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:02:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:02:24 INFO - Running setup.py install for mozfile 12:02:25 INFO - Running setup.py install for mozhttpd 12:02:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:02:25 INFO - Running setup.py install for mozinfo 12:02:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:02:25 INFO - Running setup.py install for mozInstall 12:02:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:02:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:02:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:02:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:02:25 INFO - Running setup.py install for mozleak 12:02:25 INFO - Running setup.py install for mozlog 12:02:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:02:25 INFO - Running setup.py install for moznetwork 12:02:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:02:25 INFO - Running setup.py install for mozprocess 12:02:25 INFO - Running setup.py install for mozprofile 12:02:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:02:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:02:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:02:25 INFO - Running setup.py install for mozrunner 12:02:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:02:26 INFO - Running setup.py install for mozscreenshot 12:02:26 INFO - Running setup.py install for moztest 12:02:26 INFO - Running setup.py install for mozversion 12:02:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:02:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:02:26 INFO - Cleaning up... 12:02:26 INFO - Return code: 0 12:02:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:02: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')]} 12:02:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:02:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02: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')]} 12:02:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:02:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f08a74f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2abeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abbf60>, '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 0x2abcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abd1d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1476989674.459868-749303686', '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 12:02:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:02:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:02:26 INFO - Using env: {'DISPLAY': ':0', 12:02:26 INFO - 'HOME': '/home/cltbld', 12:02:26 INFO - 'LANG': 'en_US.UTF-8', 12:02:26 INFO - 'LANGUAGE': 'en_US:en', 12:02:26 INFO - 'LOGNAME': 'cltbld', 12:02:26 INFO - 'MAIL': '/var/mail/cltbld', 12:02:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:02:26 INFO - 'MOZ_NO_REMOTE': '1', 12:02:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:02:26 INFO - 'NO_EM_RESTART': '1', 12:02:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:02:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:02:26 INFO - 'PWD': '/builds/slave/test', 12:02:26 INFO - 'SHELL': '/bin/bash', 12:02:26 INFO - 'SHLVL': '1', 12:02:26 INFO - 'TERM': 'linux', 12:02:26 INFO - 'TMOUT': '86400', 12:02:26 INFO - 'USER': 'cltbld', 12:02:26 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1476989674.459868-749303686', 12:02:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:02:26 INFO - '_': '/tools/buildbot/bin/python'} 12:02:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:02:26 INFO - Running setup.py (path:/tmp/pip-FdaNsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:02:26 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)) 12:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:02:26 INFO - Running setup.py (path:/tmp/pip-UaxHKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:02:26 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)) 12:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:02:26 INFO - Running setup.py (path:/tmp/pip-Q9wfyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:02:26 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)) 12:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:02:26 INFO - Running setup.py (path:/tmp/pip-3sXEeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:02:26 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)) 12:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:02:26 INFO - Running setup.py (path:/tmp/pip-0yuJXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:02:26 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)) 12:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:02:26 INFO - Running setup.py (path:/tmp/pip-B9LwqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:02:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:02:27 INFO - Running setup.py (path:/tmp/pip-Js3GeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:02:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:02:27 INFO - Running setup.py (path:/tmp/pip-ROIBG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:02:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:02:27 INFO - Running setup.py (path:/tmp/pip-ICkI_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:02:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:02:27 INFO - Running setup.py (path:/tmp/pip-au7qnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:02:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:02:27 INFO - Running setup.py (path:/tmp/pip-mD7brR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:02:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:02:27 INFO - Running setup.py (path:/tmp/pip-0GsRRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:02:27 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)) 12:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:02:27 INFO - Running setup.py (path:/tmp/pip-10xtvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:02:27 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)) 12:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:02:27 INFO - Running setup.py (path:/tmp/pip-JpqmUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:02:27 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)) 12:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:02:27 INFO - Running setup.py (path:/tmp/pip-0IL6V2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:02:27 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)) 12:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:02:27 INFO - Running setup.py (path:/tmp/pip-5qOJnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:02:27 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)) 12:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:02:27 INFO - Running setup.py (path:/tmp/pip-hHjWPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:02:27 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)) 12:02:27 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)) 12:02:27 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)) 12:02:27 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)) 12:02:27 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)) 12:02:27 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)) 12:02:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:02: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 12:02: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 12:02: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 12:02: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 12:02: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 12:02: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 12:02:29 INFO - Downloading blessings-1.6.tar.gz 12:02:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:02:29 INFO - Installing collected packages: blessings 12:02:29 INFO - Running setup.py install for blessings 12:02:29 INFO - Successfully installed blessings 12:02:29 INFO - Cleaning up... 12:02:29 INFO - Return code: 0 12:02:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:02:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:02:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:02:30 INFO - Reading from file tmpfile_stdout 12:02:30 INFO - Current package versions: 12:02:30 INFO - argparse == 1.2.1 12:02:30 INFO - blessings == 1.6 12:02:30 INFO - blobuploader == 1.2.4 12:02:30 INFO - docopt == 0.6.1 12:02:30 INFO - functools32 == 3.2.3-2 12:02:30 INFO - jsonschema == 2.5.1 12:02:30 INFO - manifestparser == 1.1 12:02:30 INFO - mozInstall == 1.12 12:02:30 INFO - mozcrash == 0.17 12:02:30 INFO - mozdebug == 0.1 12:02:30 INFO - mozdevice == 0.48 12:02:30 INFO - mozfile == 1.2 12:02:30 INFO - mozhttpd == 0.7 12:02:30 INFO - mozinfo == 0.9 12:02:30 INFO - mozleak == 0.1 12:02:30 INFO - mozlog == 3.4 12:02:30 INFO - moznetwork == 0.27 12:02:30 INFO - mozprocess == 0.23 12:02:30 INFO - mozprofile == 0.28 12:02:30 INFO - mozrunner == 6.12 12:02:30 INFO - mozscreenshot == 0.1 12:02:30 INFO - mozsystemmonitor == 0.3 12:02:30 INFO - moztest == 0.7 12:02:30 INFO - mozversion == 1.4 12:02:30 INFO - psutil == 3.1.1 12:02:30 INFO - requests == 1.2.3 12:02:30 INFO - wsgiref == 0.1.2 12:02:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:02:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:02:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f08a74f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2abeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abbf60>, '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 0x2abcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abd1d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1476989674.459868-749303686', '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 12:02:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:02:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:02:30 INFO - Using env: {'DISPLAY': ':0', 12:02:30 INFO - 'HOME': '/home/cltbld', 12:02:30 INFO - 'LANG': 'en_US.UTF-8', 12:02:30 INFO - 'LANGUAGE': 'en_US:en', 12:02:30 INFO - 'LOGNAME': 'cltbld', 12:02:30 INFO - 'MAIL': '/var/mail/cltbld', 12:02:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:02:30 INFO - 'MOZ_NO_REMOTE': '1', 12:02:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:02:30 INFO - 'NO_EM_RESTART': '1', 12:02:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:02:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:02:30 INFO - 'PWD': '/builds/slave/test', 12:02:30 INFO - 'SHELL': '/bin/bash', 12:02:30 INFO - 'SHLVL': '1', 12:02:30 INFO - 'TERM': 'linux', 12:02:30 INFO - 'TMOUT': '86400', 12:02:30 INFO - 'USER': 'cltbld', 12:02:30 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1476989674.459868-749303686', 12:02:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:02:30 INFO - '_': '/tools/buildbot/bin/python'} 12:02:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:02:30 INFO - Cleaning up... 12:02:30 INFO - Return code: 0 12:02:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:02:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:02:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:30 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 0x7f08a74f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2abeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abbf60>, '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 0x2abcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abd1d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1476989674.459868-749303686', '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 12:02:30 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 12:02:30 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 12:02:30 INFO - Using env: {'DISPLAY': ':0', 12:02:30 INFO - 'HOME': '/home/cltbld', 12:02:30 INFO - 'LANG': 'en_US.UTF-8', 12:02:30 INFO - 'LANGUAGE': 'en_US:en', 12:02:30 INFO - 'LOGNAME': 'cltbld', 12:02:30 INFO - 'MAIL': '/var/mail/cltbld', 12:02:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:02:30 INFO - 'MOZ_NO_REMOTE': '1', 12:02:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:02:30 INFO - 'NO_EM_RESTART': '1', 12:02:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:02:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:02:30 INFO - 'PWD': '/builds/slave/test', 12:02:30 INFO - 'SHELL': '/bin/bash', 12:02:30 INFO - 'SHLVL': '1', 12:02:30 INFO - 'TERM': 'linux', 12:02:30 INFO - 'TMOUT': '86400', 12:02:30 INFO - 'USER': 'cltbld', 12:02:30 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1476989674.459868-749303686', 12:02:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:02:30 INFO - '_': '/tools/buildbot/bin/python'} 12:02:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:02:30 INFO - Cleaning up... 12:02:30 INFO - Return code: 0 12:02:30 INFO - Running post-action listener: _resource_record_post_action 12:02:30 INFO - Running post-action listener: _start_resource_monitoring 12:02:30 INFO - Starting resource monitoring. 12:02:30 INFO - [mozharness: 2016-10-20 19:02:30.710742Z] Finished create-virtualenv step (success) 12:02:30 INFO - [mozharness: 2016-10-20 19:02:30.711244Z] Running install step. 12:02:30 INFO - Running pre-action listener: _resource_record_pre_action 12:02:30 INFO - Running main action method: install 12:02:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:02:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:02:30 INFO - Reading from file tmpfile_stdout 12:02:30 INFO - Detecting whether we're running mozinstall >=1.0... 12:02:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:02:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:02:31 INFO - Reading from file tmpfile_stdout 12:02:31 INFO - Output received: 12:02:31 INFO - Usage: mozinstall [options] installer 12:02:31 INFO - Options: 12:02:31 INFO - -h, --help show this help message and exit 12:02:31 INFO - -d DEST, --destination=DEST 12:02:31 INFO - Directory to install application into. [default: 12:02:31 INFO - "/builds/slave/test"] 12:02:31 INFO - --app=APP Application being installed. [default: firefox] 12:02:31 INFO - mkdir: /builds/slave/test/build/application 12:02:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:02:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:02:47 INFO - Reading from file tmpfile_stdout 12:02:47 INFO - Output received: 12:02:47 INFO - /builds/slave/test/build/application/firefox/firefox 12:02:47 INFO - Running post-action listener: _resource_record_post_action 12:02:47 INFO - [mozharness: 2016-10-20 19:02:47.043752Z] Finished install step (success) 12:02:47 INFO - [mozharness: 2016-10-20 19:02:47.043997Z] Running run-tests step. 12:02:47 INFO - Running pre-action listener: _resource_record_pre_action 12:02:47 INFO - Running main action method: run_tests 12:02:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:02:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:02:47 INFO - Python 2.7.3 12:02:47 INFO - Return code: 0 12:02:47 INFO - grabbing minidump binary from tooltool 12:02:47 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')]} 12:02:47 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 0x2abbf60>, '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 0x2abcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abd1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:02:47 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 12:02:47 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 12:02:47 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 12:02:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:02:47 INFO - Return code: 0 12:02:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:02:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:02:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:02:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:02:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:02:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U-aWYEleS52Ruqp8S_LGMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 12:02:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/U-aWYEleS52Ruqp8S_LGMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 12:02:47 INFO - Using env: {'DISPLAY': ':0', 12:02:47 INFO - 'HOME': '/home/cltbld', 12:02:47 INFO - 'LANG': 'en_US.UTF-8', 12:02:47 INFO - 'LANGUAGE': 'en_US:en', 12:02:47 INFO - 'LOGNAME': 'cltbld', 12:02:47 INFO - 'MAIL': '/var/mail/cltbld', 12:02:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:02:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:02:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:02:47 INFO - 'MOZ_NO_REMOTE': '1', 12:02:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:02:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:02:47 INFO - 'NO_EM_RESTART': '1', 12:02:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:02:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:02:47 INFO - 'PWD': '/builds/slave/test', 12:02:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:02:47 INFO - 'SHELL': '/bin/bash', 12:02:47 INFO - 'SHLVL': '1', 12:02:47 INFO - 'TERM': 'linux', 12:02:47 INFO - 'TMOUT': '86400', 12:02:47 INFO - 'USER': 'cltbld', 12:02:47 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1476989674.459868-749303686', 12:02:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:02:47 INFO - '_': '/tools/buildbot/bin/python'} 12:02:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U-aWYEleS52Ruqp8S_LGMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 12:02:47 INFO - mozversion application_buildid: 20161020111749 12:02:47 INFO - mozversion application_changeset: ba53dda46a532a144ab53c6bc119fe08fe83cb40 12:02:47 INFO - mozversion application_display_name: Nightly 12:02:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:02:47 INFO - mozversion application_name: Firefox 12:02:47 INFO - mozversion application_remotingname: firefox 12:02:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:02:47 INFO - mozversion application_vendor: Mozilla 12:02:47 INFO - mozversion application_version: 52.0a1 12:02:47 INFO - mozversion platform_buildid: 20161020111749 12:02:47 INFO - mozversion platform_changeset: ba53dda46a532a144ab53c6bc119fe08fe83cb40 12:02:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:02:47 INFO - mozversion platform_version: 52.0a1 12:02:47 INFO - using testdate: 1476990167 12:02:47 INFO - actual date: 1476990167 12:02:47 INFO - starting webserver on 'localhost:45164' 12:02:47 INFO - SUITE-START | Running 2 tests 12:02:47 INFO - TEST-START | dromaeo_css 12:02:47 INFO - operating with platform_type : linux_ 12:02:47 INFO - Initialising browser for dromaeo_css test... 12:02:47 INFO - TEST-INFO | started process 21899 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8FEGk6/profile http://localhost:45164/getInfo.html) 12:02:51 INFO - PROCESS | 21899 | __metrics Screen width/height:1600/1200 12:02:51 INFO - PROCESS | 21899 | colorDepth:24 12:02:51 INFO - PROCESS | 21899 | Browser inner width/height: 1024/697 12:02:51 INFO - PROCESS | 21899 | __metrics 12:02:52 INFO - PROCESS | 21899 | 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" 12:02:52 INFO - PROCESS | 21899 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:02:53 INFO - PROCESS | 21899 | console.error: PushService: 12:02:53 INFO - PROCESS | 21899 | stateChangeProcessEnqueue: Error transitioning state 12:02:53 INFO - PROCESS | 21899 | UnknownError 12:02:53 INFO - TEST-INFO | 21899: exit 0 12:02:53 INFO - Browser initialized. 12:02:53 INFO - Running cycle 1/1 for dromaeo_css test... 12:02:53 INFO - TEST-INFO | started process 21982 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8FEGk6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:03:06 INFO - PROCESS | 21982 | RSS: Main: 173088768 12:03:06 INFO - PROCESS | 21982 | 12:03:57 INFO - PROCESS | 21982 | 1476990237738 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] 12:06:10 INFO - PROCESS | 21982 | Cycle 1(1): loaded http://localhost:45164/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45164/tests/dromaeo/cssquery-ext.html) 12:06:13 INFO - PROCESS | 21982 | RSS: Main: 282603520 12:06:13 INFO - PROCESS | 21982 | 12:09:15 INFO - PROCESS | 21982 | Cycle 1(1): loaded http://localhost:45164/tests/dromaeo/cssquery-ext.html (next: http://localhost:45164/tests/dromaeo/cssquery-jquery.html) 12:09:16 INFO - PROCESS | 21982 | RSS: Main: 280674304 12:09:16 INFO - PROCESS | 21982 | 12:12:18 INFO - PROCESS | 21982 | Cycle 1(1): loaded http://localhost:45164/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45164/tests/dromaeo/cssquery-mootools.html) 12:12:19 INFO - PROCESS | 21982 | RSS: Main: 249053184 12:12:19 INFO - PROCESS | 21982 | 12:15:21 INFO - PROCESS | 21982 | Cycle 1(1): loaded http://localhost:45164/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45164/tests/dromaeo/cssquery-prototype.html) 12:15:22 INFO - PROCESS | 21982 | RSS: Main: 221184000 12:15:22 INFO - PROCESS | 21982 | 12:18:25 INFO - PROCESS | 21982 | Cycle 1(1): loaded http://localhost:45164/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45164/tests/dromaeo/cssquery-yui.html) 12:18:26 INFO - PROCESS | 21982 | RSS: Main: 221437952 12:18:26 INFO - PROCESS | 21982 | 12:21:29 INFO - PROCESS | 21982 | Cycle 1(1): loaded http://localhost:45164/tests/dromaeo/cssquery-yui.html (next: http://localhost:45164/tests/dromaeo/cssquery-dojo.html) 12:21:29 INFO - PROCESS | 21982 | RSS: Main: 315781120 12:21:29 INFO - PROCESS | 21982 | 12:21:29 INFO - PROCESS | 21982 | __start_tp_report 12:21:29 INFO - PROCESS | 21982 | _x_x_mozilla_page_load 12:21:29 INFO - PROCESS | 21982 | _x_x_mozilla_page_load_details 12:21:29 INFO - PROCESS | 21982 | |i|pagename|runs| 12:21:29 INFO - PROCESS | 21982 | |0;dojo.html;2542.2373288013596;2549.0441084593276;2576.4847030593874;2588.9741102588982;2601.9089331873374;4552.84065057723;4572.748498832563;4573.108243892442;4576.931346029813;4604.3323718060865;4593.977030114853;4595.494495605481;4598.724076555409;4609.055143695543;4617.122746678137;4209.410682504445;4233.555476674936;4252.19208350414;4273.444452221207;4290.978545107286;4233.407322974786;4270.636995855356;4270.807813648377;4280.400743895857;4282.635975942048;4270.081932384537;4273.508546517143;4295.634871035965;4311.655067594585;4341.934870976938;4340.826366945318;4343.283358245917;4345.521992580813;4359.128174365108;4386.934195987063;4105.630493255591;4128.752274863487;4198.307279298912;4269.765162916038;4270.829166833323;4544.818207271705;4547.658440759984;4577.8397756078375;4611.331356953223;4625.213713668684;4826.734529600871;4827.565519103297;4879.268109783526;4879.756012199376;4912.4350699669285;4807.879803004917;4851.878703032417;4857.441394239637;4866.172750632366;4876.658633895629;4591.839285625054;4662.417197850269;4675.2052151134385;4702.976485117552;4719.221328480762;5101.234814777738;5104.336436263262;5105.310783044316;5106.4893510648635;5153.484651534892;4913.410390753061;4913.852584422473;4914.582260507826;4915.557599816034;4964.131277026506;4796.784144713496;4823.3729615149805;4828.66199366041;4938.555530002317;4991.429958487305;4876.731779752076;4883.584895283941;4942.40691117061;4943.9258411123865;4949.505049495094;4861.878453038632;4865.7323847188745;4868.026394720999;4869.14789911764;4932.950670493321;4109.835606575703;4163.042500224965;4193.937090943638;4223.957760422418;4281.636060934856;3671.6695497405362;3691.9446208306895;3701.130234394915;3711.183539621279;3716.7026637868908;4269.146170765797;4281.785910704452;4284.828606855754;4287.892802679958;4349.260625693576;4990.700557966461;5021.5229553192385;5021.59827213822;5028.34631497903;5076.771545280471;4173.311403618369;4292.248856450109;4292.935605965913;4293.613574778285;4362.934555981663;4446.466424029072;4450.910981780346;4494.505604383515;4496.437945256843;4501.572350626685;4674.789634466525;4679.555442232982;4681.180793361216;4685.812567497262;4687.10944920464;4931.16170251051;4936.160852655129;4936.703797772145;4937.456879743154;4940.184869496637;4620.884477888079;4672.836450724209;4674.322223277538;4675.742834144155;4679;4799.232122860465;4805.159097158054;4810.903781924272;4817.710937343771;4818.8795280118275;4874.683145595525;4874.878128046827;4876.878078047936;4877.878053048702;4880.365552478297;4842.104210721028;4855.077535268288;4866.416030076413;4890.437599676083;4954.727489988085;4887.36464259644;4891.706497610155;4896.681715688612;4909.877253068702;4944.752762361795;4605.723656580616;4640.466346370075;4643.3963584733765;4734.597559207506;4831.879203019812;4828.444728856227;4883.389576302962;4886;4913.852584422473;4932.45742968266;4757.690750101232;4770.284457331428;4772.976135119441;4817.638677099301;4832.927506087482 12:21:29 INFO - PROCESS | 21982 | |1;ext.html;552.9917051244231;585.6134950932383;593.0599999001582;602.1690067706564;604.2929772166567;27973.440531189364;28578.85710571447;37995.860124196246;39309.60690393095;39432.80283598585;39964.200715985666;40411.39382909259;40429.59570404295;40440.79779601098;40449.39325910107;7666.118396384431;7809;7810.609469526529;7819.491733037363;7820.45256832022;7676.385889128856;7748.883766743504;7771.533707977511;7775.688972441096;7805.804854878616;7791.688332466694;7836.764897053069;7837.216278372146;7839.216078392172;7842.921570784276;7790.8441831163345;7826.491278066907;7833.843323133506;7834.76495705124;7835.294823465915;7642.350400215988;7701.807454813618;7706.19084996073;7706.537607743498;7706.7687969361;38481.42277865834;38830.80584597087;38859.22281554353;38886;38901.805490972365;2703.6371179643297;2961.9259518511994;3019.1848200985833;3074.431230222416;3131.561581378609;29029.274268143254;29031.85484072566;29190.124296271148;30000.54999175014;30591.69408305933;3531.9293614127832;3551.0944709099012;3570.285942811448;3642.653947874948;3644.708423326154;172867;173510.1324493382;173623;173627;173916;28387;29106.417871642872;29111.85444072766;52374;52910.73544632252;32025.67974320227;32163.35673286568;32182.517262241086;32194;32226;11802.586909458129;11915.344656043828;11958.940205299092;11962.700932476757;11962.82055769164;9415.199708024758;9439.480828554495;9442.669506567237;9475.810483790285;9489.098535639103;7747.612619369009;7766.339861111869;7800.447191111965;7870.72452464161;7886.369090472748;3051.633803943497;3069.6776838431642;3076.4308602908086;3078.368934368449;3093.334932989373;827.2513375395276;827.8716798896181;845.8266055458616;862.6032025268447;991.6578780320777;26193.73806261913;27702.5844612331;27862;28031.299217519725;28288.575671364946;709.3651182191909;949.7720547068653;956.789506308611;984.1978787288338;1015.6445244164483;13584.524541641193;14390.928045359915;14683.706325873423;14785.48250811238;14836.18400987956;332204;332587;334242;335445;336325;47774.283385749244;48567.51432485701;48586.27120593194;48616.5138348612;48792.756036219595;993.7962717642865;1069.8448724934997;1145.2498613408231;1158.692946369213;1163.2962057954985;27780.30549236285;30965.380692385577;31653.84173079212;31668.022459872158;31983.520247196775;46655;47272.29091563698;47280.29079563878;47342.28986565273;47359.76320118377;309983;313788;314951;314973;315317;24359.75640243575;25337;25339.873300634117;25366.239012829643;25374.619380708937;41073.794631026656;41162.38256426216;41276.38085428781;41670.58329416788;41713;35022;35094.649053509136;35224.823875881484;35462.113447164025;35624.10939726424;34739.65260347465;34792.47811282883;34792.82603587067;34926.30147396987;34937.30125397529;28046.719532805226;29238;30117.698823012364;34924;35042.824785875906;29913.401731965674;32571.18572035718;32587.185320366232;32618.836905816268;32828.19444930552;24688.52785806866;25074.37314067163;25102.3724406884;25208.74791252064;25506.489870202862 12:21:29 INFO - PROCESS | 21982 | |2;jquery.html;334.71549183194304;354.632954891687;364.70641133887216;366.1213088587391;388.093800974724;12405.751884962307;12511.374431278433;13104.541341053065;13199.689137755815;17382.47852564422;14544.2000689962;14547.927260363684;15497.07017578946;15605;15661.921690391531;5010.774515146818;5027.597792176617;5194.402643695967;5252.3171987641745;5261.947380526203;3666.5416822897137;5087.6184286178495;5193.87015324618;5198.2722418861385;5202.4277329493725;3839.2705385976574;5823.155642431845;6091.878162436748;6110.236220472441;6225.097360882669;6010.158577799111;6067.302260240085;6164.044573091133;6195.2255968004;6198.473129783996;5402.594805389612;5425.891482170335;5428.565714742811;5428.945710542884;5446.537044351235;20362.28731994373;20759.58480830375;20869.478263043395;20964;21001.78998210029;1791.8745687801859;1879.736836842843;2053;2432.1852179519883;2502.9374265643505;12507.624771256877;13190.142640728322;13348.2658453785;13867;13885.583432497042;1679.722845730453;1679.9664006719797;1687.5190570687419;1825.178669598686;1837.0539172326262;63737.36262637361;64650.67674661644;65865.67067164682;66702.66648666775;67145.9999999995;9146.176844083931;9472.715818525456;9518.95240523793;9549.800816726336;9561.282903782245;12735.299558524184;12773.489060437665;12831.679208019874;12842.165259258118;12873.678158046123;6655.633940133339;6736.494762892803;6868.141482314711;6882.827929301708;6884.51808373409;6182.814515564541;6205.229662693536;6277.372262773686;6332.841678958063;6382.138411314506;5255.316808814906;5590.357108932443;5602.299712535933;5978.252718410199;6150;1575.440718544923;1591.8487743664334;1608.5013645769848;1618.919054047293;1639.2377544441892;800.2437696376868;832.854250506159;867.0245973280059;911.093462005309;925.3060204846365;16899.577510562336;17273.39543115985;18204.54488637768;19013.42959711211;19049.46788917777;775.577310365852;818.1940788323496;824.2087595907996;849;901.3550270755896;8850.601722922484;9555.952220238993;9584.137427631547;9682.273829462678;9760.902390976142;345813.16747329826;352115;355275;356034;356363;78097.79973102856;79216;79310.60344698354;79815;80392;402.12537730436185;422.81184872731956;893.4103491695449;911.2163539356148;916.2715641065236;9759.512024398893;9956.357201061744;10024.812409200213;10108.747281318027;10169.491525423551;33573;34334;35719.821400892826;35964;37911.24177516379;49591.75204123956;50512.24231636602;50744.49255507398;50946;51933.22100168576;7026.367626913602;7521.435892307989;7935.920640793749;7940.84118317642;8156.918430815853;11451.48468318911;11689.240199387013;11801.17391782567;11927.403629818647;12225.327606981702;10125.240606954361;10162.136218421518;10295.639652612123;10442.477876106317;10579.555334741026;10251.48742562854;10514.526846292089;10760.784784304427;10764.3541387517;10799.67600971972;9694.75763105928;10531.57873685044;10643.254972151875;10704.946475267885;11206.327620342805;7651.961740191264;7673.501222420525;7696.923030769621;7864.5281283123195;7960.601969901598;10530.36817790935;10688.519016644424;10809.0812280957;10823.458827058774;11070.169737269576 12:21:29 INFO - PROCESS | 21982 | |3;mootools.html;1211.9272843629387;1328.382302229463;1394.5398018653846;1439.8416174220833;1689.3918189451788;6751.122354093967;7211.423086153109;7566.583837888921;7857.607119644023;7870.173631768667;7905.683772649101;7970.60146992651;7980.122186559473;7980.561069141195;7988.201179882023;2157.1694897464513;2169.229923377202;2172.087723156278;2173.239366221818;2187.7593464718866;2093.4766308422895;2139.7860213978556;2141.271967531039;2146.2595404585395;2148.398448434441;2115.1010820401343;2124.957500849982;2129.829613630906;2131.381899249216;2178.8583742056794;2079.906404211814;2081.843861710378;2083.5416208434194;2084.718562993992;2093.152273329304;2010.7486564179478;2050.76416212136;2068.772435032145;2074.98962505188;2077.345636124631;7751.108622508371;7816.765497035098;7883.211678832128;7889.644965976545;7897.60511974399;4365.236083685374;4574.245249533823;4575.748333841638;4587.518310577408;4588.059447813191;2820.351319196576;2963.4369469800668;2994.1466681995526;3013.472642287591;3016.08009557085;891.9777005574848;894.7315805258462;898.2006014646904;906.3700727994046;917.8256131335025;10229.795404091876;10299.17606591471;10311.175105991577;10313.381197128196;10318.948405257926;3885.8057097145597;4050.5139383274195;4140.503139623264;4216.746995180238;4220.894477638022;8193.672253109928;8200.26197642215;8203.097659257477;8204.753857384288;8207.097219305871;4340;4345.67407444443;4349.217140914602;4361.498427680794;4363.956360436418;3613.223157021253;3729.384651532521;3970.5235371754998;4000.179963107556;4006.45912801768;3299;3326.5010248462922;3453.395655760232;3462.9826850865584;3473.635268296843;1036.7667274863247;1046.6075221791828;1050.8423736439443;1057.460695045517;1065.5950738719237;634.3434545245649;760.3726925286661;776.5107981971322;794.2970471133088;816.4285000499674;4540.750258735801;4727.078219747185;4779.784909679072;4808.951910480921;4866.6106711463;394.30995757424506;411.84555791578157;413.0067188411874;414.63097842919825;414.9419081328616;3263.494158405451;3265.9510107347933;3282.606087269543;3295.653956334598;3364;9112.088791120836;9566.61733530651;9575.329726919048;9580;9595.088466595662;9466.574004169692;9477.526123693926;9477.763055923657;9482.952585237168;9512.09635084666;7243;7274.56352618834;7323.3408993189805;7327.303906128909;7329.74345897891;4665.440147182359;4824.252240902666;4873.220284754422;5061.190209566452;5094.2103973884105;8447.831043379221;8694.217520423192;8800.735977920673;8841.513716745641;8954.910450895408;8937.329700272636;9124.771880703036;9138.086191381075;9145.542722863696;9198;5603.243562119062;5852.912206316823;6790.490713196629;6920.480963927826;6941.167059952838;7174.856502870018;7373.741919032808;7393.741219057307;7636.541807491568;7656.923430765621;6569.310222426768;6684;6721.630310332783;6876.965615172092;7101.715931362688;6737.3599508046655;6741.764038258833;6834.487413443912;6862.897056544056;6929.272426395156;6228.065790131516;6302.71637776292;6304.779332723333;6306.936930630818;6313.431791138636;4521.502634710114;4524.276115821453;4548.977255113703;4553.681242313139;4561.498235194193;4363.759993200278;4398.604125628709;4493.0789188216995;4586.151561961048;4661.766911654471 12:21:29 INFO - PROCESS | 21982 | |4;prototype.html;290.21207421849675;292.10469909726686;296.9480340940336;302.5673287199304;304.585763361828;4709.646776491764;4729.517003573122;4743.312219728137;4747.8813029674275;4755.429348478183;4688.343631891538;4692.044012272272;4692.991006933508;4696.718196908188;4698.412698412699;3740.588535261126;3761.1913438610695;3766.924661506768;3770.6417890300377;3781.8865434037025;3601.7298702597277;3772.15126596515;3787.4886890269736;3790.241951609675;3798.708439130695;3674.816259187043;3686.2258925625515;3722.683571896392;3723.1809002019513;3738.4579236010763;3703.981480092609;3709.2581483703098;3720.2373513429816;3724.664780169784;3740;3091.8608662610236;3160.1309639848996;3305.1406634275263;3317.0712200583876;3326.139520012787;4472.664550158751;4572.245579479382;4600.894396282496;4618.792154353062;4622.590110016444;4210.810513526868;4219.409282700424;4222.3244280914905;4223.817331147284;4224.556421575721;4590.380298659672;4689.788959496796;4942.752862356868;4954.529319714621;4957.851264462072;3579.8568057277676;3587.3542762302777;3590.138366791977;3597.9280414391565;3615.1504396466808;5130.3074084998425;5133.563647090002;5141.794328226866;5146.790504231502;5147.639665223436;3677.7609455385314;3679.8528058877882;3683.6684698377276;3712.814359282025;3713.4615480755137;3479.913002174915;3664.0839790052487;3665.3035923175044;3674.430463278196;3691.280200360904;4153.771542565188;4165.291900376883;4176.665866730655;4177.4569305990635;4181.205570941512;4921.3356196912955;4928.8767780805765;4937.604991600663;4948.802047918115;4958.330625365529;1239.962801115968;1263.4630282130058;1271.6693659648558;1273.6561128495255;1275.9983413020734;802.2819576479019;810.805406702399;820.5527987246965;825.781167990483;829.4774292195999;3935.5474120475938;3938.3895496198134;3939.907172869284;3943.29884029435;3966.5240171179644;4512.2329204035395;4535.684651451108;4535.954640453553;4557.384753058361;4561.429821272341;3905.5899130591447;3917.2948869203246;3926.823292951824;3955.960440395617;3963.207358528306;2312.838101332924;2383.825742338261;2411.6985376827897;2426.502566973766;2433.634954756765;4281.743095414286;4327.333976419101;4631.258998560214;4751.809927602857;4778.761061946889;5193.714345710947;5217.34783152106;5236.3716354037;5255.080360936897;5264.578833693296;4841.636877234221;4851.369321988119;4852.102361063215;4903.730294833818;4905.681130726492;4949.480304567968;5119.180931051014;5136.5377116059735;5151.583314588518;5177.637565370538;5011.248312753116;5011.448740638454;5021.974890125526;5026.47222041695;5027.421846487555;4835.540623640749;4839.903201936012;4844.32179494864;4852.199387101089;4883.121038213014;3408.6591340865716;3566.965579981776;3576.8390422431576;3602.9099272518397;3612.187257866959;5091.643584949018;5112.488751124858;5127.2052831811125;5141.663167576382;5145.871353216199;4954.405471343462;4968.453470118357;4970.16104041507;4971.37857767779;4993.450720420678;4716.58502449257;4949.9257511138085;4979.850604481727;4990.775415106256;5008.123578373843;4951.405831300267;4957;4962.362420401331;4963.751812409438;4985.800567977385;5017.84946451607;5017.9498205018945;5024;5031.371078615173;5074.391073071255;4787.593054590398;4879.146149423907;4899.407692500023;4931.580815630711;4935.358403407534 12:21:29 INFO - PROCESS | 21982 | |5;yui.html;606.9150318955344;610.2585358789071;666.1606375966282;673.9932600673992;771.2326235395782;11216.719582010453;11718.414079296044;11720.120990925694;11751.294922304667;11901.226420282675;13684.657883552916;14208.076475029142;14213;14836.184009879453;14895.776563351532;608.9086637004463;630.4420587779825;784.3842583571883;812.175641723651;817.3297895725508;631.8515148939996;772.5982489105662;788.3811208201563;796.9322607578363;799.5682331540961;832.4214670803793;836.9372297077713;839.689314953468;839.8698201778734;840.1724301562956;831.7546323834453;831.930968705217;832.4381042796089;832.6378025558871;832.995835020827;473.2971537267156;482.5343543480523;597.8684689368375;605.736504620487;615.5598746895946;13221;13263.469461221539;13277.86722132776;13280.601581952556;13288.667783305398;11600.245984011097;11663.358515281656;11890.167688261825;12143.149979501439;12191.45138468771;11546.266938576979;11639.35983520906;11641.6507504775;11715.238509496856;11786.764264714659;4056.776877271749;4079.388091786226;4080.10237747695;4099.938500922489;4218.620324170839;63393.683031584544;63470.68264658647;64241.357586424005;64411.35588644101;65405.672971635315;10082.29423940317;10206.753205224373;10216.744581385376;10329.173666106693;10694.411807350514;17257.482275531755;17293.048882311592;17389.739153912702;17411.73882391765;17432.21555030027;6587.934120658828;6630.933690663128;6640.136782218281;6681.665916704145;6723.125993620896;3523.3305671922253;3552.0942159749097;3586.228960773394;3627.075095850594;3648.1062139775395;2834.6881842997254;2894.536874100134;2904.404597057598;2956.5565165224957;2985.044785668565;516.2514354186445;520.2534363188761;522.6184885033947;531.2827682628498;536.5921899356517;489.73309546297355;563.1355868741463;568.4656422962402;576.3602401334515;596.4959609130278;8046.798830029179;8149.918500814916;8238.299744521662;8470;8628.827423451496;481.7175311480937;558.8016254229772;562.7720773086907;610.3255902228063;624.1854380034099;3728.9067773305883;4039.5354534228354;4043.332850079704;4162.880565568609;4215.451991241181;55298.72350638221;55874.441255587735;74477.6276118616;102631.48684256531;102868;84809;85286;85696.57151714202;86447;87029;72895;74487.62756186184;76208;78460.60769696115;79111.60444197858;7609.695612175451;7810.258025487569;7915.643796029078;8097.2712455879255;8341.496158914199;45175.32237016513;45223;45388.319175211735;45815.312770307806;46801.29798052964;62540.68729656323;67264;67267;67290.3270967284;70601;9415.340926135104;9522.571484283086;9657.613695452384;9701.417914925127;9874.12391645585;11247.212695111264;11435.885641143483;11794.174407791372;11863.288202707865;11981.161318707607;9933.15568176713;10021.699349019542;10126.44304563256;10297.124744396511;10410.947945260225;10324.535395907353;10335.896641033794;10711.357318560911;10725.678229653124;10880.401577913291;11272.154588406067;11507.309561426342;11700.94149529281;11913.702157445787;12139.210951288138;9722.805543889224;10013.349132306377;10039.949800250952;10173.643922462677;10641.148708103488;9290.535473226177;9336.719898403058;9670.323077384797;9729.416235025921;10371.896281037092 12:21:29 INFO - PROCESS | 21982 | __end_tp_report 12:21:29 INFO - PROCESS | 21982 | __start_cc_report 12:21:29 INFO - PROCESS | 21982 | _x_x_mozilla_cycle_collect,2326 12:21:29 INFO - PROCESS | 21982 | __end_cc_report 12:21:29 INFO - PROCESS | 21982 | __startTimestamp1476991289447__endTimestamp 12:21:29 INFO - PROCESS | 21982 | 12:21:29 INFO - PROCESS | 21982 | ------- Summary: start ------- 12:21:29 INFO - PROCESS | 21982 | Number of tests: 6 12:21:29 INFO - PROCESS | 21982 | 12:21:29 INFO - PROCESS | 21982 | [#0] dojo.html Cycles:165 Average:4572.87 Median:4679.56 stddev:473.63 (10.1%) stddev-sans-first:447.50 12:21:29 INFO - PROCESS | 21982 | Values: 2542.2 2549.0 2576.5 2589.0 2601.9 4552.8 4572.7 4573.1 4576.9 4604.3 4594.0 4595.5 4598.7 4609.1 4617.1 4209.4 4233.6 4252.2 4273.4 4291.0 4233.4 4270.6 4270.8 4280.4 4282.6 4270.1 4273.5 4295.6 4311.7 4341.9 4340.8 4343.3 4345.5 4359.1 4386.9 4105.6 4128.8 4198.3 4269.8 4270.8 4544.8 4547.7 4577.8 4611.3 4625.2 4826.7 4827.6 4879.3 4879.8 4912.4 4807.9 4851.9 4857.4 4866.2 4876.7 4591.8 4662.4 4675.2 4703.0 4719.2 5101.2 5104.3 5105.3 5106.5 5153.5 4913.4 4913.9 4914.6 4915.6 4964.1 4796.8 4823.4 4828.7 4938.6 4991.4 4876.7 4883.6 4942.4 4943.9 4949.5 4861.9 4865.7 4868.0 4869.1 4933.0 4109.8 4163.0 4193.9 4224.0 4281.6 3671.7 3691.9 3701.1 3711.2 3716.7 4269.1 4281.8 4284.8 4287.9 4349.3 4990.7 5021.5 5021.6 5028.3 5076.8 4173.3 4292.2 4292.9 4293.6 4362.9 4446.5 4450.9 4494.5 4496.4 4501.6 4674.8 4679.6 4681.2 4685.8 4687.1 4931.2 4936.2 4936.7 4937.5 4940.2 4620.9 4672.8 4674.3 4675.7 4679.0 4799.2 4805.2 4810.9 4817.7 4818.9 4874.7 4874.9 4876.9 4877.9 4880.4 4842.1 4855.1 4866.4 4890.4 4954.7 4887.4 4891.7 4896.7 4909.9 4944.8 4605.7 4640.5 4643.4 4734.6 4831.9 4828.4 4883.4 4886.0 4913.9 4932.5 4757.7 4770.3 4773.0 4817.6 4832.9 12:21:29 INFO - PROCESS | 21982 | 12:21:29 INFO - PROCESS | 21982 | [#1] ext.html Cycles:180 Average:41956.99 Median:35068.74 stddev:74621.24 (212.8%) stddev-sans-first:74765.82 12:21:29 INFO - PROCESS | 21982 | Values: 553.0 585.6 593.1 602.2 604.3 27973.4 28578.9 37995.9 39309.6 39432.8 39964.2 40411.4 40429.6 40440.8 40449.4 7666.1 7809.0 7810.6 7819.5 7820.5 7676.4 7748.9 7771.5 7775.7 7805.8 7791.7 7836.8 7837.2 7839.2 7842.9 7790.8 7826.5 7833.8 7834.8 7835.3 7642.4 7701.8 7706.2 7706.5 7706.8 38481.4 38830.8 38859.2 38886.0 38901.8 2703.6 2961.9 3019.2 3074.4 3131.6 29029.3 29031.9 29190.1 30000.5 30591.7 3531.9 3551.1 3570.3 3642.7 3644.7 172867.0 173510.1 173623.0 173627.0 173916.0 28387.0 29106.4 29111.9 52374.0 52910.7 32025.7 32163.4 32182.5 32194.0 32226.0 11802.6 11915.3 11958.9 11962.7 11962.8 9415.2 9439.5 9442.7 9475.8 9489.1 7747.6 7766.3 7800.4 7870.7 7886.4 3051.6 3069.7 3076.4 3078.4 3093.3 827.3 827.9 845.8 862.6 991.7 26193.7 27702.6 27862.0 28031.3 28288.6 709.4 949.8 956.8 984.2 1015.6 13584.5 14390.9 14683.7 14785.5 14836.2 332204.0 332587.0 334242.0 335445.0 336325.0 47774.3 48567.5 48586.3 48616.5 48792.8 993.8 1069.8 1145.2 1158.7 1163.3 27780.3 30965.4 31653.8 31668.0 31983.5 46655.0 47272.3 47280.3 47342.3 47359.8 309983.0 313788.0 314951.0 314973.0 315317.0 24359.8 25337.0 25339.9 25366.2 25374.6 41073.8 41162.4 41276.4 41670.6 41713.0 35022.0 35094.6 35224.8 35462.1 35624.1 34739.7 34792.5 34792.8 34926.3 34937.3 28046.7 29238.0 30117.7 34924.0 35042.8 29913.4 32571.2 32587.2 32618.8 32828.2 24688.5 25074.4 25102.4 25208.7 25506.5 12:21:29 INFO - PROCESS | 21982 | 12:21:29 INFO - PROCESS | 21982 | [#2] jquery.html Cycles:180 Average:23085.00 Median:25007.28 stddev:58558.72 (234.2%) stddev-sans-first:58698.08 12:21:29 INFO - PROCESS | 21982 | Values: 334.7 354.6 364.7 366.1 388.1 12405.8 12511.4 13104.5 13199.7 17382.5 14544.2 14547.9 15497.1 15605.0 15661.9 5010.8 5027.6 5194.4 5252.3 5261.9 3666.5 5087.6 5193.9 5198.3 5202.4 3839.3 5823.2 6091.9 6110.2 6225.1 6010.2 6067.3 6164.0 6195.2 6198.5 5402.6 5425.9 5428.6 5428.9 5446.5 20362.3 20759.6 20869.5 20964.0 21001.8 1791.9 1879.7 2053.0 2432.2 2502.9 12507.6 13190.1 13348.3 13867.0 13885.6 1679.7 1680.0 1687.5 1825.2 1837.1 63737.4 64650.7 65865.7 66702.7 67146.0 9146.2 9472.7 9519.0 9549.8 9561.3 12735.3 12773.5 12831.7 12842.2 12873.7 6655.6 6736.5 6868.1 6882.8 6884.5 6182.8 6205.2 6277.4 6332.8 6382.1 5255.3 5590.4 5602.3 5978.3 6150.0 1575.4 1591.8 1608.5 1618.9 1639.2 800.2 832.9 867.0 911.1 925.3 16899.6 17273.4 18204.5 19013.4 19049.5 775.6 818.2 824.2 849.0 901.4 8850.6 9556.0 9584.1 9682.3 9760.9 345813.2 352115.0 355275.0 356034.0 356363.0 78097.8 79216.0 79310.6 79815.0 80392.0 402.1 422.8 893.4 911.2 916.3 9759.5 9956.4 10024.8 10108.7 10169.5 33573.0 34334.0 35719.8 35964.0 37911.2 49591.8 50512.2 50744.5 50946.0 51933.2 7026.4 7521.4 7935.9 7940.8 8156.9 11451.5 11689.2 11801.2 11927.4 12225.3 10125.2 10162.1 10295.6 10442.5 10579.6 10251.5 10514.5 10760.8 10764.4 10799.7 9694.8 10531.6 10643.3 10704.9 11206.3 7652.0 7673.5 7696.9 7864.5 7960.6 10530.4 10688.5 10809.1 10823.5 11070.2 12:21:29 INFO - PROCESS | 21982 | 12:21:29 INFO - PROCESS | 21982 | [#3] mootools.html Cycles:180 Average:4999.44 Median:4663.60 stddev:2862.91 (61.4%) stddev-sans-first:2856.79 12:21:29 INFO - PROCESS | 21982 | Values: 1211.9 1328.4 1394.5 1439.8 1689.4 6751.1 7211.4 7566.6 7857.6 7870.2 7905.7 7970.6 7980.1 7980.6 7988.2 2157.2 2169.2 2172.1 2173.2 2187.8 2093.5 2139.8 2141.3 2146.3 2148.4 2115.1 2125.0 2129.8 2131.4 2178.9 2079.9 2081.8 2083.5 2084.7 2093.2 2010.7 2050.8 2068.8 2075.0 2077.3 7751.1 7816.8 7883.2 7889.6 7897.6 4365.2 4574.2 4575.7 4587.5 4588.1 2820.4 2963.4 2994.1 3013.5 3016.1 892.0 894.7 898.2 906.4 917.8 10229.8 10299.2 10311.2 10313.4 10318.9 3885.8 4050.5 4140.5 4216.7 4220.9 8193.7 8200.3 8203.1 8204.8 8207.1 4340.0 4345.7 4349.2 4361.5 4364.0 3613.2 3729.4 3970.5 4000.2 4006.5 3299.0 3326.5 3453.4 3463.0 3473.6 1036.8 1046.6 1050.8 1057.5 1065.6 634.3 760.4 776.5 794.3 816.4 4540.8 4727.1 4779.8 4809.0 4866.6 394.3 411.8 413.0 414.6 414.9 3263.5 3266.0 3282.6 3295.7 3364.0 9112.1 9566.6 9575.3 9580.0 9595.1 9466.6 9477.5 9477.8 9483.0 9512.1 7243.0 7274.6 7323.3 7327.3 7329.7 4665.4 4824.3 4873.2 5061.2 5094.2 8447.8 8694.2 8800.7 8841.5 8954.9 8937.3 9124.8 9138.1 9145.5 9198.0 5603.2 5852.9 6790.5 6920.5 6941.2 7174.9 7373.7 7393.7 7636.5 7656.9 6569.3 6684.0 6721.6 6877.0 7101.7 6737.4 6741.8 6834.5 6862.9 6929.3 6228.1 6302.7 6304.8 6306.9 6313.4 4521.5 4524.3 4549.0 4553.7 4561.5 4363.8 4398.6 4493.1 4586.2 4661.8 12:21:29 INFO - PROCESS | 21982 | 12:21:29 INFO - PROCESS | 21982 | [#4] prototype.html Cycles:180 Average:4075.05 Median:4609.84 stddev:1197.08 (26.0%) stddev-sans-first:1166.24 12:21:29 INFO - PROCESS | 21982 | Values: 290.2 292.1 296.9 302.6 304.6 4709.6 4729.5 4743.3 4747.9 4755.4 4688.3 4692.0 4693.0 4696.7 4698.4 3740.6 3761.2 3766.9 3770.6 3781.9 3601.7 3772.2 3787.5 3790.2 3798.7 3674.8 3686.2 3722.7 3723.2 3738.5 3704.0 3709.3 3720.2 3724.7 3740.0 3091.9 3160.1 3305.1 3317.1 3326.1 4472.7 4572.2 4600.9 4618.8 4622.6 4210.8 4219.4 4222.3 4223.8 4224.6 4590.4 4689.8 4942.8 4954.5 4957.9 3579.9 3587.4 3590.1 3597.9 3615.2 5130.3 5133.6 5141.8 5146.8 5147.6 3677.8 3679.9 3683.7 3712.8 3713.5 3479.9 3664.1 3665.3 3674.4 3691.3 4153.8 4165.3 4176.7 4177.5 4181.2 4921.3 4928.9 4937.6 4948.8 4958.3 1240.0 1263.5 1271.7 1273.7 1276.0 802.3 810.8 820.6 825.8 829.5 3935.5 3938.4 3939.9 3943.3 3966.5 4512.2 4535.7 4536.0 4557.4 4561.4 3905.6 3917.3 3926.8 3956.0 3963.2 2312.8 2383.8 2411.7 2426.5 2433.6 4281.7 4327.3 4631.3 4751.8 4778.8 5193.7 5217.3 5236.4 5255.1 5264.6 4841.6 4851.4 4852.1 4903.7 4905.7 4949.5 5119.2 5136.5 5151.6 5177.6 5011.2 5011.4 5022.0 5026.5 5027.4 4835.5 4839.9 4844.3 4852.2 4883.1 3408.7 3567.0 3576.8 3602.9 3612.2 5091.6 5112.5 5127.2 5141.7 5145.9 4954.4 4968.5 4970.2 4971.4 4993.5 4716.6 4949.9 4979.9 4990.8 5008.1 4951.4 4957.0 4962.4 4963.8 4985.8 5017.8 5017.9 5024.0 5031.4 5074.4 4787.6 4879.1 4899.4 4931.6 4935.4 12:21:29 INFO - PROCESS | 21982 | 12:21:29 INFO - PROCESS | 21982 | [#5] yui.html Cycles:180 Average:17356.81 Median:518.25 stddev:24693.98 (4764.9%) stddev-sans-first:24731.23 12:21:29 INFO - PROCESS | 21982 | Values: 606.9 610.3 666.2 674.0 771.2 11216.7 11718.4 11720.1 11751.3 11901.2 13684.7 14208.1 14213.0 14836.2 14895.8 608.9 630.4 784.4 812.2 817.3 631.9 772.6 788.4 796.9 799.6 832.4 836.9 839.7 839.9 840.2 831.8 831.9 832.4 832.6 833.0 473.3 482.5 597.9 605.7 615.6 13221.0 13263.5 13277.9 13280.6 13288.7 11600.2 11663.4 11890.2 12143.1 12191.5 11546.3 11639.4 11641.7 11715.2 11786.8 4056.8 4079.4 4080.1 4099.9 4218.6 63393.7 63470.7 64241.4 64411.4 65405.7 10082.3 10206.8 10216.7 10329.2 10694.4 17257.5 17293.0 17389.7 17411.7 17432.2 6587.9 6630.9 6640.1 6681.7 6723.1 3523.3 3552.1 3586.2 3627.1 3648.1 2834.7 2894.5 2904.4 2956.6 2985.0 516.3 520.3 522.6 531.3 536.6 489.7 563.1 568.5 576.4 596.5 8046.8 8149.9 8238.3 8470.0 8628.8 481.7 558.8 562.8 610.3 624.2 3728.9 4039.5 4043.3 4162.9 4215.5 55298.7 55874.4 74477.6 102631.5 102868.0 84809.0 85286.0 85696.6 86447.0 87029.0 72895.0 74487.6 76208.0 78460.6 79111.6 7609.7 7810.3 7915.6 8097.3 8341.5 45175.3 45223.0 45388.3 45815.3 46801.3 62540.7 67264.0 67267.0 67290.3 70601.0 9415.3 9522.6 9657.6 9701.4 9874.1 11247.2 11435.9 11794.2 11863.3 11981.2 9933.2 10021.7 10126.4 10297.1 10410.9 10324.5 10335.9 10711.4 10725.7 10880.4 11272.2 11507.3 11700.9 11913.7 12139.2 9722.8 10013.3 10039.9 10173.6 10641.1 9290.5 9336.7 9670.3 9729.4 10371.9 12:21:29 INFO - PROCESS | 21982 | -------- Summary: end -------- 12:21:29 INFO - PROCESS | 21982 | 12:21:30 INFO - TEST-INFO | 21982: exit 0 12:21:30 INFO - TEST-OK | dromaeo_css | took 1122979ms 12:21:30 INFO - TEST-START | kraken 12:21:30 INFO - operating with platform_type : linux_ 12:21:30 INFO - Initialising browser for kraken test... 12:21:30 INFO - TEST-INFO | started process 22291 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz7rlhP/profile http://localhost:45164/getInfo.html) 12:21:34 INFO - PROCESS | 22291 | __metrics Screen width/height:1600/1200 12:21:34 INFO - PROCESS | 22291 | colorDepth:24 12:21:34 INFO - PROCESS | 22291 | Browser inner width/height: 1024/697 12:21:34 INFO - PROCESS | 22291 | __metrics 12:21:35 INFO - PROCESS | 22291 | 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" 12:21:35 INFO - PROCESS | 22291 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:21:36 INFO - PROCESS | 22291 | console.error: PushService: 12:21:36 INFO - PROCESS | 22291 | stateChangeProcessEnqueue: Error transitioning state 12:21:36 INFO - PROCESS | 22291 | UnknownError 12:21:36 INFO - TEST-INFO | 22291: exit 0 12:21:36 INFO - Browser initialized. 12:21:36 INFO - Running cycle 1/1 for kraken test... 12:21:36 INFO - TEST-INFO | started process 22374 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz7rlhP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:21:49 INFO - PROCESS | 22374 | RSS: Main: 173707264 12:21:49 INFO - PROCESS | 22374 | 12:21:51 INFO - PROCESS | 22374 | Cycle 1(1): loaded http://localhost:45164/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45164/tests/kraken/driver.html?testName=audio-beat-detection) 12:21:52 INFO - PROCESS | 22374 | RSS: Main: 229810176 12:21:52 INFO - PROCESS | 22374 | 12:21:55 INFO - PROCESS | 22374 | Cycle 1(1): loaded http://localhost:45164/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45164/tests/kraken/driver.html?testName=audio-dft) 12:21:56 INFO - PROCESS | 22374 | RSS: Main: 216879104 12:21:56 INFO - PROCESS | 22374 | 12:21:59 INFO - PROCESS | 22374 | Cycle 1(1): loaded http://localhost:45164/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45164/tests/kraken/driver.html?testName=audio-fft) 12:22:00 INFO - PROCESS | 22374 | RSS: Main: 298491904 12:22:00 INFO - PROCESS | 22374 | 12:22:02 INFO - PROCESS | 22374 | Cycle 1(1): loaded http://localhost:45164/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45164/tests/kraken/driver.html?testName=audio-oscillator) 12:22:02 INFO - PROCESS | 22374 | RSS: Main: 210440192 12:22:02 INFO - PROCESS | 22374 | 12:22:05 INFO - PROCESS | 22374 | Cycle 1(1): loaded http://localhost:45164/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45164/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:22:05 INFO - PROCESS | 22374 | RSS: Main: 212336640 12:22:05 INFO - PROCESS | 22374 | 12:22:08 INFO - PROCESS | 22374 | Cycle 1(1): loaded http://localhost:45164/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45164/tests/kraken/driver.html?testName=imaging-darkroom) 12:22:09 INFO - PROCESS | 22374 | RSS: Main: 248639488 12:22:09 INFO - PROCESS | 22374 | 12:22:12 INFO - PROCESS | 22374 | Cycle 1(1): loaded http://localhost:45164/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45164/tests/kraken/driver.html?testName=imaging-desaturate) 12:22:13 INFO - PROCESS | 22374 | RSS: Main: 247869440 12:22:13 INFO - PROCESS | 22374 | 12:22:16 INFO - PROCESS | 22374 | Cycle 1(1): loaded http://localhost:45164/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45164/tests/kraken/driver.html?testName=json-parse-financial) 12:22:16 INFO - PROCESS | 22374 | RSS: Main: 247463936 12:22:16 INFO - PROCESS | 22374 | 12:22:18 INFO - PROCESS | 22374 | Cycle 1(1): loaded http://localhost:45164/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45164/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:22:19 INFO - PROCESS | 22374 | RSS: Main: 209526784 12:22:19 INFO - PROCESS | 22374 | 12:22:20 INFO - PROCESS | 22374 | Cycle 1(1): loaded http://localhost:45164/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45164/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:22:21 INFO - PROCESS | 22374 | RSS: Main: 217952256 12:22:21 INFO - PROCESS | 22374 | 12:22:23 INFO - PROCESS | 22374 | Cycle 1(1): loaded http://localhost:45164/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45164/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:22:24 INFO - PROCESS | 22374 | RSS: Main: 225976320 12:22:24 INFO - PROCESS | 22374 | 12:22:27 INFO - PROCESS | 22374 | Cycle 1(1): loaded http://localhost:45164/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45164/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:22:27 INFO - PROCESS | 22374 | RSS: Main: 235438080 12:22:27 INFO - PROCESS | 22374 | 12:22:30 INFO - PROCESS | 22374 | Cycle 1(1): loaded http://localhost:45164/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45164/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:22:31 INFO - PROCESS | 22374 | RSS: Main: 231714816 12:22:31 INFO - PROCESS | 22374 | 12:22:33 INFO - PROCESS | 22374 | Cycle 1(1): loaded http://localhost:45164/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45164/tests/kraken/driver.html?testName=ai-astar) 12:22:33 INFO - PROCESS | 22374 | RSS: Main: 281665536 12:22:33 INFO - PROCESS | 22374 | 12:22:33 INFO - PROCESS | 22374 | __start_tp_report 12:22:33 INFO - PROCESS | 22374 | _x_x_mozilla_page_load 12:22:33 INFO - PROCESS | 22374 | _x_x_mozilla_page_load_details 12:22:33 INFO - PROCESS | 22374 | |i|pagename|runs| 12:22:33 INFO - PROCESS | 22374 | |0;ai-astar;107;114;113;113;114;116;114;113;114;114 12:22:33 INFO - PROCESS | 22374 | |1;audio-beat-detection;159;129;128;160;129;133;128;129;159;126 12:22:33 INFO - PROCESS | 22374 | |2;audio-dft;160;161;161;161;162;161;162;162;161;161 12:22:33 INFO - PROCESS | 22374 | |3;audio-fft;78;76;76;103;77;76;76;76;103;77 12:22:33 INFO - PROCESS | 22374 | |4;audio-oscillator;83;84;125;84;85;83;110;84;83;112 12:22:33 INFO - PROCESS | 22374 | |5;imaging-gaussian-blur;118;117;117;116;116;117;117;117;116;117 12:22:33 INFO - PROCESS | 22374 | |6;imaging-darkroom;146;149;148;147;147;147;146;146;145;147 12:22:33 INFO - PROCESS | 22374 | |7;imaging-desaturate;84;85;85;85;85;85;85;85;86;85 12:22:33 INFO - PROCESS | 22374 | |8;json-parse-financial;65;63;61;62;62;63;64;63;63;71 12:22:33 INFO - PROCESS | 22374 | |9;json-stringify-tinderbox;67;67;67;67;67;68;68;71;68;68 12:22:33 INFO - PROCESS | 22374 | |10;stanford-crypto-aes;84;83;84;83;82;92;90;84;84;83 12:22:33 INFO - PROCESS | 22374 | |11;stanford-crypto-ccm;144;143;140;142;141;139;140;141;182;141 12:22:33 INFO - PROCESS | 22374 | |12;stanford-crypto-pbkdf2;184;177;179;178;173;176;177;173;180;178 12:22:33 INFO - PROCESS | 22374 | |13;stanford-crypto-sha256-iterative;70;71;71;74;68;74;69;70;69;68 12:22:33 INFO - PROCESS | 22374 | __end_tp_report 12:22:33 INFO - PROCESS | 22374 | __start_cc_report 12:22:33 INFO - PROCESS | 22374 | _x_x_mozilla_cycle_collect,1957 12:22:33 INFO - PROCESS | 22374 | __end_cc_report 12:22:33 INFO - PROCESS | 22374 | __startTimestamp1476991353651__endTimestamp 12:22:33 INFO - PROCESS | 22374 | 12:22:33 INFO - PROCESS | 22374 | ------- Summary: start ------- 12:22:33 INFO - PROCESS | 22374 | Number of tests: 14 12:22:33 INFO - PROCESS | 22374 | 12:22:33 INFO - PROCESS | 22374 | [#0] ai-astar Cycles:10 Average:113.20 Median:114.00 stddev:2.35 (2.1%) stddev-sans-first:0.93 12:22:33 INFO - PROCESS | 22374 | Values: 107.0 114.0 113.0 113.0 114.0 116.0 114.0 113.0 114.0 114.0 12:22:33 INFO - PROCESS | 22374 | 12:22:33 INFO - PROCESS | 22374 | [#1] audio-beat-detection Cycles:10 Average:138.00 Median:131.00 stddev:14.82 (11.3%) stddev-sans-first:13.64 12:22:33 INFO - PROCESS | 22374 | Values: 159.0 129.0 128.0 160.0 129.0 133.0 128.0 129.0 159.0 126.0 12:22:33 INFO - PROCESS | 22374 | 12:22:33 INFO - PROCESS | 22374 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 12:22:33 INFO - PROCESS | 22374 | Values: 160.0 161.0 161.0 161.0 162.0 161.0 162.0 162.0 161.0 161.0 12:22:33 INFO - PROCESS | 22374 | 12:22:33 INFO - PROCESS | 22374 | [#3] audio-fft Cycles:10 Average:81.80 Median:76.00 stddev:11.19 (14.7%) stddev-sans-first:11.79 12:22:33 INFO - PROCESS | 22374 | Values: 78.0 76.0 76.0 103.0 77.0 76.0 76.0 76.0 103.0 77.0 12:22:33 INFO - PROCESS | 22374 | 12:22:33 INFO - PROCESS | 22374 | [#4] audio-oscillator Cycles:10 Average:93.30 Median:83.50 stddev:15.92 (19.1%) stddev-sans-first:16.44 12:22:33 INFO - PROCESS | 22374 | Values: 83.0 84.0 125.0 84.0 85.0 83.0 110.0 84.0 83.0 112.0 12:22:33 INFO - PROCESS | 22374 | 12:22:33 INFO - PROCESS | 22374 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.50 12:22:33 INFO - PROCESS | 22374 | Values: 118.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 116.0 117.0 12:22:33 INFO - PROCESS | 22374 | 12:22:33 INFO - PROCESS | 22374 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:1.14 (0.8%) stddev-sans-first:1.17 12:22:33 INFO - PROCESS | 22374 | Values: 146.0 149.0 148.0 147.0 147.0 147.0 146.0 146.0 145.0 147.0 12:22:33 INFO - PROCESS | 22374 | 12:22:33 INFO - PROCESS | 22374 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.00 stddev:0.47 (0.6%) stddev-sans-first:0.33 12:22:33 INFO - PROCESS | 22374 | Values: 84.0 85.0 85.0 85.0 85.0 85.0 85.0 85.0 86.0 85.0 12:22:33 INFO - PROCESS | 22374 | 12:22:33 INFO - PROCESS | 22374 | [#8] json-parse-financial Cycles:10 Average:63.70 Median:63.00 stddev:2.79 (4.4%) stddev-sans-first:2.92 12:22:33 INFO - PROCESS | 22374 | Values: 65.0 63.0 61.0 62.0 62.0 63.0 64.0 63.0 63.0 71.0 12:22:33 INFO - PROCESS | 22374 | 12:22:33 INFO - PROCESS | 22374 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:1.23 (1.8%) stddev-sans-first:1.27 12:22:33 INFO - PROCESS | 22374 | Values: 67.0 67.0 67.0 67.0 67.0 68.0 68.0 71.0 68.0 68.0 12:22:33 INFO - PROCESS | 22374 | 12:22:33 INFO - PROCESS | 22374 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:84.00 stddev:3.31 (3.9%) stddev-sans-first:3.50 12:22:33 INFO - PROCESS | 22374 | Values: 84.0 83.0 84.0 83.0 82.0 92.0 90.0 84.0 84.0 83.0 12:22:33 INFO - PROCESS | 22374 | 12:22:33 INFO - PROCESS | 22374 | [#11] stanford-crypto-ccm Cycles:10 Average:145.30 Median:141.50 stddev:12.98 (9.2%) stddev-sans-first:13.76 12:22:33 INFO - PROCESS | 22374 | Values: 144.0 143.0 140.0 142.0 141.0 139.0 140.0 141.0 182.0 141.0 12:22:33 INFO - PROCESS | 22374 | 12:22:33 INFO - PROCESS | 22374 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.50 Median:178.00 stddev:3.24 (1.8%) stddev-sans-first:2.44 12:22:33 INFO - PROCESS | 22374 | Values: 184.0 177.0 179.0 178.0 173.0 176.0 177.0 173.0 180.0 178.0 12:22:33 INFO - PROCESS | 22374 | 12:22:33 INFO - PROCESS | 22374 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.50 stddev:2.17 (3.1%) stddev-sans-first:2.30 12:22:33 INFO - PROCESS | 22374 | Values: 70.0 71.0 71.0 74.0 68.0 74.0 69.0 70.0 69.0 68.0 12:22:33 INFO - PROCESS | 22374 | -------- Summary: end -------- 12:22:33 INFO - PROCESS | 22374 | 12:22:35 INFO - TEST-INFO | 22374: exit 0 12:22:35 INFO - TEST-OK | kraken | took 64805ms 12:22:35 INFO - SUITE-END | took 1187s 12:22:35 INFO - Completed test suite (00:19:47) 12:22:35 INFO - javascript benchmark 12:22:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2542.2373288013596, 2549.0441084593276, 2576.4847030593874, 2588.9741102588982, 2601.9089331873374, 4552.84065057723, 4572.748498832563, 4573.108243892442, 4576.931346029813, 4604.3323718060865, 4593.977030114853, 4595.494495605481, 4598.724076555409, 4609.055143695543, 4617.122746678137, 4209.410682504445, 4233.555476674936, 4252.19208350414, 4273.444452221207, 4290.978545107286, 4233.407322974786, 4270.636995855356, 4270.807813648377, 4280.400743895857, 4282.635975942048, 4270.081932384537, 4273.508546517143, 4295.634871035965, 4311.655067594585, 4341.934870976938, 4340.826366945318, 4343.283358245917, 4345.521992580813, 4359.128174365108, 4386.934195987063, 4105.630493255591, 4128.752274863487, 4198.307279298912, 4269.765162916038, 4270.829166833323, 4544.818207271705, 4547.658440759984, 4577.8397756078375, 4611.331356953223, 4625.213713668684, 4826.734529600871, 4827.565519103297, 4879.268109783526, 4879.756012199376, 4912.4350699669285, 4807.879803004917, 4851.878703032417, 4857.441394239637, 4866.172750632366, 4876.658633895629, 4591.839285625054, 4662.417197850269, 4675.2052151134385, 4702.976485117552, 4719.221328480762, 5101.234814777738, 5104.336436263262, 5105.310783044316, 5106.4893510648635, 5153.484651534892, 4913.410390753061, 4913.852584422473, 4914.582260507826, 4915.557599816034, 4964.131277026506, 4796.784144713496, 4823.3729615149805, 4828.66199366041, 4938.555530002317, 4991.429958487305, 4876.731779752076, 4883.584895283941, 4942.40691117061, 4943.9258411123865, 4949.505049495094, 4861.878453038632, 4865.7323847188745, 4868.026394720999, 4869.14789911764, 4932.950670493321, 4109.835606575703, 4163.042500224965, 4193.937090943638, 4223.957760422418, 4281.636060934856, 3671.6695497405362, 3691.9446208306895, 3701.130234394915, 3711.183539621279, 3716.7026637868908, 4269.146170765797, 4281.785910704452, 4284.828606855754, 4287.892802679958, 4349.260625693576, 4990.700557966461, 5021.5229553192385, 5021.59827213822, 5028.34631497903, 5076.771545280471, 4173.311403618369, 4292.248856450109, 4292.935605965913, 4293.613574778285, 4362.934555981663, 4446.466424029072, 4450.910981780346, 4494.505604383515, 4496.437945256843, 4501.572350626685, 4674.789634466525, 4679.555442232982, 4681.180793361216, 4685.812567497262, 4687.10944920464, 4931.16170251051, 4936.160852655129, 4936.703797772145, 4937.456879743154, 4940.184869496637, 4620.884477888079, 4672.836450724209, 4674.322223277538, 4675.742834144155, 4679.0, 4799.232122860465, 4805.159097158054, 4810.903781924272, 4817.710937343771, 4818.8795280118275, 4874.683145595525, 4874.878128046827, 4876.878078047936, 4877.878053048702, 4880.365552478297, 4842.104210721028, 4855.077535268288, 4866.416030076413, 4890.437599676083, 4954.727489988085, 4887.36464259644, 4891.706497610155, 4896.681715688612, 4909.877253068702, 4944.752762361795, 4605.723656580616, 4640.466346370075, 4643.3963584733765, 4734.597559207506, 4831.879203019812, 4828.444728856227, 4883.389576302962, 4886.0, 4913.852584422473, 4932.45742968266, 4757.690750101232, 4770.284457331428, 4772.976135119441, 4817.638677099301, 4832.927506087482], "value": 4542.679132680553, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.9917051244231, 585.6134950932383, 593.0599999001582, 602.1690067706564, 604.2929772166567, 27973.440531189364, 28578.85710571447, 37995.860124196246, 39309.60690393095, 39432.80283598585, 39964.200715985666, 40411.39382909259, 40429.59570404295, 40440.79779601098, 40449.39325910107, 7666.118396384431, 7809.0, 7810.609469526529, 7819.491733037363, 7820.45256832022, 7676.385889128856, 7748.883766743504, 7771.533707977511, 7775.688972441096, 7805.804854878616, 7791.688332466694, 7836.764897053069, 7837.216278372146, 7839.216078392172, 7842.921570784276, 7790.8441831163345, 7826.491278066907, 7833.843323133506, 7834.76495705124, 7835.294823465915, 7642.350400215988, 7701.807454813618, 7706.19084996073, 7706.537607743498, 7706.7687969361, 38481.42277865834, 38830.80584597087, 38859.22281554353, 38886.0, 38901.805490972365, 2703.6371179643297, 2961.9259518511994, 3019.1848200985833, 3074.431230222416, 3131.561581378609, 29029.274268143254, 29031.85484072566, 29190.124296271148, 30000.54999175014, 30591.69408305933, 3531.9293614127832, 3551.0944709099012, 3570.285942811448, 3642.653947874948, 3644.708423326154, 172867.0, 173510.1324493382, 173623.0, 173627.0, 173916.0, 28387.0, 29106.417871642872, 29111.85444072766, 52374.0, 52910.73544632252, 32025.67974320227, 32163.35673286568, 32182.517262241086, 32194.0, 32226.0, 11802.586909458129, 11915.344656043828, 11958.940205299092, 11962.700932476757, 11962.82055769164, 9415.199708024758, 9439.480828554495, 9442.669506567237, 9475.810483790285, 9489.098535639103, 7747.612619369009, 7766.339861111869, 7800.447191111965, 7870.72452464161, 7886.369090472748, 3051.633803943497, 3069.6776838431642, 3076.4308602908086, 3078.368934368449, 3093.334932989373, 827.2513375395276, 827.8716798896181, 845.8266055458616, 862.6032025268447, 991.6578780320777, 26193.73806261913, 27702.5844612331, 27862.0, 28031.299217519725, 28288.575671364946, 709.3651182191909, 949.7720547068653, 956.789506308611, 984.1978787288338, 1015.6445244164483, 13584.524541641193, 14390.928045359915, 14683.706325873423, 14785.48250811238, 14836.18400987956, 332204.0, 332587.0, 334242.0, 335445.0, 336325.0, 47774.283385749244, 48567.51432485701, 48586.27120593194, 48616.5138348612, 48792.756036219595, 993.7962717642865, 1069.8448724934997, 1145.2498613408231, 1158.692946369213, 1163.2962057954985, 27780.30549236285, 30965.380692385577, 31653.84173079212, 31668.022459872158, 31983.520247196775, 46655.0, 47272.29091563698, 47280.29079563878, 47342.28986565273, 47359.76320118377, 309983.0, 313788.0, 314951.0, 314973.0, 315317.0, 24359.75640243575, 25337.0, 25339.873300634117, 25366.239012829643, 25374.619380708937, 41073.794631026656, 41162.38256426216, 41276.38085428781, 41670.58329416788, 41713.0, 35022.0, 35094.649053509136, 35224.823875881484, 35462.113447164025, 35624.10939726424, 34739.65260347465, 34792.47811282883, 34792.82603587067, 34926.30147396987, 34937.30125397529, 28046.719532805226, 29238.0, 30117.698823012364, 34924.0, 35042.824785875906, 29913.401731965674, 32571.18572035718, 32587.185320366232, 32618.836905816268, 32828.19444930552, 24688.52785806866, 25074.37314067163, 25102.3724406884, 25208.74791252064, 25506.489870202862], "value": 15801.222494438649, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.71549183194304, 354.632954891687, 364.70641133887216, 366.1213088587391, 388.093800974724, 12405.751884962307, 12511.374431278433, 13104.541341053065, 13199.689137755815, 17382.47852564422, 14544.2000689962, 14547.927260363684, 15497.07017578946, 15605.0, 15661.921690391531, 5010.774515146818, 5027.597792176617, 5194.402643695967, 5252.3171987641745, 5261.947380526203, 3666.5416822897137, 5087.6184286178495, 5193.87015324618, 5198.2722418861385, 5202.4277329493725, 3839.2705385976574, 5823.155642431845, 6091.878162436748, 6110.236220472441, 6225.097360882669, 6010.158577799111, 6067.302260240085, 6164.044573091133, 6195.2255968004, 6198.473129783996, 5402.594805389612, 5425.891482170335, 5428.565714742811, 5428.945710542884, 5446.537044351235, 20362.28731994373, 20759.58480830375, 20869.478263043395, 20964.0, 21001.78998210029, 1791.8745687801859, 1879.736836842843, 2053.0, 2432.1852179519883, 2502.9374265643505, 12507.624771256877, 13190.142640728322, 13348.2658453785, 13867.0, 13885.583432497042, 1679.722845730453, 1679.9664006719797, 1687.5190570687419, 1825.178669598686, 1837.0539172326262, 63737.36262637361, 64650.67674661644, 65865.67067164682, 66702.66648666775, 67145.9999999995, 9146.176844083931, 9472.715818525456, 9518.95240523793, 9549.800816726336, 9561.282903782245, 12735.299558524184, 12773.489060437665, 12831.679208019874, 12842.165259258118, 12873.678158046123, 6655.633940133339, 6736.494762892803, 6868.141482314711, 6882.827929301708, 6884.51808373409, 6182.814515564541, 6205.229662693536, 6277.372262773686, 6332.841678958063, 6382.138411314506, 5255.316808814906, 5590.357108932443, 5602.299712535933, 5978.252718410199, 6150.0, 1575.440718544923, 1591.8487743664334, 1608.5013645769848, 1618.919054047293, 1639.2377544441892, 800.2437696376868, 832.854250506159, 867.0245973280059, 911.093462005309, 925.3060204846365, 16899.577510562336, 17273.39543115985, 18204.54488637768, 19013.42959711211, 19049.46788917777, 775.577310365852, 818.1940788323496, 824.2087595907996, 849.0, 901.3550270755896, 8850.601722922484, 9555.952220238993, 9584.137427631547, 9682.273829462678, 9760.902390976142, 345813.16747329826, 352115.0, 355275.0, 356034.0, 356363.0, 78097.79973102856, 79216.0, 79310.60344698354, 79815.0, 80392.0, 402.12537730436185, 422.81184872731956, 893.4103491695449, 911.2163539356148, 916.2715641065236, 9759.512024398893, 9956.357201061744, 10024.812409200213, 10108.747281318027, 10169.491525423551, 33573.0, 34334.0, 35719.821400892826, 35964.0, 37911.24177516379, 49591.75204123956, 50512.24231636602, 50744.49255507398, 50946.0, 51933.22100168576, 7026.367626913602, 7521.435892307989, 7935.920640793749, 7940.84118317642, 8156.918430815853, 11451.48468318911, 11689.240199387013, 11801.17391782567, 11927.403629818647, 12225.327606981702, 10125.240606954361, 10162.136218421518, 10295.639652612123, 10442.477876106317, 10579.555334741026, 10251.48742562854, 10514.526846292089, 10760.784784304427, 10764.3541387517, 10799.67600971972, 9694.75763105928, 10531.57873685044, 10643.254972151875, 10704.946475267885, 11206.327620342805, 7651.961740191264, 7673.501222420525, 7696.923030769621, 7864.5281283123195, 7960.601969901598, 10530.36817790935, 10688.519016644424, 10809.0812280957, 10823.458827058774, 11070.169737269576], "value": 8072.08752700639, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1211.9272843629387, 1328.382302229463, 1394.5398018653846, 1439.8416174220833, 1689.3918189451788, 6751.122354093967, 7211.423086153109, 7566.583837888921, 7857.607119644023, 7870.173631768667, 7905.683772649101, 7970.60146992651, 7980.122186559473, 7980.561069141195, 7988.201179882023, 2157.1694897464513, 2169.229923377202, 2172.087723156278, 2173.239366221818, 2187.7593464718866, 2093.4766308422895, 2139.7860213978556, 2141.271967531039, 2146.2595404585395, 2148.398448434441, 2115.1010820401343, 2124.957500849982, 2129.829613630906, 2131.381899249216, 2178.8583742056794, 2079.906404211814, 2081.843861710378, 2083.5416208434194, 2084.718562993992, 2093.152273329304, 2010.7486564179478, 2050.76416212136, 2068.772435032145, 2074.98962505188, 2077.345636124631, 7751.108622508371, 7816.765497035098, 7883.211678832128, 7889.644965976545, 7897.60511974399, 4365.236083685374, 4574.245249533823, 4575.748333841638, 4587.518310577408, 4588.059447813191, 2820.351319196576, 2963.4369469800668, 2994.1466681995526, 3013.472642287591, 3016.08009557085, 891.9777005574848, 894.7315805258462, 898.2006014646904, 906.3700727994046, 917.8256131335025, 10229.795404091876, 10299.17606591471, 10311.175105991577, 10313.381197128196, 10318.948405257926, 3885.8057097145597, 4050.5139383274195, 4140.503139623264, 4216.746995180238, 4220.894477638022, 8193.672253109928, 8200.26197642215, 8203.097659257477, 8204.753857384288, 8207.097219305871, 4340.0, 4345.67407444443, 4349.217140914602, 4361.498427680794, 4363.956360436418, 3613.223157021253, 3729.384651532521, 3970.5235371754998, 4000.179963107556, 4006.45912801768, 3299.0, 3326.5010248462922, 3453.395655760232, 3462.9826850865584, 3473.635268296843, 1036.7667274863247, 1046.6075221791828, 1050.8423736439443, 1057.460695045517, 1065.5950738719237, 634.3434545245649, 760.3726925286661, 776.5107981971322, 794.2970471133088, 816.4285000499674, 4540.750258735801, 4727.078219747185, 4779.784909679072, 4808.951910480921, 4866.6106711463, 394.30995757424506, 411.84555791578157, 413.0067188411874, 414.63097842919825, 414.9419081328616, 3263.494158405451, 3265.9510107347933, 3282.606087269543, 3295.653956334598, 3364.0, 9112.088791120836, 9566.61733530651, 9575.329726919048, 9580.0, 9595.088466595662, 9466.574004169692, 9477.526123693926, 9477.763055923657, 9482.952585237168, 9512.09635084666, 7243.0, 7274.56352618834, 7323.3408993189805, 7327.303906128909, 7329.74345897891, 4665.440147182359, 4824.252240902666, 4873.220284754422, 5061.190209566452, 5094.2103973884105, 8447.831043379221, 8694.217520423192, 8800.735977920673, 8841.513716745641, 8954.910450895408, 8937.329700272636, 9124.771880703036, 9138.086191381075, 9145.542722863696, 9198.0, 5603.243562119062, 5852.912206316823, 6790.490713196629, 6920.480963927826, 6941.167059952838, 7174.856502870018, 7373.741919032808, 7393.741219057307, 7636.541807491568, 7656.923430765621, 6569.310222426768, 6684.0, 6721.630310332783, 6876.965615172092, 7101.715931362688, 6737.3599508046655, 6741.764038258833, 6834.487413443912, 6862.897056544056, 6929.272426395156, 6228.065790131516, 6302.71637776292, 6304.779332723333, 6306.936930630818, 6313.431791138636, 4521.502634710114, 4524.276115821453, 4548.977255113703, 4553.681242313139, 4561.498235194193, 4363.759993200278, 4398.604125628709, 4493.0789188216995, 4586.151561961048, 4661.766911654471], "value": 3930.358097419269, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.21207421849675, 292.10469909726686, 296.9480340940336, 302.5673287199304, 304.585763361828, 4709.646776491764, 4729.517003573122, 4743.312219728137, 4747.8813029674275, 4755.429348478183, 4688.343631891538, 4692.044012272272, 4692.991006933508, 4696.718196908188, 4698.412698412699, 3740.588535261126, 3761.1913438610695, 3766.924661506768, 3770.6417890300377, 3781.8865434037025, 3601.7298702597277, 3772.15126596515, 3787.4886890269736, 3790.241951609675, 3798.708439130695, 3674.816259187043, 3686.2258925625515, 3722.683571896392, 3723.1809002019513, 3738.4579236010763, 3703.981480092609, 3709.2581483703098, 3720.2373513429816, 3724.664780169784, 3740.0, 3091.8608662610236, 3160.1309639848996, 3305.1406634275263, 3317.0712200583876, 3326.139520012787, 4472.664550158751, 4572.245579479382, 4600.894396282496, 4618.792154353062, 4622.590110016444, 4210.810513526868, 4219.409282700424, 4222.3244280914905, 4223.817331147284, 4224.556421575721, 4590.380298659672, 4689.788959496796, 4942.752862356868, 4954.529319714621, 4957.851264462072, 3579.8568057277676, 3587.3542762302777, 3590.138366791977, 3597.9280414391565, 3615.1504396466808, 5130.3074084998425, 5133.563647090002, 5141.794328226866, 5146.790504231502, 5147.639665223436, 3677.7609455385314, 3679.8528058877882, 3683.6684698377276, 3712.814359282025, 3713.4615480755137, 3479.913002174915, 3664.0839790052487, 3665.3035923175044, 3674.430463278196, 3691.280200360904, 4153.771542565188, 4165.291900376883, 4176.665866730655, 4177.4569305990635, 4181.205570941512, 4921.3356196912955, 4928.8767780805765, 4937.604991600663, 4948.802047918115, 4958.330625365529, 1239.962801115968, 1263.4630282130058, 1271.6693659648558, 1273.6561128495255, 1275.9983413020734, 802.2819576479019, 810.805406702399, 820.5527987246965, 825.781167990483, 829.4774292195999, 3935.5474120475938, 3938.3895496198134, 3939.907172869284, 3943.29884029435, 3966.5240171179644, 4512.2329204035395, 4535.684651451108, 4535.954640453553, 4557.384753058361, 4561.429821272341, 3905.5899130591447, 3917.2948869203246, 3926.823292951824, 3955.960440395617, 3963.207358528306, 2312.838101332924, 2383.825742338261, 2411.6985376827897, 2426.502566973766, 2433.634954756765, 4281.743095414286, 4327.333976419101, 4631.258998560214, 4751.809927602857, 4778.761061946889, 5193.714345710947, 5217.34783152106, 5236.3716354037, 5255.080360936897, 5264.578833693296, 4841.636877234221, 4851.369321988119, 4852.102361063215, 4903.730294833818, 4905.681130726492, 4949.480304567968, 5119.180931051014, 5136.5377116059735, 5151.583314588518, 5177.637565370538, 5011.248312753116, 5011.448740638454, 5021.974890125526, 5026.47222041695, 5027.421846487555, 4835.540623640749, 4839.903201936012, 4844.32179494864, 4852.199387101089, 4883.121038213014, 3408.6591340865716, 3566.965579981776, 3576.8390422431576, 3602.9099272518397, 3612.187257866959, 5091.643584949018, 5112.488751124858, 5127.2052831811125, 5141.663167576382, 5145.871353216199, 4954.405471343462, 4968.453470118357, 4970.16104041507, 4971.37857767779, 4993.450720420678, 4716.58502449257, 4949.9257511138085, 4979.850604481727, 4990.775415106256, 5008.123578373843, 4951.405831300267, 4957.0, 4962.362420401331, 4963.751812409438, 4985.800567977385, 5017.84946451607, 5017.9498205018945, 5024.0, 5031.371078615173, 5074.391073071255, 4787.593054590398, 4879.146149423907, 4899.407692500023, 4931.580815630711, 4935.358403407534], "value": 3695.702558866049, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.9150318955344, 610.2585358789071, 666.1606375966282, 673.9932600673992, 771.2326235395782, 11216.719582010453, 11718.414079296044, 11720.120990925694, 11751.294922304667, 11901.226420282675, 13684.657883552916, 14208.076475029142, 14213.0, 14836.184009879453, 14895.776563351532, 608.9086637004463, 630.4420587779825, 784.3842583571883, 812.175641723651, 817.3297895725508, 631.8515148939996, 772.5982489105662, 788.3811208201563, 796.9322607578363, 799.5682331540961, 832.4214670803793, 836.9372297077713, 839.689314953468, 839.8698201778734, 840.1724301562956, 831.7546323834453, 831.930968705217, 832.4381042796089, 832.6378025558871, 832.995835020827, 473.2971537267156, 482.5343543480523, 597.8684689368375, 605.736504620487, 615.5598746895946, 13221.0, 13263.469461221539, 13277.86722132776, 13280.601581952556, 13288.667783305398, 11600.245984011097, 11663.358515281656, 11890.167688261825, 12143.149979501439, 12191.45138468771, 11546.266938576979, 11639.35983520906, 11641.6507504775, 11715.238509496856, 11786.764264714659, 4056.776877271749, 4079.388091786226, 4080.10237747695, 4099.938500922489, 4218.620324170839, 63393.683031584544, 63470.68264658647, 64241.357586424005, 64411.35588644101, 65405.672971635315, 10082.29423940317, 10206.753205224373, 10216.744581385376, 10329.173666106693, 10694.411807350514, 17257.482275531755, 17293.048882311592, 17389.739153912702, 17411.73882391765, 17432.21555030027, 6587.934120658828, 6630.933690663128, 6640.136782218281, 6681.665916704145, 6723.125993620896, 3523.3305671922253, 3552.0942159749097, 3586.228960773394, 3627.075095850594, 3648.1062139775395, 2834.6881842997254, 2894.536874100134, 2904.404597057598, 2956.5565165224957, 2985.044785668565, 516.2514354186445, 520.2534363188761, 522.6184885033947, 531.2827682628498, 536.5921899356517, 489.73309546297355, 563.1355868741463, 568.4656422962402, 576.3602401334515, 596.4959609130278, 8046.798830029179, 8149.918500814916, 8238.299744521662, 8470.0, 8628.827423451496, 481.7175311480937, 558.8016254229772, 562.7720773086907, 610.3255902228063, 624.1854380034099, 3728.9067773305883, 4039.5354534228354, 4043.332850079704, 4162.880565568609, 4215.451991241181, 55298.72350638221, 55874.441255587735, 74477.6276118616, 102631.48684256531, 102868.0, 84809.0, 85286.0, 85696.57151714202, 86447.0, 87029.0, 72895.0, 74487.62756186184, 76208.0, 78460.60769696115, 79111.60444197858, 7609.695612175451, 7810.258025487569, 7915.643796029078, 8097.2712455879255, 8341.496158914199, 45175.32237016513, 45223.0, 45388.319175211735, 45815.312770307806, 46801.29798052964, 62540.68729656323, 67264.0, 67267.0, 67290.3270967284, 70601.0, 9415.340926135104, 9522.571484283086, 9657.613695452384, 9701.417914925127, 9874.12391645585, 11247.212695111264, 11435.885641143483, 11794.174407791372, 11863.288202707865, 11981.161318707607, 9933.15568176713, 10021.699349019542, 10126.44304563256, 10297.124744396511, 10410.947945260225, 10324.535395907353, 10335.896641033794, 10711.357318560911, 10725.678229653124, 10880.401577913291, 11272.154588406067, 11507.309561426342, 11700.94149529281, 11913.702157445787, 12139.210951288138, 9722.805543889224, 10013.349132306377, 10039.949800250952, 10173.643922462677, 10641.148708103488, 9290.535473226177, 9336.719898403058, 9670.323077384797, 9729.416235025921, 10371.896281037092], "value": 6452.167497828669, "unit": "score"}], "name": "dromaeo_css", "value": 6153.82803127047, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 114.0, 113.0, 113.0, 114.0, 116.0, 114.0, 113.0, 114.0, 114.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 129.0, 128.0, 160.0, 129.0, 133.0, 128.0, 129.0, 159.0, 126.0], "value": 138.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 161.0, 162.0, 161.0, 162.0, 162.0, 161.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 76.0, 103.0, 77.0, 76.0, 76.0, 76.0, 103.0, 77.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 125.0, 84.0, 85.0, 83.0, 110.0, 84.0, 83.0, 112.0], "value": 93.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 149.0, 148.0, 147.0, 147.0, 147.0, 146.0, 146.0, 145.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 86.0, 85.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 61.0, 62.0, 62.0, 63.0, 64.0, 63.0, 63.0, 71.0], "value": 63.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 68.0, 68.0, 71.0, 68.0, 68.0], "value": 67.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 84.0, 83.0, 82.0, 92.0, 90.0, 84.0, 84.0, 83.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 143.0, 140.0, 142.0, 141.0, 139.0, 140.0, 141.0, 182.0, 141.0], "value": 145.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 177.0, 179.0, 178.0, 173.0, 176.0, 177.0, 173.0, 180.0, 178.0], "value": 177.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 71.0, 74.0, 68.0, 74.0, 69.0, 70.0, 69.0, 68.0], "value": 70.4, "unit": "score"}], "name": "kraken", "value": 1545.7, "alertThreshold": 2.0}]} 12:22:35 INFO - Return code: 0 12:22:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:22:35 INFO - # TBPL SUCCESS # 12:22:35 INFO - Running post-action listener: _resource_record_post_action 12:22:35 INFO - [mozharness: 2016-10-20 19:22:35.438788Z] Finished run-tests step (success) 12:22:35 INFO - Running post-run listener: _resource_record_post_run 12:22:35 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 402464768; Read time: 12; Write time: 327732 12:22:35 INFO - TinderboxPrint: CPU usage
13.1% 12:22:35 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 12:22:35 INFO - TinderboxPrint: I/O write bytes / time
402,464,768 / 327,732 12:22:35 INFO - TinderboxPrint: CPU idle
8,350.5 (86.9%) 12:22:35 INFO - TinderboxPrint: CPU user
1,205.7 (12.6%) 12:22:35 INFO - TinderboxPrint: Swap in / out
0 / 0 12:22:35 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110489600; Read time: 0; Write time: 110824 12:22:35 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 291053568; Read time: 0; Write time: 216880 12:22:36 INFO - Running post-run listener: _upload_blobber_files 12:22:36 INFO - Blob upload gear active. 12:22:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:22:36 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 12:22:36 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:22:36 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:22:36 INFO - (blobuploader) - INFO - Open directory for files ... 12:22:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:22:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:22:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:22:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:22:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:22:40 INFO - (blobuploader) - INFO - Done attempting. 12:22:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:22:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:22:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:22:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:22:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:22:40 INFO - (blobuploader) - INFO - Done attempting. 12:22:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:22:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:22:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:22:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:22:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:22:41 INFO - (blobuploader) - INFO - Done attempting. 12:22:41 INFO - (blobuploader) - INFO - Iteration through files over. 12:22:41 INFO - Return code: 0 12:22:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:22:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:22:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/71056dd071bb1037904c53472649196032df9c777fcf1250442bbed35fe9d7e8fb3ee362369ef9f091d021bda22dc3d8295d9e6accc5751575c650575f6cadf4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/65ba2b368eaebe7116269f2aee1198f6073aafe3e9339d3717b1fa6ffc645580eb0f9fcf4c91d84298604d9484427ec5de1daf66bd24c266461e29f1c1a48c4f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/67a06fdf99442eda9bb9dde70c616fbcf0aaec5e56be570399c2c6b5121dda8a534ba44e9149342a020adab2c0eab0dce1b0fd725a9731d7e4f50114db29816d"} 12:22:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:22:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:22:41 INFO - Contents: 12:22:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/71056dd071bb1037904c53472649196032df9c777fcf1250442bbed35fe9d7e8fb3ee362369ef9f091d021bda22dc3d8295d9e6accc5751575c650575f6cadf4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/65ba2b368eaebe7116269f2aee1198f6073aafe3e9339d3717b1fa6ffc645580eb0f9fcf4c91d84298604d9484427ec5de1daf66bd24c266461e29f1c1a48c4f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/67a06fdf99442eda9bb9dde70c616fbcf0aaec5e56be570399c2c6b5121dda8a534ba44e9149342a020adab2c0eab0dce1b0fd725a9731d7e4f50114db29816d"} 12:22:41 INFO - Running post-run listener: copy_logs_to_upload_dir 12:22:41 INFO - Copying logs to upload dir... 12:22:41 INFO - mkdir: /builds/slave/test/build/upload/logs 12:22:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.789299 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-20 12:22:41.427996) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 12:22:41.431795) ========= 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=af724c981e2a0f424dbabf99000001e7-1476989674.459868-749303686 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-Non-PGO/sha512/71056dd071bb1037904c53472649196032df9c777fcf1250442bbed35fe9d7e8fb3ee362369ef9f091d021bda22dc3d8295d9e6accc5751575c650575f6cadf4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/65ba2b368eaebe7116269f2aee1198f6073aafe3e9339d3717b1fa6ffc645580eb0f9fcf4c91d84298604d9484427ec5de1daf66bd24c266461e29f1c1a48c4f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/67a06fdf99442eda9bb9dde70c616fbcf0aaec5e56be570399c2c6b5121dda8a534ba44e9149342a020adab2c0eab0dce1b0fd725a9731d7e4f50114db29816d"} build_url:https://queue.taskcluster.net/v1/task/U-aWYEleS52Ruqp8S_LGMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011432 build_url: 'https://queue.taskcluster.net/v1/task/U-aWYEleS52Ruqp8S_LGMQ/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-Non-PGO/sha512/71056dd071bb1037904c53472649196032df9c777fcf1250442bbed35fe9d7e8fb3ee362369ef9f091d021bda22dc3d8295d9e6accc5751575c650575f6cadf4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/65ba2b368eaebe7116269f2aee1198f6073aafe3e9339d3717b1fa6ffc645580eb0f9fcf4c91d84298604d9484427ec5de1daf66bd24c266461e29f1c1a48c4f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/67a06fdf99442eda9bb9dde70c616fbcf0aaec5e56be570399c2c6b5121dda8a534ba44e9149342a020adab2c0eab0dce1b0fd725a9731d7e4f50114db29816d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 12:22:41.457377) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 12:22:41.457744) ========= 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=af724c981e2a0f424dbabf99000001e7-1476989674.459868-749303686 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-20 12:22:41.542160) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 12:22:41.542529) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 12:22:41.542876) ========= ========= Total master_lag: 0.17 =========