builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-032 starttime: 1467223353.92 results: success (0) buildid: 20160629083023 builduid: b76d946d6787438099458f7a41084178 revision: eeb6862f960c1310bde9aed159f3fc5bb2d4b6d7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 11:02:33.915430) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 11:02:33.915943) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 11:02:33.916272) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 11:02:33.932277) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 11:02:33.932568) ========= 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=745a4373a2a16df560f216e000000264-1467223353.339480-25359402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-29 11:02:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2016-06-29 11:02:34 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129024 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 11:02:34.075776) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 11:02:34.076095) ========= 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=745a4373a2a16df560f216e000000264-1467223353.339480-25359402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019986 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 11:02:34.125475) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 11:02:34.125794) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev eeb6862f960c1310bde9aed159f3fc5bb2d4b6d7 --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 eeb6862f960c1310bde9aed159f3fc5bb2d4b6d7 --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=745a4373a2a16df560f216e000000264-1467223353.339480-25359402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-29 11:02:34,635 truncating revision to first 12 chars 2016-06-29 11:02:34,635 Setting DEBUG logging. 2016-06-29 11:02:34,635 attempt 1/10 2016-06-29 11:02:34,635 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/eeb6862f960c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-29 11:02:34,954 unpacking tar archive at: fx-team-eeb6862f960c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.649673 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 11:02:34.789058) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 11:02:34.789428) ========= script_repo_revision: eeb6862f960c1310bde9aed159f3fc5bb2d4b6d7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 11:02:34.789825) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 11:02:34.790138) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 11:02:34.802126) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-06-29 11:02:34.802392) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1467223353.339480-25359402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:02:35 INFO - MultiFileLogger online at 20160629 11:02:35 in /builds/slave/test 11:02:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:02:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:02:35 INFO - {'append_to_log': False, 11:02:35 INFO - 'base_work_dir': '/builds/slave/test', 11:02:35 INFO - 'blob_upload_branch': 'Fx-Team', 11:02:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:02:35 INFO - 'branch': 'Fx-Team', 11:02:35 INFO - 'buildbot_json_path': 'buildprops.json', 11:02:35 INFO - 'config_files': ('talos/linux_config.py',), 11:02:35 INFO - 'default_actions': ('clobber', 11:02:35 INFO - 'read-buildbot-config', 11:02:35 INFO - 'download-and-extract', 11:02:35 INFO - 'populate-webroot', 11:02:35 INFO - 'create-virtualenv', 11:02:35 INFO - 'install', 11:02:35 INFO - 'run-tests'), 11:02:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:02:35 INFO - 'download_minidump_stackwalk': True, 11:02:35 INFO - 'download_symbols': 'ondemand', 11:02:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:02:35 INFO - 'tooltool.py': '/tools/tooltool.py', 11:02:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:02:35 INFO - '/tools/misc-python/virtualenv.py')}, 11:02:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:02:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:02:35 INFO - 'installer_path': 'installer.exe', 11:02:35 INFO - 'log_level': 'info', 11:02:35 INFO - 'log_name': 'talos', 11:02:35 INFO - 'log_to_console': True, 11:02:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:02:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:02:35 INFO - 'opt_config_files': (), 11:02:35 INFO - 'pip_index': False, 11:02:35 INFO - 'sps_profile': False, 11:02:35 INFO - 'sps_profile_interval': 0, 11:02:35 INFO - 'suite': 'dromaeojs-e10s', 11:02:35 INFO - 'system_bits': '32', 11:02:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:02:35 INFO - 'title': 'talos-linux64-ix-032', 11:02:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:02:35 INFO - 'use_talos_json': True, 11:02:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:02:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:02:35 INFO - 'work_dir': 'build'} 11:02:35 INFO - ##### 11:02:35 INFO - ##### Running clobber step. 11:02:35 INFO - ##### 11:02:35 INFO - Running pre-action listener: _resource_record_pre_action 11:02:35 INFO - Running main action method: clobber 11:02:35 INFO - rmtree: /builds/slave/test/build 11:02:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:02:35 INFO - Running post-action listener: _resource_record_post_action 11:02:35 INFO - ##### 11:02:35 INFO - ##### Finished clobber step (success) 11:02:35 INFO - ##### 11:02:35 INFO - ##### 11:02:35 INFO - ##### Running read-buildbot-config step. 11:02:35 INFO - ##### 11:02:35 INFO - Running pre-action listener: _resource_record_pre_action 11:02:35 INFO - Running main action method: read_buildbot_config 11:02:35 INFO - Using buildbot properties: 11:02:35 INFO - { 11:02:35 INFO - "project": "", 11:02:35 INFO - "product": "firefox", 11:02:35 INFO - "script_repo_revision": "production", 11:02:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:02:35 INFO - "repository": "", 11:02:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 11:02:35 INFO - "buildid": "20160629083023", 11:02:35 INFO - "pgo_build": "True", 11:02:35 INFO - "basedir": "/builds/slave/test", 11:02:35 INFO - "buildnumber": 879, 11:02:35 INFO - "slavename": "talos-linux64-ix-032", 11:02:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:02:35 INFO - "platform": "ubuntu64_hw", 11:02:35 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:02:35 INFO - "branch": "fx-team", 11:02:35 INFO - "repo_path": "integration/fx-team", 11:02:35 INFO - "revision": "eeb6862f960c1310bde9aed159f3fc5bb2d4b6d7", 11:02:35 INFO - "stage_platform": "linux64-pgo", 11:02:35 INFO - "builduid": "b76d946d6787438099458f7a41084178", 11:02:35 INFO - "slavebuilddir": "test" 11:02:35 INFO - } 11:02:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/edElhXcdSVqAWMyG-E7syw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 11:02:35 INFO - Running post-action listener: _resource_record_post_action 11:02:35 INFO - ##### 11:02:35 INFO - ##### Finished read-buildbot-config step (success) 11:02:35 INFO - ##### 11:02:35 INFO - ##### 11:02:35 INFO - ##### Running download-and-extract step. 11:02:35 INFO - ##### 11:02:35 INFO - Running pre-action listener: _resource_record_pre_action 11:02:35 INFO - Running main action method: download_and_extract 11:02:35 INFO - mkdir: /builds/slave/test/build/tests 11:02:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:02:35 INFO - https://queue.taskcluster.net/v1/task/edElhXcdSVqAWMyG-E7syw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:02:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/edElhXcdSVqAWMyG-E7syw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:02:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/edElhXcdSVqAWMyG-E7syw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:02:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/edElhXcdSVqAWMyG-E7syw/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 11:02:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/edElhXcdSVqAWMyG-E7syw/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 11:02:36 INFO - Downloaded 1361 bytes. 11:02:36 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:02:36 INFO - Using the following test package requirements: 11:02:36 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:02:36 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:02:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:02:36 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:02:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:02:36 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:02:36 INFO - u'jsshell-linux-x86_64.zip'], 11:02:36 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:02:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:02:36 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:02:36 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:02:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:02:36 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:02:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:02:36 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:02:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:02:36 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:02:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:02:36 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:02:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:02:36 INFO - https://queue.taskcluster.net/v1/task/edElhXcdSVqAWMyG-E7syw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:02:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/edElhXcdSVqAWMyG-E7syw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:02:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/edElhXcdSVqAWMyG-E7syw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:02:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/edElhXcdSVqAWMyG-E7syw/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 11:02:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/edElhXcdSVqAWMyG-E7syw/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 11:02:37 INFO - Downloaded 24268166 bytes. 11:02:37 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'] 11:02:37 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 11:02:39 INFO - Return code: 0 11:02:39 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 11:02:39 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')]} 11:02:39 INFO - https://queue.taskcluster.net/v1/task/edElhXcdSVqAWMyG-E7syw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:02:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/edElhXcdSVqAWMyG-E7syw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:02:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/edElhXcdSVqAWMyG-E7syw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:02:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/edElhXcdSVqAWMyG-E7syw/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 11:02:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/edElhXcdSVqAWMyG-E7syw/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 11:02:40 INFO - Downloaded 24268166 bytes. 11:02:40 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'] 11:02:40 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 11:02:41 INFO - Return code: 0 11:02:41 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')]} 11:02:41 INFO - https://queue.taskcluster.net/v1/task/edElhXcdSVqAWMyG-E7syw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:02:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/edElhXcdSVqAWMyG-E7syw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:02:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/edElhXcdSVqAWMyG-E7syw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:02:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/edElhXcdSVqAWMyG-E7syw/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 11:02:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/edElhXcdSVqAWMyG-E7syw/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 11:02:42 INFO - Downloaded 14405245 bytes. 11:02:42 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'] 11:02:42 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 11:02:42 INFO - Return code: 0 11:02: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')]} 11:02:42 INFO - https://queue.taskcluster.net/v1/task/edElhXcdSVqAWMyG-E7syw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:02:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/edElhXcdSVqAWMyG-E7syw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:02:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/edElhXcdSVqAWMyG-E7syw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:02:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/edElhXcdSVqAWMyG-E7syw/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 11:02:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/edElhXcdSVqAWMyG-E7syw/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 11:02:45 INFO - Downloaded 60338855 bytes. 11:02:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/edElhXcdSVqAWMyG-E7syw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:02:45 INFO - mkdir: /builds/slave/test/properties 11:02:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:02:45 INFO - Writing to file /builds/slave/test/properties/build_url 11:02:45 INFO - Contents: 11:02:45 INFO - build_url:https://queue.taskcluster.net/v1/task/edElhXcdSVqAWMyG-E7syw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:02:46 INFO - Running post-action listener: _resource_record_post_action 11:02:46 INFO - Running post-action listener: set_extra_try_arguments 11:02:46 INFO - ##### 11:02:46 INFO - ##### Finished download-and-extract step (success) 11:02:46 INFO - ##### 11:02:46 INFO - ##### 11:02:46 INFO - ##### Running populate-webroot step. 11:02:46 INFO - ##### 11:02:46 INFO - Running pre-action listener: _resource_record_pre_action 11:02:46 INFO - Running main action method: populate_webroot 11:02:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:02:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:02:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:02:46 INFO - '--tppagecycles', 11:02:46 INFO - '7'], 11:02:46 INFO - 'tests': ['tsvgm']}}, 11:02:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:02:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:02:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:02:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:02:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:02:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:02:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:02:46 INFO - 'talos_options': ['--disable-e10s'], 11:02:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:02:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:02:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:02:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:02:46 INFO - 'talos_options': ['--disable-e10s'], 11:02:46 INFO - 'tests': ['damp', 'tps']}, 11:02:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:02:46 INFO - 'tests': ['damp', 'tps']}, 11:02:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:02:46 INFO - 'tests': ['dromaeo_dom']}, 11:02:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:02:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:02:46 INFO - 'tests': ['basic_compositor_video']}, 11:02:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:02:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:02:46 INFO - 'tests': ['a11yr', 11:02:46 INFO - 'ts_paint', 11:02:46 INFO - 'tpaint', 11:02:46 INFO - 'sessionrestore', 11:02:46 INFO - 'sessionrestore_no_auto_restore', 11:02:46 INFO - 'tabpaint']}, 11:02:46 INFO - 'other-e10s': {'tests': ['a11yr', 11:02:46 INFO - 'ts_paint', 11:02:46 INFO - 'tpaint', 11:02:46 INFO - 'sessionrestore', 11:02:46 INFO - 'sessionrestore_no_auto_restore', 11:02:46 INFO - 'tabpaint']}, 11:02:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:02:46 INFO - 'ts_paint', 11:02:46 INFO - 'tpaint', 11:02:46 INFO - 'sessionrestore', 11:02:46 INFO - 'sessionrestore_no_auto_restore', 11:02:46 INFO - 'tabpaint']}, 11:02:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:02:46 INFO - 'ts_paint', 11:02:46 INFO - 'tpaint', 11:02:46 INFO - 'sessionrestore', 11:02:46 INFO - 'sessionrestore_no_auto_restore', 11:02:46 INFO - 'tabpaint']}, 11:02:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:02:46 INFO - 'tests': ['a11yr', 11:02:46 INFO - 'ts_paint', 11:02:46 INFO - 'tpaint', 11:02:46 INFO - 'sessionrestore', 11:02:46 INFO - 'sessionrestore_no_auto_restore', 11:02:46 INFO - 'tabpaint']}, 11:02:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:02:46 INFO - 'tests': ['a11yr', 11:02:46 INFO - 'ts_paint', 11:02:46 INFO - 'tpaint', 11:02:46 INFO - 'sessionrestore', 11:02:46 INFO - 'sessionrestore_no_auto_restore', 11:02:46 INFO - 'tabpaint']}, 11:02:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:02:46 INFO - 'tests': ['tsvgx', 11:02:46 INFO - 'tsvgr_opacity', 11:02:46 INFO - 'tart', 11:02:46 INFO - 'tscrollx', 11:02:46 INFO - 'cart']}, 11:02:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:02:46 INFO - 'tsvgr_opacity', 11:02:46 INFO - 'tart', 11:02:46 INFO - 'tscrollx', 11:02:46 INFO - 'cart']}, 11:02:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:02:46 INFO - 'talos_options': ['--disable-e10s'], 11:02:46 INFO - 'tests': ['tp5o']}, 11:02:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:02:46 INFO - 'tests': ['tp5o']}, 11:02:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:02:46 INFO - 'talos_options': ['--disable-e10s', 11:02:46 INFO - '--xperf_path', 11:02:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:02:46 INFO - 'tests': ['tp5n']}, 11:02:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:02:46 INFO - 'talos_options': ['--xperf_path', 11:02:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:02:46 INFO - 'tests': ['tp5n']}}, 11:02:46 INFO - 'talos.zip': {'path': '', 11:02:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:02:46 INFO - Running post-action listener: _resource_record_post_action 11:02:46 INFO - ##### 11:02:46 INFO - ##### Finished populate-webroot step (success) 11:02:46 INFO - ##### 11:02:46 INFO - ##### 11:02:46 INFO - ##### Running create-virtualenv step. 11:02:46 INFO - ##### 11:02:46 INFO - Running pre-action listener: _resource_record_pre_action 11:02:46 INFO - Running main action method: create_virtualenv 11:02:46 INFO - Creating virtualenv /builds/slave/test/build/venv 11:02:46 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 11:02:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:02:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:02:46 INFO - Using real prefix '/usr' 11:02:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:02:47 INFO - Installing distribute.............................................................................................................................................................................................done. 11:02:49 INFO - Installing pip.................done. 11:02:49 INFO - Return code: 0 11:02:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:02:49 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')]} 11:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:49 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')]} 11:02:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:49 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 0x2487030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2748180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27463b0>, '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 0x27472b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2747740>, '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': '745a4373a2a16df560f216e000000264-1467223353.339480-25359402', '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 11:02:49 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 11:02:49 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 11:02:49 INFO - Using env: {'DISPLAY': ':0', 11:02:49 INFO - 'HOME': '/home/cltbld', 11:02:49 INFO - 'LANG': 'en_US.UTF-8', 11:02:49 INFO - 'LANGUAGE': 'en_US:en', 11:02:49 INFO - 'LOGNAME': 'cltbld', 11:02:49 INFO - 'MAIL': '/var/mail/cltbld', 11:02:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:49 INFO - 'MOZ_NO_REMOTE': '1', 11:02:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:49 INFO - 'NO_EM_RESTART': '1', 11:02:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:49 INFO - 'PWD': '/builds/slave/test', 11:02:49 INFO - 'SHELL': '/bin/bash', 11:02:49 INFO - 'SHLVL': '1', 11:02:49 INFO - 'TERM': 'linux', 11:02:49 INFO - 'TMOUT': '86400', 11:02:49 INFO - 'USER': 'cltbld', 11:02:49 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1467223353.339480-25359402', 11:02:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:49 INFO - '_': '/tools/buildbot/bin/python'} 11:02:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:49 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 11:02:49 INFO - Cleaning up... 11:02:49 INFO - Return code: 0 11:02:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:02:49 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')]} 11:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:49 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')]} 11:02:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:49 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 0x2487030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2748180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27463b0>, '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 0x27472b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2747740>, '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': '745a4373a2a16df560f216e000000264-1467223353.339480-25359402', '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 11:02:49 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 11:02:49 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 11:02:49 INFO - Using env: {'DISPLAY': ':0', 11:02:49 INFO - 'HOME': '/home/cltbld', 11:02:49 INFO - 'LANG': 'en_US.UTF-8', 11:02:49 INFO - 'LANGUAGE': 'en_US:en', 11:02:49 INFO - 'LOGNAME': 'cltbld', 11:02:49 INFO - 'MAIL': '/var/mail/cltbld', 11:02:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:49 INFO - 'MOZ_NO_REMOTE': '1', 11:02:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:49 INFO - 'NO_EM_RESTART': '1', 11:02:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:49 INFO - 'PWD': '/builds/slave/test', 11:02:49 INFO - 'SHELL': '/bin/bash', 11:02:49 INFO - 'SHLVL': '1', 11:02:49 INFO - 'TERM': 'linux', 11:02:49 INFO - 'TMOUT': '86400', 11:02:49 INFO - 'USER': 'cltbld', 11:02:49 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1467223353.339480-25359402', 11:02:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:49 INFO - '_': '/tools/buildbot/bin/python'} 11:02:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:49 INFO - Downloading/unpacking psutil>=3.1.1 11:02:49 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 11:02:49 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 11:02:49 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 11:02:49 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 11:02:49 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 11:02:49 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 11:02:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:02:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:02:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:02:51 INFO - Installing collected packages: psutil 11:02:51 INFO - Running setup.py install for psutil 11:02:51 INFO - building 'psutil._psutil_linux' extension 11:02:51 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 11:02:51 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 11:02:51 INFO - building 'psutil._psutil_posix' extension 11:02:51 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 11:02:51 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 11:02:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:02:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:02:51 INFO - Successfully installed psutil 11:02:51 INFO - Cleaning up... 11:02:52 INFO - Return code: 0 11:02:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:02:52 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')]} 11:02:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:52 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')]} 11:02:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:52 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 0x2487030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2748180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27463b0>, '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 0x27472b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2747740>, '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': '745a4373a2a16df560f216e000000264-1467223353.339480-25359402', '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 11:02:52 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 11:02:52 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 11:02:52 INFO - Using env: {'DISPLAY': ':0', 11:02:52 INFO - 'HOME': '/home/cltbld', 11:02:52 INFO - 'LANG': 'en_US.UTF-8', 11:02:52 INFO - 'LANGUAGE': 'en_US:en', 11:02:52 INFO - 'LOGNAME': 'cltbld', 11:02:52 INFO - 'MAIL': '/var/mail/cltbld', 11:02:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:52 INFO - 'MOZ_NO_REMOTE': '1', 11:02:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:52 INFO - 'NO_EM_RESTART': '1', 11:02:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:52 INFO - 'PWD': '/builds/slave/test', 11:02:52 INFO - 'SHELL': '/bin/bash', 11:02:52 INFO - 'SHLVL': '1', 11:02:52 INFO - 'TERM': 'linux', 11:02:52 INFO - 'TMOUT': '86400', 11:02:52 INFO - 'USER': 'cltbld', 11:02:52 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1467223353.339480-25359402', 11:02:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:52 INFO - '_': '/tools/buildbot/bin/python'} 11:02:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:02:52 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 11:02:52 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 11:02:52 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 11:02:52 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 11:02:52 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 11:02:52 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 11:02:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:02:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:02:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:02:54 INFO - Installing collected packages: mozsystemmonitor 11:02:54 INFO - Running setup.py install for mozsystemmonitor 11:02:54 INFO - Successfully installed mozsystemmonitor 11:02:54 INFO - Cleaning up... 11:02:54 INFO - Return code: 0 11:02:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:02:54 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')]} 11:02:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:54 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')]} 11:02:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:54 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 0x2487030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2748180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27463b0>, '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 0x27472b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2747740>, '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': '745a4373a2a16df560f216e000000264-1467223353.339480-25359402', '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 11:02:54 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 11:02:54 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 11:02:54 INFO - Using env: {'DISPLAY': ':0', 11:02:54 INFO - 'HOME': '/home/cltbld', 11:02:54 INFO - 'LANG': 'en_US.UTF-8', 11:02:54 INFO - 'LANGUAGE': 'en_US:en', 11:02:54 INFO - 'LOGNAME': 'cltbld', 11:02:54 INFO - 'MAIL': '/var/mail/cltbld', 11:02:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:54 INFO - 'MOZ_NO_REMOTE': '1', 11:02:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:54 INFO - 'NO_EM_RESTART': '1', 11:02:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:54 INFO - 'PWD': '/builds/slave/test', 11:02:54 INFO - 'SHELL': '/bin/bash', 11:02:54 INFO - 'SHLVL': '1', 11:02:54 INFO - 'TERM': 'linux', 11:02:54 INFO - 'TMOUT': '86400', 11:02:54 INFO - 'USER': 'cltbld', 11:02:54 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1467223353.339480-25359402', 11:02:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:54 INFO - '_': '/tools/buildbot/bin/python'} 11:02:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:54 INFO - Downloading/unpacking jsonschema==2.5.1 11:02:54 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 11:02:54 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 11:02:54 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 11:02:54 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 11:02:54 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 11:02:54 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 11:02:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:02:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:02:56 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 11:02:56 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 11:02:56 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 11:02:56 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 11:02:56 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 11:02:56 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 11:02:56 INFO - Downloading functools32-3.2.3-2.tar.gz 11:02:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:02:56 INFO - warning: no files found matching '*.txt' 11:02:56 INFO - no previously-included directories found matching 'build' 11:02:56 INFO - no previously-included directories found matching 'dist' 11:02:56 INFO - no previously-included directories found matching '.git*' 11:02:56 INFO - Installing collected packages: jsonschema, functools32 11:02:56 INFO - Running setup.py install for functools32 11:02:56 INFO - warning: no files found matching '*.txt' 11:02:56 INFO - no previously-included directories found matching 'build' 11:02:56 INFO - no previously-included directories found matching 'dist' 11:02:56 INFO - no previously-included directories found matching '.git*' 11:02:56 INFO - Successfully installed jsonschema functools32 11:02:56 INFO - Cleaning up... 11:02:56 INFO - Return code: 0 11:02:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:02:56 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')]} 11:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:56 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')]} 11:02:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:56 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 0x2487030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2748180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27463b0>, '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 0x27472b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2747740>, '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': '745a4373a2a16df560f216e000000264-1467223353.339480-25359402', '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 11:02:56 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 11:02:56 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 11:02:56 INFO - Using env: {'DISPLAY': ':0', 11:02:56 INFO - 'HOME': '/home/cltbld', 11:02:56 INFO - 'LANG': 'en_US.UTF-8', 11:02:56 INFO - 'LANGUAGE': 'en_US:en', 11:02:56 INFO - 'LOGNAME': 'cltbld', 11:02:56 INFO - 'MAIL': '/var/mail/cltbld', 11:02:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:56 INFO - 'MOZ_NO_REMOTE': '1', 11:02:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:56 INFO - 'NO_EM_RESTART': '1', 11:02:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:56 INFO - 'PWD': '/builds/slave/test', 11:02:56 INFO - 'SHELL': '/bin/bash', 11:02:56 INFO - 'SHLVL': '1', 11:02:56 INFO - 'TERM': 'linux', 11:02:56 INFO - 'TMOUT': '86400', 11:02:56 INFO - 'USER': 'cltbld', 11:02:56 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1467223353.339480-25359402', 11:02:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:56 INFO - '_': '/tools/buildbot/bin/python'} 11:02:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:57 INFO - Downloading/unpacking blobuploader==1.2.4 11:02:57 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 11:02:57 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 11:02:57 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 11:02:57 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 11:02:57 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 11:02:57 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 11:02:58 INFO - Downloading blobuploader-1.2.4.tar.gz 11:02:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:02:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:02:59 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 11:02:59 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 11:02:59 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 11:02:59 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 11:02:59 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 11:02:59 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 11:02:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:02:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:02:59 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 11:02:59 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 11:02:59 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 11:02:59 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 11:02:59 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 11:02:59 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 11:02:59 INFO - Downloading docopt-0.6.1.tar.gz 11:02:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:02:59 INFO - Installing collected packages: blobuploader, requests, docopt 11:02:59 INFO - Running setup.py install for blobuploader 11:02:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:02:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:02:59 INFO - Running setup.py install for requests 11:03:00 INFO - Running setup.py install for docopt 11:03:00 INFO - Successfully installed blobuploader requests docopt 11:03:00 INFO - Cleaning up... 11:03:00 INFO - Return code: 0 11:03:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:03:00 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')]} 11:03:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:00 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')]} 11:03:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:00 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 0x2487030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2748180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27463b0>, '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 0x27472b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2747740>, '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': '745a4373a2a16df560f216e000000264-1467223353.339480-25359402', '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 11:03:00 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 11:03:00 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 11:03:00 INFO - Using env: {'DISPLAY': ':0', 11:03:00 INFO - 'HOME': '/home/cltbld', 11:03:00 INFO - 'LANG': 'en_US.UTF-8', 11:03:00 INFO - 'LANGUAGE': 'en_US:en', 11:03:00 INFO - 'LOGNAME': 'cltbld', 11:03:00 INFO - 'MAIL': '/var/mail/cltbld', 11:03:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:00 INFO - 'MOZ_NO_REMOTE': '1', 11:03:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:00 INFO - 'NO_EM_RESTART': '1', 11:03:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:00 INFO - 'PWD': '/builds/slave/test', 11:03:00 INFO - 'SHELL': '/bin/bash', 11:03:00 INFO - 'SHLVL': '1', 11:03:00 INFO - 'TERM': 'linux', 11:03:00 INFO - 'TMOUT': '86400', 11:03:00 INFO - 'USER': 'cltbld', 11:03:00 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1467223353.339480-25359402', 11:03:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:00 INFO - '_': '/tools/buildbot/bin/python'} 11:03:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:03:00 INFO - Running setup.py (path:/tmp/pip-UiQNFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:03:00 INFO - Running setup.py (path:/tmp/pip-EvHoW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:03:00 INFO - Running setup.py (path:/tmp/pip-ScUJ2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:03:00 INFO - Running setup.py (path:/tmp/pip-q0vF00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:03:00 INFO - Running setup.py (path:/tmp/pip-5YG1sK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:03:00 INFO - Running setup.py (path:/tmp/pip-UhBgT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:03:00 INFO - Running setup.py (path:/tmp/pip-koLqgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:03:01 INFO - Running setup.py (path:/tmp/pip-ebZ1ku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:03:01 INFO - Running setup.py (path:/tmp/pip-3mqVIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:03:01 INFO - Running setup.py (path:/tmp/pip-1WdvzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:03:01 INFO - Running setup.py (path:/tmp/pip-DlwTPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:03:01 INFO - Running setup.py (path:/tmp/pip-z3sewr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:03:01 INFO - Running setup.py (path:/tmp/pip-H_lpMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:03:01 INFO - Running setup.py (path:/tmp/pip-rOdKNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:01 INFO - Running setup.py (path:/tmp/pip-9ukavy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:03:01 INFO - Running setup.py (path:/tmp/pip-COWHuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:03:01 INFO - Running setup.py (path:/tmp/pip-OtkFXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:03:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:03:01 INFO - Running setup.py install for manifestparser 11:03:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:03:01 INFO - Running setup.py install for mozcrash 11:03:01 INFO - Running setup.py install for mozdebug 11:03:02 INFO - Running setup.py install for mozdevice 11:03:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:03:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:03:02 INFO - Running setup.py install for mozfile 11:03:02 INFO - Running setup.py install for mozhttpd 11:03:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:03:02 INFO - Running setup.py install for mozinfo 11:03:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:03:02 INFO - Running setup.py install for mozInstall 11:03:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:03:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:03:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:03:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:03:02 INFO - Running setup.py install for mozleak 11:03:02 INFO - Running setup.py install for mozlog 11:03:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:03:02 INFO - Running setup.py install for moznetwork 11:03:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:03:02 INFO - Running setup.py install for mozprocess 11:03:03 INFO - Running setup.py install for mozprofile 11:03:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:03:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:03:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:03:03 INFO - Running setup.py install for mozrunner 11:03:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:03:03 INFO - Running setup.py install for mozscreenshot 11:03:03 INFO - Running setup.py install for moztest 11:03:03 INFO - Running setup.py install for mozversion 11:03:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:03:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:03:03 INFO - Cleaning up... 11:03:03 INFO - Return code: 0 11:03:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:03:03 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')]} 11:03:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:03 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')]} 11:03:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:03 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 0x2487030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2748180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27463b0>, '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 0x27472b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2747740>, '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': '745a4373a2a16df560f216e000000264-1467223353.339480-25359402', '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 11:03:03 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 11:03:03 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 11:03:03 INFO - Using env: {'DISPLAY': ':0', 11:03:03 INFO - 'HOME': '/home/cltbld', 11:03:03 INFO - 'LANG': 'en_US.UTF-8', 11:03:03 INFO - 'LANGUAGE': 'en_US:en', 11:03:03 INFO - 'LOGNAME': 'cltbld', 11:03:03 INFO - 'MAIL': '/var/mail/cltbld', 11:03:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:03 INFO - 'MOZ_NO_REMOTE': '1', 11:03:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:03 INFO - 'NO_EM_RESTART': '1', 11:03:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:03 INFO - 'PWD': '/builds/slave/test', 11:03:03 INFO - 'SHELL': '/bin/bash', 11:03:03 INFO - 'SHLVL': '1', 11:03:03 INFO - 'TERM': 'linux', 11:03:03 INFO - 'TMOUT': '86400', 11:03:03 INFO - 'USER': 'cltbld', 11:03:03 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1467223353.339480-25359402', 11:03:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:03 INFO - '_': '/tools/buildbot/bin/python'} 11:03:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:03:03 INFO - Running setup.py (path:/tmp/pip-ExE_CJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:03:03 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)) 11:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:03:03 INFO - Running setup.py (path:/tmp/pip-1za_jA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:03:03 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)) 11:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:03:03 INFO - Running setup.py (path:/tmp/pip-UfyV8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:03:04 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)) 11:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:03:04 INFO - Running setup.py (path:/tmp/pip-4jkQNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:03:04 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)) 11:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:03:04 INFO - Running setup.py (path:/tmp/pip-ny9Gd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:03:04 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)) 11:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:03:04 INFO - Running setup.py (path:/tmp/pip-nGZgkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:03:04 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)) 11:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:03:04 INFO - Running setup.py (path:/tmp/pip-JTIXjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:03:04 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)) 11:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:03:04 INFO - Running setup.py (path:/tmp/pip-QEFKNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:03:04 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)) 11:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:03:04 INFO - Running setup.py (path:/tmp/pip-oYRFBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:03:04 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)) 11:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:03:04 INFO - Running setup.py (path:/tmp/pip-gpvt08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:03:04 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)) 11:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:03:04 INFO - Running setup.py (path:/tmp/pip-gYRemz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:03:04 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)) 11:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:03:04 INFO - Running setup.py (path:/tmp/pip-bXzZJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:03:04 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)) 11:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:03:04 INFO - Running setup.py (path:/tmp/pip-Irg3HG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:03:04 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)) 11:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:03:04 INFO - Running setup.py (path:/tmp/pip-ZzBae0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:03:04 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)) 11:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:04 INFO - Running setup.py (path:/tmp/pip-Iqwk3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:04 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)) 11:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:03:04 INFO - Running setup.py (path:/tmp/pip-YB4xC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:03:04 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)) 11:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:03:04 INFO - Running setup.py (path:/tmp/pip-Ga3kyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:03:05 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)) 11:03:05 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)) 11:03:05 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)) 11:03:05 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)) 11:03:05 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)) 11:03:05 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)) 11:03:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:03:05 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 11:03:05 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 11:03:05 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 11:03:05 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 11:03:05 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 11:03:05 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 11:03:06 INFO - Downloading blessings-1.6.tar.gz 11:03:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:03:07 INFO - Installing collected packages: blessings 11:03:07 INFO - Running setup.py install for blessings 11:03:07 INFO - Successfully installed blessings 11:03:07 INFO - Cleaning up... 11:03:07 INFO - Return code: 0 11:03:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:03:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:03:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:03:07 INFO - Reading from file tmpfile_stdout 11:03:07 INFO - Current package versions: 11:03:07 INFO - argparse == 1.2.1 11:03:07 INFO - blessings == 1.6 11:03:07 INFO - blobuploader == 1.2.4 11:03:07 INFO - docopt == 0.6.1 11:03:07 INFO - functools32 == 3.2.3-2 11:03:07 INFO - jsonschema == 2.5.1 11:03:07 INFO - manifestparser == 1.1 11:03:07 INFO - mozInstall == 1.12 11:03:07 INFO - mozcrash == 0.17 11:03:07 INFO - mozdebug == 0.1 11:03:07 INFO - mozdevice == 0.48 11:03:07 INFO - mozfile == 1.2 11:03:07 INFO - mozhttpd == 0.7 11:03:07 INFO - mozinfo == 0.9 11:03:07 INFO - mozleak == 0.1 11:03:07 INFO - mozlog == 3.2 11:03:07 INFO - moznetwork == 0.27 11:03:07 INFO - mozprocess == 0.22 11:03:07 INFO - mozprofile == 0.28 11:03:07 INFO - mozrunner == 6.11 11:03:07 INFO - mozscreenshot == 0.1 11:03:07 INFO - mozsystemmonitor == 0.3 11:03:07 INFO - moztest == 0.7 11:03:07 INFO - mozversion == 1.4 11:03:07 INFO - psutil == 3.1.1 11:03:07 INFO - requests == 1.2.3 11:03:07 INFO - wsgiref == 0.1.2 11:03:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:03:07 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')]} 11:03:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:07 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')]} 11:03:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:07 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 0x2487030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2748180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27463b0>, '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 0x27472b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2747740>, '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': '745a4373a2a16df560f216e000000264-1467223353.339480-25359402', '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 11:03:07 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 11:03:07 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 11:03:07 INFO - Using env: {'DISPLAY': ':0', 11:03:07 INFO - 'HOME': '/home/cltbld', 11:03:07 INFO - 'LANG': 'en_US.UTF-8', 11:03:07 INFO - 'LANGUAGE': 'en_US:en', 11:03:07 INFO - 'LOGNAME': 'cltbld', 11:03:07 INFO - 'MAIL': '/var/mail/cltbld', 11:03:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:07 INFO - 'MOZ_NO_REMOTE': '1', 11:03:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:07 INFO - 'NO_EM_RESTART': '1', 11:03:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:07 INFO - 'PWD': '/builds/slave/test', 11:03:07 INFO - 'SHELL': '/bin/bash', 11:03:07 INFO - 'SHLVL': '1', 11:03:07 INFO - 'TERM': 'linux', 11:03:07 INFO - 'TMOUT': '86400', 11:03:07 INFO - 'USER': 'cltbld', 11:03:07 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1467223353.339480-25359402', 11:03:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:07 INFO - '_': '/tools/buildbot/bin/python'} 11:03:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:07 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)) 11:03:07 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)) 11:03:07 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)) 11:03:07 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)) 11:03:07 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)) 11:03:07 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)) 11:03:07 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)) 11:03:07 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)) 11:03:07 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)) 11:03:07 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)) 11:03:07 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)) 11:03:07 INFO - Cleaning up... 11:03:07 INFO - Return code: 0 11:03:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:03:07 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')]} 11:03:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:07 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')]} 11:03:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:07 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 0x2487030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2748180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27463b0>, '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 0x27472b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2747740>, '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': '745a4373a2a16df560f216e000000264-1467223353.339480-25359402', '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 11:03:07 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 11:03:07 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 11:03:07 INFO - Using env: {'DISPLAY': ':0', 11:03:07 INFO - 'HOME': '/home/cltbld', 11:03:07 INFO - 'LANG': 'en_US.UTF-8', 11:03:07 INFO - 'LANGUAGE': 'en_US:en', 11:03:07 INFO - 'LOGNAME': 'cltbld', 11:03:07 INFO - 'MAIL': '/var/mail/cltbld', 11:03:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:07 INFO - 'MOZ_NO_REMOTE': '1', 11:03:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:07 INFO - 'NO_EM_RESTART': '1', 11:03:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:07 INFO - 'PWD': '/builds/slave/test', 11:03:07 INFO - 'SHELL': '/bin/bash', 11:03:07 INFO - 'SHLVL': '1', 11:03:07 INFO - 'TERM': 'linux', 11:03:07 INFO - 'TMOUT': '86400', 11:03:07 INFO - 'USER': 'cltbld', 11:03:07 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1467223353.339480-25359402', 11:03:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:07 INFO - '_': '/tools/buildbot/bin/python'} 11:03:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:03:07 INFO - Cleaning up... 11:03:07 INFO - Return code: 0 11:03:07 INFO - Running post-action listener: _resource_record_post_action 11:03:07 INFO - Running post-action listener: _start_resource_monitoring 11:03:07 INFO - Starting resource monitoring. 11:03:07 INFO - ##### 11:03:07 INFO - ##### Finished create-virtualenv step (success) 11:03:07 INFO - ##### 11:03:07 INFO - ##### 11:03:07 INFO - ##### Running install step. 11:03:07 INFO - ##### 11:03:07 INFO - Running pre-action listener: _resource_record_pre_action 11:03:07 INFO - Running main action method: install 11:03:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:03:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:03:08 INFO - Reading from file tmpfile_stdout 11:03:08 INFO - Detecting whether we're running mozinstall >=1.0... 11:03:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:03:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:03:08 INFO - Reading from file tmpfile_stdout 11:03:08 INFO - Output received: 11:03:08 INFO - Usage: mozinstall [options] installer 11:03:08 INFO - Options: 11:03:08 INFO - -h, --help show this help message and exit 11:03:08 INFO - -d DEST, --destination=DEST 11:03:08 INFO - Directory to install application into. [default: 11:03:08 INFO - "/builds/slave/test"] 11:03:08 INFO - --app=APP Application being installed. [default: firefox] 11:03:08 INFO - mkdir: /builds/slave/test/build/application 11:03:08 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'] 11:03:08 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 11:03:25 INFO - Reading from file tmpfile_stdout 11:03:25 INFO - Output received: 11:03:25 INFO - /builds/slave/test/build/application/firefox/firefox 11:03:25 INFO - Running post-action listener: _resource_record_post_action 11:03:25 INFO - ##### 11:03:25 INFO - ##### Finished install step (success) 11:03:25 INFO - ##### 11:03:25 INFO - ##### 11:03:25 INFO - ##### Running run-tests step. 11:03:25 INFO - ##### 11:03:25 INFO - Running pre-action listener: _resource_record_pre_action 11:03:25 INFO - Running main action method: run_tests 11:03:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:03:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:03:25 INFO - Python 2.7.3 11:03:25 INFO - Return code: 0 11:03:25 INFO - grabbing minidump binary from tooltool 11:03:25 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')]} 11:03:25 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 0x27463b0>, '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 0x27472b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2747740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:03:25 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 11:03:25 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 11:03:25 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 11:03:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:03:25 INFO - Return code: 0 11:03:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:03:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:03:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:03:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:03:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:03:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/edElhXcdSVqAWMyG-E7syw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:03:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/edElhXcdSVqAWMyG-E7syw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:03:25 INFO - Using env: {'DISPLAY': ':0', 11:03:25 INFO - 'HOME': '/home/cltbld', 11:03:25 INFO - 'LANG': 'en_US.UTF-8', 11:03:25 INFO - 'LANGUAGE': 'en_US:en', 11:03:25 INFO - 'LOGNAME': 'cltbld', 11:03:25 INFO - 'MAIL': '/var/mail/cltbld', 11:03:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:03:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:03:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:25 INFO - 'MOZ_NO_REMOTE': '1', 11:03:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:03:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:25 INFO - 'NO_EM_RESTART': '1', 11:03:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:25 INFO - 'PWD': '/builds/slave/test', 11:03:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:03:25 INFO - 'SHELL': '/bin/bash', 11:03:25 INFO - 'SHLVL': '1', 11:03:25 INFO - 'TERM': 'linux', 11:03:25 INFO - 'TMOUT': '86400', 11:03:25 INFO - 'USER': 'cltbld', 11:03:25 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1467223353.339480-25359402', 11:03:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:25 INFO - '_': '/tools/buildbot/bin/python'} 11:03:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/edElhXcdSVqAWMyG-E7syw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:03:25 INFO - mozversion application_buildid: 20160629083023 11:03:25 INFO - mozversion application_changeset: eeb6862f960c1310bde9aed159f3fc5bb2d4b6d7 11:03:25 INFO - mozversion application_display_name: Nightly 11:03:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:03:25 INFO - mozversion application_name: Firefox 11:03:25 INFO - mozversion application_remotingname: firefox 11:03:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:03:25 INFO - mozversion application_vendor: Mozilla 11:03:25 INFO - mozversion application_version: 50.0a1 11:03:25 INFO - mozversion platform_buildid: 20160629083023 11:03:25 INFO - mozversion platform_changeset: eeb6862f960c1310bde9aed159f3fc5bb2d4b6d7 11:03:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:03:25 INFO - mozversion platform_version: 50.0a1 11:03:25 INFO - using testdate: 1467223405 11:03:25 INFO - actual date: 1467223405 11:03:25 INFO - starting webserver on 'localhost:40449' 11:03:25 INFO - SUITE-START | Running 2 tests 11:03:25 INFO - TEST-START | dromaeo_css 11:03:25 INFO - operating with platform_type : linux_ 11:03:25 INFO - Initialising browser for dromaeo_css test... 11:03:25 INFO - TEST-INFO | started process 16872 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyjNIWy/profile http://localhost:40449/getInfo.html) 11:03:30 INFO - PROCESS | 16872 | __metrics Screen width/height:1600/1200 11:03:30 INFO - PROCESS | 16872 | colorDepth:24 11:03:30 INFO - PROCESS | 16872 | Browser inner width/height: 1024/697 11:03:30 INFO - PROCESS | 16872 | __metrics 11:03:31 ERROR - PROCESS | 16872 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 11:03:32 INFO - TEST-INFO | 16872: exit 0 11:03:32 INFO - Browser initialized. 11:03:32 INFO - Running cycle 1/1 for dromaeo_css test... 11:03:32 INFO - TEST-INFO | started process 16994 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyjNIWy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:03:44 INFO - PROCESS | 16994 | RSS: Main: 168529920 11:03:44 INFO - PROCESS | 16994 | 11:04:34 INFO - PROCESS | 16994 | 1467223474105 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] 11:06:41 INFO - PROCESS | 16994 | Cycle 1(1): loaded http://localhost:40449/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40449/tests/dromaeo/cssquery-ext.html) 11:06:43 INFO - PROCESS | 16994 | RSS: Main: 171487232 11:06:43 INFO - PROCESS | 16994 | 11:09:45 INFO - PROCESS | 16994 | Cycle 1(1): loaded http://localhost:40449/tests/dromaeo/cssquery-ext.html (next: http://localhost:40449/tests/dromaeo/cssquery-jquery.html) 11:09:45 INFO - PROCESS | 16994 | RSS: Main: 168628224 11:09:45 INFO - PROCESS | 16994 | 11:12:47 INFO - PROCESS | 16994 | Cycle 1(1): loaded http://localhost:40449/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40449/tests/dromaeo/cssquery-mootools.html) 11:12:48 INFO - PROCESS | 16994 | RSS: Main: 171819008 11:12:48 INFO - PROCESS | 16994 | 11:15:50 INFO - PROCESS | 16994 | Cycle 1(1): loaded http://localhost:40449/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40449/tests/dromaeo/cssquery-prototype.html) 11:15:50 INFO - PROCESS | 16994 | RSS: Main: 167292928 11:15:50 INFO - PROCESS | 16994 | 11:18:53 INFO - PROCESS | 16994 | Cycle 1(1): loaded http://localhost:40449/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40449/tests/dromaeo/cssquery-yui.html) 11:18:53 INFO - PROCESS | 16994 | RSS: Main: 169787392 11:18:53 INFO - PROCESS | 16994 | 11:21:56 INFO - PROCESS | 16994 | Cycle 1(1): loaded http://localhost:40449/tests/dromaeo/cssquery-yui.html (next: http://localhost:40449/tests/dromaeo/cssquery-dojo.html) 11:21:56 INFO - PROCESS | 16994 | RSS: Main: 170151936 11:21:56 INFO - PROCESS | 16994 | 11:21:56 INFO - PROCESS | 16994 | __start_tp_report 11:21:56 INFO - PROCESS | 16994 | _x_x_mozilla_page_load 11:21:56 INFO - PROCESS | 16994 | _x_x_mozilla_page_load_details 11:21:56 INFO - PROCESS | 16994 | |i|pagename|runs| 11:21:56 INFO - PROCESS | 16994 | |0;dojo.html;3123.984380078101;3136.0591822453266;3153.936921261576;3155.715985561299;3157.9210519737007;5313.22958171065;5397.082495975688;5431.646942948705;5446.2647542581735;5477.589180811445;5232.8691782705455;5357.383900851403;5430.266913966613;5446.945530544694;5459.535939445142;4911.165101932671;4937.604991600681;5019.196928491424;5081;5139.460356662553;219.90007740482716;4780.378550788392;4870.732109733964;4874.439439464471;4878.34142390778;4881.682690625098;4937.185364414867;4945.67853089548;4954.801807927679;4960.503949605047;4962.106820772296;4968.478309777493;4973.925391119136;4976.576990955773;4977.253411988195;4855.951440485585;4892.730899800509;4913.803447862081;4914.11545921734;4917.827876024322;5403.540699040586;5415;5454.072807622713;5466.234727138204;5470.206820011116;5720.71396430181;5861.384554621746;5874.030784920483;5883.558733095035;5896.498797602209;5881.176635271066;5955.910661340084;5957.07665311873;5979.2824861016525;6038.788642397495;5551.306086739158;5552.805651802208;5556.833295001156;5559.8888022239735;5565.666060036411;5814.534837213013;5964.731587078505;5999.670018149044;6058.454739073504;6069.332373438918;5770.711464426762;5809.68046757424;5816.069428891442;5825.912611310834;5848.590598658138;5883.7058147092475;5886.3230728465915;5905.143754155709;5906.704664766745;5917.911231331534;5685.658860468385;5703.287089113861;5750.597458177971;5782.624129431658;5822.214001109881;5769.624974376652;5810.62230954995;5812.21535092757;5819.592628515963;5822.796202132905;4415.558444155623;4434.55654434554;4447.888802779957;4452.888677783081;4486.910261794746;3904.2581909437117;3907.667848232932;3941.0541470047556;3947.2302900934615;4014.558398576154;5585.273914391103;5598.692071936001;5605.915911261334;5640.887182256414;5659.717014149276;5926.970365148233;5940.584159108907;5942.1383899335215;5945.2865656120675;5946.197263369476;5430.266913966643;5547.694876781816;5567.025770490148;5590.86022849432;5625.606207565431;4878.390201224847;4893.804247830047;4896.167651499253;4902.607791376681;4955.90088198234;5944.821655350346;6124.663143527059;6125.540584456184;6130.63216207029;6134;5787.9131813021995;5814.825555233434;5827.970860145672;5892.852678682896;5902.4097590240635;6072.666003369681;6114.847128821815;6119.479844213113;6128.8774224516155;6133.969330153321;5540.916886246629;5739.942600573941;5761.884762304814;5771.971140144273;5778.335491418373;5880.411958804086;5935.525157987437;5940.287165540163;5945.197398351167;5992.940070599413;5692.886142277214;5769.769209231752;5798.072308430631;5800.738966746422;5804.24544809189;5540.667559946416;5645.181448689999;5652.88694226105;5756;5780.3352614448195;5576.749046292845;5603.943960560342;5606.719664016864;5610.691411972381;5666.518345940642;5717.17101020358;5733.369329373682;5734.942650573441;5766.884662306814;5772.19189313488;5470.070088085115;5599.524040456607;5623.325200975909;5660.29246344207;5687.289088863892 11:21:56 INFO - PROCESS | 16994 | |1;ext.html;577.4860374266904;604.2326245668002;613.2334581772782;632.7658766256486;667.9732810687573;37599.81200093999;41323;41396;41411.99999999996;41479.170416591725;42040.78979605098;42050.57949420505;42297;42360.36459453111;42569.574304257025;8747.431416957894;8801.603927823264;8803.119688031209;8846.292296616255;8880.422772519765;8823.514706691161;8879.378443508956;8901.688440904569;8902.821943561124;8946.284297256203;8821;8826.426282291663;8833.955830220872;8878.822423551524;8969.506677132755;8823.205911467967;8895.599698013604;8911.376203665746;8921.732348029536;8925.241354484877;8758.167974042455;8781.165789250012;8783.12168783123;8801.339899507562;8840.911590884074;33809.6619033809;39956.40065399021;40239.597604023875;40380;40480.19039619191;3352.765306428551;3427.657234276577;3528.4530897710897;3573.8927832165077;3613.259281847215;30706;31085;31163.37673246545;31211.531827022613;32319.353612927844;4251.936220956688;4289.656827453796;4296.785160741982;4441.622462090726;4497.775111244425;316394;317119;317283;318185;320321;37043;37246;37385.62614373876;37433.812830936215;37505.81247093801;37755.62244377576;38220.2355952885;38350;38395.616043839764;38505.422418663744;17601.29594816193;17713;17882.463526094238;17884.91057544704;17957.820421795615;12761.29812860283;12812.103152779217;12860.742785144244;12903.612891613078;12903.741925161445;19160.329388471335;19225.32711355096;19260.80739192618;19325.710114348298;19339.613207735765;7036.50744447894;7218.386437152901;7277.963610181915;7303.671334789948;7521.586312752851;959.9712008639752;1061.4480470155477;1094.261373572835;1107.3466654673782;1130.7116685245373;32885.67114328874;32989.83505082459;33099.50350744741;33115.337693246;33135;1060.596973150198;1127.515168477546;1138.6071805227184;1164.7379339648512;1199.5861427807567;16511.33954641825;16846.157692115346;16965.236564354633;16977.320907163576;17015.553677937267;272045;274407;275059;276387;584138;57198.7140064297;58074.64440167004;58701;58702;58806.11790823141;1305.5104335874048;1343.1739480219594;1345.3609535470573;1363.3864760857655;1369.3084992078936;30500.389992199587;31595.21011974719;31968;32160.356792863542;32453.51319730253;52598.21102683539;56432;56669.43330566806;56806;57233;522738;525307;525823;530270;534060;30032;30755;30913.0726078209;31949.20126996844;44446.777766110965;48462.75768621134;48861.26708099453;49092.263616046504;49815.75092124516;52569.737151313995;42819;43456.565434345255;43543.564564353954;43776.343354849065;44909.32636010397;42887;42972.57027429811;42973.35539966966;43494.782526088435;43569;36393.272134557694;41453.79273103615;42500.36249456199;44247.336289955034;44373.55626443694;42227.788861055495;44433.55566444423;44555.777221114986;45073.54926450693;45319;34086.48870266898;35103;35243.82378088093;35284.82357588196;35399.64600353964 11:21:56 INFO - PROCESS | 16994 | |2;jquery.html;391.3112921258584;394.7236934146097;394.95260568731754;400.4933758795124;416.99166016679646;14302.642433939156;18725.34461293855;19514.804851951478;20260.493487662796;20391.490212744688;19594.804051959476;19799;19887.60224795507;20741.585168296664;20748.481287967807;5716.456936591027;5791.884162316751;5871.236739223917;5873;5874.471297583216;5659.717014149297;5775.711214439282;5781.161731548923;5782.98797710399;5817.1565123057135;5667.263255776764;5730.455606717355;5834.6790926499025;5837.357890632048;5840.737166827482;5728.742206600713;5760.7695692172265;5767.913481297784;5777.682227477508;5803.47768700819;5097.286379906816;5120.359955005624;5155.0978578748945;5173.741312934339;5205.323307969978;23465.88267058654;23644.29067127989;23898.402539936465;24168.274951751475;24500.142495012766;2431.9721946177124;2544.3893465568317;2557.744225577427;2864.069177517315;2992.012635830171;14879.628009299746;15089.320980555902;15147;15312.234388280542;15401.614959625987;1876.55900863297;1881.388548721671;1910.9294020511963;1929.4211736479;1954.3159894037115;76412.61793691051;81300;84476.15523844745;85442.57278713629;85728.14271857264;10570.52432640533;10653.627123050655;10766.515506802212;10944.781104377867;11206.83189752138;15013.399464021317;15054.172020538757;15127.924360378127;15151;15178.392864285304;8173.713920012771;8347.540885251248;8459.280961118251;8504.277136443472;8521.44610600309;8187.1403502631365;8284;8311.459755115899;8406.579671016425;8541.444806087584;6528.706208220641;6707.49693772969;6775.1192344995825;6826.692798824065;6843.152348865878;1911.084388835609;1984.8709833861042;2007.498125468633;2018.3743039657752;2036.7046778217373;980.4999450280409;1015.619142821442;1060.6923992042375;1113.5768408005067;1131.7510147767478;20509.589808203753;21198.258060967793;21217.893910530347;21269.78730212709;21320.14719411237;995.4027583449872;1026.2149455666422;1046.6912260883057;1095.8575385199872;1152.2280072351546;11503.942480287713;12013.339266340436;12014.879851201551;12068.939655301667;12132.272063676031;446288;447802;462054;466782;467120;50908.74545627248;87587;88192.55903720441;89388;89453.55273223593;991.3110388280076;1017.1049476460815;1017.7481697512102;1018.2261481274137;1033.7363972187195;17971.730424043388;18546.16542255629;18823.8347399475;19037.333693320666;19040.61918761645;41302.38046429366;42237.36643950282;43114.78442607767;43940;44373.55626443694;53919.19121213263;54192;55323;55926.72036639791;63263;8917.73246802597;9034.503102329172;9234.445933244027;9250.629974800933;9577.473238971923;8956.552172391224;14432.134071955295;14433.711325773636;14454.638634034232;14476.348564314841;12347.19743216688;12624.87375126237;12648.367581620698;12666.28223737837;12950.935245323713;10577.9471102644;12553.874461255637;12716.809247861474;12791.296478693761;12906.80639790385;12867.420966056738;12925.935370323465;13225.867741322463;13290.534831281246;13314.533991310258;7664.425168112302;9096.317776166681;9372.250219982521;9374.343795934219;9489.620415183592;10867.728306792393;11734.88265117372;12488.313142777235;12526.937365313479;12675.873241267469 11:21:56 INFO - PROCESS | 16994 | |3;mootools.html;1503.4437258214462;1536.431520337475;1656.9420070297542;1787.177898166843;1820.7177887427454;7792.883106753389;8756.518391488482;8780.824383512327;9458.337916345867;9466.574004169812;8781;8921.107889211076;8997.775055623597;9048.502332371718;9127.863082053775;2257.3566533537987;2289.4505318723554;2302.9193978210765;2303.6199027160496;2304.1474654377903;2251.0995601759264;2254.391314345126;2291.942701432469;2292.793648571628;2295.517941232335;2274.9886250568807;2299.1722979727283;2323.140438037928;2324.3491822289784;2331.1374791327235;2194.1333173396497;2196.3959911024517;2206.2719302630094;2210.9005094770773;2214.4685275533916;2177.7168968034052;2188.376312750874;2189.3650841256017;2215.213599172303;2223.977760222393;8957.910420895772;9071.954640226822;9082.137196966278;9125.634974601007;9137;5391.568674506069;5490.917636235459;5497.092979658351;5499.257600223958;5505.972470137664;3298.7855789373853;3372.9325413491592;3438.381091403546;3469.757117001811;3535.6641119093647;1136.732867776072;1140.0651465798048;1152.8501294831701;1154.065207182185;1181.6100686773343;13108.082434229607;13208.801867971988;13251.204927704368;13271.535496257682;13286.20282783036;4696.365990591295;4729.793902554827;4828.058528586892;4853.39332583427;4977.701337919736;11094.057005154653;11148.66554003365;11176.608818691308;11243.156763242789;11246.49390777417;5618.213450116987;5668.121441176624;5675.091985282417;5676.091825307931;5695.45893140151;4294.849680261176;4980.551750342486;4991.825286114969;5172.094883395466;5181.4300426953005;4164.37534369847;4164.83340666376;4366.366876802909;4405.713628614194;4422.646188304928;1350.2978451205317;1360.8843248323806;1374.4227424481742;1378.3590630356732;1401.9299035048207;953.6185525789601;959.6161535385762;967.4823969176457;972.7422233108232;982.2387649571497;6135.693215339215;6218.409251121137;6311.084892690534;6360.681965901686;6369.872602547923;438.6140196626948;442.49997502821606;445.9531749166356;470.0716085730655;471.1636844600861;4029.234445455354;4088.059746258318;4160.875173744793;4180.3102488089735;4197.013701780079;11441.771164576829;11729.706757331134;11859.229150105215;11861.644150675322;11865.525378984916;10802.513886874953;11089.667309980552;11249.381284029294;11752.588659397052;11784.057275418118;8624.353173512012;8742;8750.91249087501;8800.207981281588;8820.073892241222;6207.534434917309;6458.38645328693;6472.514561407819;6479.643619600967;6546.934530654633;10067.395956242648;10852.511636976196;10865.348079115278;11017;11057.557697692002;10475.266731329039;10947;10947.616833410792;10994.34033957965;11143.275687080639;8000;8219.95890020546;8348.457350272212;8354.415190936576;8356.373272004503;9174.403663762101;9203.309751768778;9220;9262.583183756882;9344.15902568772;8104;8358.164183581594;8375;8414;8547.40168188221;8200.671973121247;8219.260266576037;8292.2951549119;8309.04445988719;8348.206920342558;7328.96335518319;7339.376153026839;7358.190599033995;7358.926410735824;7375.704971801068;5228.660137091229;5333.866653333697;5418.187271909245;5499.752511136929;5559.471850174227;5541.501264886179;5548;5559.833205003856;5582.078956972054;5626.521745651666 11:21:56 INFO - PROCESS | 16994 | |4;prototype.html;330.4250603949128;334.78908287778694;335.5738212470162;342.4230172159909;343.3767711603441;5664.640486283288;5675.489205971462;5705.343885453174;5707.3721890592005;5757.222774925383;5599.188117722928;5611.242482264893;5648.858778530539;5653.519450846683;5673.092305231164;4144.48193975753;4214.957850421487;4335.544767799383;4352.673549483786;4352.673549483786;4327.420491520588;4353.2599458092045;4375.934360984587;4378.824847006132;4380.299152135659;4326.242907491192;4374.321980093075;4383.583559561853;4391.121775644868;4400.603945644892;4289.2334444283415;4345.261305578044;4354.651627869763;4372.256716358227;4388.232059389626;3781.9054523636855;3826.7321287509885;3839.2897313997;3870.3033453978273;3884.378499440076;5331.893362132736;5388.353397592275;5394;5473.917891231635;5526.226328314039;4870.780814863339;5045.571126454256;5052.444231134609;5067.594592432597;5073.568746656539;5904.468597826216;5914.615549989237;5930.55520835939;5951.047832346804;5979.833932383187;4295.463067116611;4301.1397720455725;4314.050908800059;4320.833374988735;4325.956740432618;6019.307779605314;6061.909071363933;6084.1100477273385;6108.175396321484;6135.693215339215;4373;4404.11917616478;4410.2282100632265;4414.1171765647;4421.46942366918;4438.334249862546;4447.110577884436;4458.175237581057;4458.420405347284;4468.843590474383;4877.512248775094;5030.84907452777;5043.2435134730085;5052.873678158076;5069.518395752398;5935.249101515064;5949.345571987078;5971.4327138921735;5980.9497156450525;6016.368281330485;1493.7983372244826;1538.9769153462707;1555.7510798272222;1558.758392449172;1561.1179683479024;976.6288810252058;979.5151400056875;998.3959704378747;1036.1710631494775;1060.7006417138944;5703.771849126071;5717.22817419643;5732.426757324234;5755.798547050833;5766.4233576642;5947.51312171957;5991.55063370249;6020.458158765732;6021.41079335881;6043.184170137063;5518.862028449321;5683.261176047087;5819.185314056035;5845.3277873045145;5861.765529378862;3210.197450637341;3246.5454836322933;3284.178955261185;3288.6053673559327;3289.73682105431;6260.283397983695;6317.084022816666;6399.840003999937;6424.357564243632;6484.481241500669;6207.844803879849;6272.6550039747335;6288;6300.716467758962;6307.842303942346;6195.31851496326;6338.873222535523;6377.234731832117;6380.968095159495;6433.420992110732;6028.5177185825905;6075.605085669417;6114.57197996136;6121.693915304128;6141.570090093829;6092.725827337692;6094.878102437838;6094.939050609614;6096.177016102769;6113.29697084841;6078.54410919174;6313.779017734358;6390.840228994126;6412.422881940648;6423.976447419048;4422.889427764331;4452.888677782952;4488.438945131858;4492.955070449254;4509.57159069901;5967.8209653710455;6043.697815109139;6130.356312587114;6135.570510064253;6158.3225845157895;5906.9072221639135;5944.256967879015;5948.821535353946;5971.820845374646;5988.970055149871;5914.556408269311;5963.28440587115;5967.552433567586;5974.4324289192455;6003.099535069775;5609.5512359012;5880.647161170344;5883.588148829712;5883.852648733456;5885.146653735099;6006.399360063959;6010;6011.789587364421;6029.3669164737075;6031.457168854824;5639.210510528447;5823.767049317979;5879.794207202727;5904.645721256738;5906.852328691817 11:21:56 INFO - PROCESS | 16994 | |5;yui.html;814.8736945773408;835.4653022065877;837.1419295222393;842.1241908415249;866.1338661338661;13463.932680336597;14126.293685315744;14580.343884525195;14618.926905365472;14674.926625366872;13312.933435332834;13386.263755493444;13407.597772066854;13409.731805363912;13445.126066805675;776.095848336687;776.7281451491989;793.7102957420528;796.1322158846856;803.0644299391203;809.299955538458;812.9430939834214;813.6175997281298;814.6008455856618;815.4943934760428;843.2200214801314;846.7544412120509;850.8851305073798;853.5092321914892;853.7566793463864;835.5947365527715;836.6611522333465;836.7447928381841;841.3521588376946;843.6245870587591;614.7663887722637;615.4922189193933;616.1989413762092;617.5954749638994;618.7679620142446;14073.155610663393;14102.858971410256;14159;14164;14174.574762757135;15015.474458394014;15084.698306033928;15094.320755565916;15187.924060379737;15303.923480382527;12209.755804883942;12227.266364018098;12305.815412768816;12384.504619815196;12855.228686278853;3827.9469055683385;3835.76985380878;3925.2934471795065;3983.2830090583684;4067.2068946555432;79860;81557.59221203915;81752;81904.59047704782;82336.17663823404;10965.232433729563;11464.082873370111;11777.352245626573;11781.528738850522;12022.639320820215;21198.258060967793;21239;21314.467138321666;21500;21536.676949845765;7805.297523222937;7811.257930496708;8143.714969976022;8318.292945099734;8351.66593336272;4557.72653640776;4659.184642687516;4701.576858082789;4762.499937506512;4852.781624826891;3625.6736893679695;3634.7637403568683;3641.362761516724;3694.538182727159;3727.496787933594;643.4434214404506;651.3486513486514;651.6318280171688;653.6372313366128;656.4289068510426;697.7278861244118;705.1221229569219;712.6294326949957;712.8004158835535;719.144218380126;8510.723371502016;8725.389222754346;9001.369904106781;9025;9214.401063930824;604.4227762486814;665.457044401712;685.2222727204559;701.3547536266647;704.5455681085773;4364.672649551297;4449.354843547732;4462.732236065782;4499.662525310615;4553.089382123589;64029.35970640327;64209.67895160494;64360.03459948105;78551;121837;103902.48048759859;104117;106308;106772.46613767037;108479.45760271305;54966.189031552254;74117.6294118526;92769;92860;94700.52649736707;8168.469049511763;8209.671613135408;8331.50010999342;8594.699185528476;8818.250448711931;55550;55812.16281755858;55818.441815581325;55866.72066639641;56833;77200;78947.21052789399;80865;81540.18459815325;82346.58826706068;9834.262430317613;9979;10627.521761520904;10820.837687434852;11356.488957997075;11757.88242117602;12287.69280767988;12631.621051368473;12649;12985;10686.465676716289;11014.39420831862;11110.666719993653;11389.145814063813;11409.144314176636;10863.185261105291;10919.235653504178;11007.449627518432;11017.889821101686;11032.172587056164;10786.460676965964;10829.891701082888;10837.241393102408;10839.187060970302;10856.34861908288;8967.192952634034;9081.818363632823;9103.271738260792;9137.406068605786;9343.859842102509;9515.381500202464;9537.904620953701;9547;9553.761155970878;9620.95189524048 11:21:56 INFO - PROCESS | 16994 | __end_tp_report 11:21:56 INFO - PROCESS | 16994 | __start_cc_report 11:21:56 INFO - PROCESS | 16994 | _x_x_mozilla_cycle_collect,342 11:21:56 INFO - PROCESS | 16994 | __end_cc_report 11:21:56 INFO - PROCESS | 16994 | __startTimestamp1467224516664__endTimestamp 11:21:56 INFO - PROCESS | 16994 | 11:21:56 INFO - PROCESS | 16994 | ------- Summary: start ------- 11:21:56 INFO - PROCESS | 16994 | Number of tests: 6 11:21:56 INFO - PROCESS | 16994 | 11:21:56 INFO - PROCESS | 16994 | [#0] dojo.html Cycles:165 Average:5402.50 Median:5640.89 stddev:757.01 (13.4%) stddev-sans-first:737.92 11:21:56 INFO - PROCESS | 16994 | Values: 3124.0 3136.1 3153.9 3155.7 3157.9 5313.2 5397.1 5431.6 5446.3 5477.6 5232.9 5357.4 5430.3 5446.9 5459.5 4911.2 4937.6 5019.2 5081.0 5139.5 219.9 4780.4 4870.7 4874.4 4878.3 4881.7 4937.2 4945.7 4954.8 4960.5 4962.1 4968.5 4973.9 4976.6 4977.3 4856.0 4892.7 4913.8 4914.1 4917.8 5403.5 5415.0 5454.1 5466.2 5470.2 5720.7 5861.4 5874.0 5883.6 5896.5 5881.2 5955.9 5957.1 5979.3 6038.8 5551.3 5552.8 5556.8 5559.9 5565.7 5814.5 5964.7 5999.7 6058.5 6069.3 5770.7 5809.7 5816.1 5825.9 5848.6 5883.7 5886.3 5905.1 5906.7 5917.9 5685.7 5703.3 5750.6 5782.6 5822.2 5769.6 5810.6 5812.2 5819.6 5822.8 4415.6 4434.6 4447.9 4452.9 4486.9 3904.3 3907.7 3941.1 3947.2 4014.6 5585.3 5598.7 5605.9 5640.9 5659.7 5927.0 5940.6 5942.1 5945.3 5946.2 5430.3 5547.7 5567.0 5590.9 5625.6 4878.4 4893.8 4896.2 4902.6 4955.9 5944.8 6124.7 6125.5 6130.6 6134.0 5787.9 5814.8 5828.0 5892.9 5902.4 6072.7 6114.8 6119.5 6128.9 6134.0 5540.9 5739.9 5761.9 5772.0 5778.3 5880.4 5935.5 5940.3 5945.2 5992.9 5692.9 5769.8 5798.1 5800.7 5804.2 5540.7 5645.2 5652.9 5756.0 5780.3 5576.7 5603.9 5606.7 5610.7 5666.5 5717.2 5733.4 5734.9 5766.9 5772.2 5470.1 5599.5 5623.3 5660.3 5687.3 11:21:56 INFO - PROCESS | 16994 | 11:21:56 INFO - PROCESS | 16994 | [#1] ext.html Cycles:180 Average:55872.71 Median:41404.00 stddev:109212.50 (263.8%) stddev-sans-first:109439.96 11:21:56 INFO - PROCESS | 16994 | Values: 577.5 604.2 613.2 632.8 668.0 37599.8 41323.0 41396.0 41412.0 41479.2 42040.8 42050.6 42297.0 42360.4 42569.6 8747.4 8801.6 8803.1 8846.3 8880.4 8823.5 8879.4 8901.7 8902.8 8946.3 8821.0 8826.4 8834.0 8878.8 8969.5 8823.2 8895.6 8911.4 8921.7 8925.2 8758.2 8781.2 8783.1 8801.3 8840.9 33809.7 39956.4 40239.6 40380.0 40480.2 3352.8 3427.7 3528.5 3573.9 3613.3 30706.0 31085.0 31163.4 31211.5 32319.4 4251.9 4289.7 4296.8 4441.6 4497.8 316394.0 317119.0 317283.0 318185.0 320321.0 37043.0 37246.0 37385.6 37433.8 37505.8 37755.6 38220.2 38350.0 38395.6 38505.4 17601.3 17713.0 17882.5 17884.9 17957.8 12761.3 12812.1 12860.7 12903.6 12903.7 19160.3 19225.3 19260.8 19325.7 19339.6 7036.5 7218.4 7278.0 7303.7 7521.6 960.0 1061.4 1094.3 1107.3 1130.7 32885.7 32989.8 33099.5 33115.3 33135.0 1060.6 1127.5 1138.6 1164.7 1199.6 16511.3 16846.2 16965.2 16977.3 17015.6 272045.0 274407.0 275059.0 276387.0 584138.0 57198.7 58074.6 58701.0 58702.0 58806.1 1305.5 1343.2 1345.4 1363.4 1369.3 30500.4 31595.2 31968.0 32160.4 32453.5 52598.2 56432.0 56669.4 56806.0 57233.0 522738.0 525307.0 525823.0 530270.0 534060.0 30032.0 30755.0 30913.1 31949.2 44446.8 48462.8 48861.3 49092.3 49815.8 52569.7 42819.0 43456.6 43543.6 43776.3 44909.3 42887.0 42972.6 42973.4 43494.8 43569.0 36393.3 41453.8 42500.4 44247.3 44373.6 42227.8 44433.6 44555.8 45073.5 45319.0 34086.5 35103.0 35243.8 35284.8 35399.6 11:21:56 INFO - PROCESS | 16994 | 11:21:56 INFO - PROCESS | 16994 | [#2] jquery.html Cycles:180 Average:28345.91 Median:13466.06 stddev:75455.70 (560.3%) stddev-sans-first:75638.18 11:21:56 INFO - PROCESS | 16994 | Values: 391.3 394.7 395.0 400.5 417.0 14302.6 18725.3 19514.8 20260.5 20391.5 19594.8 19799.0 19887.6 20741.6 20748.5 5716.5 5791.9 5871.2 5873.0 5874.5 5659.7 5775.7 5781.2 5783.0 5817.2 5667.3 5730.5 5834.7 5837.4 5840.7 5728.7 5760.8 5767.9 5777.7 5803.5 5097.3 5120.4 5155.1 5173.7 5205.3 23465.9 23644.3 23898.4 24168.3 24500.1 2432.0 2544.4 2557.7 2864.1 2992.0 14879.6 15089.3 15147.0 15312.2 15401.6 1876.6 1881.4 1910.9 1929.4 1954.3 76412.6 81300.0 84476.2 85442.6 85728.1 10570.5 10653.6 10766.5 10944.8 11206.8 15013.4 15054.2 15127.9 15151.0 15178.4 8173.7 8347.5 8459.3 8504.3 8521.4 8187.1 8284.0 8311.5 8406.6 8541.4 6528.7 6707.5 6775.1 6826.7 6843.2 1911.1 1984.9 2007.5 2018.4 2036.7 980.5 1015.6 1060.7 1113.6 1131.8 20509.6 21198.3 21217.9 21269.8 21320.1 995.4 1026.2 1046.7 1095.9 1152.2 11503.9 12013.3 12014.9 12068.9 12132.3 446288.0 447802.0 462054.0 466782.0 467120.0 50908.7 87587.0 88192.6 89388.0 89453.6 991.3 1017.1 1017.7 1018.2 1033.7 17971.7 18546.2 18823.8 19037.3 19040.6 41302.4 42237.4 43114.8 43940.0 44373.6 53919.2 54192.0 55323.0 55926.7 63263.0 8917.7 9034.5 9234.4 9250.6 9577.5 8956.6 14432.1 14433.7 14454.6 14476.3 12347.2 12624.9 12648.4 12666.3 12950.9 10577.9 12553.9 12716.8 12791.3 12906.8 12867.4 12925.9 13225.9 13290.5 13314.5 7664.4 9096.3 9372.3 9374.3 9489.6 10867.7 11734.9 12488.3 12526.9 12675.9 11:21:56 INFO - PROCESS | 16994 | 11:21:56 INFO - PROCESS | 16994 | [#3] mootools.html Cycles:180 Average:6100.69 Median:470.62 stddev:3572.20 (759.0%) stddev-sans-first:3565.51 11:21:56 INFO - PROCESS | 16994 | Values: 1503.4 1536.4 1656.9 1787.2 1820.7 7792.9 8756.5 8780.8 9458.3 9466.6 8781.0 8921.1 8997.8 9048.5 9127.9 2257.4 2289.5 2302.9 2303.6 2304.1 2251.1 2254.4 2291.9 2292.8 2295.5 2275.0 2299.2 2323.1 2324.3 2331.1 2194.1 2196.4 2206.3 2210.9 2214.5 2177.7 2188.4 2189.4 2215.2 2224.0 8957.9 9072.0 9082.1 9125.6 9137.0 5391.6 5490.9 5497.1 5499.3 5506.0 3298.8 3372.9 3438.4 3469.8 3535.7 1136.7 1140.1 1152.9 1154.1 1181.6 13108.1 13208.8 13251.2 13271.5 13286.2 4696.4 4729.8 4828.1 4853.4 4977.7 11094.1 11148.7 11176.6 11243.2 11246.5 5618.2 5668.1 5675.1 5676.1 5695.5 4294.8 4980.6 4991.8 5172.1 5181.4 4164.4 4164.8 4366.4 4405.7 4422.6 1350.3 1360.9 1374.4 1378.4 1401.9 953.6 959.6 967.5 972.7 982.2 6135.7 6218.4 6311.1 6360.7 6369.9 438.6 442.5 446.0 470.1 471.2 4029.2 4088.1 4160.9 4180.3 4197.0 11441.8 11729.7 11859.2 11861.6 11865.5 10802.5 11089.7 11249.4 11752.6 11784.1 8624.4 8742.0 8750.9 8800.2 8820.1 6207.5 6458.4 6472.5 6479.6 6546.9 10067.4 10852.5 10865.3 11017.0 11057.6 10475.3 10947.0 10947.6 10994.3 11143.3 8000.0 8220.0 8348.5 8354.4 8356.4 9174.4 9203.3 9220.0 9262.6 9344.2 8104.0 8358.2 8375.0 8414.0 8547.4 8200.7 8219.3 8292.3 8309.0 8348.2 7329.0 7339.4 7358.2 7358.9 7375.7 5228.7 5333.9 5418.2 5499.8 5559.5 5541.5 5548.0 5559.8 5582.1 5626.5 11:21:56 INFO - PROCESS | 16994 | 11:21:56 INFO - PROCESS | 16994 | [#4] prototype.html Cycles:180 Average:5013.23 Median:5712.30 stddev:1479.14 (25.9%) stddev-sans-first:1440.93 11:21:56 INFO - PROCESS | 16994 | Values: 330.4 334.8 335.6 342.4 343.4 5664.6 5675.5 5705.3 5707.4 5757.2 5599.2 5611.2 5648.9 5653.5 5673.1 4144.5 4215.0 4335.5 4352.7 4352.7 4327.4 4353.3 4375.9 4378.8 4380.3 4326.2 4374.3 4383.6 4391.1 4400.6 4289.2 4345.3 4354.7 4372.3 4388.2 3781.9 3826.7 3839.3 3870.3 3884.4 5331.9 5388.4 5394.0 5473.9 5526.2 4870.8 5045.6 5052.4 5067.6 5073.6 5904.5 5914.6 5930.6 5951.0 5979.8 4295.5 4301.1 4314.1 4320.8 4326.0 6019.3 6061.9 6084.1 6108.2 6135.7 4373.0 4404.1 4410.2 4414.1 4421.5 4438.3 4447.1 4458.2 4458.4 4468.8 4877.5 5030.8 5043.2 5052.9 5069.5 5935.2 5949.3 5971.4 5980.9 6016.4 1493.8 1539.0 1555.8 1558.8 1561.1 976.6 979.5 998.4 1036.2 1060.7 5703.8 5717.2 5732.4 5755.8 5766.4 5947.5 5991.6 6020.5 6021.4 6043.2 5518.9 5683.3 5819.2 5845.3 5861.8 3210.2 3246.5 3284.2 3288.6 3289.7 6260.3 6317.1 6399.8 6424.4 6484.5 6207.8 6272.7 6288.0 6300.7 6307.8 6195.3 6338.9 6377.2 6381.0 6433.4 6028.5 6075.6 6114.6 6121.7 6141.6 6092.7 6094.9 6094.9 6096.2 6113.3 6078.5 6313.8 6390.8 6412.4 6424.0 4422.9 4452.9 4488.4 4493.0 4509.6 5967.8 6043.7 6130.4 6135.6 6158.3 5906.9 5944.3 5948.8 5971.8 5989.0 5914.6 5963.3 5967.6 5974.4 6003.1 5609.6 5880.6 5883.6 5883.9 5885.1 6006.4 6010.0 6011.8 6029.4 6031.5 5639.2 5823.8 5879.8 5904.6 5906.9 11:21:56 INFO - PROCESS | 16994 | 11:21:56 INFO - PROCESS | 16994 | [#5] yui.html Cycles:180 Average:19719.04 Median:609.59 stddev:28802.32 (4724.8%) stddev-sans-first:28848.14 11:21:56 INFO - PROCESS | 16994 | Values: 814.9 835.5 837.1 842.1 866.1 13463.9 14126.3 14580.3 14618.9 14674.9 13312.9 13386.3 13407.6 13409.7 13445.1 776.1 776.7 793.7 796.1 803.1 809.3 812.9 813.6 814.6 815.5 843.2 846.8 850.9 853.5 853.8 835.6 836.7 836.7 841.4 843.6 614.8 615.5 616.2 617.6 618.8 14073.2 14102.9 14159.0 14164.0 14174.6 15015.5 15084.7 15094.3 15187.9 15303.9 12209.8 12227.3 12305.8 12384.5 12855.2 3827.9 3835.8 3925.3 3983.3 4067.2 79860.0 81557.6 81752.0 81904.6 82336.2 10965.2 11464.1 11777.4 11781.5 12022.6 21198.3 21239.0 21314.5 21500.0 21536.7 7805.3 7811.3 8143.7 8318.3 8351.7 4557.7 4659.2 4701.6 4762.5 4852.8 3625.7 3634.8 3641.4 3694.5 3727.5 643.4 651.3 651.6 653.6 656.4 697.7 705.1 712.6 712.8 719.1 8510.7 8725.4 9001.4 9025.0 9214.4 604.4 665.5 685.2 701.4 704.5 4364.7 4449.4 4462.7 4499.7 4553.1 64029.4 64209.7 64360.0 78551.0 121837.0 103902.5 104117.0 106308.0 106772.5 108479.5 54966.2 74117.6 92769.0 92860.0 94700.5 8168.5 8209.7 8331.5 8594.7 8818.3 55550.0 55812.2 55818.4 55866.7 56833.0 77200.0 78947.2 80865.0 81540.2 82346.6 9834.3 9979.0 10627.5 10820.8 11356.5 11757.9 12287.7 12631.6 12649.0 12985.0 10686.5 11014.4 11110.7 11389.1 11409.1 10863.2 10919.2 11007.4 11017.9 11032.2 10786.5 10829.9 10837.2 10839.2 10856.3 8967.2 9081.8 9103.3 9137.4 9343.9 9515.4 9537.9 9547.0 9553.8 9621.0 11:21:56 INFO - PROCESS | 16994 | -------- Summary: end -------- 11:21:56 INFO - PROCESS | 16994 | 11:21:57 INFO - TEST-INFO | 16994: exit 0 11:21:57 INFO - TEST-OK | dromaeo_css | took 1111851ms 11:21:57 INFO - TEST-START | kraken 11:21:57 INFO - operating with platform_type : linux_ 11:21:57 INFO - Initialising browser for kraken test... 11:21:57 INFO - TEST-INFO | started process 17241 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAWWiEa/profile http://localhost:40449/getInfo.html) 11:22:02 INFO - PROCESS | 17241 | __metrics Screen width/height:1600/1200 11:22:02 INFO - PROCESS | 17241 | colorDepth:24 11:22:02 INFO - PROCESS | 17241 | Browser inner width/height: 1024/697 11:22:02 INFO - PROCESS | 17241 | __metrics 11:22:03 ERROR - PROCESS | 17241 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 11:22:04 INFO - TEST-INFO | 17241: exit 0 11:22:04 INFO - Browser initialized. 11:22:04 INFO - Running cycle 1/1 for kraken test... 11:22:04 INFO - TEST-INFO | started process 17363 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAWWiEa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:22:16 INFO - PROCESS | 17363 | RSS: Main: 168734720 11:22:16 INFO - PROCESS | 17363 | 11:22:18 INFO - PROCESS | 17363 | Cycle 1(1): loaded http://localhost:40449/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40449/tests/kraken/driver.html?testName=audio-beat-detection) 11:22:19 INFO - PROCESS | 17363 | RSS: Main: 173895680 11:22:19 INFO - PROCESS | 17363 | 11:22:22 INFO - PROCESS | 17363 | Cycle 1(1): loaded http://localhost:40449/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40449/tests/kraken/driver.html?testName=audio-dft) 11:22:22 INFO - PROCESS | 17363 | RSS: Main: 173568000 11:22:22 INFO - PROCESS | 17363 | 11:22:25 INFO - PROCESS | 17363 | Cycle 1(1): loaded http://localhost:40449/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40449/tests/kraken/driver.html?testName=audio-fft) 11:22:26 INFO - PROCESS | 17363 | RSS: Main: 168099840 11:22:26 INFO - PROCESS | 17363 | 11:22:28 INFO - PROCESS | 17363 | Cycle 1(1): loaded http://localhost:40449/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40449/tests/kraken/driver.html?testName=audio-oscillator) 11:22:28 INFO - PROCESS | 17363 | RSS: Main: 168931328 11:22:28 INFO - PROCESS | 17363 | 11:22:31 INFO - PROCESS | 17363 | Cycle 1(1): loaded http://localhost:40449/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40449/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:22:31 INFO - PROCESS | 17363 | RSS: Main: 169201664 11:22:31 INFO - PROCESS | 17363 | 11:22:34 INFO - PROCESS | 17363 | Cycle 1(1): loaded http://localhost:40449/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40449/tests/kraken/driver.html?testName=imaging-darkroom) 11:22:35 INFO - PROCESS | 17363 | RSS: Main: 168648704 11:22:35 INFO - PROCESS | 17363 | 11:22:38 INFO - PROCESS | 17363 | Cycle 1(1): loaded http://localhost:40449/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40449/tests/kraken/driver.html?testName=imaging-desaturate) 11:22:39 INFO - PROCESS | 17363 | RSS: Main: 169934848 11:22:39 INFO - PROCESS | 17363 | 11:22:42 INFO - PROCESS | 17363 | Cycle 1(1): loaded http://localhost:40449/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40449/tests/kraken/driver.html?testName=json-parse-financial) 11:22:42 INFO - PROCESS | 17363 | RSS: Main: 169521152 11:22:42 INFO - PROCESS | 17363 | 11:22:44 INFO - PROCESS | 17363 | Cycle 1(1): loaded http://localhost:40449/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40449/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:22:45 INFO - PROCESS | 17363 | RSS: Main: 169836544 11:22:45 INFO - PROCESS | 17363 | 11:22:46 INFO - PROCESS | 17363 | Cycle 1(1): loaded http://localhost:40449/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40449/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:22:47 INFO - PROCESS | 17363 | RSS: Main: 170135552 11:22:47 INFO - PROCESS | 17363 | 11:22:49 INFO - PROCESS | 17363 | Cycle 1(1): loaded http://localhost:40449/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40449/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:22:50 INFO - PROCESS | 17363 | RSS: Main: 170418176 11:22:50 INFO - PROCESS | 17363 | 11:22:52 INFO - PROCESS | 17363 | Cycle 1(1): loaded http://localhost:40449/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40449/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:22:53 INFO - PROCESS | 17363 | RSS: Main: 170708992 11:22:53 INFO - PROCESS | 17363 | 11:22:56 INFO - PROCESS | 17363 | Cycle 1(1): loaded http://localhost:40449/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40449/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:22:56 INFO - PROCESS | 17363 | RSS: Main: 170213376 11:22:56 INFO - PROCESS | 17363 | 11:22:58 INFO - PROCESS | 17363 | Cycle 1(1): loaded http://localhost:40449/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40449/tests/kraken/driver.html?testName=ai-astar) 11:22:58 INFO - PROCESS | 17363 | RSS: Main: 171008000 11:22:58 INFO - PROCESS | 17363 | 11:22:58 INFO - PROCESS | 17363 | __start_tp_report 11:22:58 INFO - PROCESS | 17363 | _x_x_mozilla_page_load 11:22:58 INFO - PROCESS | 17363 | _x_x_mozilla_page_load_details 11:22:58 INFO - PROCESS | 17363 | |i|pagename|runs| 11:22:58 INFO - PROCESS | 17363 | |0;ai-astar;104;110;105;110;112;113;112;115;113;111 11:22:58 INFO - PROCESS | 17363 | |1;audio-beat-detection;148;123;148;176;122;150;147;121;176;121 11:22:58 INFO - PROCESS | 17363 | |2;audio-dft;162;163;164;163;171;165;177;165;162;162 11:22:58 INFO - PROCESS | 17363 | |3;audio-fft;74;76;74;160;76;76;75;78;167;75 11:22:58 INFO - PROCESS | 17363 | |4;audio-oscillator;85;83;159;84;84;84;150;84;84;156 11:22:58 INFO - PROCESS | 17363 | |5;imaging-gaussian-blur;117;118;117;117;118;117;117;119;117;117 11:22:58 INFO - PROCESS | 17363 | |6;imaging-darkroom;147;146;147;149;148;147;146;148;147;149 11:22:58 INFO - PROCESS | 17363 | |7;imaging-desaturate;101;101;95;95;95;96;95;97;95;95 11:22:58 INFO - PROCESS | 17363 | |8;json-parse-financial;58;58;53;54;54;55;55;57;56;54 11:22:58 INFO - PROCESS | 17363 | |9;json-stringify-tinderbox;59;60;59;59;61;60;60;60;61;61 11:22:58 INFO - PROCESS | 17363 | |10;stanford-crypto-aes;75;75;78;75;79;76;75;80;81;78 11:22:58 INFO - PROCESS | 17363 | |11;stanford-crypto-ccm;138;126;128;128;122;135;135;128;161;134 11:22:58 INFO - PROCESS | 17363 | |12;stanford-crypto-pbkdf2;161;166;158;156;162;160;161;161;159;159 11:22:58 INFO - PROCESS | 17363 | |13;stanford-crypto-sha256-iterative;67;64;65;68;67;63;63;63;62;60 11:22:58 INFO - PROCESS | 17363 | __end_tp_report 11:22:58 INFO - PROCESS | 17363 | __start_cc_report 11:22:58 INFO - PROCESS | 17363 | _x_x_mozilla_cycle_collect,905 11:22:58 INFO - PROCESS | 17363 | __end_cc_report 11:22:58 INFO - PROCESS | 17363 | __startTimestamp1467224578843__endTimestamp 11:22:58 INFO - PROCESS | 17363 | 11:22:58 INFO - PROCESS | 17363 | ------- Summary: start ------- 11:22:58 INFO - PROCESS | 17363 | Number of tests: 14 11:22:58 INFO - PROCESS | 17363 | 11:22:58 INFO - PROCESS | 17363 | [#0] ai-astar Cycles:10 Average:110.50 Median:112.00 stddev:3.50 (3.1%) stddev-sans-first:2.82 11:22:58 INFO - PROCESS | 17363 | Values: 104.0 110.0 105.0 110.0 112.0 113.0 112.0 115.0 113.0 111.0 11:22:58 INFO - PROCESS | 17363 | 11:22:58 INFO - PROCESS | 17363 | [#1] audio-beat-detection Cycles:10 Average:143.20 Median:148.00 stddev:21.35 (14.4%) stddev-sans-first:22.57 11:22:58 INFO - PROCESS | 17363 | Values: 148.0 123.0 148.0 176.0 122.0 150.0 147.0 121.0 176.0 121.0 11:22:58 INFO - PROCESS | 17363 | 11:22:58 INFO - PROCESS | 17363 | [#2] audio-dft Cycles:10 Average:165.40 Median:164.50 stddev:4.88 (3.0%) stddev-sans-first:5.02 11:22:58 INFO - PROCESS | 17363 | Values: 162.0 163.0 164.0 163.0 171.0 165.0 177.0 165.0 162.0 162.0 11:22:58 INFO - PROCESS | 17363 | 11:22:58 INFO - PROCESS | 17363 | [#3] audio-fft Cycles:10 Average:93.10 Median:75.50 stddev:37.16 (49.2%) stddev-sans-first:38.76 11:22:58 INFO - PROCESS | 17363 | Values: 74.0 76.0 74.0 160.0 76.0 76.0 75.0 78.0 167.0 75.0 11:22:58 INFO - PROCESS | 17363 | 11:22:58 INFO - PROCESS | 17363 | [#4] audio-oscillator Cycles:10 Average:105.30 Median:84.00 stddev:34.37 (40.9%) stddev-sans-first:35.66 11:22:58 INFO - PROCESS | 17363 | Values: 85.0 83.0 159.0 84.0 84.0 84.0 150.0 84.0 84.0 156.0 11:22:58 INFO - PROCESS | 17363 | 11:22:58 INFO - PROCESS | 17363 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 11:22:58 INFO - PROCESS | 17363 | Values: 117.0 118.0 117.0 117.0 118.0 117.0 117.0 119.0 117.0 117.0 11:22:58 INFO - PROCESS | 17363 | 11:22:58 INFO - PROCESS | 17363 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:1.07 (0.7%) stddev-sans-first:1.13 11:22:58 INFO - PROCESS | 17363 | Values: 147.0 146.0 147.0 149.0 148.0 147.0 146.0 148.0 147.0 149.0 11:22:58 INFO - PROCESS | 17363 | 11:22:58 INFO - PROCESS | 17363 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:95.00 stddev:2.46 (2.6%) stddev-sans-first:2.00 11:22:58 INFO - PROCESS | 17363 | Values: 101.0 101.0 95.0 95.0 95.0 96.0 95.0 97.0 95.0 95.0 11:22:58 INFO - PROCESS | 17363 | 11:22:58 INFO - PROCESS | 17363 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.50 stddev:1.78 (3.2%) stddev-sans-first:1.62 11:22:58 INFO - PROCESS | 17363 | Values: 58.0 58.0 53.0 54.0 54.0 55.0 55.0 57.0 56.0 54.0 11:22:58 INFO - PROCESS | 17363 | 11:22:58 INFO - PROCESS | 17363 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:0.82 (1.4%) stddev-sans-first:0.78 11:22:58 INFO - PROCESS | 17363 | Values: 59.0 60.0 59.0 59.0 61.0 60.0 60.0 60.0 61.0 61.0 11:22:58 INFO - PROCESS | 17363 | 11:22:58 INFO - PROCESS | 17363 | [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:78.00 stddev:2.30 (2.9%) stddev-sans-first:2.30 11:22:58 INFO - PROCESS | 17363 | Values: 75.0 75.0 78.0 75.0 79.0 76.0 75.0 80.0 81.0 78.0 11:22:58 INFO - PROCESS | 17363 | 11:22:58 INFO - PROCESS | 17363 | [#11] stanford-crypto-ccm Cycles:10 Average:133.50 Median:134.50 stddev:10.86 (8.1%) stddev-sans-first:11.39 11:22:58 INFO - PROCESS | 17363 | Values: 138.0 126.0 128.0 128.0 122.0 135.0 135.0 128.0 161.0 134.0 11:22:58 INFO - PROCESS | 17363 | 11:22:58 INFO - PROCESS | 17363 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.30 Median:161.00 stddev:2.67 (1.7%) stddev-sans-first:2.82 11:22:58 INFO - PROCESS | 17363 | Values: 161.0 166.0 158.0 156.0 162.0 160.0 161.0 161.0 159.0 159.0 11:22:58 INFO - PROCESS | 17363 | 11:22:58 INFO - PROCESS | 17363 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.50 stddev:2.53 (3.9%) stddev-sans-first:2.47 11:22:58 INFO - PROCESS | 17363 | Values: 67.0 64.0 65.0 68.0 67.0 63.0 63.0 63.0 62.0 60.0 11:22:58 INFO - PROCESS | 17363 | -------- Summary: end -------- 11:22:58 INFO - PROCESS | 17363 | 11:22:59 INFO - TEST-INFO | 17363: exit 0 11:22:59 INFO - TEST-OK | kraken | took 62470ms 11:22:59 INFO - SUITE-END | took 1174s 11:23:00 INFO - Completed test suite (00:19:34) 11:23:00 INFO - javascript benchmark 11:23:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7353.760027112016, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3123.984380078101, 3136.0591822453266, 3153.936921261576, 3155.715985561299, 3157.9210519737007, 5313.22958171065, 5397.082495975688, 5431.646942948705, 5446.2647542581735, 5477.589180811445, 5232.8691782705455, 5357.383900851403, 5430.266913966613, 5446.945530544694, 5459.535939445142, 4911.165101932671, 4937.604991600681, 5019.196928491424, 5081.0, 5139.460356662553, 219.90007740482716, 4780.378550788392, 4870.732109733964, 4874.439439464471, 4878.34142390778, 4881.682690625098, 4937.185364414867, 4945.67853089548, 4954.801807927679, 4960.503949605047, 4962.106820772296, 4968.478309777493, 4973.925391119136, 4976.576990955773, 4977.253411988195, 4855.951440485585, 4892.730899800509, 4913.803447862081, 4914.11545921734, 4917.827876024322, 5403.540699040586, 5415.0, 5454.072807622713, 5466.234727138204, 5470.206820011116, 5720.71396430181, 5861.384554621746, 5874.030784920483, 5883.558733095035, 5896.498797602209, 5881.176635271066, 5955.910661340084, 5957.07665311873, 5979.2824861016525, 6038.788642397495, 5551.306086739158, 5552.805651802208, 5556.833295001156, 5559.8888022239735, 5565.666060036411, 5814.534837213013, 5964.731587078505, 5999.670018149044, 6058.454739073504, 6069.332373438918, 5770.711464426762, 5809.68046757424, 5816.069428891442, 5825.912611310834, 5848.590598658138, 5883.7058147092475, 5886.3230728465915, 5905.143754155709, 5906.704664766745, 5917.911231331534, 5685.658860468385, 5703.287089113861, 5750.597458177971, 5782.624129431658, 5822.214001109881, 5769.624974376652, 5810.62230954995, 5812.21535092757, 5819.592628515963, 5822.796202132905, 4415.558444155623, 4434.55654434554, 4447.888802779957, 4452.888677783081, 4486.910261794746, 3904.2581909437117, 3907.667848232932, 3941.0541470047556, 3947.2302900934615, 4014.558398576154, 5585.273914391103, 5598.692071936001, 5605.915911261334, 5640.887182256414, 5659.717014149276, 5926.970365148233, 5940.584159108907, 5942.1383899335215, 5945.2865656120675, 5946.197263369476, 5430.266913966643, 5547.694876781816, 5567.025770490148, 5590.86022849432, 5625.606207565431, 4878.390201224847, 4893.804247830047, 4896.167651499253, 4902.607791376681, 4955.90088198234, 5944.821655350346, 6124.663143527059, 6125.540584456184, 6130.63216207029, 6134.0, 5787.9131813021995, 5814.825555233434, 5827.970860145672, 5892.852678682896, 5902.4097590240635, 6072.666003369681, 6114.847128821815, 6119.479844213113, 6128.8774224516155, 6133.969330153321, 5540.916886246629, 5739.942600573941, 5761.884762304814, 5771.971140144273, 5778.335491418373, 5880.411958804086, 5935.525157987437, 5940.287165540163, 5945.197398351167, 5992.940070599413, 5692.886142277214, 5769.769209231752, 5798.072308430631, 5800.738966746422, 5804.24544809189, 5540.667559946416, 5645.181448689999, 5652.88694226105, 5756.0, 5780.3352614448195, 5576.749046292845, 5603.943960560342, 5606.719664016864, 5610.691411972381, 5666.518345940642, 5717.17101020358, 5733.369329373682, 5734.942650573441, 5766.884662306814, 5772.19189313488, 5470.070088085115, 5599.524040456607, 5623.325200975909, 5660.29246344207, 5687.289088863892], "value": 5351.373514060866, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.4860374266904, 604.2326245668002, 613.2334581772782, 632.7658766256486, 667.9732810687573, 37599.81200093999, 41323.0, 41396.0, 41411.99999999996, 41479.170416591725, 42040.78979605098, 42050.57949420505, 42297.0, 42360.36459453111, 42569.574304257025, 8747.431416957894, 8801.603927823264, 8803.119688031209, 8846.292296616255, 8880.422772519765, 8823.514706691161, 8879.378443508956, 8901.688440904569, 8902.821943561124, 8946.284297256203, 8821.0, 8826.426282291663, 8833.955830220872, 8878.822423551524, 8969.506677132755, 8823.205911467967, 8895.599698013604, 8911.376203665746, 8921.732348029536, 8925.241354484877, 8758.167974042455, 8781.165789250012, 8783.12168783123, 8801.339899507562, 8840.911590884074, 33809.6619033809, 39956.40065399021, 40239.597604023875, 40380.0, 40480.19039619191, 3352.765306428551, 3427.657234276577, 3528.4530897710897, 3573.8927832165077, 3613.259281847215, 30706.0, 31085.0, 31163.37673246545, 31211.531827022613, 32319.353612927844, 4251.936220956688, 4289.656827453796, 4296.785160741982, 4441.622462090726, 4497.775111244425, 316394.0, 317119.0, 317283.0, 318185.0, 320321.0, 37043.0, 37246.0, 37385.62614373876, 37433.812830936215, 37505.81247093801, 37755.62244377576, 38220.2355952885, 38350.0, 38395.616043839764, 38505.422418663744, 17601.29594816193, 17713.0, 17882.463526094238, 17884.91057544704, 17957.820421795615, 12761.29812860283, 12812.103152779217, 12860.742785144244, 12903.612891613078, 12903.741925161445, 19160.329388471335, 19225.32711355096, 19260.80739192618, 19325.710114348298, 19339.613207735765, 7036.50744447894, 7218.386437152901, 7277.963610181915, 7303.671334789948, 7521.586312752851, 959.9712008639752, 1061.4480470155477, 1094.261373572835, 1107.3466654673782, 1130.7116685245373, 32885.67114328874, 32989.83505082459, 33099.50350744741, 33115.337693246, 33135.0, 1060.596973150198, 1127.515168477546, 1138.6071805227184, 1164.7379339648512, 1199.5861427807567, 16511.33954641825, 16846.157692115346, 16965.236564354633, 16977.320907163576, 17015.553677937267, 272045.0, 274407.0, 275059.0, 276387.0, 584138.0, 57198.7140064297, 58074.64440167004, 58701.0, 58702.0, 58806.11790823141, 1305.5104335874048, 1343.1739480219594, 1345.3609535470573, 1363.3864760857655, 1369.3084992078936, 30500.389992199587, 31595.21011974719, 31968.0, 32160.356792863542, 32453.51319730253, 52598.21102683539, 56432.0, 56669.43330566806, 56806.0, 57233.0, 522738.0, 525307.0, 525823.0, 530270.0, 534060.0, 30032.0, 30755.0, 30913.0726078209, 31949.20126996844, 44446.777766110965, 48462.75768621134, 48861.26708099453, 49092.263616046504, 49815.75092124516, 52569.737151313995, 42819.0, 43456.565434345255, 43543.564564353954, 43776.343354849065, 44909.32636010397, 42887.0, 42972.57027429811, 42973.35539966966, 43494.782526088435, 43569.0, 36393.272134557694, 41453.79273103615, 42500.36249456199, 44247.336289955034, 44373.55626443694, 42227.788861055495, 44433.55566444423, 44555.777221114986, 45073.54926450693, 45319.0, 34086.48870266898, 35103.0, 35243.82378088093, 35284.82357588196, 35399.64600353964], "value": 19865.982270660446, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.3112921258584, 394.7236934146097, 394.95260568731754, 400.4933758795124, 416.99166016679646, 14302.642433939156, 18725.34461293855, 19514.804851951478, 20260.493487662796, 20391.490212744688, 19594.804051959476, 19799.0, 19887.60224795507, 20741.585168296664, 20748.481287967807, 5716.456936591027, 5791.884162316751, 5871.236739223917, 5873.0, 5874.471297583216, 5659.717014149297, 5775.711214439282, 5781.161731548923, 5782.98797710399, 5817.1565123057135, 5667.263255776764, 5730.455606717355, 5834.6790926499025, 5837.357890632048, 5840.737166827482, 5728.742206600713, 5760.7695692172265, 5767.913481297784, 5777.682227477508, 5803.47768700819, 5097.286379906816, 5120.359955005624, 5155.0978578748945, 5173.741312934339, 5205.323307969978, 23465.88267058654, 23644.29067127989, 23898.402539936465, 24168.274951751475, 24500.142495012766, 2431.9721946177124, 2544.3893465568317, 2557.744225577427, 2864.069177517315, 2992.012635830171, 14879.628009299746, 15089.320980555902, 15147.0, 15312.234388280542, 15401.614959625987, 1876.55900863297, 1881.388548721671, 1910.9294020511963, 1929.4211736479, 1954.3159894037115, 76412.61793691051, 81300.0, 84476.15523844745, 85442.57278713629, 85728.14271857264, 10570.52432640533, 10653.627123050655, 10766.515506802212, 10944.781104377867, 11206.83189752138, 15013.399464021317, 15054.172020538757, 15127.924360378127, 15151.0, 15178.392864285304, 8173.713920012771, 8347.540885251248, 8459.280961118251, 8504.277136443472, 8521.44610600309, 8187.1403502631365, 8284.0, 8311.459755115899, 8406.579671016425, 8541.444806087584, 6528.706208220641, 6707.49693772969, 6775.1192344995825, 6826.692798824065, 6843.152348865878, 1911.084388835609, 1984.8709833861042, 2007.498125468633, 2018.3743039657752, 2036.7046778217373, 980.4999450280409, 1015.619142821442, 1060.6923992042375, 1113.5768408005067, 1131.7510147767478, 20509.589808203753, 21198.258060967793, 21217.893910530347, 21269.78730212709, 21320.14719411237, 995.4027583449872, 1026.2149455666422, 1046.6912260883057, 1095.8575385199872, 1152.2280072351546, 11503.942480287713, 12013.339266340436, 12014.879851201551, 12068.939655301667, 12132.272063676031, 446288.0, 447802.0, 462054.0, 466782.0, 467120.0, 50908.74545627248, 87587.0, 88192.55903720441, 89388.0, 89453.55273223593, 991.3110388280076, 1017.1049476460815, 1017.7481697512102, 1018.2261481274137, 1033.7363972187195, 17971.730424043388, 18546.16542255629, 18823.8347399475, 19037.333693320666, 19040.61918761645, 41302.38046429366, 42237.36643950282, 43114.78442607767, 43940.0, 44373.55626443694, 53919.19121213263, 54192.0, 55323.0, 55926.72036639791, 63263.0, 8917.73246802597, 9034.503102329172, 9234.445933244027, 9250.629974800933, 9577.473238971923, 8956.552172391224, 14432.134071955295, 14433.711325773636, 14454.638634034232, 14476.348564314841, 12347.19743216688, 12624.87375126237, 12648.367581620698, 12666.28223737837, 12950.935245323713, 10577.9471102644, 12553.874461255637, 12716.809247861474, 12791.296478693761, 12906.80639790385, 12867.420966056738, 12925.935370323465, 13225.867741322463, 13290.534831281246, 13314.533991310258, 7664.425168112302, 9096.317776166681, 9372.250219982521, 9374.343795934219, 9489.620415183592, 10867.728306792393, 11734.88265117372, 12488.313142777235, 12526.937365313479, 12675.873241267469], "value": 9645.704922828938, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1503.4437258214462, 1536.431520337475, 1656.9420070297542, 1787.177898166843, 1820.7177887427454, 7792.883106753389, 8756.518391488482, 8780.824383512327, 9458.337916345867, 9466.574004169812, 8781.0, 8921.107889211076, 8997.775055623597, 9048.502332371718, 9127.863082053775, 2257.3566533537987, 2289.4505318723554, 2302.9193978210765, 2303.6199027160496, 2304.1474654377903, 2251.0995601759264, 2254.391314345126, 2291.942701432469, 2292.793648571628, 2295.517941232335, 2274.9886250568807, 2299.1722979727283, 2323.140438037928, 2324.3491822289784, 2331.1374791327235, 2194.1333173396497, 2196.3959911024517, 2206.2719302630094, 2210.9005094770773, 2214.4685275533916, 2177.7168968034052, 2188.376312750874, 2189.3650841256017, 2215.213599172303, 2223.977760222393, 8957.910420895772, 9071.954640226822, 9082.137196966278, 9125.634974601007, 9137.0, 5391.568674506069, 5490.917636235459, 5497.092979658351, 5499.257600223958, 5505.972470137664, 3298.7855789373853, 3372.9325413491592, 3438.381091403546, 3469.757117001811, 3535.6641119093647, 1136.732867776072, 1140.0651465798048, 1152.8501294831701, 1154.065207182185, 1181.6100686773343, 13108.082434229607, 13208.801867971988, 13251.204927704368, 13271.535496257682, 13286.20282783036, 4696.365990591295, 4729.793902554827, 4828.058528586892, 4853.39332583427, 4977.701337919736, 11094.057005154653, 11148.66554003365, 11176.608818691308, 11243.156763242789, 11246.49390777417, 5618.213450116987, 5668.121441176624, 5675.091985282417, 5676.091825307931, 5695.45893140151, 4294.849680261176, 4980.551750342486, 4991.825286114969, 5172.094883395466, 5181.4300426953005, 4164.37534369847, 4164.83340666376, 4366.366876802909, 4405.713628614194, 4422.646188304928, 1350.2978451205317, 1360.8843248323806, 1374.4227424481742, 1378.3590630356732, 1401.9299035048207, 953.6185525789601, 959.6161535385762, 967.4823969176457, 972.7422233108232, 982.2387649571497, 6135.693215339215, 6218.409251121137, 6311.084892690534, 6360.681965901686, 6369.872602547923, 438.6140196626948, 442.49997502821606, 445.9531749166356, 470.0716085730655, 471.1636844600861, 4029.234445455354, 4088.059746258318, 4160.875173744793, 4180.3102488089735, 4197.013701780079, 11441.771164576829, 11729.706757331134, 11859.229150105215, 11861.644150675322, 11865.525378984916, 10802.513886874953, 11089.667309980552, 11249.381284029294, 11752.588659397052, 11784.057275418118, 8624.353173512012, 8742.0, 8750.91249087501, 8800.207981281588, 8820.073892241222, 6207.534434917309, 6458.38645328693, 6472.514561407819, 6479.643619600967, 6546.934530654633, 10067.395956242648, 10852.511636976196, 10865.348079115278, 11017.0, 11057.557697692002, 10475.266731329039, 10947.0, 10947.616833410792, 10994.34033957965, 11143.275687080639, 8000.0, 8219.95890020546, 8348.457350272212, 8354.415190936576, 8356.373272004503, 9174.403663762101, 9203.309751768778, 9220.0, 9262.583183756882, 9344.15902568772, 8104.0, 8358.164183581594, 8375.0, 8414.0, 8547.40168188221, 8200.671973121247, 8219.260266576037, 8292.2951549119, 8309.04445988719, 8348.206920342558, 7328.96335518319, 7339.376153026839, 7358.190599033995, 7358.926410735824, 7375.704971801068, 5228.660137091229, 5333.866653333697, 5418.187271909245, 5499.752511136929, 5559.471850174227, 5541.501264886179, 5548.0, 5559.833205003856, 5582.078956972054, 5626.521745651666], "value": 4737.600131719636, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.4250603949128, 334.78908287778694, 335.5738212470162, 342.4230172159909, 343.3767711603441, 5664.640486283288, 5675.489205971462, 5705.343885453174, 5707.3721890592005, 5757.222774925383, 5599.188117722928, 5611.242482264893, 5648.858778530539, 5653.519450846683, 5673.092305231164, 4144.48193975753, 4214.957850421487, 4335.544767799383, 4352.673549483786, 4352.673549483786, 4327.420491520588, 4353.2599458092045, 4375.934360984587, 4378.824847006132, 4380.299152135659, 4326.242907491192, 4374.321980093075, 4383.583559561853, 4391.121775644868, 4400.603945644892, 4289.2334444283415, 4345.261305578044, 4354.651627869763, 4372.256716358227, 4388.232059389626, 3781.9054523636855, 3826.7321287509885, 3839.2897313997, 3870.3033453978273, 3884.378499440076, 5331.893362132736, 5388.353397592275, 5394.0, 5473.917891231635, 5526.226328314039, 4870.780814863339, 5045.571126454256, 5052.444231134609, 5067.594592432597, 5073.568746656539, 5904.468597826216, 5914.615549989237, 5930.55520835939, 5951.047832346804, 5979.833932383187, 4295.463067116611, 4301.1397720455725, 4314.050908800059, 4320.833374988735, 4325.956740432618, 6019.307779605314, 6061.909071363933, 6084.1100477273385, 6108.175396321484, 6135.693215339215, 4373.0, 4404.11917616478, 4410.2282100632265, 4414.1171765647, 4421.46942366918, 4438.334249862546, 4447.110577884436, 4458.175237581057, 4458.420405347284, 4468.843590474383, 4877.512248775094, 5030.84907452777, 5043.2435134730085, 5052.873678158076, 5069.518395752398, 5935.249101515064, 5949.345571987078, 5971.4327138921735, 5980.9497156450525, 6016.368281330485, 1493.7983372244826, 1538.9769153462707, 1555.7510798272222, 1558.758392449172, 1561.1179683479024, 976.6288810252058, 979.5151400056875, 998.3959704378747, 1036.1710631494775, 1060.7006417138944, 5703.771849126071, 5717.22817419643, 5732.426757324234, 5755.798547050833, 5766.4233576642, 5947.51312171957, 5991.55063370249, 6020.458158765732, 6021.41079335881, 6043.184170137063, 5518.862028449321, 5683.261176047087, 5819.185314056035, 5845.3277873045145, 5861.765529378862, 3210.197450637341, 3246.5454836322933, 3284.178955261185, 3288.6053673559327, 3289.73682105431, 6260.283397983695, 6317.084022816666, 6399.840003999937, 6424.357564243632, 6484.481241500669, 6207.844803879849, 6272.6550039747335, 6288.0, 6300.716467758962, 6307.842303942346, 6195.31851496326, 6338.873222535523, 6377.234731832117, 6380.968095159495, 6433.420992110732, 6028.5177185825905, 6075.605085669417, 6114.57197996136, 6121.693915304128, 6141.570090093829, 6092.725827337692, 6094.878102437838, 6094.939050609614, 6096.177016102769, 6113.29697084841, 6078.54410919174, 6313.779017734358, 6390.840228994126, 6412.422881940648, 6423.976447419048, 4422.889427764331, 4452.888677782952, 4488.438945131858, 4492.955070449254, 4509.57159069901, 5967.8209653710455, 6043.697815109139, 6130.356312587114, 6135.570510064253, 6158.3225845157895, 5906.9072221639135, 5944.256967879015, 5948.821535353946, 5971.820845374646, 5988.970055149871, 5914.556408269311, 5963.28440587115, 5967.552433567586, 5974.4324289192455, 6003.099535069775, 5609.5512359012, 5880.647161170344, 5883.588148829712, 5883.852648733456, 5885.146653735099, 6006.399360063959, 6010.0, 6011.789587364421, 6029.3669164737075, 6031.457168854824, 5639.210510528447, 5823.767049317979, 5879.794207202727, 5904.645721256738, 5906.852328691817], "value": 4536.610887064464, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [814.8736945773408, 835.4653022065877, 837.1419295222393, 842.1241908415249, 866.1338661338661, 13463.932680336597, 14126.293685315744, 14580.343884525195, 14618.926905365472, 14674.926625366872, 13312.933435332834, 13386.263755493444, 13407.597772066854, 13409.731805363912, 13445.126066805675, 776.095848336687, 776.7281451491989, 793.7102957420528, 796.1322158846856, 803.0644299391203, 809.299955538458, 812.9430939834214, 813.6175997281298, 814.6008455856618, 815.4943934760428, 843.2200214801314, 846.7544412120509, 850.8851305073798, 853.5092321914892, 853.7566793463864, 835.5947365527715, 836.6611522333465, 836.7447928381841, 841.3521588376946, 843.6245870587591, 614.7663887722637, 615.4922189193933, 616.1989413762092, 617.5954749638994, 618.7679620142446, 14073.155610663393, 14102.858971410256, 14159.0, 14164.0, 14174.574762757135, 15015.474458394014, 15084.698306033928, 15094.320755565916, 15187.924060379737, 15303.923480382527, 12209.755804883942, 12227.266364018098, 12305.815412768816, 12384.504619815196, 12855.228686278853, 3827.9469055683385, 3835.76985380878, 3925.2934471795065, 3983.2830090583684, 4067.2068946555432, 79860.0, 81557.59221203915, 81752.0, 81904.59047704782, 82336.17663823404, 10965.232433729563, 11464.082873370111, 11777.352245626573, 11781.528738850522, 12022.639320820215, 21198.258060967793, 21239.0, 21314.467138321666, 21500.0, 21536.676949845765, 7805.297523222937, 7811.257930496708, 8143.714969976022, 8318.292945099734, 8351.66593336272, 4557.72653640776, 4659.184642687516, 4701.576858082789, 4762.499937506512, 4852.781624826891, 3625.6736893679695, 3634.7637403568683, 3641.362761516724, 3694.538182727159, 3727.496787933594, 643.4434214404506, 651.3486513486514, 651.6318280171688, 653.6372313366128, 656.4289068510426, 697.7278861244118, 705.1221229569219, 712.6294326949957, 712.8004158835535, 719.144218380126, 8510.723371502016, 8725.389222754346, 9001.369904106781, 9025.0, 9214.401063930824, 604.4227762486814, 665.457044401712, 685.2222727204559, 701.3547536266647, 704.5455681085773, 4364.672649551297, 4449.354843547732, 4462.732236065782, 4499.662525310615, 4553.089382123589, 64029.35970640327, 64209.67895160494, 64360.03459948105, 78551.0, 121837.0, 103902.48048759859, 104117.0, 106308.0, 106772.46613767037, 108479.45760271305, 54966.189031552254, 74117.6294118526, 92769.0, 92860.0, 94700.52649736707, 8168.469049511763, 8209.671613135408, 8331.50010999342, 8594.699185528476, 8818.250448711931, 55550.0, 55812.16281755858, 55818.441815581325, 55866.72066639641, 56833.0, 77200.0, 78947.21052789399, 80865.0, 81540.18459815325, 82346.58826706068, 9834.262430317613, 9979.0, 10627.521761520904, 10820.837687434852, 11356.488957997075, 11757.88242117602, 12287.69280767988, 12631.621051368473, 12649.0, 12985.0, 10686.465676716289, 11014.39420831862, 11110.666719993653, 11389.145814063813, 11409.144314176636, 10863.185261105291, 10919.235653504178, 11007.449627518432, 11017.889821101686, 11032.172587056164, 10786.460676965964, 10829.891701082888, 10837.241393102408, 10839.187060970302, 10856.34861908288, 8967.192952634034, 9081.818363632823, 9103.271738260792, 9137.406068605786, 9343.859842102509, 9515.381500202464, 9537.904620953701, 9547.0, 9553.761155970878, 9620.95189524048], "value": 7174.900650424924, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1529.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 110.0, 105.0, 110.0, 112.0, 113.0, 112.0, 115.0, 113.0, 111.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 123.0, 148.0, 176.0, 122.0, 150.0, 147.0, 121.0, 176.0, 121.0], "value": 143.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 164.0, 163.0, 171.0, 165.0, 177.0, 165.0, 162.0, 162.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 74.0, 160.0, 76.0, 76.0, 75.0, 78.0, 167.0, 75.0], "value": 93.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 159.0, 84.0, 84.0, 84.0, 150.0, 84.0, 84.0, 156.0], "value": 105.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 119.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 149.0, 148.0, 147.0, 146.0, 148.0, 147.0, 149.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 101.0, 95.0, 95.0, 95.0, 96.0, 95.0, 97.0, 95.0, 95.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 53.0, 54.0, 54.0, 55.0, 55.0, 57.0, 56.0, 54.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 59.0, 61.0, 60.0, 60.0, 60.0, 61.0, 61.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 78.0, 75.0, 79.0, 76.0, 75.0, 80.0, 81.0, 78.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 126.0, 128.0, 128.0, 122.0, 135.0, 135.0, 128.0, 161.0, 134.0], "value": 133.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 166.0, 158.0, 156.0, 162.0, 160.0, 161.0, 161.0, 159.0, 159.0], "value": 160.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 65.0, 68.0, 67.0, 63.0, 63.0, 63.0, 62.0, 60.0], "value": 64.2, "unit": "score"}]}]} 11:23:00 INFO - Return code: 0 11:23:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:23:00 ERROR - # TBPL SUCCESS # 11:23:00 INFO - Running post-action listener: _resource_record_post_action 11:23:00 INFO - ##### 11:23:00 INFO - ##### Finished run-tests step (success) 11:23:00 INFO - ##### 11:23:00 INFO - Running post-run listener: _resource_record_post_run 11:23:00 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 568340480; Read time: 332; Write time: 1042244 11:23:00 INFO - TinderboxPrint: CPU usage
13.4% 11:23:00 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 332 11:23:00 INFO - TinderboxPrint: I/O write bytes / time
568,340,480 / 1,042,244 11:23:00 INFO - TinderboxPrint: CPU idle
8,238.7 (86.6%) 11:23:00 INFO - TinderboxPrint: CPU user
1,209.4 (12.7%) 11:23:00 INFO - TinderboxPrint: Swap in / out
0 / 0 11:23:00 INFO - install - Wall time: 17s; CPU: 17.0%; Read bytes: 0; Write bytes: 272396288; Read time: 0; Write time: 679584 11:23:00 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295944192; Read time: 332; Write time: 362660 11:23:00 INFO - Running post-run listener: _upload_blobber_files 11:23:00 INFO - Blob upload gear active. 11:23:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:23:00 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 11:23:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:23:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:23:01 INFO - (blobuploader) - INFO - Open directory for files ... 11:23:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:23:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:23:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:23:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:23:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:23:04 INFO - (blobuploader) - INFO - Done attempting. 11:23:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:23:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:23:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:23:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:23:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:23:05 INFO - (blobuploader) - INFO - Done attempting. 11:23:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:23:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:23:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:23:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:23:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:23:05 INFO - (blobuploader) - INFO - Done attempting. 11:23:05 INFO - (blobuploader) - INFO - Iteration through files over. 11:23:05 INFO - Return code: 0 11:23:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:23:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:23:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/90f7e3fa04c161df726d0f76706c56cf23e97029aad6345d32cd41784651b91c1305f1b7555a2fd3bbc47aaa3252b7422007359b64668927f5306d7771f757f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f34a084e923aff45293c8a7ab8f1007c27b43e886dc74458f6611ce17c98b16bc87ba1cb60e165d54a3a408b2bc26abf072817e66dd637ec3df6a66beab2cb96", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/666dcfe909c6ecab886691fdd7364ec24831abecca4820b8dfe30d9b8f7592311f4b62b7a5e03ff643ca92e6e493bf0f76a8d8f7e83f7aa1b02fdf574ff83f11"} 11:23:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:23:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:23:05 INFO - Contents: 11:23:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/90f7e3fa04c161df726d0f76706c56cf23e97029aad6345d32cd41784651b91c1305f1b7555a2fd3bbc47aaa3252b7422007359b64668927f5306d7771f757f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f34a084e923aff45293c8a7ab8f1007c27b43e886dc74458f6611ce17c98b16bc87ba1cb60e165d54a3a408b2bc26abf072817e66dd637ec3df6a66beab2cb96", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/666dcfe909c6ecab886691fdd7364ec24831abecca4820b8dfe30d9b8f7592311f4b62b7a5e03ff643ca92e6e493bf0f76a8d8f7e83f7aa1b02fdf574ff83f11"} 11:23:05 INFO - Running post-run listener: copy_logs_to_upload_dir 11:23:05 INFO - Copying logs to upload dir... 11:23:05 INFO - mkdir: /builds/slave/test/build/upload/logs 11:23:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.730630 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-06-29 11:23:05.546886) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 11:23:05.550463) ========= 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=745a4373a2a16df560f216e000000264-1467223353.339480-25359402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/90f7e3fa04c161df726d0f76706c56cf23e97029aad6345d32cd41784651b91c1305f1b7555a2fd3bbc47aaa3252b7422007359b64668927f5306d7771f757f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f34a084e923aff45293c8a7ab8f1007c27b43e886dc74458f6611ce17c98b16bc87ba1cb60e165d54a3a408b2bc26abf072817e66dd637ec3df6a66beab2cb96", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/666dcfe909c6ecab886691fdd7364ec24831abecca4820b8dfe30d9b8f7592311f4b62b7a5e03ff643ca92e6e493bf0f76a8d8f7e83f7aa1b02fdf574ff83f11"} build_url:https://queue.taskcluster.net/v1/task/edElhXcdSVqAWMyG-E7syw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011119 build_url: 'https://queue.taskcluster.net/v1/task/edElhXcdSVqAWMyG-E7syw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/90f7e3fa04c161df726d0f76706c56cf23e97029aad6345d32cd41784651b91c1305f1b7555a2fd3bbc47aaa3252b7422007359b64668927f5306d7771f757f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f34a084e923aff45293c8a7ab8f1007c27b43e886dc74458f6611ce17c98b16bc87ba1cb60e165d54a3a408b2bc26abf072817e66dd637ec3df6a66beab2cb96", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/666dcfe909c6ecab886691fdd7364ec24831abecca4820b8dfe30d9b8f7592311f4b62b7a5e03ff643ca92e6e493bf0f76a8d8f7e83f7aa1b02fdf574ff83f11"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 11:23:05.575536) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 11:23:05.575825) ========= 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=745a4373a2a16df560f216e000000264-1467223353.339480-25359402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004457 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 11:23:05.661170) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 11:23:05.661518) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 11:23:05.661828) ========= ========= Total master_lag: 0.17 =========