builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-042 starttime: 1467418380.52 results: success (0) buildid: 20160701163622 builduid: 3ffc009058604326a6fae6372a6a65f2 revision: 1bbc4c035fd893b9ea1039c08bd28f34b8b66574 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 17:13:00.520658) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 17:13:00.521094) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 17:13:00.521367) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 17:13:00.536585) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 17:13:00.536868) ========= 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-1467417046.763097-1411699576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-01 17:13:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 36.9M=0s 2016-07-01 17:13:00 (36.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132080 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 17:13:00.683074) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 17:13:00.683383) ========= 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-1467417046.763097-1411699576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014045 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 17:13:00.737254) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-01 17:13:00.740677) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1bbc4c035fd893b9ea1039c08bd28f34b8b66574 --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 1bbc4c035fd893b9ea1039c08bd28f34b8b66574 --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-1467417046.763097-1411699576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-01 17:13:00,977 truncating revision to first 12 chars 2016-07-01 17:13:00,978 Setting DEBUG logging. 2016-07-01 17:13:00,978 attempt 1/10 2016-07-01 17:13:00,978 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1bbc4c035fd8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-01 17:13:02,180 unpacking tar archive at: fx-team-1bbc4c035fd8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.563303 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-01 17:13:02.319066) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 17:13:02.319370) ========= script_repo_revision: 1bbc4c035fd893b9ea1039c08bd28f34b8b66574 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 17:13:02.319777) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 17:13:02.320051) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 17:13:02.329070) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-01 17:13:02.329420) ========= /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-1467417046.763097-1411699576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:13:02 INFO - MultiFileLogger online at 20160701 17:13:02 in /builds/slave/test 17:13: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 17:13:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:13:02 INFO - {'append_to_log': False, 17:13:02 INFO - 'base_work_dir': '/builds/slave/test', 17:13:02 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:13:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:13:02 INFO - 'branch': 'Fx-Team-Non-PGO', 17:13:02 INFO - 'buildbot_json_path': 'buildprops.json', 17:13:02 INFO - 'config_files': ('talos/linux_config.py',), 17:13:02 INFO - 'default_actions': ('clobber', 17:13:02 INFO - 'read-buildbot-config', 17:13:02 INFO - 'download-and-extract', 17:13:02 INFO - 'populate-webroot', 17:13:02 INFO - 'create-virtualenv', 17:13:02 INFO - 'install', 17:13:02 INFO - 'run-tests'), 17:13:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:13:02 INFO - 'download_minidump_stackwalk': True, 17:13:02 INFO - 'download_symbols': 'ondemand', 17:13:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:13:02 INFO - 'tooltool.py': '/tools/tooltool.py', 17:13:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:13:02 INFO - '/tools/misc-python/virtualenv.py')}, 17:13:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:13:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:13:02 INFO - 'installer_path': 'installer.exe', 17:13:02 INFO - 'log_level': 'info', 17:13:02 INFO - 'log_name': 'talos', 17:13:02 INFO - 'log_to_console': True, 17:13:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:13:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:13:02 INFO - 'opt_config_files': (), 17:13:02 INFO - 'pip_index': False, 17:13:02 INFO - 'sps_profile': False, 17:13:02 INFO - 'sps_profile_interval': 0, 17:13:02 INFO - 'suite': 'dromaeojs', 17:13:02 INFO - 'system_bits': '32', 17:13:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:13:02 INFO - 'title': 'talos-linux64-ix-042', 17:13:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:13:02 INFO - 'use_talos_json': True, 17:13:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:13:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:13:02 INFO - 'work_dir': 'build'} 17:13:02 INFO - ##### 17:13:02 INFO - ##### Running clobber step. 17:13:02 INFO - ##### 17:13:02 INFO - Running pre-action listener: _resource_record_pre_action 17:13:02 INFO - Running main action method: clobber 17:13:02 INFO - rmtree: /builds/slave/test/build 17:13:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:13:03 INFO - Running post-action listener: _resource_record_post_action 17:13:03 INFO - ##### 17:13:03 INFO - ##### Finished clobber step (success) 17:13:03 INFO - ##### 17:13:03 INFO - ##### 17:13:03 INFO - ##### Running read-buildbot-config step. 17:13:03 INFO - ##### 17:13:03 INFO - Running pre-action listener: _resource_record_pre_action 17:13:03 INFO - Running main action method: read_buildbot_config 17:13:03 INFO - Using buildbot properties: 17:13:03 INFO - { 17:13:03 INFO - "project": "", 17:13:03 INFO - "product": "firefox", 17:13:03 INFO - "script_repo_revision": "production", 17:13:03 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:13:03 INFO - "repository": "", 17:13:03 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 17:13:03 INFO - "buildid": "20160701163622", 17:13:03 INFO - "pgo_build": "False", 17:13:03 INFO - "basedir": "/builds/slave/test", 17:13:03 INFO - "buildnumber": 1924, 17:13:03 INFO - "slavename": "talos-linux64-ix-042", 17:13:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:13:03 INFO - "platform": "ubuntu64_hw", 17:13:03 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:13:03 INFO - "branch": "fx-team", 17:13:03 INFO - "repo_path": "integration/fx-team", 17:13:03 INFO - "revision": "1bbc4c035fd893b9ea1039c08bd28f34b8b66574", 17:13:03 INFO - "stage_platform": "linux64", 17:13:03 INFO - "builduid": "3ffc009058604326a6fae6372a6a65f2", 17:13:03 INFO - "slavebuilddir": "test" 17:13:03 INFO - } 17:13:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/Tu5EVArkRhq3ZR4RPOOOmA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 17:13:03 INFO - Running post-action listener: _resource_record_post_action 17:13:03 INFO - ##### 17:13:03 INFO - ##### Finished read-buildbot-config step (success) 17:13:03 INFO - ##### 17:13:03 INFO - ##### 17:13:03 INFO - ##### Running download-and-extract step. 17:13:03 INFO - ##### 17:13:03 INFO - Running pre-action listener: _resource_record_pre_action 17:13:03 INFO - Running main action method: download_and_extract 17:13:03 INFO - mkdir: /builds/slave/test/build/tests 17:13: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')]} 17:13:03 INFO - https://queue.taskcluster.net/v1/task/Tu5EVArkRhq3ZR4RPOOOmA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:13:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tu5EVArkRhq3ZR4RPOOOmA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:13:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tu5EVArkRhq3ZR4RPOOOmA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:13:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tu5EVArkRhq3ZR4RPOOOmA/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 17:13:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tu5EVArkRhq3ZR4RPOOOmA/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 17:13:04 INFO - Downloaded 1361 bytes. 17:13:04 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:13:04 INFO - Using the following test package requirements: 17:13:04 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:13:04 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:13:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:13:04 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:13:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:13:04 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:13:04 INFO - u'jsshell-linux-x86_64.zip'], 17:13:04 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:13:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:13:04 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:13:04 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:13:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:13:04 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:13:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:13:04 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:13:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:13:04 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:13:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:13:04 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:04 INFO - https://queue.taskcluster.net/v1/task/Tu5EVArkRhq3ZR4RPOOOmA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:13:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tu5EVArkRhq3ZR4RPOOOmA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:13:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tu5EVArkRhq3ZR4RPOOOmA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:13:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tu5EVArkRhq3ZR4RPOOOmA/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 17:13:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tu5EVArkRhq3ZR4RPOOOmA/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 17:13:07 INFO - Downloaded 22704157 bytes. 17:13:07 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'] 17:13:07 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 17:13:08 INFO - Return code: 0 17:13:08 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 17:13:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:08 INFO - https://queue.taskcluster.net/v1/task/Tu5EVArkRhq3ZR4RPOOOmA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:13:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tu5EVArkRhq3ZR4RPOOOmA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:13:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tu5EVArkRhq3ZR4RPOOOmA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:13:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tu5EVArkRhq3ZR4RPOOOmA/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 17:13:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tu5EVArkRhq3ZR4RPOOOmA/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 17:13:09 INFO - Downloaded 22704157 bytes. 17:13:09 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'] 17:13:09 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 17:13:11 INFO - Return code: 0 17:13: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')]} 17:13:11 INFO - https://queue.taskcluster.net/v1/task/Tu5EVArkRhq3ZR4RPOOOmA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:13:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tu5EVArkRhq3ZR4RPOOOmA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:13:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tu5EVArkRhq3ZR4RPOOOmA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:13:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tu5EVArkRhq3ZR4RPOOOmA/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 17:13:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tu5EVArkRhq3ZR4RPOOOmA/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 17:13:12 INFO - Downloaded 14405242 bytes. 17:13:12 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'] 17:13:12 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 17:13:12 INFO - Return code: 0 17:13:12 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')]} 17:13:12 INFO - https://queue.taskcluster.net/v1/task/Tu5EVArkRhq3ZR4RPOOOmA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:13:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tu5EVArkRhq3ZR4RPOOOmA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:13:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tu5EVArkRhq3ZR4RPOOOmA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:13:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tu5EVArkRhq3ZR4RPOOOmA/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 17:13:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tu5EVArkRhq3ZR4RPOOOmA/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 17:13:13 INFO - Downloaded 56459298 bytes. 17:13:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Tu5EVArkRhq3ZR4RPOOOmA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:13:13 INFO - mkdir: /builds/slave/test/properties 17:13:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:13:13 INFO - Writing to file /builds/slave/test/properties/build_url 17:13:13 INFO - Contents: 17:13:13 INFO - build_url:https://queue.taskcluster.net/v1/task/Tu5EVArkRhq3ZR4RPOOOmA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:13:14 INFO - Running post-action listener: _resource_record_post_action 17:13:14 INFO - Running post-action listener: set_extra_try_arguments 17:13:14 INFO - ##### 17:13:14 INFO - ##### Finished download-and-extract step (success) 17:13:14 INFO - ##### 17:13:14 INFO - ##### 17:13:14 INFO - ##### Running populate-webroot step. 17:13:14 INFO - ##### 17:13:14 INFO - Running pre-action listener: _resource_record_pre_action 17:13:14 INFO - Running main action method: populate_webroot 17:13:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:13:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:13:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:13:14 INFO - '--tppagecycles', 17:13:14 INFO - '7'], 17:13:14 INFO - 'tests': ['tsvgm']}}, 17:13:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:13:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:13:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:13:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:13:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:13:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:13:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:14 INFO - 'talos_options': ['--disable-e10s'], 17:13:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:13:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:13:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:14 INFO - 'talos_options': ['--disable-e10s'], 17:13:14 INFO - 'tests': ['damp', 'tps']}, 17:13:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:14 INFO - 'tests': ['damp', 'tps']}, 17:13:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:13:14 INFO - 'tests': ['dromaeo_dom']}, 17:13:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:13:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:13:14 INFO - 'tests': ['basic_compositor_video']}, 17:13:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:13:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:13:14 INFO - 'tests': ['a11yr', 17:13:14 INFO - 'ts_paint', 17:13:14 INFO - 'tpaint', 17:13:14 INFO - 'sessionrestore', 17:13:14 INFO - 'sessionrestore_no_auto_restore', 17:13:14 INFO - 'tabpaint']}, 17:13:14 INFO - 'other-e10s': {'tests': ['a11yr', 17:13:14 INFO - 'ts_paint', 17:13:14 INFO - 'tpaint', 17:13:14 INFO - 'sessionrestore', 17:13:14 INFO - 'sessionrestore_no_auto_restore', 17:13:14 INFO - 'tabpaint']}, 17:13:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:13:14 INFO - 'ts_paint', 17:13:14 INFO - 'tpaint', 17:13:14 INFO - 'sessionrestore', 17:13:14 INFO - 'sessionrestore_no_auto_restore', 17:13:14 INFO - 'tabpaint']}, 17:13:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:13:14 INFO - 'ts_paint', 17:13:14 INFO - 'tpaint', 17:13:14 INFO - 'sessionrestore', 17:13:14 INFO - 'sessionrestore_no_auto_restore', 17:13:14 INFO - 'tabpaint']}, 17:13:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:13:14 INFO - 'tests': ['a11yr', 17:13:14 INFO - 'ts_paint', 17:13:14 INFO - 'tpaint', 17:13:14 INFO - 'sessionrestore', 17:13:14 INFO - 'sessionrestore_no_auto_restore', 17:13:14 INFO - 'tabpaint']}, 17:13:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:13:14 INFO - 'tests': ['a11yr', 17:13:14 INFO - 'ts_paint', 17:13:14 INFO - 'tpaint', 17:13:14 INFO - 'sessionrestore', 17:13:14 INFO - 'sessionrestore_no_auto_restore', 17:13:14 INFO - 'tabpaint']}, 17:13:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:13:14 INFO - 'tests': ['tsvgx', 17:13:14 INFO - 'tsvgr_opacity', 17:13:14 INFO - 'tart', 17:13:14 INFO - 'tscrollx', 17:13:14 INFO - 'cart']}, 17:13:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:13:14 INFO - 'tsvgr_opacity', 17:13:14 INFO - 'tart', 17:13:14 INFO - 'tscrollx', 17:13:14 INFO - 'cart']}, 17:13:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:14 INFO - 'talos_options': ['--disable-e10s'], 17:13:14 INFO - 'tests': ['tp5o']}, 17:13:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:14 INFO - 'tests': ['tp5o']}, 17:13:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:14 INFO - 'talos_options': ['--disable-e10s', 17:13:14 INFO - '--xperf_path', 17:13:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:13:14 INFO - 'tests': ['tp5n']}, 17:13:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:14 INFO - 'talos_options': ['--xperf_path', 17:13:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:13:14 INFO - 'tests': ['tp5n']}}, 17:13:14 INFO - 'talos.zip': {'path': '', 17:13:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:13:14 INFO - Running post-action listener: _resource_record_post_action 17:13:14 INFO - ##### 17:13:14 INFO - ##### Finished populate-webroot step (success) 17:13:14 INFO - ##### 17:13:14 INFO - ##### 17:13:14 INFO - ##### Running create-virtualenv step. 17:13:14 INFO - ##### 17:13:14 INFO - Running pre-action listener: _resource_record_pre_action 17:13:14 INFO - Running main action method: create_virtualenv 17:13:14 INFO - Creating virtualenv /builds/slave/test/build/venv 17:13:14 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 17:13:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:13:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:13:14 INFO - Using real prefix '/usr' 17:13:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:13:15 INFO - Installing distribute.............................................................................................................................................................................................done. 17:13:17 INFO - Installing pip.................done. 17:13:17 INFO - Return code: 0 17:13:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:13:17 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')]} 17:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:17 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')]} 17:13:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:17 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 0x1ddf030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209e3b0>, '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 0x209f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x209f740>, '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-1467417046.763097-1411699576', '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 17:13:17 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 17:13:17 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 17:13:17 INFO - Using env: {'DISPLAY': ':0', 17:13:17 INFO - 'HOME': '/home/cltbld', 17:13:17 INFO - 'LANG': 'en_US.UTF-8', 17:13:17 INFO - 'LANGUAGE': 'en_US:en', 17:13:17 INFO - 'LOGNAME': 'cltbld', 17:13:17 INFO - 'MAIL': '/var/mail/cltbld', 17:13:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:17 INFO - 'MOZ_NO_REMOTE': '1', 17:13:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:17 INFO - 'NO_EM_RESTART': '1', 17:13:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:17 INFO - 'PWD': '/builds/slave/test', 17:13:17 INFO - 'SHELL': '/bin/bash', 17:13:17 INFO - 'SHLVL': '1', 17:13:17 INFO - 'TERM': 'linux', 17:13:17 INFO - 'TMOUT': '86400', 17:13:17 INFO - 'USER': 'cltbld', 17:13:17 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467417046.763097-1411699576', 17:13:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:17 INFO - '_': '/tools/buildbot/bin/python'} 17:13:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:17 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 17:13:17 INFO - Cleaning up... 17:13:17 INFO - Return code: 0 17:13:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:13:17 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')]} 17:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:17 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')]} 17:13:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:17 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 0x1ddf030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209e3b0>, '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 0x209f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x209f740>, '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-1467417046.763097-1411699576', '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 17:13:17 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 17:13:17 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 17:13:17 INFO - Using env: {'DISPLAY': ':0', 17:13:17 INFO - 'HOME': '/home/cltbld', 17:13:17 INFO - 'LANG': 'en_US.UTF-8', 17:13:17 INFO - 'LANGUAGE': 'en_US:en', 17:13:17 INFO - 'LOGNAME': 'cltbld', 17:13:17 INFO - 'MAIL': '/var/mail/cltbld', 17:13:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:17 INFO - 'MOZ_NO_REMOTE': '1', 17:13:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:17 INFO - 'NO_EM_RESTART': '1', 17:13:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:17 INFO - 'PWD': '/builds/slave/test', 17:13:17 INFO - 'SHELL': '/bin/bash', 17:13:17 INFO - 'SHLVL': '1', 17:13:17 INFO - 'TERM': 'linux', 17:13:17 INFO - 'TMOUT': '86400', 17:13:17 INFO - 'USER': 'cltbld', 17:13:17 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467417046.763097-1411699576', 17:13:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:17 INFO - '_': '/tools/buildbot/bin/python'} 17:13:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:17 INFO - Downloading/unpacking psutil>=3.1.1 17:13:17 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 17:13:17 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 17:13:17 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 17:13:17 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 17:13:17 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 17:13:17 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 17:13:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:13:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:13:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:13:19 INFO - Installing collected packages: psutil 17:13:19 INFO - Running setup.py install for psutil 17:13:19 INFO - building 'psutil._psutil_linux' extension 17:13:19 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 17:13:20 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 17:13:20 INFO - building 'psutil._psutil_posix' extension 17:13:20 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 17:13:20 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 17:13:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:13:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:13:20 INFO - Successfully installed psutil 17:13:20 INFO - Cleaning up... 17:13:20 INFO - Return code: 0 17:13:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:13:20 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')]} 17:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:20 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')]} 17:13:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:20 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 0x1ddf030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209e3b0>, '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 0x209f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x209f740>, '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-1467417046.763097-1411699576', '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 17:13:20 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 17:13:20 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 17:13:20 INFO - Using env: {'DISPLAY': ':0', 17:13:20 INFO - 'HOME': '/home/cltbld', 17:13:20 INFO - 'LANG': 'en_US.UTF-8', 17:13:20 INFO - 'LANGUAGE': 'en_US:en', 17:13:20 INFO - 'LOGNAME': 'cltbld', 17:13:20 INFO - 'MAIL': '/var/mail/cltbld', 17:13:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:20 INFO - 'MOZ_NO_REMOTE': '1', 17:13:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:20 INFO - 'NO_EM_RESTART': '1', 17:13:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:20 INFO - 'PWD': '/builds/slave/test', 17:13:20 INFO - 'SHELL': '/bin/bash', 17:13:20 INFO - 'SHLVL': '1', 17:13:20 INFO - 'TERM': 'linux', 17:13:20 INFO - 'TMOUT': '86400', 17:13:20 INFO - 'USER': 'cltbld', 17:13:20 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467417046.763097-1411699576', 17:13:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:20 INFO - '_': '/tools/buildbot/bin/python'} 17:13:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:13:20 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 17:13:20 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 17:13:20 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 17:13:20 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 17:13:20 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 17:13:20 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 17:13:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:13:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:13:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:13:22 INFO - Installing collected packages: mozsystemmonitor 17:13:22 INFO - Running setup.py install for mozsystemmonitor 17:13:22 INFO - Successfully installed mozsystemmonitor 17:13:22 INFO - Cleaning up... 17:13:22 INFO - Return code: 0 17:13:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:13:22 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')]} 17:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:22 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')]} 17:13:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:22 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 0x1ddf030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209e3b0>, '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 0x209f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x209f740>, '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-1467417046.763097-1411699576', '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 17:13:22 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 17:13:22 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 17:13:22 INFO - Using env: {'DISPLAY': ':0', 17:13:22 INFO - 'HOME': '/home/cltbld', 17:13:22 INFO - 'LANG': 'en_US.UTF-8', 17:13:22 INFO - 'LANGUAGE': 'en_US:en', 17:13:22 INFO - 'LOGNAME': 'cltbld', 17:13:22 INFO - 'MAIL': '/var/mail/cltbld', 17:13:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:22 INFO - 'MOZ_NO_REMOTE': '1', 17:13:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:22 INFO - 'NO_EM_RESTART': '1', 17:13:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:22 INFO - 'PWD': '/builds/slave/test', 17:13:22 INFO - 'SHELL': '/bin/bash', 17:13:22 INFO - 'SHLVL': '1', 17:13:22 INFO - 'TERM': 'linux', 17:13:22 INFO - 'TMOUT': '86400', 17:13:22 INFO - 'USER': 'cltbld', 17:13:22 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467417046.763097-1411699576', 17:13:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:22 INFO - '_': '/tools/buildbot/bin/python'} 17:13:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:22 INFO - Downloading/unpacking jsonschema==2.5.1 17:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:13:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:13:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:24 INFO - Downloading functools32-3.2.3-2.tar.gz 17:13:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:13:25 INFO - warning: no files found matching '*.txt' 17:13:25 INFO - no previously-included directories found matching 'build' 17:13:25 INFO - no previously-included directories found matching 'dist' 17:13:25 INFO - no previously-included directories found matching '.git*' 17:13:25 INFO - Installing collected packages: jsonschema, functools32 17:13:25 INFO - Running setup.py install for functools32 17:13:25 INFO - warning: no files found matching '*.txt' 17:13:25 INFO - no previously-included directories found matching 'build' 17:13:25 INFO - no previously-included directories found matching 'dist' 17:13:25 INFO - no previously-included directories found matching '.git*' 17:13:25 INFO - Successfully installed jsonschema functools32 17:13:25 INFO - Cleaning up... 17:13:25 INFO - Return code: 0 17:13:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:13:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:25 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 0x1ddf030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209e3b0>, '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 0x209f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x209f740>, '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-1467417046.763097-1411699576', '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 17:13:25 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 17:13:25 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 17:13:25 INFO - Using env: {'DISPLAY': ':0', 17:13:25 INFO - 'HOME': '/home/cltbld', 17:13:25 INFO - 'LANG': 'en_US.UTF-8', 17:13:25 INFO - 'LANGUAGE': 'en_US:en', 17:13:25 INFO - 'LOGNAME': 'cltbld', 17:13:25 INFO - 'MAIL': '/var/mail/cltbld', 17:13:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:25 INFO - 'MOZ_NO_REMOTE': '1', 17:13:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:25 INFO - 'NO_EM_RESTART': '1', 17:13:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:25 INFO - 'PWD': '/builds/slave/test', 17:13:25 INFO - 'SHELL': '/bin/bash', 17:13:25 INFO - 'SHLVL': '1', 17:13:25 INFO - 'TERM': 'linux', 17:13:25 INFO - 'TMOUT': '86400', 17:13:25 INFO - 'USER': 'cltbld', 17:13:25 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467417046.763097-1411699576', 17:13:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:25 INFO - '_': '/tools/buildbot/bin/python'} 17:13:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:25 INFO - Downloading/unpacking blobuploader==1.2.4 17:13:25 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 17:13:25 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 17:13:25 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 17:13:25 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 17:13:25 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 17:13:25 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 17:13:27 INFO - Downloading blobuploader-1.2.4.tar.gz 17:13:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:13:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:13:27 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 17:13:27 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 17:13:27 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 17:13:27 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 17:13:27 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 17:13:27 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 17:13:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:13:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:13:27 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 17:13:27 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 17:13:27 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 17:13:27 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 17:13:27 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 17:13:27 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 17:13:28 INFO - Downloading docopt-0.6.1.tar.gz 17:13:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:13:28 INFO - Installing collected packages: blobuploader, requests, docopt 17:13:28 INFO - Running setup.py install for blobuploader 17:13:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:13:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:13:28 INFO - Running setup.py install for requests 17:13:28 INFO - Running setup.py install for docopt 17:13:28 INFO - Successfully installed blobuploader requests docopt 17:13:28 INFO - Cleaning up... 17:13:28 INFO - Return code: 0 17:13:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:28 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 0x1ddf030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209e3b0>, '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 0x209f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x209f740>, '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-1467417046.763097-1411699576', '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 17:13:28 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 17:13:28 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 17:13:28 INFO - Using env: {'DISPLAY': ':0', 17:13:28 INFO - 'HOME': '/home/cltbld', 17:13:28 INFO - 'LANG': 'en_US.UTF-8', 17:13:28 INFO - 'LANGUAGE': 'en_US:en', 17:13:28 INFO - 'LOGNAME': 'cltbld', 17:13:28 INFO - 'MAIL': '/var/mail/cltbld', 17:13:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:28 INFO - 'MOZ_NO_REMOTE': '1', 17:13:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:28 INFO - 'NO_EM_RESTART': '1', 17:13:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:28 INFO - 'PWD': '/builds/slave/test', 17:13:28 INFO - 'SHELL': '/bin/bash', 17:13:28 INFO - 'SHLVL': '1', 17:13:28 INFO - 'TERM': 'linux', 17:13:28 INFO - 'TMOUT': '86400', 17:13:28 INFO - 'USER': 'cltbld', 17:13:28 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467417046.763097-1411699576', 17:13:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:28 INFO - '_': '/tools/buildbot/bin/python'} 17:13:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:13:28 INFO - Running setup.py (path:/tmp/pip-z4FMu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:13:29 INFO - Running setup.py (path:/tmp/pip-B4X9Mp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:13:29 INFO - Running setup.py (path:/tmp/pip-M6wDcZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:13:29 INFO - Running setup.py (path:/tmp/pip-zSqQp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:13:29 INFO - Running setup.py (path:/tmp/pip-YMLZOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:13:29 INFO - Running setup.py (path:/tmp/pip-PZY1Rf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:13:29 INFO - Running setup.py (path:/tmp/pip-QjSMIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:13:29 INFO - Running setup.py (path:/tmp/pip-vZGttW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:13:29 INFO - Running setup.py (path:/tmp/pip-9rQGbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:13:29 INFO - Running setup.py (path:/tmp/pip-pO3KG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:13:29 INFO - Running setup.py (path:/tmp/pip-phgQv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:13:29 INFO - Running setup.py (path:/tmp/pip-_fDMHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:13:29 INFO - Running setup.py (path:/tmp/pip-18lLrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:13:29 INFO - Running setup.py (path:/tmp/pip-twI0pp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:29 INFO - Running setup.py (path:/tmp/pip-jTN8dG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:13:30 INFO - Running setup.py (path:/tmp/pip-vp4z9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:13:30 INFO - Running setup.py (path:/tmp/pip-Su2peq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:13:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:13:30 INFO - Running setup.py install for manifestparser 17:13:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:13:30 INFO - Running setup.py install for mozcrash 17:13:30 INFO - Running setup.py install for mozdebug 17:13:30 INFO - Running setup.py install for mozdevice 17:13:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:13:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:13:30 INFO - Running setup.py install for mozfile 17:13:30 INFO - Running setup.py install for mozhttpd 17:13:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:13:30 INFO - Running setup.py install for mozinfo 17:13:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:13:30 INFO - Running setup.py install for mozInstall 17:13:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:13:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:13:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:13:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:13:30 INFO - Running setup.py install for mozleak 17:13:31 INFO - Running setup.py install for mozlog 17:13:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:13:31 INFO - Running setup.py install for moznetwork 17:13:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:13:31 INFO - Running setup.py install for mozprocess 17:13:31 INFO - Running setup.py install for mozprofile 17:13:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:13:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:13:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:13:31 INFO - Running setup.py install for mozrunner 17:13:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:13:31 INFO - Running setup.py install for mozscreenshot 17:13:31 INFO - Running setup.py install for moztest 17:13:31 INFO - Running setup.py install for mozversion 17:13:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:13:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:13:31 INFO - Cleaning up... 17:13:31 INFO - Return code: 0 17:13:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:13:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:31 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 0x1ddf030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209e3b0>, '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 0x209f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x209f740>, '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-1467417046.763097-1411699576', '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 17:13:31 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 17:13:31 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 17:13:31 INFO - Using env: {'DISPLAY': ':0', 17:13:31 INFO - 'HOME': '/home/cltbld', 17:13:31 INFO - 'LANG': 'en_US.UTF-8', 17:13:31 INFO - 'LANGUAGE': 'en_US:en', 17:13:31 INFO - 'LOGNAME': 'cltbld', 17:13:31 INFO - 'MAIL': '/var/mail/cltbld', 17:13:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:31 INFO - 'MOZ_NO_REMOTE': '1', 17:13:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:31 INFO - 'NO_EM_RESTART': '1', 17:13:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:31 INFO - 'PWD': '/builds/slave/test', 17:13:31 INFO - 'SHELL': '/bin/bash', 17:13:31 INFO - 'SHLVL': '1', 17:13:31 INFO - 'TERM': 'linux', 17:13:31 INFO - 'TMOUT': '86400', 17:13:31 INFO - 'USER': 'cltbld', 17:13:31 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467417046.763097-1411699576', 17:13:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:31 INFO - '_': '/tools/buildbot/bin/python'} 17:13:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:13:32 INFO - Running setup.py (path:/tmp/pip-ZBeMIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:13:32 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)) 17:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:13:32 INFO - Running setup.py (path:/tmp/pip-0dfhFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:13:32 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)) 17:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:13:32 INFO - Running setup.py (path:/tmp/pip-0vM7lS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:13:32 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)) 17:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:13:32 INFO - Running setup.py (path:/tmp/pip-DV0aIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:13:32 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)) 17:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:13:32 INFO - Running setup.py (path:/tmp/pip-DCGxmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:13:32 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)) 17:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:13:32 INFO - Running setup.py (path:/tmp/pip-rjVDK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:13:32 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)) 17:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:13:32 INFO - Running setup.py (path:/tmp/pip-XciktJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:13:32 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)) 17:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:13:32 INFO - Running setup.py (path:/tmp/pip-neVDAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:13:32 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)) 17:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:13:32 INFO - Running setup.py (path:/tmp/pip-qcWrzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:13:32 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)) 17:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:13:32 INFO - Running setup.py (path:/tmp/pip-T1BWGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:13:32 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)) 17:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:13:32 INFO - Running setup.py (path:/tmp/pip-ns2ftt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:13:32 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)) 17:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:13:33 INFO - Running setup.py (path:/tmp/pip-BxUs8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:13:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:13:33 INFO - Running setup.py (path:/tmp/pip-P8AExM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:13:33 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)) 17:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:13:33 INFO - Running setup.py (path:/tmp/pip-_f20eY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:13:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:33 INFO - Running setup.py (path:/tmp/pip-cd5Egj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:33 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)) 17:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:13:33 INFO - Running setup.py (path:/tmp/pip-RzNPWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:13:33 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)) 17:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:13:33 INFO - Running setup.py (path:/tmp/pip-DyKzBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:13:33 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)) 17:13:33 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)) 17:13:33 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)) 17:13:33 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)) 17:13:33 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)) 17:13:33 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)) 17:13:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:13:33 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 17:13:33 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 17:13:33 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 17:13:33 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 17:13:33 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 17:13:33 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 17:13:35 INFO - Downloading blessings-1.6.tar.gz 17:13:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:13:35 INFO - Installing collected packages: blessings 17:13:35 INFO - Running setup.py install for blessings 17:13:35 INFO - Successfully installed blessings 17:13:35 INFO - Cleaning up... 17:13:35 INFO - Return code: 0 17:13:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:13:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:13:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:13:35 INFO - Reading from file tmpfile_stdout 17:13:35 INFO - Current package versions: 17:13:35 INFO - argparse == 1.2.1 17:13:35 INFO - blessings == 1.6 17:13:35 INFO - blobuploader == 1.2.4 17:13:35 INFO - docopt == 0.6.1 17:13:35 INFO - functools32 == 3.2.3-2 17:13:35 INFO - jsonschema == 2.5.1 17:13:35 INFO - manifestparser == 1.1 17:13:35 INFO - mozInstall == 1.12 17:13:35 INFO - mozcrash == 0.17 17:13:35 INFO - mozdebug == 0.1 17:13:35 INFO - mozdevice == 0.48 17:13:35 INFO - mozfile == 1.2 17:13:35 INFO - mozhttpd == 0.7 17:13:35 INFO - mozinfo == 0.9 17:13:35 INFO - mozleak == 0.1 17:13:35 INFO - mozlog == 3.2 17:13:35 INFO - moznetwork == 0.27 17:13:35 INFO - mozprocess == 0.22 17:13:35 INFO - mozprofile == 0.28 17:13:35 INFO - mozrunner == 6.11 17:13:35 INFO - mozscreenshot == 0.1 17:13:35 INFO - mozsystemmonitor == 0.3 17:13:35 INFO - moztest == 0.7 17:13:35 INFO - mozversion == 1.4 17:13:35 INFO - psutil == 3.1.1 17:13:35 INFO - requests == 1.2.3 17:13:35 INFO - wsgiref == 0.1.2 17:13:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:13:35 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')]} 17:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:35 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')]} 17:13:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:35 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 0x1ddf030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209e3b0>, '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 0x209f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x209f740>, '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-1467417046.763097-1411699576', '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 17:13:35 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 17:13:35 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 17:13:35 INFO - Using env: {'DISPLAY': ':0', 17:13:35 INFO - 'HOME': '/home/cltbld', 17:13:35 INFO - 'LANG': 'en_US.UTF-8', 17:13:35 INFO - 'LANGUAGE': 'en_US:en', 17:13:35 INFO - 'LOGNAME': 'cltbld', 17:13:35 INFO - 'MAIL': '/var/mail/cltbld', 17:13:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:35 INFO - 'MOZ_NO_REMOTE': '1', 17:13:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:35 INFO - 'NO_EM_RESTART': '1', 17:13:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:35 INFO - 'PWD': '/builds/slave/test', 17:13:35 INFO - 'SHELL': '/bin/bash', 17:13:35 INFO - 'SHLVL': '1', 17:13:35 INFO - 'TERM': 'linux', 17:13:35 INFO - 'TMOUT': '86400', 17:13:35 INFO - 'USER': 'cltbld', 17:13:35 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467417046.763097-1411699576', 17:13:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:35 INFO - '_': '/tools/buildbot/bin/python'} 17:13:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:36 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)) 17:13:36 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)) 17:13:36 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)) 17:13:36 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)) 17:13:36 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)) 17:13:36 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)) 17:13:36 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)) 17:13:36 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)) 17:13:36 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)) 17:13:36 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)) 17:13:36 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)) 17:13:36 INFO - Cleaning up... 17:13:36 INFO - Return code: 0 17:13:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:13:36 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')]} 17:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:36 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')]} 17:13:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:36 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 0x1ddf030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209e3b0>, '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 0x209f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x209f740>, '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-1467417046.763097-1411699576', '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 17:13:36 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 17:13:36 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 17:13:36 INFO - Using env: {'DISPLAY': ':0', 17:13:36 INFO - 'HOME': '/home/cltbld', 17:13:36 INFO - 'LANG': 'en_US.UTF-8', 17:13:36 INFO - 'LANGUAGE': 'en_US:en', 17:13:36 INFO - 'LOGNAME': 'cltbld', 17:13:36 INFO - 'MAIL': '/var/mail/cltbld', 17:13:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:36 INFO - 'MOZ_NO_REMOTE': '1', 17:13:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:36 INFO - 'NO_EM_RESTART': '1', 17:13:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:36 INFO - 'PWD': '/builds/slave/test', 17:13:36 INFO - 'SHELL': '/bin/bash', 17:13:36 INFO - 'SHLVL': '1', 17:13:36 INFO - 'TERM': 'linux', 17:13:36 INFO - 'TMOUT': '86400', 17:13:36 INFO - 'USER': 'cltbld', 17:13:36 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467417046.763097-1411699576', 17:13:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:36 INFO - '_': '/tools/buildbot/bin/python'} 17:13:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:13:36 INFO - Cleaning up... 17:13:36 INFO - Return code: 0 17:13:36 INFO - Running post-action listener: _resource_record_post_action 17:13:36 INFO - Running post-action listener: _start_resource_monitoring 17:13:36 INFO - Starting resource monitoring. 17:13:36 INFO - ##### 17:13:36 INFO - ##### Finished create-virtualenv step (success) 17:13:36 INFO - ##### 17:13:36 INFO - ##### 17:13:36 INFO - ##### Running install step. 17:13:36 INFO - ##### 17:13:36 INFO - Running pre-action listener: _resource_record_pre_action 17:13:36 INFO - Running main action method: install 17:13:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:13:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:13:36 INFO - Reading from file tmpfile_stdout 17:13:36 INFO - Detecting whether we're running mozinstall >=1.0... 17:13:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:13:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:13:36 INFO - Reading from file tmpfile_stdout 17:13:36 INFO - Output received: 17:13:36 INFO - Usage: mozinstall [options] installer 17:13:36 INFO - Options: 17:13:36 INFO - -h, --help show this help message and exit 17:13:36 INFO - -d DEST, --destination=DEST 17:13:36 INFO - Directory to install application into. [default: 17:13:36 INFO - "/builds/slave/test"] 17:13:36 INFO - --app=APP Application being installed. [default: firefox] 17:13:36 INFO - mkdir: /builds/slave/test/build/application 17:13:36 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'] 17:13:36 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 17:13:52 INFO - Reading from file tmpfile_stdout 17:13:52 INFO - Output received: 17:13:52 INFO - /builds/slave/test/build/application/firefox/firefox 17:13:52 INFO - Running post-action listener: _resource_record_post_action 17:13:52 INFO - ##### 17:13:52 INFO - ##### Finished install step (success) 17:13:52 INFO - ##### 17:13:52 INFO - ##### 17:13:52 INFO - ##### Running run-tests step. 17:13:52 INFO - ##### 17:13:52 INFO - Running pre-action listener: _resource_record_pre_action 17:13:52 INFO - Running main action method: run_tests 17:13:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:13:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:13:52 INFO - Python 2.7.3 17:13:52 INFO - Return code: 0 17:13:52 INFO - grabbing minidump binary from tooltool 17:13:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:52 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 0x209e3b0>, '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 0x209f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x209f740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:13:52 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 17:13:52 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 17:13:52 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 17:13:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:13:52 INFO - Return code: 0 17:13:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:13:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:13:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:13:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:13:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:13:52 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/Tu5EVArkRhq3ZR4RPOOOmA/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 17:13:52 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/Tu5EVArkRhq3ZR4RPOOOmA/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 17:13:52 INFO - Using env: {'DISPLAY': ':0', 17:13:52 INFO - 'HOME': '/home/cltbld', 17:13:52 INFO - 'LANG': 'en_US.UTF-8', 17:13:52 INFO - 'LANGUAGE': 'en_US:en', 17:13:52 INFO - 'LOGNAME': 'cltbld', 17:13:52 INFO - 'MAIL': '/var/mail/cltbld', 17:13:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:13:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:13:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:52 INFO - 'MOZ_NO_REMOTE': '1', 17:13:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:13:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:52 INFO - 'NO_EM_RESTART': '1', 17:13:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:52 INFO - 'PWD': '/builds/slave/test', 17:13:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:13:52 INFO - 'SHELL': '/bin/bash', 17:13:52 INFO - 'SHLVL': '1', 17:13:52 INFO - 'TERM': 'linux', 17:13:52 INFO - 'TMOUT': '86400', 17:13:52 INFO - 'USER': 'cltbld', 17:13:52 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1467417046.763097-1411699576', 17:13:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:52 INFO - '_': '/tools/buildbot/bin/python'} 17:13:52 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/Tu5EVArkRhq3ZR4RPOOOmA/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 17:13:53 INFO - mozversion application_buildid: 20160701163622 17:13:53 INFO - mozversion application_changeset: 1bbc4c035fd893b9ea1039c08bd28f34b8b66574 17:13:53 INFO - mozversion application_display_name: Nightly 17:13:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:13:53 INFO - mozversion application_name: Firefox 17:13:53 INFO - mozversion application_remotingname: firefox 17:13:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:13:53 INFO - mozversion application_vendor: Mozilla 17:13:53 INFO - mozversion application_version: 50.0a1 17:13:53 INFO - mozversion platform_buildid: 20160701163622 17:13:53 INFO - mozversion platform_changeset: 1bbc4c035fd893b9ea1039c08bd28f34b8b66574 17:13:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:13:53 INFO - mozversion platform_version: 50.0a1 17:13:53 INFO - using testdate: 1467418433 17:13:53 INFO - actual date: 1467418433 17:13:53 INFO - starting webserver on 'localhost:56701' 17:13:53 INFO - SUITE-START | Running 2 tests 17:13:53 INFO - TEST-START | dromaeo_css 17:13:53 INFO - operating with platform_type : linux_ 17:13:53 INFO - Initialising browser for dromaeo_css test... 17:13:53 INFO - TEST-INFO | started process 11213 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp26v7Pk/profile http://localhost:56701/getInfo.html) 17:13:57 INFO - PROCESS | 11213 | __metrics Screen width/height:1600/1200 17:13:57 INFO - PROCESS | 11213 | colorDepth:24 17:13:57 INFO - PROCESS | 11213 | Browser inner width/height: 1024/697 17:13:57 INFO - PROCESS | 11213 | __metrics 17:13:58 INFO - PROCESS | 11213 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:13:59 INFO - TEST-INFO | 11213: exit 0 17:13:59 INFO - Browser initialized. 17:13:59 INFO - Running cycle 1/1 for dromaeo_css test... 17:13:59 INFO - TEST-INFO | started process 11293 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp26v7Pk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:14:11 INFO - PROCESS | 11293 | RSS: Main: 159551488 17:14:11 INFO - PROCESS | 11293 | 17:15:03 INFO - PROCESS | 11293 | 1467418503497 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] 17:17:15 INFO - PROCESS | 11293 | Cycle 1(1): loaded http://localhost:56701/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56701/tests/dromaeo/cssquery-ext.html) 17:17:16 INFO - PROCESS | 11293 | RSS: Main: 233644032 17:17:16 INFO - PROCESS | 11293 | 17:20:19 INFO - PROCESS | 11293 | Cycle 1(1): loaded http://localhost:56701/tests/dromaeo/cssquery-ext.html (next: http://localhost:56701/tests/dromaeo/cssquery-jquery.html) 17:20:19 INFO - PROCESS | 11293 | RSS: Main: 238858240 17:20:19 INFO - PROCESS | 11293 | 17:23:22 INFO - PROCESS | 11293 | Cycle 1(1): loaded http://localhost:56701/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56701/tests/dromaeo/cssquery-mootools.html) 17:23:22 INFO - PROCESS | 11293 | RSS: Main: 245321728 17:23:22 INFO - PROCESS | 11293 | 17:26:24 INFO - PROCESS | 11293 | Cycle 1(1): loaded http://localhost:56701/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56701/tests/dromaeo/cssquery-prototype.html) 17:26:25 INFO - PROCESS | 11293 | RSS: Main: 243953664 17:26:25 INFO - PROCESS | 11293 | 17:29:28 INFO - PROCESS | 11293 | Cycle 1(1): loaded http://localhost:56701/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56701/tests/dromaeo/cssquery-yui.html) 17:29:29 INFO - PROCESS | 11293 | RSS: Main: 216338432 17:29:29 INFO - PROCESS | 11293 | 17:32:31 INFO - PROCESS | 11293 | Cycle 1(1): loaded http://localhost:56701/tests/dromaeo/cssquery-yui.html (next: http://localhost:56701/tests/dromaeo/cssquery-dojo.html) 17:32:32 INFO - PROCESS | 11293 | RSS: Main: 278175744 17:32:32 INFO - PROCESS | 11293 | 17:32:32 INFO - PROCESS | 11293 | __start_tp_report 17:32:32 INFO - PROCESS | 11293 | _x_x_mozilla_page_load 17:32:32 INFO - PROCESS | 11293 | _x_x_mozilla_page_load_details 17:32:32 INFO - PROCESS | 11293 | |i|pagename|runs| 17:32:32 INFO - PROCESS | 11293 | |0;dojo.html;2650.3241673373286;2665.333666583354;2694.851783151927;2705.3642394037383;2706.4316493536357;4731.219348807451;4808.278758186274;4845.103655823675;4952.108620448318;5002.0496105739885;4736.905261894769;4835.68568043077;4856.684315519497;4900.411950565928;4901.754912254391;4419.18245124653;4436.134953684033;4512.210363186446;4567.018091110411;4610.884727881813;4535.097647193745;4540.341650460681;4591.77041147943;4613.769311534426;4640.814367425299;4383.715058521186;4384.978075109636;4420.9336859947125;4427.667924905645;4451.976045509551;4416.55834416559;4456.398386217851;4467.620252278561;4470.910581788378;4471.217536931056;4474.082813023322;4476.798544065525;4483.237849565582;4484.349769283468;4530.841420550265;4741.739204343759;4766.30888521166;4873.829415970424;4951.207806750938;4968.378952630921;5171.974140129275;5209.426963034063;5248.790048398059;5258.237555554461;5262.789488420459;5277.788888444457;5285.524302812765;5302.310699609026;5319.760610772524;5321.308229930123;4780.282957556325;4820.035992801384;4824.445188803263;4866.878328041792;4914.8771280718265;5350.4649535046965;5352.5450336721815;5360.142377219626;5429.538489228381;5434.619576629677;5149.433562308143;5150.330457040561;5167.173252279617;5211;5215.426303106655;5076.543111120017;5145.562627176657;5200.5059519345605;5211.166213405837;5273.077211487975;5153.2785410042625;5157.63896527247;5196.818111366084;5217.739113044333;5257.053730328501;5140.897182056338;5203.895922081537;5205.765740541685;5206.297149884717;5208.088584497774;4382.035952090535;4415.779211039435;4418.977905110454;4479.865604031885;4512.548745125461;3897.240038192582;3918.4710064140977;3923.136909879822;3936.4095385691803;3944.5463771666628;4501.887452813706;4536.72779633223;4551.931721024187;4592.7014744041535;4604.8388306409115;5334.733263336895;5336.519713225828;5340.279062326536;5341.679499230058;5346.759395827119;4546.340780586796;4549.681522293474;4552.135094332132;4591.058832939239;4596.839110631178;4611.054733779567;4671.392718946583;4687.250039993584;4710.034442939189;4767.61859051282;4900.338454308623;4900.921797204609;4904.730239836772;4935.728534930613;4937.160682684024;5134.8973020540125;5138.614603904647;5161.793528258828;5200.479952004769;5231.90130072689;4649.721016739007;4783;4792.257200133985;4845.6608037438455;4854.781534831011;5137.075326441276;5143.074246635641;5146.485351464824;5191.792328306977;5192.948070519397;5158.6131040171385;5163.561097306771;5172.19830926207;5194.039102766001;5202.739863006759;4900.607951363811;4941.728204948762;4968;5011.047900898818;5025.095482813129;5032.773525191302;5034.841986343088;5038.672486288379;5039.974800125976;5076.263941728503;4967.7019378837385;4983.601311895112;5007.24891266313;5027.924581131213;5051.040302342543;4871.683340582851;5056.924146137884;5086.262491938574;5088.923666144937;5102.1326374515675;4987.551120399036;5003.474635163401;5003.724795136157;5013.774380152829;5060.595152387874 17:32:32 INFO - PROCESS | 11293 | |1;ext.html;554.3043528909254;594.8542607061271;596.7612954818075;601.4466690644607;601.542827451137;39182.608173918255;40862.18275634485;40907.386389204185;41020;44640.3303950441;40972.180556388856;41338.793306033425;41339;41341.379879301836;41419.79290103545;7909.485883417574;8035.598220089001;8049.1950804919625;8051.2351326623875;8051.63767630458;7915.089764677078;7989.960050199741;7993.1607181246;7995.240452157036;7998.360131189491;8000.279974802266;8030.437869349148;8038.437309388345;8041.356691464698;8048.396370272224;7975.322097621709;8009.799755006172;8017.037955445355;8031.919680803176;8041.919580804176;7899.368050555941;7970.880436793453;7975.60121993898;7979.202079792032;7981.6408261627785;38177.809110954266;38427.23145537102;38507;38507.22985540274;38533.42199867004;3301.5873015873017;3451.551298331201;3636.4545318202217;3774.2640185163905;3783.5459744830796;29628.259293517618;29729;29740.85129574338;29752;30067.398652027056;3451.8964431067106;3543.982280088583;3594.3889538778208;3624.220792529619;3629.0927268182954;266851;267005;267064;268496;287894.56052719813;52482.73758631182;56237;57032.42967570354;57080;57130.428695713344;59099;59423.10865337023;59587;59594;59654;13466.797998030037;13602.387892544859;13607.863921360859;13608.047436679337;13608.795868061987;10713.142948564097;10760.623378181726;10811.945940270405;10822.242443028912;10839.891601084046;18450;18462.81537184638;18514.259429622663;18570.628587428175;18571.25714971413;6965.79102626922;7069.823254418578;7088.594958822061;7191.64041797908;7278.308560686726;822.7408366364576;934.63082082577;948.742915636784;960.0351646595267;1021.836506159011;27852.16443506698;28804;29191.416171676872;29227.7077229225;29370;946.7775072857872;975.0785507695301;976.9902300977042;1043.1341986151476;1103.0844399148687;14867.851321486647;15048.849511504965;15309.6172595686;15442.382304707686;15524.68950621004;399199;437190;445075;733197;734193;50004.749976249885;50328.24507632388;50727.49272507302;50747;50758.74620626947;1098.0008192544747;1189.143816452153;1206.1014544164477;1251.0804558649386;1253.1290752926811;27768.583471247544;28478.857605712667;28987;29581.85209073941;29686.703132969258;41472.58527414808;41971.160576788905;42118.789406052776;42129.57870421257;42133.15733685248;310579;311233;312553;312640;313314;22670;24704.50590988206;25483.872580636977;25655.743442565334;26942.191734248005;41022.58977410307;41318.1736365265;41361.79319103385;41669.374959375025;42300.192982631714;35175;35585.1103722409;35642;36219.818900905324;36288.63711362852;34512.48231276583;35150.47274290939;35372.82313588416;35510;35643.82178089093;34442.82778586091;35113.824430877685;35848;35921.101972449855;35973.46039809353;31021.224469388446;31627.367452650356;31958.067619435547;32003.519947201275;32375.352492950482;24947.376315592257;24947.75052249454;25224;25244.242672719847;25258.494830103664 17:32:32 INFO - PROCESS | 11293 | |2;jquery.html;342.11221879223405;368.70872011111226;369.8631506342652;373.9925201495971;385.9594742552032;13386;16773.664526709457;17353.739693904587;18724.15741291642;18746.062696865138;16925.57686057849;17004.319827206928;17060.48818535443;17355.566110847234;17366.13169341534;5037.874053148664;5319.468053194688;5375.731213439332;5384.596155288349;5385.892282154355;3822.3310920588788;5343.664083979005;5945.346011938684;6255.812325630216;6291.874162516747;6100.572959892787;6307;6342.238931328224;6349.047642853563;6354.809355719312;6332.430081292683;6360.618362898194;6365.809025729212;6396.040593910904;6403.391677790602;5399.136138217906;5567.8886422271735;5573.749181286852;5592.105263157875;5598.804041858515;17732;18124;18172.45482635523;18202.362917297964;18231.45305640833;2045.1512622261744;2252.8986195621073;2464.915437207641;2486.105002199207;2620.4366061296723;13230.206187628677;13821.308934553334;13886.93056534721;14362.497312594114;14549.636259093502;1747.8339557741995;1783.839454449106;1822.863285253598;1846.879952803077;1855.4248183063294;65482.672586637236;66014.66992665055;66060;67087.66456167736;67435.66282168607;8558.35812314079;9053.864192037125;9204.217641500414;9445.622175113056;9945.80108397828;12751.107422480338;13197;13209.471621135048;13290.401931913088;13301.534446294334;7250.9637451812405;7347.816304592321;7350.7427240046345;7353.6323183840595;7437.293457121565;6816.250212476623;6861.210960739479;7017.649117544102;7252.891206631904;7309.086364204474;6152.107944348045;6156.015037593964;6210.378962103753;6226.439620434183;6228.532860035425;1761.2778760708304;1778.919948602316;1846.22458567402;1867.3090956346239;1895.118769772035;811.5374236685033;889.7731078574922;894.1594900793234;945.9432434053979;950.3769595915323;17827.376041838474;18375;18381.776113919168;18385.81614183841;18516.444506664822;871.8430682477215;900.7703035725979;903.75146834621;906.9501177435304;970.315927271272;9869.506524673738;10279.640212592523;10398.478951192976;10435.895641043493;10580.735481612868;386034;392021;396846;400404;402627;67373.32626673671;70165.64917175483;70668.29331706617;71107.2889271111;71141.64429177821;874.0996773323487;881.7310720230263;899.7570655922995;910.4628269321132;913.9862902056475;15780.289886954884;16064.196790160679;16093.517194484184;16150.273237704096;16194.352225910832;23815.880920595286;33473.665263348026;34193.829030854686;36228.4565731509;37400.62599373971;45009.77495112635;45020.54979450163;45397.773011134734;47895.760521198565;47969.280460793816;7642.847143056996;7672.38620910337;7847.764567062997;7866.6066696666085;7905.102775333993;11864.584739534075;11995.220310679779;12291.139620226499;12342.691432714253;12459.563915262923;10496.895031049591;10523.684289471328;10611.575536978435;10642.62750803749;10761.085307748928;10293.948530257301;10595;10614.522346494581;10689;10880.564777408816;10303.433311167659;10666.946665266623;10668.413237272025;10687.25189236746;10786.244962852525;7593.430492712958;7672.616369181407;7836.764897053097;7911.960440197762;8058.717944871902;10622.415767132881;10670.253082284165;10801.081908037591;10874.836877447004;11039.39283339424 17:32:32 INFO - PROCESS | 11293 | |3;mootools.html;1273.6051823934579;1354.8103265542823;1369.2332293915408;1676.3378465506119;1714.1771949464257;7817.609119544021;8000.959995200031;8117;8123.065847427548;8126.024877014759;6948.305169483049;7497.137829149649;7660.348870346027;7664.4634875558595;7942.841143177133;2197.13213280754;2232.464208589943;2235.7540670526228;2237.876916769577;2238.0823862216494;2152.752433470155;2186.4424571734185;2246.3261021693506;2247.2696373678536;2247.415671925303;1909.3317338931402;2133.434639820449;2184.14818220894;2189.8029177374033;2195.2536137713173;2177.2597316912165;2192.8684278943156;2197.252934002439;2209.7569267380495;2211.347652442533;2151.397608669575;2153.8599991000533;2157.6224160771803;2161.4056134562966;2161.6217161996587;7801.687932482694;7838.216178382173;7840.13758486566;7841.960790196013;7847.764567062997;4474.82100715971;4595.862124136282;4608.907821843544;4610.077984403133;4614.192516309632;2905.0703774792073;2924.4151169766133;3038.8328641924686;3050.1612056684367;3052.5726398304255;950.0689324462066;967.9661211857551;973.445136272325;980.4117529482324;982.3909176310733;10803.4058126803;10804.351738895692;10813.891861081445;10817.891821081766;10821.67534973952;4071.694622903294;4198.265303571863;4303.311470164758;4311.935320970188;4387.210302145644;9244.445333280024;9302.95348523253;9307.696922430865;9313.301502387349;9324.813503729887;4484;4500;4500.639948804088;4501.279795232747;4503.211937910853;4120.711550191458;4128.979355103205;4178.331466965271;4179.164167166578;4180.937285940713;3682.797446140488;3704.2034613212572;3745.5879853216125;3792.051987003249;3874.3026255273758;1062.7874425115008;1142.280363371071;1162.4855803268638;1164.6913567904512;1183.917125801203;735.1986334894883;764.5107131435885;778.9610519474116;802.3140215115992;859.8882145321069;5258.631895767336;5270.472952704776;5338.546223570962;5343.278657381282;5411.918821217685;874.1651722604897;875.4572165257454;889.7197382824389;892.1970226795936;894.4570615687886;3545.822708864598;3610.1696609779897;3613.0425437259146;3707.0547010512146;3946.210757848442;9827.459489727991;9855.35940163887;9962.701118966443;10066.547005384775;10096.141827944706;9952.054554817281;9952.253580981456;9953.153981911619;9963.501824908726;9971.152452041513;6519.902201466982;7031.191412987469;7199.244079371695;7258.237885022102;7427.962860185665;5318.680879147263;5492.093804522209;5527;5580.469855363734;5586.748596313095;8779.956100219459;8892.955535222283;8954.462732236087;9027.774305642411;9046.140616641409;8996.820063598821;9019.368644194843;9203.539823008688;9222.538873056454;9289.814203716023;6949.895751563629;6953;7001.229864714775;7061.046758687511;7103.2186459488385;7562.470627056054;7566.1298950621385;7704.38364930793;7753.340966017951;7764.88352674699;5582.720863956867;7029.507934444539;7034.507584469038;7135.429165666838;7180.1742799578715;6776.322367763184;6877.724891004304;6909.481788865754;6966.756163534252;7034.050403195503;6349.206349206349;6383.96808015957;6439.098526206241;6444.484441244783;6446.194225721785;4582.221022426129;4718.764061796828;4763.452202996561;4820.734859582757;4853.223484242645;4758.5241475852135;4773.37946067009;4800.879978000578;4846.200376937766;4909.754512274443 17:32:32 INFO - PROCESS | 11293 | |4;prototype.html;297.3043079194684;301.43932285948136;306.24052350171576;306.5019343566704;310.3761439506592;4919;4919.1883339249025;4949.925751113737;4967.577755890745;4969.8569329054335;4811.941372897957;4890.559849613534;4897.779599918003;4904.975475122628;4909.950900490994;3651.671349578544;3763.9811800940956;3780.7164462665273;3782.470454136423;3784.6404591563896;3700.944485832701;3771.18919432322;3868.825902834365;3899.454076429302;3917.784521851297;3766.9434958475645;3846.7114966377494;3862.343401621731;3864.8840534783862;3896.79199448172;3763.9435408468894;3851.6533511983775;3864.246471937959;3871.3031654302213;3884.6503814656535;3213.068210219057;3297.38998285318;3416.7266618670446;3419.128122328815;3435.862565497402;4808.365155846994;4822.7829747661435;4824.6863953842885;4825.30033145192;4827.9034419311765;4415.889602759957;4417.580329868657;4424.579664931826;4428.070105277896;4429.889252768674;4921.483244259337;5125.205593133071;5127.717975511346;5155.922661160085;5178.844634660929;3682.355587772156;3703.962960370389;3731.8693845715543;3736.1406876418578;3744.3634582121103;5187.844364669028;5401.919616076801;5404.1625847212135;5404.540614047811;5412.539934105605;3703.5000274962536;3727.6086010969;3731.4962480065387;3736.8878933632036;3751.662350388478;3781.5840257571645;3796.9430458543143;3801.650414103009;3806.4290356446754;3808.8666896658483;4338.501072376654;4339.696221264544;4340.045190058182;4359.193549193409;4362.258416069276;5073.670211436245;5124.30821839047;5149.639525233198;5182.481751824787;5205.27126202332;1295.533607901155;1299.5841330774251;1316.776148054833;1317.4993502469192;1318.1695531815087;808.9716859909875;826.3430572694722;835.2315869400167;850.9914900850912;851.3317046118767;4044.4944381952255;4059.416827437302;4082.2651922653613;4083.816228269735;4085.2442298174337;4712.9057418851435;4736.95263047372;4739.95260047402;4751.52484751529;4794.832180873723;4050.6835278534595;4061.5126184857413;4085.9387109193385;4109.91780164395;4161.314667559644;2421.5520128776234;2518.3452302401506;2520.206135067448;2691.542437785581;2771.808122507341;4824.758762061883;4905.607551395951;4913.754312284372;4916.655834091579;4946.678465899777;5361.597880159004;5365.946340536622;5375.462453754593;5384.407715151408;5392.514673679388;4748.525147485224;4945.381827271591;4991.575716064102;5037.420696619935;5042.218456139304;5325.680459172462;5373.865653358697;5381.11211650089;5387.191921211849;5396.568274538106;5266.445149524133;5276.920846187387;5277.551408130198;5313.2561441397465;5331.733413329395;4966.354373931365;5051.646384753179;5054.140796064605;5054.898902021865;5069.493050694901;3755.230177813487;3762.698984081212;3766.642168993941;3768.2463507298103;3785.4511095891494;5388.568914486753;5410.594205434687;5419.4038655747045;5432.56539476833;5442.401335852974;5143.382794064736;5179.896402071862;5251.687078230442;5255.553277971415;5280.76236569363;5172.19830926207;5201.765920533509;5209.426963033988;5217.399999000164;5291.259223708761;5088.516590923857;5095.923561146512;5102.36220472441;5166.974165129151;5181.637285390138;4948.406191256928;5213.644452442317;5230.660007099526;5233.188855727369;5279.574514881037;5111.64218504716;5137.743112844418;5140.7429628517675;5172.508611681884;5229 17:32:32 INFO - PROCESS | 11293 | |5;yui.html;672.3276723276723;674.6559254780061;697.4072038767046;703.8662654095722;715.5992644119293;12778.3610819459;13558.728825423486;13959.860401395996;13976.161430314176;14091.859081409208;13355;13391;13459.798103028463;13467.057305988585;13470.528531501399;649.0750680280605;776.9145394006655;780.2353693380477;797.143071198461;809.0453265147124;804.9114597394282;805.3597390074875;807.7455601485514;808.4340961327065;808.7897146741831;851.0128251228576;852.4757274276337;852.9914700852975;853.2661910756744;853.5049671190726;663.4526515624605;680.1124532485105;680.6630717794674;685.0785693242581;843.464400105931;591.5858898770878;608.8964875971095;612.1796792298342;622.0855342646303;622.1911515030488;13094.214347139106;13170.736585268241;13203.207807531579;13287.667808304774;13302.135361201588;12647;13131.856634681444;13164.60506184816;13187.53843615469;13254.271015094166;10105.141063009652;10118.949405253;10562.683119506428;10881.238313317992;10968.670939871816;4129.463169787939;4157.272477316487;4248.808803603845;4290.635295999844;4360.847370342054;63432.36567634357;64530.3546964529;65720;67185;67408.32591674119;10428.113610343054;10810.567577296977;10836.72908177286;11082.722931926766;11086.390248536409;18261.452156435327;19379.51551211203;19427.80572194288;19472.221111155395;19487.805121948884;7202.171750248788;7352.19125896151;7385.556866587915;7420.36926861212;7576.848463030708;3876.612338766101;3917.5886531914307;3948.170884114311;4009.599040095967;4026.275270451288;2954.5863579098946;3027;3036.9088927332214;3058.7400070994213;3065.524843649238;544.901917654826;550.6640949021094;551.635920292605;560.1709469984446;567.7218163100051;502.6330778531619;542.3383472163954;585.7071464267866;589.7405141737622;610.8320211941751;8482;8680.652773888974;8806.86789698155;8809.823803523894;8926.776830579287;569.6240481282334;607.8571535689109;612.4824523277823;624.7251209467911;638.0939066525544;4015.31739604268;4273.081287523198;4287.421198138274;4362.367456718758;4386.758728269912;57021.42978570244;93641;94011.52994234985;96355.00466797761;96951.51524242475;81053;82728;83204.58397707973;83278;83690.5815470931;45327;74537.25462745411;74953.62523187349;75011.24988750042;75301;8130.634121464666;8239.711610093618;8288.461250018729;8329.791755206168;8465;44928.77535612301;45788.54211457843;46472;46536.53463465322;47205.29192062053;36810.263794724495;41409.1718165629;54733.45266547283;60243.39756602553;60534.39465605464;9693.9030609693;10062.195024398177;10088.445135517324;10198.592056317664;10210.897891020995;10458.790824183627;10464.790704186025;10568.577256909637;11543.307401555934;11552.480138393961;10492.47537623131;10630.25588208818;10684.519196636014;11177.161712871404;11214.607488738182;10537.367757934548;10564.947175264075;10676.092532134855;10772.24594278393;11159.49782259784;10479.842802357818;10555.89444105549;10905.727356816144;10993.725156871142;11018.283811552223;8870.955645221733;8900.154485323885;9006.909930900869;9398.81202375935;9423.57593908262;9087.863682044906;9124.817503649758;9156.908430915872;9164.129407706258;9300.441973481613 17:32:32 INFO - PROCESS | 11293 | __end_tp_report 17:32:32 INFO - PROCESS | 11293 | __start_cc_report 17:32:32 INFO - PROCESS | 11293 | _x_x_mozilla_cycle_collect,1078 17:32:32 INFO - PROCESS | 11293 | __end_cc_report 17:32:32 INFO - PROCESS | 11293 | __startTimestamp1467419552051__endTimestamp 17:32:32 INFO - PROCESS | 11293 | 17:32:32 INFO - PROCESS | 11293 | ------- Summary: start ------- 17:32:32 INFO - PROCESS | 11293 | Number of tests: 6 17:32:32 INFO - PROCESS | 11293 | 17:32:32 INFO - PROCESS | 11293 | [#0] dojo.html Cycles:165 Average:4819.14 Median:4937.16 stddev:505.90 (10.2%) stddev-sans-first:477.99 17:32:32 INFO - PROCESS | 11293 | Values: 2650.3 2665.3 2694.9 2705.4 2706.4 4731.2 4808.3 4845.1 4952.1 5002.0 4736.9 4835.7 4856.7 4900.4 4901.8 4419.2 4436.1 4512.2 4567.0 4610.9 4535.1 4540.3 4591.8 4613.8 4640.8 4383.7 4385.0 4420.9 4427.7 4452.0 4416.6 4456.4 4467.6 4470.9 4471.2 4474.1 4476.8 4483.2 4484.3 4530.8 4741.7 4766.3 4873.8 4951.2 4968.4 5172.0 5209.4 5248.8 5258.2 5262.8 5277.8 5285.5 5302.3 5319.8 5321.3 4780.3 4820.0 4824.4 4866.9 4914.9 5350.5 5352.5 5360.1 5429.5 5434.6 5149.4 5150.3 5167.2 5211.0 5215.4 5076.5 5145.6 5200.5 5211.2 5273.1 5153.3 5157.6 5196.8 5217.7 5257.1 5140.9 5203.9 5205.8 5206.3 5208.1 4382.0 4415.8 4419.0 4479.9 4512.5 3897.2 3918.5 3923.1 3936.4 3944.5 4501.9 4536.7 4551.9 4592.7 4604.8 5334.7 5336.5 5340.3 5341.7 5346.8 4546.3 4549.7 4552.1 4591.1 4596.8 4611.1 4671.4 4687.3 4710.0 4767.6 4900.3 4900.9 4904.7 4935.7 4937.2 5134.9 5138.6 5161.8 5200.5 5231.9 4649.7 4783.0 4792.3 4845.7 4854.8 5137.1 5143.1 5146.5 5191.8 5192.9 5158.6 5163.6 5172.2 5194.0 5202.7 4900.6 4941.7 4968.0 5011.0 5025.1 5032.8 5034.8 5038.7 5040.0 5076.3 4967.7 4983.6 5007.2 5027.9 5051.0 4871.7 5056.9 5086.3 5088.9 5102.1 4987.6 5003.5 5003.7 5013.8 5060.6 17:32:32 INFO - PROCESS | 11293 | 17:32:32 INFO - PROCESS | 11293 | [#1] ext.html Cycles:180 Average:52667.06 Median:3705.36 stddev:108805.20 (2936.4%) stddev-sans-first:109040.08 17:32:32 INFO - PROCESS | 11293 | Values: 554.3 594.9 596.8 601.4 601.5 39182.6 40862.2 40907.4 41020.0 44640.3 40972.2 41338.8 41339.0 41341.4 41419.8 7909.5 8035.6 8049.2 8051.2 8051.6 7915.1 7990.0 7993.2 7995.2 7998.4 8000.3 8030.4 8038.4 8041.4 8048.4 7975.3 8009.8 8017.0 8031.9 8041.9 7899.4 7970.9 7975.6 7979.2 7981.6 38177.8 38427.2 38507.0 38507.2 38533.4 3301.6 3451.6 3636.5 3774.3 3783.5 29628.3 29729.0 29740.9 29752.0 30067.4 3451.9 3544.0 3594.4 3624.2 3629.1 266851.0 267005.0 267064.0 268496.0 287894.6 52482.7 56237.0 57032.4 57080.0 57130.4 59099.0 59423.1 59587.0 59594.0 59654.0 13466.8 13602.4 13607.9 13608.0 13608.8 10713.1 10760.6 10811.9 10822.2 10839.9 18450.0 18462.8 18514.3 18570.6 18571.3 6965.8 7069.8 7088.6 7191.6 7278.3 822.7 934.6 948.7 960.0 1021.8 27852.2 28804.0 29191.4 29227.7 29370.0 946.8 975.1 977.0 1043.1 1103.1 14867.9 15048.8 15309.6 15442.4 15524.7 399199.0 437190.0 445075.0 733197.0 734193.0 50004.7 50328.2 50727.5 50747.0 50758.7 1098.0 1189.1 1206.1 1251.1 1253.1 27768.6 28478.9 28987.0 29581.9 29686.7 41472.6 41971.2 42118.8 42129.6 42133.2 310579.0 311233.0 312553.0 312640.0 313314.0 22670.0 24704.5 25483.9 25655.7 26942.2 41022.6 41318.2 41361.8 41669.4 42300.2 35175.0 35585.1 35642.0 36219.8 36288.6 34512.5 35150.5 35372.8 35510.0 35643.8 34442.8 35113.8 35848.0 35921.1 35973.5 31021.2 31627.4 31958.1 32003.5 32375.4 24947.4 24947.8 25224.0 25244.2 25258.5 17:32:32 INFO - PROCESS | 11293 | 17:32:32 INFO - PROCESS | 11293 | [#2] jquery.html Cycles:180 Average:24272.13 Median:389027.50 stddev:64948.83 (16.7%) stddev-sans-first:65106.17 17:32:32 INFO - PROCESS | 11293 | Values: 342.1 368.7 369.9 374.0 386.0 13386.0 16773.7 17353.7 18724.2 18746.1 16925.6 17004.3 17060.5 17355.6 17366.1 5037.9 5319.5 5375.7 5384.6 5385.9 3822.3 5343.7 5945.3 6255.8 6291.9 6100.6 6307.0 6342.2 6349.0 6354.8 6332.4 6360.6 6365.8 6396.0 6403.4 5399.1 5567.9 5573.7 5592.1 5598.8 17732.0 18124.0 18172.5 18202.4 18231.5 2045.2 2252.9 2464.9 2486.1 2620.4 13230.2 13821.3 13886.9 14362.5 14549.6 1747.8 1783.8 1822.9 1846.9 1855.4 65482.7 66014.7 66060.0 67087.7 67435.7 8558.4 9053.9 9204.2 9445.6 9945.8 12751.1 13197.0 13209.5 13290.4 13301.5 7251.0 7347.8 7350.7 7353.6 7437.3 6816.3 6861.2 7017.6 7252.9 7309.1 6152.1 6156.0 6210.4 6226.4 6228.5 1761.3 1778.9 1846.2 1867.3 1895.1 811.5 889.8 894.2 945.9 950.4 17827.4 18375.0 18381.8 18385.8 18516.4 871.8 900.8 903.8 907.0 970.3 9869.5 10279.6 10398.5 10435.9 10580.7 386034.0 392021.0 396846.0 400404.0 402627.0 67373.3 70165.6 70668.3 71107.3 71141.6 874.1 881.7 899.8 910.5 914.0 15780.3 16064.2 16093.5 16150.3 16194.4 23815.9 33473.7 34193.8 36228.5 37400.6 45009.8 45020.5 45397.8 47895.8 47969.3 7642.8 7672.4 7847.8 7866.6 7905.1 11864.6 11995.2 12291.1 12342.7 12459.6 10496.9 10523.7 10611.6 10642.6 10761.1 10293.9 10595.0 10614.5 10689.0 10880.6 10303.4 10666.9 10668.4 10687.3 10786.2 7593.4 7672.6 7836.8 7912.0 8058.7 10622.4 10670.3 10801.1 10874.8 11039.4 17:32:32 INFO - PROCESS | 11293 | 17:32:32 INFO - PROCESS | 11293 | [#3] mootools.html Cycles:180 Average:5220.20 Median:5340.91 stddev:2936.02 (55.0%) stddev-sans-first:2929.27 17:32:32 INFO - PROCESS | 11293 | Values: 1273.6 1354.8 1369.2 1676.3 1714.2 7817.6 8001.0 8117.0 8123.1 8126.0 6948.3 7497.1 7660.3 7664.5 7942.8 2197.1 2232.5 2235.8 2237.9 2238.1 2152.8 2186.4 2246.3 2247.3 2247.4 1909.3 2133.4 2184.1 2189.8 2195.3 2177.3 2192.9 2197.3 2209.8 2211.3 2151.4 2153.9 2157.6 2161.4 2161.6 7801.7 7838.2 7840.1 7842.0 7847.8 4474.8 4595.9 4608.9 4610.1 4614.2 2905.1 2924.4 3038.8 3050.2 3052.6 950.1 968.0 973.4 980.4 982.4 10803.4 10804.4 10813.9 10817.9 10821.7 4071.7 4198.3 4303.3 4311.9 4387.2 9244.4 9303.0 9307.7 9313.3 9324.8 4484.0 4500.0 4500.6 4501.3 4503.2 4120.7 4129.0 4178.3 4179.2 4180.9 3682.8 3704.2 3745.6 3792.1 3874.3 1062.8 1142.3 1162.5 1164.7 1183.9 735.2 764.5 779.0 802.3 859.9 5258.6 5270.5 5338.5 5343.3 5411.9 874.2 875.5 889.7 892.2 894.5 3545.8 3610.2 3613.0 3707.1 3946.2 9827.5 9855.4 9962.7 10066.5 10096.1 9952.1 9952.3 9953.2 9963.5 9971.2 6519.9 7031.2 7199.2 7258.2 7428.0 5318.7 5492.1 5527.0 5580.5 5586.7 8780.0 8893.0 8954.5 9027.8 9046.1 8996.8 9019.4 9203.5 9222.5 9289.8 6949.9 6953.0 7001.2 7061.0 7103.2 7562.5 7566.1 7704.4 7753.3 7764.9 5582.7 7029.5 7034.5 7135.4 7180.2 6776.3 6877.7 6909.5 6966.8 7034.1 6349.2 6384.0 6439.1 6444.5 6446.2 4582.2 4718.8 4763.5 4820.7 4853.2 4758.5 4773.4 4800.9 4846.2 4909.8 17:32:32 INFO - PROCESS | 11293 | 17:32:32 INFO - PROCESS | 11293 | [#4] prototype.html Cycles:180 Average:4246.98 Median:4825.03 stddev:1255.98 (26.0%) stddev-sans-first:1224.02 17:32:32 INFO - PROCESS | 11293 | Values: 297.3 301.4 306.2 306.5 310.4 4919.0 4919.2 4949.9 4967.6 4969.9 4811.9 4890.6 4897.8 4905.0 4910.0 3651.7 3764.0 3780.7 3782.5 3784.6 3700.9 3771.2 3868.8 3899.5 3917.8 3766.9 3846.7 3862.3 3864.9 3896.8 3763.9 3851.7 3864.2 3871.3 3884.7 3213.1 3297.4 3416.7 3419.1 3435.9 4808.4 4822.8 4824.7 4825.3 4827.9 4415.9 4417.6 4424.6 4428.1 4429.9 4921.5 5125.2 5127.7 5155.9 5178.8 3682.4 3704.0 3731.9 3736.1 3744.4 5187.8 5401.9 5404.2 5404.5 5412.5 3703.5 3727.6 3731.5 3736.9 3751.7 3781.6 3796.9 3801.7 3806.4 3808.9 4338.5 4339.7 4340.0 4359.2 4362.3 5073.7 5124.3 5149.6 5182.5 5205.3 1295.5 1299.6 1316.8 1317.5 1318.2 809.0 826.3 835.2 851.0 851.3 4044.5 4059.4 4082.3 4083.8 4085.2 4712.9 4737.0 4740.0 4751.5 4794.8 4050.7 4061.5 4085.9 4109.9 4161.3 2421.6 2518.3 2520.2 2691.5 2771.8 4824.8 4905.6 4913.8 4916.7 4946.7 5361.6 5365.9 5375.5 5384.4 5392.5 4748.5 4945.4 4991.6 5037.4 5042.2 5325.7 5373.9 5381.1 5387.2 5396.6 5266.4 5276.9 5277.6 5313.3 5331.7 4966.4 5051.6 5054.1 5054.9 5069.5 3755.2 3762.7 3766.6 3768.2 3785.5 5388.6 5410.6 5419.4 5432.6 5442.4 5143.4 5179.9 5251.7 5255.6 5280.8 5172.2 5201.8 5209.4 5217.4 5291.3 5088.5 5095.9 5102.4 5167.0 5181.6 4948.4 5213.6 5230.7 5233.2 5279.6 5111.6 5137.7 5140.7 5172.5 5229.0 17:32:32 INFO - PROCESS | 11293 | 17:32:32 INFO - PROCESS | 11293 | [#5] yui.html Cycles:180 Average:17046.54 Median:27642.06 stddev:24010.86 (86.9%) stddev-sans-first:24046.74 17:32:32 INFO - PROCESS | 11293 | Values: 672.3 674.7 697.4 703.9 715.6 12778.4 13558.7 13959.9 13976.2 14091.9 13355.0 13391.0 13459.8 13467.1 13470.5 649.1 776.9 780.2 797.1 809.0 804.9 805.4 807.7 808.4 808.8 851.0 852.5 853.0 853.3 853.5 663.5 680.1 680.7 685.1 843.5 591.6 608.9 612.2 622.1 622.2 13094.2 13170.7 13203.2 13287.7 13302.1 12647.0 13131.9 13164.6 13187.5 13254.3 10105.1 10118.9 10562.7 10881.2 10968.7 4129.5 4157.3 4248.8 4290.6 4360.8 63432.4 64530.4 65720.0 67185.0 67408.3 10428.1 10810.6 10836.7 11082.7 11086.4 18261.5 19379.5 19427.8 19472.2 19487.8 7202.2 7352.2 7385.6 7420.4 7576.8 3876.6 3917.6 3948.2 4009.6 4026.3 2954.6 3027.0 3036.9 3058.7 3065.5 544.9 550.7 551.6 560.2 567.7 502.6 542.3 585.7 589.7 610.8 8482.0 8680.7 8806.9 8809.8 8926.8 569.6 607.9 612.5 624.7 638.1 4015.3 4273.1 4287.4 4362.4 4386.8 57021.4 93641.0 94011.5 96355.0 96951.5 81053.0 82728.0 83204.6 83278.0 83690.6 45327.0 74537.3 74953.6 75011.2 75301.0 8130.6 8239.7 8288.5 8329.8 8465.0 44928.8 45788.5 46472.0 46536.5 47205.3 36810.3 41409.2 54733.5 60243.4 60534.4 9693.9 10062.2 10088.4 10198.6 10210.9 10458.8 10464.8 10568.6 11543.3 11552.5 10492.5 10630.3 10684.5 11177.2 11214.6 10537.4 10564.9 10676.1 10772.2 11159.5 10479.8 10555.9 10905.7 10993.7 11018.3 8871.0 8900.2 9006.9 9398.8 9423.6 9087.9 9124.8 9156.9 9164.1 9300.4 17:32:32 INFO - PROCESS | 11293 | -------- Summary: end -------- 17:32:32 INFO - PROCESS | 11293 | 17:32:32 INFO - TEST-INFO | 11293: exit 0 17:32:32 INFO - TEST-OK | dromaeo_css | took 1119719ms 17:32:32 INFO - TEST-START | kraken 17:32:32 INFO - operating with platform_type : linux_ 17:32:32 INFO - Initialising browser for kraken test... 17:32:32 INFO - TEST-INFO | started process 11489 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxE03E_/profile http://localhost:56701/getInfo.html) 17:32:37 INFO - PROCESS | 11489 | __metrics Screen width/height:1600/1200 17:32:37 INFO - PROCESS | 11489 | colorDepth:24 17:32:37 INFO - PROCESS | 11489 | Browser inner width/height: 1024/697 17:32:37 INFO - PROCESS | 11489 | __metrics 17:32:38 INFO - PROCESS | 11489 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:32:39 INFO - TEST-INFO | 11489: exit 0 17:32:39 INFO - Browser initialized. 17:32:39 INFO - Running cycle 1/1 for kraken test... 17:32:39 INFO - TEST-INFO | started process 11569 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxE03E_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:32:51 INFO - PROCESS | 11569 | RSS: Main: 159027200 17:32:51 INFO - PROCESS | 11569 | 17:32:53 INFO - PROCESS | 11569 | Cycle 1(1): loaded http://localhost:56701/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56701/tests/kraken/driver.html?testName=audio-beat-detection) 17:32:54 INFO - PROCESS | 11569 | RSS: Main: 217395200 17:32:54 INFO - PROCESS | 11569 | 17:32:57 INFO - PROCESS | 11569 | Cycle 1(1): loaded http://localhost:56701/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56701/tests/kraken/driver.html?testName=audio-dft) 17:32:58 INFO - PROCESS | 11569 | RSS: Main: 204677120 17:32:58 INFO - PROCESS | 11569 | 17:33:01 INFO - PROCESS | 11569 | Cycle 1(1): loaded http://localhost:56701/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56701/tests/kraken/driver.html?testName=audio-fft) 17:33:02 INFO - PROCESS | 11569 | RSS: Main: 271507456 17:33:02 INFO - PROCESS | 11569 | 17:33:04 INFO - PROCESS | 11569 | Cycle 1(1): loaded http://localhost:56701/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56701/tests/kraken/driver.html?testName=audio-oscillator) 17:33:04 INFO - PROCESS | 11569 | RSS: Main: 181772288 17:33:04 INFO - PROCESS | 11569 | 17:33:07 INFO - PROCESS | 11569 | Cycle 1(1): loaded http://localhost:56701/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56701/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:33:07 INFO - PROCESS | 11569 | RSS: Main: 185720832 17:33:07 INFO - PROCESS | 11569 | 17:33:10 INFO - PROCESS | 11569 | Cycle 1(1): loaded http://localhost:56701/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56701/tests/kraken/driver.html?testName=imaging-darkroom) 17:33:11 INFO - PROCESS | 11569 | RSS: Main: 221765632 17:33:11 INFO - PROCESS | 11569 | 17:33:14 INFO - PROCESS | 11569 | Cycle 1(1): loaded http://localhost:56701/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56701/tests/kraken/driver.html?testName=imaging-desaturate) 17:33:15 INFO - PROCESS | 11569 | RSS: Main: 217178112 17:33:15 INFO - PROCESS | 11569 | 17:33:18 INFO - PROCESS | 11569 | Cycle 1(1): loaded http://localhost:56701/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56701/tests/kraken/driver.html?testName=json-parse-financial) 17:33:19 INFO - PROCESS | 11569 | RSS: Main: 220200960 17:33:19 INFO - PROCESS | 11569 | 17:33:20 INFO - PROCESS | 11569 | Cycle 1(1): loaded http://localhost:56701/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56701/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:33:21 INFO - PROCESS | 11569 | RSS: Main: 207634432 17:33:21 INFO - PROCESS | 11569 | 17:33:23 INFO - PROCESS | 11569 | Cycle 1(1): loaded http://localhost:56701/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56701/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:33:23 INFO - PROCESS | 11569 | RSS: Main: 212033536 17:33:23 INFO - PROCESS | 11569 | 17:33:25 INFO - PROCESS | 11569 | Cycle 1(1): loaded http://localhost:56701/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56701/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:33:26 INFO - PROCESS | 11569 | RSS: Main: 214032384 17:33:26 INFO - PROCESS | 11569 | 17:33:29 INFO - PROCESS | 11569 | Cycle 1(1): loaded http://localhost:56701/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56701/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:33:30 INFO - PROCESS | 11569 | RSS: Main: 226500608 17:33:30 INFO - PROCESS | 11569 | 17:33:32 INFO - PROCESS | 11569 | Cycle 1(1): loaded http://localhost:56701/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56701/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:33:33 INFO - PROCESS | 11569 | RSS: Main: 226398208 17:33:33 INFO - PROCESS | 11569 | 17:33:35 INFO - PROCESS | 11569 | Cycle 1(1): loaded http://localhost:56701/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56701/tests/kraken/driver.html?testName=ai-astar) 17:33:35 INFO - PROCESS | 11569 | RSS: Main: 268763136 17:33:35 INFO - PROCESS | 11569 | 17:33:35 INFO - PROCESS | 11569 | __start_tp_report 17:33:35 INFO - PROCESS | 11569 | _x_x_mozilla_page_load 17:33:35 INFO - PROCESS | 11569 | _x_x_mozilla_page_load_details 17:33:35 INFO - PROCESS | 11569 | |i|pagename|runs| 17:33:35 INFO - PROCESS | 11569 | |0;ai-astar;105;114;114;113;115;113;113;113;115;114 17:33:35 INFO - PROCESS | 11569 | |1;audio-beat-detection;144;122;125;185;124;124;152;121;158;123 17:33:35 INFO - PROCESS | 11569 | |2;audio-dft;161;161;162;161;162;161;162;162;163;159 17:33:35 INFO - PROCESS | 11569 | |3;audio-fft;75;75;76;110;76;75;75;76;100;76 17:33:35 INFO - PROCESS | 11569 | |4;audio-oscillator;84;86;112;85;84;86;119;84;86;123 17:33:35 INFO - PROCESS | 11569 | |5;imaging-gaussian-blur;117;117;118;117;116;117;118;118;118;118 17:33:35 INFO - PROCESS | 11569 | |6;imaging-darkroom;146;146;146;145;145;146;146;146;145;147 17:33:35 INFO - PROCESS | 11569 | |7;imaging-desaturate;95;95;95;94;95;95;95;96;95;95 17:33:35 INFO - PROCESS | 11569 | |8;json-parse-financial;64;63;64;64;72;67;65;64;63;64 17:33:35 INFO - PROCESS | 11569 | |9;json-stringify-tinderbox;63;66;64;65;66;64;64;64;65;65 17:33:35 INFO - PROCESS | 11569 | |10;stanford-crypto-aes;79;80;78;89;81;81;77;84;78;82 17:33:35 INFO - PROCESS | 11569 | |11;stanford-crypto-ccm;147;133;127;127;127;127;129;128;177;139 17:33:35 INFO - PROCESS | 11569 | |12;stanford-crypto-pbkdf2;167;172;171;167;166;168;171;167;166;172 17:33:35 INFO - PROCESS | 11569 | |13;stanford-crypto-sha256-iterative;67;68;71;70;68;65;66;67;66;71 17:33:35 INFO - PROCESS | 11569 | __end_tp_report 17:33:35 INFO - PROCESS | 11569 | __start_cc_report 17:33:35 INFO - PROCESS | 11569 | _x_x_mozilla_cycle_collect,1910 17:33:35 INFO - PROCESS | 11569 | __end_cc_report 17:33:35 INFO - PROCESS | 11569 | __startTimestamp1467419615493__endTimestamp 17:33:35 INFO - PROCESS | 11569 | 17:33:35 INFO - PROCESS | 11569 | ------- Summary: start ------- 17:33:35 INFO - PROCESS | 11569 | Number of tests: 14 17:33:35 INFO - PROCESS | 11569 | 17:33:35 INFO - PROCESS | 11569 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:2.88 (2.5%) stddev-sans-first:0.83 17:33:35 INFO - PROCESS | 11569 | Values: 105.0 114.0 114.0 113.0 115.0 113.0 113.0 113.0 115.0 114.0 17:33:35 INFO - PROCESS | 11569 | 17:33:35 INFO - PROCESS | 11569 | [#1] audio-beat-detection Cycles:10 Average:137.80 Median:134.50 stddev:21.53 (16.0%) stddev-sans-first:22.72 17:33:35 INFO - PROCESS | 11569 | Values: 144.0 122.0 125.0 185.0 124.0 124.0 152.0 121.0 158.0 123.0 17:33:35 INFO - PROCESS | 11569 | 17:33:35 INFO - PROCESS | 11569 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 17:33:35 INFO - PROCESS | 11569 | Values: 161.0 161.0 162.0 161.0 162.0 161.0 162.0 162.0 163.0 159.0 17:33:35 INFO - PROCESS | 11569 | 17:33:35 INFO - PROCESS | 11569 | [#3] audio-fft Cycles:10 Average:81.40 Median:75.50 stddev:12.67 (16.8%) stddev-sans-first:13.22 17:33:35 INFO - PROCESS | 11569 | Values: 75.0 75.0 76.0 110.0 76.0 75.0 75.0 76.0 100.0 76.0 17:33:35 INFO - PROCESS | 11569 | 17:33:35 INFO - PROCESS | 11569 | [#4] audio-oscillator Cycles:10 Average:94.90 Median:84.50 stddev:16.18 (19.1%) stddev-sans-first:16.67 17:33:35 INFO - PROCESS | 11569 | Values: 84.0 86.0 112.0 85.0 84.0 86.0 119.0 84.0 86.0 123.0 17:33:35 INFO - PROCESS | 11569 | 17:33:35 INFO - PROCESS | 11569 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 17:33:35 INFO - PROCESS | 11569 | Values: 117.0 117.0 118.0 117.0 116.0 117.0 118.0 118.0 118.0 118.0 17:33:35 INFO - PROCESS | 11569 | 17:33:35 INFO - PROCESS | 11569 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 17:33:35 INFO - PROCESS | 11569 | Values: 146.0 146.0 146.0 145.0 145.0 146.0 146.0 146.0 145.0 147.0 17:33:35 INFO - PROCESS | 11569 | 17:33:35 INFO - PROCESS | 11569 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 17:33:35 INFO - PROCESS | 11569 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 95.0 96.0 95.0 95.0 17:33:35 INFO - PROCESS | 11569 | 17:33:35 INFO - PROCESS | 11569 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:64.00 stddev:2.71 (4.2%) stddev-sans-first:2.85 17:33:35 INFO - PROCESS | 11569 | Values: 64.0 63.0 64.0 64.0 72.0 67.0 65.0 64.0 63.0 64.0 17:33:35 INFO - PROCESS | 11569 | 17:33:35 INFO - PROCESS | 11569 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.97 (1.5%) stddev-sans-first:0.83 17:33:35 INFO - PROCESS | 11569 | Values: 63.0 66.0 64.0 65.0 66.0 64.0 64.0 64.0 65.0 65.0 17:33:35 INFO - PROCESS | 11569 | 17:33:35 INFO - PROCESS | 11569 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:81.00 stddev:3.54 (4.4%) stddev-sans-first:3.69 17:33:35 INFO - PROCESS | 11569 | Values: 79.0 80.0 78.0 89.0 81.0 81.0 77.0 84.0 78.0 82.0 17:33:35 INFO - PROCESS | 11569 | 17:33:35 INFO - PROCESS | 11569 | [#11] stanford-crypto-ccm Cycles:10 Average:136.10 Median:131.00 stddev:15.84 (12.1%) stddev-sans-first:16.30 17:33:35 INFO - PROCESS | 11569 | Values: 147.0 133.0 127.0 127.0 127.0 127.0 129.0 128.0 177.0 139.0 17:33:35 INFO - PROCESS | 11569 | 17:33:35 INFO - PROCESS | 11569 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.70 Median:169.50 stddev:2.50 (1.5%) stddev-sans-first:2.57 17:33:35 INFO - PROCESS | 11569 | Values: 167.0 172.0 171.0 167.0 166.0 168.0 171.0 167.0 166.0 172.0 17:33:35 INFO - PROCESS | 11569 | 17:33:35 INFO - PROCESS | 11569 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:2.13 (3.1%) stddev-sans-first:2.24 17:33:35 INFO - PROCESS | 11569 | Values: 67.0 68.0 71.0 70.0 68.0 65.0 66.0 67.0 66.0 71.0 17:33:35 INFO - PROCESS | 11569 | -------- Summary: end -------- 17:33:35 INFO - PROCESS | 11569 | 17:33:36 INFO - TEST-INFO | 11569: exit 0 17:33:36 INFO - TEST-OK | kraken | took 63747ms 17:33:36 INFO - SUITE-END | took 1183s 17:33:36 INFO - Completed test suite (00:19:43) 17:33:36 INFO - javascript benchmark 17:33:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2650.3241673373286, 2665.333666583354, 2694.851783151927, 2705.3642394037383, 2706.4316493536357, 4731.219348807451, 4808.278758186274, 4845.103655823675, 4952.108620448318, 5002.0496105739885, 4736.905261894769, 4835.68568043077, 4856.684315519497, 4900.411950565928, 4901.754912254391, 4419.18245124653, 4436.134953684033, 4512.210363186446, 4567.018091110411, 4610.884727881813, 4535.097647193745, 4540.341650460681, 4591.77041147943, 4613.769311534426, 4640.814367425299, 4383.715058521186, 4384.978075109636, 4420.9336859947125, 4427.667924905645, 4451.976045509551, 4416.55834416559, 4456.398386217851, 4467.620252278561, 4470.910581788378, 4471.217536931056, 4474.082813023322, 4476.798544065525, 4483.237849565582, 4484.349769283468, 4530.841420550265, 4741.739204343759, 4766.30888521166, 4873.829415970424, 4951.207806750938, 4968.378952630921, 5171.974140129275, 5209.426963034063, 5248.790048398059, 5258.237555554461, 5262.789488420459, 5277.788888444457, 5285.524302812765, 5302.310699609026, 5319.760610772524, 5321.308229930123, 4780.282957556325, 4820.035992801384, 4824.445188803263, 4866.878328041792, 4914.8771280718265, 5350.4649535046965, 5352.5450336721815, 5360.142377219626, 5429.538489228381, 5434.619576629677, 5149.433562308143, 5150.330457040561, 5167.173252279617, 5211.0, 5215.426303106655, 5076.543111120017, 5145.562627176657, 5200.5059519345605, 5211.166213405837, 5273.077211487975, 5153.2785410042625, 5157.63896527247, 5196.818111366084, 5217.739113044333, 5257.053730328501, 5140.897182056338, 5203.895922081537, 5205.765740541685, 5206.297149884717, 5208.088584497774, 4382.035952090535, 4415.779211039435, 4418.977905110454, 4479.865604031885, 4512.548745125461, 3897.240038192582, 3918.4710064140977, 3923.136909879822, 3936.4095385691803, 3944.5463771666628, 4501.887452813706, 4536.72779633223, 4551.931721024187, 4592.7014744041535, 4604.8388306409115, 5334.733263336895, 5336.519713225828, 5340.279062326536, 5341.679499230058, 5346.759395827119, 4546.340780586796, 4549.681522293474, 4552.135094332132, 4591.058832939239, 4596.839110631178, 4611.054733779567, 4671.392718946583, 4687.250039993584, 4710.034442939189, 4767.61859051282, 4900.338454308623, 4900.921797204609, 4904.730239836772, 4935.728534930613, 4937.160682684024, 5134.8973020540125, 5138.614603904647, 5161.793528258828, 5200.479952004769, 5231.90130072689, 4649.721016739007, 4783.0, 4792.257200133985, 4845.6608037438455, 4854.781534831011, 5137.075326441276, 5143.074246635641, 5146.485351464824, 5191.792328306977, 5192.948070519397, 5158.6131040171385, 5163.561097306771, 5172.19830926207, 5194.039102766001, 5202.739863006759, 4900.607951363811, 4941.728204948762, 4968.0, 5011.047900898818, 5025.095482813129, 5032.773525191302, 5034.841986343088, 5038.672486288379, 5039.974800125976, 5076.263941728503, 4967.7019378837385, 4983.601311895112, 5007.24891266313, 5027.924581131213, 5051.040302342543, 4871.683340582851, 5056.924146137884, 5086.262491938574, 5088.923666144937, 5102.1326374515675, 4987.551120399036, 5003.474635163401, 5003.724795136157, 5013.774380152829, 5060.595152387874], "value": 4786.519275402417, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.3043528909254, 594.8542607061271, 596.7612954818075, 601.4466690644607, 601.542827451137, 39182.608173918255, 40862.18275634485, 40907.386389204185, 41020.0, 44640.3303950441, 40972.180556388856, 41338.793306033425, 41339.0, 41341.379879301836, 41419.79290103545, 7909.485883417574, 8035.598220089001, 8049.1950804919625, 8051.2351326623875, 8051.63767630458, 7915.089764677078, 7989.960050199741, 7993.1607181246, 7995.240452157036, 7998.360131189491, 8000.279974802266, 8030.437869349148, 8038.437309388345, 8041.356691464698, 8048.396370272224, 7975.322097621709, 8009.799755006172, 8017.037955445355, 8031.919680803176, 8041.919580804176, 7899.368050555941, 7970.880436793453, 7975.60121993898, 7979.202079792032, 7981.6408261627785, 38177.809110954266, 38427.23145537102, 38507.0, 38507.22985540274, 38533.42199867004, 3301.5873015873017, 3451.551298331201, 3636.4545318202217, 3774.2640185163905, 3783.5459744830796, 29628.259293517618, 29729.0, 29740.85129574338, 29752.0, 30067.398652027056, 3451.8964431067106, 3543.982280088583, 3594.3889538778208, 3624.220792529619, 3629.0927268182954, 266851.0, 267005.0, 267064.0, 268496.0, 287894.56052719813, 52482.73758631182, 56237.0, 57032.42967570354, 57080.0, 57130.428695713344, 59099.0, 59423.10865337023, 59587.0, 59594.0, 59654.0, 13466.797998030037, 13602.387892544859, 13607.863921360859, 13608.047436679337, 13608.795868061987, 10713.142948564097, 10760.623378181726, 10811.945940270405, 10822.242443028912, 10839.891601084046, 18450.0, 18462.81537184638, 18514.259429622663, 18570.628587428175, 18571.25714971413, 6965.79102626922, 7069.823254418578, 7088.594958822061, 7191.64041797908, 7278.308560686726, 822.7408366364576, 934.63082082577, 948.742915636784, 960.0351646595267, 1021.836506159011, 27852.16443506698, 28804.0, 29191.416171676872, 29227.7077229225, 29370.0, 946.7775072857872, 975.0785507695301, 976.9902300977042, 1043.1341986151476, 1103.0844399148687, 14867.851321486647, 15048.849511504965, 15309.6172595686, 15442.382304707686, 15524.68950621004, 399199.0, 437190.0, 445075.0, 733197.0, 734193.0, 50004.749976249885, 50328.24507632388, 50727.49272507302, 50747.0, 50758.74620626947, 1098.0008192544747, 1189.143816452153, 1206.1014544164477, 1251.0804558649386, 1253.1290752926811, 27768.583471247544, 28478.857605712667, 28987.0, 29581.85209073941, 29686.703132969258, 41472.58527414808, 41971.160576788905, 42118.789406052776, 42129.57870421257, 42133.15733685248, 310579.0, 311233.0, 312553.0, 312640.0, 313314.0, 22670.0, 24704.50590988206, 25483.872580636977, 25655.743442565334, 26942.191734248005, 41022.58977410307, 41318.1736365265, 41361.79319103385, 41669.374959375025, 42300.192982631714, 35175.0, 35585.1103722409, 35642.0, 36219.818900905324, 36288.63711362852, 34512.48231276583, 35150.47274290939, 35372.82313588416, 35510.0, 35643.82178089093, 34442.82778586091, 35113.824430877685, 35848.0, 35921.101972449855, 35973.46039809353, 31021.224469388446, 31627.367452650356, 31958.067619435547, 32003.519947201275, 32375.352492950482, 24947.376315592257, 24947.75052249454, 25224.0, 25244.242672719847, 25258.494830103664], "value": 18034.32808827984, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.11221879223405, 368.70872011111226, 369.8631506342652, 373.9925201495971, 385.9594742552032, 13386.0, 16773.664526709457, 17353.739693904587, 18724.15741291642, 18746.062696865138, 16925.57686057849, 17004.319827206928, 17060.48818535443, 17355.566110847234, 17366.13169341534, 5037.874053148664, 5319.468053194688, 5375.731213439332, 5384.596155288349, 5385.892282154355, 3822.3310920588788, 5343.664083979005, 5945.346011938684, 6255.812325630216, 6291.874162516747, 6100.572959892787, 6307.0, 6342.238931328224, 6349.047642853563, 6354.809355719312, 6332.430081292683, 6360.618362898194, 6365.809025729212, 6396.040593910904, 6403.391677790602, 5399.136138217906, 5567.8886422271735, 5573.749181286852, 5592.105263157875, 5598.804041858515, 17732.0, 18124.0, 18172.45482635523, 18202.362917297964, 18231.45305640833, 2045.1512622261744, 2252.8986195621073, 2464.915437207641, 2486.105002199207, 2620.4366061296723, 13230.206187628677, 13821.308934553334, 13886.93056534721, 14362.497312594114, 14549.636259093502, 1747.8339557741995, 1783.839454449106, 1822.863285253598, 1846.879952803077, 1855.4248183063294, 65482.672586637236, 66014.66992665055, 66060.0, 67087.66456167736, 67435.66282168607, 8558.35812314079, 9053.864192037125, 9204.217641500414, 9445.622175113056, 9945.80108397828, 12751.107422480338, 13197.0, 13209.471621135048, 13290.401931913088, 13301.534446294334, 7250.9637451812405, 7347.816304592321, 7350.7427240046345, 7353.6323183840595, 7437.293457121565, 6816.250212476623, 6861.210960739479, 7017.649117544102, 7252.891206631904, 7309.086364204474, 6152.107944348045, 6156.015037593964, 6210.378962103753, 6226.439620434183, 6228.532860035425, 1761.2778760708304, 1778.919948602316, 1846.22458567402, 1867.3090956346239, 1895.118769772035, 811.5374236685033, 889.7731078574922, 894.1594900793234, 945.9432434053979, 950.3769595915323, 17827.376041838474, 18375.0, 18381.776113919168, 18385.81614183841, 18516.444506664822, 871.8430682477215, 900.7703035725979, 903.75146834621, 906.9501177435304, 970.315927271272, 9869.506524673738, 10279.640212592523, 10398.478951192976, 10435.895641043493, 10580.735481612868, 386034.0, 392021.0, 396846.0, 400404.0, 402627.0, 67373.32626673671, 70165.64917175483, 70668.29331706617, 71107.2889271111, 71141.64429177821, 874.0996773323487, 881.7310720230263, 899.7570655922995, 910.4628269321132, 913.9862902056475, 15780.289886954884, 16064.196790160679, 16093.517194484184, 16150.273237704096, 16194.352225910832, 23815.880920595286, 33473.665263348026, 34193.829030854686, 36228.4565731509, 37400.62599373971, 45009.77495112635, 45020.54979450163, 45397.773011134734, 47895.760521198565, 47969.280460793816, 7642.847143056996, 7672.38620910337, 7847.764567062997, 7866.6066696666085, 7905.102775333993, 11864.584739534075, 11995.220310679779, 12291.139620226499, 12342.691432714253, 12459.563915262923, 10496.895031049591, 10523.684289471328, 10611.575536978435, 10642.62750803749, 10761.085307748928, 10293.948530257301, 10595.0, 10614.522346494581, 10689.0, 10880.564777408816, 10303.433311167659, 10666.946665266623, 10668.413237272025, 10687.25189236746, 10786.244962852525, 7593.430492712958, 7672.616369181407, 7836.764897053097, 7911.960440197762, 8058.717944871902, 10622.415767132881, 10670.253082284165, 10801.081908037591, 10874.836877447004, 11039.39283339424], "value": 8530.024249352682, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1273.6051823934579, 1354.8103265542823, 1369.2332293915408, 1676.3378465506119, 1714.1771949464257, 7817.609119544021, 8000.959995200031, 8117.0, 8123.065847427548, 8126.024877014759, 6948.305169483049, 7497.137829149649, 7660.348870346027, 7664.4634875558595, 7942.841143177133, 2197.13213280754, 2232.464208589943, 2235.7540670526228, 2237.876916769577, 2238.0823862216494, 2152.752433470155, 2186.4424571734185, 2246.3261021693506, 2247.2696373678536, 2247.415671925303, 1909.3317338931402, 2133.434639820449, 2184.14818220894, 2189.8029177374033, 2195.2536137713173, 2177.2597316912165, 2192.8684278943156, 2197.252934002439, 2209.7569267380495, 2211.347652442533, 2151.397608669575, 2153.8599991000533, 2157.6224160771803, 2161.4056134562966, 2161.6217161996587, 7801.687932482694, 7838.216178382173, 7840.13758486566, 7841.960790196013, 7847.764567062997, 4474.82100715971, 4595.862124136282, 4608.907821843544, 4610.077984403133, 4614.192516309632, 2905.0703774792073, 2924.4151169766133, 3038.8328641924686, 3050.1612056684367, 3052.5726398304255, 950.0689324462066, 967.9661211857551, 973.445136272325, 980.4117529482324, 982.3909176310733, 10803.4058126803, 10804.351738895692, 10813.891861081445, 10817.891821081766, 10821.67534973952, 4071.694622903294, 4198.265303571863, 4303.311470164758, 4311.935320970188, 4387.210302145644, 9244.445333280024, 9302.95348523253, 9307.696922430865, 9313.301502387349, 9324.813503729887, 4484.0, 4500.0, 4500.639948804088, 4501.279795232747, 4503.211937910853, 4120.711550191458, 4128.979355103205, 4178.331466965271, 4179.164167166578, 4180.937285940713, 3682.797446140488, 3704.2034613212572, 3745.5879853216125, 3792.051987003249, 3874.3026255273758, 1062.7874425115008, 1142.280363371071, 1162.4855803268638, 1164.6913567904512, 1183.917125801203, 735.1986334894883, 764.5107131435885, 778.9610519474116, 802.3140215115992, 859.8882145321069, 5258.631895767336, 5270.472952704776, 5338.546223570962, 5343.278657381282, 5411.918821217685, 874.1651722604897, 875.4572165257454, 889.7197382824389, 892.1970226795936, 894.4570615687886, 3545.822708864598, 3610.1696609779897, 3613.0425437259146, 3707.0547010512146, 3946.210757848442, 9827.459489727991, 9855.35940163887, 9962.701118966443, 10066.547005384775, 10096.141827944706, 9952.054554817281, 9952.253580981456, 9953.153981911619, 9963.501824908726, 9971.152452041513, 6519.902201466982, 7031.191412987469, 7199.244079371695, 7258.237885022102, 7427.962860185665, 5318.680879147263, 5492.093804522209, 5527.0, 5580.469855363734, 5586.748596313095, 8779.956100219459, 8892.955535222283, 8954.462732236087, 9027.774305642411, 9046.140616641409, 8996.820063598821, 9019.368644194843, 9203.539823008688, 9222.538873056454, 9289.814203716023, 6949.895751563629, 6953.0, 7001.229864714775, 7061.046758687511, 7103.2186459488385, 7562.470627056054, 7566.1298950621385, 7704.38364930793, 7753.340966017951, 7764.88352674699, 5582.720863956867, 7029.507934444539, 7034.507584469038, 7135.429165666838, 7180.1742799578715, 6776.322367763184, 6877.724891004304, 6909.481788865754, 6966.756163534252, 7034.050403195503, 6349.206349206349, 6383.96808015957, 6439.098526206241, 6444.484441244783, 6446.194225721785, 4582.221022426129, 4718.764061796828, 4763.452202996561, 4820.734859582757, 4853.223484242645, 4758.5241475852135, 4773.37946067009, 4800.879978000578, 4846.200376937766, 4909.754512274443], "value": 4192.656079585171, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.3043079194684, 301.43932285948136, 306.24052350171576, 306.5019343566704, 310.3761439506592, 4919.0, 4919.1883339249025, 4949.925751113737, 4967.577755890745, 4969.8569329054335, 4811.941372897957, 4890.559849613534, 4897.779599918003, 4904.975475122628, 4909.950900490994, 3651.671349578544, 3763.9811800940956, 3780.7164462665273, 3782.470454136423, 3784.6404591563896, 3700.944485832701, 3771.18919432322, 3868.825902834365, 3899.454076429302, 3917.784521851297, 3766.9434958475645, 3846.7114966377494, 3862.343401621731, 3864.8840534783862, 3896.79199448172, 3763.9435408468894, 3851.6533511983775, 3864.246471937959, 3871.3031654302213, 3884.6503814656535, 3213.068210219057, 3297.38998285318, 3416.7266618670446, 3419.128122328815, 3435.862565497402, 4808.365155846994, 4822.7829747661435, 4824.6863953842885, 4825.30033145192, 4827.9034419311765, 4415.889602759957, 4417.580329868657, 4424.579664931826, 4428.070105277896, 4429.889252768674, 4921.483244259337, 5125.205593133071, 5127.717975511346, 5155.922661160085, 5178.844634660929, 3682.355587772156, 3703.962960370389, 3731.8693845715543, 3736.1406876418578, 3744.3634582121103, 5187.844364669028, 5401.919616076801, 5404.1625847212135, 5404.540614047811, 5412.539934105605, 3703.5000274962536, 3727.6086010969, 3731.4962480065387, 3736.8878933632036, 3751.662350388478, 3781.5840257571645, 3796.9430458543143, 3801.650414103009, 3806.4290356446754, 3808.8666896658483, 4338.501072376654, 4339.696221264544, 4340.045190058182, 4359.193549193409, 4362.258416069276, 5073.670211436245, 5124.30821839047, 5149.639525233198, 5182.481751824787, 5205.27126202332, 1295.533607901155, 1299.5841330774251, 1316.776148054833, 1317.4993502469192, 1318.1695531815087, 808.9716859909875, 826.3430572694722, 835.2315869400167, 850.9914900850912, 851.3317046118767, 4044.4944381952255, 4059.416827437302, 4082.2651922653613, 4083.816228269735, 4085.2442298174337, 4712.9057418851435, 4736.95263047372, 4739.95260047402, 4751.52484751529, 4794.832180873723, 4050.6835278534595, 4061.5126184857413, 4085.9387109193385, 4109.91780164395, 4161.314667559644, 2421.5520128776234, 2518.3452302401506, 2520.206135067448, 2691.542437785581, 2771.808122507341, 4824.758762061883, 4905.607551395951, 4913.754312284372, 4916.655834091579, 4946.678465899777, 5361.597880159004, 5365.946340536622, 5375.462453754593, 5384.407715151408, 5392.514673679388, 4748.525147485224, 4945.381827271591, 4991.575716064102, 5037.420696619935, 5042.218456139304, 5325.680459172462, 5373.865653358697, 5381.11211650089, 5387.191921211849, 5396.568274538106, 5266.445149524133, 5276.920846187387, 5277.551408130198, 5313.2561441397465, 5331.733413329395, 4966.354373931365, 5051.646384753179, 5054.140796064605, 5054.898902021865, 5069.493050694901, 3755.230177813487, 3762.698984081212, 3766.642168993941, 3768.2463507298103, 3785.4511095891494, 5388.568914486753, 5410.594205434687, 5419.4038655747045, 5432.56539476833, 5442.401335852974, 5143.382794064736, 5179.896402071862, 5251.687078230442, 5255.553277971415, 5280.76236569363, 5172.19830926207, 5201.765920533509, 5209.426963033988, 5217.399999000164, 5291.259223708761, 5088.516590923857, 5095.923561146512, 5102.36220472441, 5166.974165129151, 5181.637285390138, 4948.406191256928, 5213.644452442317, 5230.660007099526, 5233.188855727369, 5279.574514881037, 5111.64218504716, 5137.743112844418, 5140.7429628517675, 5172.508611681884, 5229.0], "value": 3846.6117119526266, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.3276723276723, 674.6559254780061, 697.4072038767046, 703.8662654095722, 715.5992644119293, 12778.3610819459, 13558.728825423486, 13959.860401395996, 13976.161430314176, 14091.859081409208, 13355.0, 13391.0, 13459.798103028463, 13467.057305988585, 13470.528531501399, 649.0750680280605, 776.9145394006655, 780.2353693380477, 797.143071198461, 809.0453265147124, 804.9114597394282, 805.3597390074875, 807.7455601485514, 808.4340961327065, 808.7897146741831, 851.0128251228576, 852.4757274276337, 852.9914700852975, 853.2661910756744, 853.5049671190726, 663.4526515624605, 680.1124532485105, 680.6630717794674, 685.0785693242581, 843.464400105931, 591.5858898770878, 608.8964875971095, 612.1796792298342, 622.0855342646303, 622.1911515030488, 13094.214347139106, 13170.736585268241, 13203.207807531579, 13287.667808304774, 13302.135361201588, 12647.0, 13131.856634681444, 13164.60506184816, 13187.53843615469, 13254.271015094166, 10105.141063009652, 10118.949405253, 10562.683119506428, 10881.238313317992, 10968.670939871816, 4129.463169787939, 4157.272477316487, 4248.808803603845, 4290.635295999844, 4360.847370342054, 63432.36567634357, 64530.3546964529, 65720.0, 67185.0, 67408.32591674119, 10428.113610343054, 10810.567577296977, 10836.72908177286, 11082.722931926766, 11086.390248536409, 18261.452156435327, 19379.51551211203, 19427.80572194288, 19472.221111155395, 19487.805121948884, 7202.171750248788, 7352.19125896151, 7385.556866587915, 7420.36926861212, 7576.848463030708, 3876.612338766101, 3917.5886531914307, 3948.170884114311, 4009.599040095967, 4026.275270451288, 2954.5863579098946, 3027.0, 3036.9088927332214, 3058.7400070994213, 3065.524843649238, 544.901917654826, 550.6640949021094, 551.635920292605, 560.1709469984446, 567.7218163100051, 502.6330778531619, 542.3383472163954, 585.7071464267866, 589.7405141737622, 610.8320211941751, 8482.0, 8680.652773888974, 8806.86789698155, 8809.823803523894, 8926.776830579287, 569.6240481282334, 607.8571535689109, 612.4824523277823, 624.7251209467911, 638.0939066525544, 4015.31739604268, 4273.081287523198, 4287.421198138274, 4362.367456718758, 4386.758728269912, 57021.42978570244, 93641.0, 94011.52994234985, 96355.00466797761, 96951.51524242475, 81053.0, 82728.0, 83204.58397707973, 83278.0, 83690.5815470931, 45327.0, 74537.25462745411, 74953.62523187349, 75011.24988750042, 75301.0, 8130.634121464666, 8239.711610093618, 8288.461250018729, 8329.791755206168, 8465.0, 44928.77535612301, 45788.54211457843, 46472.0, 46536.53463465322, 47205.29192062053, 36810.263794724495, 41409.1718165629, 54733.45266547283, 60243.39756602553, 60534.39465605464, 9693.9030609693, 10062.195024398177, 10088.445135517324, 10198.592056317664, 10210.897891020995, 10458.790824183627, 10464.790704186025, 10568.577256909637, 11543.307401555934, 11552.480138393961, 10492.47537623131, 10630.25588208818, 10684.519196636014, 11177.161712871404, 11214.607488738182, 10537.367757934548, 10564.947175264075, 10676.092532134855, 10772.24594278393, 11159.49782259784, 10479.842802357818, 10555.89444105549, 10905.727356816144, 10993.725156871142, 11018.283811552223, 8870.955645221733, 8900.154485323885, 9006.909930900869, 9398.81202375935, 9423.57593908262, 9087.863682044906, 9124.817503649758, 9156.908430915872, 9164.129407706258, 9300.441973481613], "value": 6531.748567258336, "unit": "score"}], "name": "dromaeo_css", "value": 6530.595662522587, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 114.0, 113.0, 115.0, 113.0, 113.0, 113.0, 115.0, 114.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 122.0, 125.0, 185.0, 124.0, 124.0, 152.0, 121.0, 158.0, 123.0], "value": 137.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 162.0, 161.0, 162.0, 162.0, 163.0, 159.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 110.0, 76.0, 75.0, 75.0, 76.0, 100.0, 76.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 112.0, 85.0, 84.0, 86.0, 119.0, 84.0, 86.0, 123.0], "value": 94.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 116.0, 117.0, 118.0, 118.0, 118.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 147.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 64.0, 72.0, 67.0, 65.0, 64.0, 63.0, 64.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 64.0, 65.0, 66.0, 64.0, 64.0, 64.0, 65.0, 65.0], "value": 64.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 78.0, 89.0, 81.0, 81.0, 77.0, 84.0, 78.0, 82.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 133.0, 127.0, 127.0, 127.0, 127.0, 129.0, 128.0, 177.0, 139.0], "value": 136.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 172.0, 171.0, 167.0, 166.0, 168.0, 171.0, 167.0, 166.0, 172.0], "value": 168.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 71.0, 70.0, 68.0, 65.0, 66.0, 67.0, 66.0, 71.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1529.8, "alertThreshold": 2.0}]} 17:33:36 INFO - Return code: 0 17:33:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:33:36 INFO - # TBPL SUCCESS # 17:33:36 INFO - Running post-action listener: _resource_record_post_action 17:33:36 INFO - ##### 17:33:36 INFO - ##### Finished run-tests step (success) 17:33:36 INFO - ##### 17:33:36 INFO - Running post-run listener: _resource_record_post_run 17:33:36 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 8192; Write bytes: 551256064; Read time: 64; Write time: 504136 17:33:36 INFO - TinderboxPrint: CPU usage
13.0% 17:33:36 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 64 17:33:36 INFO - TinderboxPrint: I/O write bytes / time
551,256,064 / 504,136 17:33:36 INFO - TinderboxPrint: CPU idle
8,333.1 (87.0%) 17:33:36 INFO - TinderboxPrint: CPU user
1,202.4 (12.6%) 17:33:36 INFO - TinderboxPrint: Swap in / out
0 / 0 17:33:36 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 262541312; Read time: 0; Write time: 266136 17:33:36 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288100352; Read time: 56; Write time: 238000 17:33:37 INFO - Running post-run listener: _upload_blobber_files 17:33:37 INFO - Blob upload gear active. 17:33:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:33:37 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 17:33:37 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'] 17:33:37 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 17:33:37 INFO - (blobuploader) - INFO - Open directory for files ... 17:33:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:33:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:33:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:33:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:33:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:33:38 INFO - (blobuploader) - INFO - Done attempting. 17:33:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:33:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:33:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:33:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:33:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:33:39 INFO - (blobuploader) - INFO - Done attempting. 17:33:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:33:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:33:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:33:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:33:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:33:42 INFO - (blobuploader) - INFO - Done attempting. 17:33:42 INFO - (blobuploader) - INFO - Iteration through files over. 17:33:42 INFO - Return code: 0 17:33:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:33:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:33:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/241ed42ea386b6cfccecdf413335ee83c1c493d146fa3b690659604acb2e6c8ef1304eb7cbcc753af2d9a4c7c389331b226c8c10eead212133d0e04a868fd1d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/41cbf57a39fc8faec7af05670c2e92c2cdad1cf796698b0c330f056bf11508b2ac4573cf2b70cd78412dd86f7a49f1e54e78cc127782380dc8193280ee40b176", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c0213c74bdf7abb87260f8c6d8d8cbfd417cf7bda13fca20b35c34f777902203bbead6a62878b9d649afdc9bfe9ffca380a2b39656c16e2b63bef3b981f96506"} 17:33:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:33:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:33:42 INFO - Contents: 17:33:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/241ed42ea386b6cfccecdf413335ee83c1c493d146fa3b690659604acb2e6c8ef1304eb7cbcc753af2d9a4c7c389331b226c8c10eead212133d0e04a868fd1d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/41cbf57a39fc8faec7af05670c2e92c2cdad1cf796698b0c330f056bf11508b2ac4573cf2b70cd78412dd86f7a49f1e54e78cc127782380dc8193280ee40b176", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c0213c74bdf7abb87260f8c6d8d8cbfd417cf7bda13fca20b35c34f777902203bbead6a62878b9d649afdc9bfe9ffca380a2b39656c16e2b63bef3b981f96506"} 17:33:42 INFO - Running post-run listener: copy_logs_to_upload_dir 17:33:42 INFO - Copying logs to upload dir... 17:33:42 INFO - mkdir: /builds/slave/test/build/upload/logs 17:33:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.214247 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-01 17:33:42.550249) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 17:33:42.553947) ========= 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-1467417046.763097-1411699576 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/241ed42ea386b6cfccecdf413335ee83c1c493d146fa3b690659604acb2e6c8ef1304eb7cbcc753af2d9a4c7c389331b226c8c10eead212133d0e04a868fd1d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/41cbf57a39fc8faec7af05670c2e92c2cdad1cf796698b0c330f056bf11508b2ac4573cf2b70cd78412dd86f7a49f1e54e78cc127782380dc8193280ee40b176", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c0213c74bdf7abb87260f8c6d8d8cbfd417cf7bda13fca20b35c34f777902203bbead6a62878b9d649afdc9bfe9ffca380a2b39656c16e2b63bef3b981f96506"} build_url:https://queue.taskcluster.net/v1/task/Tu5EVArkRhq3ZR4RPOOOmA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011225 build_url: 'https://queue.taskcluster.net/v1/task/Tu5EVArkRhq3ZR4RPOOOmA/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/241ed42ea386b6cfccecdf413335ee83c1c493d146fa3b690659604acb2e6c8ef1304eb7cbcc753af2d9a4c7c389331b226c8c10eead212133d0e04a868fd1d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/41cbf57a39fc8faec7af05670c2e92c2cdad1cf796698b0c330f056bf11508b2ac4573cf2b70cd78412dd86f7a49f1e54e78cc127782380dc8193280ee40b176", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c0213c74bdf7abb87260f8c6d8d8cbfd417cf7bda13fca20b35c34f777902203bbead6a62878b9d649afdc9bfe9ffca380a2b39656c16e2b63bef3b981f96506"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 17:33:42.579221) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 17:33:42.579557) ========= 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-1467417046.763097-1411699576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004393 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 17:33:42.662260) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 17:33:42.662600) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 17:33:42.662881) ========= ========= Total master_lag: 0.17 =========