builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-042 starttime: 1467875041.07 results: success (0) buildid: 20160706234023 builduid: c57e29f997e248af8b2750d386449388 revision: b9cc2dcbf4363c8049183110fe79e026fae87ecb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 00:04:01.068233) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 00:04:01.069173) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 00:04:01.069901) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 00:04:01.110160) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 00:04:01.110488) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1467874808.201413-564417626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-07 00:04:01-- 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% 46.5M=0s 2016-07-07 00:04:01 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.367290 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 00:04:01.495662) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 00:04:01.496207) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1467874808.201413-564417626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021268 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 00:04:01.549202) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-07 00:04:01.550153) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b9cc2dcbf4363c8049183110fe79e026fae87ecb --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 b9cc2dcbf4363c8049183110fe79e026fae87ecb --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=74d6aec007b0fa31a864ebd7000001f8-1467874808.201413-564417626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-07 00:04:01,623 truncating revision to first 12 chars 2016-07-07 00:04:01,623 Setting DEBUG logging. 2016-07-07 00:04:01,623 attempt 1/10 2016-07-07 00:04:01,624 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b9cc2dcbf436?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 00:04:02,388 unpacking tar archive at: fx-team-b9cc2dcbf436/testing/mozharness/ program finished with exit code 0 elapsedTime=1.121784 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-07 00:04:02.686824) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 00:04:02.687150) ========= script_repo_revision: b9cc2dcbf4363c8049183110fe79e026fae87ecb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 00:04:02.687603) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 00:04:02.687918) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 00:04:02.701763) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-07-07 00:04:02.702072) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=74d6aec007b0fa31a864ebd7000001f8-1467874808.201413-564417626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:04:02 INFO - MultiFileLogger online at 20160707 00:04:02 in /builds/slave/test 00:04:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 00:04:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:04:02 INFO - {'append_to_log': False, 00:04:02 INFO - 'base_work_dir': '/builds/slave/test', 00:04:02 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 00:04:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:04:02 INFO - 'branch': 'Fx-Team-Non-PGO', 00:04:02 INFO - 'buildbot_json_path': 'buildprops.json', 00:04:02 INFO - 'config_files': ('talos/linux_config.py',), 00:04:02 INFO - 'default_actions': ('clobber', 00:04:02 INFO - 'read-buildbot-config', 00:04:02 INFO - 'download-and-extract', 00:04:02 INFO - 'populate-webroot', 00:04:02 INFO - 'create-virtualenv', 00:04:02 INFO - 'install', 00:04:02 INFO - 'run-tests'), 00:04:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:04:02 INFO - 'download_minidump_stackwalk': True, 00:04:02 INFO - 'download_symbols': 'ondemand', 00:04:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:04:02 INFO - 'tooltool.py': '/tools/tooltool.py', 00:04:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:04:02 INFO - '/tools/misc-python/virtualenv.py')}, 00:04:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:04:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:04:02 INFO - 'installer_path': 'installer.exe', 00:04:02 INFO - 'log_level': 'info', 00:04:02 INFO - 'log_name': 'talos', 00:04:02 INFO - 'log_to_console': True, 00:04:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:04:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:04:02 INFO - 'opt_config_files': (), 00:04:02 INFO - 'pip_index': False, 00:04:02 INFO - 'sps_profile': False, 00:04:02 INFO - 'sps_profile_interval': 0, 00:04:02 INFO - 'suite': 'dromaeojs', 00:04:02 INFO - 'system_bits': '32', 00:04:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:04:02 INFO - 'title': 'talos-linux64-ix-042', 00:04:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:04:02 INFO - 'use_talos_json': True, 00:04:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:04:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:04:02 INFO - 'work_dir': 'build'} 00:04:02 INFO - ##### 00:04:02 INFO - ##### Running clobber step. 00:04:02 INFO - ##### 00:04:02 INFO - Running pre-action listener: _resource_record_pre_action 00:04:02 INFO - Running main action method: clobber 00:04:02 INFO - rmtree: /builds/slave/test/build 00:04:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:04:03 INFO - Running post-action listener: _resource_record_post_action 00:04:03 INFO - ##### 00:04:03 INFO - ##### Finished clobber step (success) 00:04:03 INFO - ##### 00:04:03 INFO - ##### 00:04:03 INFO - ##### Running read-buildbot-config step. 00:04:03 INFO - ##### 00:04:03 INFO - Running pre-action listener: _resource_record_pre_action 00:04:03 INFO - Running main action method: read_buildbot_config 00:04:03 INFO - Using buildbot properties: 00:04:03 INFO - { 00:04:03 INFO - "project": "", 00:04:03 INFO - "product": "firefox", 00:04:03 INFO - "script_repo_revision": "production", 00:04:03 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 00:04:03 INFO - "repository": "", 00:04:03 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 00:04:03 INFO - "buildid": "20160706234023", 00:04:03 INFO - "pgo_build": "False", 00:04:03 INFO - "basedir": "/builds/slave/test", 00:04:03 INFO - "buildnumber": 1939, 00:04:03 INFO - "slavename": "talos-linux64-ix-042", 00:04:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 00:04:03 INFO - "platform": "ubuntu64_hw", 00:04:03 INFO - "scheduler": "tests-fx-team-linux64-talos", 00:04:03 INFO - "branch": "fx-team", 00:04:03 INFO - "repo_path": "integration/fx-team", 00:04:03 INFO - "revision": "b9cc2dcbf4363c8049183110fe79e026fae87ecb", 00:04:03 INFO - "stage_platform": "linux64", 00:04:03 INFO - "builduid": "c57e29f997e248af8b2750d386449388", 00:04:03 INFO - "slavebuilddir": "test" 00:04:03 INFO - } 00:04:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/aYFmiwosQTy6wQe4dNiUhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 00:04:03 INFO - Running post-action listener: _resource_record_post_action 00:04:03 INFO - ##### 00:04:03 INFO - ##### Finished read-buildbot-config step (success) 00:04:03 INFO - ##### 00:04:03 INFO - ##### 00:04:03 INFO - ##### Running download-and-extract step. 00:04:03 INFO - ##### 00:04:03 INFO - Running pre-action listener: _resource_record_pre_action 00:04:03 INFO - Running main action method: download_and_extract 00:04:03 INFO - mkdir: /builds/slave/test/build/tests 00:04:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:04:03 INFO - https://queue.taskcluster.net/v1/task/aYFmiwosQTy6wQe4dNiUhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 00:04:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aYFmiwosQTy6wQe4dNiUhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 00:04:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aYFmiwosQTy6wQe4dNiUhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 00:04:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aYFmiwosQTy6wQe4dNiUhQ/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 00:04:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aYFmiwosQTy6wQe4dNiUhQ/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 00:04:14 INFO - Downloaded 1361 bytes. 00:04:14 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 00:04:14 INFO - Using the following test package requirements: 00:04:14 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 00:04:14 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:04:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:04:14 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:04:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:04:14 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:04:14 INFO - u'jsshell-linux-x86_64.zip'], 00:04:14 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:04:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:04:14 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 00:04:14 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:04:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:04:14 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:04:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:04:14 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:04:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:04:14 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:04:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:04:14 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:04:14 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')]} 00:04:14 INFO - https://queue.taskcluster.net/v1/task/aYFmiwosQTy6wQe4dNiUhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:04:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aYFmiwosQTy6wQe4dNiUhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:04:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aYFmiwosQTy6wQe4dNiUhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:04:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aYFmiwosQTy6wQe4dNiUhQ/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 00:04:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aYFmiwosQTy6wQe4dNiUhQ/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 00:04:22 INFO - Downloaded 22733538 bytes. 00:04:22 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'] 00:04:22 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 00:04:23 INFO - Return code: 0 00:04:23 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 00:04:23 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')]} 00:04:23 INFO - https://queue.taskcluster.net/v1/task/aYFmiwosQTy6wQe4dNiUhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:04:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aYFmiwosQTy6wQe4dNiUhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:04:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aYFmiwosQTy6wQe4dNiUhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:04:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aYFmiwosQTy6wQe4dNiUhQ/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 00:04:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aYFmiwosQTy6wQe4dNiUhQ/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 00:04:26 INFO - Downloaded 22733538 bytes. 00:04:26 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'] 00:04:26 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 00:04:27 INFO - Return code: 0 00:04:27 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')]} 00:04:27 INFO - https://queue.taskcluster.net/v1/task/aYFmiwosQTy6wQe4dNiUhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:04:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aYFmiwosQTy6wQe4dNiUhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 00:04:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aYFmiwosQTy6wQe4dNiUhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 00:04:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aYFmiwosQTy6wQe4dNiUhQ/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 00:04:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aYFmiwosQTy6wQe4dNiUhQ/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 00:04:28 INFO - Downloaded 14403333 bytes. 00:04:28 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'] 00:04:28 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 00:04:29 INFO - Return code: 0 00:04:29 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')]} 00:04:29 INFO - https://queue.taskcluster.net/v1/task/aYFmiwosQTy6wQe4dNiUhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:04:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aYFmiwosQTy6wQe4dNiUhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:04:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aYFmiwosQTy6wQe4dNiUhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:04:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aYFmiwosQTy6wQe4dNiUhQ/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 00:04:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aYFmiwosQTy6wQe4dNiUhQ/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 00:04:31 INFO - Downloaded 56583164 bytes. 00:04:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aYFmiwosQTy6wQe4dNiUhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:04:31 INFO - mkdir: /builds/slave/test/properties 00:04:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:04:31 INFO - Writing to file /builds/slave/test/properties/build_url 00:04:31 INFO - Contents: 00:04:31 INFO - build_url:https://queue.taskcluster.net/v1/task/aYFmiwosQTy6wQe4dNiUhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:04:31 INFO - Running post-action listener: _resource_record_post_action 00:04:31 INFO - Running post-action listener: set_extra_try_arguments 00:04:31 INFO - ##### 00:04:31 INFO - ##### Finished download-and-extract step (success) 00:04:31 INFO - ##### 00:04:31 INFO - ##### 00:04:31 INFO - ##### Running populate-webroot step. 00:04:31 INFO - ##### 00:04:31 INFO - Running pre-action listener: _resource_record_pre_action 00:04:31 INFO - Running main action method: populate_webroot 00:04:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:04:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:04:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:04:32 INFO - '--tppagecycles', 00:04:32 INFO - '7'], 00:04:32 INFO - 'tests': ['tsvgm']}}, 00:04:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:04:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:04:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:04:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:04:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:04:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:04:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:04:32 INFO - 'talos_options': ['--disable-e10s'], 00:04:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:04:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:04:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:04:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:04:32 INFO - 'talos_options': ['--disable-e10s'], 00:04:32 INFO - 'tests': ['damp', 'tps']}, 00:04:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:04:32 INFO - 'tests': ['damp', 'tps']}, 00:04:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:04:32 INFO - 'tests': ['dromaeo_dom']}, 00:04:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:04:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:04:32 INFO - 'tests': ['basic_compositor_video']}, 00:04:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:04:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:04:32 INFO - 'tests': ['a11yr', 00:04:32 INFO - 'ts_paint', 00:04:32 INFO - 'tpaint', 00:04:32 INFO - 'sessionrestore', 00:04:32 INFO - 'sessionrestore_no_auto_restore', 00:04:32 INFO - 'tabpaint']}, 00:04:32 INFO - 'other-e10s': {'tests': ['a11yr', 00:04:32 INFO - 'ts_paint', 00:04:32 INFO - 'tpaint', 00:04:32 INFO - 'sessionrestore', 00:04:32 INFO - 'sessionrestore_no_auto_restore', 00:04:32 INFO - 'tabpaint']}, 00:04:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:04:32 INFO - 'ts_paint', 00:04:32 INFO - 'tpaint', 00:04:32 INFO - 'sessionrestore', 00:04:32 INFO - 'sessionrestore_no_auto_restore', 00:04:32 INFO - 'tabpaint']}, 00:04:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:04:32 INFO - 'ts_paint', 00:04:32 INFO - 'tpaint', 00:04:32 INFO - 'sessionrestore', 00:04:32 INFO - 'sessionrestore_no_auto_restore', 00:04:32 INFO - 'tabpaint']}, 00:04:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:04:32 INFO - 'tests': ['a11yr', 00:04:32 INFO - 'ts_paint', 00:04:32 INFO - 'tpaint', 00:04:32 INFO - 'sessionrestore', 00:04:32 INFO - 'sessionrestore_no_auto_restore', 00:04:32 INFO - 'tabpaint']}, 00:04:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:04:32 INFO - 'tests': ['a11yr', 00:04:32 INFO - 'ts_paint', 00:04:32 INFO - 'tpaint', 00:04:32 INFO - 'sessionrestore', 00:04:32 INFO - 'sessionrestore_no_auto_restore', 00:04:32 INFO - 'tabpaint']}, 00:04:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:04:32 INFO - 'tests': ['tsvgx', 00:04:32 INFO - 'tsvgr_opacity', 00:04:32 INFO - 'tart', 00:04:32 INFO - 'tscrollx', 00:04:32 INFO - 'cart']}, 00:04:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:04:32 INFO - 'tsvgr_opacity', 00:04:32 INFO - 'tart', 00:04:32 INFO - 'tscrollx', 00:04:32 INFO - 'cart']}, 00:04:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:04:32 INFO - 'talos_options': ['--disable-e10s'], 00:04:32 INFO - 'tests': ['tp5o']}, 00:04:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:04:32 INFO - 'tests': ['tp5o']}, 00:04:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:04:32 INFO - 'talos_options': ['--disable-e10s', 00:04:32 INFO - '--xperf_path', 00:04:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:04:32 INFO - 'tests': ['tp5n']}, 00:04:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:04:32 INFO - 'talos_options': ['--xperf_path', 00:04:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:04:32 INFO - 'tests': ['tp5n']}}, 00:04:32 INFO - 'talos.zip': {'path': '', 00:04:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:04:32 INFO - Running post-action listener: _resource_record_post_action 00:04:32 INFO - ##### 00:04:32 INFO - ##### Finished populate-webroot step (success) 00:04:32 INFO - ##### 00:04:32 INFO - ##### 00:04:32 INFO - ##### Running create-virtualenv step. 00:04:32 INFO - ##### 00:04:32 INFO - Running pre-action listener: _resource_record_pre_action 00:04:32 INFO - Running main action method: create_virtualenv 00:04:32 INFO - Creating virtualenv /builds/slave/test/build/venv 00:04:32 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 00:04:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:04:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:04:32 INFO - Using real prefix '/usr' 00:04:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:04:32 INFO - Installing distribute.............................................................................................................................................................................................done. 00:04:34 INFO - Installing pip.................done. 00:04:34 INFO - Return code: 0 00:04:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:04:34 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')]} 00:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:04:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:04:34 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')]} 00:04:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:04:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:04:34 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 0x21fc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bb3b0>, '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 0x24bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bc740>, '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': '74d6aec007b0fa31a864ebd7000001f8-1467874808.201413-564417626', '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 00:04:34 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 00:04:34 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 00:04:34 INFO - Using env: {'DISPLAY': ':0', 00:04:34 INFO - 'HOME': '/home/cltbld', 00:04:34 INFO - 'LANG': 'en_US.UTF-8', 00:04:34 INFO - 'LANGUAGE': 'en_US:en', 00:04:34 INFO - 'LOGNAME': 'cltbld', 00:04:34 INFO - 'MAIL': '/var/mail/cltbld', 00:04:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:04:34 INFO - 'MOZ_NO_REMOTE': '1', 00:04:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:04:34 INFO - 'NO_EM_RESTART': '1', 00:04:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:04:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:04:34 INFO - 'PWD': '/builds/slave/test', 00:04:34 INFO - 'SHELL': '/bin/bash', 00:04:34 INFO - 'SHLVL': '1', 00:04:34 INFO - 'TERM': 'linux', 00:04:34 INFO - 'TMOUT': '86400', 00:04:34 INFO - 'USER': 'cltbld', 00:04:34 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467874808.201413-564417626', 00:04:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:04:34 INFO - '_': '/tools/buildbot/bin/python'} 00:04:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:04:34 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 00:04:34 INFO - Cleaning up... 00:04:34 INFO - Return code: 0 00:04:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:04:34 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')]} 00:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:04:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:04:34 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')]} 00:04:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:04:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:04:34 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 0x21fc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bb3b0>, '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 0x24bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bc740>, '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': '74d6aec007b0fa31a864ebd7000001f8-1467874808.201413-564417626', '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 00:04:34 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 00:04:34 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 00:04:34 INFO - Using env: {'DISPLAY': ':0', 00:04:34 INFO - 'HOME': '/home/cltbld', 00:04:34 INFO - 'LANG': 'en_US.UTF-8', 00:04:34 INFO - 'LANGUAGE': 'en_US:en', 00:04:34 INFO - 'LOGNAME': 'cltbld', 00:04:34 INFO - 'MAIL': '/var/mail/cltbld', 00:04:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:04:34 INFO - 'MOZ_NO_REMOTE': '1', 00:04:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:04:34 INFO - 'NO_EM_RESTART': '1', 00:04:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:04:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:04:34 INFO - 'PWD': '/builds/slave/test', 00:04:34 INFO - 'SHELL': '/bin/bash', 00:04:34 INFO - 'SHLVL': '1', 00:04:34 INFO - 'TERM': 'linux', 00:04:34 INFO - 'TMOUT': '86400', 00:04:34 INFO - 'USER': 'cltbld', 00:04:34 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467874808.201413-564417626', 00:04:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:04:34 INFO - '_': '/tools/buildbot/bin/python'} 00:04:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:04:35 INFO - Downloading/unpacking psutil>=3.1.1 00:04:35 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 00:04:35 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 00:04:35 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 00:04:35 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 00:04:35 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 00:04:35 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 00:04:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:04:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:04:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:04:37 INFO - Installing collected packages: psutil 00:04:37 INFO - Running setup.py install for psutil 00:04:37 INFO - building 'psutil._psutil_linux' extension 00:04:37 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 00:04:37 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 00:04:37 INFO - building 'psutil._psutil_posix' extension 00:04:37 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 00:04:37 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 00:04:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:04:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:04:37 INFO - Successfully installed psutil 00:04:37 INFO - Cleaning up... 00:04:37 INFO - Return code: 0 00:04:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:04:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:04:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:04:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:04:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:04:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:04:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:04:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21fc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bb3b0>, '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 0x24bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bc740>, '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': '74d6aec007b0fa31a864ebd7000001f8-1467874808.201413-564417626', '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 00:04:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:04:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 00:04:37 INFO - Using env: {'DISPLAY': ':0', 00:04:37 INFO - 'HOME': '/home/cltbld', 00:04:37 INFO - 'LANG': 'en_US.UTF-8', 00:04:37 INFO - 'LANGUAGE': 'en_US:en', 00:04:37 INFO - 'LOGNAME': 'cltbld', 00:04:37 INFO - 'MAIL': '/var/mail/cltbld', 00:04:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:04:37 INFO - 'MOZ_NO_REMOTE': '1', 00:04:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:04:37 INFO - 'NO_EM_RESTART': '1', 00:04:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:04:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:04:37 INFO - 'PWD': '/builds/slave/test', 00:04:37 INFO - 'SHELL': '/bin/bash', 00:04:37 INFO - 'SHLVL': '1', 00:04:37 INFO - 'TERM': 'linux', 00:04:37 INFO - 'TMOUT': '86400', 00:04:37 INFO - 'USER': 'cltbld', 00:04:37 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467874808.201413-564417626', 00:04:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:04:37 INFO - '_': '/tools/buildbot/bin/python'} 00:04:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:04:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:04:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:04:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:04:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:04:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:04:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:04:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:04:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:04:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:04:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:04:40 INFO - Installing collected packages: mozsystemmonitor 00:04:40 INFO - Running setup.py install for mozsystemmonitor 00:04:40 INFO - Successfully installed mozsystemmonitor 00:04:40 INFO - Cleaning up... 00:04:40 INFO - Return code: 0 00:04:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:04:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:04:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:04:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:04:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:04:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:04:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21fc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bb3b0>, '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 0x24bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bc740>, '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': '74d6aec007b0fa31a864ebd7000001f8-1467874808.201413-564417626', '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 00:04:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 00:04:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 00:04:40 INFO - Using env: {'DISPLAY': ':0', 00:04:40 INFO - 'HOME': '/home/cltbld', 00:04:40 INFO - 'LANG': 'en_US.UTF-8', 00:04:40 INFO - 'LANGUAGE': 'en_US:en', 00:04:40 INFO - 'LOGNAME': 'cltbld', 00:04:40 INFO - 'MAIL': '/var/mail/cltbld', 00:04:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:04:40 INFO - 'MOZ_NO_REMOTE': '1', 00:04:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:04:40 INFO - 'NO_EM_RESTART': '1', 00:04:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:04:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:04:40 INFO - 'PWD': '/builds/slave/test', 00:04:40 INFO - 'SHELL': '/bin/bash', 00:04:40 INFO - 'SHLVL': '1', 00:04:40 INFO - 'TERM': 'linux', 00:04:40 INFO - 'TMOUT': '86400', 00:04:40 INFO - 'USER': 'cltbld', 00:04:40 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467874808.201413-564417626', 00:04:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:04:40 INFO - '_': '/tools/buildbot/bin/python'} 00:04:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:04:41 INFO - Downloading/unpacking jsonschema==2.5.1 00:04:41 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 00:04:41 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 00:04:41 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 00:04:41 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 00:04:41 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 00:04:41 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 00:04:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:04:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:04:43 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 00:04:43 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 00:04:43 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 00:04:43 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 00:04:43 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 00:04:43 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 00:04:43 INFO - Downloading functools32-3.2.3-2.tar.gz 00:04:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:04:43 INFO - warning: no files found matching '*.txt' 00:04:43 INFO - no previously-included directories found matching 'build' 00:04:43 INFO - no previously-included directories found matching 'dist' 00:04:43 INFO - no previously-included directories found matching '.git*' 00:04:43 INFO - Installing collected packages: jsonschema, functools32 00:04:43 INFO - Running setup.py install for functools32 00:04:43 INFO - warning: no files found matching '*.txt' 00:04:43 INFO - no previously-included directories found matching 'build' 00:04:43 INFO - no previously-included directories found matching 'dist' 00:04:43 INFO - no previously-included directories found matching '.git*' 00:04:43 INFO - Successfully installed jsonschema functools32 00:04:43 INFO - Cleaning up... 00:04:43 INFO - Return code: 0 00:04:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:04:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:04:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:04:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:04:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:04:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:04:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:04:43 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 0x21fc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bb3b0>, '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 0x24bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bc740>, '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': '74d6aec007b0fa31a864ebd7000001f8-1467874808.201413-564417626', '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 00:04:43 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 00:04:43 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 00:04:43 INFO - Using env: {'DISPLAY': ':0', 00:04:43 INFO - 'HOME': '/home/cltbld', 00:04:43 INFO - 'LANG': 'en_US.UTF-8', 00:04:43 INFO - 'LANGUAGE': 'en_US:en', 00:04:43 INFO - 'LOGNAME': 'cltbld', 00:04:43 INFO - 'MAIL': '/var/mail/cltbld', 00:04:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:04:43 INFO - 'MOZ_NO_REMOTE': '1', 00:04:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:04:43 INFO - 'NO_EM_RESTART': '1', 00:04:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:04:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:04:43 INFO - 'PWD': '/builds/slave/test', 00:04:43 INFO - 'SHELL': '/bin/bash', 00:04:43 INFO - 'SHLVL': '1', 00:04:43 INFO - 'TERM': 'linux', 00:04:43 INFO - 'TMOUT': '86400', 00:04:43 INFO - 'USER': 'cltbld', 00:04:43 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467874808.201413-564417626', 00:04:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:04:43 INFO - '_': '/tools/buildbot/bin/python'} 00:04:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:04:43 INFO - Downloading/unpacking blobuploader==1.2.4 00:04:43 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 00:04:43 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 00:04:43 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 00:04:43 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 00:04:43 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 00:04:43 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 00:04:45 INFO - Downloading blobuploader-1.2.4.tar.gz 00:04:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:04:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:04:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:04:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:04:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:04:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:04:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:04:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:04:46 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 00:04:46 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 00:04:46 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 00:04:46 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 00:04:46 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 00:04:46 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 00:04:46 INFO - Downloading docopt-0.6.1.tar.gz 00:04:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:04:46 INFO - Installing collected packages: blobuploader, requests, docopt 00:04:46 INFO - Running setup.py install for blobuploader 00:04:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:04:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:04:46 INFO - Running setup.py install for requests 00:04:46 INFO - Running setup.py install for docopt 00:04:47 INFO - Successfully installed blobuploader requests docopt 00:04:47 INFO - Cleaning up... 00:04:47 INFO - Return code: 0 00:04:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:04: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')]} 00:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:04:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:04: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')]} 00:04:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:04:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:04:47 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 0x21fc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bb3b0>, '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 0x24bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bc740>, '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': '74d6aec007b0fa31a864ebd7000001f8-1467874808.201413-564417626', '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 00:04:47 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 00:04:47 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 00:04:47 INFO - Using env: {'DISPLAY': ':0', 00:04:47 INFO - 'HOME': '/home/cltbld', 00:04:47 INFO - 'LANG': 'en_US.UTF-8', 00:04:47 INFO - 'LANGUAGE': 'en_US:en', 00:04:47 INFO - 'LOGNAME': 'cltbld', 00:04:47 INFO - 'MAIL': '/var/mail/cltbld', 00:04:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:04:47 INFO - 'MOZ_NO_REMOTE': '1', 00:04:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:04:47 INFO - 'NO_EM_RESTART': '1', 00:04:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:04:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:04:47 INFO - 'PWD': '/builds/slave/test', 00:04:47 INFO - 'SHELL': '/bin/bash', 00:04:47 INFO - 'SHLVL': '1', 00:04:47 INFO - 'TERM': 'linux', 00:04:47 INFO - 'TMOUT': '86400', 00:04:47 INFO - 'USER': 'cltbld', 00:04:47 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467874808.201413-564417626', 00:04:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:04:47 INFO - '_': '/tools/buildbot/bin/python'} 00:04:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:04:47 INFO - Running setup.py (path:/tmp/pip-oib5eK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:04:47 INFO - Running setup.py (path:/tmp/pip-gQM1wu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:04:47 INFO - Running setup.py (path:/tmp/pip-aeShNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:04:47 INFO - Running setup.py (path:/tmp/pip-n3G1ii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:04:47 INFO - Running setup.py (path:/tmp/pip-wyGwQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:04:47 INFO - Running setup.py (path:/tmp/pip-R96qW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:04:47 INFO - Running setup.py (path:/tmp/pip-cX4jn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:04:47 INFO - Running setup.py (path:/tmp/pip-QwUvkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:04:47 INFO - Running setup.py (path:/tmp/pip-4lm4zW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:04:47 INFO - Running setup.py (path:/tmp/pip-wc5Idq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:04:48 INFO - Running setup.py (path:/tmp/pip-WCbGac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:04:48 INFO - Running setup.py (path:/tmp/pip-2bvKGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:04:48 INFO - Running setup.py (path:/tmp/pip-Hbfd2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:04:48 INFO - Running setup.py (path:/tmp/pip-pMwvIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:04:48 INFO - Running setup.py (path:/tmp/pip-9CqbjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:04:48 INFO - Running setup.py (path:/tmp/pip-HlqTHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:04:48 INFO - Running setup.py (path:/tmp/pip-CH5wee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:04:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:04:48 INFO - Running setup.py install for manifestparser 00:04:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:04:48 INFO - Running setup.py install for mozcrash 00:04:48 INFO - Running setup.py install for mozdebug 00:04:48 INFO - Running setup.py install for mozdevice 00:04:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:04:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:04:49 INFO - Running setup.py install for mozfile 00:04:49 INFO - Running setup.py install for mozhttpd 00:04:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:04:49 INFO - Running setup.py install for mozinfo 00:04:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:04:49 INFO - Running setup.py install for mozInstall 00:04:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:04:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:04:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:04:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:04:49 INFO - Running setup.py install for mozleak 00:04:49 INFO - Running setup.py install for mozlog 00:04:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:04:49 INFO - Running setup.py install for moznetwork 00:04:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:04:49 INFO - Running setup.py install for mozprocess 00:04:49 INFO - Running setup.py install for mozprofile 00:04:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:04:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:04:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:04:49 INFO - Running setup.py install for mozrunner 00:04:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:04:50 INFO - Running setup.py install for mozscreenshot 00:04:50 INFO - Running setup.py install for moztest 00:04:50 INFO - Running setup.py install for mozversion 00:04:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:04:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:04:50 INFO - Cleaning up... 00:04:50 INFO - Return code: 0 00:04:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:04: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')]} 00:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:04:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:04: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')]} 00:04:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:04:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:04:50 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 0x21fc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bb3b0>, '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 0x24bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bc740>, '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': '74d6aec007b0fa31a864ebd7000001f8-1467874808.201413-564417626', '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 00:04:50 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 00:04:50 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 00:04:50 INFO - Using env: {'DISPLAY': ':0', 00:04:50 INFO - 'HOME': '/home/cltbld', 00:04:50 INFO - 'LANG': 'en_US.UTF-8', 00:04:50 INFO - 'LANGUAGE': 'en_US:en', 00:04:50 INFO - 'LOGNAME': 'cltbld', 00:04:50 INFO - 'MAIL': '/var/mail/cltbld', 00:04:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:04:50 INFO - 'MOZ_NO_REMOTE': '1', 00:04:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:04:50 INFO - 'NO_EM_RESTART': '1', 00:04:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:04:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:04:50 INFO - 'PWD': '/builds/slave/test', 00:04:50 INFO - 'SHELL': '/bin/bash', 00:04:50 INFO - 'SHLVL': '1', 00:04:50 INFO - 'TERM': 'linux', 00:04:50 INFO - 'TMOUT': '86400', 00:04:50 INFO - 'USER': 'cltbld', 00:04:50 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467874808.201413-564417626', 00:04:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:04:50 INFO - '_': '/tools/buildbot/bin/python'} 00:04:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:04:50 INFO - Running setup.py (path:/tmp/pip-tNBBMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:04:50 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)) 00:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:04:50 INFO - Running setup.py (path:/tmp/pip-LRoqBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:04:50 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)) 00:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:04:50 INFO - Running setup.py (path:/tmp/pip-cowScK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:04:50 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)) 00:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:04:50 INFO - Running setup.py (path:/tmp/pip-NwBjYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:04:50 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)) 00:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:04:50 INFO - Running setup.py (path:/tmp/pip-cXeSpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:04:50 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)) 00:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:04:50 INFO - Running setup.py (path:/tmp/pip-2XLL3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:04:51 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)) 00:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:04:51 INFO - Running setup.py (path:/tmp/pip-dyXvuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:04:51 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)) 00:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:04:51 INFO - Running setup.py (path:/tmp/pip-ACSDlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:04:51 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)) 00:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:04:51 INFO - Running setup.py (path:/tmp/pip-TumbwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:04:51 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)) 00:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:04:51 INFO - Running setup.py (path:/tmp/pip-JcPswR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:04:51 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)) 00:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:04:51 INFO - Running setup.py (path:/tmp/pip-VHX3Re-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:04:51 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)) 00:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:04:51 INFO - Running setup.py (path:/tmp/pip-GcQURj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:04:51 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)) 00:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:04:51 INFO - Running setup.py (path:/tmp/pip-WHQz0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:04:51 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)) 00:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:04:51 INFO - Running setup.py (path:/tmp/pip-WlcnbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:04:51 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)) 00:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:04:51 INFO - Running setup.py (path:/tmp/pip-Z9M4Ti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:04:51 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)) 00:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:04:51 INFO - Running setup.py (path:/tmp/pip-t5FeCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:04:51 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)) 00:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:04:51 INFO - Running setup.py (path:/tmp/pip-AkvCu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:04:51 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)) 00:04:51 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)) 00:04:51 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)) 00:04:51 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)) 00:04:51 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)) 00:04:51 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)) 00:04:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:04:51 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 00:04:51 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 00:04:51 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 00:04:51 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 00:04:51 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 00:04:51 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 00:04:53 INFO - Downloading blessings-1.6.tar.gz 00:04:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:04:53 INFO - Installing collected packages: blessings 00:04:53 INFO - Running setup.py install for blessings 00:04:53 INFO - Successfully installed blessings 00:04:53 INFO - Cleaning up... 00:04:53 INFO - Return code: 0 00:04:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:04:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:04:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:04:54 INFO - Reading from file tmpfile_stdout 00:04:54 INFO - Current package versions: 00:04:54 INFO - argparse == 1.2.1 00:04:54 INFO - blessings == 1.6 00:04:54 INFO - blobuploader == 1.2.4 00:04:54 INFO - docopt == 0.6.1 00:04:54 INFO - functools32 == 3.2.3-2 00:04:54 INFO - jsonschema == 2.5.1 00:04:54 INFO - manifestparser == 1.1 00:04:54 INFO - mozInstall == 1.12 00:04:54 INFO - mozcrash == 0.17 00:04:54 INFO - mozdebug == 0.1 00:04:54 INFO - mozdevice == 0.48 00:04:54 INFO - mozfile == 1.2 00:04:54 INFO - mozhttpd == 0.7 00:04:54 INFO - mozinfo == 0.9 00:04:54 INFO - mozleak == 0.1 00:04:54 INFO - mozlog == 3.2 00:04:54 INFO - moznetwork == 0.27 00:04:54 INFO - mozprocess == 0.23 00:04:54 INFO - mozprofile == 0.28 00:04:54 INFO - mozrunner == 6.12 00:04:54 INFO - mozscreenshot == 0.1 00:04:54 INFO - mozsystemmonitor == 0.3 00:04:54 INFO - moztest == 0.7 00:04:54 INFO - mozversion == 1.4 00:04:54 INFO - psutil == 3.1.1 00:04:54 INFO - requests == 1.2.3 00:04:54 INFO - wsgiref == 0.1.2 00:04:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:04:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:04:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:04:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:04:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:04:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:04:54 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 0x21fc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bb3b0>, '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 0x24bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bc740>, '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': '74d6aec007b0fa31a864ebd7000001f8-1467874808.201413-564417626', '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 00:04:54 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 00:04:54 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 00:04:54 INFO - Using env: {'DISPLAY': ':0', 00:04:54 INFO - 'HOME': '/home/cltbld', 00:04:54 INFO - 'LANG': 'en_US.UTF-8', 00:04:54 INFO - 'LANGUAGE': 'en_US:en', 00:04:54 INFO - 'LOGNAME': 'cltbld', 00:04:54 INFO - 'MAIL': '/var/mail/cltbld', 00:04:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:04:54 INFO - 'MOZ_NO_REMOTE': '1', 00:04:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:04:54 INFO - 'NO_EM_RESTART': '1', 00:04:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:04:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:04:54 INFO - 'PWD': '/builds/slave/test', 00:04:54 INFO - 'SHELL': '/bin/bash', 00:04:54 INFO - 'SHLVL': '1', 00:04:54 INFO - 'TERM': 'linux', 00:04:54 INFO - 'TMOUT': '86400', 00:04:54 INFO - 'USER': 'cltbld', 00:04:54 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467874808.201413-564417626', 00:04:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:04:54 INFO - '_': '/tools/buildbot/bin/python'} 00:04:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:04:54 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)) 00:04:54 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)) 00:04:54 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)) 00:04:54 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)) 00:04:54 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)) 00:04:54 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)) 00:04:54 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)) 00:04:54 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)) 00:04:54 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)) 00:04:54 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)) 00:04:54 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)) 00:04:54 INFO - Cleaning up... 00:04:54 INFO - Return code: 0 00:04:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:04:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:04:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:04:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:04:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:04:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:04:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21fc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bb3b0>, '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 0x24bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bc740>, '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': '74d6aec007b0fa31a864ebd7000001f8-1467874808.201413-564417626', '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 00:04:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:04:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:04:54 INFO - Using env: {'DISPLAY': ':0', 00:04:54 INFO - 'HOME': '/home/cltbld', 00:04:54 INFO - 'LANG': 'en_US.UTF-8', 00:04:54 INFO - 'LANGUAGE': 'en_US:en', 00:04:54 INFO - 'LOGNAME': 'cltbld', 00:04:54 INFO - 'MAIL': '/var/mail/cltbld', 00:04:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:04:54 INFO - 'MOZ_NO_REMOTE': '1', 00:04:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:04:54 INFO - 'NO_EM_RESTART': '1', 00:04:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:04:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:04:54 INFO - 'PWD': '/builds/slave/test', 00:04:54 INFO - 'SHELL': '/bin/bash', 00:04:54 INFO - 'SHLVL': '1', 00:04:54 INFO - 'TERM': 'linux', 00:04:54 INFO - 'TMOUT': '86400', 00:04:54 INFO - 'USER': 'cltbld', 00:04:54 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467874808.201413-564417626', 00:04:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:04:54 INFO - '_': '/tools/buildbot/bin/python'} 00:04:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:04:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:04:54 INFO - Cleaning up... 00:04:54 INFO - Return code: 0 00:04:54 INFO - Running post-action listener: _resource_record_post_action 00:04:54 INFO - Running post-action listener: _start_resource_monitoring 00:04:54 INFO - Starting resource monitoring. 00:04:54 INFO - ##### 00:04:54 INFO - ##### Finished create-virtualenv step (success) 00:04:54 INFO - ##### 00:04:54 INFO - ##### 00:04:54 INFO - ##### Running install step. 00:04:54 INFO - ##### 00:04:54 INFO - Running pre-action listener: _resource_record_pre_action 00:04:54 INFO - Running main action method: install 00:04:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:04:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:04:54 INFO - Reading from file tmpfile_stdout 00:04:54 INFO - Detecting whether we're running mozinstall >=1.0... 00:04:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:04:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:04:54 INFO - Reading from file tmpfile_stdout 00:04:54 INFO - Output received: 00:04:54 INFO - Usage: mozinstall [options] installer 00:04:54 INFO - Options: 00:04:54 INFO - -h, --help show this help message and exit 00:04:54 INFO - -d DEST, --destination=DEST 00:04:54 INFO - Directory to install application into. [default: 00:04:54 INFO - "/builds/slave/test"] 00:04:54 INFO - --app=APP Application being installed. [default: firefox] 00:04:54 INFO - mkdir: /builds/slave/test/build/application 00:04:54 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'] 00:04:54 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 00:05:11 INFO - Reading from file tmpfile_stdout 00:05:11 INFO - Output received: 00:05:11 INFO - /builds/slave/test/build/application/firefox/firefox 00:05:11 INFO - Running post-action listener: _resource_record_post_action 00:05:11 INFO - ##### 00:05:11 INFO - ##### Finished install step (success) 00:05:11 INFO - ##### 00:05:11 INFO - ##### 00:05:11 INFO - ##### Running run-tests step. 00:05:11 INFO - ##### 00:05:11 INFO - Running pre-action listener: _resource_record_pre_action 00:05:11 INFO - Running main action method: run_tests 00:05:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:05:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:05:11 INFO - Python 2.7.3 00:05:11 INFO - Return code: 0 00:05:11 INFO - grabbing minidump binary from tooltool 00:05: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')]} 00:05:11 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 0x24bb3b0>, '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 0x24bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bc740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:05:11 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 00:05:11 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 00:05:11 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 00:05:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:05:11 INFO - Return code: 0 00:05:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:05:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:05:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:05:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:05:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:05:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aYFmiwosQTy6wQe4dNiUhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 00:05:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aYFmiwosQTy6wQe4dNiUhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 00:05:11 INFO - Using env: {'DISPLAY': ':0', 00:05:11 INFO - 'HOME': '/home/cltbld', 00:05:11 INFO - 'LANG': 'en_US.UTF-8', 00:05:11 INFO - 'LANGUAGE': 'en_US:en', 00:05:11 INFO - 'LOGNAME': 'cltbld', 00:05:11 INFO - 'MAIL': '/var/mail/cltbld', 00:05:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:05:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:05:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:11 INFO - 'MOZ_NO_REMOTE': '1', 00:05:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:05:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:05:11 INFO - 'NO_EM_RESTART': '1', 00:05:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:05:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:11 INFO - 'PWD': '/builds/slave/test', 00:05:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:05:11 INFO - 'SHELL': '/bin/bash', 00:05:11 INFO - 'SHLVL': '1', 00:05:11 INFO - 'TERM': 'linux', 00:05:11 INFO - 'TMOUT': '86400', 00:05:11 INFO - 'USER': 'cltbld', 00:05:11 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467874808.201413-564417626', 00:05:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:11 INFO - '_': '/tools/buildbot/bin/python'} 00:05:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aYFmiwosQTy6wQe4dNiUhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 00:05:11 INFO - mozversion application_buildid: 20160706234023 00:05:11 INFO - mozversion application_changeset: b9cc2dcbf4363c8049183110fe79e026fae87ecb 00:05:11 INFO - mozversion application_display_name: Nightly 00:05:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:05:11 INFO - mozversion application_name: Firefox 00:05:11 INFO - mozversion application_remotingname: firefox 00:05:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:05:11 INFO - mozversion application_vendor: Mozilla 00:05:11 INFO - mozversion application_version: 50.0a1 00:05:11 INFO - mozversion platform_buildid: 20160706234023 00:05:11 INFO - mozversion platform_changeset: b9cc2dcbf4363c8049183110fe79e026fae87ecb 00:05:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:05:11 INFO - mozversion platform_version: 50.0a1 00:05:11 INFO - using testdate: 1467875111 00:05:11 INFO - actual date: 1467875111 00:05:11 INFO - starting webserver on 'localhost:60198' 00:05:11 INFO - SUITE-START | Running 2 tests 00:05:11 INFO - TEST-START | dromaeo_css 00:05:11 INFO - operating with platform_type : linux_ 00:05:11 INFO - Initialising browser for dromaeo_css test... 00:05:11 INFO - TEST-INFO | started process 15472 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEQEyIE/profile http://localhost:60198/getInfo.html) 00:05:15 INFO - PROCESS | 15472 | __metrics Screen width/height:1600/1200 00:05:15 INFO - PROCESS | 15472 | colorDepth:24 00:05:15 INFO - PROCESS | 15472 | Browser inner width/height: 1024/697 00:05:15 INFO - PROCESS | 15472 | __metrics 00:05:16 INFO - PROCESS | 15472 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:05:17 INFO - TEST-INFO | 15472: exit 0 00:05:17 INFO - Browser initialized. 00:05:17 INFO - Running cycle 1/1 for dromaeo_css test... 00:05:17 INFO - TEST-INFO | started process 15554 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEQEyIE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:05:29 INFO - PROCESS | 15554 | RSS: Main: 159547392 00:05:29 INFO - PROCESS | 15554 | 00:06:20 INFO - PROCESS | 15554 | 1467875180553 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] 00:08:33 INFO - PROCESS | 15554 | Cycle 1(1): loaded http://localhost:60198/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60198/tests/dromaeo/cssquery-ext.html) 00:08:35 INFO - PROCESS | 15554 | RSS: Main: 274243584 00:08:35 INFO - PROCESS | 15554 | 00:11:37 INFO - PROCESS | 15554 | Cycle 1(1): loaded http://localhost:60198/tests/dromaeo/cssquery-ext.html (next: http://localhost:60198/tests/dromaeo/cssquery-jquery.html) 00:11:38 INFO - PROCESS | 15554 | RSS: Main: 239316992 00:11:38 INFO - PROCESS | 15554 | 00:14:40 INFO - PROCESS | 15554 | Cycle 1(1): loaded http://localhost:60198/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60198/tests/dromaeo/cssquery-mootools.html) 00:14:41 INFO - PROCESS | 15554 | RSS: Main: 241020928 00:14:41 INFO - PROCESS | 15554 | 00:17:43 INFO - PROCESS | 15554 | Cycle 1(1): loaded http://localhost:60198/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60198/tests/dromaeo/cssquery-prototype.html) 00:17:44 INFO - PROCESS | 15554 | RSS: Main: 234360832 00:17:44 INFO - PROCESS | 15554 | 00:20:47 INFO - PROCESS | 15554 | Cycle 1(1): loaded http://localhost:60198/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60198/tests/dromaeo/cssquery-yui.html) 00:20:47 INFO - PROCESS | 15554 | RSS: Main: 216510464 00:20:47 INFO - PROCESS | 15554 | 00:23:50 INFO - PROCESS | 15554 | Cycle 1(1): loaded http://localhost:60198/tests/dromaeo/cssquery-yui.html (next: http://localhost:60198/tests/dromaeo/cssquery-dojo.html) 00:23:51 INFO - PROCESS | 15554 | RSS: Main: 304734208 00:23:51 INFO - PROCESS | 15554 | 00:23:51 INFO - PROCESS | 15554 | __start_tp_report 00:23:51 INFO - PROCESS | 15554 | _x_x_mozilla_page_load 00:23:51 INFO - PROCESS | 15554 | _x_x_mozilla_page_load_details 00:23:51 INFO - PROCESS | 15554 | |i|pagename|runs| 00:23:51 INFO - PROCESS | 15554 | |0;dojo.html;2669.2259244819;2678.290253082932;2705.418335057962;2716.8369897806147;2718;4717.646176536757;4763.166445871967;4798.568128868401;4852.733099679516;4860.708357498548;4811.687240329385;4817.9759101204445;4866.367372241612;4882.316475693406;4952.479989601094;4376.168527979674;4401.515833258347;4468.865934021985;4523.773811309437;4606.884827879297;4512.864614061567;4556.20266453371;4571.108633816407;4581.725096494204;4588.793504292298;4381.277089280265;4418.6023257906945;4427.933580996288;4440.400545926291;4491.214037543416;4420.646348292129;4424.668149888771;4432.911341773179;4477.955220447787;4491.505934347219;4392.4289842320295;4440.2895536714295;4442.2892337225885;4445.688801783876;4480.350349199381;4711.199096153662;4810.63920205986;4826.444958829745;4885.853424397274;4889.193283108283;5103.795848166106;5153.201253805666;5160.638755287131;5230.712310822903;5234.398044224925;5199.454057324002;5235.450277720823;5236.8690782730355;5243.947560524384;5264.31563896691;4673.948361618676;4816.157172494799;4853.781579828917;4864.0028794097125;4866.270059491105;5309.5752339812725;5333.893322133613;5385.084535628874;5387.488188622075;5412.079946409041;5110.770015349318;5120.795168193231;5154.814392689627;5169.870753231199;5172.818951336685;4984.775685094107;5125.282460455539;5182.196759502283;5245.895082098336;5296.523312901781;5115.825774046016;5137.8715532112;5151.896962060813;5165.1219292720325;5191.402988656353;5099.97450012755;5114.360704911886;5116.462771409023;5120.692758434506;5129.333186685707;4229.429027081366;4259.680523960654;4292.613664770186;4329.264025115738;4340.47914250292;3781.243751249761;3806.695464362844;3819.0261483321574;3834.213986132836;3859.286032084073;4458.264386376211;4468.151051300308;4474.306482495218;4488.057507923372;4516.209663308908;5030.471800460972;5089.541941225233;5146.819861304836;5192.4807519248525;5209.322788037531;4451.154280686659;4458.554144585581;4461.308497182942;4484.417025786692;4504.189245935698;4649.5350464953235;4658.277966915133;4662.650301227422;4675.649326300541;4723.031778485402;4733.597644200281;4852.417709874838;4880.951190488192;4888.633352498506;4905.166121759309;5175.068487672255;5185.714785686823;5195.532402083831;5196.2465442509865;5203.947960520346;4872.439669437918;4892.2661600760175;4918.827841025547;4922.65541412112;4930.137225985366;4926.261060840902;4991.226359914219;5013.24801279811;5049.899002020013;5057.443681194992;5103.081445339874;5104.2088476286235;5121.436641969455;5123.666961647481;5174.404943431554;4835.081334546425;5006.649534532694;5017.147084995632;5030;5033.169527028;4913.729744864067;4939.333190019302;4941.777620007037;4959.851204463872;4985.277134815359;4903.901921961469;4916.950830491649;4923.507649235048;4971.676841005323;4976.726280054487;4883.389576302962;4962.776675049559;4992.675476094188;5016.2224855147515;5026.4973502649445;4772.141014617402;4799.1601469743355;4816.614670826255;4857.077155340474;4857.732824694675 00:23:51 INFO - PROCESS | 15554 | |1;ext.html;541.5609049840095;580.9215755872958;586.0915580849684;587.1896782440232;590.2091197794955;39920.80039599801;41232.79383603082;41375.58624413755;41402.58597414029;45068.54931450685;40362.59637403625;40740.79629601848;40852.591474085326;40910.18179636406;40935.79532102343;7491.175970643225;7948.966634337543;8069.273765361117;8089.271965523102;10262.794744105113;10193.082622563968;10611.151107911388;10612.946935265312;10614.097801686827;10614.522346494427;10628.256022078458;10654.4140072296;10671.78656426871;10674.733131671692;10678.839817402744;7624.847503049936;7774.105977812511;7775.455718099735;10385.42880141592;10538.631147909824;10122.089011988955;10484.108850747696;10512.579496820117;10517;10529.262951593391;39012.80493597542;39342.60657393418;39426.21147577061;39486.40770388446;39489.80255098735;2986.596809430721;3001.2496875781053;3048.6189226346705;3091.9536206956914;3452.654734526527;30260.0921972339;30789.538156927665;31116.910908118334;31398.686013139806;31988;3493.6681015303507;3553.8400771965325;3582.5880023797336;3585.8565657373674;3678.4666223397726;266689;267588.63439779513;267928;269044;269076;32793.67206327954;33817.15457113592;56530;57147.42852571504;57177;35004.47493287603;35139.7701080461;35141;35161.47257791135;35245.64754352475;13952.720945581235;14076.929615351857;14089.71820563583;14093.083949543452;14095.647608809863;10474.266801323987;11434.771304574027;11642.126840486828;11660.88339116615;11997.160198786001;8088.150744171895;8123.83752324962;8154.5514996674565;8207.507549547046;8208.58957052145;3155.857986390618;3184.7611429142908;3191.632962209376;3197.7122059014337;3226.8547915343865;858.7166235142388;899.865020246955;918.7749001494676;952.514217748953;988.2538683294067;28165.295867603472;29307;29474.705252947195;29665.703342966295;29899.25251868677;903.8915330160423;932.147085416836;960.5629438605557;1002.2232769603615;1020.6580795433464;15247.313870875838;15558.766618500731;15653.295601697951;15788.763168552481;15897.682046359008;409460;411243;412104;412870;413686;50393.24410133851;50762;50808.74595626998;50871.23693144606;50992;1086.7120213143364;1127.639155470258;1172.4958267944864;1182.3437991914398;1229.3853073463267;28659;29208.123756287347;29551;30164.396712065198;30661.386772264876;43227.135457291304;43557;43622.34566481442;43647.56352436435;43784;308409;308986;309807;310067;310998;25086.811145510837;26325.07862224813;26593.202203933914;26699.19902402931;26704.599431008937;42232.788836055624;42353;43194.35208471938;44090.33864491971;44300.33549496825;36145.457818133276;37208.62791372051;37230.90460049447;37813.86558403252;37949.241015180094;36721;36926.815365923;37530.62469375271;38767.418488723255;39133.60866391299;37250.627493724714;37447.62552374441;39264.80367598258;39472.40791388074;40867.386989194594;31967;33615.879668111986;33763.493547596314;34259.486107707904;34723;25809.870950645876;26188.476230475666;26291.4741705161;26392.472150557267;26431.735682642928 00:23:51 INFO - PROCESS | 15554 | |2;jquery.html;350.3133857639027;368.13488302489156;371.6450789496031;377.04795391636117;385.28721864550585;13034.413451394686;16402.671946561077;17024.23390947409;18323;18357.7246341305;15813.130277834744;16103.516894493185;17491;17559.122043897816;17884.910575447106;5039.77321020555;5159.71621560814;5460.645058071233;5461.972690136544;5572.247746554204;3377.3414184234084;5053.736565858535;5347.358317001966;5363.597730170233;5488.313960754906;5338.67967921924;5339.733013349336;5364.6512976656395;5376.059189641816;5377.193420986844;5195.142801437758;5323.893522129555;5484.8354549363585;5490.588205884575;5574.86062848428;5377.462253774591;5383.16560933056;5398.055340315468;5398.055340315468;5399;12571.120021598492;16106.953048051839;20307.79692203074;21277.89361053185;21403.892980535154;1863.3757691173473;1923.3460623388116;2013.315472739261;2290.0839664134314;2340.2745149003863;8798.736037918872;8821.867671984925;8850.336224783166;9193.908060919372;9318.30112741547;1685.3764107280263;1693.6274019715643;1751.7284820852788;1754.8332908373684;1844.8985305808176;69631;71778.28221717768;72426.27573724248;73700.6314968427;74636;9002.36983411168;9433.339666223435;10175.898241017496;10235.641752538775;10366.993571864226;13557.712017358335;13561.186328820302;13629.454821807214;13715.794263086062;13742.862571374359;7069.8939515907305;7095.609741464269;7150.034745309421;7392.075990501187;7457.216992215739;6987.615681137586;6996.055532503149;7028.648567571601;7108.3957863581145;7217.675204615805;4157.667386609064;4306.633936115402;4376.606105450524;4421.226285400042;4497.235469970113;1768.5843826700716;1806.6296409236074;1817.9000154991338;1870.7652949053831;1875.4561177258715;833.9416240863203;895.8477058900003;930.6975233049286;957.8563215517589;959.5825815770023;17757.200925958365;17797.19912603936;17921.257800146745;17945.910270448825;18071.72892406615;849.3544905871458;881.3742243007408;881.7927786970057;907.582512044467;911.5123408976166;9626.566804493814;9699.70900872975;9978.700638980843;10064;10143.137833284254;377233;393756;394993;395996;396730;78177;79631;79995.60002199952;80260;80328.59835700784;912.3886995712888;915.9450432974043;919.7792529792802;939.0609390609391;941.6280569175137;15555.066695998275;15872.52382428529;15965.760513592073;15972.8402715976;16366.590835229215;26319.736802632495;38665.6133438662;39249.41125883057;39374.80312598419;39691.40462893001;48577.27134093062;50896.74551627218;51138.48861511486;51477;51697.7415112922;6851.177858656993;7660.157382687788;7721.073471183494;7734.342580880463;7815.218478152139;10912.945435272773;11925.522979080739;12245.834122797296;12415.44130514147;12694;10593.629222977466;10604.787904241717;10607;10725.141988641046;10903.618373356894;10534.420606866695;10837.67486975392;10950.507227174638;11080.113590912546;11155.44222788841;10454.163666906781;10738.892611073788;10832.079273261861;10915.072218861485;11134.944325278646;7599.962000189964;7719.768406947801;7786.299233069051;7882.7241046563095;7885.053793544811;8874.51190184546;10479.266451348638;10487.94756026215;10576.259661823598;10929 00:23:51 INFO - PROCESS | 15554 | |3;mootools.html;1341.7584834729748;1410.0200360749277;1476.4979906831675;1698.957526061849;1716.613761903572;7717.035370578677;8149.062857771358;8156.959215203923;8221.38339624529;8239.217274358927;6983.127109111361;7190.9640451797795;7738.110117336508;7990.520568765864;8113.594320283992;2225.643896976484;2249.156566287642;2251.189571754167;2254.0983606557425;2257.559775843711;2214.5017371091535;2224.254874617005;2265.501589650274;2265.796078352948;2268;1926.7687877454655;2206.227820262903;2254.616715158427;2260.0394832196334;2287.0280130944366;2223.2218723446663;2224.510607666311;2243.5064285857165;2247.674087257355;2253.177590179589;2225.543763528473;2229.141780414536;2231.843770936035;2231.933042008742;2236.2396785093147;8220.465669731448;8268;8275.917240827575;8279.8344033119;8289.751307460785;4528.366028755977;4537.909241815179;4663.044075964419;4687.718736875764;4688.671792974493;2869.569564565311;2896.826190428581;2946.1456177708437;2950.8081974671577;2958.40831833632;930.6370515498961;943.4056544377067;953.1040821627718;953.6662168241129;955.4744890310302;11074.335539867634;11130.276532025393;11141.72145696356;11143.387113708743;11159;4148.315527937856;4284.700070995001;4393.51671316155;4398.076403955205;4461.5092339842595;9439.197668198143;9468.715938521718;9489.478078705737;9506.382085164441;9519.143277105093;4815.686980346266;4817.78319975602;4820.39745031871;4820.71075735457;4821.927671084936;4226.894327641772;4270.188664153801;4286.892827679333;4303.1608836277255;4339.848105316299;3728.7203459740085;3745.382011968049;3752.924941501209;3817.2747178036084;3859.3246181918053;1071.5499490214129;1148.5520646947698;1161.651504548649;1167.2646232873406;1196.9461374238006;629.361198383641;769.3806485779002;796.5698522797625;826.1738261738262;834.845553572591;5251.501107394792;5308.495692909168;5439.673619582759;5549.0289199389945;5553.6390134641115;867.6746220167437;880.9383343165916;887.8845750052581;893.5264309915755;897.2014906733012;3728.8508459661853;3729.645683660048;3737.831797569116;3787.0721673190246;3812.4471951566866;9589.760255993657;10010.299279050541;10155.695329140137;10179.898201017895;10195.337303075275;8769.649214031368;9088.681896133603;9925.553350099262;9934.354266972623;9940.652077177265;6857.55425897315;6977.965110174417;7141.500094993301;7442.218567050381;7449.180590135081;5734.5125664319;5743.0811070228565;5812.622179558315;5829.242198514166;6021.87956240864;9315.906840931775;9438.57526411327;9446.905530944603;9467.66863159786;9471.289653275893;9344;9515.33392662507;9620.470874101711;9715.9028409715;9772.706818795448;6919.723211071702;6943.930560694328;6987.650617469208;6995.055667484824;7000.264972178052;7409.073865766779;7637.121731001006;7715.035620547432;7716.845663086595;7722.53664780115;5741.080165506934;6024.487918526975;6951.965240173767;7061.540999834994;7197.064381630564;6969.477289203229;7052.259512751088;7104.680289386886;7179.389751871149;7222.025026621549;6526.641034743135;6560.3111673273615;6561.967190164019;6588.143541339595;6594.307597702172;4030.496187976503;4132.669386449017;4173.332266837291;4195.97902010488;4209.389638502339;4580.312953056935;4605.194091033989;4625;4637.6521760868745;4680.017196388796 00:23:51 INFO - PROCESS | 15554 | |4;prototype.html;287.9006742673777;290.9127261821454;293.36632872994335;301.2679189569346;301.87924830067954;4853.44185418677;4890.290907818364;4908.214685650297;4923.409190897093;4924.039812236615;4823.155947709154;4833.419989601244;4842.515748425156;4849.369581954341;4853.951460485394;3603.099225193695;3671.7613355131966;3721.869734559291;3804.258169656918;3846.346121159396;3787.110029143149;3797.8670746523876;3802.1065049713297;3818.293615681094;3841.519810023747;3604.819759012039;3774.7168962327937;3781.5840257571645;3789.749382703715;3789.9431508527396;3667.8532858685753;3806.7144964127665;3823.5411750590106;3824.8661296854475;3832.693384529231;3370.1911541230174;3377.9155521111925;3380.053584996205;3385.627580966092;3399.3031428557088;4777.450593181794;4792.520747925215;4793.113274044313;4793.400824896888;4809.062232864593;4244.427002354673;4360.4331436913;4365.690292912113;4370.7159034662645;4390.780460976938;5031.32077169581;5037.899242015176;5061.089003979282;5089.41471730752;5112.872178195537;3656.287024030315;3665.5601327840563;3665.5784584772828;3672.7796332219887;3691.7231207659534;5068.949310506885;5254.97372513135;5261.973690131563;5327.762339817286;5357.812476563302;3717.423799311111;3738.85044598213;3739.270842185802;3751.756135851161;3754.549454065475;3783.432485127198;3784.1674831537016;3790.507234059555;3794.317022935898;3795.0891785971166;4309.741415515079;4316.460442444694;4319.762413067248;4321.6974811762875;4332.285172946428;4866.78099485524;5032.421271553745;5036.647434679538;5045.41977672565;5057.443681195065;1294.4822071171418;1314.7764879970428;1315.2963164706837;1319.9142055766345;1322.107577385261;835.7839343754944;847.4406891451736;855.9471849624996;866.1728049712635;866.6220709072605;4361.454818147731;4390.8902277442685;4465.26323156682;4498.415206023262;4514.706544074625;5210.218467229945;5212.976473645276;5222.582193424517;5223.764930578133;5250.343707036621;4309.396684464177;4487.640988720895;4491.640668746492;4512.706674066175;4542.409486766699;2767.5571908494544;2781.596668483099;2791.9302017449727;2797.4684809886057;2799.510085734988;4965.428975667773;4979.601631869442;4981.775820088104;4986.850394488171;4990.70241737151;5135.460776618476;5343.812966546152;5367.570594352443;5427.294451721251;5432.837014889559;4987.875303117451;5000.374953130859;5002.299678045077;5002.574781143498;5015.17249653803;5299.33758280215;5329.855385322679;5338.652987555796;5360.383555891122;5379.731013449234;4917.213245880785;5180.507851754077;5194.662346947436;5194.7922083116255;5218.582513398995;4971.477994810492;4971.9254211186135;4982.800687972585;4987.177115775857;5016.724080175625;3686.152184997412;3697.186618943828;3698.3158115748674;3705.833237504373;3707.0917625182;5126.384833819965;5203;5211.9478805211465;5240.502152295526;5315.255864179096;5040.697558146523;5052.5705315048635;5063.645544811828;5068.391792984866;5069.467705890976;5055.570276526537;5099.56653684441;5122.795088196431;5137.640365174402;5140.331756871583;4767.928481072856;4868.17241069012;5017.523335283142;5028.145215313332;5041;4910.386201724785;5074.391073071255;5076.7207803571155;5080.745962701924;5084.8220312288895;4913.90424032857;4919.409670839522;4953.7523123844385;4982.480343495269;4995.650304478797 00:23:51 INFO - PROCESS | 15554 | |5;yui.html;623.5043140703141;639.875224331255;647.2685864972581;705.3616477088235;715.2333735672889;12457.937710311448;13438.32808359583;13457.7308453831;13473;13486.25825579594;12738.426770795313;13121.475140994373;13155.079144459867;13168.73662526749;13188.736225275488;617.6016469377249;629.2606187729423;765.5980610179645;782.8238646304565;784.752802867095;761.7676608634392;770.7225398856407;774.2953911940135;783.7335305995961;784.1531146361943;819.942604017719;821.256762629818;822.1942496353547;823.7158180427742;824.2416976381713;642.1972534332085;792.2711105782694;802.7912742686885;814.7474282972267;815.1563132158218;595.910613407988;597.7340083662772;598.8413070536311;599.5233789137646;600.1208229943111;12877.67805804853;12893.033022523254;12899.419526121346;12907.870921290762;12925.224486530838;11761.235519691192;12233.266004039786;12704.872951270461;12866.035047371484;13109.47562097515;11917.523299068027;11940.402979850973;11946.701332466671;11976.221545599508;12252.142350035501;4176.0058974129015;4188.706790524665;4216.599423054836;4232.597903199191;4369.4756629204385;61665.691671541805;62953.685231574;62999.37000630027;63017.36982630207;63077.36922630761;9149.908500915039;9175.495347755805;9439.150476457151;9535;9761.755956101155;16887.408940687015;17131.828681713272;17156.65686686259;17185.914070429568;17191.1404429778;6592.86814263712;6621.801345959629;6651.86696266072;6696.0960270362875;6799.592024478448;3506.1935754776546;3604.5133906922756;3608.9458658120147;3609.7473176877893;3679.4296883983025;2839.886404543795;2926.7512261457587;2932.9706702933127;2958;2963.0222026731126;517.3972322244618;519.4623564610686;527.0855066459766;528.4794477439718;528.8889333239986;422.89834979877594;530.3847536857227;540.4388838848286;619.7025427794593;631.1069836181844;8608;8808.075152109064;8884.555772211364;8944.552772361487;9103.590338434655;488.83868323453174;500.9223570346602;534.4628648208526;587.5681374189967;605.4429924469499;3990.615015974418;4068.3158763788933;4228.70399072062;4247.915041699149;4267.97866010668;86206;87068.25863482822;92954.53522732478;93777;93801;81826.59086704528;82172;83160;83726.581367094;87549;45891;70018.2998170022;70874.2912570878;74007.62996184985;74877;7736.149023607286;7750.379969602305;7844.646990885538;7952.92047079545;7980.002499687539;30976.53535197019;31433;38748.80625596854;38829.41755873721;45164.32253516265;41243.38134927918;59693;60524;60790;62223.6888815553;10350.844737328796;10808.18938579594;10839.458027098772;11318.09455243595;11560.42197890119;13079;13081.672958176121;13495.527656531975;13626.318684065558;14038.1577105374;12178.695532611755;12223.501846630508;12766.744665106831;12994.35028248565;13130.671733206364;12517.374131293582;12569.874301257236;12770;12775.680607984874;12899.806502902651;11646.24299420535;11965.641030769091;12245.326507042199;12331;12459.937700311802;9864;10263.640772572924;10296.661434013531;10305.175585953255;11027.283226590567;9757.26820488452;9779.608815647294;9823.557939892866;9988.101070903653;10069.446180460145 00:23:51 INFO - PROCESS | 15554 | __end_tp_report 00:23:51 INFO - PROCESS | 15554 | __start_cc_report 00:23:51 INFO - PROCESS | 15554 | _x_x_mozilla_cycle_collect,1087 00:23:51 INFO - PROCESS | 15554 | __end_cc_report 00:23:51 INFO - PROCESS | 15554 | __startTimestamp1467876231135__endTimestamp 00:23:51 INFO - PROCESS | 15554 | 00:23:51 INFO - PROCESS | 15554 | ------- Summary: start ------- 00:23:51 INFO - PROCESS | 15554 | Number of tests: 6 00:23:51 INFO - PROCESS | 15554 | 00:23:51 INFO - PROCESS | 15554 | [#0] dojo.html Cycles:165 Average:4767.97 Median:4883.39 stddev:497.59 (10.2%) stddev-sans-first:471.09 00:23:51 INFO - PROCESS | 15554 | Values: 2669.2 2678.3 2705.4 2716.8 2718.0 4717.6 4763.2 4798.6 4852.7 4860.7 4811.7 4818.0 4866.4 4882.3 4952.5 4376.2 4401.5 4468.9 4523.8 4606.9 4512.9 4556.2 4571.1 4581.7 4588.8 4381.3 4418.6 4427.9 4440.4 4491.2 4420.6 4424.7 4432.9 4478.0 4491.5 4392.4 4440.3 4442.3 4445.7 4480.4 4711.2 4810.6 4826.4 4885.9 4889.2 5103.8 5153.2 5160.6 5230.7 5234.4 5199.5 5235.5 5236.9 5243.9 5264.3 4673.9 4816.2 4853.8 4864.0 4866.3 5309.6 5333.9 5385.1 5387.5 5412.1 5110.8 5120.8 5154.8 5169.9 5172.8 4984.8 5125.3 5182.2 5245.9 5296.5 5115.8 5137.9 5151.9 5165.1 5191.4 5100.0 5114.4 5116.5 5120.7 5129.3 4229.4 4259.7 4292.6 4329.3 4340.5 3781.2 3806.7 3819.0 3834.2 3859.3 4458.3 4468.2 4474.3 4488.1 4516.2 5030.5 5089.5 5146.8 5192.5 5209.3 4451.2 4458.6 4461.3 4484.4 4504.2 4649.5 4658.3 4662.7 4675.6 4723.0 4733.6 4852.4 4881.0 4888.6 4905.2 5175.1 5185.7 5195.5 5196.2 5203.9 4872.4 4892.3 4918.8 4922.7 4930.1 4926.3 4991.2 5013.2 5049.9 5057.4 5103.1 5104.2 5121.4 5123.7 5174.4 4835.1 5006.6 5017.1 5030.0 5033.2 4913.7 4939.3 4941.8 4959.9 4985.3 4903.9 4917.0 4923.5 4971.7 4976.7 4883.4 4962.8 4992.7 5016.2 5026.5 4772.1 4799.2 4816.6 4857.1 4857.7 00:23:51 INFO - PROCESS | 15554 | 00:23:51 INFO - PROCESS | 15554 | [#1] ext.html Cycles:180 Average:48152.67 Median:19087.83 stddev:88367.70 (463.0%) stddev-sans-first:88543.29 00:23:51 INFO - PROCESS | 15554 | Values: 541.6 580.9 586.1 587.2 590.2 39920.8 41232.8 41375.6 41402.6 45068.5 40362.6 40740.8 40852.6 40910.2 40935.8 7491.2 7949.0 8069.3 8089.3 10262.8 10193.1 10611.2 10612.9 10614.1 10614.5 10628.3 10654.4 10671.8 10674.7 10678.8 7624.8 7774.1 7775.5 10385.4 10538.6 10122.1 10484.1 10512.6 10517.0 10529.3 39012.8 39342.6 39426.2 39486.4 39489.8 2986.6 3001.2 3048.6 3092.0 3452.7 30260.1 30789.5 31116.9 31398.7 31988.0 3493.7 3553.8 3582.6 3585.9 3678.5 266689.0 267588.6 267928.0 269044.0 269076.0 32793.7 33817.2 56530.0 57147.4 57177.0 35004.5 35139.8 35141.0 35161.5 35245.6 13952.7 14076.9 14089.7 14093.1 14095.6 10474.3 11434.8 11642.1 11660.9 11997.2 8088.2 8123.8 8154.6 8207.5 8208.6 3155.9 3184.8 3191.6 3197.7 3226.9 858.7 899.9 918.8 952.5 988.3 28165.3 29307.0 29474.7 29665.7 29899.3 903.9 932.1 960.6 1002.2 1020.7 15247.3 15558.8 15653.3 15788.8 15897.7 409460.0 411243.0 412104.0 412870.0 413686.0 50393.2 50762.0 50808.7 50871.2 50992.0 1086.7 1127.6 1172.5 1182.3 1229.4 28659.0 29208.1 29551.0 30164.4 30661.4 43227.1 43557.0 43622.3 43647.6 43784.0 308409.0 308986.0 309807.0 310067.0 310998.0 25086.8 26325.1 26593.2 26699.2 26704.6 42232.8 42353.0 43194.4 44090.3 44300.3 36145.5 37208.6 37230.9 37813.9 37949.2 36721.0 36926.8 37530.6 38767.4 39133.6 37250.6 37447.6 39264.8 39472.4 40867.4 31967.0 33615.9 33763.5 34259.5 34723.0 25809.9 26188.5 26291.5 26392.5 26431.7 00:23:51 INFO - PROCESS | 15554 | 00:23:51 INFO - PROCESS | 15554 | [#2] jquery.html Cycles:180 Average:24536.82 Median:4232.15 stddev:64802.50 (1531.2%) stddev-sans-first:64958.84 00:23:51 INFO - PROCESS | 15554 | Values: 350.3 368.1 371.6 377.0 385.3 13034.4 16402.7 17024.2 18323.0 18357.7 15813.1 16103.5 17491.0 17559.1 17884.9 5039.8 5159.7 5460.6 5462.0 5572.2 3377.3 5053.7 5347.4 5363.6 5488.3 5338.7 5339.7 5364.7 5376.1 5377.2 5195.1 5323.9 5484.8 5490.6 5574.9 5377.5 5383.2 5398.1 5398.1 5399.0 12571.1 16107.0 20307.8 21277.9 21403.9 1863.4 1923.3 2013.3 2290.1 2340.3 8798.7 8821.9 8850.3 9193.9 9318.3 1685.4 1693.6 1751.7 1754.8 1844.9 69631.0 71778.3 72426.3 73700.6 74636.0 9002.4 9433.3 10175.9 10235.6 10367.0 13557.7 13561.2 13629.5 13715.8 13742.9 7069.9 7095.6 7150.0 7392.1 7457.2 6987.6 6996.1 7028.6 7108.4 7217.7 4157.7 4306.6 4376.6 4421.2 4497.2 1768.6 1806.6 1817.9 1870.8 1875.5 833.9 895.8 930.7 957.9 959.6 17757.2 17797.2 17921.3 17945.9 18071.7 849.4 881.4 881.8 907.6 911.5 9626.6 9699.7 9978.7 10064.0 10143.1 377233.0 393756.0 394993.0 395996.0 396730.0 78177.0 79631.0 79995.6 80260.0 80328.6 912.4 915.9 919.8 939.1 941.6 15555.1 15872.5 15965.8 15972.8 16366.6 26319.7 38665.6 39249.4 39374.8 39691.4 48577.3 50896.7 51138.5 51477.0 51697.7 6851.2 7660.2 7721.1 7734.3 7815.2 10912.9 11925.5 12245.8 12415.4 12694.0 10593.6 10604.8 10607.0 10725.1 10903.6 10534.4 10837.7 10950.5 11080.1 11155.4 10454.2 10738.9 10832.1 10915.1 11134.9 7600.0 7719.8 7786.3 7882.7 7885.1 8874.5 10479.3 10487.9 10576.3 10929.0 00:23:51 INFO - PROCESS | 15554 | 00:23:51 INFO - PROCESS | 15554 | [#3] mootools.html Cycles:180 Average:5283.18 Median:5374.08 stddev:2994.96 (55.7%) stddev-sans-first:2988.72 00:23:51 INFO - PROCESS | 15554 | Values: 1341.8 1410.0 1476.5 1699.0 1716.6 7717.0 8149.1 8157.0 8221.4 8239.2 6983.1 7191.0 7738.1 7990.5 8113.6 2225.6 2249.2 2251.2 2254.1 2257.6 2214.5 2224.3 2265.5 2265.8 2268.0 1926.8 2206.2 2254.6 2260.0 2287.0 2223.2 2224.5 2243.5 2247.7 2253.2 2225.5 2229.1 2231.8 2231.9 2236.2 8220.5 8268.0 8275.9 8279.8 8289.8 4528.4 4537.9 4663.0 4687.7 4688.7 2869.6 2896.8 2946.1 2950.8 2958.4 930.6 943.4 953.1 953.7 955.5 11074.3 11130.3 11141.7 11143.4 11159.0 4148.3 4284.7 4393.5 4398.1 4461.5 9439.2 9468.7 9489.5 9506.4 9519.1 4815.7 4817.8 4820.4 4820.7 4821.9 4226.9 4270.2 4286.9 4303.2 4339.8 3728.7 3745.4 3752.9 3817.3 3859.3 1071.5 1148.6 1161.7 1167.3 1196.9 629.4 769.4 796.6 826.2 834.8 5251.5 5308.5 5439.7 5549.0 5553.6 867.7 880.9 887.9 893.5 897.2 3728.9 3729.6 3737.8 3787.1 3812.4 9589.8 10010.3 10155.7 10179.9 10195.3 8769.6 9088.7 9925.6 9934.4 9940.7 6857.6 6978.0 7141.5 7442.2 7449.2 5734.5 5743.1 5812.6 5829.2 6021.9 9315.9 9438.6 9446.9 9467.7 9471.3 9344.0 9515.3 9620.5 9715.9 9772.7 6919.7 6943.9 6987.7 6995.1 7000.3 7409.1 7637.1 7715.0 7716.8 7722.5 5741.1 6024.5 6952.0 7061.5 7197.1 6969.5 7052.3 7104.7 7179.4 7222.0 6526.6 6560.3 6562.0 6588.1 6594.3 4030.5 4132.7 4173.3 4196.0 4209.4 4580.3 4605.2 4625.0 4637.7 4680.0 00:23:51 INFO - PROCESS | 15554 | 00:23:51 INFO - PROCESS | 15554 | [#4] prototype.html Cycles:180 Average:4233.41 Median:4853.70 stddev:1227.47 (25.3%) stddev-sans-first:1194.66 00:23:51 INFO - PROCESS | 15554 | Values: 287.9 290.9 293.4 301.3 301.9 4853.4 4890.3 4908.2 4923.4 4924.0 4823.2 4833.4 4842.5 4849.4 4854.0 3603.1 3671.8 3721.9 3804.3 3846.3 3787.1 3797.9 3802.1 3818.3 3841.5 3604.8 3774.7 3781.6 3789.7 3789.9 3667.9 3806.7 3823.5 3824.9 3832.7 3370.2 3377.9 3380.1 3385.6 3399.3 4777.5 4792.5 4793.1 4793.4 4809.1 4244.4 4360.4 4365.7 4370.7 4390.8 5031.3 5037.9 5061.1 5089.4 5112.9 3656.3 3665.6 3665.6 3672.8 3691.7 5068.9 5255.0 5262.0 5327.8 5357.8 3717.4 3738.9 3739.3 3751.8 3754.5 3783.4 3784.2 3790.5 3794.3 3795.1 4309.7 4316.5 4319.8 4321.7 4332.3 4866.8 5032.4 5036.6 5045.4 5057.4 1294.5 1314.8 1315.3 1319.9 1322.1 835.8 847.4 855.9 866.2 866.6 4361.5 4390.9 4465.3 4498.4 4514.7 5210.2 5213.0 5222.6 5223.8 5250.3 4309.4 4487.6 4491.6 4512.7 4542.4 2767.6 2781.6 2791.9 2797.5 2799.5 4965.4 4979.6 4981.8 4986.9 4990.7 5135.5 5343.8 5367.6 5427.3 5432.8 4987.9 5000.4 5002.3 5002.6 5015.2 5299.3 5329.9 5338.7 5360.4 5379.7 4917.2 5180.5 5194.7 5194.8 5218.6 4971.5 4971.9 4982.8 4987.2 5016.7 3686.2 3697.2 3698.3 3705.8 3707.1 5126.4 5203.0 5211.9 5240.5 5315.3 5040.7 5052.6 5063.6 5068.4 5069.5 5055.6 5099.6 5122.8 5137.6 5140.3 4767.9 4868.2 5017.5 5028.1 5041.0 4910.4 5074.4 5076.7 5080.7 5084.8 4913.9 4919.4 4953.8 4982.5 4995.7 00:23:51 INFO - PROCESS | 15554 | 00:23:51 INFO - PROCESS | 15554 | [#5] yui.html Cycles:180 Average:17083.55 Median:518.43 stddev:23886.89 (4607.5%) stddev-sans-first:23921.93 00:23:51 INFO - PROCESS | 15554 | Values: 623.5 639.9 647.3 705.4 715.2 12457.9 13438.3 13457.7 13473.0 13486.3 12738.4 13121.5 13155.1 13168.7 13188.7 617.6 629.3 765.6 782.8 784.8 761.8 770.7 774.3 783.7 784.2 819.9 821.3 822.2 823.7 824.2 642.2 792.3 802.8 814.7 815.2 595.9 597.7 598.8 599.5 600.1 12877.7 12893.0 12899.4 12907.9 12925.2 11761.2 12233.3 12704.9 12866.0 13109.5 11917.5 11940.4 11946.7 11976.2 12252.1 4176.0 4188.7 4216.6 4232.6 4369.5 61665.7 62953.7 62999.4 63017.4 63077.4 9149.9 9175.5 9439.2 9535.0 9761.8 16887.4 17131.8 17156.7 17185.9 17191.1 6592.9 6621.8 6651.9 6696.1 6799.6 3506.2 3604.5 3608.9 3609.7 3679.4 2839.9 2926.8 2933.0 2958.0 2963.0 517.4 519.5 527.1 528.5 528.9 422.9 530.4 540.4 619.7 631.1 8608.0 8808.1 8884.6 8944.6 9103.6 488.8 500.9 534.5 587.6 605.4 3990.6 4068.3 4228.7 4247.9 4268.0 86206.0 87068.3 92954.5 93777.0 93801.0 81826.6 82172.0 83160.0 83726.6 87549.0 45891.0 70018.3 70874.3 74007.6 74877.0 7736.1 7750.4 7844.6 7952.9 7980.0 30976.5 31433.0 38748.8 38829.4 45164.3 41243.4 59693.0 60524.0 60790.0 62223.7 10350.8 10808.2 10839.5 11318.1 11560.4 13079.0 13081.7 13495.5 13626.3 14038.2 12178.7 12223.5 12766.7 12994.4 13130.7 12517.4 12569.9 12770.0 12775.7 12899.8 11646.2 11965.6 12245.3 12331.0 12459.9 9864.0 10263.6 10296.7 10305.2 11027.3 9757.3 9779.6 9823.6 9988.1 10069.4 00:23:51 INFO - PROCESS | 15554 | -------- Summary: end -------- 00:23:51 INFO - PROCESS | 15554 | 00:23:51 INFO - TEST-INFO | 15554: exit 0 00:23:51 INFO - TEST-OK | dromaeo_css | took 1120436ms 00:23:51 INFO - TEST-START | kraken 00:23:51 INFO - operating with platform_type : linux_ 00:23:51 INFO - Initialising browser for kraken test... 00:23:51 INFO - TEST-INFO | started process 15748 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCFil6T/profile http://localhost:60198/getInfo.html) 00:23:56 INFO - PROCESS | 15748 | __metrics Screen width/height:1600/1200 00:23:56 INFO - PROCESS | 15748 | colorDepth:24 00:23:56 INFO - PROCESS | 15748 | Browser inner width/height: 1024/697 00:23:56 INFO - PROCESS | 15748 | __metrics 00:23:57 INFO - PROCESS | 15748 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:23:57 INFO - TEST-INFO | 15748: exit 0 00:23:57 INFO - Browser initialized. 00:23:57 INFO - Running cycle 1/1 for kraken test... 00:23:57 INFO - TEST-INFO | started process 15832 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCFil6T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:24:09 INFO - PROCESS | 15832 | RSS: Main: 159793152 00:24:09 INFO - PROCESS | 15832 | 00:24:12 INFO - PROCESS | 15832 | Cycle 1(1): loaded http://localhost:60198/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60198/tests/kraken/driver.html?testName=audio-beat-detection) 00:24:13 INFO - PROCESS | 15832 | RSS: Main: 217554944 00:24:13 INFO - PROCESS | 15832 | 00:24:16 INFO - PROCESS | 15832 | Cycle 1(1): loaded http://localhost:60198/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60198/tests/kraken/driver.html?testName=audio-dft) 00:24:16 INFO - PROCESS | 15832 | RSS: Main: 205041664 00:24:16 INFO - PROCESS | 15832 | 00:24:20 INFO - PROCESS | 15832 | Cycle 1(1): loaded http://localhost:60198/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60198/tests/kraken/driver.html?testName=audio-fft) 00:24:20 INFO - PROCESS | 15832 | RSS: Main: 271011840 00:24:20 INFO - PROCESS | 15832 | 00:24:22 INFO - PROCESS | 15832 | Cycle 1(1): loaded http://localhost:60198/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60198/tests/kraken/driver.html?testName=audio-oscillator) 00:24:23 INFO - PROCESS | 15832 | RSS: Main: 181882880 00:24:23 INFO - PROCESS | 15832 | 00:24:25 INFO - PROCESS | 15832 | Cycle 1(1): loaded http://localhost:60198/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60198/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:24:26 INFO - PROCESS | 15832 | RSS: Main: 185716736 00:24:26 INFO - PROCESS | 15832 | 00:24:29 INFO - PROCESS | 15832 | Cycle 1(1): loaded http://localhost:60198/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60198/tests/kraken/driver.html?testName=imaging-darkroom) 00:24:30 INFO - PROCESS | 15832 | RSS: Main: 222023680 00:24:30 INFO - PROCESS | 15832 | 00:24:33 INFO - PROCESS | 15832 | Cycle 1(1): loaded http://localhost:60198/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60198/tests/kraken/driver.html?testName=imaging-desaturate) 00:24:34 INFO - PROCESS | 15832 | RSS: Main: 217944064 00:24:34 INFO - PROCESS | 15832 | 00:24:36 INFO - PROCESS | 15832 | Cycle 1(1): loaded http://localhost:60198/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60198/tests/kraken/driver.html?testName=json-parse-financial) 00:24:37 INFO - PROCESS | 15832 | RSS: Main: 221356032 00:24:37 INFO - PROCESS | 15832 | 00:24:39 INFO - PROCESS | 15832 | Cycle 1(1): loaded http://localhost:60198/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60198/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:24:39 INFO - PROCESS | 15832 | RSS: Main: 206790656 00:24:39 INFO - PROCESS | 15832 | 00:24:41 INFO - PROCESS | 15832 | Cycle 1(1): loaded http://localhost:60198/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60198/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:24:42 INFO - PROCESS | 15832 | RSS: Main: 212140032 00:24:42 INFO - PROCESS | 15832 | 00:24:44 INFO - PROCESS | 15832 | Cycle 1(1): loaded http://localhost:60198/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60198/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:24:45 INFO - PROCESS | 15832 | RSS: Main: 207577088 00:24:45 INFO - PROCESS | 15832 | 00:24:47 INFO - PROCESS | 15832 | Cycle 1(1): loaded http://localhost:60198/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60198/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:24:48 INFO - PROCESS | 15832 | RSS: Main: 224481280 00:24:48 INFO - PROCESS | 15832 | 00:24:51 INFO - PROCESS | 15832 | Cycle 1(1): loaded http://localhost:60198/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60198/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:24:52 INFO - PROCESS | 15832 | RSS: Main: 224710656 00:24:52 INFO - PROCESS | 15832 | 00:24:53 INFO - PROCESS | 15832 | Cycle 1(1): loaded http://localhost:60198/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60198/tests/kraken/driver.html?testName=ai-astar) 00:24:54 INFO - PROCESS | 15832 | RSS: Main: 266543104 00:24:54 INFO - PROCESS | 15832 | 00:24:54 INFO - PROCESS | 15832 | __start_tp_report 00:24:54 INFO - PROCESS | 15832 | _x_x_mozilla_page_load 00:24:54 INFO - PROCESS | 15832 | _x_x_mozilla_page_load_details 00:24:54 INFO - PROCESS | 15832 | |i|pagename|runs| 00:24:54 INFO - PROCESS | 15832 | |0;ai-astar;102;112;111;112;113;111;112;112;112;111 00:24:54 INFO - PROCESS | 15832 | |1;audio-beat-detection;148;127;130;175;136;123;142;122;170;123 00:24:54 INFO - PROCESS | 15832 | |2;audio-dft;161;160;160;161;163;161;162;163;160;160 00:24:54 INFO - PROCESS | 15832 | |3;audio-fft;75;76;76;105;76;76;75;75;104;76 00:24:54 INFO - PROCESS | 15832 | |4;audio-oscillator;92;86;115;85;84;85;126;85;84;128 00:24:54 INFO - PROCESS | 15832 | |5;imaging-gaussian-blur;117;116;117;117;117;116;117;117;117;117 00:24:54 INFO - PROCESS | 15832 | |6;imaging-darkroom;147;146;147;148;147;148;148;148;145;147 00:24:54 INFO - PROCESS | 15832 | |7;imaging-desaturate;95;95;95;96;95;95;95;95;95;95 00:24:54 INFO - PROCESS | 15832 | |8;json-parse-financial;64;63;64;64;65;65;65;66;66;64 00:24:54 INFO - PROCESS | 15832 | |9;json-stringify-tinderbox;65;65;66;65;65;66;64;64;64;64 00:24:54 INFO - PROCESS | 15832 | |10;stanford-crypto-aes;78;79;83;77;77;77;78;78;83;78 00:24:54 INFO - PROCESS | 15832 | |11;stanford-crypto-ccm;130;128;132;139;128;140;136;130;211;141 00:24:54 INFO - PROCESS | 15832 | |12;stanford-crypto-pbkdf2;167;165;164;164;162;169;165;166;167;167 00:24:54 INFO - PROCESS | 15832 | |13;stanford-crypto-sha256-iterative;71;68;68;75;66;66;66;65;65;65 00:24:54 INFO - PROCESS | 15832 | __end_tp_report 00:24:54 INFO - PROCESS | 15832 | __start_cc_report 00:24:54 INFO - PROCESS | 15832 | _x_x_mozilla_cycle_collect,1886 00:24:54 INFO - PROCESS | 15832 | __end_cc_report 00:24:54 INFO - PROCESS | 15832 | __startTimestamp1467876294061__endTimestamp 00:24:54 INFO - PROCESS | 15832 | 00:24:54 INFO - PROCESS | 15832 | ------- Summary: start ------- 00:24:54 INFO - PROCESS | 15832 | Number of tests: 14 00:24:54 INFO - PROCESS | 15832 | 00:24:54 INFO - PROCESS | 15832 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.00 stddev:3.16 (2.8%) stddev-sans-first:0.67 00:24:54 INFO - PROCESS | 15832 | Values: 102.0 112.0 111.0 112.0 113.0 111.0 112.0 112.0 112.0 111.0 00:24:54 INFO - PROCESS | 15832 | 00:24:54 INFO - PROCESS | 15832 | [#1] audio-beat-detection Cycles:10 Average:139.60 Median:139.00 stddev:19.37 (13.9%) stddev-sans-first:20.31 00:24:54 INFO - PROCESS | 15832 | Values: 148.0 127.0 130.0 175.0 136.0 123.0 142.0 122.0 170.0 123.0 00:24:54 INFO - PROCESS | 15832 | 00:24:54 INFO - PROCESS | 15832 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:1.20 (0.7%) stddev-sans-first:1.27 00:24:54 INFO - PROCESS | 15832 | Values: 161.0 160.0 160.0 161.0 163.0 161.0 162.0 163.0 160.0 160.0 00:24:54 INFO - PROCESS | 15832 | 00:24:54 INFO - PROCESS | 15832 | [#3] audio-fft Cycles:10 Average:81.40 Median:76.00 stddev:12.19 (16.0%) stddev-sans-first:12.70 00:24:54 INFO - PROCESS | 15832 | Values: 75.0 76.0 76.0 105.0 76.0 76.0 75.0 75.0 104.0 76.0 00:24:54 INFO - PROCESS | 15832 | 00:24:54 INFO - PROCESS | 15832 | [#4] audio-oscillator Cycles:10 Average:97.00 Median:85.00 stddev:18.38 (21.6%) stddev-sans-first:19.41 00:24:54 INFO - PROCESS | 15832 | Values: 92.0 86.0 115.0 85.0 84.0 85.0 126.0 85.0 84.0 128.0 00:24:54 INFO - PROCESS | 15832 | 00:24:54 INFO - PROCESS | 15832 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 00:24:54 INFO - PROCESS | 15832 | Values: 117.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 00:24:54 INFO - PROCESS | 15832 | 00:24:54 INFO - PROCESS | 15832 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.50 stddev:0.99 (0.7%) stddev-sans-first:1.05 00:24:54 INFO - PROCESS | 15832 | Values: 147.0 146.0 147.0 148.0 147.0 148.0 148.0 148.0 145.0 147.0 00:24:54 INFO - PROCESS | 15832 | 00:24:54 INFO - PROCESS | 15832 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 00:24:54 INFO - PROCESS | 15832 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 00:24:54 INFO - PROCESS | 15832 | 00:24:54 INFO - PROCESS | 15832 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:65.00 stddev:0.97 (1.5%) stddev-sans-first:1.00 00:24:54 INFO - PROCESS | 15832 | Values: 64.0 63.0 64.0 64.0 65.0 65.0 65.0 66.0 66.0 64.0 00:24:54 INFO - PROCESS | 15832 | 00:24:54 INFO - PROCESS | 15832 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 00:24:54 INFO - PROCESS | 15832 | Values: 65.0 65.0 66.0 65.0 65.0 66.0 64.0 64.0 64.0 64.0 00:24:54 INFO - PROCESS | 15832 | 00:24:54 INFO - PROCESS | 15832 | [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:78.00 stddev:2.30 (2.9%) stddev-sans-first:2.42 00:24:54 INFO - PROCESS | 15832 | Values: 78.0 79.0 83.0 77.0 77.0 77.0 78.0 78.0 83.0 78.0 00:24:54 INFO - PROCESS | 15832 | 00:24:54 INFO - PROCESS | 15832 | [#11] stanford-crypto-ccm Cycles:10 Average:141.50 Median:137.50 stddev:24.92 (18.1%) stddev-sans-first:26.08 00:24:54 INFO - PROCESS | 15832 | Values: 130.0 128.0 132.0 139.0 128.0 140.0 136.0 130.0 211.0 141.0 00:24:54 INFO - PROCESS | 15832 | 00:24:54 INFO - PROCESS | 15832 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.60 Median:166.50 stddev:2.01 (1.2%) stddev-sans-first:2.07 00:24:54 INFO - PROCESS | 15832 | Values: 167.0 165.0 164.0 164.0 162.0 169.0 165.0 166.0 167.0 167.0 00:24:54 INFO - PROCESS | 15832 | 00:24:54 INFO - PROCESS | 15832 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.00 stddev:3.24 (4.8%) stddev-sans-first:3.18 00:24:54 INFO - PROCESS | 15832 | Values: 71.0 68.0 68.0 75.0 66.0 66.0 66.0 65.0 65.0 65.0 00:24:54 INFO - PROCESS | 15832 | -------- Summary: end -------- 00:24:54 INFO - PROCESS | 15832 | 00:24:55 INFO - TEST-INFO | 15832: exit 0 00:24:55 INFO - TEST-OK | kraken | took 63164ms 00:24:55 INFO - SUITE-END | took 1183s 00:24:55 INFO - Completed test suite (00:19:43) 00:24:55 INFO - javascript benchmark 00:24:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2669.2259244819, 2678.290253082932, 2705.418335057962, 2716.8369897806147, 2718.0, 4717.646176536757, 4763.166445871967, 4798.568128868401, 4852.733099679516, 4860.708357498548, 4811.687240329385, 4817.9759101204445, 4866.367372241612, 4882.316475693406, 4952.479989601094, 4376.168527979674, 4401.515833258347, 4468.865934021985, 4523.773811309437, 4606.884827879297, 4512.864614061567, 4556.20266453371, 4571.108633816407, 4581.725096494204, 4588.793504292298, 4381.277089280265, 4418.6023257906945, 4427.933580996288, 4440.400545926291, 4491.214037543416, 4420.646348292129, 4424.668149888771, 4432.911341773179, 4477.955220447787, 4491.505934347219, 4392.4289842320295, 4440.2895536714295, 4442.2892337225885, 4445.688801783876, 4480.350349199381, 4711.199096153662, 4810.63920205986, 4826.444958829745, 4885.853424397274, 4889.193283108283, 5103.795848166106, 5153.201253805666, 5160.638755287131, 5230.712310822903, 5234.398044224925, 5199.454057324002, 5235.450277720823, 5236.8690782730355, 5243.947560524384, 5264.31563896691, 4673.948361618676, 4816.157172494799, 4853.781579828917, 4864.0028794097125, 4866.270059491105, 5309.5752339812725, 5333.893322133613, 5385.084535628874, 5387.488188622075, 5412.079946409041, 5110.770015349318, 5120.795168193231, 5154.814392689627, 5169.870753231199, 5172.818951336685, 4984.775685094107, 5125.282460455539, 5182.196759502283, 5245.895082098336, 5296.523312901781, 5115.825774046016, 5137.8715532112, 5151.896962060813, 5165.1219292720325, 5191.402988656353, 5099.97450012755, 5114.360704911886, 5116.462771409023, 5120.692758434506, 5129.333186685707, 4229.429027081366, 4259.680523960654, 4292.613664770186, 4329.264025115738, 4340.47914250292, 3781.243751249761, 3806.695464362844, 3819.0261483321574, 3834.213986132836, 3859.286032084073, 4458.264386376211, 4468.151051300308, 4474.306482495218, 4488.057507923372, 4516.209663308908, 5030.471800460972, 5089.541941225233, 5146.819861304836, 5192.4807519248525, 5209.322788037531, 4451.154280686659, 4458.554144585581, 4461.308497182942, 4484.417025786692, 4504.189245935698, 4649.5350464953235, 4658.277966915133, 4662.650301227422, 4675.649326300541, 4723.031778485402, 4733.597644200281, 4852.417709874838, 4880.951190488192, 4888.633352498506, 4905.166121759309, 5175.068487672255, 5185.714785686823, 5195.532402083831, 5196.2465442509865, 5203.947960520346, 4872.439669437918, 4892.2661600760175, 4918.827841025547, 4922.65541412112, 4930.137225985366, 4926.261060840902, 4991.226359914219, 5013.24801279811, 5049.899002020013, 5057.443681194992, 5103.081445339874, 5104.2088476286235, 5121.436641969455, 5123.666961647481, 5174.404943431554, 4835.081334546425, 5006.649534532694, 5017.147084995632, 5030.0, 5033.169527028, 4913.729744864067, 4939.333190019302, 4941.777620007037, 4959.851204463872, 4985.277134815359, 4903.901921961469, 4916.950830491649, 4923.507649235048, 4971.676841005323, 4976.726280054487, 4883.389576302962, 4962.776675049559, 4992.675476094188, 5016.2224855147515, 5026.4973502649445, 4772.141014617402, 4799.1601469743355, 4816.614670826255, 4857.077155340474, 4857.732824694675], "value": 4736.317179738843, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.5609049840095, 580.9215755872958, 586.0915580849684, 587.1896782440232, 590.2091197794955, 39920.80039599801, 41232.79383603082, 41375.58624413755, 41402.58597414029, 45068.54931450685, 40362.59637403625, 40740.79629601848, 40852.591474085326, 40910.18179636406, 40935.79532102343, 7491.175970643225, 7948.966634337543, 8069.273765361117, 8089.271965523102, 10262.794744105113, 10193.082622563968, 10611.151107911388, 10612.946935265312, 10614.097801686827, 10614.522346494427, 10628.256022078458, 10654.4140072296, 10671.78656426871, 10674.733131671692, 10678.839817402744, 7624.847503049936, 7774.105977812511, 7775.455718099735, 10385.42880141592, 10538.631147909824, 10122.089011988955, 10484.108850747696, 10512.579496820117, 10517.0, 10529.262951593391, 39012.80493597542, 39342.60657393418, 39426.21147577061, 39486.40770388446, 39489.80255098735, 2986.596809430721, 3001.2496875781053, 3048.6189226346705, 3091.9536206956914, 3452.654734526527, 30260.0921972339, 30789.538156927665, 31116.910908118334, 31398.686013139806, 31988.0, 3493.6681015303507, 3553.8400771965325, 3582.5880023797336, 3585.8565657373674, 3678.4666223397726, 266689.0, 267588.63439779513, 267928.0, 269044.0, 269076.0, 32793.67206327954, 33817.15457113592, 56530.0, 57147.42852571504, 57177.0, 35004.47493287603, 35139.7701080461, 35141.0, 35161.47257791135, 35245.64754352475, 13952.720945581235, 14076.929615351857, 14089.71820563583, 14093.083949543452, 14095.647608809863, 10474.266801323987, 11434.771304574027, 11642.126840486828, 11660.88339116615, 11997.160198786001, 8088.150744171895, 8123.83752324962, 8154.5514996674565, 8207.507549547046, 8208.58957052145, 3155.857986390618, 3184.7611429142908, 3191.632962209376, 3197.7122059014337, 3226.8547915343865, 858.7166235142388, 899.865020246955, 918.7749001494676, 952.514217748953, 988.2538683294067, 28165.295867603472, 29307.0, 29474.705252947195, 29665.703342966295, 29899.25251868677, 903.8915330160423, 932.147085416836, 960.5629438605557, 1002.2232769603615, 1020.6580795433464, 15247.313870875838, 15558.766618500731, 15653.295601697951, 15788.763168552481, 15897.682046359008, 409460.0, 411243.0, 412104.0, 412870.0, 413686.0, 50393.24410133851, 50762.0, 50808.74595626998, 50871.23693144606, 50992.0, 1086.7120213143364, 1127.639155470258, 1172.4958267944864, 1182.3437991914398, 1229.3853073463267, 28659.0, 29208.123756287347, 29551.0, 30164.396712065198, 30661.386772264876, 43227.135457291304, 43557.0, 43622.34566481442, 43647.56352436435, 43784.0, 308409.0, 308986.0, 309807.0, 310067.0, 310998.0, 25086.811145510837, 26325.07862224813, 26593.202203933914, 26699.19902402931, 26704.599431008937, 42232.788836055624, 42353.0, 43194.35208471938, 44090.33864491971, 44300.33549496825, 36145.457818133276, 37208.62791372051, 37230.90460049447, 37813.86558403252, 37949.241015180094, 36721.0, 36926.815365923, 37530.62469375271, 38767.418488723255, 39133.60866391299, 37250.627493724714, 37447.62552374441, 39264.80367598258, 39472.40791388074, 40867.386989194594, 31967.0, 33615.879668111986, 33763.493547596314, 34259.486107707904, 34723.0, 25809.870950645876, 26188.476230475666, 26291.4741705161, 26392.472150557267, 26431.735682642928], "value": 17418.83265607844, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.3133857639027, 368.13488302489156, 371.6450789496031, 377.04795391636117, 385.28721864550585, 13034.413451394686, 16402.671946561077, 17024.23390947409, 18323.0, 18357.7246341305, 15813.130277834744, 16103.516894493185, 17491.0, 17559.122043897816, 17884.910575447106, 5039.77321020555, 5159.71621560814, 5460.645058071233, 5461.972690136544, 5572.247746554204, 3377.3414184234084, 5053.736565858535, 5347.358317001966, 5363.597730170233, 5488.313960754906, 5338.67967921924, 5339.733013349336, 5364.6512976656395, 5376.059189641816, 5377.193420986844, 5195.142801437758, 5323.893522129555, 5484.8354549363585, 5490.588205884575, 5574.86062848428, 5377.462253774591, 5383.16560933056, 5398.055340315468, 5398.055340315468, 5399.0, 12571.120021598492, 16106.953048051839, 20307.79692203074, 21277.89361053185, 21403.892980535154, 1863.3757691173473, 1923.3460623388116, 2013.315472739261, 2290.0839664134314, 2340.2745149003863, 8798.736037918872, 8821.867671984925, 8850.336224783166, 9193.908060919372, 9318.30112741547, 1685.3764107280263, 1693.6274019715643, 1751.7284820852788, 1754.8332908373684, 1844.8985305808176, 69631.0, 71778.28221717768, 72426.27573724248, 73700.6314968427, 74636.0, 9002.36983411168, 9433.339666223435, 10175.898241017496, 10235.641752538775, 10366.993571864226, 13557.712017358335, 13561.186328820302, 13629.454821807214, 13715.794263086062, 13742.862571374359, 7069.8939515907305, 7095.609741464269, 7150.034745309421, 7392.075990501187, 7457.216992215739, 6987.615681137586, 6996.055532503149, 7028.648567571601, 7108.3957863581145, 7217.675204615805, 4157.667386609064, 4306.633936115402, 4376.606105450524, 4421.226285400042, 4497.235469970113, 1768.5843826700716, 1806.6296409236074, 1817.9000154991338, 1870.7652949053831, 1875.4561177258715, 833.9416240863203, 895.8477058900003, 930.6975233049286, 957.8563215517589, 959.5825815770023, 17757.200925958365, 17797.19912603936, 17921.257800146745, 17945.910270448825, 18071.72892406615, 849.3544905871458, 881.3742243007408, 881.7927786970057, 907.582512044467, 911.5123408976166, 9626.566804493814, 9699.70900872975, 9978.700638980843, 10064.0, 10143.137833284254, 377233.0, 393756.0, 394993.0, 395996.0, 396730.0, 78177.0, 79631.0, 79995.60002199952, 80260.0, 80328.59835700784, 912.3886995712888, 915.9450432974043, 919.7792529792802, 939.0609390609391, 941.6280569175137, 15555.066695998275, 15872.52382428529, 15965.760513592073, 15972.8402715976, 16366.590835229215, 26319.736802632495, 38665.6133438662, 39249.41125883057, 39374.80312598419, 39691.40462893001, 48577.27134093062, 50896.74551627218, 51138.48861511486, 51477.0, 51697.7415112922, 6851.177858656993, 7660.157382687788, 7721.073471183494, 7734.342580880463, 7815.218478152139, 10912.945435272773, 11925.522979080739, 12245.834122797296, 12415.44130514147, 12694.0, 10593.629222977466, 10604.787904241717, 10607.0, 10725.141988641046, 10903.618373356894, 10534.420606866695, 10837.67486975392, 10950.507227174638, 11080.113590912546, 11155.44222788841, 10454.163666906781, 10738.892611073788, 10832.079273261861, 10915.072218861485, 11134.944325278646, 7599.962000189964, 7719.768406947801, 7786.299233069051, 7882.7241046563095, 7885.053793544811, 8874.51190184546, 10479.266451348638, 10487.94756026215, 10576.259661823598, 10929.0], "value": 8288.456321996851, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.7584834729748, 1410.0200360749277, 1476.4979906831675, 1698.957526061849, 1716.613761903572, 7717.035370578677, 8149.062857771358, 8156.959215203923, 8221.38339624529, 8239.217274358927, 6983.127109111361, 7190.9640451797795, 7738.110117336508, 7990.520568765864, 8113.594320283992, 2225.643896976484, 2249.156566287642, 2251.189571754167, 2254.0983606557425, 2257.559775843711, 2214.5017371091535, 2224.254874617005, 2265.501589650274, 2265.796078352948, 2268.0, 1926.7687877454655, 2206.227820262903, 2254.616715158427, 2260.0394832196334, 2287.0280130944366, 2223.2218723446663, 2224.510607666311, 2243.5064285857165, 2247.674087257355, 2253.177590179589, 2225.543763528473, 2229.141780414536, 2231.843770936035, 2231.933042008742, 2236.2396785093147, 8220.465669731448, 8268.0, 8275.917240827575, 8279.8344033119, 8289.751307460785, 4528.366028755977, 4537.909241815179, 4663.044075964419, 4687.718736875764, 4688.671792974493, 2869.569564565311, 2896.826190428581, 2946.1456177708437, 2950.8081974671577, 2958.40831833632, 930.6370515498961, 943.4056544377067, 953.1040821627718, 953.6662168241129, 955.4744890310302, 11074.335539867634, 11130.276532025393, 11141.72145696356, 11143.387113708743, 11159.0, 4148.315527937856, 4284.700070995001, 4393.51671316155, 4398.076403955205, 4461.5092339842595, 9439.197668198143, 9468.715938521718, 9489.478078705737, 9506.382085164441, 9519.143277105093, 4815.686980346266, 4817.78319975602, 4820.39745031871, 4820.71075735457, 4821.927671084936, 4226.894327641772, 4270.188664153801, 4286.892827679333, 4303.1608836277255, 4339.848105316299, 3728.7203459740085, 3745.382011968049, 3752.924941501209, 3817.2747178036084, 3859.3246181918053, 1071.5499490214129, 1148.5520646947698, 1161.651504548649, 1167.2646232873406, 1196.9461374238006, 629.361198383641, 769.3806485779002, 796.5698522797625, 826.1738261738262, 834.845553572591, 5251.501107394792, 5308.495692909168, 5439.673619582759, 5549.0289199389945, 5553.6390134641115, 867.6746220167437, 880.9383343165916, 887.8845750052581, 893.5264309915755, 897.2014906733012, 3728.8508459661853, 3729.645683660048, 3737.831797569116, 3787.0721673190246, 3812.4471951566866, 9589.760255993657, 10010.299279050541, 10155.695329140137, 10179.898201017895, 10195.337303075275, 8769.649214031368, 9088.681896133603, 9925.553350099262, 9934.354266972623, 9940.652077177265, 6857.55425897315, 6977.965110174417, 7141.500094993301, 7442.218567050381, 7449.180590135081, 5734.5125664319, 5743.0811070228565, 5812.622179558315, 5829.242198514166, 6021.87956240864, 9315.906840931775, 9438.57526411327, 9446.905530944603, 9467.66863159786, 9471.289653275893, 9344.0, 9515.33392662507, 9620.470874101711, 9715.9028409715, 9772.706818795448, 6919.723211071702, 6943.930560694328, 6987.650617469208, 6995.055667484824, 7000.264972178052, 7409.073865766779, 7637.121731001006, 7715.035620547432, 7716.845663086595, 7722.53664780115, 5741.080165506934, 6024.487918526975, 6951.965240173767, 7061.540999834994, 7197.064381630564, 6969.477289203229, 7052.259512751088, 7104.680289386886, 7179.389751871149, 7222.025026621549, 6526.641034743135, 6560.3111673273615, 6561.967190164019, 6588.143541339595, 6594.307597702172, 4030.496187976503, 4132.669386449017, 4173.332266837291, 4195.97902010488, 4209.389638502339, 4580.312953056935, 4605.194091033989, 4625.0, 4637.6521760868745, 4680.017196388796], "value": 4231.538649479966, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.9006742673777, 290.9127261821454, 293.36632872994335, 301.2679189569346, 301.87924830067954, 4853.44185418677, 4890.290907818364, 4908.214685650297, 4923.409190897093, 4924.039812236615, 4823.155947709154, 4833.419989601244, 4842.515748425156, 4849.369581954341, 4853.951460485394, 3603.099225193695, 3671.7613355131966, 3721.869734559291, 3804.258169656918, 3846.346121159396, 3787.110029143149, 3797.8670746523876, 3802.1065049713297, 3818.293615681094, 3841.519810023747, 3604.819759012039, 3774.7168962327937, 3781.5840257571645, 3789.749382703715, 3789.9431508527396, 3667.8532858685753, 3806.7144964127665, 3823.5411750590106, 3824.8661296854475, 3832.693384529231, 3370.1911541230174, 3377.9155521111925, 3380.053584996205, 3385.627580966092, 3399.3031428557088, 4777.450593181794, 4792.520747925215, 4793.113274044313, 4793.400824896888, 4809.062232864593, 4244.427002354673, 4360.4331436913, 4365.690292912113, 4370.7159034662645, 4390.780460976938, 5031.32077169581, 5037.899242015176, 5061.089003979282, 5089.41471730752, 5112.872178195537, 3656.287024030315, 3665.5601327840563, 3665.5784584772828, 3672.7796332219887, 3691.7231207659534, 5068.949310506885, 5254.97372513135, 5261.973690131563, 5327.762339817286, 5357.812476563302, 3717.423799311111, 3738.85044598213, 3739.270842185802, 3751.756135851161, 3754.549454065475, 3783.432485127198, 3784.1674831537016, 3790.507234059555, 3794.317022935898, 3795.0891785971166, 4309.741415515079, 4316.460442444694, 4319.762413067248, 4321.6974811762875, 4332.285172946428, 4866.78099485524, 5032.421271553745, 5036.647434679538, 5045.41977672565, 5057.443681195065, 1294.4822071171418, 1314.7764879970428, 1315.2963164706837, 1319.9142055766345, 1322.107577385261, 835.7839343754944, 847.4406891451736, 855.9471849624996, 866.1728049712635, 866.6220709072605, 4361.454818147731, 4390.8902277442685, 4465.26323156682, 4498.415206023262, 4514.706544074625, 5210.218467229945, 5212.976473645276, 5222.582193424517, 5223.764930578133, 5250.343707036621, 4309.396684464177, 4487.640988720895, 4491.640668746492, 4512.706674066175, 4542.409486766699, 2767.5571908494544, 2781.596668483099, 2791.9302017449727, 2797.4684809886057, 2799.510085734988, 4965.428975667773, 4979.601631869442, 4981.775820088104, 4986.850394488171, 4990.70241737151, 5135.460776618476, 5343.812966546152, 5367.570594352443, 5427.294451721251, 5432.837014889559, 4987.875303117451, 5000.374953130859, 5002.299678045077, 5002.574781143498, 5015.17249653803, 5299.33758280215, 5329.855385322679, 5338.652987555796, 5360.383555891122, 5379.731013449234, 4917.213245880785, 5180.507851754077, 5194.662346947436, 5194.7922083116255, 5218.582513398995, 4971.477994810492, 4971.9254211186135, 4982.800687972585, 4987.177115775857, 5016.724080175625, 3686.152184997412, 3697.186618943828, 3698.3158115748674, 3705.833237504373, 3707.0917625182, 5126.384833819965, 5203.0, 5211.9478805211465, 5240.502152295526, 5315.255864179096, 5040.697558146523, 5052.5705315048635, 5063.645544811828, 5068.391792984866, 5069.467705890976, 5055.570276526537, 5099.56653684441, 5122.795088196431, 5137.640365174402, 5140.331756871583, 4767.928481072856, 4868.17241069012, 5017.523335283142, 5028.145215313332, 5041.0, 4910.386201724785, 5074.391073071255, 5076.7207803571155, 5080.745962701924, 5084.8220312288895, 4913.90424032857, 4919.409670839522, 4953.7523123844385, 4982.480343495269, 4995.650304478797], "value": 3840.578418780193, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [623.5043140703141, 639.875224331255, 647.2685864972581, 705.3616477088235, 715.2333735672889, 12457.937710311448, 13438.32808359583, 13457.7308453831, 13473.0, 13486.25825579594, 12738.426770795313, 13121.475140994373, 13155.079144459867, 13168.73662526749, 13188.736225275488, 617.6016469377249, 629.2606187729423, 765.5980610179645, 782.8238646304565, 784.752802867095, 761.7676608634392, 770.7225398856407, 774.2953911940135, 783.7335305995961, 784.1531146361943, 819.942604017719, 821.256762629818, 822.1942496353547, 823.7158180427742, 824.2416976381713, 642.1972534332085, 792.2711105782694, 802.7912742686885, 814.7474282972267, 815.1563132158218, 595.910613407988, 597.7340083662772, 598.8413070536311, 599.5233789137646, 600.1208229943111, 12877.67805804853, 12893.033022523254, 12899.419526121346, 12907.870921290762, 12925.224486530838, 11761.235519691192, 12233.266004039786, 12704.872951270461, 12866.035047371484, 13109.47562097515, 11917.523299068027, 11940.402979850973, 11946.701332466671, 11976.221545599508, 12252.142350035501, 4176.0058974129015, 4188.706790524665, 4216.599423054836, 4232.597903199191, 4369.4756629204385, 61665.691671541805, 62953.685231574, 62999.37000630027, 63017.36982630207, 63077.36922630761, 9149.908500915039, 9175.495347755805, 9439.150476457151, 9535.0, 9761.755956101155, 16887.408940687015, 17131.828681713272, 17156.65686686259, 17185.914070429568, 17191.1404429778, 6592.86814263712, 6621.801345959629, 6651.86696266072, 6696.0960270362875, 6799.592024478448, 3506.1935754776546, 3604.5133906922756, 3608.9458658120147, 3609.7473176877893, 3679.4296883983025, 2839.886404543795, 2926.7512261457587, 2932.9706702933127, 2958.0, 2963.0222026731126, 517.3972322244618, 519.4623564610686, 527.0855066459766, 528.4794477439718, 528.8889333239986, 422.89834979877594, 530.3847536857227, 540.4388838848286, 619.7025427794593, 631.1069836181844, 8608.0, 8808.075152109064, 8884.555772211364, 8944.552772361487, 9103.590338434655, 488.83868323453174, 500.9223570346602, 534.4628648208526, 587.5681374189967, 605.4429924469499, 3990.615015974418, 4068.3158763788933, 4228.70399072062, 4247.915041699149, 4267.97866010668, 86206.0, 87068.25863482822, 92954.53522732478, 93777.0, 93801.0, 81826.59086704528, 82172.0, 83160.0, 83726.581367094, 87549.0, 45891.0, 70018.2998170022, 70874.2912570878, 74007.62996184985, 74877.0, 7736.149023607286, 7750.379969602305, 7844.646990885538, 7952.92047079545, 7980.002499687539, 30976.53535197019, 31433.0, 38748.80625596854, 38829.41755873721, 45164.32253516265, 41243.38134927918, 59693.0, 60524.0, 60790.0, 62223.6888815553, 10350.844737328796, 10808.18938579594, 10839.458027098772, 11318.09455243595, 11560.42197890119, 13079.0, 13081.672958176121, 13495.527656531975, 13626.318684065558, 14038.1577105374, 12178.695532611755, 12223.501846630508, 12766.744665106831, 12994.35028248565, 13130.671733206364, 12517.374131293582, 12569.874301257236, 12770.0, 12775.680607984874, 12899.806502902651, 11646.24299420535, 11965.641030769091, 12245.326507042199, 12331.0, 12459.937700311802, 9864.0, 10263.640772572924, 10296.661434013531, 10305.175585953255, 11027.283226590567, 9757.26820488452, 9779.608815647294, 9823.557939892866, 9988.101070903653, 10069.446180460145], "value": 6521.237240303922, "unit": "score"}], "name": "dromaeo_css", "value": 6457.0532168913, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 111.0, 112.0, 113.0, 111.0, 112.0, 112.0, 112.0, 111.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 127.0, 130.0, 175.0, 136.0, 123.0, 142.0, 122.0, 170.0, 123.0], "value": 139.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 161.0, 163.0, 161.0, 162.0, 163.0, 160.0, 160.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 105.0, 76.0, 76.0, 75.0, 75.0, 104.0, 76.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 86.0, 115.0, 85.0, 84.0, 85.0, 126.0, 85.0, 84.0, 128.0], "value": 97.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 148.0, 147.0, 148.0, 148.0, 148.0, 145.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 64.0, 65.0, 65.0, 65.0, 66.0, 66.0, 64.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 65.0, 65.0, 66.0, 64.0, 64.0, 64.0, 64.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 83.0, 77.0, 77.0, 77.0, 78.0, 78.0, 83.0, 78.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 128.0, 132.0, 139.0, 128.0, 140.0, 136.0, 130.0, 211.0, 141.0], "value": 141.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 165.0, 164.0, 164.0, 162.0, 169.0, 165.0, 166.0, 167.0, 167.0], "value": 165.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 68.0, 75.0, 66.0, 66.0, 66.0, 65.0, 65.0, 65.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1531.6999999999998, "alertThreshold": 2.0}]} 00:24:55 INFO - Return code: 0 00:24:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:24:55 INFO - # TBPL SUCCESS # 00:24:55 INFO - Running post-action listener: _resource_record_post_action 00:24:55 INFO - ##### 00:24:55 INFO - ##### Finished run-tests step (success) 00:24:55 INFO - ##### 00:24:55 INFO - Running post-run listener: _resource_record_post_run 00:24:55 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 8192; Write bytes: 535023616; Read time: 36; Write time: 542092 00:24:55 INFO - TinderboxPrint: CPU usage
12.9% 00:24:55 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 36 00:24:55 INFO - TinderboxPrint: I/O write bytes / time
535,023,616 / 542,092 00:24:55 INFO - TinderboxPrint: CPU idle
8,336.7 (87.0%) 00:24:55 INFO - TinderboxPrint: CPU user
1,198.8 (12.5%) 00:24:55 INFO - TinderboxPrint: Swap in / out
0 / 0 00:24:55 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246329344; Read time: 0; Write time: 318716 00:24:55 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288497664; Read time: 20; Write time: 223348 00:24:56 INFO - Running post-run listener: _upload_blobber_files 00:24:56 INFO - Blob upload gear active. 00:24:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:24:56 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 00:24:56 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:24:56 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:24:56 INFO - (blobuploader) - INFO - Open directory for files ... 00:24:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:24:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:24:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:24:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:24:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:24:57 INFO - (blobuploader) - INFO - Done attempting. 00:24:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:24:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:24:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:24:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:24:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:24:58 INFO - (blobuploader) - INFO - Done attempting. 00:24:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:24:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:24:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:25:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:25:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:25:01 INFO - (blobuploader) - INFO - Done attempting. 00:25:01 INFO - (blobuploader) - INFO - Iteration through files over. 00:25:01 INFO - Return code: 0 00:25:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:25:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:25:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/68cab4f05e2483c127be46e56725f9f3c63fa3ce782a9fef52e7ac97f348bbec0aca77c3e810c8219412e7755a1f06f054cf3234d365105aaab31566e018e3a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a0334e0aaf192c808d8b4cbdd7762f64191c738e549daab4fbb00267edd8b2b92e3ea94cafd6388af8f71fbb13df376023d9eb37ac7c9e0000126471094469e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/362e7f17c16878108cdf9148eafabf16155d5472c67e50781e92547c2fb011913c6f16bdbddefc7fcd14fe1f63a9bcd8dd9ae5b623f9a8dda547d308129f6457"} 00:25:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:25:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:25:01 INFO - Contents: 00:25:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/68cab4f05e2483c127be46e56725f9f3c63fa3ce782a9fef52e7ac97f348bbec0aca77c3e810c8219412e7755a1f06f054cf3234d365105aaab31566e018e3a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a0334e0aaf192c808d8b4cbdd7762f64191c738e549daab4fbb00267edd8b2b92e3ea94cafd6388af8f71fbb13df376023d9eb37ac7c9e0000126471094469e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/362e7f17c16878108cdf9148eafabf16155d5472c67e50781e92547c2fb011913c6f16bdbddefc7fcd14fe1f63a9bcd8dd9ae5b623f9a8dda547d308129f6457"} 00:25:01 INFO - Running post-run listener: copy_logs_to_upload_dir 00:25:01 INFO - Copying logs to upload dir... 00:25:01 INFO - mkdir: /builds/slave/test/build/upload/logs 00:25:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.689031 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-07-07 00:25:01.397459) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 00:25:01.400945) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1467874808.201413-564417626 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-Non-PGO/sha512/68cab4f05e2483c127be46e56725f9f3c63fa3ce782a9fef52e7ac97f348bbec0aca77c3e810c8219412e7755a1f06f054cf3234d365105aaab31566e018e3a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a0334e0aaf192c808d8b4cbdd7762f64191c738e549daab4fbb00267edd8b2b92e3ea94cafd6388af8f71fbb13df376023d9eb37ac7c9e0000126471094469e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/362e7f17c16878108cdf9148eafabf16155d5472c67e50781e92547c2fb011913c6f16bdbddefc7fcd14fe1f63a9bcd8dd9ae5b623f9a8dda547d308129f6457"} build_url:https://queue.taskcluster.net/v1/task/aYFmiwosQTy6wQe4dNiUhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011262 build_url: 'https://queue.taskcluster.net/v1/task/aYFmiwosQTy6wQe4dNiUhQ/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-Non-PGO/sha512/68cab4f05e2483c127be46e56725f9f3c63fa3ce782a9fef52e7ac97f348bbec0aca77c3e810c8219412e7755a1f06f054cf3234d365105aaab31566e018e3a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a0334e0aaf192c808d8b4cbdd7762f64191c738e549daab4fbb00267edd8b2b92e3ea94cafd6388af8f71fbb13df376023d9eb37ac7c9e0000126471094469e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/362e7f17c16878108cdf9148eafabf16155d5472c67e50781e92547c2fb011913c6f16bdbddefc7fcd14fe1f63a9bcd8dd9ae5b623f9a8dda547d308129f6457"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 00:25:01.426743) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 00:25:01.427106) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1467874808.201413-564417626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 00:25:01.510413) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 00:25:01.510745) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 00:25:01.511039) ========= ========= Total master_lag: 0.16 =========