builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-045 starttime: 1467289259.92 results: success (0) buildid: 20160630045127 builduid: 150ab89b60ae4c669abd09f5b250b7f5 revision: 5f550071f889ff522db03e1e8e86e4cea11b4962 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 05:20:59.917226) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 05:20:59.917917) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 05:20:59.918392) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 05:20:59.955046) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:20:59.955523) ========= 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=4300f881736b422476174874000001bc-1467288796.216613-75457196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-30 05:20:59-- 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% 225M=0s 2016-06-30 05:21:00 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.352424 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:21:00.325524) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:21:00.325866) ========= 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=4300f881736b422476174874000001bc-1467288796.216613-75457196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021886 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:21:00.376073) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-30 05:21:00.376446) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5f550071f889ff522db03e1e8e86e4cea11b4962 --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 5f550071f889ff522db03e1e8e86e4cea11b4962 --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=4300f881736b422476174874000001bc-1467288796.216613-75457196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-30 05:21:00,447 truncating revision to first 12 chars 2016-06-30 05:21:00,447 Setting DEBUG logging. 2016-06-30 05:21:00,447 attempt 1/10 2016-06-30 05:21:00,447 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5f550071f889?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-30 05:21:01,634 unpacking tar archive at: fx-team-5f550071f889/testing/mozharness/ program finished with exit code 0 elapsedTime=1.521065 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-30 05:21:01.912797) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 05:21:01.913141) ========= script_repo_revision: 5f550071f889ff522db03e1e8e86e4cea11b4962 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 05:21:01.913563) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 05:21:01.913836) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 05:21:01.924029) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-06-30 05:21:01.924598) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4300f881736b422476174874000001bc-1467288796.216613-75457196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:21:02 INFO - MultiFileLogger online at 20160630 05:21:02 in /builds/slave/test 05:21:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:21:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:21:02 INFO - {'append_to_log': False, 05:21:02 INFO - 'base_work_dir': '/builds/slave/test', 05:21:02 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:21:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:21:02 INFO - 'branch': 'Fx-Team-Non-PGO', 05:21:02 INFO - 'buildbot_json_path': 'buildprops.json', 05:21:02 INFO - 'config_files': ('talos/linux_config.py',), 05:21:02 INFO - 'default_actions': ('clobber', 05:21:02 INFO - 'read-buildbot-config', 05:21:02 INFO - 'download-and-extract', 05:21:02 INFO - 'populate-webroot', 05:21:02 INFO - 'create-virtualenv', 05:21:02 INFO - 'install', 05:21:02 INFO - 'run-tests'), 05:21:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:21:02 INFO - 'download_minidump_stackwalk': True, 05:21:02 INFO - 'download_symbols': 'ondemand', 05:21:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:21:02 INFO - 'tooltool.py': '/tools/tooltool.py', 05:21:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:21:02 INFO - '/tools/misc-python/virtualenv.py')}, 05:21:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:21:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:21:02 INFO - 'installer_path': 'installer.exe', 05:21:02 INFO - 'log_level': 'info', 05:21:02 INFO - 'log_name': 'talos', 05:21:02 INFO - 'log_to_console': True, 05:21:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:21:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:21:02 INFO - 'opt_config_files': (), 05:21:02 INFO - 'pip_index': False, 05:21:02 INFO - 'sps_profile': False, 05:21:02 INFO - 'sps_profile_interval': 0, 05:21:02 INFO - 'suite': 'dromaeojs', 05:21:02 INFO - 'system_bits': '32', 05:21:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:21:02 INFO - 'title': 'talos-linux64-ix-045', 05:21:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:21:02 INFO - 'use_talos_json': True, 05:21:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:21:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:21:02 INFO - 'work_dir': 'build'} 05:21:02 INFO - ##### 05:21:02 INFO - ##### Running clobber step. 05:21:02 INFO - ##### 05:21:02 INFO - Running pre-action listener: _resource_record_pre_action 05:21:02 INFO - Running main action method: clobber 05:21:02 INFO - rmtree: /builds/slave/test/build 05:21:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:21:02 INFO - Running post-action listener: _resource_record_post_action 05:21:02 INFO - ##### 05:21:02 INFO - ##### Finished clobber step (success) 05:21:02 INFO - ##### 05:21:02 INFO - ##### 05:21:02 INFO - ##### Running read-buildbot-config step. 05:21:02 INFO - ##### 05:21:02 INFO - Running pre-action listener: _resource_record_pre_action 05:21:02 INFO - Running main action method: read_buildbot_config 05:21:02 INFO - Using buildbot properties: 05:21:02 INFO - { 05:21:02 INFO - "project": "", 05:21:02 INFO - "product": "firefox", 05:21:02 INFO - "script_repo_revision": "production", 05:21:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:21:02 INFO - "repository": "", 05:21:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:21:02 INFO - "buildid": "20160630045127", 05:21:02 INFO - "pgo_build": "False", 05:21:02 INFO - "basedir": "/builds/slave/test", 05:21:02 INFO - "buildnumber": 1785, 05:21:02 INFO - "slavename": "talos-linux64-ix-045", 05:21:02 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:21:02 INFO - "platform": "ubuntu64_hw", 05:21:02 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:21:02 INFO - "branch": "fx-team", 05:21:02 INFO - "repo_path": "integration/fx-team", 05:21:02 INFO - "revision": "5f550071f889ff522db03e1e8e86e4cea11b4962", 05:21:02 INFO - "stage_platform": "linux64", 05:21:02 INFO - "builduid": "150ab89b60ae4c669abd09f5b250b7f5", 05:21:02 INFO - "slavebuilddir": "test" 05:21:02 INFO - } 05:21:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:21:02 INFO - Running post-action listener: _resource_record_post_action 05:21:02 INFO - ##### 05:21:02 INFO - ##### Finished read-buildbot-config step (success) 05:21:02 INFO - ##### 05:21:02 INFO - ##### 05:21:02 INFO - ##### Running download-and-extract step. 05:21:02 INFO - ##### 05:21:02 INFO - Running pre-action listener: _resource_record_pre_action 05:21:02 INFO - Running main action method: download_and_extract 05:21:02 INFO - mkdir: /builds/slave/test/build/tests 05:21:02 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:02 INFO - https://queue.taskcluster.net/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:21:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:21:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:21:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:21:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:21:09 INFO - Downloaded 1361 bytes. 05:21:09 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:21:09 INFO - Using the following test package requirements: 05:21:09 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:21:09 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:21:09 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:21:09 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:09 INFO - u'jsshell-linux-x86_64.zip'], 05:21:09 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:21:09 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:21:09 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:21:09 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:21:09 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:21:09 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:21:09 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:21:09 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:09 INFO - https://queue.taskcluster.net/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:21:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:21:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:21:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:21:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:21:27 INFO - Downloaded 22701713 bytes. 05:21:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:21:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:21:28 INFO - Return code: 0 05:21:28 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:21:28 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:28 INFO - https://queue.taskcluster.net/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:21:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:21:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:21:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:21:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:21:29 INFO - Downloaded 22701713 bytes. 05:21:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:21:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:21:31 INFO - Return code: 0 05:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:31 INFO - https://queue.taskcluster.net/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:21:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:21:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:21:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:21:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:21:32 INFO - Downloaded 14405242 bytes. 05:21:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:21:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:21:32 INFO - Return code: 0 05:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:32 INFO - https://queue.taskcluster.net/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:21:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:21:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:21:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:21:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:21:33 INFO - Downloaded 56450949 bytes. 05:21:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:21:33 INFO - mkdir: /builds/slave/test/properties 05:21:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:21:33 INFO - Writing to file /builds/slave/test/properties/build_url 05:21:33 INFO - Contents: 05:21:33 INFO - build_url:https://queue.taskcluster.net/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:21:34 INFO - Running post-action listener: _resource_record_post_action 05:21:34 INFO - Running post-action listener: set_extra_try_arguments 05:21:34 INFO - ##### 05:21:34 INFO - ##### Finished download-and-extract step (success) 05:21:34 INFO - ##### 05:21:34 INFO - ##### 05:21:34 INFO - ##### Running populate-webroot step. 05:21:34 INFO - ##### 05:21:34 INFO - Running pre-action listener: _resource_record_pre_action 05:21:34 INFO - Running main action method: populate_webroot 05:21:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:21:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:21:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:21:34 INFO - '--tppagecycles', 05:21:34 INFO - '7'], 05:21:34 INFO - 'tests': ['tsvgm']}}, 05:21:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:21:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:21:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:21:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:21:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:21:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:21:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:34 INFO - 'talos_options': ['--disable-e10s'], 05:21:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:21:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:21:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:34 INFO - 'talos_options': ['--disable-e10s'], 05:21:34 INFO - 'tests': ['damp', 'tps']}, 05:21:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:34 INFO - 'tests': ['damp', 'tps']}, 05:21:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:21:34 INFO - 'tests': ['dromaeo_dom']}, 05:21:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:21:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:21:34 INFO - 'tests': ['basic_compositor_video']}, 05:21:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:21:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:21:34 INFO - 'tests': ['a11yr', 05:21:34 INFO - 'ts_paint', 05:21:34 INFO - 'tpaint', 05:21:34 INFO - 'sessionrestore', 05:21:34 INFO - 'sessionrestore_no_auto_restore', 05:21:34 INFO - 'tabpaint']}, 05:21:34 INFO - 'other-e10s': {'tests': ['a11yr', 05:21:34 INFO - 'ts_paint', 05:21:34 INFO - 'tpaint', 05:21:34 INFO - 'sessionrestore', 05:21:34 INFO - 'sessionrestore_no_auto_restore', 05:21:34 INFO - 'tabpaint']}, 05:21:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:21:34 INFO - 'ts_paint', 05:21:34 INFO - 'tpaint', 05:21:34 INFO - 'sessionrestore', 05:21:34 INFO - 'sessionrestore_no_auto_restore', 05:21:34 INFO - 'tabpaint']}, 05:21:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:21:34 INFO - 'ts_paint', 05:21:34 INFO - 'tpaint', 05:21:34 INFO - 'sessionrestore', 05:21:34 INFO - 'sessionrestore_no_auto_restore', 05:21:34 INFO - 'tabpaint']}, 05:21:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:21:34 INFO - 'tests': ['a11yr', 05:21:34 INFO - 'ts_paint', 05:21:34 INFO - 'tpaint', 05:21:34 INFO - 'sessionrestore', 05:21:34 INFO - 'sessionrestore_no_auto_restore', 05:21:34 INFO - 'tabpaint']}, 05:21:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:21:34 INFO - 'tests': ['a11yr', 05:21:34 INFO - 'ts_paint', 05:21:34 INFO - 'tpaint', 05:21:34 INFO - 'sessionrestore', 05:21:34 INFO - 'sessionrestore_no_auto_restore', 05:21:34 INFO - 'tabpaint']}, 05:21:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:21:34 INFO - 'tests': ['tsvgx', 05:21:34 INFO - 'tsvgr_opacity', 05:21:34 INFO - 'tart', 05:21:34 INFO - 'tscrollx', 05:21:34 INFO - 'cart']}, 05:21:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:21:34 INFO - 'tsvgr_opacity', 05:21:34 INFO - 'tart', 05:21:34 INFO - 'tscrollx', 05:21:34 INFO - 'cart']}, 05:21:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:34 INFO - 'talos_options': ['--disable-e10s'], 05:21:34 INFO - 'tests': ['tp5o']}, 05:21:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:34 INFO - 'tests': ['tp5o']}, 05:21:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:34 INFO - 'talos_options': ['--disable-e10s', 05:21:34 INFO - '--xperf_path', 05:21:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:21:34 INFO - 'tests': ['tp5n']}, 05:21:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:34 INFO - 'talos_options': ['--xperf_path', 05:21:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:21:34 INFO - 'tests': ['tp5n']}}, 05:21:34 INFO - 'talos.zip': {'path': '', 05:21:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:21:34 INFO - Running post-action listener: _resource_record_post_action 05:21:34 INFO - ##### 05:21:34 INFO - ##### Finished populate-webroot step (success) 05:21:34 INFO - ##### 05:21:34 INFO - ##### 05:21:34 INFO - ##### Running create-virtualenv step. 05:21:34 INFO - ##### 05:21:34 INFO - Running pre-action listener: _resource_record_pre_action 05:21:34 INFO - Running main action method: create_virtualenv 05:21:34 INFO - Creating virtualenv /builds/slave/test/build/venv 05:21:34 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 05:21:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:21:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:21:34 INFO - Using real prefix '/usr' 05:21:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:21:35 INFO - Installing distribute.............................................................................................................................................................................................done. 05:21:37 INFO - Installing pip.................done. 05:21:37 INFO - Return code: 0 05:21:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:21: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2489030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27483b0>, '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 0x27492b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2749740>, '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': '4300f881736b422476174874000001bc-1467288796.216613-75457196', '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 05:21: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', 'pip>=1.5'] in /builds/slave/test/build 05:21: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 pip>=1.5 05:21:37 INFO - Using env: {'DISPLAY': ':0', 05:21:37 INFO - 'HOME': '/home/cltbld', 05:21:37 INFO - 'LANG': 'en_US.UTF-8', 05:21:37 INFO - 'LANGUAGE': 'en_US:en', 05:21:37 INFO - 'LOGNAME': 'cltbld', 05:21:37 INFO - 'MAIL': '/var/mail/cltbld', 05:21:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:37 INFO - 'MOZ_NO_REMOTE': '1', 05:21:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:37 INFO - 'NO_EM_RESTART': '1', 05:21:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:37 INFO - 'PWD': '/builds/slave/test', 05:21:37 INFO - 'SHELL': '/bin/bash', 05:21:37 INFO - 'SHLVL': '1', 05:21:37 INFO - 'TERM': 'linux', 05:21:37 INFO - 'TMOUT': '86400', 05:21:37 INFO - 'USER': 'cltbld', 05:21:37 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467288796.216613-75457196', 05:21:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:37 INFO - '_': '/tools/buildbot/bin/python'} 05:21:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:37 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 05:21:37 INFO - Cleaning up... 05:21:37 INFO - Return code: 0 05:21:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:21: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21: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', '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 0x2489030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27483b0>, '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 0x27492b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2749740>, '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': '4300f881736b422476174874000001bc-1467288796.216613-75457196', '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 05:21: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', 'psutil>=3.1.1'] in /builds/slave/test/build 05:21: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 psutil>=3.1.1 05:21:37 INFO - Using env: {'DISPLAY': ':0', 05:21:37 INFO - 'HOME': '/home/cltbld', 05:21:37 INFO - 'LANG': 'en_US.UTF-8', 05:21:37 INFO - 'LANGUAGE': 'en_US:en', 05:21:37 INFO - 'LOGNAME': 'cltbld', 05:21:37 INFO - 'MAIL': '/var/mail/cltbld', 05:21:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:37 INFO - 'MOZ_NO_REMOTE': '1', 05:21:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:37 INFO - 'NO_EM_RESTART': '1', 05:21:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:37 INFO - 'PWD': '/builds/slave/test', 05:21:37 INFO - 'SHELL': '/bin/bash', 05:21:37 INFO - 'SHLVL': '1', 05:21:37 INFO - 'TERM': 'linux', 05:21:37 INFO - 'TMOUT': '86400', 05:21:37 INFO - 'USER': 'cltbld', 05:21:37 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467288796.216613-75457196', 05:21:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:37 INFO - '_': '/tools/buildbot/bin/python'} 05:21:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:37 INFO - Downloading/unpacking psutil>=3.1.1 05:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:21:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:21:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:21:39 INFO - Installing collected packages: psutil 05:21:39 INFO - Running setup.py install for psutil 05:21:39 INFO - building 'psutil._psutil_linux' extension 05:21:39 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 05:21:39 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 05:21:39 INFO - building 'psutil._psutil_posix' extension 05:21:39 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 05:21:39 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 05:21:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:21:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:21:40 INFO - Successfully installed psutil 05:21:40 INFO - Cleaning up... 05:21:40 INFO - Return code: 0 05:21:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:21:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2489030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27483b0>, '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 0x27492b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2749740>, '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': '4300f881736b422476174874000001bc-1467288796.216613-75457196', '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 05:21:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:21:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:21:40 INFO - Using env: {'DISPLAY': ':0', 05:21:40 INFO - 'HOME': '/home/cltbld', 05:21:40 INFO - 'LANG': 'en_US.UTF-8', 05:21:40 INFO - 'LANGUAGE': 'en_US:en', 05:21:40 INFO - 'LOGNAME': 'cltbld', 05:21:40 INFO - 'MAIL': '/var/mail/cltbld', 05:21:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:40 INFO - 'MOZ_NO_REMOTE': '1', 05:21:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:40 INFO - 'NO_EM_RESTART': '1', 05:21:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:40 INFO - 'PWD': '/builds/slave/test', 05:21:40 INFO - 'SHELL': '/bin/bash', 05:21:40 INFO - 'SHLVL': '1', 05:21:40 INFO - 'TERM': 'linux', 05:21:40 INFO - 'TMOUT': '86400', 05:21:40 INFO - 'USER': 'cltbld', 05:21:40 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467288796.216613-75457196', 05:21:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:40 INFO - '_': '/tools/buildbot/bin/python'} 05:21:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:21:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:21:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:21:42 INFO - Installing collected packages: mozsystemmonitor 05:21:42 INFO - Running setup.py install for mozsystemmonitor 05:21:42 INFO - Successfully installed mozsystemmonitor 05:21:42 INFO - Cleaning up... 05:21:42 INFO - Return code: 0 05:21:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:21:42 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:42 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:42 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 0x2489030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27483b0>, '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 0x27492b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2749740>, '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': '4300f881736b422476174874000001bc-1467288796.216613-75457196', '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 05:21:42 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 05:21:42 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 05:21:42 INFO - Using env: {'DISPLAY': ':0', 05:21:42 INFO - 'HOME': '/home/cltbld', 05:21:42 INFO - 'LANG': 'en_US.UTF-8', 05:21:42 INFO - 'LANGUAGE': 'en_US:en', 05:21:42 INFO - 'LOGNAME': 'cltbld', 05:21:42 INFO - 'MAIL': '/var/mail/cltbld', 05:21:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:42 INFO - 'MOZ_NO_REMOTE': '1', 05:21:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:42 INFO - 'NO_EM_RESTART': '1', 05:21:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:42 INFO - 'PWD': '/builds/slave/test', 05:21:42 INFO - 'SHELL': '/bin/bash', 05:21:42 INFO - 'SHLVL': '1', 05:21:42 INFO - 'TERM': 'linux', 05:21:42 INFO - 'TMOUT': '86400', 05:21:42 INFO - 'USER': 'cltbld', 05:21:42 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467288796.216613-75457196', 05:21:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:42 INFO - '_': '/tools/buildbot/bin/python'} 05:21:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:42 INFO - Downloading/unpacking jsonschema==2.5.1 05:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:21:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:21:44 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 05:21:44 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 05:21:44 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 05:21:44 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 05:21:44 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 05:21:44 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 05:21:44 INFO - Downloading functools32-3.2.3-2.tar.gz 05:21:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:21:44 INFO - warning: no files found matching '*.txt' 05:21:44 INFO - no previously-included directories found matching 'build' 05:21:44 INFO - no previously-included directories found matching 'dist' 05:21:44 INFO - no previously-included directories found matching '.git*' 05:21:44 INFO - Installing collected packages: jsonschema, functools32 05:21:44 INFO - Running setup.py install for functools32 05:21:44 INFO - warning: no files found matching '*.txt' 05:21:44 INFO - no previously-included directories found matching 'build' 05:21:44 INFO - no previously-included directories found matching 'dist' 05:21:44 INFO - no previously-included directories found matching '.git*' 05:21:44 INFO - Successfully installed jsonschema functools32 05:21:44 INFO - Cleaning up... 05:21:45 INFO - Return code: 0 05:21:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:21:45 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:45 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:45 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 0x2489030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27483b0>, '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 0x27492b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2749740>, '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': '4300f881736b422476174874000001bc-1467288796.216613-75457196', '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 05:21:45 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 05:21:45 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 05:21:45 INFO - Using env: {'DISPLAY': ':0', 05:21:45 INFO - 'HOME': '/home/cltbld', 05:21:45 INFO - 'LANG': 'en_US.UTF-8', 05:21:45 INFO - 'LANGUAGE': 'en_US:en', 05:21:45 INFO - 'LOGNAME': 'cltbld', 05:21:45 INFO - 'MAIL': '/var/mail/cltbld', 05:21:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:45 INFO - 'MOZ_NO_REMOTE': '1', 05:21:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:45 INFO - 'NO_EM_RESTART': '1', 05:21:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:45 INFO - 'PWD': '/builds/slave/test', 05:21:45 INFO - 'SHELL': '/bin/bash', 05:21:45 INFO - 'SHLVL': '1', 05:21:45 INFO - 'TERM': 'linux', 05:21:45 INFO - 'TMOUT': '86400', 05:21:45 INFO - 'USER': 'cltbld', 05:21:45 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467288796.216613-75457196', 05:21:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:45 INFO - '_': '/tools/buildbot/bin/python'} 05:21:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:45 INFO - Downloading/unpacking blobuploader==1.2.4 05:21:45 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 05:21:45 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 05:21:45 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 05:21:45 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 05:21:45 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 05:21:45 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 05:21:47 INFO - Downloading blobuploader-1.2.4.tar.gz 05:21:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:21:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:21:47 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 05:21:47 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 05:21:47 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 05:21:47 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 05:21:47 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 05:21:47 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 05:21:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:21:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:21:47 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 05:21:47 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 05:21:47 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 05:21:47 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 05:21:47 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 05:21:47 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 05:21:47 INFO - Downloading docopt-0.6.1.tar.gz 05:21:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:21:47 INFO - Installing collected packages: blobuploader, requests, docopt 05:21:47 INFO - Running setup.py install for blobuploader 05:21:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:21:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:21:47 INFO - Running setup.py install for requests 05:21:48 INFO - Running setup.py install for docopt 05:21:48 INFO - Successfully installed blobuploader requests docopt 05:21:48 INFO - Cleaning up... 05:21:48 INFO - Return code: 0 05:21:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:21:48 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:48 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:48 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 0x2489030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27483b0>, '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 0x27492b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2749740>, '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': '4300f881736b422476174874000001bc-1467288796.216613-75457196', '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 05:21:48 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 05:21:48 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 05:21:48 INFO - Using env: {'DISPLAY': ':0', 05:21:48 INFO - 'HOME': '/home/cltbld', 05:21:48 INFO - 'LANG': 'en_US.UTF-8', 05:21:48 INFO - 'LANGUAGE': 'en_US:en', 05:21:48 INFO - 'LOGNAME': 'cltbld', 05:21:48 INFO - 'MAIL': '/var/mail/cltbld', 05:21:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:48 INFO - 'MOZ_NO_REMOTE': '1', 05:21:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:48 INFO - 'NO_EM_RESTART': '1', 05:21:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:48 INFO - 'PWD': '/builds/slave/test', 05:21:48 INFO - 'SHELL': '/bin/bash', 05:21:48 INFO - 'SHLVL': '1', 05:21:48 INFO - 'TERM': 'linux', 05:21:48 INFO - 'TMOUT': '86400', 05:21:48 INFO - 'USER': 'cltbld', 05:21:48 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467288796.216613-75457196', 05:21:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:48 INFO - '_': '/tools/buildbot/bin/python'} 05:21:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:21:48 INFO - Running setup.py (path:/tmp/pip-eeZf7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:21:48 INFO - Running setup.py (path:/tmp/pip-gOoUHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:21:48 INFO - Running setup.py (path:/tmp/pip-9IvrEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:21:48 INFO - Running setup.py (path:/tmp/pip-m6eq4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:21:48 INFO - Running setup.py (path:/tmp/pip-tnjUyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:21:49 INFO - Running setup.py (path:/tmp/pip-y2TTwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:21:49 INFO - Running setup.py (path:/tmp/pip-oBnRnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:21:49 INFO - Running setup.py (path:/tmp/pip-XNqoJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:21:49 INFO - Running setup.py (path:/tmp/pip-SM72G9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:21:49 INFO - Running setup.py (path:/tmp/pip-EwKiHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:21:49 INFO - Running setup.py (path:/tmp/pip-Nop_Hy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:21:49 INFO - Running setup.py (path:/tmp/pip-U2viZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:21:49 INFO - Running setup.py (path:/tmp/pip-Y_LHnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:21:49 INFO - Running setup.py (path:/tmp/pip-2BJdPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:49 INFO - Running setup.py (path:/tmp/pip-8TWgkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:21:49 INFO - Running setup.py (path:/tmp/pip-qr4RUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:21:49 INFO - Running setup.py (path:/tmp/pip-7Qacbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:21:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:21:49 INFO - Running setup.py install for manifestparser 05:21:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:21:50 INFO - Running setup.py install for mozcrash 05:21:50 INFO - Running setup.py install for mozdebug 05:21:50 INFO - Running setup.py install for mozdevice 05:21:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:21:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:21:50 INFO - Running setup.py install for mozfile 05:21:50 INFO - Running setup.py install for mozhttpd 05:21:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:21:50 INFO - Running setup.py install for mozinfo 05:21:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:21:50 INFO - Running setup.py install for mozInstall 05:21:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:21:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:21:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:21:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:21:50 INFO - Running setup.py install for mozleak 05:21:50 INFO - Running setup.py install for mozlog 05:21:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:21:50 INFO - Running setup.py install for moznetwork 05:21:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:21:51 INFO - Running setup.py install for mozprocess 05:21:51 INFO - Running setup.py install for mozprofile 05:21:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:21:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:21:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:21:51 INFO - Running setup.py install for mozrunner 05:21:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:21:51 INFO - Running setup.py install for mozscreenshot 05:21:51 INFO - Running setup.py install for moztest 05:21:51 INFO - Running setup.py install for mozversion 05:21:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:21:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:21:51 INFO - Cleaning up... 05:21:51 INFO - Return code: 0 05:21:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:21:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:51 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 0x2489030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27483b0>, '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 0x27492b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2749740>, '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': '4300f881736b422476174874000001bc-1467288796.216613-75457196', '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 05:21:51 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 05:21:51 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 05:21:51 INFO - Using env: {'DISPLAY': ':0', 05:21:51 INFO - 'HOME': '/home/cltbld', 05:21:51 INFO - 'LANG': 'en_US.UTF-8', 05:21:51 INFO - 'LANGUAGE': 'en_US:en', 05:21:51 INFO - 'LOGNAME': 'cltbld', 05:21:51 INFO - 'MAIL': '/var/mail/cltbld', 05:21:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:51 INFO - 'MOZ_NO_REMOTE': '1', 05:21:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:51 INFO - 'NO_EM_RESTART': '1', 05:21:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:51 INFO - 'PWD': '/builds/slave/test', 05:21:51 INFO - 'SHELL': '/bin/bash', 05:21:51 INFO - 'SHLVL': '1', 05:21:51 INFO - 'TERM': 'linux', 05:21:51 INFO - 'TMOUT': '86400', 05:21:51 INFO - 'USER': 'cltbld', 05:21:51 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467288796.216613-75457196', 05:21:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:51 INFO - '_': '/tools/buildbot/bin/python'} 05:21:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:21:51 INFO - Running setup.py (path:/tmp/pip-5aflcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:21:52 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)) 05:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:21:52 INFO - Running setup.py (path:/tmp/pip-P2_VtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:21:52 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)) 05:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:21:52 INFO - Running setup.py (path:/tmp/pip-kw5jOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:21:52 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)) 05:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:21:52 INFO - Running setup.py (path:/tmp/pip-mvBr_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:21:52 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)) 05:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:21:52 INFO - Running setup.py (path:/tmp/pip-DRLec_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:21:52 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)) 05:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:21:52 INFO - Running setup.py (path:/tmp/pip-c5odj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:21:52 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)) 05:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:21:52 INFO - Running setup.py (path:/tmp/pip-nG3WW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:21:52 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)) 05:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:21:52 INFO - Running setup.py (path:/tmp/pip-i7O255-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:21:52 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)) 05:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:21:52 INFO - Running setup.py (path:/tmp/pip-vqkrCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:21:52 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)) 05:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:21:52 INFO - Running setup.py (path:/tmp/pip-rxtoG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:21:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 05:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:21:52 INFO - Running setup.py (path:/tmp/pip-sAWnLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:21:52 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)) 05:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:21:52 INFO - Running setup.py (path:/tmp/pip-6Ys_Mx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:21:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 05:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:21:52 INFO - Running setup.py (path:/tmp/pip-wriTS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:21:52 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)) 05:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:21:52 INFO - Running setup.py (path:/tmp/pip-cK0VJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:21:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 05:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:52 INFO - Running setup.py (path:/tmp/pip-Q__0v2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:53 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)) 05:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:21:53 INFO - Running setup.py (path:/tmp/pip-EfXCZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:21:53 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)) 05:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:21:53 INFO - Running setup.py (path:/tmp/pip-m8u_Ep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:21:53 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)) 05:21:53 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)) 05:21:53 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)) 05:21:53 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)) 05:21:53 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)) 05:21:53 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)) 05:21:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:21:53 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 05:21:53 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 05:21:53 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 05:21:53 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 05:21:53 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 05:21:53 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 05:21:55 INFO - Downloading blessings-1.6.tar.gz 05:21:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:21:55 INFO - Installing collected packages: blessings 05:21:55 INFO - Running setup.py install for blessings 05:21:55 INFO - Successfully installed blessings 05:21:55 INFO - Cleaning up... 05:21:55 INFO - Return code: 0 05:21:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:21:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:21:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:21:55 INFO - Reading from file tmpfile_stdout 05:21:55 INFO - Current package versions: 05:21:55 INFO - argparse == 1.2.1 05:21:55 INFO - blessings == 1.6 05:21:55 INFO - blobuploader == 1.2.4 05:21:55 INFO - docopt == 0.6.1 05:21:55 INFO - functools32 == 3.2.3-2 05:21:55 INFO - jsonschema == 2.5.1 05:21:55 INFO - manifestparser == 1.1 05:21:55 INFO - mozInstall == 1.12 05:21:55 INFO - mozcrash == 0.17 05:21:55 INFO - mozdebug == 0.1 05:21:55 INFO - mozdevice == 0.48 05:21:55 INFO - mozfile == 1.2 05:21:55 INFO - mozhttpd == 0.7 05:21:55 INFO - mozinfo == 0.9 05:21:55 INFO - mozleak == 0.1 05:21:55 INFO - mozlog == 3.2 05:21:55 INFO - moznetwork == 0.27 05:21:55 INFO - mozprocess == 0.22 05:21:55 INFO - mozprofile == 0.28 05:21:55 INFO - mozrunner == 6.11 05:21:55 INFO - mozscreenshot == 0.1 05:21:55 INFO - mozsystemmonitor == 0.3 05:21:55 INFO - moztest == 0.7 05:21:55 INFO - mozversion == 1.4 05:21:55 INFO - psutil == 3.1.1 05:21:55 INFO - requests == 1.2.3 05:21:55 INFO - wsgiref == 0.1.2 05:21:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:21: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:55 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 0x2489030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27483b0>, '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 0x27492b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2749740>, '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': '4300f881736b422476174874000001bc-1467288796.216613-75457196', '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 05:21:55 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 05:21:55 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 05:21:55 INFO - Using env: {'DISPLAY': ':0', 05:21:55 INFO - 'HOME': '/home/cltbld', 05:21:55 INFO - 'LANG': 'en_US.UTF-8', 05:21:55 INFO - 'LANGUAGE': 'en_US:en', 05:21:55 INFO - 'LOGNAME': 'cltbld', 05:21:55 INFO - 'MAIL': '/var/mail/cltbld', 05:21:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:55 INFO - 'MOZ_NO_REMOTE': '1', 05:21:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:55 INFO - 'NO_EM_RESTART': '1', 05:21:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:55 INFO - 'PWD': '/builds/slave/test', 05:21:55 INFO - 'SHELL': '/bin/bash', 05:21:55 INFO - 'SHLVL': '1', 05:21:55 INFO - 'TERM': 'linux', 05:21:55 INFO - 'TMOUT': '86400', 05:21:55 INFO - 'USER': 'cltbld', 05:21:55 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467288796.216613-75457196', 05:21:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:55 INFO - '_': '/tools/buildbot/bin/python'} 05:21:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:55 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)) 05:21:55 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)) 05:21:55 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)) 05:21:55 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)) 05:21:55 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)) 05:21:55 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)) 05:21:55 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)) 05:21:55 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)) 05:21:55 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)) 05:21:55 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)) 05:21:55 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)) 05:21:55 INFO - Cleaning up... 05:21:55 INFO - Return code: 0 05:21:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:21: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:55 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 0x2489030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27483b0>, '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 0x27492b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2749740>, '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': '4300f881736b422476174874000001bc-1467288796.216613-75457196', '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 05:21:55 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 05:21:55 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 05:21:55 INFO - Using env: {'DISPLAY': ':0', 05:21:55 INFO - 'HOME': '/home/cltbld', 05:21:55 INFO - 'LANG': 'en_US.UTF-8', 05:21:55 INFO - 'LANGUAGE': 'en_US:en', 05:21:55 INFO - 'LOGNAME': 'cltbld', 05:21:55 INFO - 'MAIL': '/var/mail/cltbld', 05:21:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:55 INFO - 'MOZ_NO_REMOTE': '1', 05:21:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:55 INFO - 'NO_EM_RESTART': '1', 05:21:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:55 INFO - 'PWD': '/builds/slave/test', 05:21:55 INFO - 'SHELL': '/bin/bash', 05:21:55 INFO - 'SHLVL': '1', 05:21:55 INFO - 'TERM': 'linux', 05:21:55 INFO - 'TMOUT': '86400', 05:21:55 INFO - 'USER': 'cltbld', 05:21:55 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467288796.216613-75457196', 05:21:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:55 INFO - '_': '/tools/buildbot/bin/python'} 05:21:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:21:55 INFO - Cleaning up... 05:21:55 INFO - Return code: 0 05:21:55 INFO - Running post-action listener: _resource_record_post_action 05:21:55 INFO - Running post-action listener: _start_resource_monitoring 05:21:56 INFO - Starting resource monitoring. 05:21:56 INFO - ##### 05:21:56 INFO - ##### Finished create-virtualenv step (success) 05:21:56 INFO - ##### 05:21:56 INFO - ##### 05:21:56 INFO - ##### Running install step. 05:21:56 INFO - ##### 05:21:56 INFO - Running pre-action listener: _resource_record_pre_action 05:21:56 INFO - Running main action method: install 05:21:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:21:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:21:56 INFO - Reading from file tmpfile_stdout 05:21:56 INFO - Detecting whether we're running mozinstall >=1.0... 05:21:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:21:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:21:56 INFO - Reading from file tmpfile_stdout 05:21:56 INFO - Output received: 05:21:56 INFO - Usage: mozinstall [options] installer 05:21:56 INFO - Options: 05:21:56 INFO - -h, --help show this help message and exit 05:21:56 INFO - -d DEST, --destination=DEST 05:21:56 INFO - Directory to install application into. [default: 05:21:56 INFO - "/builds/slave/test"] 05:21:56 INFO - --app=APP Application being installed. [default: firefox] 05:21:56 INFO - mkdir: /builds/slave/test/build/application 05:21:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:21:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:22:12 INFO - Reading from file tmpfile_stdout 05:22:12 INFO - Output received: 05:22:12 INFO - /builds/slave/test/build/application/firefox/firefox 05:22:12 INFO - Running post-action listener: _resource_record_post_action 05:22:12 INFO - ##### 05:22:12 INFO - ##### Finished install step (success) 05:22:12 INFO - ##### 05:22:12 INFO - ##### 05:22:12 INFO - ##### Running run-tests step. 05:22:12 INFO - ##### 05:22:12 INFO - Running pre-action listener: _resource_record_pre_action 05:22:12 INFO - Running main action method: run_tests 05:22:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:22:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:22:12 INFO - Python 2.7.3 05:22:12 INFO - Return code: 0 05:22:12 INFO - grabbing minidump binary from tooltool 05:22:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:12 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 0x27483b0>, '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 0x27492b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2749740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:22:12 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 05:22:12 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 05:22:12 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 05:22:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:22:12 INFO - Return code: 0 05:22:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:22:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:22:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:22:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:22:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:22:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 05:22:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 05:22:12 INFO - Using env: {'DISPLAY': ':0', 05:22:12 INFO - 'HOME': '/home/cltbld', 05:22:12 INFO - 'LANG': 'en_US.UTF-8', 05:22:12 INFO - 'LANGUAGE': 'en_US:en', 05:22:12 INFO - 'LOGNAME': 'cltbld', 05:22:12 INFO - 'MAIL': '/var/mail/cltbld', 05:22:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:22:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:22:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:12 INFO - 'MOZ_NO_REMOTE': '1', 05:22:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:22:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:12 INFO - 'NO_EM_RESTART': '1', 05:22:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:12 INFO - 'PWD': '/builds/slave/test', 05:22:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:22:12 INFO - 'SHELL': '/bin/bash', 05:22:12 INFO - 'SHLVL': '1', 05:22:12 INFO - 'TERM': 'linux', 05:22:12 INFO - 'TMOUT': '86400', 05:22:12 INFO - 'USER': 'cltbld', 05:22:12 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467288796.216613-75457196', 05:22:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:12 INFO - '_': '/tools/buildbot/bin/python'} 05:22:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 05:22:12 INFO - mozversion application_buildid: 20160630045127 05:22:12 INFO - mozversion application_changeset: 5f550071f889ff522db03e1e8e86e4cea11b4962 05:22:12 INFO - mozversion application_display_name: Nightly 05:22:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:22:12 INFO - mozversion application_name: Firefox 05:22:12 INFO - mozversion application_remotingname: firefox 05:22:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:22:12 INFO - mozversion application_vendor: Mozilla 05:22:12 INFO - mozversion application_version: 50.0a1 05:22:12 INFO - mozversion platform_buildid: 20160630045127 05:22:12 INFO - mozversion platform_changeset: 5f550071f889ff522db03e1e8e86e4cea11b4962 05:22:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:22:12 INFO - mozversion platform_version: 50.0a1 05:22:12 INFO - using testdate: 1467289332 05:22:12 INFO - actual date: 1467289332 05:22:12 INFO - starting webserver on 'localhost:51405' 05:22:12 INFO - SUITE-START | Running 2 tests 05:22:12 INFO - TEST-START | dromaeo_css 05:22:12 INFO - operating with platform_type : linux_ 05:22:12 INFO - Initialising browser for dromaeo_css test... 05:22:12 INFO - TEST-INFO | started process 13425 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXUtE3Y/profile http://localhost:51405/getInfo.html) 05:22:17 INFO - PROCESS | 13425 | __metrics Screen width/height:1600/1200 05:22:17 INFO - PROCESS | 13425 | colorDepth:24 05:22:17 INFO - PROCESS | 13425 | Browser inner width/height: 1024/697 05:22:17 INFO - PROCESS | 13425 | __metrics 05:22:18 INFO - PROCESS | 13425 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:22:19 INFO - TEST-INFO | 13425: exit 0 05:22:19 INFO - Browser initialized. 05:22:19 INFO - Running cycle 1/1 for dromaeo_css test... 05:22:19 INFO - TEST-INFO | started process 13507 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXUtE3Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:22:31 INFO - PROCESS | 13507 | RSS: Main: 158670848 05:22:31 INFO - PROCESS | 13507 | 05:23:22 INFO - PROCESS | 13507 | 1467289402293 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] 05:25:35 INFO - PROCESS | 13507 | Cycle 1(1): loaded http://localhost:51405/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51405/tests/dromaeo/cssquery-ext.html) 05:25:36 INFO - PROCESS | 13507 | RSS: Main: 247091200 05:25:36 INFO - PROCESS | 13507 | 05:28:38 INFO - PROCESS | 13507 | Cycle 1(1): loaded http://localhost:51405/tests/dromaeo/cssquery-ext.html (next: http://localhost:51405/tests/dromaeo/cssquery-jquery.html) 05:28:39 INFO - PROCESS | 13507 | RSS: Main: 244649984 05:28:39 INFO - PROCESS | 13507 | 05:31:41 INFO - PROCESS | 13507 | Cycle 1(1): loaded http://localhost:51405/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51405/tests/dromaeo/cssquery-mootools.html) 05:31:42 INFO - PROCESS | 13507 | RSS: Main: 240369664 05:31:42 INFO - PROCESS | 13507 | 05:34:44 INFO - PROCESS | 13507 | Cycle 1(1): loaded http://localhost:51405/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51405/tests/dromaeo/cssquery-prototype.html) 05:34:44 INFO - PROCESS | 13507 | RSS: Main: 234852352 05:34:44 INFO - PROCESS | 13507 | 05:37:47 INFO - PROCESS | 13507 | Cycle 1(1): loaded http://localhost:51405/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51405/tests/dromaeo/cssquery-yui.html) 05:37:48 INFO - PROCESS | 13507 | RSS: Main: 226430976 05:37:48 INFO - PROCESS | 13507 | 05:40:51 INFO - PROCESS | 13507 | Cycle 1(1): loaded http://localhost:51405/tests/dromaeo/cssquery-yui.html (next: http://localhost:51405/tests/dromaeo/cssquery-dojo.html) 05:40:51 INFO - PROCESS | 13507 | RSS: Main: 320491520 05:40:51 INFO - PROCESS | 13507 | 05:40:51 INFO - PROCESS | 13507 | __start_tp_report 05:40:51 INFO - PROCESS | 13507 | _x_x_mozilla_page_load 05:40:51 INFO - PROCESS | 13507 | _x_x_mozilla_page_load_details 05:40:51 INFO - PROCESS | 13507 | |i|pagename|runs| 05:40:51 INFO - PROCESS | 13507 | |0;dojo.html;2603.2840968733594;2636.419987602727;2677.973220267798;2678.973210267897;2680.6247125402447;4669.299605059243;4720.008798152384;4754.263089221167;4806.951930480698;4866.683665561741;4746.193147164981;4751.168545504532;4798.184308667526;4820.373351464314;4830.2754586812;4273.636740877021;4336.522982471925;4355.629771469429;4384.934225986597;4589.908201835961;4485.865424037268;4512.300593408027;4538.7503687297185;4550.567696068884;4567.337736028274;4329.631981281595;4368.235558777201;4388.012697143149;4401.2517871961845;4420.160169567772;4373.387725718402;4377.627901628365;4387.802548885308;4424.203643344197;4444.288913773813;4403.0533435311245;4416.712913660602;4426.048399594103;4466.441694788152;4468.70953388032;4719.197736384823;4760.45254795696;4806.206975848981;4813.3983252093485;4849.2968519564465;5141.331626888481;5155.304033955443;5196.58427325813;5212;5214.217867319894;5212.29633999409;5222.556082732972;5242.9213561796605;5243.659162154486;5254.947450525522;4680.882977925545;4724.551167639069;4749.453812811502;4757.881052973703;4828.37231159947;5239.29269548606;5241.161414173714;5261.263423120766;5288.762005709752;5292.285541451932;5008.899822003539;5009.273655320031;5054.368203974504;5057.747112644353;5064.873378165576;5048.72232027242;5134.127198376285;5151.2530683050745;5188.818391356284;5190;5144.897102057937;5162.225666150108;5164.070467315844;5168.043911876315;5175.948240517622;5147.047796157723;5148.227765835155;5152.330197074431;5152.793888244429;5177.508136727005;4274.20927128476;4304.677149213821;4307.935380969288;4351.086271882877;4354.216241076637;3776.7167462440425;3831.9808400958373;3844.36567966288;3848.0572259796527;3851.2105018471148;4371.934420983688;4382.758948257812;4425.203463376559;4428.31361139024;4472.195004899084;5194.870128246748;5201.687898726089;5203.635745497854;5203.739813009334;5263.105272103751;4420.115976804587;4430.689851710349;4432.867013989586;4437.711548749321;4440.156370289635;4558.247889098328;4613.700109492872;4662.137504561667;4662.487126416091;4677.859664210079;4826;4829.227323628203;4834.299026641117;4835.6131509478455;4879.756012199376;5032.043911656773;5109.437961824122;5147.9227811582105;5158.071547121554;5161.741912904415;4747.145513807548;4793.9280910787065;4806.47128815823;4820.8794780130775;4824.517548245148;5045.344105266292;5068.9239661405845;5073.2897394365555;5073.755147884687;5126.923096153635;4952.257161425815;5126.333576635014;5137.049645815536;5157.200633901752;5161.522469214723;4944.950550494449;4990.451050384382;5011;5012.824551140692;5057.671251368649;4996.850094497171;5008.674436161784;5013.222950442687;5038.7984480621835;5058.7976480941825;4735.455422626442;4887.169181239126;4954.133026720381;4957.3059771632725;5021.246812978083;5003.174476211384;5017.57350625201;5027.622928280321;5029.723365214948;5071.797128114834;4917.311576379381;4923.729194894315;4924.901501970012;4929.950700492949;4962.404511458503 05:40:51 INFO - PROCESS | 13507 | |1;ext.html;563.6195567991605;577.3908526504538;589.0722112672541;592.6414519215874;595.2172892646171;30959.690403095963;31304.686953130462;31387.372252554964;31411.214719632022;39909.8004509977;36305;39720;39734.20531589366;39886.40170397439;39980.60019399805;7963.044434667833;8113.269805717484;8118;8122.756317310461;8124;7691.615419229044;7769.223077692242;7770;7770.689172433096;7774.572398518079;8024.799380015488;8072.031356237259;8072.313853322475;8086.070101938264;8101.716439924604;8001.8799718004275;8034.035915690096;8041.678332866678;8047.356211503065;8050.235227653364;7925.405594580429;7999.640016199285;8001.239727259994;8005.519668819831;8007.279344858933;38389.424158637645;38616.80691596552;38761.224775504335;38788;38799.41800872989;3252.642209356969;3315.8673653053847;3712.3316309768943;3787.1478917243676;3930.3121953658283;28386.432271354457;28757.856210719023;30273.243168920733;30784.846075769703;31605.20986975321;3203.8077715337154;3289.555909952174;3343.7157841583494;3385.086026772782;3389.2882494676146;263005;263066;265110;265512;265562;33155.83422082874;33883;56272.43727562672;56929.430705693245;57048.42951570514;34357.65642343595;34923.65076349255;34938.47592286118;34949;34994.125146871025;12851.293178875065;12951.352432378344;12972.610821675366;12975.416106275052;12976.740465190833;10596.947015265028;10615.097716694014;10621.468926553796;10625.149988000941;10625.46872656364;8018.957535520345;8100.594970251464;8138.593070346459;8190.8771368429525;8227.42408031444;3220.710136087763;3270.6238782539835;3271.7709760316548;3278.541004259406;3300.950485742716;772.4515593928373;806.8063664720424;857.5155037403847;861.1818772166467;866.7313132928687;28217.858910705316;28398;28743.425131497253;28755.56866647002;28894.133176004754;964.4020707161465;998.5955687946393;1025.7640742629237;1051.453244312953;1098.4946924414699;14545.636359090895;14808.777868331983;15011.24943752808;15013.624659383384;15213.695726085416;389012;389057;391027;392171;393795;48665.75667121642;49282.507174928505;49377.50622493729;49456;49549;1080.0819303591884;1186.8399512886463;1221.4808706299787;1222.0406980520427;1223.7736018836545;28482.57276140901;28896.42207155803;29406.264843379086;29838.254043648216;30035.249118772204;42099.7895010523;42513.5748642522;42520.36219456772;42559.787201063795;42620.57379426166;296619;296944;298544;299313;299520;22484.437889052904;22706.659400109344;25708;25914;25961.40385961389;42251.7887410561;42433.78783106065;42653;43348.13303733971;43593.55080614923;36996.44505332476;37177.6282237185;37320.253594928494;37406.812965936086;37557.248855023296;36419.27161456809;36653.45019824758;37118.628813712596;37300.81349593234;37437.62562374341;35855;36081.45877811783;36194;36666.45000325051;37023.44464832976;32453.51319730159;32564.29257036032;32856.34287314288;33165.33669326648;33589.3282134351;25354.746452535976;25410.618840717034;25441.236762897144;25915.740842591335;27462.725372746016 05:40:51 INFO - PROCESS | 13507 | |2;jquery.html;349.40949794846694;375.2008222486104;376.918962423079;378.56843198753427;384.250711113329;13035.54375596853;17553.29786808526;17605.29578816849;18436.07819609021;19423.611527769437;14537;15576;17055.74416383752;17154.82845171548;17251.482455526322;5161.793528258874;6686.130802995628;7034.366906978371;7049.330313620198;7142.4286057115305;4118.094019315746;6623.635700036521;7022.683979220922;7057.117860267466;7061.858762824741;6879.759208427706;7089.5037347385705;7166.247544007882;7167.462440316971;7168.892466613005;7140.357367836919;7148.606826624534;7155.105611798525;7195.784126476162;7195.8201044973775;6498.707558159894;6620.768273110466;6628;6630.469562434993;6636.104125942984;23726.864582187514;23851.403714907094;23854.761452385428;24897.751022489905;24980;1955.9119839607251;2061.371281759063;2075.4858183451083;2423.151896836111;2537.238828351487;13928.30358482082;14831.258437078212;15239.542813715607;15373.308201130863;15470.226488675522;1818.9363372281907;1846.538365408648;1881.1252767463059;1888.0465364990591;1919.7792253890702;79156.60421697855;79503.6024819878;79911;82377;83339.58330208431;14432.927835360966;14680.522440655703;16629;17276.913615432095;17314.65370692579;29448.11655650334;29664.555031674543;29679.258018549277;29724;29867.25331866677;9253.953730231306;9260.583273752698;9294.628214871465;9332.626694932127;9424.858627120599;7692.692292308245;7763.456558040883;7884.881726774103;7907.406944479072;7966.920330796618;8461.196186362286;8487.702930397407;8586.356023298278;8678.39251252419;8740.562971851383;3121.1048511741355;3148.622165340174;3224.5808044954006;3241.62721287055;3373.9325213495595;833.924946754795;881.4490943160524;916.1159481100769;929.8605209218535;936.6955739384728;16816.411425600047;17481.125943702766;17487.387941422243;17917.222830461298;17924.551886202687;826.6156237349661;829.3323874281141;844.8986121665439;864.883240762489;890.8218356328761;7271.709131634675;9480.762980925394;9690.12788849007;9815.214782817358;9900.207983361313;411814;412725.42735576973;413790;417424.1287935591;418462;82766.58616706877;85803.57098214593;85845.570772147;86157.56921215479;86212.56893715616;926.7127190570944;928.758522784081;929.2287401456774;950.7623094226443;955.5938726041544;12457.750844983231;15604;16047.395260473859;16505.33978640841;16798.748018779483;28263.15210543687;39011.02472438098;40599.797001015984;40709.38935916023;40777.59222407738;51657.483425165265;52312.738436307576;53941.460585393645;54400.18399724086;54495.18257226224;7597.240275972358;7655.2344765523;7709.4603377763015;7775.883361749691;7792.766217013499;11123.66516018083;11519.30884146954;11782.11634127461;11960.76078478443;12089.516419343128;9360.906390936003;9413.199878010446;10001.099901008944;10095.394276343442;10234.181265498593;10097.394156350643;10144.54349554257;10467.685969420929;10573.365598064142;10595.09941654968;10280.948595256976;10833.51249193804;10850.240483166102;11070.501827417624;11098.61154859576;7243.311885370881;7397.445191610543;7443.18125006238;7549.622518874145;7709.267619576131;8383.245507904317;9156.816863662823;9484.478353690612;9535.713928582154;9811.411315321104 05:40:51 INFO - PROCESS | 13507 | |3;mootools.html;1305.9020573456994;1361.3329468560407;1396.197186617695;1661.2524364036187;1678.6978343898093;7554.093508778948;8019.719309824157;8094.352451803857;8118.837623247531;8123.390745694074;6958.199807022182;7207.963960180192;7210.639468026604;7391.852162956738;7907.841843163148;1946.0950657944018;2182.1162429216192;2259.559385919746;2261.4233370490583;2272.4773302140516;2217.268301460514;2219.911203551856;2243.7083179186684;2243.9775602244013;2244.7867452591977;1893.4698284480367;2223.83321250906;2230.531588366445;2231.8549294295817;2236.194969810875;2164.2425151197112;2251.268337790225;2251.3020963501367;2259.412552736284;2263.6151854184827;2128.4785227619177;2170.6201414752354;2178.4771654802894;2187.5406164705432;2192.8355373347063;7899.88150177742;7952.8409431811615;7957.522548647042;7957.5225486471;7961.880571791427;4460.710053846489;4512.481064677571;4561.817527298904;4562.292844609091;4595.977020114878;2788.0799336218997;2891.031504446013;2935.5156399194107;2955.733983941456;2956.807807492506;932.4871320773548;957.1242313283337;964.4550828781786;977.6089564174316;978.8287049766334;10913.781724365548;10923.672289831318;10925.235233533656;10925.289856159325;10926.125909927187;4089.3048181809163;4253.659707223414;4317.287647538121;4359.062801497693;4361.105973275471;9272.860907086399;9292.163705266423;9311.208547273422;9319.627214911328;9320.067993200626;4512.909741805145;4526.547345265513;4529.84145554904;4534.387857639176;4535.433070866142;4113.958860411418;4144.79276036197;4145.7719825409895;4148.79256037197;4152.5432202457705;3697.7226707997006;3718.5537735471376;3745.569259535134;3769.1707824278615;3784.035071056918;1179.2511755035614;1181.2794195540714;1198.7662405830954;1201.3572738584814;1228.2200802490304;688.5042769206163;762.1540090499541;769.638270013093;795.7851380127333;811.3671336357651;4921.9507804922205;5074.13739664258;5133.666311689728;5139.563137133386;5165.302684137593;412.03994692367314;413.8799748073025;419.6663652396291;428.57356929854996;429.39455367931066;3444.534987776668;3446.9310613788084;3452.671996160361;3532.7880327179937;3537.3102245061964;9437.764055898657;9797.265205109503;9827.901720982842;9938.403695778277;9949.950250248847;9922.503874806374;9985.251106167067;10008.149307308815;10033.949830250802;10048.447335396624;7298.2701729826595;7383.114026316876;7450.701971921062;7504.6247687615405;7527.887081693779;4952.628552858478;4975.129352363394;4998.850034498971;5020.096382651158;5064.7467626619255;8909.198172164537;9139.086091390807;9249.768755781159;9271.814563708553;9284;9227.907720922705;9414.62341506332;9480.668176613786;9513.66702165421;9625.278104142077;6331.240251169889;6568.868622627616;6575;6700.229473610402;6704.497162712719;7113.253108423748;7331.523450975669;7332.156801967842;7520.398368130427;7522.924770752223;6519.185101862267;6716.429103526255;6756.493263005196;6762.256151823197;6840.213375461686;6562.179727534059;6570.8357291068105;6637.867242655217;6656.800295991128;6798.898016529657;5751.309842818889;5789.594728369142;5827.067669173081;5840.94159058404;5952.642841429528;4306.354046892991;4339.587739164775;4422;4425.026494171278;4453.643708503248;4385.2983522637505;4430.756308403069;4458.71018383804;4499.617532509773;4500.234960056864 05:40:51 INFO - PROCESS | 13507 | |4;prototype.html;291.8905410471073;297.57446851003056;300.29430837531805;303.44015291786656;306.4132186862159;4900.313956046148;4902.3872015998;4902.926456103157;4908.533689299516;4909.5581397674205;4868.58617017553;4870.41555013398;4871.171900776868;4900.779464924078;4900.87747806305;3625.528681271431;3733.663970242678;3780.1683629601443;3849.0569810396423;3882.7087968402343;3855.15186658936;3858.9035274118232;3862.4592557041897;3863.9806800965957;3883.922321553567;3854.402567602026;3863.613638636128;3870.3033453978273;3876.8061596920184;3879.515060617423;3647.215848592552;3717.9999999999864;3811.6188381161937;3825.827837747308;3841.5774264830848;3383.5450756174837;3384.170878134848;3387;3394.6605339466105;3399.4390925497264;4719.150552900476;4730.668853180278;4750.738709370983;4762.976185119087;4764.928526072112;4228.8283787159635;4371.27873900806;4383.956160438387;4419.315006174048;4425.933610995838;5062.848114556569;5074.82238121664;5088.160453525201;5088.516590923857;5100.897982040376;3678.779273243614;3686.7234957378305;3687.870924517656;3694.2796154749567;3717.925641487155;5104.157813960692;5310.256564081032;5334.626091389333;5344.278522399465;5349.679019258857;3743.5320584926885;3750.6497660842074;3775.7356985011334;3778.414345776354;3784.6913382836447;3798.6771124454176;3805.752626079296;3814.7138964577766;3815.313243616176;3826.885193444201;4337.436133302651;4345.435093437896;4347.956520434818;4361.781910904506;4363.734516990037;4848.884756506023;5117.897642047138;5122.770535071556;5126.564242039394;5153.665011774223;1285.929273889945;1291.1736488647273;1296.2805642868298;1297.6366617347157;1298.214580178997;817.791463176886;849.9362547808939;881.713443130985;892.7009451833578;898.905614910425;4416.6245869101485;4429.55704429561;4441.422615060086;4451.221036318631;4473.4408198975125;5156.535911767959;5186.533212010937;5189.818356357585;5209.671533758868;5210.426853046162;4284.293091639907;4418.138462999685;4429.53489883564;4457.153140903218;4461.687681862239;2738.87675054623;2743.6570428696414;2774.140016594862;2778.8054836161677;2780.360517081083;4853.878653033702;4859.060268537554;4864.78108485119;4868.367112275381;4882.36529251195;5008.223725322581;5254.789808407697;5256.6057545684225;5268;5378.757955891994;4881.609471242363;4911.140550403594;4921.753912304371;4938.58022068121;4941.678790878509;5250.632455728215;5253.290805741176;5254.65844720092;5265.315508983807;5265.868353291198;4964.900701986012;5104.9489505104475;5132.486751324837;5138.3577052868395;5172.612054095883;4809.639277054165;4852.660313778143;4875.463698993179;4880.438749543848;4908.803647854189;3711.7216208783907;3720.572134204493;3721.976456474491;3725.515682961198;3729.5151630287887;4964.429090654477;5222.738863056756;5244.449332819999;5254.89490210186;5255.869987952608;4998.975005124951;5001.449840517467;5003.499650034967;5025.919427323143;5031.22016087507;5004.374453193351;5009.7996080157845;5077.365329333833;5078.923816142835;5082.593392528663;4775.450823155382;4891.19295316283;4947.18371468718;4956.6530342877095;5060.595152387874;4960.156773348467;5129.58963282929;5151.381834179922;5173.741312934413;5198.16829307309;4993.350864387607;4993.900121997467;5041.117804384291;5071.239314102914;5079.009593129452 05:40:51 INFO - PROCESS | 13507 | |5;yui.html;633.2148136310976;640.4044238857862;648.847520832604;694.4930200953304;727.9344858962694;12812.67968300793;13707.177569345822;13707.725845483084;13746.31268436578;13748.243846588446;13781.104228225158;14308.642283942907;14317.498887538939;14496;14538.709225815477;777.0364747712823;786.4455558831011;790.9090454597708;793.6269953122023;795.085651500773;640.5324113397223;762.6758627583283;786.7167819584945;792.2790260862587;793.3375631347832;821.5112008355019;821.7247222180577;822.5311572403732;823.5923218007065;823.5964377455034;663.1180529895228;819.2667562531501;819.4755356571799;820.5035953248318;821.4988856797349;592.7421571616361;609.2414943395456;610.2432983100967;612.1552257884091;613.895637741585;13074.934625326812;13079.738405231938;13094;13097.738045239137;13099.803502947463;11736.53053877844;11918.88081119195;11937.34344611046;12489.75020499594;12674.429650665743;11447.313161210353;11555.595554155649;11626.186166968315;11683.357415342152;11725.941370293094;3845.86629184922;3922.8626998055215;3925.568187499373;3991.3214753491975;4014.1770936957855;61101;61149.694251528905;61963;62060.68969655123;62264;9517.714468565953;9668.661596844076;9746.415215087118;9840.704778856645;9955.900440995641;17841.28634854617;17857.196426160855;17866.642667146585;17921.551961200814;17940.19269132892;6460.192859419851;6513.8697226056165;6530.118434011442;6545.639989800607;6615.4376877965915;3712.9071773205346;3715.7398982070995;3754.3992961126087;3798.2973149967343;3834.5206849143856;2826.23691603266;2921.649402071765;2943.808652437585;2943.9411211776073;2946.6022087017977;500.83472454090065;506.4150905703918;518.142474205191;518.5903136522105;519.7037688517509;459.2514201851028;509.84194899581246;512.0271484180088;517.2138349708422;521.5801279969585;6394.1687580614225;6460.515461340418;6482.546221764525;6557.884385965837;6569.770058048041;459.7103824590553;481.35738788716753;481.5040508276481;499.57286520024854;509.2895410901845;3352.5641666583188;3567;3617.986963650182;3626.601073881871;3700.611435799256;51588;52673.2099018515;76008.61995689986;78817.211827881;79276;78358;78994.6050269745;79231;82645;83162;73949.6302518484;74626.62686686532;75892;76117.61941190259;77641.61179194068;8655.30757539408;8708.738737837875;8731.869021964803;8869.556522173994;8905.376623636283;33766.49350259699;43937.34093988657;45447.77276113598;46082.30876536922;46199.53800462087;58312.4168758307;62112.378876210656;62482.687586563596;63879.680601596694;64749.35250647433;11401.486933087865;11494.482748276514;11501.654950351503;11648.825267620823;12051.397430128634;11357.829632555684;12434.937825311177;12743.980481561639;13033.348332583522;13231.66920826987;11288.717782055513;11820.172587918763;12111.454984525893;12370.257784532956;12413.255204687748;10618.59145990775;11072.335659860435;11082.61210857616;11450.828237576276;11452.255603385753;10277;11122.499487523242;11132.833007504732;11405.942970285096;11486.13853960973;10007.949960250153;10063.69808905734;10439;10552.157034937913;10833.51249193804;9891.604335826487;10149.441780702133;10476.63331783384;10500.264981451224;10509.211809114195 05:40:51 INFO - PROCESS | 13507 | __end_tp_report 05:40:51 INFO - PROCESS | 13507 | __start_cc_report 05:40:51 INFO - PROCESS | 13507 | _x_x_mozilla_cycle_collect,917 05:40:51 INFO - PROCESS | 13507 | __end_cc_report 05:40:51 INFO - PROCESS | 13507 | __startTimestamp1467290451720__endTimestamp 05:40:51 INFO - PROCESS | 13507 | 05:40:51 INFO - PROCESS | 13507 | ------- Summary: start ------- 05:40:51 INFO - PROCESS | 13507 | Number of tests: 6 05:40:51 INFO - PROCESS | 13507 | 05:40:51 INFO - PROCESS | 13507 | [#0] dojo.html Cycles:165 Average:4750.28 Median:4835.61 stddev:505.39 (10.5%) stddev-sans-first:478.05 05:40:51 INFO - PROCESS | 13507 | Values: 2603.3 2636.4 2678.0 2679.0 2680.6 4669.3 4720.0 4754.3 4807.0 4866.7 4746.2 4751.2 4798.2 4820.4 4830.3 4273.6 4336.5 4355.6 4384.9 4589.9 4485.9 4512.3 4538.8 4550.6 4567.3 4329.6 4368.2 4388.0 4401.3 4420.2 4373.4 4377.6 4387.8 4424.2 4444.3 4403.1 4416.7 4426.0 4466.4 4468.7 4719.2 4760.5 4806.2 4813.4 4849.3 5141.3 5155.3 5196.6 5212.0 5214.2 5212.3 5222.6 5242.9 5243.7 5254.9 4680.9 4724.6 4749.5 4757.9 4828.4 5239.3 5241.2 5261.3 5288.8 5292.3 5008.9 5009.3 5054.4 5057.7 5064.9 5048.7 5134.1 5151.3 5188.8 5190.0 5144.9 5162.2 5164.1 5168.0 5175.9 5147.0 5148.2 5152.3 5152.8 5177.5 4274.2 4304.7 4307.9 4351.1 4354.2 3776.7 3832.0 3844.4 3848.1 3851.2 4371.9 4382.8 4425.2 4428.3 4472.2 5194.9 5201.7 5203.6 5203.7 5263.1 4420.1 4430.7 4432.9 4437.7 4440.2 4558.2 4613.7 4662.1 4662.5 4677.9 4826.0 4829.2 4834.3 4835.6 4879.8 5032.0 5109.4 5147.9 5158.1 5161.7 4747.1 4793.9 4806.5 4820.9 4824.5 5045.3 5068.9 5073.3 5073.8 5126.9 4952.3 5126.3 5137.0 5157.2 5161.5 4945.0 4990.5 5011.0 5012.8 5057.7 4996.9 5008.7 5013.2 5038.8 5058.8 4735.5 4887.2 4954.1 4957.3 5021.2 5003.2 5017.6 5027.6 5029.7 5071.8 4917.3 4923.7 4924.9 4930.0 4962.4 05:40:51 INFO - PROCESS | 13507 | 05:40:51 INFO - PROCESS | 13507 | [#1] ext.html Cycles:180 Average:46211.88 Median:36536.36 stddev:84992.16 (232.6%) stddev-sans-first:85161.48 05:40:51 INFO - PROCESS | 13507 | Values: 563.6 577.4 589.1 592.6 595.2 30959.7 31304.7 31387.4 31411.2 39909.8 36305.0 39720.0 39734.2 39886.4 39980.6 7963.0 8113.3 8118.0 8122.8 8124.0 7691.6 7769.2 7770.0 7770.7 7774.6 8024.8 8072.0 8072.3 8086.1 8101.7 8001.9 8034.0 8041.7 8047.4 8050.2 7925.4 7999.6 8001.2 8005.5 8007.3 38389.4 38616.8 38761.2 38788.0 38799.4 3252.6 3315.9 3712.3 3787.1 3930.3 28386.4 28757.9 30273.2 30784.8 31605.2 3203.8 3289.6 3343.7 3385.1 3389.3 263005.0 263066.0 265110.0 265512.0 265562.0 33155.8 33883.0 56272.4 56929.4 57048.4 34357.7 34923.7 34938.5 34949.0 34994.1 12851.3 12951.4 12972.6 12975.4 12976.7 10596.9 10615.1 10621.5 10625.1 10625.5 8019.0 8100.6 8138.6 8190.9 8227.4 3220.7 3270.6 3271.8 3278.5 3301.0 772.5 806.8 857.5 861.2 866.7 28217.9 28398.0 28743.4 28755.6 28894.1 964.4 998.6 1025.8 1051.5 1098.5 14545.6 14808.8 15011.2 15013.6 15213.7 389012.0 389057.0 391027.0 392171.0 393795.0 48665.8 49282.5 49377.5 49456.0 49549.0 1080.1 1186.8 1221.5 1222.0 1223.8 28482.6 28896.4 29406.3 29838.3 30035.2 42099.8 42513.6 42520.4 42559.8 42620.6 296619.0 296944.0 298544.0 299313.0 299520.0 22484.4 22706.7 25708.0 25914.0 25961.4 42251.8 42433.8 42653.0 43348.1 43593.6 36996.4 37177.6 37320.3 37406.8 37557.2 36419.3 36653.5 37118.6 37300.8 37437.6 35855.0 36081.5 36194.0 36666.5 37023.4 32453.5 32564.3 32856.3 33165.3 33589.3 25354.7 25410.6 25441.2 25915.7 27462.7 05:40:51 INFO - PROCESS | 13507 | 05:40:51 INFO - PROCESS | 13507 | [#2] jquery.html Cycles:180 Average:26949.08 Median:51985.11 stddev:68581.87 (131.9%) stddev-sans-first:68745.18 05:40:51 INFO - PROCESS | 13507 | Values: 349.4 375.2 376.9 378.6 384.3 13035.5 17553.3 17605.3 18436.1 19423.6 14537.0 15576.0 17055.7 17154.8 17251.5 5161.8 6686.1 7034.4 7049.3 7142.4 4118.1 6623.6 7022.7 7057.1 7061.9 6879.8 7089.5 7166.2 7167.5 7168.9 7140.4 7148.6 7155.1 7195.8 7195.8 6498.7 6620.8 6628.0 6630.5 6636.1 23726.9 23851.4 23854.8 24897.8 24980.0 1955.9 2061.4 2075.5 2423.2 2537.2 13928.3 14831.3 15239.5 15373.3 15470.2 1818.9 1846.5 1881.1 1888.0 1919.8 79156.6 79503.6 79911.0 82377.0 83339.6 14432.9 14680.5 16629.0 17276.9 17314.7 29448.1 29664.6 29679.3 29724.0 29867.3 9254.0 9260.6 9294.6 9332.6 9424.9 7692.7 7763.5 7884.9 7907.4 7966.9 8461.2 8487.7 8586.4 8678.4 8740.6 3121.1 3148.6 3224.6 3241.6 3373.9 833.9 881.4 916.1 929.9 936.7 16816.4 17481.1 17487.4 17917.2 17924.6 826.6 829.3 844.9 864.9 890.8 7271.7 9480.8 9690.1 9815.2 9900.2 411814.0 412725.4 413790.0 417424.1 418462.0 82766.6 85803.6 85845.6 86157.6 86212.6 926.7 928.8 929.2 950.8 955.6 12457.8 15604.0 16047.4 16505.3 16798.7 28263.2 39011.0 40599.8 40709.4 40777.6 51657.5 52312.7 53941.5 54400.2 54495.2 7597.2 7655.2 7709.5 7775.9 7792.8 11123.7 11519.3 11782.1 11960.8 12089.5 9360.9 9413.2 10001.1 10095.4 10234.2 10097.4 10144.5 10467.7 10573.4 10595.1 10280.9 10833.5 10850.2 11070.5 11098.6 7243.3 7397.4 7443.2 7549.6 7709.3 8383.2 9156.8 9484.5 9535.7 9811.4 05:40:51 INFO - PROCESS | 13507 | 05:40:51 INFO - PROCESS | 13507 | [#3] mootools.html Cycles:180 Average:5134.39 Median:4562.06 stddev:2960.73 (64.9%) stddev-sans-first:2955.05 05:40:51 INFO - PROCESS | 13507 | Values: 1305.9 1361.3 1396.2 1661.3 1678.7 7554.1 8019.7 8094.4 8118.8 8123.4 6958.2 7208.0 7210.6 7391.9 7907.8 1946.1 2182.1 2259.6 2261.4 2272.5 2217.3 2219.9 2243.7 2244.0 2244.8 1893.5 2223.8 2230.5 2231.9 2236.2 2164.2 2251.3 2251.3 2259.4 2263.6 2128.5 2170.6 2178.5 2187.5 2192.8 7899.9 7952.8 7957.5 7957.5 7961.9 4460.7 4512.5 4561.8 4562.3 4596.0 2788.1 2891.0 2935.5 2955.7 2956.8 932.5 957.1 964.5 977.6 978.8 10913.8 10923.7 10925.2 10925.3 10926.1 4089.3 4253.7 4317.3 4359.1 4361.1 9272.9 9292.2 9311.2 9319.6 9320.1 4512.9 4526.5 4529.8 4534.4 4535.4 4114.0 4144.8 4145.8 4148.8 4152.5 3697.7 3718.6 3745.6 3769.2 3784.0 1179.3 1181.3 1198.8 1201.4 1228.2 688.5 762.2 769.6 795.8 811.4 4922.0 5074.1 5133.7 5139.6 5165.3 412.0 413.9 419.7 428.6 429.4 3444.5 3446.9 3452.7 3532.8 3537.3 9437.8 9797.3 9827.9 9938.4 9950.0 9922.5 9985.3 10008.1 10033.9 10048.4 7298.3 7383.1 7450.7 7504.6 7527.9 4952.6 4975.1 4998.9 5020.1 5064.7 8909.2 9139.1 9249.8 9271.8 9284.0 9227.9 9414.6 9480.7 9513.7 9625.3 6331.2 6568.9 6575.0 6700.2 6704.5 7113.3 7331.5 7332.2 7520.4 7522.9 6519.2 6716.4 6756.5 6762.3 6840.2 6562.2 6570.8 6637.9 6656.8 6798.9 5751.3 5789.6 5827.1 5840.9 5952.6 4306.4 4339.6 4422.0 4425.0 4453.6 4385.3 4430.8 4458.7 4499.6 4500.2 05:40:51 INFO - PROCESS | 13507 | 05:40:51 INFO - PROCESS | 13507 | [#4] prototype.html Cycles:180 Average:4227.89 Median:4861.92 stddev:1215.93 (25.0%) stddev-sans-first:1182.90 05:40:51 INFO - PROCESS | 13507 | Values: 291.9 297.6 300.3 303.4 306.4 4900.3 4902.4 4902.9 4908.5 4909.6 4868.6 4870.4 4871.2 4900.8 4900.9 3625.5 3733.7 3780.2 3849.1 3882.7 3855.2 3858.9 3862.5 3864.0 3883.9 3854.4 3863.6 3870.3 3876.8 3879.5 3647.2 3718.0 3811.6 3825.8 3841.6 3383.5 3384.2 3387.0 3394.7 3399.4 4719.2 4730.7 4750.7 4763.0 4764.9 4228.8 4371.3 4384.0 4419.3 4425.9 5062.8 5074.8 5088.2 5088.5 5100.9 3678.8 3686.7 3687.9 3694.3 3717.9 5104.2 5310.3 5334.6 5344.3 5349.7 3743.5 3750.6 3775.7 3778.4 3784.7 3798.7 3805.8 3814.7 3815.3 3826.9 4337.4 4345.4 4348.0 4361.8 4363.7 4848.9 5117.9 5122.8 5126.6 5153.7 1285.9 1291.2 1296.3 1297.6 1298.2 817.8 849.9 881.7 892.7 898.9 4416.6 4429.6 4441.4 4451.2 4473.4 5156.5 5186.5 5189.8 5209.7 5210.4 4284.3 4418.1 4429.5 4457.2 4461.7 2738.9 2743.7 2774.1 2778.8 2780.4 4853.9 4859.1 4864.8 4868.4 4882.4 5008.2 5254.8 5256.6 5268.0 5378.8 4881.6 4911.1 4921.8 4938.6 4941.7 5250.6 5253.3 5254.7 5265.3 5265.9 4964.9 5104.9 5132.5 5138.4 5172.6 4809.6 4852.7 4875.5 4880.4 4908.8 3711.7 3720.6 3722.0 3725.5 3729.5 4964.4 5222.7 5244.4 5254.9 5255.9 4999.0 5001.4 5003.5 5025.9 5031.2 5004.4 5009.8 5077.4 5078.9 5082.6 4775.5 4891.2 4947.2 4956.7 5060.6 4960.2 5129.6 5151.4 5173.7 5198.2 4993.4 4993.9 5041.1 5071.2 5079.0 05:40:51 INFO - PROCESS | 13507 | 05:40:51 INFO - PROCESS | 13507 | [#5] yui.html Cycles:180 Average:16783.98 Median:23340.45 stddev:22886.35 (98.1%) stddev-sans-first:22918.42 05:40:51 INFO - PROCESS | 13507 | Values: 633.2 640.4 648.8 694.5 727.9 12812.7 13707.2 13707.7 13746.3 13748.2 13781.1 14308.6 14317.5 14496.0 14538.7 777.0 786.4 790.9 793.6 795.1 640.5 762.7 786.7 792.3 793.3 821.5 821.7 822.5 823.6 823.6 663.1 819.3 819.5 820.5 821.5 592.7 609.2 610.2 612.2 613.9 13074.9 13079.7 13094.0 13097.7 13099.8 11736.5 11918.9 11937.3 12489.8 12674.4 11447.3 11555.6 11626.2 11683.4 11725.9 3845.9 3922.9 3925.6 3991.3 4014.2 61101.0 61149.7 61963.0 62060.7 62264.0 9517.7 9668.7 9746.4 9840.7 9955.9 17841.3 17857.2 17866.6 17921.6 17940.2 6460.2 6513.9 6530.1 6545.6 6615.4 3712.9 3715.7 3754.4 3798.3 3834.5 2826.2 2921.6 2943.8 2943.9 2946.6 500.8 506.4 518.1 518.6 519.7 459.3 509.8 512.0 517.2 521.6 6394.2 6460.5 6482.5 6557.9 6569.8 459.7 481.4 481.5 499.6 509.3 3352.6 3567.0 3618.0 3626.6 3700.6 51588.0 52673.2 76008.6 78817.2 79276.0 78358.0 78994.6 79231.0 82645.0 83162.0 73949.6 74626.6 75892.0 76117.6 77641.6 8655.3 8708.7 8731.9 8869.6 8905.4 33766.5 43937.3 45447.8 46082.3 46199.5 58312.4 62112.4 62482.7 63879.7 64749.4 11401.5 11494.5 11501.7 11648.8 12051.4 11357.8 12434.9 12744.0 13033.3 13231.7 11288.7 11820.2 12111.5 12370.3 12413.3 10618.6 11072.3 11082.6 11450.8 11452.3 10277.0 11122.5 11132.8 11405.9 11486.1 10007.9 10063.7 10439.0 10552.2 10833.5 9891.6 10149.4 10476.6 10500.3 10509.2 05:40:51 INFO - PROCESS | 13507 | -------- Summary: end -------- 05:40:51 INFO - PROCESS | 13507 | 05:40:52 INFO - TEST-INFO | 13507: exit 0 05:40:52 INFO - TEST-OK | dromaeo_css | took 1119695ms 05:40:52 INFO - TEST-START | kraken 05:40:52 INFO - operating with platform_type : linux_ 05:40:52 INFO - Initialising browser for kraken test... 05:40:52 INFO - TEST-INFO | started process 13691 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptdaLGa/profile http://localhost:51405/getInfo.html) 05:40:56 INFO - PROCESS | 13691 | __metrics Screen width/height:1600/1200 05:40:56 INFO - PROCESS | 13691 | colorDepth:24 05:40:56 INFO - PROCESS | 13691 | Browser inner width/height: 1024/697 05:40:56 INFO - PROCESS | 13691 | __metrics 05:40:57 INFO - PROCESS | 13691 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:40:58 INFO - TEST-INFO | 13691: exit 0 05:40:58 INFO - Browser initialized. 05:40:58 INFO - Running cycle 1/1 for kraken test... 05:40:58 INFO - TEST-INFO | started process 13775 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptdaLGa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:41:10 INFO - PROCESS | 13775 | RSS: Main: 159526912 05:41:10 INFO - PROCESS | 13775 | 05:41:13 INFO - PROCESS | 13775 | Cycle 1(1): loaded http://localhost:51405/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51405/tests/kraken/driver.html?testName=audio-beat-detection) 05:41:14 INFO - PROCESS | 13775 | RSS: Main: 216788992 05:41:14 INFO - PROCESS | 13775 | 05:41:17 INFO - PROCESS | 13775 | Cycle 1(1): loaded http://localhost:51405/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51405/tests/kraken/driver.html?testName=audio-dft) 05:41:17 INFO - PROCESS | 13775 | RSS: Main: 204390400 05:41:17 INFO - PROCESS | 13775 | 05:41:21 INFO - PROCESS | 13775 | Cycle 1(1): loaded http://localhost:51405/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51405/tests/kraken/driver.html?testName=audio-fft) 05:41:21 INFO - PROCESS | 13775 | RSS: Main: 271917056 05:41:21 INFO - PROCESS | 13775 | 05:41:23 INFO - PROCESS | 13775 | Cycle 1(1): loaded http://localhost:51405/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51405/tests/kraken/driver.html?testName=audio-oscillator) 05:41:24 INFO - PROCESS | 13775 | RSS: Main: 182304768 05:41:24 INFO - PROCESS | 13775 | 05:41:26 INFO - PROCESS | 13775 | Cycle 1(1): loaded http://localhost:51405/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51405/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:41:27 INFO - PROCESS | 13775 | RSS: Main: 185757696 05:41:27 INFO - PROCESS | 13775 | 05:41:30 INFO - PROCESS | 13775 | Cycle 1(1): loaded http://localhost:51405/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51405/tests/kraken/driver.html?testName=imaging-darkroom) 05:41:30 INFO - PROCESS | 13775 | RSS: Main: 222240768 05:41:30 INFO - PROCESS | 13775 | 05:41:34 INFO - PROCESS | 13775 | Cycle 1(1): loaded http://localhost:51405/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51405/tests/kraken/driver.html?testName=imaging-desaturate) 05:41:35 INFO - PROCESS | 13775 | RSS: Main: 218009600 05:41:35 INFO - PROCESS | 13775 | 05:41:38 INFO - PROCESS | 13775 | Cycle 1(1): loaded http://localhost:51405/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51405/tests/kraken/driver.html?testName=json-parse-financial) 05:41:38 INFO - PROCESS | 13775 | RSS: Main: 220246016 05:41:38 INFO - PROCESS | 13775 | 05:41:40 INFO - PROCESS | 13775 | Cycle 1(1): loaded http://localhost:51405/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51405/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:41:40 INFO - PROCESS | 13775 | RSS: Main: 206544896 05:41:40 INFO - PROCESS | 13775 | 05:41:42 INFO - PROCESS | 13775 | Cycle 1(1): loaded http://localhost:51405/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51405/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:41:43 INFO - PROCESS | 13775 | RSS: Main: 211447808 05:41:43 INFO - PROCESS | 13775 | 05:41:45 INFO - PROCESS | 13775 | Cycle 1(1): loaded http://localhost:51405/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51405/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:41:46 INFO - PROCESS | 13775 | RSS: Main: 210063360 05:41:46 INFO - PROCESS | 13775 | 05:41:49 INFO - PROCESS | 13775 | Cycle 1(1): loaded http://localhost:51405/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51405/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:41:49 INFO - PROCESS | 13775 | RSS: Main: 224899072 05:41:49 INFO - PROCESS | 13775 | 05:41:52 INFO - PROCESS | 13775 | Cycle 1(1): loaded http://localhost:51405/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51405/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:41:53 INFO - PROCESS | 13775 | RSS: Main: 226484224 05:41:53 INFO - PROCESS | 13775 | 05:41:54 INFO - PROCESS | 13775 | Cycle 1(1): loaded http://localhost:51405/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51405/tests/kraken/driver.html?testName=ai-astar) 05:41:55 INFO - PROCESS | 13775 | RSS: Main: 269168640 05:41:55 INFO - PROCESS | 13775 | 05:41:55 INFO - PROCESS | 13775 | __start_tp_report 05:41:55 INFO - PROCESS | 13775 | _x_x_mozilla_page_load 05:41:55 INFO - PROCESS | 13775 | _x_x_mozilla_page_load_details 05:41:55 INFO - PROCESS | 13775 | |i|pagename|runs| 05:41:55 INFO - PROCESS | 13775 | |0;ai-astar;105;115;116;115;114;114;115;114;114;115 05:41:55 INFO - PROCESS | 13775 | |1;audio-beat-detection;149;120;124;178;124;127;144;122;158;122 05:41:55 INFO - PROCESS | 13775 | |2;audio-dft;161;163;160;160;160;160;159;161;162;162 05:41:55 INFO - PROCESS | 13775 | |3;audio-fft;83;77;76;116;77;77;74;75;102;77 05:41:55 INFO - PROCESS | 13775 | |4;audio-oscillator;85;85;112;84;84;84;128;85;86;124 05:41:55 INFO - PROCESS | 13775 | |5;imaging-gaussian-blur;117;118;117;117;116;117;117;116;118;117 05:41:55 INFO - PROCESS | 13775 | |6;imaging-darkroom;146;146;146;146;145;146;146;146;146;146 05:41:55 INFO - PROCESS | 13775 | |7;imaging-desaturate;95;94;95;95;94;95;95;94;95;95 05:41:55 INFO - PROCESS | 13775 | |8;json-parse-financial;64;63;63;63;63;64;63;66;65;63 05:41:55 INFO - PROCESS | 13775 | |9;json-stringify-tinderbox;66;65;66;65;65;64;65;65;65;65 05:41:55 INFO - PROCESS | 13775 | |10;stanford-crypto-aes;80;78;78;78;78;85;78;84;79;84 05:41:55 INFO - PROCESS | 13775 | |11;stanford-crypto-ccm;133;137;134;140;130;131;131;131;208;134 05:41:55 INFO - PROCESS | 13775 | |12;stanford-crypto-pbkdf2;173;174;171;177;168;172;170;170;168;168 05:41:55 INFO - PROCESS | 13775 | |13;stanford-crypto-sha256-iterative;72;67;70;67;69;67;67;71;66;65 05:41:55 INFO - PROCESS | 13775 | __end_tp_report 05:41:55 INFO - PROCESS | 13775 | __start_cc_report 05:41:55 INFO - PROCESS | 13775 | _x_x_mozilla_cycle_collect,1908 05:41:55 INFO - PROCESS | 13775 | __end_cc_report 05:41:55 INFO - PROCESS | 13775 | __startTimestamp1467290515223__endTimestamp 05:41:55 INFO - PROCESS | 13775 | 05:41:55 INFO - PROCESS | 13775 | ------- Summary: start ------- 05:41:55 INFO - PROCESS | 13775 | Number of tests: 14 05:41:55 INFO - PROCESS | 13775 | 05:41:55 INFO - PROCESS | 13775 | [#0] ai-astar Cycles:10 Average:113.70 Median:115.00 stddev:3.13 (2.7%) stddev-sans-first:0.71 05:41:55 INFO - PROCESS | 13775 | Values: 105.0 115.0 116.0 115.0 114.0 114.0 115.0 114.0 114.0 115.0 05:41:55 INFO - PROCESS | 13775 | 05:41:55 INFO - PROCESS | 13775 | [#1] audio-beat-detection Cycles:10 Average:136.80 Median:135.50 stddev:19.70 (14.5%) stddev-sans-first:20.39 05:41:55 INFO - PROCESS | 13775 | Values: 149.0 120.0 124.0 178.0 124.0 127.0 144.0 122.0 158.0 122.0 05:41:55 INFO - PROCESS | 13775 | 05:41:55 INFO - PROCESS | 13775 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.23 (0.8%) stddev-sans-first:1.30 05:41:55 INFO - PROCESS | 13775 | Values: 161.0 163.0 160.0 160.0 160.0 160.0 159.0 161.0 162.0 162.0 05:41:55 INFO - PROCESS | 13775 | 05:41:55 INFO - PROCESS | 13775 | [#3] audio-fft Cycles:10 Average:83.40 Median:77.00 stddev:14.09 (18.3%) stddev-sans-first:14.94 05:41:55 INFO - PROCESS | 13775 | Values: 83.0 77.0 76.0 116.0 77.0 77.0 74.0 75.0 102.0 77.0 05:41:55 INFO - PROCESS | 13775 | 05:41:55 INFO - PROCESS | 13775 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:84.50 stddev:18.13 (21.5%) stddev-sans-first:18.81 05:41:55 INFO - PROCESS | 13775 | Values: 85.0 85.0 112.0 84.0 84.0 84.0 128.0 85.0 86.0 124.0 05:41:55 INFO - PROCESS | 13775 | 05:41:55 INFO - PROCESS | 13775 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 05:41:55 INFO - PROCESS | 13775 | Values: 117.0 118.0 117.0 117.0 116.0 117.0 117.0 116.0 118.0 117.0 05:41:55 INFO - PROCESS | 13775 | 05:41:55 INFO - PROCESS | 13775 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 05:41:55 INFO - PROCESS | 13775 | Values: 146.0 146.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 05:41:55 INFO - PROCESS | 13775 | 05:41:55 INFO - PROCESS | 13775 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 05:41:55 INFO - PROCESS | 13775 | Values: 95.0 94.0 95.0 95.0 94.0 95.0 95.0 94.0 95.0 95.0 05:41:55 INFO - PROCESS | 13775 | 05:41:55 INFO - PROCESS | 13775 | [#8] json-parse-financial Cycles:10 Average:63.70 Median:63.50 stddev:1.06 (1.7%) stddev-sans-first:1.12 05:41:55 INFO - PROCESS | 13775 | Values: 64.0 63.0 63.0 63.0 63.0 64.0 63.0 66.0 65.0 63.0 05:41:55 INFO - PROCESS | 13775 | 05:41:55 INFO - PROCESS | 13775 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 05:41:55 INFO - PROCESS | 13775 | Values: 66.0 65.0 66.0 65.0 65.0 64.0 65.0 65.0 65.0 65.0 05:41:55 INFO - PROCESS | 13775 | 05:41:55 INFO - PROCESS | 13775 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:79.50 stddev:2.94 (3.7%) stddev-sans-first:3.11 05:41:55 INFO - PROCESS | 13775 | Values: 80.0 78.0 78.0 78.0 78.0 85.0 78.0 84.0 79.0 84.0 05:41:55 INFO - PROCESS | 13775 | 05:41:55 INFO - PROCESS | 13775 | [#11] stanford-crypto-ccm Cycles:10 Average:140.90 Median:134.00 stddev:23.78 (17.7%) stddev-sans-first:25.05 05:41:55 INFO - PROCESS | 13775 | Values: 133.0 137.0 134.0 140.0 130.0 131.0 131.0 131.0 208.0 134.0 05:41:55 INFO - PROCESS | 13775 | 05:41:55 INFO - PROCESS | 13775 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.10 Median:171.50 stddev:2.96 (1.7%) stddev-sans-first:3.06 05:41:55 INFO - PROCESS | 13775 | Values: 173.0 174.0 171.0 177.0 168.0 172.0 170.0 170.0 168.0 168.0 05:41:55 INFO - PROCESS | 13775 | 05:41:55 INFO - PROCESS | 13775 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:2.28 (3.4%) stddev-sans-first:1.94 05:41:55 INFO - PROCESS | 13775 | Values: 72.0 67.0 70.0 67.0 69.0 67.0 67.0 71.0 66.0 65.0 05:41:55 INFO - PROCESS | 13775 | -------- Summary: end -------- 05:41:55 INFO - PROCESS | 13775 | 05:41:56 INFO - TEST-INFO | 13775: exit 0 05:41:56 INFO - TEST-OK | kraken | took 63745ms 05:41:56 INFO - SUITE-END | took 1183s 05:41:56 INFO - Completed test suite (00:19:43) 05:41:56 INFO - javascript benchmark 05:41:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2603.2840968733594, 2636.419987602727, 2677.973220267798, 2678.973210267897, 2680.6247125402447, 4669.299605059243, 4720.008798152384, 4754.263089221167, 4806.951930480698, 4866.683665561741, 4746.193147164981, 4751.168545504532, 4798.184308667526, 4820.373351464314, 4830.2754586812, 4273.636740877021, 4336.522982471925, 4355.629771469429, 4384.934225986597, 4589.908201835961, 4485.865424037268, 4512.300593408027, 4538.7503687297185, 4550.567696068884, 4567.337736028274, 4329.631981281595, 4368.235558777201, 4388.012697143149, 4401.2517871961845, 4420.160169567772, 4373.387725718402, 4377.627901628365, 4387.802548885308, 4424.203643344197, 4444.288913773813, 4403.0533435311245, 4416.712913660602, 4426.048399594103, 4466.441694788152, 4468.70953388032, 4719.197736384823, 4760.45254795696, 4806.206975848981, 4813.3983252093485, 4849.2968519564465, 5141.331626888481, 5155.304033955443, 5196.58427325813, 5212.0, 5214.217867319894, 5212.29633999409, 5222.556082732972, 5242.9213561796605, 5243.659162154486, 5254.947450525522, 4680.882977925545, 4724.551167639069, 4749.453812811502, 4757.881052973703, 4828.37231159947, 5239.29269548606, 5241.161414173714, 5261.263423120766, 5288.762005709752, 5292.285541451932, 5008.899822003539, 5009.273655320031, 5054.368203974504, 5057.747112644353, 5064.873378165576, 5048.72232027242, 5134.127198376285, 5151.2530683050745, 5188.818391356284, 5190.0, 5144.897102057937, 5162.225666150108, 5164.070467315844, 5168.043911876315, 5175.948240517622, 5147.047796157723, 5148.227765835155, 5152.330197074431, 5152.793888244429, 5177.508136727005, 4274.20927128476, 4304.677149213821, 4307.935380969288, 4351.086271882877, 4354.216241076637, 3776.7167462440425, 3831.9808400958373, 3844.36567966288, 3848.0572259796527, 3851.2105018471148, 4371.934420983688, 4382.758948257812, 4425.203463376559, 4428.31361139024, 4472.195004899084, 5194.870128246748, 5201.687898726089, 5203.635745497854, 5203.739813009334, 5263.105272103751, 4420.115976804587, 4430.689851710349, 4432.867013989586, 4437.711548749321, 4440.156370289635, 4558.247889098328, 4613.700109492872, 4662.137504561667, 4662.487126416091, 4677.859664210079, 4826.0, 4829.227323628203, 4834.299026641117, 4835.6131509478455, 4879.756012199376, 5032.043911656773, 5109.437961824122, 5147.9227811582105, 5158.071547121554, 5161.741912904415, 4747.145513807548, 4793.9280910787065, 4806.47128815823, 4820.8794780130775, 4824.517548245148, 5045.344105266292, 5068.9239661405845, 5073.2897394365555, 5073.755147884687, 5126.923096153635, 4952.257161425815, 5126.333576635014, 5137.049645815536, 5157.200633901752, 5161.522469214723, 4944.950550494449, 4990.451050384382, 5011.0, 5012.824551140692, 5057.671251368649, 4996.850094497171, 5008.674436161784, 5013.222950442687, 5038.7984480621835, 5058.7976480941825, 4735.455422626442, 4887.169181239126, 4954.133026720381, 4957.3059771632725, 5021.246812978083, 5003.174476211384, 5017.57350625201, 5027.622928280321, 5029.723365214948, 5071.797128114834, 4917.311576379381, 4923.729194894315, 4924.901501970012, 4929.950700492949, 4962.404511458503], "value": 4717.416119229933, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.6195567991605, 577.3908526504538, 589.0722112672541, 592.6414519215874, 595.2172892646171, 30959.690403095963, 31304.686953130462, 31387.372252554964, 31411.214719632022, 39909.8004509977, 36305.0, 39720.0, 39734.20531589366, 39886.40170397439, 39980.60019399805, 7963.044434667833, 8113.269805717484, 8118.0, 8122.756317310461, 8124.0, 7691.615419229044, 7769.223077692242, 7770.0, 7770.689172433096, 7774.572398518079, 8024.799380015488, 8072.031356237259, 8072.313853322475, 8086.070101938264, 8101.716439924604, 8001.8799718004275, 8034.035915690096, 8041.678332866678, 8047.356211503065, 8050.235227653364, 7925.405594580429, 7999.640016199285, 8001.239727259994, 8005.519668819831, 8007.279344858933, 38389.424158637645, 38616.80691596552, 38761.224775504335, 38788.0, 38799.41800872989, 3252.642209356969, 3315.8673653053847, 3712.3316309768943, 3787.1478917243676, 3930.3121953658283, 28386.432271354457, 28757.856210719023, 30273.243168920733, 30784.846075769703, 31605.20986975321, 3203.8077715337154, 3289.555909952174, 3343.7157841583494, 3385.086026772782, 3389.2882494676146, 263005.0, 263066.0, 265110.0, 265512.0, 265562.0, 33155.83422082874, 33883.0, 56272.43727562672, 56929.430705693245, 57048.42951570514, 34357.65642343595, 34923.65076349255, 34938.47592286118, 34949.0, 34994.125146871025, 12851.293178875065, 12951.352432378344, 12972.610821675366, 12975.416106275052, 12976.740465190833, 10596.947015265028, 10615.097716694014, 10621.468926553796, 10625.149988000941, 10625.46872656364, 8018.957535520345, 8100.594970251464, 8138.593070346459, 8190.8771368429525, 8227.42408031444, 3220.710136087763, 3270.6238782539835, 3271.7709760316548, 3278.541004259406, 3300.950485742716, 772.4515593928373, 806.8063664720424, 857.5155037403847, 861.1818772166467, 866.7313132928687, 28217.858910705316, 28398.0, 28743.425131497253, 28755.56866647002, 28894.133176004754, 964.4020707161465, 998.5955687946393, 1025.7640742629237, 1051.453244312953, 1098.4946924414699, 14545.636359090895, 14808.777868331983, 15011.24943752808, 15013.624659383384, 15213.695726085416, 389012.0, 389057.0, 391027.0, 392171.0, 393795.0, 48665.75667121642, 49282.507174928505, 49377.50622493729, 49456.0, 49549.0, 1080.0819303591884, 1186.8399512886463, 1221.4808706299787, 1222.0406980520427, 1223.7736018836545, 28482.57276140901, 28896.42207155803, 29406.264843379086, 29838.254043648216, 30035.249118772204, 42099.7895010523, 42513.5748642522, 42520.36219456772, 42559.787201063795, 42620.57379426166, 296619.0, 296944.0, 298544.0, 299313.0, 299520.0, 22484.437889052904, 22706.659400109344, 25708.0, 25914.0, 25961.40385961389, 42251.7887410561, 42433.78783106065, 42653.0, 43348.13303733971, 43593.55080614923, 36996.44505332476, 37177.6282237185, 37320.253594928494, 37406.812965936086, 37557.248855023296, 36419.27161456809, 36653.45019824758, 37118.628813712596, 37300.81349593234, 37437.62562374341, 35855.0, 36081.45877811783, 36194.0, 36666.45000325051, 37023.44464832976, 32453.51319730159, 32564.29257036032, 32856.34287314288, 33165.33669326648, 33589.3282134351, 25354.746452535976, 25410.618840717034, 25441.236762897144, 25915.740842591335, 27462.725372746016], "value": 16554.797698838767, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.40949794846694, 375.2008222486104, 376.918962423079, 378.56843198753427, 384.250711113329, 13035.54375596853, 17553.29786808526, 17605.29578816849, 18436.07819609021, 19423.611527769437, 14537.0, 15576.0, 17055.74416383752, 17154.82845171548, 17251.482455526322, 5161.793528258874, 6686.130802995628, 7034.366906978371, 7049.330313620198, 7142.4286057115305, 4118.094019315746, 6623.635700036521, 7022.683979220922, 7057.117860267466, 7061.858762824741, 6879.759208427706, 7089.5037347385705, 7166.247544007882, 7167.462440316971, 7168.892466613005, 7140.357367836919, 7148.606826624534, 7155.105611798525, 7195.784126476162, 7195.8201044973775, 6498.707558159894, 6620.768273110466, 6628.0, 6630.469562434993, 6636.104125942984, 23726.864582187514, 23851.403714907094, 23854.761452385428, 24897.751022489905, 24980.0, 1955.9119839607251, 2061.371281759063, 2075.4858183451083, 2423.151896836111, 2537.238828351487, 13928.30358482082, 14831.258437078212, 15239.542813715607, 15373.308201130863, 15470.226488675522, 1818.9363372281907, 1846.538365408648, 1881.1252767463059, 1888.0465364990591, 1919.7792253890702, 79156.60421697855, 79503.6024819878, 79911.0, 82377.0, 83339.58330208431, 14432.927835360966, 14680.522440655703, 16629.0, 17276.913615432095, 17314.65370692579, 29448.11655650334, 29664.555031674543, 29679.258018549277, 29724.0, 29867.25331866677, 9253.953730231306, 9260.583273752698, 9294.628214871465, 9332.626694932127, 9424.858627120599, 7692.692292308245, 7763.456558040883, 7884.881726774103, 7907.406944479072, 7966.920330796618, 8461.196186362286, 8487.702930397407, 8586.356023298278, 8678.39251252419, 8740.562971851383, 3121.1048511741355, 3148.622165340174, 3224.5808044954006, 3241.62721287055, 3373.9325213495595, 833.924946754795, 881.4490943160524, 916.1159481100769, 929.8605209218535, 936.6955739384728, 16816.411425600047, 17481.125943702766, 17487.387941422243, 17917.222830461298, 17924.551886202687, 826.6156237349661, 829.3323874281141, 844.8986121665439, 864.883240762489, 890.8218356328761, 7271.709131634675, 9480.762980925394, 9690.12788849007, 9815.214782817358, 9900.207983361313, 411814.0, 412725.42735576973, 413790.0, 417424.1287935591, 418462.0, 82766.58616706877, 85803.57098214593, 85845.570772147, 86157.56921215479, 86212.56893715616, 926.7127190570944, 928.758522784081, 929.2287401456774, 950.7623094226443, 955.5938726041544, 12457.750844983231, 15604.0, 16047.395260473859, 16505.33978640841, 16798.748018779483, 28263.15210543687, 39011.02472438098, 40599.797001015984, 40709.38935916023, 40777.59222407738, 51657.483425165265, 52312.738436307576, 53941.460585393645, 54400.18399724086, 54495.18257226224, 7597.240275972358, 7655.2344765523, 7709.4603377763015, 7775.883361749691, 7792.766217013499, 11123.66516018083, 11519.30884146954, 11782.11634127461, 11960.76078478443, 12089.516419343128, 9360.906390936003, 9413.199878010446, 10001.099901008944, 10095.394276343442, 10234.181265498593, 10097.394156350643, 10144.54349554257, 10467.685969420929, 10573.365598064142, 10595.09941654968, 10280.948595256976, 10833.51249193804, 10850.240483166102, 11070.501827417624, 11098.61154859576, 7243.311885370881, 7397.445191610543, 7443.18125006238, 7549.622518874145, 7709.267619576131, 8383.245507904317, 9156.816863662823, 9484.478353690612, 9535.713928582154, 9811.411315321104], "value": 9495.14837134319, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1305.9020573456994, 1361.3329468560407, 1396.197186617695, 1661.2524364036187, 1678.6978343898093, 7554.093508778948, 8019.719309824157, 8094.352451803857, 8118.837623247531, 8123.390745694074, 6958.199807022182, 7207.963960180192, 7210.639468026604, 7391.852162956738, 7907.841843163148, 1946.0950657944018, 2182.1162429216192, 2259.559385919746, 2261.4233370490583, 2272.4773302140516, 2217.268301460514, 2219.911203551856, 2243.7083179186684, 2243.9775602244013, 2244.7867452591977, 1893.4698284480367, 2223.83321250906, 2230.531588366445, 2231.8549294295817, 2236.194969810875, 2164.2425151197112, 2251.268337790225, 2251.3020963501367, 2259.412552736284, 2263.6151854184827, 2128.4785227619177, 2170.6201414752354, 2178.4771654802894, 2187.5406164705432, 2192.8355373347063, 7899.88150177742, 7952.8409431811615, 7957.522548647042, 7957.5225486471, 7961.880571791427, 4460.710053846489, 4512.481064677571, 4561.817527298904, 4562.292844609091, 4595.977020114878, 2788.0799336218997, 2891.031504446013, 2935.5156399194107, 2955.733983941456, 2956.807807492506, 932.4871320773548, 957.1242313283337, 964.4550828781786, 977.6089564174316, 978.8287049766334, 10913.781724365548, 10923.672289831318, 10925.235233533656, 10925.289856159325, 10926.125909927187, 4089.3048181809163, 4253.659707223414, 4317.287647538121, 4359.062801497693, 4361.105973275471, 9272.860907086399, 9292.163705266423, 9311.208547273422, 9319.627214911328, 9320.067993200626, 4512.909741805145, 4526.547345265513, 4529.84145554904, 4534.387857639176, 4535.433070866142, 4113.958860411418, 4144.79276036197, 4145.7719825409895, 4148.79256037197, 4152.5432202457705, 3697.7226707997006, 3718.5537735471376, 3745.569259535134, 3769.1707824278615, 3784.035071056918, 1179.2511755035614, 1181.2794195540714, 1198.7662405830954, 1201.3572738584814, 1228.2200802490304, 688.5042769206163, 762.1540090499541, 769.638270013093, 795.7851380127333, 811.3671336357651, 4921.9507804922205, 5074.13739664258, 5133.666311689728, 5139.563137133386, 5165.302684137593, 412.03994692367314, 413.8799748073025, 419.6663652396291, 428.57356929854996, 429.39455367931066, 3444.534987776668, 3446.9310613788084, 3452.671996160361, 3532.7880327179937, 3537.3102245061964, 9437.764055898657, 9797.265205109503, 9827.901720982842, 9938.403695778277, 9949.950250248847, 9922.503874806374, 9985.251106167067, 10008.149307308815, 10033.949830250802, 10048.447335396624, 7298.2701729826595, 7383.114026316876, 7450.701971921062, 7504.6247687615405, 7527.887081693779, 4952.628552858478, 4975.129352363394, 4998.850034498971, 5020.096382651158, 5064.7467626619255, 8909.198172164537, 9139.086091390807, 9249.768755781159, 9271.814563708553, 9284.0, 9227.907720922705, 9414.62341506332, 9480.668176613786, 9513.66702165421, 9625.278104142077, 6331.240251169889, 6568.868622627616, 6575.0, 6700.229473610402, 6704.497162712719, 7113.253108423748, 7331.523450975669, 7332.156801967842, 7520.398368130427, 7522.924770752223, 6519.185101862267, 6716.429103526255, 6756.493263005196, 6762.256151823197, 6840.213375461686, 6562.179727534059, 6570.8357291068105, 6637.867242655217, 6656.800295991128, 6798.898016529657, 5751.309842818889, 5789.594728369142, 5827.067669173081, 5840.94159058404, 5952.642841429528, 4306.354046892991, 4339.587739164775, 4422.0, 4425.026494171278, 4453.643708503248, 4385.2983522637505, 4430.756308403069, 4458.71018383804, 4499.617532509773, 4500.234960056864], "value": 4048.705648204603, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.8905410471073, 297.57446851003056, 300.29430837531805, 303.44015291786656, 306.4132186862159, 4900.313956046148, 4902.3872015998, 4902.926456103157, 4908.533689299516, 4909.5581397674205, 4868.58617017553, 4870.41555013398, 4871.171900776868, 4900.779464924078, 4900.87747806305, 3625.528681271431, 3733.663970242678, 3780.1683629601443, 3849.0569810396423, 3882.7087968402343, 3855.15186658936, 3858.9035274118232, 3862.4592557041897, 3863.9806800965957, 3883.922321553567, 3854.402567602026, 3863.613638636128, 3870.3033453978273, 3876.8061596920184, 3879.515060617423, 3647.215848592552, 3717.9999999999864, 3811.6188381161937, 3825.827837747308, 3841.5774264830848, 3383.5450756174837, 3384.170878134848, 3387.0, 3394.6605339466105, 3399.4390925497264, 4719.150552900476, 4730.668853180278, 4750.738709370983, 4762.976185119087, 4764.928526072112, 4228.8283787159635, 4371.27873900806, 4383.956160438387, 4419.315006174048, 4425.933610995838, 5062.848114556569, 5074.82238121664, 5088.160453525201, 5088.516590923857, 5100.897982040376, 3678.779273243614, 3686.7234957378305, 3687.870924517656, 3694.2796154749567, 3717.925641487155, 5104.157813960692, 5310.256564081032, 5334.626091389333, 5344.278522399465, 5349.679019258857, 3743.5320584926885, 3750.6497660842074, 3775.7356985011334, 3778.414345776354, 3784.6913382836447, 3798.6771124454176, 3805.752626079296, 3814.7138964577766, 3815.313243616176, 3826.885193444201, 4337.436133302651, 4345.435093437896, 4347.956520434818, 4361.781910904506, 4363.734516990037, 4848.884756506023, 5117.897642047138, 5122.770535071556, 5126.564242039394, 5153.665011774223, 1285.929273889945, 1291.1736488647273, 1296.2805642868298, 1297.6366617347157, 1298.214580178997, 817.791463176886, 849.9362547808939, 881.713443130985, 892.7009451833578, 898.905614910425, 4416.6245869101485, 4429.55704429561, 4441.422615060086, 4451.221036318631, 4473.4408198975125, 5156.535911767959, 5186.533212010937, 5189.818356357585, 5209.671533758868, 5210.426853046162, 4284.293091639907, 4418.138462999685, 4429.53489883564, 4457.153140903218, 4461.687681862239, 2738.87675054623, 2743.6570428696414, 2774.140016594862, 2778.8054836161677, 2780.360517081083, 4853.878653033702, 4859.060268537554, 4864.78108485119, 4868.367112275381, 4882.36529251195, 5008.223725322581, 5254.789808407697, 5256.6057545684225, 5268.0, 5378.757955891994, 4881.609471242363, 4911.140550403594, 4921.753912304371, 4938.58022068121, 4941.678790878509, 5250.632455728215, 5253.290805741176, 5254.65844720092, 5265.315508983807, 5265.868353291198, 4964.900701986012, 5104.9489505104475, 5132.486751324837, 5138.3577052868395, 5172.612054095883, 4809.639277054165, 4852.660313778143, 4875.463698993179, 4880.438749543848, 4908.803647854189, 3711.7216208783907, 3720.572134204493, 3721.976456474491, 3725.515682961198, 3729.5151630287887, 4964.429090654477, 5222.738863056756, 5244.449332819999, 5254.89490210186, 5255.869987952608, 4998.975005124951, 5001.449840517467, 5003.499650034967, 5025.919427323143, 5031.22016087507, 5004.374453193351, 5009.7996080157845, 5077.365329333833, 5078.923816142835, 5082.593392528663, 4775.450823155382, 4891.19295316283, 4947.18371468718, 4956.6530342877095, 5060.595152387874, 4960.156773348467, 5129.58963282929, 5151.381834179922, 5173.741312934413, 5198.16829307309, 4993.350864387607, 4993.900121997467, 5041.117804384291, 5071.239314102914, 5079.009593129452], "value": 3840.0019753039164, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [633.2148136310976, 640.4044238857862, 648.847520832604, 694.4930200953304, 727.9344858962694, 12812.67968300793, 13707.177569345822, 13707.725845483084, 13746.31268436578, 13748.243846588446, 13781.104228225158, 14308.642283942907, 14317.498887538939, 14496.0, 14538.709225815477, 777.0364747712823, 786.4455558831011, 790.9090454597708, 793.6269953122023, 795.085651500773, 640.5324113397223, 762.6758627583283, 786.7167819584945, 792.2790260862587, 793.3375631347832, 821.5112008355019, 821.7247222180577, 822.5311572403732, 823.5923218007065, 823.5964377455034, 663.1180529895228, 819.2667562531501, 819.4755356571799, 820.5035953248318, 821.4988856797349, 592.7421571616361, 609.2414943395456, 610.2432983100967, 612.1552257884091, 613.895637741585, 13074.934625326812, 13079.738405231938, 13094.0, 13097.738045239137, 13099.803502947463, 11736.53053877844, 11918.88081119195, 11937.34344611046, 12489.75020499594, 12674.429650665743, 11447.313161210353, 11555.595554155649, 11626.186166968315, 11683.357415342152, 11725.941370293094, 3845.86629184922, 3922.8626998055215, 3925.568187499373, 3991.3214753491975, 4014.1770936957855, 61101.0, 61149.694251528905, 61963.0, 62060.68969655123, 62264.0, 9517.714468565953, 9668.661596844076, 9746.415215087118, 9840.704778856645, 9955.900440995641, 17841.28634854617, 17857.196426160855, 17866.642667146585, 17921.551961200814, 17940.19269132892, 6460.192859419851, 6513.8697226056165, 6530.118434011442, 6545.639989800607, 6615.4376877965915, 3712.9071773205346, 3715.7398982070995, 3754.3992961126087, 3798.2973149967343, 3834.5206849143856, 2826.23691603266, 2921.649402071765, 2943.808652437585, 2943.9411211776073, 2946.6022087017977, 500.83472454090065, 506.4150905703918, 518.142474205191, 518.5903136522105, 519.7037688517509, 459.2514201851028, 509.84194899581246, 512.0271484180088, 517.2138349708422, 521.5801279969585, 6394.1687580614225, 6460.515461340418, 6482.546221764525, 6557.884385965837, 6569.770058048041, 459.7103824590553, 481.35738788716753, 481.5040508276481, 499.57286520024854, 509.2895410901845, 3352.5641666583188, 3567.0, 3617.986963650182, 3626.601073881871, 3700.611435799256, 51588.0, 52673.2099018515, 76008.61995689986, 78817.211827881, 79276.0, 78358.0, 78994.6050269745, 79231.0, 82645.0, 83162.0, 73949.6302518484, 74626.62686686532, 75892.0, 76117.61941190259, 77641.61179194068, 8655.30757539408, 8708.738737837875, 8731.869021964803, 8869.556522173994, 8905.376623636283, 33766.49350259699, 43937.34093988657, 45447.77276113598, 46082.30876536922, 46199.53800462087, 58312.4168758307, 62112.378876210656, 62482.687586563596, 63879.680601596694, 64749.35250647433, 11401.486933087865, 11494.482748276514, 11501.654950351503, 11648.825267620823, 12051.397430128634, 11357.829632555684, 12434.937825311177, 12743.980481561639, 13033.348332583522, 13231.66920826987, 11288.717782055513, 11820.172587918763, 12111.454984525893, 12370.257784532956, 12413.255204687748, 10618.59145990775, 11072.335659860435, 11082.61210857616, 11450.828237576276, 11452.255603385753, 10277.0, 11122.499487523242, 11132.833007504732, 11405.942970285096, 11486.13853960973, 10007.949960250153, 10063.69808905734, 10439.0, 10552.157034937913, 10833.51249193804, 9891.604335826487, 10149.441780702133, 10476.63331783384, 10500.264981451224, 10509.211809114195], "value": 6412.279023853589, "unit": "score"}], "name": "dromaeo_css", "value": 6478.482593215764, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 116.0, 115.0, 114.0, 114.0, 115.0, 114.0, 114.0, 115.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 120.0, 124.0, 178.0, 124.0, 127.0, 144.0, 122.0, 158.0, 122.0], "value": 136.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 160.0, 160.0, 160.0, 160.0, 159.0, 161.0, 162.0, 162.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 77.0, 76.0, 116.0, 77.0, 77.0, 74.0, 75.0, 102.0, 77.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 112.0, 84.0, 84.0, 84.0, 128.0, 85.0, 86.0, 124.0], "value": 95.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 118.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 63.0, 63.0, 64.0, 63.0, 66.0, 65.0, 63.0], "value": 63.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 78.0, 78.0, 78.0, 85.0, 78.0, 84.0, 79.0, 84.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 137.0, 134.0, 140.0, 130.0, 131.0, 131.0, 131.0, 208.0, 134.0], "value": 140.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 174.0, 171.0, 177.0, 168.0, 172.0, 170.0, 170.0, 168.0, 168.0], "value": 171.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 67.0, 70.0, 67.0, 69.0, 67.0, 67.0, 71.0, 66.0, 65.0], "value": 68.1, "unit": "score"}], "name": "kraken", "value": 1537.1000000000001, "alertThreshold": 2.0}]} 05:41:56 INFO - Return code: 0 05:41:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:41:56 INFO - # TBPL SUCCESS # 05:41:56 INFO - Running post-action listener: _resource_record_post_action 05:41:56 INFO - ##### 05:41:56 INFO - ##### Finished run-tests step (success) 05:41:56 INFO - ##### 05:41:56 INFO - Running post-run listener: _resource_record_post_run 05:41:56 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 534806528; Read time: 20; Write time: 438540 05:41:56 INFO - TinderboxPrint: CPU usage
13.0% 05:41:56 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 05:41:56 INFO - TinderboxPrint: I/O write bytes / time
534,806,528 / 438,540 05:41:56 INFO - TinderboxPrint: CPU idle
8,335.4 (87.0%) 05:41:56 INFO - TinderboxPrint: CPU user
1,199.9 (12.5%) 05:41:56 INFO - TinderboxPrint: Swap in / out
0 / 0 05:41:56 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246190080; Read time: 0; Write time: 257956 05:41:56 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 288616448; Read time: 0; Write time: 180584 05:41:57 INFO - Running post-run listener: _upload_blobber_files 05:41:57 INFO - Blob upload gear active. 05:41:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:41:57 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 05:41:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:41:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:41:57 INFO - (blobuploader) - INFO - Open directory for files ... 05:41:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:41:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:41:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:41:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:41:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:41:58 INFO - (blobuploader) - INFO - Done attempting. 05:41:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:41:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:41:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:42:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:42:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:42:02 INFO - (blobuploader) - INFO - Done attempting. 05:42:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:42:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:42:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:42:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:42:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:42:06 INFO - (blobuploader) - INFO - Done attempting. 05:42:06 INFO - (blobuploader) - INFO - Iteration through files over. 05:42:06 INFO - Return code: 0 05:42:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:42:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:42:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cd29efb32609164a4c39445b3101d7fd068720c13b5cd1eef2f6c7696708db2ab00147efe1b864898aeb3e8391f98c70854fea9d0d191b296b071104b5d9279b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/498346ca39622d9ec40206cfcb37b6ff9f23d55d2362d950e6417504cd439bef52bb1ac347951da9dcfd28ba9c1449025249cedaa094d914634a6d1af6ac00cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0d29e8303e8bfe9cadbcaf8ae21d669ad69c42305e1c158cf2699b682edbe43e0d568e73144a7f98612223de7318ea67c3556b9955af8a704c9fb80223844cc0"} 05:42:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:42:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:42:06 INFO - Contents: 05:42:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cd29efb32609164a4c39445b3101d7fd068720c13b5cd1eef2f6c7696708db2ab00147efe1b864898aeb3e8391f98c70854fea9d0d191b296b071104b5d9279b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/498346ca39622d9ec40206cfcb37b6ff9f23d55d2362d950e6417504cd439bef52bb1ac347951da9dcfd28ba9c1449025249cedaa094d914634a6d1af6ac00cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0d29e8303e8bfe9cadbcaf8ae21d669ad69c42305e1c158cf2699b682edbe43e0d568e73144a7f98612223de7318ea67c3556b9955af8a704c9fb80223844cc0"} 05:42:06 INFO - Running post-run listener: copy_logs_to_upload_dir 05:42:06 INFO - Copying logs to upload dir... 05:42:06 INFO - mkdir: /builds/slave/test/build/upload/logs 05:42:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.100175 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-06-30 05:42:06.044942) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 05:42:06.048992) ========= 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=4300f881736b422476174874000001bc-1467288796.216613-75457196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cd29efb32609164a4c39445b3101d7fd068720c13b5cd1eef2f6c7696708db2ab00147efe1b864898aeb3e8391f98c70854fea9d0d191b296b071104b5d9279b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/498346ca39622d9ec40206cfcb37b6ff9f23d55d2362d950e6417504cd439bef52bb1ac347951da9dcfd28ba9c1449025249cedaa094d914634a6d1af6ac00cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0d29e8303e8bfe9cadbcaf8ae21d669ad69c42305e1c158cf2699b682edbe43e0d568e73144a7f98612223de7318ea67c3556b9955af8a704c9fb80223844cc0"} build_url:https://queue.taskcluster.net/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011323 build_url: 'https://queue.taskcluster.net/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cd29efb32609164a4c39445b3101d7fd068720c13b5cd1eef2f6c7696708db2ab00147efe1b864898aeb3e8391f98c70854fea9d0d191b296b071104b5d9279b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/498346ca39622d9ec40206cfcb37b6ff9f23d55d2362d950e6417504cd439bef52bb1ac347951da9dcfd28ba9c1449025249cedaa094d914634a6d1af6ac00cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0d29e8303e8bfe9cadbcaf8ae21d669ad69c42305e1c158cf2699b682edbe43e0d568e73144a7f98612223de7318ea67c3556b9955af8a704c9fb80223844cc0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 05:42:06.075932) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:42:06.076332) ========= 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=4300f881736b422476174874000001bc-1467288796.216613-75457196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004342 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:42:06.162676) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 05:42:06.163050) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 05:42:06.163462) ========= ========= Total master_lag: 0.18 =========