builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-039 starttime: 1467730320.59 results: success (0) buildid: 20160701053013 builduid: c68b6e2fc3944ac3b7d2a07845c3598d revision: adfe23aae513a339ef042d5ff4255500e452114a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 07:52:00.586686) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 07:52:00.587192) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 07:52:00.587544) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 07:52:00.609978) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 07:52:00.610461) ========= 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=5bd038846534b2fdfa68eeae000001e2-1467730254.8185-1346645108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 07:52:00-- 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% 222M=0s 2016-07-05 07:52:01 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.073703 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 07:52:00.699047) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 07:52:00.699389) ========= 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=5bd038846534b2fdfa68eeae000001e2-1467730254.8185-1346645108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016777 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 07:52:00.749708) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 07:52:00.750068) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev adfe23aae513a339ef042d5ff4255500e452114a --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 adfe23aae513a339ef042d5ff4255500e452114a --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=5bd038846534b2fdfa68eeae000001e2-1467730254.8185-1346645108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 07:52:01,173 truncating revision to first 12 chars 2016-07-05 07:52:01,173 Setting DEBUG logging. 2016-07-05 07:52:01,173 attempt 1/10 2016-07-05 07:52:01,173 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/adfe23aae513?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 07:52:01,815 unpacking tar archive at: fx-team-adfe23aae513/testing/mozharness/ program finished with exit code 0 elapsedTime=0.983974 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 07:52:01.748519) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 07:52:01.748876) ========= script_repo_revision: adfe23aae513a339ef042d5ff4255500e452114a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 07:52:01.749359) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 07:52:01.749680) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 07:52:01.759386) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-07-05 07:52:01.760098) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5bd038846534b2fdfa68eeae000001e2-1467730254.8185-1346645108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:52:02 INFO - MultiFileLogger online at 20160705 07:52:02 in /builds/slave/test 07:52:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 07:52:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:52:02 INFO - {'append_to_log': False, 07:52:02 INFO - 'base_work_dir': '/builds/slave/test', 07:52:02 INFO - 'blob_upload_branch': 'Fx-Team', 07:52:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:52:02 INFO - 'branch': 'Fx-Team', 07:52:02 INFO - 'buildbot_json_path': 'buildprops.json', 07:52:02 INFO - 'config_files': ('talos/linux_config.py',), 07:52:02 INFO - 'default_actions': ('clobber', 07:52:02 INFO - 'read-buildbot-config', 07:52:02 INFO - 'download-and-extract', 07:52:02 INFO - 'populate-webroot', 07:52:02 INFO - 'create-virtualenv', 07:52:02 INFO - 'install', 07:52:02 INFO - 'run-tests'), 07:52:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:52:02 INFO - 'download_minidump_stackwalk': True, 07:52:02 INFO - 'download_symbols': 'ondemand', 07:52:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:52:02 INFO - 'tooltool.py': '/tools/tooltool.py', 07:52:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:52:02 INFO - '/tools/misc-python/virtualenv.py')}, 07:52:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:52:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:52:02 INFO - 'installer_path': 'installer.exe', 07:52:02 INFO - 'log_level': 'info', 07:52:02 INFO - 'log_name': 'talos', 07:52:02 INFO - 'log_to_console': True, 07:52:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:52:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:52:02 INFO - 'opt_config_files': (), 07:52:02 INFO - 'pip_index': False, 07:52:02 INFO - 'sps_profile': False, 07:52:02 INFO - 'sps_profile_interval': 0, 07:52:02 INFO - 'suite': 'dromaeojs-e10s', 07:52:02 INFO - 'system_bits': '32', 07:52:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:52:02 INFO - 'title': 'talos-linux64-ix-039', 07:52:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:52:02 INFO - 'use_talos_json': True, 07:52:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:52:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:52:02 INFO - 'work_dir': 'build'} 07:52:02 INFO - ##### 07:52:02 INFO - ##### Running clobber step. 07:52:02 INFO - ##### 07:52:02 INFO - Running pre-action listener: _resource_record_pre_action 07:52:02 INFO - Running main action method: clobber 07:52:02 INFO - rmtree: /builds/slave/test/build 07:52:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:52:02 INFO - Running post-action listener: _resource_record_post_action 07:52:02 INFO - ##### 07:52:02 INFO - ##### Finished clobber step (success) 07:52:02 INFO - ##### 07:52:02 INFO - ##### 07:52:02 INFO - ##### Running read-buildbot-config step. 07:52:02 INFO - ##### 07:52:02 INFO - Running pre-action listener: _resource_record_pre_action 07:52:02 INFO - Running main action method: read_buildbot_config 07:52:02 INFO - Using buildbot properties: 07:52:02 INFO - { 07:52:02 INFO - "project": "", 07:52:02 INFO - "product": "firefox", 07:52:02 INFO - "script_repo_revision": "production", 07:52:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 07:52:02 INFO - "repository": "", 07:52:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 07:52:02 INFO - "buildid": "20160701053013", 07:52:02 INFO - "pgo_build": "True", 07:52:02 INFO - "basedir": "/builds/slave/test", 07:52:02 INFO - "buildnumber": 536, 07:52:02 INFO - "slavename": "talos-linux64-ix-039", 07:52:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:52:02 INFO - "platform": "ubuntu64_hw", 07:52:02 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 07:52:02 INFO - "branch": "fx-team", 07:52:02 INFO - "repo_path": "integration/fx-team", 07:52:02 INFO - "revision": "adfe23aae513a339ef042d5ff4255500e452114a", 07:52:02 INFO - "stage_platform": "linux64-pgo", 07:52:02 INFO - "builduid": "c68b6e2fc3944ac3b7d2a07845c3598d", 07:52:02 INFO - "slavebuilddir": "test" 07:52:02 INFO - } 07:52:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:52:02 INFO - Running post-action listener: _resource_record_post_action 07:52:02 INFO - ##### 07:52:02 INFO - ##### Finished read-buildbot-config step (success) 07:52:02 INFO - ##### 07:52:02 INFO - ##### 07:52:02 INFO - ##### Running download-and-extract step. 07:52:02 INFO - ##### 07:52:02 INFO - Running pre-action listener: _resource_record_pre_action 07:52:02 INFO - Running main action method: download_and_extract 07:52:02 INFO - mkdir: /builds/slave/test/build/tests 07:52:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:02 INFO - https://queue.taskcluster.net/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:52:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:52:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:52:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnK2meMqRLSW-83BDvR3Qw/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 07:52:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnK2meMqRLSW-83BDvR3Qw/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 07:52:03 INFO - Downloaded 1361 bytes. 07:52:03 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:52:03 INFO - Using the following test package requirements: 07:52:03 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:52:03 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:52:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:52:03 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:52:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:52:03 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:52:03 INFO - u'jsshell-linux-x86_64.zip'], 07:52:03 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:52:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:52:03 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:52:03 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:52:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:52:03 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:52:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:52:03 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:52:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:52:03 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:52:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:52:03 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:52: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')]} 07:52:03 INFO - https://queue.taskcluster.net/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:52:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:52:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:52:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnK2meMqRLSW-83BDvR3Qw/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 07:52:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnK2meMqRLSW-83BDvR3Qw/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 07:52:05 INFO - Downloaded 24270733 bytes. 07:52:05 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'] 07:52:05 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 07:52:07 INFO - Return code: 0 07:52:07 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 07:52:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:07 INFO - https://queue.taskcluster.net/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:52:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:52:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:52:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnK2meMqRLSW-83BDvR3Qw/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 07:52:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnK2meMqRLSW-83BDvR3Qw/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 07:52:08 INFO - Downloaded 24270733 bytes. 07:52:08 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'] 07:52:08 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 07:52:10 INFO - Return code: 0 07:52: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')]} 07:52:10 INFO - https://queue.taskcluster.net/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:52:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:52:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:52:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnK2meMqRLSW-83BDvR3Qw/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 07:52:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnK2meMqRLSW-83BDvR3Qw/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 07:52:11 INFO - Downloaded 14405242 bytes. 07:52:11 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'] 07:52:11 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 07:52:11 INFO - Return code: 0 07:52:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:52:11 INFO - https://queue.taskcluster.net/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:52:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:52:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:52:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnK2meMqRLSW-83BDvR3Qw/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 07:52:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnK2meMqRLSW-83BDvR3Qw/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 07:52:15 INFO - Downloaded 60316904 bytes. 07:52:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:52:15 INFO - mkdir: /builds/slave/test/properties 07:52:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:52:15 INFO - Writing to file /builds/slave/test/properties/build_url 07:52:15 INFO - Contents: 07:52:15 INFO - build_url:https://queue.taskcluster.net/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:52:16 INFO - Running post-action listener: _resource_record_post_action 07:52:16 INFO - Running post-action listener: set_extra_try_arguments 07:52:16 INFO - ##### 07:52:16 INFO - ##### Finished download-and-extract step (success) 07:52:16 INFO - ##### 07:52:16 INFO - ##### 07:52:16 INFO - ##### Running populate-webroot step. 07:52:16 INFO - ##### 07:52:16 INFO - Running pre-action listener: _resource_record_pre_action 07:52:16 INFO - Running main action method: populate_webroot 07:52:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:52:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:52:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:52:16 INFO - '--tppagecycles', 07:52:16 INFO - '7'], 07:52:16 INFO - 'tests': ['tsvgm']}}, 07:52:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:52:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:52:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:52:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:52:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:52:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:52:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:16 INFO - 'talos_options': ['--disable-e10s'], 07:52:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:52:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:52:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:16 INFO - 'talos_options': ['--disable-e10s'], 07:52:16 INFO - 'tests': ['damp', 'tps']}, 07:52:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:16 INFO - 'tests': ['damp', 'tps']}, 07:52:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:52:16 INFO - 'tests': ['dromaeo_dom']}, 07:52:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:52:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:52:16 INFO - 'tests': ['basic_compositor_video']}, 07:52:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:52:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:52:16 INFO - 'tests': ['a11yr', 07:52:16 INFO - 'ts_paint', 07:52:16 INFO - 'tpaint', 07:52:16 INFO - 'sessionrestore', 07:52:16 INFO - 'sessionrestore_no_auto_restore', 07:52:16 INFO - 'tabpaint']}, 07:52:16 INFO - 'other-e10s': {'tests': ['a11yr', 07:52:16 INFO - 'ts_paint', 07:52:16 INFO - 'tpaint', 07:52:16 INFO - 'sessionrestore', 07:52:16 INFO - 'sessionrestore_no_auto_restore', 07:52:16 INFO - 'tabpaint']}, 07:52:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:52:16 INFO - 'ts_paint', 07:52:16 INFO - 'tpaint', 07:52:16 INFO - 'sessionrestore', 07:52:16 INFO - 'sessionrestore_no_auto_restore', 07:52:16 INFO - 'tabpaint']}, 07:52:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:52:16 INFO - 'ts_paint', 07:52:16 INFO - 'tpaint', 07:52:16 INFO - 'sessionrestore', 07:52:16 INFO - 'sessionrestore_no_auto_restore', 07:52:16 INFO - 'tabpaint']}, 07:52:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:52:16 INFO - 'tests': ['a11yr', 07:52:16 INFO - 'ts_paint', 07:52:16 INFO - 'tpaint', 07:52:16 INFO - 'sessionrestore', 07:52:16 INFO - 'sessionrestore_no_auto_restore', 07:52:16 INFO - 'tabpaint']}, 07:52:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:52:16 INFO - 'tests': ['a11yr', 07:52:16 INFO - 'ts_paint', 07:52:16 INFO - 'tpaint', 07:52:16 INFO - 'sessionrestore', 07:52:16 INFO - 'sessionrestore_no_auto_restore', 07:52:16 INFO - 'tabpaint']}, 07:52:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:52:16 INFO - 'tests': ['tsvgx', 07:52:16 INFO - 'tsvgr_opacity', 07:52:16 INFO - 'tart', 07:52:16 INFO - 'tscrollx', 07:52:16 INFO - 'cart']}, 07:52:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:52:16 INFO - 'tsvgr_opacity', 07:52:16 INFO - 'tart', 07:52:16 INFO - 'tscrollx', 07:52:16 INFO - 'cart']}, 07:52:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:16 INFO - 'talos_options': ['--disable-e10s'], 07:52:16 INFO - 'tests': ['tp5o']}, 07:52:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:16 INFO - 'tests': ['tp5o']}, 07:52:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:16 INFO - 'talos_options': ['--disable-e10s', 07:52:16 INFO - '--xperf_path', 07:52:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:52:16 INFO - 'tests': ['tp5n']}, 07:52:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:16 INFO - 'talos_options': ['--xperf_path', 07:52:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:52:16 INFO - 'tests': ['tp5n']}}, 07:52:16 INFO - 'talos.zip': {'path': '', 07:52:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:52:16 INFO - Running post-action listener: _resource_record_post_action 07:52:16 INFO - ##### 07:52:16 INFO - ##### Finished populate-webroot step (success) 07:52:16 INFO - ##### 07:52:16 INFO - ##### 07:52:16 INFO - ##### Running create-virtualenv step. 07:52:16 INFO - ##### 07:52:16 INFO - Running pre-action listener: _resource_record_pre_action 07:52:16 INFO - Running main action method: create_virtualenv 07:52:16 INFO - Creating virtualenv /builds/slave/test/build/venv 07:52:16 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 07:52:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:52:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:52:16 INFO - Using real prefix '/usr' 07:52:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:52:16 INFO - Installing distribute.............................................................................................................................................................................................done. 07:52:18 INFO - Installing pip.................done. 07:52:18 INFO - Return code: 0 07:52:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:52:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:52:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1293180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12913b0>, '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 0x12922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1292740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467730254.8185-1346645108', '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 07:52:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:52:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:52:18 INFO - Using env: {'DISPLAY': ':0', 07:52:18 INFO - 'HOME': '/home/cltbld', 07:52:18 INFO - 'LANG': 'en_US.UTF-8', 07:52:18 INFO - 'LANGUAGE': 'en_US:en', 07:52:18 INFO - 'LOGNAME': 'cltbld', 07:52:18 INFO - 'MAIL': '/var/mail/cltbld', 07:52:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:18 INFO - 'MOZ_NO_REMOTE': '1', 07:52:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:18 INFO - 'NO_EM_RESTART': '1', 07:52:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:18 INFO - 'PWD': '/builds/slave/test', 07:52:18 INFO - 'SHELL': '/bin/bash', 07:52:18 INFO - 'SHLVL': '1', 07:52:18 INFO - 'TERM': 'linux', 07:52:18 INFO - 'TMOUT': '86400', 07:52:18 INFO - 'USER': 'cltbld', 07:52:18 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467730254.8185-1346645108', 07:52:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:18 INFO - '_': '/tools/buildbot/bin/python'} 07:52:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:19 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 07:52:19 INFO - Cleaning up... 07:52:19 INFO - Return code: 0 07:52:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:52:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:52:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xfd2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1293180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12913b0>, '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 0x12922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1292740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467730254.8185-1346645108', '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 07:52:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:52:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:52:19 INFO - Using env: {'DISPLAY': ':0', 07:52:19 INFO - 'HOME': '/home/cltbld', 07:52:19 INFO - 'LANG': 'en_US.UTF-8', 07:52:19 INFO - 'LANGUAGE': 'en_US:en', 07:52:19 INFO - 'LOGNAME': 'cltbld', 07:52:19 INFO - 'MAIL': '/var/mail/cltbld', 07:52:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:19 INFO - 'MOZ_NO_REMOTE': '1', 07:52:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:19 INFO - 'NO_EM_RESTART': '1', 07:52:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:19 INFO - 'PWD': '/builds/slave/test', 07:52:19 INFO - 'SHELL': '/bin/bash', 07:52:19 INFO - 'SHLVL': '1', 07:52:19 INFO - 'TERM': 'linux', 07:52:19 INFO - 'TMOUT': '86400', 07:52:19 INFO - 'USER': 'cltbld', 07:52:19 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467730254.8185-1346645108', 07:52:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:19 INFO - '_': '/tools/buildbot/bin/python'} 07:52:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:19 INFO - Downloading/unpacking psutil>=3.1.1 07:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:52:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:52:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:52:21 INFO - Installing collected packages: psutil 07:52:21 INFO - Running setup.py install for psutil 07:52:21 INFO - building 'psutil._psutil_linux' extension 07:52:21 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 07:52:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:52:21 INFO - building 'psutil._psutil_posix' extension 07:52:21 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 07:52:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:52:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:52:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:52:21 INFO - Successfully installed psutil 07:52:21 INFO - Cleaning up... 07:52:21 INFO - Return code: 0 07:52:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:52:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:52:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1293180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12913b0>, '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 0x12922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1292740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467730254.8185-1346645108', '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 07:52:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:52:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:52:21 INFO - Using env: {'DISPLAY': ':0', 07:52:21 INFO - 'HOME': '/home/cltbld', 07:52:21 INFO - 'LANG': 'en_US.UTF-8', 07:52:21 INFO - 'LANGUAGE': 'en_US:en', 07:52:21 INFO - 'LOGNAME': 'cltbld', 07:52:21 INFO - 'MAIL': '/var/mail/cltbld', 07:52:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:21 INFO - 'MOZ_NO_REMOTE': '1', 07:52:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:21 INFO - 'NO_EM_RESTART': '1', 07:52:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:21 INFO - 'PWD': '/builds/slave/test', 07:52:21 INFO - 'SHELL': '/bin/bash', 07:52:21 INFO - 'SHLVL': '1', 07:52:21 INFO - 'TERM': 'linux', 07:52:21 INFO - 'TMOUT': '86400', 07:52:21 INFO - 'USER': 'cltbld', 07:52:21 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467730254.8185-1346645108', 07:52:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:21 INFO - '_': '/tools/buildbot/bin/python'} 07:52:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:52:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:52:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:52:24 INFO - Installing collected packages: mozsystemmonitor 07:52:24 INFO - Running setup.py install for mozsystemmonitor 07:52:24 INFO - Successfully installed mozsystemmonitor 07:52:24 INFO - Cleaning up... 07:52:24 INFO - Return code: 0 07:52:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:52:24 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')]} 07:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:24 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')]} 07:52:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:24 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 0xfd2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1293180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12913b0>, '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 0x12922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1292740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467730254.8185-1346645108', '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 07:52:24 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 07:52:24 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 07:52:24 INFO - Using env: {'DISPLAY': ':0', 07:52:24 INFO - 'HOME': '/home/cltbld', 07:52:24 INFO - 'LANG': 'en_US.UTF-8', 07:52:24 INFO - 'LANGUAGE': 'en_US:en', 07:52:24 INFO - 'LOGNAME': 'cltbld', 07:52:24 INFO - 'MAIL': '/var/mail/cltbld', 07:52:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:24 INFO - 'MOZ_NO_REMOTE': '1', 07:52:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:24 INFO - 'NO_EM_RESTART': '1', 07:52:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:24 INFO - 'PWD': '/builds/slave/test', 07:52:24 INFO - 'SHELL': '/bin/bash', 07:52:24 INFO - 'SHLVL': '1', 07:52:24 INFO - 'TERM': 'linux', 07:52:24 INFO - 'TMOUT': '86400', 07:52:24 INFO - 'USER': 'cltbld', 07:52:24 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467730254.8185-1346645108', 07:52:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:24 INFO - '_': '/tools/buildbot/bin/python'} 07:52:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:24 INFO - Downloading/unpacking jsonschema==2.5.1 07:52:24 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 07:52:24 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 07:52:24 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 07:52:24 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 07:52:24 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 07:52:24 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 07:52:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:52:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:26 INFO - Downloading functools32-3.2.3-2.tar.gz 07:52:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:52:26 INFO - warning: no files found matching '*.txt' 07:52:26 INFO - no previously-included directories found matching 'build' 07:52:26 INFO - no previously-included directories found matching 'dist' 07:52:26 INFO - no previously-included directories found matching '.git*' 07:52:26 INFO - Installing collected packages: jsonschema, functools32 07:52:26 INFO - Running setup.py install for functools32 07:52:26 INFO - warning: no files found matching '*.txt' 07:52:26 INFO - no previously-included directories found matching 'build' 07:52:26 INFO - no previously-included directories found matching 'dist' 07:52:26 INFO - no previously-included directories found matching '.git*' 07:52:26 INFO - Successfully installed jsonschema functools32 07:52:26 INFO - Cleaning up... 07:52:26 INFO - Return code: 0 07:52:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:52:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1293180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12913b0>, '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 0x12922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1292740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467730254.8185-1346645108', '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 07:52:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:52:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:52:26 INFO - Using env: {'DISPLAY': ':0', 07:52:26 INFO - 'HOME': '/home/cltbld', 07:52:26 INFO - 'LANG': 'en_US.UTF-8', 07:52:26 INFO - 'LANGUAGE': 'en_US:en', 07:52:26 INFO - 'LOGNAME': 'cltbld', 07:52:26 INFO - 'MAIL': '/var/mail/cltbld', 07:52:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:26 INFO - 'MOZ_NO_REMOTE': '1', 07:52:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:26 INFO - 'NO_EM_RESTART': '1', 07:52:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:26 INFO - 'PWD': '/builds/slave/test', 07:52:26 INFO - 'SHELL': '/bin/bash', 07:52:26 INFO - 'SHLVL': '1', 07:52:26 INFO - 'TERM': 'linux', 07:52:26 INFO - 'TMOUT': '86400', 07:52:26 INFO - 'USER': 'cltbld', 07:52:26 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467730254.8185-1346645108', 07:52:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:26 INFO - '_': '/tools/buildbot/bin/python'} 07:52:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:26 INFO - Downloading/unpacking blobuploader==1.2.4 07:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:28 INFO - Downloading blobuploader-1.2.4.tar.gz 07:52:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:52:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:52:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:52:29 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 07:52:29 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 07:52:29 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 07:52:29 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 07:52:29 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 07:52:29 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 07:52:29 INFO - Downloading docopt-0.6.1.tar.gz 07:52:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:52:29 INFO - Installing collected packages: blobuploader, requests, docopt 07:52:29 INFO - Running setup.py install for blobuploader 07:52:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:52:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:52:29 INFO - Running setup.py install for requests 07:52:30 INFO - Running setup.py install for docopt 07:52:30 INFO - Successfully installed blobuploader requests docopt 07:52:30 INFO - Cleaning up... 07:52:30 INFO - Return code: 0 07:52:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:52:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:52:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:30 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 0xfd2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1293180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12913b0>, '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 0x12922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1292740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467730254.8185-1346645108', '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 07:52:30 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 07:52:30 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 07:52:30 INFO - Using env: {'DISPLAY': ':0', 07:52:30 INFO - 'HOME': '/home/cltbld', 07:52:30 INFO - 'LANG': 'en_US.UTF-8', 07:52:30 INFO - 'LANGUAGE': 'en_US:en', 07:52:30 INFO - 'LOGNAME': 'cltbld', 07:52:30 INFO - 'MAIL': '/var/mail/cltbld', 07:52:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:30 INFO - 'MOZ_NO_REMOTE': '1', 07:52:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:30 INFO - 'NO_EM_RESTART': '1', 07:52:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:30 INFO - 'PWD': '/builds/slave/test', 07:52:30 INFO - 'SHELL': '/bin/bash', 07:52:30 INFO - 'SHLVL': '1', 07:52:30 INFO - 'TERM': 'linux', 07:52:30 INFO - 'TMOUT': '86400', 07:52:30 INFO - 'USER': 'cltbld', 07:52:30 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467730254.8185-1346645108', 07:52:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:30 INFO - '_': '/tools/buildbot/bin/python'} 07:52:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:52:30 INFO - Running setup.py (path:/tmp/pip-fjbD67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:52:30 INFO - Running setup.py (path:/tmp/pip-zwac68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:52:30 INFO - Running setup.py (path:/tmp/pip-5wqrYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:52:30 INFO - Running setup.py (path:/tmp/pip-D9k8dK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:52:30 INFO - Running setup.py (path:/tmp/pip-3Wto3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:52:30 INFO - Running setup.py (path:/tmp/pip-NcMn4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:52:30 INFO - Running setup.py (path:/tmp/pip-b4HZfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:52:30 INFO - Running setup.py (path:/tmp/pip-TukInl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:52:31 INFO - Running setup.py (path:/tmp/pip-lOCCpd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:52:31 INFO - Running setup.py (path:/tmp/pip-3LAtfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:52:31 INFO - Running setup.py (path:/tmp/pip-2MsH_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:52:31 INFO - Running setup.py (path:/tmp/pip-nKsGGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:52:31 INFO - Running setup.py (path:/tmp/pip-dELDbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:52:31 INFO - Running setup.py (path:/tmp/pip-GSUBNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:52:31 INFO - Running setup.py (path:/tmp/pip-qQgm2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:52:31 INFO - Running setup.py (path:/tmp/pip-oFJ8M6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:52:31 INFO - Running setup.py (path:/tmp/pip-SzybyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:52:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:52:31 INFO - Running setup.py install for manifestparser 07:52:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:52:31 INFO - Running setup.py install for mozcrash 07:52:31 INFO - Running setup.py install for mozdebug 07:52:32 INFO - Running setup.py install for mozdevice 07:52:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:52:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:52:32 INFO - Running setup.py install for mozfile 07:52:32 INFO - Running setup.py install for mozhttpd 07:52:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:52:32 INFO - Running setup.py install for mozinfo 07:52:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:52:32 INFO - Running setup.py install for mozInstall 07:52:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:52:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:52:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:52:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:52:32 INFO - Running setup.py install for mozleak 07:52:32 INFO - Running setup.py install for mozlog 07:52:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:52:32 INFO - Running setup.py install for moznetwork 07:52:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:52:32 INFO - Running setup.py install for mozprocess 07:52:32 INFO - Running setup.py install for mozprofile 07:52:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:52:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:52:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:52:33 INFO - Running setup.py install for mozrunner 07:52:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:52:33 INFO - Running setup.py install for mozscreenshot 07:52:33 INFO - Running setup.py install for moztest 07:52:33 INFO - Running setup.py install for mozversion 07:52:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:52:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:52:33 INFO - Cleaning up... 07:52:33 INFO - Return code: 0 07:52:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:52:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:52:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1293180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12913b0>, '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 0x12922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1292740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467730254.8185-1346645108', '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 07:52:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:52:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:52:33 INFO - Using env: {'DISPLAY': ':0', 07:52:33 INFO - 'HOME': '/home/cltbld', 07:52:33 INFO - 'LANG': 'en_US.UTF-8', 07:52:33 INFO - 'LANGUAGE': 'en_US:en', 07:52:33 INFO - 'LOGNAME': 'cltbld', 07:52:33 INFO - 'MAIL': '/var/mail/cltbld', 07:52:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:33 INFO - 'MOZ_NO_REMOTE': '1', 07:52:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:33 INFO - 'NO_EM_RESTART': '1', 07:52:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:33 INFO - 'PWD': '/builds/slave/test', 07:52:33 INFO - 'SHELL': '/bin/bash', 07:52:33 INFO - 'SHLVL': '1', 07:52:33 INFO - 'TERM': 'linux', 07:52:33 INFO - 'TMOUT': '86400', 07:52:33 INFO - 'USER': 'cltbld', 07:52:33 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467730254.8185-1346645108', 07:52:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:33 INFO - '_': '/tools/buildbot/bin/python'} 07:52:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:52:33 INFO - Running setup.py (path:/tmp/pip-50GbpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:52:33 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:52:33 INFO - Running setup.py (path:/tmp/pip-fj9Ghg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:52:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:52:33 INFO - Running setup.py (path:/tmp/pip-RSROWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:52:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:52:33 INFO - Running setup.py (path:/tmp/pip-4Fbi1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:52:34 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)) 07:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:52:34 INFO - Running setup.py (path:/tmp/pip-oNzi_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:52:34 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)) 07:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:52:34 INFO - Running setup.py (path:/tmp/pip-bHTiWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:52:34 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)) 07:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:52:34 INFO - Running setup.py (path:/tmp/pip-O2pFym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:52:34 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)) 07:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:52:34 INFO - Running setup.py (path:/tmp/pip-dLPuF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:52:34 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)) 07:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:52:34 INFO - Running setup.py (path:/tmp/pip-WBrF0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:52:34 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)) 07:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:52:34 INFO - Running setup.py (path:/tmp/pip-fb_YfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:52:34 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)) 07:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:52:34 INFO - Running setup.py (path:/tmp/pip-cbDKzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:52:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:52:34 INFO - Running setup.py (path:/tmp/pip-e44Rcq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:52:34 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)) 07:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:52:34 INFO - Running setup.py (path:/tmp/pip-PC8KYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:52:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:52:34 INFO - Running setup.py (path:/tmp/pip-wg1ch3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:52:34 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)) 07:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:52:34 INFO - Running setup.py (path:/tmp/pip-ZeVPeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:52:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:52:34 INFO - Running setup.py (path:/tmp/pip-cIt0JE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:52:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:52:34 INFO - Running setup.py (path:/tmp/pip-Ff1jMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:52:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:52:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:52:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:52:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:52:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:52:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:52:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:37 INFO - Downloading blessings-1.6.tar.gz 07:52:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:52:37 INFO - Installing collected packages: blessings 07:52:37 INFO - Running setup.py install for blessings 07:52:37 INFO - Successfully installed blessings 07:52:37 INFO - Cleaning up... 07:52:37 INFO - Return code: 0 07:52:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:52:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:52:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:52:37 INFO - Reading from file tmpfile_stdout 07:52:37 INFO - Current package versions: 07:52:37 INFO - argparse == 1.2.1 07:52:37 INFO - blessings == 1.6 07:52:37 INFO - blobuploader == 1.2.4 07:52:37 INFO - docopt == 0.6.1 07:52:37 INFO - functools32 == 3.2.3-2 07:52:37 INFO - jsonschema == 2.5.1 07:52:37 INFO - manifestparser == 1.1 07:52:37 INFO - mozInstall == 1.12 07:52:37 INFO - mozcrash == 0.17 07:52:37 INFO - mozdebug == 0.1 07:52:37 INFO - mozdevice == 0.48 07:52:37 INFO - mozfile == 1.2 07:52:37 INFO - mozhttpd == 0.7 07:52:37 INFO - mozinfo == 0.9 07:52:37 INFO - mozleak == 0.1 07:52:37 INFO - mozlog == 3.2 07:52:37 INFO - moznetwork == 0.27 07:52:37 INFO - mozprocess == 0.22 07:52:37 INFO - mozprofile == 0.28 07:52:37 INFO - mozrunner == 6.11 07:52:37 INFO - mozscreenshot == 0.1 07:52:37 INFO - mozsystemmonitor == 0.3 07:52:37 INFO - moztest == 0.7 07:52:37 INFO - mozversion == 1.4 07:52:37 INFO - psutil == 3.1.1 07:52:37 INFO - requests == 1.2.3 07:52:37 INFO - wsgiref == 0.1.2 07:52:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:52: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')]} 07:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52: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')]} 07:52:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:37 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 0xfd2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1293180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12913b0>, '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 0x12922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1292740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467730254.8185-1346645108', '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 07:52:37 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 07:52:37 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 07:52:37 INFO - Using env: {'DISPLAY': ':0', 07:52:37 INFO - 'HOME': '/home/cltbld', 07:52:37 INFO - 'LANG': 'en_US.UTF-8', 07:52:37 INFO - 'LANGUAGE': 'en_US:en', 07:52:37 INFO - 'LOGNAME': 'cltbld', 07:52:37 INFO - 'MAIL': '/var/mail/cltbld', 07:52:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:37 INFO - 'MOZ_NO_REMOTE': '1', 07:52:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:37 INFO - 'NO_EM_RESTART': '1', 07:52:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:37 INFO - 'PWD': '/builds/slave/test', 07:52:37 INFO - 'SHELL': '/bin/bash', 07:52:37 INFO - 'SHLVL': '1', 07:52:37 INFO - 'TERM': 'linux', 07:52:37 INFO - 'TMOUT': '86400', 07:52:37 INFO - 'USER': 'cltbld', 07:52:37 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467730254.8185-1346645108', 07:52:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:37 INFO - '_': '/tools/buildbot/bin/python'} 07:52:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:52:37 INFO - Cleaning up... 07:52:37 INFO - Return code: 0 07:52:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:52: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')]} 07:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52: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')]} 07:52:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1293180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12913b0>, '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 0x12922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1292740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467730254.8185-1346645108', '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 07:52:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:52:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:52:37 INFO - Using env: {'DISPLAY': ':0', 07:52:37 INFO - 'HOME': '/home/cltbld', 07:52:37 INFO - 'LANG': 'en_US.UTF-8', 07:52:37 INFO - 'LANGUAGE': 'en_US:en', 07:52:37 INFO - 'LOGNAME': 'cltbld', 07:52:37 INFO - 'MAIL': '/var/mail/cltbld', 07:52:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:37 INFO - 'MOZ_NO_REMOTE': '1', 07:52:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:37 INFO - 'NO_EM_RESTART': '1', 07:52:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:37 INFO - 'PWD': '/builds/slave/test', 07:52:37 INFO - 'SHELL': '/bin/bash', 07:52:37 INFO - 'SHLVL': '1', 07:52:37 INFO - 'TERM': 'linux', 07:52:37 INFO - 'TMOUT': '86400', 07:52:37 INFO - 'USER': 'cltbld', 07:52:37 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467730254.8185-1346645108', 07:52:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:37 INFO - '_': '/tools/buildbot/bin/python'} 07:52:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:52:37 INFO - Cleaning up... 07:52:37 INFO - Return code: 0 07:52:37 INFO - Running post-action listener: _resource_record_post_action 07:52:37 INFO - Running post-action listener: _start_resource_monitoring 07:52:38 INFO - Starting resource monitoring. 07:52:38 INFO - ##### 07:52:38 INFO - ##### Finished create-virtualenv step (success) 07:52:38 INFO - ##### 07:52:38 INFO - ##### 07:52:38 INFO - ##### Running install step. 07:52:38 INFO - ##### 07:52:38 INFO - Running pre-action listener: _resource_record_pre_action 07:52:38 INFO - Running main action method: install 07:52:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:52:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:52:38 INFO - Reading from file tmpfile_stdout 07:52:38 INFO - Detecting whether we're running mozinstall >=1.0... 07:52:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:52:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:52:38 INFO - Reading from file tmpfile_stdout 07:52:38 INFO - Output received: 07:52:38 INFO - Usage: mozinstall [options] installer 07:52:38 INFO - Options: 07:52:38 INFO - -h, --help show this help message and exit 07:52:38 INFO - -d DEST, --destination=DEST 07:52:38 INFO - Directory to install application into. [default: 07:52:38 INFO - "/builds/slave/test"] 07:52:38 INFO - --app=APP Application being installed. [default: firefox] 07:52:38 INFO - mkdir: /builds/slave/test/build/application 07:52:38 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'] 07:52:38 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 07:52:55 INFO - Reading from file tmpfile_stdout 07:52:55 INFO - Output received: 07:52:55 INFO - /builds/slave/test/build/application/firefox/firefox 07:52:55 INFO - Running post-action listener: _resource_record_post_action 07:52:55 INFO - ##### 07:52:55 INFO - ##### Finished install step (success) 07:52:55 INFO - ##### 07:52:55 INFO - ##### 07:52:55 INFO - ##### Running run-tests step. 07:52:55 INFO - ##### 07:52:55 INFO - Running pre-action listener: _resource_record_pre_action 07:52:55 INFO - Running main action method: run_tests 07:52:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:52:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:52:55 INFO - Python 2.7.3 07:52:55 INFO - Return code: 0 07:52:55 INFO - grabbing minidump binary from tooltool 07:52:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:55 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12913b0>, '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 0x12922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1292740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:52:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:52:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:52:55 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:52:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:52:55 INFO - Return code: 0 07:52:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:52:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:52:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:52:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:52:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:52:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:52:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:52:55 INFO - Using env: {'DISPLAY': ':0', 07:52:55 INFO - 'HOME': '/home/cltbld', 07:52:55 INFO - 'LANG': 'en_US.UTF-8', 07:52:55 INFO - 'LANGUAGE': 'en_US:en', 07:52:55 INFO - 'LOGNAME': 'cltbld', 07:52:55 INFO - 'MAIL': '/var/mail/cltbld', 07:52:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:52:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:52:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:55 INFO - 'MOZ_NO_REMOTE': '1', 07:52:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:52:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:55 INFO - 'NO_EM_RESTART': '1', 07:52:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:55 INFO - 'PWD': '/builds/slave/test', 07:52:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:52:55 INFO - 'SHELL': '/bin/bash', 07:52:55 INFO - 'SHLVL': '1', 07:52:55 INFO - 'TERM': 'linux', 07:52:55 INFO - 'TMOUT': '86400', 07:52:55 INFO - 'USER': 'cltbld', 07:52:55 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467730254.8185-1346645108', 07:52:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:55 INFO - '_': '/tools/buildbot/bin/python'} 07:52:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:52:55 INFO - mozversion application_buildid: 20160701053013 07:52:55 INFO - mozversion application_changeset: adfe23aae513a339ef042d5ff4255500e452114a 07:52:55 INFO - mozversion application_display_name: Nightly 07:52:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:52:55 INFO - mozversion application_name: Firefox 07:52:55 INFO - mozversion application_remotingname: firefox 07:52:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:52:55 INFO - mozversion application_vendor: Mozilla 07:52:55 INFO - mozversion application_version: 50.0a1 07:52:55 INFO - mozversion platform_buildid: 20160701053013 07:52:55 INFO - mozversion platform_changeset: adfe23aae513a339ef042d5ff4255500e452114a 07:52:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:52:55 INFO - mozversion platform_version: 50.0a1 07:52:55 INFO - using testdate: 1467730375 07:52:55 INFO - actual date: 1467730375 07:52:55 INFO - starting webserver on 'localhost:36080' 07:52:55 INFO - SUITE-START | Running 2 tests 07:52:55 INFO - TEST-START | dromaeo_css 07:52:55 INFO - operating with platform_type : linux_ 07:52:55 INFO - Initialising browser for dromaeo_css test... 07:52:55 INFO - TEST-INFO | started process 27628 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu7W0E8/profile http://localhost:36080/getInfo.html) 07:53:00 INFO - PROCESS | 27628 | __metrics Screen width/height:1600/1200 07:53:00 INFO - PROCESS | 27628 | colorDepth:24 07:53:00 INFO - PROCESS | 27628 | Browser inner width/height: 1024/697 07:53:00 INFO - PROCESS | 27628 | __metrics 07:53:01 ERROR - PROCESS | 27628 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 07:53:02 INFO - TEST-INFO | 27628: exit 0 07:53:02 INFO - Browser initialized. 07:53:02 INFO - Running cycle 1/1 for dromaeo_css test... 07:53:02 INFO - TEST-INFO | started process 27748 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu7W0E8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:53:13 INFO - PROCESS | 27748 | RSS: Main: 168296448 07:53:13 INFO - PROCESS | 27748 | 07:54:03 INFO - PROCESS | 27748 | 1467730443537 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] 07:56:12 INFO - PROCESS | 27748 | Cycle 1(1): loaded http://localhost:36080/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36080/tests/dromaeo/cssquery-ext.html) 07:56:13 INFO - PROCESS | 27748 | RSS: Main: 172691456 07:56:13 INFO - PROCESS | 27748 | 07:59:15 INFO - PROCESS | 27748 | Cycle 1(1): loaded http://localhost:36080/tests/dromaeo/cssquery-ext.html (next: http://localhost:36080/tests/dromaeo/cssquery-jquery.html) 07:59:15 INFO - PROCESS | 27748 | RSS: Main: 169168896 07:59:15 INFO - PROCESS | 27748 | 08:02:17 INFO - PROCESS | 27748 | Cycle 1(1): loaded http://localhost:36080/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36080/tests/dromaeo/cssquery-mootools.html) 08:02:18 INFO - PROCESS | 27748 | RSS: Main: 172953600 08:02:18 INFO - PROCESS | 27748 | 08:05:19 INFO - PROCESS | 27748 | Cycle 1(1): loaded http://localhost:36080/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36080/tests/dromaeo/cssquery-prototype.html) 08:05:20 INFO - PROCESS | 27748 | RSS: Main: 168370176 08:05:20 INFO - PROCESS | 27748 | 08:08:22 INFO - PROCESS | 27748 | Cycle 1(1): loaded http://localhost:36080/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36080/tests/dromaeo/cssquery-yui.html) 08:08:23 INFO - PROCESS | 27748 | RSS: Main: 170037248 08:08:23 INFO - PROCESS | 27748 | 08:11:25 INFO - PROCESS | 27748 | Cycle 1(1): loaded http://localhost:36080/tests/dromaeo/cssquery-yui.html (next: http://localhost:36080/tests/dromaeo/cssquery-dojo.html) 08:11:26 INFO - PROCESS | 27748 | RSS: Main: 171094016 08:11:26 INFO - PROCESS | 27748 | 08:11:26 INFO - PROCESS | 27748 | __start_tp_report 08:11:26 INFO - PROCESS | 27748 | _x_x_mozilla_page_load 08:11:26 INFO - PROCESS | 27748 | _x_x_mozilla_page_load_details 08:11:26 INFO - PROCESS | 27748 | |i|pagename|runs| 08:11:26 INFO - PROCESS | 27748 | |0;dojo.html;3179.984100079499;3201.5837941067657;3219.533167690686;3244.399786039583;3263.184203949013;5559.833205003852;5584.9720751396235;5586.776528938843;5654.830355089354;5659.915101273474;5494.2857428534335;5529.281193444846;5538.363088244853;5599.888002239963;5627.43725627437;4960.975195124038;4993.775280112403;5098.694078355311;5149.382074151088;5208.062548741225;790.3481140893543;5089;5096.617753668471;5125.026245013454;5183.714895680736;5022.573081288095;5032.572231360339;5042.546170844624;5063.797448102072;5087.440381558025;4936.4076310842565;5028.547430731252;5053.74731263439;5077.64456488046;5078.46676099008;4951.678140920829;4977.203647416432;4980.77586508608;4990.800367985276;5046.7224302663335;5467.097928841737;5468.671879687232;5474.589405794542;5489.066858634042;5500.202470641774;5775.624584402042;5853.151293062525;5865.648061116347;5889.941100588982;5911.940880591182;5957.731902064417;5966.940330596725;6026.939730602681;6038.849028774272;6045.12345709874;5569.66582005081;5586.273784408001;5594.2447769551;5601.467860553282;5613.4386561343945;5966.373530779206;6105.389461053859;6107.450329470369;6128.3258841527395;6139.47814435769;5887.293524776968;5950.375210602824;5968.253968253968;5970.373110823388;6015.127806468037;5974.3428222895445;6016.308124565643;6029.969850150809;6037.818865434044;6045;5806.216160818235;5839.708014599253;5856.4143585641095;6020.548458865603;6026.367231440723;5790.739416726173;5883.61756485827;5910.822675319747;5934.643921364645;5960.284765828128;4495.370648109268;4500.977495112504;4516.8193272268745;4536.3422303765765;4539.614132798683;3905.6875449963936;4014.0767623446773;4027.81874815634;4033.415154802537;4038.1519880825354;5728.455796699307;5746;5758.395368486249;5762.078067509178;5871.2073870027;6056.697165141725;6067.7269522871575;6122.020476723703;6122.142899994004;6130.693465326716;5610.382857885629;5653.773849046074;5656.208130861683;5770.365259821417;5826.563007774434;5134.383873935151;5140.074786538385;5151.124308867502;5151.793928242903;5181.948180518222;6148;6195.039768835838;6238.469730072904;6258.749650013949;6270.843228919222;5796.62321949072;5942.821715348374;5954.612950158225;6005.819825405332;6007.669578173242;6134.426636849298;6156.261248650011;6171.56799024064;6178.62928224308;6223.844403889939;5861.6189947653265;5899.056151015817;5907.113932910098;5916.674582897982;5954.940450595439;5753.223314852608;5982.042873140276;6003.729832157651;6040.063790112539;6093;5867.20792692981;5910.320313164041;5916.911246331395;5923.229980102559;5928.407159284209;5725.570582206268;5883.646981181143;5885.646861188342;5897.764089436375;5898.793542226002;5557.805476808292;5706.800261990977;5710.314762228559;5729.140628905531;5770.913436298543;5709.715314054304;5749.367569567261;5848;5853.414658534283;5911.408859114226;5683.573731970201;5773.942260577341;5778.219940308173;5801.477866991991;5803.738831752666 08:11:26 INFO - PROCESS | 27748 | |1;ext.html;585.3853453873435;619.2352444730758;621.4903778901303;632.433971595422;648.0506058624114;42912.35631465527;44165.558344416546;44183.999999999956;44475.55524444755;48038.279425808556;46735;46763.76618116913;47017;47117.05765884689;47268;8992.280617550612;9219.677311294106;9220.631174753002;9232.584533696;9240.630374785;9114.45313281202;9194.816103677922;9200.953995230015;9224.953875230614;9227.53862306882;9265.768355791091;9291.907080929172;9310.53447327631;9314.161725444708;9319.114684105032;9129;9158.084191580821;9177.403468774508;9183.954080229556;9211.940626827933;9127.954360228223;9144.359894807367;9157;9171.082891710843;9185;43771.34342984826;44171.337429938576;44225;44240.77879610581;44275.11449770987;3675.98569173278;3703.925921481582;3791.6587507124214;3831.7126215533667;4241.172971270604;33318.50022249668;34017.6598234017;34044.65955340464;34102.82948585266;34130.82934585311;4420.955790442086;4456.398386217884;4542.568455996675;4563.885902852422;4598.678092533524;373892;377341;379085;379347;380355;36670.266594668494;61785.38214617886;62545;62558.68720656368;62628.37371626226;37885.43171852425;39499.40750888739;39935.40096898549;39967.2006559873;40001;15355;15439.536813895376;15463.149526776135;15601.219939003231;15641.687166256612;12617.810732839014;12693.301868397326;12722.491100356066;12728.10903236783;12736;8975.730728078168;9057.139571740674;9061.77345566353;9084.909150908406;9132.178103970675;3427.1260828489076;3443.5867695876655;3477.8696923499965;3491.6508349165388;3541.3625547401716;985.103555764251;1033.751899544104;1051.8444666001994;1114.4149321606221;1154.3016475032484;33819.15452113717;33905;34303.31393372118;34312.31375372478;34529.309413811585;1105.8175401058895;1147.363213416545;1147.7474955509774;1202.1344631865043;1242.577523641966;17716.91141544284;17778.46664600064;17806.37677681275;17851.37520186787;18077.27690892376;579033;580204;588597;588914;591189;62301.68849155725;62950.68524657348;63034.684826575576;63062;63109.68445157837;1348.6426097084282;1352.2157148853642;1356.5658989123583;1363.195714528433;1389.5136702154368;31907.521387179677;32022.359552808346;34150.487742684374;34946.82526587351;35993;60310.698446507486;60590;60893.69553152206;60994.08508872459;61293.080603790084;492228;496623;496666;497744;498104;46045;46534.975226610164;47326;47688.52311476841;47721.5227847731;51929;52220;53573.73213133909;53584;53671.463285368205;42542.36186457144;43613.345799813666;47170.76414618042;47426.76286618683;47955.760221198674;43653;44357.556424435345;44516.777416114004;44772;45750.08499830051;42526;42903.570964291204;42989.35515967326;43998.560014400726;44111.11777764491;38838.80580597079;38958.80520597379;39320.60679393169;39811.60188398195;39904.800475997436;29593;29696.406071878875;29832;29993.4001319968;30246.395072098876 08:11:26 INFO - PROCESS | 27748 | |2;jquery.html;406.89827543114205;414.9564295748948;415.55535576932687;421.7237709300408;434.10357611532186;18820.247190112397;20479.385618431454;20803.479913002164;20811.063502142402;21403.03686334115;19824.107915143817;20207.191712331525;20248.59502809943;20273.898630506865;20344.796552034477;5758.971205143968;5957.31490878548;5959.493443057324;6005.759769609211;6018.458338749533;4189.539150693421;5807.041838096709;5903.645781253117;6555.213374395079;6624.304448032959;6680.298568650294;6686.866262674768;6688.732450701966;6707.195136583617;6739.123913891187;6456.774012909549;6627.237867645186;6667.633135207295;6668.333166683317;6671.699773510204;5647.124695672136;5866.6480011199465;5881.558883083786;5925.940740592625;5929.822105336847;25542.233732987854;25591.488170236677;25625.871870640713;25758.871205644038;26024.609630855553;2371.205646108556;2447.9143229987044;2568.0883286433236;2576.7552082552315;3118.8596513156963;14922;15948.2823272953;16120;16169.595760105974;16513.422030229005;1936.5933154037668;1942.9125689344014;1995.920163193485;2041.8570700051002;2127.765945745982;86821;87459.56270218671;87558;88417.55791221067;89211.55394223052;11210.495527701272;11227.428160057598;11457.88542114585;11682.415879206006;11695.239809412362;16129.11289879068;16159.838401616069;16211.837881621268;16254.43109491162;16307.347706091623;8031.237032481905;8096.230858068474;8154.062282837431;8200.917990820015;8263.256306932404;7458.291462311072;7589.772306830804;7599.392048636096;7723.266289702469;7752.689892404241;6854.485913556503;6909.792706218822;6979.93020069803;7038.612876291751;7085.2206257311655;1701.2344444999799;1762.5064981805115;1801.7027190513681;1819.2631984046482;2023.625629258592;912.1744820937063;943.5093751249449;954.465499320369;960.8318544254868;1044.7753732947301;18213.36253231157;20467.032285281723;20589.691154632692;20600.690989635168;20865.47836304074;1043.4678314059884;1053.731298518888;1055.720234137954;1056.906102184251;1074.1084899533369;11097.667069987914;11347.432628368548;11521;11558.711032224093;11599.536018559163;458005;461564;464911;471817;474325;92284;95589;95689;98403.50798246106;99040;999.5851721535481;1024.2471783239314;1026.9794604107876;1047.2093569355088;1061.7982583309147;18838.587579062485;18840.152193151065;18932.621347573247;18980.620387591895;19054.523636909187;45732;45974;46611.30083048689;46695.76652116718;46852.531474684816;63168;64565;65141.34858651353;65165.67417163074;65332.673336633015;8183.181681831769;8195.098539160806;8491.8726219108;8502;9041.95479022627;10010.099091081838;13399.12905661129;13752.31238438054;13821.79267310971;13910.51313204033;12438.813417798921;12516.186447880858;12993.025523085616;12995;13032.152910060815;12538.811917821058;12802.583641918201;12851.16467429614;12922.676933076747;12981.935090324489;12327.876721232673;13076.934615327244;13121.409536570687;13209.405576749261;13557.25435101079;8769.079246679006;8852.159044890725;8956.28349732033;9071.727848164566;9282.62869485213;9007.05425930294;12804.679883003;12820.61538153857;12830.16603920742;12887.226766394046 08:11:26 INFO - PROCESS | 27748 | |3;mootools.html;1453.38231251718;1483.3102607287612;1591.8328575499572;1787.982120178798;1789.838914497695;8077.19228077192;8782.780430489242;8830.779230519223;9307.953460232706;9380.57787399567;8865.46807191569;9097.408668436547;9205.447673139617;9209.171174594285;9227.261819054476;2396.4967356855036;2410.1323523531514;2423.7333893271725;2427.9150229741963;2435.208557218902;2410.819188560865;2432.975670243293;2474.34429876083;2479.9752002479927;2483.900643974239;2443.6701045358914;2462.4705688277018;2470.0984140788664;2489.3900994256433;2499.3501689560753;2409.180878501318;2433.4403087289934;2445.7921076708503;2448.5347783920997;2451.240115564181;2353.9529209415887;2366.3847399676038;2366.6923299970895;2372.240882917467;2428.6114221724615;9367.391119577205;9368.156865882036;9391.107844754737;9458.57436415363;9474.336796424253;5352.143657014859;5414.35027796667;5447.237386765856;5488.25908502355;5490.313710786152;3534.3461459629793;3564.41187204111;3603.3333833240936;3624.2207925295925;3633.872814451508;1227.9017678585692;1252.8684488128797;1259.7732408166526;1273.4587800184977;1299.9285039322833;13085.86914130856;13205.33973301331;13207.537736179187;13222.338883055809;13245.07284490086;4825.879353016203;4842.6368022398465;4951.3810773653295;4964.726940018334;4983.07813054586;11077.778444431066;11117.610883619034;11133.832992505118;11143.164262680331;11169.106471482262;5609.1305847593685;5630.915536266959;5632.239647647597;5632.605717599728;5635.182898479779;4333.674974376871;4916.262560615936;5081.568066714371;5090.541851233407;5195.064888320138;4157.854475093418;4229.767362795076;4280.571942805695;4303.07483890965;4331.371951067078;1349.0758830201344;1353.3571553512004;1358.986410135886;1376.1880490510646;1381.5233744358181;907.138218692245;972.5672075926286;981.2346369831542;992.265723364705;999.835027220515;6042.39576042401;6045.455908968214;6084.939150608438;6107.6640784757265;6149.41580549847;443.32835753832967;444.64650602770877;449.00769299847053;1031.9484025798681;1052.5105825791045;4060.4924384451942;4120.896977575525;4133.627973482401;4136.462259906253;4151.045259590311;11416;11515.942420288013;11618.128640352008;11678.88321116795;11683.065354771597;11636.418179091012;11649.41752912351;11664.70838229034;11676.24104433226;11699.181057325906;8281.171882811792;8288.50268983863;8349.624266908004;8373.288270496954;8421.24208821209;5836.678982655994;5945.851353716019;5957.582969192115;5961.582689211714;6123.479504242189;10253.897461025592;10898.509567069343;10972.780544389227;11053.115750740082;11122.277051991594;11183.384913829492;11213.607523736957;11236.101111911192;11304.547818087512;11451.942740286246;7222.494425390172;7947.125816160334;8214.58927053633;8233.135520770473;8342;8955.910440895768;8968.05835387275;8977.910220897707;8987.865182022144;8996.460212387277;7957.721479748181;7992.160823113722;8052.677892884219;8121.431499794958;8276.83446331082;7933.9603301983125;8068.233517815798;8104.959475202586;8162.755117346489;8208.302294305051;6565.409113179837;6743.865122697617;6803.523753337219;6822.147231596051;6877.3810357068105;5300.01949639318;5320.334958130234;5379.946200538101;5383.273258110105;5394.541463975606;5187.325647665779;5211.0359583477175;5302.9469705304;5319.175527793198;5321.388040375252 08:11:26 INFO - PROCESS | 27748 | |4;prototype.html;322.2636276109091;323.56965236235794;332.4365200984331;343.3733436478427;348.71405447533016;5544.833654990347;5549.223108764766;5693.886122277552;5748.942510574893;5781.450762177592;5558.388577256509;5567.137093750465;5609.411011843748;5654.575906806986;5658.349289831671;4365.650747940165;4366.166210191727;4380.518143004267;4390.363397307388;4426.804762714065;4217.34631132175;4360.887973566736;4417.86746397607;4423.86728398147;4429.247028005231;4364.519902810688;4366.279563871957;4386.2324093283705;4393.319035549495;4396.648268138557;4405.185040767468;4407.228734971367;4408.14041261954;4424.9557504424865;4436.622887054604;3787.9242415151816;3847.2497862916744;3880.1075752577067;3884.2814079395403;3895.5325360956867;5445.863853403696;5488.231647569343;5500.3949565547755;5535.806246781343;5560.77756889724;5011.924821127686;5015.22264049073;5019.698818070928;5028.547430731252;5058.418281897592;5659.207710920475;5933.317668468138;5945.116618440053;5988.550858685572;5999.820005399845;4214.662826973866;4252.87241382759;4253.553376895444;4274.529801721808;4275.183047204925;6168.599041062362;6182.721777519977;6197.1324014637985;6245.843853903689;6267.843303917393;4197.853075142355;4327.112941846914;4352.934705979413;4367.737935723867;4376.431063961664;4387.8244870204835;4393.6704747144095;4403.823847046082;4423.18171138334;4429.424174857312;5005.3242812220615;5039.521245481674;5050.292958985745;5061.063703214917;5085.466026067284;5820.3888591698105;5874.588778785529;5955.52355811534;6004.669743164168;6051.546134039964;1506.246876561719;1518.6507103366287;1521.9847801522064;1522.4671365022155;1527.7861099446086;955.603424578806;963.7349728824489;966.8984756600456;977.3305285879053;981.5926390547985;5099.923501147486;5104.5707201983505;5139.665921715076;5169.172932330809;5189.247559103909;5314.538501912005;5368.785248590091;5401.730593310569;5425.674459532441;5453.7818487260065;4966.90066198674;5068.265101560327;5077.26379674945;5120.564751996122;5144.511271429208;2828.6888442271334;2859.1129854296064;2881.5389537673873;2911.388608392219;2931.6775154732964;5569;5627.71861406928;5636.788090560467;5648.971755141198;5665.830025099253;5342.813001544927;5423.945760542344;5452.963936851986;5493.725313734298;5512.145617429305;5479.082321187632;5546.861328466821;5555.2778138841695;5560.304961879846;5563.525665698593;5258.579313654822;5322.22827689975;5375.467991622525;5434.782608695607;5435.918461223006;5290.709011004432;5310.734463276898;5312.760925758427;5349.0625405798755;5364.785408583613;5511;5516.531094856982;5590.189422533791;5608.8878222434505;5650.0959846424375;3812.9237415252096;3886.6985157289478;3888.9027774304736;3994.7603143811466;3997.480327557399;5354.7858085676135;5406.107992181246;5425.620206585501;5886.646801191942;5982.521398288213;5912.438318359749;5915.556333274935;5920.6974465617495;5940.376260492759;5944.524438045032;5851.180834683233;5883.352831188651;5905.704714764331;5918.7928422505;5931.495822855106;5597.984725498899;5749.626274292157;5807.709614519342;5808.273965754281;5818.24362832846;5909.91135132982;5938.435848594377;5946.405359464019;5966.552508561788;5973.850653733518;5582.855514619575;5742.655440673573;5789.247397838254;5807.854803629774;5827.6794776286015 08:11:26 INFO - PROCESS | 27748 | |5;yui.html;753.7927070055731;771.4175797273058;774.4927072767339;823.7240524424318;845.028217549818;14909.925450372746;15961.920190399062;16141.838581614194;16170.514884553453;16769.66460670786;15081.547553573382;15162;15276.847231527681;15278.465253716122;15282.465113721022;667.1127400557259;778.98831517527;796.474326944217;797.7008621766837;803.5058439059994;802.6668932393079;807.7738233294687;811.6063709101081;811.8295158016823;812.3054788156101;855.9315254779602;859.0893652728097;859.5745106172453;859.7893516088567;860.1398601398602;843.8734189871507;848.6308455821737;850.9787255318605;851.3742399336483;851.6295411496019;616.8889599872022;616.9321374648785;617.4257940115691;622.7384498510636;623.392192612204;15297.235138243042;15352.692946141015;15370.692586148214;15400.152991585459;15433.459828905934;12693.555725549562;13667.589972300846;13867.306634668226;14610.70778584433;16085.115318657468;13750.518731844337;13899.652508687364;14033.719325613532;14040.1575905446;14121.78817317741;4629.537046295377;4641.303804429329;4651;4659.813607455698;4748.216544270192;69862;86337;86364.56817715871;86554;86904.56547717284;11526.711832204095;11547.422628868691;12041.578544750892;12309.93845030787;12319.260844349368;23837;24059.157929472734;24112.156074537306;24133.51732965331;24160;9165.404248723811;9174;9303.95348023269;9378.577963991636;9466.148046675833;4839.8287277484915;4918.434380046269;5028.823991160292;5152.278680984665;5154.664946778447;3522.383582872987;3599.8380072896784;3621.058524783575;3627;3651.5253017107607;639.7984634840103;645.0936434309803;664.8038828545591;672.9158855143107;673.8416472129046;621.4996927473337;659.5515049766109;675.9324067593201;677.4918810891832;678.8642271545611;9399.624015039459;9932.65235716761;9944;9947;10068.338724110587;722.5989575785385;752.2139364364143;768.4966347042696;783.9451238413257;790.1900551934314;4806.831760888352;4908.705477671351;5094;5250.921236181461;5394.649347792381;123892;126951;127382;128023.35988320185;129424;102833;105032.47483762685;107724.46137769418;109716.451417744;110105.44947275212;58049.4195058044;80309;92959;94108.52945735364;94411.52794235985;10086;10353.378797271887;10442;10644.680659580225;10701.19741019411;56941.43058569361;57729.422705772406;57994.7100264496;58082.12876806767;58662.70668646629;67151.66424168044;68636.6568167156;69956.65021675063;74373.25626743663;83549;13630.522931697344;13749.312534373441;13832.861671383158;13946.860531394963;14367.13797172173;15204;15364.692706146037;15482.225888705745;15762.133082680562;16361;15057;15097.47158849435;15376.538703838904;15652;15829.129397883227;13693.863061369259;14053.159110511684;14316.427342906167;14465.421383144556;15800.446984355493;14776.852231477978;15044.774328384865;15189.696206075596;15344.616384590474;15565.621683036727;12175.208611440228;12435.12984002437;12471.93764031174;12679.746405071663;12721.363931803558;10995.725106872393;11166.553337866395;11342.773144536897;11565.190436669352;12310.81533777012 08:11:26 INFO - PROCESS | 27748 | __end_tp_report 08:11:26 INFO - PROCESS | 27748 | __start_cc_report 08:11:26 INFO - PROCESS | 27748 | _x_x_mozilla_cycle_collect,353 08:11:26 INFO - PROCESS | 27748 | __end_cc_report 08:11:26 INFO - PROCESS | 27748 | __startTimestamp1467731486053__endTimestamp 08:11:26 INFO - PROCESS | 27748 | 08:11:26 INFO - PROCESS | 27748 | ------- Summary: start ------- 08:11:26 INFO - PROCESS | 27748 | Number of tests: 6 08:11:26 INFO - PROCESS | 27748 | 08:11:26 INFO - PROCESS | 27748 | [#0] dojo.html Cycles:165 Average:5519.09 Median:5773.94 stddev:743.00 (12.9%) stddev-sans-first:722.27 08:11:26 INFO - PROCESS | 27748 | Values: 3180.0 3201.6 3219.5 3244.4 3263.2 5559.8 5585.0 5586.8 5654.8 5659.9 5494.3 5529.3 5538.4 5599.9 5627.4 4961.0 4993.8 5098.7 5149.4 5208.1 790.3 5089.0 5096.6 5125.0 5183.7 5022.6 5032.6 5042.5 5063.8 5087.4 4936.4 5028.5 5053.7 5077.6 5078.5 4951.7 4977.2 4980.8 4990.8 5046.7 5467.1 5468.7 5474.6 5489.1 5500.2 5775.6 5853.2 5865.6 5889.9 5911.9 5957.7 5966.9 6026.9 6038.8 6045.1 5569.7 5586.3 5594.2 5601.5 5613.4 5966.4 6105.4 6107.5 6128.3 6139.5 5887.3 5950.4 5968.3 5970.4 6015.1 5974.3 6016.3 6030.0 6037.8 6045.0 5806.2 5839.7 5856.4 6020.5 6026.4 5790.7 5883.6 5910.8 5934.6 5960.3 4495.4 4501.0 4516.8 4536.3 4539.6 3905.7 4014.1 4027.8 4033.4 4038.2 5728.5 5746.0 5758.4 5762.1 5871.2 6056.7 6067.7 6122.0 6122.1 6130.7 5610.4 5653.8 5656.2 5770.4 5826.6 5134.4 5140.1 5151.1 5151.8 5181.9 6148.0 6195.0 6238.5 6258.7 6270.8 5796.6 5942.8 5954.6 6005.8 6007.7 6134.4 6156.3 6171.6 6178.6 6223.8 5861.6 5899.1 5907.1 5916.7 5954.9 5753.2 5982.0 6003.7 6040.1 6093.0 5867.2 5910.3 5916.9 5923.2 5928.4 5725.6 5883.6 5885.6 5897.8 5898.8 5557.8 5706.8 5710.3 5729.1 5770.9 5709.7 5749.4 5848.0 5853.4 5911.4 5683.6 5773.9 5778.2 5801.5 5803.7 08:11:26 INFO - PROCESS | 27748 | 08:11:26 INFO - PROCESS | 27748 | [#1] ext.html Cycles:180 Average:64949.14 Median:44257.95 stddev:131300.51 (296.7%) stddev-sans-first:131579.92 08:11:26 INFO - PROCESS | 27748 | Values: 585.4 619.2 621.5 632.4 648.1 42912.4 44165.6 44184.0 44475.6 48038.3 46735.0 46763.8 47017.0 47117.1 47268.0 8992.3 9219.7 9220.6 9232.6 9240.6 9114.5 9194.8 9201.0 9225.0 9227.5 9265.8 9291.9 9310.5 9314.2 9319.1 9129.0 9158.1 9177.4 9184.0 9211.9 9128.0 9144.4 9157.0 9171.1 9185.0 43771.3 44171.3 44225.0 44240.8 44275.1 3676.0 3703.9 3791.7 3831.7 4241.2 33318.5 34017.7 34044.7 34102.8 34130.8 4421.0 4456.4 4542.6 4563.9 4598.7 373892.0 377341.0 379085.0 379347.0 380355.0 36670.3 61785.4 62545.0 62558.7 62628.4 37885.4 39499.4 39935.4 39967.2 40001.0 15355.0 15439.5 15463.1 15601.2 15641.7 12617.8 12693.3 12722.5 12728.1 12736.0 8975.7 9057.1 9061.8 9084.9 9132.2 3427.1 3443.6 3477.9 3491.7 3541.4 985.1 1033.8 1051.8 1114.4 1154.3 33819.2 33905.0 34303.3 34312.3 34529.3 1105.8 1147.4 1147.7 1202.1 1242.6 17716.9 17778.5 17806.4 17851.4 18077.3 579033.0 580204.0 588597.0 588914.0 591189.0 62301.7 62950.7 63034.7 63062.0 63109.7 1348.6 1352.2 1356.6 1363.2 1389.5 31907.5 32022.4 34150.5 34946.8 35993.0 60310.7 60590.0 60893.7 60994.1 61293.1 492228.0 496623.0 496666.0 497744.0 498104.0 46045.0 46535.0 47326.0 47688.5 47721.5 51929.0 52220.0 53573.7 53584.0 53671.5 42542.4 43613.3 47170.8 47426.8 47955.8 43653.0 44357.6 44516.8 44772.0 45750.1 42526.0 42903.6 42989.4 43998.6 44111.1 38838.8 38958.8 39320.6 39811.6 39904.8 29593.0 29696.4 29832.0 29993.4 30246.4 08:11:26 INFO - PROCESS | 27748 | 08:11:26 INFO - PROCESS | 27748 | [#2] jquery.html Cycles:180 Average:29625.08 Median:14167.81 stddev:77210.54 (545.0%) stddev-sans-first:77395.97 08:11:26 INFO - PROCESS | 27748 | Values: 406.9 415.0 415.6 421.7 434.1 18820.2 20479.4 20803.5 20811.1 21403.0 19824.1 20207.2 20248.6 20273.9 20344.8 5759.0 5957.3 5959.5 6005.8 6018.5 4189.5 5807.0 5903.6 6555.2 6624.3 6680.3 6686.9 6688.7 6707.2 6739.1 6456.8 6627.2 6667.6 6668.3 6671.7 5647.1 5866.6 5881.6 5925.9 5929.8 25542.2 25591.5 25625.9 25758.9 26024.6 2371.2 2447.9 2568.1 2576.8 3118.9 14922.0 15948.3 16120.0 16169.6 16513.4 1936.6 1942.9 1995.9 2041.9 2127.8 86821.0 87459.6 87558.0 88417.6 89211.6 11210.5 11227.4 11457.9 11682.4 11695.2 16129.1 16159.8 16211.8 16254.4 16307.3 8031.2 8096.2 8154.1 8200.9 8263.3 7458.3 7589.8 7599.4 7723.3 7752.7 6854.5 6909.8 6979.9 7038.6 7085.2 1701.2 1762.5 1801.7 1819.3 2023.6 912.2 943.5 954.5 960.8 1044.8 18213.4 20467.0 20589.7 20600.7 20865.5 1043.5 1053.7 1055.7 1056.9 1074.1 11097.7 11347.4 11521.0 11558.7 11599.5 458005.0 461564.0 464911.0 471817.0 474325.0 92284.0 95589.0 95689.0 98403.5 99040.0 999.6 1024.2 1027.0 1047.2 1061.8 18838.6 18840.2 18932.6 18980.6 19054.5 45732.0 45974.0 46611.3 46695.8 46852.5 63168.0 64565.0 65141.3 65165.7 65332.7 8183.2 8195.1 8491.9 8502.0 9042.0 10010.1 13399.1 13752.3 13821.8 13910.5 12438.8 12516.2 12993.0 12995.0 13032.2 12538.8 12802.6 12851.2 12922.7 12981.9 12327.9 13076.9 13121.4 13209.4 13557.3 8769.1 8852.2 8956.3 9071.7 9282.6 9007.1 12804.7 12820.6 12830.2 12887.2 08:11:26 INFO - PROCESS | 27748 | 08:11:26 INFO - PROCESS | 27748 | [#3] mootools.html Cycles:180 Average:6082.88 Median:2637.44 stddev:3533.56 (134.0%) stddev-sans-first:3526.34 08:11:26 INFO - PROCESS | 27748 | Values: 1453.4 1483.3 1591.8 1788.0 1789.8 8077.2 8782.8 8830.8 9308.0 9380.6 8865.5 9097.4 9205.4 9209.2 9227.3 2396.5 2410.1 2423.7 2427.9 2435.2 2410.8 2433.0 2474.3 2480.0 2483.9 2443.7 2462.5 2470.1 2489.4 2499.4 2409.2 2433.4 2445.8 2448.5 2451.2 2354.0 2366.4 2366.7 2372.2 2428.6 9367.4 9368.2 9391.1 9458.6 9474.3 5352.1 5414.4 5447.2 5488.3 5490.3 3534.3 3564.4 3603.3 3624.2 3633.9 1227.9 1252.9 1259.8 1273.5 1299.9 13085.9 13205.3 13207.5 13222.3 13245.1 4825.9 4842.6 4951.4 4964.7 4983.1 11077.8 11117.6 11133.8 11143.2 11169.1 5609.1 5630.9 5632.2 5632.6 5635.2 4333.7 4916.3 5081.6 5090.5 5195.1 4157.9 4229.8 4280.6 4303.1 4331.4 1349.1 1353.4 1359.0 1376.2 1381.5 907.1 972.6 981.2 992.3 999.8 6042.4 6045.5 6084.9 6107.7 6149.4 443.3 444.6 449.0 1031.9 1052.5 4060.5 4120.9 4133.6 4136.5 4151.0 11416.0 11515.9 11618.1 11678.9 11683.1 11636.4 11649.4 11664.7 11676.2 11699.2 8281.2 8288.5 8349.6 8373.3 8421.2 5836.7 5945.9 5957.6 5961.6 6123.5 10253.9 10898.5 10972.8 11053.1 11122.3 11183.4 11213.6 11236.1 11304.5 11451.9 7222.5 7947.1 8214.6 8233.1 8342.0 8955.9 8968.1 8977.9 8987.9 8996.5 7957.7 7992.2 8052.7 8121.4 8276.8 7934.0 8068.2 8105.0 8162.8 8208.3 6565.4 6743.9 6803.5 6822.1 6877.4 5300.0 5320.3 5379.9 5383.3 5394.5 5187.3 5211.0 5302.9 5319.2 5321.4 08:11:26 INFO - PROCESS | 27748 | 08:11:26 INFO - PROCESS | 27748 | [#4] prototype.html Cycles:180 Average:4786.50 Median:5372.13 stddev:1382.62 (25.7%) stddev-sans-first:1345.29 08:11:26 INFO - PROCESS | 27748 | Values: 322.3 323.6 332.4 343.4 348.7 5544.8 5549.2 5693.9 5748.9 5781.5 5558.4 5567.1 5609.4 5654.6 5658.3 4365.7 4366.2 4380.5 4390.4 4426.8 4217.3 4360.9 4417.9 4423.9 4429.2 4364.5 4366.3 4386.2 4393.3 4396.6 4405.2 4407.2 4408.1 4425.0 4436.6 3787.9 3847.2 3880.1 3884.3 3895.5 5445.9 5488.2 5500.4 5535.8 5560.8 5011.9 5015.2 5019.7 5028.5 5058.4 5659.2 5933.3 5945.1 5988.6 5999.8 4214.7 4252.9 4253.6 4274.5 4275.2 6168.6 6182.7 6197.1 6245.8 6267.8 4197.9 4327.1 4352.9 4367.7 4376.4 4387.8 4393.7 4403.8 4423.2 4429.4 5005.3 5039.5 5050.3 5061.1 5085.5 5820.4 5874.6 5955.5 6004.7 6051.5 1506.2 1518.7 1522.0 1522.5 1527.8 955.6 963.7 966.9 977.3 981.6 5099.9 5104.6 5139.7 5169.2 5189.2 5314.5 5368.8 5401.7 5425.7 5453.8 4966.9 5068.3 5077.3 5120.6 5144.5 2828.7 2859.1 2881.5 2911.4 2931.7 5569.0 5627.7 5636.8 5649.0 5665.8 5342.8 5423.9 5453.0 5493.7 5512.1 5479.1 5546.9 5555.3 5560.3 5563.5 5258.6 5322.2 5375.5 5434.8 5435.9 5290.7 5310.7 5312.8 5349.1 5364.8 5511.0 5516.5 5590.2 5608.9 5650.1 3812.9 3886.7 3888.9 3994.8 3997.5 5354.8 5406.1 5425.6 5886.6 5982.5 5912.4 5915.6 5920.7 5940.4 5944.5 5851.2 5883.4 5905.7 5918.8 5931.5 5598.0 5749.6 5807.7 5808.3 5818.2 5909.9 5938.4 5946.4 5966.6 5973.9 5582.9 5742.7 5789.2 5807.9 5827.7 08:11:26 INFO - PROCESS | 27748 | 08:11:26 INFO - PROCESS | 27748 | [#5] yui.html Cycles:180 Average:22113.27 Median:4140.53 stddev:31955.68 (771.8%) stddev-sans-first:32005.07 08:11:26 INFO - PROCESS | 27748 | Values: 753.8 771.4 774.5 823.7 845.0 14909.9 15961.9 16141.8 16170.5 16769.7 15081.5 15162.0 15276.8 15278.5 15282.5 667.1 779.0 796.5 797.7 803.5 802.7 807.8 811.6 811.8 812.3 855.9 859.1 859.6 859.8 860.1 843.9 848.6 851.0 851.4 851.6 616.9 616.9 617.4 622.7 623.4 15297.2 15352.7 15370.7 15400.2 15433.5 12693.6 13667.6 13867.3 14610.7 16085.1 13750.5 13899.7 14033.7 14040.2 14121.8 4629.5 4641.3 4651.0 4659.8 4748.2 69862.0 86337.0 86364.6 86554.0 86904.6 11526.7 11547.4 12041.6 12309.9 12319.3 23837.0 24059.2 24112.2 24133.5 24160.0 9165.4 9174.0 9304.0 9378.6 9466.1 4839.8 4918.4 5028.8 5152.3 5154.7 3522.4 3599.8 3621.1 3627.0 3651.5 639.8 645.1 664.8 672.9 673.8 621.5 659.6 675.9 677.5 678.9 9399.6 9932.7 9944.0 9947.0 10068.3 722.6 752.2 768.5 783.9 790.2 4806.8 4908.7 5094.0 5250.9 5394.6 123892.0 126951.0 127382.0 128023.4 129424.0 102833.0 105032.5 107724.5 109716.5 110105.4 58049.4 80309.0 92959.0 94108.5 94411.5 10086.0 10353.4 10442.0 10644.7 10701.2 56941.4 57729.4 57994.7 58082.1 58662.7 67151.7 68636.7 69956.7 74373.3 83549.0 13630.5 13749.3 13832.9 13946.9 14367.1 15204.0 15364.7 15482.2 15762.1 16361.0 15057.0 15097.5 15376.5 15652.0 15829.1 13693.9 14053.2 14316.4 14465.4 15800.4 14776.9 15044.8 15189.7 15344.6 15565.6 12175.2 12435.1 12471.9 12679.7 12721.4 10995.7 11166.6 11342.8 11565.2 12310.8 08:11:26 INFO - PROCESS | 27748 | -------- Summary: end -------- 08:11:26 INFO - PROCESS | 27748 | 08:11:26 INFO - TEST-INFO | 27748: exit 0 08:11:26 INFO - TEST-OK | dromaeo_css | took 1111076ms 08:11:26 INFO - TEST-START | kraken 08:11:26 INFO - operating with platform_type : linux_ 08:11:26 INFO - Initialising browser for kraken test... 08:11:26 INFO - TEST-INFO | started process 27989 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp7TEXM/profile http://localhost:36080/getInfo.html) 08:11:31 INFO - PROCESS | 27989 | __metrics Screen width/height:1600/1200 08:11:31 INFO - PROCESS | 27989 | colorDepth:24 08:11:31 INFO - PROCESS | 27989 | Browser inner width/height: 1024/697 08:11:31 INFO - PROCESS | 27989 | __metrics 08:11:32 ERROR - PROCESS | 27989 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 08:11:32 INFO - TEST-INFO | 27989: exit 0 08:11:32 INFO - Browser initialized. 08:11:32 INFO - Running cycle 1/1 for kraken test... 08:11:32 INFO - TEST-INFO | started process 28111 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp7TEXM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:11:44 INFO - PROCESS | 28111 | RSS: Main: 168542208 08:11:44 INFO - PROCESS | 28111 | 08:11:47 INFO - PROCESS | 28111 | Cycle 1(1): loaded http://localhost:36080/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36080/tests/kraken/driver.html?testName=audio-beat-detection) 08:11:48 INFO - PROCESS | 28111 | RSS: Main: 173563904 08:11:48 INFO - PROCESS | 28111 | 08:11:50 INFO - PROCESS | 28111 | Cycle 1(1): loaded http://localhost:36080/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36080/tests/kraken/driver.html?testName=audio-dft) 08:11:51 INFO - PROCESS | 28111 | RSS: Main: 173211648 08:11:51 INFO - PROCESS | 28111 | 08:11:54 INFO - PROCESS | 28111 | Cycle 1(1): loaded http://localhost:36080/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36080/tests/kraken/driver.html?testName=audio-fft) 08:11:54 INFO - PROCESS | 28111 | RSS: Main: 168075264 08:11:54 INFO - PROCESS | 28111 | 08:11:56 INFO - PROCESS | 28111 | Cycle 1(1): loaded http://localhost:36080/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36080/tests/kraken/driver.html?testName=audio-oscillator) 08:11:57 INFO - PROCESS | 28111 | RSS: Main: 168591360 08:11:57 INFO - PROCESS | 28111 | 08:11:59 INFO - PROCESS | 28111 | Cycle 1(1): loaded http://localhost:36080/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36080/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:12:00 INFO - PROCESS | 28111 | RSS: Main: 169250816 08:12:00 INFO - PROCESS | 28111 | 08:12:03 INFO - PROCESS | 28111 | Cycle 1(1): loaded http://localhost:36080/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36080/tests/kraken/driver.html?testName=imaging-darkroom) 08:12:04 INFO - PROCESS | 28111 | RSS: Main: 168996864 08:12:04 INFO - PROCESS | 28111 | 08:12:07 INFO - PROCESS | 28111 | Cycle 1(1): loaded http://localhost:36080/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36080/tests/kraken/driver.html?testName=imaging-desaturate) 08:12:08 INFO - PROCESS | 28111 | RSS: Main: 166567936 08:12:08 INFO - PROCESS | 28111 | 08:12:11 INFO - PROCESS | 28111 | Cycle 1(1): loaded http://localhost:36080/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36080/tests/kraken/driver.html?testName=json-parse-financial) 08:12:11 INFO - PROCESS | 28111 | RSS: Main: 167804928 08:12:11 INFO - PROCESS | 28111 | 08:12:13 INFO - PROCESS | 28111 | Cycle 1(1): loaded http://localhost:36080/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36080/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:12:13 INFO - PROCESS | 28111 | RSS: Main: 168189952 08:12:13 INFO - PROCESS | 28111 | 08:12:15 INFO - PROCESS | 28111 | Cycle 1(1): loaded http://localhost:36080/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36080/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:12:16 INFO - PROCESS | 28111 | RSS: Main: 168415232 08:12:16 INFO - PROCESS | 28111 | 08:12:18 INFO - PROCESS | 28111 | Cycle 1(1): loaded http://localhost:36080/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36080/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:12:18 INFO - PROCESS | 28111 | RSS: Main: 168845312 08:12:18 INFO - PROCESS | 28111 | 08:12:21 INFO - PROCESS | 28111 | Cycle 1(1): loaded http://localhost:36080/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36080/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:12:22 INFO - PROCESS | 28111 | RSS: Main: 169390080 08:12:22 INFO - PROCESS | 28111 | 08:12:24 INFO - PROCESS | 28111 | Cycle 1(1): loaded http://localhost:36080/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36080/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:12:25 INFO - PROCESS | 28111 | RSS: Main: 169095168 08:12:25 INFO - PROCESS | 28111 | 08:12:27 INFO - PROCESS | 28111 | Cycle 1(1): loaded http://localhost:36080/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36080/tests/kraken/driver.html?testName=ai-astar) 08:12:27 INFO - PROCESS | 28111 | RSS: Main: 170119168 08:12:27 INFO - PROCESS | 28111 | 08:12:27 INFO - PROCESS | 28111 | __start_tp_report 08:12:27 INFO - PROCESS | 28111 | _x_x_mozilla_page_load 08:12:27 INFO - PROCESS | 28111 | _x_x_mozilla_page_load_details 08:12:27 INFO - PROCESS | 28111 | |i|pagename|runs| 08:12:27 INFO - PROCESS | 28111 | |0;ai-astar;102;110;105;111;112;110;111;110;110;111 08:12:27 INFO - PROCESS | 28111 | |1;audio-beat-detection;144;121;151;165;119;144;150;118;170;121 08:12:27 INFO - PROCESS | 28111 | |2;audio-dft;162;162;165;164;162;164;177;163;161;163 08:12:27 INFO - PROCESS | 28111 | |3;audio-fft;74;76;75;158;76;76;75;75;165;76 08:12:27 INFO - PROCESS | 28111 | |4;audio-oscillator;84;83;140;84;85;95;137;85;84;145 08:12:27 INFO - PROCESS | 28111 | |5;imaging-gaussian-blur;119;118;119;118;119;117;117;117;118;117 08:12:27 INFO - PROCESS | 28111 | |6;imaging-darkroom;155;147;146;147;150;147;146;148;147;148 08:12:27 INFO - PROCESS | 28111 | |7;imaging-desaturate;95;95;97;95;96;96;96;97;96;95 08:12:27 INFO - PROCESS | 28111 | |8;json-parse-financial;55;53;58;54;55;53;53;58;54;56 08:12:27 INFO - PROCESS | 28111 | |9;json-stringify-tinderbox;62;61;61;62;62;61;63;61;62;61 08:12:27 INFO - PROCESS | 28111 | |10;stanford-crypto-aes;76;79;75;76;76;75;84;77;82;75 08:12:27 INFO - PROCESS | 28111 | |11;stanford-crypto-ccm;128;120;121;117;138;120;124;139;170;120 08:12:27 INFO - PROCESS | 28111 | |12;stanford-crypto-pbkdf2;153;159;153;155;155;153;155;157;158;154 08:12:27 INFO - PROCESS | 28111 | |13;stanford-crypto-sha256-iterative;62;63;63;62;63;62;62;64;62;61 08:12:27 INFO - PROCESS | 28111 | __end_tp_report 08:12:27 INFO - PROCESS | 28111 | __start_cc_report 08:12:27 INFO - PROCESS | 28111 | _x_x_mozilla_cycle_collect,913 08:12:27 INFO - PROCESS | 28111 | __end_cc_report 08:12:27 INFO - PROCESS | 28111 | __startTimestamp1467731547278__endTimestamp 08:12:27 INFO - PROCESS | 28111 | 08:12:27 INFO - PROCESS | 28111 | ------- Summary: start ------- 08:12:27 INFO - PROCESS | 28111 | Number of tests: 14 08:12:27 INFO - PROCESS | 28111 | 08:12:27 INFO - PROCESS | 28111 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.50 stddev:3.16 (2.9%) stddev-sans-first:2.00 08:12:27 INFO - PROCESS | 28111 | Values: 102.0 110.0 105.0 111.0 112.0 110.0 111.0 110.0 110.0 111.0 08:12:27 INFO - PROCESS | 28111 | 08:12:27 INFO - PROCESS | 28111 | [#1] audio-beat-detection Cycles:10 Average:140.30 Median:147.00 stddev:19.51 (13.3%) stddev-sans-first:20.64 08:12:27 INFO - PROCESS | 28111 | Values: 144.0 121.0 151.0 165.0 119.0 144.0 150.0 118.0 170.0 121.0 08:12:27 INFO - PROCESS | 28111 | 08:12:27 INFO - PROCESS | 28111 | [#2] audio-dft Cycles:10 Average:164.30 Median:163.50 stddev:4.62 (2.8%) stddev-sans-first:4.82 08:12:27 INFO - PROCESS | 28111 | Values: 162.0 162.0 165.0 164.0 162.0 164.0 177.0 163.0 161.0 163.0 08:12:27 INFO - PROCESS | 28111 | 08:12:27 INFO - PROCESS | 28111 | [#3] audio-fft Cycles:10 Average:92.60 Median:75.50 stddev:36.36 (48.2%) stddev-sans-first:37.93 08:12:27 INFO - PROCESS | 28111 | Values: 74.0 76.0 75.0 158.0 76.0 76.0 75.0 75.0 165.0 76.0 08:12:27 INFO - PROCESS | 28111 | 08:12:27 INFO - PROCESS | 28111 | [#4] audio-oscillator Cycles:10 Average:102.20 Median:84.00 stddev:26.83 (31.9%) stddev-sans-first:27.64 08:12:27 INFO - PROCESS | 28111 | Values: 84.0 83.0 140.0 84.0 85.0 95.0 137.0 85.0 84.0 145.0 08:12:27 INFO - PROCESS | 28111 | 08:12:27 INFO - PROCESS | 28111 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.88 (0.7%) stddev-sans-first:0.83 08:12:27 INFO - PROCESS | 28111 | Values: 119.0 118.0 119.0 118.0 119.0 117.0 117.0 117.0 118.0 117.0 08:12:27 INFO - PROCESS | 28111 | 08:12:27 INFO - PROCESS | 28111 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:147.50 stddev:2.69 (1.8%) stddev-sans-first:1.22 08:12:27 INFO - PROCESS | 28111 | Values: 155.0 147.0 146.0 147.0 150.0 147.0 146.0 148.0 147.0 148.0 08:12:27 INFO - PROCESS | 28111 | 08:12:27 INFO - PROCESS | 28111 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.78 08:12:27 INFO - PROCESS | 28111 | Values: 95.0 95.0 97.0 95.0 96.0 96.0 96.0 97.0 96.0 95.0 08:12:27 INFO - PROCESS | 28111 | 08:12:27 INFO - PROCESS | 28111 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:1.91 (3.5%) stddev-sans-first:2.03 08:12:27 INFO - PROCESS | 28111 | Values: 55.0 53.0 58.0 54.0 55.0 53.0 53.0 58.0 54.0 56.0 08:12:27 INFO - PROCESS | 28111 | 08:12:27 INFO - PROCESS | 28111 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:62.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 08:12:27 INFO - PROCESS | 28111 | Values: 62.0 61.0 61.0 62.0 62.0 61.0 63.0 61.0 62.0 61.0 08:12:27 INFO - PROCESS | 28111 | 08:12:27 INFO - PROCESS | 28111 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:76.50 stddev:3.17 (4.1%) stddev-sans-first:3.32 08:12:27 INFO - PROCESS | 28111 | Values: 76.0 79.0 75.0 76.0 76.0 75.0 84.0 77.0 82.0 75.0 08:12:27 INFO - PROCESS | 28111 | 08:12:27 INFO - PROCESS | 28111 | [#11] stanford-crypto-ccm Cycles:10 Average:129.70 Median:126.00 stddev:16.10 (12.8%) stddev-sans-first:17.07 08:12:27 INFO - PROCESS | 28111 | Values: 128.0 120.0 121.0 117.0 138.0 120.0 124.0 139.0 170.0 120.0 08:12:27 INFO - PROCESS | 28111 | 08:12:27 INFO - PROCESS | 28111 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.20 Median:155.00 stddev:2.15 (1.4%) stddev-sans-first:2.13 08:12:27 INFO - PROCESS | 28111 | Values: 153.0 159.0 153.0 155.0 155.0 153.0 155.0 157.0 158.0 154.0 08:12:27 INFO - PROCESS | 28111 | 08:12:27 INFO - PROCESS | 28111 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:62.50 stddev:0.84 (1.3%) stddev-sans-first:0.88 08:12:27 INFO - PROCESS | 28111 | Values: 62.0 63.0 63.0 62.0 63.0 62.0 62.0 64.0 62.0 61.0 08:12:27 INFO - PROCESS | 28111 | -------- Summary: end -------- 08:12:27 INFO - PROCESS | 28111 | 08:12:28 INFO - TEST-INFO | 28111: exit 0 08:12:28 INFO - TEST-OK | kraken | took 61496ms 08:12:28 INFO - SUITE-END | took 1172s 08:12:28 INFO - Completed test suite (00:19:32) 08:12:28 INFO - javascript benchmark 08:12:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7535.811645480906, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3179.984100079499, 3201.5837941067657, 3219.533167690686, 3244.399786039583, 3263.184203949013, 5559.833205003852, 5584.9720751396235, 5586.776528938843, 5654.830355089354, 5659.915101273474, 5494.2857428534335, 5529.281193444846, 5538.363088244853, 5599.888002239963, 5627.43725627437, 4960.975195124038, 4993.775280112403, 5098.694078355311, 5149.382074151088, 5208.062548741225, 790.3481140893543, 5089.0, 5096.617753668471, 5125.026245013454, 5183.714895680736, 5022.573081288095, 5032.572231360339, 5042.546170844624, 5063.797448102072, 5087.440381558025, 4936.4076310842565, 5028.547430731252, 5053.74731263439, 5077.64456488046, 5078.46676099008, 4951.678140920829, 4977.203647416432, 4980.77586508608, 4990.800367985276, 5046.7224302663335, 5467.097928841737, 5468.671879687232, 5474.589405794542, 5489.066858634042, 5500.202470641774, 5775.624584402042, 5853.151293062525, 5865.648061116347, 5889.941100588982, 5911.940880591182, 5957.731902064417, 5966.940330596725, 6026.939730602681, 6038.849028774272, 6045.12345709874, 5569.66582005081, 5586.273784408001, 5594.2447769551, 5601.467860553282, 5613.4386561343945, 5966.373530779206, 6105.389461053859, 6107.450329470369, 6128.3258841527395, 6139.47814435769, 5887.293524776968, 5950.375210602824, 5968.253968253968, 5970.373110823388, 6015.127806468037, 5974.3428222895445, 6016.308124565643, 6029.969850150809, 6037.818865434044, 6045.0, 5806.216160818235, 5839.708014599253, 5856.4143585641095, 6020.548458865603, 6026.367231440723, 5790.739416726173, 5883.61756485827, 5910.822675319747, 5934.643921364645, 5960.284765828128, 4495.370648109268, 4500.977495112504, 4516.8193272268745, 4536.3422303765765, 4539.614132798683, 3905.6875449963936, 4014.0767623446773, 4027.81874815634, 4033.415154802537, 4038.1519880825354, 5728.455796699307, 5746.0, 5758.395368486249, 5762.078067509178, 5871.2073870027, 6056.697165141725, 6067.7269522871575, 6122.020476723703, 6122.142899994004, 6130.693465326716, 5610.382857885629, 5653.773849046074, 5656.208130861683, 5770.365259821417, 5826.563007774434, 5134.383873935151, 5140.074786538385, 5151.124308867502, 5151.793928242903, 5181.948180518222, 6148.0, 6195.039768835838, 6238.469730072904, 6258.749650013949, 6270.843228919222, 5796.62321949072, 5942.821715348374, 5954.612950158225, 6005.819825405332, 6007.669578173242, 6134.426636849298, 6156.261248650011, 6171.56799024064, 6178.62928224308, 6223.844403889939, 5861.6189947653265, 5899.056151015817, 5907.113932910098, 5916.674582897982, 5954.940450595439, 5753.223314852608, 5982.042873140276, 6003.729832157651, 6040.063790112539, 6093.0, 5867.20792692981, 5910.320313164041, 5916.911246331395, 5923.229980102559, 5928.407159284209, 5725.570582206268, 5883.646981181143, 5885.646861188342, 5897.764089436375, 5898.793542226002, 5557.805476808292, 5706.800261990977, 5710.314762228559, 5729.140628905531, 5770.913436298543, 5709.715314054304, 5749.367569567261, 5848.0, 5853.414658534283, 5911.408859114226, 5683.573731970201, 5773.942260577341, 5778.219940308173, 5801.477866991991, 5803.738831752666], "value": 5469.950357641447, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.3853453873435, 619.2352444730758, 621.4903778901303, 632.433971595422, 648.0506058624114, 42912.35631465527, 44165.558344416546, 44183.999999999956, 44475.55524444755, 48038.279425808556, 46735.0, 46763.76618116913, 47017.0, 47117.05765884689, 47268.0, 8992.280617550612, 9219.677311294106, 9220.631174753002, 9232.584533696, 9240.630374785, 9114.45313281202, 9194.816103677922, 9200.953995230015, 9224.953875230614, 9227.53862306882, 9265.768355791091, 9291.907080929172, 9310.53447327631, 9314.161725444708, 9319.114684105032, 9129.0, 9158.084191580821, 9177.403468774508, 9183.954080229556, 9211.940626827933, 9127.954360228223, 9144.359894807367, 9157.0, 9171.082891710843, 9185.0, 43771.34342984826, 44171.337429938576, 44225.0, 44240.77879610581, 44275.11449770987, 3675.98569173278, 3703.925921481582, 3791.6587507124214, 3831.7126215533667, 4241.172971270604, 33318.50022249668, 34017.6598234017, 34044.65955340464, 34102.82948585266, 34130.82934585311, 4420.955790442086, 4456.398386217884, 4542.568455996675, 4563.885902852422, 4598.678092533524, 373892.0, 377341.0, 379085.0, 379347.0, 380355.0, 36670.266594668494, 61785.38214617886, 62545.0, 62558.68720656368, 62628.37371626226, 37885.43171852425, 39499.40750888739, 39935.40096898549, 39967.2006559873, 40001.0, 15355.0, 15439.536813895376, 15463.149526776135, 15601.219939003231, 15641.687166256612, 12617.810732839014, 12693.301868397326, 12722.491100356066, 12728.10903236783, 12736.0, 8975.730728078168, 9057.139571740674, 9061.77345566353, 9084.909150908406, 9132.178103970675, 3427.1260828489076, 3443.5867695876655, 3477.8696923499965, 3491.6508349165388, 3541.3625547401716, 985.103555764251, 1033.751899544104, 1051.8444666001994, 1114.4149321606221, 1154.3016475032484, 33819.15452113717, 33905.0, 34303.31393372118, 34312.31375372478, 34529.309413811585, 1105.8175401058895, 1147.363213416545, 1147.7474955509774, 1202.1344631865043, 1242.577523641966, 17716.91141544284, 17778.46664600064, 17806.37677681275, 17851.37520186787, 18077.27690892376, 579033.0, 580204.0, 588597.0, 588914.0, 591189.0, 62301.68849155725, 62950.68524657348, 63034.684826575576, 63062.0, 63109.68445157837, 1348.6426097084282, 1352.2157148853642, 1356.5658989123583, 1363.195714528433, 1389.5136702154368, 31907.521387179677, 32022.359552808346, 34150.487742684374, 34946.82526587351, 35993.0, 60310.698446507486, 60590.0, 60893.69553152206, 60994.08508872459, 61293.080603790084, 492228.0, 496623.0, 496666.0, 497744.0, 498104.0, 46045.0, 46534.975226610164, 47326.0, 47688.52311476841, 47721.5227847731, 51929.0, 52220.0, 53573.73213133909, 53584.0, 53671.463285368205, 42542.36186457144, 43613.345799813666, 47170.76414618042, 47426.76286618683, 47955.760221198674, 43653.0, 44357.556424435345, 44516.777416114004, 44772.0, 45750.08499830051, 42526.0, 42903.570964291204, 42989.35515967326, 43998.560014400726, 44111.11777764491, 38838.80580597079, 38958.80520597379, 39320.60679393169, 39811.60188398195, 39904.800475997436, 29593.0, 29696.406071878875, 29832.0, 29993.4001319968, 30246.395072098876], "value": 20313.910599026967, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.89827543114205, 414.9564295748948, 415.55535576932687, 421.7237709300408, 434.10357611532186, 18820.247190112397, 20479.385618431454, 20803.479913002164, 20811.063502142402, 21403.03686334115, 19824.107915143817, 20207.191712331525, 20248.59502809943, 20273.898630506865, 20344.796552034477, 5758.971205143968, 5957.31490878548, 5959.493443057324, 6005.759769609211, 6018.458338749533, 4189.539150693421, 5807.041838096709, 5903.645781253117, 6555.213374395079, 6624.304448032959, 6680.298568650294, 6686.866262674768, 6688.732450701966, 6707.195136583617, 6739.123913891187, 6456.774012909549, 6627.237867645186, 6667.633135207295, 6668.333166683317, 6671.699773510204, 5647.124695672136, 5866.6480011199465, 5881.558883083786, 5925.940740592625, 5929.822105336847, 25542.233732987854, 25591.488170236677, 25625.871870640713, 25758.871205644038, 26024.609630855553, 2371.205646108556, 2447.9143229987044, 2568.0883286433236, 2576.7552082552315, 3118.8596513156963, 14922.0, 15948.2823272953, 16120.0, 16169.595760105974, 16513.422030229005, 1936.5933154037668, 1942.9125689344014, 1995.920163193485, 2041.8570700051002, 2127.765945745982, 86821.0, 87459.56270218671, 87558.0, 88417.55791221067, 89211.55394223052, 11210.495527701272, 11227.428160057598, 11457.88542114585, 11682.415879206006, 11695.239809412362, 16129.11289879068, 16159.838401616069, 16211.837881621268, 16254.43109491162, 16307.347706091623, 8031.237032481905, 8096.230858068474, 8154.062282837431, 8200.917990820015, 8263.256306932404, 7458.291462311072, 7589.772306830804, 7599.392048636096, 7723.266289702469, 7752.689892404241, 6854.485913556503, 6909.792706218822, 6979.93020069803, 7038.612876291751, 7085.2206257311655, 1701.2344444999799, 1762.5064981805115, 1801.7027190513681, 1819.2631984046482, 2023.625629258592, 912.1744820937063, 943.5093751249449, 954.465499320369, 960.8318544254868, 1044.7753732947301, 18213.36253231157, 20467.032285281723, 20589.691154632692, 20600.690989635168, 20865.47836304074, 1043.4678314059884, 1053.731298518888, 1055.720234137954, 1056.906102184251, 1074.1084899533369, 11097.667069987914, 11347.432628368548, 11521.0, 11558.711032224093, 11599.536018559163, 458005.0, 461564.0, 464911.0, 471817.0, 474325.0, 92284.0, 95589.0, 95689.0, 98403.50798246106, 99040.0, 999.5851721535481, 1024.2471783239314, 1026.9794604107876, 1047.2093569355088, 1061.7982583309147, 18838.587579062485, 18840.152193151065, 18932.621347573247, 18980.620387591895, 19054.523636909187, 45732.0, 45974.0, 46611.30083048689, 46695.76652116718, 46852.531474684816, 63168.0, 64565.0, 65141.34858651353, 65165.67417163074, 65332.673336633015, 8183.181681831769, 8195.098539160806, 8491.8726219108, 8502.0, 9041.95479022627, 10010.099091081838, 13399.12905661129, 13752.31238438054, 13821.79267310971, 13910.51313204033, 12438.813417798921, 12516.186447880858, 12993.025523085616, 12995.0, 13032.152910060815, 12538.811917821058, 12802.583641918201, 12851.16467429614, 12922.676933076747, 12981.935090324489, 12327.876721232673, 13076.934615327244, 13121.409536570687, 13209.405576749261, 13557.25435101079, 8769.079246679006, 8852.159044890725, 8956.28349732033, 9071.727848164566, 9282.62869485213, 9007.05425930294, 12804.679883003, 12820.61538153857, 12830.16603920742, 12887.226766394046], "value": 9893.673724313892, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1453.38231251718, 1483.3102607287612, 1591.8328575499572, 1787.982120178798, 1789.838914497695, 8077.19228077192, 8782.780430489242, 8830.779230519223, 9307.953460232706, 9380.57787399567, 8865.46807191569, 9097.408668436547, 9205.447673139617, 9209.171174594285, 9227.261819054476, 2396.4967356855036, 2410.1323523531514, 2423.7333893271725, 2427.9150229741963, 2435.208557218902, 2410.819188560865, 2432.975670243293, 2474.34429876083, 2479.9752002479927, 2483.900643974239, 2443.6701045358914, 2462.4705688277018, 2470.0984140788664, 2489.3900994256433, 2499.3501689560753, 2409.180878501318, 2433.4403087289934, 2445.7921076708503, 2448.5347783920997, 2451.240115564181, 2353.9529209415887, 2366.3847399676038, 2366.6923299970895, 2372.240882917467, 2428.6114221724615, 9367.391119577205, 9368.156865882036, 9391.107844754737, 9458.57436415363, 9474.336796424253, 5352.143657014859, 5414.35027796667, 5447.237386765856, 5488.25908502355, 5490.313710786152, 3534.3461459629793, 3564.41187204111, 3603.3333833240936, 3624.2207925295925, 3633.872814451508, 1227.9017678585692, 1252.8684488128797, 1259.7732408166526, 1273.4587800184977, 1299.9285039322833, 13085.86914130856, 13205.33973301331, 13207.537736179187, 13222.338883055809, 13245.07284490086, 4825.879353016203, 4842.6368022398465, 4951.3810773653295, 4964.726940018334, 4983.07813054586, 11077.778444431066, 11117.610883619034, 11133.832992505118, 11143.164262680331, 11169.106471482262, 5609.1305847593685, 5630.915536266959, 5632.239647647597, 5632.605717599728, 5635.182898479779, 4333.674974376871, 4916.262560615936, 5081.568066714371, 5090.541851233407, 5195.064888320138, 4157.854475093418, 4229.767362795076, 4280.571942805695, 4303.07483890965, 4331.371951067078, 1349.0758830201344, 1353.3571553512004, 1358.986410135886, 1376.1880490510646, 1381.5233744358181, 907.138218692245, 972.5672075926286, 981.2346369831542, 992.265723364705, 999.835027220515, 6042.39576042401, 6045.455908968214, 6084.939150608438, 6107.6640784757265, 6149.41580549847, 443.32835753832967, 444.64650602770877, 449.00769299847053, 1031.9484025798681, 1052.5105825791045, 4060.4924384451942, 4120.896977575525, 4133.627973482401, 4136.462259906253, 4151.045259590311, 11416.0, 11515.942420288013, 11618.128640352008, 11678.88321116795, 11683.065354771597, 11636.418179091012, 11649.41752912351, 11664.70838229034, 11676.24104433226, 11699.181057325906, 8281.171882811792, 8288.50268983863, 8349.624266908004, 8373.288270496954, 8421.24208821209, 5836.678982655994, 5945.851353716019, 5957.582969192115, 5961.582689211714, 6123.479504242189, 10253.897461025592, 10898.509567069343, 10972.780544389227, 11053.115750740082, 11122.277051991594, 11183.384913829492, 11213.607523736957, 11236.101111911192, 11304.547818087512, 11451.942740286246, 7222.494425390172, 7947.125816160334, 8214.58927053633, 8233.135520770473, 8342.0, 8955.910440895768, 8968.05835387275, 8977.910220897707, 8987.865182022144, 8996.460212387277, 7957.721479748181, 7992.160823113722, 8052.677892884219, 8121.431499794958, 8276.83446331082, 7933.9603301983125, 8068.233517815798, 8104.959475202586, 8162.755117346489, 8208.302294305051, 6565.409113179837, 6743.865122697617, 6803.523753337219, 6822.147231596051, 6877.3810357068105, 5300.01949639318, 5320.334958130234, 5379.946200538101, 5383.273258110105, 5394.541463975606, 5187.325647665779, 5211.0359583477175, 5302.9469705304, 5319.175527793198, 5321.388040375252], "value": 4813.862579863021, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.2636276109091, 323.56965236235794, 332.4365200984331, 343.3733436478427, 348.71405447533016, 5544.833654990347, 5549.223108764766, 5693.886122277552, 5748.942510574893, 5781.450762177592, 5558.388577256509, 5567.137093750465, 5609.411011843748, 5654.575906806986, 5658.349289831671, 4365.650747940165, 4366.166210191727, 4380.518143004267, 4390.363397307388, 4426.804762714065, 4217.34631132175, 4360.887973566736, 4417.86746397607, 4423.86728398147, 4429.247028005231, 4364.519902810688, 4366.279563871957, 4386.2324093283705, 4393.319035549495, 4396.648268138557, 4405.185040767468, 4407.228734971367, 4408.14041261954, 4424.9557504424865, 4436.622887054604, 3787.9242415151816, 3847.2497862916744, 3880.1075752577067, 3884.2814079395403, 3895.5325360956867, 5445.863853403696, 5488.231647569343, 5500.3949565547755, 5535.806246781343, 5560.77756889724, 5011.924821127686, 5015.22264049073, 5019.698818070928, 5028.547430731252, 5058.418281897592, 5659.207710920475, 5933.317668468138, 5945.116618440053, 5988.550858685572, 5999.820005399845, 4214.662826973866, 4252.87241382759, 4253.553376895444, 4274.529801721808, 4275.183047204925, 6168.599041062362, 6182.721777519977, 6197.1324014637985, 6245.843853903689, 6267.843303917393, 4197.853075142355, 4327.112941846914, 4352.934705979413, 4367.737935723867, 4376.431063961664, 4387.8244870204835, 4393.6704747144095, 4403.823847046082, 4423.18171138334, 4429.424174857312, 5005.3242812220615, 5039.521245481674, 5050.292958985745, 5061.063703214917, 5085.466026067284, 5820.3888591698105, 5874.588778785529, 5955.52355811534, 6004.669743164168, 6051.546134039964, 1506.246876561719, 1518.6507103366287, 1521.9847801522064, 1522.4671365022155, 1527.7861099446086, 955.603424578806, 963.7349728824489, 966.8984756600456, 977.3305285879053, 981.5926390547985, 5099.923501147486, 5104.5707201983505, 5139.665921715076, 5169.172932330809, 5189.247559103909, 5314.538501912005, 5368.785248590091, 5401.730593310569, 5425.674459532441, 5453.7818487260065, 4966.90066198674, 5068.265101560327, 5077.26379674945, 5120.564751996122, 5144.511271429208, 2828.6888442271334, 2859.1129854296064, 2881.5389537673873, 2911.388608392219, 2931.6775154732964, 5569.0, 5627.71861406928, 5636.788090560467, 5648.971755141198, 5665.830025099253, 5342.813001544927, 5423.945760542344, 5452.963936851986, 5493.725313734298, 5512.145617429305, 5479.082321187632, 5546.861328466821, 5555.2778138841695, 5560.304961879846, 5563.525665698593, 5258.579313654822, 5322.22827689975, 5375.467991622525, 5434.782608695607, 5435.918461223006, 5290.709011004432, 5310.734463276898, 5312.760925758427, 5349.0625405798755, 5364.785408583613, 5511.0, 5516.531094856982, 5590.189422533791, 5608.8878222434505, 5650.0959846424375, 3812.9237415252096, 3886.6985157289478, 3888.9027774304736, 3994.7603143811466, 3997.480327557399, 5354.7858085676135, 5406.107992181246, 5425.620206585501, 5886.646801191942, 5982.521398288213, 5912.438318359749, 5915.556333274935, 5920.6974465617495, 5940.376260492759, 5944.524438045032, 5851.180834683233, 5883.352831188651, 5905.704714764331, 5918.7928422505, 5931.495822855106, 5597.984725498899, 5749.626274292157, 5807.709614519342, 5808.273965754281, 5818.24362832846, 5909.91135132982, 5938.435848594377, 5946.405359464019, 5966.552508561788, 5973.850653733518, 5582.855514619575, 5742.655440673573, 5789.247397838254, 5807.854803629774, 5827.6794776286015], "value": 4343.834245929174, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [753.7927070055731, 771.4175797273058, 774.4927072767339, 823.7240524424318, 845.028217549818, 14909.925450372746, 15961.920190399062, 16141.838581614194, 16170.514884553453, 16769.66460670786, 15081.547553573382, 15162.0, 15276.847231527681, 15278.465253716122, 15282.465113721022, 667.1127400557259, 778.98831517527, 796.474326944217, 797.7008621766837, 803.5058439059994, 802.6668932393079, 807.7738233294687, 811.6063709101081, 811.8295158016823, 812.3054788156101, 855.9315254779602, 859.0893652728097, 859.5745106172453, 859.7893516088567, 860.1398601398602, 843.8734189871507, 848.6308455821737, 850.9787255318605, 851.3742399336483, 851.6295411496019, 616.8889599872022, 616.9321374648785, 617.4257940115691, 622.7384498510636, 623.392192612204, 15297.235138243042, 15352.692946141015, 15370.692586148214, 15400.152991585459, 15433.459828905934, 12693.555725549562, 13667.589972300846, 13867.306634668226, 14610.70778584433, 16085.115318657468, 13750.518731844337, 13899.652508687364, 14033.719325613532, 14040.1575905446, 14121.78817317741, 4629.537046295377, 4641.303804429329, 4651.0, 4659.813607455698, 4748.216544270192, 69862.0, 86337.0, 86364.56817715871, 86554.0, 86904.56547717284, 11526.711832204095, 11547.422628868691, 12041.578544750892, 12309.93845030787, 12319.260844349368, 23837.0, 24059.157929472734, 24112.156074537306, 24133.51732965331, 24160.0, 9165.404248723811, 9174.0, 9303.95348023269, 9378.577963991636, 9466.148046675833, 4839.8287277484915, 4918.434380046269, 5028.823991160292, 5152.278680984665, 5154.664946778447, 3522.383582872987, 3599.8380072896784, 3621.058524783575, 3627.0, 3651.5253017107607, 639.7984634840103, 645.0936434309803, 664.8038828545591, 672.9158855143107, 673.8416472129046, 621.4996927473337, 659.5515049766109, 675.9324067593201, 677.4918810891832, 678.8642271545611, 9399.624015039459, 9932.65235716761, 9944.0, 9947.0, 10068.338724110587, 722.5989575785385, 752.2139364364143, 768.4966347042696, 783.9451238413257, 790.1900551934314, 4806.831760888352, 4908.705477671351, 5094.0, 5250.921236181461, 5394.649347792381, 123892.0, 126951.0, 127382.0, 128023.35988320185, 129424.0, 102833.0, 105032.47483762685, 107724.46137769418, 109716.451417744, 110105.44947275212, 58049.4195058044, 80309.0, 92959.0, 94108.52945735364, 94411.52794235985, 10086.0, 10353.378797271887, 10442.0, 10644.680659580225, 10701.19741019411, 56941.43058569361, 57729.422705772406, 57994.7100264496, 58082.12876806767, 58662.70668646629, 67151.66424168044, 68636.6568167156, 69956.65021675063, 74373.25626743663, 83549.0, 13630.522931697344, 13749.312534373441, 13832.861671383158, 13946.860531394963, 14367.13797172173, 15204.0, 15364.692706146037, 15482.225888705745, 15762.133082680562, 16361.0, 15057.0, 15097.47158849435, 15376.538703838904, 15652.0, 15829.129397883227, 13693.863061369259, 14053.159110511684, 14316.427342906167, 14465.421383144556, 15800.446984355493, 14776.852231477978, 15044.774328384865, 15189.696206075596, 15344.616384590474, 15565.621683036727, 12175.208611440228, 12435.12984002437, 12471.93764031174, 12679.746405071663, 12721.363931803558, 10995.725106872393, 11166.553337866395, 11342.773144536897, 11565.190436669352, 12310.81533777012], "value": 7965.906019333569, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1511.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 105.0, 111.0, 112.0, 110.0, 111.0, 110.0, 110.0, 111.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 121.0, 151.0, 165.0, 119.0, 144.0, 150.0, 118.0, 170.0, 121.0], "value": 140.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 165.0, 164.0, 162.0, 164.0, 177.0, 163.0, 161.0, 163.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 158.0, 76.0, 76.0, 75.0, 75.0, 165.0, 76.0], "value": 92.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 140.0, 84.0, 85.0, 95.0, 137.0, 85.0, 84.0, 145.0], "value": 102.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 119.0, 118.0, 119.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 147.0, 146.0, 147.0, 150.0, 147.0, 146.0, 148.0, 147.0, 148.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 95.0, 96.0, 96.0, 96.0, 97.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 58.0, 54.0, 55.0, 53.0, 53.0, 58.0, 54.0, 56.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 62.0, 62.0, 61.0, 63.0, 61.0, 62.0, 61.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 75.0, 76.0, 76.0, 75.0, 84.0, 77.0, 82.0, 75.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 120.0, 121.0, 117.0, 138.0, 120.0, 124.0, 139.0, 170.0, 120.0], "value": 129.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 159.0, 153.0, 155.0, 155.0, 153.0, 155.0, 157.0, 158.0, 154.0], "value": 155.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 62.0, 63.0, 62.0, 62.0, 64.0, 62.0, 61.0], "value": 62.4, "unit": "score"}]}]} 08:12:28 INFO - Return code: 0 08:12:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:12:28 ERROR - # TBPL SUCCESS # 08:12:28 INFO - Running post-action listener: _resource_record_post_action 08:12:28 INFO - ##### 08:12:28 INFO - ##### Finished run-tests step (success) 08:12:28 INFO - ##### 08:12:28 INFO - Running post-run listener: _resource_record_post_run 08:12:28 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8192; Write bytes: 559054848; Read time: 16; Write time: 726244 08:12:28 INFO - TinderboxPrint: CPU usage
13.4% 08:12:28 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 16 08:12:28 INFO - TinderboxPrint: I/O write bytes / time
559,054,848 / 726,244 08:12:28 INFO - TinderboxPrint: CPU idle
8,223.6 (86.6%) 08:12:28 INFO - TinderboxPrint: CPU user
1,213.2 (12.8%) 08:12:28 INFO - TinderboxPrint: Swap in / out
0 / 0 08:12:28 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 263385088; Read time: 0; Write time: 386524 08:12:28 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295669760; Read time: 8; Write time: 339720 08:12:29 INFO - Running post-run listener: _upload_blobber_files 08:12:29 INFO - Blob upload gear active. 08:12:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:12:29 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 08:12:29 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'] 08:12:29 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 08:12:29 INFO - (blobuploader) - INFO - Open directory for files ... 08:12:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:12:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:12:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:12:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:12:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:12:32 INFO - (blobuploader) - INFO - Done attempting. 08:12:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:12:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:12:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:12:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:12:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:12:34 INFO - (blobuploader) - INFO - Done attempting. 08:12:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:12:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:12:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:12:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:12:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:12:35 INFO - (blobuploader) - INFO - Done attempting. 08:12:35 INFO - (blobuploader) - INFO - Iteration through files over. 08:12:35 INFO - Return code: 0 08:12:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:12:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:12:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/96cb1fb067f299df4fa6bd0e227d8f82c835a8cf06486ffb289919a3e45c2bf16ce9cd9d6978bcb5685365a2f3178dbc58fd1cedb31459ec537dbc8ad243dcef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6f1cea16eff15ebd2cc82dc96ec394f4b51f738e3852815b4336daf51b10bdcd8de0173ea7eea1281a3d36895689e7131da93526fffc268361fea510d6961e2d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c1b0827fdbd18e373ac8aedbdb9c9dbf9938a91c4ec8d9d2e26d42027295072a494d2434678a58701b21a7ecafe88d9785c6fa24a5dce41a714bfd9a065f49bf"} 08:12:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:12:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:12:35 INFO - Contents: 08:12:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/96cb1fb067f299df4fa6bd0e227d8f82c835a8cf06486ffb289919a3e45c2bf16ce9cd9d6978bcb5685365a2f3178dbc58fd1cedb31459ec537dbc8ad243dcef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6f1cea16eff15ebd2cc82dc96ec394f4b51f738e3852815b4336daf51b10bdcd8de0173ea7eea1281a3d36895689e7131da93526fffc268361fea510d6961e2d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c1b0827fdbd18e373ac8aedbdb9c9dbf9938a91c4ec8d9d2e26d42027295072a494d2434678a58701b21a7ecafe88d9785c6fa24a5dce41a714bfd9a065f49bf"} 08:12:35 INFO - Running post-run listener: copy_logs_to_upload_dir 08:12:35 INFO - Copying logs to upload dir... 08:12:35 INFO - mkdir: /builds/slave/test/build/upload/logs 08:12:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.191417 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-07-05 08:12:34.963151) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 08:12:34.967021) ========= 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=5bd038846534b2fdfa68eeae000001e2-1467730254.8185-1346645108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/96cb1fb067f299df4fa6bd0e227d8f82c835a8cf06486ffb289919a3e45c2bf16ce9cd9d6978bcb5685365a2f3178dbc58fd1cedb31459ec537dbc8ad243dcef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6f1cea16eff15ebd2cc82dc96ec394f4b51f738e3852815b4336daf51b10bdcd8de0173ea7eea1281a3d36895689e7131da93526fffc268361fea510d6961e2d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c1b0827fdbd18e373ac8aedbdb9c9dbf9938a91c4ec8d9d2e26d42027295072a494d2434678a58701b21a7ecafe88d9785c6fa24a5dce41a714bfd9a065f49bf"} build_url:https://queue.taskcluster.net/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011104 build_url: 'https://queue.taskcluster.net/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/96cb1fb067f299df4fa6bd0e227d8f82c835a8cf06486ffb289919a3e45c2bf16ce9cd9d6978bcb5685365a2f3178dbc58fd1cedb31459ec537dbc8ad243dcef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6f1cea16eff15ebd2cc82dc96ec394f4b51f738e3852815b4336daf51b10bdcd8de0173ea7eea1281a3d36895689e7131da93526fffc268361fea510d6961e2d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c1b0827fdbd18e373ac8aedbdb9c9dbf9938a91c4ec8d9d2e26d42027295072a494d2434678a58701b21a7ecafe88d9785c6fa24a5dce41a714bfd9a065f49bf"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 08:12:34.992183) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 08:12:34.992534) ========= 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=5bd038846534b2fdfa68eeae000001e2-1467730254.8185-1346645108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004441 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 08:12:35.078697) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 08:12:35.079009) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 08:12:35.079684) ========= ========= Total master_lag: 0.17 =========