builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-030 starttime: 1467893678.91 results: success (0) buildid: 20160707023025 builduid: cb3b718895874723aa588fb152877c2d revision: fa4355015e36065e83c1683023c661e5dd60e8ba ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 05:14:38.910138) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 05:14:38.910660) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 05:14:38.910953) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 05:14:38.926194) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 05:14:38.926572) ========= 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=4ac8d263c7293b36a1be1aed000001be-1467893678.411107-1757343348 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-07 05:14:39-- 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% 81.2M=0s 2016-07-07 05:14:39 (81.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098014 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 05:14:39.039635) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 05:14:39.039954) ========= 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=4ac8d263c7293b36a1be1aed000001be-1467893678.411107-1757343348 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018029 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 05:14:39.089258) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 05:14:39.089614) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev fa4355015e36065e83c1683023c661e5dd60e8ba --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 fa4355015e36065e83c1683023c661e5dd60e8ba --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=4ac8d263c7293b36a1be1aed000001be-1467893678.411107-1757343348 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-07 05:14:39,394 truncating revision to first 12 chars 2016-07-07 05:14:39,394 Setting DEBUG logging. 2016-07-07 05:14:39,394 attempt 1/10 2016-07-07 05:14:39,394 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/fa4355015e36?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 05:14:39,686 unpacking tar archive at: fx-team-fa4355015e36/testing/mozharness/ program finished with exit code 0 elapsedTime=0.635645 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 05:14:39.739004) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 05:14:39.739349) ========= script_repo_revision: fa4355015e36065e83c1683023c661e5dd60e8ba ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 05:14:39.739744) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 05:14:39.740127) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 05:14:39.751378) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-07 05:14:39.751732) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4ac8d263c7293b36a1be1aed000001be-1467893678.411107-1757343348 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:14:40 INFO - MultiFileLogger online at 20160707 05:14:40 in /builds/slave/test 05:14:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:14:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:14:40 INFO - {'append_to_log': False, 05:14:40 INFO - 'base_work_dir': '/builds/slave/test', 05:14:40 INFO - 'blob_upload_branch': 'Fx-Team', 05:14:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:14:40 INFO - 'branch': 'Fx-Team', 05:14:40 INFO - 'buildbot_json_path': 'buildprops.json', 05:14:40 INFO - 'config_files': ('talos/linux_config.py',), 05:14:40 INFO - 'default_actions': ('clobber', 05:14:40 INFO - 'read-buildbot-config', 05:14:40 INFO - 'download-and-extract', 05:14:40 INFO - 'populate-webroot', 05:14:40 INFO - 'create-virtualenv', 05:14:40 INFO - 'install', 05:14:40 INFO - 'run-tests'), 05:14:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:14:40 INFO - 'download_minidump_stackwalk': True, 05:14:40 INFO - 'download_symbols': 'ondemand', 05:14:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:14:40 INFO - 'tooltool.py': '/tools/tooltool.py', 05:14:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:14:40 INFO - '/tools/misc-python/virtualenv.py')}, 05:14:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:14:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:14:40 INFO - 'installer_path': 'installer.exe', 05:14:40 INFO - 'log_level': 'info', 05:14:40 INFO - 'log_name': 'talos', 05:14:40 INFO - 'log_to_console': True, 05:14:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:14:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:14:40 INFO - 'opt_config_files': (), 05:14:40 INFO - 'pip_index': False, 05:14:40 INFO - 'sps_profile': False, 05:14:40 INFO - 'sps_profile_interval': 0, 05:14:40 INFO - 'suite': 'dromaeojs', 05:14:40 INFO - 'system_bits': '32', 05:14:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:14:40 INFO - 'title': 'talos-linux64-ix-030', 05:14:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:14:40 INFO - 'use_talos_json': True, 05:14:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:14:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:14:40 INFO - 'work_dir': 'build'} 05:14:40 INFO - ##### 05:14:40 INFO - ##### Running clobber step. 05:14:40 INFO - ##### 05:14:40 INFO - Running pre-action listener: _resource_record_pre_action 05:14:40 INFO - Running main action method: clobber 05:14:40 INFO - rmtree: /builds/slave/test/build 05:14:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:14:40 INFO - Running post-action listener: _resource_record_post_action 05:14:40 INFO - ##### 05:14:40 INFO - ##### Finished clobber step (success) 05:14:40 INFO - ##### 05:14:40 INFO - ##### 05:14:40 INFO - ##### Running read-buildbot-config step. 05:14:40 INFO - ##### 05:14:40 INFO - Running pre-action listener: _resource_record_pre_action 05:14:40 INFO - Running main action method: read_buildbot_config 05:14:40 INFO - Using buildbot properties: 05:14:40 INFO - { 05:14:40 INFO - "project": "", 05:14:40 INFO - "product": "firefox", 05:14:40 INFO - "script_repo_revision": "production", 05:14:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:14:40 INFO - "repository": "", 05:14:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:14:40 INFO - "buildid": "20160707023025", 05:14:40 INFO - "pgo_build": "True", 05:14:40 INFO - "basedir": "/builds/slave/test", 05:14:40 INFO - "buildnumber": 866, 05:14:40 INFO - "slavename": "talos-linux64-ix-030", 05:14:40 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:14:40 INFO - "platform": "ubuntu64_hw", 05:14:40 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:14:40 INFO - "branch": "fx-team", 05:14:40 INFO - "repo_path": "integration/fx-team", 05:14:40 INFO - "revision": "fa4355015e36065e83c1683023c661e5dd60e8ba", 05:14:40 INFO - "stage_platform": "linux64-pgo", 05:14:40 INFO - "builduid": "cb3b718895874723aa588fb152877c2d", 05:14:40 INFO - "slavebuilddir": "test" 05:14:40 INFO - } 05:14:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/HEpUDLoPQc6smYc9c1KV4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:14:40 INFO - Running post-action listener: _resource_record_post_action 05:14:40 INFO - ##### 05:14:40 INFO - ##### Finished read-buildbot-config step (success) 05:14:40 INFO - ##### 05:14:40 INFO - ##### 05:14:40 INFO - ##### Running download-and-extract step. 05:14:40 INFO - ##### 05:14:40 INFO - Running pre-action listener: _resource_record_pre_action 05:14:40 INFO - Running main action method: download_and_extract 05:14:40 INFO - mkdir: /builds/slave/test/build/tests 05:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:40 INFO - https://queue.taskcluster.net/v1/task/HEpUDLoPQc6smYc9c1KV4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:14:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HEpUDLoPQc6smYc9c1KV4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:14:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HEpUDLoPQc6smYc9c1KV4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:14:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HEpUDLoPQc6smYc9c1KV4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:14:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HEpUDLoPQc6smYc9c1KV4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:14:41 INFO - Downloaded 1361 bytes. 05:14:41 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:14:41 INFO - Using the following test package requirements: 05:14:41 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:14:41 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:14:41 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:14:41 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:41 INFO - u'jsshell-linux-x86_64.zip'], 05:14:41 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:14:41 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:14:41 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:14:41 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:14:41 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:14:41 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:14:41 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:41 INFO - https://queue.taskcluster.net/v1/task/HEpUDLoPQc6smYc9c1KV4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:14:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HEpUDLoPQc6smYc9c1KV4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:14:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HEpUDLoPQc6smYc9c1KV4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:14:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HEpUDLoPQc6smYc9c1KV4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:14:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HEpUDLoPQc6smYc9c1KV4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:14:42 INFO - Downloaded 24302909 bytes. 05:14:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:14:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:14:43 INFO - Return code: 0 05:14:43 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:14:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:43 INFO - https://queue.taskcluster.net/v1/task/HEpUDLoPQc6smYc9c1KV4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:14:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HEpUDLoPQc6smYc9c1KV4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:14:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HEpUDLoPQc6smYc9c1KV4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:14:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HEpUDLoPQc6smYc9c1KV4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:14:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HEpUDLoPQc6smYc9c1KV4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:14:44 INFO - Downloaded 24302909 bytes. 05:14:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:14:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:14:46 INFO - Return code: 0 05:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:46 INFO - https://queue.taskcluster.net/v1/task/HEpUDLoPQc6smYc9c1KV4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:14:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HEpUDLoPQc6smYc9c1KV4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:14:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HEpUDLoPQc6smYc9c1KV4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:14:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HEpUDLoPQc6smYc9c1KV4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:14:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HEpUDLoPQc6smYc9c1KV4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:14:47 INFO - Downloaded 14403333 bytes. 05:14:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:14:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:14:47 INFO - Return code: 0 05:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:47 INFO - https://queue.taskcluster.net/v1/task/HEpUDLoPQc6smYc9c1KV4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:14:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HEpUDLoPQc6smYc9c1KV4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:14:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HEpUDLoPQc6smYc9c1KV4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:14:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HEpUDLoPQc6smYc9c1KV4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:14:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HEpUDLoPQc6smYc9c1KV4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:14:49 INFO - Downloaded 60403518 bytes. 05:14:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HEpUDLoPQc6smYc9c1KV4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:14:49 INFO - mkdir: /builds/slave/test/properties 05:14:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:14:49 INFO - Writing to file /builds/slave/test/properties/build_url 05:14:49 INFO - Contents: 05:14:49 INFO - build_url:https://queue.taskcluster.net/v1/task/HEpUDLoPQc6smYc9c1KV4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:14:49 INFO - Running post-action listener: _resource_record_post_action 05:14:49 INFO - Running post-action listener: set_extra_try_arguments 05:14:49 INFO - ##### 05:14:49 INFO - ##### Finished download-and-extract step (success) 05:14:49 INFO - ##### 05:14:49 INFO - ##### 05:14:49 INFO - ##### Running populate-webroot step. 05:14:49 INFO - ##### 05:14:49 INFO - Running pre-action listener: _resource_record_pre_action 05:14:49 INFO - Running main action method: populate_webroot 05:14:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:14:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:14:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:14:49 INFO - '--tppagecycles', 05:14:49 INFO - '7'], 05:14:49 INFO - 'tests': ['tsvgm']}}, 05:14:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:14:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:14:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:14:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:14:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:14:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:14:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:49 INFO - 'talos_options': ['--disable-e10s'], 05:14:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:14:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:14:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:49 INFO - 'talos_options': ['--disable-e10s'], 05:14:49 INFO - 'tests': ['damp', 'tps']}, 05:14:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:49 INFO - 'tests': ['damp', 'tps']}, 05:14:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:14:49 INFO - 'tests': ['dromaeo_dom']}, 05:14:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:14:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:14:49 INFO - 'tests': ['basic_compositor_video']}, 05:14:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:14:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:14:49 INFO - 'tests': ['a11yr', 05:14:49 INFO - 'ts_paint', 05:14:49 INFO - 'tpaint', 05:14:49 INFO - 'sessionrestore', 05:14:49 INFO - 'sessionrestore_no_auto_restore', 05:14:49 INFO - 'tabpaint']}, 05:14:49 INFO - 'other-e10s': {'tests': ['a11yr', 05:14:49 INFO - 'ts_paint', 05:14:49 INFO - 'tpaint', 05:14:49 INFO - 'sessionrestore', 05:14:49 INFO - 'sessionrestore_no_auto_restore', 05:14:49 INFO - 'tabpaint']}, 05:14:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:14:49 INFO - 'ts_paint', 05:14:49 INFO - 'tpaint', 05:14:49 INFO - 'sessionrestore', 05:14:49 INFO - 'sessionrestore_no_auto_restore', 05:14:49 INFO - 'tabpaint']}, 05:14:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:14:49 INFO - 'ts_paint', 05:14:49 INFO - 'tpaint', 05:14:49 INFO - 'sessionrestore', 05:14:49 INFO - 'sessionrestore_no_auto_restore', 05:14:49 INFO - 'tabpaint']}, 05:14:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:14:49 INFO - 'tests': ['a11yr', 05:14:49 INFO - 'ts_paint', 05:14:49 INFO - 'tpaint', 05:14:49 INFO - 'sessionrestore', 05:14:49 INFO - 'sessionrestore_no_auto_restore', 05:14:49 INFO - 'tabpaint']}, 05:14:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:14:49 INFO - 'tests': ['a11yr', 05:14:49 INFO - 'ts_paint', 05:14:49 INFO - 'tpaint', 05:14:49 INFO - 'sessionrestore', 05:14:49 INFO - 'sessionrestore_no_auto_restore', 05:14:49 INFO - 'tabpaint']}, 05:14:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:14:49 INFO - 'tests': ['tsvgx', 05:14:49 INFO - 'tsvgr_opacity', 05:14:49 INFO - 'tart', 05:14:49 INFO - 'tscrollx', 05:14:49 INFO - 'cart']}, 05:14:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:14:49 INFO - 'tsvgr_opacity', 05:14:49 INFO - 'tart', 05:14:49 INFO - 'tscrollx', 05:14:49 INFO - 'cart']}, 05:14:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:49 INFO - 'talos_options': ['--disable-e10s'], 05:14:49 INFO - 'tests': ['tp5o']}, 05:14:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:49 INFO - 'tests': ['tp5o']}, 05:14:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:49 INFO - 'talos_options': ['--disable-e10s', 05:14:49 INFO - '--xperf_path', 05:14:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:14:49 INFO - 'tests': ['tp5n']}, 05:14:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:49 INFO - 'talos_options': ['--xperf_path', 05:14:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:14:49 INFO - 'tests': ['tp5n']}}, 05:14:49 INFO - 'talos.zip': {'path': '', 05:14:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:14:49 INFO - Running post-action listener: _resource_record_post_action 05:14:49 INFO - ##### 05:14:49 INFO - ##### Finished populate-webroot step (success) 05:14:49 INFO - ##### 05:14:49 INFO - ##### 05:14:49 INFO - ##### Running create-virtualenv step. 05:14:49 INFO - ##### 05:14:49 INFO - Running pre-action listener: _resource_record_pre_action 05:14:49 INFO - Running main action method: create_virtualenv 05:14:49 INFO - Creating virtualenv /builds/slave/test/build/venv 05:14:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:14:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:14:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:14:49 INFO - Using real prefix '/usr' 05:14:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:14:50 INFO - Installing distribute.............................................................................................................................................................................................done. 05:14:52 INFO - Installing pip.................done. 05:14:52 INFO - Return code: 0 05:14:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xced030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfae180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfac3b0>, '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 0xfad2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfad740>, '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': '4ac8d263c7293b36a1be1aed000001be-1467893678.411107-1757343348', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:14:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:14:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:14:52 INFO - Using env: {'DISPLAY': ':0', 05:14:52 INFO - 'HOME': '/home/cltbld', 05:14:52 INFO - 'LANG': 'en_US.UTF-8', 05:14:52 INFO - 'LANGUAGE': 'en_US:en', 05:14:52 INFO - 'LOGNAME': 'cltbld', 05:14:52 INFO - 'MAIL': '/var/mail/cltbld', 05:14:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:52 INFO - 'MOZ_NO_REMOTE': '1', 05:14:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:52 INFO - 'NO_EM_RESTART': '1', 05:14:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:52 INFO - 'PWD': '/builds/slave/test', 05:14:52 INFO - 'SHELL': '/bin/bash', 05:14:52 INFO - 'SHLVL': '1', 05:14:52 INFO - 'TERM': 'linux', 05:14:52 INFO - 'TMOUT': '86400', 05:14:52 INFO - 'USER': 'cltbld', 05:14:52 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467893678.411107-1757343348', 05:14:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:52 INFO - '_': '/tools/buildbot/bin/python'} 05:14:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:14:52 INFO - Cleaning up... 05:14:52 INFO - Return code: 0 05:14:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xced030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfae180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfac3b0>, '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 0xfad2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfad740>, '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': '4ac8d263c7293b36a1be1aed000001be-1467893678.411107-1757343348', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:14:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:14:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:14:52 INFO - Using env: {'DISPLAY': ':0', 05:14:52 INFO - 'HOME': '/home/cltbld', 05:14:52 INFO - 'LANG': 'en_US.UTF-8', 05:14:52 INFO - 'LANGUAGE': 'en_US:en', 05:14:52 INFO - 'LOGNAME': 'cltbld', 05:14:52 INFO - 'MAIL': '/var/mail/cltbld', 05:14:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:52 INFO - 'MOZ_NO_REMOTE': '1', 05:14:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:52 INFO - 'NO_EM_RESTART': '1', 05:14:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:52 INFO - 'PWD': '/builds/slave/test', 05:14:52 INFO - 'SHELL': '/bin/bash', 05:14:52 INFO - 'SHLVL': '1', 05:14:52 INFO - 'TERM': 'linux', 05:14:52 INFO - 'TMOUT': '86400', 05:14:52 INFO - 'USER': 'cltbld', 05:14:52 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467893678.411107-1757343348', 05:14:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:52 INFO - '_': '/tools/buildbot/bin/python'} 05:14:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:52 INFO - Downloading/unpacking psutil>=3.1.1 05:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:14:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:14:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:14:54 INFO - Installing collected packages: psutil 05:14:54 INFO - Running setup.py install for psutil 05:14:54 INFO - building 'psutil._psutil_linux' extension 05:14:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:14:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:14:55 INFO - building 'psutil._psutil_posix' extension 05:14:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:14:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:14:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:14:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:14:55 INFO - Successfully installed psutil 05:14:55 INFO - Cleaning up... 05:14:55 INFO - Return code: 0 05:14:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:14:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xced030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfae180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfac3b0>, '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 0xfad2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfad740>, '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': '4ac8d263c7293b36a1be1aed000001be-1467893678.411107-1757343348', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:14:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:14:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:14:55 INFO - Using env: {'DISPLAY': ':0', 05:14:55 INFO - 'HOME': '/home/cltbld', 05:14:55 INFO - 'LANG': 'en_US.UTF-8', 05:14:55 INFO - 'LANGUAGE': 'en_US:en', 05:14:55 INFO - 'LOGNAME': 'cltbld', 05:14:55 INFO - 'MAIL': '/var/mail/cltbld', 05:14:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:55 INFO - 'MOZ_NO_REMOTE': '1', 05:14:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:55 INFO - 'NO_EM_RESTART': '1', 05:14:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:55 INFO - 'PWD': '/builds/slave/test', 05:14:55 INFO - 'SHELL': '/bin/bash', 05:14:55 INFO - 'SHLVL': '1', 05:14:55 INFO - 'TERM': 'linux', 05:14:55 INFO - 'TMOUT': '86400', 05:14:55 INFO - 'USER': 'cltbld', 05:14:55 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467893678.411107-1757343348', 05:14:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:55 INFO - '_': '/tools/buildbot/bin/python'} 05:14:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:14:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:14:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:14:57 INFO - Installing collected packages: mozsystemmonitor 05:14:57 INFO - Running setup.py install for mozsystemmonitor 05:14:57 INFO - Successfully installed mozsystemmonitor 05:14:57 INFO - Cleaning up... 05:14:57 INFO - Return code: 0 05:14:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:14:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xced030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfae180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfac3b0>, '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 0xfad2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfad740>, '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': '4ac8d263c7293b36a1be1aed000001be-1467893678.411107-1757343348', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:14:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:14:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:14:57 INFO - Using env: {'DISPLAY': ':0', 05:14:57 INFO - 'HOME': '/home/cltbld', 05:14:57 INFO - 'LANG': 'en_US.UTF-8', 05:14:57 INFO - 'LANGUAGE': 'en_US:en', 05:14:57 INFO - 'LOGNAME': 'cltbld', 05:14:57 INFO - 'MAIL': '/var/mail/cltbld', 05:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:57 INFO - 'MOZ_NO_REMOTE': '1', 05:14:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:57 INFO - 'NO_EM_RESTART': '1', 05:14:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:57 INFO - 'PWD': '/builds/slave/test', 05:14:57 INFO - 'SHELL': '/bin/bash', 05:14:57 INFO - 'SHLVL': '1', 05:14:57 INFO - 'TERM': 'linux', 05:14:57 INFO - 'TMOUT': '86400', 05:14:57 INFO - 'USER': 'cltbld', 05:14:57 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467893678.411107-1757343348', 05:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:57 INFO - '_': '/tools/buildbot/bin/python'} 05:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:57 INFO - Downloading/unpacking jsonschema==2.5.1 05:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:14:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:00 INFO - Downloading functools32-3.2.3-2.tar.gz 05:15:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:15:00 INFO - warning: no files found matching '*.txt' 05:15:00 INFO - no previously-included directories found matching 'build' 05:15:00 INFO - no previously-included directories found matching 'dist' 05:15:00 INFO - no previously-included directories found matching '.git*' 05:15:00 INFO - Installing collected packages: jsonschema, functools32 05:15:00 INFO - Running setup.py install for functools32 05:15:00 INFO - warning: no files found matching '*.txt' 05:15:00 INFO - no previously-included directories found matching 'build' 05:15:00 INFO - no previously-included directories found matching 'dist' 05:15:00 INFO - no previously-included directories found matching '.git*' 05:15:00 INFO - Successfully installed jsonschema functools32 05:15:00 INFO - Cleaning up... 05:15:00 INFO - Return code: 0 05:15:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:00 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 0xced030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfae180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfac3b0>, '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 0xfad2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfad740>, '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': '4ac8d263c7293b36a1be1aed000001be-1467893678.411107-1757343348', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:15:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:15:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:15:00 INFO - Using env: {'DISPLAY': ':0', 05:15:00 INFO - 'HOME': '/home/cltbld', 05:15:00 INFO - 'LANG': 'en_US.UTF-8', 05:15:00 INFO - 'LANGUAGE': 'en_US:en', 05:15:00 INFO - 'LOGNAME': 'cltbld', 05:15:00 INFO - 'MAIL': '/var/mail/cltbld', 05:15:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:00 INFO - 'MOZ_NO_REMOTE': '1', 05:15:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:00 INFO - 'NO_EM_RESTART': '1', 05:15:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:00 INFO - 'PWD': '/builds/slave/test', 05:15:00 INFO - 'SHELL': '/bin/bash', 05:15:00 INFO - 'SHLVL': '1', 05:15:00 INFO - 'TERM': 'linux', 05:15:00 INFO - 'TMOUT': '86400', 05:15:00 INFO - 'USER': 'cltbld', 05:15:00 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467893678.411107-1757343348', 05:15:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:00 INFO - '_': '/tools/buildbot/bin/python'} 05:15:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:00 INFO - Downloading/unpacking blobuploader==1.2.4 05:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:02 INFO - Downloading blobuploader-1.2.4.tar.gz 05:15:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:15:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:15:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:03 INFO - Downloading docopt-0.6.1.tar.gz 05:15:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:15:03 INFO - Installing collected packages: blobuploader, requests, docopt 05:15:03 INFO - Running setup.py install for blobuploader 05:15:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:15:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:15:03 INFO - Running setup.py install for requests 05:15:03 INFO - Running setup.py install for docopt 05:15:03 INFO - Successfully installed blobuploader requests docopt 05:15:03 INFO - Cleaning up... 05:15:03 INFO - Return code: 0 05:15:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:15: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')]} 05:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15: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')]} 05:15:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xced030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfae180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfac3b0>, '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 0xfad2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfad740>, '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': '4ac8d263c7293b36a1be1aed000001be-1467893678.411107-1757343348', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:15:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:15:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:15:03 INFO - Using env: {'DISPLAY': ':0', 05:15:03 INFO - 'HOME': '/home/cltbld', 05:15:03 INFO - 'LANG': 'en_US.UTF-8', 05:15:03 INFO - 'LANGUAGE': 'en_US:en', 05:15:03 INFO - 'LOGNAME': 'cltbld', 05:15:03 INFO - 'MAIL': '/var/mail/cltbld', 05:15:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:03 INFO - 'MOZ_NO_REMOTE': '1', 05:15:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:03 INFO - 'NO_EM_RESTART': '1', 05:15:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:03 INFO - 'PWD': '/builds/slave/test', 05:15:03 INFO - 'SHELL': '/bin/bash', 05:15:03 INFO - 'SHLVL': '1', 05:15:03 INFO - 'TERM': 'linux', 05:15:03 INFO - 'TMOUT': '86400', 05:15:03 INFO - 'USER': 'cltbld', 05:15:03 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467893678.411107-1757343348', 05:15:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:03 INFO - '_': '/tools/buildbot/bin/python'} 05:15:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:15:04 INFO - Running setup.py (path:/tmp/pip-RHYtpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:15:04 INFO - Running setup.py (path:/tmp/pip-jmMw0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:15:04 INFO - Running setup.py (path:/tmp/pip-e9TmG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:15:04 INFO - Running setup.py (path:/tmp/pip-CT80K2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:15:04 INFO - Running setup.py (path:/tmp/pip-njtTIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:15:04 INFO - Running setup.py (path:/tmp/pip-iyBtsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:15:04 INFO - Running setup.py (path:/tmp/pip-poZoFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:15:04 INFO - Running setup.py (path:/tmp/pip-JpTsW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:15:04 INFO - Running setup.py (path:/tmp/pip-oo5UNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:15:04 INFO - Running setup.py (path:/tmp/pip-grJatL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:15:04 INFO - Running setup.py (path:/tmp/pip-AJrc8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:15:04 INFO - Running setup.py (path:/tmp/pip-DnwG89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:15:04 INFO - Running setup.py (path:/tmp/pip-XkHEgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:15:05 INFO - Running setup.py (path:/tmp/pip-URIDRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:05 INFO - Running setup.py (path:/tmp/pip-SdDulD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:15:05 INFO - Running setup.py (path:/tmp/pip-t8o1Je-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:15:05 INFO - Running setup.py (path:/tmp/pip-enDSFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:15:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:15:05 INFO - Running setup.py install for manifestparser 05:15:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:15:05 INFO - Running setup.py install for mozcrash 05:15:05 INFO - Running setup.py install for mozdebug 05:15:05 INFO - Running setup.py install for mozdevice 05:15:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:15:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:15:05 INFO - Running setup.py install for mozfile 05:15:05 INFO - Running setup.py install for mozhttpd 05:15:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:15:05 INFO - Running setup.py install for mozinfo 05:15:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:15:06 INFO - Running setup.py install for mozInstall 05:15:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:15:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:15:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:15:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:15:06 INFO - Running setup.py install for mozleak 05:15:06 INFO - Running setup.py install for mozlog 05:15:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:15:06 INFO - Running setup.py install for moznetwork 05:15:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:15:06 INFO - Running setup.py install for mozprocess 05:15:06 INFO - Running setup.py install for mozprofile 05:15:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:15:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:15:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:15:06 INFO - Running setup.py install for mozrunner 05:15:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:15:06 INFO - Running setup.py install for mozscreenshot 05:15:06 INFO - Running setup.py install for moztest 05:15:06 INFO - Running setup.py install for mozversion 05:15:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:15:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:15:07 INFO - Cleaning up... 05:15:07 INFO - Return code: 0 05:15:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:15: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')]} 05:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15: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')]} 05:15:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:07 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 0xced030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfae180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfac3b0>, '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 0xfad2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfad740>, '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': '4ac8d263c7293b36a1be1aed000001be-1467893678.411107-1757343348', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:15:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:15:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:15:07 INFO - Using env: {'DISPLAY': ':0', 05:15:07 INFO - 'HOME': '/home/cltbld', 05:15:07 INFO - 'LANG': 'en_US.UTF-8', 05:15:07 INFO - 'LANGUAGE': 'en_US:en', 05:15:07 INFO - 'LOGNAME': 'cltbld', 05:15:07 INFO - 'MAIL': '/var/mail/cltbld', 05:15:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:07 INFO - 'MOZ_NO_REMOTE': '1', 05:15:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:07 INFO - 'NO_EM_RESTART': '1', 05:15:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:07 INFO - 'PWD': '/builds/slave/test', 05:15:07 INFO - 'SHELL': '/bin/bash', 05:15:07 INFO - 'SHLVL': '1', 05:15:07 INFO - 'TERM': 'linux', 05:15:07 INFO - 'TMOUT': '86400', 05:15:07 INFO - 'USER': 'cltbld', 05:15:07 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467893678.411107-1757343348', 05:15:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:07 INFO - '_': '/tools/buildbot/bin/python'} 05:15:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:15:07 INFO - Running setup.py (path:/tmp/pip-qSNBfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:15:07 INFO - Running setup.py (path:/tmp/pip-KSAIMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:15:07 INFO - Running setup.py (path:/tmp/pip-DEpH4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:15:07 INFO - Running setup.py (path:/tmp/pip-3VAUiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:15:07 INFO - Running setup.py (path:/tmp/pip-Zu6fJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:15:07 INFO - Running setup.py (path:/tmp/pip-GoLIt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:15:07 INFO - Running setup.py (path:/tmp/pip-qKu38o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:15:07 INFO - Running setup.py (path:/tmp/pip-x9BTXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:15:07 INFO - Running setup.py (path:/tmp/pip-VWSuwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:15:07 INFO - Running setup.py (path:/tmp/pip-SJ8NEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:15:08 INFO - Running setup.py (path:/tmp/pip-erEfW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:15:08 INFO - Running setup.py (path:/tmp/pip-UfVWCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:15:08 INFO - Running setup.py (path:/tmp/pip-kjg8gi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:15:08 INFO - Running setup.py (path:/tmp/pip-uWg8Lr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:08 INFO - Running setup.py (path:/tmp/pip-xrSlOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:15:08 INFO - Running setup.py (path:/tmp/pip-jY86Zl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:15:08 INFO - Running setup.py (path:/tmp/pip-J_vcAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:15:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:10 INFO - Downloading blessings-1.6.tar.gz 05:15:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:15:10 INFO - Installing collected packages: blessings 05:15:10 INFO - Running setup.py install for blessings 05:15:10 INFO - Successfully installed blessings 05:15:10 INFO - Cleaning up... 05:15:10 INFO - Return code: 0 05:15:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:15:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:15:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:15:10 INFO - Reading from file tmpfile_stdout 05:15:10 INFO - Current package versions: 05:15:10 INFO - argparse == 1.2.1 05:15:10 INFO - blessings == 1.6 05:15:10 INFO - blobuploader == 1.2.4 05:15:10 INFO - docopt == 0.6.1 05:15:10 INFO - functools32 == 3.2.3-2 05:15:10 INFO - jsonschema == 2.5.1 05:15:10 INFO - manifestparser == 1.1 05:15:10 INFO - mozInstall == 1.12 05:15:10 INFO - mozcrash == 0.17 05:15:10 INFO - mozdebug == 0.1 05:15:10 INFO - mozdevice == 0.48 05:15:10 INFO - mozfile == 1.2 05:15:10 INFO - mozhttpd == 0.7 05:15:10 INFO - mozinfo == 0.9 05:15:10 INFO - mozleak == 0.1 05:15:10 INFO - mozlog == 3.2 05:15:10 INFO - moznetwork == 0.27 05:15:10 INFO - mozprocess == 0.23 05:15:10 INFO - mozprofile == 0.28 05:15:10 INFO - mozrunner == 6.12 05:15:10 INFO - mozscreenshot == 0.1 05:15:10 INFO - mozsystemmonitor == 0.3 05:15:10 INFO - moztest == 0.7 05:15:10 INFO - mozversion == 1.4 05:15:10 INFO - psutil == 3.1.1 05:15:10 INFO - requests == 1.2.3 05:15:10 INFO - wsgiref == 0.1.2 05:15:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:15: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')]} 05:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15: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')]} 05:15:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xced030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfae180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfac3b0>, '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 0xfad2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfad740>, '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': '4ac8d263c7293b36a1be1aed000001be-1467893678.411107-1757343348', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:15:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:15:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:15:10 INFO - Using env: {'DISPLAY': ':0', 05:15:10 INFO - 'HOME': '/home/cltbld', 05:15:10 INFO - 'LANG': 'en_US.UTF-8', 05:15:10 INFO - 'LANGUAGE': 'en_US:en', 05:15:10 INFO - 'LOGNAME': 'cltbld', 05:15:10 INFO - 'MAIL': '/var/mail/cltbld', 05:15:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:10 INFO - 'MOZ_NO_REMOTE': '1', 05:15:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:10 INFO - 'NO_EM_RESTART': '1', 05:15:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:10 INFO - 'PWD': '/builds/slave/test', 05:15:10 INFO - 'SHELL': '/bin/bash', 05:15:10 INFO - 'SHLVL': '1', 05:15:10 INFO - 'TERM': 'linux', 05:15:10 INFO - 'TMOUT': '86400', 05:15:10 INFO - 'USER': 'cltbld', 05:15:10 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467893678.411107-1757343348', 05:15:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:10 INFO - '_': '/tools/buildbot/bin/python'} 05:15:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:15:11 INFO - Cleaning up... 05:15:11 INFO - Return code: 0 05:15:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:15: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')]} 05:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15: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')]} 05:15:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:11 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 0xced030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfae180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfac3b0>, '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 0xfad2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfad740>, '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': '4ac8d263c7293b36a1be1aed000001be-1467893678.411107-1757343348', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:15:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:15:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:15:11 INFO - Using env: {'DISPLAY': ':0', 05:15:11 INFO - 'HOME': '/home/cltbld', 05:15:11 INFO - 'LANG': 'en_US.UTF-8', 05:15:11 INFO - 'LANGUAGE': 'en_US:en', 05:15:11 INFO - 'LOGNAME': 'cltbld', 05:15:11 INFO - 'MAIL': '/var/mail/cltbld', 05:15:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:11 INFO - 'MOZ_NO_REMOTE': '1', 05:15:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:11 INFO - 'NO_EM_RESTART': '1', 05:15:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:11 INFO - 'PWD': '/builds/slave/test', 05:15:11 INFO - 'SHELL': '/bin/bash', 05:15:11 INFO - 'SHLVL': '1', 05:15:11 INFO - 'TERM': 'linux', 05:15:11 INFO - 'TMOUT': '86400', 05:15:11 INFO - 'USER': 'cltbld', 05:15:11 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467893678.411107-1757343348', 05:15:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:11 INFO - '_': '/tools/buildbot/bin/python'} 05:15:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:15:11 INFO - Cleaning up... 05:15:11 INFO - Return code: 0 05:15:11 INFO - Running post-action listener: _resource_record_post_action 05:15:11 INFO - Running post-action listener: _start_resource_monitoring 05:15:11 INFO - Starting resource monitoring. 05:15:11 INFO - ##### 05:15:11 INFO - ##### Finished create-virtualenv step (success) 05:15:11 INFO - ##### 05:15:11 INFO - ##### 05:15:11 INFO - ##### Running install step. 05:15:11 INFO - ##### 05:15:11 INFO - Running pre-action listener: _resource_record_pre_action 05:15:11 INFO - Running main action method: install 05:15:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:15:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:15:11 INFO - Reading from file tmpfile_stdout 05:15:11 INFO - Detecting whether we're running mozinstall >=1.0... 05:15:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:15:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:15:11 INFO - Reading from file tmpfile_stdout 05:15:11 INFO - Output received: 05:15:11 INFO - Usage: mozinstall [options] installer 05:15:11 INFO - Options: 05:15:11 INFO - -h, --help show this help message and exit 05:15:11 INFO - -d DEST, --destination=DEST 05:15:11 INFO - Directory to install application into. [default: 05:15:11 INFO - "/builds/slave/test"] 05:15:11 INFO - --app=APP Application being installed. [default: firefox] 05:15:11 INFO - mkdir: /builds/slave/test/build/application 05:15:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:15:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:15:28 INFO - Reading from file tmpfile_stdout 05:15:28 INFO - Output received: 05:15:28 INFO - /builds/slave/test/build/application/firefox/firefox 05:15:28 INFO - Running post-action listener: _resource_record_post_action 05:15:28 INFO - ##### 05:15:28 INFO - ##### Finished install step (success) 05:15:28 INFO - ##### 05:15:28 INFO - ##### 05:15:28 INFO - ##### Running run-tests step. 05:15:28 INFO - ##### 05:15:28 INFO - Running pre-action listener: _resource_record_pre_action 05:15:28 INFO - Running main action method: run_tests 05:15:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:15:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:15:28 INFO - Python 2.7.3 05:15:28 INFO - Return code: 0 05:15:28 INFO - grabbing minidump binary from tooltool 05:15:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:28 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfac3b0>, '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 0xfad2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfad740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:15:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:15:28 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:15:28 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:15:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:15:28 INFO - Return code: 0 05:15:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:15:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:15:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:15:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:15:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:15:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HEpUDLoPQc6smYc9c1KV4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:15:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HEpUDLoPQc6smYc9c1KV4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:15:28 INFO - Using env: {'DISPLAY': ':0', 05:15:28 INFO - 'HOME': '/home/cltbld', 05:15:28 INFO - 'LANG': 'en_US.UTF-8', 05:15:28 INFO - 'LANGUAGE': 'en_US:en', 05:15:28 INFO - 'LOGNAME': 'cltbld', 05:15:28 INFO - 'MAIL': '/var/mail/cltbld', 05:15:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:15:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:15:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:28 INFO - 'MOZ_NO_REMOTE': '1', 05:15:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:15:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:28 INFO - 'NO_EM_RESTART': '1', 05:15:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:28 INFO - 'PWD': '/builds/slave/test', 05:15:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:15:28 INFO - 'SHELL': '/bin/bash', 05:15:28 INFO - 'SHLVL': '1', 05:15:28 INFO - 'TERM': 'linux', 05:15:28 INFO - 'TMOUT': '86400', 05:15:28 INFO - 'USER': 'cltbld', 05:15:28 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467893678.411107-1757343348', 05:15:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:28 INFO - '_': '/tools/buildbot/bin/python'} 05:15:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HEpUDLoPQc6smYc9c1KV4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:15:29 INFO - mozversion application_buildid: 20160707023025 05:15:29 INFO - mozversion application_changeset: fa4355015e36065e83c1683023c661e5dd60e8ba 05:15:29 INFO - mozversion application_display_name: Nightly 05:15:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:15:29 INFO - mozversion application_name: Firefox 05:15:29 INFO - mozversion application_remotingname: firefox 05:15:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:15:29 INFO - mozversion application_vendor: Mozilla 05:15:29 INFO - mozversion application_version: 50.0a1 05:15:29 INFO - mozversion platform_buildid: 20160707023025 05:15:29 INFO - mozversion platform_changeset: fa4355015e36065e83c1683023c661e5dd60e8ba 05:15:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:15:29 INFO - mozversion platform_version: 50.0a1 05:15:29 INFO - using testdate: 1467893729 05:15:29 INFO - actual date: 1467893729 05:15:29 INFO - starting webserver on 'localhost:55947' 05:15:29 INFO - SUITE-START | Running 2 tests 05:15:29 INFO - TEST-START | dromaeo_css 05:15:29 INFO - operating with platform_type : linux_ 05:15:29 INFO - Initialising browser for dromaeo_css test... 05:15:29 INFO - TEST-INFO | started process 27724 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU34X5g/profile http://localhost:55947/getInfo.html) 05:15:32 INFO - PROCESS | 27724 | __metrics Screen width/height:1600/1200 05:15:32 INFO - PROCESS | 27724 | colorDepth:24 05:15:32 INFO - PROCESS | 27724 | Browser inner width/height: 1024/697 05:15:32 INFO - PROCESS | 27724 | __metrics 05:15:33 INFO - PROCESS | 27724 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:15:34 INFO - TEST-INFO | 27724: exit 0 05:15:34 INFO - Browser initialized. 05:15:34 INFO - Running cycle 1/1 for dromaeo_css test... 05:15:34 INFO - TEST-INFO | started process 27810 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU34X5g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:15:46 INFO - PROCESS | 27810 | RSS: Main: 157216768 05:15:46 INFO - PROCESS | 27810 | 05:16:37 INFO - PROCESS | 27810 | 1467893797900 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:18:45 INFO - PROCESS | 27810 | Cycle 1(1): loaded http://localhost:55947/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55947/tests/dromaeo/cssquery-ext.html) 05:18:46 INFO - PROCESS | 27810 | RSS: Main: 253296640 05:18:46 INFO - PROCESS | 27810 | 05:21:49 INFO - PROCESS | 27810 | Cycle 1(1): loaded http://localhost:55947/tests/dromaeo/cssquery-ext.html (next: http://localhost:55947/tests/dromaeo/cssquery-jquery.html) 05:21:49 INFO - PROCESS | 27810 | RSS: Main: 235016192 05:21:49 INFO - PROCESS | 27810 | 05:24:51 INFO - PROCESS | 27810 | Cycle 1(1): loaded http://localhost:55947/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55947/tests/dromaeo/cssquery-mootools.html) 05:24:52 INFO - PROCESS | 27810 | RSS: Main: 246841344 05:24:52 INFO - PROCESS | 27810 | 05:27:54 INFO - PROCESS | 27810 | Cycle 1(1): loaded http://localhost:55947/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55947/tests/dromaeo/cssquery-prototype.html) 05:27:55 INFO - PROCESS | 27810 | RSS: Main: 241606656 05:27:55 INFO - PROCESS | 27810 | 05:30:57 INFO - PROCESS | 27810 | Cycle 1(1): loaded http://localhost:55947/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55947/tests/dromaeo/cssquery-yui.html) 05:30:58 INFO - PROCESS | 27810 | RSS: Main: 225660928 05:30:58 INFO - PROCESS | 27810 | 05:34:01 INFO - PROCESS | 27810 | Cycle 1(1): loaded http://localhost:55947/tests/dromaeo/cssquery-yui.html (next: http://localhost:55947/tests/dromaeo/cssquery-dojo.html) 05:34:01 INFO - PROCESS | 27810 | RSS: Main: 276508672 05:34:01 INFO - PROCESS | 27810 | 05:34:01 INFO - PROCESS | 27810 | __start_tp_report 05:34:01 INFO - PROCESS | 27810 | _x_x_mozilla_page_load 05:34:01 INFO - PROCESS | 27810 | _x_x_mozilla_page_load_details 05:34:01 INFO - PROCESS | 27810 | |i|pagename|runs| 05:34:01 INFO - PROCESS | 27810 | |0;dojo.html;3043.376107897881;3064.4024415239037;3088.1507585413992;3088.9073327800165;3107.3940581586585;5179.041877252711;5230.73846307685;5272.762725677344;5284.762185701643;5291.576673866086;5251.894962100756;5261.2371206175085;5271.762770675329;5272.789088436458;5283.709395983219;4770.141374552588;4860.878478038042;4863.829765958192;4869.610431165516;5031.924521132168;4928.901421971558;4940.283658869462;4953.702777833323;5004.549590536851;5024.296598476216;4782.04359128174;4797.736124513151;4798.1123492154065;4821.083994041121;4873.658843880948;4858.076965376567;4858.587020103296;4859.368282123337;4863.8297659582095;4902.3626928499425;4774.80900763969;4807.591354734852;4831.855044348676;4847.878803029917;4875.561199492063;5288.365396152486;5375.569954403638;5384.730763461811;5454.672719636835;5458.1266997280645;5826.708664566797;5827.562932780016;5850.736716847752;5853.0635098384055;5862.97068514659;5616.1014237721765;5696.145578163268;5750.05124154514;5789.8263052108505;5791.478766910956;5347.572194224453;5470.234167216593;5470.56235501163;5470.972645136789;5473.0969390050595;5944.227250457413;5955.642661440327;5961.046232602763;5962.075878238793;5962.3739507351975;5496.203050557647;5557.221988921554;5618.97190514053;5737.254156959569;5746.9425305747245;5736.77052917887;5737.3688894221605;5779.797707080232;5789.421057894261;5789.623674461147;5663.235463212496;5726.141078838207;5729.684867332254;5734.598578099493;5767.913481297784;5519.834404967857;5575.386707462176;5609.8597535061135;5625.774969001194;5735.942640573624;4334.653227741773;4336.848210312624;4337.414449049401;4338.262495375794;4373.781310934441;3868.323043467382;3886.067343837459;3894.201688653819;3914.9608503914596;3921.156951255494;5278.366596008426;5285.709285989307;5322.760475778599;5351.545118664957;5362.731863406814;5631.1271752878365;5644.604877658607;5648.096304591328;5652.208690783294;5690.260266165455;5381.704006279692;5390.029794637003;5401.891962160814;5404;5406.104629468364;4799.616030717534;4801.063792560487;4844.079624871263;4890.926636100461;4959.454460009396;5901.3508514063415;5902.468777810018;5904.822855314347;5909.852253693692;5911;5674.347450043298;5678.574106941914;5681.204631351531;5681.744321505459;5685.829425117253;5731.283589551306;5752.741126649395;5754.942450575608;5756.366799652119;5811.360750317546;5469.453054694499;5506.504414602705;5507.146392309199;5512.3385193777;5512.751926163252;5471.343438787371;5609.242752228397;5620.044592419216;5625.409332020243;5625.943740562542;5500.862478438071;5567;5567.693776842312;5597.832065038056;5603.10350343943;5559.805406810742;5571.359293681278;5572.331320241597;5573.136163894603;5591.384947655836;5394.298741163623;5454.699991500505;5523.7790488380015;5540.141278101901;5591.524720398812;5576.442355764391;5643.633163844337;5646.887062258814;5691.203231547669;5692.743826527899;5497.147942068986;5505.862353441196;5512.641678290898;5513.641613295123;5518.365387980273 05:34:01 INFO - PROCESS | 27810 | |1;ext.html;571.7941541045226;601.2094096263414;615.9014557670772;626.4549841637776;628.3151365012142;31584.52623210651;34157.82921085391;34181.82909085454;34190.145246368855;42815.3577696334;40755;45025.32462013073;45103;45168.0966380673;45186.54813451864;8801.5159166246;8926.687565935194;8964.50695211763;8966.327525435618;8968.730938071836;8950.552472376388;9033.141851524128;9033.638654453815;9040.321975851804;9043.95478022609;9011.008789033202;9068.773280668003;9080.364374493787;9081.727548173532;9084.227840633554;8974.730758077269;9002.05478424769;9017.954910225473;9019.143181397789;9023.413478123934;8928.24109950655;8976.685815996474;8985.23625491834;8991.100889911022;8996.910030899739;42895;43311;43316.56683433157;43407.78296108531;43423;3645.2345007548447;3687.612800655946;3698.9630103698887;3759.0790256387086;3785.356489396809;31503.212419689462;31791.364172716647;33251.5012274816;34316.48525272123;35187.1203219919;4180.916381672349;4205.97897010516;4230.725002874803;4260.7656578888145;4408.515063343029;345970;353018;353264;354043;354355;63977;64092.35907640864;64731.676341618935;64746;64794.35205647977;36671.449928251095;37564.62435375611;37816.43275350872;68714.3128568718;68812.31187688159;17502.649947000988;17606.383776568015;17648.117594120242;17655.293788248582;17671.73492397615;13570.117942333716;13679.726405472034;13686.93156534231;13708.93145534266;13726.45094196221;20526.178952841718;20542.79457205409;20628.484287892923;20692.172313107607;20757.584848302948;7631.122420921554;7678.155402905676;7726.420518461138;7768.912352270687;7781.961090194626;992.3797626483448;1064.3932958213743;1073.4203530093819;1077.1221454514546;1136.3522792008475;31645.683543164734;31656;31708.524372134438;31721.524177137362;32055.679443205736;1090.1061129873428;1092.5138313450439;1127.9661610151709;1149.40231079838;1239.0892693869998;16637.33450661984;16715.331386744394;16858.32566697343;17002;17019.574510637332;446872;450618;451123;452039;454411;54648.45351546513;55956;56040.159397609066;56177.719111405;56201.43798561962;1200.9071744712269;1293.8188653588504;1316.3484075382555;1337.8662133786543;1346.7441186174594;32027.35945281128;33772;33890.43593486079;34000.31999360048;34358;49444.50555494543;49510.257346139115;49981.50018499768;50016.49983500118;50120;402374;403952;403981;404572;405551;25408.364790880376;27985.44029119447;28623.856880715462;29088;29826.403471930007;46235.53764462447;47401.52598473971;47530.52469475399;48089.75955120202;48921;41377.1724565513;41936;41937.79031104947;42983;43602;41413;41779.164416712105;41877.581224187365;42612.5738742621;42855.785721071195;40714.59285407227;41534;41829;42108.57891421169;42161.156776863674;36042.27915441729;36736.26527469382;36995.815020924725;37505.98181528124;37732;27889.58165627558;27900.4654743991;28083;28221.43557128887;28284.85857570699 05:34:01 INFO - PROCESS | 27810 | |2;jquery.html;380.1503639366017;382.7684251028126;396.5202105452402;406.4614385938632;406.6401234907106;18058.5485362866;20524.58950820983;20560.588788224228;20821.06305216265;20841.583168336623;19314.32399866005;19878.403647890587;20187.999999999964;20237.089330980103;20338.59322813543;5683.658980461186;5742.28221472316;5770.47432410419;5871.207387002764;5882.14708867214;4132.152908653734;6171.321154672983;6459.709313080899;6466.159399278087;6567.835804104888;6287.559870809046;6495.610263384212;6499.772507962222;6539.869202615945;6540.672966351687;6494.5453818232745;6510.609363438209;6514.967425162868;6541.280459149513;6545;3767.943480847762;5292.708901010443;5632.3804381518;5641.238432811559;5700.572457065695;23800.40498987539;23929.28212153621;24020.519589608284;24418.145364912143;24474;2428.89069991849;2491;2619.0964117379663;2620.1615483045434;2696.6089916961932;14100.85899141016;14984.850151498564;15306;15312.693746125015;15542.300596473073;1926.5280006398382;1971.9605607887906;1996.5407956170018;2016.2942969960543;2043.5606344635974;77732;78500;79048.83804647808;79643.6017819913;81654;10578.735531611617;10590.947045264724;10661.093807026335;10847.566097356017;11117.777644447066;15158.772618410732;15197.848021519865;15267.770983435257;15274.389024438899;15298.694026119416;8411.45325553837;8541.743747687578;8622.706594010948;8662.263707584925;8858.11418858109;8214.480321140609;8280.958595206985;8293.502389856629;8396.706115285935;8794.516301603473;6022.608530445507;6729.1252137221845;6809.897851532231;6811.829704257334;6817.556858804261;1781.4210381626024;1927.4410420977758;1946.1534232608578;1975.9703604445945;2012.7282816819834;937.8827646544182;1023.7389465686202;1037.9221558383001;1099.6961365938346;1100.7269987475836;19379.224831006883;19393.4181974541;20324.288649897182;20573.382798516068;20610.07254673543;992.1595440457991;1008.3949630221808;1026.2457094035879;1036.6112707734599;1044.216837371971;10641.787164256672;11516.769664606662;11597.420128993685;11690.123240756977;11732.296062236293;363952;472054;491399;491859;495038;97362;101488;102203;102542;102747;994.3586386780486;1015.8679371681486;1030.2221822524095;1031.582209205273;1033.6743925663393;18330;18688.25246990105;19219.558533109794;19276.710849336992;19484;39161.608383915795;40231.79884100678;43474.130517390106;43909.78045109754;44766.3285050731;52810.207846883095;54006;54349.18476222781;54661.72669136629;55013.72493137669;8293.170682931659;8411.731051466186;8465.195806398382;8796.208341249318;8885.600147993226;12012.279263244232;14164.220967846455;14303.713925721218;14430.350634221275;14538.781918271023;11986.520539178335;12106.878931210575;12332.938335308267;12451.315177665316;12526.185797923106;11961.521539138337;12071.336076515525;12277.75444491123;12297.50809967627;12515.374231288217;12192.085593580694;12212.145149839425;12593.118481706193;12708.555200568306;12890.585953899197;8572.27135693473;8743.256823170103;9110.088991101102;12006.819897701367;13448;12233.632991010283;12769.174151324185;13288.734225315633;13654;13777.793333100211 05:34:01 INFO - PROCESS | 27810 | |3;mootools.html;1366.071071671263;1495.8055452791139;1537.715522628314;1643.55623981525;1810.9637807243855;8448.408611397204;8924.419912705678;8934.195922366986;9130.771730706736;9155.587998540064;8877.334199935014;9094.181523662868;9095.454272743624;9096.181343679067;9101.63593456261;2016.8689035212665;2241.450844543085;2287.256641591481;2288.794008539231;2381.226101517014;2395.700537432821;2395.988020059906;2410.457647029422;2411.8311718179734;2412.445137618349;2339.555484457956;2345.812335013195;2371.8576885386847;2376.3821406434276;2383.5709572276983;1959.1183967214738;2195.3523710505438;2246.988765056164;2248.9662655060188;2251.538434620907;2255.515064261175;2257.1761307122947;2274.3404412720292;2275.192306731103;2277.8177745780463;9027.368084234105;9077.636894524278;9093.363464557484;9096.954515227448;9102.954485227598;5036.748162591893;5127.974360128175;5133.589312854962;5146.897062058775;5152.458991805844;3287.819169945652;3333;3472.73954453417;3496.3531746626954;3517.7009954153928;1067.7864427114607;1070.4861666400093;1078.396098185019;1085.2240647936685;1093.0272057868503;12674.80987785184;12717.872821271761;12733.172343797716;12736.363181840963;12747.171433856769;4446.088551846864;4511.954880451219;4655.278431843002;4686.554777296152;4692.577668009895;10686.305390149615;10697.786044279072;10715.892841071645;10718.517666705016;10718.678439646823;5311.017461769585;5320.042392369411;5324.973375133177;5327.227552005015;5333.200019996954;4204.411382406465;4732.337472753818;4865.391826021747;4867.977724677787;4905.583025442877;3926.155876486512;3934.685225182036;4020.336644453691;4109.8972525687095;4174.165166966619;1109.1237922041496;1191.2733232728028;1231.950721971129;1253.486070711004;1270.4600544768437;974.2060220919927;993.4188499727741;1007.5012868630075;1010.8180527505119;1025.7538190834146;6159.137720719103;6286.685665716787;6344.175257216532;6364.236291645032;6445.806625801233;996.2030375699411;1007.6725064354114;1013.554036224059;1021.877374715039;1026.9743256418649;4354.716943398669;4402.713823601455;4405.581469760367;4413.558644135561;4443.2224360736745;10758.892411075945;11012.50443730034;11405.714857128472;11408.258463199865;11476.426178691032;11126.221164518567;11272.323660580227;11285.774284514264;11386.08911287095;11419.200655954004;8188.877166842502;8348.165183481724;8361.289290410383;8376.916230837614;8393.706220282384;6214.223222097238;6393.849107160756;6437.967810160919;6569.638669873012;6588.242352129567;9932.801343973224;10273.126784223126;10660.200484963814;10691.358518488605;10704.30422022566;10202.591896324064;10575.735606609896;10589.417582033062;10617;10681.839772403264;8022.679092836222;8113.472624279639;8175.059868115005;8182.918170818216;8192.30365418946;8790.91209087901;8830.911690883266;8891.555422228734;8898.110188981309;8900.287976961697;6433.935660643521;7941.761747147595;8074.555899425588;8248.216419440143;8254.215849494289;7954.363650908029;7965.761027169194;8093.150219227132;8236.39390318882;8265.46274492156;6785;6998.510104292651;7006.789796306119;7051.541649792747;7138.321859423347;5437.673739575638;5437.782488700408;5496.203050557567;5513.751881165437;5545.889082218414;5537.833864984057;5543.172981779241;5682.6306290091015;5695.917775622618;5747.827565173052 05:34:01 INFO - PROCESS | 27810 | |4;prototype.html;295.9807612505188;298.84609426145533;305.1638510481282;311.7194524927565;319.24020830423586;5339.439358867321;5391.272178255935;5393.838184854456;5402.91895621566;5430.619856610039;5005.374328208974;5097.7196254206;5259.6055295852775;5262.736863156846;5270.683758974455;4108.5686002969705;4166.187593419269;4201.894952626179;4208.936865947013;4211.305134652778;4208.789560521977;4210.157968406315;4211.599898009699;4220.683448741342;4222.9577704222875;3951.5060617422823;3987.8006099695044;4172.269852775752;4176.686748493875;4184.058586817972;4164.104717485755;4171.791410429466;4190.413342132104;4191.308434108369;4196.916061678765;3686.096906257984;3686.7234957378037;3706.110533471974;3711.870084547028;3722.8883133506038;5081.136206844845;5112.156494178456;5131.923021154686;5151.819686310999;5165.276861239429;4750.809967601292;4765.166095933232;4778.761061946889;4781.784819683123;4785.784639691187;5511.614187006911;5514.200440936082;5526.143447765603;5549.639273447213;5553.527950124244;3895.6721919854085;4013.9397909031386;4028.2144981728575;4028.879133625996;4037.5154981402125;5662.348829884533;5697.857553561153;5698.772049118031;5702.173184888168;5702.201691763156;4096.446979657768;4099.159672267178;4118.546959834416;4132.470985735237;4146.896327591834;4079.347304431277;4135.60711732385;4180.623743863067;4195.538490766014;4195.685323600742;4670.462896766848;4717.8112875485285;4726.338312636233;4726.692764970266;4738.8341408050555;5563.805266815642;5567.415421380778;5583.933944440501;5597.944020559742;5609.382967873531;1363.6659018540522;1371.403439503819;1413.5476647472915;1433.1186320412871;1440.2366745624836;937.920276776468;960.5437417226761;962.7544976031068;972.1250874213265;1003.9046290602381;5366.597505187126;5367.75845086972;5380.569554435636;5386.218998245311;5407.972960135253;5608.775648973995;5716.1997320375185;5722.141678748138;5732.914006289909;5762.164486149569;5314.468553144655;5318.627696061239;5367.194920761917;5372.91940620891;5393.867287869592;2967.629046369204;2994.7454466370605;2998.4752668282963;3000.159955212544;3002.759779217701;5577.498025177753;5764.798232061858;5809.215755872988;5813.76744930198;5857.26784151981;5699.173619825185;5703.9429605704245;5710.487385550345;5720.599558030898;5727.226824378656;5761.9135712964335;5805.477507024388;5806.506446951972;5807.0998995155815;5848.970755146197;5350.732463376893;5579.442055794388;5584.972075139761;5603.635763675348;5617.915731264116;5568.916466252928;5582.49757521825;5598.1602759586385;5601.579881508822;5625.437456254342;5637.238972738628;5799.681017543907;5803.535717142534;5880.294364676095;5984;3976.4830572025453;4004.519457665099;4009.7995100245453;4021.819018144249;4030.314846476165;5806.535477161732;5814.273215848019;5823.097419899922;5828.271466066742;5843.532517398683;5231.136862417658;5508.504234618904;5559.471850174227;5676.4323567642905;5692.8576785579035;5528.419515950767;5551.778608706079;5561.303802340325;5564.888702225851;5575.9163612545035;5292.285541452009;5331.8939019086465;5435.809746658848;5461.399246082849;5562.471565201299;5561.777528898961;5569.136783798518;5582.525485333792;5583.469570390806;5587.804426845041;5215.6609820361555;5451.48210919962;5460.918086228789;5491.28613280271;5495.175723641486 05:34:01 INFO - PROCESS | 27810 | |5;yui.html;785.6464590934081;786.5005721366933;826.3926014379431;845.2730651639592;859.3726579596893;15940.52178434646;16842.83157168428;17027.57431064224;17031.659366812655;17080.145992700378;14346.856531434683;15372.308246128923;15383.461578844743;15387.38450461983;15407.07557546548;672.3847679373392;817.3992115794871;820.0200760091693;820.1962077164383;820.2904487618227;805.5368163306093;838.6016642094986;839.102160688064;842.2588122452264;844.8986121665378;863.1756672377895;871.3987348729388;872.9127087291283;874.2001069021837;875.3434923807145;702.7680865314434;721.2679130682361;869.2698133567802;877.4735158904638;878.1350369885657;523.9842804715864;612.6385432594745;631.1763149090435;632.7785275153706;633.6863252689902;14406.06360586569;14500.637484062878;14658.63353416173;14719.632009199855;14767.187804670739;14600.707985840223;14692.48576299835;14707.779383309258;14762.926185369111;14810.111393316327;13038.478460861554;13168.27574483403;13372;13434.664133396744;13660;4648.186567350734;4708.552687494683;4727.149113159629;4776.904461910743;4864.01308506289;76938;77628.61185694035;78052;78277;78946.4474098667;11098.667039988813;11163.888361116447;11181.44092795357;11494.42527873603;11536.134789890792;20391.694124588143;20460.079296431697;22132.114715411524;22208.11167553312;22217.333479995625;8783.956080219557;8805.867911981326;8807.251383632334;8871.379003469696;8880.73357799267;4767.523247675204;4777.450593181759;4792.329073929653;4892.951070489249;4956.844016615618;3319.966800332014;3417.4873768934362;3418.9658103419147;3420.931581368359;3424.126847653832;581.8458108601224;590.8581940334288;591.0572636644545;599.9770391482512;599.9850003749941;646.3956200952125;662.3310456438935;693.6185098196073;731.3600599475459;746.4364404874393;9705.660301889542;9900.653477128266;9922.404655720535;10189.54147063384;10270.435126067989;651.5048563092084;704.3097764191122;710.6127160697432;713.653877869233;713.8144082538578;4870.245112007645;5029.924551131736;5044.268581055726;5091.2363145527725;5142.434332223453;116240.41879790547;116436.41781791036;117137;122221;122225;105264;105754;107073;108805.20753132098;109200.4539977295;74364.25635743681;75609.24390756022;76365;76551;89608.55195723979;10157.492125393848;10381.896181038093;10506.789864202521;10543.15654747603;10553.577856885639;44031.559684402746;44374;50187;51204.743976281374;52519;72746.63626681833;73079.63460182665;76771.61614191893;77564;79465.60267198627;13515.189088654712;13770.862291376958;13850.30748462593;14049.648758781112;14312.06971546846;14717.95484886538;15786.289616967035;15901.581160050644;16036.759448608513;16596.087215202795;14575.562733118024;14641.197115122819;15005.699886002438;15416.152111633968;15595.688086237984;14795.556133316019;14835.554933352018;15234.238288085773;15521.37914483408;15541.766873497132;14228.430862765374;14392.784108238175;14549.523234283664;14810.555683329518;15293.694126117192;10882.455877206266;10902.400367979837;11113.277636953571;11239.887601124212;11255.155863310449;12246.07807460525;12297;12489.375531223584;12775.23348599087;12841.229526228457 05:34:01 INFO - PROCESS | 27810 | __end_tp_report 05:34:01 INFO - PROCESS | 27810 | __start_cc_report 05:34:01 INFO - PROCESS | 27810 | _x_x_mozilla_cycle_collect,801 05:34:01 INFO - PROCESS | 27810 | __end_cc_report 05:34:01 INFO - PROCESS | 27810 | __startTimestamp1467894841647__endTimestamp 05:34:01 INFO - PROCESS | 27810 | 05:34:01 INFO - PROCESS | 27810 | ------- Summary: start ------- 05:34:01 INFO - PROCESS | 27810 | Number of tests: 6 05:34:01 INFO - PROCESS | 27810 | 05:34:01 INFO - PROCESS | 27810 | [#0] dojo.html Cycles:165 Average:5296.20 Median:5505.86 stddev:602.07 (10.9%) stddev-sans-first:577.40 05:34:01 INFO - PROCESS | 27810 | Values: 3043.4 3064.4 3088.2 3088.9 3107.4 5179.0 5230.7 5272.8 5284.8 5291.6 5251.9 5261.2 5271.8 5272.8 5283.7 4770.1 4860.9 4863.8 4869.6 5031.9 4928.9 4940.3 4953.7 5004.5 5024.3 4782.0 4797.7 4798.1 4821.1 4873.7 4858.1 4858.6 4859.4 4863.8 4902.4 4774.8 4807.6 4831.9 4847.9 4875.6 5288.4 5375.6 5384.7 5454.7 5458.1 5826.7 5827.6 5850.7 5853.1 5863.0 5616.1 5696.1 5750.1 5789.8 5791.5 5347.6 5470.2 5470.6 5471.0 5473.1 5944.2 5955.6 5961.0 5962.1 5962.4 5496.2 5557.2 5619.0 5737.3 5746.9 5736.8 5737.4 5779.8 5789.4 5789.6 5663.2 5726.1 5729.7 5734.6 5767.9 5519.8 5575.4 5609.9 5625.8 5735.9 4334.7 4336.8 4337.4 4338.3 4373.8 3868.3 3886.1 3894.2 3915.0 3921.2 5278.4 5285.7 5322.8 5351.5 5362.7 5631.1 5644.6 5648.1 5652.2 5690.3 5381.7 5390.0 5401.9 5404.0 5406.1 4799.6 4801.1 4844.1 4890.9 4959.5 5901.4 5902.5 5904.8 5909.9 5911.0 5674.3 5678.6 5681.2 5681.7 5685.8 5731.3 5752.7 5754.9 5756.4 5811.4 5469.5 5506.5 5507.1 5512.3 5512.8 5471.3 5609.2 5620.0 5625.4 5625.9 5500.9 5567.0 5567.7 5597.8 5603.1 5559.8 5571.4 5572.3 5573.1 5591.4 5394.3 5454.7 5523.8 5540.1 5591.5 5576.4 5643.6 5646.9 5691.2 5692.7 5497.1 5505.9 5512.6 5513.6 5518.4 05:34:01 INFO - PROCESS | 27810 | 05:34:01 INFO - PROCESS | 27810 | [#1] ext.html Cycles:180 Average:56925.71 Median:41656.58 stddev:106639.05 (256.0%) stddev-sans-first:106854.26 05:34:01 INFO - PROCESS | 27810 | Values: 571.8 601.2 615.9 626.5 628.3 31584.5 34157.8 34181.8 34190.1 42815.4 40755.0 45025.3 45103.0 45168.1 45186.5 8801.5 8926.7 8964.5 8966.3 8968.7 8950.6 9033.1 9033.6 9040.3 9044.0 9011.0 9068.8 9080.4 9081.7 9084.2 8974.7 9002.1 9018.0 9019.1 9023.4 8928.2 8976.7 8985.2 8991.1 8996.9 42895.0 43311.0 43316.6 43407.8 43423.0 3645.2 3687.6 3699.0 3759.1 3785.4 31503.2 31791.4 33251.5 34316.5 35187.1 4180.9 4206.0 4230.7 4260.8 4408.5 345970.0 353018.0 353264.0 354043.0 354355.0 63977.0 64092.4 64731.7 64746.0 64794.4 36671.4 37564.6 37816.4 68714.3 68812.3 17502.6 17606.4 17648.1 17655.3 17671.7 13570.1 13679.7 13686.9 13708.9 13726.5 20526.2 20542.8 20628.5 20692.2 20757.6 7631.1 7678.2 7726.4 7768.9 7782.0 992.4 1064.4 1073.4 1077.1 1136.4 31645.7 31656.0 31708.5 31721.5 32055.7 1090.1 1092.5 1128.0 1149.4 1239.1 16637.3 16715.3 16858.3 17002.0 17019.6 446872.0 450618.0 451123.0 452039.0 454411.0 54648.5 55956.0 56040.2 56177.7 56201.4 1200.9 1293.8 1316.3 1337.9 1346.7 32027.4 33772.0 33890.4 34000.3 34358.0 49444.5 49510.3 49981.5 50016.5 50120.0 402374.0 403952.0 403981.0 404572.0 405551.0 25408.4 27985.4 28623.9 29088.0 29826.4 46235.5 47401.5 47530.5 48089.8 48921.0 41377.2 41936.0 41937.8 42983.0 43602.0 41413.0 41779.2 41877.6 42612.6 42855.8 40714.6 41534.0 41829.0 42108.6 42161.2 36042.3 36736.3 36995.8 37506.0 37732.0 27889.6 27900.5 28083.0 28221.4 28284.9 05:34:01 INFO - PROCESS | 27810 | 05:34:01 INFO - PROCESS | 27810 | [#2] jquery.html Cycles:180 Average:28953.32 Median:20715.57 stddev:76973.36 (371.6%) stddev-sans-first:77159.39 05:34:01 INFO - PROCESS | 27810 | Values: 380.2 382.8 396.5 406.5 406.6 18058.5 20524.6 20560.6 20821.1 20841.6 19314.3 19878.4 20188.0 20237.1 20338.6 5683.7 5742.3 5770.5 5871.2 5882.1 4132.2 6171.3 6459.7 6466.2 6567.8 6287.6 6495.6 6499.8 6539.9 6540.7 6494.5 6510.6 6515.0 6541.3 6545.0 3767.9 5292.7 5632.4 5641.2 5700.6 23800.4 23929.3 24020.5 24418.1 24474.0 2428.9 2491.0 2619.1 2620.2 2696.6 14100.9 14984.9 15306.0 15312.7 15542.3 1926.5 1972.0 1996.5 2016.3 2043.6 77732.0 78500.0 79048.8 79643.6 81654.0 10578.7 10590.9 10661.1 10847.6 11117.8 15158.8 15197.8 15267.8 15274.4 15298.7 8411.5 8541.7 8622.7 8662.3 8858.1 8214.5 8281.0 8293.5 8396.7 8794.5 6022.6 6729.1 6809.9 6811.8 6817.6 1781.4 1927.4 1946.2 1976.0 2012.7 937.9 1023.7 1037.9 1099.7 1100.7 19379.2 19393.4 20324.3 20573.4 20610.1 992.2 1008.4 1026.2 1036.6 1044.2 10641.8 11516.8 11597.4 11690.1 11732.3 363952.0 472054.0 491399.0 491859.0 495038.0 97362.0 101488.0 102203.0 102542.0 102747.0 994.4 1015.9 1030.2 1031.6 1033.7 18330.0 18688.3 19219.6 19276.7 19484.0 39161.6 40231.8 43474.1 43909.8 44766.3 52810.2 54006.0 54349.2 54661.7 55013.7 8293.2 8411.7 8465.2 8796.2 8885.6 12012.3 14164.2 14303.7 14430.4 14538.8 11986.5 12106.9 12332.9 12451.3 12526.2 11961.5 12071.3 12277.8 12297.5 12515.4 12192.1 12212.1 12593.1 12708.6 12890.6 8572.3 8743.3 9110.1 12006.8 13448.0 12233.6 12769.2 13288.7 13654.0 13777.8 05:34:01 INFO - PROCESS | 27810 | 05:34:01 INFO - PROCESS | 27810 | [#3] mootools.html Cycles:180 Average:5973.33 Median:4428.39 stddev:3433.57 (77.5%) stddev-sans-first:3425.75 05:34:01 INFO - PROCESS | 27810 | Values: 1366.1 1495.8 1537.7 1643.6 1811.0 8448.4 8924.4 8934.2 9130.8 9155.6 8877.3 9094.2 9095.5 9096.2 9101.6 2016.9 2241.5 2287.3 2288.8 2381.2 2395.7 2396.0 2410.5 2411.8 2412.4 2339.6 2345.8 2371.9 2376.4 2383.6 1959.1 2195.4 2247.0 2249.0 2251.5 2255.5 2257.2 2274.3 2275.2 2277.8 9027.4 9077.6 9093.4 9097.0 9103.0 5036.7 5128.0 5133.6 5146.9 5152.5 3287.8 3333.0 3472.7 3496.4 3517.7 1067.8 1070.5 1078.4 1085.2 1093.0 12674.8 12717.9 12733.2 12736.4 12747.2 4446.1 4512.0 4655.3 4686.6 4692.6 10686.3 10697.8 10715.9 10718.5 10718.7 5311.0 5320.0 5325.0 5327.2 5333.2 4204.4 4732.3 4865.4 4868.0 4905.6 3926.2 3934.7 4020.3 4109.9 4174.2 1109.1 1191.3 1232.0 1253.5 1270.5 974.2 993.4 1007.5 1010.8 1025.8 6159.1 6286.7 6344.2 6364.2 6445.8 996.2 1007.7 1013.6 1021.9 1027.0 4354.7 4402.7 4405.6 4413.6 4443.2 10758.9 11012.5 11405.7 11408.3 11476.4 11126.2 11272.3 11285.8 11386.1 11419.2 8188.9 8348.2 8361.3 8376.9 8393.7 6214.2 6393.8 6438.0 6569.6 6588.2 9932.8 10273.1 10660.2 10691.4 10704.3 10202.6 10575.7 10589.4 10617.0 10681.8 8022.7 8113.5 8175.1 8182.9 8192.3 8790.9 8830.9 8891.6 8898.1 8900.3 6433.9 7941.8 8074.6 8248.2 8254.2 7954.4 7965.8 8093.2 8236.4 8265.5 6785.0 6998.5 7006.8 7051.5 7138.3 5437.7 5437.8 5496.2 5513.8 5545.9 5537.8 5543.2 5682.6 5695.9 5747.8 05:34:01 INFO - PROCESS | 27810 | 05:34:01 INFO - PROCESS | 27810 | [#4] prototype.html Cycles:180 Average:4676.29 Median:5367.48 stddev:1365.63 (25.4%) stddev-sans-first:1329.29 05:34:01 INFO - PROCESS | 27810 | Values: 296.0 298.8 305.2 311.7 319.2 5339.4 5391.3 5393.8 5402.9 5430.6 5005.4 5097.7 5259.6 5262.7 5270.7 4108.6 4166.2 4201.9 4208.9 4211.3 4208.8 4210.2 4211.6 4220.7 4223.0 3951.5 3987.8 4172.3 4176.7 4184.1 4164.1 4171.8 4190.4 4191.3 4196.9 3686.1 3686.7 3706.1 3711.9 3722.9 5081.1 5112.2 5131.9 5151.8 5165.3 4750.8 4765.2 4778.8 4781.8 4785.8 5511.6 5514.2 5526.1 5549.6 5553.5 3895.7 4013.9 4028.2 4028.9 4037.5 5662.3 5697.9 5698.8 5702.2 5702.2 4096.4 4099.2 4118.5 4132.5 4146.9 4079.3 4135.6 4180.6 4195.5 4195.7 4670.5 4717.8 4726.3 4726.7 4738.8 5563.8 5567.4 5583.9 5597.9 5609.4 1363.7 1371.4 1413.5 1433.1 1440.2 937.9 960.5 962.8 972.1 1003.9 5366.6 5367.8 5380.6 5386.2 5408.0 5608.8 5716.2 5722.1 5732.9 5762.2 5314.5 5318.6 5367.2 5372.9 5393.9 2967.6 2994.7 2998.5 3000.2 3002.8 5577.5 5764.8 5809.2 5813.8 5857.3 5699.2 5703.9 5710.5 5720.6 5727.2 5761.9 5805.5 5806.5 5807.1 5849.0 5350.7 5579.4 5585.0 5603.6 5617.9 5568.9 5582.5 5598.2 5601.6 5625.4 5637.2 5799.7 5803.5 5880.3 5984.0 3976.5 4004.5 4009.8 4021.8 4030.3 5806.5 5814.3 5823.1 5828.3 5843.5 5231.1 5508.5 5559.5 5676.4 5692.9 5528.4 5551.8 5561.3 5564.9 5575.9 5292.3 5331.9 5435.8 5461.4 5562.5 5561.8 5569.1 5582.5 5583.5 5587.8 5215.7 5451.5 5460.9 5491.3 5495.2 05:34:01 INFO - PROCESS | 27810 | 05:34:01 INFO - PROCESS | 27810 | [#5] yui.html Cycles:180 Average:21292.41 Median:3422.53 stddev:30451.52 (889.7%) stddev-sans-first:30498.02 05:34:01 INFO - PROCESS | 27810 | Values: 785.6 786.5 826.4 845.3 859.4 15940.5 16842.8 17027.6 17031.7 17080.1 14346.9 15372.3 15383.5 15387.4 15407.1 672.4 817.4 820.0 820.2 820.3 805.5 838.6 839.1 842.3 844.9 863.2 871.4 872.9 874.2 875.3 702.8 721.3 869.3 877.5 878.1 524.0 612.6 631.2 632.8 633.7 14406.1 14500.6 14658.6 14719.6 14767.2 14600.7 14692.5 14707.8 14762.9 14810.1 13038.5 13168.3 13372.0 13434.7 13660.0 4648.2 4708.6 4727.1 4776.9 4864.0 76938.0 77628.6 78052.0 78277.0 78946.4 11098.7 11163.9 11181.4 11494.4 11536.1 20391.7 20460.1 22132.1 22208.1 22217.3 8784.0 8805.9 8807.3 8871.4 8880.7 4767.5 4777.5 4792.3 4893.0 4956.8 3320.0 3417.5 3419.0 3420.9 3424.1 581.8 590.9 591.1 600.0 600.0 646.4 662.3 693.6 731.4 746.4 9705.7 9900.7 9922.4 10189.5 10270.4 651.5 704.3 710.6 713.7 713.8 4870.2 5029.9 5044.3 5091.2 5142.4 116240.4 116436.4 117137.0 122221.0 122225.0 105264.0 105754.0 107073.0 108805.2 109200.5 74364.3 75609.2 76365.0 76551.0 89608.6 10157.5 10381.9 10506.8 10543.2 10553.6 44031.6 44374.0 50187.0 51204.7 52519.0 72746.6 73079.6 76771.6 77564.0 79465.6 13515.2 13770.9 13850.3 14049.6 14312.1 14718.0 15786.3 15901.6 16036.8 16596.1 14575.6 14641.2 15005.7 15416.2 15595.7 14795.6 14835.6 15234.2 15521.4 15541.8 14228.4 14392.8 14549.5 14810.6 15293.7 10882.5 10902.4 11113.3 11239.9 11255.2 12246.1 12297.0 12489.4 12775.2 12841.2 05:34:01 INFO - PROCESS | 27810 | -------- Summary: end -------- 05:34:01 INFO - PROCESS | 27810 | 05:34:02 INFO - TEST-INFO | 27810: exit 0 05:34:02 INFO - TEST-OK | dromaeo_css | took 1113296ms 05:34:02 INFO - TEST-START | kraken 05:34:02 INFO - operating with platform_type : linux_ 05:34:02 INFO - Initialising browser for kraken test... 05:34:02 INFO - TEST-INFO | started process 28004 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphQJjVp/profile http://localhost:55947/getInfo.html) 05:34:06 INFO - PROCESS | 28004 | __metrics Screen width/height:1600/1200 05:34:06 INFO - PROCESS | 28004 | colorDepth:24 05:34:06 INFO - PROCESS | 28004 | Browser inner width/height: 1024/697 05:34:06 INFO - PROCESS | 28004 | __metrics 05:34:07 INFO - PROCESS | 28004 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:34:08 INFO - TEST-INFO | 28004: exit 0 05:34:08 INFO - Browser initialized. 05:34:08 INFO - Running cycle 1/1 for kraken test... 05:34:08 INFO - TEST-INFO | started process 28086 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphQJjVp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:34:19 INFO - PROCESS | 28086 | RSS: Main: 157585408 05:34:19 INFO - PROCESS | 28086 | 05:34:22 INFO - PROCESS | 28086 | Cycle 1(1): loaded http://localhost:55947/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55947/tests/kraken/driver.html?testName=audio-beat-detection) 05:34:23 INFO - PROCESS | 28086 | RSS: Main: 215543808 05:34:23 INFO - PROCESS | 28086 | 05:34:25 INFO - PROCESS | 28086 | Cycle 1(1): loaded http://localhost:55947/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55947/tests/kraken/driver.html?testName=audio-dft) 05:34:26 INFO - PROCESS | 28086 | RSS: Main: 203177984 05:34:26 INFO - PROCESS | 28086 | 05:34:29 INFO - PROCESS | 28086 | Cycle 1(1): loaded http://localhost:55947/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55947/tests/kraken/driver.html?testName=audio-fft) 05:34:30 INFO - PROCESS | 28086 | RSS: Main: 269352960 05:34:30 INFO - PROCESS | 28086 | 05:34:32 INFO - PROCESS | 28086 | Cycle 1(1): loaded http://localhost:55947/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55947/tests/kraken/driver.html?testName=audio-oscillator) 05:34:32 INFO - PROCESS | 28086 | RSS: Main: 180006912 05:34:32 INFO - PROCESS | 28086 | 05:34:34 INFO - PROCESS | 28086 | Cycle 1(1): loaded http://localhost:55947/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55947/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:34:35 INFO - PROCESS | 28086 | RSS: Main: 184172544 05:34:35 INFO - PROCESS | 28086 | 05:34:38 INFO - PROCESS | 28086 | Cycle 1(1): loaded http://localhost:55947/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55947/tests/kraken/driver.html?testName=imaging-darkroom) 05:34:39 INFO - PROCESS | 28086 | RSS: Main: 218669056 05:34:39 INFO - PROCESS | 28086 | 05:34:42 INFO - PROCESS | 28086 | Cycle 1(1): loaded http://localhost:55947/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55947/tests/kraken/driver.html?testName=imaging-desaturate) 05:34:43 INFO - PROCESS | 28086 | RSS: Main: 221306880 05:34:43 INFO - PROCESS | 28086 | 05:34:45 INFO - PROCESS | 28086 | Cycle 1(1): loaded http://localhost:55947/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55947/tests/kraken/driver.html?testName=json-parse-financial) 05:34:46 INFO - PROCESS | 28086 | RSS: Main: 220946432 05:34:46 INFO - PROCESS | 28086 | 05:34:48 INFO - PROCESS | 28086 | Cycle 1(1): loaded http://localhost:55947/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55947/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:34:48 INFO - PROCESS | 28086 | RSS: Main: 207466496 05:34:48 INFO - PROCESS | 28086 | 05:34:50 INFO - PROCESS | 28086 | Cycle 1(1): loaded http://localhost:55947/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55947/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:34:51 INFO - PROCESS | 28086 | RSS: Main: 212008960 05:34:51 INFO - PROCESS | 28086 | 05:34:53 INFO - PROCESS | 28086 | Cycle 1(1): loaded http://localhost:55947/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55947/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:34:53 INFO - PROCESS | 28086 | RSS: Main: 209408000 05:34:53 INFO - PROCESS | 28086 | 05:34:56 INFO - PROCESS | 28086 | Cycle 1(1): loaded http://localhost:55947/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55947/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:34:56 INFO - PROCESS | 28086 | RSS: Main: 226037760 05:34:56 INFO - PROCESS | 28086 | 05:34:59 INFO - PROCESS | 28086 | Cycle 1(1): loaded http://localhost:55947/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55947/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:35:00 INFO - PROCESS | 28086 | RSS: Main: 225173504 05:35:00 INFO - PROCESS | 28086 | 05:35:01 INFO - PROCESS | 28086 | Cycle 1(1): loaded http://localhost:55947/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55947/tests/kraken/driver.html?testName=ai-astar) 05:35:01 INFO - PROCESS | 28086 | RSS: Main: 267980800 05:35:01 INFO - PROCESS | 28086 | 05:35:01 INFO - PROCESS | 28086 | __start_tp_report 05:35:01 INFO - PROCESS | 28086 | _x_x_mozilla_page_load 05:35:01 INFO - PROCESS | 28086 | _x_x_mozilla_page_load_details 05:35:01 INFO - PROCESS | 28086 | |i|pagename|runs| 05:35:01 INFO - PROCESS | 28086 | |0;ai-astar;103;112;110;111;112;110;110;110;111;109 05:35:01 INFO - PROCESS | 28086 | |1;audio-beat-detection;149;119;118;179;117;122;144;118;153;115 05:35:01 INFO - PROCESS | 28086 | |2;audio-dft;162;159;161;160;160;160;161;161;161;160 05:35:01 INFO - PROCESS | 28086 | |3;audio-fft;74;75;75;135;76;76;75;86;108;75 05:35:01 INFO - PROCESS | 28086 | |4;audio-oscillator;84;84;123;83;84;84;121;85;83;133 05:35:01 INFO - PROCESS | 28086 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;117;116;117 05:35:01 INFO - PROCESS | 28086 | |6;imaging-darkroom;145;145;146;144;145;145;146;146;146;145 05:35:01 INFO - PROCESS | 28086 | |7;imaging-desaturate;95;94;95;95;94;95;94;95;95;94 05:35:01 INFO - PROCESS | 28086 | |8;json-parse-financial;53;54;53;53;53;54;55;54;55;54 05:35:01 INFO - PROCESS | 28086 | |9;json-stringify-tinderbox;60;62;61;60;61;60;61;60;60;64 05:35:01 INFO - PROCESS | 28086 | |10;stanford-crypto-aes;75;75;74;74;75;75;75;74;79;77 05:35:01 INFO - PROCESS | 28086 | |11;stanford-crypto-ccm;118;117;125;119;120;126;126;118;159;129 05:35:01 INFO - PROCESS | 28086 | |12;stanford-crypto-pbkdf2;158;153;152;155;157;155;154;154;155;156 05:35:01 INFO - PROCESS | 28086 | |13;stanford-crypto-sha256-iterative;62;62;62;61;61;63;62;65;60;60 05:35:01 INFO - PROCESS | 28086 | __end_tp_report 05:35:01 INFO - PROCESS | 28086 | __start_cc_report 05:35:01 INFO - PROCESS | 28086 | _x_x_mozilla_cycle_collect,1663 05:35:01 INFO - PROCESS | 28086 | __end_cc_report 05:35:01 INFO - PROCESS | 28086 | __startTimestamp1467894901945__endTimestamp 05:35:01 INFO - PROCESS | 28086 | 05:35:01 INFO - PROCESS | 28086 | ------- Summary: start ------- 05:35:01 INFO - PROCESS | 28086 | Number of tests: 14 05:35:01 INFO - PROCESS | 28086 | 05:35:01 INFO - PROCESS | 28086 | [#0] ai-astar Cycles:10 Average:109.80 Median:110.50 stddev:2.57 (2.3%) stddev-sans-first:1.01 05:35:01 INFO - PROCESS | 28086 | Values: 103.0 112.0 110.0 111.0 112.0 110.0 110.0 110.0 111.0 109.0 05:35:01 INFO - PROCESS | 28086 | 05:35:01 INFO - PROCESS | 28086 | [#1] audio-beat-detection Cycles:10 Average:133.40 Median:133.00 stddev:21.70 (16.3%) stddev-sans-first:22.27 05:35:01 INFO - PROCESS | 28086 | Values: 149.0 119.0 118.0 179.0 117.0 122.0 144.0 118.0 153.0 115.0 05:35:01 INFO - PROCESS | 28086 | 05:35:01 INFO - PROCESS | 28086 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.85 (0.5%) stddev-sans-first:0.71 05:35:01 INFO - PROCESS | 28086 | Values: 162.0 159.0 161.0 160.0 160.0 160.0 161.0 161.0 161.0 160.0 05:35:01 INFO - PROCESS | 28086 | 05:35:01 INFO - PROCESS | 28086 | [#3] audio-fft Cycles:10 Average:85.50 Median:75.00 stddev:20.30 (27.1%) stddev-sans-first:21.11 05:35:01 INFO - PROCESS | 28086 | Values: 74.0 75.0 75.0 135.0 76.0 76.0 75.0 86.0 108.0 75.0 05:35:01 INFO - PROCESS | 28086 | 05:35:01 INFO - PROCESS | 28086 | [#4] audio-oscillator Cycles:10 Average:96.40 Median:84.00 stddev:20.43 (24.3%) stddev-sans-first:21.17 05:35:01 INFO - PROCESS | 28086 | Values: 84.0 84.0 123.0 83.0 84.0 84.0 121.0 85.0 83.0 133.0 05:35:01 INFO - PROCESS | 28086 | 05:35:01 INFO - PROCESS | 28086 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:35:01 INFO - PROCESS | 28086 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 05:35:01 INFO - PROCESS | 28086 | 05:35:01 INFO - PROCESS | 28086 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 05:35:01 INFO - PROCESS | 28086 | Values: 145.0 145.0 146.0 144.0 145.0 145.0 146.0 146.0 146.0 145.0 05:35:01 INFO - PROCESS | 28086 | 05:35:01 INFO - PROCESS | 28086 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:35:01 INFO - PROCESS | 28086 | Values: 95.0 94.0 95.0 95.0 94.0 95.0 94.0 95.0 95.0 94.0 05:35:01 INFO - PROCESS | 28086 | 05:35:01 INFO - PROCESS | 28086 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:0.79 (1.5%) stddev-sans-first:0.78 05:35:01 INFO - PROCESS | 28086 | Values: 53.0 54.0 53.0 53.0 53.0 54.0 55.0 54.0 55.0 54.0 05:35:01 INFO - PROCESS | 28086 | 05:35:01 INFO - PROCESS | 28086 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:1.29 (2.1%) stddev-sans-first:1.32 05:35:01 INFO - PROCESS | 28086 | Values: 60.0 62.0 61.0 60.0 61.0 60.0 61.0 60.0 60.0 64.0 05:35:01 INFO - PROCESS | 28086 | 05:35:01 INFO - PROCESS | 28086 | [#10] stanford-crypto-aes Cycles:10 Average:75.30 Median:75.00 stddev:1.57 (2.1%) stddev-sans-first:1.66 05:35:01 INFO - PROCESS | 28086 | Values: 75.0 75.0 74.0 74.0 75.0 75.0 75.0 74.0 79.0 77.0 05:35:01 INFO - PROCESS | 28086 | 05:35:01 INFO - PROCESS | 28086 | [#11] stanford-crypto-ccm Cycles:10 Average:125.70 Median:125.50 stddev:12.44 (9.9%) stddev-sans-first:12.88 05:35:01 INFO - PROCESS | 28086 | Values: 118.0 117.0 125.0 119.0 120.0 126.0 126.0 118.0 159.0 129.0 05:35:01 INFO - PROCESS | 28086 | 05:35:01 INFO - PROCESS | 28086 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.90 Median:155.00 stddev:1.79 (1.2%) stddev-sans-first:1.51 05:35:01 INFO - PROCESS | 28086 | Values: 158.0 153.0 152.0 155.0 157.0 155.0 154.0 154.0 155.0 156.0 05:35:01 INFO - PROCESS | 28086 | 05:35:01 INFO - PROCESS | 28086 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.80 Median:62.00 stddev:1.48 (2.4%) stddev-sans-first:1.56 05:35:01 INFO - PROCESS | 28086 | Values: 62.0 62.0 62.0 61.0 61.0 63.0 62.0 65.0 60.0 60.0 05:35:01 INFO - PROCESS | 28086 | -------- Summary: end -------- 05:35:01 INFO - PROCESS | 28086 | 05:35:02 INFO - TEST-INFO | 28086: exit 0 05:35:02 INFO - TEST-OK | kraken | took 60502ms 05:35:02 INFO - SUITE-END | took 1173s 05:35:03 INFO - Completed test suite (00:19:33) 05:35:03 INFO - javascript benchmark 05:35:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3043.376107897881, 3064.4024415239037, 3088.1507585413992, 3088.9073327800165, 3107.3940581586585, 5179.041877252711, 5230.73846307685, 5272.762725677344, 5284.762185701643, 5291.576673866086, 5251.894962100756, 5261.2371206175085, 5271.762770675329, 5272.789088436458, 5283.709395983219, 4770.141374552588, 4860.878478038042, 4863.829765958192, 4869.610431165516, 5031.924521132168, 4928.901421971558, 4940.283658869462, 4953.702777833323, 5004.549590536851, 5024.296598476216, 4782.04359128174, 4797.736124513151, 4798.1123492154065, 4821.083994041121, 4873.658843880948, 4858.076965376567, 4858.587020103296, 4859.368282123337, 4863.8297659582095, 4902.3626928499425, 4774.80900763969, 4807.591354734852, 4831.855044348676, 4847.878803029917, 4875.561199492063, 5288.365396152486, 5375.569954403638, 5384.730763461811, 5454.672719636835, 5458.1266997280645, 5826.708664566797, 5827.562932780016, 5850.736716847752, 5853.0635098384055, 5862.97068514659, 5616.1014237721765, 5696.145578163268, 5750.05124154514, 5789.8263052108505, 5791.478766910956, 5347.572194224453, 5470.234167216593, 5470.56235501163, 5470.972645136789, 5473.0969390050595, 5944.227250457413, 5955.642661440327, 5961.046232602763, 5962.075878238793, 5962.3739507351975, 5496.203050557647, 5557.221988921554, 5618.97190514053, 5737.254156959569, 5746.9425305747245, 5736.77052917887, 5737.3688894221605, 5779.797707080232, 5789.421057894261, 5789.623674461147, 5663.235463212496, 5726.141078838207, 5729.684867332254, 5734.598578099493, 5767.913481297784, 5519.834404967857, 5575.386707462176, 5609.8597535061135, 5625.774969001194, 5735.942640573624, 4334.653227741773, 4336.848210312624, 4337.414449049401, 4338.262495375794, 4373.781310934441, 3868.323043467382, 3886.067343837459, 3894.201688653819, 3914.9608503914596, 3921.156951255494, 5278.366596008426, 5285.709285989307, 5322.760475778599, 5351.545118664957, 5362.731863406814, 5631.1271752878365, 5644.604877658607, 5648.096304591328, 5652.208690783294, 5690.260266165455, 5381.704006279692, 5390.029794637003, 5401.891962160814, 5404.0, 5406.104629468364, 4799.616030717534, 4801.063792560487, 4844.079624871263, 4890.926636100461, 4959.454460009396, 5901.3508514063415, 5902.468777810018, 5904.822855314347, 5909.852253693692, 5911.0, 5674.347450043298, 5678.574106941914, 5681.204631351531, 5681.744321505459, 5685.829425117253, 5731.283589551306, 5752.741126649395, 5754.942450575608, 5756.366799652119, 5811.360750317546, 5469.453054694499, 5506.504414602705, 5507.146392309199, 5512.3385193777, 5512.751926163252, 5471.343438787371, 5609.242752228397, 5620.044592419216, 5625.409332020243, 5625.943740562542, 5500.862478438071, 5567.0, 5567.693776842312, 5597.832065038056, 5603.10350343943, 5559.805406810742, 5571.359293681278, 5572.331320241597, 5573.136163894603, 5591.384947655836, 5394.298741163623, 5454.699991500505, 5523.7790488380015, 5540.141278101901, 5591.524720398812, 5576.442355764391, 5643.633163844337, 5646.887062258814, 5691.203231547669, 5692.743826527899, 5497.147942068986, 5505.862353441196, 5512.641678290898, 5513.641613295123, 5518.365387980273], "value": 5255.395722685312, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.7941541045226, 601.2094096263414, 615.9014557670772, 626.4549841637776, 628.3151365012142, 31584.52623210651, 34157.82921085391, 34181.82909085454, 34190.145246368855, 42815.3577696334, 40755.0, 45025.32462013073, 45103.0, 45168.0966380673, 45186.54813451864, 8801.5159166246, 8926.687565935194, 8964.50695211763, 8966.327525435618, 8968.730938071836, 8950.552472376388, 9033.141851524128, 9033.638654453815, 9040.321975851804, 9043.95478022609, 9011.008789033202, 9068.773280668003, 9080.364374493787, 9081.727548173532, 9084.227840633554, 8974.730758077269, 9002.05478424769, 9017.954910225473, 9019.143181397789, 9023.413478123934, 8928.24109950655, 8976.685815996474, 8985.23625491834, 8991.100889911022, 8996.910030899739, 42895.0, 43311.0, 43316.56683433157, 43407.78296108531, 43423.0, 3645.2345007548447, 3687.612800655946, 3698.9630103698887, 3759.0790256387086, 3785.356489396809, 31503.212419689462, 31791.364172716647, 33251.5012274816, 34316.48525272123, 35187.1203219919, 4180.916381672349, 4205.97897010516, 4230.725002874803, 4260.7656578888145, 4408.515063343029, 345970.0, 353018.0, 353264.0, 354043.0, 354355.0, 63977.0, 64092.35907640864, 64731.676341618935, 64746.0, 64794.35205647977, 36671.449928251095, 37564.62435375611, 37816.43275350872, 68714.3128568718, 68812.31187688159, 17502.649947000988, 17606.383776568015, 17648.117594120242, 17655.293788248582, 17671.73492397615, 13570.117942333716, 13679.726405472034, 13686.93156534231, 13708.93145534266, 13726.45094196221, 20526.178952841718, 20542.79457205409, 20628.484287892923, 20692.172313107607, 20757.584848302948, 7631.122420921554, 7678.155402905676, 7726.420518461138, 7768.912352270687, 7781.961090194626, 992.3797626483448, 1064.3932958213743, 1073.4203530093819, 1077.1221454514546, 1136.3522792008475, 31645.683543164734, 31656.0, 31708.524372134438, 31721.524177137362, 32055.679443205736, 1090.1061129873428, 1092.5138313450439, 1127.9661610151709, 1149.40231079838, 1239.0892693869998, 16637.33450661984, 16715.331386744394, 16858.32566697343, 17002.0, 17019.574510637332, 446872.0, 450618.0, 451123.0, 452039.0, 454411.0, 54648.45351546513, 55956.0, 56040.159397609066, 56177.719111405, 56201.43798561962, 1200.9071744712269, 1293.8188653588504, 1316.3484075382555, 1337.8662133786543, 1346.7441186174594, 32027.35945281128, 33772.0, 33890.43593486079, 34000.31999360048, 34358.0, 49444.50555494543, 49510.257346139115, 49981.50018499768, 50016.49983500118, 50120.0, 402374.0, 403952.0, 403981.0, 404572.0, 405551.0, 25408.364790880376, 27985.44029119447, 28623.856880715462, 29088.0, 29826.403471930007, 46235.53764462447, 47401.52598473971, 47530.52469475399, 48089.75955120202, 48921.0, 41377.1724565513, 41936.0, 41937.79031104947, 42983.0, 43602.0, 41413.0, 41779.164416712105, 41877.581224187365, 42612.5738742621, 42855.785721071195, 40714.59285407227, 41534.0, 41829.0, 42108.57891421169, 42161.156776863674, 36042.27915441729, 36736.26527469382, 36995.815020924725, 37505.98181528124, 37732.0, 27889.58165627558, 27900.4654743991, 28083.0, 28221.43557128887, 28284.85857570699], "value": 20107.898798842863, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.1503639366017, 382.7684251028126, 396.5202105452402, 406.4614385938632, 406.6401234907106, 18058.5485362866, 20524.58950820983, 20560.588788224228, 20821.06305216265, 20841.583168336623, 19314.32399866005, 19878.403647890587, 20187.999999999964, 20237.089330980103, 20338.59322813543, 5683.658980461186, 5742.28221472316, 5770.47432410419, 5871.207387002764, 5882.14708867214, 4132.152908653734, 6171.321154672983, 6459.709313080899, 6466.159399278087, 6567.835804104888, 6287.559870809046, 6495.610263384212, 6499.772507962222, 6539.869202615945, 6540.672966351687, 6494.5453818232745, 6510.609363438209, 6514.967425162868, 6541.280459149513, 6545.0, 3767.943480847762, 5292.708901010443, 5632.3804381518, 5641.238432811559, 5700.572457065695, 23800.40498987539, 23929.28212153621, 24020.519589608284, 24418.145364912143, 24474.0, 2428.89069991849, 2491.0, 2619.0964117379663, 2620.1615483045434, 2696.6089916961932, 14100.85899141016, 14984.850151498564, 15306.0, 15312.693746125015, 15542.300596473073, 1926.5280006398382, 1971.9605607887906, 1996.5407956170018, 2016.2942969960543, 2043.5606344635974, 77732.0, 78500.0, 79048.83804647808, 79643.6017819913, 81654.0, 10578.735531611617, 10590.947045264724, 10661.093807026335, 10847.566097356017, 11117.777644447066, 15158.772618410732, 15197.848021519865, 15267.770983435257, 15274.389024438899, 15298.694026119416, 8411.45325553837, 8541.743747687578, 8622.706594010948, 8662.263707584925, 8858.11418858109, 8214.480321140609, 8280.958595206985, 8293.502389856629, 8396.706115285935, 8794.516301603473, 6022.608530445507, 6729.1252137221845, 6809.897851532231, 6811.829704257334, 6817.556858804261, 1781.4210381626024, 1927.4410420977758, 1946.1534232608578, 1975.9703604445945, 2012.7282816819834, 937.8827646544182, 1023.7389465686202, 1037.9221558383001, 1099.6961365938346, 1100.7269987475836, 19379.224831006883, 19393.4181974541, 20324.288649897182, 20573.382798516068, 20610.07254673543, 992.1595440457991, 1008.3949630221808, 1026.2457094035879, 1036.6112707734599, 1044.216837371971, 10641.787164256672, 11516.769664606662, 11597.420128993685, 11690.123240756977, 11732.296062236293, 363952.0, 472054.0, 491399.0, 491859.0, 495038.0, 97362.0, 101488.0, 102203.0, 102542.0, 102747.0, 994.3586386780486, 1015.8679371681486, 1030.2221822524095, 1031.582209205273, 1033.6743925663393, 18330.0, 18688.25246990105, 19219.558533109794, 19276.710849336992, 19484.0, 39161.608383915795, 40231.79884100678, 43474.130517390106, 43909.78045109754, 44766.3285050731, 52810.207846883095, 54006.0, 54349.18476222781, 54661.72669136629, 55013.72493137669, 8293.170682931659, 8411.731051466186, 8465.195806398382, 8796.208341249318, 8885.600147993226, 12012.279263244232, 14164.220967846455, 14303.713925721218, 14430.350634221275, 14538.781918271023, 11986.520539178335, 12106.878931210575, 12332.938335308267, 12451.315177665316, 12526.185797923106, 11961.521539138337, 12071.336076515525, 12277.75444491123, 12297.50809967627, 12515.374231288217, 12192.085593580694, 12212.145149839425, 12593.118481706193, 12708.555200568306, 12890.585953899197, 8572.27135693473, 8743.256823170103, 9110.088991101102, 12006.819897701367, 13448.0, 12233.632991010283, 12769.174151324185, 13288.734225315633, 13654.0, 13777.793333100211], "value": 9762.504630615542, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1366.071071671263, 1495.8055452791139, 1537.715522628314, 1643.55623981525, 1810.9637807243855, 8448.408611397204, 8924.419912705678, 8934.195922366986, 9130.771730706736, 9155.587998540064, 8877.334199935014, 9094.181523662868, 9095.454272743624, 9096.181343679067, 9101.63593456261, 2016.8689035212665, 2241.450844543085, 2287.256641591481, 2288.794008539231, 2381.226101517014, 2395.700537432821, 2395.988020059906, 2410.457647029422, 2411.8311718179734, 2412.445137618349, 2339.555484457956, 2345.812335013195, 2371.8576885386847, 2376.3821406434276, 2383.5709572276983, 1959.1183967214738, 2195.3523710505438, 2246.988765056164, 2248.9662655060188, 2251.538434620907, 2255.515064261175, 2257.1761307122947, 2274.3404412720292, 2275.192306731103, 2277.8177745780463, 9027.368084234105, 9077.636894524278, 9093.363464557484, 9096.954515227448, 9102.954485227598, 5036.748162591893, 5127.974360128175, 5133.589312854962, 5146.897062058775, 5152.458991805844, 3287.819169945652, 3333.0, 3472.73954453417, 3496.3531746626954, 3517.7009954153928, 1067.7864427114607, 1070.4861666400093, 1078.396098185019, 1085.2240647936685, 1093.0272057868503, 12674.80987785184, 12717.872821271761, 12733.172343797716, 12736.363181840963, 12747.171433856769, 4446.088551846864, 4511.954880451219, 4655.278431843002, 4686.554777296152, 4692.577668009895, 10686.305390149615, 10697.786044279072, 10715.892841071645, 10718.517666705016, 10718.678439646823, 5311.017461769585, 5320.042392369411, 5324.973375133177, 5327.227552005015, 5333.200019996954, 4204.411382406465, 4732.337472753818, 4865.391826021747, 4867.977724677787, 4905.583025442877, 3926.155876486512, 3934.685225182036, 4020.336644453691, 4109.8972525687095, 4174.165166966619, 1109.1237922041496, 1191.2733232728028, 1231.950721971129, 1253.486070711004, 1270.4600544768437, 974.2060220919927, 993.4188499727741, 1007.5012868630075, 1010.8180527505119, 1025.7538190834146, 6159.137720719103, 6286.685665716787, 6344.175257216532, 6364.236291645032, 6445.806625801233, 996.2030375699411, 1007.6725064354114, 1013.554036224059, 1021.877374715039, 1026.9743256418649, 4354.716943398669, 4402.713823601455, 4405.581469760367, 4413.558644135561, 4443.2224360736745, 10758.892411075945, 11012.50443730034, 11405.714857128472, 11408.258463199865, 11476.426178691032, 11126.221164518567, 11272.323660580227, 11285.774284514264, 11386.08911287095, 11419.200655954004, 8188.877166842502, 8348.165183481724, 8361.289290410383, 8376.916230837614, 8393.706220282384, 6214.223222097238, 6393.849107160756, 6437.967810160919, 6569.638669873012, 6588.242352129567, 9932.801343973224, 10273.126784223126, 10660.200484963814, 10691.358518488605, 10704.30422022566, 10202.591896324064, 10575.735606609896, 10589.417582033062, 10617.0, 10681.839772403264, 8022.679092836222, 8113.472624279639, 8175.059868115005, 8182.918170818216, 8192.30365418946, 8790.91209087901, 8830.911690883266, 8891.555422228734, 8898.110188981309, 8900.287976961697, 6433.935660643521, 7941.761747147595, 8074.555899425588, 8248.216419440143, 8254.215849494289, 7954.363650908029, 7965.761027169194, 8093.150219227132, 8236.39390318882, 8265.46274492156, 6785.0, 6998.510104292651, 7006.789796306119, 7051.541649792747, 7138.321859423347, 5437.673739575638, 5437.782488700408, 5496.203050557567, 5513.751881165437, 5545.889082218414, 5537.833864984057, 5543.172981779241, 5682.6306290091015, 5695.917775622618, 5747.827565173052], "value": 4744.678026736398, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.9807612505188, 298.84609426145533, 305.1638510481282, 311.7194524927565, 319.24020830423586, 5339.439358867321, 5391.272178255935, 5393.838184854456, 5402.91895621566, 5430.619856610039, 5005.374328208974, 5097.7196254206, 5259.6055295852775, 5262.736863156846, 5270.683758974455, 4108.5686002969705, 4166.187593419269, 4201.894952626179, 4208.936865947013, 4211.305134652778, 4208.789560521977, 4210.157968406315, 4211.599898009699, 4220.683448741342, 4222.9577704222875, 3951.5060617422823, 3987.8006099695044, 4172.269852775752, 4176.686748493875, 4184.058586817972, 4164.104717485755, 4171.791410429466, 4190.413342132104, 4191.308434108369, 4196.916061678765, 3686.096906257984, 3686.7234957378037, 3706.110533471974, 3711.870084547028, 3722.8883133506038, 5081.136206844845, 5112.156494178456, 5131.923021154686, 5151.819686310999, 5165.276861239429, 4750.809967601292, 4765.166095933232, 4778.761061946889, 4781.784819683123, 4785.784639691187, 5511.614187006911, 5514.200440936082, 5526.143447765603, 5549.639273447213, 5553.527950124244, 3895.6721919854085, 4013.9397909031386, 4028.2144981728575, 4028.879133625996, 4037.5154981402125, 5662.348829884533, 5697.857553561153, 5698.772049118031, 5702.173184888168, 5702.201691763156, 4096.446979657768, 4099.159672267178, 4118.546959834416, 4132.470985735237, 4146.896327591834, 4079.347304431277, 4135.60711732385, 4180.623743863067, 4195.538490766014, 4195.685323600742, 4670.462896766848, 4717.8112875485285, 4726.338312636233, 4726.692764970266, 4738.8341408050555, 5563.805266815642, 5567.415421380778, 5583.933944440501, 5597.944020559742, 5609.382967873531, 1363.6659018540522, 1371.403439503819, 1413.5476647472915, 1433.1186320412871, 1440.2366745624836, 937.920276776468, 960.5437417226761, 962.7544976031068, 972.1250874213265, 1003.9046290602381, 5366.597505187126, 5367.75845086972, 5380.569554435636, 5386.218998245311, 5407.972960135253, 5608.775648973995, 5716.1997320375185, 5722.141678748138, 5732.914006289909, 5762.164486149569, 5314.468553144655, 5318.627696061239, 5367.194920761917, 5372.91940620891, 5393.867287869592, 2967.629046369204, 2994.7454466370605, 2998.4752668282963, 3000.159955212544, 3002.759779217701, 5577.498025177753, 5764.798232061858, 5809.215755872988, 5813.76744930198, 5857.26784151981, 5699.173619825185, 5703.9429605704245, 5710.487385550345, 5720.599558030898, 5727.226824378656, 5761.9135712964335, 5805.477507024388, 5806.506446951972, 5807.0998995155815, 5848.970755146197, 5350.732463376893, 5579.442055794388, 5584.972075139761, 5603.635763675348, 5617.915731264116, 5568.916466252928, 5582.49757521825, 5598.1602759586385, 5601.579881508822, 5625.437456254342, 5637.238972738628, 5799.681017543907, 5803.535717142534, 5880.294364676095, 5984.0, 3976.4830572025453, 4004.519457665099, 4009.7995100245453, 4021.819018144249, 4030.314846476165, 5806.535477161732, 5814.273215848019, 5823.097419899922, 5828.271466066742, 5843.532517398683, 5231.136862417658, 5508.504234618904, 5559.471850174227, 5676.4323567642905, 5692.8576785579035, 5528.419515950767, 5551.778608706079, 5561.303802340325, 5564.888702225851, 5575.9163612545035, 5292.285541452009, 5331.8939019086465, 5435.809746658848, 5461.399246082849, 5562.471565201299, 5561.777528898961, 5569.136783798518, 5582.525485333792, 5583.469570390806, 5587.804426845041, 5215.6609820361555, 5451.48210919962, 5460.918086228789, 5491.28613280271, 5495.175723641486], "value": 4232.792358798731, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [785.6464590934081, 786.5005721366933, 826.3926014379431, 845.2730651639592, 859.3726579596893, 15940.52178434646, 16842.83157168428, 17027.57431064224, 17031.659366812655, 17080.145992700378, 14346.856531434683, 15372.308246128923, 15383.461578844743, 15387.38450461983, 15407.07557546548, 672.3847679373392, 817.3992115794871, 820.0200760091693, 820.1962077164383, 820.2904487618227, 805.5368163306093, 838.6016642094986, 839.102160688064, 842.2588122452264, 844.8986121665378, 863.1756672377895, 871.3987348729388, 872.9127087291283, 874.2001069021837, 875.3434923807145, 702.7680865314434, 721.2679130682361, 869.2698133567802, 877.4735158904638, 878.1350369885657, 523.9842804715864, 612.6385432594745, 631.1763149090435, 632.7785275153706, 633.6863252689902, 14406.06360586569, 14500.637484062878, 14658.63353416173, 14719.632009199855, 14767.187804670739, 14600.707985840223, 14692.48576299835, 14707.779383309258, 14762.926185369111, 14810.111393316327, 13038.478460861554, 13168.27574483403, 13372.0, 13434.664133396744, 13660.0, 4648.186567350734, 4708.552687494683, 4727.149113159629, 4776.904461910743, 4864.01308506289, 76938.0, 77628.61185694035, 78052.0, 78277.0, 78946.4474098667, 11098.667039988813, 11163.888361116447, 11181.44092795357, 11494.42527873603, 11536.134789890792, 20391.694124588143, 20460.079296431697, 22132.114715411524, 22208.11167553312, 22217.333479995625, 8783.956080219557, 8805.867911981326, 8807.251383632334, 8871.379003469696, 8880.73357799267, 4767.523247675204, 4777.450593181759, 4792.329073929653, 4892.951070489249, 4956.844016615618, 3319.966800332014, 3417.4873768934362, 3418.9658103419147, 3420.931581368359, 3424.126847653832, 581.8458108601224, 590.8581940334288, 591.0572636644545, 599.9770391482512, 599.9850003749941, 646.3956200952125, 662.3310456438935, 693.6185098196073, 731.3600599475459, 746.4364404874393, 9705.660301889542, 9900.653477128266, 9922.404655720535, 10189.54147063384, 10270.435126067989, 651.5048563092084, 704.3097764191122, 710.6127160697432, 713.653877869233, 713.8144082538578, 4870.245112007645, 5029.924551131736, 5044.268581055726, 5091.2363145527725, 5142.434332223453, 116240.41879790547, 116436.41781791036, 117137.0, 122221.0, 122225.0, 105264.0, 105754.0, 107073.0, 108805.20753132098, 109200.4539977295, 74364.25635743681, 75609.24390756022, 76365.0, 76551.0, 89608.55195723979, 10157.492125393848, 10381.896181038093, 10506.789864202521, 10543.15654747603, 10553.577856885639, 44031.559684402746, 44374.0, 50187.0, 51204.743976281374, 52519.0, 72746.63626681833, 73079.63460182665, 76771.61614191893, 77564.0, 79465.60267198627, 13515.189088654712, 13770.862291376958, 13850.30748462593, 14049.648758781112, 14312.06971546846, 14717.95484886538, 15786.289616967035, 15901.581160050644, 16036.759448608513, 16596.087215202795, 14575.562733118024, 14641.197115122819, 15005.699886002438, 15416.152111633968, 15595.688086237984, 14795.556133316019, 14835.554933352018, 15234.238288085773, 15521.37914483408, 15541.766873497132, 14228.430862765374, 14392.784108238175, 14549.523234283664, 14810.555683329518, 15293.694126117192, 10882.455877206266, 10902.400367979837, 11113.277636953571, 11239.887601124212, 11255.155863310449, 12246.07807460525, 12297.0, 12489.375531223584, 12775.23348599087, 12841.229526228457], "value": 7793.754100727231, "unit": "score"}], "name": "dromaeo_css", "value": 7379.493243858905, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 110.0, 111.0, 112.0, 110.0, 110.0, 110.0, 111.0, 109.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 119.0, 118.0, 179.0, 117.0, 122.0, 144.0, 118.0, 153.0, 115.0], "value": 133.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 159.0, 161.0, 160.0, 160.0, 160.0, 161.0, 161.0, 161.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 135.0, 76.0, 76.0, 75.0, 86.0, 108.0, 75.0], "value": 85.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 123.0, 83.0, 84.0, 84.0, 121.0, 85.0, 83.0, 133.0], "value": 96.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 144.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 53.0, 53.0, 53.0, 54.0, 55.0, 54.0, 55.0, 54.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 61.0, 60.0, 61.0, 60.0, 61.0, 60.0, 60.0, 64.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 74.0, 75.0, 75.0, 75.0, 74.0, 79.0, 77.0], "value": 75.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 125.0, 119.0, 120.0, 126.0, 126.0, 118.0, 159.0, 129.0], "value": 125.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 153.0, 152.0, 155.0, 157.0, 155.0, 154.0, 154.0, 155.0, 156.0], "value": 154.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 61.0, 61.0, 63.0, 62.0, 65.0, 60.0, 60.0], "value": 61.8, "unit": "score"}], "name": "kraken", "value": 1474.7, "alertThreshold": 2.0}]} 05:35:03 INFO - Return code: 0 05:35:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:35:03 INFO - # TBPL SUCCESS # 05:35:03 INFO - Running post-action listener: _resource_record_post_action 05:35:03 INFO - ##### 05:35:03 INFO - ##### Finished run-tests step (success) 05:35:03 INFO - ##### 05:35:03 INFO - Running post-run listener: _resource_record_post_run 05:35:03 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 555229184; Read time: 12; Write time: 466384 05:35:03 INFO - TinderboxPrint: CPU usage
13.0% 05:35:03 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 05:35:03 INFO - TinderboxPrint: I/O write bytes / time
555,229,184 / 466,384 05:35:03 INFO - TinderboxPrint: CPU idle
8,269.9 (87.0%) 05:35:03 INFO - TinderboxPrint: CPU user
1,195.3 (12.6%) 05:35:03 INFO - TinderboxPrint: Swap in / out
0 / 0 05:35:03 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 258818048; Read time: 0; Write time: 272572 05:35:03 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 296411136; Read time: 0; Write time: 193812 05:35:03 INFO - Running post-run listener: _upload_blobber_files 05:35:03 INFO - Blob upload gear active. 05:35:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:35:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:35:03 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'] 05:35:03 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 05:35:04 INFO - (blobuploader) - INFO - Open directory for files ... 05:35:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:35:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:35:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:35:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:35:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:35:05 INFO - (blobuploader) - INFO - Done attempting. 05:35:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:35:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:35:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:35:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:35:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:35:05 INFO - (blobuploader) - INFO - Done attempting. 05:35:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:35:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:35:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:35:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:35:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:35:09 INFO - (blobuploader) - INFO - Done attempting. 05:35:09 INFO - (blobuploader) - INFO - Iteration through files over. 05:35:09 INFO - Return code: 0 05:35:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:35:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:35:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/864634684ea264b210fb6cb8ae5601d64ae56c30123398840b0fc12561f3d6f77c9ef1ca0edb82676edf9d81ca5707a57e886dee93e5e7fafe0cb3ccd3197f1e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3354898f8fa4f8d0f2ca2afe5cfa7b3ebc6e3435ac60d359621b61224a9a6cd1c9a96a667822fcb0013d7438f17d0d904d3977e912ae6c46a4130968baee9b1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d831e72c19abf07e30478e0f4b1eb1c7ad4e5676cd747d5087e6226476b1283d1f6d387ad78d79428870aaede79284bb383c1e70ece2fbcb65a0ef663f4c5cb4"} 05:35:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:35:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:35:09 INFO - Contents: 05:35:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/864634684ea264b210fb6cb8ae5601d64ae56c30123398840b0fc12561f3d6f77c9ef1ca0edb82676edf9d81ca5707a57e886dee93e5e7fafe0cb3ccd3197f1e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3354898f8fa4f8d0f2ca2afe5cfa7b3ebc6e3435ac60d359621b61224a9a6cd1c9a96a667822fcb0013d7438f17d0d904d3977e912ae6c46a4130968baee9b1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d831e72c19abf07e30478e0f4b1eb1c7ad4e5676cd747d5087e6226476b1283d1f6d387ad78d79428870aaede79284bb383c1e70ece2fbcb65a0ef663f4c5cb4"} 05:35:09 INFO - Running post-run listener: copy_logs_to_upload_dir 05:35:09 INFO - Copying logs to upload dir... 05:35:09 INFO - mkdir: /builds/slave/test/build/upload/logs 05:35:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.401456 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-07 05:35:09.178910) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 05:35:09.182942) ========= 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=4ac8d263c7293b36a1be1aed000001be-1467893678.411107-1757343348 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/864634684ea264b210fb6cb8ae5601d64ae56c30123398840b0fc12561f3d6f77c9ef1ca0edb82676edf9d81ca5707a57e886dee93e5e7fafe0cb3ccd3197f1e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3354898f8fa4f8d0f2ca2afe5cfa7b3ebc6e3435ac60d359621b61224a9a6cd1c9a96a667822fcb0013d7438f17d0d904d3977e912ae6c46a4130968baee9b1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d831e72c19abf07e30478e0f4b1eb1c7ad4e5676cd747d5087e6226476b1283d1f6d387ad78d79428870aaede79284bb383c1e70ece2fbcb65a0ef663f4c5cb4"} build_url:https://queue.taskcluster.net/v1/task/HEpUDLoPQc6smYc9c1KV4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011440 build_url: 'https://queue.taskcluster.net/v1/task/HEpUDLoPQc6smYc9c1KV4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/864634684ea264b210fb6cb8ae5601d64ae56c30123398840b0fc12561f3d6f77c9ef1ca0edb82676edf9d81ca5707a57e886dee93e5e7fafe0cb3ccd3197f1e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3354898f8fa4f8d0f2ca2afe5cfa7b3ebc6e3435ac60d359621b61224a9a6cd1c9a96a667822fcb0013d7438f17d0d904d3977e912ae6c46a4130968baee9b1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d831e72c19abf07e30478e0f4b1eb1c7ad4e5676cd747d5087e6226476b1283d1f6d387ad78d79428870aaede79284bb383c1e70ece2fbcb65a0ef663f4c5cb4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 05:35:09.209702) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 05:35:09.210093) ========= 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=4ac8d263c7293b36a1be1aed000001be-1467893678.411107-1757343348 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004377 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 05:35:09.292558) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 05:35:09.292893) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 05:35:09.293267) ========= ========= Total master_lag: 0.18 =========