builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-050 starttime: 1468246701.57 results: success (0) buildid: 20160711023012 builduid: 34c4873734d942f9af7ea3f6f6c7fe6e revision: 0136b1e24160b1daf36846fb5aaf4a52e6f6d457 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 07:18:21.567273) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 07:18:21.567790) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 07:18:21.568132) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 07:18:21.582689) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 07:18:21.582955) ========= 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=6dbc10da6d83fee962c624be000001a8-1468246427.596564-1214046542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-11 07:18:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 12.5M=0.001s 2016-07-11 07:18:22 (12.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113859 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 07:18:21.710777) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 07:18:21.711093) ========= 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=6dbc10da6d83fee962c624be000001a8-1468246427.596564-1214046542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017607 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 07:18:21.761231) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-11 07:18:21.761608) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0136b1e24160b1daf36846fb5aaf4a52e6f6d457 --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 0136b1e24160b1daf36846fb5aaf4a52e6f6d457 --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=6dbc10da6d83fee962c624be000001a8-1468246427.596564-1214046542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-11 07:18:22,290 truncating revision to first 12 chars 2016-07-11 07:18:22,290 Setting DEBUG logging. 2016-07-11 07:18:22,290 attempt 1/10 2016-07-11 07:18:22,290 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0136b1e24160?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-11 07:18:23,483 unpacking tar archive at: fx-team-0136b1e24160/testing/mozharness/ program finished with exit code 0 elapsedTime=1.527234 ========= master_lag: 0.47 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-11 07:18:23.763112) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 07:18:23.763448) ========= script_repo_revision: 0136b1e24160b1daf36846fb5aaf4a52e6f6d457 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 07:18:23.763840) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 07:18:23.764111) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 07:18:23.776344) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-11 07:18:23.776781) ========= /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=6dbc10da6d83fee962c624be000001a8-1468246427.596564-1214046542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:18:24 INFO - MultiFileLogger online at 20160711 07:18:24 in /builds/slave/test 07:18:24 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 07:18:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:18:24 INFO - {'append_to_log': False, 07:18:24 INFO - 'base_work_dir': '/builds/slave/test', 07:18:24 INFO - 'blob_upload_branch': 'Fx-Team', 07:18:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:18:24 INFO - 'branch': 'Fx-Team', 07:18:24 INFO - 'buildbot_json_path': 'buildprops.json', 07:18:24 INFO - 'config_files': ('talos/linux_config.py',), 07:18:24 INFO - 'default_actions': ('clobber', 07:18:24 INFO - 'read-buildbot-config', 07:18:24 INFO - 'download-and-extract', 07:18:24 INFO - 'populate-webroot', 07:18:24 INFO - 'create-virtualenv', 07:18:24 INFO - 'install', 07:18:24 INFO - 'run-tests'), 07:18:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:18:24 INFO - 'download_minidump_stackwalk': True, 07:18:24 INFO - 'download_symbols': 'ondemand', 07:18:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:18:24 INFO - 'tooltool.py': '/tools/tooltool.py', 07:18:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:18:24 INFO - '/tools/misc-python/virtualenv.py')}, 07:18:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:18:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:18:24 INFO - 'installer_path': 'installer.exe', 07:18:24 INFO - 'log_level': 'info', 07:18:24 INFO - 'log_name': 'talos', 07:18:24 INFO - 'log_to_console': True, 07:18:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:18:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:18:24 INFO - 'opt_config_files': (), 07:18:24 INFO - 'pip_index': False, 07:18:24 INFO - 'sps_profile': False, 07:18:24 INFO - 'sps_profile_interval': 0, 07:18:24 INFO - 'suite': 'dromaeojs', 07:18:24 INFO - 'system_bits': '32', 07:18:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:18:24 INFO - 'title': 'talos-linux64-ix-050', 07:18:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:18:24 INFO - 'use_talos_json': True, 07:18:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:18:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:18:24 INFO - 'work_dir': 'build'} 07:18:24 INFO - ##### 07:18:24 INFO - ##### Running clobber step. 07:18:24 INFO - ##### 07:18:24 INFO - Running pre-action listener: _resource_record_pre_action 07:18:24 INFO - Running main action method: clobber 07:18:24 INFO - rmtree: /builds/slave/test/build 07:18:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:18:25 INFO - Running post-action listener: _resource_record_post_action 07:18:25 INFO - ##### 07:18:25 INFO - ##### Finished clobber step (success) 07:18:25 INFO - ##### 07:18:25 INFO - ##### 07:18:25 INFO - ##### Running read-buildbot-config step. 07:18:25 INFO - ##### 07:18:25 INFO - Running pre-action listener: _resource_record_pre_action 07:18:25 INFO - Running main action method: read_buildbot_config 07:18:25 INFO - Using buildbot properties: 07:18:25 INFO - { 07:18:25 INFO - "project": "", 07:18:25 INFO - "product": "firefox", 07:18:25 INFO - "script_repo_revision": "production", 07:18:25 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:18:25 INFO - "repository": "", 07:18:25 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 07:18:25 INFO - "buildid": "20160711023012", 07:18:25 INFO - "pgo_build": "True", 07:18:25 INFO - "basedir": "/builds/slave/test", 07:18:25 INFO - "buildnumber": 884, 07:18:25 INFO - "slavename": "talos-linux64-ix-050", 07:18:25 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:18:25 INFO - "platform": "ubuntu64_hw", 07:18:25 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 07:18:25 INFO - "branch": "fx-team", 07:18:25 INFO - "repo_path": "integration/fx-team", 07:18:25 INFO - "revision": "0136b1e24160b1daf36846fb5aaf4a52e6f6d457", 07:18:25 INFO - "stage_platform": "linux64-pgo", 07:18:25 INFO - "builduid": "34c4873734d942f9af7ea3f6f6c7fe6e", 07:18:25 INFO - "slavebuilddir": "test" 07:18:25 INFO - } 07:18:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/N08filg4QGSMeysKRjTCOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:18:25 INFO - Running post-action listener: _resource_record_post_action 07:18:25 INFO - ##### 07:18:25 INFO - ##### Finished read-buildbot-config step (success) 07:18:25 INFO - ##### 07:18:25 INFO - ##### 07:18:25 INFO - ##### Running download-and-extract step. 07:18:25 INFO - ##### 07:18:25 INFO - Running pre-action listener: _resource_record_pre_action 07:18:25 INFO - Running main action method: download_and_extract 07:18:25 INFO - mkdir: /builds/slave/test/build/tests 07:18:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:25 INFO - https://queue.taskcluster.net/v1/task/N08filg4QGSMeysKRjTCOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:18:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N08filg4QGSMeysKRjTCOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:18:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N08filg4QGSMeysKRjTCOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:18:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N08filg4QGSMeysKRjTCOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:18:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N08filg4QGSMeysKRjTCOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:18:26 INFO - Downloaded 1361 bytes. 07:18:26 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:18:26 INFO - Using the following test package requirements: 07:18:26 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:18:26 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:18:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:18:26 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:18:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:18:26 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:18:26 INFO - u'jsshell-linux-x86_64.zip'], 07:18:26 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:18:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:18:26 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:18:26 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:18:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:18:26 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:18:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:18:26 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:18:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:18:26 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:18:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:18:26 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:18:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:26 INFO - https://queue.taskcluster.net/v1/task/N08filg4QGSMeysKRjTCOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:18:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N08filg4QGSMeysKRjTCOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:18:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N08filg4QGSMeysKRjTCOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:18:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N08filg4QGSMeysKRjTCOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:18:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N08filg4QGSMeysKRjTCOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:18:27 INFO - Downloaded 24304874 bytes. 07:18:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:18:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:18:28 INFO - Return code: 0 07:18:28 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:18: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')]} 07:18:28 INFO - https://queue.taskcluster.net/v1/task/N08filg4QGSMeysKRjTCOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:18:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N08filg4QGSMeysKRjTCOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:18:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N08filg4QGSMeysKRjTCOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:18:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N08filg4QGSMeysKRjTCOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:18:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N08filg4QGSMeysKRjTCOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:18:29 INFO - Downloaded 24304874 bytes. 07:18:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:18:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:18:31 INFO - Return code: 0 07:18:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:31 INFO - https://queue.taskcluster.net/v1/task/N08filg4QGSMeysKRjTCOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:18:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N08filg4QGSMeysKRjTCOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:18:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N08filg4QGSMeysKRjTCOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:18:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N08filg4QGSMeysKRjTCOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:18:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N08filg4QGSMeysKRjTCOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:18:32 INFO - Downloaded 14403333 bytes. 07:18:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:18:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:18:32 INFO - Return code: 0 07:18:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:32 INFO - https://queue.taskcluster.net/v1/task/N08filg4QGSMeysKRjTCOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:18:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N08filg4QGSMeysKRjTCOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:18:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N08filg4QGSMeysKRjTCOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:18:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N08filg4QGSMeysKRjTCOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:18:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N08filg4QGSMeysKRjTCOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:18:33 INFO - Downloaded 60487524 bytes. 07:18:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N08filg4QGSMeysKRjTCOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:18:33 INFO - mkdir: /builds/slave/test/properties 07:18:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:18:33 INFO - Writing to file /builds/slave/test/properties/build_url 07:18:33 INFO - Contents: 07:18:33 INFO - build_url:https://queue.taskcluster.net/v1/task/N08filg4QGSMeysKRjTCOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:18:34 INFO - Running post-action listener: _resource_record_post_action 07:18:34 INFO - Running post-action listener: set_extra_try_arguments 07:18:34 INFO - ##### 07:18:34 INFO - ##### Finished download-and-extract step (success) 07:18:34 INFO - ##### 07:18:34 INFO - ##### 07:18:34 INFO - ##### Running populate-webroot step. 07:18:34 INFO - ##### 07:18:34 INFO - Running pre-action listener: _resource_record_pre_action 07:18:34 INFO - Running main action method: populate_webroot 07:18:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:18:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:18:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:18:34 INFO - '--tppagecycles', 07:18:34 INFO - '7'], 07:18:34 INFO - 'tests': ['tsvgm']}}, 07:18:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:18:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:18:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:18:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:18:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:18:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:18:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:34 INFO - 'talos_options': ['--disable-e10s'], 07:18:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:18:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:18:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:34 INFO - 'talos_options': ['--disable-e10s'], 07:18:34 INFO - 'tests': ['damp', 'tps']}, 07:18:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:34 INFO - 'tests': ['damp', 'tps']}, 07:18:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:18:34 INFO - 'tests': ['dromaeo_dom']}, 07:18:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:18:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:18:34 INFO - 'tests': ['basic_compositor_video']}, 07:18:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:18:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:18:34 INFO - 'tests': ['a11yr', 07:18:34 INFO - 'ts_paint', 07:18:34 INFO - 'tpaint', 07:18:34 INFO - 'sessionrestore', 07:18:34 INFO - 'sessionrestore_no_auto_restore', 07:18:34 INFO - 'tabpaint']}, 07:18:34 INFO - 'other-e10s': {'tests': ['a11yr', 07:18:34 INFO - 'ts_paint', 07:18:34 INFO - 'tpaint', 07:18:34 INFO - 'sessionrestore', 07:18:34 INFO - 'sessionrestore_no_auto_restore', 07:18:34 INFO - 'tabpaint']}, 07:18:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:18:34 INFO - 'ts_paint', 07:18:34 INFO - 'tpaint', 07:18:34 INFO - 'sessionrestore', 07:18:34 INFO - 'sessionrestore_no_auto_restore', 07:18:34 INFO - 'tabpaint']}, 07:18:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:18:34 INFO - 'ts_paint', 07:18:34 INFO - 'tpaint', 07:18:34 INFO - 'sessionrestore', 07:18:34 INFO - 'sessionrestore_no_auto_restore', 07:18:34 INFO - 'tabpaint']}, 07:18:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:18:34 INFO - 'tests': ['a11yr', 07:18:34 INFO - 'ts_paint', 07:18:34 INFO - 'tpaint', 07:18:34 INFO - 'sessionrestore', 07:18:34 INFO - 'sessionrestore_no_auto_restore', 07:18:34 INFO - 'tabpaint']}, 07:18:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:18:34 INFO - 'tests': ['a11yr', 07:18:34 INFO - 'ts_paint', 07:18:34 INFO - 'tpaint', 07:18:34 INFO - 'sessionrestore', 07:18:34 INFO - 'sessionrestore_no_auto_restore', 07:18:34 INFO - 'tabpaint']}, 07:18:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:18:34 INFO - 'tests': ['tsvgx', 07:18:34 INFO - 'tsvgr_opacity', 07:18:34 INFO - 'tart', 07:18:34 INFO - 'tscrollx', 07:18:34 INFO - 'cart']}, 07:18:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:18:34 INFO - 'tsvgr_opacity', 07:18:34 INFO - 'tart', 07:18:34 INFO - 'tscrollx', 07:18:34 INFO - 'cart']}, 07:18:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:34 INFO - 'talos_options': ['--disable-e10s'], 07:18:34 INFO - 'tests': ['tp5o']}, 07:18:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:34 INFO - 'tests': ['tp5o']}, 07:18:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:34 INFO - 'talos_options': ['--disable-e10s', 07:18:34 INFO - '--xperf_path', 07:18:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:18:34 INFO - 'tests': ['tp5n']}, 07:18:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:34 INFO - 'talos_options': ['--xperf_path', 07:18:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:18:34 INFO - 'tests': ['tp5n']}}, 07:18:34 INFO - 'talos.zip': {'path': '', 07:18:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:18:34 INFO - Running post-action listener: _resource_record_post_action 07:18:34 INFO - ##### 07:18:34 INFO - ##### Finished populate-webroot step (success) 07:18:34 INFO - ##### 07:18:34 INFO - ##### 07:18:34 INFO - ##### Running create-virtualenv step. 07:18:34 INFO - ##### 07:18:34 INFO - Running pre-action listener: _resource_record_pre_action 07:18:34 INFO - Running main action method: create_virtualenv 07:18:34 INFO - Creating virtualenv /builds/slave/test/build/venv 07:18:34 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:18:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:18:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:18:34 INFO - Using real prefix '/usr' 07:18:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:18:35 INFO - Installing distribute.............................................................................................................................................................................................done. 07:18:37 INFO - Installing pip.................done. 07:18:37 INFO - Return code: 0 07:18:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:18:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1673030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1934180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19323b0>, '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 0x19332b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1933740>, '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': '6dbc10da6d83fee962c624be000001a8-1468246427.596564-1214046542', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:18:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:18:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:18:37 INFO - Using env: {'DISPLAY': ':0', 07:18:37 INFO - 'HOME': '/home/cltbld', 07:18:37 INFO - 'LANG': 'en_US.UTF-8', 07:18:37 INFO - 'LANGUAGE': 'en_US:en', 07:18:37 INFO - 'LOGNAME': 'cltbld', 07:18:37 INFO - 'MAIL': '/var/mail/cltbld', 07:18:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:37 INFO - 'MOZ_NO_REMOTE': '1', 07:18:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:37 INFO - 'NO_EM_RESTART': '1', 07:18:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:37 INFO - 'PWD': '/builds/slave/test', 07:18:37 INFO - 'SHELL': '/bin/bash', 07:18:37 INFO - 'SHLVL': '1', 07:18:37 INFO - 'TERM': 'linux', 07:18:37 INFO - 'TMOUT': '86400', 07:18:37 INFO - 'USER': 'cltbld', 07:18:37 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468246427.596564-1214046542', 07:18:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:37 INFO - '_': '/tools/buildbot/bin/python'} 07:18:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:18:37 INFO - Cleaning up... 07:18:37 INFO - Return code: 0 07:18:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:18:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1673030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1934180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19323b0>, '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 0x19332b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1933740>, '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': '6dbc10da6d83fee962c624be000001a8-1468246427.596564-1214046542', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:18:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:18:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:18:37 INFO - Using env: {'DISPLAY': ':0', 07:18:37 INFO - 'HOME': '/home/cltbld', 07:18:37 INFO - 'LANG': 'en_US.UTF-8', 07:18:37 INFO - 'LANGUAGE': 'en_US:en', 07:18:37 INFO - 'LOGNAME': 'cltbld', 07:18:37 INFO - 'MAIL': '/var/mail/cltbld', 07:18:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:37 INFO - 'MOZ_NO_REMOTE': '1', 07:18:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:37 INFO - 'NO_EM_RESTART': '1', 07:18:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:37 INFO - 'PWD': '/builds/slave/test', 07:18:37 INFO - 'SHELL': '/bin/bash', 07:18:37 INFO - 'SHLVL': '1', 07:18:37 INFO - 'TERM': 'linux', 07:18:37 INFO - 'TMOUT': '86400', 07:18:37 INFO - 'USER': 'cltbld', 07:18:37 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468246427.596564-1214046542', 07:18:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:37 INFO - '_': '/tools/buildbot/bin/python'} 07:18:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:37 INFO - Downloading/unpacking psutil>=3.1.1 07:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:18:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:18:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:18:39 INFO - Installing collected packages: psutil 07:18:39 INFO - Running setup.py install for psutil 07:18:39 INFO - building 'psutil._psutil_linux' extension 07:18:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:18:39 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:18:39 INFO - building 'psutil._psutil_posix' extension 07:18:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:18:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:18:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:18:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:18:40 INFO - Successfully installed psutil 07:18:40 INFO - Cleaning up... 07:18:40 INFO - Return code: 0 07:18:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:18: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')]} 07:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18: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')]} 07:18:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1673030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1934180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19323b0>, '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 0x19332b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1933740>, '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': '6dbc10da6d83fee962c624be000001a8-1468246427.596564-1214046542', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:18:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:18:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:18:40 INFO - Using env: {'DISPLAY': ':0', 07:18:40 INFO - 'HOME': '/home/cltbld', 07:18:40 INFO - 'LANG': 'en_US.UTF-8', 07:18:40 INFO - 'LANGUAGE': 'en_US:en', 07:18:40 INFO - 'LOGNAME': 'cltbld', 07:18:40 INFO - 'MAIL': '/var/mail/cltbld', 07:18:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:40 INFO - 'MOZ_NO_REMOTE': '1', 07:18:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:40 INFO - 'NO_EM_RESTART': '1', 07:18:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:40 INFO - 'PWD': '/builds/slave/test', 07:18:40 INFO - 'SHELL': '/bin/bash', 07:18:40 INFO - 'SHLVL': '1', 07:18:40 INFO - 'TERM': 'linux', 07:18:40 INFO - 'TMOUT': '86400', 07:18:40 INFO - 'USER': 'cltbld', 07:18:40 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468246427.596564-1214046542', 07:18:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:40 INFO - '_': '/tools/buildbot/bin/python'} 07:18:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:18:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:18:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:18:42 INFO - Installing collected packages: mozsystemmonitor 07:18:42 INFO - Running setup.py install for mozsystemmonitor 07:18:42 INFO - Successfully installed mozsystemmonitor 07:18:42 INFO - Cleaning up... 07:18:42 INFO - Return code: 0 07:18:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:18:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1673030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1934180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19323b0>, '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 0x19332b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1933740>, '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': '6dbc10da6d83fee962c624be000001a8-1468246427.596564-1214046542', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:18:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:18:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:18:42 INFO - Using env: {'DISPLAY': ':0', 07:18:42 INFO - 'HOME': '/home/cltbld', 07:18:42 INFO - 'LANG': 'en_US.UTF-8', 07:18:42 INFO - 'LANGUAGE': 'en_US:en', 07:18:42 INFO - 'LOGNAME': 'cltbld', 07:18:42 INFO - 'MAIL': '/var/mail/cltbld', 07:18:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:42 INFO - 'MOZ_NO_REMOTE': '1', 07:18:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:42 INFO - 'NO_EM_RESTART': '1', 07:18:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:42 INFO - 'PWD': '/builds/slave/test', 07:18:42 INFO - 'SHELL': '/bin/bash', 07:18:42 INFO - 'SHLVL': '1', 07:18:42 INFO - 'TERM': 'linux', 07:18:42 INFO - 'TMOUT': '86400', 07:18:42 INFO - 'USER': 'cltbld', 07:18:42 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468246427.596564-1214046542', 07:18:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:42 INFO - '_': '/tools/buildbot/bin/python'} 07:18:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:42 INFO - Downloading/unpacking jsonschema==2.5.1 07:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:18:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:45 INFO - Downloading functools32-3.2.3-2.tar.gz 07:18:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:18:45 INFO - warning: no files found matching '*.txt' 07:18:45 INFO - no previously-included directories found matching 'build' 07:18:45 INFO - no previously-included directories found matching 'dist' 07:18:45 INFO - no previously-included directories found matching '.git*' 07:18:45 INFO - Installing collected packages: jsonschema, functools32 07:18:45 INFO - Running setup.py install for functools32 07:18:45 INFO - warning: no files found matching '*.txt' 07:18:45 INFO - no previously-included directories found matching 'build' 07:18:45 INFO - no previously-included directories found matching 'dist' 07:18:45 INFO - no previously-included directories found matching '.git*' 07:18:45 INFO - Successfully installed jsonschema functools32 07:18:45 INFO - Cleaning up... 07:18:45 INFO - Return code: 0 07:18:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:18:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1673030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1934180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19323b0>, '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 0x19332b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1933740>, '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': '6dbc10da6d83fee962c624be000001a8-1468246427.596564-1214046542', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:18:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:18:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:18:45 INFO - Using env: {'DISPLAY': ':0', 07:18:45 INFO - 'HOME': '/home/cltbld', 07:18:45 INFO - 'LANG': 'en_US.UTF-8', 07:18:45 INFO - 'LANGUAGE': 'en_US:en', 07:18:45 INFO - 'LOGNAME': 'cltbld', 07:18:45 INFO - 'MAIL': '/var/mail/cltbld', 07:18:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:45 INFO - 'MOZ_NO_REMOTE': '1', 07:18:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:45 INFO - 'NO_EM_RESTART': '1', 07:18:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:45 INFO - 'PWD': '/builds/slave/test', 07:18:45 INFO - 'SHELL': '/bin/bash', 07:18:45 INFO - 'SHLVL': '1', 07:18:45 INFO - 'TERM': 'linux', 07:18:45 INFO - 'TMOUT': '86400', 07:18:45 INFO - 'USER': 'cltbld', 07:18:45 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468246427.596564-1214046542', 07:18:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:45 INFO - '_': '/tools/buildbot/bin/python'} 07:18:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:45 INFO - Downloading/unpacking blobuploader==1.2.4 07:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:47 INFO - Downloading blobuploader-1.2.4.tar.gz 07:18:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:18:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:18:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:48 INFO - Downloading docopt-0.6.1.tar.gz 07:18:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:18:48 INFO - Installing collected packages: blobuploader, requests, docopt 07:18:48 INFO - Running setup.py install for blobuploader 07:18:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:18:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:18:48 INFO - Running setup.py install for requests 07:18:48 INFO - Running setup.py install for docopt 07:18:48 INFO - Successfully installed blobuploader requests docopt 07:18:48 INFO - Cleaning up... 07:18:48 INFO - Return code: 0 07:18:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:18:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1673030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1934180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19323b0>, '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 0x19332b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1933740>, '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': '6dbc10da6d83fee962c624be000001a8-1468246427.596564-1214046542', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:18:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:18:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:18:48 INFO - Using env: {'DISPLAY': ':0', 07:18:48 INFO - 'HOME': '/home/cltbld', 07:18:48 INFO - 'LANG': 'en_US.UTF-8', 07:18:48 INFO - 'LANGUAGE': 'en_US:en', 07:18:48 INFO - 'LOGNAME': 'cltbld', 07:18:48 INFO - 'MAIL': '/var/mail/cltbld', 07:18:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:48 INFO - 'MOZ_NO_REMOTE': '1', 07:18:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:48 INFO - 'NO_EM_RESTART': '1', 07:18:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:48 INFO - 'PWD': '/builds/slave/test', 07:18:48 INFO - 'SHELL': '/bin/bash', 07:18:48 INFO - 'SHLVL': '1', 07:18:48 INFO - 'TERM': 'linux', 07:18:48 INFO - 'TMOUT': '86400', 07:18:48 INFO - 'USER': 'cltbld', 07:18:48 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468246427.596564-1214046542', 07:18:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:48 INFO - '_': '/tools/buildbot/bin/python'} 07:18:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:18:48 INFO - Running setup.py (path:/tmp/pip-1HCo6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:18:49 INFO - Running setup.py (path:/tmp/pip-UPQKsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:18:49 INFO - Running setup.py (path:/tmp/pip-tmEjem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:18:49 INFO - Running setup.py (path:/tmp/pip-57LPSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:18:49 INFO - Running setup.py (path:/tmp/pip-u7Sex9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:18:49 INFO - Running setup.py (path:/tmp/pip-t4PTaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:18:49 INFO - Running setup.py (path:/tmp/pip-iu6WS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:18:49 INFO - Running setup.py (path:/tmp/pip-wq2iqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:18:49 INFO - Running setup.py (path:/tmp/pip-neQDrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:18:49 INFO - Running setup.py (path:/tmp/pip-avO4Vw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:18:49 INFO - Running setup.py (path:/tmp/pip-BhKhRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:18:49 INFO - Running setup.py (path:/tmp/pip-jFecQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:18:49 INFO - Running setup.py (path:/tmp/pip-agUQNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:18:49 INFO - Running setup.py (path:/tmp/pip-QmTTNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:18:50 INFO - Running setup.py (path:/tmp/pip-veLzyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:18:50 INFO - Running setup.py (path:/tmp/pip-MaacHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:18:50 INFO - Running setup.py (path:/tmp/pip-XPDTGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:18:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:18:50 INFO - Running setup.py install for manifestparser 07:18:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:18:50 INFO - Running setup.py install for mozcrash 07:18:50 INFO - Running setup.py install for mozdebug 07:18:50 INFO - Running setup.py install for mozdevice 07:18:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:18:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:18:50 INFO - Running setup.py install for mozfile 07:18:50 INFO - Running setup.py install for mozhttpd 07:18:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:18:50 INFO - Running setup.py install for mozinfo 07:18:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:18:50 INFO - Running setup.py install for mozInstall 07:18:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:18:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:18:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:18:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:18:51 INFO - Running setup.py install for mozleak 07:18:51 INFO - Running setup.py install for mozlog 07:18:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:18:51 INFO - Running setup.py install for moznetwork 07:18:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:18:51 INFO - Running setup.py install for mozprocess 07:18:51 INFO - Running setup.py install for mozprofile 07:18:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:18:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:18:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:18:51 INFO - Running setup.py install for mozrunner 07:18:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:18:51 INFO - Running setup.py install for mozscreenshot 07:18:51 INFO - Running setup.py install for moztest 07:18:51 INFO - Running setup.py install for mozversion 07:18:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:18:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:18:51 INFO - Cleaning up... 07:18:52 INFO - Return code: 0 07:18:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:18: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')]} 07:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18: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')]} 07:18:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:52 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 0x1673030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1934180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19323b0>, '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 0x19332b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1933740>, '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': '6dbc10da6d83fee962c624be000001a8-1468246427.596564-1214046542', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:18:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:18:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:18:52 INFO - Using env: {'DISPLAY': ':0', 07:18:52 INFO - 'HOME': '/home/cltbld', 07:18:52 INFO - 'LANG': 'en_US.UTF-8', 07:18:52 INFO - 'LANGUAGE': 'en_US:en', 07:18:52 INFO - 'LOGNAME': 'cltbld', 07:18:52 INFO - 'MAIL': '/var/mail/cltbld', 07:18:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:52 INFO - 'MOZ_NO_REMOTE': '1', 07:18:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:52 INFO - 'NO_EM_RESTART': '1', 07:18:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:52 INFO - 'PWD': '/builds/slave/test', 07:18:52 INFO - 'SHELL': '/bin/bash', 07:18:52 INFO - 'SHLVL': '1', 07:18:52 INFO - 'TERM': 'linux', 07:18:52 INFO - 'TMOUT': '86400', 07:18:52 INFO - 'USER': 'cltbld', 07:18:52 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468246427.596564-1214046542', 07:18:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:52 INFO - '_': '/tools/buildbot/bin/python'} 07:18:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:18:52 INFO - Running setup.py (path:/tmp/pip-dkzeh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:18:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:18:52 INFO - Running setup.py (path:/tmp/pip-QLJLX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:18:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:18:52 INFO - Running setup.py (path:/tmp/pip-_eyOFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:18:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:18:52 INFO - Running setup.py (path:/tmp/pip-xyYbge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:18:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:18:52 INFO - Running setup.py (path:/tmp/pip-e0jgg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:18:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:18:52 INFO - Running setup.py (path:/tmp/pip-2T5MLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:18:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:18:52 INFO - Running setup.py (path:/tmp/pip-YqiFzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:18:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:18:52 INFO - Running setup.py (path:/tmp/pip-yePNWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:18:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:18:52 INFO - Running setup.py (path:/tmp/pip-UkH81y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:18:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:18:52 INFO - Running setup.py (path:/tmp/pip-zlK683-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:18:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:18:52 INFO - Running setup.py (path:/tmp/pip-qFZF9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:18:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:18:53 INFO - Running setup.py (path:/tmp/pip-WAwv8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:18:53 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)) 07:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:18:53 INFO - Running setup.py (path:/tmp/pip-YHgGLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:18:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:18:53 INFO - Running setup.py (path:/tmp/pip-dPD_Nn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:18:53 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)) 07:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:18:53 INFO - Running setup.py (path:/tmp/pip-WGxHLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:18:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:18:53 INFO - Running setup.py (path:/tmp/pip-5ErfKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:18:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:18:53 INFO - Running setup.py (path:/tmp/pip-9mSQF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:18:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:18:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:18:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:18:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:18:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:18:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:18:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:55 INFO - Downloading blessings-1.6.tar.gz 07:18:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:18:55 INFO - Installing collected packages: blessings 07:18:55 INFO - Running setup.py install for blessings 07:18:55 INFO - Successfully installed blessings 07:18:55 INFO - Cleaning up... 07:18:55 INFO - Return code: 0 07:18:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:18:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:18:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:18:55 INFO - Reading from file tmpfile_stdout 07:18:55 INFO - Current package versions: 07:18:55 INFO - argparse == 1.2.1 07:18:55 INFO - blessings == 1.6 07:18:55 INFO - blobuploader == 1.2.4 07:18:55 INFO - docopt == 0.6.1 07:18:55 INFO - functools32 == 3.2.3-2 07:18:55 INFO - jsonschema == 2.5.1 07:18:55 INFO - manifestparser == 1.1 07:18:55 INFO - mozInstall == 1.12 07:18:55 INFO - mozcrash == 0.17 07:18:55 INFO - mozdebug == 0.1 07:18:55 INFO - mozdevice == 0.48 07:18:55 INFO - mozfile == 1.2 07:18:55 INFO - mozhttpd == 0.7 07:18:55 INFO - mozinfo == 0.9 07:18:55 INFO - mozleak == 0.1 07:18:55 INFO - mozlog == 3.2 07:18:55 INFO - moznetwork == 0.27 07:18:55 INFO - mozprocess == 0.23 07:18:55 INFO - mozprofile == 0.28 07:18:55 INFO - mozrunner == 6.12 07:18:55 INFO - mozscreenshot == 0.1 07:18:55 INFO - mozsystemmonitor == 0.3 07:18:55 INFO - moztest == 0.7 07:18:55 INFO - mozversion == 1.4 07:18:55 INFO - psutil == 3.1.1 07:18:55 INFO - requests == 1.2.3 07:18:55 INFO - wsgiref == 0.1.2 07:18:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:18:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1673030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1934180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19323b0>, '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 0x19332b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1933740>, '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': '6dbc10da6d83fee962c624be000001a8-1468246427.596564-1214046542', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:18:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:18:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:18:55 INFO - Using env: {'DISPLAY': ':0', 07:18:55 INFO - 'HOME': '/home/cltbld', 07:18:55 INFO - 'LANG': 'en_US.UTF-8', 07:18:55 INFO - 'LANGUAGE': 'en_US:en', 07:18:55 INFO - 'LOGNAME': 'cltbld', 07:18:55 INFO - 'MAIL': '/var/mail/cltbld', 07:18:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:55 INFO - 'MOZ_NO_REMOTE': '1', 07:18:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:55 INFO - 'NO_EM_RESTART': '1', 07:18:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:55 INFO - 'PWD': '/builds/slave/test', 07:18:55 INFO - 'SHELL': '/bin/bash', 07:18:55 INFO - 'SHLVL': '1', 07:18:55 INFO - 'TERM': 'linux', 07:18:55 INFO - 'TMOUT': '86400', 07:18:55 INFO - 'USER': 'cltbld', 07:18:55 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468246427.596564-1214046542', 07:18:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:55 INFO - '_': '/tools/buildbot/bin/python'} 07:18:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:18:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:18:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:18:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:18:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:18:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:18:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:18:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:18:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:18:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:18:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:18:56 INFO - Cleaning up... 07:18:56 INFO - Return code: 0 07:18:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1673030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1934180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19323b0>, '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 0x19332b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1933740>, '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': '6dbc10da6d83fee962c624be000001a8-1468246427.596564-1214046542', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:18:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:18:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:18:56 INFO - Using env: {'DISPLAY': ':0', 07:18:56 INFO - 'HOME': '/home/cltbld', 07:18:56 INFO - 'LANG': 'en_US.UTF-8', 07:18:56 INFO - 'LANGUAGE': 'en_US:en', 07:18:56 INFO - 'LOGNAME': 'cltbld', 07:18:56 INFO - 'MAIL': '/var/mail/cltbld', 07:18:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:56 INFO - 'MOZ_NO_REMOTE': '1', 07:18:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:56 INFO - 'NO_EM_RESTART': '1', 07:18:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:56 INFO - 'PWD': '/builds/slave/test', 07:18:56 INFO - 'SHELL': '/bin/bash', 07:18:56 INFO - 'SHLVL': '1', 07:18:56 INFO - 'TERM': 'linux', 07:18:56 INFO - 'TMOUT': '86400', 07:18:56 INFO - 'USER': 'cltbld', 07:18:56 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468246427.596564-1214046542', 07:18:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:56 INFO - '_': '/tools/buildbot/bin/python'} 07:18:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:18:56 INFO - Cleaning up... 07:18:56 INFO - Return code: 0 07:18:56 INFO - Running post-action listener: _resource_record_post_action 07:18:56 INFO - Running post-action listener: _start_resource_monitoring 07:18:56 INFO - Starting resource monitoring. 07:18:56 INFO - ##### 07:18:56 INFO - ##### Finished create-virtualenv step (success) 07:18:56 INFO - ##### 07:18:56 INFO - ##### 07:18:56 INFO - ##### Running install step. 07:18:56 INFO - ##### 07:18:56 INFO - Running pre-action listener: _resource_record_pre_action 07:18:56 INFO - Running main action method: install 07:18:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:18:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:18:56 INFO - Reading from file tmpfile_stdout 07:18:56 INFO - Detecting whether we're running mozinstall >=1.0... 07:18:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:18:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:18:56 INFO - Reading from file tmpfile_stdout 07:18:56 INFO - Output received: 07:18:56 INFO - Usage: mozinstall [options] installer 07:18:56 INFO - Options: 07:18:56 INFO - -h, --help show this help message and exit 07:18:56 INFO - -d DEST, --destination=DEST 07:18:56 INFO - Directory to install application into. [default: 07:18:56 INFO - "/builds/slave/test"] 07:18:56 INFO - --app=APP Application being installed. [default: firefox] 07:18:56 INFO - mkdir: /builds/slave/test/build/application 07:18:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:18:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:19:13 INFO - Reading from file tmpfile_stdout 07:19:13 INFO - Output received: 07:19:13 INFO - /builds/slave/test/build/application/firefox/firefox 07:19:13 INFO - Running post-action listener: _resource_record_post_action 07:19:13 INFO - ##### 07:19:13 INFO - ##### Finished install step (success) 07:19:13 INFO - ##### 07:19:13 INFO - ##### 07:19:13 INFO - ##### Running run-tests step. 07:19:13 INFO - ##### 07:19:13 INFO - Running pre-action listener: _resource_record_pre_action 07:19:13 INFO - Running main action method: run_tests 07:19:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:19:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:19:13 INFO - Python 2.7.3 07:19:13 INFO - Return code: 0 07:19:13 INFO - grabbing minidump binary from tooltool 07:19:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:19:13 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 0x19323b0>, '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 0x19332b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1933740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:19:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:19:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:19:13 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:19:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:19:13 INFO - Return code: 0 07:19:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:19:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:19:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:19:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:19:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:19:13 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/N08filg4QGSMeysKRjTCOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 07:19:13 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/N08filg4QGSMeysKRjTCOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 07:19:13 INFO - Using env: {'DISPLAY': ':0', 07:19:13 INFO - 'HOME': '/home/cltbld', 07:19:13 INFO - 'LANG': 'en_US.UTF-8', 07:19:13 INFO - 'LANGUAGE': 'en_US:en', 07:19:13 INFO - 'LOGNAME': 'cltbld', 07:19:13 INFO - 'MAIL': '/var/mail/cltbld', 07:19:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:19:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:19:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:13 INFO - 'MOZ_NO_REMOTE': '1', 07:19:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:19:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:13 INFO - 'NO_EM_RESTART': '1', 07:19:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:13 INFO - 'PWD': '/builds/slave/test', 07:19:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:19:13 INFO - 'SHELL': '/bin/bash', 07:19:13 INFO - 'SHLVL': '1', 07:19:13 INFO - 'TERM': 'linux', 07:19:13 INFO - 'TMOUT': '86400', 07:19:13 INFO - 'USER': 'cltbld', 07:19:13 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468246427.596564-1214046542', 07:19:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:13 INFO - '_': '/tools/buildbot/bin/python'} 07:19:13 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/N08filg4QGSMeysKRjTCOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 07:19:14 INFO - mozversion application_buildid: 20160711023012 07:19:14 INFO - mozversion application_changeset: 0136b1e24160b1daf36846fb5aaf4a52e6f6d457 07:19:14 INFO - mozversion application_display_name: Nightly 07:19:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:19:14 INFO - mozversion application_name: Firefox 07:19:14 INFO - mozversion application_remotingname: firefox 07:19:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:19:14 INFO - mozversion application_vendor: Mozilla 07:19:14 INFO - mozversion application_version: 50.0a1 07:19:14 INFO - mozversion platform_buildid: 20160711023012 07:19:14 INFO - mozversion platform_changeset: 0136b1e24160b1daf36846fb5aaf4a52e6f6d457 07:19:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:19:14 INFO - mozversion platform_version: 50.0a1 07:19:14 INFO - using testdate: 1468246754 07:19:14 INFO - actual date: 1468246754 07:19:14 INFO - starting webserver on 'localhost:52942' 07:19:14 INFO - SUITE-START | Running 2 tests 07:19:14 INFO - TEST-START | dromaeo_css 07:19:14 INFO - operating with platform_type : linux_ 07:19:14 INFO - Initialising browser for dromaeo_css test... 07:19:14 INFO - TEST-INFO | started process 3574 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwY_GiV/profile http://localhost:52942/getInfo.html) 07:19:17 INFO - PROCESS | 3574 | __metrics Screen width/height:1600/1200 07:19:17 INFO - PROCESS | 3574 | colorDepth:24 07:19:17 INFO - PROCESS | 3574 | Browser inner width/height: 1024/697 07:19:17 INFO - PROCESS | 3574 | __metrics 07:19:18 INFO - PROCESS | 3574 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:19:18 INFO - PROCESS | 3574 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:19:19 INFO - TEST-INFO | 3574: exit 0 07:19:19 INFO - Browser initialized. 07:19:19 INFO - Running cycle 1/1 for dromaeo_css test... 07:19:19 INFO - TEST-INFO | started process 3657 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwY_GiV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:19:31 INFO - PROCESS | 3657 | RSS: Main: 157548544 07:19:31 INFO - PROCESS | 3657 | 07:20:22 INFO - PROCESS | 3657 | 1468246822739 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:22:30 INFO - PROCESS | 3657 | Cycle 1(1): loaded http://localhost:52942/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52942/tests/dromaeo/cssquery-ext.html) 07:22:31 INFO - PROCESS | 3657 | RSS: Main: 254713856 07:22:31 INFO - PROCESS | 3657 | 07:25:33 INFO - PROCESS | 3657 | Cycle 1(1): loaded http://localhost:52942/tests/dromaeo/cssquery-ext.html (next: http://localhost:52942/tests/dromaeo/cssquery-jquery.html) 07:25:34 INFO - PROCESS | 3657 | RSS: Main: 243519488 07:25:34 INFO - PROCESS | 3657 | 07:28:36 INFO - PROCESS | 3657 | Cycle 1(1): loaded http://localhost:52942/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52942/tests/dromaeo/cssquery-mootools.html) 07:28:36 INFO - PROCESS | 3657 | RSS: Main: 242311168 07:28:36 INFO - PROCESS | 3657 | 07:31:39 INFO - PROCESS | 3657 | Cycle 1(1): loaded http://localhost:52942/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52942/tests/dromaeo/cssquery-prototype.html) 07:31:39 INFO - PROCESS | 3657 | RSS: Main: 237813760 07:31:39 INFO - PROCESS | 3657 | 07:34:42 INFO - PROCESS | 3657 | Cycle 1(1): loaded http://localhost:52942/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52942/tests/dromaeo/cssquery-yui.html) 07:34:42 INFO - PROCESS | 3657 | RSS: Main: 201216000 07:34:42 INFO - PROCESS | 3657 | 07:37:45 INFO - PROCESS | 3657 | Cycle 1(1): loaded http://localhost:52942/tests/dromaeo/cssquery-yui.html (next: http://localhost:52942/tests/dromaeo/cssquery-dojo.html) 07:37:45 INFO - PROCESS | 3657 | RSS: Main: 268947456 07:37:45 INFO - PROCESS | 3657 | 07:37:45 INFO - PROCESS | 3657 | __start_tp_report 07:37:45 INFO - PROCESS | 3657 | _x_x_mozilla_page_load 07:37:45 INFO - PROCESS | 3657 | _x_x_mozilla_page_load_details 07:37:45 INFO - PROCESS | 3657 | |i|pagename|runs| 07:37:45 INFO - PROCESS | 3657 | |0;dojo.html;3029.5758593796863;3068.3249685069277;3084.6298444186696;3095.241665791881;3107.161066512042;5252.553532949694;5319.840404787863;5343.30537030186;5440.40155582886;5459.290292262005;5354.9196762048505;5355.437679043703;5379.731013449332;5391.460853914607;5431.429699881515;4802.06359759847;4864.14877396456;4893;4906.969536397361;5047.015831912779;4962.702237865739;4978.128827455199;5006.4492905780335;5024.5226703463295;5034.119029169899;4707.882302942419;4828.85513434594;4835.758212089381;4851.029794041188;4901.534354236324;4865.172920603471;4887.169181239163;4902.534259245366;4904.411470623512;4946.505349465025;4744.359511465942;4863.610911127102;4879.1461494238365;4892.315075889378;4927.236278376858;5268.868278293035;5350.30446042016;5378.46215378463;5426.213199086111;5427.240186373871;5809.883802323972;5820.330661973885;5835.795747148872;5836.562257830679;5854.531637468992;5598.272224610815;5649.067903795869;5847.707614619295;5879;5879.382664820175;5341.946580534183;5449.536789372948;5456.127019676833;5456.890862182734;5457.399686034533;5915.556333275022;5923.911141332884;5924.229850119457;5927.911081333784;5928.762849486058;5471.835844924659;5575.609707320448;5584.91622625661;5693.715314234271;5699.430056994267;5788.855278618068;5808.332041815245;5816.82549523515;5817.94182058174;5825.70871456434;5704;5741.655500669973;5749.453801888814;5750.108733146369;5755.769769209269;5554.305711786027;5662.546996240291;5691.03252447085;5708.315002199763;5754.625949313365;4362.432883725095;4377.321515165155;4379.1022840317655;4384.254676704968;4422.336649502536;3890.533136023695;3916.804159791999;3923.0780766519847;3955.940660890089;3973.7019723520275;5253.894922101536;5362.115250983544;5363.490468405495;5396.082665946798;5430.782768689287;5769.826905192851;5788;5789.768409263666;5799.33307669615;5849.941500585025;5430.239766432703;5435.864103397446;5462.863428414322;5466.644668096561;5473.972630136904;4827.493113223061;4934.087193869074;4968.1554135797005;4988.301637770715;5053.519915608012;6006.339302676702;6011.158437818709;6014.6391216527145;6014.6391216527145;6020.849478763066;5819.941800582109;5838.854028649318;5841.620294680833;5843.29880414353;5847.06446968483;5835.56233282497;5869.589128760946;5921.940780592139;5955.702214889325;6014.368491308524;5679.290088738908;5696.174054762119;5707.743151558107;5721.828345149652;5724.370319264961;5463.69949652757;5773.6824474654295;5831.620944638585;5834.970825145847;5846.269216347957;5611.80358687444;5641.830745077655;5673.716314184357;5718.628289161191;5725.16985037159;5651.43485651448;5677.858053548694;5688.260526131577;5688.374278829243;5689.288838895138;5411.377691565521;5455.045367060669;5614.522765564972;5623.493885550321;5626.634268772516;5665.688387138747;5730.74211660468;5800.1299805029585;5807.622504537191;5808.709564521672;5532.253145825423;5541.058020136506;5566.805161819317;5570.24801651788;5616.915746263728 07:37:45 INFO - PROCESS | 3657 | |1;ext.html;581.9243498345214;600.8678090820019;613.3467856732576;615.7690865925276;622.7695752571552;34002.65997340026;43511.34732979004;44776.55223447765;44782.32826507605;44829.327560086625;46502;46966.29550556745;47002.764986175105;47017;47068.29397559039;8780.034196238425;8913.732588022338;8915.55422228886;8919.509426981513;8924.241439477652;9026.638934442615;9104.226140778042;9106.86339704905;9114.635414583408;9149.085091490831;9150.77123071922;9197.95401022994;9201.125893040184;9202.815943681122;9203.079692030777;9052.456852588833;9098.272138228926;9102.180803727697;9117.95441022794;9120.954395228047;8959.73120806377;9022.639094436214;9025.638974441015;9030.051844556292;9030.096990300983;43534.12931741348;43589.78205108954;43803;43853.34219986703;43874.78062609667;3440.6043305019994;3536.29274145172;3673.448982652597;3766.8493260269556;4035.535913369971;33582.66417335844;34347;34405;34546.82726586376;35938.820305898305;4423.778811059434;4468.19572476954;4505.43682039745;4517.706349087299;4580.770961451914;366489;367421.32578674407;367485;367721;369311;56819;57187.428125719045;57599;57601.71199143978;57620.42379576234;35283.82358088245;36209.81895090508;36232.45651315233;38549.229015419536;38559.61440385616;16565.337386504405;16585.83414165867;16591.336346546002;16643.50069497917;16669.24988375526;13803.378847951866;13919.791203131961;13925.373358198905;13932.791008134885;13940.093893896865;19838.40484785459;19912.402627921187;20165.899170504348;20213.49466263355;20245.696314555295;6928.579641173547;7162.355388015104;7197.388222001188;7316.524425912298;7352.272216029229;974.6296407365156;1008.3596915958419;1034.8551202831609;1071.5874388360537;1123.5168877382641;32083;32337.35325293481;32583.185420364207;32632.673673262965;32912.506312405334;865.3207232322596;1107.379867274329;1137.8350139229765;1165.7143999720122;1189.79178643737;16627.833721662628;16635.168241588115;16974.660506789794;17002.744958825628;17237.224324905408;611489;614815;618251;620807;622676;59195.704021479614;60153;60357.09464358038;60578.697106514184;60657.69671151616;1214.338185688784;1320.828292321992;1370.136813807295;1374.4914381678843;1378.200643626694;33045.33909321752;34216.486752698234;34400.41996850196;34678;34814.65185348215;51333.379995800555;51812.481875182275;51861.740691296305;51942;51975;427044;429166;429476;431337;492745;27628.585571216045;28063.859680702284;28170;29312.120636380943;29398.559021614266;48937;49723;49864.50135498599;50334.49665503298;50748.74625626848;40150.397744034446;41950.79024604857;41980.160396792504;42677.57322426736;43602.78198609113;38935;40108;40324.79837600793;40360;40428.59571404248;41039;41113.1777364457;41135.1772964545;42409.151816964106;42502.36246456244;36541.45187822238;38072.80963595164;38146.67509569784;38382;38731;28062.579061314504;28250;28437.289067773472;28482.430351393272;28511.714882851735 07:37:45 INFO - PROCESS | 3657 | |2;jquery.html;395.7309029859695;399.06817580948484;404.82187837351563;406.07617669801203;417.50317122624074;18630.068496575186;19894.900525497353;20284.99999999998;20306.289279875207;21234.25680101197;19938.202471901142;20264.59470810583;20329.28847490338;20398.246236758034;20515.589688206226;5650.943490565093;5940.97029514854;5965.1946987156825;5987.341392446828;5994.07091900756;5747.770089196448;5856.502197313233;5899.734511946951;5976.163337132783;5977.4022597740095;5878.059510478324;5898.498627616657;5912.940870591304;5917.082852157922;5919.112133180036;5620.269364982567;5804.361520232771;5897.587168898179;5899.528037756969;5903.734331955051;5093.465186155438;5154.226865970097;5157.4068982067165;5165.328507294065;5166.664166829144;23837.28488145341;24478;24677.50644987108;24697.506049878903;24864.12975545847;2291.472961218929;2401.903923843044;2501.987490062538;2566.1747832420488;2581.974180258211;14671.77992330116;14743.041702289423;15177.317020733983;15499.147546884917;15658.765118523232;1979.2973494409566;2001.8498612603967;2032.552838375555;2048.7336646235894;2092.016752126498;54945;58012.70993645047;85163;86078.5696071522;88273.55863220643;10776.568937242579;10779;10970.122390208764;10973.50619222137;11106.556147700909;15317.31072101758;15444.613884652974;15453.381864725285;15503.84496155024;15523.068615882858;8355.498670079814;8456.957715211385;8537.103604121601;8605.182507661762;8693.869591956125;8204.589770511451;8208.46644968075;8383.28742056932;8440.57797110142;8553.529555874487;6660.200775906922;6860.176778786577;6880.69036893341;6962;6963.373296403348;1924.259160223296;1932.6811076172273;1957.2464601128383;1961.8038196180553;1979.3764964036282;997.7455748784014;1011.8178727828914;1020.4999550220487;1033.5194134727237;1035.7307100154014;20537.58924821495;21198.576028479343;21429.46426339354;21451.67822482664;21546.461338466663;1036.9533370998324;1042.4735508568124;1077.0199118801852;1077.7628921637227;1084.38732116354;11600.361980091007;11925.68817430082;11974.46114924813;12003.339816310187;12061;512345;517069;531190;531640;531651;64068;85521.57239213763;88063.55968220117;88123;90855.54572227097;994.9403035817729;1008.1732978957185;1027.2655051638114;1028.9691309260734;1062.4103622489592;19411.417657470298;19572.412827615193;19955.900220499385;20083.497912552302;20121.798782011992;29464.705352946195;29627.851860740557;31948.840255798572;41438.96402589959;44101.117977639624;57213.56471135235;57545.71227143837;58406;59853.40146598653;60679.39320606914;9153.542322883963;9177.54112294396;9241.815163696554;9380.296477764332;9471.289653275893;12648.494060237488;14329.57011289663;14347.92826035863;14531.564053078424;14970.32633531472;12613.432395542406;12668;12689.23864568129;12730.936345318214;12773;12432.12975091735;12545.724566177174;12677.80983285233;12809.8078528824;12912.935435322763;12663.81004284918;12942.158759680591;12976;13045.934770326088;13055.673608159872;9152.816943661222;9206.953965230132;9244.815103698023;9314.906850931675;9373.287773582671;11011.01801675706;11953.462094205608;12034.578789742318;12075.456604452645;12502.937485312515 07:37:45 INFO - PROCESS | 3657 | |3;mootools.html;1441.128117488919;1497.1915165810462;1593.3865461797204;1732.4802559232244;1795.210107552676;8475.957620211899;8908.242799362046;9013.95493022534;9020.458772473648;9024.909750902498;7579.6589153488085;8248.83502329953;8536.615852286646;8553.272971797405;8842.336824738155;2364.7635236476385;2396.293093537402;2398.268528098938;2399.748026457223;2402.3033320337167;2341.098677009347;2388.6417037444435;2393.85636861788;2397.2448678666165;2401.147592604618;2038.7961203879568;2088.7597926238527;2291.9770802291932;2372.1460274301326;2381.4760752634393;2362.7400985891536;2376.4771750214927;2390.163442795008;2398.844075135128;2400.327908185711;2345.812335013212;2349.3891588187194;2355.705536807899;2357.97642023581;2359.2332491940188;8909.064548222408;8955.820883582357;8976.551172441417;8978.640854365818;8993.505357205351;5257.842264732064;5404.945950540484;5411.648242864201;5413.323334583177;5416.512513873731;3573.5533058367705;3576.695980841632;3628.1836586767768;3635.363811333006;3642.7450078494517;1087.4617064553097;1093.3822390349508;1099.5491848342142;1108.8281316395971;1117.3742704085737;12421.627351179388;12440.004799616008;12453;12459;12466.501339946391;4558.49856515783;4585.885352866205;4758;4765.594924431392;4790.8323208687525;10532.57869685204;10533.052025317758;10542.420166890895;10547;10557.9472102639;5409.864753381197;5414.052540805422;5416.458354164631;5419.810306639328;5429.104197807396;4942;4962.528559786814;4993.275974983607;5006;5033.270175824485;3907.628775266345;3921.764694118362;3927.8428862845167;4035.616616421435;4122.381642753551;1151.9712007199887;1225.9448324825405;1232.5870833270956;1249.6376050945305;1249.6750844780422;987.5457289646843;994.8209322322051;996.7707427291764;997.6209040564539;1012.8835183953939;5884.411558844081;5935.7625694972585;5962.850928726816;5981.192539007178;6092.664903430354;903.814717982812;963.6679236248295;971;972.2707969023232;1003.3027046202965;3883.339832228528;4080.8571699990953;4086.387041943732;4109.691773116969;4156.896077598024;10763.408012559228;11074.723131921766;11184.161187910939;11187.4965626547;11197.216194866443;9809.901900981042;10477.057064864199;11059.115270778319;11067.335959842436;11081.612143575097;8069.757907262791;8454.66181352739;8466;8468.110848360957;8474.915250847536;6090.208272924491;6108.35862234459;6218.8806014917745;6261.373862613702;6404.199475065617;9964.451955142536;10036.347637403545;10363.585456581652;10432.061114499731;10443.321184123008;9817.950910245403;10156.949215253877;10171.949140254252;10187.08316251541;10368.222383321432;8533.957330213309;8559.358048146538;8695.087015863497;8702.738917832476;8703;8450.239478446969;8562.357823163164;8587.184217499327;8631.6978905738;8649.697260595849;6349.396807303298;7723.845523089394;7906.327962123284;7916.84166316682;7976.561289129154;7707.691692332468;7722.613869306625;7879.172686867796;7900.881486777818;7955.721549745731;7120.928790712233;7199.316064973819;7199.748008819666;7325.523840950321;7330.120385553768;4814;4872.43966943806;4911.066897289504;4911.7298548580175;4928.507149285043;5497.725113744376;5538.113901775697;5553.6390134641115;5564.360098588714;5648.083260023533 07:37:45 INFO - PROCESS | 3657 | |4;prototype.html;318.02208209755;326.0934601806977;327.4482496992568;338.9915252118698;343.93465241604093;5353.518183363496;5406.621536492447;5419.566434685225;5435.28235882058;5438.483344082316;5047;5166.870828229296;5179.14544100224;5190.299309593203;5348.518633323;4006.699497537682;4126.83492660294;4152.937705934413;4196.97901510492;4197.4753155855515;4115.156392939441;4156.688248381369;4163.937540936873;4165.5834416558255;4186.56041115683;4066.8983275418204;4139.2135494256145;4153.193360888008;4177.644900183473;4179.373094035888;4144.647704945083;4151.356539736345;4151.937720934188;4157.812898419578;4184.707070505081;3685.3919103347916;3698.4637227601847;3699.5213207151273;3702.2780557791243;3721.5534135903595;4995.550400463976;5142.228665700138;5162.174052151675;5200.453952335026;5222.060029194743;4727.6762506498235;4749.430068391815;4771.427428708543;4781;4800.399950006249;5446.2375267462585;5455.509004189642;5530.225768392428;5542.307211598551;5549.889002219973;3907.6483116519366;4044.474218351625;4066.9389959150635;4072.429859819628;4080.2655522006025;5655.462731040545;5657.886842263131;5663.377028526858;5692.800751973702;5748.367679555246;4023.4970628671417;4043.2317859606583;4047.138316374501;4106.7125301229225;4129.380592911088;4069.674426045909;4166.166766646622;4166.270902592034;4172.353285240732;4179.644730197906;4704.694194877322;4713.878754560462;4713.939363643153;4751.786169622375;4767.76161191946;5555.833325000176;5579.2746942897165;5580.302462192226;5581.6930068845795;5586.972065139648;1322.9073964822562;1389.8540653231466;1428.39293300349;1449.7680371140566;1450.8549145085617;987.5309228116731;1015.8120747661707;1026.1175389165462;1033.4419413516616;1034.1054987435814;5349.277847490617;5351.759170837244;5370.892582148414;5375;5399.973000134974;5613.410591887875;5624.887502250014;5640.520555752725;5671.546276297886;5682.488576028178;5204.271402003723;5485.561155107582;5497.993232470119;5505.9724701376235;5506.972465137729;3020.8338541380435;3039.814472355783;3047.2229581456586;3052.1759125036115;3053.6640969493337;5645.266115404971;5850.297964244318;5873.236479257669;5925.067091789591;5926.436988486087;5639.42096213061;5688.459596338341;5749.453801888814;5769.567282453832;5779.653220806765;5799.391063938226;5858.736356863951;5873.295204575393;5939.851503712442;5942.098528470848;5533.253010843646;5615.157726341082;5638.689872057076;5658.887611813404;5697.772089116389;5563.221149039218;5567.8886422272135;5600.243967064394;5635.295588051494;5648.915266270927;5600.747966341443;5814.848506052787;5881.470667639762;5917.497012753792;5930.406959304035;3841.250956063541;4074.8166332514515;4085;4085.264652362603;4103.466549348565;5614.85962850932;5706.600537962303;5760.107183386582;5802.4197580241635;5804.709764511673;5568.276124103841;5588.804391846266;5600.607957443103;5617.831465056055;5624.634398764068;5276.314079169683;5495.862603434946;5559.916601250903;5581.04663367818;5591.720413979366;5497.587680923867;5518.53092487127;5529.751161197836;5535.142052981794;5539.861503462445;5623.971880140573;5686.914696279477;5691.630044047124;5718.828435146952;5719.199312096227;5288.7258478854465;5519;5529;5533.7786488541615;5536.390996990247 07:37:45 INFO - PROCESS | 3657 | |5;yui.html;747.3386053342791;754.113916148525;763.9656215470303;790.7983464216627;839.5652607438428;14985.775213371795;15231.923840380783;15811;16085.91957040216;16108.516744497654;14872.851271487281;14992.325345359457;15034.774478382833;15037.473688420907;15042.924785376057;650.4146268358468;802.7551596762985;809.6963638635511;834.0783434305097;836.3518273338182;826.9958650206771;838.4885220015785;840.6931470013432;840.8528507511191;841.1420351241729;880.6433394475248;884.0717246890739;884.2351366068369;885.9379843410964;886.3618194899661;693.9236683964785;832.305025303872;851.3487182305541;866.3935245328264;873.7597160780805;624.709510077816;625.0717684238901;625.3933684326241;625.4058644287944;626.3704976498635;14802.40790368384;14850.480233191787;14866.331015104346;14876.479323223744;14882.925585372112;14245;14263.928680356636;14353.569392918229;14483.637909052253;14617.12297262157;12956.09307348486;13219.537316193888;13358.198508089448;13360.86639133606;13472.797908031387;4344.239758042361;4356.934645980313;4375.606195442426;4460.264056430718;4541.137183935041;68044.6597767008;70418.29581704168;78686;78945.60527197385;79369.60315198445;11744.94127529374;11996.64010079699;12024.699382515331;12215.93892030552;12529.498820047096;21510.139594416047;21626;21645.458863528536;21646.134154633637;21675.34973950784;8586.78533036679;8727.389082764146;8768.298536117096;8807.603657835412;8811.911880881238;4898.804047838118;4900.558949694473;5026.773795179226;5033.464793238098;5048.3184770056305;3264.102371847761;3351.2124650707065;3351.463765797461;3362.445196542592;3367.393869103585;653.8496145886378;658.338369938209;663.5255792108666;670.0920253057135;674.3458844920419;669.8827705151579;711.9537230080028;724.6594100772628;727.3490226247479;733.6185183704443;9673.564689588986;10130.746731331628;10290.12533934624;10302.845457318146;10394.272400932014;668.2649086005355;675.8817206988856;717.9928200718031;735.4594373135741;763.4121726270852;4701.811927522861;4842.709437433695;4885.1206782779445;4924.138275801721;4963.354763880745;98657;102486;103803.4809825946;112968.43515782533;117629;99353.50323248337;99525.50237248768;99787.50106249422;99881;101063.49468252611;82278.17721822824;85934.57032714796;86731.56634216789;88781;89439.55280223557;9884.654037108954;9922.255830812574;10071.949640251752;10086.596536138471;10143.137833284254;42537.78731106449;48445.75777121092;51173;51173.23240151475;53482.4651753493;74752;77286;78832;79140.60429697814;79805;12658.810117848423;12898.940155230843;12995.28525931083;13262.270575118075;13317.800232996706;13811.585652430444;13875.514356997457;13917.79123313131;14254.216018119103;14418.351174196976;14478.782818257523;14648.560543183721;14748.483803066842;14757.335919883846;14784.63038424048;13239.27184004889;13501.527446539323;13693.724165717615;13871.79192312096;14285;12800.295983720613;12851.807222891477;13053.543125990545;14313.912198218672;14485.803912165926;10864;11134;11148.55405783792;11662.591809286974;11759.529618815151;11204.327740335606;11287.661370158909;11610.361430121424;11648.888445817896;11767.411629418666 07:37:45 INFO - PROCESS | 3657 | __end_tp_report 07:37:45 INFO - PROCESS | 3657 | __start_cc_report 07:37:45 INFO - PROCESS | 3657 | _x_x_mozilla_cycle_collect,827 07:37:45 INFO - PROCESS | 3657 | __end_cc_report 07:37:45 INFO - PROCESS | 3657 | __startTimestamp1468247865981__endTimestamp 07:37:45 INFO - PROCESS | 3657 | 07:37:45 INFO - PROCESS | 3657 | ------- Summary: start ------- 07:37:45 INFO - PROCESS | 3657 | Number of tests: 6 07:37:45 INFO - PROCESS | 3657 | 07:37:45 INFO - PROCESS | 3657 | [#0] dojo.html Cycles:165 Average:5358.01 Median:5566.81 stddev:621.30 (11.2%) stddev-sans-first:595.75 07:37:45 INFO - PROCESS | 3657 | Values: 3029.6 3068.3 3084.6 3095.2 3107.2 5252.6 5319.8 5343.3 5440.4 5459.3 5354.9 5355.4 5379.7 5391.5 5431.4 4802.1 4864.1 4893.0 4907.0 5047.0 4962.7 4978.1 5006.4 5024.5 5034.1 4707.9 4828.9 4835.8 4851.0 4901.5 4865.2 4887.2 4902.5 4904.4 4946.5 4744.4 4863.6 4879.1 4892.3 4927.2 5268.9 5350.3 5378.5 5426.2 5427.2 5809.9 5820.3 5835.8 5836.6 5854.5 5598.3 5649.1 5847.7 5879.0 5879.4 5341.9 5449.5 5456.1 5456.9 5457.4 5915.6 5923.9 5924.2 5927.9 5928.8 5471.8 5575.6 5584.9 5693.7 5699.4 5788.9 5808.3 5816.8 5817.9 5825.7 5704.0 5741.7 5749.5 5750.1 5755.8 5554.3 5662.5 5691.0 5708.3 5754.6 4362.4 4377.3 4379.1 4384.3 4422.3 3890.5 3916.8 3923.1 3955.9 3973.7 5253.9 5362.1 5363.5 5396.1 5430.8 5769.8 5788.0 5789.8 5799.3 5849.9 5430.2 5435.9 5462.9 5466.6 5474.0 4827.5 4934.1 4968.2 4988.3 5053.5 6006.3 6011.2 6014.6 6014.6 6020.8 5819.9 5838.9 5841.6 5843.3 5847.1 5835.6 5869.6 5921.9 5955.7 6014.4 5679.3 5696.2 5707.7 5721.8 5724.4 5463.7 5773.7 5831.6 5835.0 5846.3 5611.8 5641.8 5673.7 5718.6 5725.2 5651.4 5677.9 5688.3 5688.4 5689.3 5411.4 5455.0 5614.5 5623.5 5626.6 5665.7 5730.7 5800.1 5807.6 5808.7 5532.3 5541.1 5566.8 5570.2 5616.9 07:37:45 INFO - PROCESS | 3657 | 07:37:45 INFO - PROCESS | 3657 | [#1] ext.html Cycles:180 Average:63017.19 Median:42455.76 stddev:129706.51 (305.5%) stddev-sans-first:129985.66 07:37:45 INFO - PROCESS | 3657 | Values: 581.9 600.9 613.3 615.8 622.8 34002.7 43511.3 44776.6 44782.3 44829.3 46502.0 46966.3 47002.8 47017.0 47068.3 8780.0 8913.7 8915.6 8919.5 8924.2 9026.6 9104.2 9106.9 9114.6 9149.1 9150.8 9198.0 9201.1 9202.8 9203.1 9052.5 9098.3 9102.2 9118.0 9121.0 8959.7 9022.6 9025.6 9030.1 9030.1 43534.1 43589.8 43803.0 43853.3 43874.8 3440.6 3536.3 3673.4 3766.8 4035.5 33582.7 34347.0 34405.0 34546.8 35938.8 4423.8 4468.2 4505.4 4517.7 4580.8 366489.0 367421.3 367485.0 367721.0 369311.0 56819.0 57187.4 57599.0 57601.7 57620.4 35283.8 36209.8 36232.5 38549.2 38559.6 16565.3 16585.8 16591.3 16643.5 16669.2 13803.4 13919.8 13925.4 13932.8 13940.1 19838.4 19912.4 20165.9 20213.5 20245.7 6928.6 7162.4 7197.4 7316.5 7352.3 974.6 1008.4 1034.9 1071.6 1123.5 32083.0 32337.4 32583.2 32632.7 32912.5 865.3 1107.4 1137.8 1165.7 1189.8 16627.8 16635.2 16974.7 17002.7 17237.2 611489.0 614815.0 618251.0 620807.0 622676.0 59195.7 60153.0 60357.1 60578.7 60657.7 1214.3 1320.8 1370.1 1374.5 1378.2 33045.3 34216.5 34400.4 34678.0 34814.7 51333.4 51812.5 51861.7 51942.0 51975.0 427044.0 429166.0 429476.0 431337.0 492745.0 27628.6 28063.9 28170.0 29312.1 29398.6 48937.0 49723.0 49864.5 50334.5 50748.7 40150.4 41950.8 41980.2 42677.6 43602.8 38935.0 40108.0 40324.8 40360.0 40428.6 41039.0 41113.2 41135.2 42409.2 42502.4 36541.5 38072.8 38146.7 38382.0 38731.0 28062.6 28250.0 28437.3 28482.4 28511.7 07:37:45 INFO - PROCESS | 3657 | 07:37:45 INFO - PROCESS | 3657 | [#2] jquery.html Cycles:180 Average:30037.37 Median:13439.95 stddev:86018.94 (640.0%) stddev-sans-first:86231.45 07:37:45 INFO - PROCESS | 3657 | Values: 395.7 399.1 404.8 406.1 417.5 18630.1 19894.9 20285.0 20306.3 21234.3 19938.2 20264.6 20329.3 20398.2 20515.6 5650.9 5941.0 5965.2 5987.3 5994.1 5747.8 5856.5 5899.7 5976.2 5977.4 5878.1 5898.5 5912.9 5917.1 5919.1 5620.3 5804.4 5897.6 5899.5 5903.7 5093.5 5154.2 5157.4 5165.3 5166.7 23837.3 24478.0 24677.5 24697.5 24864.1 2291.5 2401.9 2502.0 2566.2 2582.0 14671.8 14743.0 15177.3 15499.1 15658.8 1979.3 2001.8 2032.6 2048.7 2092.0 54945.0 58012.7 85163.0 86078.6 88273.6 10776.6 10779.0 10970.1 10973.5 11106.6 15317.3 15444.6 15453.4 15503.8 15523.1 8355.5 8457.0 8537.1 8605.2 8693.9 8204.6 8208.5 8383.3 8440.6 8553.5 6660.2 6860.2 6880.7 6962.0 6963.4 1924.3 1932.7 1957.2 1961.8 1979.4 997.7 1011.8 1020.5 1033.5 1035.7 20537.6 21198.6 21429.5 21451.7 21546.5 1037.0 1042.5 1077.0 1077.8 1084.4 11600.4 11925.7 11974.5 12003.3 12061.0 512345.0 517069.0 531190.0 531640.0 531651.0 64068.0 85521.6 88063.6 88123.0 90855.5 994.9 1008.2 1027.3 1029.0 1062.4 19411.4 19572.4 19955.9 20083.5 20121.8 29464.7 29627.9 31948.8 41439.0 44101.1 57213.6 57545.7 58406.0 59853.4 60679.4 9153.5 9177.5 9241.8 9380.3 9471.3 12648.5 14329.6 14347.9 14531.6 14970.3 12613.4 12668.0 12689.2 12730.9 12773.0 12432.1 12545.7 12677.8 12809.8 12912.9 12663.8 12942.2 12976.0 13045.9 13055.7 9152.8 9207.0 9244.8 9314.9 9373.3 11011.0 11953.5 12034.6 12075.5 12502.9 07:37:45 INFO - PROCESS | 3657 | 07:37:45 INFO - PROCESS | 3657 | [#3] mootools.html Cycles:180 Average:5889.61 Median:4891.75 stddev:3329.47 (68.1%) stddev-sans-first:3322.02 07:37:45 INFO - PROCESS | 3657 | Values: 1441.1 1497.2 1593.4 1732.5 1795.2 8476.0 8908.2 9014.0 9020.5 9024.9 7579.7 8248.8 8536.6 8553.3 8842.3 2364.8 2396.3 2398.3 2399.7 2402.3 2341.1 2388.6 2393.9 2397.2 2401.1 2038.8 2088.8 2292.0 2372.1 2381.5 2362.7 2376.5 2390.2 2398.8 2400.3 2345.8 2349.4 2355.7 2358.0 2359.2 8909.1 8955.8 8976.6 8978.6 8993.5 5257.8 5404.9 5411.6 5413.3 5416.5 3573.6 3576.7 3628.2 3635.4 3642.7 1087.5 1093.4 1099.5 1108.8 1117.4 12421.6 12440.0 12453.0 12459.0 12466.5 4558.5 4585.9 4758.0 4765.6 4790.8 10532.6 10533.1 10542.4 10547.0 10557.9 5409.9 5414.1 5416.5 5419.8 5429.1 4942.0 4962.5 4993.3 5006.0 5033.3 3907.6 3921.8 3927.8 4035.6 4122.4 1152.0 1225.9 1232.6 1249.6 1249.7 987.5 994.8 996.8 997.6 1012.9 5884.4 5935.8 5962.9 5981.2 6092.7 903.8 963.7 971.0 972.3 1003.3 3883.3 4080.9 4086.4 4109.7 4156.9 10763.4 11074.7 11184.2 11187.5 11197.2 9809.9 10477.1 11059.1 11067.3 11081.6 8069.8 8454.7 8466.0 8468.1 8474.9 6090.2 6108.4 6218.9 6261.4 6404.2 9964.5 10036.3 10363.6 10432.1 10443.3 9818.0 10156.9 10171.9 10187.1 10368.2 8534.0 8559.4 8695.1 8702.7 8703.0 8450.2 8562.4 8587.2 8631.7 8649.7 6349.4 7723.8 7906.3 7916.8 7976.6 7707.7 7722.6 7879.2 7900.9 7955.7 7120.9 7199.3 7199.7 7325.5 7330.1 4814.0 4872.4 4911.1 4911.7 4928.5 5497.7 5538.1 5553.6 5564.4 5648.1 07:37:45 INFO - PROCESS | 3657 | 07:37:45 INFO - PROCESS | 3657 | [#4] prototype.html Cycles:180 Average:4691.55 Median:5372.95 stddev:1366.63 (25.4%) stddev-sans-first:1330.46 07:37:45 INFO - PROCESS | 3657 | Values: 318.0 326.1 327.4 339.0 343.9 5353.5 5406.6 5419.6 5435.3 5438.5 5047.0 5166.9 5179.1 5190.3 5348.5 4006.7 4126.8 4152.9 4197.0 4197.5 4115.2 4156.7 4163.9 4165.6 4186.6 4066.9 4139.2 4153.2 4177.6 4179.4 4144.6 4151.4 4151.9 4157.8 4184.7 3685.4 3698.5 3699.5 3702.3 3721.6 4995.6 5142.2 5162.2 5200.5 5222.1 4727.7 4749.4 4771.4 4781.0 4800.4 5446.2 5455.5 5530.2 5542.3 5549.9 3907.6 4044.5 4066.9 4072.4 4080.3 5655.5 5657.9 5663.4 5692.8 5748.4 4023.5 4043.2 4047.1 4106.7 4129.4 4069.7 4166.2 4166.3 4172.4 4179.6 4704.7 4713.9 4713.9 4751.8 4767.8 5555.8 5579.3 5580.3 5581.7 5587.0 1322.9 1389.9 1428.4 1449.8 1450.9 987.5 1015.8 1026.1 1033.4 1034.1 5349.3 5351.8 5370.9 5375.0 5400.0 5613.4 5624.9 5640.5 5671.5 5682.5 5204.3 5485.6 5498.0 5506.0 5507.0 3020.8 3039.8 3047.2 3052.2 3053.7 5645.3 5850.3 5873.2 5925.1 5926.4 5639.4 5688.5 5749.5 5769.6 5779.7 5799.4 5858.7 5873.3 5939.9 5942.1 5533.3 5615.2 5638.7 5658.9 5697.8 5563.2 5567.9 5600.2 5635.3 5648.9 5600.7 5814.8 5881.5 5917.5 5930.4 3841.3 4074.8 4085.0 4085.3 4103.5 5614.9 5706.6 5760.1 5802.4 5804.7 5568.3 5588.8 5600.6 5617.8 5624.6 5276.3 5495.9 5559.9 5581.0 5591.7 5497.6 5518.5 5529.8 5535.1 5539.9 5624.0 5686.9 5691.6 5718.8 5719.2 5288.7 5519.0 5529.0 5533.8 5536.4 07:37:45 INFO - PROCESS | 3657 | 07:37:45 INFO - PROCESS | 3657 | [#5] yui.html Cycles:180 Average:20781.03 Median:4417.94 stddev:29395.06 (665.4%) stddev-sans-first:29439.03 07:37:45 INFO - PROCESS | 3657 | Values: 747.3 754.1 764.0 790.8 839.6 14985.8 15231.9 15811.0 16085.9 16108.5 14872.9 14992.3 15034.8 15037.5 15042.9 650.4 802.8 809.7 834.1 836.4 827.0 838.5 840.7 840.9 841.1 880.6 884.1 884.2 885.9 886.4 693.9 832.3 851.3 866.4 873.8 624.7 625.1 625.4 625.4 626.4 14802.4 14850.5 14866.3 14876.5 14882.9 14245.0 14263.9 14353.6 14483.6 14617.1 12956.1 13219.5 13358.2 13360.9 13472.8 4344.2 4356.9 4375.6 4460.3 4541.1 68044.7 70418.3 78686.0 78945.6 79369.6 11744.9 11996.6 12024.7 12215.9 12529.5 21510.1 21626.0 21645.5 21646.1 21675.3 8586.8 8727.4 8768.3 8807.6 8811.9 4898.8 4900.6 5026.8 5033.5 5048.3 3264.1 3351.2 3351.5 3362.4 3367.4 653.8 658.3 663.5 670.1 674.3 669.9 712.0 724.7 727.3 733.6 9673.6 10130.7 10290.1 10302.8 10394.3 668.3 675.9 718.0 735.5 763.4 4701.8 4842.7 4885.1 4924.1 4963.4 98657.0 102486.0 103803.5 112968.4 117629.0 99353.5 99525.5 99787.5 99881.0 101063.5 82278.2 85934.6 86731.6 88781.0 89439.6 9884.7 9922.3 10071.9 10086.6 10143.1 42537.8 48445.8 51173.0 51173.2 53482.5 74752.0 77286.0 78832.0 79140.6 79805.0 12658.8 12898.9 12995.3 13262.3 13317.8 13811.6 13875.5 13917.8 14254.2 14418.4 14478.8 14648.6 14748.5 14757.3 14784.6 13239.3 13501.5 13693.7 13871.8 14285.0 12800.3 12851.8 13053.5 14313.9 14485.8 10864.0 11134.0 11148.6 11662.6 11759.5 11204.3 11287.7 11610.4 11648.9 11767.4 07:37:45 INFO - PROCESS | 3657 | -------- Summary: end -------- 07:37:45 INFO - PROCESS | 3657 | 07:37:46 INFO - TEST-INFO | 3657: exit 0 07:37:46 INFO - TEST-OK | dromaeo_css | took 1112626ms 07:37:46 INFO - TEST-START | kraken 07:37:46 INFO - operating with platform_type : linux_ 07:37:46 INFO - Initialising browser for kraken test... 07:37:46 INFO - TEST-INFO | started process 3887 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB44bmh/profile http://localhost:52942/getInfo.html) 07:37:50 INFO - PROCESS | 3887 | __metrics Screen width/height:1600/1200 07:37:50 INFO - PROCESS | 3887 | colorDepth:24 07:37:50 INFO - PROCESS | 3887 | Browser inner width/height: 1024/697 07:37:50 INFO - PROCESS | 3887 | __metrics 07:37:51 INFO - PROCESS | 3887 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:37:51 INFO - PROCESS | 3887 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:37:52 INFO - TEST-INFO | 3887: exit 0 07:37:52 INFO - Browser initialized. 07:37:52 INFO - Running cycle 1/1 for kraken test... 07:37:52 INFO - TEST-INFO | started process 3969 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB44bmh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:38:04 INFO - PROCESS | 3969 | RSS: Main: 157503488 07:38:04 INFO - PROCESS | 3969 | 07:38:06 INFO - PROCESS | 3969 | Cycle 1(1): loaded http://localhost:52942/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52942/tests/kraken/driver.html?testName=audio-beat-detection) 07:38:07 INFO - PROCESS | 3969 | RSS: Main: 215416832 07:38:07 INFO - PROCESS | 3969 | 07:38:10 INFO - PROCESS | 3969 | Cycle 1(1): loaded http://localhost:52942/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52942/tests/kraken/driver.html?testName=audio-dft) 07:38:10 INFO - PROCESS | 3969 | RSS: Main: 203476992 07:38:10 INFO - PROCESS | 3969 | 07:38:13 INFO - PROCESS | 3969 | Cycle 1(1): loaded http://localhost:52942/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52942/tests/kraken/driver.html?testName=audio-fft) 07:38:14 INFO - PROCESS | 3969 | RSS: Main: 270143488 07:38:14 INFO - PROCESS | 3969 | 07:38:16 INFO - PROCESS | 3969 | Cycle 1(1): loaded http://localhost:52942/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52942/tests/kraken/driver.html?testName=audio-oscillator) 07:38:17 INFO - PROCESS | 3969 | RSS: Main: 180535296 07:38:17 INFO - PROCESS | 3969 | 07:38:19 INFO - PROCESS | 3969 | Cycle 1(1): loaded http://localhost:52942/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52942/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:38:19 INFO - PROCESS | 3969 | RSS: Main: 185073664 07:38:19 INFO - PROCESS | 3969 | 07:38:22 INFO - PROCESS | 3969 | Cycle 1(1): loaded http://localhost:52942/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52942/tests/kraken/driver.html?testName=imaging-darkroom) 07:38:23 INFO - PROCESS | 3969 | RSS: Main: 219475968 07:38:23 INFO - PROCESS | 3969 | 07:38:26 INFO - PROCESS | 3969 | Cycle 1(1): loaded http://localhost:52942/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52942/tests/kraken/driver.html?testName=imaging-desaturate) 07:38:27 INFO - PROCESS | 3969 | RSS: Main: 221945856 07:38:27 INFO - PROCESS | 3969 | 07:38:30 INFO - PROCESS | 3969 | Cycle 1(1): loaded http://localhost:52942/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52942/tests/kraken/driver.html?testName=json-parse-financial) 07:38:30 INFO - PROCESS | 3969 | RSS: Main: 221822976 07:38:30 INFO - PROCESS | 3969 | 07:38:32 INFO - PROCESS | 3969 | Cycle 1(1): loaded http://localhost:52942/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52942/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:38:32 INFO - PROCESS | 3969 | RSS: Main: 208670720 07:38:32 INFO - PROCESS | 3969 | 07:38:34 INFO - PROCESS | 3969 | Cycle 1(1): loaded http://localhost:52942/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52942/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:38:35 INFO - PROCESS | 3969 | RSS: Main: 213045248 07:38:35 INFO - PROCESS | 3969 | 07:38:37 INFO - PROCESS | 3969 | Cycle 1(1): loaded http://localhost:52942/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52942/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:38:37 INFO - PROCESS | 3969 | RSS: Main: 209694720 07:38:37 INFO - PROCESS | 3969 | 07:38:40 INFO - PROCESS | 3969 | Cycle 1(1): loaded http://localhost:52942/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52942/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:38:41 INFO - PROCESS | 3969 | RSS: Main: 224546816 07:38:41 INFO - PROCESS | 3969 | 07:38:43 INFO - PROCESS | 3969 | Cycle 1(1): loaded http://localhost:52942/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52942/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:38:44 INFO - PROCESS | 3969 | RSS: Main: 223522816 07:38:44 INFO - PROCESS | 3969 | 07:38:46 INFO - PROCESS | 3969 | Cycle 1(1): loaded http://localhost:52942/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52942/tests/kraken/driver.html?testName=ai-astar) 07:38:46 INFO - PROCESS | 3969 | RSS: Main: 266137600 07:38:46 INFO - PROCESS | 3969 | 07:38:46 INFO - PROCESS | 3969 | __start_tp_report 07:38:46 INFO - PROCESS | 3969 | _x_x_mozilla_page_load 07:38:46 INFO - PROCESS | 3969 | _x_x_mozilla_page_load_details 07:38:46 INFO - PROCESS | 3969 | |i|pagename|runs| 07:38:46 INFO - PROCESS | 3969 | |0;ai-astar;102;110;110;110;111;111;111;110;110;109 07:38:46 INFO - PROCESS | 3969 | |1;audio-beat-detection;150;116;124;178;123;118;150;118;150;118 07:38:46 INFO - PROCESS | 3969 | |2;audio-dft;160;160;161;161;160;159;161;162;161;161 07:38:46 INFO - PROCESS | 3969 | |3;audio-fft;75;74;75;126;75;75;75;74;106;75 07:38:46 INFO - PROCESS | 3969 | |4;audio-oscillator;83;84;118;84;85;83;122;83;84;122 07:38:46 INFO - PROCESS | 3969 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 07:38:46 INFO - PROCESS | 3969 | |6;imaging-darkroom;145;146;147;145;145;146;146;145;145;145 07:38:46 INFO - PROCESS | 3969 | |7;imaging-desaturate;95;96;95;95;95;95;94;95;96;95 07:38:46 INFO - PROCESS | 3969 | |8;json-parse-financial;53;54;52;51;52;53;53;53;52;51 07:38:46 INFO - PROCESS | 3969 | |9;json-stringify-tinderbox;63;62;63;62;63;63;63;63;63;62 07:38:46 INFO - PROCESS | 3969 | |10;stanford-crypto-aes;75;75;75;76;75;75;74;75;75;80 07:38:46 INFO - PROCESS | 3969 | |11;stanford-crypto-ccm;120;120;117;117;117;124;138;132;158;132 07:38:46 INFO - PROCESS | 3969 | |12;stanford-crypto-pbkdf2;158;163;160;163;155;158;156;164;153;160 07:38:46 INFO - PROCESS | 3969 | |13;stanford-crypto-sha256-iterative;63;63;63;63;62;65;62;63;61;60 07:38:46 INFO - PROCESS | 3969 | __end_tp_report 07:38:46 INFO - PROCESS | 3969 | __start_cc_report 07:38:46 INFO - PROCESS | 3969 | _x_x_mozilla_cycle_collect,1659 07:38:46 INFO - PROCESS | 3969 | __end_cc_report 07:38:46 INFO - PROCESS | 3969 | __startTimestamp1468247926263__endTimestamp 07:38:46 INFO - PROCESS | 3969 | 07:38:46 INFO - PROCESS | 3969 | ------- Summary: start ------- 07:38:46 INFO - PROCESS | 3969 | Number of tests: 14 07:38:46 INFO - PROCESS | 3969 | 07:38:46 INFO - PROCESS | 3969 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:2.67 (2.4%) stddev-sans-first:0.67 07:38:46 INFO - PROCESS | 3969 | Values: 102.0 110.0 110.0 110.0 111.0 111.0 111.0 110.0 110.0 109.0 07:38:46 INFO - PROCESS | 3969 | 07:38:46 INFO - PROCESS | 3969 | [#1] audio-beat-detection Cycles:10 Average:134.50 Median:137.00 stddev:21.12 (15.4%) stddev-sans-first:21.64 07:38:46 INFO - PROCESS | 3969 | Values: 150.0 116.0 124.0 178.0 123.0 118.0 150.0 118.0 150.0 118.0 07:38:46 INFO - PROCESS | 3969 | 07:38:46 INFO - PROCESS | 3969 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.84 (0.5%) stddev-sans-first:0.87 07:38:46 INFO - PROCESS | 3969 | Values: 160.0 160.0 161.0 161.0 160.0 159.0 161.0 162.0 161.0 161.0 07:38:46 INFO - PROCESS | 3969 | 07:38:46 INFO - PROCESS | 3969 | [#3] audio-fft Cycles:10 Average:83.00 Median:75.00 stddev:18.02 (24.0%) stddev-sans-first:18.88 07:38:46 INFO - PROCESS | 3969 | Values: 75.0 74.0 75.0 126.0 75.0 75.0 75.0 74.0 106.0 75.0 07:38:46 INFO - PROCESS | 3969 | 07:38:46 INFO - PROCESS | 3969 | [#4] audio-oscillator Cycles:10 Average:94.80 Median:83.50 stddev:17.89 (21.4%) stddev-sans-first:18.46 07:38:46 INFO - PROCESS | 3969 | Values: 83.0 84.0 118.0 84.0 85.0 83.0 122.0 83.0 84.0 122.0 07:38:46 INFO - PROCESS | 3969 | 07:38:46 INFO - PROCESS | 3969 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 07:38:46 INFO - PROCESS | 3969 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 07:38:46 INFO - PROCESS | 3969 | 07:38:46 INFO - PROCESS | 3969 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 07:38:46 INFO - PROCESS | 3969 | Values: 145.0 146.0 147.0 145.0 145.0 146.0 146.0 145.0 145.0 145.0 07:38:46 INFO - PROCESS | 3969 | 07:38:46 INFO - PROCESS | 3969 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 07:38:46 INFO - PROCESS | 3969 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 94.0 95.0 96.0 95.0 07:38:46 INFO - PROCESS | 3969 | 07:38:46 INFO - PROCESS | 3969 | [#8] json-parse-financial Cycles:10 Average:52.40 Median:53.00 stddev:0.97 (1.8%) stddev-sans-first:1.00 07:38:46 INFO - PROCESS | 3969 | Values: 53.0 54.0 52.0 51.0 52.0 53.0 53.0 53.0 52.0 51.0 07:38:46 INFO - PROCESS | 3969 | 07:38:46 INFO - PROCESS | 3969 | [#9] json-stringify-tinderbox Cycles:10 Average:62.70 Median:63.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 07:38:46 INFO - PROCESS | 3969 | Values: 63.0 62.0 63.0 62.0 63.0 63.0 63.0 63.0 63.0 62.0 07:38:46 INFO - PROCESS | 3969 | 07:38:46 INFO - PROCESS | 3969 | [#10] stanford-crypto-aes Cycles:10 Average:75.50 Median:75.00 stddev:1.65 (2.2%) stddev-sans-first:1.74 07:38:46 INFO - PROCESS | 3969 | Values: 75.0 75.0 75.0 76.0 75.0 75.0 74.0 75.0 75.0 80.0 07:38:46 INFO - PROCESS | 3969 | 07:38:46 INFO - PROCESS | 3969 | [#11] stanford-crypto-ccm Cycles:10 Average:127.50 Median:128.00 stddev:13.07 (10.2%) stddev-sans-first:13.57 07:38:46 INFO - PROCESS | 3969 | Values: 120.0 120.0 117.0 117.0 117.0 124.0 138.0 132.0 158.0 132.0 07:38:46 INFO - PROCESS | 3969 | 07:38:46 INFO - PROCESS | 3969 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.00 Median:160.00 stddev:3.68 (2.3%) stddev-sans-first:3.89 07:38:46 INFO - PROCESS | 3969 | Values: 158.0 163.0 160.0 163.0 155.0 158.0 156.0 164.0 153.0 160.0 07:38:46 INFO - PROCESS | 3969 | 07:38:46 INFO - PROCESS | 3969 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:63.00 stddev:1.35 (2.1%) stddev-sans-first:1.42 07:38:46 INFO - PROCESS | 3969 | Values: 63.0 63.0 63.0 63.0 62.0 65.0 62.0 63.0 61.0 60.0 07:38:46 INFO - PROCESS | 3969 | -------- Summary: end -------- 07:38:46 INFO - PROCESS | 3969 | 07:38:47 INFO - TEST-INFO | 3969: exit 0 07:38:47 INFO - TEST-OK | kraken | took 60606ms 07:38:47 INFO - SUITE-END | took 1173s 07:38:47 INFO - Completed test suite (00:19:33) 07:38:47 INFO - javascript benchmark 07:38:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3029.5758593796863, 3068.3249685069277, 3084.6298444186696, 3095.241665791881, 3107.161066512042, 5252.553532949694, 5319.840404787863, 5343.30537030186, 5440.40155582886, 5459.290292262005, 5354.9196762048505, 5355.437679043703, 5379.731013449332, 5391.460853914607, 5431.429699881515, 4802.06359759847, 4864.14877396456, 4893.0, 4906.969536397361, 5047.015831912779, 4962.702237865739, 4978.128827455199, 5006.4492905780335, 5024.5226703463295, 5034.119029169899, 4707.882302942419, 4828.85513434594, 4835.758212089381, 4851.029794041188, 4901.534354236324, 4865.172920603471, 4887.169181239163, 4902.534259245366, 4904.411470623512, 4946.505349465025, 4744.359511465942, 4863.610911127102, 4879.1461494238365, 4892.315075889378, 4927.236278376858, 5268.868278293035, 5350.30446042016, 5378.46215378463, 5426.213199086111, 5427.240186373871, 5809.883802323972, 5820.330661973885, 5835.795747148872, 5836.562257830679, 5854.531637468992, 5598.272224610815, 5649.067903795869, 5847.707614619295, 5879.0, 5879.382664820175, 5341.946580534183, 5449.536789372948, 5456.127019676833, 5456.890862182734, 5457.399686034533, 5915.556333275022, 5923.911141332884, 5924.229850119457, 5927.911081333784, 5928.762849486058, 5471.835844924659, 5575.609707320448, 5584.91622625661, 5693.715314234271, 5699.430056994267, 5788.855278618068, 5808.332041815245, 5816.82549523515, 5817.94182058174, 5825.70871456434, 5704.0, 5741.655500669973, 5749.453801888814, 5750.108733146369, 5755.769769209269, 5554.305711786027, 5662.546996240291, 5691.03252447085, 5708.315002199763, 5754.625949313365, 4362.432883725095, 4377.321515165155, 4379.1022840317655, 4384.254676704968, 4422.336649502536, 3890.533136023695, 3916.804159791999, 3923.0780766519847, 3955.940660890089, 3973.7019723520275, 5253.894922101536, 5362.115250983544, 5363.490468405495, 5396.082665946798, 5430.782768689287, 5769.826905192851, 5788.0, 5789.768409263666, 5799.33307669615, 5849.941500585025, 5430.239766432703, 5435.864103397446, 5462.863428414322, 5466.644668096561, 5473.972630136904, 4827.493113223061, 4934.087193869074, 4968.1554135797005, 4988.301637770715, 5053.519915608012, 6006.339302676702, 6011.158437818709, 6014.6391216527145, 6014.6391216527145, 6020.849478763066, 5819.941800582109, 5838.854028649318, 5841.620294680833, 5843.29880414353, 5847.06446968483, 5835.56233282497, 5869.589128760946, 5921.940780592139, 5955.702214889325, 6014.368491308524, 5679.290088738908, 5696.174054762119, 5707.743151558107, 5721.828345149652, 5724.370319264961, 5463.69949652757, 5773.6824474654295, 5831.620944638585, 5834.970825145847, 5846.269216347957, 5611.80358687444, 5641.830745077655, 5673.716314184357, 5718.628289161191, 5725.16985037159, 5651.43485651448, 5677.858053548694, 5688.260526131577, 5688.374278829243, 5689.288838895138, 5411.377691565521, 5455.045367060669, 5614.522765564972, 5623.493885550321, 5626.634268772516, 5665.688387138747, 5730.74211660468, 5800.1299805029585, 5807.622504537191, 5808.709564521672, 5532.253145825423, 5541.058020136506, 5566.805161819317, 5570.24801651788, 5616.915746263728], "value": 5315.082735322228, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.9243498345214, 600.8678090820019, 613.3467856732576, 615.7690865925276, 622.7695752571552, 34002.65997340026, 43511.34732979004, 44776.55223447765, 44782.32826507605, 44829.327560086625, 46502.0, 46966.29550556745, 47002.764986175105, 47017.0, 47068.29397559039, 8780.034196238425, 8913.732588022338, 8915.55422228886, 8919.509426981513, 8924.241439477652, 9026.638934442615, 9104.226140778042, 9106.86339704905, 9114.635414583408, 9149.085091490831, 9150.77123071922, 9197.95401022994, 9201.125893040184, 9202.815943681122, 9203.079692030777, 9052.456852588833, 9098.272138228926, 9102.180803727697, 9117.95441022794, 9120.954395228047, 8959.73120806377, 9022.639094436214, 9025.638974441015, 9030.051844556292, 9030.096990300983, 43534.12931741348, 43589.78205108954, 43803.0, 43853.34219986703, 43874.78062609667, 3440.6043305019994, 3536.29274145172, 3673.448982652597, 3766.8493260269556, 4035.535913369971, 33582.66417335844, 34347.0, 34405.0, 34546.82726586376, 35938.820305898305, 4423.778811059434, 4468.19572476954, 4505.43682039745, 4517.706349087299, 4580.770961451914, 366489.0, 367421.32578674407, 367485.0, 367721.0, 369311.0, 56819.0, 57187.428125719045, 57599.0, 57601.71199143978, 57620.42379576234, 35283.82358088245, 36209.81895090508, 36232.45651315233, 38549.229015419536, 38559.61440385616, 16565.337386504405, 16585.83414165867, 16591.336346546002, 16643.50069497917, 16669.24988375526, 13803.378847951866, 13919.791203131961, 13925.373358198905, 13932.791008134885, 13940.093893896865, 19838.40484785459, 19912.402627921187, 20165.899170504348, 20213.49466263355, 20245.696314555295, 6928.579641173547, 7162.355388015104, 7197.388222001188, 7316.524425912298, 7352.272216029229, 974.6296407365156, 1008.3596915958419, 1034.8551202831609, 1071.5874388360537, 1123.5168877382641, 32083.0, 32337.35325293481, 32583.185420364207, 32632.673673262965, 32912.506312405334, 865.3207232322596, 1107.379867274329, 1137.8350139229765, 1165.7143999720122, 1189.79178643737, 16627.833721662628, 16635.168241588115, 16974.660506789794, 17002.744958825628, 17237.224324905408, 611489.0, 614815.0, 618251.0, 620807.0, 622676.0, 59195.704021479614, 60153.0, 60357.09464358038, 60578.697106514184, 60657.69671151616, 1214.338185688784, 1320.828292321992, 1370.136813807295, 1374.4914381678843, 1378.200643626694, 33045.33909321752, 34216.486752698234, 34400.41996850196, 34678.0, 34814.65185348215, 51333.379995800555, 51812.481875182275, 51861.740691296305, 51942.0, 51975.0, 427044.0, 429166.0, 429476.0, 431337.0, 492745.0, 27628.585571216045, 28063.859680702284, 28170.0, 29312.120636380943, 29398.559021614266, 48937.0, 49723.0, 49864.50135498599, 50334.49665503298, 50748.74625626848, 40150.397744034446, 41950.79024604857, 41980.160396792504, 42677.57322426736, 43602.78198609113, 38935.0, 40108.0, 40324.79837600793, 40360.0, 40428.59571404248, 41039.0, 41113.1777364457, 41135.1772964545, 42409.151816964106, 42502.36246456244, 36541.45187822238, 38072.80963595164, 38146.67509569784, 38382.0, 38731.0, 28062.579061314504, 28250.0, 28437.289067773472, 28482.430351393272, 28511.714882851735], "value": 20338.899369882496, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.7309029859695, 399.06817580948484, 404.82187837351563, 406.07617669801203, 417.50317122624074, 18630.068496575186, 19894.900525497353, 20284.99999999998, 20306.289279875207, 21234.25680101197, 19938.202471901142, 20264.59470810583, 20329.28847490338, 20398.246236758034, 20515.589688206226, 5650.943490565093, 5940.97029514854, 5965.1946987156825, 5987.341392446828, 5994.07091900756, 5747.770089196448, 5856.502197313233, 5899.734511946951, 5976.163337132783, 5977.4022597740095, 5878.059510478324, 5898.498627616657, 5912.940870591304, 5917.082852157922, 5919.112133180036, 5620.269364982567, 5804.361520232771, 5897.587168898179, 5899.528037756969, 5903.734331955051, 5093.465186155438, 5154.226865970097, 5157.4068982067165, 5165.328507294065, 5166.664166829144, 23837.28488145341, 24478.0, 24677.50644987108, 24697.506049878903, 24864.12975545847, 2291.472961218929, 2401.903923843044, 2501.987490062538, 2566.1747832420488, 2581.974180258211, 14671.77992330116, 14743.041702289423, 15177.317020733983, 15499.147546884917, 15658.765118523232, 1979.2973494409566, 2001.8498612603967, 2032.552838375555, 2048.7336646235894, 2092.016752126498, 54945.0, 58012.70993645047, 85163.0, 86078.5696071522, 88273.55863220643, 10776.568937242579, 10779.0, 10970.122390208764, 10973.50619222137, 11106.556147700909, 15317.31072101758, 15444.613884652974, 15453.381864725285, 15503.84496155024, 15523.068615882858, 8355.498670079814, 8456.957715211385, 8537.103604121601, 8605.182507661762, 8693.869591956125, 8204.589770511451, 8208.46644968075, 8383.28742056932, 8440.57797110142, 8553.529555874487, 6660.200775906922, 6860.176778786577, 6880.69036893341, 6962.0, 6963.373296403348, 1924.259160223296, 1932.6811076172273, 1957.2464601128383, 1961.8038196180553, 1979.3764964036282, 997.7455748784014, 1011.8178727828914, 1020.4999550220487, 1033.5194134727237, 1035.7307100154014, 20537.58924821495, 21198.576028479343, 21429.46426339354, 21451.67822482664, 21546.461338466663, 1036.9533370998324, 1042.4735508568124, 1077.0199118801852, 1077.7628921637227, 1084.38732116354, 11600.361980091007, 11925.68817430082, 11974.46114924813, 12003.339816310187, 12061.0, 512345.0, 517069.0, 531190.0, 531640.0, 531651.0, 64068.0, 85521.57239213763, 88063.55968220117, 88123.0, 90855.54572227097, 994.9403035817729, 1008.1732978957185, 1027.2655051638114, 1028.9691309260734, 1062.4103622489592, 19411.417657470298, 19572.412827615193, 19955.900220499385, 20083.497912552302, 20121.798782011992, 29464.705352946195, 29627.851860740557, 31948.840255798572, 41438.96402589959, 44101.117977639624, 57213.56471135235, 57545.71227143837, 58406.0, 59853.40146598653, 60679.39320606914, 9153.542322883963, 9177.54112294396, 9241.815163696554, 9380.296477764332, 9471.289653275893, 12648.494060237488, 14329.57011289663, 14347.92826035863, 14531.564053078424, 14970.32633531472, 12613.432395542406, 12668.0, 12689.23864568129, 12730.936345318214, 12773.0, 12432.12975091735, 12545.724566177174, 12677.80983285233, 12809.8078528824, 12912.935435322763, 12663.81004284918, 12942.158759680591, 12976.0, 13045.934770326088, 13055.673608159872, 9152.816943661222, 9206.953965230132, 9244.815103698023, 9314.906850931675, 9373.287773582671, 11011.01801675706, 11953.462094205608, 12034.578789742318, 12075.456604452645, 12502.937485312515], "value": 9711.396572479522, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1441.128117488919, 1497.1915165810462, 1593.3865461797204, 1732.4802559232244, 1795.210107552676, 8475.957620211899, 8908.242799362046, 9013.95493022534, 9020.458772473648, 9024.909750902498, 7579.6589153488085, 8248.83502329953, 8536.615852286646, 8553.272971797405, 8842.336824738155, 2364.7635236476385, 2396.293093537402, 2398.268528098938, 2399.748026457223, 2402.3033320337167, 2341.098677009347, 2388.6417037444435, 2393.85636861788, 2397.2448678666165, 2401.147592604618, 2038.7961203879568, 2088.7597926238527, 2291.9770802291932, 2372.1460274301326, 2381.4760752634393, 2362.7400985891536, 2376.4771750214927, 2390.163442795008, 2398.844075135128, 2400.327908185711, 2345.812335013212, 2349.3891588187194, 2355.705536807899, 2357.97642023581, 2359.2332491940188, 8909.064548222408, 8955.820883582357, 8976.551172441417, 8978.640854365818, 8993.505357205351, 5257.842264732064, 5404.945950540484, 5411.648242864201, 5413.323334583177, 5416.512513873731, 3573.5533058367705, 3576.695980841632, 3628.1836586767768, 3635.363811333006, 3642.7450078494517, 1087.4617064553097, 1093.3822390349508, 1099.5491848342142, 1108.8281316395971, 1117.3742704085737, 12421.627351179388, 12440.004799616008, 12453.0, 12459.0, 12466.501339946391, 4558.49856515783, 4585.885352866205, 4758.0, 4765.594924431392, 4790.8323208687525, 10532.57869685204, 10533.052025317758, 10542.420166890895, 10547.0, 10557.9472102639, 5409.864753381197, 5414.052540805422, 5416.458354164631, 5419.810306639328, 5429.104197807396, 4942.0, 4962.528559786814, 4993.275974983607, 5006.0, 5033.270175824485, 3907.628775266345, 3921.764694118362, 3927.8428862845167, 4035.616616421435, 4122.381642753551, 1151.9712007199887, 1225.9448324825405, 1232.5870833270956, 1249.6376050945305, 1249.6750844780422, 987.5457289646843, 994.8209322322051, 996.7707427291764, 997.6209040564539, 1012.8835183953939, 5884.411558844081, 5935.7625694972585, 5962.850928726816, 5981.192539007178, 6092.664903430354, 903.814717982812, 963.6679236248295, 971.0, 972.2707969023232, 1003.3027046202965, 3883.339832228528, 4080.8571699990953, 4086.387041943732, 4109.691773116969, 4156.896077598024, 10763.408012559228, 11074.723131921766, 11184.161187910939, 11187.4965626547, 11197.216194866443, 9809.901900981042, 10477.057064864199, 11059.115270778319, 11067.335959842436, 11081.612143575097, 8069.757907262791, 8454.66181352739, 8466.0, 8468.110848360957, 8474.915250847536, 6090.208272924491, 6108.35862234459, 6218.8806014917745, 6261.373862613702, 6404.199475065617, 9964.451955142536, 10036.347637403545, 10363.585456581652, 10432.061114499731, 10443.321184123008, 9817.950910245403, 10156.949215253877, 10171.949140254252, 10187.08316251541, 10368.222383321432, 8533.957330213309, 8559.358048146538, 8695.087015863497, 8702.738917832476, 8703.0, 8450.239478446969, 8562.357823163164, 8587.184217499327, 8631.6978905738, 8649.697260595849, 6349.396807303298, 7723.845523089394, 7906.327962123284, 7916.84166316682, 7976.561289129154, 7707.691692332468, 7722.613869306625, 7879.172686867796, 7900.881486777818, 7955.721549745731, 7120.928790712233, 7199.316064973819, 7199.748008819666, 7325.523840950321, 7330.120385553768, 4814.0, 4872.43966943806, 4911.066897289504, 4911.7298548580175, 4928.507149285043, 5497.725113744376, 5538.113901775697, 5553.6390134641115, 5564.360098588714, 5648.083260023533], "value": 4712.5573343485985, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.02208209755, 326.0934601806977, 327.4482496992568, 338.9915252118698, 343.93465241604093, 5353.518183363496, 5406.621536492447, 5419.566434685225, 5435.28235882058, 5438.483344082316, 5047.0, 5166.870828229296, 5179.14544100224, 5190.299309593203, 5348.518633323, 4006.699497537682, 4126.83492660294, 4152.937705934413, 4196.97901510492, 4197.4753155855515, 4115.156392939441, 4156.688248381369, 4163.937540936873, 4165.5834416558255, 4186.56041115683, 4066.8983275418204, 4139.2135494256145, 4153.193360888008, 4177.644900183473, 4179.373094035888, 4144.647704945083, 4151.356539736345, 4151.937720934188, 4157.812898419578, 4184.707070505081, 3685.3919103347916, 3698.4637227601847, 3699.5213207151273, 3702.2780557791243, 3721.5534135903595, 4995.550400463976, 5142.228665700138, 5162.174052151675, 5200.453952335026, 5222.060029194743, 4727.6762506498235, 4749.430068391815, 4771.427428708543, 4781.0, 4800.399950006249, 5446.2375267462585, 5455.509004189642, 5530.225768392428, 5542.307211598551, 5549.889002219973, 3907.6483116519366, 4044.474218351625, 4066.9389959150635, 4072.429859819628, 4080.2655522006025, 5655.462731040545, 5657.886842263131, 5663.377028526858, 5692.800751973702, 5748.367679555246, 4023.4970628671417, 4043.2317859606583, 4047.138316374501, 4106.7125301229225, 4129.380592911088, 4069.674426045909, 4166.166766646622, 4166.270902592034, 4172.353285240732, 4179.644730197906, 4704.694194877322, 4713.878754560462, 4713.939363643153, 4751.786169622375, 4767.76161191946, 5555.833325000176, 5579.2746942897165, 5580.302462192226, 5581.6930068845795, 5586.972065139648, 1322.9073964822562, 1389.8540653231466, 1428.39293300349, 1449.7680371140566, 1450.8549145085617, 987.5309228116731, 1015.8120747661707, 1026.1175389165462, 1033.4419413516616, 1034.1054987435814, 5349.277847490617, 5351.759170837244, 5370.892582148414, 5375.0, 5399.973000134974, 5613.410591887875, 5624.887502250014, 5640.520555752725, 5671.546276297886, 5682.488576028178, 5204.271402003723, 5485.561155107582, 5497.993232470119, 5505.9724701376235, 5506.972465137729, 3020.8338541380435, 3039.814472355783, 3047.2229581456586, 3052.1759125036115, 3053.6640969493337, 5645.266115404971, 5850.297964244318, 5873.236479257669, 5925.067091789591, 5926.436988486087, 5639.42096213061, 5688.459596338341, 5749.453801888814, 5769.567282453832, 5779.653220806765, 5799.391063938226, 5858.736356863951, 5873.295204575393, 5939.851503712442, 5942.098528470848, 5533.253010843646, 5615.157726341082, 5638.689872057076, 5658.887611813404, 5697.772089116389, 5563.221149039218, 5567.8886422272135, 5600.243967064394, 5635.295588051494, 5648.915266270927, 5600.747966341443, 5814.848506052787, 5881.470667639762, 5917.497012753792, 5930.406959304035, 3841.250956063541, 4074.8166332514515, 4085.0, 4085.264652362603, 4103.466549348565, 5614.85962850932, 5706.600537962303, 5760.107183386582, 5802.4197580241635, 5804.709764511673, 5568.276124103841, 5588.804391846266, 5600.607957443103, 5617.831465056055, 5624.634398764068, 5276.314079169683, 5495.862603434946, 5559.916601250903, 5581.04663367818, 5591.720413979366, 5497.587680923867, 5518.53092487127, 5529.751161197836, 5535.142052981794, 5539.861503462445, 5623.971880140573, 5686.914696279477, 5691.630044047124, 5718.828435146952, 5719.199312096227, 5288.7258478854465, 5519.0, 5529.0, 5533.7786488541615, 5536.390996990247], "value": 4258.879464714996, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.3386053342791, 754.113916148525, 763.9656215470303, 790.7983464216627, 839.5652607438428, 14985.775213371795, 15231.923840380783, 15811.0, 16085.91957040216, 16108.516744497654, 14872.851271487281, 14992.325345359457, 15034.774478382833, 15037.473688420907, 15042.924785376057, 650.4146268358468, 802.7551596762985, 809.6963638635511, 834.0783434305097, 836.3518273338182, 826.9958650206771, 838.4885220015785, 840.6931470013432, 840.8528507511191, 841.1420351241729, 880.6433394475248, 884.0717246890739, 884.2351366068369, 885.9379843410964, 886.3618194899661, 693.9236683964785, 832.305025303872, 851.3487182305541, 866.3935245328264, 873.7597160780805, 624.709510077816, 625.0717684238901, 625.3933684326241, 625.4058644287944, 626.3704976498635, 14802.40790368384, 14850.480233191787, 14866.331015104346, 14876.479323223744, 14882.925585372112, 14245.0, 14263.928680356636, 14353.569392918229, 14483.637909052253, 14617.12297262157, 12956.09307348486, 13219.537316193888, 13358.198508089448, 13360.86639133606, 13472.797908031387, 4344.239758042361, 4356.934645980313, 4375.606195442426, 4460.264056430718, 4541.137183935041, 68044.6597767008, 70418.29581704168, 78686.0, 78945.60527197385, 79369.60315198445, 11744.94127529374, 11996.64010079699, 12024.699382515331, 12215.93892030552, 12529.498820047096, 21510.139594416047, 21626.0, 21645.458863528536, 21646.134154633637, 21675.34973950784, 8586.78533036679, 8727.389082764146, 8768.298536117096, 8807.603657835412, 8811.911880881238, 4898.804047838118, 4900.558949694473, 5026.773795179226, 5033.464793238098, 5048.3184770056305, 3264.102371847761, 3351.2124650707065, 3351.463765797461, 3362.445196542592, 3367.393869103585, 653.8496145886378, 658.338369938209, 663.5255792108666, 670.0920253057135, 674.3458844920419, 669.8827705151579, 711.9537230080028, 724.6594100772628, 727.3490226247479, 733.6185183704443, 9673.564689588986, 10130.746731331628, 10290.12533934624, 10302.845457318146, 10394.272400932014, 668.2649086005355, 675.8817206988856, 717.9928200718031, 735.4594373135741, 763.4121726270852, 4701.811927522861, 4842.709437433695, 4885.1206782779445, 4924.138275801721, 4963.354763880745, 98657.0, 102486.0, 103803.4809825946, 112968.43515782533, 117629.0, 99353.50323248337, 99525.50237248768, 99787.50106249422, 99881.0, 101063.49468252611, 82278.17721822824, 85934.57032714796, 86731.56634216789, 88781.0, 89439.55280223557, 9884.654037108954, 9922.255830812574, 10071.949640251752, 10086.596536138471, 10143.137833284254, 42537.78731106449, 48445.75777121092, 51173.0, 51173.23240151475, 53482.4651753493, 74752.0, 77286.0, 78832.0, 79140.60429697814, 79805.0, 12658.810117848423, 12898.940155230843, 12995.28525931083, 13262.270575118075, 13317.800232996706, 13811.585652430444, 13875.514356997457, 13917.79123313131, 14254.216018119103, 14418.351174196976, 14478.782818257523, 14648.560543183721, 14748.483803066842, 14757.335919883846, 14784.63038424048, 13239.27184004889, 13501.527446539323, 13693.724165717615, 13871.79192312096, 14285.0, 12800.295983720613, 12851.807222891477, 13053.543125990545, 14313.912198218672, 14485.803912165926, 10864.0, 11134.0, 11148.55405783792, 11662.591809286974, 11759.529618815151, 11204.327740335606, 11287.661370158909, 11610.361430121424, 11648.888445817896, 11767.411629418666], "value": 7685.541947223398, "unit": "score"}], "name": "dromaeo_css", "value": 7382.982761314883, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 110.0, 110.0, 111.0, 111.0, 111.0, 110.0, 110.0, 109.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 116.0, 124.0, 178.0, 123.0, 118.0, 150.0, 118.0, 150.0, 118.0], "value": 134.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 161.0, 160.0, 159.0, 161.0, 162.0, 161.0, 161.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 126.0, 75.0, 75.0, 75.0, 74.0, 106.0, 75.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 118.0, 84.0, 85.0, 83.0, 122.0, 83.0, 84.0, 122.0], "value": 94.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 147.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 96.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 52.0, 51.0, 52.0, 53.0, 53.0, 53.0, 52.0, 51.0], "value": 52.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 62.0, 63.0, 63.0, 63.0, 63.0, 63.0, 62.0], "value": 62.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 76.0, 75.0, 75.0, 74.0, 75.0, 75.0, 80.0], "value": 75.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 120.0, 117.0, 117.0, 117.0, 124.0, 138.0, 132.0, 158.0, 132.0], "value": 127.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 163.0, 160.0, 163.0, 155.0, 158.0, 156.0, 164.0, 153.0, 160.0], "value": 159.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 62.0, 65.0, 62.0, 63.0, 61.0, 60.0], "value": 62.5, "unit": "score"}], "name": "kraken", "value": 1479.5, "alertThreshold": 2.0}]} 07:38:47 INFO - Return code: 0 07:38:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:38:47 INFO - # TBPL SUCCESS # 07:38:47 INFO - Running post-action listener: _resource_record_post_action 07:38:47 INFO - ##### 07:38:47 INFO - ##### Finished run-tests step (success) 07:38:47 INFO - ##### 07:38:47 INFO - Running post-run listener: _resource_record_post_run 07:38:47 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 2310144; Write bytes: 572243968; Read time: 1072; Write time: 462748 07:38:47 INFO - TinderboxPrint: CPU usage
13.0% 07:38:47 INFO - TinderboxPrint: I/O read bytes / time
2,310,144 / 1,072 07:38:47 INFO - TinderboxPrint: I/O write bytes / time
572,243,968 / 462,748 07:38:47 INFO - TinderboxPrint: CPU idle
8,271.2 (87.0%) 07:38:47 INFO - TinderboxPrint: CPU user
1,192.6 (12.5%) 07:38:47 INFO - TinderboxPrint: Swap in / out
0 / 0 07:38:47 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 269103104; Read time: 120; Write time: 255348 07:38:47 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 2306048; Write bytes: 298586112; Read time: 952; Write time: 206576 07:38:48 INFO - Running post-run listener: _upload_blobber_files 07:38:48 INFO - Blob upload gear active. 07:38:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:38:48 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 07:38:48 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'] 07:38:48 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 07:38:48 INFO - (blobuploader) - INFO - Open directory for files ... 07:38:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:38:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:38:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:38:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:38:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:38:49 INFO - (blobuploader) - INFO - Done attempting. 07:38:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:38:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:38:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:38:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:38:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:38:53 INFO - (blobuploader) - INFO - Done attempting. 07:38:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:38:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:38:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:38:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:38:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:38:54 INFO - (blobuploader) - INFO - Done attempting. 07:38:54 INFO - (blobuploader) - INFO - Iteration through files over. 07:38:54 INFO - Return code: 0 07:38:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:38:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:38:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f1a70c105cc313d44d234c230a715d415720f1b1813f794e30c3329b6e71055f844595aa3d6c952b5317e3e43186096ab23e4750fbfa0b59448723c76cb6318", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6a1e51a8af225a81b08a8f5967a940a59203573b6705f8aa82dc05142a774a182b9a2167c6d470744d892de93486883489a1e8072441ceae3d4f9d7ea736edfe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bdeb6fa3d560eb6fe770ec919e47cd04516fb963878dd5ada5387eb60eeb4066763c2e510ba4b313408c51398ff1756b9f958b02559b7050b18929d42b6f1f4f"} 07:38:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:38:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:38:54 INFO - Contents: 07:38:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f1a70c105cc313d44d234c230a715d415720f1b1813f794e30c3329b6e71055f844595aa3d6c952b5317e3e43186096ab23e4750fbfa0b59448723c76cb6318", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6a1e51a8af225a81b08a8f5967a940a59203573b6705f8aa82dc05142a774a182b9a2167c6d470744d892de93486883489a1e8072441ceae3d4f9d7ea736edfe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bdeb6fa3d560eb6fe770ec919e47cd04516fb963878dd5ada5387eb60eeb4066763c2e510ba4b313408c51398ff1756b9f958b02559b7050b18929d42b6f1f4f"} 07:38:54 INFO - Running post-run listener: copy_logs_to_upload_dir 07:38:54 INFO - Copying logs to upload dir... 07:38:54 INFO - mkdir: /builds/slave/test/build/upload/logs 07:38:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.955134 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-11 07:38:53.744219) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 07:38:53.747783) ========= 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=6dbc10da6d83fee962c624be000001a8-1468246427.596564-1214046542 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/5f1a70c105cc313d44d234c230a715d415720f1b1813f794e30c3329b6e71055f844595aa3d6c952b5317e3e43186096ab23e4750fbfa0b59448723c76cb6318", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6a1e51a8af225a81b08a8f5967a940a59203573b6705f8aa82dc05142a774a182b9a2167c6d470744d892de93486883489a1e8072441ceae3d4f9d7ea736edfe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bdeb6fa3d560eb6fe770ec919e47cd04516fb963878dd5ada5387eb60eeb4066763c2e510ba4b313408c51398ff1756b9f958b02559b7050b18929d42b6f1f4f"} build_url:https://queue.taskcluster.net/v1/task/N08filg4QGSMeysKRjTCOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011256 build_url: 'https://queue.taskcluster.net/v1/task/N08filg4QGSMeysKRjTCOw/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/5f1a70c105cc313d44d234c230a715d415720f1b1813f794e30c3329b6e71055f844595aa3d6c952b5317e3e43186096ab23e4750fbfa0b59448723c76cb6318", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6a1e51a8af225a81b08a8f5967a940a59203573b6705f8aa82dc05142a774a182b9a2167c6d470744d892de93486883489a1e8072441ceae3d4f9d7ea736edfe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bdeb6fa3d560eb6fe770ec919e47cd04516fb963878dd5ada5387eb60eeb4066763c2e510ba4b313408c51398ff1756b9f958b02559b7050b18929d42b6f1f4f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 07:38:53.776598) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 07:38:53.776931) ========= 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=6dbc10da6d83fee962c624be000001a8-1468246427.596564-1214046542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004669 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 07:38:53.862322) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 07:38:53.863050) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 07:38:53.863811) ========= ========= Total master_lag: 0.63 =========