builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-020 starttime: 1468941221.87 results: success (0) buildid: 20160719053026 builduid: e5289d66e7c84285abb63181b844c517 revision: efa58477381d54e2d0bd1d89c2d9210a3714e143 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 08:13:41.870188) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 08:13:41.870879) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 08:13:41.871333) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 08:13:41.888156) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 08:13:41.888793) ========= 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=af724c981e2a0f424dbabf99000001e7-1468941221.411428-774779316 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-19 08:13:42-- 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% 217M=0s 2016-07-19 08:13:42 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.072734 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 08:13:41.978442) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 08:13:41.978974) ========= 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=af724c981e2a0f424dbabf99000001e7-1468941221.411428-774779316 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022525 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 08:13:42.032544) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-19 08:13:42.033064) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev efa58477381d54e2d0bd1d89c2d9210a3714e143 --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 efa58477381d54e2d0bd1d89c2d9210a3714e143 --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=af724c981e2a0f424dbabf99000001e7-1468941221.411428-774779316 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-19 08:13:42,371 truncating revision to first 12 chars 2016-07-19 08:13:42,371 Setting DEBUG logging. 2016-07-19 08:13:42,371 attempt 1/10 2016-07-19 08:13:42,371 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/efa58477381d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-19 08:13:43,495 unpacking tar archive at: fx-team-efa58477381d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.468274 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-19 08:13:43.515780) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 08:13:43.516094) ========= script_repo_revision: efa58477381d54e2d0bd1d89c2d9210a3714e143 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 08:13:43.516520) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 08:13:43.516804) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 08:13:43.527440) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-19 08:13:43.527837) ========= /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=af724c981e2a0f424dbabf99000001e7-1468941221.411428-774779316 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:13:43 INFO - MultiFileLogger online at 20160719 08:13:43 in /builds/slave/test 08:13:43 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 08:13:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:13:43 INFO - {'append_to_log': False, 08:13:43 INFO - 'base_work_dir': '/builds/slave/test', 08:13:43 INFO - 'blob_upload_branch': 'Fx-Team', 08:13:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:13:43 INFO - 'branch': 'Fx-Team', 08:13:43 INFO - 'buildbot_json_path': 'buildprops.json', 08:13:43 INFO - 'config_files': ('talos/linux_config.py',), 08:13:43 INFO - 'default_actions': ('clobber', 08:13:43 INFO - 'read-buildbot-config', 08:13:43 INFO - 'download-and-extract', 08:13:43 INFO - 'populate-webroot', 08:13:43 INFO - 'create-virtualenv', 08:13:43 INFO - 'install', 08:13:43 INFO - 'run-tests'), 08:13:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:13:43 INFO - 'download_minidump_stackwalk': True, 08:13:43 INFO - 'download_symbols': 'ondemand', 08:13:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:13:43 INFO - 'tooltool.py': '/tools/tooltool.py', 08:13:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:13:43 INFO - '/tools/misc-python/virtualenv.py')}, 08:13:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:13:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:13:43 INFO - 'installer_path': 'installer.exe', 08:13:43 INFO - 'log_level': 'info', 08:13:43 INFO - 'log_name': 'talos', 08:13:43 INFO - 'log_to_console': True, 08:13:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:13:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:13:43 INFO - 'opt_config_files': (), 08:13:43 INFO - 'pip_index': False, 08:13:43 INFO - 'sps_profile': False, 08:13:43 INFO - 'sps_profile_interval': 0, 08:13:43 INFO - 'suite': 'dromaeojs', 08:13:43 INFO - 'system_bits': '32', 08:13:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:13:43 INFO - 'title': 'talos-linux64-ix-020', 08:13:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:13:43 INFO - 'use_talos_json': True, 08:13:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:13:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:13:43 INFO - 'work_dir': 'build'} 08:13:43 INFO - ##### 08:13:43 INFO - ##### Running clobber step. 08:13:43 INFO - ##### 08:13:43 INFO - Running pre-action listener: _resource_record_pre_action 08:13:43 INFO - Running main action method: clobber 08:13:43 INFO - rmtree: /builds/slave/test/build 08:13:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:13:44 INFO - Running post-action listener: _resource_record_post_action 08:13:44 INFO - ##### 08:13:44 INFO - ##### Finished clobber step (success) 08:13:44 INFO - ##### 08:13:44 INFO - ##### 08:13:44 INFO - ##### Running read-buildbot-config step. 08:13:44 INFO - ##### 08:13:44 INFO - Running pre-action listener: _resource_record_pre_action 08:13:44 INFO - Running main action method: read_buildbot_config 08:13:44 INFO - Using buildbot properties: 08:13:44 INFO - { 08:13:44 INFO - "project": "", 08:13:44 INFO - "product": "firefox", 08:13:44 INFO - "script_repo_revision": "production", 08:13:44 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:13:44 INFO - "repository": "", 08:13:44 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:13:44 INFO - "buildid": "20160719053026", 08:13:44 INFO - "pgo_build": "True", 08:13:44 INFO - "basedir": "/builds/slave/test", 08:13:44 INFO - "buildnumber": 301, 08:13:44 INFO - "slavename": "talos-linux64-ix-020", 08:13:44 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:13:44 INFO - "platform": "ubuntu64_hw", 08:13:44 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:13:44 INFO - "branch": "fx-team", 08:13:44 INFO - "repo_path": "integration/fx-team", 08:13:44 INFO - "revision": "efa58477381d54e2d0bd1d89c2d9210a3714e143", 08:13:44 INFO - "stage_platform": "linux64-pgo", 08:13:44 INFO - "builduid": "e5289d66e7c84285abb63181b844c517", 08:13:44 INFO - "slavebuilddir": "test" 08:13:44 INFO - } 08:13:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/AaClyWQdRVyBf6ylml4JWQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:13:44 INFO - Running post-action listener: _resource_record_post_action 08:13:44 INFO - ##### 08:13:44 INFO - ##### Finished read-buildbot-config step (success) 08:13:44 INFO - ##### 08:13:44 INFO - ##### 08:13:44 INFO - ##### Running download-and-extract step. 08:13:44 INFO - ##### 08:13:44 INFO - Running pre-action listener: _resource_record_pre_action 08:13:44 INFO - Running main action method: download_and_extract 08:13:44 INFO - mkdir: /builds/slave/test/build/tests 08:13:44 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')]} 08:13:44 INFO - https://queue.taskcluster.net/v1/task/AaClyWQdRVyBf6ylml4JWQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:13:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AaClyWQdRVyBf6ylml4JWQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:13:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AaClyWQdRVyBf6ylml4JWQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:13:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AaClyWQdRVyBf6ylml4JWQ/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 08:13:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AaClyWQdRVyBf6ylml4JWQ/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 08:13:45 INFO - Downloaded 1361 bytes. 08:13:45 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:13:45 INFO - Using the following test package requirements: 08:13:45 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:13:45 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:13:45 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:13:45 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:45 INFO - u'jsshell-linux-x86_64.zip'], 08:13:45 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:13:45 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:13:45 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:13:45 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:13:45 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:13:45 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:13:45 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:13: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')]} 08:13:45 INFO - https://queue.taskcluster.net/v1/task/AaClyWQdRVyBf6ylml4JWQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:13:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AaClyWQdRVyBf6ylml4JWQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:13:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AaClyWQdRVyBf6ylml4JWQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:13:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AaClyWQdRVyBf6ylml4JWQ/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 08:13:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AaClyWQdRVyBf6ylml4JWQ/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 08:13:46 INFO - Downloaded 24334132 bytes. 08:13:46 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'] 08:13:46 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 08:13:47 INFO - Return code: 0 08:13:47 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 08:13:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:47 INFO - https://queue.taskcluster.net/v1/task/AaClyWQdRVyBf6ylml4JWQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:13:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AaClyWQdRVyBf6ylml4JWQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:13:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AaClyWQdRVyBf6ylml4JWQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:13:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AaClyWQdRVyBf6ylml4JWQ/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 08:13:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AaClyWQdRVyBf6ylml4JWQ/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 08:13:48 INFO - Downloaded 24334132 bytes. 08:13:48 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'] 08:13:48 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 08:13:50 INFO - Return code: 0 08:13:50 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')]} 08:13:50 INFO - https://queue.taskcluster.net/v1/task/AaClyWQdRVyBf6ylml4JWQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:13:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AaClyWQdRVyBf6ylml4JWQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:13:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AaClyWQdRVyBf6ylml4JWQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:13:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AaClyWQdRVyBf6ylml4JWQ/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 08:13:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AaClyWQdRVyBf6ylml4JWQ/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 08:13:51 INFO - Downloaded 14403317 bytes. 08:13:51 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'] 08:13:51 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 08:13:51 INFO - Return code: 0 08:13:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:51 INFO - https://queue.taskcluster.net/v1/task/AaClyWQdRVyBf6ylml4JWQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:13:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AaClyWQdRVyBf6ylml4JWQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:13:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AaClyWQdRVyBf6ylml4JWQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:13:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AaClyWQdRVyBf6ylml4JWQ/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 08:13:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AaClyWQdRVyBf6ylml4JWQ/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 08:13:53 INFO - Downloaded 60851422 bytes. 08:13:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AaClyWQdRVyBf6ylml4JWQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:13:53 INFO - mkdir: /builds/slave/test/properties 08:13:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:13:53 INFO - Writing to file /builds/slave/test/properties/build_url 08:13:53 INFO - Contents: 08:13:53 INFO - build_url:https://queue.taskcluster.net/v1/task/AaClyWQdRVyBf6ylml4JWQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:13:53 INFO - Running post-action listener: _resource_record_post_action 08:13:54 INFO - Running post-action listener: set_extra_try_arguments 08:13:54 INFO - ##### 08:13:54 INFO - ##### Finished download-and-extract step (success) 08:13:54 INFO - ##### 08:13:54 INFO - ##### 08:13:54 INFO - ##### Running populate-webroot step. 08:13:54 INFO - ##### 08:13:54 INFO - Running pre-action listener: _resource_record_pre_action 08:13:54 INFO - Running main action method: populate_webroot 08:13:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:13:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:13:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:13:54 INFO - '--tppagecycles', 08:13:54 INFO - '7'], 08:13:54 INFO - 'tests': ['tsvgm']}}, 08:13:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:13:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:13:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:13:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:13:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:13:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:13:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:54 INFO - 'talos_options': ['--disable-e10s'], 08:13:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:13:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:13:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:54 INFO - 'talos_options': ['--disable-e10s'], 08:13:54 INFO - 'tests': ['damp', 'tps']}, 08:13:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:54 INFO - 'tests': ['damp', 'tps']}, 08:13:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:13:54 INFO - 'tests': ['dromaeo_dom']}, 08:13:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:13:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:13:54 INFO - 'tests': ['basic_compositor_video']}, 08:13:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:13:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:13:54 INFO - 'tests': ['a11yr', 08:13:54 INFO - 'ts_paint', 08:13:54 INFO - 'tpaint', 08:13:54 INFO - 'sessionrestore', 08:13:54 INFO - 'sessionrestore_no_auto_restore', 08:13:54 INFO - 'tabpaint']}, 08:13:54 INFO - 'other-e10s': {'tests': ['a11yr', 08:13:54 INFO - 'ts_paint', 08:13:54 INFO - 'tpaint', 08:13:54 INFO - 'sessionrestore', 08:13:54 INFO - 'sessionrestore_no_auto_restore', 08:13:54 INFO - 'tabpaint']}, 08:13:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:13:54 INFO - 'ts_paint', 08:13:54 INFO - 'tpaint', 08:13:54 INFO - 'sessionrestore', 08:13:54 INFO - 'sessionrestore_no_auto_restore', 08:13:54 INFO - 'tabpaint']}, 08:13:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:13:54 INFO - 'ts_paint', 08:13:54 INFO - 'tpaint', 08:13:54 INFO - 'sessionrestore', 08:13:54 INFO - 'sessionrestore_no_auto_restore', 08:13:54 INFO - 'tabpaint']}, 08:13:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:13:54 INFO - 'tests': ['a11yr', 08:13:54 INFO - 'ts_paint', 08:13:54 INFO - 'tpaint', 08:13:54 INFO - 'sessionrestore', 08:13:54 INFO - 'sessionrestore_no_auto_restore', 08:13:54 INFO - 'tabpaint']}, 08:13:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:13:54 INFO - 'tests': ['a11yr', 08:13:54 INFO - 'ts_paint', 08:13:54 INFO - 'tpaint', 08:13:54 INFO - 'sessionrestore', 08:13:54 INFO - 'sessionrestore_no_auto_restore', 08:13:54 INFO - 'tabpaint']}, 08:13:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:13:54 INFO - 'tests': ['tsvgx', 08:13:54 INFO - 'tsvgr_opacity', 08:13:54 INFO - 'tart', 08:13:54 INFO - 'tscrollx', 08:13:54 INFO - 'cart']}, 08:13:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:13:54 INFO - 'tsvgr_opacity', 08:13:54 INFO - 'tart', 08:13:54 INFO - 'tscrollx', 08:13:54 INFO - 'cart']}, 08:13:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:54 INFO - 'talos_options': ['--disable-e10s'], 08:13:54 INFO - 'tests': ['tp5o']}, 08:13:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:54 INFO - 'tests': ['tp5o']}, 08:13:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:54 INFO - 'talos_options': ['--disable-e10s', 08:13:54 INFO - '--xperf_path', 08:13:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:13:54 INFO - 'tests': ['tp5n']}, 08:13:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:54 INFO - 'talos_options': ['--xperf_path', 08:13:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:13:54 INFO - 'tests': ['tp5n']}}, 08:13:54 INFO - 'talos.zip': {'path': '', 08:13:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:13:54 INFO - Running post-action listener: _resource_record_post_action 08:13:54 INFO - ##### 08:13:54 INFO - ##### Finished populate-webroot step (success) 08:13:54 INFO - ##### 08:13:54 INFO - ##### 08:13:54 INFO - ##### Running create-virtualenv step. 08:13:54 INFO - ##### 08:13:54 INFO - Running pre-action listener: _resource_record_pre_action 08:13:54 INFO - Running main action method: create_virtualenv 08:13:54 INFO - Creating virtualenv /builds/slave/test/build/venv 08:13:54 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 08:13:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:13:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:13:54 INFO - Using real prefix '/usr' 08:13:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:13:54 INFO - Installing distribute.............................................................................................................................................................................................done. 08:13:56 INFO - Installing pip.................done. 08:13:56 INFO - Return code: 0 08:13:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:13: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')]} 08:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13: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')]} 08:13:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2269180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22673b0>, '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 0x22682b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2268740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468941221.411428-774779316', '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 08:13: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', 'pip>=1.5'] in /builds/slave/test/build 08:13: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 pip>=1.5 08:13:56 INFO - Using env: {'DISPLAY': ':0', 08:13:56 INFO - 'HOME': '/home/cltbld', 08:13:56 INFO - 'LANG': 'en_US.UTF-8', 08:13:56 INFO - 'LANGUAGE': 'en_US:en', 08:13:56 INFO - 'LOGNAME': 'cltbld', 08:13:56 INFO - 'MAIL': '/var/mail/cltbld', 08:13:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:56 INFO - 'MOZ_NO_REMOTE': '1', 08:13:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:56 INFO - 'NO_EM_RESTART': '1', 08:13:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:56 INFO - 'PWD': '/builds/slave/test', 08:13:56 INFO - 'SHELL': '/bin/bash', 08:13:56 INFO - 'SHLVL': '1', 08:13:56 INFO - 'TERM': 'linux', 08:13:56 INFO - 'TMOUT': '86400', 08:13:56 INFO - 'USER': 'cltbld', 08:13:56 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468941221.411428-774779316', 08:13:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:56 INFO - '_': '/tools/buildbot/bin/python'} 08:13:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:56 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 08:13:56 INFO - Cleaning up... 08:13:56 INFO - Return code: 0 08:13:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:13: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')]} 08:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13: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')]} 08:13:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13: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', '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 0x1fa8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2269180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22673b0>, '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 0x22682b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2268740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468941221.411428-774779316', '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 08:13: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', 'psutil>=3.1.1'] in /builds/slave/test/build 08:13: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 psutil>=3.1.1 08:13:56 INFO - Using env: {'DISPLAY': ':0', 08:13:56 INFO - 'HOME': '/home/cltbld', 08:13:56 INFO - 'LANG': 'en_US.UTF-8', 08:13:56 INFO - 'LANGUAGE': 'en_US:en', 08:13:56 INFO - 'LOGNAME': 'cltbld', 08:13:56 INFO - 'MAIL': '/var/mail/cltbld', 08:13:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:56 INFO - 'MOZ_NO_REMOTE': '1', 08:13:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:56 INFO - 'NO_EM_RESTART': '1', 08:13:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:56 INFO - 'PWD': '/builds/slave/test', 08:13:56 INFO - 'SHELL': '/bin/bash', 08:13:56 INFO - 'SHLVL': '1', 08:13:56 INFO - 'TERM': 'linux', 08:13:56 INFO - 'TMOUT': '86400', 08:13:56 INFO - 'USER': 'cltbld', 08:13:56 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468941221.411428-774779316', 08:13:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:56 INFO - '_': '/tools/buildbot/bin/python'} 08:13:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:57 INFO - Downloading/unpacking psutil>=3.1.1 08:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:13:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:13:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:13:59 INFO - Installing collected packages: psutil 08:13:59 INFO - Running setup.py install for psutil 08:13:59 INFO - building 'psutil._psutil_linux' extension 08:13:59 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 08:13:59 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 08:13:59 INFO - building 'psutil._psutil_posix' extension 08:13:59 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 08:13:59 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 08:13:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:13:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:13:59 INFO - Successfully installed psutil 08:13:59 INFO - Cleaning up... 08:13:59 INFO - Return code: 0 08:13:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2269180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22673b0>, '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 0x22682b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2268740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468941221.411428-774779316', '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 08:13:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:13:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:13:59 INFO - Using env: {'DISPLAY': ':0', 08:13:59 INFO - 'HOME': '/home/cltbld', 08:13:59 INFO - 'LANG': 'en_US.UTF-8', 08:13:59 INFO - 'LANGUAGE': 'en_US:en', 08:13:59 INFO - 'LOGNAME': 'cltbld', 08:13:59 INFO - 'MAIL': '/var/mail/cltbld', 08:13:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:59 INFO - 'MOZ_NO_REMOTE': '1', 08:13:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:59 INFO - 'NO_EM_RESTART': '1', 08:13:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:59 INFO - 'PWD': '/builds/slave/test', 08:13:59 INFO - 'SHELL': '/bin/bash', 08:13:59 INFO - 'SHLVL': '1', 08:13:59 INFO - 'TERM': 'linux', 08:13:59 INFO - 'TMOUT': '86400', 08:13:59 INFO - 'USER': 'cltbld', 08:13:59 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468941221.411428-774779316', 08:13:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:59 INFO - '_': '/tools/buildbot/bin/python'} 08:13:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:14:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:14:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:14:01 INFO - Installing collected packages: mozsystemmonitor 08:14:01 INFO - Running setup.py install for mozsystemmonitor 08:14:01 INFO - Successfully installed mozsystemmonitor 08:14:01 INFO - Cleaning up... 08:14:02 INFO - Return code: 0 08:14:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:14:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:02 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 0x1fa8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2269180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22673b0>, '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 0x22682b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2268740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468941221.411428-774779316', '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 08:14:02 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 08:14:02 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 08:14:02 INFO - Using env: {'DISPLAY': ':0', 08:14:02 INFO - 'HOME': '/home/cltbld', 08:14:02 INFO - 'LANG': 'en_US.UTF-8', 08:14:02 INFO - 'LANGUAGE': 'en_US:en', 08:14:02 INFO - 'LOGNAME': 'cltbld', 08:14:02 INFO - 'MAIL': '/var/mail/cltbld', 08:14:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:02 INFO - 'MOZ_NO_REMOTE': '1', 08:14:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:02 INFO - 'NO_EM_RESTART': '1', 08:14:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:02 INFO - 'PWD': '/builds/slave/test', 08:14:02 INFO - 'SHELL': '/bin/bash', 08:14:02 INFO - 'SHLVL': '1', 08:14:02 INFO - 'TERM': 'linux', 08:14:02 INFO - 'TMOUT': '86400', 08:14:02 INFO - 'USER': 'cltbld', 08:14:02 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468941221.411428-774779316', 08:14:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:02 INFO - '_': '/tools/buildbot/bin/python'} 08:14:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:02 INFO - Downloading/unpacking jsonschema==2.5.1 08:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:14:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:14:04 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 08:14:04 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 08:14:04 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 08:14:04 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 08:14:04 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 08:14:04 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 08:14:04 INFO - Downloading functools32-3.2.3-2.tar.gz 08:14:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:14:04 INFO - warning: no files found matching '*.txt' 08:14:04 INFO - no previously-included directories found matching 'build' 08:14:04 INFO - no previously-included directories found matching 'dist' 08:14:04 INFO - no previously-included directories found matching '.git*' 08:14:04 INFO - Installing collected packages: jsonschema, functools32 08:14:04 INFO - Running setup.py install for functools32 08:14:04 INFO - warning: no files found matching '*.txt' 08:14:04 INFO - no previously-included directories found matching 'build' 08:14:04 INFO - no previously-included directories found matching 'dist' 08:14:04 INFO - no previously-included directories found matching '.git*' 08:14:04 INFO - Successfully installed jsonschema functools32 08:14:04 INFO - Cleaning up... 08:14:04 INFO - Return code: 0 08:14:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:14:04 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')]} 08:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:04 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')]} 08:14:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:04 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 0x1fa8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2269180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22673b0>, '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 0x22682b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2268740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468941221.411428-774779316', '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 08:14:04 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 08:14:04 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 08:14:04 INFO - Using env: {'DISPLAY': ':0', 08:14:04 INFO - 'HOME': '/home/cltbld', 08:14:04 INFO - 'LANG': 'en_US.UTF-8', 08:14:04 INFO - 'LANGUAGE': 'en_US:en', 08:14:04 INFO - 'LOGNAME': 'cltbld', 08:14:04 INFO - 'MAIL': '/var/mail/cltbld', 08:14:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:04 INFO - 'MOZ_NO_REMOTE': '1', 08:14:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:04 INFO - 'NO_EM_RESTART': '1', 08:14:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:04 INFO - 'PWD': '/builds/slave/test', 08:14:04 INFO - 'SHELL': '/bin/bash', 08:14:04 INFO - 'SHLVL': '1', 08:14:04 INFO - 'TERM': 'linux', 08:14:04 INFO - 'TMOUT': '86400', 08:14:04 INFO - 'USER': 'cltbld', 08:14:04 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468941221.411428-774779316', 08:14:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:04 INFO - '_': '/tools/buildbot/bin/python'} 08:14:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:05 INFO - Downloading/unpacking blobuploader==1.2.4 08:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:07 INFO - Downloading blobuploader-1.2.4.tar.gz 08:14:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:14:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:14:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:07 INFO - Downloading docopt-0.6.1.tar.gz 08:14:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:14:07 INFO - Installing collected packages: blobuploader, requests, docopt 08:14:07 INFO - Running setup.py install for blobuploader 08:14:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:14:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:14:07 INFO - Running setup.py install for requests 08:14:08 INFO - Running setup.py install for docopt 08:14:08 INFO - Successfully installed blobuploader requests docopt 08:14:08 INFO - Cleaning up... 08:14:08 INFO - Return code: 0 08:14:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:08 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')]} 08:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:08 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')]} 08:14:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:08 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 0x1fa8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2269180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22673b0>, '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 0x22682b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2268740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468941221.411428-774779316', '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 08:14:08 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 08:14:08 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 08:14:08 INFO - Using env: {'DISPLAY': ':0', 08:14:08 INFO - 'HOME': '/home/cltbld', 08:14:08 INFO - 'LANG': 'en_US.UTF-8', 08:14:08 INFO - 'LANGUAGE': 'en_US:en', 08:14:08 INFO - 'LOGNAME': 'cltbld', 08:14:08 INFO - 'MAIL': '/var/mail/cltbld', 08:14:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:08 INFO - 'MOZ_NO_REMOTE': '1', 08:14:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:08 INFO - 'NO_EM_RESTART': '1', 08:14:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:08 INFO - 'PWD': '/builds/slave/test', 08:14:08 INFO - 'SHELL': '/bin/bash', 08:14:08 INFO - 'SHLVL': '1', 08:14:08 INFO - 'TERM': 'linux', 08:14:08 INFO - 'TMOUT': '86400', 08:14:08 INFO - 'USER': 'cltbld', 08:14:08 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468941221.411428-774779316', 08:14:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:08 INFO - '_': '/tools/buildbot/bin/python'} 08:14:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:14:08 INFO - Running setup.py (path:/tmp/pip-xunNzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:14:08 INFO - Running setup.py (path:/tmp/pip-wSfIdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:14:08 INFO - Running setup.py (path:/tmp/pip-bqyDeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:14:08 INFO - Running setup.py (path:/tmp/pip-CfIpUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:14:08 INFO - Running setup.py (path:/tmp/pip-ZbiXWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:14:08 INFO - Running setup.py (path:/tmp/pip-4n6V2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:14:09 INFO - Running setup.py (path:/tmp/pip-i_6nyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:14:09 INFO - Running setup.py (path:/tmp/pip-h4b0d_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:14:09 INFO - Running setup.py (path:/tmp/pip-sCkLLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:14:09 INFO - Running setup.py (path:/tmp/pip-9cxKSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:14:09 INFO - Running setup.py (path:/tmp/pip-DYNRBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:14:09 INFO - Running setup.py (path:/tmp/pip-4T5qdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:14:09 INFO - Running setup.py (path:/tmp/pip-kIkH0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:14:09 INFO - Running setup.py (path:/tmp/pip-ziIZBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:09 INFO - Running setup.py (path:/tmp/pip-B0GWXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:14:09 INFO - Running setup.py (path:/tmp/pip-92UZ6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:14:09 INFO - Running setup.py (path:/tmp/pip-pQDqfJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:14:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:14:09 INFO - Running setup.py install for manifestparser 08:14:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:14:09 INFO - Running setup.py install for mozcrash 08:14:10 INFO - Running setup.py install for mozdebug 08:14:10 INFO - Running setup.py install for mozdevice 08:14:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:14:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:14:10 INFO - Running setup.py install for mozfile 08:14:10 INFO - Running setup.py install for mozhttpd 08:14:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:14:10 INFO - Running setup.py install for mozinfo 08:14:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:14:10 INFO - Running setup.py install for mozInstall 08:14:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:14:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:14:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:14:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:14:10 INFO - Running setup.py install for mozleak 08:14:10 INFO - Running setup.py install for mozlog 08:14:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:14:10 INFO - Running setup.py install for moznetwork 08:14:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:14:10 INFO - Running setup.py install for mozprocess 08:14:11 INFO - Running setup.py install for mozprofile 08:14:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:14:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:14:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:14:11 INFO - Running setup.py install for mozrunner 08:14:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:14:11 INFO - Running setup.py install for mozscreenshot 08:14:11 INFO - Running setup.py install for moztest 08:14:11 INFO - Running setup.py install for mozversion 08:14:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:14:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:14:11 INFO - Cleaning up... 08:14:11 INFO - Return code: 0 08:14:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:11 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 0x1fa8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2269180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22673b0>, '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 0x22682b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2268740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468941221.411428-774779316', '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 08:14:11 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 08:14:11 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 08:14:11 INFO - Using env: {'DISPLAY': ':0', 08:14:11 INFO - 'HOME': '/home/cltbld', 08:14:11 INFO - 'LANG': 'en_US.UTF-8', 08:14:11 INFO - 'LANGUAGE': 'en_US:en', 08:14:11 INFO - 'LOGNAME': 'cltbld', 08:14:11 INFO - 'MAIL': '/var/mail/cltbld', 08:14:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:11 INFO - 'MOZ_NO_REMOTE': '1', 08:14:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:11 INFO - 'NO_EM_RESTART': '1', 08:14:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:11 INFO - 'PWD': '/builds/slave/test', 08:14:11 INFO - 'SHELL': '/bin/bash', 08:14:11 INFO - 'SHLVL': '1', 08:14:11 INFO - 'TERM': 'linux', 08:14:11 INFO - 'TMOUT': '86400', 08:14:11 INFO - 'USER': 'cltbld', 08:14:11 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468941221.411428-774779316', 08:14:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:11 INFO - '_': '/tools/buildbot/bin/python'} 08:14:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:14:11 INFO - Running setup.py (path:/tmp/pip-hq8mnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:14:11 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)) 08:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:14:11 INFO - Running setup.py (path:/tmp/pip-J6Tuaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:14:11 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)) 08:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:14:11 INFO - Running setup.py (path:/tmp/pip-pAxs8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:14:12 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)) 08:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:14:12 INFO - Running setup.py (path:/tmp/pip-HIl83R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:14:12 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)) 08:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:14:12 INFO - Running setup.py (path:/tmp/pip-ttZh6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:14:12 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)) 08:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:14:12 INFO - Running setup.py (path:/tmp/pip-4NkYTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:14:12 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)) 08:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:14:12 INFO - Running setup.py (path:/tmp/pip-knE8T4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:14:12 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)) 08:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:14:12 INFO - Running setup.py (path:/tmp/pip-uPqy3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:14:12 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)) 08:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:14:12 INFO - Running setup.py (path:/tmp/pip-MQ062y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:14:12 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)) 08:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:14:12 INFO - Running setup.py (path:/tmp/pip-g9VTRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:14:12 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)) 08:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:14:12 INFO - Running setup.py (path:/tmp/pip-Hnlg9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:14:12 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)) 08:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:14:12 INFO - Running setup.py (path:/tmp/pip-EvuLp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:14:12 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)) 08:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:14:12 INFO - Running setup.py (path:/tmp/pip-SxOIWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:14:12 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)) 08:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:14:12 INFO - Running setup.py (path:/tmp/pip-Y99cW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:14:12 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)) 08:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:12 INFO - Running setup.py (path:/tmp/pip-_V03aP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:12 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)) 08:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:14:12 INFO - Running setup.py (path:/tmp/pip-YlQ8KP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:14:13 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)) 08:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:14:13 INFO - Running setup.py (path:/tmp/pip-MDvixF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:14:13 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)) 08:14:13 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)) 08:14:13 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)) 08:14:13 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)) 08:14:13 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)) 08:14:13 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)) 08:14:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:14:13 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 08:14:13 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 08:14:13 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 08:14:13 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 08:14:13 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 08:14:13 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 08:14:14 INFO - Downloading blessings-1.6.tar.gz 08:14:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:14:15 INFO - Installing collected packages: blessings 08:14:15 INFO - Running setup.py install for blessings 08:14:15 INFO - Successfully installed blessings 08:14:15 INFO - Cleaning up... 08:14:15 INFO - Return code: 0 08:14:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:14:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:14:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:14:15 INFO - Reading from file tmpfile_stdout 08:14:15 INFO - Current package versions: 08:14:15 INFO - argparse == 1.2.1 08:14:15 INFO - blessings == 1.6 08:14:15 INFO - blobuploader == 1.2.4 08:14:15 INFO - docopt == 0.6.1 08:14:15 INFO - functools32 == 3.2.3-2 08:14:15 INFO - jsonschema == 2.5.1 08:14:15 INFO - manifestparser == 1.1 08:14:15 INFO - mozInstall == 1.12 08:14:15 INFO - mozcrash == 0.17 08:14:15 INFO - mozdebug == 0.1 08:14:15 INFO - mozdevice == 0.48 08:14:15 INFO - mozfile == 1.2 08:14:15 INFO - mozhttpd == 0.7 08:14:15 INFO - mozinfo == 0.9 08:14:15 INFO - mozleak == 0.1 08:14:15 INFO - mozlog == 3.2 08:14:15 INFO - moznetwork == 0.27 08:14:15 INFO - mozprocess == 0.23 08:14:15 INFO - mozprofile == 0.28 08:14:15 INFO - mozrunner == 6.12 08:14:15 INFO - mozscreenshot == 0.1 08:14:15 INFO - mozsystemmonitor == 0.3 08:14:15 INFO - moztest == 0.7 08:14:15 INFO - mozversion == 1.4 08:14:15 INFO - psutil == 3.1.1 08:14:15 INFO - requests == 1.2.3 08:14:15 INFO - wsgiref == 0.1.2 08:14:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:15 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')]} 08:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:15 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')]} 08:14:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:15 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 0x1fa8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2269180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22673b0>, '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 0x22682b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2268740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468941221.411428-774779316', '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 08:14:15 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 08:14:15 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 08:14:15 INFO - Using env: {'DISPLAY': ':0', 08:14:15 INFO - 'HOME': '/home/cltbld', 08:14:15 INFO - 'LANG': 'en_US.UTF-8', 08:14:15 INFO - 'LANGUAGE': 'en_US:en', 08:14:15 INFO - 'LOGNAME': 'cltbld', 08:14:15 INFO - 'MAIL': '/var/mail/cltbld', 08:14:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:15 INFO - 'MOZ_NO_REMOTE': '1', 08:14:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:15 INFO - 'NO_EM_RESTART': '1', 08:14:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:15 INFO - 'PWD': '/builds/slave/test', 08:14:15 INFO - 'SHELL': '/bin/bash', 08:14:15 INFO - 'SHLVL': '1', 08:14:15 INFO - 'TERM': 'linux', 08:14:15 INFO - 'TMOUT': '86400', 08:14:15 INFO - 'USER': 'cltbld', 08:14:15 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468941221.411428-774779316', 08:14:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:15 INFO - '_': '/tools/buildbot/bin/python'} 08:14:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:15 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)) 08:14:15 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)) 08:14:15 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)) 08:14:15 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)) 08:14:15 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)) 08:14:15 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)) 08:14:15 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)) 08:14:15 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)) 08:14:15 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)) 08:14:15 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)) 08:14:15 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)) 08:14:15 INFO - Cleaning up... 08:14:15 INFO - Return code: 0 08:14:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:14:15 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')]} 08:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:15 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')]} 08:14:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:15 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 0x1fa8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2269180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22673b0>, '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 0x22682b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2268740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468941221.411428-774779316', '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 08:14:15 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 08:14:15 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 08:14:15 INFO - Using env: {'DISPLAY': ':0', 08:14:15 INFO - 'HOME': '/home/cltbld', 08:14:15 INFO - 'LANG': 'en_US.UTF-8', 08:14:15 INFO - 'LANGUAGE': 'en_US:en', 08:14:15 INFO - 'LOGNAME': 'cltbld', 08:14:15 INFO - 'MAIL': '/var/mail/cltbld', 08:14:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:15 INFO - 'MOZ_NO_REMOTE': '1', 08:14:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:15 INFO - 'NO_EM_RESTART': '1', 08:14:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:15 INFO - 'PWD': '/builds/slave/test', 08:14:15 INFO - 'SHELL': '/bin/bash', 08:14:15 INFO - 'SHLVL': '1', 08:14:15 INFO - 'TERM': 'linux', 08:14:15 INFO - 'TMOUT': '86400', 08:14:15 INFO - 'USER': 'cltbld', 08:14:15 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468941221.411428-774779316', 08:14:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:15 INFO - '_': '/tools/buildbot/bin/python'} 08:14:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:14:15 INFO - Cleaning up... 08:14:15 INFO - Return code: 0 08:14:15 INFO - Running post-action listener: _resource_record_post_action 08:14:15 INFO - Running post-action listener: _start_resource_monitoring 08:14:15 INFO - Starting resource monitoring. 08:14:15 INFO - ##### 08:14:15 INFO - ##### Finished create-virtualenv step (success) 08:14:15 INFO - ##### 08:14:15 INFO - ##### 08:14:15 INFO - ##### Running install step. 08:14:15 INFO - ##### 08:14:15 INFO - Running pre-action listener: _resource_record_pre_action 08:14:15 INFO - Running main action method: install 08:14:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:14:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:14:16 INFO - Reading from file tmpfile_stdout 08:14:16 INFO - Detecting whether we're running mozinstall >=1.0... 08:14:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:14:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:14:16 INFO - Reading from file tmpfile_stdout 08:14:16 INFO - Output received: 08:14:16 INFO - Usage: mozinstall [options] installer 08:14:16 INFO - Options: 08:14:16 INFO - -h, --help show this help message and exit 08:14:16 INFO - -d DEST, --destination=DEST 08:14:16 INFO - Directory to install application into. [default: 08:14:16 INFO - "/builds/slave/test"] 08:14:16 INFO - --app=APP Application being installed. [default: firefox] 08:14:16 INFO - mkdir: /builds/slave/test/build/application 08:14:16 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'] 08:14:16 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 08:14:33 INFO - Reading from file tmpfile_stdout 08:14:33 INFO - Output received: 08:14:33 INFO - /builds/slave/test/build/application/firefox/firefox 08:14:33 INFO - Running post-action listener: _resource_record_post_action 08:14:33 INFO - ##### 08:14:33 INFO - ##### Finished install step (success) 08:14:33 INFO - ##### 08:14:33 INFO - ##### 08:14:33 INFO - ##### Running run-tests step. 08:14:33 INFO - ##### 08:14:33 INFO - Running pre-action listener: _resource_record_pre_action 08:14:33 INFO - Running main action method: run_tests 08:14:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:14:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:14:33 INFO - Python 2.7.3 08:14:33 INFO - Return code: 0 08:14:33 INFO - grabbing minidump binary from tooltool 08:14:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:33 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 0x22673b0>, '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 0x22682b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2268740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:14:33 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 08:14:33 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 08:14:33 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 08:14:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:14:33 INFO - Return code: 0 08:14:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:14:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:14:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:14:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:14:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:14:34 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/AaClyWQdRVyBf6ylml4JWQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 08:14:34 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/AaClyWQdRVyBf6ylml4JWQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 08:14:34 INFO - Using env: {'DISPLAY': ':0', 08:14:34 INFO - 'HOME': '/home/cltbld', 08:14:34 INFO - 'LANG': 'en_US.UTF-8', 08:14:34 INFO - 'LANGUAGE': 'en_US:en', 08:14:34 INFO - 'LOGNAME': 'cltbld', 08:14:34 INFO - 'MAIL': '/var/mail/cltbld', 08:14:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:14:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:34 INFO - 'MOZ_NO_REMOTE': '1', 08:14:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:14:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:34 INFO - 'NO_EM_RESTART': '1', 08:14:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:34 INFO - 'PWD': '/builds/slave/test', 08:14:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:14:34 INFO - 'SHELL': '/bin/bash', 08:14:34 INFO - 'SHLVL': '1', 08:14:34 INFO - 'TERM': 'linux', 08:14:34 INFO - 'TMOUT': '86400', 08:14:34 INFO - 'USER': 'cltbld', 08:14:34 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468941221.411428-774779316', 08:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:34 INFO - '_': '/tools/buildbot/bin/python'} 08:14:34 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/AaClyWQdRVyBf6ylml4JWQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 08:14:34 INFO - mozversion application_buildid: 20160719053026 08:14:34 INFO - mozversion application_changeset: efa58477381d54e2d0bd1d89c2d9210a3714e143 08:14:34 INFO - mozversion application_display_name: Nightly 08:14:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:14:34 INFO - mozversion application_name: Firefox 08:14:34 INFO - mozversion application_remotingname: firefox 08:14:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:14:34 INFO - mozversion application_vendor: Mozilla 08:14:34 INFO - mozversion application_version: 50.0a1 08:14:34 INFO - mozversion platform_buildid: 20160719053026 08:14:34 INFO - mozversion platform_changeset: efa58477381d54e2d0bd1d89c2d9210a3714e143 08:14:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:14:34 INFO - mozversion platform_version: 50.0a1 08:14:34 INFO - using testdate: 1468941274 08:14:34 INFO - actual date: 1468941274 08:14:34 INFO - starting webserver on 'localhost:57545' 08:14:34 INFO - SUITE-START | Running 2 tests 08:14:34 INFO - TEST-START | dromaeo_css 08:14:34 INFO - operating with platform_type : linux_ 08:14:34 INFO - Initialising browser for dromaeo_css test... 08:14:34 INFO - TEST-INFO | started process 7471 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjkvpdV/profile http://localhost:57545/getInfo.html) 08:14:38 INFO - PROCESS | 7471 | __metrics Screen width/height:1600/1200 08:14:38 INFO - PROCESS | 7471 | colorDepth:24 08:14:38 INFO - PROCESS | 7471 | Browser inner width/height: 1024/697 08:14:38 INFO - PROCESS | 7471 | __metrics 08:14:40 INFO - PROCESS | 7471 | 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" 08:14:40 INFO - PROCESS | 7471 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:14:40 INFO - PROCESS | 7471 | console.error: PushService: 08:14:40 INFO - PROCESS | 7471 | stateChangeProcessEnqueue: Error transitioning state 08:14:40 INFO - PROCESS | 7471 | UnknownError 08:14:41 INFO - TEST-INFO | 7471: exit 0 08:14:41 INFO - Browser initialized. 08:14:41 INFO - Running cycle 1/1 for dromaeo_css test... 08:14:41 INFO - TEST-INFO | started process 7550 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjkvpdV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:14:52 INFO - PROCESS | 7550 | RSS: Main: 157970432 08:14:52 INFO - PROCESS | 7550 | 08:15:44 INFO - PROCESS | 7550 | 1468941344374 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] 08:17:52 INFO - PROCESS | 7550 | Cycle 1(1): loaded http://localhost:57545/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57545/tests/dromaeo/cssquery-ext.html) 08:17:53 INFO - PROCESS | 7550 | RSS: Main: 268386304 08:17:53 INFO - PROCESS | 7550 | 08:20:56 INFO - PROCESS | 7550 | Cycle 1(1): loaded http://localhost:57545/tests/dromaeo/cssquery-ext.html (next: http://localhost:57545/tests/dromaeo/cssquery-jquery.html) 08:20:56 INFO - PROCESS | 7550 | RSS: Main: 245747712 08:20:56 INFO - PROCESS | 7550 | 08:23:58 INFO - PROCESS | 7550 | Cycle 1(1): loaded http://localhost:57545/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57545/tests/dromaeo/cssquery-mootools.html) 08:23:58 INFO - PROCESS | 7550 | RSS: Main: 243298304 08:23:58 INFO - PROCESS | 7550 | 08:27:00 INFO - PROCESS | 7550 | Cycle 1(1): loaded http://localhost:57545/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57545/tests/dromaeo/cssquery-prototype.html) 08:27:01 INFO - PROCESS | 7550 | RSS: Main: 233422848 08:27:01 INFO - PROCESS | 7550 | 08:30:04 INFO - PROCESS | 7550 | Cycle 1(1): loaded http://localhost:57545/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57545/tests/dromaeo/cssquery-yui.html) 08:30:04 INFO - PROCESS | 7550 | RSS: Main: 224350208 08:30:04 INFO - PROCESS | 7550 | 08:33:07 INFO - PROCESS | 7550 | Cycle 1(1): loaded http://localhost:57545/tests/dromaeo/cssquery-yui.html (next: http://localhost:57545/tests/dromaeo/cssquery-dojo.html) 08:33:07 INFO - PROCESS | 7550 | RSS: Main: 301338624 08:33:07 INFO - PROCESS | 7550 | 08:33:07 INFO - PROCESS | 7550 | __start_tp_report 08:33:07 INFO - PROCESS | 7550 | _x_x_mozilla_page_load 08:33:07 INFO - PROCESS | 7550 | _x_x_mozilla_page_load_details 08:33:07 INFO - PROCESS | 7550 | |i|pagename|runs| 08:33:07 INFO - PROCESS | 7550 | |0;dojo.html;2968.5547167924824;3011.9397612047774;3026.485497465431;3072.201227680803;3105.3168302973345;5233.528982391584;5343.332083489564;5386.245925570418;5468.890622187554;5508.559315254775;5406.189071639246;5420.214068959998;5425.538829199513;5427.48438898304;5491.807786727465;4831.299461578069;4875.073735990169;4903.19097348937;4915.655904086715;5038.168702164138;4951.826686065989;4973.254011898226;4986.650934434591;5015.147424937751;5023.070731914608;4805.615550755949;4820.035992801436;4858.805647774085;4873.269009648546;4889.682170658896;4847.297141914438;4872.902541949176;4875.902481950341;4917.975410122926;4960.280759289919;4875.341828853095;4896.143174944406;4898.191798353268;4899.902001959941;4902.754862256873;5242.423333433319;5359.678419294854;5428.809991650312;5453.481919217668;5456.127019676872;5767.855803604902;5782.624129431616;5813.883722325572;5816.272965879265;5817.767289308465;5666.490015898589;5830.125481177814;5866.501347385477;5897.911531327033;5900.704964751788;5311.760970756287;5402.108652072403;5402.459754024566;5407.702576358299;5410.864728381783;5873.3245676746865;5896.262967129109;5896.439838215363;5905.616134951214;5909.143174239797;5553.750081246354;5560.110382338888;5574.331080270313;5591.27313449249;5621.775128994795;5707.71461426927;5711.029125048752;5748.9425105748405;5754.223179870748;5774.82675519735;5621.241132447149;5687.971560142173;5696.943030569724;5720.370759216483;5751.511121554631;5734.4552267535355;5766.394528574523;5779.162021506942;5789.073748200268;5798.536117110621;4399.20814253431;4425.070735145656;4429.247028005247;4430.246858034142;4472.217361961643;3891.2995660780766;3891.4357418174204;3914.530256369254;3922.7254092213843;3947.6644485219076;5434.375046869582;5440.863978400572;5464.7814087436855;5470.753816078286;5516.9448305517235;5762.74067666956;5764.193012978187;5769.769209231584;5773.191753154561;5814.767409303665;5388.299521062315;5431.51116399518;5464.043792336325;5470.452954704578;5470.671759694431;4998.550130488274;5012.974935125374;5014.598832093424;5018.322526458955;5057.089723849669;5990.430909063632;5997.850053748604;6002.429769171922;6018.398160183947;6054.606450580698;5666.575006874418;5784.074548072288;5790.913136302875;5797.333306669787;5801.274840644919;5994.250718660168;6004.8799024020145;6005.129256257906;6010.338862725184;6012.488938440281;5729.169270455844;5731.054376027909;5736.42635736423;5738.913916291175;5744.425557444222;5715.142728590578;5799.391063938226;5805.680687562224;5852.853678658068;5882.647041177543;5743;5744.5978781486565;5746;5749.195112684144;5752.884942301214;5552.833414997556;5674.801381951612;5710.486056254957;5720.02759530889;5733.082706766897;5627.099664053731;5635.915461268166;5680.346760122638;5693.971530142323;5703.258576385043;5705.7147142643535;5722.942770572407;5730.856728581652;5732.455416735404;5776.451237132465;5448;5503.229547863382;5608.6073974823;5621.35354434229;5625.915611265752 08:33:07 INFO - PROCESS | 7550 | |1;ext.html;591.792872494627;603.4418163199042;625.068647714905;626.3016736338982;638.5434414393709;44229.33655995159;45024.87437814052;45032.54967450324;45130.7743461283;48694.51305486944;47008.52991470084;47604.0479190416;47622.523774762245;47644.76177619107;47661.76169119158;9055.275577953747;9199.724008279762;9201.03389144137;9201.079892010779;9207.171354578086;9069.863952040725;9184.586693598803;9196.080391960784;9212.401193922407;9213.447193168398;9233.399829011092;9267.536623168848;9267.95366023169;9270.07299270071;9273.350865439423;9121.179093881516;9155.221806146486;9160.312976526788;9190.632374705005;9202.76993075175;9078.954605226998;9114.544272786334;9154.221891139261;9155.313351498598;9168.495732734697;44870.77564612189;45145.32282015772;45330.32004519935;45333;45343.31985020227;3614.457831325296;4205.621494065518;4224.683148763855;4227.704060715751;4363.47638283408;33993.32013359719;34012.48981265283;34406.48390274148;34436.48345274823;34887.82556087229;4392.297232442794;4423.203823311803;4441.356003379492;4461.486929003174;4522.394549934758;343657;345162;345551;345721;345755;60410;60512.394876051556;60601;60738.088928666104;61089;55876.720616396655;61794;63148.684256578425;63260.36739632545;69338.30661693419;17515.474535763948;17603.471895843144;17664.205110769788;17665.470035898943;17674.823251767575;10863.891361086446;13421.060525763298;13480.056396052378;13517.188968661912;13523.32383380827;17184;17642.558936026446;17674.646507070043;17943.820561794477;18362.08189590542;5939.406059394026;5943.405659434022;5972.641641501524;5994;6041.24484439445;913.977150571241;984.8670429491926;1037.387941114746;1131.4173200801595;1179.9469023893773;32868.3426331472;33669.32661346808;34905.825470872485;36944.07639809026;37876.62123378786;1103.5254840418536;1126.6056880092067;1166.032193279576;1190.7380376317196;1227.2943057741657;17487.562810929576;17711.911440442716;17766.289348426177;17933.37233196832;17981.820181798277;533182;539520;541385;541748;541904;59375.10937335943;59439.70280148571;59551.40448595458;59566.10650840241;59604.70197648984;1247.108317552954;1375.4498200719793;1410.7249086428253;1414.4412956881974;1418.418448436157;33484.33031339311;34380.82809585936;34769.826150869085;34902.30195396027;34926.30147397089;51376.74311628418;51767.741161293954;51987.2201916964;52140.21789673082;52153.217701735266;376261;376897;376966;377049;378429;24779.87610061938;29188.27029324199;29503.082299650454;29539.261518462212;29789.553156702234;48694.26958595553;49731.254031190285;50265.90740282248;50496.747516262185;50867.491325086274;41690.58309416988;42247.366289505066;42319.36520952127;42923.57076429196;43091.138177235654;41909.371359429024;42514.36228456514;42873.35689964591;42978.78510607427;43551.34672979971;41344.586554135276;42110.157796843276;43343.56656433395;43480.782596086814;43575.98876129159;36660.0834979117;37149;37415.81292093522;38008.61991380051;38077.80961095288;28660;28690.282742931595;29037.709622904345;29334.706652933197;29482.705172947997 08:33:07 INFO - PROCESS | 7550 | |2;jquery.html;388.66768912579727;389.41198789827354;400.6214127649371;404.77130421311955;413.8204138204139;18163;19534;20191;20229.393118206477;20697.68953465699;19216.231350745988;19300.51748706283;20262.088206030727;20303.49241268969;20313;5683.403242659523;5857.560682948764;5914.497267732248;5938.910916336258;6041.063635136539;5745.2818397700285;5761.625494342854;5848.67832269225;5977.671228082454;5980.97009514954;5942.910856337158;5950.315713692916;5963.85090372742;5978.8206353809455;5987.9101813472835;5840.211571437865;6195.504359651217;6227.782027629011;6242.563020588538;6246.500279977591;4960.082384758795;5867.178594996704;5937.732802023919;5957.285125784891;5966.134910438005;13478.663033424244;13744.793828092586;14173.858261417357;14224.431022759078;14255.429782808675;2305.7809508096702;2328.068772491017;2352.7294361148515;2362.574736547421;2372.9525409491885;9871.2103031758;10198.49007549627;10249;10265.897341026568;10403;1885.38724914402;1898.5511581760436;1901.3820508334848;1954.697021961584;1954.8045195480338;76806;83599;84121.57939210265;84374.15625843724;84688;10301;10369.170466362673;10759.78480430387;10843.132549396187;11054.944725276482;14708.264586770618;14755.188464634548;14792.926035369754;14795.186264755543;14807.407703691732;7740.845183096307;7815.765527034198;7875.803104922423;7980.960095199487;7981.600919953979;7282.417406607458;7388.852222955511;7396.667149978264;7449.833820626212;7722.768316950501;4341.891452713644;4367.2575662137515;4391.538888416734;4468.486124095705;4604.539546045368;1896.4121122452084;1988.582397696471;2013.5133110608388;2026.422469596158;2032.979670203279;899.1772528136681;963.5567638886191;977.8093271811929;985.2216748768536;1033.1115240892825;19838.70241946372;20246;20337.288194913108;20337.694934575993;20460.795392046188;979.9559019844124;1001.8296889528798;1009.5305682857506;1021.39737554843;1025.789713108826;9338.813223735624;11160.609378671708;11183.888161118448;11221.943890280496;11382.715432114263;470462;480003;489838;490920;497678;82270;83847.16152838393;84724;85479;85543.5722821382;996.4868092932;996.4868092932146;1012.9341592796445;1014.60937539048;1016.7610611506439;17444.82555174432;17595.29618815233;18077.909610451865;18138.455846324632;18331.08344582792;39814.402783958845;39939;40518.79740601278;40733;41171.58828411678;56289.71855140698;57514;57917.710411449356;58000;59003.409965899795;8782.868256976022;8789.868151977598;8867.512286824287;8979.251132840385;8988.235999940078;13113.737725245632;13520.12119212248;13575.253361065235;13697.315134243447;13732.45070197221;11131.610393636183;11376.260543064674;11459.255148415326;11927.165098443025;12184.268943863397;11393.601223957454;11551.711207219887;11717.414129293331;11877.46551405206;12002.75994480123;11914.106442017057;12063.276203427822;12066;12245.75508489843;12268.38658067111;8688.30493560501;8844.336674749547;8871.334649901155;8923.375363724477;11832.408379581158;12446.56437024736;12455;12747.87252127504;12897.290649014394;13448.260345681081 08:33:07 INFO - PROCESS | 7550 | |3;mootools.html;1348.3056226043584;1439.899207055506;1497.565705945276;1594.6252630631807;1745.5199820049477;8225.794355141117;8464.57677116144;8472.364572657052;8638.870416943751;8656.610452529636;8345.248927596514;8514.829703405929;8534.445261058027;8541.145885411455;8553.828923421543;2355.740868504463;2385.7017872765905;2388.8208384371155;2390.3904504351367;2391.5695174868515;2327.5112226432384;2345.95308093838;2349.7415284318713;2360.7875291223786;2379.3456799380224;2330.7669233076726;2334.2180369576126;2358.363241924679;2361.5631108244943;2365.503244318695;2262.061244583496;2276.2147059264526;2284.1434462076722;2289.7595752446005;2315.305408377497;2269.897854596547;2305.7809508096702;2309.480366917447;2313.6298192289155;2314.155333303332;8486.787830304293;8531.95734021326;8534.530600816952;8596.054434012254;8600.526971016592;5200;5272.209168624699;5280.049591073605;5284.207368894658;5290.470952904717;3373.224158443572;3409.3010932758725;3411.993461928737;3432.8111953842526;3493.2314890724;1120.0927248928313;1138.1975707126455;1149.2242736153064;1152.8616566012133;1159.1858741070198;11434.656960291204;11464.770704585862;11508.36703981289;11593.362365069917;11601.361925094116;4446.555344465528;4554.20301447252;4651.325557794101;4654.883627909329;4654.906901862011;9199.126083022102;9217;9229.53852307382;9233.953830230941;9244.676436324697;5223.686578805284;5238.188080847474;5240.161574148118;5244.737763111905;5262.973685131627;4038.495188101487;4216.177845320133;4287.8499252526635;4791.041791641685;4904.828331008398;3790.6967442604528;3811.0853395184954;3830.138218900781;3853.903652408656;3998.1803730235233;1152.7809716153904;1158.588701011129;1163;1165.2425923149851;1172.302480024384;949.1647350331802;978.2907392140642;982.6953644370268;986.0927946289431;1008.1934452438167;5805.680687562224;5887.8233652990475;5921.970390148022;5979.937310323888;6062.878742425127;481.8795301174706;483.07009007660116;487.81219230595764;491.22631854828074;498.8303976647957;3992.7404718693774;4015.7188996769946;4030.8387664493093;4086.4483294755423;4134.91730165395;10225.59097636101;10457.790844183226;10560.894391056145;10568.313059651098;10615.89384106149;10432.895671043192;10438.425886576311;10447.529861156267;10453.477326133663;10456.947715261374;7834.294913457816;7870.881936770838;7908.367330613537;8014.398920080901;8117.4723642961835;5905.143754155709;6158.3225845157895;6176.474999625082;6193.783217587543;6288.182536270256;9295.209907157967;9697.321187516805;9760.56077476501;9799.608015679292;9840.458774767456;9629.277804164856;9847.655332063343;9889.406635601887;9916.504174791087;9937.950310248403;7418.740344087931;7475.439342049477;7510.924890751241;7531;7541.5475071495885;7759.573223472537;7806.72676456344;7834.529928204326;7953.9602301990435;8334.708285209988;7368.410527157922;7435.293647103516;7465.888011679721;7522.5862577558755;7563;7442.404607631268;7473.663685134291;7647.617619118911;7698.692052318069;7704.229577042251;7042.119735033121;7074.575525468488;7167.892481612885;7174.031505746866;7184.9640751798;5368.194770784414;5394.703291319015;5449.972750136224;5473.233747275305;5543.833684989457;4855.393075865517;4945.876353091202;5072.492750724898;5076;5141.074606570854 08:33:07 INFO - PROCESS | 7550 | |4;prototype.html;328.3236532742552;329.82354440374405;342.0354600027921;343.6014223500739;345.5732170769101;5124.846254612367;5192.844214673566;5288.8413347599635;5346.304980352554;5360.919586206205;5044.520770526803;5181.248718935762;5182.689038657683;5198.584113270938;5203.609729270301;4121.629053385194;4125.298699221132;4129.545749967501;4132.318167502373;4191.350340697181;3947.230290093433;3954.1498577805764;4161.334186530155;4192.4759405074365;4194;4122.732022418548;4129.112240868213;4146.502419709639;4150.771707556083;4150.896227594304;4127.401526778615;4150.190712811003;4159.896002599929;4162.4598898407785;4166.791660416967;3463;3698.2973235085246;3700.3524383232825;3708.4993525873933;3713.1459764254105;5102.158143906251;5108.131617624976;5119.744012799382;5126.256692779563;5136.614753893473;4668.603168730662;4679.415073115861;4693.577578017961;4700.811967521295;4711.835085772016;5327.174287985368;5395.892082158335;5433.673979561199;5453.754581043862;5464.644798088111;3824.7131465139946;3865.1496670732395;3885.708571857094;3887.9222415551812;3889.1638297766117;5651.4348565143155;5658.886822263532;5670.68811215383;5702.54379649627;5716.514096301861;4106.958930410718;4109.582194143016;4111.301078816548;4113.424120623115;4128.958710412858;3971.920561588752;4148.211839750437;4152;4166.812493437803;4171.687123465752;4708.246680531099;4720.976395118002;4739.549742774431;4740.360051393087;4761.452432970253;5532.97639936613;5552.41699621542;5553.555715542828;5577.549837042398;5585.329760428694;1287;1289.9419526121346;1418.7446259673359;1422.3030714949807;1422.7439060969125;902.0393281155548;906.5059542549326;920.6455514626917;924.916757491829;933.2627224492575;4695.5069717679835;4734.130018642617;4735.958089220366;4749.881252968635;4782.33047373368;4935.851924442272;4987.326710894055;5007.674501157413;5008;5008.873003574166;4489.95706953342;4694.450831225688;4714.976425117852;4770.379850619397;4791.616670666338;2656.787457003435;2668.6130511075785;2693.7710294625176;2701.540738074532;2708.106324912774;5179.585633149339;5228.581713462914;5230.738463076831;5276.894462110737;5279.894402112013;4778.682339065551;5059.392872855281;5090.287359769635;5090.592752579785;5123.846284611468;5131.974340128276;5187.714675692798;5188.662736922163;5191.039657663345;5252.632315737862;5048.72232027242;5058.9494105058475;5079.339685840817;5086.821961231339;5091.0581542414775;4678.953210467852;4934.284528743384;4953.662511122049;4987.107477662874;5048.242763585492;5084.9745751272485;5130.486951304989;5158.303629010035;5197.7661005254095;5207.27098206259;3754.94367584481;3769.8869033929027;3776.3580191368083;3777.962220377871;3797.981010095042;4775.355327030807;4981.526754958273;5005.374328208974;5111.693298402108;5410.3507579090765;5373.596980226421;5494.791145947885;5541.556675466034;5543.417941116125;5561.860953476195;5561.777528898799;5588.217649529151;5594.216809646571;5596.804111856066;5628;5309.761060752198;5553.750081246434;5557.083081291542;5590.608657394106;5592.440755924375;5528.170774383874;5532.640378375393;5559.749811258584;5560.026995275892;5584.692841893735;5501.4223506532835;5502.889942201054;5517.44825517445;5521.723913804374;5540.833774986757 08:33:07 INFO - PROCESS | 7550 | |5;yui.html;791.2601717394236;794.9903622399556;808.870580707087;821.8397412504562;853.778017715394;14746.63133421665;15782.842171578295;15915.84084159158;15936.84063159368;15947.441839535619;14971.101733895974;15215.6956860863;15875.60310992223;15905.920470397632;16568;816.5835423933792;823.4894365493402;835.9791005224888;836.2640876029086;836.6778790165799;678.6403206300644;805.1867613710166;824.6536454689015;833.8332333533288;834.5118105908051;866.4801119328415;870.8214815962745;871.9782005449852;874.2263097159029;874.4097734029536;705.0341032785117;867.7483529776357;869.2437579306013;869.4870026684255;870.1298701298701;604.4408921747366;612.718149651161;617.475146125794;619.7335145887266;620.7858288890326;13982.951278654142;14030.929845350707;14035.578932632037;14185.361658725382;14186.71626567463;13723.656908577266;14073.64815879601;14127.78808317876;14181.14913105217;14276.357563909649;12534.68663283416;12613.810792838114;13479.326033698373;13502.797458038138;13835.239061851595;3992.121733218716;4002.0995276062945;4006.0585762345827;4029.214303210875;4062.0657248832936;84039.57980210122;89256.55371723165;89853.55073224657;90167.09832901653;92648.53675731645;11824.822627660593;11827.940860295816;11843.526258949545;11959;12122.939385303018;21205.893970530356;21233.469163271042;21295.89352053261;21296.29629629626;21334.253301134388;8344.874826877602;8588.613512391958;8674.436161649473;8810;8837.60230789616;4627;4656.371389862393;4685.789139488663;4693.577578017995;4734.715917044989;3728;3841.7310788244554;3863.478430411915;3878.3406820840523;3919.2749341371937;712.0280816685291;714.0645754062195;722.9927700723031;724.5006618034879;733.7358550921664;617.2500411999442;645.4965127200791;713.3365969648277;731.4404480572366;739.8594267089236;10567.63013294531;10633.574657013787;10634.361938283728;10828.675139745821;11150.442477876073;638.9776357827546;649.5940037476577;666.1306994372294;736.9668364923591;761.0980987529795;4846.29728689338;5170.560502357342;5210.791568337224;5236.0575096482235;5354.170103633943;121624.39187804004;130546;130562;133934.97292621856;134181;113793;114345.4282728581;115775;116209;117280;77830.6108469454;78599.99999999885;100714.4964275174;101567;102548;10395.948020260153;10609.522571484456;10677.412742299248;10703.304285221435;11071.83392249133;35526;37476.62523374731;37652.43521347237;47833.52166478291;51982.480175197765;47306.29040564325;66232.00651990128;73998.63000684962;77790;79777;12982.285974271128;13097.345132743516;13230.536931207747;13777.793333100211;14071.085379450304;15523;15947.362105516113;16276;16325.67348653044;17030.914845425694;14577.416903324172;14611.561653150422;14985.325660345528;15116.848831511545;15477.458288959833;14370.353334099782;14500.492482763053;14597.649253546433;14824.184669843262;15295.464658736892;13747.656308591964;13879.444822206999;14494.782578261545;14805.333759980611;14817.40730370773;11901.226420282654;11913.463894124958;12232.143749937419;12379.504819807107;12640.178388404724;11687.649370518899;11701.12106845808;11818.290902545874;12074.154809163274;12375.319357435428 08:33:07 INFO - PROCESS | 7550 | __end_tp_report 08:33:07 INFO - PROCESS | 7550 | __start_cc_report 08:33:07 INFO - PROCESS | 7550 | _x_x_mozilla_cycle_collect,943 08:33:07 INFO - PROCESS | 7550 | __end_cc_report 08:33:07 INFO - PROCESS | 7550 | __startTimestamp1468942387427__endTimestamp 08:33:07 INFO - PROCESS | 7550 | 08:33:07 INFO - PROCESS | 7550 | ------- Summary: start ------- 08:33:07 INFO - PROCESS | 7550 | Number of tests: 6 08:33:07 INFO - PROCESS | 7550 | 08:33:07 INFO - PROCESS | 7550 | [#0] dojo.html Cycles:165 Average:5371.73 Median:5608.61 stddev:625.06 (11.1%) stddev-sans-first:597.87 08:33:07 INFO - PROCESS | 7550 | Values: 2968.6 3011.9 3026.5 3072.2 3105.3 5233.5 5343.3 5386.2 5468.9 5508.6 5406.2 5420.2 5425.5 5427.5 5491.8 4831.3 4875.1 4903.2 4915.7 5038.2 4951.8 4973.3 4986.7 5015.1 5023.1 4805.6 4820.0 4858.8 4873.3 4889.7 4847.3 4872.9 4875.9 4918.0 4960.3 4875.3 4896.1 4898.2 4899.9 4902.8 5242.4 5359.7 5428.8 5453.5 5456.1 5767.9 5782.6 5813.9 5816.3 5817.8 5666.5 5830.1 5866.5 5897.9 5900.7 5311.8 5402.1 5402.5 5407.7 5410.9 5873.3 5896.3 5896.4 5905.6 5909.1 5553.8 5560.1 5574.3 5591.3 5621.8 5707.7 5711.0 5748.9 5754.2 5774.8 5621.2 5688.0 5696.9 5720.4 5751.5 5734.5 5766.4 5779.2 5789.1 5798.5 4399.2 4425.1 4429.2 4430.2 4472.2 3891.3 3891.4 3914.5 3922.7 3947.7 5434.4 5440.9 5464.8 5470.8 5516.9 5762.7 5764.2 5769.8 5773.2 5814.8 5388.3 5431.5 5464.0 5470.5 5470.7 4998.6 5013.0 5014.6 5018.3 5057.1 5990.4 5997.9 6002.4 6018.4 6054.6 5666.6 5784.1 5790.9 5797.3 5801.3 5994.3 6004.9 6005.1 6010.3 6012.5 5729.2 5731.1 5736.4 5738.9 5744.4 5715.1 5799.4 5805.7 5852.9 5882.6 5743.0 5744.6 5746.0 5749.2 5752.9 5552.8 5674.8 5710.5 5720.0 5733.1 5627.1 5635.9 5680.3 5694.0 5703.3 5705.7 5722.9 5730.9 5732.5 5776.5 5448.0 5503.2 5608.6 5621.4 5625.9 08:33:07 INFO - PROCESS | 7550 | 08:33:07 INFO - PROCESS | 7550 | [#1] ext.html Cycles:180 Average:59524.10 Median:43563.67 stddev:113530.95 (260.6%) stddev-sans-first:113763.21 08:33:07 INFO - PROCESS | 7550 | Values: 591.8 603.4 625.1 626.3 638.5 44229.3 45024.9 45032.5 45130.8 48694.5 47008.5 47604.0 47622.5 47644.8 47661.8 9055.3 9199.7 9201.0 9201.1 9207.2 9069.9 9184.6 9196.1 9212.4 9213.4 9233.4 9267.5 9268.0 9270.1 9273.4 9121.2 9155.2 9160.3 9190.6 9202.8 9079.0 9114.5 9154.2 9155.3 9168.5 44870.8 45145.3 45330.3 45333.0 45343.3 3614.5 4205.6 4224.7 4227.7 4363.5 33993.3 34012.5 34406.5 34436.5 34887.8 4392.3 4423.2 4441.4 4461.5 4522.4 343657.0 345162.0 345551.0 345721.0 345755.0 60410.0 60512.4 60601.0 60738.1 61089.0 55876.7 61794.0 63148.7 63260.4 69338.3 17515.5 17603.5 17664.2 17665.5 17674.8 10863.9 13421.1 13480.1 13517.2 13523.3 17184.0 17642.6 17674.6 17943.8 18362.1 5939.4 5943.4 5972.6 5994.0 6041.2 914.0 984.9 1037.4 1131.4 1179.9 32868.3 33669.3 34905.8 36944.1 37876.6 1103.5 1126.6 1166.0 1190.7 1227.3 17487.6 17711.9 17766.3 17933.4 17981.8 533182.0 539520.0 541385.0 541748.0 541904.0 59375.1 59439.7 59551.4 59566.1 59604.7 1247.1 1375.4 1410.7 1414.4 1418.4 33484.3 34380.8 34769.8 34902.3 34926.3 51376.7 51767.7 51987.2 52140.2 52153.2 376261.0 376897.0 376966.0 377049.0 378429.0 24779.9 29188.3 29503.1 29539.3 29789.6 48694.3 49731.3 50265.9 50496.7 50867.5 41690.6 42247.4 42319.4 42923.6 43091.1 41909.4 42514.4 42873.4 42978.8 43551.3 41344.6 42110.2 43343.6 43480.8 43576.0 36660.1 37149.0 37415.8 38008.6 38077.8 28660.0 28690.3 29037.7 29334.7 29482.7 08:33:07 INFO - PROCESS | 7550 | 08:33:07 INFO - PROCESS | 7550 | [#2] jquery.html Cycles:180 Average:28566.80 Median:2367.76 stddev:80008.48 (3379.1%) stddev-sans-first:80204.95 08:33:07 INFO - PROCESS | 7550 | Values: 388.7 389.4 400.6 404.8 413.8 18163.0 19534.0 20191.0 20229.4 20697.7 19216.2 19300.5 20262.1 20303.5 20313.0 5683.4 5857.6 5914.5 5938.9 6041.1 5745.3 5761.6 5848.7 5977.7 5981.0 5942.9 5950.3 5963.9 5978.8 5987.9 5840.2 6195.5 6227.8 6242.6 6246.5 4960.1 5867.2 5937.7 5957.3 5966.1 13478.7 13744.8 14173.9 14224.4 14255.4 2305.8 2328.1 2352.7 2362.6 2373.0 9871.2 10198.5 10249.0 10265.9 10403.0 1885.4 1898.6 1901.4 1954.7 1954.8 76806.0 83599.0 84121.6 84374.2 84688.0 10301.0 10369.2 10759.8 10843.1 11054.9 14708.3 14755.2 14792.9 14795.2 14807.4 7740.8 7815.8 7875.8 7981.0 7981.6 7282.4 7388.9 7396.7 7449.8 7722.8 4341.9 4367.3 4391.5 4468.5 4604.5 1896.4 1988.6 2013.5 2026.4 2033.0 899.2 963.6 977.8 985.2 1033.1 19838.7 20246.0 20337.3 20337.7 20460.8 980.0 1001.8 1009.5 1021.4 1025.8 9338.8 11160.6 11183.9 11221.9 11382.7 470462.0 480003.0 489838.0 490920.0 497678.0 82270.0 83847.2 84724.0 85479.0 85543.6 996.5 996.5 1012.9 1014.6 1016.8 17444.8 17595.3 18077.9 18138.5 18331.1 39814.4 39939.0 40518.8 40733.0 41171.6 56289.7 57514.0 57917.7 58000.0 59003.4 8782.9 8789.9 8867.5 8979.3 8988.2 13113.7 13520.1 13575.3 13697.3 13732.5 11131.6 11376.3 11459.3 11927.2 12184.3 11393.6 11551.7 11717.4 11877.5 12002.8 11914.1 12063.3 12066.0 12245.8 12268.4 8688.3 8844.3 8871.3 8923.4 11832.4 12446.6 12455.0 12747.9 12897.3 13448.3 08:33:07 INFO - PROCESS | 7550 | 08:33:07 INFO - PROCESS | 7550 | [#3] mootools.html Cycles:180 Average:5630.82 Median:5170.54 stddev:3130.49 (60.5%) stddev-sans-first:3122.73 08:33:07 INFO - PROCESS | 7550 | Values: 1348.3 1439.9 1497.6 1594.6 1745.5 8225.8 8464.6 8472.4 8638.9 8656.6 8345.2 8514.8 8534.4 8541.1 8553.8 2355.7 2385.7 2388.8 2390.4 2391.6 2327.5 2346.0 2349.7 2360.8 2379.3 2330.8 2334.2 2358.4 2361.6 2365.5 2262.1 2276.2 2284.1 2289.8 2315.3 2269.9 2305.8 2309.5 2313.6 2314.2 8486.8 8532.0 8534.5 8596.1 8600.5 5200.0 5272.2 5280.0 5284.2 5290.5 3373.2 3409.3 3412.0 3432.8 3493.2 1120.1 1138.2 1149.2 1152.9 1159.2 11434.7 11464.8 11508.4 11593.4 11601.4 4446.6 4554.2 4651.3 4654.9 4654.9 9199.1 9217.0 9229.5 9234.0 9244.7 5223.7 5238.2 5240.2 5244.7 5263.0 4038.5 4216.2 4287.8 4791.0 4904.8 3790.7 3811.1 3830.1 3853.9 3998.2 1152.8 1158.6 1163.0 1165.2 1172.3 949.2 978.3 982.7 986.1 1008.2 5805.7 5887.8 5922.0 5979.9 6062.9 481.9 483.1 487.8 491.2 498.8 3992.7 4015.7 4030.8 4086.4 4134.9 10225.6 10457.8 10560.9 10568.3 10615.9 10432.9 10438.4 10447.5 10453.5 10456.9 7834.3 7870.9 7908.4 8014.4 8117.5 5905.1 6158.3 6176.5 6193.8 6288.2 9295.2 9697.3 9760.6 9799.6 9840.5 9629.3 9847.7 9889.4 9916.5 9938.0 7418.7 7475.4 7510.9 7531.0 7541.5 7759.6 7806.7 7834.5 7954.0 8334.7 7368.4 7435.3 7465.9 7522.6 7563.0 7442.4 7473.7 7647.6 7698.7 7704.2 7042.1 7074.6 7167.9 7174.0 7185.0 5368.2 5394.7 5450.0 5473.2 5543.8 4855.4 4945.9 5072.5 5076.0 5141.1 08:33:07 INFO - PROCESS | 7550 | 08:33:07 INFO - PROCESS | 7550 | [#4] prototype.html Cycles:180 Average:4465.78 Median:5007.84 stddev:1283.39 (25.6%) stddev-sans-first:1248.85 08:33:07 INFO - PROCESS | 7550 | Values: 328.3 329.8 342.0 343.6 345.6 5124.8 5192.8 5288.8 5346.3 5360.9 5044.5 5181.2 5182.7 5198.6 5203.6 4121.6 4125.3 4129.5 4132.3 4191.4 3947.2 3954.1 4161.3 4192.5 4194.0 4122.7 4129.1 4146.5 4150.8 4150.9 4127.4 4150.2 4159.9 4162.5 4166.8 3463.0 3698.3 3700.4 3708.5 3713.1 5102.2 5108.1 5119.7 5126.3 5136.6 4668.6 4679.4 4693.6 4700.8 4711.8 5327.2 5395.9 5433.7 5453.8 5464.6 3824.7 3865.1 3885.7 3887.9 3889.2 5651.4 5658.9 5670.7 5702.5 5716.5 4107.0 4109.6 4111.3 4113.4 4129.0 3971.9 4148.2 4152.0 4166.8 4171.7 4708.2 4721.0 4739.5 4740.4 4761.5 5533.0 5552.4 5553.6 5577.5 5585.3 1287.0 1289.9 1418.7 1422.3 1422.7 902.0 906.5 920.6 924.9 933.3 4695.5 4734.1 4736.0 4749.9 4782.3 4935.9 4987.3 5007.7 5008.0 5008.9 4490.0 4694.5 4715.0 4770.4 4791.6 2656.8 2668.6 2693.8 2701.5 2708.1 5179.6 5228.6 5230.7 5276.9 5279.9 4778.7 5059.4 5090.3 5090.6 5123.8 5132.0 5187.7 5188.7 5191.0 5252.6 5048.7 5058.9 5079.3 5086.8 5091.1 4679.0 4934.3 4953.7 4987.1 5048.2 5085.0 5130.5 5158.3 5197.8 5207.3 3754.9 3769.9 3776.4 3778.0 3798.0 4775.4 4981.5 5005.4 5111.7 5410.4 5373.6 5494.8 5541.6 5543.4 5561.9 5561.8 5588.2 5594.2 5596.8 5628.0 5309.8 5553.8 5557.1 5590.6 5592.4 5528.2 5532.6 5559.7 5560.0 5584.7 5501.4 5502.9 5517.4 5521.7 5540.8 08:33:07 INFO - PROCESS | 7550 | 08:33:07 INFO - PROCESS | 7550 | [#5] yui.html Cycles:180 Average:22128.35 Median:21296.09 stddev:33186.54 (155.8%) stddev-sans-first:33240.96 08:33:07 INFO - PROCESS | 7550 | Values: 791.3 795.0 808.9 821.8 853.8 14746.6 15782.8 15915.8 15936.8 15947.4 14971.1 15215.7 15875.6 15905.9 16568.0 816.6 823.5 836.0 836.3 836.7 678.6 805.2 824.7 833.8 834.5 866.5 870.8 872.0 874.2 874.4 705.0 867.7 869.2 869.5 870.1 604.4 612.7 617.5 619.7 620.8 13983.0 14030.9 14035.6 14185.4 14186.7 13723.7 14073.6 14127.8 14181.1 14276.4 12534.7 12613.8 13479.3 13502.8 13835.2 3992.1 4002.1 4006.1 4029.2 4062.1 84039.6 89256.6 89853.6 90167.1 92648.5 11824.8 11827.9 11843.5 11959.0 12122.9 21205.9 21233.5 21295.9 21296.3 21334.3 8344.9 8588.6 8674.4 8810.0 8837.6 4627.0 4656.4 4685.8 4693.6 4734.7 3728.0 3841.7 3863.5 3878.3 3919.3 712.0 714.1 723.0 724.5 733.7 617.3 645.5 713.3 731.4 739.9 10567.6 10633.6 10634.4 10828.7 11150.4 639.0 649.6 666.1 737.0 761.1 4846.3 5170.6 5210.8 5236.1 5354.2 121624.4 130546.0 130562.0 133935.0 134181.0 113793.0 114345.4 115775.0 116209.0 117280.0 77830.6 78600.0 100714.5 101567.0 102548.0 10395.9 10609.5 10677.4 10703.3 11071.8 35526.0 37476.6 37652.4 47833.5 51982.5 47306.3 66232.0 73998.6 77790.0 79777.0 12982.3 13097.3 13230.5 13777.8 14071.1 15523.0 15947.4 16276.0 16325.7 17030.9 14577.4 14611.6 14985.3 15116.8 15477.5 14370.4 14500.5 14597.6 14824.2 15295.5 13747.7 13879.4 14494.8 14805.3 14817.4 11901.2 11913.5 12232.1 12379.5 12640.2 11687.6 11701.1 11818.3 12074.2 12375.3 08:33:07 INFO - PROCESS | 7550 | -------- Summary: end -------- 08:33:07 INFO - PROCESS | 7550 | 08:33:08 INFO - TEST-INFO | 7550: exit 0 08:33:08 INFO - TEST-OK | dromaeo_css | took 1114016ms 08:33:08 INFO - TEST-START | kraken 08:33:08 INFO - operating with platform_type : linux_ 08:33:08 INFO - Initialising browser for kraken test... 08:33:08 INFO - TEST-INFO | started process 7752 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH4r5yj/profile http://localhost:57545/getInfo.html) 08:33:12 INFO - PROCESS | 7752 | __metrics Screen width/height:1600/1200 08:33:12 INFO - PROCESS | 7752 | colorDepth:24 08:33:12 INFO - PROCESS | 7752 | Browser inner width/height: 1024/697 08:33:12 INFO - PROCESS | 7752 | __metrics 08:33:13 INFO - PROCESS | 7752 | 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" 08:33:13 INFO - PROCESS | 7752 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:33:14 INFO - TEST-INFO | 7752: exit 0 08:33:14 INFO - Browser initialized. 08:33:14 INFO - Running cycle 1/1 for kraken test... 08:33:14 INFO - TEST-INFO | started process 7833 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH4r5yj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:33:26 INFO - PROCESS | 7833 | RSS: Main: 158228480 08:33:26 INFO - PROCESS | 7833 | 08:33:28 INFO - PROCESS | 7833 | Cycle 1(1): loaded http://localhost:57545/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57545/tests/kraken/driver.html?testName=audio-beat-detection) 08:33:29 INFO - PROCESS | 7833 | RSS: Main: 217120768 08:33:29 INFO - PROCESS | 7833 | 08:33:32 INFO - PROCESS | 7833 | Cycle 1(1): loaded http://localhost:57545/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57545/tests/kraken/driver.html?testName=audio-dft) 08:33:32 INFO - PROCESS | 7833 | RSS: Main: 205942784 08:33:32 INFO - PROCESS | 7833 | 08:33:36 INFO - PROCESS | 7833 | Cycle 1(1): loaded http://localhost:57545/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57545/tests/kraken/driver.html?testName=audio-fft) 08:33:36 INFO - PROCESS | 7833 | RSS: Main: 269578240 08:33:36 INFO - PROCESS | 7833 | 08:33:38 INFO - PROCESS | 7833 | Cycle 1(1): loaded http://localhost:57545/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57545/tests/kraken/driver.html?testName=audio-oscillator) 08:33:39 INFO - PROCESS | 7833 | RSS: Main: 180801536 08:33:39 INFO - PROCESS | 7833 | 08:33:41 INFO - PROCESS | 7833 | Cycle 1(1): loaded http://localhost:57545/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57545/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:33:42 INFO - PROCESS | 7833 | RSS: Main: 184766464 08:33:42 INFO - PROCESS | 7833 | 08:33:45 INFO - PROCESS | 7833 | Cycle 1(1): loaded http://localhost:57545/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57545/tests/kraken/driver.html?testName=imaging-darkroom) 08:33:45 INFO - PROCESS | 7833 | RSS: Main: 219148288 08:33:45 INFO - PROCESS | 7833 | 08:33:49 INFO - PROCESS | 7833 | Cycle 1(1): loaded http://localhost:57545/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57545/tests/kraken/driver.html?testName=imaging-desaturate) 08:33:49 INFO - PROCESS | 7833 | RSS: Main: 221216768 08:33:49 INFO - PROCESS | 7833 | 08:33:52 INFO - PROCESS | 7833 | Cycle 1(1): loaded http://localhost:57545/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57545/tests/kraken/driver.html?testName=json-parse-financial) 08:33:53 INFO - PROCESS | 7833 | RSS: Main: 221462528 08:33:53 INFO - PROCESS | 7833 | 08:33:54 INFO - PROCESS | 7833 | Cycle 1(1): loaded http://localhost:57545/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57545/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:33:55 INFO - PROCESS | 7833 | RSS: Main: 210014208 08:33:55 INFO - PROCESS | 7833 | 08:33:56 INFO - PROCESS | 7833 | Cycle 1(1): loaded http://localhost:57545/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57545/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:33:57 INFO - PROCESS | 7833 | RSS: Main: 214020096 08:33:57 INFO - PROCESS | 7833 | 08:33:59 INFO - PROCESS | 7833 | Cycle 1(1): loaded http://localhost:57545/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57545/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:34:00 INFO - PROCESS | 7833 | RSS: Main: 212152320 08:34:00 INFO - PROCESS | 7833 | 08:34:02 INFO - PROCESS | 7833 | Cycle 1(1): loaded http://localhost:57545/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57545/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:34:03 INFO - PROCESS | 7833 | RSS: Main: 224460800 08:34:03 INFO - PROCESS | 7833 | 08:34:05 INFO - PROCESS | 7833 | Cycle 1(1): loaded http://localhost:57545/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57545/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:34:06 INFO - PROCESS | 7833 | RSS: Main: 225431552 08:34:06 INFO - PROCESS | 7833 | 08:34:08 INFO - PROCESS | 7833 | Cycle 1(1): loaded http://localhost:57545/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57545/tests/kraken/driver.html?testName=ai-astar) 08:34:08 INFO - PROCESS | 7833 | RSS: Main: 268304384 08:34:08 INFO - PROCESS | 7833 | 08:34:08 INFO - PROCESS | 7833 | __start_tp_report 08:34:08 INFO - PROCESS | 7833 | _x_x_mozilla_page_load 08:34:08 INFO - PROCESS | 7833 | _x_x_mozilla_page_load_details 08:34:08 INFO - PROCESS | 7833 | |i|pagename|runs| 08:34:08 INFO - PROCESS | 7833 | |0;ai-astar;100;111;111;109;111;110;109;114;111;111 08:34:08 INFO - PROCESS | 7833 | |1;audio-beat-detection;147;118;120;175;115;121;142;116;167;119 08:34:08 INFO - PROCESS | 7833 | |2;audio-dft;160;160;161;160;161;159;160;161;163;161 08:34:08 INFO - PROCESS | 7833 | |3;audio-fft;74;74;74;109;74;74;73;73;99;74 08:34:08 INFO - PROCESS | 7833 | |4;audio-oscillator;83;85;110;83;83;84;113;84;84;133 08:34:08 INFO - PROCESS | 7833 | |5;imaging-gaussian-blur;117;116;117;117;117;116;118;117;117;117 08:34:08 INFO - PROCESS | 7833 | |6;imaging-darkroom;145;147;145;145;146;148;146;145;146;145 08:34:08 INFO - PROCESS | 7833 | |7;imaging-desaturate;94;94;95;95;95;94;94;95;94;95 08:34:08 INFO - PROCESS | 7833 | |8;json-parse-financial;53;49;50;51;50;50;51;50;51;51 08:34:08 INFO - PROCESS | 7833 | |9;json-stringify-tinderbox;62;63;63;62;64;63;63;63;63;64 08:34:08 INFO - PROCESS | 7833 | |10;stanford-crypto-aes;75;75;74;76;84;78;80;81;74;79 08:34:08 INFO - PROCESS | 7833 | |11;stanford-crypto-ccm;122;133;129;121;115;137;137;130;194;127 08:34:08 INFO - PROCESS | 7833 | |12;stanford-crypto-pbkdf2;154;156;156;154;152;158;153;153;154;152 08:34:08 INFO - PROCESS | 7833 | |13;stanford-crypto-sha256-iterative;62;61;62;62;61;61;61;62;62;61 08:34:08 INFO - PROCESS | 7833 | __end_tp_report 08:34:08 INFO - PROCESS | 7833 | __start_cc_report 08:34:08 INFO - PROCESS | 7833 | _x_x_mozilla_cycle_collect,1642 08:34:08 INFO - PROCESS | 7833 | __end_cc_report 08:34:08 INFO - PROCESS | 7833 | __startTimestamp1468942448451__endTimestamp 08:34:08 INFO - PROCESS | 7833 | 08:34:08 INFO - PROCESS | 7833 | ------- Summary: start ------- 08:34:08 INFO - PROCESS | 7833 | Number of tests: 14 08:34:08 INFO - PROCESS | 7833 | 08:34:08 INFO - PROCESS | 7833 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:3.68 (3.3%) stddev-sans-first:1.48 08:34:08 INFO - PROCESS | 7833 | Values: 100.0 111.0 111.0 109.0 111.0 110.0 109.0 114.0 111.0 111.0 08:34:08 INFO - PROCESS | 7833 | 08:34:08 INFO - PROCESS | 7833 | [#1] audio-beat-detection Cycles:10 Average:134.00 Median:131.50 stddev:22.44 (17.1%) stddev-sans-first:23.31 08:34:08 INFO - PROCESS | 7833 | Values: 147.0 118.0 120.0 175.0 115.0 121.0 142.0 116.0 167.0 119.0 08:34:08 INFO - PROCESS | 7833 | 08:34:08 INFO - PROCESS | 7833 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.07 (0.7%) stddev-sans-first:1.12 08:34:08 INFO - PROCESS | 7833 | Values: 160.0 160.0 161.0 160.0 161.0 159.0 160.0 161.0 163.0 161.0 08:34:08 INFO - PROCESS | 7833 | 08:34:08 INFO - PROCESS | 7833 | [#3] audio-fft Cycles:10 Average:79.80 Median:74.00 stddev:12.98 (17.5%) stddev-sans-first:13.59 08:34:08 INFO - PROCESS | 7833 | Values: 74.0 74.0 74.0 109.0 74.0 74.0 73.0 73.0 99.0 74.0 08:34:08 INFO - PROCESS | 7833 | 08:34:08 INFO - PROCESS | 7833 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:83.50 stddev:17.89 (21.4%) stddev-sans-first:18.51 08:34:08 INFO - PROCESS | 7833 | Values: 83.0 85.0 110.0 83.0 83.0 84.0 113.0 84.0 84.0 133.0 08:34:08 INFO - PROCESS | 7833 | 08:34:08 INFO - PROCESS | 7833 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 08:34:08 INFO - PROCESS | 7833 | Values: 117.0 116.0 117.0 117.0 117.0 116.0 118.0 117.0 117.0 117.0 08:34:08 INFO - PROCESS | 7833 | 08:34:08 INFO - PROCESS | 7833 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:1.03 (0.7%) stddev-sans-first:1.05 08:34:08 INFO - PROCESS | 7833 | Values: 145.0 147.0 145.0 145.0 146.0 148.0 146.0 145.0 146.0 145.0 08:34:08 INFO - PROCESS | 7833 | 08:34:08 INFO - PROCESS | 7833 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 08:34:08 INFO - PROCESS | 7833 | Values: 94.0 94.0 95.0 95.0 95.0 94.0 94.0 95.0 94.0 95.0 08:34:08 INFO - PROCESS | 7833 | 08:34:08 INFO - PROCESS | 7833 | [#8] json-parse-financial Cycles:10 Average:50.60 Median:51.00 stddev:1.07 (2.1%) stddev-sans-first:0.71 08:34:08 INFO - PROCESS | 7833 | Values: 53.0 49.0 50.0 51.0 50.0 50.0 51.0 50.0 51.0 51.0 08:34:08 INFO - PROCESS | 7833 | 08:34:08 INFO - PROCESS | 7833 | [#9] json-stringify-tinderbox Cycles:10 Average:63.00 Median:63.00 stddev:0.67 (1.1%) stddev-sans-first:0.60 08:34:08 INFO - PROCESS | 7833 | Values: 62.0 63.0 63.0 62.0 64.0 63.0 63.0 63.0 63.0 64.0 08:34:08 INFO - PROCESS | 7833 | 08:34:08 INFO - PROCESS | 7833 | [#10] stanford-crypto-aes Cycles:10 Average:77.60 Median:78.50 stddev:3.37 (4.3%) stddev-sans-first:3.44 08:34:08 INFO - PROCESS | 7833 | Values: 75.0 75.0 74.0 76.0 84.0 78.0 80.0 81.0 74.0 79.0 08:34:08 INFO - PROCESS | 7833 | 08:34:08 INFO - PROCESS | 7833 | [#11] stanford-crypto-ccm Cycles:10 Average:134.50 Median:131.50 stddev:22.06 (16.8%) stddev-sans-first:22.93 08:34:08 INFO - PROCESS | 7833 | Values: 122.0 133.0 129.0 121.0 115.0 137.0 137.0 130.0 194.0 127.0 08:34:08 INFO - PROCESS | 7833 | 08:34:08 INFO - PROCESS | 7833 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.20 Median:154.00 stddev:1.93 (1.3%) stddev-sans-first:2.05 08:34:08 INFO - PROCESS | 7833 | Values: 154.0 156.0 156.0 154.0 152.0 158.0 153.0 153.0 154.0 152.0 08:34:08 INFO - PROCESS | 7833 | 08:34:08 INFO - PROCESS | 7833 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.50 Median:62.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 08:34:08 INFO - PROCESS | 7833 | Values: 62.0 61.0 62.0 62.0 61.0 61.0 61.0 62.0 62.0 61.0 08:34:08 INFO - PROCESS | 7833 | -------- Summary: end -------- 08:34:08 INFO - PROCESS | 7833 | 08:34:09 INFO - TEST-INFO | 7833: exit 0 08:34:09 INFO - TEST-OK | kraken | took 61222ms 08:34:09 INFO - SUITE-END | took 1175s 08:34:09 INFO - Completed test suite (00:19:35) 08:34:09 INFO - javascript benchmark 08:34:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2968.5547167924824, 3011.9397612047774, 3026.485497465431, 3072.201227680803, 3105.3168302973345, 5233.528982391584, 5343.332083489564, 5386.245925570418, 5468.890622187554, 5508.559315254775, 5406.189071639246, 5420.214068959998, 5425.538829199513, 5427.48438898304, 5491.807786727465, 4831.299461578069, 4875.073735990169, 4903.19097348937, 4915.655904086715, 5038.168702164138, 4951.826686065989, 4973.254011898226, 4986.650934434591, 5015.147424937751, 5023.070731914608, 4805.615550755949, 4820.035992801436, 4858.805647774085, 4873.269009648546, 4889.682170658896, 4847.297141914438, 4872.902541949176, 4875.902481950341, 4917.975410122926, 4960.280759289919, 4875.341828853095, 4896.143174944406, 4898.191798353268, 4899.902001959941, 4902.754862256873, 5242.423333433319, 5359.678419294854, 5428.809991650312, 5453.481919217668, 5456.127019676872, 5767.855803604902, 5782.624129431616, 5813.883722325572, 5816.272965879265, 5817.767289308465, 5666.490015898589, 5830.125481177814, 5866.501347385477, 5897.911531327033, 5900.704964751788, 5311.760970756287, 5402.108652072403, 5402.459754024566, 5407.702576358299, 5410.864728381783, 5873.3245676746865, 5896.262967129109, 5896.439838215363, 5905.616134951214, 5909.143174239797, 5553.750081246354, 5560.110382338888, 5574.331080270313, 5591.27313449249, 5621.775128994795, 5707.71461426927, 5711.029125048752, 5748.9425105748405, 5754.223179870748, 5774.82675519735, 5621.241132447149, 5687.971560142173, 5696.943030569724, 5720.370759216483, 5751.511121554631, 5734.4552267535355, 5766.394528574523, 5779.162021506942, 5789.073748200268, 5798.536117110621, 4399.20814253431, 4425.070735145656, 4429.247028005247, 4430.246858034142, 4472.217361961643, 3891.2995660780766, 3891.4357418174204, 3914.530256369254, 3922.7254092213843, 3947.6644485219076, 5434.375046869582, 5440.863978400572, 5464.7814087436855, 5470.753816078286, 5516.9448305517235, 5762.74067666956, 5764.193012978187, 5769.769209231584, 5773.191753154561, 5814.767409303665, 5388.299521062315, 5431.51116399518, 5464.043792336325, 5470.452954704578, 5470.671759694431, 4998.550130488274, 5012.974935125374, 5014.598832093424, 5018.322526458955, 5057.089723849669, 5990.430909063632, 5997.850053748604, 6002.429769171922, 6018.398160183947, 6054.606450580698, 5666.575006874418, 5784.074548072288, 5790.913136302875, 5797.333306669787, 5801.274840644919, 5994.250718660168, 6004.8799024020145, 6005.129256257906, 6010.338862725184, 6012.488938440281, 5729.169270455844, 5731.054376027909, 5736.42635736423, 5738.913916291175, 5744.425557444222, 5715.142728590578, 5799.391063938226, 5805.680687562224, 5852.853678658068, 5882.647041177543, 5743.0, 5744.5978781486565, 5746.0, 5749.195112684144, 5752.884942301214, 5552.833414997556, 5674.801381951612, 5710.486056254957, 5720.02759530889, 5733.082706766897, 5627.099664053731, 5635.915461268166, 5680.346760122638, 5693.971530142323, 5703.258576385043, 5705.7147142643535, 5722.942770572407, 5730.856728581652, 5732.455416735404, 5776.451237132465, 5448.0, 5503.229547863382, 5608.6073974823, 5621.35354434229, 5625.915611265752], "value": 5327.798020968842, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.792872494627, 603.4418163199042, 625.068647714905, 626.3016736338982, 638.5434414393709, 44229.33655995159, 45024.87437814052, 45032.54967450324, 45130.7743461283, 48694.51305486944, 47008.52991470084, 47604.0479190416, 47622.523774762245, 47644.76177619107, 47661.76169119158, 9055.275577953747, 9199.724008279762, 9201.03389144137, 9201.079892010779, 9207.171354578086, 9069.863952040725, 9184.586693598803, 9196.080391960784, 9212.401193922407, 9213.447193168398, 9233.399829011092, 9267.536623168848, 9267.95366023169, 9270.07299270071, 9273.350865439423, 9121.179093881516, 9155.221806146486, 9160.312976526788, 9190.632374705005, 9202.76993075175, 9078.954605226998, 9114.544272786334, 9154.221891139261, 9155.313351498598, 9168.495732734697, 44870.77564612189, 45145.32282015772, 45330.32004519935, 45333.0, 45343.31985020227, 3614.457831325296, 4205.621494065518, 4224.683148763855, 4227.704060715751, 4363.47638283408, 33993.32013359719, 34012.48981265283, 34406.48390274148, 34436.48345274823, 34887.82556087229, 4392.297232442794, 4423.203823311803, 4441.356003379492, 4461.486929003174, 4522.394549934758, 343657.0, 345162.0, 345551.0, 345721.0, 345755.0, 60410.0, 60512.394876051556, 60601.0, 60738.088928666104, 61089.0, 55876.720616396655, 61794.0, 63148.684256578425, 63260.36739632545, 69338.30661693419, 17515.474535763948, 17603.471895843144, 17664.205110769788, 17665.470035898943, 17674.823251767575, 10863.891361086446, 13421.060525763298, 13480.056396052378, 13517.188968661912, 13523.32383380827, 17184.0, 17642.558936026446, 17674.646507070043, 17943.820561794477, 18362.08189590542, 5939.406059394026, 5943.405659434022, 5972.641641501524, 5994.0, 6041.24484439445, 913.977150571241, 984.8670429491926, 1037.387941114746, 1131.4173200801595, 1179.9469023893773, 32868.3426331472, 33669.32661346808, 34905.825470872485, 36944.07639809026, 37876.62123378786, 1103.5254840418536, 1126.6056880092067, 1166.032193279576, 1190.7380376317196, 1227.2943057741657, 17487.562810929576, 17711.911440442716, 17766.289348426177, 17933.37233196832, 17981.820181798277, 533182.0, 539520.0, 541385.0, 541748.0, 541904.0, 59375.10937335943, 59439.70280148571, 59551.40448595458, 59566.10650840241, 59604.70197648984, 1247.108317552954, 1375.4498200719793, 1410.7249086428253, 1414.4412956881974, 1418.418448436157, 33484.33031339311, 34380.82809585936, 34769.826150869085, 34902.30195396027, 34926.30147397089, 51376.74311628418, 51767.741161293954, 51987.2201916964, 52140.21789673082, 52153.217701735266, 376261.0, 376897.0, 376966.0, 377049.0, 378429.0, 24779.87610061938, 29188.27029324199, 29503.082299650454, 29539.261518462212, 29789.553156702234, 48694.26958595553, 49731.254031190285, 50265.90740282248, 50496.747516262185, 50867.491325086274, 41690.58309416988, 42247.366289505066, 42319.36520952127, 42923.57076429196, 43091.138177235654, 41909.371359429024, 42514.36228456514, 42873.35689964591, 42978.78510607427, 43551.34672979971, 41344.586554135276, 42110.157796843276, 43343.56656433395, 43480.782596086814, 43575.98876129159, 36660.0834979117, 37149.0, 37415.81292093522, 38008.61991380051, 38077.80961095288, 28660.0, 28690.282742931595, 29037.709622904345, 29334.706652933197, 29482.705172947997], "value": 20653.033576704955, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.66768912579727, 389.41198789827354, 400.6214127649371, 404.77130421311955, 413.8204138204139, 18163.0, 19534.0, 20191.0, 20229.393118206477, 20697.68953465699, 19216.231350745988, 19300.51748706283, 20262.088206030727, 20303.49241268969, 20313.0, 5683.403242659523, 5857.560682948764, 5914.497267732248, 5938.910916336258, 6041.063635136539, 5745.2818397700285, 5761.625494342854, 5848.67832269225, 5977.671228082454, 5980.97009514954, 5942.910856337158, 5950.315713692916, 5963.85090372742, 5978.8206353809455, 5987.9101813472835, 5840.211571437865, 6195.504359651217, 6227.782027629011, 6242.563020588538, 6246.500279977591, 4960.082384758795, 5867.178594996704, 5937.732802023919, 5957.285125784891, 5966.134910438005, 13478.663033424244, 13744.793828092586, 14173.858261417357, 14224.431022759078, 14255.429782808675, 2305.7809508096702, 2328.068772491017, 2352.7294361148515, 2362.574736547421, 2372.9525409491885, 9871.2103031758, 10198.49007549627, 10249.0, 10265.897341026568, 10403.0, 1885.38724914402, 1898.5511581760436, 1901.3820508334848, 1954.697021961584, 1954.8045195480338, 76806.0, 83599.0, 84121.57939210265, 84374.15625843724, 84688.0, 10301.0, 10369.170466362673, 10759.78480430387, 10843.132549396187, 11054.944725276482, 14708.264586770618, 14755.188464634548, 14792.926035369754, 14795.186264755543, 14807.407703691732, 7740.845183096307, 7815.765527034198, 7875.803104922423, 7980.960095199487, 7981.600919953979, 7282.417406607458, 7388.852222955511, 7396.667149978264, 7449.833820626212, 7722.768316950501, 4341.891452713644, 4367.2575662137515, 4391.538888416734, 4468.486124095705, 4604.539546045368, 1896.4121122452084, 1988.582397696471, 2013.5133110608388, 2026.422469596158, 2032.979670203279, 899.1772528136681, 963.5567638886191, 977.8093271811929, 985.2216748768536, 1033.1115240892825, 19838.70241946372, 20246.0, 20337.288194913108, 20337.694934575993, 20460.795392046188, 979.9559019844124, 1001.8296889528798, 1009.5305682857506, 1021.39737554843, 1025.789713108826, 9338.813223735624, 11160.609378671708, 11183.888161118448, 11221.943890280496, 11382.715432114263, 470462.0, 480003.0, 489838.0, 490920.0, 497678.0, 82270.0, 83847.16152838393, 84724.0, 85479.0, 85543.5722821382, 996.4868092932, 996.4868092932146, 1012.9341592796445, 1014.60937539048, 1016.7610611506439, 17444.82555174432, 17595.29618815233, 18077.909610451865, 18138.455846324632, 18331.08344582792, 39814.402783958845, 39939.0, 40518.79740601278, 40733.0, 41171.58828411678, 56289.71855140698, 57514.0, 57917.710411449356, 58000.0, 59003.409965899795, 8782.868256976022, 8789.868151977598, 8867.512286824287, 8979.251132840385, 8988.235999940078, 13113.737725245632, 13520.12119212248, 13575.253361065235, 13697.315134243447, 13732.45070197221, 11131.610393636183, 11376.260543064674, 11459.255148415326, 11927.165098443025, 12184.268943863397, 11393.601223957454, 11551.711207219887, 11717.414129293331, 11877.46551405206, 12002.75994480123, 11914.106442017057, 12063.276203427822, 12066.0, 12245.75508489843, 12268.38658067111, 8688.30493560501, 8844.336674749547, 8871.334649901155, 8923.375363724477, 11832.408379581158, 12446.56437024736, 12455.0, 12747.87252127504, 12897.290649014394, 13448.260345681081], "value": 9169.589892365286, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1348.3056226043584, 1439.899207055506, 1497.565705945276, 1594.6252630631807, 1745.5199820049477, 8225.794355141117, 8464.57677116144, 8472.364572657052, 8638.870416943751, 8656.610452529636, 8345.248927596514, 8514.829703405929, 8534.445261058027, 8541.145885411455, 8553.828923421543, 2355.740868504463, 2385.7017872765905, 2388.8208384371155, 2390.3904504351367, 2391.5695174868515, 2327.5112226432384, 2345.95308093838, 2349.7415284318713, 2360.7875291223786, 2379.3456799380224, 2330.7669233076726, 2334.2180369576126, 2358.363241924679, 2361.5631108244943, 2365.503244318695, 2262.061244583496, 2276.2147059264526, 2284.1434462076722, 2289.7595752446005, 2315.305408377497, 2269.897854596547, 2305.7809508096702, 2309.480366917447, 2313.6298192289155, 2314.155333303332, 8486.787830304293, 8531.95734021326, 8534.530600816952, 8596.054434012254, 8600.526971016592, 5200.0, 5272.209168624699, 5280.049591073605, 5284.207368894658, 5290.470952904717, 3373.224158443572, 3409.3010932758725, 3411.993461928737, 3432.8111953842526, 3493.2314890724, 1120.0927248928313, 1138.1975707126455, 1149.2242736153064, 1152.8616566012133, 1159.1858741070198, 11434.656960291204, 11464.770704585862, 11508.36703981289, 11593.362365069917, 11601.361925094116, 4446.555344465528, 4554.20301447252, 4651.325557794101, 4654.883627909329, 4654.906901862011, 9199.126083022102, 9217.0, 9229.53852307382, 9233.953830230941, 9244.676436324697, 5223.686578805284, 5238.188080847474, 5240.161574148118, 5244.737763111905, 5262.973685131627, 4038.495188101487, 4216.177845320133, 4287.8499252526635, 4791.041791641685, 4904.828331008398, 3790.6967442604528, 3811.0853395184954, 3830.138218900781, 3853.903652408656, 3998.1803730235233, 1152.7809716153904, 1158.588701011129, 1163.0, 1165.2425923149851, 1172.302480024384, 949.1647350331802, 978.2907392140642, 982.6953644370268, 986.0927946289431, 1008.1934452438167, 5805.680687562224, 5887.8233652990475, 5921.970390148022, 5979.937310323888, 6062.878742425127, 481.8795301174706, 483.07009007660116, 487.81219230595764, 491.22631854828074, 498.8303976647957, 3992.7404718693774, 4015.7188996769946, 4030.8387664493093, 4086.4483294755423, 4134.91730165395, 10225.59097636101, 10457.790844183226, 10560.894391056145, 10568.313059651098, 10615.89384106149, 10432.895671043192, 10438.425886576311, 10447.529861156267, 10453.477326133663, 10456.947715261374, 7834.294913457816, 7870.881936770838, 7908.367330613537, 8014.398920080901, 8117.4723642961835, 5905.143754155709, 6158.3225845157895, 6176.474999625082, 6193.783217587543, 6288.182536270256, 9295.209907157967, 9697.321187516805, 9760.56077476501, 9799.608015679292, 9840.458774767456, 9629.277804164856, 9847.655332063343, 9889.406635601887, 9916.504174791087, 9937.950310248403, 7418.740344087931, 7475.439342049477, 7510.924890751241, 7531.0, 7541.5475071495885, 7759.573223472537, 7806.72676456344, 7834.529928204326, 7953.9602301990435, 8334.708285209988, 7368.410527157922, 7435.293647103516, 7465.888011679721, 7522.5862577558755, 7563.0, 7442.404607631268, 7473.663685134291, 7647.617619118911, 7698.692052318069, 7704.229577042251, 7042.119735033121, 7074.575525468488, 7167.892481612885, 7174.031505746866, 7184.9640751798, 5368.194770784414, 5394.703291319015, 5449.972750136224, 5473.233747275305, 5543.833684989457, 4855.393075865517, 4945.876353091202, 5072.492750724898, 5076.0, 5141.074606570854], "value": 4473.912789514087, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.3236532742552, 329.82354440374405, 342.0354600027921, 343.6014223500739, 345.5732170769101, 5124.846254612367, 5192.844214673566, 5288.8413347599635, 5346.304980352554, 5360.919586206205, 5044.520770526803, 5181.248718935762, 5182.689038657683, 5198.584113270938, 5203.609729270301, 4121.629053385194, 4125.298699221132, 4129.545749967501, 4132.318167502373, 4191.350340697181, 3947.230290093433, 3954.1498577805764, 4161.334186530155, 4192.4759405074365, 4194.0, 4122.732022418548, 4129.112240868213, 4146.502419709639, 4150.771707556083, 4150.896227594304, 4127.401526778615, 4150.190712811003, 4159.896002599929, 4162.4598898407785, 4166.791660416967, 3463.0, 3698.2973235085246, 3700.3524383232825, 3708.4993525873933, 3713.1459764254105, 5102.158143906251, 5108.131617624976, 5119.744012799382, 5126.256692779563, 5136.614753893473, 4668.603168730662, 4679.415073115861, 4693.577578017961, 4700.811967521295, 4711.835085772016, 5327.174287985368, 5395.892082158335, 5433.673979561199, 5453.754581043862, 5464.644798088111, 3824.7131465139946, 3865.1496670732395, 3885.708571857094, 3887.9222415551812, 3889.1638297766117, 5651.4348565143155, 5658.886822263532, 5670.68811215383, 5702.54379649627, 5716.514096301861, 4106.958930410718, 4109.582194143016, 4111.301078816548, 4113.424120623115, 4128.958710412858, 3971.920561588752, 4148.211839750437, 4152.0, 4166.812493437803, 4171.687123465752, 4708.246680531099, 4720.976395118002, 4739.549742774431, 4740.360051393087, 4761.452432970253, 5532.97639936613, 5552.41699621542, 5553.555715542828, 5577.549837042398, 5585.329760428694, 1287.0, 1289.9419526121346, 1418.7446259673359, 1422.3030714949807, 1422.7439060969125, 902.0393281155548, 906.5059542549326, 920.6455514626917, 924.916757491829, 933.2627224492575, 4695.5069717679835, 4734.130018642617, 4735.958089220366, 4749.881252968635, 4782.33047373368, 4935.851924442272, 4987.326710894055, 5007.674501157413, 5008.0, 5008.873003574166, 4489.95706953342, 4694.450831225688, 4714.976425117852, 4770.379850619397, 4791.616670666338, 2656.787457003435, 2668.6130511075785, 2693.7710294625176, 2701.540738074532, 2708.106324912774, 5179.585633149339, 5228.581713462914, 5230.738463076831, 5276.894462110737, 5279.894402112013, 4778.682339065551, 5059.392872855281, 5090.287359769635, 5090.592752579785, 5123.846284611468, 5131.974340128276, 5187.714675692798, 5188.662736922163, 5191.039657663345, 5252.632315737862, 5048.72232027242, 5058.9494105058475, 5079.339685840817, 5086.821961231339, 5091.0581542414775, 4678.953210467852, 4934.284528743384, 4953.662511122049, 4987.107477662874, 5048.242763585492, 5084.9745751272485, 5130.486951304989, 5158.303629010035, 5197.7661005254095, 5207.27098206259, 3754.94367584481, 3769.8869033929027, 3776.3580191368083, 3777.962220377871, 3797.981010095042, 4775.355327030807, 4981.526754958273, 5005.374328208974, 5111.693298402108, 5410.3507579090765, 5373.596980226421, 5494.791145947885, 5541.556675466034, 5543.417941116125, 5561.860953476195, 5561.777528898799, 5588.217649529151, 5594.216809646571, 5596.804111856066, 5628.0, 5309.761060752198, 5553.750081246434, 5557.083081291542, 5590.608657394106, 5592.440755924375, 5528.170774383874, 5532.640378375393, 5559.749811258584, 5560.026995275892, 5584.692841893735, 5501.4223506532835, 5502.889942201054, 5517.44825517445, 5521.723913804374, 5540.833774986757], "value": 4061.5631295571893, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [791.2601717394236, 794.9903622399556, 808.870580707087, 821.8397412504562, 853.778017715394, 14746.63133421665, 15782.842171578295, 15915.84084159158, 15936.84063159368, 15947.441839535619, 14971.101733895974, 15215.6956860863, 15875.60310992223, 15905.920470397632, 16568.0, 816.5835423933792, 823.4894365493402, 835.9791005224888, 836.2640876029086, 836.6778790165799, 678.6403206300644, 805.1867613710166, 824.6536454689015, 833.8332333533288, 834.5118105908051, 866.4801119328415, 870.8214815962745, 871.9782005449852, 874.2263097159029, 874.4097734029536, 705.0341032785117, 867.7483529776357, 869.2437579306013, 869.4870026684255, 870.1298701298701, 604.4408921747366, 612.718149651161, 617.475146125794, 619.7335145887266, 620.7858288890326, 13982.951278654142, 14030.929845350707, 14035.578932632037, 14185.361658725382, 14186.71626567463, 13723.656908577266, 14073.64815879601, 14127.78808317876, 14181.14913105217, 14276.357563909649, 12534.68663283416, 12613.810792838114, 13479.326033698373, 13502.797458038138, 13835.239061851595, 3992.121733218716, 4002.0995276062945, 4006.0585762345827, 4029.214303210875, 4062.0657248832936, 84039.57980210122, 89256.55371723165, 89853.55073224657, 90167.09832901653, 92648.53675731645, 11824.822627660593, 11827.940860295816, 11843.526258949545, 11959.0, 12122.939385303018, 21205.893970530356, 21233.469163271042, 21295.89352053261, 21296.29629629626, 21334.253301134388, 8344.874826877602, 8588.613512391958, 8674.436161649473, 8810.0, 8837.60230789616, 4627.0, 4656.371389862393, 4685.789139488663, 4693.577578017995, 4734.715917044989, 3728.0, 3841.7310788244554, 3863.478430411915, 3878.3406820840523, 3919.2749341371937, 712.0280816685291, 714.0645754062195, 722.9927700723031, 724.5006618034879, 733.7358550921664, 617.2500411999442, 645.4965127200791, 713.3365969648277, 731.4404480572366, 739.8594267089236, 10567.63013294531, 10633.574657013787, 10634.361938283728, 10828.675139745821, 11150.442477876073, 638.9776357827546, 649.5940037476577, 666.1306994372294, 736.9668364923591, 761.0980987529795, 4846.29728689338, 5170.560502357342, 5210.791568337224, 5236.0575096482235, 5354.170103633943, 121624.39187804004, 130546.0, 130562.0, 133934.97292621856, 134181.0, 113793.0, 114345.4282728581, 115775.0, 116209.0, 117280.0, 77830.6108469454, 78599.99999999885, 100714.4964275174, 101567.0, 102548.0, 10395.948020260153, 10609.522571484456, 10677.412742299248, 10703.304285221435, 11071.83392249133, 35526.0, 37476.62523374731, 37652.43521347237, 47833.52166478291, 51982.480175197765, 47306.29040564325, 66232.00651990128, 73998.63000684962, 77790.0, 79777.0, 12982.285974271128, 13097.345132743516, 13230.536931207747, 13777.793333100211, 14071.085379450304, 15523.0, 15947.362105516113, 16276.0, 16325.67348653044, 17030.914845425694, 14577.416903324172, 14611.561653150422, 14985.325660345528, 15116.848831511545, 15477.458288959833, 14370.353334099782, 14500.492482763053, 14597.649253546433, 14824.184669843262, 15295.464658736892, 13747.656308591964, 13879.444822206999, 14494.782578261545, 14805.333759980611, 14817.40730370773, 11901.226420282654, 11913.463894124958, 12232.143749937419, 12379.504819807107, 12640.178388404724, 11687.649370518899, 11701.12106845808, 11818.290902545874, 12074.154809163274, 12375.319357435428], "value": 7873.203256254512, "unit": "score"}], "name": "dromaeo_css", "value": 7242.866784419659, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 111.0, 111.0, 109.0, 111.0, 110.0, 109.0, 114.0, 111.0, 111.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 118.0, 120.0, 175.0, 115.0, 121.0, 142.0, 116.0, 167.0, 119.0], "value": 134.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 160.0, 161.0, 159.0, 160.0, 161.0, 163.0, 161.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 109.0, 74.0, 74.0, 73.0, 73.0, 99.0, 74.0], "value": 79.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 110.0, 83.0, 83.0, 84.0, 113.0, 84.0, 84.0, 133.0], "value": 94.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 118.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 145.0, 145.0, 146.0, 148.0, 146.0, 145.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 49.0, 50.0, 51.0, 50.0, 50.0, 51.0, 50.0, 51.0, 51.0], "value": 50.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 62.0, 64.0, 63.0, 63.0, 63.0, 63.0, 64.0], "value": 63.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 76.0, 84.0, 78.0, 80.0, 81.0, 74.0, 79.0], "value": 77.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 133.0, 129.0, 121.0, 115.0, 137.0, 137.0, 130.0, 194.0, 127.0], "value": 134.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 156.0, 156.0, 154.0, 152.0, 158.0, 153.0, 153.0, 154.0, 152.0], "value": 154.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 62.0, 62.0, 61.0, 61.0, 61.0, 62.0, 62.0, 61.0], "value": 61.5, "unit": "score"}], "name": "kraken", "value": 1476.8999999999999, "alertThreshold": 2.0}]} 08:34:09 INFO - Return code: 0 08:34:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:34:09 INFO - # TBPL SUCCESS # 08:34:09 INFO - Running post-action listener: _resource_record_post_action 08:34:09 INFO - ##### 08:34:09 INFO - ##### Finished run-tests step (success) 08:34:09 INFO - ##### 08:34:09 INFO - Running post-run listener: _resource_record_post_run 08:34:09 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 562331648; Read time: 0; Write time: 1722700 08:34:09 INFO - TinderboxPrint: CPU usage
13.1% 08:34:09 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:34:09 INFO - TinderboxPrint: I/O write bytes / time
562,331,648 / 1,722,700 08:34:09 INFO - TinderboxPrint: CPU idle
8,269.9 (86.9%) 08:34:09 INFO - TinderboxPrint: CPU user
1,195.2 (12.6%) 08:34:09 INFO - TinderboxPrint: Swap in / out
0 / 0 08:34:09 INFO - install - Wall time: 18s; CPU: 18.0%; Read bytes: 0; Write bytes: 266498048; Read time: 0; Write time: 996664 08:34:09 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 294629376; Read time: 0; Write time: 725812 08:34:10 INFO - Running post-run listener: _upload_blobber_files 08:34:10 INFO - Blob upload gear active. 08:34:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:34:10 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:34:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:34:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:34:10 INFO - (blobuploader) - INFO - Open directory for files ... 08:34:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:34:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:34:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:18 INFO - (blobuploader) - INFO - Done attempting. 08:34:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:34:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:34:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:19 INFO - (blobuploader) - INFO - Done attempting. 08:34:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:34:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:34:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:20 INFO - (blobuploader) - INFO - Done attempting. 08:34:20 INFO - (blobuploader) - INFO - Iteration through files over. 08:34:20 INFO - Return code: 0 08:34:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:34:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:34:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ad5208906b7b4197756c2da8fe839dfc426198c07b0969f73562daa4392c8c5e57e76c187ddb7c123b4c0483c96c6149b892082c94612e9dae3bec804232246", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/554afee69e366178196d01310dc52f91606f214ccc1e14c87dcf30b8788340d1966707d7b744a84246aaa3f493329e50897ab1a181ef1b50d6bf47e51c11349a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08b55862129a5a62b974ebf08ff276fc1dd54e8fba1bb5637d19fb1a4bb650da3074c184a5c2d2c19e06b567128094d12f2a128ef4b5f8502966f240a15b284d"} 08:34:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:34:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:34:20 INFO - Contents: 08:34:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ad5208906b7b4197756c2da8fe839dfc426198c07b0969f73562daa4392c8c5e57e76c187ddb7c123b4c0483c96c6149b892082c94612e9dae3bec804232246", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/554afee69e366178196d01310dc52f91606f214ccc1e14c87dcf30b8788340d1966707d7b744a84246aaa3f493329e50897ab1a181ef1b50d6bf47e51c11349a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08b55862129a5a62b974ebf08ff276fc1dd54e8fba1bb5637d19fb1a4bb650da3074c184a5c2d2c19e06b567128094d12f2a128ef4b5f8502966f240a15b284d"} 08:34:20 INFO - Running post-run listener: copy_logs_to_upload_dir 08:34:20 INFO - Copying logs to upload dir... 08:34:20 INFO - mkdir: /builds/slave/test/build/upload/logs 08:34:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.226912 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-19 08:34:19.767613) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 08:34:19.771739) ========= 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=af724c981e2a0f424dbabf99000001e7-1468941221.411428-774779316 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/3ad5208906b7b4197756c2da8fe839dfc426198c07b0969f73562daa4392c8c5e57e76c187ddb7c123b4c0483c96c6149b892082c94612e9dae3bec804232246", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/554afee69e366178196d01310dc52f91606f214ccc1e14c87dcf30b8788340d1966707d7b744a84246aaa3f493329e50897ab1a181ef1b50d6bf47e51c11349a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08b55862129a5a62b974ebf08ff276fc1dd54e8fba1bb5637d19fb1a4bb650da3074c184a5c2d2c19e06b567128094d12f2a128ef4b5f8502966f240a15b284d"} build_url:https://queue.taskcluster.net/v1/task/AaClyWQdRVyBf6ylml4JWQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011321 build_url: 'https://queue.taskcluster.net/v1/task/AaClyWQdRVyBf6ylml4JWQ/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/3ad5208906b7b4197756c2da8fe839dfc426198c07b0969f73562daa4392c8c5e57e76c187ddb7c123b4c0483c96c6149b892082c94612e9dae3bec804232246", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/554afee69e366178196d01310dc52f91606f214ccc1e14c87dcf30b8788340d1966707d7b744a84246aaa3f493329e50897ab1a181ef1b50d6bf47e51c11349a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08b55862129a5a62b974ebf08ff276fc1dd54e8fba1bb5637d19fb1a4bb650da3074c184a5c2d2c19e06b567128094d12f2a128ef4b5f8502966f240a15b284d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 08:34:19.798173) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 08:34:19.798552) ========= 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=af724c981e2a0f424dbabf99000001e7-1468941221.411428-774779316 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004489 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 08:34:19.884516) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 08:34:19.884875) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 08:34:19.885248) ========= ========= Total master_lag: 0.17 =========