builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-006 starttime: 1467763078.48 results: success (0) buildid: 20160705162222 builduid: 42906ffa46ff414d88a8150d80a3bdb4 revision: 2feacd5bcb0efcb8916849c4fad7e01afb30cf2b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 16:57:58.485265) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 16:57:58.485944) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 16:57:58.486260) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 16:57:58.548009) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 16:57:58.548441) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1467762503.650719-1404784090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 16:57:59-- 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% 223M=0s 2016-07-05 16:57:59 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120844 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 16:57:58.686151) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 16:57:58.686479) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1467762503.650719-1404784090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019566 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 16:57:58.736110) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-05 16:57:58.736468) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2feacd5bcb0efcb8916849c4fad7e01afb30cf2b --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 2feacd5bcb0efcb8916849c4fad7e01afb30cf2b --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=e31afd3c0f0de4e86ebe4d94000001b5-1467762503.650719-1404784090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 16:57:59,401 truncating revision to first 12 chars 2016-07-05 16:57:59,401 Setting DEBUG logging. 2016-07-05 16:57:59,401 attempt 1/10 2016-07-05 16:57:59,401 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2feacd5bcb0e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 16:58:00,519 unpacking tar archive at: fx-team-2feacd5bcb0e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.457315 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-05 16:58:00.208737) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 16:58:00.209087) ========= script_repo_revision: 2feacd5bcb0efcb8916849c4fad7e01afb30cf2b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 16:58:00.209571) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 16:58:00.209904) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 16:58:00.220095) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-05 16:58:00.220425) ========= /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=e31afd3c0f0de4e86ebe4d94000001b5-1467762503.650719-1404784090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:58:00 INFO - MultiFileLogger online at 20160705 16:58:00 in /builds/slave/test 16:58:00 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 16:58:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:58:00 INFO - {'append_to_log': False, 16:58:00 INFO - 'base_work_dir': '/builds/slave/test', 16:58:00 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:58:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:58:00 INFO - 'branch': 'Fx-Team-Non-PGO', 16:58:00 INFO - 'buildbot_json_path': 'buildprops.json', 16:58:00 INFO - 'config_files': ('talos/linux_config.py',), 16:58:00 INFO - 'default_actions': ('clobber', 16:58:00 INFO - 'read-buildbot-config', 16:58:00 INFO - 'download-and-extract', 16:58:00 INFO - 'populate-webroot', 16:58:00 INFO - 'create-virtualenv', 16:58:00 INFO - 'install', 16:58:00 INFO - 'run-tests'), 16:58:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:58:00 INFO - 'download_minidump_stackwalk': True, 16:58:00 INFO - 'download_symbols': 'ondemand', 16:58:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:58:00 INFO - 'tooltool.py': '/tools/tooltool.py', 16:58:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:58:00 INFO - '/tools/misc-python/virtualenv.py')}, 16:58:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:58:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:58:00 INFO - 'installer_path': 'installer.exe', 16:58:00 INFO - 'log_level': 'info', 16:58:00 INFO - 'log_name': 'talos', 16:58:00 INFO - 'log_to_console': True, 16:58:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:58:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:58:00 INFO - 'opt_config_files': (), 16:58:00 INFO - 'pip_index': False, 16:58:00 INFO - 'sps_profile': False, 16:58:00 INFO - 'sps_profile_interval': 0, 16:58:00 INFO - 'suite': 'dromaeojs', 16:58:00 INFO - 'system_bits': '32', 16:58:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:58:00 INFO - 'title': 'talos-linux64-ix-006', 16:58:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:58:00 INFO - 'use_talos_json': True, 16:58:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:58:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:58:00 INFO - 'work_dir': 'build'} 16:58:00 INFO - ##### 16:58:00 INFO - ##### Running clobber step. 16:58:00 INFO - ##### 16:58:00 INFO - Running pre-action listener: _resource_record_pre_action 16:58:00 INFO - Running main action method: clobber 16:58:00 INFO - rmtree: /builds/slave/test/build 16:58:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:58:01 INFO - Running post-action listener: _resource_record_post_action 16:58:01 INFO - ##### 16:58:01 INFO - ##### Finished clobber step (success) 16:58:01 INFO - ##### 16:58:01 INFO - ##### 16:58:01 INFO - ##### Running read-buildbot-config step. 16:58:01 INFO - ##### 16:58:01 INFO - Running pre-action listener: _resource_record_pre_action 16:58:01 INFO - Running main action method: read_buildbot_config 16:58:01 INFO - Using buildbot properties: 16:58:01 INFO - { 16:58:01 INFO - "project": "", 16:58:01 INFO - "product": "firefox", 16:58:01 INFO - "script_repo_revision": "production", 16:58:01 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:58:01 INFO - "repository": "", 16:58:01 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 16:58:01 INFO - "buildid": "20160705162222", 16:58:01 INFO - "pgo_build": "False", 16:58:01 INFO - "basedir": "/builds/slave/test", 16:58:01 INFO - "buildnumber": 1934, 16:58:01 INFO - "slavename": "talos-linux64-ix-006", 16:58:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:58:01 INFO - "platform": "ubuntu64_hw", 16:58:01 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:58:01 INFO - "branch": "fx-team", 16:58:01 INFO - "repo_path": "integration/fx-team", 16:58:01 INFO - "revision": "2feacd5bcb0efcb8916849c4fad7e01afb30cf2b", 16:58:01 INFO - "stage_platform": "linux64", 16:58:01 INFO - "builduid": "42906ffa46ff414d88a8150d80a3bdb4", 16:58:01 INFO - "slavebuilddir": "test" 16:58:01 INFO - } 16:58:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/SUhdP0DyQH6ThQzqrCNrww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 16:58:01 INFO - Running post-action listener: _resource_record_post_action 16:58:01 INFO - ##### 16:58:01 INFO - ##### Finished read-buildbot-config step (success) 16:58:01 INFO - ##### 16:58:01 INFO - ##### 16:58:01 INFO - ##### Running download-and-extract step. 16:58:01 INFO - ##### 16:58:01 INFO - Running pre-action listener: _resource_record_pre_action 16:58:01 INFO - Running main action method: download_and_extract 16:58:01 INFO - mkdir: /builds/slave/test/build/tests 16:58:01 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')]} 16:58:01 INFO - https://queue.taskcluster.net/v1/task/SUhdP0DyQH6ThQzqrCNrww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:58:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SUhdP0DyQH6ThQzqrCNrww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:58:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SUhdP0DyQH6ThQzqrCNrww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:58:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SUhdP0DyQH6ThQzqrCNrww/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 16:58:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SUhdP0DyQH6ThQzqrCNrww/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 16:58:02 INFO - Downloaded 1361 bytes. 16:58:02 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:58:02 INFO - Using the following test package requirements: 16:58:02 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:58:02 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:58:02 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:58:02 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:02 INFO - u'jsshell-linux-x86_64.zip'], 16:58:02 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:58:02 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:58:02 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:58:02 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:58:02 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:58:02 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:58:02 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:58:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:02 INFO - https://queue.taskcluster.net/v1/task/SUhdP0DyQH6ThQzqrCNrww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:58:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SUhdP0DyQH6ThQzqrCNrww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:58:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SUhdP0DyQH6ThQzqrCNrww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:58:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SUhdP0DyQH6ThQzqrCNrww/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 16:58:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SUhdP0DyQH6ThQzqrCNrww/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 16:58:04 INFO - Downloaded 22729872 bytes. 16:58:04 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'] 16:58:04 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 16:58:05 INFO - Return code: 0 16:58:05 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 16:58:05 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')]} 16:58:05 INFO - https://queue.taskcluster.net/v1/task/SUhdP0DyQH6ThQzqrCNrww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:58:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SUhdP0DyQH6ThQzqrCNrww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:58:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SUhdP0DyQH6ThQzqrCNrww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:58:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SUhdP0DyQH6ThQzqrCNrww/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 16:58:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SUhdP0DyQH6ThQzqrCNrww/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 16:58:12 INFO - Downloaded 22729872 bytes. 16:58:12 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'] 16:58:12 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 16:58:14 INFO - Return code: 0 16:58:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:14 INFO - https://queue.taskcluster.net/v1/task/SUhdP0DyQH6ThQzqrCNrww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:58:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SUhdP0DyQH6ThQzqrCNrww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:58:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SUhdP0DyQH6ThQzqrCNrww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:58:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SUhdP0DyQH6ThQzqrCNrww/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 16:58:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SUhdP0DyQH6ThQzqrCNrww/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 16:58:15 INFO - Downloaded 14403333 bytes. 16:58:15 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'] 16:58:15 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 16:58:15 INFO - Return code: 0 16:58:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:15 INFO - https://queue.taskcluster.net/v1/task/SUhdP0DyQH6ThQzqrCNrww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:58:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SUhdP0DyQH6ThQzqrCNrww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:58:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SUhdP0DyQH6ThQzqrCNrww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:58:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SUhdP0DyQH6ThQzqrCNrww/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 16:58:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SUhdP0DyQH6ThQzqrCNrww/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 16:58:16 INFO - Downloaded 56470221 bytes. 16:58:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SUhdP0DyQH6ThQzqrCNrww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:58:16 INFO - mkdir: /builds/slave/test/properties 16:58:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:58:16 INFO - Writing to file /builds/slave/test/properties/build_url 16:58:16 INFO - Contents: 16:58:16 INFO - build_url:https://queue.taskcluster.net/v1/task/SUhdP0DyQH6ThQzqrCNrww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:58:17 INFO - Running post-action listener: _resource_record_post_action 16:58:17 INFO - Running post-action listener: set_extra_try_arguments 16:58:17 INFO - ##### 16:58:17 INFO - ##### Finished download-and-extract step (success) 16:58:17 INFO - ##### 16:58:17 INFO - ##### 16:58:17 INFO - ##### Running populate-webroot step. 16:58:17 INFO - ##### 16:58:17 INFO - Running pre-action listener: _resource_record_pre_action 16:58:17 INFO - Running main action method: populate_webroot 16:58:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:58:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:58:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:58:17 INFO - '--tppagecycles', 16:58:17 INFO - '7'], 16:58:17 INFO - 'tests': ['tsvgm']}}, 16:58:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:58:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:58:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:58:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:58:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:58:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:58:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:17 INFO - 'talos_options': ['--disable-e10s'], 16:58:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:58:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:58:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:17 INFO - 'talos_options': ['--disable-e10s'], 16:58:17 INFO - 'tests': ['damp', 'tps']}, 16:58:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:17 INFO - 'tests': ['damp', 'tps']}, 16:58:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:58:17 INFO - 'tests': ['dromaeo_dom']}, 16:58:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:58:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:58:17 INFO - 'tests': ['basic_compositor_video']}, 16:58:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:58:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:58:17 INFO - 'tests': ['a11yr', 16:58:17 INFO - 'ts_paint', 16:58:17 INFO - 'tpaint', 16:58:17 INFO - 'sessionrestore', 16:58:17 INFO - 'sessionrestore_no_auto_restore', 16:58:17 INFO - 'tabpaint']}, 16:58:17 INFO - 'other-e10s': {'tests': ['a11yr', 16:58:17 INFO - 'ts_paint', 16:58:17 INFO - 'tpaint', 16:58:17 INFO - 'sessionrestore', 16:58:17 INFO - 'sessionrestore_no_auto_restore', 16:58:17 INFO - 'tabpaint']}, 16:58:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:58:17 INFO - 'ts_paint', 16:58:17 INFO - 'tpaint', 16:58:17 INFO - 'sessionrestore', 16:58:17 INFO - 'sessionrestore_no_auto_restore', 16:58:17 INFO - 'tabpaint']}, 16:58:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:58:17 INFO - 'ts_paint', 16:58:17 INFO - 'tpaint', 16:58:17 INFO - 'sessionrestore', 16:58:17 INFO - 'sessionrestore_no_auto_restore', 16:58:17 INFO - 'tabpaint']}, 16:58:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:58:17 INFO - 'tests': ['a11yr', 16:58:17 INFO - 'ts_paint', 16:58:17 INFO - 'tpaint', 16:58:17 INFO - 'sessionrestore', 16:58:17 INFO - 'sessionrestore_no_auto_restore', 16:58:17 INFO - 'tabpaint']}, 16:58:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:58:17 INFO - 'tests': ['a11yr', 16:58:17 INFO - 'ts_paint', 16:58:17 INFO - 'tpaint', 16:58:17 INFO - 'sessionrestore', 16:58:17 INFO - 'sessionrestore_no_auto_restore', 16:58:17 INFO - 'tabpaint']}, 16:58:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:58:17 INFO - 'tests': ['tsvgx', 16:58:17 INFO - 'tsvgr_opacity', 16:58:17 INFO - 'tart', 16:58:17 INFO - 'tscrollx', 16:58:17 INFO - 'cart']}, 16:58:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:58:17 INFO - 'tsvgr_opacity', 16:58:17 INFO - 'tart', 16:58:17 INFO - 'tscrollx', 16:58:17 INFO - 'cart']}, 16:58:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:17 INFO - 'talos_options': ['--disable-e10s'], 16:58:17 INFO - 'tests': ['tp5o']}, 16:58:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:17 INFO - 'tests': ['tp5o']}, 16:58:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:17 INFO - 'talos_options': ['--disable-e10s', 16:58:17 INFO - '--xperf_path', 16:58:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:58:17 INFO - 'tests': ['tp5n']}, 16:58:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:17 INFO - 'talos_options': ['--xperf_path', 16:58:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:58:17 INFO - 'tests': ['tp5n']}}, 16:58:17 INFO - 'talos.zip': {'path': '', 16:58:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:58:17 INFO - Running post-action listener: _resource_record_post_action 16:58:17 INFO - ##### 16:58:17 INFO - ##### Finished populate-webroot step (success) 16:58:17 INFO - ##### 16:58:17 INFO - ##### 16:58:17 INFO - ##### Running create-virtualenv step. 16:58:17 INFO - ##### 16:58:17 INFO - Running pre-action listener: _resource_record_pre_action 16:58:17 INFO - Running main action method: create_virtualenv 16:58:17 INFO - Creating virtualenv /builds/slave/test/build/venv 16:58:17 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 16:58:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:58:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:58:17 INFO - Using real prefix '/usr' 16:58:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:58:18 INFO - Installing distribute.............................................................................................................................................................................................done. 16:58:20 INFO - Installing pip.................done. 16:58:20 INFO - Return code: 0 16:58:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:58: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')]} 16:58:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58: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')]} 16:58:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b65180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b633b0>, '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 0x1b642b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b64740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467762503.650719-1404784090', '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 16:58: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', 'pip>=1.5'] in /builds/slave/test/build 16:58: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 pip>=1.5 16:58:20 INFO - Using env: {'DISPLAY': ':0', 16:58:20 INFO - 'HOME': '/home/cltbld', 16:58:20 INFO - 'LANG': 'en_US.UTF-8', 16:58:20 INFO - 'LANGUAGE': 'en_US:en', 16:58:20 INFO - 'LOGNAME': 'cltbld', 16:58:20 INFO - 'MAIL': '/var/mail/cltbld', 16:58:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:20 INFO - 'MOZ_NO_REMOTE': '1', 16:58:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:20 INFO - 'NO_EM_RESTART': '1', 16:58:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:20 INFO - 'PWD': '/builds/slave/test', 16:58:20 INFO - 'SHELL': '/bin/bash', 16:58:20 INFO - 'SHLVL': '1', 16:58:20 INFO - 'TERM': 'linux', 16:58:20 INFO - 'TMOUT': '86400', 16:58:20 INFO - 'USER': 'cltbld', 16:58:20 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467762503.650719-1404784090', 16:58:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:20 INFO - '_': '/tools/buildbot/bin/python'} 16:58:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:20 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 16:58:20 INFO - Cleaning up... 16:58:20 INFO - Return code: 0 16:58:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:58: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')]} 16:58:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58: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')]} 16:58:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58: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', '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 0x18a4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b65180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b633b0>, '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 0x1b642b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b64740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467762503.650719-1404784090', '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 16:58: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', 'psutil>=3.1.1'] in /builds/slave/test/build 16:58: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 psutil>=3.1.1 16:58:20 INFO - Using env: {'DISPLAY': ':0', 16:58:20 INFO - 'HOME': '/home/cltbld', 16:58:20 INFO - 'LANG': 'en_US.UTF-8', 16:58:20 INFO - 'LANGUAGE': 'en_US:en', 16:58:20 INFO - 'LOGNAME': 'cltbld', 16:58:20 INFO - 'MAIL': '/var/mail/cltbld', 16:58:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:20 INFO - 'MOZ_NO_REMOTE': '1', 16:58:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:20 INFO - 'NO_EM_RESTART': '1', 16:58:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:20 INFO - 'PWD': '/builds/slave/test', 16:58:20 INFO - 'SHELL': '/bin/bash', 16:58:20 INFO - 'SHLVL': '1', 16:58:20 INFO - 'TERM': 'linux', 16:58:20 INFO - 'TMOUT': '86400', 16:58:20 INFO - 'USER': 'cltbld', 16:58:20 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467762503.650719-1404784090', 16:58:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:20 INFO - '_': '/tools/buildbot/bin/python'} 16:58:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:20 INFO - Downloading/unpacking psutil>=3.1.1 16:58: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 16:58: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 16:58: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 16:58: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 16:58: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 16:58: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 16:58:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:58:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:58:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:58:22 INFO - Installing collected packages: psutil 16:58:22 INFO - Running setup.py install for psutil 16:58:22 INFO - building 'psutil._psutil_linux' extension 16:58:22 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 16:58:22 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 16:58:23 INFO - building 'psutil._psutil_posix' extension 16:58:23 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 16:58:23 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 16:58:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:58:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:58:23 INFO - Successfully installed psutil 16:58:23 INFO - Cleaning up... 16:58:23 INFO - Return code: 0 16:58:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:58:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:23 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 0x18a4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b65180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b633b0>, '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 0x1b642b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b64740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467762503.650719-1404784090', '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 16:58:23 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 16:58:23 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 16:58:23 INFO - Using env: {'DISPLAY': ':0', 16:58:23 INFO - 'HOME': '/home/cltbld', 16:58:23 INFO - 'LANG': 'en_US.UTF-8', 16:58:23 INFO - 'LANGUAGE': 'en_US:en', 16:58:23 INFO - 'LOGNAME': 'cltbld', 16:58:23 INFO - 'MAIL': '/var/mail/cltbld', 16:58:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:23 INFO - 'MOZ_NO_REMOTE': '1', 16:58:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:23 INFO - 'NO_EM_RESTART': '1', 16:58:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:23 INFO - 'PWD': '/builds/slave/test', 16:58:23 INFO - 'SHELL': '/bin/bash', 16:58:23 INFO - 'SHLVL': '1', 16:58:23 INFO - 'TERM': 'linux', 16:58:23 INFO - 'TMOUT': '86400', 16:58:23 INFO - 'USER': 'cltbld', 16:58:23 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467762503.650719-1404784090', 16:58:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:23 INFO - '_': '/tools/buildbot/bin/python'} 16:58:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:58:23 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 16:58:23 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 16:58:23 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 16:58:23 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 16:58:23 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 16:58:23 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 16:58:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:58:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:58:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:58:25 INFO - Installing collected packages: mozsystemmonitor 16:58:25 INFO - Running setup.py install for mozsystemmonitor 16:58:25 INFO - Successfully installed mozsystemmonitor 16:58:25 INFO - Cleaning up... 16:58:25 INFO - Return code: 0 16:58:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:58: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')]} 16:58:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58: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')]} 16:58:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58: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', '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 0x18a4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b65180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b633b0>, '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 0x1b642b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b64740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467762503.650719-1404784090', '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 16:58: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:58: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 jsonschema==2.5.1 16:58:25 INFO - Using env: {'DISPLAY': ':0', 16:58:25 INFO - 'HOME': '/home/cltbld', 16:58:25 INFO - 'LANG': 'en_US.UTF-8', 16:58:25 INFO - 'LANGUAGE': 'en_US:en', 16:58:25 INFO - 'LOGNAME': 'cltbld', 16:58:25 INFO - 'MAIL': '/var/mail/cltbld', 16:58:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:25 INFO - 'MOZ_NO_REMOTE': '1', 16:58:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:25 INFO - 'NO_EM_RESTART': '1', 16:58:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:25 INFO - 'PWD': '/builds/slave/test', 16:58:25 INFO - 'SHELL': '/bin/bash', 16:58:25 INFO - 'SHLVL': '1', 16:58:25 INFO - 'TERM': 'linux', 16:58:25 INFO - 'TMOUT': '86400', 16:58:25 INFO - 'USER': 'cltbld', 16:58:25 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467762503.650719-1404784090', 16:58:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:25 INFO - '_': '/tools/buildbot/bin/python'} 16:58:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:25 INFO - Downloading/unpacking jsonschema==2.5.1 16:58: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 16:58: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 16:58: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 16:58: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 16:58: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 16:58: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 16:58:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:58:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:58: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 16:58: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 16:58: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 16:58: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 16:58: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 16:58: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 16:58:27 INFO - Downloading functools32-3.2.3-2.tar.gz 16:58:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:58:27 INFO - warning: no files found matching '*.txt' 16:58:27 INFO - no previously-included directories found matching 'build' 16:58:27 INFO - no previously-included directories found matching 'dist' 16:58:27 INFO - no previously-included directories found matching '.git*' 16:58:27 INFO - Installing collected packages: jsonschema, functools32 16:58:27 INFO - Running setup.py install for functools32 16:58:28 INFO - warning: no files found matching '*.txt' 16:58:28 INFO - no previously-included directories found matching 'build' 16:58:28 INFO - no previously-included directories found matching 'dist' 16:58:28 INFO - no previously-included directories found matching '.git*' 16:58:28 INFO - Successfully installed jsonschema functools32 16:58:28 INFO - Cleaning up... 16:58:28 INFO - Return code: 0 16:58:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:58: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')]} 16:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58: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')]} 16:58:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:28 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 0x18a4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b65180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b633b0>, '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 0x1b642b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b64740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467762503.650719-1404784090', '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 16:58:28 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 16:58:28 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 16:58:28 INFO - Using env: {'DISPLAY': ':0', 16:58:28 INFO - 'HOME': '/home/cltbld', 16:58:28 INFO - 'LANG': 'en_US.UTF-8', 16:58:28 INFO - 'LANGUAGE': 'en_US:en', 16:58:28 INFO - 'LOGNAME': 'cltbld', 16:58:28 INFO - 'MAIL': '/var/mail/cltbld', 16:58:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:28 INFO - 'MOZ_NO_REMOTE': '1', 16:58:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:28 INFO - 'NO_EM_RESTART': '1', 16:58:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:28 INFO - 'PWD': '/builds/slave/test', 16:58:28 INFO - 'SHELL': '/bin/bash', 16:58:28 INFO - 'SHLVL': '1', 16:58:28 INFO - 'TERM': 'linux', 16:58:28 INFO - 'TMOUT': '86400', 16:58:28 INFO - 'USER': 'cltbld', 16:58:28 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467762503.650719-1404784090', 16:58:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:28 INFO - '_': '/tools/buildbot/bin/python'} 16:58:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:28 INFO - Downloading/unpacking blobuploader==1.2.4 16:58:28 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 16:58:28 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 16:58:28 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 16:58:28 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 16:58:28 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 16:58:28 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 16:58:30 INFO - Downloading blobuploader-1.2.4.tar.gz 16:58:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:58:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:58:30 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 16:58:30 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 16:58:30 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 16:58:30 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 16:58:30 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 16:58:30 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 16:58:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:58:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:58:30 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 16:58:30 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 16:58:30 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 16:58:30 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 16:58:30 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 16:58:30 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 16:58:30 INFO - Downloading docopt-0.6.1.tar.gz 16:58:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:58:31 INFO - Installing collected packages: blobuploader, requests, docopt 16:58:31 INFO - Running setup.py install for blobuploader 16:58:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:58:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:58:31 INFO - Running setup.py install for requests 16:58:31 INFO - Running setup.py install for docopt 16:58:31 INFO - Successfully installed blobuploader requests docopt 16:58:31 INFO - Cleaning up... 16:58:31 INFO - Return code: 0 16:58:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:58: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')]} 16:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58: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')]} 16:58:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:31 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 0x18a4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b65180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b633b0>, '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 0x1b642b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b64740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467762503.650719-1404784090', '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 16:58:31 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 16:58:31 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 16:58:31 INFO - Using env: {'DISPLAY': ':0', 16:58:31 INFO - 'HOME': '/home/cltbld', 16:58:31 INFO - 'LANG': 'en_US.UTF-8', 16:58:31 INFO - 'LANGUAGE': 'en_US:en', 16:58:31 INFO - 'LOGNAME': 'cltbld', 16:58:31 INFO - 'MAIL': '/var/mail/cltbld', 16:58:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:31 INFO - 'MOZ_NO_REMOTE': '1', 16:58:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:31 INFO - 'NO_EM_RESTART': '1', 16:58:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:31 INFO - 'PWD': '/builds/slave/test', 16:58:31 INFO - 'SHELL': '/bin/bash', 16:58:31 INFO - 'SHLVL': '1', 16:58:31 INFO - 'TERM': 'linux', 16:58:31 INFO - 'TMOUT': '86400', 16:58:31 INFO - 'USER': 'cltbld', 16:58:31 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467762503.650719-1404784090', 16:58:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:31 INFO - '_': '/tools/buildbot/bin/python'} 16:58:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:58:31 INFO - Running setup.py (path:/tmp/pip-fIvqki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:58:31 INFO - Running setup.py (path:/tmp/pip-GMSAuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:58:31 INFO - Running setup.py (path:/tmp/pip-lz9thX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:58:32 INFO - Running setup.py (path:/tmp/pip-4QLkpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:58:32 INFO - Running setup.py (path:/tmp/pip-k7W0q0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:58:32 INFO - Running setup.py (path:/tmp/pip-EFcSGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:58:32 INFO - Running setup.py (path:/tmp/pip-r6Le_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:58:32 INFO - Running setup.py (path:/tmp/pip-tz3H5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:58:32 INFO - Running setup.py (path:/tmp/pip-_V5Jsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:58:32 INFO - Running setup.py (path:/tmp/pip-y5fY1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:58:32 INFO - Running setup.py (path:/tmp/pip-Q80iXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:58:32 INFO - Running setup.py (path:/tmp/pip-ZS2jyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:58:32 INFO - Running setup.py (path:/tmp/pip-Q7JZg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:58:32 INFO - Running setup.py (path:/tmp/pip-bjrbLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:58:32 INFO - Running setup.py (path:/tmp/pip-HjArqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:58:32 INFO - Running setup.py (path:/tmp/pip-J5DFT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:58:32 INFO - Running setup.py (path:/tmp/pip-4dyzs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:58:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:58:33 INFO - Running setup.py install for manifestparser 16:58:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:58:33 INFO - Running setup.py install for mozcrash 16:58:33 INFO - Running setup.py install for mozdebug 16:58:33 INFO - Running setup.py install for mozdevice 16:58:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:58:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:58:33 INFO - Running setup.py install for mozfile 16:58:33 INFO - Running setup.py install for mozhttpd 16:58:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:58:33 INFO - Running setup.py install for mozinfo 16:58:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:58:33 INFO - Running setup.py install for mozInstall 16:58:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:58:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:58:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:58:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:58:33 INFO - Running setup.py install for mozleak 16:58:33 INFO - Running setup.py install for mozlog 16:58:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:58:34 INFO - Running setup.py install for moznetwork 16:58:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:58:34 INFO - Running setup.py install for mozprocess 16:58:34 INFO - Running setup.py install for mozprofile 16:58:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:58:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:58:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:58:34 INFO - Running setup.py install for mozrunner 16:58:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:58:34 INFO - Running setup.py install for mozscreenshot 16:58:34 INFO - Running setup.py install for moztest 16:58:34 INFO - Running setup.py install for mozversion 16:58:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:58:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:58:34 INFO - Cleaning up... 16:58:34 INFO - Return code: 0 16:58:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:58:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:34 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 0x18a4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b65180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b633b0>, '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 0x1b642b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b64740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467762503.650719-1404784090', '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 16:58:34 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 16:58:34 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 16:58:34 INFO - Using env: {'DISPLAY': ':0', 16:58:34 INFO - 'HOME': '/home/cltbld', 16:58:34 INFO - 'LANG': 'en_US.UTF-8', 16:58:34 INFO - 'LANGUAGE': 'en_US:en', 16:58:34 INFO - 'LOGNAME': 'cltbld', 16:58:34 INFO - 'MAIL': '/var/mail/cltbld', 16:58:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:34 INFO - 'MOZ_NO_REMOTE': '1', 16:58:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:34 INFO - 'NO_EM_RESTART': '1', 16:58:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:34 INFO - 'PWD': '/builds/slave/test', 16:58:34 INFO - 'SHELL': '/bin/bash', 16:58:34 INFO - 'SHLVL': '1', 16:58:34 INFO - 'TERM': 'linux', 16:58:34 INFO - 'TMOUT': '86400', 16:58:34 INFO - 'USER': 'cltbld', 16:58:34 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467762503.650719-1404784090', 16:58:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:34 INFO - '_': '/tools/buildbot/bin/python'} 16:58:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:58:35 INFO - Running setup.py (path:/tmp/pip-ArJCO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:58:35 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)) 16:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:58:35 INFO - Running setup.py (path:/tmp/pip-wkLCaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:58:35 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)) 16:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:58:35 INFO - Running setup.py (path:/tmp/pip-8dEAG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:58:35 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)) 16:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:58:35 INFO - Running setup.py (path:/tmp/pip-1Jv98Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:58:35 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)) 16:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:58:35 INFO - Running setup.py (path:/tmp/pip-_BiSOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:58:35 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)) 16:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:58:35 INFO - Running setup.py (path:/tmp/pip-H0rTtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:58:35 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)) 16:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:58:35 INFO - Running setup.py (path:/tmp/pip-A7RmD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:58:35 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)) 16:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:58:35 INFO - Running setup.py (path:/tmp/pip-aW87qI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:58:35 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)) 16:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:58:35 INFO - Running setup.py (path:/tmp/pip-EhXWG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:58:35 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)) 16:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:58:35 INFO - Running setup.py (path:/tmp/pip-GjYK9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:58:35 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)) 16:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:58:35 INFO - Running setup.py (path:/tmp/pip-4A2oEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:58:35 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)) 16:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:58:35 INFO - Running setup.py (path:/tmp/pip-WYSaEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:58:35 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)) 16:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:58:35 INFO - Running setup.py (path:/tmp/pip-UEPfcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:58:36 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)) 16:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:58:36 INFO - Running setup.py (path:/tmp/pip-Uv3I8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:58:36 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)) 16:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:58:36 INFO - Running setup.py (path:/tmp/pip-X_2Q1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:58:36 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)) 16:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:58:36 INFO - Running setup.py (path:/tmp/pip-iEOYaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:58:36 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)) 16:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:58:36 INFO - Running setup.py (path:/tmp/pip-r5W3CE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:58:36 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)) 16:58:36 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)) 16:58:36 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)) 16:58:36 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)) 16:58:36 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)) 16:58:36 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)) 16:58:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:58:36 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 16:58:36 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 16:58:36 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 16:58:36 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 16:58:36 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 16:58:36 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 16:58:38 INFO - Downloading blessings-1.6.tar.gz 16:58:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:58:38 INFO - Installing collected packages: blessings 16:58:38 INFO - Running setup.py install for blessings 16:58:38 INFO - Successfully installed blessings 16:58:38 INFO - Cleaning up... 16:58:38 INFO - Return code: 0 16:58:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:58:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:58:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:58:38 INFO - Reading from file tmpfile_stdout 16:58:38 INFO - Current package versions: 16:58:38 INFO - argparse == 1.2.1 16:58:38 INFO - blessings == 1.6 16:58:38 INFO - blobuploader == 1.2.4 16:58:38 INFO - docopt == 0.6.1 16:58:38 INFO - functools32 == 3.2.3-2 16:58:38 INFO - jsonschema == 2.5.1 16:58:38 INFO - manifestparser == 1.1 16:58:38 INFO - mozInstall == 1.12 16:58:38 INFO - mozcrash == 0.17 16:58:38 INFO - mozdebug == 0.1 16:58:38 INFO - mozdevice == 0.48 16:58:38 INFO - mozfile == 1.2 16:58:38 INFO - mozhttpd == 0.7 16:58:38 INFO - mozinfo == 0.9 16:58:38 INFO - mozleak == 0.1 16:58:38 INFO - mozlog == 3.2 16:58:38 INFO - moznetwork == 0.27 16:58:38 INFO - mozprocess == 0.22 16:58:38 INFO - mozprofile == 0.28 16:58:38 INFO - mozrunner == 6.11 16:58:38 INFO - mozscreenshot == 0.1 16:58:38 INFO - mozsystemmonitor == 0.3 16:58:38 INFO - moztest == 0.7 16:58:38 INFO - mozversion == 1.4 16:58:38 INFO - psutil == 3.1.1 16:58:38 INFO - requests == 1.2.3 16:58:38 INFO - wsgiref == 0.1.2 16:58:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:58:38 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')]} 16:58:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:38 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')]} 16:58:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:38 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 0x18a4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b65180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b633b0>, '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 0x1b642b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b64740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467762503.650719-1404784090', '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 16:58:38 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 16:58:38 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 16:58:38 INFO - Using env: {'DISPLAY': ':0', 16:58:38 INFO - 'HOME': '/home/cltbld', 16:58:38 INFO - 'LANG': 'en_US.UTF-8', 16:58:38 INFO - 'LANGUAGE': 'en_US:en', 16:58:38 INFO - 'LOGNAME': 'cltbld', 16:58:38 INFO - 'MAIL': '/var/mail/cltbld', 16:58:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:38 INFO - 'MOZ_NO_REMOTE': '1', 16:58:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:38 INFO - 'NO_EM_RESTART': '1', 16:58:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:38 INFO - 'PWD': '/builds/slave/test', 16:58:38 INFO - 'SHELL': '/bin/bash', 16:58:38 INFO - 'SHLVL': '1', 16:58:38 INFO - 'TERM': 'linux', 16:58:38 INFO - 'TMOUT': '86400', 16:58:38 INFO - 'USER': 'cltbld', 16:58:38 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467762503.650719-1404784090', 16:58:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:38 INFO - '_': '/tools/buildbot/bin/python'} 16:58:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:38 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)) 16:58:38 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)) 16:58:38 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)) 16:58:38 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)) 16:58:38 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)) 16:58:38 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)) 16:58:38 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)) 16:58:38 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)) 16:58:38 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)) 16:58:38 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)) 16:58:38 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)) 16:58:38 INFO - Cleaning up... 16:58:38 INFO - Return code: 0 16:58:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:58:38 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')]} 16:58:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:38 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')]} 16:58:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:38 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 0x18a4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b65180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b633b0>, '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 0x1b642b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b64740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467762503.650719-1404784090', '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 16:58:38 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 16:58:38 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 16:58:38 INFO - Using env: {'DISPLAY': ':0', 16:58:38 INFO - 'HOME': '/home/cltbld', 16:58:38 INFO - 'LANG': 'en_US.UTF-8', 16:58:38 INFO - 'LANGUAGE': 'en_US:en', 16:58:38 INFO - 'LOGNAME': 'cltbld', 16:58:38 INFO - 'MAIL': '/var/mail/cltbld', 16:58:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:38 INFO - 'MOZ_NO_REMOTE': '1', 16:58:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:38 INFO - 'NO_EM_RESTART': '1', 16:58:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:38 INFO - 'PWD': '/builds/slave/test', 16:58:38 INFO - 'SHELL': '/bin/bash', 16:58:38 INFO - 'SHLVL': '1', 16:58:38 INFO - 'TERM': 'linux', 16:58:38 INFO - 'TMOUT': '86400', 16:58:38 INFO - 'USER': 'cltbld', 16:58:38 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467762503.650719-1404784090', 16:58:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:38 INFO - '_': '/tools/buildbot/bin/python'} 16:58:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:58:39 INFO - Cleaning up... 16:58:39 INFO - Return code: 0 16:58:39 INFO - Running post-action listener: _resource_record_post_action 16:58:39 INFO - Running post-action listener: _start_resource_monitoring 16:58:39 INFO - Starting resource monitoring. 16:58:39 INFO - ##### 16:58:39 INFO - ##### Finished create-virtualenv step (success) 16:58:39 INFO - ##### 16:58:39 INFO - ##### 16:58:39 INFO - ##### Running install step. 16:58:39 INFO - ##### 16:58:39 INFO - Running pre-action listener: _resource_record_pre_action 16:58:39 INFO - Running main action method: install 16:58:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:58:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:58:39 INFO - Reading from file tmpfile_stdout 16:58:39 INFO - Detecting whether we're running mozinstall >=1.0... 16:58:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:58:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:58:39 INFO - Reading from file tmpfile_stdout 16:58:39 INFO - Output received: 16:58:39 INFO - Usage: mozinstall [options] installer 16:58:39 INFO - Options: 16:58:39 INFO - -h, --help show this help message and exit 16:58:39 INFO - -d DEST, --destination=DEST 16:58:39 INFO - Directory to install application into. [default: 16:58:39 INFO - "/builds/slave/test"] 16:58:39 INFO - --app=APP Application being installed. [default: firefox] 16:58:39 INFO - mkdir: /builds/slave/test/build/application 16:58:39 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'] 16:58:39 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 16:58:55 INFO - Reading from file tmpfile_stdout 16:58:55 INFO - Output received: 16:58:55 INFO - /builds/slave/test/build/application/firefox/firefox 16:58:55 INFO - Running post-action listener: _resource_record_post_action 16:58:55 INFO - ##### 16:58:55 INFO - ##### Finished install step (success) 16:58:55 INFO - ##### 16:58:55 INFO - ##### 16:58:55 INFO - ##### Running run-tests step. 16:58:55 INFO - ##### 16:58:55 INFO - Running pre-action listener: _resource_record_pre_action 16:58:55 INFO - Running main action method: run_tests 16:58:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:58:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:58:55 INFO - Python 2.7.3 16:58:55 INFO - Return code: 0 16:58:55 INFO - grabbing minidump binary from tooltool 16:58:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:55 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 0x1b633b0>, '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 0x1b642b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b64740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:58:55 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 16:58:55 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 16:58:55 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 16:58:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:58:55 INFO - Return code: 0 16:58:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:58:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:58:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:58:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:58:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:58:55 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/SUhdP0DyQH6ThQzqrCNrww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 16:58:55 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/SUhdP0DyQH6ThQzqrCNrww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 16:58:55 INFO - Using env: {'DISPLAY': ':0', 16:58:55 INFO - 'HOME': '/home/cltbld', 16:58:55 INFO - 'LANG': 'en_US.UTF-8', 16:58:55 INFO - 'LANGUAGE': 'en_US:en', 16:58:55 INFO - 'LOGNAME': 'cltbld', 16:58:55 INFO - 'MAIL': '/var/mail/cltbld', 16:58:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:58:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:58:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:55 INFO - 'MOZ_NO_REMOTE': '1', 16:58:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:58:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:55 INFO - 'NO_EM_RESTART': '1', 16:58:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:55 INFO - 'PWD': '/builds/slave/test', 16:58:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:58:55 INFO - 'SHELL': '/bin/bash', 16:58:55 INFO - 'SHLVL': '1', 16:58:55 INFO - 'TERM': 'linux', 16:58:55 INFO - 'TMOUT': '86400', 16:58:55 INFO - 'USER': 'cltbld', 16:58:55 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467762503.650719-1404784090', 16:58:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:55 INFO - '_': '/tools/buildbot/bin/python'} 16:58:55 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/SUhdP0DyQH6ThQzqrCNrww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 16:58:55 INFO - mozversion application_buildid: 20160705162222 16:58:55 INFO - mozversion application_changeset: 2feacd5bcb0efcb8916849c4fad7e01afb30cf2b 16:58:55 INFO - mozversion application_display_name: Nightly 16:58:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:58:55 INFO - mozversion application_name: Firefox 16:58:55 INFO - mozversion application_remotingname: firefox 16:58:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:58:55 INFO - mozversion application_vendor: Mozilla 16:58:55 INFO - mozversion application_version: 50.0a1 16:58:56 INFO - mozversion platform_buildid: 20160705162222 16:58:56 INFO - mozversion platform_changeset: 2feacd5bcb0efcb8916849c4fad7e01afb30cf2b 16:58:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:58:56 INFO - mozversion platform_version: 50.0a1 16:58:56 INFO - using testdate: 1467763135 16:58:56 INFO - actual date: 1467763135 16:58:56 INFO - starting webserver on 'localhost:33624' 16:58:56 INFO - SUITE-START | Running 2 tests 16:58:56 INFO - TEST-START | dromaeo_css 16:58:56 INFO - operating with platform_type : linux_ 16:58:56 INFO - Initialising browser for dromaeo_css test... 16:58:56 INFO - TEST-INFO | started process 21626 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSf29Qk/profile http://localhost:33624/getInfo.html) 16:59:00 INFO - PROCESS | 21626 | __metrics Screen width/height:1600/1200 16:59:00 INFO - PROCESS | 21626 | colorDepth:24 16:59:00 INFO - PROCESS | 21626 | Browser inner width/height: 1024/697 16:59:00 INFO - PROCESS | 21626 | __metrics 16:59:01 INFO - PROCESS | 21626 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:59:01 INFO - TEST-INFO | 21626: exit 0 16:59:01 INFO - Browser initialized. 16:59:01 INFO - Running cycle 1/1 for dromaeo_css test... 16:59:01 INFO - TEST-INFO | started process 21706 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSf29Qk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:59:13 INFO - PROCESS | 21706 | RSS: Main: 159240192 16:59:13 INFO - PROCESS | 21706 | 17:00:05 INFO - PROCESS | 21706 | 1467763205009 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:02:17 INFO - PROCESS | 21706 | Cycle 1(1): loaded http://localhost:33624/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33624/tests/dromaeo/cssquery-ext.html) 17:02:18 INFO - PROCESS | 21706 | RSS: Main: 236294144 17:02:18 INFO - PROCESS | 21706 | 17:05:21 INFO - PROCESS | 21706 | Cycle 1(1): loaded http://localhost:33624/tests/dromaeo/cssquery-ext.html (next: http://localhost:33624/tests/dromaeo/cssquery-jquery.html) 17:05:22 INFO - PROCESS | 21706 | RSS: Main: 239845376 17:05:22 INFO - PROCESS | 21706 | 17:08:24 INFO - PROCESS | 21706 | Cycle 1(1): loaded http://localhost:33624/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33624/tests/dromaeo/cssquery-mootools.html) 17:08:24 INFO - PROCESS | 21706 | RSS: Main: 243580928 17:08:24 INFO - PROCESS | 21706 | 17:11:27 INFO - PROCESS | 21706 | Cycle 1(1): loaded http://localhost:33624/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33624/tests/dromaeo/cssquery-prototype.html) 17:11:27 INFO - PROCESS | 21706 | RSS: Main: 235118592 17:11:27 INFO - PROCESS | 21706 | 17:14:30 INFO - PROCESS | 21706 | Cycle 1(1): loaded http://localhost:33624/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33624/tests/dromaeo/cssquery-yui.html) 17:14:31 INFO - PROCESS | 21706 | RSS: Main: 211271680 17:14:31 INFO - PROCESS | 21706 | 17:17:34 INFO - PROCESS | 21706 | Cycle 1(1): loaded http://localhost:33624/tests/dromaeo/cssquery-yui.html (next: http://localhost:33624/tests/dromaeo/cssquery-dojo.html) 17:17:34 INFO - PROCESS | 21706 | RSS: Main: 274526208 17:17:34 INFO - PROCESS | 21706 | 17:17:34 INFO - PROCESS | 21706 | __start_tp_report 17:17:34 INFO - PROCESS | 21706 | _x_x_mozilla_page_load 17:17:34 INFO - PROCESS | 21706 | _x_x_mozilla_page_load_details 17:17:34 INFO - PROCESS | 21706 | |i|pagename|runs| 17:17:34 INFO - PROCESS | 21706 | |0;dojo.html;2618.685757709075;2620.2532278300687;2636.6308716779654;2649.1390298153106;2660.6142109394136;4553.521880202572;4577.336286238494;4616.422947131608;4679.485256621769;4706.811727530895;4653.511381304957;4675.4856965733825;4687.296905464182;4735;4737.265723812815;4099.71302008858;4247.787610619456;4330.155619654169;4364.650827933773;4477.3731677565165;4383.101464199847;4420.07178492517;4436.711613745097;4444.666650001247;4470.418845550074;4246;4251.171021650779;4251.893702657459;4280.443542339507;4304.956950430487;4256.914861702749;4263.381809637585;4306.504751953534;4317.395564620955;4317.417148684919;4293.29160688486;4295.570442955711;4304.461942257218;4328.913421731548;4348.608625223714;4585.380973568593;4600.677952543323;4631.073785242931;4638.930416043762;4696.459907110692;4974.204127339644;4984.950150498521;4986.177280748672;5002.424721157041;5005.74971251436;4972.279019542182;4976.676516026447;5036.647434679574;5038.143515602356;5046.596272298208;4612.031473390559;4645.001324715135;4648.558386953234;4660.673752837269;4701.106789709944;5122.974385128051;5164.948350516447;5165.251038599382;5168.147255702767;5174.456682048406;4774.40319960005;4829.517048295143;4937.185364414903;4985.451600323961;5034.0686972910125;4955.430125535538;4961.131801934647;4978.726170060609;4988.027334669777;5040.722760248222;4929.211326187793;4933;4933.481984391659;4942.851714448572;4973.955469351405;4783.330333753208;4834.395700537433;4886.169351210303;4915.827946021872;4976.129177393942;4202.495700515958;4203.159368126387;4231.915361692749;4262.936055959163;4263.16868210696;3695.815209239527;3704.5369328833895;3714.1643130296006;3729.9254014919547;3737.439384092408;4141.91716165681;4271.167122411162;4271.957280427218;4313.956860431418;4318.00685842258;5059;5070.949290507047;5079.923801142986;5089.745512724349;5139.049275883974;4305.870823875289;4309.202797482476;4315.201687687788;4358.869233922987;4359;4387.846425375096;4418.381426600278;4444.644428445717;4555.589996900295;4561.5666511682;4696.882577935579;4719.764011799465;4721.929171062368;4726.1492931272705;4772.785224664968;4999.475055119306;5010.624203184703;5013.097642424399;5017.523335283142;5053.2420136979745;4613.215753321876;4653.883652908705;4679.532046795293;4743.027679325661;4772.832950846704;4879.219324907997;4901.6323775716255;4903.730294833818;4939.308496810521;4939.456659767495;4972.900541989212;4975.154223781893;4978.103941290602;4978.751062446936;4980.228064649985;4774.379330687128;4869.31829543857;4879.316895634543;4893.6085113191575;4911.582515486224;4892.828750993698;4915.18899381598;4920.778564964657;4921.550955778745;4970.105381031449;4843.467218606021;4843.95156048435;4850.223964165716;4901.313816065683;4909.77905994224;4833.3958255218095;4844.733539655353;4852.95147048525;4858.562729354234;4886.706797592155;4750.904981900412;4752.19212733843;4754.572088512051;4766.856994290177;4811.350467686818 17:17:34 INFO - PROCESS | 21706 | |1;ext.html;545.2623379513715;584.3251045042975;589.861382575095;593.9020061689824;594.3907494817811;40011.79994100029;41483;41595.42450330461;41643.167136657285;46313;42066;42594;42659.146817063716;42686.57313426865;42692;7624.771256862303;7781.455298129134;7785.883211751829;7929.563873986914;8068.273855353017;7613.885791713129;10111.797764044715;10372.273940824145;10404.739881502946;10753.78492430151;10442.791144177112;10490.265681402305;10496.895031049668;10499.265051446364;10504.68485945419;7683.423743219281;10120.898791012069;10296.073353398193;10366.378017318948;10366.481675916173;9789.510524473819;9829;9841.655542056065;9843.360181588174;9861.950690246575;39275.41086883699;39610.60389396098;39639.40540891889;39724.205515889524;39761.20477590432;2919.6350456192977;3012.7137921897383;3046.5737169979366;3432.7253819694365;3703.518542589446;29892.252693682614;29937.85031074831;30063.398732025238;30540.236494087603;30854.84572577145;3541.610422853484;3558.679718825318;3613.6386361363916;3671.0822294426393;3689.9262014759556;185164;185645;186744;259110;259372;31251.68748312488;53365.1995220072;54304;54312;54314.45685543173;30511.69488305133;32420.675793242237;32477.837610811795;32505.837470812494;32508.512372314435;13058.869411305956;13172.736545269041;13176.077674562688;13186.868131318755;13191.40638671262;8367.665293388196;11299.661010169708;11303.208775385645;11451.59919402817;11638;7809.570473623891;7820.491668041559;7823.726169584037;7839.568823714751;7877.7636670899965;3052.282713562311;3093.58236638051;3100.209446591105;3127.8748850045745;3129.2333378322455;804.8591496488091;875.2560323724783;879.2394578689515;976.9071938165863;980.4068538534227;28302.292442689097;28885.133445996653;28901.7109828899;29811.254718632208;29902.850485747433;925.8518637018045;938.5260443476137;955.1690029674228;963.4460185393427;993.8012397520525;14992.400303987719;15361.539153825179;15453.079266471439;15474.303656335493;15711.450099246471;378844;382108;382383;384397;384951;49789.751051244515;50331.24503132456;50334.49665503371;50398.748006260466;50486.74756626267;1037.258360272409;1066.2642776484047;1135.778523187987;1150.097173718627;1201.585453018707;26734.331641709112;29780.55329170021;30362.240943975692;30533;30967.380652387277;42700.35949460823;43258.78370608127;43286.78356608197;43317;43332;295012;295859;296026;297012;298577;24576.262712118663;25637.48725025452;25677;25738;25805.225843224733;42356.57643423526;42718.145637087706;43255.351169733105;43944.34083488686;44090;37157.62842371542;38045;38065.42901856419;38106.428403573416;38532.22935541217;36881.63118368782;36981;37121.0719731998;37175;38306.80846595749;36892.446613301356;37354.252914942095;37560.43659345167;37661.623383766906;37667.43498847465;33779.15552111217;34184.82907585446;34222.486662700576;34703.30593388169;35000;25578.87210563935;25767.226983190536;26171.345716357242;26186.738132619193;26240.60639090377 17:17:34 INFO - PROCESS | 21706 | |2;jquery.html;346.9531613232213;370.6830659785883;374.2477619983832;375.5981100222761;387.4807757604809;12847.22916625002;16330.91834540827;16833.24250408733;17489.56276093098;18542.258309667595;15948.681026379465;17755.644887102284;18087.90956045221;18096.63806723868;18104.637907241846;4968.105740966625;5205.375354957391;5297.973510132444;5308.362996440433;5313.548348390372;3696.519452471175;5227.79088836446;5256.3955145158225;5812.389699081577;6131.969340153315;6193.969030154843;6223.346548612399;6229.875402491947;6230.345813689565;6242.7502899884175;5998.700064996755;6288.182536270278;6292.528060395489;6297.779577714758;6300;3382.441897086978;3522.7710198836994;3525.8589656413715;5491.066518691792;5503.367112782042;18696;20015.09932053061;20341.796582034287;21789.67315490253;21851;1784.7590575272302;1821.3716267887557;1984.2162345873444;2266.5317777921787;2435.0138194031447;13309.667258318523;13386.330683465787;13598.320083995859;13813.930930345285;14248.572542823731;1756.6750151222066;1815.972760408595;1819.790724066736;1844.087176847469;1892.1201641236892;69835;70944;71212;71750;72839.63580182118;8972.147645973622;9148.908510914805;9464.19554337889;9617.903820961841;10071.5467803949;12945.09384343087;13217.14088584239;13244.53644122451;13278.933605331911;13313.068085233941;6973.651317434108;7422.777316680508;7459.216782237895;7479.401647868158;7506.24937506245;6902.827429314207;6946.409555187764;7017.4035207006955;7026.367626913602;7055.2239253682055;5980.192673989043;6087.482563982023;6137.294211165773;6163.335899307252;6219.875602487925;1677.1698009485383;1678.7230107032447;1703.49746824687;1709.726443768991;1717.2015013019006;862.1464749897556;865.8354912566718;897.9281657467387;909.5497728624373;931.334096121263;17041.573960651083;17183.442569840707;17638.735418968725;18035.54911127206;18146.364877229233;801.1547817053065;809.9109097999216;843.5107637570195;846.6063280574563;903.4263242840843;9861.753456163653;10168.33905796121;10194.388336699822;10244.231682623833;10409.42748148844;131901;132143;134105;352683;362247;68465;69850.30149698438;69880.3011969884;70458.64770676114;70565.2943470569;912.8721978922956;949.4730424614405;957.9233661307079;962.4465932089076;975.1516180922642;11409.885901140882;15069;15204;16219.51341459758;16543.503694889172;25077.623835642116;31729;35249.64750352566;38316;39265;50964.72588185325;51097.23354149616;51758;53554;53815.730921345144;7526.887096693445;7559.20628334017;7611.314981651456;7622.8094297643;7627.656755446129;7722.498037627536;11365.829512557484;11530.884691152982;11749.412529373327;11760.235584686969;4618.145643056046;9682.225421966366;9750.609975600897;10499.370037797757;10667.626633067805;10333.793324133625;10417.374957502574;10457.372557646566;10720.463976801284;10868.347899126078;10529.894701052892;10616.469176541297;10695.625653102416;10818.56725730962;10870.076043536072;7823.178566250462;7854.45018848698;7925.960370198112;7939;7941.086775020946;10325.483725813829;10701;10706.089982351587;10785.730356741144;10882.61910833117 17:17:34 INFO - PROCESS | 21706 | |3;mootools.html;1390.5689236336736;1426.7645838436656;1521.277393238212;1694.3730819596751;1729.9394521191762;7705.845883082342;8197.631106600202;8285.46144500607;8292.626831792568;8308.293795027415;6947.7220911163495;7160.534565253255;7718.691252349913;7994.640241189146;8130.3902207334395;2234.318532847485;2243.540074284768;2258.3112150794;2261.762514935933;2263.9886800565973;2185.530111026129;2195.6706494025866;2233.095596283508;2233.2853486884205;2234.3967128875192;1900.1164458526782;2167.143978128638;2214.4795972946345;2222.799948004679;2248.5615305015526;2258;2266.274792066531;2279.5099053703534;2288.9084436622597;2290.198430549311;2233.8547994380315;2236.8546044507216;2238.2054370698493;2240.6975058367075;2246.472079061419;8250.092489826115;8307.750767476986;8308.210719981593;8312.667493300261;8319.66721331146;4712.599429048535;4713.905721885578;4745.359376484165;4769.070031343889;4773.427188737339;2754.628125203112;2786.8327900325844;2834.4331133773326;2837.4183292425005;2854.100958198161;940.8071345374182;944.6363150187159;944.8488241881266;946.0964778636454;972.9173020293283;11103.888961110366;11104.722381940435;11112.611058612909;11129.833052504218;11142.108631309477;4156.106437115974;4279.828806847753;4401.603855653007;4434.312681534368;4464.2187617166865;9158.358914875895;9289.024652411399;9324.25405967521;9374.953125234466;9377.202937750231;4873.31773551703;4884.194107972145;4884.413870335511;4884.535969082932;4885.071836351082;4359.760213188305;4397.8240870364825;4407.206702793464;4416.9779151104685;4441.866743997685;3721.5348081489815;3743.288775132716;3810.1998580297895;3814.8283327249787;3959.6634286086005;1078.6440474643348;1193.5524178433088;1214.3199808107488;1218.622227109599;1219.4146809531296;679.8470344172522;691.6126968897433;702.5047341624143;709.6593635055099;742.9108506979089;4960.379952505937;4998.4251811042195;5058.367704036996;5081.898362032813;5095.87260318495;823.4853216739538;825.1171246765903;846.1538461538462;848.6562942008496;875.9737207883774;3621.9637803622154;3650.2152037312107;3681.3189559931498;3697.574778900461;3713.9442908356395;9459.668911588062;9876.555555000043;9973.551190196458;9990.700278991642;9998.750031249132;8638.78403039929;9298.814023719488;9930.602775889029;9932.950335248423;9933.50332483373;7474.70101195957;7625.6568454418575;7630.694772209161;7636;7637.121731001006;5257.710825904459;5304.946950530445;5342;5461.918071228855;5467.7266136692215;9022.503762293138;9023.187913087853;9129.90870091317;9330.253579713743;9334.953325233602;9263.86104208424;9313.813723725623;9328.720138395858;9329.16037556623;9476.857847132436;6970.23327433992;7018.508704390643;7024.5434046786795;7054;7078.079849619517;7368.815779605553;7550.433717471102;7578.431617628589;7674.232576742281;7805.5706936116785;5478.534324582455;6913.930860691329;7065;7232.204457509775;7309.671064802203;6974.895376569457;7073.151221853411;7106.040684507525;7189.604571748604;7258.383037441877;6467.417932386108;6521.739130434729;6554.8361290966195;6559.409653131241;6577.210734711865;4337.587435265418;4501.324801279834;4504.887377815581;4524.751138687404;4627.07458508293;4397.230484665107;4450.977745111254;4488.438945131858;4497.302918047708;4503.774811259489 17:17:34 INFO - PROCESS | 21706 | |4;prototype.html;304.7029146582083;307.5417627734676;311.26075570520015;311.8955150024742;312.42825629098735;4884.291777692237;4907.533784290486;4911.386076740408;4916.483769204236;4919.188333924907;4799;4802.423709154898;4848.545436369092;4866.562009419152;4867.732274724889;3620.4388319810405;3755.6619904208615;3756.267527832074;3809.2191100824402;3838.923221535568;3727.5526936767624;3772.264408440355;3777.300214903291;3778.433235014756;3806.90482737931;3758.379867321902;3785.734998550103;3786.5456145262606;3795.8861234162882;3801.5438147422346;3622;3707.536557930245;3821.789801560913;3828.3683192273243;3835.1179228777537;3393.6606339365867;3393.711534519569;3397.184675677844;3406.1654894550993;3417.214040770612;4689.132510485537;4713.670043096985;4748.596369308613;4754.595859351959;4769.260764581495;4224.260754367973;4328.329108988112;4331.04716962271;4341.522432532419;4360.389545463606;4978.253262010691;4988.102141614508;4989.57588604969;5001.899962000776;5028.84913452597;3698.33429982603;3721.5299956517024;3724.2737666155112;3728.478013078144;3734.3278209922205;5137.871553211162;5269.473052694738;5293.550048245904;5332.760025798849;5334.866628334323;3788.1666033472593;3797.6012518685693;3800.7909564974193;3807.3337165996395;3813.4279858020964;3871.593482684334;3877.8836634901;3895.8441662333757;3901.063744701308;3901.31726947783;4344.239758042393;4351.912961740747;4363.95265136365;4389.495208051115;4394.846180383671;4883.34074899891;5025.673331233458;5033.7734801934;5043.142665746758;5105.795768169231;1317.8616245294297;1330.7072444062292;1335.953241636538;1344.5899000804652;1345.9327033648278;847.4788005376772;874.4185116897319;876.088867577712;890.6570970176529;891.7503099132254;4275.251830929575;4410.977945110254;4417.690761646654;4420.513743488214;4427.358033085249;5139.408967968657;5143.254228136899;5170.121079416508;5177.611679124081;5189.455107213764;4374.4094547236355;4375.256206444912;4377.124575084996;4393.648508119343;4396.912061758747;2569.8586577738406;2729.849858257815;2741.684706258766;2758.1311886755607;2762.4337010912714;4891.070696567712;4909.877253068702;4919.573323736148;4920.138975679241;4933.260010998307;5043;5307.495787900143;5317.096093664087;5325.254464374991;5329.973350133302;4911.4106307243355;4921.163402221702;4939.493454496342;4943.950560494349;4958.975205124024;5220.634555581225;5225.216217567396;5228.843134705813;5239.397469290928;5266.683998959921;4950.6039516837845;5105.387353517453;5110.514501122388;5118.692878427306;5121.411037730709;4866.829660961991;4872.585830204331;4918.409790825124;4948.183549714401;4969.801207951641;3805.8477660894364;3805.904852378713;3825.732198746061;3840.8655697050467;3847.8845634631007;4966.577840883421;5139.948600514096;5218.295530103539;5224.50367215114;5232.686038837682;5032.018756342478;5056.544910958031;5057;5060.987802439453;5110.693358398508;5064.898702026013;5068;5069.442361340323;5091.618128640441;5092.363454568179;4796.904061918812;4989.600831933364;5015;5019;5056.494350564914;4857.8299759508245;4932.235503496964;5099.719515426687;5108.233764935289;5112.642115052059;4965.702057876539;5002.174641184164;5004.124278251365;5014.6991180529285;5039.823606173766 17:17:34 INFO - PROCESS | 21706 | |5;yui.html;574.9252597162368;576.3919065386017;642.6433329502125;650.137356473703;726.5749536521134;12391.876081239185;13247.536336228233;13258.668533286673;13300.268485233308;13368.799468007976;11596.420178991038;11716.882831171686;11726.589569365075;11730.941345293262;11752.471138798754;605.2041565341584;742.9219931907153;747.5066456138936;758.981025474362;767.946243762934;773.6711897443593;774.3185996323227;778.155701064343;778.6690656471005;779.4310153587884;831.71721614651;831.8336332733447;832.488019867783;832.6128350317101;834.4284165346727;636.5448704176536;794.5351969098084;817.3542901108117;818.0142927772021;830.2195935820309;584.0567483514094;596.4989408896548;600.5795942839986;602.4999250621973;602.8854517641633;12786;12789.61631151067;12813.743725125538;12818.423170957329;12836.614901552968;12639.1784534005;13068.281244531547;13110.344482775918;13242.404091815892;13357;9317.39436936597;11235.438228088562;11541.653750387502;12091.516339346415;12148.3318417487;4187.099773548671;4192.559781222989;4289.227938970984;4401.22978478765;4423.977880110579;52232.73883630596;53144;58947.41052589462;64409.67795161041;64915.67542162306;9963.202943764481;9977.551010204557;9992.459463373565;10185;10293.639722609672;16910;17052.317907283817;17056.147192640317;17094.658106837793;17957.281708731767;7120;7381;7395.852082958419;7424.406047516186;7589.810254743676;3657.122290650225;3725.3294407006997;3816.5038544988975;3836.9808150959066;3866.3427217373114;3044.786864919479;3132.8903488377796;3150.432922074003;3151.73210277129;3153.038323311366;505.13621706881645;518.1916210711303;539.4362890779067;541.9187121931742;550.0813641219173;495.9429665588431;562.1174755633698;563.5435297409111;573.1574585359515;581.825452364289;7703.614819259014;7709.653065612061;7810.492317999426;7881.881771773428;8045;458.0815464992735;473.11527443680535;553.2503457814684;581.7207740284687;606.8907596632561;3556.7332450066347;3773.3773927302236;3832.7317087803585;3866.052817059838;3888.5333759948985;88412.5579372099;90371.54814225886;90691.54654226819;93206.53396732973;94326.52836735772;50772.492275077515;53569.46430535645;74695.62652186814;76356.23643763602;76654.23345766471;43733;45715;57720.42279577234;68900;70401.29598704152;7398.556086634819;7464.290892365217;7487.663055162422;7518.436117291334;7561.962190189234;40525.18949620932;41673;42054.789726051175;42568.78715606402;42766.14467710691;61661;63035;63483.6825815868;63592;63626;10322.638707645196;10520.263581549218;10561.894381056398;10722.356658600509;10727.318766105203;12966.80549791735;13029.609111726664;13189.076764626385;13220.40508177115;13298.667533311746;11574.247673901169;11915.404229788302;12028.218165819193;12052.638420847388;12247.69380765488;12023.579174728842;12187.634370968884;12478.126531142732;12626;13272.86727132755;10552.630657926935;10671.89328106709;11593.6521904343;11668.124890633406;12312.076594255646;9611.231101512001;9816.26378021637;10013.849792252977;10280.845787313347;10379.429131397847;9406.764830879009;9606.615735370508;9619.951900240454;9645.228381729305;9665.613375464902 17:17:34 INFO - PROCESS | 21706 | __end_tp_report 17:17:34 INFO - PROCESS | 21706 | __start_cc_report 17:17:34 INFO - PROCESS | 21706 | _x_x_mozilla_cycle_collect,1026 17:17:34 INFO - PROCESS | 21706 | __end_cc_report 17:17:34 INFO - PROCESS | 21706 | __startTimestamp1467764254426__endTimestamp 17:17:34 INFO - PROCESS | 21706 | 17:17:34 INFO - PROCESS | 21706 | ------- Summary: start ------- 17:17:34 INFO - PROCESS | 21706 | Number of tests: 6 17:17:34 INFO - PROCESS | 21706 | 17:17:34 INFO - PROCESS | 21706 | [#0] dojo.html Cycles:165 Average:4619.70 Median:4743.03 stddev:479.32 (10.1%) stddev-sans-first:454.36 17:17:34 INFO - PROCESS | 21706 | Values: 2618.7 2620.3 2636.6 2649.1 2660.6 4553.5 4577.3 4616.4 4679.5 4706.8 4653.5 4675.5 4687.3 4735.0 4737.3 4099.7 4247.8 4330.2 4364.7 4477.4 4383.1 4420.1 4436.7 4444.7 4470.4 4246.0 4251.2 4251.9 4280.4 4305.0 4256.9 4263.4 4306.5 4317.4 4317.4 4293.3 4295.6 4304.5 4328.9 4348.6 4585.4 4600.7 4631.1 4638.9 4696.5 4974.2 4985.0 4986.2 5002.4 5005.7 4972.3 4976.7 5036.6 5038.1 5046.6 4612.0 4645.0 4648.6 4660.7 4701.1 5123.0 5164.9 5165.3 5168.1 5174.5 4774.4 4829.5 4937.2 4985.5 5034.1 4955.4 4961.1 4978.7 4988.0 5040.7 4929.2 4933.0 4933.5 4942.9 4974.0 4783.3 4834.4 4886.2 4915.8 4976.1 4202.5 4203.2 4231.9 4262.9 4263.2 3695.8 3704.5 3714.2 3729.9 3737.4 4141.9 4271.2 4272.0 4314.0 4318.0 5059.0 5070.9 5079.9 5089.7 5139.0 4305.9 4309.2 4315.2 4358.9 4359.0 4387.8 4418.4 4444.6 4555.6 4561.6 4696.9 4719.8 4721.9 4726.1 4772.8 4999.5 5010.6 5013.1 5017.5 5053.2 4613.2 4653.9 4679.5 4743.0 4772.8 4879.2 4901.6 4903.7 4939.3 4939.5 4972.9 4975.2 4978.1 4978.8 4980.2 4774.4 4869.3 4879.3 4893.6 4911.6 4892.8 4915.2 4920.8 4921.6 4970.1 4843.5 4844.0 4850.2 4901.3 4909.8 4833.4 4844.7 4853.0 4858.6 4886.7 4750.9 4752.2 4754.6 4766.9 4811.4 17:17:34 INFO - PROCESS | 21706 | 17:17:34 INFO - PROCESS | 21706 | [#1] ext.html Cycles:180 Average:45361.96 Median:20276.36 stddev:80718.62 (398.1%) stddev-sans-first:80874.91 17:17:34 INFO - PROCESS | 21706 | Values: 545.3 584.3 589.9 593.9 594.4 40011.8 41483.0 41595.4 41643.2 46313.0 42066.0 42594.0 42659.1 42686.6 42692.0 7624.8 7781.5 7785.9 7929.6 8068.3 7613.9 10111.8 10372.3 10404.7 10753.8 10442.8 10490.3 10496.9 10499.3 10504.7 7683.4 10120.9 10296.1 10366.4 10366.5 9789.5 9829.0 9841.7 9843.4 9862.0 39275.4 39610.6 39639.4 39724.2 39761.2 2919.6 3012.7 3046.6 3432.7 3703.5 29892.3 29937.9 30063.4 30540.2 30854.8 3541.6 3558.7 3613.6 3671.1 3689.9 185164.0 185645.0 186744.0 259110.0 259372.0 31251.7 53365.2 54304.0 54312.0 54314.5 30511.7 32420.7 32477.8 32505.8 32508.5 13058.9 13172.7 13176.1 13186.9 13191.4 8367.7 11299.7 11303.2 11451.6 11638.0 7809.6 7820.5 7823.7 7839.6 7877.8 3052.3 3093.6 3100.2 3127.9 3129.2 804.9 875.3 879.2 976.9 980.4 28302.3 28885.1 28901.7 29811.3 29902.9 925.9 938.5 955.2 963.4 993.8 14992.4 15361.5 15453.1 15474.3 15711.5 378844.0 382108.0 382383.0 384397.0 384951.0 49789.8 50331.2 50334.5 50398.7 50486.7 1037.3 1066.3 1135.8 1150.1 1201.6 26734.3 29780.6 30362.2 30533.0 30967.4 42700.4 43258.8 43286.8 43317.0 43332.0 295012.0 295859.0 296026.0 297012.0 298577.0 24576.3 25637.5 25677.0 25738.0 25805.2 42356.6 42718.1 43255.4 43944.3 44090.0 37157.6 38045.0 38065.4 38106.4 38532.2 36881.6 36981.0 37121.1 37175.0 38306.8 36892.4 37354.3 37560.4 37661.6 37667.4 33779.2 34184.8 34222.5 34703.3 35000.0 25578.9 25767.2 26171.3 26186.7 26240.6 17:17:34 INFO - PROCESS | 21706 | 17:17:34 INFO - PROCESS | 21706 | [#2] jquery.html Cycles:180 Average:19641.41 Median:374.92 stddev:42526.58 (11342.8%) stddev-sans-first:42621.20 17:17:34 INFO - PROCESS | 21706 | Values: 347.0 370.7 374.2 375.6 387.5 12847.2 16330.9 16833.2 17489.6 18542.3 15948.7 17755.6 18087.9 18096.6 18104.6 4968.1 5205.4 5298.0 5308.4 5313.5 3696.5 5227.8 5256.4 5812.4 6132.0 6194.0 6223.3 6229.9 6230.3 6242.8 5998.7 6288.2 6292.5 6297.8 6300.0 3382.4 3522.8 3525.9 5491.1 5503.4 18696.0 20015.1 20341.8 21789.7 21851.0 1784.8 1821.4 1984.2 2266.5 2435.0 13309.7 13386.3 13598.3 13813.9 14248.6 1756.7 1816.0 1819.8 1844.1 1892.1 69835.0 70944.0 71212.0 71750.0 72839.6 8972.1 9148.9 9464.2 9617.9 10071.5 12945.1 13217.1 13244.5 13278.9 13313.1 6973.7 7422.8 7459.2 7479.4 7506.2 6902.8 6946.4 7017.4 7026.4 7055.2 5980.2 6087.5 6137.3 6163.3 6219.9 1677.2 1678.7 1703.5 1709.7 1717.2 862.1 865.8 897.9 909.5 931.3 17041.6 17183.4 17638.7 18035.5 18146.4 801.2 809.9 843.5 846.6 903.4 9861.8 10168.3 10194.4 10244.2 10409.4 131901.0 132143.0 134105.0 352683.0 362247.0 68465.0 69850.3 69880.3 70458.6 70565.3 912.9 949.5 957.9 962.4 975.2 11409.9 15069.0 15204.0 16219.5 16543.5 25077.6 31729.0 35249.6 38316.0 39265.0 50964.7 51097.2 51758.0 53554.0 53815.7 7526.9 7559.2 7611.3 7622.8 7627.7 7722.5 11365.8 11530.9 11749.4 11760.2 4618.1 9682.2 9750.6 10499.4 10667.6 10333.8 10417.4 10457.4 10720.5 10868.3 10529.9 10616.5 10695.6 10818.6 10870.1 7823.2 7854.5 7926.0 7939.0 7941.1 10325.5 10701.0 10706.1 10785.7 10882.6 17:17:34 INFO - PROCESS | 21706 | 17:17:34 INFO - PROCESS | 21706 | [#3] mootools.html Cycles:180 Average:5263.57 Median:5281.33 stddev:2975.52 (56.3%) stddev-sans-first:2969.64 17:17:34 INFO - PROCESS | 21706 | Values: 1390.6 1426.8 1521.3 1694.4 1729.9 7705.8 8197.6 8285.5 8292.6 8308.3 6947.7 7160.5 7718.7 7994.6 8130.4 2234.3 2243.5 2258.3 2261.8 2264.0 2185.5 2195.7 2233.1 2233.3 2234.4 1900.1 2167.1 2214.5 2222.8 2248.6 2258.0 2266.3 2279.5 2288.9 2290.2 2233.9 2236.9 2238.2 2240.7 2246.5 8250.1 8307.8 8308.2 8312.7 8319.7 4712.6 4713.9 4745.4 4769.1 4773.4 2754.6 2786.8 2834.4 2837.4 2854.1 940.8 944.6 944.8 946.1 972.9 11103.9 11104.7 11112.6 11129.8 11142.1 4156.1 4279.8 4401.6 4434.3 4464.2 9158.4 9289.0 9324.3 9375.0 9377.2 4873.3 4884.2 4884.4 4884.5 4885.1 4359.8 4397.8 4407.2 4417.0 4441.9 3721.5 3743.3 3810.2 3814.8 3959.7 1078.6 1193.6 1214.3 1218.6 1219.4 679.8 691.6 702.5 709.7 742.9 4960.4 4998.4 5058.4 5081.9 5095.9 823.5 825.1 846.2 848.7 876.0 3622.0 3650.2 3681.3 3697.6 3713.9 9459.7 9876.6 9973.6 9990.7 9998.8 8638.8 9298.8 9930.6 9933.0 9933.5 7474.7 7625.7 7630.7 7636.0 7637.1 5257.7 5304.9 5342.0 5461.9 5467.7 9022.5 9023.2 9129.9 9330.3 9335.0 9263.9 9313.8 9328.7 9329.2 9476.9 6970.2 7018.5 7024.5 7054.0 7078.1 7368.8 7550.4 7578.4 7674.2 7805.6 5478.5 6913.9 7065.0 7232.2 7309.7 6974.9 7073.2 7106.0 7189.6 7258.4 6467.4 6521.7 6554.8 6559.4 6577.2 4337.6 4501.3 4504.9 4524.8 4627.1 4397.2 4451.0 4488.4 4497.3 4503.8 17:17:34 INFO - PROCESS | 21706 | 17:17:34 INFO - PROCESS | 21706 | [#4] prototype.html Cycles:180 Average:4221.92 Median:4866.70 stddev:1208.40 (24.8%) stddev-sans-first:1175.48 17:17:34 INFO - PROCESS | 21706 | Values: 304.7 307.5 311.3 311.9 312.4 4884.3 4907.5 4911.4 4916.5 4919.2 4799.0 4802.4 4848.5 4866.6 4867.7 3620.4 3755.7 3756.3 3809.2 3838.9 3727.6 3772.3 3777.3 3778.4 3806.9 3758.4 3785.7 3786.5 3795.9 3801.5 3622.0 3707.5 3821.8 3828.4 3835.1 3393.7 3393.7 3397.2 3406.2 3417.2 4689.1 4713.7 4748.6 4754.6 4769.3 4224.3 4328.3 4331.0 4341.5 4360.4 4978.3 4988.1 4989.6 5001.9 5028.8 3698.3 3721.5 3724.3 3728.5 3734.3 5137.9 5269.5 5293.6 5332.8 5334.9 3788.2 3797.6 3800.8 3807.3 3813.4 3871.6 3877.9 3895.8 3901.1 3901.3 4344.2 4351.9 4364.0 4389.5 4394.8 4883.3 5025.7 5033.8 5043.1 5105.8 1317.9 1330.7 1336.0 1344.6 1345.9 847.5 874.4 876.1 890.7 891.8 4275.3 4411.0 4417.7 4420.5 4427.4 5139.4 5143.3 5170.1 5177.6 5189.5 4374.4 4375.3 4377.1 4393.6 4396.9 2569.9 2729.8 2741.7 2758.1 2762.4 4891.1 4909.9 4919.6 4920.1 4933.3 5043.0 5307.5 5317.1 5325.3 5330.0 4911.4 4921.2 4939.5 4944.0 4959.0 5220.6 5225.2 5228.8 5239.4 5266.7 4950.6 5105.4 5110.5 5118.7 5121.4 4866.8 4872.6 4918.4 4948.2 4969.8 3805.8 3805.9 3825.7 3840.9 3847.9 4966.6 5139.9 5218.3 5224.5 5232.7 5032.0 5056.5 5057.0 5061.0 5110.7 5064.9 5068.0 5069.4 5091.6 5092.4 4796.9 4989.6 5015.0 5019.0 5056.5 4857.8 4932.2 5099.7 5108.2 5112.6 4965.7 5002.2 5004.1 5014.7 5039.8 17:17:34 INFO - PROCESS | 21706 | 17:17:34 INFO - PROCESS | 21706 | [#5] yui.html Cycles:180 Average:16414.49 Median:25645.34 stddev:22509.07 (87.8%) stddev-sans-first:22540.79 17:17:34 INFO - PROCESS | 21706 | Values: 574.9 576.4 642.6 650.1 726.6 12391.9 13247.5 13258.7 13300.3 13368.8 11596.4 11716.9 11726.6 11730.9 11752.5 605.2 742.9 747.5 759.0 767.9 773.7 774.3 778.2 778.7 779.4 831.7 831.8 832.5 832.6 834.4 636.5 794.5 817.4 818.0 830.2 584.1 596.5 600.6 602.5 602.9 12786.0 12789.6 12813.7 12818.4 12836.6 12639.2 13068.3 13110.3 13242.4 13357.0 9317.4 11235.4 11541.7 12091.5 12148.3 4187.1 4192.6 4289.2 4401.2 4424.0 52232.7 53144.0 58947.4 64409.7 64915.7 9963.2 9977.6 9992.5 10185.0 10293.6 16910.0 17052.3 17056.1 17094.7 17957.3 7120.0 7381.0 7395.9 7424.4 7589.8 3657.1 3725.3 3816.5 3837.0 3866.3 3044.8 3132.9 3150.4 3151.7 3153.0 505.1 518.2 539.4 541.9 550.1 495.9 562.1 563.5 573.2 581.8 7703.6 7709.7 7810.5 7881.9 8045.0 458.1 473.1 553.3 581.7 606.9 3556.7 3773.4 3832.7 3866.1 3888.5 88412.6 90371.5 90691.5 93206.5 94326.5 50772.5 53569.5 74695.6 76356.2 76654.2 43733.0 45715.0 57720.4 68900.0 70401.3 7398.6 7464.3 7487.7 7518.4 7562.0 40525.2 41673.0 42054.8 42568.8 42766.1 61661.0 63035.0 63483.7 63592.0 63626.0 10322.6 10520.3 10561.9 10722.4 10727.3 12966.8 13029.6 13189.1 13220.4 13298.7 11574.2 11915.4 12028.2 12052.6 12247.7 12023.6 12187.6 12478.1 12626.0 13272.9 10552.6 10671.9 11593.7 11668.1 12312.1 9611.2 9816.3 10013.8 10280.8 10379.4 9406.8 9606.6 9620.0 9645.2 9665.6 17:17:34 INFO - PROCESS | 21706 | -------- Summary: end -------- 17:17:34 INFO - PROCESS | 21706 | 17:17:35 INFO - TEST-INFO | 21706: exit 0 17:17:35 INFO - TEST-OK | dromaeo_css | took 1119165ms 17:17:35 INFO - TEST-START | kraken 17:17:35 INFO - operating with platform_type : linux_ 17:17:35 INFO - Initialising browser for kraken test... 17:17:35 INFO - TEST-INFO | started process 21896 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwasT4K/profile http://localhost:33624/getInfo.html) 17:17:39 INFO - PROCESS | 21896 | __metrics Screen width/height:1600/1200 17:17:39 INFO - PROCESS | 21896 | colorDepth:24 17:17:39 INFO - PROCESS | 21896 | Browser inner width/height: 1024/697 17:17:39 INFO - PROCESS | 21896 | __metrics 17:17:40 INFO - PROCESS | 21896 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:17:41 INFO - TEST-INFO | 21896: exit 0 17:17:41 INFO - Browser initialized. 17:17:41 INFO - Running cycle 1/1 for kraken test... 17:17:41 INFO - TEST-INFO | started process 21977 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwasT4K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:17:53 INFO - PROCESS | 21977 | RSS: Main: 159125504 17:17:53 INFO - PROCESS | 21977 | 17:17:55 INFO - PROCESS | 21977 | Cycle 1(1): loaded http://localhost:33624/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33624/tests/kraken/driver.html?testName=audio-beat-detection) 17:17:56 INFO - PROCESS | 21977 | RSS: Main: 216784896 17:17:56 INFO - PROCESS | 21977 | 17:17:59 INFO - PROCESS | 21977 | Cycle 1(1): loaded http://localhost:33624/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33624/tests/kraken/driver.html?testName=audio-dft) 17:18:00 INFO - PROCESS | 21977 | RSS: Main: 203685888 17:18:00 INFO - PROCESS | 21977 | 17:18:03 INFO - PROCESS | 21977 | Cycle 1(1): loaded http://localhost:33624/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33624/tests/kraken/driver.html?testName=audio-fft) 17:18:04 INFO - PROCESS | 21977 | RSS: Main: 271425536 17:18:04 INFO - PROCESS | 21977 | 17:18:06 INFO - PROCESS | 21977 | Cycle 1(1): loaded http://localhost:33624/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33624/tests/kraken/driver.html?testName=audio-oscillator) 17:18:06 INFO - PROCESS | 21977 | RSS: Main: 181915648 17:18:06 INFO - PROCESS | 21977 | 17:18:09 INFO - PROCESS | 21977 | Cycle 1(1): loaded http://localhost:33624/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33624/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:18:09 INFO - PROCESS | 21977 | RSS: Main: 186232832 17:18:09 INFO - PROCESS | 21977 | 17:18:12 INFO - PROCESS | 21977 | Cycle 1(1): loaded http://localhost:33624/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33624/tests/kraken/driver.html?testName=imaging-darkroom) 17:18:13 INFO - PROCESS | 21977 | RSS: Main: 222441472 17:18:13 INFO - PROCESS | 21977 | 17:18:16 INFO - PROCESS | 21977 | Cycle 1(1): loaded http://localhost:33624/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33624/tests/kraken/driver.html?testName=imaging-desaturate) 17:18:17 INFO - PROCESS | 21977 | RSS: Main: 223006720 17:18:17 INFO - PROCESS | 21977 | 17:18:20 INFO - PROCESS | 21977 | Cycle 1(1): loaded http://localhost:33624/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33624/tests/kraken/driver.html?testName=json-parse-financial) 17:18:20 INFO - PROCESS | 21977 | RSS: Main: 222179328 17:18:20 INFO - PROCESS | 21977 | 17:18:22 INFO - PROCESS | 21977 | Cycle 1(1): loaded http://localhost:33624/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33624/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:18:23 INFO - PROCESS | 21977 | RSS: Main: 208990208 17:18:23 INFO - PROCESS | 21977 | 17:18:25 INFO - PROCESS | 21977 | Cycle 1(1): loaded http://localhost:33624/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33624/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:18:25 INFO - PROCESS | 21977 | RSS: Main: 213381120 17:18:25 INFO - PROCESS | 21977 | 17:18:27 INFO - PROCESS | 21977 | Cycle 1(1): loaded http://localhost:33624/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33624/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:18:28 INFO - PROCESS | 21977 | RSS: Main: 210632704 17:18:28 INFO - PROCESS | 21977 | 17:18:31 INFO - PROCESS | 21977 | Cycle 1(1): loaded http://localhost:33624/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33624/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:18:32 INFO - PROCESS | 21977 | RSS: Main: 223821824 17:18:32 INFO - PROCESS | 21977 | 17:18:34 INFO - PROCESS | 21977 | Cycle 1(1): loaded http://localhost:33624/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33624/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:18:35 INFO - PROCESS | 21977 | RSS: Main: 225157120 17:18:35 INFO - PROCESS | 21977 | 17:18:37 INFO - PROCESS | 21977 | Cycle 1(1): loaded http://localhost:33624/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33624/tests/kraken/driver.html?testName=ai-astar) 17:18:37 INFO - PROCESS | 21977 | RSS: Main: 266993664 17:18:37 INFO - PROCESS | 21977 | 17:18:37 INFO - PROCESS | 21977 | __start_tp_report 17:18:37 INFO - PROCESS | 21977 | _x_x_mozilla_page_load 17:18:37 INFO - PROCESS | 21977 | _x_x_mozilla_page_load_details 17:18:37 INFO - PROCESS | 21977 | |i|pagename|runs| 17:18:37 INFO - PROCESS | 21977 | |0;ai-astar;106;113;113;112;114;113;112;111;113;112 17:18:37 INFO - PROCESS | 21977 | |1;audio-beat-detection;157;126;125;181;123;122;146;121;155;123 17:18:37 INFO - PROCESS | 21977 | |2;audio-dft;161;162;160;161;167;163;162;164;162;160 17:18:37 INFO - PROCESS | 21977 | |3;audio-fft;76;76;76;115;76;76;75;75;112;76 17:18:37 INFO - PROCESS | 21977 | |4;audio-oscillator;85;86;123;85;86;85;121;84;85;135 17:18:37 INFO - PROCESS | 21977 | |5;imaging-gaussian-blur;116;116;118;118;116;117;116;117;117;119 17:18:37 INFO - PROCESS | 21977 | |6;imaging-darkroom;146;146;146;146;146;146;146;146;146;146 17:18:37 INFO - PROCESS | 21977 | |7;imaging-desaturate;95;96;94;95;96;97;95;95;95;95 17:18:37 INFO - PROCESS | 21977 | |8;json-parse-financial;64;65;64;64;70;63;66;64;64;63 17:18:37 INFO - PROCESS | 21977 | |9;json-stringify-tinderbox;64;65;64;64;65;64;65;76;64;64 17:18:37 INFO - PROCESS | 21977 | |10;stanford-crypto-aes;80;80;79;79;79;78;77;78;79;83 17:18:37 INFO - PROCESS | 21977 | |11;stanford-crypto-ccm;130;137;130;134;131;145;130;146;172;141 17:18:37 INFO - PROCESS | 21977 | |12;stanford-crypto-pbkdf2;169;169;167;174;164;168;165;167;171;166 17:18:37 INFO - PROCESS | 21977 | |13;stanford-crypto-sha256-iterative;66;72;68;68;68;67;66;69;66;66 17:18:37 INFO - PROCESS | 21977 | __end_tp_report 17:18:37 INFO - PROCESS | 21977 | __start_cc_report 17:18:37 INFO - PROCESS | 21977 | _x_x_mozilla_cycle_collect,1907 17:18:37 INFO - PROCESS | 21977 | __end_cc_report 17:18:37 INFO - PROCESS | 21977 | __startTimestamp1467764317457__endTimestamp 17:18:37 INFO - PROCESS | 21977 | 17:18:37 INFO - PROCESS | 21977 | ------- Summary: start ------- 17:18:37 INFO - PROCESS | 21977 | Number of tests: 14 17:18:37 INFO - PROCESS | 21977 | 17:18:37 INFO - PROCESS | 21977 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:2.23 (2.0%) stddev-sans-first:0.88 17:18:37 INFO - PROCESS | 21977 | Values: 106.0 113.0 113.0 112.0 114.0 113.0 112.0 111.0 113.0 112.0 17:18:37 INFO - PROCESS | 21977 | 17:18:37 INFO - PROCESS | 21977 | [#1] audio-beat-detection Cycles:10 Average:137.90 Median:136.00 stddev:20.74 (15.2%) stddev-sans-first:20.81 17:18:37 INFO - PROCESS | 21977 | Values: 157.0 126.0 125.0 181.0 123.0 122.0 146.0 121.0 155.0 123.0 17:18:37 INFO - PROCESS | 21977 | 17:18:37 INFO - PROCESS | 21977 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:2.10 (1.3%) stddev-sans-first:2.18 17:18:37 INFO - PROCESS | 21977 | Values: 161.0 162.0 160.0 161.0 167.0 163.0 162.0 164.0 162.0 160.0 17:18:37 INFO - PROCESS | 21977 | 17:18:37 INFO - PROCESS | 21977 | [#3] audio-fft Cycles:10 Average:83.30 Median:76.00 stddev:15.94 (21.0%) stddev-sans-first:16.68 17:18:37 INFO - PROCESS | 21977 | Values: 76.0 76.0 76.0 115.0 76.0 76.0 75.0 75.0 112.0 76.0 17:18:37 INFO - PROCESS | 21977 | 17:18:37 INFO - PROCESS | 21977 | [#4] audio-oscillator Cycles:10 Average:97.50 Median:85.00 stddev:20.22 (23.8%) stddev-sans-first:20.94 17:18:37 INFO - PROCESS | 21977 | Values: 85.0 86.0 123.0 85.0 86.0 85.0 121.0 84.0 85.0 135.0 17:18:37 INFO - PROCESS | 21977 | 17:18:37 INFO - PROCESS | 21977 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:1.05 (0.9%) stddev-sans-first:1.05 17:18:37 INFO - PROCESS | 21977 | Values: 116.0 116.0 118.0 118.0 116.0 117.0 116.0 117.0 117.0 119.0 17:18:37 INFO - PROCESS | 21977 | 17:18:37 INFO - PROCESS | 21977 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 17:18:37 INFO - PROCESS | 21977 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 17:18:37 INFO - PROCESS | 21977 | 17:18:37 INFO - PROCESS | 21977 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 17:18:37 INFO - PROCESS | 21977 | Values: 95.0 96.0 94.0 95.0 96.0 97.0 95.0 95.0 95.0 95.0 17:18:37 INFO - PROCESS | 21977 | 17:18:37 INFO - PROCESS | 21977 | [#8] json-parse-financial Cycles:10 Average:64.70 Median:64.00 stddev:2.06 (3.2%) stddev-sans-first:2.17 17:18:37 INFO - PROCESS | 21977 | Values: 64.0 65.0 64.0 64.0 70.0 63.0 66.0 64.0 64.0 63.0 17:18:37 INFO - PROCESS | 21977 | 17:18:37 INFO - PROCESS | 21977 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:64.50 stddev:3.72 (5.8%) stddev-sans-first:3.91 17:18:37 INFO - PROCESS | 21977 | Values: 64.0 65.0 64.0 64.0 65.0 64.0 65.0 76.0 64.0 64.0 17:18:37 INFO - PROCESS | 21977 | 17:18:37 INFO - PROCESS | 21977 | [#10] stanford-crypto-aes Cycles:10 Average:79.20 Median:79.00 stddev:1.62 (2.0%) stddev-sans-first:1.69 17:18:37 INFO - PROCESS | 21977 | Values: 80.0 80.0 79.0 79.0 79.0 78.0 77.0 78.0 79.0 83.0 17:18:37 INFO - PROCESS | 21977 | 17:18:37 INFO - PROCESS | 21977 | [#11] stanford-crypto-ccm Cycles:10 Average:139.60 Median:139.00 stddev:12.95 (9.3%) stddev-sans-first:13.27 17:18:37 INFO - PROCESS | 21977 | Values: 130.0 137.0 130.0 134.0 131.0 145.0 130.0 146.0 172.0 141.0 17:18:37 INFO - PROCESS | 21977 | 17:18:37 INFO - PROCESS | 21977 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.00 Median:168.50 stddev:2.94 (1.7%) stddev-sans-first:3.10 17:18:37 INFO - PROCESS | 21977 | Values: 169.0 169.0 167.0 174.0 164.0 168.0 165.0 167.0 171.0 166.0 17:18:37 INFO - PROCESS | 21977 | 17:18:37 INFO - PROCESS | 21977 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:1.90 (2.8%) stddev-sans-first:1.92 17:18:37 INFO - PROCESS | 21977 | Values: 66.0 72.0 68.0 68.0 68.0 67.0 66.0 69.0 66.0 66.0 17:18:37 INFO - PROCESS | 21977 | -------- Summary: end -------- 17:18:37 INFO - PROCESS | 21977 | 17:18:38 INFO - TEST-INFO | 21977: exit 0 17:18:38 INFO - TEST-OK | kraken | took 63397ms 17:18:38 INFO - SUITE-END | took 1182s 17:18:38 INFO - Completed test suite (00:19:42) 17:18:38 INFO - javascript benchmark 17:18:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2618.685757709075, 2620.2532278300687, 2636.6308716779654, 2649.1390298153106, 2660.6142109394136, 4553.521880202572, 4577.336286238494, 4616.422947131608, 4679.485256621769, 4706.811727530895, 4653.511381304957, 4675.4856965733825, 4687.296905464182, 4735.0, 4737.265723812815, 4099.71302008858, 4247.787610619456, 4330.155619654169, 4364.650827933773, 4477.3731677565165, 4383.101464199847, 4420.07178492517, 4436.711613745097, 4444.666650001247, 4470.418845550074, 4246.0, 4251.171021650779, 4251.893702657459, 4280.443542339507, 4304.956950430487, 4256.914861702749, 4263.381809637585, 4306.504751953534, 4317.395564620955, 4317.417148684919, 4293.29160688486, 4295.570442955711, 4304.461942257218, 4328.913421731548, 4348.608625223714, 4585.380973568593, 4600.677952543323, 4631.073785242931, 4638.930416043762, 4696.459907110692, 4974.204127339644, 4984.950150498521, 4986.177280748672, 5002.424721157041, 5005.74971251436, 4972.279019542182, 4976.676516026447, 5036.647434679574, 5038.143515602356, 5046.596272298208, 4612.031473390559, 4645.001324715135, 4648.558386953234, 4660.673752837269, 4701.106789709944, 5122.974385128051, 5164.948350516447, 5165.251038599382, 5168.147255702767, 5174.456682048406, 4774.40319960005, 4829.517048295143, 4937.185364414903, 4985.451600323961, 5034.0686972910125, 4955.430125535538, 4961.131801934647, 4978.726170060609, 4988.027334669777, 5040.722760248222, 4929.211326187793, 4933.0, 4933.481984391659, 4942.851714448572, 4973.955469351405, 4783.330333753208, 4834.395700537433, 4886.169351210303, 4915.827946021872, 4976.129177393942, 4202.495700515958, 4203.159368126387, 4231.915361692749, 4262.936055959163, 4263.16868210696, 3695.815209239527, 3704.5369328833895, 3714.1643130296006, 3729.9254014919547, 3737.439384092408, 4141.91716165681, 4271.167122411162, 4271.957280427218, 4313.956860431418, 4318.00685842258, 5059.0, 5070.949290507047, 5079.923801142986, 5089.745512724349, 5139.049275883974, 4305.870823875289, 4309.202797482476, 4315.201687687788, 4358.869233922987, 4359.0, 4387.846425375096, 4418.381426600278, 4444.644428445717, 4555.589996900295, 4561.5666511682, 4696.882577935579, 4719.764011799465, 4721.929171062368, 4726.1492931272705, 4772.785224664968, 4999.475055119306, 5010.624203184703, 5013.097642424399, 5017.523335283142, 5053.2420136979745, 4613.215753321876, 4653.883652908705, 4679.532046795293, 4743.027679325661, 4772.832950846704, 4879.219324907997, 4901.6323775716255, 4903.730294833818, 4939.308496810521, 4939.456659767495, 4972.900541989212, 4975.154223781893, 4978.103941290602, 4978.751062446936, 4980.228064649985, 4774.379330687128, 4869.31829543857, 4879.316895634543, 4893.6085113191575, 4911.582515486224, 4892.828750993698, 4915.18899381598, 4920.778564964657, 4921.550955778745, 4970.105381031449, 4843.467218606021, 4843.95156048435, 4850.223964165716, 4901.313816065683, 4909.77905994224, 4833.3958255218095, 4844.733539655353, 4852.95147048525, 4858.562729354234, 4886.706797592155, 4750.904981900412, 4752.19212733843, 4754.572088512051, 4766.856994290177, 4811.350467686818], "value": 4589.55219864832, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.2623379513715, 584.3251045042975, 589.861382575095, 593.9020061689824, 594.3907494817811, 40011.79994100029, 41483.0, 41595.42450330461, 41643.167136657285, 46313.0, 42066.0, 42594.0, 42659.146817063716, 42686.57313426865, 42692.0, 7624.771256862303, 7781.455298129134, 7785.883211751829, 7929.563873986914, 8068.273855353017, 7613.885791713129, 10111.797764044715, 10372.273940824145, 10404.739881502946, 10753.78492430151, 10442.791144177112, 10490.265681402305, 10496.895031049668, 10499.265051446364, 10504.68485945419, 7683.423743219281, 10120.898791012069, 10296.073353398193, 10366.378017318948, 10366.481675916173, 9789.510524473819, 9829.0, 9841.655542056065, 9843.360181588174, 9861.950690246575, 39275.41086883699, 39610.60389396098, 39639.40540891889, 39724.205515889524, 39761.20477590432, 2919.6350456192977, 3012.7137921897383, 3046.5737169979366, 3432.7253819694365, 3703.518542589446, 29892.252693682614, 29937.85031074831, 30063.398732025238, 30540.236494087603, 30854.84572577145, 3541.610422853484, 3558.679718825318, 3613.6386361363916, 3671.0822294426393, 3689.9262014759556, 185164.0, 185645.0, 186744.0, 259110.0, 259372.0, 31251.68748312488, 53365.1995220072, 54304.0, 54312.0, 54314.45685543173, 30511.69488305133, 32420.675793242237, 32477.837610811795, 32505.837470812494, 32508.512372314435, 13058.869411305956, 13172.736545269041, 13176.077674562688, 13186.868131318755, 13191.40638671262, 8367.665293388196, 11299.661010169708, 11303.208775385645, 11451.59919402817, 11638.0, 7809.570473623891, 7820.491668041559, 7823.726169584037, 7839.568823714751, 7877.7636670899965, 3052.282713562311, 3093.58236638051, 3100.209446591105, 3127.8748850045745, 3129.2333378322455, 804.8591496488091, 875.2560323724783, 879.2394578689515, 976.9071938165863, 980.4068538534227, 28302.292442689097, 28885.133445996653, 28901.7109828899, 29811.254718632208, 29902.850485747433, 925.8518637018045, 938.5260443476137, 955.1690029674228, 963.4460185393427, 993.8012397520525, 14992.400303987719, 15361.539153825179, 15453.079266471439, 15474.303656335493, 15711.450099246471, 378844.0, 382108.0, 382383.0, 384397.0, 384951.0, 49789.751051244515, 50331.24503132456, 50334.49665503371, 50398.748006260466, 50486.74756626267, 1037.258360272409, 1066.2642776484047, 1135.778523187987, 1150.097173718627, 1201.585453018707, 26734.331641709112, 29780.55329170021, 30362.240943975692, 30533.0, 30967.380652387277, 42700.35949460823, 43258.78370608127, 43286.78356608197, 43317.0, 43332.0, 295012.0, 295859.0, 296026.0, 297012.0, 298577.0, 24576.262712118663, 25637.48725025452, 25677.0, 25738.0, 25805.225843224733, 42356.57643423526, 42718.145637087706, 43255.351169733105, 43944.34083488686, 44090.0, 37157.62842371542, 38045.0, 38065.42901856419, 38106.428403573416, 38532.22935541217, 36881.63118368782, 36981.0, 37121.0719731998, 37175.0, 38306.80846595749, 36892.446613301356, 37354.252914942095, 37560.43659345167, 37661.623383766906, 37667.43498847465, 33779.15552111217, 34184.82907585446, 34222.486662700576, 34703.30593388169, 35000.0, 25578.87210563935, 25767.226983190536, 26171.345716357242, 26186.738132619193, 26240.60639090377], "value": 17055.861790149673, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.9531613232213, 370.6830659785883, 374.2477619983832, 375.5981100222761, 387.4807757604809, 12847.22916625002, 16330.91834540827, 16833.24250408733, 17489.56276093098, 18542.258309667595, 15948.681026379465, 17755.644887102284, 18087.90956045221, 18096.63806723868, 18104.637907241846, 4968.105740966625, 5205.375354957391, 5297.973510132444, 5308.362996440433, 5313.548348390372, 3696.519452471175, 5227.79088836446, 5256.3955145158225, 5812.389699081577, 6131.969340153315, 6193.969030154843, 6223.346548612399, 6229.875402491947, 6230.345813689565, 6242.7502899884175, 5998.700064996755, 6288.182536270278, 6292.528060395489, 6297.779577714758, 6300.0, 3382.441897086978, 3522.7710198836994, 3525.8589656413715, 5491.066518691792, 5503.367112782042, 18696.0, 20015.09932053061, 20341.796582034287, 21789.67315490253, 21851.0, 1784.7590575272302, 1821.3716267887557, 1984.2162345873444, 2266.5317777921787, 2435.0138194031447, 13309.667258318523, 13386.330683465787, 13598.320083995859, 13813.930930345285, 14248.572542823731, 1756.6750151222066, 1815.972760408595, 1819.790724066736, 1844.087176847469, 1892.1201641236892, 69835.0, 70944.0, 71212.0, 71750.0, 72839.63580182118, 8972.147645973622, 9148.908510914805, 9464.19554337889, 9617.903820961841, 10071.5467803949, 12945.09384343087, 13217.14088584239, 13244.53644122451, 13278.933605331911, 13313.068085233941, 6973.651317434108, 7422.777316680508, 7459.216782237895, 7479.401647868158, 7506.24937506245, 6902.827429314207, 6946.409555187764, 7017.4035207006955, 7026.367626913602, 7055.2239253682055, 5980.192673989043, 6087.482563982023, 6137.294211165773, 6163.335899307252, 6219.875602487925, 1677.1698009485383, 1678.7230107032447, 1703.49746824687, 1709.726443768991, 1717.2015013019006, 862.1464749897556, 865.8354912566718, 897.9281657467387, 909.5497728624373, 931.334096121263, 17041.573960651083, 17183.442569840707, 17638.735418968725, 18035.54911127206, 18146.364877229233, 801.1547817053065, 809.9109097999216, 843.5107637570195, 846.6063280574563, 903.4263242840843, 9861.753456163653, 10168.33905796121, 10194.388336699822, 10244.231682623833, 10409.42748148844, 131901.0, 132143.0, 134105.0, 352683.0, 362247.0, 68465.0, 69850.30149698438, 69880.3011969884, 70458.64770676114, 70565.2943470569, 912.8721978922956, 949.4730424614405, 957.9233661307079, 962.4465932089076, 975.1516180922642, 11409.885901140882, 15069.0, 15204.0, 16219.51341459758, 16543.503694889172, 25077.623835642116, 31729.0, 35249.64750352566, 38316.0, 39265.0, 50964.72588185325, 51097.23354149616, 51758.0, 53554.0, 53815.730921345144, 7526.887096693445, 7559.20628334017, 7611.314981651456, 7622.8094297643, 7627.656755446129, 7722.498037627536, 11365.829512557484, 11530.884691152982, 11749.412529373327, 11760.235584686969, 4618.145643056046, 9682.225421966366, 9750.609975600897, 10499.370037797757, 10667.626633067805, 10333.793324133625, 10417.374957502574, 10457.372557646566, 10720.463976801284, 10868.347899126078, 10529.894701052892, 10616.469176541297, 10695.625653102416, 10818.56725730962, 10870.076043536072, 7823.178566250462, 7854.45018848698, 7925.960370198112, 7939.0, 7941.086775020946, 10325.483725813829, 10701.0, 10706.089982351587, 10785.730356741144, 10882.61910833117], "value": 8233.469275258085, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1390.5689236336736, 1426.7645838436656, 1521.277393238212, 1694.3730819596751, 1729.9394521191762, 7705.845883082342, 8197.631106600202, 8285.46144500607, 8292.626831792568, 8308.293795027415, 6947.7220911163495, 7160.534565253255, 7718.691252349913, 7994.640241189146, 8130.3902207334395, 2234.318532847485, 2243.540074284768, 2258.3112150794, 2261.762514935933, 2263.9886800565973, 2185.530111026129, 2195.6706494025866, 2233.095596283508, 2233.2853486884205, 2234.3967128875192, 1900.1164458526782, 2167.143978128638, 2214.4795972946345, 2222.799948004679, 2248.5615305015526, 2258.0, 2266.274792066531, 2279.5099053703534, 2288.9084436622597, 2290.198430549311, 2233.8547994380315, 2236.8546044507216, 2238.2054370698493, 2240.6975058367075, 2246.472079061419, 8250.092489826115, 8307.750767476986, 8308.210719981593, 8312.667493300261, 8319.66721331146, 4712.599429048535, 4713.905721885578, 4745.359376484165, 4769.070031343889, 4773.427188737339, 2754.628125203112, 2786.8327900325844, 2834.4331133773326, 2837.4183292425005, 2854.100958198161, 940.8071345374182, 944.6363150187159, 944.8488241881266, 946.0964778636454, 972.9173020293283, 11103.888961110366, 11104.722381940435, 11112.611058612909, 11129.833052504218, 11142.108631309477, 4156.106437115974, 4279.828806847753, 4401.603855653007, 4434.312681534368, 4464.2187617166865, 9158.358914875895, 9289.024652411399, 9324.25405967521, 9374.953125234466, 9377.202937750231, 4873.31773551703, 4884.194107972145, 4884.413870335511, 4884.535969082932, 4885.071836351082, 4359.760213188305, 4397.8240870364825, 4407.206702793464, 4416.9779151104685, 4441.866743997685, 3721.5348081489815, 3743.288775132716, 3810.1998580297895, 3814.8283327249787, 3959.6634286086005, 1078.6440474643348, 1193.5524178433088, 1214.3199808107488, 1218.622227109599, 1219.4146809531296, 679.8470344172522, 691.6126968897433, 702.5047341624143, 709.6593635055099, 742.9108506979089, 4960.379952505937, 4998.4251811042195, 5058.367704036996, 5081.898362032813, 5095.87260318495, 823.4853216739538, 825.1171246765903, 846.1538461538462, 848.6562942008496, 875.9737207883774, 3621.9637803622154, 3650.2152037312107, 3681.3189559931498, 3697.574778900461, 3713.9442908356395, 9459.668911588062, 9876.555555000043, 9973.551190196458, 9990.700278991642, 9998.750031249132, 8638.78403039929, 9298.814023719488, 9930.602775889029, 9932.950335248423, 9933.50332483373, 7474.70101195957, 7625.6568454418575, 7630.694772209161, 7636.0, 7637.121731001006, 5257.710825904459, 5304.946950530445, 5342.0, 5461.918071228855, 5467.7266136692215, 9022.503762293138, 9023.187913087853, 9129.90870091317, 9330.253579713743, 9334.953325233602, 9263.86104208424, 9313.813723725623, 9328.720138395858, 9329.16037556623, 9476.857847132436, 6970.23327433992, 7018.508704390643, 7024.5434046786795, 7054.0, 7078.079849619517, 7368.815779605553, 7550.433717471102, 7578.431617628589, 7674.232576742281, 7805.5706936116785, 5478.534324582455, 6913.930860691329, 7065.0, 7232.204457509775, 7309.671064802203, 6974.895376569457, 7073.151221853411, 7106.040684507525, 7189.604571748604, 7258.383037441877, 6467.417932386108, 6521.739130434729, 6554.8361290966195, 6559.409653131241, 6577.210734711865, 4337.587435265418, 4501.324801279834, 4504.887377815581, 4524.751138687404, 4627.07458508293, 4397.230484665107, 4450.977745111254, 4488.438945131858, 4497.302918047708, 4503.774811259489], "value": 4210.1552851681, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.7029146582083, 307.5417627734676, 311.26075570520015, 311.8955150024742, 312.42825629098735, 4884.291777692237, 4907.533784290486, 4911.386076740408, 4916.483769204236, 4919.188333924907, 4799.0, 4802.423709154898, 4848.545436369092, 4866.562009419152, 4867.732274724889, 3620.4388319810405, 3755.6619904208615, 3756.267527832074, 3809.2191100824402, 3838.923221535568, 3727.5526936767624, 3772.264408440355, 3777.300214903291, 3778.433235014756, 3806.90482737931, 3758.379867321902, 3785.734998550103, 3786.5456145262606, 3795.8861234162882, 3801.5438147422346, 3622.0, 3707.536557930245, 3821.789801560913, 3828.3683192273243, 3835.1179228777537, 3393.6606339365867, 3393.711534519569, 3397.184675677844, 3406.1654894550993, 3417.214040770612, 4689.132510485537, 4713.670043096985, 4748.596369308613, 4754.595859351959, 4769.260764581495, 4224.260754367973, 4328.329108988112, 4331.04716962271, 4341.522432532419, 4360.389545463606, 4978.253262010691, 4988.102141614508, 4989.57588604969, 5001.899962000776, 5028.84913452597, 3698.33429982603, 3721.5299956517024, 3724.2737666155112, 3728.478013078144, 3734.3278209922205, 5137.871553211162, 5269.473052694738, 5293.550048245904, 5332.760025798849, 5334.866628334323, 3788.1666033472593, 3797.6012518685693, 3800.7909564974193, 3807.3337165996395, 3813.4279858020964, 3871.593482684334, 3877.8836634901, 3895.8441662333757, 3901.063744701308, 3901.31726947783, 4344.239758042393, 4351.912961740747, 4363.95265136365, 4389.495208051115, 4394.846180383671, 4883.34074899891, 5025.673331233458, 5033.7734801934, 5043.142665746758, 5105.795768169231, 1317.8616245294297, 1330.7072444062292, 1335.953241636538, 1344.5899000804652, 1345.9327033648278, 847.4788005376772, 874.4185116897319, 876.088867577712, 890.6570970176529, 891.7503099132254, 4275.251830929575, 4410.977945110254, 4417.690761646654, 4420.513743488214, 4427.358033085249, 5139.408967968657, 5143.254228136899, 5170.121079416508, 5177.611679124081, 5189.455107213764, 4374.4094547236355, 4375.256206444912, 4377.124575084996, 4393.648508119343, 4396.912061758747, 2569.8586577738406, 2729.849858257815, 2741.684706258766, 2758.1311886755607, 2762.4337010912714, 4891.070696567712, 4909.877253068702, 4919.573323736148, 4920.138975679241, 4933.260010998307, 5043.0, 5307.495787900143, 5317.096093664087, 5325.254464374991, 5329.973350133302, 4911.4106307243355, 4921.163402221702, 4939.493454496342, 4943.950560494349, 4958.975205124024, 5220.634555581225, 5225.216217567396, 5228.843134705813, 5239.397469290928, 5266.683998959921, 4950.6039516837845, 5105.387353517453, 5110.514501122388, 5118.692878427306, 5121.411037730709, 4866.829660961991, 4872.585830204331, 4918.409790825124, 4948.183549714401, 4969.801207951641, 3805.8477660894364, 3805.904852378713, 3825.732198746061, 3840.8655697050467, 3847.8845634631007, 4966.577840883421, 5139.948600514096, 5218.295530103539, 5224.50367215114, 5232.686038837682, 5032.018756342478, 5056.544910958031, 5057.0, 5060.987802439453, 5110.693358398508, 5064.898702026013, 5068.0, 5069.442361340323, 5091.618128640441, 5092.363454568179, 4796.904061918812, 4989.600831933364, 5015.0, 5019.0, 5056.494350564914, 4857.8299759508245, 4932.235503496964, 5099.719515426687, 5108.233764935289, 5112.642115052059, 4965.702057876539, 5002.174641184164, 5004.124278251365, 5014.6991180529285, 5039.823606173766], "value": 3841.187845640069, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.9252597162368, 576.3919065386017, 642.6433329502125, 650.137356473703, 726.5749536521134, 12391.876081239185, 13247.536336228233, 13258.668533286673, 13300.268485233308, 13368.799468007976, 11596.420178991038, 11716.882831171686, 11726.589569365075, 11730.941345293262, 11752.471138798754, 605.2041565341584, 742.9219931907153, 747.5066456138936, 758.981025474362, 767.946243762934, 773.6711897443593, 774.3185996323227, 778.155701064343, 778.6690656471005, 779.4310153587884, 831.71721614651, 831.8336332733447, 832.488019867783, 832.6128350317101, 834.4284165346727, 636.5448704176536, 794.5351969098084, 817.3542901108117, 818.0142927772021, 830.2195935820309, 584.0567483514094, 596.4989408896548, 600.5795942839986, 602.4999250621973, 602.8854517641633, 12786.0, 12789.61631151067, 12813.743725125538, 12818.423170957329, 12836.614901552968, 12639.1784534005, 13068.281244531547, 13110.344482775918, 13242.404091815892, 13357.0, 9317.39436936597, 11235.438228088562, 11541.653750387502, 12091.516339346415, 12148.3318417487, 4187.099773548671, 4192.559781222989, 4289.227938970984, 4401.22978478765, 4423.977880110579, 52232.73883630596, 53144.0, 58947.41052589462, 64409.67795161041, 64915.67542162306, 9963.202943764481, 9977.551010204557, 9992.459463373565, 10185.0, 10293.639722609672, 16910.0, 17052.317907283817, 17056.147192640317, 17094.658106837793, 17957.281708731767, 7120.0, 7381.0, 7395.852082958419, 7424.406047516186, 7589.810254743676, 3657.122290650225, 3725.3294407006997, 3816.5038544988975, 3836.9808150959066, 3866.3427217373114, 3044.786864919479, 3132.8903488377796, 3150.432922074003, 3151.73210277129, 3153.038323311366, 505.13621706881645, 518.1916210711303, 539.4362890779067, 541.9187121931742, 550.0813641219173, 495.9429665588431, 562.1174755633698, 563.5435297409111, 573.1574585359515, 581.825452364289, 7703.614819259014, 7709.653065612061, 7810.492317999426, 7881.881771773428, 8045.0, 458.0815464992735, 473.11527443680535, 553.2503457814684, 581.7207740284687, 606.8907596632561, 3556.7332450066347, 3773.3773927302236, 3832.7317087803585, 3866.052817059838, 3888.5333759948985, 88412.5579372099, 90371.54814225886, 90691.54654226819, 93206.53396732973, 94326.52836735772, 50772.492275077515, 53569.46430535645, 74695.62652186814, 76356.23643763602, 76654.23345766471, 43733.0, 45715.0, 57720.42279577234, 68900.0, 70401.29598704152, 7398.556086634819, 7464.290892365217, 7487.663055162422, 7518.436117291334, 7561.962190189234, 40525.18949620932, 41673.0, 42054.789726051175, 42568.78715606402, 42766.14467710691, 61661.0, 63035.0, 63483.6825815868, 63592.0, 63626.0, 10322.638707645196, 10520.263581549218, 10561.894381056398, 10722.356658600509, 10727.318766105203, 12966.80549791735, 13029.609111726664, 13189.076764626385, 13220.40508177115, 13298.667533311746, 11574.247673901169, 11915.404229788302, 12028.218165819193, 12052.638420847388, 12247.69380765488, 12023.579174728842, 12187.634370968884, 12478.126531142732, 12626.0, 13272.86727132755, 10552.630657926935, 10671.89328106709, 11593.6521904343, 11668.124890633406, 12312.076594255646, 9611.231101512001, 9816.26378021637, 10013.849792252977, 10280.845787313347, 10379.429131397847, 9406.764830879009, 9606.615735370508, 9619.951900240454, 9645.228381729305, 9665.613375464902], "value": 6412.746489557539, "unit": "score"}], "name": "dromaeo_css", "value": 6370.600714865074, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 113.0, 113.0, 112.0, 114.0, 113.0, 112.0, 111.0, 113.0, 112.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 126.0, 125.0, 181.0, 123.0, 122.0, 146.0, 121.0, 155.0, 123.0], "value": 137.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 161.0, 167.0, 163.0, 162.0, 164.0, 162.0, 160.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 115.0, 76.0, 76.0, 75.0, 75.0, 112.0, 76.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 123.0, 85.0, 86.0, 85.0, 121.0, 84.0, 85.0, 135.0], "value": 97.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 118.0, 118.0, 116.0, 117.0, 116.0, 117.0, 117.0, 119.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 94.0, 95.0, 96.0, 97.0, 95.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 70.0, 63.0, 66.0, 64.0, 64.0, 63.0], "value": 64.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 65.0, 64.0, 65.0, 76.0, 64.0, 64.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 79.0, 79.0, 79.0, 78.0, 77.0, 78.0, 79.0, 83.0], "value": 79.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 137.0, 130.0, 134.0, 131.0, 145.0, 130.0, 146.0, 172.0, 141.0], "value": 139.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 169.0, 167.0, 174.0, 164.0, 168.0, 165.0, 167.0, 171.0, 166.0], "value": 168.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 72.0, 68.0, 68.0, 68.0, 67.0, 66.0, 69.0, 66.0, 66.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1535.6999999999998, "alertThreshold": 2.0}]} 17:18:38 INFO - Return code: 0 17:18:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:18:38 INFO - # TBPL SUCCESS # 17:18:38 INFO - Running post-action listener: _resource_record_post_action 17:18:38 INFO - ##### 17:18:38 INFO - ##### Finished run-tests step (success) 17:18:38 INFO - ##### 17:18:38 INFO - Running post-run listener: _resource_record_post_run 17:18:38 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 8192; Write bytes: 543137792; Read time: 228; Write time: 421956 17:18:38 INFO - TinderboxPrint: CPU usage
13.0% 17:18:38 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 228 17:18:38 INFO - TinderboxPrint: I/O write bytes / time
543,137,792 / 421,956 17:18:38 INFO - TinderboxPrint: CPU idle
8,329.4 (87.0%) 17:18:38 INFO - TinderboxPrint: CPU user
1,200.3 (12.5%) 17:18:38 INFO - TinderboxPrint: Swap in / out
0 / 0 17:18:38 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 245714944; Read time: 220; Write time: 229792 17:18:38 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 294866944; Read time: 0; Write time: 190676 17:18:39 INFO - Running post-run listener: _upload_blobber_files 17:18:39 INFO - Blob upload gear active. 17:18:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:18:39 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:18:39 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:18:39 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:18:39 INFO - (blobuploader) - INFO - Open directory for files ... 17:18:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:18:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:18:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:18:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:18:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:18:43 INFO - (blobuploader) - INFO - Done attempting. 17:18:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:18:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:18:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:18:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:18:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:18:43 INFO - (blobuploader) - INFO - Done attempting. 17:18:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:18:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:18:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:18:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:18:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:18:44 INFO - (blobuploader) - INFO - Done attempting. 17:18:44 INFO - (blobuploader) - INFO - Iteration through files over. 17:18:44 INFO - Return code: 0 17:18:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:18:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:18:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2a58fe5ba57bd8824063479ba52e8fff0333cdbfb87e29bdf3d8c6779d98dd9b7f9acbcd997bae72553fd6f2de21b2b5d78093b2c92f4c629e94b190e18afed0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/408b2bd8d5e693b5c73a7cc350ce55de70c33478343658fbdb2cb4c4e79dbf5af2cebdb7c1373ffd8a781da75a2e817b341f1a1726beae701300a253fd82da82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7a5a4cfa1e900ef1f21735eb69ab547de39be9784d7ddc5e667e31d7a4e7c058cc182f44a6b4776295291e96d08c6e424a45b05bf3f327b55d986550dbcecd51"} 17:18:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:18:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:18:44 INFO - Contents: 17:18:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2a58fe5ba57bd8824063479ba52e8fff0333cdbfb87e29bdf3d8c6779d98dd9b7f9acbcd997bae72553fd6f2de21b2b5d78093b2c92f4c629e94b190e18afed0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/408b2bd8d5e693b5c73a7cc350ce55de70c33478343658fbdb2cb4c4e79dbf5af2cebdb7c1373ffd8a781da75a2e817b341f1a1726beae701300a253fd82da82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7a5a4cfa1e900ef1f21735eb69ab547de39be9784d7ddc5e667e31d7a4e7c058cc182f44a6b4776295291e96d08c6e424a45b05bf3f327b55d986550dbcecd51"} 17:18:44 INFO - Running post-run listener: copy_logs_to_upload_dir 17:18:44 INFO - Copying logs to upload dir... 17:18:44 INFO - mkdir: /builds/slave/test/build/upload/logs 17:18:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.952486 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-05 17:18:44.186709) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 17:18:44.190136) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1467762503.650719-1404784090 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/2a58fe5ba57bd8824063479ba52e8fff0333cdbfb87e29bdf3d8c6779d98dd9b7f9acbcd997bae72553fd6f2de21b2b5d78093b2c92f4c629e94b190e18afed0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/408b2bd8d5e693b5c73a7cc350ce55de70c33478343658fbdb2cb4c4e79dbf5af2cebdb7c1373ffd8a781da75a2e817b341f1a1726beae701300a253fd82da82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7a5a4cfa1e900ef1f21735eb69ab547de39be9784d7ddc5e667e31d7a4e7c058cc182f44a6b4776295291e96d08c6e424a45b05bf3f327b55d986550dbcecd51"} build_url:https://queue.taskcluster.net/v1/task/SUhdP0DyQH6ThQzqrCNrww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011179 build_url: 'https://queue.taskcluster.net/v1/task/SUhdP0DyQH6ThQzqrCNrww/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/2a58fe5ba57bd8824063479ba52e8fff0333cdbfb87e29bdf3d8c6779d98dd9b7f9acbcd997bae72553fd6f2de21b2b5d78093b2c92f4c629e94b190e18afed0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/408b2bd8d5e693b5c73a7cc350ce55de70c33478343658fbdb2cb4c4e79dbf5af2cebdb7c1373ffd8a781da75a2e817b341f1a1726beae701300a253fd82da82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7a5a4cfa1e900ef1f21735eb69ab547de39be9784d7ddc5e667e31d7a4e7c058cc182f44a6b4776295291e96d08c6e424a45b05bf3f327b55d986550dbcecd51"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 17:18:44.215366) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 17:18:44.215717) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1467762503.650719-1404784090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 17:18:44.299557) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 17:18:44.299944) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 17:18:44.300249) ========= ========= Total master_lag: 0.17 =========