builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-064 starttime: 1467223894.01 results: success (0) buildid: 20160629083023 builduid: b76d946d6787438099458f7a41084178 revision: eeb6862f960c1310bde9aed159f3fc5bb2d4b6d7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 11:11:34.006911) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 11:11:34.007371) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 11:11:34.007665) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 11:11:34.022022) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 11:11:34.022359) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1467223893.905306-1755092311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-29 11:11: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% 104M=0s 2016-06-29 11:11:34 (104 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087934 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 11:11:34.125048) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 11:11:34.125356) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1467223893.905306-1755092311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019011 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 11:11:34.174389) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 11:11:34.174744) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1467223893.905306-1755092311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-29 11:11:34,877 truncating revision to first 12 chars 2016-06-29 11:11:34,877 Setting DEBUG logging. 2016-06-29 11:11:34,877 attempt 1/10 2016-06-29 11:11:34,877 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:11:35,201 unpacking tar archive at: fx-team-eeb6862f960c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.653373 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 11:11:34.841706) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 11:11:34.842712) ========= script_repo_revision: eeb6862f960c1310bde9aed159f3fc5bb2d4b6d7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 11:11:34.843172) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 11:11:34.844037) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 11:11:34.853716) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-29 11:11:34.854103) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1467223893.905306-1755092311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:11:35 INFO - MultiFileLogger online at 20160629 11:11:35 in /builds/slave/test 11:11:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:11:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:11:35 INFO - {'append_to_log': False, 11:11:35 INFO - 'base_work_dir': '/builds/slave/test', 11:11:35 INFO - 'blob_upload_branch': 'Fx-Team', 11:11:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:11:35 INFO - 'branch': 'Fx-Team', 11:11:35 INFO - 'buildbot_json_path': 'buildprops.json', 11:11:35 INFO - 'config_files': ('talos/linux_config.py',), 11:11:35 INFO - 'default_actions': ('clobber', 11:11:35 INFO - 'read-buildbot-config', 11:11:35 INFO - 'download-and-extract', 11:11:35 INFO - 'populate-webroot', 11:11:35 INFO - 'create-virtualenv', 11:11:35 INFO - 'install', 11:11:35 INFO - 'run-tests'), 11:11:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:11:35 INFO - 'download_minidump_stackwalk': True, 11:11:35 INFO - 'download_symbols': 'ondemand', 11:11:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:11:35 INFO - 'tooltool.py': '/tools/tooltool.py', 11:11:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:11:35 INFO - '/tools/misc-python/virtualenv.py')}, 11:11:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:11:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:11:35 INFO - 'installer_path': 'installer.exe', 11:11:35 INFO - 'log_level': 'info', 11:11:35 INFO - 'log_name': 'talos', 11:11:35 INFO - 'log_to_console': True, 11:11:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:11:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:11:35 INFO - 'opt_config_files': (), 11:11:35 INFO - 'pip_index': False, 11:11:35 INFO - 'sps_profile': False, 11:11:35 INFO - 'sps_profile_interval': 0, 11:11:35 INFO - 'suite': 'dromaeojs', 11:11:35 INFO - 'system_bits': '32', 11:11:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:11:35 INFO - 'title': 'talos-linux64-ix-064', 11:11:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:11:35 INFO - 'use_talos_json': True, 11:11:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:11:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:11:35 INFO - 'work_dir': 'build'} 11:11:35 INFO - ##### 11:11:35 INFO - ##### Running clobber step. 11:11:35 INFO - ##### 11:11:35 INFO - Running pre-action listener: _resource_record_pre_action 11:11:35 INFO - Running main action method: clobber 11:11:35 INFO - rmtree: /builds/slave/test/build 11:11:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:11:36 INFO - Running post-action listener: _resource_record_post_action 11:11:36 INFO - ##### 11:11:36 INFO - ##### Finished clobber step (success) 11:11:36 INFO - ##### 11:11:36 INFO - ##### 11:11:36 INFO - ##### Running read-buildbot-config step. 11:11:36 INFO - ##### 11:11:36 INFO - Running pre-action listener: _resource_record_pre_action 11:11:36 INFO - Running main action method: read_buildbot_config 11:11:36 INFO - Using buildbot properties: 11:11:36 INFO - { 11:11:36 INFO - "project": "", 11:11:36 INFO - "product": "firefox", 11:11:36 INFO - "script_repo_revision": "production", 11:11:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:11:36 INFO - "repository": "", 11:11:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:11:36 INFO - "buildid": "20160629083023", 11:11:36 INFO - "pgo_build": "True", 11:11:36 INFO - "basedir": "/builds/slave/test", 11:11:36 INFO - "buildnumber": 233, 11:11:36 INFO - "slavename": "talos-linux64-ix-064", 11:11:36 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:11:36 INFO - "platform": "ubuntu64_hw", 11:11:36 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:11:36 INFO - "branch": "fx-team", 11:11:36 INFO - "repo_path": "integration/fx-team", 11:11:36 INFO - "revision": "eeb6862f960c1310bde9aed159f3fc5bb2d4b6d7", 11:11:36 INFO - "stage_platform": "linux64-pgo", 11:11:36 INFO - "builduid": "b76d946d6787438099458f7a41084178", 11:11:36 INFO - "slavebuilddir": "test" 11:11:36 INFO - } 11:11:36 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:11:36 INFO - Running post-action listener: _resource_record_post_action 11:11:36 INFO - ##### 11:11:36 INFO - ##### Finished read-buildbot-config step (success) 11:11:36 INFO - ##### 11:11:36 INFO - ##### 11:11:36 INFO - ##### Running download-and-extract step. 11:11:36 INFO - ##### 11:11:36 INFO - Running pre-action listener: _resource_record_pre_action 11:11:36 INFO - Running main action method: download_and_extract 11:11:36 INFO - mkdir: /builds/slave/test/build/tests 11:11: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:11:36 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:11: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.test_packages.json 11:11: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.test_packages.json 11:11: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.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:11:36 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:11:37 INFO - Downloaded 1361 bytes. 11:11:37 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:11:37 INFO - Using the following test package requirements: 11:11:37 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:11:37 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:11:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:11:37 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:11:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:11:37 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:11:37 INFO - u'jsshell-linux-x86_64.zip'], 11:11:37 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:11:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:11:37 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:11:37 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:11:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:11:37 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:11:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:11:37 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:11:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:11:37 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:11:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:11:37 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:11:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:37 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:11:37 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:11:37 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:11:37 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:11:37 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:11:41 INFO - Downloaded 24268166 bytes. 11:11:41 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:11:41 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:11:42 INFO - Return code: 0 11:11:42 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:11: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:11:42 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:11: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.common.tests.zip 11:11: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.common.tests.zip 11:11: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.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:11:42 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:11:44 INFO - Downloaded 24268166 bytes. 11:11:44 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:11:44 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:11:45 INFO - Return code: 0 11:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:45 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:11:45 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:11:45 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:11:45 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:11:45 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:11:46 INFO - Downloaded 14405245 bytes. 11:11:46 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:11:46 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:11:47 INFO - Return code: 0 11:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:11:47 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:11:47 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:11:47 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:11:47 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:11:47 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:11:48 INFO - Downloaded 60338855 bytes. 11:11:48 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:11:48 INFO - mkdir: /builds/slave/test/properties 11:11:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:11:48 INFO - Writing to file /builds/slave/test/properties/build_url 11:11:48 INFO - Contents: 11:11:48 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:11:49 INFO - Running post-action listener: _resource_record_post_action 11:11:49 INFO - Running post-action listener: set_extra_try_arguments 11:11:49 INFO - ##### 11:11:49 INFO - ##### Finished download-and-extract step (success) 11:11:49 INFO - ##### 11:11:49 INFO - ##### 11:11:49 INFO - ##### Running populate-webroot step. 11:11:49 INFO - ##### 11:11:49 INFO - Running pre-action listener: _resource_record_pre_action 11:11:49 INFO - Running main action method: populate_webroot 11:11:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:11:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:11:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:11:49 INFO - '--tppagecycles', 11:11:49 INFO - '7'], 11:11:49 INFO - 'tests': ['tsvgm']}}, 11:11:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:11:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:11:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:11:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:11:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:11:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:11:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:49 INFO - 'talos_options': ['--disable-e10s'], 11:11:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:11:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:11:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:49 INFO - 'talos_options': ['--disable-e10s'], 11:11:49 INFO - 'tests': ['damp', 'tps']}, 11:11:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:49 INFO - 'tests': ['damp', 'tps']}, 11:11:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:11:49 INFO - 'tests': ['dromaeo_dom']}, 11:11:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:11:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:11:49 INFO - 'tests': ['basic_compositor_video']}, 11:11:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:11:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:11:49 INFO - 'tests': ['a11yr', 11:11:49 INFO - 'ts_paint', 11:11:49 INFO - 'tpaint', 11:11:49 INFO - 'sessionrestore', 11:11:49 INFO - 'sessionrestore_no_auto_restore', 11:11:49 INFO - 'tabpaint']}, 11:11:49 INFO - 'other-e10s': {'tests': ['a11yr', 11:11:49 INFO - 'ts_paint', 11:11:49 INFO - 'tpaint', 11:11:49 INFO - 'sessionrestore', 11:11:49 INFO - 'sessionrestore_no_auto_restore', 11:11:49 INFO - 'tabpaint']}, 11:11:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:11:49 INFO - 'ts_paint', 11:11:49 INFO - 'tpaint', 11:11:49 INFO - 'sessionrestore', 11:11:49 INFO - 'sessionrestore_no_auto_restore', 11:11:49 INFO - 'tabpaint']}, 11:11:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:11:49 INFO - 'ts_paint', 11:11:49 INFO - 'tpaint', 11:11:49 INFO - 'sessionrestore', 11:11:49 INFO - 'sessionrestore_no_auto_restore', 11:11:49 INFO - 'tabpaint']}, 11:11:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:11:49 INFO - 'tests': ['a11yr', 11:11:49 INFO - 'ts_paint', 11:11:49 INFO - 'tpaint', 11:11:49 INFO - 'sessionrestore', 11:11:49 INFO - 'sessionrestore_no_auto_restore', 11:11:49 INFO - 'tabpaint']}, 11:11:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:11:49 INFO - 'tests': ['a11yr', 11:11:49 INFO - 'ts_paint', 11:11:49 INFO - 'tpaint', 11:11:49 INFO - 'sessionrestore', 11:11:49 INFO - 'sessionrestore_no_auto_restore', 11:11:49 INFO - 'tabpaint']}, 11:11:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:11:49 INFO - 'tests': ['tsvgx', 11:11:49 INFO - 'tsvgr_opacity', 11:11:49 INFO - 'tart', 11:11:49 INFO - 'tscrollx', 11:11:49 INFO - 'cart']}, 11:11:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:11:49 INFO - 'tsvgr_opacity', 11:11:49 INFO - 'tart', 11:11:49 INFO - 'tscrollx', 11:11:49 INFO - 'cart']}, 11:11:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:49 INFO - 'talos_options': ['--disable-e10s'], 11:11:49 INFO - 'tests': ['tp5o']}, 11:11:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:49 INFO - 'tests': ['tp5o']}, 11:11:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:49 INFO - 'talos_options': ['--disable-e10s', 11:11:49 INFO - '--xperf_path', 11:11:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:11:49 INFO - 'tests': ['tp5n']}, 11:11:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:49 INFO - 'talos_options': ['--xperf_path', 11:11:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:11:49 INFO - 'tests': ['tp5n']}}, 11:11:49 INFO - 'talos.zip': {'path': '', 11:11:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:11:49 INFO - Running post-action listener: _resource_record_post_action 11:11:49 INFO - ##### 11:11:49 INFO - ##### Finished populate-webroot step (success) 11:11:49 INFO - ##### 11:11:49 INFO - ##### 11:11:49 INFO - ##### Running create-virtualenv step. 11:11:49 INFO - ##### 11:11:49 INFO - Running pre-action listener: _resource_record_pre_action 11:11:49 INFO - Running main action method: create_virtualenv 11:11:49 INFO - Creating virtualenv /builds/slave/test/build/venv 11:11:49 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:11:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:11:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:11:49 INFO - Using real prefix '/usr' 11:11:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:11:49 INFO - Installing distribute.............................................................................................................................................................................................done. 11:11:51 INFO - Installing pip.................done. 11:11:51 INFO - Return code: 0 11:11:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:11:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:51 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 0x1311030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d03b0>, '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 0x15d12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d1740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1467223893.905306-1755092311', '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:11:51 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:11:51 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:11:51 INFO - Using env: {'DISPLAY': ':0', 11:11:51 INFO - 'HOME': '/home/cltbld', 11:11:51 INFO - 'LANG': 'en_US.UTF-8', 11:11:51 INFO - 'LANGUAGE': 'en_US:en', 11:11:51 INFO - 'LOGNAME': 'cltbld', 11:11:51 INFO - 'MAIL': '/var/mail/cltbld', 11:11:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:51 INFO - 'MOZ_NO_REMOTE': '1', 11:11:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:51 INFO - 'NO_EM_RESTART': '1', 11:11:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:51 INFO - 'PWD': '/builds/slave/test', 11:11:51 INFO - 'SHELL': '/bin/bash', 11:11:51 INFO - 'SHLVL': '1', 11:11:51 INFO - 'TERM': 'linux', 11:11:51 INFO - 'TMOUT': '86400', 11:11:51 INFO - 'USER': 'cltbld', 11:11:51 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1467223893.905306-1755092311', 11:11:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:51 INFO - '_': '/tools/buildbot/bin/python'} 11:11:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:52 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:11:52 INFO - Cleaning up... 11:11:52 INFO - Return code: 0 11:11:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:11: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:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11: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:11:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11: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', '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 0x1311030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d03b0>, '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 0x15d12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d1740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1467223893.905306-1755092311', '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:11: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', 'psutil>=3.1.1'] in /builds/slave/test/build 11:11: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 psutil>=3.1.1 11:11:52 INFO - Using env: {'DISPLAY': ':0', 11:11:52 INFO - 'HOME': '/home/cltbld', 11:11:52 INFO - 'LANG': 'en_US.UTF-8', 11:11:52 INFO - 'LANGUAGE': 'en_US:en', 11:11:52 INFO - 'LOGNAME': 'cltbld', 11:11:52 INFO - 'MAIL': '/var/mail/cltbld', 11:11:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:52 INFO - 'MOZ_NO_REMOTE': '1', 11:11:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:52 INFO - 'NO_EM_RESTART': '1', 11:11:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:52 INFO - 'PWD': '/builds/slave/test', 11:11:52 INFO - 'SHELL': '/bin/bash', 11:11:52 INFO - 'SHLVL': '1', 11:11:52 INFO - 'TERM': 'linux', 11:11:52 INFO - 'TMOUT': '86400', 11:11:52 INFO - 'USER': 'cltbld', 11:11:52 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1467223893.905306-1755092311', 11:11:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:52 INFO - '_': '/tools/buildbot/bin/python'} 11:11:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:52 INFO - Downloading/unpacking psutil>=3.1.1 11:11: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:11: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:11: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:11: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:11: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:11: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:11:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:11:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:11:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:11:54 INFO - Installing collected packages: psutil 11:11:54 INFO - Running setup.py install for psutil 11:11:54 INFO - building 'psutil._psutil_linux' extension 11:11:54 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:11:54 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:11:54 INFO - building 'psutil._psutil_posix' extension 11:11:54 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:11:54 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:11:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:11:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:11:54 INFO - Successfully installed psutil 11:11:54 INFO - Cleaning up... 11:11:54 INFO - Return code: 0 11:11:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:11: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:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11: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:11:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1311030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d03b0>, '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 0x15d12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d1740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1467223893.905306-1755092311', '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:11: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:11: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 mozsystemmonitor==0.3 11:11:54 INFO - Using env: {'DISPLAY': ':0', 11:11:54 INFO - 'HOME': '/home/cltbld', 11:11:54 INFO - 'LANG': 'en_US.UTF-8', 11:11:54 INFO - 'LANGUAGE': 'en_US:en', 11:11:54 INFO - 'LOGNAME': 'cltbld', 11:11:54 INFO - 'MAIL': '/var/mail/cltbld', 11:11:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:54 INFO - 'MOZ_NO_REMOTE': '1', 11:11:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:54 INFO - 'NO_EM_RESTART': '1', 11:11:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:54 INFO - 'PWD': '/builds/slave/test', 11:11:54 INFO - 'SHELL': '/bin/bash', 11:11:54 INFO - 'SHLVL': '1', 11:11:54 INFO - 'TERM': 'linux', 11:11:54 INFO - 'TMOUT': '86400', 11:11:54 INFO - 'USER': 'cltbld', 11:11:54 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1467223893.905306-1755092311', 11:11:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:54 INFO - '_': '/tools/buildbot/bin/python'} 11:11:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:11:55 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:11:55 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:11:55 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:11:55 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:11:55 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:11:55 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:11:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:11:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:11:57 INFO - Installing collected packages: mozsystemmonitor 11:11:57 INFO - Running setup.py install for mozsystemmonitor 11:11:57 INFO - Successfully installed mozsystemmonitor 11:11:57 INFO - Cleaning up... 11:11:57 INFO - Return code: 0 11:11:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:11:57 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:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:57 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:11:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:57 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 0x1311030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d03b0>, '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 0x15d12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d1740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1467223893.905306-1755092311', '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:11:57 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:11:57 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:11:57 INFO - Using env: {'DISPLAY': ':0', 11:11:57 INFO - 'HOME': '/home/cltbld', 11:11:57 INFO - 'LANG': 'en_US.UTF-8', 11:11:57 INFO - 'LANGUAGE': 'en_US:en', 11:11:57 INFO - 'LOGNAME': 'cltbld', 11:11:57 INFO - 'MAIL': '/var/mail/cltbld', 11:11:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:57 INFO - 'MOZ_NO_REMOTE': '1', 11:11:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:57 INFO - 'NO_EM_RESTART': '1', 11:11:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:57 INFO - 'PWD': '/builds/slave/test', 11:11:57 INFO - 'SHELL': '/bin/bash', 11:11:57 INFO - 'SHLVL': '1', 11:11:57 INFO - 'TERM': 'linux', 11:11:57 INFO - 'TMOUT': '86400', 11:11:57 INFO - 'USER': 'cltbld', 11:11:57 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1467223893.905306-1755092311', 11:11:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:57 INFO - '_': '/tools/buildbot/bin/python'} 11:11:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:57 INFO - Downloading/unpacking jsonschema==2.5.1 11:11: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:11: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:11: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:11: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:11: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:11: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:11:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:11:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:11: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:11: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:11: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:11: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:11: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:11: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:11:59 INFO - Downloading functools32-3.2.3-2.tar.gz 11:11:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:11:59 INFO - warning: no files found matching '*.txt' 11:11:59 INFO - no previously-included directories found matching 'build' 11:11:59 INFO - no previously-included directories found matching 'dist' 11:11:59 INFO - no previously-included directories found matching '.git*' 11:11:59 INFO - Installing collected packages: jsonschema, functools32 11:11:59 INFO - Running setup.py install for functools32 11:11:59 INFO - warning: no files found matching '*.txt' 11:11:59 INFO - no previously-included directories found matching 'build' 11:11:59 INFO - no previously-included directories found matching 'dist' 11:11:59 INFO - no previously-included directories found matching '.git*' 11:11:59 INFO - Successfully installed jsonschema functools32 11:11:59 INFO - Cleaning up... 11:11:59 INFO - Return code: 0 11:11:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:11:59 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:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:59 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:11:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:59 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 0x1311030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d03b0>, '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 0x15d12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d1740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1467223893.905306-1755092311', '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:11:59 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:11:59 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:11:59 INFO - Using env: {'DISPLAY': ':0', 11:11:59 INFO - 'HOME': '/home/cltbld', 11:11:59 INFO - 'LANG': 'en_US.UTF-8', 11:11:59 INFO - 'LANGUAGE': 'en_US:en', 11:11:59 INFO - 'LOGNAME': 'cltbld', 11:11:59 INFO - 'MAIL': '/var/mail/cltbld', 11:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:59 INFO - 'MOZ_NO_REMOTE': '1', 11:11:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:59 INFO - 'NO_EM_RESTART': '1', 11:11:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:59 INFO - 'PWD': '/builds/slave/test', 11:11:59 INFO - 'SHELL': '/bin/bash', 11:11:59 INFO - 'SHLVL': '1', 11:11:59 INFO - 'TERM': 'linux', 11:11:59 INFO - 'TMOUT': '86400', 11:11:59 INFO - 'USER': 'cltbld', 11:11:59 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1467223893.905306-1755092311', 11:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:59 INFO - '_': '/tools/buildbot/bin/python'} 11:11:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:59 INFO - Downloading/unpacking blobuploader==1.2.4 11:11: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:11: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:11: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:11: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:11: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:11: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:12:01 INFO - Downloading blobuploader-1.2.4.tar.gz 11:12:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:12:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:12:01 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:12:01 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:12:01 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:12:01 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:12:01 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:12:01 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:12:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:12:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:12:02 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:12:02 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:12:02 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:12:02 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:12:02 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:12:02 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:12:02 INFO - Downloading docopt-0.6.1.tar.gz 11:12:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:12:02 INFO - Installing collected packages: blobuploader, requests, docopt 11:12:02 INFO - Running setup.py install for blobuploader 11:12:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:12:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:12:02 INFO - Running setup.py install for requests 11:12:03 INFO - Running setup.py install for docopt 11:12:03 INFO - Successfully installed blobuploader requests docopt 11:12:03 INFO - Cleaning up... 11:12:03 INFO - Return code: 0 11:12:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:12: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:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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:12:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:03 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 0x1311030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d03b0>, '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 0x15d12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d1740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1467223893.905306-1755092311', '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:12:03 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:12:03 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:12:03 INFO - Using env: {'DISPLAY': ':0', 11:12:03 INFO - 'HOME': '/home/cltbld', 11:12:03 INFO - 'LANG': 'en_US.UTF-8', 11:12:03 INFO - 'LANGUAGE': 'en_US:en', 11:12:03 INFO - 'LOGNAME': 'cltbld', 11:12:03 INFO - 'MAIL': '/var/mail/cltbld', 11:12:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:03 INFO - 'MOZ_NO_REMOTE': '1', 11:12:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:03 INFO - 'NO_EM_RESTART': '1', 11:12:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:03 INFO - 'PWD': '/builds/slave/test', 11:12:03 INFO - 'SHELL': '/bin/bash', 11:12:03 INFO - 'SHLVL': '1', 11:12:03 INFO - 'TERM': 'linux', 11:12:03 INFO - 'TMOUT': '86400', 11:12:03 INFO - 'USER': 'cltbld', 11:12:03 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1467223893.905306-1755092311', 11:12:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:03 INFO - '_': '/tools/buildbot/bin/python'} 11:12:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:12:03 INFO - Running setup.py (path:/tmp/pip-m4NkjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:12:03 INFO - Running setup.py (path:/tmp/pip-SuYpAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:12:03 INFO - Running setup.py (path:/tmp/pip-KHUu5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:12:03 INFO - Running setup.py (path:/tmp/pip-W3Ltpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:12:03 INFO - Running setup.py (path:/tmp/pip-yj0ryS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:12:03 INFO - Running setup.py (path:/tmp/pip-cX8L1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:12:03 INFO - Running setup.py (path:/tmp/pip-tqUh_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:12:03 INFO - Running setup.py (path:/tmp/pip-K3cVM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:12:03 INFO - Running setup.py (path:/tmp/pip-_cpvLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:12:04 INFO - Running setup.py (path:/tmp/pip-HrF2m3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:12:04 INFO - Running setup.py (path:/tmp/pip-JGlD5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:12:04 INFO - Running setup.py (path:/tmp/pip-oqRcZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:12:04 INFO - Running setup.py (path:/tmp/pip-7G6gnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:12:04 INFO - Running setup.py (path:/tmp/pip-DjVa2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:04 INFO - Running setup.py (path:/tmp/pip-kFCjWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:12:04 INFO - Running setup.py (path:/tmp/pip-IQhzCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:12:04 INFO - Running setup.py (path:/tmp/pip-eVXBhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:12:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:12:04 INFO - Running setup.py install for manifestparser 11:12:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:12:04 INFO - Running setup.py install for mozcrash 11:12:04 INFO - Running setup.py install for mozdebug 11:12:04 INFO - Running setup.py install for mozdevice 11:12:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:12:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:12:05 INFO - Running setup.py install for mozfile 11:12:05 INFO - Running setup.py install for mozhttpd 11:12:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:12:05 INFO - Running setup.py install for mozinfo 11:12:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:12:05 INFO - Running setup.py install for mozInstall 11:12:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:12:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:12:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:12:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:12:05 INFO - Running setup.py install for mozleak 11:12:05 INFO - Running setup.py install for mozlog 11:12:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:12:05 INFO - Running setup.py install for moznetwork 11:12:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:12:05 INFO - Running setup.py install for mozprocess 11:12:05 INFO - Running setup.py install for mozprofile 11:12:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:12:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:12:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:12:05 INFO - Running setup.py install for mozrunner 11:12:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:12:06 INFO - Running setup.py install for mozscreenshot 11:12:06 INFO - Running setup.py install for moztest 11:12:06 INFO - Running setup.py install for mozversion 11:12:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:12:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:12:06 INFO - Cleaning up... 11:12:06 INFO - Return code: 0 11:12:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:12:06 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:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:06 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:12:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:06 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 0x1311030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d03b0>, '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 0x15d12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d1740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1467223893.905306-1755092311', '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:12:06 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:12:06 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:12:06 INFO - Using env: {'DISPLAY': ':0', 11:12:06 INFO - 'HOME': '/home/cltbld', 11:12:06 INFO - 'LANG': 'en_US.UTF-8', 11:12:06 INFO - 'LANGUAGE': 'en_US:en', 11:12:06 INFO - 'LOGNAME': 'cltbld', 11:12:06 INFO - 'MAIL': '/var/mail/cltbld', 11:12:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:06 INFO - 'MOZ_NO_REMOTE': '1', 11:12:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:06 INFO - 'NO_EM_RESTART': '1', 11:12:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:06 INFO - 'PWD': '/builds/slave/test', 11:12:06 INFO - 'SHELL': '/bin/bash', 11:12:06 INFO - 'SHLVL': '1', 11:12:06 INFO - 'TERM': 'linux', 11:12:06 INFO - 'TMOUT': '86400', 11:12:06 INFO - 'USER': 'cltbld', 11:12:06 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1467223893.905306-1755092311', 11:12:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:06 INFO - '_': '/tools/buildbot/bin/python'} 11:12:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:12:06 INFO - Running setup.py (path:/tmp/pip-eg0Xah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:12:06 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:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:12:06 INFO - Running setup.py (path:/tmp/pip-JumnYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:12:06 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:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:12:06 INFO - Running setup.py (path:/tmp/pip-Jy5mzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:12:06 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:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:12:06 INFO - Running setup.py (path:/tmp/pip-93B7LZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:12:06 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:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:12:06 INFO - Running setup.py (path:/tmp/pip-zvquog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:12:06 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:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:12:07 INFO - Running setup.py (path:/tmp/pip-YYy_Ll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:12:07 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:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:12:07 INFO - Running setup.py (path:/tmp/pip-oeltLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:12:07 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:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:12:07 INFO - Running setup.py (path:/tmp/pip-BIeaqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:12:07 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:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:12:07 INFO - Running setup.py (path:/tmp/pip-rDJ1Kh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:12:07 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:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:12:07 INFO - Running setup.py (path:/tmp/pip-frd2ET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:12:07 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:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:12:07 INFO - Running setup.py (path:/tmp/pip-Wv8ykx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:12:07 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:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:12:07 INFO - Running setup.py (path:/tmp/pip-Tv5n1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:12:07 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:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:12:07 INFO - Running setup.py (path:/tmp/pip-t9ny4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:12:07 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:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:12:07 INFO - Running setup.py (path:/tmp/pip-gUAlzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:12:07 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:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:07 INFO - Running setup.py (path:/tmp/pip-9jl8Os-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:07 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:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:12:07 INFO - Running setup.py (path:/tmp/pip-OIX7t5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:12:07 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:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:12:07 INFO - Running setup.py (path:/tmp/pip-DelHXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:12:07 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:12:07 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:12:07 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:12:07 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:12:07 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:12:07 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:12:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:12:07 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:12:07 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:12:07 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:12:07 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:12:07 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:12:07 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:12:09 INFO - Downloading blessings-1.6.tar.gz 11:12:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:12:09 INFO - Installing collected packages: blessings 11:12:09 INFO - Running setup.py install for blessings 11:12:09 INFO - Successfully installed blessings 11:12:09 INFO - Cleaning up... 11:12:10 INFO - Return code: 0 11:12:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:12:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:12:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:12:10 INFO - Reading from file tmpfile_stdout 11:12:10 INFO - Current package versions: 11:12:10 INFO - argparse == 1.2.1 11:12:10 INFO - blessings == 1.6 11:12:10 INFO - blobuploader == 1.2.4 11:12:10 INFO - docopt == 0.6.1 11:12:10 INFO - functools32 == 3.2.3-2 11:12:10 INFO - jsonschema == 2.5.1 11:12:10 INFO - manifestparser == 1.1 11:12:10 INFO - mozInstall == 1.12 11:12:10 INFO - mozcrash == 0.17 11:12:10 INFO - mozdebug == 0.1 11:12:10 INFO - mozdevice == 0.48 11:12:10 INFO - mozfile == 1.2 11:12:10 INFO - mozhttpd == 0.7 11:12:10 INFO - mozinfo == 0.9 11:12:10 INFO - mozleak == 0.1 11:12:10 INFO - mozlog == 3.2 11:12:10 INFO - moznetwork == 0.27 11:12:10 INFO - mozprocess == 0.22 11:12:10 INFO - mozprofile == 0.28 11:12:10 INFO - mozrunner == 6.11 11:12:10 INFO - mozscreenshot == 0.1 11:12:10 INFO - mozsystemmonitor == 0.3 11:12:10 INFO - moztest == 0.7 11:12:10 INFO - mozversion == 1.4 11:12:10 INFO - psutil == 3.1.1 11:12:10 INFO - requests == 1.2.3 11:12:10 INFO - wsgiref == 0.1.2 11:12:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:12:10 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:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:10 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:12:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:10 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 0x1311030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d03b0>, '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 0x15d12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d1740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1467223893.905306-1755092311', '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:12:10 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:12:10 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:12:10 INFO - Using env: {'DISPLAY': ':0', 11:12:10 INFO - 'HOME': '/home/cltbld', 11:12:10 INFO - 'LANG': 'en_US.UTF-8', 11:12:10 INFO - 'LANGUAGE': 'en_US:en', 11:12:10 INFO - 'LOGNAME': 'cltbld', 11:12:10 INFO - 'MAIL': '/var/mail/cltbld', 11:12:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:10 INFO - 'MOZ_NO_REMOTE': '1', 11:12:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:10 INFO - 'NO_EM_RESTART': '1', 11:12:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:10 INFO - 'PWD': '/builds/slave/test', 11:12:10 INFO - 'SHELL': '/bin/bash', 11:12:10 INFO - 'SHLVL': '1', 11:12:10 INFO - 'TERM': 'linux', 11:12:10 INFO - 'TMOUT': '86400', 11:12:10 INFO - 'USER': 'cltbld', 11:12:10 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1467223893.905306-1755092311', 11:12:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:10 INFO - '_': '/tools/buildbot/bin/python'} 11:12:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:10 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:12:10 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:12:10 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:12:10 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:12:10 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:12:10 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:12:10 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:12:10 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:12:10 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:12:10 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:12:10 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:12:10 INFO - Cleaning up... 11:12:10 INFO - Return code: 0 11:12:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:12:10 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:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:10 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:12:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:10 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 0x1311030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d03b0>, '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 0x15d12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d1740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1467223893.905306-1755092311', '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:12:10 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:12:10 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:12:10 INFO - Using env: {'DISPLAY': ':0', 11:12:10 INFO - 'HOME': '/home/cltbld', 11:12:10 INFO - 'LANG': 'en_US.UTF-8', 11:12:10 INFO - 'LANGUAGE': 'en_US:en', 11:12:10 INFO - 'LOGNAME': 'cltbld', 11:12:10 INFO - 'MAIL': '/var/mail/cltbld', 11:12:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:10 INFO - 'MOZ_NO_REMOTE': '1', 11:12:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:10 INFO - 'NO_EM_RESTART': '1', 11:12:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:10 INFO - 'PWD': '/builds/slave/test', 11:12:10 INFO - 'SHELL': '/bin/bash', 11:12:10 INFO - 'SHLVL': '1', 11:12:10 INFO - 'TERM': 'linux', 11:12:10 INFO - 'TMOUT': '86400', 11:12:10 INFO - 'USER': 'cltbld', 11:12:10 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1467223893.905306-1755092311', 11:12:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:10 INFO - '_': '/tools/buildbot/bin/python'} 11:12:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:12:10 INFO - Cleaning up... 11:12:10 INFO - Return code: 0 11:12:10 INFO - Running post-action listener: _resource_record_post_action 11:12:10 INFO - Running post-action listener: _start_resource_monitoring 11:12:10 INFO - Starting resource monitoring. 11:12:10 INFO - ##### 11:12:10 INFO - ##### Finished create-virtualenv step (success) 11:12:10 INFO - ##### 11:12:10 INFO - ##### 11:12:10 INFO - ##### Running install step. 11:12:10 INFO - ##### 11:12:10 INFO - Running pre-action listener: _resource_record_pre_action 11:12:10 INFO - Running main action method: install 11:12:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:12:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:12:10 INFO - Reading from file tmpfile_stdout 11:12:10 INFO - Detecting whether we're running mozinstall >=1.0... 11:12:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:12:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:12:10 INFO - Reading from file tmpfile_stdout 11:12:10 INFO - Output received: 11:12:10 INFO - Usage: mozinstall [options] installer 11:12:10 INFO - Options: 11:12:10 INFO - -h, --help show this help message and exit 11:12:10 INFO - -d DEST, --destination=DEST 11:12:10 INFO - Directory to install application into. [default: 11:12:10 INFO - "/builds/slave/test"] 11:12:10 INFO - --app=APP Application being installed. [default: firefox] 11:12:10 INFO - mkdir: /builds/slave/test/build/application 11:12:10 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:12:10 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:12:28 INFO - Reading from file tmpfile_stdout 11:12:28 INFO - Output received: 11:12:28 INFO - /builds/slave/test/build/application/firefox/firefox 11:12:28 INFO - Running post-action listener: _resource_record_post_action 11:12:28 INFO - ##### 11:12:28 INFO - ##### Finished install step (success) 11:12:28 INFO - ##### 11:12:28 INFO - ##### 11:12:28 INFO - ##### Running run-tests step. 11:12:28 INFO - ##### 11:12:28 INFO - Running pre-action listener: _resource_record_pre_action 11:12:28 INFO - Running main action method: run_tests 11:12:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:12:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:12:28 INFO - Python 2.7.3 11:12:28 INFO - Return code: 0 11:12:28 INFO - grabbing minidump binary from tooltool 11:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:28 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 0x15d03b0>, '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 0x15d12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d1740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:12:28 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:12:28 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:12:28 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:12:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:12:28 INFO - Return code: 0 11:12:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:12:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:12:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:12:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:12:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:12:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/edElhXcdSVqAWMyG-E7syw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:12:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/edElhXcdSVqAWMyG-E7syw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:12:28 INFO - Using env: {'DISPLAY': ':0', 11:12:28 INFO - 'HOME': '/home/cltbld', 11:12:28 INFO - 'LANG': 'en_US.UTF-8', 11:12:28 INFO - 'LANGUAGE': 'en_US:en', 11:12:28 INFO - 'LOGNAME': 'cltbld', 11:12:28 INFO - 'MAIL': '/var/mail/cltbld', 11:12:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:12:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:12:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:28 INFO - 'MOZ_NO_REMOTE': '1', 11:12:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:12:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:28 INFO - 'NO_EM_RESTART': '1', 11:12:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:28 INFO - 'PWD': '/builds/slave/test', 11:12:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:12:28 INFO - 'SHELL': '/bin/bash', 11:12:28 INFO - 'SHLVL': '1', 11:12:28 INFO - 'TERM': 'linux', 11:12:28 INFO - 'TMOUT': '86400', 11:12:28 INFO - 'USER': 'cltbld', 11:12:28 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1467223893.905306-1755092311', 11:12:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:28 INFO - '_': '/tools/buildbot/bin/python'} 11:12:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/edElhXcdSVqAWMyG-E7syw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:12:28 INFO - mozversion application_buildid: 20160629083023 11:12:28 INFO - mozversion application_changeset: eeb6862f960c1310bde9aed159f3fc5bb2d4b6d7 11:12:28 INFO - mozversion application_display_name: Nightly 11:12:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:12:28 INFO - mozversion application_name: Firefox 11:12:28 INFO - mozversion application_remotingname: firefox 11:12:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:12:28 INFO - mozversion application_vendor: Mozilla 11:12:28 INFO - mozversion application_version: 50.0a1 11:12:28 INFO - mozversion platform_buildid: 20160629083023 11:12:28 INFO - mozversion platform_changeset: eeb6862f960c1310bde9aed159f3fc5bb2d4b6d7 11:12:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:12:28 INFO - mozversion platform_version: 50.0a1 11:12:28 INFO - using testdate: 1467223948 11:12:28 INFO - actual date: 1467223948 11:12:28 INFO - starting webserver on 'localhost:51373' 11:12:28 INFO - SUITE-START | Running 2 tests 11:12:28 INFO - TEST-START | dromaeo_css 11:12:28 INFO - operating with platform_type : linux_ 11:12:28 INFO - Initialising browser for dromaeo_css test... 11:12:28 INFO - TEST-INFO | started process 28181 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBlOvq0/profile http://localhost:51373/getInfo.html) 11:12:32 INFO - PROCESS | 28181 | __metrics Screen width/height:1600/1200 11:12:32 INFO - PROCESS | 28181 | colorDepth:24 11:12:32 INFO - PROCESS | 28181 | Browser inner width/height: 1024/697 11:12:32 INFO - PROCESS | 28181 | __metrics 11:12:33 INFO - PROCESS | 28181 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:12:34 INFO - TEST-INFO | 28181: exit 0 11:12:34 INFO - Browser initialized. 11:12:34 INFO - Running cycle 1/1 for dromaeo_css test... 11:12:34 INFO - TEST-INFO | started process 28266 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBlOvq0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:12:46 INFO - PROCESS | 28266 | RSS: Main: 157343744 11:12:46 INFO - PROCESS | 28266 | 11:13:37 INFO - PROCESS | 28266 | 1467224017246 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:15:46 INFO - PROCESS | 28266 | Cycle 1(1): loaded http://localhost:51373/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51373/tests/dromaeo/cssquery-ext.html) 11:15:47 INFO - PROCESS | 28266 | RSS: Main: 257974272 11:15:47 INFO - PROCESS | 28266 | 11:18:49 INFO - PROCESS | 28266 | Cycle 1(1): loaded http://localhost:51373/tests/dromaeo/cssquery-ext.html (next: http://localhost:51373/tests/dromaeo/cssquery-jquery.html) 11:18:50 INFO - PROCESS | 28266 | RSS: Main: 242184192 11:18:50 INFO - PROCESS | 28266 | 11:21:52 INFO - PROCESS | 28266 | Cycle 1(1): loaded http://localhost:51373/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51373/tests/dromaeo/cssquery-mootools.html) 11:21:53 INFO - PROCESS | 28266 | RSS: Main: 247853056 11:21:53 INFO - PROCESS | 28266 | 11:24:55 INFO - PROCESS | 28266 | Cycle 1(1): loaded http://localhost:51373/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51373/tests/dromaeo/cssquery-prototype.html) 11:24:55 INFO - PROCESS | 28266 | RSS: Main: 245542912 11:24:55 INFO - PROCESS | 28266 | 11:27:58 INFO - PROCESS | 28266 | Cycle 1(1): loaded http://localhost:51373/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51373/tests/dromaeo/cssquery-yui.html) 11:27:58 INFO - PROCESS | 28266 | RSS: Main: 204894208 11:27:58 INFO - PROCESS | 28266 | 11:31:01 INFO - PROCESS | 28266 | Cycle 1(1): loaded http://localhost:51373/tests/dromaeo/cssquery-yui.html (next: http://localhost:51373/tests/dromaeo/cssquery-dojo.html) 11:31:01 INFO - PROCESS | 28266 | RSS: Main: 276033536 11:31:01 INFO - PROCESS | 28266 | 11:31:01 INFO - PROCESS | 28266 | __start_tp_report 11:31:01 INFO - PROCESS | 28266 | _x_x_mozilla_page_load 11:31:01 INFO - PROCESS | 28266 | _x_x_mozilla_page_load_details 11:31:01 INFO - PROCESS | 28266 | |i|pagename|runs| 11:31:01 INFO - PROCESS | 28266 | |0;dojo.html;3069.2173495758593;3103.022547897413;3107.984460077699;3129.718325350718;3132.8746850125995;5177.844664660057;5245.029669511134;5275.868103297419;5368.194770784385;5406.783728650859;5326.227696983935;5328.760205790739;5329;5340.973295133519;5411.323584551931;4785.712857228568;4838.830640927568;4866.707997520142;4878.146324393235;5024.874378140557;4883.389576302962;4903.8528844134735;4926.901461970759;4927.384076990376;4956.9772726137735;4742.857714268577;4770.141374552579;4777.689450185744;4840.806367745286;4843.58829499493;4805.038992201574;4810.687305325143;4818.180909245437;4832.275158726184;4931.975340123312;4827.565519103263;4860.635452341053;4866.51334866514;4880.829170978998;4929;5169.043726910496;5225.346831646044;5317.175837745156;5330.253764472977;5411.702356370398;5816.331121920991;5827.242458480413;5859.970700146515;5875.441833025856;5885.79399721012;5921.822345329647;5936.7922122725495;5942.910856337158;5943.762249510014;5944.613600115978;5160.458151894035;5298.523132918017;5335.7865685372535;5345;5438.646487978348;5909.409059094056;5915.231019967377;5915.792947246911;5919.585629005928;5925.555583331267;5660.971695141498;5697.686627235459;5703.258576385043;5709.314882214161;5719.342275638355;5502.477264659851;5683.232763576947;5729.942700572941;5735.426457354231;5821.388754180834;5759.539236861041;5768.3654797972185;5770.884582308414;5775.88448231033;5811.360750317462;5721.828345149652;5734.311882574118;5781.682007489629;5783.277090363705;5795.82612521625;4266.6160045595425;4284.635805956528;4285.314349704095;4360.978195109004;4425.645948324126;3918.3534716771983;3936.3505021671676;3940.9605903941165;3941.9014524637114;3944.033711740642;5392.649477783932;5410.540104091117;5413.810516631977;5422.322209723785;5475.835724928259;5790.913136302959;5792.304923409133;5798.536117110621;5801.6809075500405;5853.09277062056;5289.338832645919;5449.291592093082;5478.91781623276;5488.341399032141;5498;4818.494058123917;4826.131296366688;4840.15297322967;4868.294097355863;4881.609471242292;5974.1934838796205;5979.521638268928;5979.760809567656;5996.730147143389;5999.070144127667;5585.3297604287745;5732.197492351158;5801.88396232073;5810.186573879745;5822.679752613478;5950.404959504015;6013.30846952606;6025.939740602538;6086.452219300284;6089.604175728564;5719.456651618089;5759.308882934075;5760.164776107525;5767.077267637325;5772.567057470623;5598.356189038313;5825.388334225015;5892.970535147297;5898.705064746831;5904.940950590439;5683.971580142238;5702.657840529581;5706.714664266687;5712.542996560348;5751.683657398716;5707.286589176353;5707.514861236676;5711.943290491273;5712.8571785704025;5713.857153571194;5385.9192112119135;5521.917171242354;5577.191307260506;5623.212750215055;5634.267545219095;5645.717714114196;5674.716264186856;5708.115242137475;5713.428657134254;5741.081426971665;5514.228008078952;5549.112142057252;5551.306086739158;5558.44415558441;5558.861028474321 11:31:01 INFO - PROCESS | 28266 | |1;ext.html;578.9739461724222;582.1122787748683;609.5641616244387;613.2181468627502;627.3005598757386;33098.66901330986;42642.78678606606;42816.357754633704;42894.571054289445;43133;45229;45321.54678453215;45384;45452;45576.77211613937;8992.280617550596;9128.361014728971;9132.178103970675;9136.58885350161;9141.222996045311;9058.320625953047;9156.038615945296;9160.541972901328;9160.770980725469;9166.770830729218;8884.466931984069;8916.465012099263;8920.73237802867;8926.330525210602;8933.821323573524;9064.18422341989;9100.726978190665;9114.27085833135;9118;9118.17936385725;8964.05877382872;9042.593083311267;9053.4567925924;9055.954720226357;9058.411203271831;42975;43454.348184776936;43507.12985740299;43556.782216088715;43584.3462348065;3778.425539561144;3830.540335159799;3886.689064874803;3928.017995501125;4264.061906380592;32599.6740032599;33261.50107748386;33451.16372090693;33612;34019;4350.369196466495;4504.572065653758;4508.211063063951;4600.401947746805;4600.7929643166135;312334;312548.4372578145;313225;313573;314822;59818;59996;60086;60362.39637603568;60518.697406512685;63173.368266317666;63492.36507634957;63534;63770.36229637644;63817;17557.561060973578;17767.46697599074;17795.73306400405;17837.10814459272;17841.910790445963;13678.179309241477;13767.586972390844;13774.586762397144;13784.379702913193;13791.10357826738;16081.437149699705;17726.20232089559;17742.516047753325;17911;17983.640327193643;5156.329677141947;6020.939790602038;6094.659174981497;6096.359882212392;6105.267367915879;998.770282834952;1002.04304888831;1051.5636011055326;1137.8008848451489;1158.6350299655583;32753.34493310168;32820.83589582085;33232.667673322954;33233.3353332932;33719;1091.8908109189017;1106.9169812264113;1108.539955918285;1119.8600174978128;1172.85060640571;16988.150592470327;17113.91443042777;17243.827561724473;17280.740788888175;17614.295428182984;531249;828600;848962;849091;853415;59169.70415147897;59255;59594.70202648959;59755;59937;1228.4840367045683;1308.672831792052;1310.0894878059657;1323.9271840048698;1334.2661536155076;29640.703592963793;34100.317993640485;34383.31233375368;34484.82757586196;34795.65204348025;46009.539904600526;56303.15545266906;57581.71209143927;57868;63244;503946;504941;506526;508462;511454;26072;29048.419031618825;29399;29584.112476625734;29832.70167298386;48307;48787.756061219465;49005.50994490152;49102.75448622734;50385.74807125941;41040.58959410368;42443.7877810609;42747.57252427436;42805.78597106995;43485.56514434942;42539.5746042548;42607.36088958606;42703.57296426996;42813.785931070146;43671;41440.585594143675;42368.576314237696;42481.787591061846;42489.78755106204;42546.149077018905;35642;37210.44184337183;38060.2571598485;38068.238635227695;38469.61530384772;28285;28687.426251474437;28736.71263287424;28747.5687864678;28814.855925721076 11:31:01 INFO - PROCESS | 28266 | |2;jquery.html;400.4853762914652;407.94288799568056;411.13661311246386;413.3985051749704;416.8082681966295;13451.865481345183;18369.632607347845;19704.40886773399;20009.19963201472;20033.499162520926;19337.226510939545;19644;19739.802601974014;19884;19982.300619478287;5720.8855822883515;5927.911081333784;5931.199288096116;5938.851528711795;5963.3738457462;5799.608094057438;5888.234529511179;5892.558058145635;5894.58737888348;5902.940970590282;4149.3983372410985;4830.492798256185;6531.804045878631;6539.313372095909;6652.501062420313;5648.63283886546;5941.168236446901;6611.206655201383;6650.1354823872825;6661.93338066618;5820.476157145835;5825.621334613236;5839.737211825435;5847.8245652630485;5851.4148585141575;14289.428422863177;14528.273586320642;14701.705965880623;14772.113673179536;14865.70268594633;2241.753407125215;2284.7144106986625;2289.9084036638515;2326.5463234669246;2334.7198336199763;9940.353876997971;10811.783764324748;10900.12798976088;12768.872311276955;14199.858001419956;1883.1525813384033;1885.2364792259157;1907.4849790556611;1959.2848610257297;2026.179397344078;66644.33355666429;67736.32263677349;67815.66092169557;74880.82942718739;86555.56722216411;10628.25602207838;11095.5561777528;11192.832107518394;11571.247868888495;11583.884161158448;15939.44211952576;16098.517044488684;16170.75743863843;16178;16190.190490475665;8438.156184381513;8467.026291976501;8536.317094632415;8604.48373097616;8619.39664223511;8105.554194519358;8133.79665508367;8273.131321211307;8294.336453083739;8330.125336839666;4830.275458681226;4896.265560165933;4944.802207911644;4982.950170498249;5089.211172268304;1997.8401727861735;2001.2995451591826;2024.6355655982065;2057.1154403606592;2065.2461851424423;943.118184497497;960.3805545423163;983;1016.6695823857276;1053.1574740207802;18946.715799263024;19720.70418943717;19845.206191752455;20040.298589549588;20261.79738202599;974.2741657465234;983.6213057972589;991.8512223166439;1020.6325722739956;1080.5569716416232;10561.683149505527;11280.492377843017;11283.717907052389;11316.6039188628;11352.772944541228;439818;450525;450852;453313;455232;95292.52353738325;96255.51872240593;97648.21800014035;98728.50635746919;100293;881.6209030116983;928.1461055828654;986.7335819328741;990.895955924632;994.3834822410151;17518.73721894198;17715.468535943943;18311.72532411988;18481.445556633324;18490.907545462185;43555;44200.33699494575;44285.77857110694;45073.54926450825;45597.54402455933;57993.420065798804;59619.70190149022;60934;61608.383916162056;62110;7837.568933708472;8189;8242.340612751086;8407.53758543286;9001.864972025556;7813.413993950363;10723.731906702084;11494;13905.400878899056;14237.21695306768;12083.154179207371;12099.697507562381;12143.453544590691;12249.938750306192;12339.259644421363;11738.58914937973;11747.412629368326;12023.398830058637;12149.088818338483;12305.507779689071;12182.75634487323;12442.688932776753;12464.626061218178;12679.80980285278;12883.871161288267;8356.884735202491;8369.204925532065;8381.916180838114;8420.4947703138;8556.27271681889;11230.157738169506;12208.633740987785;12285.69285767863;12291.56979505713;12311.19977201479 11:31:01 INFO - PROCESS | 28266 | |3;mootools.html;1469.0451206715634;1510.9773353399698;1647.8105017922935;1764.576501639607;1821.3898344054733;8695.26090282326;9269.953650231739;9338.486383248919;9378.765530861732;9386.81226375473;7914.406419518545;8611.224989750921;8828.911710882889;8858.601362938667;9192.862107068398;2287.954240915181;2312.849664771793;2313.1672597864754;2316.2587971849016;2316.9420764480938;2273.954520909581;2291;2313.2250696016854;2313.849599776009;2315.9536809263805;1953.6483432982056;2244.2706120510816;2300.0339857259905;2304.976950230501;2345.061975209913;2248.6177349850564;2249.347689170139;2268.319504148757;2269.3645779181857;2282.3495303838326;2285.3600991722346;2294.0823670531754;2306.8615883047073;2311.514581937795;2319.2578374919863;9171.128742769426;9238.214751746109;9251.491167985758;9255.398399104037;9266.258699304039;5318.547923426513;5423.105187644034;5471.398146203915;5476.205950137248;5480.479354461319;3392.8133952632597;3395.813230272334;3447.6035255945385;3464.2551851351827;3495.4407294832704;1100.290312748281;1149.4425203776161;1154.7055500847314;1172.7947609168361;1182.479708928069;12986.22082675033;13064.346782660828;13107.34463276842;13108.541201058013;13110.213387196798;4778.808847646124;4780.713157210578;4795.568398844051;4851.56335929768;4909.140900342426;10873.238873278953;10929.234953553334;10954.342739435659;10959.671209863716;10974.286671366335;5497.175423686479;5512.283403157564;5521.641093328921;5523.6409633373705;5526.613137080446;5014.6431177346585;5061.670991385548;5076.796928122908;5209.505097015777;5216.243644671501;4179.414881916534;4182;4214.894627634334;4238.067625122468;4238.724482908601;1160.460385920551;1299.2204677193608;1346.501794336102;1362.8909687224998;1393.261571367177;812.2608426332009;844.5458076467278;903.1555495611624;955.9389078123278;966.4877614864133;5939.346671866091;6036.275646922398;6131.233595800525;6139.662318572432;6164.291106522717;943.3867985809279;952.8761261036021;957.9664711735056;971.1257273462145;988.4365911430559;4198.832046718097;4303.978480107642;4342.6742994275555;4357.803898824561;4372.191144638252;11242.325460472397;11440.256383335056;11521.596744113916;11550.826737598944;11633.069354451623;11515.366654833897;11600.88399116015;11625.709357266136;11633.360165190996;11641.47613357401;8380.161983801692;8529.616167272488;8568;8634.56827158652;8636.740897773077;6051.152838602688;6111.449969502766;6178.443940045418;6218;6246;10413.219008574539;10586.31188972745;10606.681799546026;10655.680329590125;10693.518791654238;10624.681259562225;10811.081058110149;10894.67315980522;10965.780684386427;10975.341479511255;7955.721549745731;7966.641501132347;8035.517868927883;8195.83608327842;8287;8775.473471591726;8794.032656407662;8831.69089081879;8869;8878.11218878107;7857.842843143219;7858.489198202098;8059.637316320663;8187.426880118573;8196.057453392697;7931.801704957422;7993.880091798744;8015;8196.385271104571;8210.753677389688;6981.371676549135;7178.318059784312;7369.115706115301;7489.325960663567;7508.211637778173;5267.367915850123;5286.20706893969;5303.973480132575;5373.9731301343245;5428;5153.793848246029;5173.715445650375;5201.791928322825;5250.369955605352;5420.945790542044 11:31:01 INFO - PROCESS | 28266 | |4;prototype.html;319.62444128149434;329.3281705321145;334.7088033410933;337.6387265625781;340.1004343511413;5116.283720279164;5223.268742376065;5246.816361427351;5290.470952904708;5303.204519322104;5065.240213967907;5213.973930130353;5216.5826733861295;5227.3465816772905;5278.419373868871;4124.938125928114;4135.896602584944;4152.314868046768;4175.457190565222;4194.14020125875;3938.3895496198134;3976.946109281043;4172.874813755592;4178.749275043492;4185.865208743532;4120.134771697947;4149.97925010376;4166.520885085796;4173.2070906527815;4176.352665336878;4139.77231252281;4162.958370416287;4166.062635906912;4169.4162817205615;4181.498220213563;3470.2192006798523;3676.761010534307;3702.8148592570265;3704.5181927229055;3715.461258117558;5129.589362925225;5136.794528218867;5143.331366922276;5157.742112894378;5161.561267292284;4712.764361781898;4715.198416269242;4724.456687480915;4728.763561821929;4729;5377.7580008899695;5501.284832971728;5527.751251193706;5535.225068490415;5546.417626149237;3962.385830196324;3997.4603428537066;4001.579439299036;4003.419504171908;4004.3593025115842;5737.254156959611;5746.367899531048;5775.249217601685;5775.711214439261;5812.38969908162;3938.822752976123;4094.959050409517;4112.527059388149;4117.197146556393;4123.958760412357;4134.297169481196;4164.895877603084;4166.166766646683;4186.079062606222;4200.7059505834295;4782.115308667838;4784.755963449528;4789.09007288621;4790.209615413418;4809.206480930678;5517.420670829585;5616.606837521416;5650.813329200914;5657.32112146545;5659.462351076641;1421.9431222750975;1428.8285405751376;1432.3053319140208;1434.0248630930857;1444.7760597107465;906.1527471813876;908.2416182487697;921.2261700171888;925.9259259259243;932.4172392254841;4753.35829662998;4764.880877978009;4793.832215872498;4827.25177597473;4831.347768051339;5023.899522009539;5036.212144688656;5049.267856160836;5081.4918508148885;5086.821961231339;4773.498782627844;4777.211760059621;4795.304680821261;4804.039192161582;5178.378594568676;2981.090767315946;3022.863971121305;3027.108057464085;3032.2116249774776;3044.2693753499443;5956.7319470623925;5963.4334738199805;5963.463288304073;5970.820875373745;5977.432143946318;5576.888462230732;5781.6241944274325;5793.855153621109;5852.063669812809;5860.384659610765;5817.389174136655;5841.678707671034;5845.970770146122;5857.765689372377;5864.560157988082;5553.0559804832465;5667.659940403589;5699.2590963174525;5702.486776189997;5713.571482138773;5646.35066967304;5650;5666.178404131296;5673.461021202979;5692.658440493584;5870.14882841994;5887.409539802473;5916.881662366814;5924.822255332347;5931.699517849524;3694.7598406103516;3790.5261842269715;3978;4071.531773845927;4077;5622.746976385991;5637.126245431965;5639.54883609302;5640.407757185437;5679.176519404746;5522.392536820867;5533.861653458695;5577.9442205577425;5590.636608620589;5596.776128954796;5330.9466905332;5466.945330546644;5472.863178420572;5480.873264068995;5501.469324110793;5366.6779993200535;5400.243965844864;5426.755795989269;5439.347278326468;5450.563954883521;5300.70846103468;5555.666660000251;5560.833175004756;5563.193336966198;5568.8305455854725;5355.0454084259745;5413.269208656781;5421.566274698093;5423.864403389947;5429.267048948342 11:31:01 INFO - PROCESS | 28266 | |5;yui.html;752.6801109528449;762.393896852003;785.7996210966203;815.0830315894618;849.7918010087529;14164;14281.21453320067;14906.180160091191;14922.179280139588;14935.103893766369;13671.248081355521;13861.029727919025;13904.443822247098;13906.443742250323;13912.860871391309;673.7877568565887;787.8188016756135;791.4934441957153;814.5764202614637;820.2986446588171;807.0476837331946;807.6163822184445;809.9757007289791;813.1665043330574;814.698561532234;856.1010938514565;857.5069335132292;857.5155037403878;858.1890113842421;858.4034096303072;695.5965539986821;820.938429617781;842.6755699055847;842.873568964654;845.691322667222;617.2562062714418;617.8640699046202;617.8764247150588;618.3723520626568;618.6411881108946;13825.723485530334;13828;13828.654283642989;13843.30783460823;13871;14782.926085369505;14792.334344954503;14798.48205312809;14851.777223341658;14869;13430.462781488728;13483.123596966167;13525.526606568821;13609;13771.724565508634;4084.0606660468256;4137.565555616678;4143.233501802146;4146.834126634931;4235.555266697014;74701;74913;77849;78500.60749696272;79316.60341698313;11715.1799374043;11799.764004719858;11824.822627660593;12009.939950300368;12175.93912030452;21851;22008.559828803332;22011;22035.559288814133;22036.228731994303;8165.611271322454;8332.083470818205;8444.61999210037;8493.362997775192;8497.490150590984;4445.799939002753;4451.599356057905;4511.571400716993;4526.79629416677;4647.86056418308;3526.7002304804378;3652.3243200008083;3661.6338366163172;3663.5237419135874;4047;542.3085565903505;630.9873802523924;736.2196072163524;738.8300690841137;751.0461713623667;670.47367816264;711.4806191480249;717.3436305780152;726.6693654387241;742.3319012888444;8798.604062817189;8947.642094316154;8957.686480973134;9083.18251357381;9106.81786364269;475.0546412638824;679.7635778289373;742.5693098003145;751.2037240525061;764.8393837294119;4195.811188496464;4339.392485052095;4362.1493808707;4386.1447017831215;4437.179121862466;76450.23549764542;77016;79494;126449.36775316065;127141;106559.4672026635;109086.45456772824;109118;110011;112271;94011;95115.52442237745;95161;95503;96649;9531.952340238255;9592.808143837225;9663.710088697351;9937.391634562935;10225;46003.76998114988;46127.61617151491;47403.525964739914;49302.75348623234;49705.254421184436;73313.6334318325;75960.62019689866;77070.2292977063;77802.61098694471;78049;13199.142055766344;13219;13885.65285867821;13977.161370317814;14224.857751422353;12986.415611297325;13020.348982551024;13101.410436530188;13230.4046317914;13553;12349.567765128177;12394;13164.60506184816;13480.595582132551;13639.181649101085;12781.297028663514;12963.15739476931;13047.021473389344;13514.59456216315;13537.390817413438;11644.41777911118;11955.76088478243;12049.75900481968;12063.39683015828;12315.69210769738;10322.948385258025;10765.46172691378;10769.946150269512;10781.568737250422;10888.727781805519;10739.785204296026;10779.461026948778;10851.728706782395;10864.239503234698;10914.34513929135 11:31:01 INFO - PROCESS | 28266 | __end_tp_report 11:31:01 INFO - PROCESS | 28266 | __start_cc_report 11:31:01 INFO - PROCESS | 28266 | _x_x_mozilla_cycle_collect,895 11:31:01 INFO - PROCESS | 28266 | __end_cc_report 11:31:01 INFO - PROCESS | 28266 | __startTimestamp1467225061798__endTimestamp 11:31:01 INFO - PROCESS | 28266 | 11:31:01 INFO - PROCESS | 28266 | ------- Summary: start ------- 11:31:01 INFO - PROCESS | 28266 | Number of tests: 6 11:31:01 INFO - PROCESS | 28266 | 11:31:01 INFO - PROCESS | 28266 | [#0] dojo.html Cycles:165 Average:5352.92 Median:5558.86 stddev:635.56 (11.4%) stddev-sans-first:611.74 11:31:01 INFO - PROCESS | 28266 | Values: 3069.2 3103.0 3108.0 3129.7 3132.9 5177.8 5245.0 5275.9 5368.2 5406.8 5326.2 5328.8 5329.0 5341.0 5411.3 4785.7 4838.8 4866.7 4878.1 5024.9 4883.4 4903.9 4926.9 4927.4 4957.0 4742.9 4770.1 4777.7 4840.8 4843.6 4805.0 4810.7 4818.2 4832.3 4932.0 4827.6 4860.6 4866.5 4880.8 4929.0 5169.0 5225.3 5317.2 5330.3 5411.7 5816.3 5827.2 5860.0 5875.4 5885.8 5921.8 5936.8 5942.9 5943.8 5944.6 5160.5 5298.5 5335.8 5345.0 5438.6 5909.4 5915.2 5915.8 5919.6 5925.6 5661.0 5697.7 5703.3 5709.3 5719.3 5502.5 5683.2 5729.9 5735.4 5821.4 5759.5 5768.4 5770.9 5775.9 5811.4 5721.8 5734.3 5781.7 5783.3 5795.8 4266.6 4284.6 4285.3 4361.0 4425.6 3918.4 3936.4 3941.0 3941.9 3944.0 5392.6 5410.5 5413.8 5422.3 5475.8 5790.9 5792.3 5798.5 5801.7 5853.1 5289.3 5449.3 5478.9 5488.3 5498.0 4818.5 4826.1 4840.2 4868.3 4881.6 5974.2 5979.5 5979.8 5996.7 5999.1 5585.3 5732.2 5801.9 5810.2 5822.7 5950.4 6013.3 6025.9 6086.5 6089.6 5719.5 5759.3 5760.2 5767.1 5772.6 5598.4 5825.4 5893.0 5898.7 5904.9 5684.0 5702.7 5706.7 5712.5 5751.7 5707.3 5707.5 5711.9 5712.9 5713.9 5385.9 5521.9 5577.2 5623.2 5634.3 5645.7 5674.7 5708.1 5713.4 5741.1 5514.2 5549.1 5551.3 5558.4 5558.9 11:31:01 INFO - PROCESS | 28266 | 11:31:01 INFO - PROCESS | 28266 | [#1] ext.html Cycles:180 Average:68708.77 Median:42934.79 stddev:153993.06 (358.7%) stddev-sans-first:154340.10 11:31:01 INFO - PROCESS | 28266 | Values: 579.0 582.1 609.6 613.2 627.3 33098.7 42642.8 42816.4 42894.6 43133.0 45229.0 45321.5 45384.0 45452.0 45576.8 8992.3 9128.4 9132.2 9136.6 9141.2 9058.3 9156.0 9160.5 9160.8 9166.8 8884.5 8916.5 8920.7 8926.3 8933.8 9064.2 9100.7 9114.3 9118.0 9118.2 8964.1 9042.6 9053.5 9056.0 9058.4 42975.0 43454.3 43507.1 43556.8 43584.3 3778.4 3830.5 3886.7 3928.0 4264.1 32599.7 33261.5 33451.2 33612.0 34019.0 4350.4 4504.6 4508.2 4600.4 4600.8 312334.0 312548.4 313225.0 313573.0 314822.0 59818.0 59996.0 60086.0 60362.4 60518.7 63173.4 63492.4 63534.0 63770.4 63817.0 17557.6 17767.5 17795.7 17837.1 17841.9 13678.2 13767.6 13774.6 13784.4 13791.1 16081.4 17726.2 17742.5 17911.0 17983.6 5156.3 6020.9 6094.7 6096.4 6105.3 998.8 1002.0 1051.6 1137.8 1158.6 32753.3 32820.8 33232.7 33233.3 33719.0 1091.9 1106.9 1108.5 1119.9 1172.9 16988.2 17113.9 17243.8 17280.7 17614.3 531249.0 828600.0 848962.0 849091.0 853415.0 59169.7 59255.0 59594.7 59755.0 59937.0 1228.5 1308.7 1310.1 1323.9 1334.3 29640.7 34100.3 34383.3 34484.8 34795.7 46009.5 56303.2 57581.7 57868.0 63244.0 503946.0 504941.0 506526.0 508462.0 511454.0 26072.0 29048.4 29399.0 29584.1 29832.7 48307.0 48787.8 49005.5 49102.8 50385.7 41040.6 42443.8 42747.6 42805.8 43485.6 42539.6 42607.4 42703.6 42813.8 43671.0 41440.6 42368.6 42481.8 42489.8 42546.1 35642.0 37210.4 38060.3 38068.2 38469.6 28285.0 28687.4 28736.7 28747.6 28814.9 11:31:01 INFO - PROCESS | 28266 | 11:31:01 INFO - PROCESS | 28266 | [#2] jquery.html Cycles:180 Average:27894.49 Median:412.27 stddev:74470.71 (18063.7%) stddev-sans-first:74651.01 11:31:01 INFO - PROCESS | 28266 | Values: 400.5 407.9 411.1 413.4 416.8 13451.9 18369.6 19704.4 20009.2 20033.5 19337.2 19644.0 19739.8 19884.0 19982.3 5720.9 5927.9 5931.2 5938.9 5963.4 5799.6 5888.2 5892.6 5894.6 5902.9 4149.4 4830.5 6531.8 6539.3 6652.5 5648.6 5941.2 6611.2 6650.1 6661.9 5820.5 5825.6 5839.7 5847.8 5851.4 14289.4 14528.3 14701.7 14772.1 14865.7 2241.8 2284.7 2289.9 2326.5 2334.7 9940.4 10811.8 10900.1 12768.9 14199.9 1883.2 1885.2 1907.5 1959.3 2026.2 66644.3 67736.3 67815.7 74880.8 86555.6 10628.3 11095.6 11192.8 11571.2 11583.9 15939.4 16098.5 16170.8 16178.0 16190.2 8438.2 8467.0 8536.3 8604.5 8619.4 8105.6 8133.8 8273.1 8294.3 8330.1 4830.3 4896.3 4944.8 4983.0 5089.2 1997.8 2001.3 2024.6 2057.1 2065.2 943.1 960.4 983.0 1016.7 1053.2 18946.7 19720.7 19845.2 20040.3 20261.8 974.3 983.6 991.9 1020.6 1080.6 10561.7 11280.5 11283.7 11316.6 11352.8 439818.0 450525.0 450852.0 453313.0 455232.0 95292.5 96255.5 97648.2 98728.5 100293.0 881.6 928.1 986.7 990.9 994.4 17518.7 17715.5 18311.7 18481.4 18490.9 43555.0 44200.3 44285.8 45073.5 45597.5 57993.4 59619.7 60934.0 61608.4 62110.0 7837.6 8189.0 8242.3 8407.5 9001.9 7813.4 10723.7 11494.0 13905.4 14237.2 12083.2 12099.7 12143.5 12249.9 12339.3 11738.6 11747.4 12023.4 12149.1 12305.5 12182.8 12442.7 12464.6 12679.8 12883.9 8356.9 8369.2 8381.9 8420.5 8556.3 11230.2 12208.6 12285.7 12291.6 12311.2 11:31:01 INFO - PROCESS | 28266 | 11:31:01 INFO - PROCESS | 28266 | [#3] mootools.html Cycles:180 Average:6044.14 Median:5038.16 stddev:3502.97 (69.5%) stddev-sans-first:3495.92 11:31:01 INFO - PROCESS | 28266 | Values: 1469.0 1511.0 1647.8 1764.6 1821.4 8695.3 9270.0 9338.5 9378.8 9386.8 7914.4 8611.2 8828.9 8858.6 9192.9 2288.0 2312.8 2313.2 2316.3 2316.9 2274.0 2291.0 2313.2 2313.8 2316.0 1953.6 2244.3 2300.0 2305.0 2345.1 2248.6 2249.3 2268.3 2269.4 2282.3 2285.4 2294.1 2306.9 2311.5 2319.3 9171.1 9238.2 9251.5 9255.4 9266.3 5318.5 5423.1 5471.4 5476.2 5480.5 3392.8 3395.8 3447.6 3464.3 3495.4 1100.3 1149.4 1154.7 1172.8 1182.5 12986.2 13064.3 13107.3 13108.5 13110.2 4778.8 4780.7 4795.6 4851.6 4909.1 10873.2 10929.2 10954.3 10959.7 10974.3 5497.2 5512.3 5521.6 5523.6 5526.6 5014.6 5061.7 5076.8 5209.5 5216.2 4179.4 4182.0 4214.9 4238.1 4238.7 1160.5 1299.2 1346.5 1362.9 1393.3 812.3 844.5 903.2 955.9 966.5 5939.3 6036.3 6131.2 6139.7 6164.3 943.4 952.9 958.0 971.1 988.4 4198.8 4304.0 4342.7 4357.8 4372.2 11242.3 11440.3 11521.6 11550.8 11633.1 11515.4 11600.9 11625.7 11633.4 11641.5 8380.2 8529.6 8568.0 8634.6 8636.7 6051.2 6111.4 6178.4 6218.0 6246.0 10413.2 10586.3 10606.7 10655.7 10693.5 10624.7 10811.1 10894.7 10965.8 10975.3 7955.7 7966.6 8035.5 8195.8 8287.0 8775.5 8794.0 8831.7 8869.0 8878.1 7857.8 7858.5 8059.6 8187.4 8196.1 7931.8 7993.9 8015.0 8196.4 8210.8 6981.4 7178.3 7369.1 7489.3 7508.2 5267.4 5286.2 5304.0 5374.0 5428.0 5153.8 5173.7 5201.8 5250.4 5420.9 11:31:01 INFO - PROCESS | 28266 | 11:31:01 INFO - PROCESS | 28266 | [#4] prototype.html Cycles:180 Average:4627.98 Median:5169.97 stddev:1354.93 (26.2%) stddev-sans-first:1319.57 11:31:01 INFO - PROCESS | 28266 | Values: 319.6 329.3 334.7 337.6 340.1 5116.3 5223.3 5246.8 5290.5 5303.2 5065.2 5214.0 5216.6 5227.3 5278.4 4124.9 4135.9 4152.3 4175.5 4194.1 3938.4 3976.9 4172.9 4178.7 4185.9 4120.1 4150.0 4166.5 4173.2 4176.4 4139.8 4163.0 4166.1 4169.4 4181.5 3470.2 3676.8 3702.8 3704.5 3715.5 5129.6 5136.8 5143.3 5157.7 5161.6 4712.8 4715.2 4724.5 4728.8 4729.0 5377.8 5501.3 5527.8 5535.2 5546.4 3962.4 3997.5 4001.6 4003.4 4004.4 5737.3 5746.4 5775.2 5775.7 5812.4 3938.8 4095.0 4112.5 4117.2 4124.0 4134.3 4164.9 4166.2 4186.1 4200.7 4782.1 4784.8 4789.1 4790.2 4809.2 5517.4 5616.6 5650.8 5657.3 5659.5 1421.9 1428.8 1432.3 1434.0 1444.8 906.2 908.2 921.2 925.9 932.4 4753.4 4764.9 4793.8 4827.3 4831.3 5023.9 5036.2 5049.3 5081.5 5086.8 4773.5 4777.2 4795.3 4804.0 5178.4 2981.1 3022.9 3027.1 3032.2 3044.3 5956.7 5963.4 5963.5 5970.8 5977.4 5576.9 5781.6 5793.9 5852.1 5860.4 5817.4 5841.7 5846.0 5857.8 5864.6 5553.1 5667.7 5699.3 5702.5 5713.6 5646.4 5650.0 5666.2 5673.5 5692.7 5870.1 5887.4 5916.9 5924.8 5931.7 3694.8 3790.5 3978.0 4071.5 4077.0 5622.7 5637.1 5639.5 5640.4 5679.2 5522.4 5533.9 5577.9 5590.6 5596.8 5330.9 5466.9 5472.9 5480.9 5501.5 5366.7 5400.2 5426.8 5439.3 5450.6 5300.7 5555.7 5560.8 5563.2 5568.8 5355.0 5413.3 5421.6 5423.9 5429.3 11:31:01 INFO - PROCESS | 28266 | 11:31:01 INFO - PROCESS | 28266 | [#5] yui.html Cycles:180 Average:20695.38 Median:4374.15 stddev:30259.97 (691.8%) stddev-sans-first:30307.81 11:31:01 INFO - PROCESS | 28266 | Values: 752.7 762.4 785.8 815.1 849.8 14164.0 14281.2 14906.2 14922.2 14935.1 13671.2 13861.0 13904.4 13906.4 13912.9 673.8 787.8 791.5 814.6 820.3 807.0 807.6 810.0 813.2 814.7 856.1 857.5 857.5 858.2 858.4 695.6 820.9 842.7 842.9 845.7 617.3 617.9 617.9 618.4 618.6 13825.7 13828.0 13828.7 13843.3 13871.0 14782.9 14792.3 14798.5 14851.8 14869.0 13430.5 13483.1 13525.5 13609.0 13771.7 4084.1 4137.6 4143.2 4146.8 4235.6 74701.0 74913.0 77849.0 78500.6 79316.6 11715.2 11799.8 11824.8 12009.9 12175.9 21851.0 22008.6 22011.0 22035.6 22036.2 8165.6 8332.1 8444.6 8493.4 8497.5 4445.8 4451.6 4511.6 4526.8 4647.9 3526.7 3652.3 3661.6 3663.5 4047.0 542.3 631.0 736.2 738.8 751.0 670.5 711.5 717.3 726.7 742.3 8798.6 8947.6 8957.7 9083.2 9106.8 475.1 679.8 742.6 751.2 764.8 4195.8 4339.4 4362.1 4386.1 4437.2 76450.2 77016.0 79494.0 126449.4 127141.0 106559.5 109086.5 109118.0 110011.0 112271.0 94011.0 95115.5 95161.0 95503.0 96649.0 9532.0 9592.8 9663.7 9937.4 10225.0 46003.8 46127.6 47403.5 49302.8 49705.3 73313.6 75960.6 77070.2 77802.6 78049.0 13199.1 13219.0 13885.7 13977.2 14224.9 12986.4 13020.3 13101.4 13230.4 13553.0 12349.6 12394.0 13164.6 13480.6 13639.2 12781.3 12963.2 13047.0 13514.6 13537.4 11644.4 11955.8 12049.8 12063.4 12315.7 10322.9 10765.5 10769.9 10781.6 10888.7 10739.8 10779.5 10851.7 10864.2 10914.3 11:31:01 INFO - PROCESS | 28266 | -------- Summary: end -------- 11:31:01 INFO - PROCESS | 28266 | 11:31:02 INFO - TEST-INFO | 28266: exit 0 11:31:02 INFO - TEST-OK | dromaeo_css | took 1114154ms 11:31:02 INFO - TEST-START | kraken 11:31:02 INFO - operating with platform_type : linux_ 11:31:02 INFO - Initialising browser for kraken test... 11:31:02 INFO - TEST-INFO | started process 28458 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYJLc1k/profile http://localhost:51373/getInfo.html) 11:31:06 INFO - PROCESS | 28458 | __metrics Screen width/height:1600/1200 11:31:06 INFO - PROCESS | 28458 | colorDepth:24 11:31:06 INFO - PROCESS | 28458 | Browser inner width/height: 1024/697 11:31:06 INFO - PROCESS | 28458 | __metrics 11:31:07 INFO - PROCESS | 28458 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:31:08 INFO - PROCESS | 28458 | console.error: PushService: 11:31:08 INFO - PROCESS | 28458 | stateChangeProcessEnqueue: Error transitioning state 11:31:08 INFO - PROCESS | 28458 | UnknownError 11:31:08 INFO - TEST-INFO | 28458: exit 0 11:31:08 INFO - Browser initialized. 11:31:08 INFO - Running cycle 1/1 for kraken test... 11:31:08 INFO - TEST-INFO | started process 28540 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYJLc1k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:31:20 INFO - PROCESS | 28540 | RSS: Main: 156942336 11:31:20 INFO - PROCESS | 28540 | 11:31:23 INFO - PROCESS | 28540 | Cycle 1(1): loaded http://localhost:51373/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51373/tests/kraken/driver.html?testName=audio-beat-detection) 11:31:23 INFO - PROCESS | 28540 | RSS: Main: 215117824 11:31:23 INFO - PROCESS | 28540 | 11:31:26 INFO - PROCESS | 28540 | Cycle 1(1): loaded http://localhost:51373/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51373/tests/kraken/driver.html?testName=audio-dft) 11:31:27 INFO - PROCESS | 28540 | RSS: Main: 204042240 11:31:27 INFO - PROCESS | 28540 | 11:31:30 INFO - PROCESS | 28540 | Cycle 1(1): loaded http://localhost:51373/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51373/tests/kraken/driver.html?testName=audio-fft) 11:31:30 INFO - PROCESS | 28540 | RSS: Main: 269520896 11:31:30 INFO - PROCESS | 28540 | 11:31:33 INFO - PROCESS | 28540 | Cycle 1(1): loaded http://localhost:51373/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51373/tests/kraken/driver.html?testName=audio-oscillator) 11:31:33 INFO - PROCESS | 28540 | RSS: Main: 179900416 11:31:33 INFO - PROCESS | 28540 | 11:31:35 INFO - PROCESS | 28540 | Cycle 1(1): loaded http://localhost:51373/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51373/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:31:36 INFO - PROCESS | 28540 | RSS: Main: 184598528 11:31:36 INFO - PROCESS | 28540 | 11:31:39 INFO - PROCESS | 28540 | Cycle 1(1): loaded http://localhost:51373/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51373/tests/kraken/driver.html?testName=imaging-darkroom) 11:31:39 INFO - PROCESS | 28540 | RSS: Main: 219148288 11:31:39 INFO - PROCESS | 28540 | 11:31:43 INFO - PROCESS | 28540 | Cycle 1(1): loaded http://localhost:51373/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51373/tests/kraken/driver.html?testName=imaging-desaturate) 11:31:43 INFO - PROCESS | 28540 | RSS: Main: 221646848 11:31:43 INFO - PROCESS | 28540 | 11:31:46 INFO - PROCESS | 28540 | Cycle 1(1): loaded http://localhost:51373/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51373/tests/kraken/driver.html?testName=json-parse-financial) 11:31:47 INFO - PROCESS | 28540 | RSS: Main: 221700096 11:31:47 INFO - PROCESS | 28540 | 11:31:48 INFO - PROCESS | 28540 | Cycle 1(1): loaded http://localhost:51373/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51373/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:31:49 INFO - PROCESS | 28540 | RSS: Main: 207872000 11:31:49 INFO - PROCESS | 28540 | 11:31:51 INFO - PROCESS | 28540 | Cycle 1(1): loaded http://localhost:51373/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51373/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:31:51 INFO - PROCESS | 28540 | RSS: Main: 212910080 11:31:51 INFO - PROCESS | 28540 | 11:31:53 INFO - PROCESS | 28540 | Cycle 1(1): loaded http://localhost:51373/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51373/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:31:54 INFO - PROCESS | 28540 | RSS: Main: 210018304 11:31:54 INFO - PROCESS | 28540 | 11:31:56 INFO - PROCESS | 28540 | Cycle 1(1): loaded http://localhost:51373/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51373/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:31:57 INFO - PROCESS | 28540 | RSS: Main: 225136640 11:31:57 INFO - PROCESS | 28540 | 11:32:00 INFO - PROCESS | 28540 | Cycle 1(1): loaded http://localhost:51373/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51373/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:32:00 INFO - PROCESS | 28540 | RSS: Main: 224735232 11:32:00 INFO - PROCESS | 28540 | 11:32:02 INFO - PROCESS | 28540 | Cycle 1(1): loaded http://localhost:51373/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51373/tests/kraken/driver.html?testName=ai-astar) 11:32:02 INFO - PROCESS | 28540 | RSS: Main: 266924032 11:32:02 INFO - PROCESS | 28540 | 11:32:02 INFO - PROCESS | 28540 | __start_tp_report 11:32:02 INFO - PROCESS | 28540 | _x_x_mozilla_page_load 11:32:02 INFO - PROCESS | 28540 | _x_x_mozilla_page_load_details 11:32:02 INFO - PROCESS | 28540 | |i|pagename|runs| 11:32:02 INFO - PROCESS | 28540 | |0;ai-astar;104;112;112;112;112;111;111;112;110;112 11:32:02 INFO - PROCESS | 28540 | |1;audio-beat-detection;148;121;122;163;120;118;141;117;154;116 11:32:02 INFO - PROCESS | 28540 | |2;audio-dft;160;161;160;161;161;162;161;162;160;162 11:32:02 INFO - PROCESS | 28540 | |3;audio-fft;75;75;77;136;74;76;74;75;104;74 11:32:02 INFO - PROCESS | 28540 | |4;audio-oscillator;84;84;115;83;83;84;124;83;84;128 11:32:02 INFO - PROCESS | 28540 | |5;imaging-gaussian-blur;116;116;117;117;117;117;116;117;117;116 11:32:02 INFO - PROCESS | 28540 | |6;imaging-darkroom;146;146;147;147;146;147;146;147;146;145 11:32:02 INFO - PROCESS | 28540 | |7;imaging-desaturate;95;95;95;95;95;95;94;95;95;95 11:32:02 INFO - PROCESS | 28540 | |8;json-parse-financial;52;52;54;53;53;58;53;53;53;53 11:32:02 INFO - PROCESS | 28540 | |9;json-stringify-tinderbox;60;61;62;62;61;60;61;60;60;61 11:32:02 INFO - PROCESS | 28540 | |10;stanford-crypto-aes;77;76;75;74;74;76;78;76;76;78 11:32:02 INFO - PROCESS | 28540 | |11;stanford-crypto-ccm;125;121;125;121;119;120;121;122;160;129 11:32:02 INFO - PROCESS | 28540 | |12;stanford-crypto-pbkdf2;162;157;158;160;161;162;158;161;157;158 11:32:02 INFO - PROCESS | 28540 | |13;stanford-crypto-sha256-iterative;63;64;64;65;64;62;64;63;63;61 11:32:02 INFO - PROCESS | 28540 | __end_tp_report 11:32:02 INFO - PROCESS | 28540 | __start_cc_report 11:32:02 INFO - PROCESS | 28540 | _x_x_mozilla_cycle_collect,1678 11:32:02 INFO - PROCESS | 28540 | __end_cc_report 11:32:02 INFO - PROCESS | 28540 | __startTimestamp1467225122806__endTimestamp 11:32:02 INFO - PROCESS | 28540 | 11:32:02 INFO - PROCESS | 28540 | ------- Summary: start ------- 11:32:02 INFO - PROCESS | 28540 | Number of tests: 14 11:32:02 INFO - PROCESS | 28540 | 11:32:02 INFO - PROCESS | 28540 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.00 stddev:2.49 (2.2%) stddev-sans-first:0.73 11:32:02 INFO - PROCESS | 28540 | Values: 104.0 112.0 112.0 112.0 112.0 111.0 111.0 112.0 110.0 112.0 11:32:02 INFO - PROCESS | 28540 | 11:32:02 INFO - PROCESS | 28540 | [#1] audio-beat-detection Cycles:10 Average:132.00 Median:131.50 stddev:17.71 (13.5%) stddev-sans-first:17.82 11:32:02 INFO - PROCESS | 28540 | Values: 148.0 121.0 122.0 163.0 120.0 118.0 141.0 117.0 154.0 116.0 11:32:02 INFO - PROCESS | 28540 | 11:32:02 INFO - PROCESS | 28540 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.78 11:32:02 INFO - PROCESS | 28540 | Values: 160.0 161.0 160.0 161.0 161.0 162.0 161.0 162.0 160.0 162.0 11:32:02 INFO - PROCESS | 28540 | 11:32:02 INFO - PROCESS | 28540 | [#3] audio-fft Cycles:10 Average:84.00 Median:75.00 stddev:20.44 (27.3%) stddev-sans-first:21.42 11:32:02 INFO - PROCESS | 28540 | Values: 75.0 75.0 77.0 136.0 74.0 76.0 74.0 75.0 104.0 74.0 11:32:02 INFO - PROCESS | 28540 | 11:32:02 INFO - PROCESS | 28540 | [#4] audio-oscillator Cycles:10 Average:95.20 Median:83.50 stddev:18.99 (22.7%) stddev-sans-first:19.70 11:32:02 INFO - PROCESS | 28540 | Values: 84.0 84.0 115.0 83.0 83.0 84.0 124.0 83.0 84.0 128.0 11:32:02 INFO - PROCESS | 28540 | 11:32:02 INFO - PROCESS | 28540 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 11:32:02 INFO - PROCESS | 28540 | Values: 116.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 11:32:02 INFO - PROCESS | 28540 | 11:32:02 INFO - PROCESS | 28540 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 11:32:02 INFO - PROCESS | 28540 | Values: 146.0 146.0 147.0 147.0 146.0 147.0 146.0 147.0 146.0 145.0 11:32:02 INFO - PROCESS | 28540 | 11:32:02 INFO - PROCESS | 28540 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:32:02 INFO - PROCESS | 28540 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 11:32:02 INFO - PROCESS | 28540 | 11:32:02 INFO - PROCESS | 28540 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.00 stddev:1.71 (3.2%) stddev-sans-first:1.74 11:32:02 INFO - PROCESS | 28540 | Values: 52.0 52.0 54.0 53.0 53.0 58.0 53.0 53.0 53.0 53.0 11:32:02 INFO - PROCESS | 28540 | 11:32:02 INFO - PROCESS | 28540 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.79 (1.3%) stddev-sans-first:0.78 11:32:02 INFO - PROCESS | 28540 | Values: 60.0 61.0 62.0 62.0 61.0 60.0 61.0 60.0 60.0 61.0 11:32:02 INFO - PROCESS | 28540 | 11:32:02 INFO - PROCESS | 28540 | [#10] stanford-crypto-aes Cycles:10 Average:76.00 Median:76.00 stddev:1.41 (1.9%) stddev-sans-first:1.45 11:32:02 INFO - PROCESS | 28540 | Values: 77.0 76.0 75.0 74.0 74.0 76.0 78.0 76.0 76.0 78.0 11:32:02 INFO - PROCESS | 28540 | 11:32:02 INFO - PROCESS | 28540 | [#11] stanford-crypto-ccm Cycles:10 Average:126.30 Median:123.50 stddev:12.21 (9.9%) stddev-sans-first:12.94 11:32:02 INFO - PROCESS | 28540 | Values: 125.0 121.0 125.0 121.0 119.0 120.0 121.0 122.0 160.0 129.0 11:32:02 INFO - PROCESS | 28540 | 11:32:02 INFO - PROCESS | 28540 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.40 Median:160.50 stddev:2.01 (1.3%) stddev-sans-first:1.90 11:32:02 INFO - PROCESS | 28540 | Values: 162.0 157.0 158.0 160.0 161.0 162.0 158.0 161.0 157.0 158.0 11:32:02 INFO - PROCESS | 28540 | 11:32:02 INFO - PROCESS | 28540 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:64.00 stddev:1.16 (1.8%) stddev-sans-first:1.22 11:32:02 INFO - PROCESS | 28540 | Values: 63.0 64.0 64.0 65.0 64.0 62.0 64.0 63.0 63.0 61.0 11:32:02 INFO - PROCESS | 28540 | -------- Summary: end -------- 11:32:02 INFO - PROCESS | 28540 | 11:32:03 INFO - TEST-INFO | 28540: exit 0 11:32:03 INFO - TEST-OK | kraken | took 61217ms 11:32:03 INFO - SUITE-END | took 1175s 11:32:03 INFO - Completed test suite (00:19:35) 11:32:03 INFO - javascript benchmark 11:32:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3069.2173495758593, 3103.022547897413, 3107.984460077699, 3129.718325350718, 3132.8746850125995, 5177.844664660057, 5245.029669511134, 5275.868103297419, 5368.194770784385, 5406.783728650859, 5326.227696983935, 5328.760205790739, 5329.0, 5340.973295133519, 5411.323584551931, 4785.712857228568, 4838.830640927568, 4866.707997520142, 4878.146324393235, 5024.874378140557, 4883.389576302962, 4903.8528844134735, 4926.901461970759, 4927.384076990376, 4956.9772726137735, 4742.857714268577, 4770.141374552579, 4777.689450185744, 4840.806367745286, 4843.58829499493, 4805.038992201574, 4810.687305325143, 4818.180909245437, 4832.275158726184, 4931.975340123312, 4827.565519103263, 4860.635452341053, 4866.51334866514, 4880.829170978998, 4929.0, 5169.043726910496, 5225.346831646044, 5317.175837745156, 5330.253764472977, 5411.702356370398, 5816.331121920991, 5827.242458480413, 5859.970700146515, 5875.441833025856, 5885.79399721012, 5921.822345329647, 5936.7922122725495, 5942.910856337158, 5943.762249510014, 5944.613600115978, 5160.458151894035, 5298.523132918017, 5335.7865685372535, 5345.0, 5438.646487978348, 5909.409059094056, 5915.231019967377, 5915.792947246911, 5919.585629005928, 5925.555583331267, 5660.971695141498, 5697.686627235459, 5703.258576385043, 5709.314882214161, 5719.342275638355, 5502.477264659851, 5683.232763576947, 5729.942700572941, 5735.426457354231, 5821.388754180834, 5759.539236861041, 5768.3654797972185, 5770.884582308414, 5775.88448231033, 5811.360750317462, 5721.828345149652, 5734.311882574118, 5781.682007489629, 5783.277090363705, 5795.82612521625, 4266.6160045595425, 4284.635805956528, 4285.314349704095, 4360.978195109004, 4425.645948324126, 3918.3534716771983, 3936.3505021671676, 3940.9605903941165, 3941.9014524637114, 3944.033711740642, 5392.649477783932, 5410.540104091117, 5413.810516631977, 5422.322209723785, 5475.835724928259, 5790.913136302959, 5792.304923409133, 5798.536117110621, 5801.6809075500405, 5853.09277062056, 5289.338832645919, 5449.291592093082, 5478.91781623276, 5488.341399032141, 5498.0, 4818.494058123917, 4826.131296366688, 4840.15297322967, 4868.294097355863, 4881.609471242292, 5974.1934838796205, 5979.521638268928, 5979.760809567656, 5996.730147143389, 5999.070144127667, 5585.3297604287745, 5732.197492351158, 5801.88396232073, 5810.186573879745, 5822.679752613478, 5950.404959504015, 6013.30846952606, 6025.939740602538, 6086.452219300284, 6089.604175728564, 5719.456651618089, 5759.308882934075, 5760.164776107525, 5767.077267637325, 5772.567057470623, 5598.356189038313, 5825.388334225015, 5892.970535147297, 5898.705064746831, 5904.940950590439, 5683.971580142238, 5702.657840529581, 5706.714664266687, 5712.542996560348, 5751.683657398716, 5707.286589176353, 5707.514861236676, 5711.943290491273, 5712.8571785704025, 5713.857153571194, 5385.9192112119135, 5521.917171242354, 5577.191307260506, 5623.212750215055, 5634.267545219095, 5645.717714114196, 5674.716264186856, 5708.115242137475, 5713.428657134254, 5741.081426971665, 5514.228008078952, 5549.112142057252, 5551.306086739158, 5558.44415558441, 5558.861028474321], "value": 5308.590728104847, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.9739461724222, 582.1122787748683, 609.5641616244387, 613.2181468627502, 627.3005598757386, 33098.66901330986, 42642.78678606606, 42816.357754633704, 42894.571054289445, 43133.0, 45229.0, 45321.54678453215, 45384.0, 45452.0, 45576.77211613937, 8992.280617550596, 9128.361014728971, 9132.178103970675, 9136.58885350161, 9141.222996045311, 9058.320625953047, 9156.038615945296, 9160.541972901328, 9160.770980725469, 9166.770830729218, 8884.466931984069, 8916.465012099263, 8920.73237802867, 8926.330525210602, 8933.821323573524, 9064.18422341989, 9100.726978190665, 9114.27085833135, 9118.0, 9118.17936385725, 8964.05877382872, 9042.593083311267, 9053.4567925924, 9055.954720226357, 9058.411203271831, 42975.0, 43454.348184776936, 43507.12985740299, 43556.782216088715, 43584.3462348065, 3778.425539561144, 3830.540335159799, 3886.689064874803, 3928.017995501125, 4264.061906380592, 32599.6740032599, 33261.50107748386, 33451.16372090693, 33612.0, 34019.0, 4350.369196466495, 4504.572065653758, 4508.211063063951, 4600.401947746805, 4600.7929643166135, 312334.0, 312548.4372578145, 313225.0, 313573.0, 314822.0, 59818.0, 59996.0, 60086.0, 60362.39637603568, 60518.697406512685, 63173.368266317666, 63492.36507634957, 63534.0, 63770.36229637644, 63817.0, 17557.561060973578, 17767.46697599074, 17795.73306400405, 17837.10814459272, 17841.910790445963, 13678.179309241477, 13767.586972390844, 13774.586762397144, 13784.379702913193, 13791.10357826738, 16081.437149699705, 17726.20232089559, 17742.516047753325, 17911.0, 17983.640327193643, 5156.329677141947, 6020.939790602038, 6094.659174981497, 6096.359882212392, 6105.267367915879, 998.770282834952, 1002.04304888831, 1051.5636011055326, 1137.8008848451489, 1158.6350299655583, 32753.34493310168, 32820.83589582085, 33232.667673322954, 33233.3353332932, 33719.0, 1091.8908109189017, 1106.9169812264113, 1108.539955918285, 1119.8600174978128, 1172.85060640571, 16988.150592470327, 17113.91443042777, 17243.827561724473, 17280.740788888175, 17614.295428182984, 531249.0, 828600.0, 848962.0, 849091.0, 853415.0, 59169.70415147897, 59255.0, 59594.70202648959, 59755.0, 59937.0, 1228.4840367045683, 1308.672831792052, 1310.0894878059657, 1323.9271840048698, 1334.2661536155076, 29640.703592963793, 34100.317993640485, 34383.31233375368, 34484.82757586196, 34795.65204348025, 46009.539904600526, 56303.15545266906, 57581.71209143927, 57868.0, 63244.0, 503946.0, 504941.0, 506526.0, 508462.0, 511454.0, 26072.0, 29048.419031618825, 29399.0, 29584.112476625734, 29832.70167298386, 48307.0, 48787.756061219465, 49005.50994490152, 49102.75448622734, 50385.74807125941, 41040.58959410368, 42443.7877810609, 42747.57252427436, 42805.78597106995, 43485.56514434942, 42539.5746042548, 42607.36088958606, 42703.57296426996, 42813.785931070146, 43671.0, 41440.585594143675, 42368.576314237696, 42481.787591061846, 42489.78755106204, 42546.149077018905, 35642.0, 37210.44184337183, 38060.2571598485, 38068.238635227695, 38469.61530384772, 28285.0, 28687.426251474437, 28736.71263287424, 28747.5687864678, 28814.855925721076], "value": 20723.530378368527, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.4853762914652, 407.94288799568056, 411.13661311246386, 413.3985051749704, 416.8082681966295, 13451.865481345183, 18369.632607347845, 19704.40886773399, 20009.19963201472, 20033.499162520926, 19337.226510939545, 19644.0, 19739.802601974014, 19884.0, 19982.300619478287, 5720.8855822883515, 5927.911081333784, 5931.199288096116, 5938.851528711795, 5963.3738457462, 5799.608094057438, 5888.234529511179, 5892.558058145635, 5894.58737888348, 5902.940970590282, 4149.3983372410985, 4830.492798256185, 6531.804045878631, 6539.313372095909, 6652.501062420313, 5648.63283886546, 5941.168236446901, 6611.206655201383, 6650.1354823872825, 6661.93338066618, 5820.476157145835, 5825.621334613236, 5839.737211825435, 5847.8245652630485, 5851.4148585141575, 14289.428422863177, 14528.273586320642, 14701.705965880623, 14772.113673179536, 14865.70268594633, 2241.753407125215, 2284.7144106986625, 2289.9084036638515, 2326.5463234669246, 2334.7198336199763, 9940.353876997971, 10811.783764324748, 10900.12798976088, 12768.872311276955, 14199.858001419956, 1883.1525813384033, 1885.2364792259157, 1907.4849790556611, 1959.2848610257297, 2026.179397344078, 66644.33355666429, 67736.32263677349, 67815.66092169557, 74880.82942718739, 86555.56722216411, 10628.25602207838, 11095.5561777528, 11192.832107518394, 11571.247868888495, 11583.884161158448, 15939.44211952576, 16098.517044488684, 16170.75743863843, 16178.0, 16190.190490475665, 8438.156184381513, 8467.026291976501, 8536.317094632415, 8604.48373097616, 8619.39664223511, 8105.554194519358, 8133.79665508367, 8273.131321211307, 8294.336453083739, 8330.125336839666, 4830.275458681226, 4896.265560165933, 4944.802207911644, 4982.950170498249, 5089.211172268304, 1997.8401727861735, 2001.2995451591826, 2024.6355655982065, 2057.1154403606592, 2065.2461851424423, 943.118184497497, 960.3805545423163, 983.0, 1016.6695823857276, 1053.1574740207802, 18946.715799263024, 19720.70418943717, 19845.206191752455, 20040.298589549588, 20261.79738202599, 974.2741657465234, 983.6213057972589, 991.8512223166439, 1020.6325722739956, 1080.5569716416232, 10561.683149505527, 11280.492377843017, 11283.717907052389, 11316.6039188628, 11352.772944541228, 439818.0, 450525.0, 450852.0, 453313.0, 455232.0, 95292.52353738325, 96255.51872240593, 97648.21800014035, 98728.50635746919, 100293.0, 881.6209030116983, 928.1461055828654, 986.7335819328741, 990.895955924632, 994.3834822410151, 17518.73721894198, 17715.468535943943, 18311.72532411988, 18481.445556633324, 18490.907545462185, 43555.0, 44200.33699494575, 44285.77857110694, 45073.54926450825, 45597.54402455933, 57993.420065798804, 59619.70190149022, 60934.0, 61608.383916162056, 62110.0, 7837.568933708472, 8189.0, 8242.340612751086, 8407.53758543286, 9001.864972025556, 7813.413993950363, 10723.731906702084, 11494.0, 13905.400878899056, 14237.21695306768, 12083.154179207371, 12099.697507562381, 12143.453544590691, 12249.938750306192, 12339.259644421363, 11738.58914937973, 11747.412629368326, 12023.398830058637, 12149.088818338483, 12305.507779689071, 12182.75634487323, 12442.688932776753, 12464.626061218178, 12679.80980285278, 12883.871161288267, 8356.884735202491, 8369.204925532065, 8381.916180838114, 8420.4947703138, 8556.27271681889, 11230.157738169506, 12208.633740987785, 12285.69285767863, 12291.56979505713, 12311.19977201479], "value": 9259.325768002793, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1469.0451206715634, 1510.9773353399698, 1647.8105017922935, 1764.576501639607, 1821.3898344054733, 8695.26090282326, 9269.953650231739, 9338.486383248919, 9378.765530861732, 9386.81226375473, 7914.406419518545, 8611.224989750921, 8828.911710882889, 8858.601362938667, 9192.862107068398, 2287.954240915181, 2312.849664771793, 2313.1672597864754, 2316.2587971849016, 2316.9420764480938, 2273.954520909581, 2291.0, 2313.2250696016854, 2313.849599776009, 2315.9536809263805, 1953.6483432982056, 2244.2706120510816, 2300.0339857259905, 2304.976950230501, 2345.061975209913, 2248.6177349850564, 2249.347689170139, 2268.319504148757, 2269.3645779181857, 2282.3495303838326, 2285.3600991722346, 2294.0823670531754, 2306.8615883047073, 2311.514581937795, 2319.2578374919863, 9171.128742769426, 9238.214751746109, 9251.491167985758, 9255.398399104037, 9266.258699304039, 5318.547923426513, 5423.105187644034, 5471.398146203915, 5476.205950137248, 5480.479354461319, 3392.8133952632597, 3395.813230272334, 3447.6035255945385, 3464.2551851351827, 3495.4407294832704, 1100.290312748281, 1149.4425203776161, 1154.7055500847314, 1172.7947609168361, 1182.479708928069, 12986.22082675033, 13064.346782660828, 13107.34463276842, 13108.541201058013, 13110.213387196798, 4778.808847646124, 4780.713157210578, 4795.568398844051, 4851.56335929768, 4909.140900342426, 10873.238873278953, 10929.234953553334, 10954.342739435659, 10959.671209863716, 10974.286671366335, 5497.175423686479, 5512.283403157564, 5521.641093328921, 5523.6409633373705, 5526.613137080446, 5014.6431177346585, 5061.670991385548, 5076.796928122908, 5209.505097015777, 5216.243644671501, 4179.414881916534, 4182.0, 4214.894627634334, 4238.067625122468, 4238.724482908601, 1160.460385920551, 1299.2204677193608, 1346.501794336102, 1362.8909687224998, 1393.261571367177, 812.2608426332009, 844.5458076467278, 903.1555495611624, 955.9389078123278, 966.4877614864133, 5939.346671866091, 6036.275646922398, 6131.233595800525, 6139.662318572432, 6164.291106522717, 943.3867985809279, 952.8761261036021, 957.9664711735056, 971.1257273462145, 988.4365911430559, 4198.832046718097, 4303.978480107642, 4342.6742994275555, 4357.803898824561, 4372.191144638252, 11242.325460472397, 11440.256383335056, 11521.596744113916, 11550.826737598944, 11633.069354451623, 11515.366654833897, 11600.88399116015, 11625.709357266136, 11633.360165190996, 11641.47613357401, 8380.161983801692, 8529.616167272488, 8568.0, 8634.56827158652, 8636.740897773077, 6051.152838602688, 6111.449969502766, 6178.443940045418, 6218.0, 6246.0, 10413.219008574539, 10586.31188972745, 10606.681799546026, 10655.680329590125, 10693.518791654238, 10624.681259562225, 10811.081058110149, 10894.67315980522, 10965.780684386427, 10975.341479511255, 7955.721549745731, 7966.641501132347, 8035.517868927883, 8195.83608327842, 8287.0, 8775.473471591726, 8794.032656407662, 8831.69089081879, 8869.0, 8878.11218878107, 7857.842843143219, 7858.489198202098, 8059.637316320663, 8187.426880118573, 8196.057453392697, 7931.801704957422, 7993.880091798744, 8015.0, 8196.385271104571, 8210.753677389688, 6981.371676549135, 7178.318059784312, 7369.115706115301, 7489.325960663567, 7508.211637778173, 5267.367915850123, 5286.20706893969, 5303.973480132575, 5373.9731301343245, 5428.0, 5153.793848246029, 5173.715445650375, 5201.791928322825, 5250.369955605352, 5420.945790542044], "value": 4785.696815282309, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.62444128149434, 329.3281705321145, 334.7088033410933, 337.6387265625781, 340.1004343511413, 5116.283720279164, 5223.268742376065, 5246.816361427351, 5290.470952904708, 5303.204519322104, 5065.240213967907, 5213.973930130353, 5216.5826733861295, 5227.3465816772905, 5278.419373868871, 4124.938125928114, 4135.896602584944, 4152.314868046768, 4175.457190565222, 4194.14020125875, 3938.3895496198134, 3976.946109281043, 4172.874813755592, 4178.749275043492, 4185.865208743532, 4120.134771697947, 4149.97925010376, 4166.520885085796, 4173.2070906527815, 4176.352665336878, 4139.77231252281, 4162.958370416287, 4166.062635906912, 4169.4162817205615, 4181.498220213563, 3470.2192006798523, 3676.761010534307, 3702.8148592570265, 3704.5181927229055, 3715.461258117558, 5129.589362925225, 5136.794528218867, 5143.331366922276, 5157.742112894378, 5161.561267292284, 4712.764361781898, 4715.198416269242, 4724.456687480915, 4728.763561821929, 4729.0, 5377.7580008899695, 5501.284832971728, 5527.751251193706, 5535.225068490415, 5546.417626149237, 3962.385830196324, 3997.4603428537066, 4001.579439299036, 4003.419504171908, 4004.3593025115842, 5737.254156959611, 5746.367899531048, 5775.249217601685, 5775.711214439261, 5812.38969908162, 3938.822752976123, 4094.959050409517, 4112.527059388149, 4117.197146556393, 4123.958760412357, 4134.297169481196, 4164.895877603084, 4166.166766646683, 4186.079062606222, 4200.7059505834295, 4782.115308667838, 4784.755963449528, 4789.09007288621, 4790.209615413418, 4809.206480930678, 5517.420670829585, 5616.606837521416, 5650.813329200914, 5657.32112146545, 5659.462351076641, 1421.9431222750975, 1428.8285405751376, 1432.3053319140208, 1434.0248630930857, 1444.7760597107465, 906.1527471813876, 908.2416182487697, 921.2261700171888, 925.9259259259243, 932.4172392254841, 4753.35829662998, 4764.880877978009, 4793.832215872498, 4827.25177597473, 4831.347768051339, 5023.899522009539, 5036.212144688656, 5049.267856160836, 5081.4918508148885, 5086.821961231339, 4773.498782627844, 4777.211760059621, 4795.304680821261, 4804.039192161582, 5178.378594568676, 2981.090767315946, 3022.863971121305, 3027.108057464085, 3032.2116249774776, 3044.2693753499443, 5956.7319470623925, 5963.4334738199805, 5963.463288304073, 5970.820875373745, 5977.432143946318, 5576.888462230732, 5781.6241944274325, 5793.855153621109, 5852.063669812809, 5860.384659610765, 5817.389174136655, 5841.678707671034, 5845.970770146122, 5857.765689372377, 5864.560157988082, 5553.0559804832465, 5667.659940403589, 5699.2590963174525, 5702.486776189997, 5713.571482138773, 5646.35066967304, 5650.0, 5666.178404131296, 5673.461021202979, 5692.658440493584, 5870.14882841994, 5887.409539802473, 5916.881662366814, 5924.822255332347, 5931.699517849524, 3694.7598406103516, 3790.5261842269715, 3978.0, 4071.531773845927, 4077.0, 5622.746976385991, 5637.126245431965, 5639.54883609302, 5640.407757185437, 5679.176519404746, 5522.392536820867, 5533.861653458695, 5577.9442205577425, 5590.636608620589, 5596.776128954796, 5330.9466905332, 5466.945330546644, 5472.863178420572, 5480.873264068995, 5501.469324110793, 5366.6779993200535, 5400.243965844864, 5426.755795989269, 5439.347278326468, 5450.563954883521, 5300.70846103468, 5555.666660000251, 5560.833175004756, 5563.193336966198, 5568.8305455854725, 5355.0454084259745, 5413.269208656781, 5421.566274698093, 5423.864403389947, 5429.267048948342], "value": 4197.164844070647, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.6801109528449, 762.393896852003, 785.7996210966203, 815.0830315894618, 849.7918010087529, 14164.0, 14281.21453320067, 14906.180160091191, 14922.179280139588, 14935.103893766369, 13671.248081355521, 13861.029727919025, 13904.443822247098, 13906.443742250323, 13912.860871391309, 673.7877568565887, 787.8188016756135, 791.4934441957153, 814.5764202614637, 820.2986446588171, 807.0476837331946, 807.6163822184445, 809.9757007289791, 813.1665043330574, 814.698561532234, 856.1010938514565, 857.5069335132292, 857.5155037403878, 858.1890113842421, 858.4034096303072, 695.5965539986821, 820.938429617781, 842.6755699055847, 842.873568964654, 845.691322667222, 617.2562062714418, 617.8640699046202, 617.8764247150588, 618.3723520626568, 618.6411881108946, 13825.723485530334, 13828.0, 13828.654283642989, 13843.30783460823, 13871.0, 14782.926085369505, 14792.334344954503, 14798.48205312809, 14851.777223341658, 14869.0, 13430.462781488728, 13483.123596966167, 13525.526606568821, 13609.0, 13771.724565508634, 4084.0606660468256, 4137.565555616678, 4143.233501802146, 4146.834126634931, 4235.555266697014, 74701.0, 74913.0, 77849.0, 78500.60749696272, 79316.60341698313, 11715.1799374043, 11799.764004719858, 11824.822627660593, 12009.939950300368, 12175.93912030452, 21851.0, 22008.559828803332, 22011.0, 22035.559288814133, 22036.228731994303, 8165.611271322454, 8332.083470818205, 8444.61999210037, 8493.362997775192, 8497.490150590984, 4445.799939002753, 4451.599356057905, 4511.571400716993, 4526.79629416677, 4647.86056418308, 3526.7002304804378, 3652.3243200008083, 3661.6338366163172, 3663.5237419135874, 4047.0, 542.3085565903505, 630.9873802523924, 736.2196072163524, 738.8300690841137, 751.0461713623667, 670.47367816264, 711.4806191480249, 717.3436305780152, 726.6693654387241, 742.3319012888444, 8798.604062817189, 8947.642094316154, 8957.686480973134, 9083.18251357381, 9106.81786364269, 475.0546412638824, 679.7635778289373, 742.5693098003145, 751.2037240525061, 764.8393837294119, 4195.811188496464, 4339.392485052095, 4362.1493808707, 4386.1447017831215, 4437.179121862466, 76450.23549764542, 77016.0, 79494.0, 126449.36775316065, 127141.0, 106559.4672026635, 109086.45456772824, 109118.0, 110011.0, 112271.0, 94011.0, 95115.52442237745, 95161.0, 95503.0, 96649.0, 9531.952340238255, 9592.808143837225, 9663.710088697351, 9937.391634562935, 10225.0, 46003.76998114988, 46127.61617151491, 47403.525964739914, 49302.75348623234, 49705.254421184436, 73313.6334318325, 75960.62019689866, 77070.2292977063, 77802.61098694471, 78049.0, 13199.142055766344, 13219.0, 13885.65285867821, 13977.161370317814, 14224.857751422353, 12986.415611297325, 13020.348982551024, 13101.410436530188, 13230.4046317914, 13553.0, 12349.567765128177, 12394.0, 13164.60506184816, 13480.595582132551, 13639.181649101085, 12781.297028663514, 12963.15739476931, 13047.021473389344, 13514.59456216315, 13537.390817413438, 11644.41777911118, 11955.76088478243, 12049.75900481968, 12063.39683015828, 12315.69210769738, 10322.948385258025, 10765.46172691378, 10769.946150269512, 10781.568737250422, 10888.727781805519, 10739.785204296026, 10779.461026948778, 10851.728706782395, 10864.239503234698, 10914.34513929135], "value": 7480.576693292382, "unit": "score"}], "name": "dromaeo_css", "value": 7313.92860348638, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 112.0, 112.0, 112.0, 111.0, 111.0, 112.0, 110.0, 112.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 121.0, 122.0, 163.0, 120.0, 118.0, 141.0, 117.0, 154.0, 116.0], "value": 132.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 161.0, 161.0, 162.0, 161.0, 162.0, 160.0, 162.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 136.0, 74.0, 76.0, 74.0, 75.0, 104.0, 74.0], "value": 84.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 115.0, 83.0, 83.0, 84.0, 124.0, 83.0, 84.0, 128.0], "value": 95.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 145.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 54.0, 53.0, 53.0, 58.0, 53.0, 53.0, 53.0, 53.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 62.0, 62.0, 61.0, 60.0, 61.0, 60.0, 60.0, 61.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 74.0, 74.0, 76.0, 78.0, 76.0, 76.0, 78.0], "value": 76.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 121.0, 125.0, 121.0, 119.0, 120.0, 121.0, 122.0, 160.0, 129.0], "value": 126.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 157.0, 158.0, 160.0, 161.0, 162.0, 158.0, 161.0, 157.0, 158.0], "value": 159.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 65.0, 64.0, 62.0, 64.0, 63.0, 63.0, 61.0], "value": 63.3, "unit": "score"}], "name": "kraken", "value": 1480.0, "alertThreshold": 2.0}]} 11:32:04 INFO - Return code: 0 11:32:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:32:04 INFO - # TBPL SUCCESS # 11:32:04 INFO - Running post-action listener: _resource_record_post_action 11:32:04 INFO - ##### 11:32:04 INFO - ##### Finished run-tests step (success) 11:32:04 INFO - ##### 11:32:04 INFO - Running post-run listener: _resource_record_post_run 11:32:04 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 551358464; Read time: 0; Write time: 689268 11:32:04 INFO - TinderboxPrint: CPU usage
13.0% 11:32:04 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 11:32:04 INFO - TinderboxPrint: I/O write bytes / time
551,358,464 / 689,268 11:32:04 INFO - TinderboxPrint: CPU idle
8,279.1 (86.9%) 11:32:04 INFO - TinderboxPrint: CPU user
1,196.1 (12.6%) 11:32:04 INFO - TinderboxPrint: Swap in / out
0 / 0 11:32:04 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 256675840; Read time: 0; Write time: 394904 11:32:04 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 294682624; Read time: 0; Write time: 294364 11:32:04 INFO - Running post-run listener: _upload_blobber_files 11:32:04 INFO - Blob upload gear active. 11:32:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:32:04 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:32:04 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:32:04 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:32:05 INFO - (blobuploader) - INFO - Open directory for files ... 11:32:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:32:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:32:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:32:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:32:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:32:06 INFO - (blobuploader) - INFO - Done attempting. 11:32:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:32:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:32:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:32:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:32:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:32:09 INFO - (blobuploader) - INFO - Done attempting. 11:32:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:32:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:32:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:32:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:32:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:32:10 INFO - (blobuploader) - INFO - Done attempting. 11:32:10 INFO - (blobuploader) - INFO - Iteration through files over. 11:32:10 INFO - Return code: 0 11:32:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:32:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:32:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/853e17bc18549f62f995e09197d9644d7dfd243b393a49bcfd6caf20d3b93f2c0df18521d42267ce7bc69b4be29d8375519a30687166c888896d79cdfb9fc94e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c6bb9cf6c44d2776f8956fba1533d5effa17f2486338314c2a153cfeb2f66106e9bc9b150dacae7124c69945a7d1fc7f05295c012d4af794690e78880e65e6c6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/64c4c27169a5dcc9ab3ff2d98b91e476a4bc3da621c987b353df02468a79c7f17fb5a70146f511942321e36fbc851c9ecb20700465268f196e45c7e6459712f2"} 11:32:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:32:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:32:10 INFO - Contents: 11:32:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/853e17bc18549f62f995e09197d9644d7dfd243b393a49bcfd6caf20d3b93f2c0df18521d42267ce7bc69b4be29d8375519a30687166c888896d79cdfb9fc94e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c6bb9cf6c44d2776f8956fba1533d5effa17f2486338314c2a153cfeb2f66106e9bc9b150dacae7124c69945a7d1fc7f05295c012d4af794690e78880e65e6c6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/64c4c27169a5dcc9ab3ff2d98b91e476a4bc3da621c987b353df02468a79c7f17fb5a70146f511942321e36fbc851c9ecb20700465268f196e45c7e6459712f2"} 11:32:10 INFO - Running post-run listener: copy_logs_to_upload_dir 11:32:10 INFO - Copying logs to upload dir... 11:32:10 INFO - mkdir: /builds/slave/test/build/upload/logs 11:32:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.762614 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-29 11:32:09.610991) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 11:32:09.615077) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1467223893.905306-1755092311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/853e17bc18549f62f995e09197d9644d7dfd243b393a49bcfd6caf20d3b93f2c0df18521d42267ce7bc69b4be29d8375519a30687166c888896d79cdfb9fc94e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c6bb9cf6c44d2776f8956fba1533d5effa17f2486338314c2a153cfeb2f66106e9bc9b150dacae7124c69945a7d1fc7f05295c012d4af794690e78880e65e6c6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/64c4c27169a5dcc9ab3ff2d98b91e476a4bc3da621c987b353df02468a79c7f17fb5a70146f511942321e36fbc851c9ecb20700465268f196e45c7e6459712f2"} 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.011179 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/853e17bc18549f62f995e09197d9644d7dfd243b393a49bcfd6caf20d3b93f2c0df18521d42267ce7bc69b4be29d8375519a30687166c888896d79cdfb9fc94e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c6bb9cf6c44d2776f8956fba1533d5effa17f2486338314c2a153cfeb2f66106e9bc9b150dacae7124c69945a7d1fc7f05295c012d4af794690e78880e65e6c6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/64c4c27169a5dcc9ab3ff2d98b91e476a4bc3da621c987b353df02468a79c7f17fb5a70146f511942321e36fbc851c9ecb20700465268f196e45c7e6459712f2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 11:32:09.642052) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 11:32:09.642676) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1467223893.905306-1755092311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004434 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 11:32:09.725485) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 11:32:09.725888) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 11:32:09.726274) ========= ========= Total master_lag: 0.15 =========