builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-042 starttime: 1475551138.7 results: success (0) buildid: 20161003183005 builduid: 4d8e2242b58c4b44b7efd34d2c71048d revision: b26e668306fba754bba594572ac721bf5b0990ef ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 20:18:58.700604) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 20:18:58.701124) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 20:18:58.701537) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 20:18:58.718447) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 20:18:58.718715) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1475550764.148701-887786732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-03 20:18:58-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 51.0M=0s 2016-10-03 20:18:58 (51.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.082707 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 20:18:58.816275) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 20:18:58.816608) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1475550764.148701-887786732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019381 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 20:18:58.865696) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-03 20:18:58.866029) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b26e668306fba754bba594572ac721bf5b0990ef --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 b26e668306fba754bba594572ac721bf5b0990ef --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=74d6aec007b0fa31a864ebd7000001f8-1475550764.148701-887786732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-03 20:18:59,052 truncating revision to first 12 chars 2016-10-03 20:18:59,052 Setting DEBUG logging. 2016-10-03 20:18:59,052 attempt 1/10 2016-10-03 20:18:59,052 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b26e668306fb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-03 20:19:00,244 unpacking tar archive at: fx-team-b26e668306fb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.595145 ========= master_lag: 0.23 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-03 20:19:00.694453) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 20:19:00.694763) ========= script_repo_revision: b26e668306fba754bba594572ac721bf5b0990ef ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 20:19:00.698218) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 20:19:00.698537) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 20:19:00.720799) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-03 20:19:00.721115) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1475550764.148701-887786732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:19:00 INFO - MultiFileLogger online at 20161003 20:19:00 in /builds/slave/test 20:19:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:19:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:19:01 INFO - {'append_to_log': False, 20:19:01 INFO - 'base_work_dir': '/builds/slave/test', 20:19:01 INFO - 'blob_upload_branch': 'Fx-Team', 20:19:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:19:01 INFO - 'branch': 'Fx-Team', 20:19:01 INFO - 'buildbot_json_path': 'buildprops.json', 20:19:01 INFO - 'config_files': ('talos/linux_config.py',), 20:19:01 INFO - 'default_actions': ('clobber', 20:19:01 INFO - 'read-buildbot-config', 20:19:01 INFO - 'download-and-extract', 20:19:01 INFO - 'populate-webroot', 20:19:01 INFO - 'create-virtualenv', 20:19:01 INFO - 'install', 20:19:01 INFO - 'run-tests'), 20:19:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:19:01 INFO - 'download_minidump_stackwalk': True, 20:19:01 INFO - 'download_symbols': 'ondemand', 20:19:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:19:01 INFO - 'tooltool.py': '/tools/tooltool.py', 20:19:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:19:01 INFO - '/tools/misc-python/virtualenv.py')}, 20:19:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:19:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:19:01 INFO - 'installer_path': 'installer.exe', 20:19:01 INFO - 'log_level': 'info', 20:19:01 INFO - 'log_name': 'talos', 20:19:01 INFO - 'log_to_console': True, 20:19:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:19:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:19:01 INFO - 'opt_config_files': (), 20:19:01 INFO - 'pip_index': False, 20:19:01 INFO - 'sps_profile': False, 20:19:01 INFO - 'sps_profile_interval': 0, 20:19:01 INFO - 'suite': 'dromaeojs', 20:19:01 INFO - 'system_bits': '32', 20:19:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:19:01 INFO - 'title': 'talos-linux64-ix-042', 20:19:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:19:01 INFO - 'use_talos_json': True, 20:19:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:19:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:19:01 INFO - 'work_dir': 'build'} 20:19:01 INFO - [mozharness: 2016-10-04 03:19:01.013179Z] Running clobber step. 20:19:01 INFO - Running pre-action listener: _resource_record_pre_action 20:19:01 INFO - Running main action method: clobber 20:19:01 INFO - rmtree: /builds/slave/test/build 20:19:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:19:01 INFO - Running post-action listener: _resource_record_post_action 20:19:01 INFO - [mozharness: 2016-10-04 03:19:01.466749Z] Finished clobber step (success) 20:19:01 INFO - [mozharness: 2016-10-04 03:19:01.466852Z] Running read-buildbot-config step. 20:19:01 INFO - Running pre-action listener: _resource_record_pre_action 20:19:01 INFO - Running main action method: read_buildbot_config 20:19:01 INFO - Using buildbot properties: 20:19:01 INFO - { 20:19:01 INFO - "project": "", 20:19:01 INFO - "product": "firefox", 20:19:01 INFO - "script_repo_revision": "production", 20:19:01 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:19:01 INFO - "repository": "", 20:19:01 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:19:01 INFO - "buildid": "20161003183005", 20:19:01 INFO - "pgo_build": "True", 20:19:01 INFO - "basedir": "/builds/slave/test", 20:19:01 INFO - "buildnumber": 497, 20:19:01 INFO - "slavename": "talos-linux64-ix-042", 20:19:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:19:01 INFO - "platform": "ubuntu64_hw", 20:19:01 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:19:01 INFO - "branch": "fx-team", 20:19:01 INFO - "repo_path": "integration/fx-team", 20:19:01 INFO - "revision": "b26e668306fba754bba594572ac721bf5b0990ef", 20:19:01 INFO - "stage_platform": "linux64-pgo", 20:19:01 INFO - "builduid": "4d8e2242b58c4b44b7efd34d2c71048d", 20:19:01 INFO - "slavebuilddir": "test" 20:19:01 INFO - } 20:19:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 20:19:01 INFO - Running post-action listener: _resource_record_post_action 20:19:01 INFO - [mozharness: 2016-10-04 03:19:01.469300Z] Finished read-buildbot-config step (success) 20:19:01 INFO - [mozharness: 2016-10-04 03:19:01.469389Z] Running download-and-extract step. 20:19:01 INFO - Running pre-action listener: _resource_record_pre_action 20:19:01 INFO - Running main action method: download_and_extract 20:19:01 INFO - mkdir: /builds/slave/test/build/tests 20:19:01 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')]} 20:19:01 INFO - trying https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 20:19:01 INFO - Downloading https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/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 20:19:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/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 20:19:02 INFO - Downloaded 1361 bytes. 20:19:02 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 20:19:02 INFO - Using the following test package requirements: 20:19:02 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 20:19:02 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:19:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:19:02 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:19:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:19:02 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:19:02 INFO - u'jsshell-linux-x86_64.zip'], 20:19:02 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:19:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:19:02 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 20:19:02 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:19:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:19:02 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:19:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:19:02 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:19:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:19:02 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:19:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:19:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:19:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 20:19:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:19:02 INFO - Fetch https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:19:02 INFO - Http code: 200 20:19:02 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 20:19:02 INFO - x-amz-cf-id: Mqzpzg0Tqyj3OnhEbMONrpV1Dv00wzL-RxgNQp-qN5eLpGaoMD0Dqw== 20:19:02 INFO - x-amz-version-id: Ta6bk0xTPumjXwe_K9VnpMcK_zVWXoYM 20:19:03 INFO - Expected file size: 21991797 20:19:03 INFO - Obtained file size: 21991797 20:19:07 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 20:19:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 20:19:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:19:07 INFO - Fetch https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:19:07 INFO - Http code: 200 20:19:07 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 20:19:07 INFO - x-amz-cf-id: Io888FUNIulOw-IdiYcUjThPY4-jVx7WT5sFEPp4IrIUGwrH9yOlsg== 20:19:07 INFO - x-amz-version-id: Ta6bk0xTPumjXwe_K9VnpMcK_zVWXoYM 20:19:08 INFO - Expected file size: 21991797 20:19:08 INFO - Obtained file size: 21991797 20:19:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 20:19:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:19:12 INFO - Fetch https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 20:19:13 INFO - Http code: 200 20:19:13 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 20:19:13 INFO - x-amz-cf-id: dywzBzkZJhsEN3wtiSIMm_skMVCIfzURVNWGDHabchF8CJix3L8eFQ== 20:19:13 INFO - x-amz-version-id: FcTpHeqJhHBt2nAq2vq_X9eRueKoLWfU 20:19:13 INFO - Expected file size: 14409006 20:19:13 INFO - Obtained file size: 14409006 20:19:13 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')]} 20:19:13 INFO - trying https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:19:13 INFO - Downloading https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/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 20:19:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/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 20:19:14 INFO - Downloaded 59669916 bytes. 20:19:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:19:14 INFO - mkdir: /builds/slave/test/properties 20:19:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:19:14 INFO - Writing to file /builds/slave/test/properties/build_url 20:19:14 INFO - Contents: 20:19:14 INFO - build_url:https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:19:15 INFO - Running post-action listener: _resource_record_post_action 20:19:15 INFO - Running post-action listener: set_extra_try_arguments 20:19:15 INFO - [mozharness: 2016-10-04 03:19:15.483988Z] Finished download-and-extract step (success) 20:19:15 INFO - [mozharness: 2016-10-04 03:19:15.484213Z] Running populate-webroot step. 20:19:15 INFO - Running pre-action listener: _resource_record_pre_action 20:19:15 INFO - Running main action method: populate_webroot 20:19:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:19:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:19:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:19:15 INFO - '--tppagecycles', 20:19:15 INFO - '7'], 20:19:15 INFO - 'tests': ['tsvgm']}}, 20:19:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:19:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:19:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:19:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:19:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:19:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:19:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:19:15 INFO - 'talos_options': ['--disable-e10s'], 20:19:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:19:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:19:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:19:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:19:15 INFO - 'talos_options': ['--disable-e10s'], 20:19:15 INFO - 'tests': ['damp', 'tps']}, 20:19:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:19:15 INFO - 'tests': ['damp', 'tps']}, 20:19:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:19:15 INFO - 'tests': ['dromaeo_dom']}, 20:19:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:19:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:19:15 INFO - 'tests': ['basic_compositor_video']}, 20:19:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:19:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:19:15 INFO - 'tests': ['a11yr', 20:19:15 INFO - 'ts_paint', 20:19:15 INFO - 'tpaint', 20:19:15 INFO - 'sessionrestore', 20:19:15 INFO - 'sessionrestore_no_auto_restore', 20:19:15 INFO - 'tabpaint']}, 20:19:15 INFO - 'other-e10s': {'tests': ['a11yr', 20:19:15 INFO - 'ts_paint', 20:19:15 INFO - 'tpaint', 20:19:15 INFO - 'sessionrestore', 20:19:15 INFO - 'sessionrestore_no_auto_restore', 20:19:15 INFO - 'tabpaint']}, 20:19:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:19:15 INFO - 'ts_paint', 20:19:15 INFO - 'tpaint', 20:19:15 INFO - 'sessionrestore', 20:19:15 INFO - 'sessionrestore_no_auto_restore', 20:19:15 INFO - 'tabpaint']}, 20:19:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:19:15 INFO - 'ts_paint', 20:19:15 INFO - 'tpaint', 20:19:15 INFO - 'sessionrestore', 20:19:15 INFO - 'sessionrestore_no_auto_restore', 20:19:15 INFO - 'tabpaint']}, 20:19:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:19:15 INFO - 'tests': ['a11yr', 20:19:15 INFO - 'ts_paint', 20:19:15 INFO - 'tpaint', 20:19:15 INFO - 'sessionrestore', 20:19:15 INFO - 'sessionrestore_no_auto_restore', 20:19:15 INFO - 'tabpaint']}, 20:19:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:19:15 INFO - 'tests': ['a11yr', 20:19:15 INFO - 'ts_paint', 20:19:15 INFO - 'tpaint', 20:19:15 INFO - 'sessionrestore', 20:19:15 INFO - 'sessionrestore_no_auto_restore', 20:19:15 INFO - 'tabpaint']}, 20:19:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:19:15 INFO - 'tests': ['tsvgx', 20:19:15 INFO - 'tsvgr_opacity', 20:19:15 INFO - 'tart', 20:19:15 INFO - 'tscrollx', 20:19:15 INFO - 'cart']}, 20:19:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:19:15 INFO - 'tsvgr_opacity', 20:19:15 INFO - 'tart', 20:19:15 INFO - 'tscrollx', 20:19:15 INFO - 'cart']}, 20:19:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:19:15 INFO - 'talos_options': ['--disable-e10s'], 20:19:15 INFO - 'tests': ['tp5o']}, 20:19:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:19:15 INFO - 'tests': ['tp5o']}, 20:19:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:19:15 INFO - 'talos_options': ['--disable-e10s', 20:19:15 INFO - '--xperf_path', 20:19:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:19:15 INFO - 'tests': ['tp5n']}, 20:19:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:19:15 INFO - 'talos_options': ['--xperf_path', 20:19:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:19:15 INFO - 'tests': ['tp5n']}}, 20:19:15 INFO - 'talos.zip': {'path': '', 20:19:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:19:15 INFO - Running post-action listener: _resource_record_post_action 20:19:15 INFO - [mozharness: 2016-10-04 03:19:15.502850Z] Finished populate-webroot step (success) 20:19:15 INFO - [mozharness: 2016-10-04 03:19:15.502938Z] Running create-virtualenv step. 20:19:15 INFO - Running pre-action listener: _resource_record_pre_action 20:19:15 INFO - Running main action method: create_virtualenv 20:19:15 INFO - Creating virtualenv /builds/slave/test/build/venv 20:19:15 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 20:19:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:19:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:19:15 INFO - Using real prefix '/usr' 20:19:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:19:16 INFO - Installing distribute.............................................................................................................................................................................................done. 20:19:18 INFO - Installing pip.................done. 20:19:18 INFO - Return code: 0 20:19:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:19:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:19:18 INFO - Reading from file tmpfile_stdout 20:19:18 INFO - Output received: 20:19:18 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) 20:19:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1316a3af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b3e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b930>, '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 0x1b3c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3ccc0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475550764.148701-887786732', '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 20:19:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:19:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:19:18 INFO - Using env: {'DISPLAY': ':0', 20:19:18 INFO - 'HOME': '/home/cltbld', 20:19:18 INFO - 'LANG': 'en_US.UTF-8', 20:19:18 INFO - 'LANGUAGE': 'en_US:en', 20:19:18 INFO - 'LOGNAME': 'cltbld', 20:19:18 INFO - 'MAIL': '/var/mail/cltbld', 20:19:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:18 INFO - 'MOZ_NO_REMOTE': '1', 20:19:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:18 INFO - 'NO_EM_RESTART': '1', 20:19:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:18 INFO - 'PWD': '/builds/slave/test', 20:19:18 INFO - 'SHELL': '/bin/bash', 20:19:18 INFO - 'SHLVL': '1', 20:19:18 INFO - 'TERM': 'linux', 20:19:18 INFO - 'TMOUT': '86400', 20:19:18 INFO - 'USER': 'cltbld', 20:19:18 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475550764.148701-887786732', 20:19:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:18 INFO - '_': '/tools/buildbot/bin/python'} 20:19:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:18 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 20:19:18 INFO - Cleaning up... 20:19:18 INFO - Return code: 0 20:19:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1316a3af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b3e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b930>, '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 0x1b3c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3ccc0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475550764.148701-887786732', '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 20:19:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:19:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:19:18 INFO - Using env: {'DISPLAY': ':0', 20:19:18 INFO - 'HOME': '/home/cltbld', 20:19:18 INFO - 'LANG': 'en_US.UTF-8', 20:19:18 INFO - 'LANGUAGE': 'en_US:en', 20:19:18 INFO - 'LOGNAME': 'cltbld', 20:19:18 INFO - 'MAIL': '/var/mail/cltbld', 20:19:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:18 INFO - 'MOZ_NO_REMOTE': '1', 20:19:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:18 INFO - 'NO_EM_RESTART': '1', 20:19:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:18 INFO - 'PWD': '/builds/slave/test', 20:19:18 INFO - 'SHELL': '/bin/bash', 20:19:18 INFO - 'SHLVL': '1', 20:19:18 INFO - 'TERM': 'linux', 20:19:18 INFO - 'TMOUT': '86400', 20:19:18 INFO - 'USER': 'cltbld', 20:19:18 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475550764.148701-887786732', 20:19:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:18 INFO - '_': '/tools/buildbot/bin/python'} 20:19:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:18 INFO - Downloading/unpacking psutil>=3.1.1 20:19: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 20:19: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 20:19: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 20:19: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 20:19: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 20:19: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 20:19:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:19:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:19:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:19:20 INFO - Installing collected packages: psutil 20:19:20 INFO - Running setup.py install for psutil 20:19:20 INFO - building 'psutil._psutil_linux' extension 20:19:20 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 20:19:20 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 20:19:20 INFO - building 'psutil._psutil_posix' extension 20:19:20 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 20:19:21 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 20:19:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:19:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:19:21 INFO - Successfully installed psutil 20:19:21 INFO - Cleaning up... 20:19:21 INFO - Return code: 0 20:19:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1316a3af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b3e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b930>, '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 0x1b3c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3ccc0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475550764.148701-887786732', '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 20:19:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:19:21 INFO - Using env: {'DISPLAY': ':0', 20:19:21 INFO - 'HOME': '/home/cltbld', 20:19:21 INFO - 'LANG': 'en_US.UTF-8', 20:19:21 INFO - 'LANGUAGE': 'en_US:en', 20:19:21 INFO - 'LOGNAME': 'cltbld', 20:19:21 INFO - 'MAIL': '/var/mail/cltbld', 20:19:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:21 INFO - 'MOZ_NO_REMOTE': '1', 20:19:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:21 INFO - 'NO_EM_RESTART': '1', 20:19:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:21 INFO - 'PWD': '/builds/slave/test', 20:19:21 INFO - 'SHELL': '/bin/bash', 20:19:21 INFO - 'SHLVL': '1', 20:19:21 INFO - 'TERM': 'linux', 20:19:21 INFO - 'TMOUT': '86400', 20:19:21 INFO - 'USER': 'cltbld', 20:19:21 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475550764.148701-887786732', 20:19:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:21 INFO - '_': '/tools/buildbot/bin/python'} 20:19:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:19: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 20:19: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 20:19: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 20:19: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 20:19: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 20:19: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 20:19:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:19:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:19:23 INFO - Installing collected packages: mozsystemmonitor 20:19:23 INFO - Running setup.py install for mozsystemmonitor 20:19:23 INFO - Successfully installed mozsystemmonitor 20:19:23 INFO - Cleaning up... 20:19:23 INFO - Return code: 0 20:19:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:19: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')]} 20:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19: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')]} 20:19:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:23 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 0x7f1316a3af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b3e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b930>, '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 0x1b3c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3ccc0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475550764.148701-887786732', '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 20:19:23 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 20:19:23 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 20:19:23 INFO - Using env: {'DISPLAY': ':0', 20:19:23 INFO - 'HOME': '/home/cltbld', 20:19:23 INFO - 'LANG': 'en_US.UTF-8', 20:19:23 INFO - 'LANGUAGE': 'en_US:en', 20:19:23 INFO - 'LOGNAME': 'cltbld', 20:19:23 INFO - 'MAIL': '/var/mail/cltbld', 20:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:23 INFO - 'MOZ_NO_REMOTE': '1', 20:19:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:23 INFO - 'NO_EM_RESTART': '1', 20:19:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:23 INFO - 'PWD': '/builds/slave/test', 20:19:23 INFO - 'SHELL': '/bin/bash', 20:19:23 INFO - 'SHLVL': '1', 20:19:23 INFO - 'TERM': 'linux', 20:19:23 INFO - 'TMOUT': '86400', 20:19:23 INFO - 'USER': 'cltbld', 20:19:23 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475550764.148701-887786732', 20:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:23 INFO - '_': '/tools/buildbot/bin/python'} 20:19:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:23 INFO - Downloading/unpacking jsonschema==2.5.1 20:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:19:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:19:25 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 20:19:25 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 20:19:25 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 20:19:25 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 20:19:25 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 20:19:25 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 20:19:25 INFO - Downloading functools32-3.2.3-2.tar.gz 20:19:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:19:25 INFO - warning: no files found matching '*.txt' 20:19:25 INFO - no previously-included directories found matching 'build' 20:19:25 INFO - no previously-included directories found matching 'dist' 20:19:25 INFO - no previously-included directories found matching '.git*' 20:19:25 INFO - Installing collected packages: jsonschema, functools32 20:19:26 INFO - Running setup.py install for functools32 20:19:26 INFO - warning: no files found matching '*.txt' 20:19:26 INFO - no previously-included directories found matching 'build' 20:19:26 INFO - no previously-included directories found matching 'dist' 20:19:26 INFO - no previously-included directories found matching '.git*' 20:19:26 INFO - Successfully installed jsonschema functools32 20:19:26 INFO - Cleaning up... 20:19:26 INFO - Return code: 0 20:19:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:19: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')]} 20:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19: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')]} 20:19:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1316a3af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b3e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b930>, '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 0x1b3c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3ccc0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475550764.148701-887786732', '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 20:19:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:19:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:19:26 INFO - Using env: {'DISPLAY': ':0', 20:19:26 INFO - 'HOME': '/home/cltbld', 20:19:26 INFO - 'LANG': 'en_US.UTF-8', 20:19:26 INFO - 'LANGUAGE': 'en_US:en', 20:19:26 INFO - 'LOGNAME': 'cltbld', 20:19:26 INFO - 'MAIL': '/var/mail/cltbld', 20:19:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:26 INFO - 'MOZ_NO_REMOTE': '1', 20:19:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:26 INFO - 'NO_EM_RESTART': '1', 20:19:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:26 INFO - 'PWD': '/builds/slave/test', 20:19:26 INFO - 'SHELL': '/bin/bash', 20:19:26 INFO - 'SHLVL': '1', 20:19:26 INFO - 'TERM': 'linux', 20:19:26 INFO - 'TMOUT': '86400', 20:19:26 INFO - 'USER': 'cltbld', 20:19:26 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475550764.148701-887786732', 20:19:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:26 INFO - '_': '/tools/buildbot/bin/python'} 20:19:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:19:26 INFO - Cleaning up... 20:19:26 INFO - Return code: 0 20:19:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:19: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')]} 20:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19: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')]} 20:19:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1316a3af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b3e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b930>, '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 0x1b3c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3ccc0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475550764.148701-887786732', '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 20:19:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:19:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:19:26 INFO - Using env: {'DISPLAY': ':0', 20:19:26 INFO - 'HOME': '/home/cltbld', 20:19:26 INFO - 'LANG': 'en_US.UTF-8', 20:19:26 INFO - 'LANGUAGE': 'en_US:en', 20:19:26 INFO - 'LOGNAME': 'cltbld', 20:19:26 INFO - 'MAIL': '/var/mail/cltbld', 20:19:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:26 INFO - 'MOZ_NO_REMOTE': '1', 20:19:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:26 INFO - 'NO_EM_RESTART': '1', 20:19:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:26 INFO - 'PWD': '/builds/slave/test', 20:19:26 INFO - 'SHELL': '/bin/bash', 20:19:26 INFO - 'SHLVL': '1', 20:19:26 INFO - 'TERM': 'linux', 20:19:26 INFO - 'TMOUT': '86400', 20:19:26 INFO - 'USER': 'cltbld', 20:19:26 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475550764.148701-887786732', 20:19:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:26 INFO - '_': '/tools/buildbot/bin/python'} 20:19:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:26 INFO - Downloading/unpacking blobuploader==1.2.4 20:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:28 INFO - Downloading blobuploader-1.2.4.tar.gz 20:19:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:19:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:19:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:29 INFO - Downloading docopt-0.6.1.tar.gz 20:19:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:19:29 INFO - Installing collected packages: blobuploader, requests, docopt 20:19:29 INFO - Running setup.py install for blobuploader 20:19:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:19:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:19:29 INFO - Running setup.py install for requests 20:19:29 INFO - Running setup.py install for docopt 20:19:29 INFO - Successfully installed blobuploader requests docopt 20:19:29 INFO - Cleaning up... 20:19:29 INFO - Return code: 0 20:19:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:19:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:29 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 0x7f1316a3af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b3e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b930>, '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 0x1b3c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3ccc0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475550764.148701-887786732', '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 20:19:29 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 20:19:29 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 20:19:29 INFO - Using env: {'DISPLAY': ':0', 20:19:29 INFO - 'HOME': '/home/cltbld', 20:19:29 INFO - 'LANG': 'en_US.UTF-8', 20:19:29 INFO - 'LANGUAGE': 'en_US:en', 20:19:29 INFO - 'LOGNAME': 'cltbld', 20:19:29 INFO - 'MAIL': '/var/mail/cltbld', 20:19:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:29 INFO - 'MOZ_NO_REMOTE': '1', 20:19:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:29 INFO - 'NO_EM_RESTART': '1', 20:19:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:29 INFO - 'PWD': '/builds/slave/test', 20:19:29 INFO - 'SHELL': '/bin/bash', 20:19:29 INFO - 'SHLVL': '1', 20:19:29 INFO - 'TERM': 'linux', 20:19:29 INFO - 'TMOUT': '86400', 20:19:29 INFO - 'USER': 'cltbld', 20:19:29 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475550764.148701-887786732', 20:19:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:29 INFO - '_': '/tools/buildbot/bin/python'} 20:19:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:19:30 INFO - Running setup.py (path:/tmp/pip-PAGtbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:19:30 INFO - Running setup.py (path:/tmp/pip-tHvPtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:19:30 INFO - Running setup.py (path:/tmp/pip-yPFWHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:19:30 INFO - Running setup.py (path:/tmp/pip-sF4pgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:19:30 INFO - Running setup.py (path:/tmp/pip-CeBJQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:19:30 INFO - Running setup.py (path:/tmp/pip-6SjvnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:19:30 INFO - Running setup.py (path:/tmp/pip-zHttpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:19:30 INFO - Running setup.py (path:/tmp/pip-kELl7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:19:30 INFO - Running setup.py (path:/tmp/pip-Igk2Py-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:19:30 INFO - Running setup.py (path:/tmp/pip-IxIoJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:19:30 INFO - Running setup.py (path:/tmp/pip-06gyEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:19:30 INFO - Running setup.py (path:/tmp/pip-yTfZZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:19:30 INFO - Running setup.py (path:/tmp/pip-9twfKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:19:31 INFO - Running setup.py (path:/tmp/pip-91GdAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:19:31 INFO - Running setup.py (path:/tmp/pip-JYHPpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:19:31 INFO - Running setup.py (path:/tmp/pip-R9qdeN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:19:31 INFO - Running setup.py (path:/tmp/pip-ur8wea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:19:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:19:31 INFO - Running setup.py install for manifestparser 20:19:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:19:31 INFO - Running setup.py install for mozcrash 20:19:31 INFO - Running setup.py install for mozdebug 20:19:31 INFO - Running setup.py install for mozdevice 20:19:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:19:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:19:31 INFO - Running setup.py install for mozfile 20:19:31 INFO - Running setup.py install for mozhttpd 20:19:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:19:31 INFO - Running setup.py install for mozinfo 20:19:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:19:32 INFO - Running setup.py install for mozInstall 20:19:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:19:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:19:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:19:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:19:32 INFO - Running setup.py install for mozleak 20:19:32 INFO - Running setup.py install for mozlog 20:19:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:19:32 INFO - Running setup.py install for moznetwork 20:19:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:19:32 INFO - Running setup.py install for mozprocess 20:19:32 INFO - Running setup.py install for mozprofile 20:19:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:19:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:19:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:19:32 INFO - Running setup.py install for mozrunner 20:19:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:19:32 INFO - Running setup.py install for mozscreenshot 20:19:32 INFO - Running setup.py install for moztest 20:19:32 INFO - Running setup.py install for mozversion 20:19:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:19:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:19:33 INFO - Cleaning up... 20:19:33 INFO - Return code: 0 20:19:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:19:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:33 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 0x7f1316a3af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b3e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b930>, '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 0x1b3c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3ccc0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475550764.148701-887786732', '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 20:19:33 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 20:19:33 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 20:19:33 INFO - Using env: {'DISPLAY': ':0', 20:19:33 INFO - 'HOME': '/home/cltbld', 20:19:33 INFO - 'LANG': 'en_US.UTF-8', 20:19:33 INFO - 'LANGUAGE': 'en_US:en', 20:19:33 INFO - 'LOGNAME': 'cltbld', 20:19:33 INFO - 'MAIL': '/var/mail/cltbld', 20:19:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:33 INFO - 'MOZ_NO_REMOTE': '1', 20:19:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:33 INFO - 'NO_EM_RESTART': '1', 20:19:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:33 INFO - 'PWD': '/builds/slave/test', 20:19:33 INFO - 'SHELL': '/bin/bash', 20:19:33 INFO - 'SHLVL': '1', 20:19:33 INFO - 'TERM': 'linux', 20:19:33 INFO - 'TMOUT': '86400', 20:19:33 INFO - 'USER': 'cltbld', 20:19:33 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475550764.148701-887786732', 20:19:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:33 INFO - '_': '/tools/buildbot/bin/python'} 20:19:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:19:33 INFO - Running setup.py (path:/tmp/pip-t_oSNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:19:33 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)) 20:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:19:33 INFO - Running setup.py (path:/tmp/pip-z6BfDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:19:33 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)) 20:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:19:33 INFO - Running setup.py (path:/tmp/pip-DCQOOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:19:33 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)) 20:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:19:33 INFO - Running setup.py (path:/tmp/pip-KT9lO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:19:33 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)) 20:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:19:33 INFO - Running setup.py (path:/tmp/pip-7qYlov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:19:33 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)) 20:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:19:33 INFO - Running setup.py (path:/tmp/pip-n7ND8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:19:33 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)) 20:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:19:33 INFO - Running setup.py (path:/tmp/pip-BU1sLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:19:33 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)) 20:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:19:33 INFO - Running setup.py (path:/tmp/pip-quL57L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:19:33 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)) 20:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:19:33 INFO - Running setup.py (path:/tmp/pip-ikEWVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:19:33 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)) 20:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:19:33 INFO - Running setup.py (path:/tmp/pip-qWdkv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:19:34 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)) 20:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:19:34 INFO - Running setup.py (path:/tmp/pip-GuzSIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:19:34 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)) 20:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:19:34 INFO - Running setup.py (path:/tmp/pip-VX9STt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:19:34 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)) 20:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:19:34 INFO - Running setup.py (path:/tmp/pip-SCjRHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:19:34 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)) 20:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:19:34 INFO - Running setup.py (path:/tmp/pip-KKFqML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:19:34 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)) 20:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:19:34 INFO - Running setup.py (path:/tmp/pip-MkekUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:19:34 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)) 20:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:19:34 INFO - Running setup.py (path:/tmp/pip-gKLomb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:19:34 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)) 20:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:19:34 INFO - Running setup.py (path:/tmp/pip-hsXizT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:19:34 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)) 20:19:34 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)) 20:19:34 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)) 20:19:34 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)) 20:19:34 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)) 20:19:34 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)) 20:19:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:19:34 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 20:19:34 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 20:19:34 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 20:19:34 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 20:19:34 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 20:19:34 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 20:19:36 INFO - Downloading blessings-1.6.tar.gz 20:19:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:19:36 INFO - Installing collected packages: blessings 20:19:36 INFO - Running setup.py install for blessings 20:19:36 INFO - Successfully installed blessings 20:19:36 INFO - Cleaning up... 20:19:36 INFO - Return code: 0 20:19:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:19:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:19:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:19:36 INFO - Reading from file tmpfile_stdout 20:19:36 INFO - Current package versions: 20:19:36 INFO - argparse == 1.2.1 20:19:36 INFO - blessings == 1.6 20:19:36 INFO - blobuploader == 1.2.4 20:19:36 INFO - docopt == 0.6.1 20:19:36 INFO - functools32 == 3.2.3-2 20:19:36 INFO - jsonschema == 2.5.1 20:19:36 INFO - manifestparser == 1.1 20:19:36 INFO - mozInstall == 1.12 20:19:36 INFO - mozcrash == 0.17 20:19:36 INFO - mozdebug == 0.1 20:19:36 INFO - mozdevice == 0.48 20:19:36 INFO - mozfile == 1.2 20:19:36 INFO - mozhttpd == 0.7 20:19:36 INFO - mozinfo == 0.9 20:19:36 INFO - mozleak == 0.1 20:19:36 INFO - mozlog == 3.4 20:19:36 INFO - moznetwork == 0.27 20:19:36 INFO - mozprocess == 0.23 20:19:36 INFO - mozprofile == 0.28 20:19:36 INFO - mozrunner == 6.12 20:19:36 INFO - mozscreenshot == 0.1 20:19:36 INFO - mozsystemmonitor == 0.3 20:19:36 INFO - moztest == 0.7 20:19:36 INFO - mozversion == 1.4 20:19:36 INFO - psutil == 3.1.1 20:19:36 INFO - requests == 1.2.3 20:19:36 INFO - wsgiref == 0.1.2 20:19:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:36 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 0x7f1316a3af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b3e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b930>, '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 0x1b3c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3ccc0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475550764.148701-887786732', '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 20:19:36 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 20:19:36 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 20:19:36 INFO - Using env: {'DISPLAY': ':0', 20:19:36 INFO - 'HOME': '/home/cltbld', 20:19:36 INFO - 'LANG': 'en_US.UTF-8', 20:19:36 INFO - 'LANGUAGE': 'en_US:en', 20:19:36 INFO - 'LOGNAME': 'cltbld', 20:19:36 INFO - 'MAIL': '/var/mail/cltbld', 20:19:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:36 INFO - 'MOZ_NO_REMOTE': '1', 20:19:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:36 INFO - 'NO_EM_RESTART': '1', 20:19:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:36 INFO - 'PWD': '/builds/slave/test', 20:19:36 INFO - 'SHELL': '/bin/bash', 20:19:36 INFO - 'SHLVL': '1', 20:19:36 INFO - 'TERM': 'linux', 20:19:36 INFO - 'TMOUT': '86400', 20:19:36 INFO - 'USER': 'cltbld', 20:19:36 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475550764.148701-887786732', 20:19:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:36 INFO - '_': '/tools/buildbot/bin/python'} 20:19:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:37 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)) 20:19:37 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)) 20:19:37 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)) 20:19:37 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)) 20:19:37 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)) 20:19:37 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)) 20:19:37 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)) 20:19:37 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)) 20:19:37 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)) 20:19:37 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)) 20:19:37 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)) 20:19:37 INFO - Cleaning up... 20:19:37 INFO - Return code: 0 20:19:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:19:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1316a3af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b3e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b930>, '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 0x1b3c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3ccc0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475550764.148701-887786732', '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 20:19:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:19:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:19:37 INFO - Using env: {'DISPLAY': ':0', 20:19:37 INFO - 'HOME': '/home/cltbld', 20:19:37 INFO - 'LANG': 'en_US.UTF-8', 20:19:37 INFO - 'LANGUAGE': 'en_US:en', 20:19:37 INFO - 'LOGNAME': 'cltbld', 20:19:37 INFO - 'MAIL': '/var/mail/cltbld', 20:19:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:37 INFO - 'MOZ_NO_REMOTE': '1', 20:19:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:37 INFO - 'NO_EM_RESTART': '1', 20:19:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:37 INFO - 'PWD': '/builds/slave/test', 20:19:37 INFO - 'SHELL': '/bin/bash', 20:19:37 INFO - 'SHLVL': '1', 20:19:37 INFO - 'TERM': 'linux', 20:19:37 INFO - 'TMOUT': '86400', 20:19:37 INFO - 'USER': 'cltbld', 20:19:37 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475550764.148701-887786732', 20:19:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:37 INFO - '_': '/tools/buildbot/bin/python'} 20:19:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:19:37 INFO - Cleaning up... 20:19:37 INFO - Return code: 0 20:19:37 INFO - Running post-action listener: _resource_record_post_action 20:19:37 INFO - Running post-action listener: _start_resource_monitoring 20:19:37 INFO - Starting resource monitoring. 20:19:37 INFO - [mozharness: 2016-10-04 03:19:37.517896Z] Finished create-virtualenv step (success) 20:19:37 INFO - [mozharness: 2016-10-04 03:19:37.518403Z] Running install step. 20:19:37 INFO - Running pre-action listener: _resource_record_pre_action 20:19:37 INFO - Running main action method: install 20:19:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:19:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:19:37 INFO - Reading from file tmpfile_stdout 20:19:37 INFO - Detecting whether we're running mozinstall >=1.0... 20:19:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:19:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:19:37 INFO - Reading from file tmpfile_stdout 20:19:37 INFO - Output received: 20:19:37 INFO - Usage: mozinstall [options] installer 20:19:37 INFO - Options: 20:19:37 INFO - -h, --help show this help message and exit 20:19:37 INFO - -d DEST, --destination=DEST 20:19:37 INFO - Directory to install application into. [default: 20:19:37 INFO - "/builds/slave/test"] 20:19:37 INFO - --app=APP Application being installed. [default: firefox] 20:19:37 INFO - mkdir: /builds/slave/test/build/application 20:19:37 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'] 20:19:37 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 20:19:55 INFO - Reading from file tmpfile_stdout 20:19:55 INFO - Output received: 20:19:55 INFO - /builds/slave/test/build/application/firefox/firefox 20:19:55 INFO - Running post-action listener: _resource_record_post_action 20:19:55 INFO - [mozharness: 2016-10-04 03:19:55.556050Z] Finished install step (success) 20:19:55 INFO - [mozharness: 2016-10-04 03:19:55.556293Z] Running run-tests step. 20:19:55 INFO - Running pre-action listener: _resource_record_pre_action 20:19:55 INFO - Running main action method: run_tests 20:19:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:19:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:19:55 INFO - Python 2.7.3 20:19:55 INFO - Return code: 0 20:19:55 INFO - grabbing minidump binary from tooltool 20:19:55 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')]} 20:19:55 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 0x1b3b930>, '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 0x1b3c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3ccc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:19:55 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 20:19:55 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 20:19:55 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 20:19:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:19:55 INFO - Return code: 0 20:19:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:19:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:19:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:19:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:19:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:19:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 20:19:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 20:19:55 INFO - Using env: {'DISPLAY': ':0', 20:19:55 INFO - 'HOME': '/home/cltbld', 20:19:55 INFO - 'LANG': 'en_US.UTF-8', 20:19:55 INFO - 'LANGUAGE': 'en_US:en', 20:19:55 INFO - 'LOGNAME': 'cltbld', 20:19:55 INFO - 'MAIL': '/var/mail/cltbld', 20:19:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:19:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:19:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:55 INFO - 'MOZ_NO_REMOTE': '1', 20:19:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:19:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:55 INFO - 'NO_EM_RESTART': '1', 20:19:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:55 INFO - 'PWD': '/builds/slave/test', 20:19:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:19:55 INFO - 'SHELL': '/bin/bash', 20:19:55 INFO - 'SHLVL': '1', 20:19:55 INFO - 'TERM': 'linux', 20:19:55 INFO - 'TMOUT': '86400', 20:19:55 INFO - 'USER': 'cltbld', 20:19:55 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475550764.148701-887786732', 20:19:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:55 INFO - '_': '/tools/buildbot/bin/python'} 20:19:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 20:19:55 INFO - mozversion application_buildid: 20161003183005 20:19:55 INFO - mozversion application_changeset: b26e668306fba754bba594572ac721bf5b0990ef 20:19:55 INFO - mozversion application_display_name: Nightly 20:19:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:19:55 INFO - mozversion application_name: Firefox 20:19:55 INFO - mozversion application_remotingname: firefox 20:19:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:19:55 INFO - mozversion application_vendor: Mozilla 20:19:55 INFO - mozversion application_version: 52.0a1 20:19:55 INFO - mozversion platform_buildid: 20161003183005 20:19:55 INFO - mozversion platform_changeset: b26e668306fba754bba594572ac721bf5b0990ef 20:19:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:19:55 INFO - mozversion platform_version: 52.0a1 20:19:55 INFO - using testdate: 1475551195 20:19:55 INFO - actual date: 1475551195 20:19:55 INFO - starting webserver on 'localhost:42828' 20:19:55 INFO - SUITE-START | Running 2 tests 20:19:55 INFO - TEST-START | dromaeo_css 20:19:55 INFO - operating with platform_type : linux_ 20:19:55 INFO - Initialising browser for dromaeo_css test... 20:19:55 INFO - TEST-INFO | started process 23097 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD9mE3S/profile http://localhost:42828/getInfo.html) 20:20:00 INFO - PROCESS | 23097 | __metrics Screen width/height:1600/1200 20:20:00 INFO - PROCESS | 23097 | colorDepth:24 20:20:00 INFO - PROCESS | 23097 | Browser inner width/height: 1024/697 20:20:00 INFO - PROCESS | 23097 | __metrics 20:20:00 INFO - PROCESS | 23097 | 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" 20:20:00 INFO - PROCESS | 23097 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:20:01 INFO - PROCESS | 23097 | console.error: PushService: 20:20:01 INFO - PROCESS | 23097 | stateChangeProcessEnqueue: Error transitioning state 20:20:01 INFO - PROCESS | 23097 | UnknownError 20:20:02 INFO - TEST-INFO | 23097: exit 0 20:20:02 INFO - Browser initialized. 20:20:02 INFO - Running cycle 1/1 for dromaeo_css test... 20:20:02 INFO - TEST-INFO | started process 23181 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD9mE3S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:20:14 INFO - PROCESS | 23181 | RSS: Main: 174170112 20:20:14 INFO - PROCESS | 23181 | 20:21:05 INFO - PROCESS | 23181 | 1475551265621 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] 20:23:15 INFO - PROCESS | 23181 | Cycle 1(1): loaded http://localhost:42828/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42828/tests/dromaeo/cssquery-ext.html) 20:23:17 INFO - PROCESS | 23181 | RSS: Main: 304435200 20:23:17 INFO - PROCESS | 23181 | 20:26:19 INFO - PROCESS | 23181 | Cycle 1(1): loaded http://localhost:42828/tests/dromaeo/cssquery-ext.html (next: http://localhost:42828/tests/dromaeo/cssquery-jquery.html) 20:26:20 INFO - PROCESS | 23181 | RSS: Main: 268066816 20:26:20 INFO - PROCESS | 23181 | 20:29:22 INFO - PROCESS | 23181 | Cycle 1(1): loaded http://localhost:42828/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42828/tests/dromaeo/cssquery-mootools.html) 20:29:22 INFO - PROCESS | 23181 | RSS: Main: 259518464 20:29:22 INFO - PROCESS | 23181 | 20:32:24 INFO - PROCESS | 23181 | Cycle 1(1): loaded http://localhost:42828/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42828/tests/dromaeo/cssquery-prototype.html) 20:32:25 INFO - PROCESS | 23181 | RSS: Main: 248868864 20:32:25 INFO - PROCESS | 23181 | 20:35:28 INFO - PROCESS | 23181 | Cycle 1(1): loaded http://localhost:42828/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42828/tests/dromaeo/cssquery-yui.html) 20:35:28 INFO - PROCESS | 23181 | RSS: Main: 216178688 20:35:28 INFO - PROCESS | 23181 | 20:38:31 INFO - PROCESS | 23181 | Cycle 1(1): loaded http://localhost:42828/tests/dromaeo/cssquery-yui.html (next: http://localhost:42828/tests/dromaeo/cssquery-dojo.html) 20:38:31 INFO - PROCESS | 23181 | RSS: Main: 308142080 20:38:31 INFO - PROCESS | 23181 | 20:38:31 INFO - PROCESS | 23181 | __start_tp_report 20:38:31 INFO - PROCESS | 23181 | _x_x_mozilla_page_load 20:38:31 INFO - PROCESS | 23181 | _x_x_mozilla_page_load_details 20:38:31 INFO - PROCESS | 23181 | |i|pagename|runs| 20:38:31 INFO - PROCESS | 23181 | |0;dojo.html;2996.3707621399503;3035.4080954213937;3038.0430164498175;3068.846557672116;3082.5838511800916;5178.275041494185;5207.270982062514;5213.452587478317;5305.177697456896;5320.7871685132595;5180.378354597444;5227.451117632641;5248.501392367719;5269.446708095652;5281.049411106;4774.116788394141;4796.472388037313;4799.304100905367;4818.759062046901;4874.829380971667;4813.15769740294;4861.781219845116;4881.4874438184015;4900.387451568554;4985.750712464381;4909.165441874872;4911.45973942866;4919.188333924898;4936;5005.6496045276845;4700.2009658358165;4759.095771803381;4767.070421267854;4913.631477639191;4927.113119638464;4771.141194584973;4773.594244489223;4827.662063655545;4876.731779752112;4887.975560122212;5216.035033518811;5257.080010998098;5263.605229607795;5264.947350526522;5280.683159010472;5653.157417464688;5658.575606829504;5659.292588426447;5663.886722265532;5724.198612194296;5511.476409741068;5556.888862222773;5686.317641882959;5721.485066344049;5755.338136114358;5340.305760251143;5342.358916929993;5343.038253114438;5344.812931547377;5384.246205531229;5849.2103566018895;5849.912251316234;5871.412858714094;5876.676782776903;5878.088896221093;5343;5349.518543331119;5510.393856675762;5571.052921003358;5621.606487545914;5636.971815140898;5673.8297851064535;5697.401772813878;5719.056355701263;5741.081426971748;5656.660600363992;5667.263255776805;5667.971660141673;5670.036093864053;5674.120511320752;5506.669599824023;5510.421405752419;5562.137868630369;5679.460451257124;5755.309362876482;4337.956620433818;4361.084172323847;4366.934495982563;4369.300911854088;4377.212101821639;3911.647951684362;3932.6264004919485;3945.2898478274187;3967.821448034845;3979.801009949491;5364.7049412282695;5366.168243922199;5368.651037682538;5372.140457526777;5378.058839703036;5415.53967912724;5579.191017302468;5711.685857277889;5724;5728.684922329228;5282.52457278839;5283.815066472655;5296.073187192226;5381.219723140122;5393.460653934575;4953.405591329064;4961.107000739901;4965.1807451770055;4980.003999200175;5019.598432125421;5629.549636029026;5847.883042339215;5857.414258574108;5861.9413805861395;5863.7947671832135;5523.613347065828;5672.659640421588;5674.829755107354;5675.971620141873;5677.148427735708;5796.159556864147;5804.796832110856;5808.854778630568;5816.243888294494;5817.040188368872;5547.2511210986;5584.3857175711455;5597.692126933058;5670.631408958405;5675.829725108253;5658.292713410824;5695.259616249861;5702.885942281214;5712.6286791358425;5754.108113242454;5570.303712035996;5577.079781836114;5579.302587176603;5583.022970979981;5587.74855131512;5416.729163541886;5426.403095659553;5486.588505861996;5487.862803429786;5558.055130627722;5498.80754173602;5503.807366742145;5507.339119305709;5560.193771903132;5574.024545704567;5579.581531385244;5589.720513974204;5595.104783234663;5596;5596.440355964371;5288.180332048539;5314.787408503771;5336.466353364633;5392.919106213331;5441.5102640762525 20:38:31 INFO - PROCESS | 23181 | |1;ext.html;551.8840349955909;593.2258402784366;596.6837576084674;610.5664977865715;614.4930432393277;33166;33906.32187356254;41780.37329440061;42525.362119568155;42547.14905701884;44353.66938991827;44613;44661.55338446615;44665;44805.327920081145;8869.42348747331;8977.910220897773;8986.640534378617;8988.68539601114;9027.368084234105;7952.244536768998;8035.397345199104;8801.559922003906;10551.472426378688;10821.83767243492;11060.944695276552;11120.888791112107;11125.388103654295;11131.109511239121;11134.610288639898;10631.734206644818;10633.840492392621;10648.57405703771;10680.35917844924;10683.78632427351;10714.196435267386;10777.245592808507;10778.461076946121;10788.460576971198;10793.946030269877;41518.58481415177;41590.1681966362;41626.791866040476;41774.58225417768;41813;3419.9145021374416;3560.287942411528;3607.260511595117;3767.717421193394;3838.4818049563232;31095.689043109505;32101;32154.196145096324;32337.191570210696;32569.185770355693;4216.64158546524;4342.848000319974;4356.411884395598;4524.5701658342405;4586.839460618862;350035;351013;351352.99999999744;353107;353548;34463.48304775431;35181.82409087989;58252.41747582555;58597.70701146467;58705;36375.63624363775;36555.634443655224;36555.903322900354;36564;36566;14368.784468232985;14399.280035998157;14401.78397324041;14429.567112986628;14475.059121157092;10930.617428390127;11802.704932376759;11889.464974076187;11904.76190476203;11906.761864762657;7831.099423566249;8313.958430207811;8443.662253509914;8537;8539.914600854036;3279.918002049968;3316.3201543683485;3317.137544238467;3322.1196382958537;3343.5820522434697;988.658912675126;1005.9346142500714;1010.5351538292321;1023.3859684189575;1110.4725255503572;28532.286692832844;28629.57055644167;28784.568231476544;29317.56023659647;29347.706522934925;1036.4144258493927;1068.4817863336275;1084.3764835219781;1088.678839742278;1123.466353482106;14722.411103555953;15819.920900395655;15854.60363490922;15865.603359916095;16059.759103613454;534973;538132;538587;538899;539477;38466.80766596149;38503.229935401134;38517.6148238514;38623.613763862;38633.227335453696;1217.1601594899491;1254.8055051467038;1310.25315570126;1349.0421800521544;1355.5052405871984;27657.58513622257;29515.55726664145;29718.55422168626;30255.243618909702;30401.543976839923;48326.27510587274;48631;48804.51195488;48881.5111848877;48994.510054898994;309151;309344;309706;310189;310192;27676.446471070867;27975.160745177676;28306.2923426916;28351.858240708665;29696.109116726533;45877.770611148066;45998;46027.30959035684;46100;46117.30824037575;37725.62274377221;38399.42400864045;40239;41137;41166.38250426186;39028;39228.60771392364;39488.40767388434;39899.800500997306;41151.7942410298;34919.82540087283;34982;35291.823540882135;35337.116572085906;35486.82256588701;32769.50845737268;34971.825140874134;35105.47341789824;35484.29031419306;35561.288774224886;24922.875385622956;25387.873060634578;25528.23415297544;25731.485370292114;26300.605490917267 20:38:31 INFO - PROCESS | 23181 | |2;jquery.html;371.5244487056569;383.30621574949345;395.3022914555809;400.2774991140991;417.09490405819366;13533.768251618692;15431;16963.915180424112;19257.903710481463;19628.214871405125;18318;18469.35357262496;18667.81332186678;19056.428307150774;19090.140943657534;5736.45503677151;5877.824435112973;5976.551758618121;5978.252718410199;5983.012802887519;4671.785335812696;5917.5561832862495;5932.991391463462;5937.792177273796;5941.88116237675;5685.204071429983;5883.735231914574;5884.146798714184;5888.263967004124;5888.558358123137;5922.082077278007;6062.636241825505;6069.696515174268;6070.150178974969;6072.817815465543;5064.18972964324;5283.63014588979;5366.195070739382;5875.529957603381;5881.14723365114;13766.65583360414;13947.442102315896;13992.16047037181;14011.159330440207;14164.575062748134;2193.59418507575;2272.784085511874;2311.5723591135693;2346.753590872951;2783.151138902634;9827.11555959967;10341.844872326921;10832.566697332097;10885.129189664887;10886.129109671207;1828.3783513605306;1895.1282410091374;1908;1911.4074636862617;1925.663008973424;80198;82428.58785706093;82656.58671706663;83783;84682.57658711667;10448.634297799541;10626.203034772423;10765.946170269099;10869.565217391373;10931.344119352705;15470.845291547166;15483.22583870802;15497;15516.767248491282;15526.378944842305;7703.422243331773;7864;7890.605469726491;7927.286544211049;8234.752957411287;7161.641917904084;7229.710811567478;7285.344319011315;7401.5189012714;7471.925280747231;4537.6143027843;4607.101615185074;4665.2302370108555;4733.928991065137;4741.2888066789565;1836.3939899833024;1879.7086451600023;1925.7881633020356;1994.9102290396968;2005.5287007553213;839.9034111077304;952.4523399045577;973.3429934793986;992.156666833186;1032.194887987371;17728.55678608045;19004.619907602046;19199.712004319947;19243.80756192448;19452.319168829024;917.7980844214262;945;973.445136272318;985.4087547471603;993.4287784523783;9865.506724663737;10771.246012779031;10868.782624347468;10873.510692018877;10938.179636527133;431353;437787;445384;449989;451088;91467;91980.54009729909;92581.5370923141;92750.53624731833;93602;965.792354643755;982.219135787051;997.9471657401366;1001.6293971230546;1001.979960400788;16238.512844614681;16566.585835354213;16893;16902.40841570539;17168.141592920554;39648.40527392149;40961;41545.1690966173;41774;42441;58276.4172358288;58372.416275836695;58637.70681146567;58690;60513;7473.654742146466;7654.311111999947;7806.219378062148;8124.8781268279845;8507;12812.231266124063;12938.805917911428;13360.532381366605;13472.124311919693;13558.118722283414;11216.83174752363;11353.54585816558;11354.886451135382;11430.942845286054;11719.531218751154;11272.492737826982;11291.43542822872;11539.596114135966;11539.596114135966;11754.177207595729;10654.786904262026;11218.66344009681;11341.943290283825;11449.656510304705;11855.762884742084;7333.1200255969625;7648.847023059619;7686.846263074819;8040.477368970998;8246.752597422086;6408.839779005562;9669.806603868024;10210.285280030326;10492.580296788348;10939.56241750321 20:38:31 INFO - PROCESS | 23181 | |3;mootools.html;1362.094207352111;1478.4899209772625;1505.9021163624363;1650.8431698988593;1799.973000404994;7821.4133939954445;8425.873611895826;8607.913920860781;8700.65197392105;8712.30301575874;8478.236958673719;8654.22112009919;8662.610182541785;8852.247558957497;8852.734417967471;2263.660450932361;2302.666113413554;2313.144136669426;2314.36355002374;2320.0835669910375;2269.5120549081944;2306.9653955190684;2307.261676263596;2308.2613563659634;2315.2591170825344;2253.346529506441;2268.7164104486938;2278.305116939333;2309.7343805462333;2315.455867871049;2198.2855571939185;2206.316042026977;2211.3034394165866;2211.7014203082617;2211.8341124415574;2223.6886835842993;2233.888305584714;2234.4190510467397;2234.597772400967;2235.832312576547;8794.208521233055;8808.471491710518;8866.512341821197;8884.644614215424;8885.644574217024;5036.84889453317;5191.273221748958;5194.220866869962;5218.425973142951;5237.9785941741375;3090.284304228177;3239.5302681111107;3287.556179915705;3299.2411745298477;3308.0902751743465;1115.2490589774059;1138.5844166879112;2048.1909645690016;2048.7294990169453;2054.4247610669036;12399.25604463735;12424.37878106091;12547.874521254762;12558.120931534797;12574.622761317176;4385.035292235703;4441.378207051015;4536.319552067216;4540.545945405433;4679.040796636681;10633.149348052137;10660.626878059385;10663.146948244123;10666.413347265974;10667.733306667395;5272.499112584298;5321.494458026481;5327.680339179662;5329.333833270841;5332.9466705333225;4258.403823464718;4351.390805287262;4630;4739.810407583658;4894.363732714724;3900.258950799339;3929.410588411704;3991.8004099794894;3998.100427403869;4029.4560234367987;1244.6888277930518;1247.3389103775014;1273.9808902866464;1279.6992706713916;1284.2037936479255;754.7962050246402;796.7848680856137;823.8475881961737;869.4218344800763;884.827458645558;5403.324584426947;5691.231683722727;5800.099950024987;5870.031444811643;5910.379410161957;942.3026960049514;967.2165545907837;970.5777986575862;975.4001289207087;1002.9849552256723;3497.3355062538035;3648.1244501319493;3680.852765889388;3796.1838204786104;3801.7718936863876;10768.892311076946;11024.614138505274;11042.558297668003;11312.03847672957;11329.94335028336;11002.064824489848;11014.779704405866;11025.173112016631;11030.06244469229;11041.723956901142;8197.79505512355;8210.220029097227;8298.087210406851;8386.329093672492;8399;5467.336082124763;5514.503694667499;5622.690752008515;5668.121441176624;5799.3040835100055;10125.392476451436;10228.386296822215;10253.384796912209;10311.123554497952;10378.06597406237;10304.83598444335;10509.9474502627;10613.9469302653;10663.89336106629;10787.244892857425;6605.504587155887;6717.193936727624;6888.862222755617;7318.560886346836;7488.326050655467;8208.220219079178;8505.574721264036;8534.871976920227;8538.829223415622;8543.444676096035;7266;7271.709131634887;7305.415566754753;7325.7802265932105;7516.736914207976;7419;7469.178390377163;7578.355839753683;7673.155952845294;7729.497582657109;6270.529710271839;6403.167588213502;6404.295527492065;6405.7117429714845;6424.229092508929;4836.322914791862;4884.096442158212;4930.728809915346;4949.505049495022;4977.377827771528;4951.529604687549;4959.9008019838675;5070.873228169326;5151.124308867426;5194.714290713896 20:38:31 INFO - PROCESS | 23181 | |4;prototype.html;315.4227763193358;324.4532961959099;332.5759656438041;336.2400973799213;336.3793800438192;5080.898382032357;5210.609204309678;5264.947350526493;5273.314469119014;5282.811367442328;5087.898242035167;5144.356955380577;5160.4323524412375;5186.677397263693;5189.662671926322;4142.606452387034;4143.689223308249;4147.854825081123;4150.405996252342;4154.459920210384;3913.960860391388;4083.3466645336753;4167.395727619493;4167.916641667165;4168.854090106847;4077.979610101945;4079.653229475498;4081.4081958116053;4082.632563069323;4084.611961863618;4058.431819545266;4059.939100913474;4060.309747342959;4065.2276067547073;4069.491313585802;3595.280943811222;3601.657842504958;3602.3875941089814;3606.765560238576;3609.350316942949;4959.876003099916;4994.650374473788;5031.899362012776;5063.670861393997;5097.923531147036;4672.15901137795;4677.859664210079;4683.578477937002;4687;4687.695299805502;5392.838214853521;5421.972890135564;5438.320209973754;5438.428964958702;5438.628050608648;3841.750286231386;3866.941995870064;3897.376419772851;3932.1152740633415;3963.969367964321;5628.2702889098755;5643.68959707216;5649.293838270216;5667.121596152561;5677.261955945742;4009.1781184857036;4010.538788039413;4010.6791456683395;4016.7389119707127;4020.396940458896;3864.1885204107452;4046.5548789633117;4056.6146216109423;4058.5738497457933;4074.490688663917;4652.278896771006;4669.556392142741;4671.299305104261;4672.135654903854;4672.57946784791;5499.890002199933;5527.50252477279;5532.1425179097305;5544.584156188222;5547.195656629847;1305.3603734170379;1341.5639917027006;1347.5014244729514;1365.6654119740726;1388.2919710947288;872.5070335260557;891.6032365597376;903.7108125399809;903.7785742493131;906.3655441191061;4560.475545312332;4580.1755683976535;4651.930221046687;4670.622166460834;4682.484926658133;4898.583620392235;4912.533309335608;4915.557599816034;4915.8033678652455;4932.8520144395725;4628.583427491542;4652.3951886255245;4653.767311634405;4653.883652908705;4664.323673067386;2807.9329854655102;3002.1086715369615;3019.969800301969;3030.1515575638855;3030.7272345489014;5806.738696758656;5808.970955145197;5817.272840894888;5820.738066787005;5832.475077243069;5596.272484576979;5738.819248685556;5764.855878603068;5815.73829177688;5836.649801011953;5767.221425107725;5794.8551286217335;5796.826095217066;5801.245838041028;5853.678047707417;5657.886842263214;5661.518770904519;5664.631798933056;5666.150077488245;5689.630174038674;5381.730913454233;5631.971840140937;5656.6888821115235;5665.291838520185;5666.631668941671;5786.3056433228285;5846.239988801429;5853.624398266489;5862;5880;3989.2819292526465;4073.51117865858;4074.5517993020153;4083.632473077437;4086.5096188457574;5426.918596220981;5689.2319536862;5707.714614269187;5708.858228354429;5714.628549144292;5415.323084614423;5455.1544510600925;5532.1701744737;5541.667499950016;5575.4424557543925;5518.475744804237;5530.474604912527;5542.695151766691;5549.1676248563035;5564.443555644565;5287.365516138088;5445.930546392504;5485.945140548543;5503.944960550503;5505.366882808528;5557.1108622621805;5579.302587176603;5581.7209139543675;5584.776608935597;5597.944020559742;5441.7279136043835;5442.455754424526;5470.8905821882545;5474.288342515448;5486.54606529278 20:38:31 INFO - PROCESS | 23181 | |5;yui.html;692.5221597097999;715.9248278930716;748.7529115391922;777.0908037596012;809.2837838512916;15408.922955385222;17057.14714264285;17068.573285667866;17132.05773682447;17205.827941720578;15265.38938442461;15473.922630386833;15490.535283941472;15496.767548486754;15583.298751556178;651.3584119642148;666.3369946902839;754.7169811320755;772.6793380747011;775.1937984496132;787.346502403007;787.9724209652663;788.3377962511489;793.9087004994442;794.56696100625;846.5936350551739;851.1743608699552;852.6845067325067;852.9701460448886;853.2576658307281;679.1069743287561;834.8747687846811;839.366278459762;839.4711331860949;839.7690635075342;514.4315531337893;587.3685787778155;599.469469519474;602.172013481463;606.4784285514454;14263.215523146222;14272.14367137975;14286.214258215794;14313.85686143146;14314.64213394663;12849.935750321189;13341.799873001914;13428.664283392896;14059.367328470244;14160.433582656682;11749.647510574696;11813.232139910879;11981.221220620719;12894.161879477804;13143.86856131436;4378.102488989782;4412.360207769888;4413.404190434315;4456.487503937024;4475.530069342737;72549.63725181393;76257.61871190609;76932.23067769363;78525;78608;10692;10958.452077396258;10974.231803773659;11068.833967490495;11167.664970050912;19640.134187252188;19676.508087297647;19685.60628787445;19688.803111968984;19712.507187320145;7977.880331795028;8032.518048917083;8088.393370497236;8168.142345053802;8248.381371397048;4038.434619153321;4375.737455752601;4393.890152746143;4423.535528769497;4498.50516443191;3493.336266109482;3651.342758303531;3654.0682126057686;3658.7438879278193;3660.816959152032;588.7556663984399;597.9133025711335;600.7897235967376;603.7856560920898;606.4178388746765;639.6034458635676;651.5927545284197;684.6542496039468;684.7466437418187;688.7520492622651;9477.857832132524;9693.51532423376;9810.215182785503;10051.497425128715;10210;639.7792761497276;699.9860002800017;708.5111273221461;709.1561042359575;719.4208662027119;4272.743635381887;4557.977210113928;4599.839005634787;4621.075784843045;4693.7653117344;95174.52412737891;96999.75006248438;99045;116168;131912;97112;98734;101010.49494752625;102475;104186;53294;55080.17379739307;77586.61206693818;83330.58334708409;84653;9586.904130958601;9671.854922176313;9675.516224188903;9798.265130115413;10151.796964060824;34790.65209347874;36696.63303367039;47682.761586191846;53087.73456132694;53640.463595363544;73063.63468182625;73083;73675;75876.62061689656;75987.24012759802;12303;12933.935330323287;12973.54592589255;13036.934815326242;13140.34298285101;14447.422103115758;14552.41790328375;15262.160581168142;15534.378624854879;16027.679446410773;12905.935470322589;13762;13888.861111388756;14037;14684.706305874037;12874.420651070537;13100;13499.595012149652;13981.44074237019;14247.928760356132;13547;13848.861511384757;13910.778183125085;13986.370613322222;14367.425302987764;11433.771324573296;11541.884581154416;11624.184091709158;11627.476763545492;12173.45219465144;11411.055766484682;11977.880221197676;12274.631761047183;12338.753224935272;12394.75210495803 20:38:31 INFO - PROCESS | 23181 | __end_tp_report 20:38:31 INFO - PROCESS | 23181 | __start_cc_report 20:38:31 INFO - PROCESS | 23181 | _x_x_mozilla_cycle_collect,1120 20:38:31 INFO - PROCESS | 23181 | __end_cc_report 20:38:31 INFO - PROCESS | 23181 | __startTimestamp1475552311649__endTimestamp 20:38:31 INFO - PROCESS | 23181 | 20:38:31 INFO - PROCESS | 23181 | ------- Summary: start ------- 20:38:31 INFO - PROCESS | 23181 | Number of tests: 6 20:38:31 INFO - PROCESS | 23181 | 20:38:31 INFO - PROCESS | 23181 | [#0] dojo.html Cycles:165 Average:5265.83 Median:5416.73 stddev:585.12 (10.8%) stddev-sans-first:559.17 20:38:31 INFO - PROCESS | 23181 | Values: 2996.4 3035.4 3038.0 3068.8 3082.6 5178.3 5207.3 5213.5 5305.2 5320.8 5180.4 5227.5 5248.5 5269.4 5281.0 4774.1 4796.5 4799.3 4818.8 4874.8 4813.2 4861.8 4881.5 4900.4 4985.8 4909.2 4911.5 4919.2 4936.0 5005.6 4700.2 4759.1 4767.1 4913.6 4927.1 4771.1 4773.6 4827.7 4876.7 4888.0 5216.0 5257.1 5263.6 5264.9 5280.7 5653.2 5658.6 5659.3 5663.9 5724.2 5511.5 5556.9 5686.3 5721.5 5755.3 5340.3 5342.4 5343.0 5344.8 5384.2 5849.2 5849.9 5871.4 5876.7 5878.1 5343.0 5349.5 5510.4 5571.1 5621.6 5637.0 5673.8 5697.4 5719.1 5741.1 5656.7 5667.3 5668.0 5670.0 5674.1 5506.7 5510.4 5562.1 5679.5 5755.3 4338.0 4361.1 4366.9 4369.3 4377.2 3911.6 3932.6 3945.3 3967.8 3979.8 5364.7 5366.2 5368.7 5372.1 5378.1 5415.5 5579.2 5711.7 5724.0 5728.7 5282.5 5283.8 5296.1 5381.2 5393.5 4953.4 4961.1 4965.2 4980.0 5019.6 5629.5 5847.9 5857.4 5861.9 5863.8 5523.6 5672.7 5674.8 5676.0 5677.1 5796.2 5804.8 5808.9 5816.2 5817.0 5547.3 5584.4 5597.7 5670.6 5675.8 5658.3 5695.3 5702.9 5712.6 5754.1 5570.3 5577.1 5579.3 5583.0 5587.7 5416.7 5426.4 5486.6 5487.9 5558.1 5498.8 5503.8 5507.3 5560.2 5574.0 5579.6 5589.7 5595.1 5596.0 5596.4 5288.2 5314.8 5336.5 5392.9 5441.5 20:38:31 INFO - PROCESS | 23181 | 20:38:31 INFO - PROCESS | 23181 | [#1] ext.html Cycles:180 Average:54266.94 Median:193059.24 stddev:109503.88 (56.7%) stddev-sans-first:109736.80 20:38:31 INFO - PROCESS | 23181 | Values: 551.9 593.2 596.7 610.6 614.5 33166.0 33906.3 41780.4 42525.4 42547.1 44353.7 44613.0 44661.6 44665.0 44805.3 8869.4 8977.9 8986.6 8988.7 9027.4 7952.2 8035.4 8801.6 10551.5 10821.8 11060.9 11120.9 11125.4 11131.1 11134.6 10631.7 10633.8 10648.6 10680.4 10683.8 10714.2 10777.2 10778.5 10788.5 10793.9 41518.6 41590.2 41626.8 41774.6 41813.0 3419.9 3560.3 3607.3 3767.7 3838.5 31095.7 32101.0 32154.2 32337.2 32569.2 4216.6 4342.8 4356.4 4524.6 4586.8 350035.0 351013.0 351353.0 353107.0 353548.0 34463.5 35181.8 58252.4 58597.7 58705.0 36375.6 36555.6 36555.9 36564.0 36566.0 14368.8 14399.3 14401.8 14429.6 14475.1 10930.6 11802.7 11889.5 11904.8 11906.8 7831.1 8314.0 8443.7 8537.0 8539.9 3279.9 3316.3 3317.1 3322.1 3343.6 988.7 1005.9 1010.5 1023.4 1110.5 28532.3 28629.6 28784.6 29317.6 29347.7 1036.4 1068.5 1084.4 1088.7 1123.5 14722.4 15819.9 15854.6 15865.6 16059.8 534973.0 538132.0 538587.0 538899.0 539477.0 38466.8 38503.2 38517.6 38623.6 38633.2 1217.2 1254.8 1310.3 1349.0 1355.5 27657.6 29515.6 29718.6 30255.2 30401.5 48326.3 48631.0 48804.5 48881.5 48994.5 309151.0 309344.0 309706.0 310189.0 310192.0 27676.4 27975.2 28306.3 28351.9 29696.1 45877.8 45998.0 46027.3 46100.0 46117.3 37725.6 38399.4 40239.0 41137.0 41166.4 39028.0 39228.6 39488.4 39899.8 41151.8 34919.8 34982.0 35291.8 35337.1 35486.8 32769.5 34971.8 35105.5 35484.3 35561.3 24922.9 25387.9 25528.2 25731.5 26300.6 20:38:31 INFO - PROCESS | 23181 | 20:38:31 INFO - PROCESS | 23181 | [#2] jquery.html Cycles:180 Average:27287.44 Median:20981.13 stddev:73489.72 (350.3%) stddev-sans-first:73668.09 20:38:31 INFO - PROCESS | 23181 | Values: 371.5 383.3 395.3 400.3 417.1 13533.8 15431.0 16963.9 19257.9 19628.2 18318.0 18469.4 18667.8 19056.4 19090.1 5736.5 5877.8 5976.6 5978.3 5983.0 4671.8 5917.6 5933.0 5937.8 5941.9 5685.2 5883.7 5884.1 5888.3 5888.6 5922.1 6062.6 6069.7 6070.2 6072.8 5064.2 5283.6 5366.2 5875.5 5881.1 13766.7 13947.4 13992.2 14011.2 14164.6 2193.6 2272.8 2311.6 2346.8 2783.2 9827.1 10341.8 10832.6 10885.1 10886.1 1828.4 1895.1 1908.0 1911.4 1925.7 80198.0 82428.6 82656.6 83783.0 84682.6 10448.6 10626.2 10765.9 10869.6 10931.3 15470.8 15483.2 15497.0 15516.8 15526.4 7703.4 7864.0 7890.6 7927.3 8234.8 7161.6 7229.7 7285.3 7401.5 7471.9 4537.6 4607.1 4665.2 4733.9 4741.3 1836.4 1879.7 1925.8 1994.9 2005.5 839.9 952.5 973.3 992.2 1032.2 17728.6 19004.6 19199.7 19243.8 19452.3 917.8 945.0 973.4 985.4 993.4 9865.5 10771.2 10868.8 10873.5 10938.2 431353.0 437787.0 445384.0 449989.0 451088.0 91467.0 91980.5 92581.5 92750.5 93602.0 965.8 982.2 997.9 1001.6 1002.0 16238.5 16566.6 16893.0 16902.4 17168.1 39648.4 40961.0 41545.2 41774.0 42441.0 58276.4 58372.4 58637.7 58690.0 60513.0 7473.7 7654.3 7806.2 8124.9 8507.0 12812.2 12938.8 13360.5 13472.1 13558.1 11216.8 11353.5 11354.9 11430.9 11719.5 11272.5 11291.4 11539.6 11539.6 11754.2 10654.8 11218.7 11341.9 11449.7 11855.8 7333.1 7648.8 7686.8 8040.5 8246.8 6408.8 9669.8 10210.3 10492.6 10939.6 20:38:31 INFO - PROCESS | 23181 | 20:38:31 INFO - PROCESS | 23181 | [#3] mootools.html Cycles:180 Average:5739.52 Median:4538.43 stddev:3334.43 (73.5%) stddev-sans-first:3327.56 20:38:31 INFO - PROCESS | 23181 | Values: 1362.1 1478.5 1505.9 1650.8 1800.0 7821.4 8425.9 8607.9 8700.7 8712.3 8478.2 8654.2 8662.6 8852.2 8852.7 2263.7 2302.7 2313.1 2314.4 2320.1 2269.5 2307.0 2307.3 2308.3 2315.3 2253.3 2268.7 2278.3 2309.7 2315.5 2198.3 2206.3 2211.3 2211.7 2211.8 2223.7 2233.9 2234.4 2234.6 2235.8 8794.2 8808.5 8866.5 8884.6 8885.6 5036.8 5191.3 5194.2 5218.4 5238.0 3090.3 3239.5 3287.6 3299.2 3308.1 1115.2 1138.6 2048.2 2048.7 2054.4 12399.3 12424.4 12547.9 12558.1 12574.6 4385.0 4441.4 4536.3 4540.5 4679.0 10633.1 10660.6 10663.1 10666.4 10667.7 5272.5 5321.5 5327.7 5329.3 5332.9 4258.4 4351.4 4630.0 4739.8 4894.4 3900.3 3929.4 3991.8 3998.1 4029.5 1244.7 1247.3 1274.0 1279.7 1284.2 754.8 796.8 823.8 869.4 884.8 5403.3 5691.2 5800.1 5870.0 5910.4 942.3 967.2 970.6 975.4 1003.0 3497.3 3648.1 3680.9 3796.2 3801.8 10768.9 11024.6 11042.6 11312.0 11329.9 11002.1 11014.8 11025.2 11030.1 11041.7 8197.8 8210.2 8298.1 8386.3 8399.0 5467.3 5514.5 5622.7 5668.1 5799.3 10125.4 10228.4 10253.4 10311.1 10378.1 10304.8 10509.9 10613.9 10663.9 10787.2 6605.5 6717.2 6888.9 7318.6 7488.3 8208.2 8505.6 8534.9 8538.8 8543.4 7266.0 7271.7 7305.4 7325.8 7516.7 7419.0 7469.2 7578.4 7673.2 7729.5 6270.5 6403.2 6404.3 6405.7 6424.2 4836.3 4884.1 4930.7 4949.5 4977.4 4951.5 4959.9 5070.9 5151.1 5194.7 20:38:31 INFO - PROCESS | 23181 | 20:38:31 INFO - PROCESS | 23181 | [#4] prototype.html Cycles:180 Average:4576.96 Median:5092.91 stddev:1352.74 (26.6%) stddev-sans-first:1318.17 20:38:31 INFO - PROCESS | 23181 | Values: 315.4 324.5 332.6 336.2 336.4 5080.9 5210.6 5264.9 5273.3 5282.8 5087.9 5144.4 5160.4 5186.7 5189.7 4142.6 4143.7 4147.9 4150.4 4154.5 3914.0 4083.3 4167.4 4167.9 4168.9 4078.0 4079.7 4081.4 4082.6 4084.6 4058.4 4059.9 4060.3 4065.2 4069.5 3595.3 3601.7 3602.4 3606.8 3609.4 4959.9 4994.7 5031.9 5063.7 5097.9 4672.2 4677.9 4683.6 4687.0 4687.7 5392.8 5422.0 5438.3 5438.4 5438.6 3841.8 3866.9 3897.4 3932.1 3964.0 5628.3 5643.7 5649.3 5667.1 5677.3 4009.2 4010.5 4010.7 4016.7 4020.4 3864.2 4046.6 4056.6 4058.6 4074.5 4652.3 4669.6 4671.3 4672.1 4672.6 5499.9 5527.5 5532.1 5544.6 5547.2 1305.4 1341.6 1347.5 1365.7 1388.3 872.5 891.6 903.7 903.8 906.4 4560.5 4580.2 4651.9 4670.6 4682.5 4898.6 4912.5 4915.6 4915.8 4932.9 4628.6 4652.4 4653.8 4653.9 4664.3 2807.9 3002.1 3020.0 3030.2 3030.7 5806.7 5809.0 5817.3 5820.7 5832.5 5596.3 5738.8 5764.9 5815.7 5836.6 5767.2 5794.9 5796.8 5801.2 5853.7 5657.9 5661.5 5664.6 5666.2 5689.6 5381.7 5632.0 5656.7 5665.3 5666.6 5786.3 5846.2 5853.6 5862.0 5880.0 3989.3 4073.5 4074.6 4083.6 4086.5 5426.9 5689.2 5707.7 5708.9 5714.6 5415.3 5455.2 5532.2 5541.7 5575.4 5518.5 5530.5 5542.7 5549.2 5564.4 5287.4 5445.9 5485.9 5503.9 5505.4 5557.1 5579.3 5581.7 5584.8 5597.9 5441.7 5442.5 5470.9 5474.3 5486.5 20:38:31 INFO - PROCESS | 23181 | 20:38:31 INFO - PROCESS | 23181 | [#5] yui.html Cycles:180 Average:20077.22 Median:4412.88 stddev:28621.33 (648.6%) stddev-sans-first:28664.61 20:38:31 INFO - PROCESS | 23181 | Values: 692.5 715.9 748.8 777.1 809.3 15408.9 17057.1 17068.6 17132.1 17205.8 15265.4 15473.9 15490.5 15496.8 15583.3 651.4 666.3 754.7 772.7 775.2 787.3 788.0 788.3 793.9 794.6 846.6 851.2 852.7 853.0 853.3 679.1 834.9 839.4 839.5 839.8 514.4 587.4 599.5 602.2 606.5 14263.2 14272.1 14286.2 14313.9 14314.6 12849.9 13341.8 13428.7 14059.4 14160.4 11749.6 11813.2 11981.2 12894.2 13143.9 4378.1 4412.4 4413.4 4456.5 4475.5 72549.6 76257.6 76932.2 78525.0 78608.0 10692.0 10958.5 10974.2 11068.8 11167.7 19640.1 19676.5 19685.6 19688.8 19712.5 7977.9 8032.5 8088.4 8168.1 8248.4 4038.4 4375.7 4393.9 4423.5 4498.5 3493.3 3651.3 3654.1 3658.7 3660.8 588.8 597.9 600.8 603.8 606.4 639.6 651.6 684.7 684.7 688.8 9477.9 9693.5 9810.2 10051.5 10210.0 639.8 700.0 708.5 709.2 719.4 4272.7 4558.0 4599.8 4621.1 4693.8 95174.5 96999.8 99045.0 116168.0 131912.0 97112.0 98734.0 101010.5 102475.0 104186.0 53294.0 55080.2 77586.6 83330.6 84653.0 9586.9 9671.9 9675.5 9798.3 10151.8 34790.7 36696.6 47682.8 53087.7 53640.5 73063.6 73083.0 73675.0 75876.6 75987.2 12303.0 12933.9 12973.5 13036.9 13140.3 14447.4 14552.4 15262.2 15534.4 16027.7 12905.9 13762.0 13888.9 14037.0 14684.7 12874.4 13100.0 13499.6 13981.4 14247.9 13547.0 13848.9 13910.8 13986.4 14367.4 11433.8 11541.9 11624.2 11627.5 12173.5 11411.1 11977.9 12274.6 12338.8 12394.8 20:38:31 INFO - PROCESS | 23181 | -------- Summary: end -------- 20:38:31 INFO - PROCESS | 23181 | 20:38:32 INFO - TEST-INFO | 23181: exit 0 20:38:32 INFO - TEST-OK | dromaeo_css | took 1116761ms 20:38:32 INFO - TEST-START | kraken 20:38:32 INFO - operating with platform_type : linux_ 20:38:32 INFO - Initialising browser for kraken test... 20:38:32 INFO - TEST-INFO | started process 23485 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvGp0Fd/profile http://localhost:42828/getInfo.html) 20:38:36 INFO - PROCESS | 23485 | __metrics Screen width/height:1600/1200 20:38:36 INFO - PROCESS | 23485 | colorDepth:24 20:38:36 INFO - PROCESS | 23485 | Browser inner width/height: 1024/697 20:38:36 INFO - PROCESS | 23485 | __metrics 20:38:37 INFO - PROCESS | 23485 | 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" 20:38:37 INFO - PROCESS | 23485 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:38:37 INFO - PROCESS | 23485 | console.error: PushService: 20:38:37 INFO - PROCESS | 23485 | stateChangeProcessEnqueue: Error transitioning state 20:38:37 INFO - PROCESS | 23485 | UnknownError 20:38:38 INFO - TEST-INFO | 23485: exit 0 20:38:38 INFO - Browser initialized. 20:38:38 INFO - Running cycle 1/1 for kraken test... 20:38:38 INFO - TEST-INFO | started process 23567 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvGp0Fd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:38:50 INFO - PROCESS | 23567 | RSS: Main: 173604864 20:38:50 INFO - PROCESS | 23567 | 20:38:53 INFO - PROCESS | 23567 | Cycle 1(1): loaded http://localhost:42828/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42828/tests/kraken/driver.html?testName=audio-beat-detection) 20:38:54 INFO - PROCESS | 23567 | RSS: Main: 232742912 20:38:54 INFO - PROCESS | 23567 | 20:38:56 INFO - PROCESS | 23567 | Cycle 1(1): loaded http://localhost:42828/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42828/tests/kraken/driver.html?testName=audio-dft) 20:38:57 INFO - PROCESS | 23567 | RSS: Main: 216907776 20:38:57 INFO - PROCESS | 23567 | 20:39:00 INFO - PROCESS | 23567 | Cycle 1(1): loaded http://localhost:42828/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42828/tests/kraken/driver.html?testName=audio-fft) 20:39:01 INFO - PROCESS | 23567 | RSS: Main: 298983424 20:39:01 INFO - PROCESS | 23567 | 20:39:03 INFO - PROCESS | 23567 | Cycle 1(1): loaded http://localhost:42828/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42828/tests/kraken/driver.html?testName=audio-oscillator) 20:39:04 INFO - PROCESS | 23567 | RSS: Main: 209281024 20:39:04 INFO - PROCESS | 23567 | 20:39:06 INFO - PROCESS | 23567 | Cycle 1(1): loaded http://localhost:42828/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42828/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:39:06 INFO - PROCESS | 23567 | RSS: Main: 213254144 20:39:06 INFO - PROCESS | 23567 | 20:39:09 INFO - PROCESS | 23567 | Cycle 1(1): loaded http://localhost:42828/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42828/tests/kraken/driver.html?testName=imaging-darkroom) 20:39:10 INFO - PROCESS | 23567 | RSS: Main: 249483264 20:39:10 INFO - PROCESS | 23567 | 20:39:13 INFO - PROCESS | 23567 | Cycle 1(1): loaded http://localhost:42828/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42828/tests/kraken/driver.html?testName=imaging-desaturate) 20:39:14 INFO - PROCESS | 23567 | RSS: Main: 248569856 20:39:14 INFO - PROCESS | 23567 | 20:39:17 INFO - PROCESS | 23567 | Cycle 1(1): loaded http://localhost:42828/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42828/tests/kraken/driver.html?testName=json-parse-financial) 20:39:17 INFO - PROCESS | 23567 | RSS: Main: 248582144 20:39:17 INFO - PROCESS | 23567 | 20:39:19 INFO - PROCESS | 23567 | Cycle 1(1): loaded http://localhost:42828/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42828/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:39:19 INFO - PROCESS | 23567 | RSS: Main: 211185664 20:39:19 INFO - PROCESS | 23567 | 20:39:21 INFO - PROCESS | 23567 | Cycle 1(1): loaded http://localhost:42828/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42828/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:39:22 INFO - PROCESS | 23567 | RSS: Main: 218710016 20:39:22 INFO - PROCESS | 23567 | 20:39:24 INFO - PROCESS | 23567 | Cycle 1(1): loaded http://localhost:42828/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42828/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:39:24 INFO - PROCESS | 23567 | RSS: Main: 223272960 20:39:24 INFO - PROCESS | 23567 | 20:39:27 INFO - PROCESS | 23567 | Cycle 1(1): loaded http://localhost:42828/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42828/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:39:28 INFO - PROCESS | 23567 | RSS: Main: 225026048 20:39:28 INFO - PROCESS | 23567 | 20:39:30 INFO - PROCESS | 23567 | Cycle 1(1): loaded http://localhost:42828/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42828/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:39:31 INFO - PROCESS | 23567 | RSS: Main: 222838784 20:39:31 INFO - PROCESS | 23567 | 20:39:33 INFO - PROCESS | 23567 | Cycle 1(1): loaded http://localhost:42828/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42828/tests/kraken/driver.html?testName=ai-astar) 20:39:33 INFO - PROCESS | 23567 | RSS: Main: 272617472 20:39:33 INFO - PROCESS | 23567 | 20:39:33 INFO - PROCESS | 23567 | __start_tp_report 20:39:33 INFO - PROCESS | 23567 | _x_x_mozilla_page_load 20:39:33 INFO - PROCESS | 23567 | _x_x_mozilla_page_load_details 20:39:33 INFO - PROCESS | 23567 | |i|pagename|runs| 20:39:33 INFO - PROCESS | 23567 | |0;ai-astar;109;110;111;110;111;111;111;112;111;111 20:39:33 INFO - PROCESS | 23567 | |1;audio-beat-detection;147;124;132;163;126;132;123;130;161;124 20:39:33 INFO - PROCESS | 23567 | |2;audio-dft;162;161;162;162;161;164;164;161;160;163 20:39:33 INFO - PROCESS | 23567 | |3;audio-fft;75;76;75;118;79;77;76;76;109;76 20:39:33 INFO - PROCESS | 23567 | |4;audio-oscillator;83;83;120;83;84;84;101;82;83;107 20:39:33 INFO - PROCESS | 23567 | |5;imaging-gaussian-blur;117;117;116;116;116;117;117;117;117;117 20:39:33 INFO - PROCESS | 23567 | |6;imaging-darkroom;146;146;146;146;147;146;146;147;146;146 20:39:33 INFO - PROCESS | 23567 | |7;imaging-desaturate;95;95;95;95;96;95;95;96;96;96 20:39:33 INFO - PROCESS | 23567 | |8;json-parse-financial;54;53;51;51;52;52;52;53;63;52 20:39:33 INFO - PROCESS | 23567 | |9;json-stringify-tinderbox;62;62;61;61;62;61;62;61;61;62 20:39:33 INFO - PROCESS | 23567 | |10;stanford-crypto-aes;79;79;85;78;79;79;85;79;85;80 20:39:33 INFO - PROCESS | 23567 | |11;stanford-crypto-ccm;136;129;128;126;125;127;127;133;161;130 20:39:33 INFO - PROCESS | 23567 | |12;stanford-crypto-pbkdf2;163;166;164;171;162;167;167;162;169;163 20:39:33 INFO - PROCESS | 23567 | |13;stanford-crypto-sha256-iterative;66;65;67;65;65;67;64;65;63;64 20:39:33 INFO - PROCESS | 23567 | __end_tp_report 20:39:33 INFO - PROCESS | 23567 | __start_cc_report 20:39:33 INFO - PROCESS | 23567 | _x_x_mozilla_cycle_collect,1655 20:39:33 INFO - PROCESS | 23567 | __end_cc_report 20:39:33 INFO - PROCESS | 23567 | __startTimestamp1475552373415__endTimestamp 20:39:33 INFO - PROCESS | 23567 | 20:39:33 INFO - PROCESS | 23567 | ------- Summary: start ------- 20:39:33 INFO - PROCESS | 23567 | Number of tests: 14 20:39:33 INFO - PROCESS | 23567 | 20:39:33 INFO - PROCESS | 23567 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:0.82 (0.7%) stddev-sans-first:0.60 20:39:33 INFO - PROCESS | 23567 | Values: 109.0 110.0 111.0 110.0 111.0 111.0 111.0 112.0 111.0 111.0 20:39:33 INFO - PROCESS | 23567 | 20:39:33 INFO - PROCESS | 23567 | [#1] audio-beat-detection Cycles:10 Average:136.20 Median:132.00 stddev:15.27 (11.6%) stddev-sans-first:15.69 20:39:33 INFO - PROCESS | 23567 | Values: 147.0 124.0 132.0 163.0 126.0 132.0 123.0 130.0 161.0 124.0 20:39:33 INFO - PROCESS | 23567 | 20:39:33 INFO - PROCESS | 23567 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.33 (0.8%) stddev-sans-first:1.41 20:39:33 INFO - PROCESS | 23567 | Values: 162.0 161.0 162.0 162.0 161.0 164.0 164.0 161.0 160.0 163.0 20:39:33 INFO - PROCESS | 23567 | 20:39:33 INFO - PROCESS | 23567 | [#3] audio-fft Cycles:10 Average:83.70 Median:76.00 stddev:15.89 (20.9%) stddev-sans-first:16.54 20:39:33 INFO - PROCESS | 23567 | Values: 75.0 76.0 75.0 118.0 79.0 77.0 76.0 76.0 109.0 76.0 20:39:33 INFO - PROCESS | 23567 | 20:39:33 INFO - PROCESS | 23567 | [#4] audio-oscillator Cycles:10 Average:91.00 Median:83.00 stddev:13.47 (16.2%) stddev-sans-first:13.97 20:39:33 INFO - PROCESS | 23567 | Values: 83.0 83.0 120.0 83.0 84.0 84.0 101.0 82.0 83.0 107.0 20:39:33 INFO - PROCESS | 23567 | 20:39:33 INFO - PROCESS | 23567 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 20:39:33 INFO - PROCESS | 23567 | Values: 117.0 117.0 116.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 20:39:33 INFO - PROCESS | 23567 | 20:39:33 INFO - PROCESS | 23567 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 20:39:33 INFO - PROCESS | 23567 | Values: 146.0 146.0 146.0 146.0 147.0 146.0 146.0 147.0 146.0 146.0 20:39:33 INFO - PROCESS | 23567 | 20:39:33 INFO - PROCESS | 23567 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 20:39:33 INFO - PROCESS | 23567 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 96.0 96.0 20:39:33 INFO - PROCESS | 23567 | 20:39:33 INFO - PROCESS | 23567 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:52.50 stddev:3.53 (6.7%) stddev-sans-first:3.73 20:39:33 INFO - PROCESS | 23567 | Values: 54.0 53.0 51.0 51.0 52.0 52.0 52.0 53.0 63.0 52.0 20:39:33 INFO - PROCESS | 23567 | 20:39:33 INFO - PROCESS | 23567 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:62.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 20:39:33 INFO - PROCESS | 23567 | Values: 62.0 62.0 61.0 61.0 62.0 61.0 62.0 61.0 61.0 62.0 20:39:33 INFO - PROCESS | 23567 | 20:39:33 INFO - PROCESS | 23567 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:79.50 stddev:2.94 (3.7%) stddev-sans-first:3.04 20:39:33 INFO - PROCESS | 23567 | Values: 79.0 79.0 85.0 78.0 79.0 79.0 85.0 79.0 85.0 80.0 20:39:33 INFO - PROCESS | 23567 | 20:39:33 INFO - PROCESS | 23567 | [#11] stanford-crypto-ccm Cycles:10 Average:132.20 Median:129.50 stddev:10.65 (8.2%) stddev-sans-first:11.21 20:39:33 INFO - PROCESS | 23567 | Values: 136.0 129.0 128.0 126.0 125.0 127.0 127.0 133.0 161.0 130.0 20:39:33 INFO - PROCESS | 23567 | 20:39:33 INFO - PROCESS | 23567 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.40 Median:166.50 stddev:3.10 (1.9%) stddev-sans-first:3.16 20:39:33 INFO - PROCESS | 23567 | Values: 163.0 166.0 164.0 171.0 162.0 167.0 167.0 162.0 169.0 163.0 20:39:33 INFO - PROCESS | 23567 | 20:39:33 INFO - PROCESS | 23567 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.00 stddev:1.29 (2.0%) stddev-sans-first:1.32 20:39:33 INFO - PROCESS | 23567 | Values: 66.0 65.0 67.0 65.0 65.0 67.0 64.0 65.0 63.0 64.0 20:39:33 INFO - PROCESS | 23567 | -------- Summary: end -------- 20:39:33 INFO - PROCESS | 23567 | 20:39:34 INFO - TEST-INFO | 23567: exit 0 20:39:34 INFO - TEST-OK | kraken | took 62026ms 20:39:34 INFO - SUITE-END | took 1178s 20:39:35 INFO - Completed test suite (00:19:39) 20:39:35 INFO - javascript benchmark 20:39:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2996.3707621399503, 3035.4080954213937, 3038.0430164498175, 3068.846557672116, 3082.5838511800916, 5178.275041494185, 5207.270982062514, 5213.452587478317, 5305.177697456896, 5320.7871685132595, 5180.378354597444, 5227.451117632641, 5248.501392367719, 5269.446708095652, 5281.049411106, 4774.116788394141, 4796.472388037313, 4799.304100905367, 4818.759062046901, 4874.829380971667, 4813.15769740294, 4861.781219845116, 4881.4874438184015, 4900.387451568554, 4985.750712464381, 4909.165441874872, 4911.45973942866, 4919.188333924898, 4936.0, 5005.6496045276845, 4700.2009658358165, 4759.095771803381, 4767.070421267854, 4913.631477639191, 4927.113119638464, 4771.141194584973, 4773.594244489223, 4827.662063655545, 4876.731779752112, 4887.975560122212, 5216.035033518811, 5257.080010998098, 5263.605229607795, 5264.947350526522, 5280.683159010472, 5653.157417464688, 5658.575606829504, 5659.292588426447, 5663.886722265532, 5724.198612194296, 5511.476409741068, 5556.888862222773, 5686.317641882959, 5721.485066344049, 5755.338136114358, 5340.305760251143, 5342.358916929993, 5343.038253114438, 5344.812931547377, 5384.246205531229, 5849.2103566018895, 5849.912251316234, 5871.412858714094, 5876.676782776903, 5878.088896221093, 5343.0, 5349.518543331119, 5510.393856675762, 5571.052921003358, 5621.606487545914, 5636.971815140898, 5673.8297851064535, 5697.401772813878, 5719.056355701263, 5741.081426971748, 5656.660600363992, 5667.263255776805, 5667.971660141673, 5670.036093864053, 5674.120511320752, 5506.669599824023, 5510.421405752419, 5562.137868630369, 5679.460451257124, 5755.309362876482, 4337.956620433818, 4361.084172323847, 4366.934495982563, 4369.300911854088, 4377.212101821639, 3911.647951684362, 3932.6264004919485, 3945.2898478274187, 3967.821448034845, 3979.801009949491, 5364.7049412282695, 5366.168243922199, 5368.651037682538, 5372.140457526777, 5378.058839703036, 5415.53967912724, 5579.191017302468, 5711.685857277889, 5724.0, 5728.684922329228, 5282.52457278839, 5283.815066472655, 5296.073187192226, 5381.219723140122, 5393.460653934575, 4953.405591329064, 4961.107000739901, 4965.1807451770055, 4980.003999200175, 5019.598432125421, 5629.549636029026, 5847.883042339215, 5857.414258574108, 5861.9413805861395, 5863.7947671832135, 5523.613347065828, 5672.659640421588, 5674.829755107354, 5675.971620141873, 5677.148427735708, 5796.159556864147, 5804.796832110856, 5808.854778630568, 5816.243888294494, 5817.040188368872, 5547.2511210986, 5584.3857175711455, 5597.692126933058, 5670.631408958405, 5675.829725108253, 5658.292713410824, 5695.259616249861, 5702.885942281214, 5712.6286791358425, 5754.108113242454, 5570.303712035996, 5577.079781836114, 5579.302587176603, 5583.022970979981, 5587.74855131512, 5416.729163541886, 5426.403095659553, 5486.588505861996, 5487.862803429786, 5558.055130627722, 5498.80754173602, 5503.807366742145, 5507.339119305709, 5560.193771903132, 5574.024545704567, 5579.581531385244, 5589.720513974204, 5595.104783234663, 5596.0, 5596.440355964371, 5288.180332048539, 5314.787408503771, 5336.466353364633, 5392.919106213331, 5441.5102640762525], "value": 5226.943091854524, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.8840349955909, 593.2258402784366, 596.6837576084674, 610.5664977865715, 614.4930432393277, 33166.0, 33906.32187356254, 41780.37329440061, 42525.362119568155, 42547.14905701884, 44353.66938991827, 44613.0, 44661.55338446615, 44665.0, 44805.327920081145, 8869.42348747331, 8977.910220897773, 8986.640534378617, 8988.68539601114, 9027.368084234105, 7952.244536768998, 8035.397345199104, 8801.559922003906, 10551.472426378688, 10821.83767243492, 11060.944695276552, 11120.888791112107, 11125.388103654295, 11131.109511239121, 11134.610288639898, 10631.734206644818, 10633.840492392621, 10648.57405703771, 10680.35917844924, 10683.78632427351, 10714.196435267386, 10777.245592808507, 10778.461076946121, 10788.460576971198, 10793.946030269877, 41518.58481415177, 41590.1681966362, 41626.791866040476, 41774.58225417768, 41813.0, 3419.9145021374416, 3560.287942411528, 3607.260511595117, 3767.717421193394, 3838.4818049563232, 31095.689043109505, 32101.0, 32154.196145096324, 32337.191570210696, 32569.185770355693, 4216.64158546524, 4342.848000319974, 4356.411884395598, 4524.5701658342405, 4586.839460618862, 350035.0, 351013.0, 351352.99999999744, 353107.0, 353548.0, 34463.48304775431, 35181.82409087989, 58252.41747582555, 58597.70701146467, 58705.0, 36375.63624363775, 36555.634443655224, 36555.903322900354, 36564.0, 36566.0, 14368.784468232985, 14399.280035998157, 14401.78397324041, 14429.567112986628, 14475.059121157092, 10930.617428390127, 11802.704932376759, 11889.464974076187, 11904.76190476203, 11906.761864762657, 7831.099423566249, 8313.958430207811, 8443.662253509914, 8537.0, 8539.914600854036, 3279.918002049968, 3316.3201543683485, 3317.137544238467, 3322.1196382958537, 3343.5820522434697, 988.658912675126, 1005.9346142500714, 1010.5351538292321, 1023.3859684189575, 1110.4725255503572, 28532.286692832844, 28629.57055644167, 28784.568231476544, 29317.56023659647, 29347.706522934925, 1036.4144258493927, 1068.4817863336275, 1084.3764835219781, 1088.678839742278, 1123.466353482106, 14722.411103555953, 15819.920900395655, 15854.60363490922, 15865.603359916095, 16059.759103613454, 534973.0, 538132.0, 538587.0, 538899.0, 539477.0, 38466.80766596149, 38503.229935401134, 38517.6148238514, 38623.613763862, 38633.227335453696, 1217.1601594899491, 1254.8055051467038, 1310.25315570126, 1349.0421800521544, 1355.5052405871984, 27657.58513622257, 29515.55726664145, 29718.55422168626, 30255.243618909702, 30401.543976839923, 48326.27510587274, 48631.0, 48804.51195488, 48881.5111848877, 48994.510054898994, 309151.0, 309344.0, 309706.0, 310189.0, 310192.0, 27676.446471070867, 27975.160745177676, 28306.2923426916, 28351.858240708665, 29696.109116726533, 45877.770611148066, 45998.0, 46027.30959035684, 46100.0, 46117.30824037575, 37725.62274377221, 38399.42400864045, 40239.0, 41137.0, 41166.38250426186, 39028.0, 39228.60771392364, 39488.40767388434, 39899.800500997306, 41151.7942410298, 34919.82540087283, 34982.0, 35291.823540882135, 35337.116572085906, 35486.82256588701, 32769.50845737268, 34971.825140874134, 35105.47341789824, 35484.29031419306, 35561.288774224886, 24922.875385622956, 25387.873060634578, 25528.23415297544, 25731.485370292114, 26300.605490917267], "value": 18273.94697266447, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.5244487056569, 383.30621574949345, 395.3022914555809, 400.2774991140991, 417.09490405819366, 13533.768251618692, 15431.0, 16963.915180424112, 19257.903710481463, 19628.214871405125, 18318.0, 18469.35357262496, 18667.81332186678, 19056.428307150774, 19090.140943657534, 5736.45503677151, 5877.824435112973, 5976.551758618121, 5978.252718410199, 5983.012802887519, 4671.785335812696, 5917.5561832862495, 5932.991391463462, 5937.792177273796, 5941.88116237675, 5685.204071429983, 5883.735231914574, 5884.146798714184, 5888.263967004124, 5888.558358123137, 5922.082077278007, 6062.636241825505, 6069.696515174268, 6070.150178974969, 6072.817815465543, 5064.18972964324, 5283.63014588979, 5366.195070739382, 5875.529957603381, 5881.14723365114, 13766.65583360414, 13947.442102315896, 13992.16047037181, 14011.159330440207, 14164.575062748134, 2193.59418507575, 2272.784085511874, 2311.5723591135693, 2346.753590872951, 2783.151138902634, 9827.11555959967, 10341.844872326921, 10832.566697332097, 10885.129189664887, 10886.129109671207, 1828.3783513605306, 1895.1282410091374, 1908.0, 1911.4074636862617, 1925.663008973424, 80198.0, 82428.58785706093, 82656.58671706663, 83783.0, 84682.57658711667, 10448.634297799541, 10626.203034772423, 10765.946170269099, 10869.565217391373, 10931.344119352705, 15470.845291547166, 15483.22583870802, 15497.0, 15516.767248491282, 15526.378944842305, 7703.422243331773, 7864.0, 7890.605469726491, 7927.286544211049, 8234.752957411287, 7161.641917904084, 7229.710811567478, 7285.344319011315, 7401.5189012714, 7471.925280747231, 4537.6143027843, 4607.101615185074, 4665.2302370108555, 4733.928991065137, 4741.2888066789565, 1836.3939899833024, 1879.7086451600023, 1925.7881633020356, 1994.9102290396968, 2005.5287007553213, 839.9034111077304, 952.4523399045577, 973.3429934793986, 992.156666833186, 1032.194887987371, 17728.55678608045, 19004.619907602046, 19199.712004319947, 19243.80756192448, 19452.319168829024, 917.7980844214262, 945.0, 973.445136272318, 985.4087547471603, 993.4287784523783, 9865.506724663737, 10771.246012779031, 10868.782624347468, 10873.510692018877, 10938.179636527133, 431353.0, 437787.0, 445384.0, 449989.0, 451088.0, 91467.0, 91980.54009729909, 92581.5370923141, 92750.53624731833, 93602.0, 965.792354643755, 982.219135787051, 997.9471657401366, 1001.6293971230546, 1001.979960400788, 16238.512844614681, 16566.585835354213, 16893.0, 16902.40841570539, 17168.141592920554, 39648.40527392149, 40961.0, 41545.1690966173, 41774.0, 42441.0, 58276.4172358288, 58372.416275836695, 58637.70681146567, 58690.0, 60513.0, 7473.654742146466, 7654.311111999947, 7806.219378062148, 8124.8781268279845, 8507.0, 12812.231266124063, 12938.805917911428, 13360.532381366605, 13472.124311919693, 13558.118722283414, 11216.83174752363, 11353.54585816558, 11354.886451135382, 11430.942845286054, 11719.531218751154, 11272.492737826982, 11291.43542822872, 11539.596114135966, 11539.596114135966, 11754.177207595729, 10654.786904262026, 11218.66344009681, 11341.943290283825, 11449.656510304705, 11855.762884742084, 7333.1200255969625, 7648.847023059619, 7686.846263074819, 8040.477368970998, 8246.752597422086, 6408.839779005562, 9669.806603868024, 10210.285280030326, 10492.580296788348, 10939.56241750321], "value": 8878.749111541772, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1362.094207352111, 1478.4899209772625, 1505.9021163624363, 1650.8431698988593, 1799.973000404994, 7821.4133939954445, 8425.873611895826, 8607.913920860781, 8700.65197392105, 8712.30301575874, 8478.236958673719, 8654.22112009919, 8662.610182541785, 8852.247558957497, 8852.734417967471, 2263.660450932361, 2302.666113413554, 2313.144136669426, 2314.36355002374, 2320.0835669910375, 2269.5120549081944, 2306.9653955190684, 2307.261676263596, 2308.2613563659634, 2315.2591170825344, 2253.346529506441, 2268.7164104486938, 2278.305116939333, 2309.7343805462333, 2315.455867871049, 2198.2855571939185, 2206.316042026977, 2211.3034394165866, 2211.7014203082617, 2211.8341124415574, 2223.6886835842993, 2233.888305584714, 2234.4190510467397, 2234.597772400967, 2235.832312576547, 8794.208521233055, 8808.471491710518, 8866.512341821197, 8884.644614215424, 8885.644574217024, 5036.84889453317, 5191.273221748958, 5194.220866869962, 5218.425973142951, 5237.9785941741375, 3090.284304228177, 3239.5302681111107, 3287.556179915705, 3299.2411745298477, 3308.0902751743465, 1115.2490589774059, 1138.5844166879112, 2048.1909645690016, 2048.7294990169453, 2054.4247610669036, 12399.25604463735, 12424.37878106091, 12547.874521254762, 12558.120931534797, 12574.622761317176, 4385.035292235703, 4441.378207051015, 4536.319552067216, 4540.545945405433, 4679.040796636681, 10633.149348052137, 10660.626878059385, 10663.146948244123, 10666.413347265974, 10667.733306667395, 5272.499112584298, 5321.494458026481, 5327.680339179662, 5329.333833270841, 5332.9466705333225, 4258.403823464718, 4351.390805287262, 4630.0, 4739.810407583658, 4894.363732714724, 3900.258950799339, 3929.410588411704, 3991.8004099794894, 3998.100427403869, 4029.4560234367987, 1244.6888277930518, 1247.3389103775014, 1273.9808902866464, 1279.6992706713916, 1284.2037936479255, 754.7962050246402, 796.7848680856137, 823.8475881961737, 869.4218344800763, 884.827458645558, 5403.324584426947, 5691.231683722727, 5800.099950024987, 5870.031444811643, 5910.379410161957, 942.3026960049514, 967.2165545907837, 970.5777986575862, 975.4001289207087, 1002.9849552256723, 3497.3355062538035, 3648.1244501319493, 3680.852765889388, 3796.1838204786104, 3801.7718936863876, 10768.892311076946, 11024.614138505274, 11042.558297668003, 11312.03847672957, 11329.94335028336, 11002.064824489848, 11014.779704405866, 11025.173112016631, 11030.06244469229, 11041.723956901142, 8197.79505512355, 8210.220029097227, 8298.087210406851, 8386.329093672492, 8399.0, 5467.336082124763, 5514.503694667499, 5622.690752008515, 5668.121441176624, 5799.3040835100055, 10125.392476451436, 10228.386296822215, 10253.384796912209, 10311.123554497952, 10378.06597406237, 10304.83598444335, 10509.9474502627, 10613.9469302653, 10663.89336106629, 10787.244892857425, 6605.504587155887, 6717.193936727624, 6888.862222755617, 7318.560886346836, 7488.326050655467, 8208.220219079178, 8505.574721264036, 8534.871976920227, 8538.829223415622, 8543.444676096035, 7266.0, 7271.709131634887, 7305.415566754753, 7325.7802265932105, 7516.736914207976, 7419.0, 7469.178390377163, 7578.355839753683, 7673.155952845294, 7729.497582657109, 6270.529710271839, 6403.167588213502, 6404.295527492065, 6405.7117429714845, 6424.229092508929, 4836.322914791862, 4884.096442158212, 4930.728809915346, 4949.505049495022, 4977.377827771528, 4951.529604687549, 4959.9008019838675, 5070.873228169326, 5151.124308867426, 5194.714290713896], "value": 4594.474483873135, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.4227763193358, 324.4532961959099, 332.5759656438041, 336.2400973799213, 336.3793800438192, 5080.898382032357, 5210.609204309678, 5264.947350526493, 5273.314469119014, 5282.811367442328, 5087.898242035167, 5144.356955380577, 5160.4323524412375, 5186.677397263693, 5189.662671926322, 4142.606452387034, 4143.689223308249, 4147.854825081123, 4150.405996252342, 4154.459920210384, 3913.960860391388, 4083.3466645336753, 4167.395727619493, 4167.916641667165, 4168.854090106847, 4077.979610101945, 4079.653229475498, 4081.4081958116053, 4082.632563069323, 4084.611961863618, 4058.431819545266, 4059.939100913474, 4060.309747342959, 4065.2276067547073, 4069.491313585802, 3595.280943811222, 3601.657842504958, 3602.3875941089814, 3606.765560238576, 3609.350316942949, 4959.876003099916, 4994.650374473788, 5031.899362012776, 5063.670861393997, 5097.923531147036, 4672.15901137795, 4677.859664210079, 4683.578477937002, 4687.0, 4687.695299805502, 5392.838214853521, 5421.972890135564, 5438.320209973754, 5438.428964958702, 5438.628050608648, 3841.750286231386, 3866.941995870064, 3897.376419772851, 3932.1152740633415, 3963.969367964321, 5628.2702889098755, 5643.68959707216, 5649.293838270216, 5667.121596152561, 5677.261955945742, 4009.1781184857036, 4010.538788039413, 4010.6791456683395, 4016.7389119707127, 4020.396940458896, 3864.1885204107452, 4046.5548789633117, 4056.6146216109423, 4058.5738497457933, 4074.490688663917, 4652.278896771006, 4669.556392142741, 4671.299305104261, 4672.135654903854, 4672.57946784791, 5499.890002199933, 5527.50252477279, 5532.1425179097305, 5544.584156188222, 5547.195656629847, 1305.3603734170379, 1341.5639917027006, 1347.5014244729514, 1365.6654119740726, 1388.2919710947288, 872.5070335260557, 891.6032365597376, 903.7108125399809, 903.7785742493131, 906.3655441191061, 4560.475545312332, 4580.1755683976535, 4651.930221046687, 4670.622166460834, 4682.484926658133, 4898.583620392235, 4912.533309335608, 4915.557599816034, 4915.8033678652455, 4932.8520144395725, 4628.583427491542, 4652.3951886255245, 4653.767311634405, 4653.883652908705, 4664.323673067386, 2807.9329854655102, 3002.1086715369615, 3019.969800301969, 3030.1515575638855, 3030.7272345489014, 5806.738696758656, 5808.970955145197, 5817.272840894888, 5820.738066787005, 5832.475077243069, 5596.272484576979, 5738.819248685556, 5764.855878603068, 5815.73829177688, 5836.649801011953, 5767.221425107725, 5794.8551286217335, 5796.826095217066, 5801.245838041028, 5853.678047707417, 5657.886842263214, 5661.518770904519, 5664.631798933056, 5666.150077488245, 5689.630174038674, 5381.730913454233, 5631.971840140937, 5656.6888821115235, 5665.291838520185, 5666.631668941671, 5786.3056433228285, 5846.239988801429, 5853.624398266489, 5862.0, 5880.0, 3989.2819292526465, 4073.51117865858, 4074.5517993020153, 4083.632473077437, 4086.5096188457574, 5426.918596220981, 5689.2319536862, 5707.714614269187, 5708.858228354429, 5714.628549144292, 5415.323084614423, 5455.1544510600925, 5532.1701744737, 5541.667499950016, 5575.4424557543925, 5518.475744804237, 5530.474604912527, 5542.695151766691, 5549.1676248563035, 5564.443555644565, 5287.365516138088, 5445.930546392504, 5485.945140548543, 5503.944960550503, 5505.366882808528, 5557.1108622621805, 5579.302587176603, 5581.7209139543675, 5584.776608935597, 5597.944020559742, 5441.7279136043835, 5442.455754424526, 5470.8905821882545, 5474.288342515448, 5486.54606529278], "value": 4144.070585029856, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [692.5221597097999, 715.9248278930716, 748.7529115391922, 777.0908037596012, 809.2837838512916, 15408.922955385222, 17057.14714264285, 17068.573285667866, 17132.05773682447, 17205.827941720578, 15265.38938442461, 15473.922630386833, 15490.535283941472, 15496.767548486754, 15583.298751556178, 651.3584119642148, 666.3369946902839, 754.7169811320755, 772.6793380747011, 775.1937984496132, 787.346502403007, 787.9724209652663, 788.3377962511489, 793.9087004994442, 794.56696100625, 846.5936350551739, 851.1743608699552, 852.6845067325067, 852.9701460448886, 853.2576658307281, 679.1069743287561, 834.8747687846811, 839.366278459762, 839.4711331860949, 839.7690635075342, 514.4315531337893, 587.3685787778155, 599.469469519474, 602.172013481463, 606.4784285514454, 14263.215523146222, 14272.14367137975, 14286.214258215794, 14313.85686143146, 14314.64213394663, 12849.935750321189, 13341.799873001914, 13428.664283392896, 14059.367328470244, 14160.433582656682, 11749.647510574696, 11813.232139910879, 11981.221220620719, 12894.161879477804, 13143.86856131436, 4378.102488989782, 4412.360207769888, 4413.404190434315, 4456.487503937024, 4475.530069342737, 72549.63725181393, 76257.61871190609, 76932.23067769363, 78525.0, 78608.0, 10692.0, 10958.452077396258, 10974.231803773659, 11068.833967490495, 11167.664970050912, 19640.134187252188, 19676.508087297647, 19685.60628787445, 19688.803111968984, 19712.507187320145, 7977.880331795028, 8032.518048917083, 8088.393370497236, 8168.142345053802, 8248.381371397048, 4038.434619153321, 4375.737455752601, 4393.890152746143, 4423.535528769497, 4498.50516443191, 3493.336266109482, 3651.342758303531, 3654.0682126057686, 3658.7438879278193, 3660.816959152032, 588.7556663984399, 597.9133025711335, 600.7897235967376, 603.7856560920898, 606.4178388746765, 639.6034458635676, 651.5927545284197, 684.6542496039468, 684.7466437418187, 688.7520492622651, 9477.857832132524, 9693.51532423376, 9810.215182785503, 10051.497425128715, 10210.0, 639.7792761497276, 699.9860002800017, 708.5111273221461, 709.1561042359575, 719.4208662027119, 4272.743635381887, 4557.977210113928, 4599.839005634787, 4621.075784843045, 4693.7653117344, 95174.52412737891, 96999.75006248438, 99045.0, 116168.0, 131912.0, 97112.0, 98734.0, 101010.49494752625, 102475.0, 104186.0, 53294.0, 55080.17379739307, 77586.61206693818, 83330.58334708409, 84653.0, 9586.904130958601, 9671.854922176313, 9675.516224188903, 9798.265130115413, 10151.796964060824, 34790.65209347874, 36696.63303367039, 47682.761586191846, 53087.73456132694, 53640.463595363544, 73063.63468182625, 73083.0, 73675.0, 75876.62061689656, 75987.24012759802, 12303.0, 12933.935330323287, 12973.54592589255, 13036.934815326242, 13140.34298285101, 14447.422103115758, 14552.41790328375, 15262.160581168142, 15534.378624854879, 16027.679446410773, 12905.935470322589, 13762.0, 13888.861111388756, 14037.0, 14684.706305874037, 12874.420651070537, 13100.0, 13499.595012149652, 13981.44074237019, 14247.928760356132, 13547.0, 13848.861511384757, 13910.778183125085, 13986.370613322222, 14367.425302987764, 11433.771324573296, 11541.884581154416, 11624.184091709158, 11627.476763545492, 12173.45219465144, 11411.055766484682, 11977.880221197676, 12274.631761047183, 12338.753224935272, 12394.75210495803], "value": 7430.854587768213, "unit": "score"}], "name": "dromaeo_css", "value": 7023.108222242305, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 111.0, 110.0, 111.0, 111.0, 111.0, 112.0, 111.0, 111.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 124.0, 132.0, 163.0, 126.0, 132.0, 123.0, 130.0, 161.0, 124.0], "value": 136.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 162.0, 161.0, 164.0, 164.0, 161.0, 160.0, 163.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 118.0, 79.0, 77.0, 76.0, 76.0, 109.0, 76.0], "value": 83.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 120.0, 83.0, 84.0, 84.0, 101.0, 82.0, 83.0, 107.0], "value": 91.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 51.0, 51.0, 52.0, 52.0, 52.0, 53.0, 63.0, 52.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 61.0, 62.0, 61.0, 62.0, 61.0, 61.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 85.0, 78.0, 79.0, 79.0, 85.0, 79.0, 85.0, 80.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 129.0, 128.0, 126.0, 125.0, 127.0, 127.0, 133.0, 161.0, 130.0], "value": 132.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 164.0, 171.0, 162.0, 167.0, 167.0, 162.0, 169.0, 163.0], "value": 165.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 65.0, 65.0, 67.0, 64.0, 65.0, 63.0, 64.0], "value": 65.1, "unit": "score"}], "name": "kraken", "value": 1500.1999999999998, "alertThreshold": 2.0}]} 20:39:35 INFO - Return code: 0 20:39:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:39:35 INFO - # TBPL SUCCESS # 20:39:35 INFO - Running post-action listener: _resource_record_post_action 20:39:35 INFO - [mozharness: 2016-10-04 03:39:35.203020Z] Finished run-tests step (success) 20:39:35 INFO - Running post-run listener: _resource_record_post_run 20:39:35 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 8192; Write bytes: 404111360; Read time: 28; Write time: 308880 20:39:35 INFO - TinderboxPrint: CPU usage
13.0% 20:39:35 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 28 20:39:35 INFO - TinderboxPrint: I/O write bytes / time
404,111,360 / 308,880 20:39:35 INFO - TinderboxPrint: CPU idle
8,307.4 (87.0%) 20:39:35 INFO - TinderboxPrint: CPU user
1,191.6 (12.5%) 20:39:35 INFO - TinderboxPrint: Swap in / out
0 / 0 20:39:35 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 115281920; Read time: 0; Write time: 100824 20:39:35 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288354304; Read time: 16; Write time: 207904 20:39:35 INFO - Running post-run listener: _upload_blobber_files 20:39:35 INFO - Blob upload gear active. 20:39:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:39:35 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 20:39:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:39:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:39:36 INFO - (blobuploader) - INFO - Open directory for files ... 20:39:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:39:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:39:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:39:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:39:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:39:36 INFO - (blobuploader) - INFO - Done attempting. 20:39:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:39:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:39:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:39:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:39:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:39:37 INFO - (blobuploader) - INFO - Done attempting. 20:39:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:39:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:39:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:39:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:39:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:39:41 INFO - (blobuploader) - INFO - Done attempting. 20:39:41 INFO - (blobuploader) - INFO - Iteration through files over. 20:39:41 INFO - Return code: 0 20:39:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:39:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:39:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9b2415d9111b687300aceeac5ea2cc058158d92e00a30a58654813219d3f9191967294e36982148babceda68a330837beb81e8fdbf4a1c3c504fc81c822581fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0d9b02adafa16f7b966aaa4d81b1f936fcaa778e15b125652ac68f2c3fc8f5b66679de41d9ce04e5a9d90ecc8e91bbd1f32632e5f56374bc0b5f7f14053a6271", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/30b22f1ef49b339707708af71edeefb5a81b898e2ab71f905b46e6d72009af5425c6f2c358daceccb36edf85ae4928d2163a3e4e89dadd3099e0938f74340c83"} 20:39:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:39:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:39:41 INFO - Contents: 20:39:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9b2415d9111b687300aceeac5ea2cc058158d92e00a30a58654813219d3f9191967294e36982148babceda68a330837beb81e8fdbf4a1c3c504fc81c822581fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0d9b02adafa16f7b966aaa4d81b1f936fcaa778e15b125652ac68f2c3fc8f5b66679de41d9ce04e5a9d90ecc8e91bbd1f32632e5f56374bc0b5f7f14053a6271", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/30b22f1ef49b339707708af71edeefb5a81b898e2ab71f905b46e6d72009af5425c6f2c358daceccb36edf85ae4928d2163a3e4e89dadd3099e0938f74340c83"} 20:39:41 INFO - Running post-run listener: copy_logs_to_upload_dir 20:39:41 INFO - Copying logs to upload dir... 20:39:41 INFO - mkdir: /builds/slave/test/build/upload/logs 20:39:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.812997 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-03 20:39:41.550839) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 20:39:41.554622) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1475550764.148701-887786732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9b2415d9111b687300aceeac5ea2cc058158d92e00a30a58654813219d3f9191967294e36982148babceda68a330837beb81e8fdbf4a1c3c504fc81c822581fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0d9b02adafa16f7b966aaa4d81b1f936fcaa778e15b125652ac68f2c3fc8f5b66679de41d9ce04e5a9d90ecc8e91bbd1f32632e5f56374bc0b5f7f14053a6271", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/30b22f1ef49b339707708af71edeefb5a81b898e2ab71f905b46e6d72009af5425c6f2c358daceccb36edf85ae4928d2163a3e4e89dadd3099e0938f74340c83"} build_url:https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011320 build_url: 'https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9b2415d9111b687300aceeac5ea2cc058158d92e00a30a58654813219d3f9191967294e36982148babceda68a330837beb81e8fdbf4a1c3c504fc81c822581fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0d9b02adafa16f7b966aaa4d81b1f936fcaa778e15b125652ac68f2c3fc8f5b66679de41d9ce04e5a9d90ecc8e91bbd1f32632e5f56374bc0b5f7f14053a6271", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/30b22f1ef49b339707708af71edeefb5a81b898e2ab71f905b46e6d72009af5425c6f2c358daceccb36edf85ae4928d2163a3e4e89dadd3099e0938f74340c83"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 20:39:41.585230) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 20:39:41.585582) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1475550764.148701-887786732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004558 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 20:39:41.668095) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 20:39:41.668445) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 20:39:41.668771) ========= ========= Total master_lag: 0.39 =========