builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-028 starttime: 1468439657.6 results: success (0) buildid: 20160713122141 builduid: 7557ed23de1b463dbe185ff6ccb589e0 revision: a097b61f58102776941bd3fa0023092ac3f27a3f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 12:54:17.596645) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 12:54:17.597099) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 8 secs) (at 2016-07-13 12:54:17.597420) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 8 secs) (at 2016-07-13 12:54:25.883370) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 12:54:25.883648) ========= 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=836cfdc75598d54cb747368e000001a9-1468438645.862253-1582568016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-13 12:54:26-- 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% 43.3M=0s 2016-07-13 12:54:26 (43.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122197 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 12:54:26.020168) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 12:54:26.020473) ========= 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=836cfdc75598d54cb747368e000001a9-1468438645.862253-1582568016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021080 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 12:54:26.069514) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 12:54:26.069822) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a097b61f58102776941bd3fa0023092ac3f27a3f --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 a097b61f58102776941bd3fa0023092ac3f27a3f --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=836cfdc75598d54cb747368e000001a9-1468438645.862253-1582568016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-13 12:54:26,718 truncating revision to first 12 chars 2016-07-13 12:54:26,718 Setting DEBUG logging. 2016-07-13 12:54:26,718 attempt 1/10 2016-07-13 12:54:26,718 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a097b61f5810?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 12:54:27,089 unpacking tar archive at: fx-team-a097b61f5810/testing/mozharness/ program finished with exit code 0 elapsedTime=0.703086 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 12:54:26.787078) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 12:54:26.787350) ========= script_repo_revision: a097b61f58102776941bd3fa0023092ac3f27a3f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 12:54:26.787721) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 12:54:26.787986) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 12:54:26.796525) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-13 12:54:26.796791) ========= /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=836cfdc75598d54cb747368e000001a9-1468438645.862253-1582568016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:54:27 INFO - MultiFileLogger online at 20160713 12:54:27 in /builds/slave/test 12:54:27 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 12:54:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:54:27 INFO - {'append_to_log': False, 12:54:27 INFO - 'base_work_dir': '/builds/slave/test', 12:54:27 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:54:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:54:27 INFO - 'branch': 'Fx-Team-Non-PGO', 12:54:27 INFO - 'buildbot_json_path': 'buildprops.json', 12:54:27 INFO - 'config_files': ('talos/linux_config.py',), 12:54:27 INFO - 'default_actions': ('clobber', 12:54:27 INFO - 'read-buildbot-config', 12:54:27 INFO - 'download-and-extract', 12:54:27 INFO - 'populate-webroot', 12:54:27 INFO - 'create-virtualenv', 12:54:27 INFO - 'install', 12:54:27 INFO - 'run-tests'), 12:54:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:54:27 INFO - 'download_minidump_stackwalk': True, 12:54:27 INFO - 'download_symbols': 'ondemand', 12:54:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:54:27 INFO - 'tooltool.py': '/tools/tooltool.py', 12:54:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:54:27 INFO - '/tools/misc-python/virtualenv.py')}, 12:54:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:54:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:54:27 INFO - 'installer_path': 'installer.exe', 12:54:27 INFO - 'log_level': 'info', 12:54:27 INFO - 'log_name': 'talos', 12:54:27 INFO - 'log_to_console': True, 12:54:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:54:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:54:27 INFO - 'opt_config_files': (), 12:54:27 INFO - 'pip_index': False, 12:54:27 INFO - 'sps_profile': False, 12:54:27 INFO - 'sps_profile_interval': 0, 12:54:27 INFO - 'suite': 'dromaeojs', 12:54:27 INFO - 'system_bits': '32', 12:54:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:54:27 INFO - 'title': 'talos-linux64-ix-028', 12:54:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:54:27 INFO - 'use_talos_json': True, 12:54:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:54:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:54:27 INFO - 'work_dir': 'build'} 12:54:27 INFO - ##### 12:54:27 INFO - ##### Running clobber step. 12:54:27 INFO - ##### 12:54:27 INFO - Running pre-action listener: _resource_record_pre_action 12:54:27 INFO - Running main action method: clobber 12:54:27 INFO - rmtree: /builds/slave/test/build 12:54:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:54:28 INFO - Running post-action listener: _resource_record_post_action 12:54:28 INFO - ##### 12:54:28 INFO - ##### Finished clobber step (success) 12:54:28 INFO - ##### 12:54:28 INFO - ##### 12:54:28 INFO - ##### Running read-buildbot-config step. 12:54:28 INFO - ##### 12:54:28 INFO - Running pre-action listener: _resource_record_pre_action 12:54:28 INFO - Running main action method: read_buildbot_config 12:54:28 INFO - Using buildbot properties: 12:54:28 INFO - { 12:54:28 INFO - "project": "", 12:54:28 INFO - "product": "firefox", 12:54:28 INFO - "script_repo_revision": "production", 12:54:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:54:28 INFO - "repository": "", 12:54:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 12:54:28 INFO - "buildid": "20160713122141", 12:54:28 INFO - "pgo_build": "False", 12:54:28 INFO - "basedir": "/builds/slave/test", 12:54:28 INFO - "buildnumber": 3149, 12:54:28 INFO - "slavename": "talos-linux64-ix-028", 12:54:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:54:28 INFO - "platform": "ubuntu64_hw", 12:54:28 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:54:28 INFO - "branch": "fx-team", 12:54:28 INFO - "repo_path": "integration/fx-team", 12:54:28 INFO - "revision": "a097b61f58102776941bd3fa0023092ac3f27a3f", 12:54:28 INFO - "stage_platform": "linux64", 12:54:28 INFO - "builduid": "7557ed23de1b463dbe185ff6ccb589e0", 12:54:28 INFO - "slavebuilddir": "test" 12:54:28 INFO - } 12:54:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZzXSWHxXTX6nznBB3pQQYA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 12:54:28 INFO - Running post-action listener: _resource_record_post_action 12:54:28 INFO - ##### 12:54:28 INFO - ##### Finished read-buildbot-config step (success) 12:54:28 INFO - ##### 12:54:28 INFO - ##### 12:54:28 INFO - ##### Running download-and-extract step. 12:54:28 INFO - ##### 12:54:28 INFO - Running pre-action listener: _resource_record_pre_action 12:54:28 INFO - Running main action method: download_and_extract 12:54:28 INFO - mkdir: /builds/slave/test/build/tests 12:54: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')]} 12:54:28 INFO - https://queue.taskcluster.net/v1/task/ZzXSWHxXTX6nznBB3pQQYA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:54:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZzXSWHxXTX6nznBB3pQQYA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:54:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZzXSWHxXTX6nznBB3pQQYA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:54:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZzXSWHxXTX6nznBB3pQQYA/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 12:54:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZzXSWHxXTX6nznBB3pQQYA/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 12:54:30 INFO - Downloaded 1361 bytes. 12:54:30 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:54:30 INFO - Using the following test package requirements: 12:54:30 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:54:30 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:54:30 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:54:30 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:30 INFO - u'jsshell-linux-x86_64.zip'], 12:54:30 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:54:30 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:54:30 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:54:30 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:54:30 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:54:30 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:54:30 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:54:30 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')]} 12:54:30 INFO - https://queue.taskcluster.net/v1/task/ZzXSWHxXTX6nznBB3pQQYA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:54:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZzXSWHxXTX6nznBB3pQQYA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:54:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZzXSWHxXTX6nznBB3pQQYA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:54:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZzXSWHxXTX6nznBB3pQQYA/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 12:54:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZzXSWHxXTX6nznBB3pQQYA/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 12:54:32 INFO - Downloaded 22755882 bytes. 12:54:32 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'] 12:54:32 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 12:54:33 INFO - Return code: 0 12:54:33 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 12:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:33 INFO - https://queue.taskcluster.net/v1/task/ZzXSWHxXTX6nznBB3pQQYA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:54:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZzXSWHxXTX6nznBB3pQQYA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:54:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZzXSWHxXTX6nznBB3pQQYA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:54:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZzXSWHxXTX6nznBB3pQQYA/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 12:54:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZzXSWHxXTX6nznBB3pQQYA/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 12:54:34 INFO - Downloaded 22755882 bytes. 12:54:34 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'] 12:54:34 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 12:54:36 INFO - Return code: 0 12:54:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:36 INFO - https://queue.taskcluster.net/v1/task/ZzXSWHxXTX6nznBB3pQQYA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:54:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZzXSWHxXTX6nznBB3pQQYA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:54:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZzXSWHxXTX6nznBB3pQQYA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:54:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZzXSWHxXTX6nznBB3pQQYA/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 12:54:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZzXSWHxXTX6nznBB3pQQYA/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 12:54:37 INFO - Downloaded 14403317 bytes. 12:54:37 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'] 12:54:37 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 12:54:37 INFO - Return code: 0 12:54:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:37 INFO - https://queue.taskcluster.net/v1/task/ZzXSWHxXTX6nznBB3pQQYA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:54:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZzXSWHxXTX6nznBB3pQQYA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:54:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZzXSWHxXTX6nznBB3pQQYA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:54:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZzXSWHxXTX6nznBB3pQQYA/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 12:54:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZzXSWHxXTX6nznBB3pQQYA/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 12:54:39 INFO - Downloaded 57052201 bytes. 12:54:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZzXSWHxXTX6nznBB3pQQYA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:54:39 INFO - mkdir: /builds/slave/test/properties 12:54:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:54:39 INFO - Writing to file /builds/slave/test/properties/build_url 12:54:39 INFO - Contents: 12:54:39 INFO - build_url:https://queue.taskcluster.net/v1/task/ZzXSWHxXTX6nznBB3pQQYA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:54:40 INFO - Running post-action listener: _resource_record_post_action 12:54:40 INFO - Running post-action listener: set_extra_try_arguments 12:54:40 INFO - ##### 12:54:40 INFO - ##### Finished download-and-extract step (success) 12:54:40 INFO - ##### 12:54:40 INFO - ##### 12:54:40 INFO - ##### Running populate-webroot step. 12:54:40 INFO - ##### 12:54:40 INFO - Running pre-action listener: _resource_record_pre_action 12:54:40 INFO - Running main action method: populate_webroot 12:54:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:54:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:54:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:54:40 INFO - '--tppagecycles', 12:54:40 INFO - '7'], 12:54:40 INFO - 'tests': ['tsvgm']}}, 12:54:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:54:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:54:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:54:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:54:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:54:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:54:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:40 INFO - 'talos_options': ['--disable-e10s'], 12:54:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:54:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:54:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:40 INFO - 'talos_options': ['--disable-e10s'], 12:54:40 INFO - 'tests': ['damp', 'tps']}, 12:54:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:40 INFO - 'tests': ['damp', 'tps']}, 12:54:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:54:40 INFO - 'tests': ['dromaeo_dom']}, 12:54:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:54:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:54:40 INFO - 'tests': ['basic_compositor_video']}, 12:54:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:54:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:54:40 INFO - 'tests': ['a11yr', 12:54:40 INFO - 'ts_paint', 12:54:40 INFO - 'tpaint', 12:54:40 INFO - 'sessionrestore', 12:54:40 INFO - 'sessionrestore_no_auto_restore', 12:54:40 INFO - 'tabpaint']}, 12:54:40 INFO - 'other-e10s': {'tests': ['a11yr', 12:54:40 INFO - 'ts_paint', 12:54:40 INFO - 'tpaint', 12:54:40 INFO - 'sessionrestore', 12:54:40 INFO - 'sessionrestore_no_auto_restore', 12:54:40 INFO - 'tabpaint']}, 12:54:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:54:40 INFO - 'ts_paint', 12:54:40 INFO - 'tpaint', 12:54:40 INFO - 'sessionrestore', 12:54:40 INFO - 'sessionrestore_no_auto_restore', 12:54:40 INFO - 'tabpaint']}, 12:54:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:54:40 INFO - 'ts_paint', 12:54:40 INFO - 'tpaint', 12:54:40 INFO - 'sessionrestore', 12:54:40 INFO - 'sessionrestore_no_auto_restore', 12:54:40 INFO - 'tabpaint']}, 12:54:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:54:40 INFO - 'tests': ['a11yr', 12:54:40 INFO - 'ts_paint', 12:54:40 INFO - 'tpaint', 12:54:40 INFO - 'sessionrestore', 12:54:40 INFO - 'sessionrestore_no_auto_restore', 12:54:40 INFO - 'tabpaint']}, 12:54:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:54:40 INFO - 'tests': ['a11yr', 12:54:40 INFO - 'ts_paint', 12:54:40 INFO - 'tpaint', 12:54:40 INFO - 'sessionrestore', 12:54:40 INFO - 'sessionrestore_no_auto_restore', 12:54:40 INFO - 'tabpaint']}, 12:54:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:54:40 INFO - 'tests': ['tsvgx', 12:54:40 INFO - 'tsvgr_opacity', 12:54:40 INFO - 'tart', 12:54:40 INFO - 'tscrollx', 12:54:40 INFO - 'cart']}, 12:54:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:54:40 INFO - 'tsvgr_opacity', 12:54:40 INFO - 'tart', 12:54:40 INFO - 'tscrollx', 12:54:40 INFO - 'cart']}, 12:54:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:40 INFO - 'talos_options': ['--disable-e10s'], 12:54:40 INFO - 'tests': ['tp5o']}, 12:54:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:40 INFO - 'tests': ['tp5o']}, 12:54:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:40 INFO - 'talos_options': ['--disable-e10s', 12:54:40 INFO - '--xperf_path', 12:54:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:54:40 INFO - 'tests': ['tp5n']}, 12:54:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:40 INFO - 'talos_options': ['--xperf_path', 12:54:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:54:40 INFO - 'tests': ['tp5n']}}, 12:54:40 INFO - 'talos.zip': {'path': '', 12:54:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:54:40 INFO - Running post-action listener: _resource_record_post_action 12:54:40 INFO - ##### 12:54:40 INFO - ##### Finished populate-webroot step (success) 12:54:40 INFO - ##### 12:54:40 INFO - ##### 12:54:40 INFO - ##### Running create-virtualenv step. 12:54:40 INFO - ##### 12:54:40 INFO - Running pre-action listener: _resource_record_pre_action 12:54:40 INFO - Running main action method: create_virtualenv 12:54:40 INFO - Creating virtualenv /builds/slave/test/build/venv 12:54:40 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 12:54:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:54:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:54:40 INFO - Using real prefix '/usr' 12:54:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:54:40 INFO - Installing distribute.............................................................................................................................................................................................done. 12:54:42 INFO - Installing pip.................done. 12:54:42 INFO - Return code: 0 12:54:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:54:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28aa180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a83b0>, '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 0x28a92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a9740>, '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': '836cfdc75598d54cb747368e000001a9-1468438645.862253-1582568016', '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 12:54:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:54:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:54:42 INFO - Using env: {'DISPLAY': ':0', 12:54:42 INFO - 'HOME': '/home/cltbld', 12:54:42 INFO - 'LANG': 'en_US.UTF-8', 12:54:42 INFO - 'LANGUAGE': 'en_US:en', 12:54:42 INFO - 'LOGNAME': 'cltbld', 12:54:42 INFO - 'MAIL': '/var/mail/cltbld', 12:54:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:42 INFO - 'MOZ_NO_REMOTE': '1', 12:54:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:42 INFO - 'NO_EM_RESTART': '1', 12:54:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:42 INFO - 'PWD': '/builds/slave/test', 12:54:42 INFO - 'SHELL': '/bin/bash', 12:54:42 INFO - 'SHLVL': '1', 12:54:42 INFO - 'TERM': 'linux', 12:54:42 INFO - 'TMOUT': '86400', 12:54:42 INFO - 'USER': 'cltbld', 12:54:42 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1468438645.862253-1582568016', 12:54:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:42 INFO - '_': '/tools/buildbot/bin/python'} 12:54:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:42 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 12:54:42 INFO - Cleaning up... 12:54:42 INFO - Return code: 0 12:54:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:54:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25e9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28aa180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a83b0>, '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 0x28a92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a9740>, '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': '836cfdc75598d54cb747368e000001a9-1468438645.862253-1582568016', '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 12:54:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:54:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:54:42 INFO - Using env: {'DISPLAY': ':0', 12:54:42 INFO - 'HOME': '/home/cltbld', 12:54:42 INFO - 'LANG': 'en_US.UTF-8', 12:54:42 INFO - 'LANGUAGE': 'en_US:en', 12:54:42 INFO - 'LOGNAME': 'cltbld', 12:54:42 INFO - 'MAIL': '/var/mail/cltbld', 12:54:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:42 INFO - 'MOZ_NO_REMOTE': '1', 12:54:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:42 INFO - 'NO_EM_RESTART': '1', 12:54:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:42 INFO - 'PWD': '/builds/slave/test', 12:54:42 INFO - 'SHELL': '/bin/bash', 12:54:42 INFO - 'SHLVL': '1', 12:54:42 INFO - 'TERM': 'linux', 12:54:42 INFO - 'TMOUT': '86400', 12:54:42 INFO - 'USER': 'cltbld', 12:54:42 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1468438645.862253-1582568016', 12:54:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:42 INFO - '_': '/tools/buildbot/bin/python'} 12:54:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:43 INFO - Downloading/unpacking psutil>=3.1.1 12:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:54:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:54:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:54:45 INFO - Installing collected packages: psutil 12:54:45 INFO - Running setup.py install for psutil 12:54:45 INFO - building 'psutil._psutil_linux' extension 12:54:45 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 12:54:45 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 12:54:45 INFO - building 'psutil._psutil_posix' extension 12:54:45 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 12:54:45 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 12:54:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:54:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:54:45 INFO - Successfully installed psutil 12:54:45 INFO - Cleaning up... 12:54:45 INFO - Return code: 0 12:54:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:54:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28aa180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a83b0>, '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 0x28a92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a9740>, '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': '836cfdc75598d54cb747368e000001a9-1468438645.862253-1582568016', '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 12:54:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:54:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:54:45 INFO - Using env: {'DISPLAY': ':0', 12:54:45 INFO - 'HOME': '/home/cltbld', 12:54:45 INFO - 'LANG': 'en_US.UTF-8', 12:54:45 INFO - 'LANGUAGE': 'en_US:en', 12:54:45 INFO - 'LOGNAME': 'cltbld', 12:54:45 INFO - 'MAIL': '/var/mail/cltbld', 12:54:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:45 INFO - 'MOZ_NO_REMOTE': '1', 12:54:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:45 INFO - 'NO_EM_RESTART': '1', 12:54:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:45 INFO - 'PWD': '/builds/slave/test', 12:54:45 INFO - 'SHELL': '/bin/bash', 12:54:45 INFO - 'SHLVL': '1', 12:54:45 INFO - 'TERM': 'linux', 12:54:45 INFO - 'TMOUT': '86400', 12:54:45 INFO - 'USER': 'cltbld', 12:54:45 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1468438645.862253-1582568016', 12:54:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:45 INFO - '_': '/tools/buildbot/bin/python'} 12:54:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:54:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:54:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:54:47 INFO - Installing collected packages: mozsystemmonitor 12:54:47 INFO - Running setup.py install for mozsystemmonitor 12:54:48 INFO - Successfully installed mozsystemmonitor 12:54:48 INFO - Cleaning up... 12:54:48 INFO - Return code: 0 12:54:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:48 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 0x25e9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28aa180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a83b0>, '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 0x28a92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a9740>, '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': '836cfdc75598d54cb747368e000001a9-1468438645.862253-1582568016', '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 12:54:48 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 12:54:48 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 12:54:48 INFO - Using env: {'DISPLAY': ':0', 12:54:48 INFO - 'HOME': '/home/cltbld', 12:54:48 INFO - 'LANG': 'en_US.UTF-8', 12:54:48 INFO - 'LANGUAGE': 'en_US:en', 12:54:48 INFO - 'LOGNAME': 'cltbld', 12:54:48 INFO - 'MAIL': '/var/mail/cltbld', 12:54:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:48 INFO - 'MOZ_NO_REMOTE': '1', 12:54:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:48 INFO - 'NO_EM_RESTART': '1', 12:54:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:48 INFO - 'PWD': '/builds/slave/test', 12:54:48 INFO - 'SHELL': '/bin/bash', 12:54:48 INFO - 'SHLVL': '1', 12:54:48 INFO - 'TERM': 'linux', 12:54:48 INFO - 'TMOUT': '86400', 12:54:48 INFO - 'USER': 'cltbld', 12:54:48 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1468438645.862253-1582568016', 12:54:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:48 INFO - '_': '/tools/buildbot/bin/python'} 12:54:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:48 INFO - Downloading/unpacking jsonschema==2.5.1 12:54:48 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 12:54:48 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 12:54:48 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 12:54:48 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 12:54:48 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 12:54:48 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 12:54:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:54:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:54:50 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 12:54:50 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 12:54:50 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 12:54:50 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 12:54:50 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 12:54:50 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 12:54:50 INFO - Downloading functools32-3.2.3-2.tar.gz 12:54:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:54:50 INFO - warning: no files found matching '*.txt' 12:54:50 INFO - no previously-included directories found matching 'build' 12:54:50 INFO - no previously-included directories found matching 'dist' 12:54:50 INFO - no previously-included directories found matching '.git*' 12:54:50 INFO - Installing collected packages: jsonschema, functools32 12:54:50 INFO - Running setup.py install for functools32 12:54:50 INFO - warning: no files found matching '*.txt' 12:54:50 INFO - no previously-included directories found matching 'build' 12:54:50 INFO - no previously-included directories found matching 'dist' 12:54:50 INFO - no previously-included directories found matching '.git*' 12:54:50 INFO - Successfully installed jsonschema functools32 12:54:50 INFO - Cleaning up... 12:54:50 INFO - Return code: 0 12:54:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:54:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:50 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 0x25e9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28aa180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a83b0>, '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 0x28a92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a9740>, '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': '836cfdc75598d54cb747368e000001a9-1468438645.862253-1582568016', '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 12:54:50 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 12:54:50 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 12:54:50 INFO - Using env: {'DISPLAY': ':0', 12:54:50 INFO - 'HOME': '/home/cltbld', 12:54:50 INFO - 'LANG': 'en_US.UTF-8', 12:54:50 INFO - 'LANGUAGE': 'en_US:en', 12:54:50 INFO - 'LOGNAME': 'cltbld', 12:54:50 INFO - 'MAIL': '/var/mail/cltbld', 12:54:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:50 INFO - 'MOZ_NO_REMOTE': '1', 12:54:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:50 INFO - 'NO_EM_RESTART': '1', 12:54:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:50 INFO - 'PWD': '/builds/slave/test', 12:54:50 INFO - 'SHELL': '/bin/bash', 12:54:50 INFO - 'SHLVL': '1', 12:54:50 INFO - 'TERM': 'linux', 12:54:50 INFO - 'TMOUT': '86400', 12:54:50 INFO - 'USER': 'cltbld', 12:54:50 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1468438645.862253-1582568016', 12:54:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:50 INFO - '_': '/tools/buildbot/bin/python'} 12:54:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:50 INFO - Downloading/unpacking blobuploader==1.2.4 12:54:50 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 12:54:50 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 12:54:50 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 12:54:50 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 12:54:50 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 12:54:50 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 12:54:52 INFO - Downloading blobuploader-1.2.4.tar.gz 12:54:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:54:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:54:52 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 12:54:52 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 12:54:52 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 12:54:52 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 12:54:52 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 12:54:52 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 12:54:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:54:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:53 INFO - Downloading docopt-0.6.1.tar.gz 12:54:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:54:53 INFO - Installing collected packages: blobuploader, requests, docopt 12:54:53 INFO - Running setup.py install for blobuploader 12:54:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:54:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:54:53 INFO - Running setup.py install for requests 12:54:54 INFO - Running setup.py install for docopt 12:54:54 INFO - Successfully installed blobuploader requests docopt 12:54:54 INFO - Cleaning up... 12:54:54 INFO - Return code: 0 12:54:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:54:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:54 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 0x25e9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28aa180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a83b0>, '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 0x28a92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a9740>, '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': '836cfdc75598d54cb747368e000001a9-1468438645.862253-1582568016', '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 12:54:54 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 12:54:54 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 12:54:54 INFO - Using env: {'DISPLAY': ':0', 12:54:54 INFO - 'HOME': '/home/cltbld', 12:54:54 INFO - 'LANG': 'en_US.UTF-8', 12:54:54 INFO - 'LANGUAGE': 'en_US:en', 12:54:54 INFO - 'LOGNAME': 'cltbld', 12:54:54 INFO - 'MAIL': '/var/mail/cltbld', 12:54:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:54 INFO - 'MOZ_NO_REMOTE': '1', 12:54:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:54 INFO - 'NO_EM_RESTART': '1', 12:54:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:54 INFO - 'PWD': '/builds/slave/test', 12:54:54 INFO - 'SHELL': '/bin/bash', 12:54:54 INFO - 'SHLVL': '1', 12:54:54 INFO - 'TERM': 'linux', 12:54:54 INFO - 'TMOUT': '86400', 12:54:54 INFO - 'USER': 'cltbld', 12:54:54 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1468438645.862253-1582568016', 12:54:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:54 INFO - '_': '/tools/buildbot/bin/python'} 12:54:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:54:54 INFO - Running setup.py (path:/tmp/pip-_ccHQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:54:54 INFO - Running setup.py (path:/tmp/pip-1x0ofp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:54:54 INFO - Running setup.py (path:/tmp/pip-BOvhiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:54:54 INFO - Running setup.py (path:/tmp/pip-sjCVqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:54:54 INFO - Running setup.py (path:/tmp/pip-To8QKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:54:54 INFO - Running setup.py (path:/tmp/pip-zlWP3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:54:54 INFO - Running setup.py (path:/tmp/pip-OMvzOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:54:54 INFO - Running setup.py (path:/tmp/pip-KE8nYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:54:55 INFO - Running setup.py (path:/tmp/pip-6u1l1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:54:55 INFO - Running setup.py (path:/tmp/pip-FbzkO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:54:55 INFO - Running setup.py (path:/tmp/pip-RqxwSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:54:55 INFO - Running setup.py (path:/tmp/pip-kdnngw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:54:55 INFO - Running setup.py (path:/tmp/pip-Xt0Vjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:54:55 INFO - Running setup.py (path:/tmp/pip-y7a6_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:55 INFO - Running setup.py (path:/tmp/pip-vAvPjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:54:55 INFO - Running setup.py (path:/tmp/pip-91g5hK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:54:55 INFO - Running setup.py (path:/tmp/pip-nYnpZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:54:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:54:55 INFO - Running setup.py install for manifestparser 12:54:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:54:55 INFO - Running setup.py install for mozcrash 12:54:55 INFO - Running setup.py install for mozdebug 12:54:55 INFO - Running setup.py install for mozdevice 12:54:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:54:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:54:56 INFO - Running setup.py install for mozfile 12:54:56 INFO - Running setup.py install for mozhttpd 12:54:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:54:56 INFO - Running setup.py install for mozinfo 12:54:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:54:56 INFO - Running setup.py install for mozInstall 12:54:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:54:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:54:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:54:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:54:56 INFO - Running setup.py install for mozleak 12:54:56 INFO - Running setup.py install for mozlog 12:54:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:54:56 INFO - Running setup.py install for moznetwork 12:54:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:54:56 INFO - Running setup.py install for mozprocess 12:54:56 INFO - Running setup.py install for mozprofile 12:54:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:54:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:54:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:54:57 INFO - Running setup.py install for mozrunner 12:54:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:54:57 INFO - Running setup.py install for mozscreenshot 12:54:57 INFO - Running setup.py install for moztest 12:54:57 INFO - Running setup.py install for mozversion 12:54:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:54:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:54:57 INFO - Cleaning up... 12:54:57 INFO - Return code: 0 12:54:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:54:57 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')]} 12:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:57 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')]} 12:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:57 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 0x25e9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28aa180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a83b0>, '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 0x28a92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a9740>, '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': '836cfdc75598d54cb747368e000001a9-1468438645.862253-1582568016', '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 12:54:57 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 12:54:57 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 12:54:57 INFO - Using env: {'DISPLAY': ':0', 12:54:57 INFO - 'HOME': '/home/cltbld', 12:54:57 INFO - 'LANG': 'en_US.UTF-8', 12:54:57 INFO - 'LANGUAGE': 'en_US:en', 12:54:57 INFO - 'LOGNAME': 'cltbld', 12:54:57 INFO - 'MAIL': '/var/mail/cltbld', 12:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:57 INFO - 'MOZ_NO_REMOTE': '1', 12:54:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:57 INFO - 'NO_EM_RESTART': '1', 12:54:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:57 INFO - 'PWD': '/builds/slave/test', 12:54:57 INFO - 'SHELL': '/bin/bash', 12:54:57 INFO - 'SHLVL': '1', 12:54:57 INFO - 'TERM': 'linux', 12:54:57 INFO - 'TMOUT': '86400', 12:54:57 INFO - 'USER': 'cltbld', 12:54:57 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1468438645.862253-1582568016', 12:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:57 INFO - '_': '/tools/buildbot/bin/python'} 12:54:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:54:57 INFO - Running setup.py (path:/tmp/pip-ybkTWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:54:57 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)) 12:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:54:57 INFO - Running setup.py (path:/tmp/pip-vvb6Sl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:54:57 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)) 12:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:54:57 INFO - Running setup.py (path:/tmp/pip-7A63rL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:54:57 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)) 12:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:54:57 INFO - Running setup.py (path:/tmp/pip-S3ZBi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:54:57 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)) 12:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:54:57 INFO - Running setup.py (path:/tmp/pip-mwpFlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:54:58 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)) 12:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:54:58 INFO - Running setup.py (path:/tmp/pip-TuFfQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:54:58 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)) 12:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:54:58 INFO - Running setup.py (path:/tmp/pip-9G4wHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:54:58 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)) 12:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:54:58 INFO - Running setup.py (path:/tmp/pip-88Vxaf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:54:58 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)) 12:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:54:58 INFO - Running setup.py (path:/tmp/pip-1Qc3gE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:54:58 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)) 12:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:54:58 INFO - Running setup.py (path:/tmp/pip-1faO99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:54:58 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)) 12:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:54:58 INFO - Running setup.py (path:/tmp/pip-vepF0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:54:58 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)) 12:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:54:58 INFO - Running setup.py (path:/tmp/pip-hNOguq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:54:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:54:58 INFO - Running setup.py (path:/tmp/pip-U6roNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:54:58 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)) 12:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:54:58 INFO - Running setup.py (path:/tmp/pip-e326ZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:54:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:58 INFO - Running setup.py (path:/tmp/pip-94kvdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:58 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)) 12:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:54:58 INFO - Running setup.py (path:/tmp/pip-fuq_mz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:54:58 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)) 12:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:54:58 INFO - Running setup.py (path:/tmp/pip-9uZECy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:54:58 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)) 12:54:58 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)) 12:54:58 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)) 12:54:58 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)) 12:54:58 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)) 12:54:58 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)) 12:54:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:54:58 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 12:54:58 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 12:54:58 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 12:54:58 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 12:54:58 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 12:54:58 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 12:55:00 INFO - Downloading blessings-1.6.tar.gz 12:55:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:55:00 INFO - Installing collected packages: blessings 12:55:00 INFO - Running setup.py install for blessings 12:55:01 INFO - Successfully installed blessings 12:55:01 INFO - Cleaning up... 12:55:01 INFO - Return code: 0 12:55:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:55:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:55:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:55:01 INFO - Reading from file tmpfile_stdout 12:55:01 INFO - Current package versions: 12:55:01 INFO - argparse == 1.2.1 12:55:01 INFO - blessings == 1.6 12:55:01 INFO - blobuploader == 1.2.4 12:55:01 INFO - docopt == 0.6.1 12:55:01 INFO - functools32 == 3.2.3-2 12:55:01 INFO - jsonschema == 2.5.1 12:55:01 INFO - manifestparser == 1.1 12:55:01 INFO - mozInstall == 1.12 12:55:01 INFO - mozcrash == 0.17 12:55:01 INFO - mozdebug == 0.1 12:55:01 INFO - mozdevice == 0.48 12:55:01 INFO - mozfile == 1.2 12:55:01 INFO - mozhttpd == 0.7 12:55:01 INFO - mozinfo == 0.9 12:55:01 INFO - mozleak == 0.1 12:55:01 INFO - mozlog == 3.2 12:55:01 INFO - moznetwork == 0.27 12:55:01 INFO - mozprocess == 0.23 12:55:01 INFO - mozprofile == 0.28 12:55:01 INFO - mozrunner == 6.12 12:55:01 INFO - mozscreenshot == 0.1 12:55:01 INFO - mozsystemmonitor == 0.3 12:55:01 INFO - moztest == 0.7 12:55:01 INFO - mozversion == 1.4 12:55:01 INFO - psutil == 3.1.1 12:55:01 INFO - requests == 1.2.3 12:55:01 INFO - wsgiref == 0.1.2 12:55:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:55: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')]} 12:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55: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')]} 12:55:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:01 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 0x25e9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28aa180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a83b0>, '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 0x28a92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a9740>, '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': '836cfdc75598d54cb747368e000001a9-1468438645.862253-1582568016', '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 12:55:01 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 12:55:01 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 12:55:01 INFO - Using env: {'DISPLAY': ':0', 12:55:01 INFO - 'HOME': '/home/cltbld', 12:55:01 INFO - 'LANG': 'en_US.UTF-8', 12:55:01 INFO - 'LANGUAGE': 'en_US:en', 12:55:01 INFO - 'LOGNAME': 'cltbld', 12:55:01 INFO - 'MAIL': '/var/mail/cltbld', 12:55:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:01 INFO - 'MOZ_NO_REMOTE': '1', 12:55:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:01 INFO - 'NO_EM_RESTART': '1', 12:55:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:01 INFO - 'PWD': '/builds/slave/test', 12:55:01 INFO - 'SHELL': '/bin/bash', 12:55:01 INFO - 'SHLVL': '1', 12:55:01 INFO - 'TERM': 'linux', 12:55:01 INFO - 'TMOUT': '86400', 12:55:01 INFO - 'USER': 'cltbld', 12:55:01 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1468438645.862253-1582568016', 12:55:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:01 INFO - '_': '/tools/buildbot/bin/python'} 12:55:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:01 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)) 12:55:01 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)) 12:55:01 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)) 12:55:01 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)) 12:55:01 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)) 12:55:01 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)) 12:55:01 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)) 12:55:01 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)) 12:55:01 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)) 12:55:01 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)) 12:55:01 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)) 12:55:01 INFO - Cleaning up... 12:55:01 INFO - Return code: 0 12:55:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:55: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')]} 12:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55: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')]} 12:55:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:01 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 0x25e9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28aa180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a83b0>, '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 0x28a92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a9740>, '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': '836cfdc75598d54cb747368e000001a9-1468438645.862253-1582568016', '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 12:55:01 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 12:55:01 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 12:55:01 INFO - Using env: {'DISPLAY': ':0', 12:55:01 INFO - 'HOME': '/home/cltbld', 12:55:01 INFO - 'LANG': 'en_US.UTF-8', 12:55:01 INFO - 'LANGUAGE': 'en_US:en', 12:55:01 INFO - 'LOGNAME': 'cltbld', 12:55:01 INFO - 'MAIL': '/var/mail/cltbld', 12:55:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:01 INFO - 'MOZ_NO_REMOTE': '1', 12:55:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:01 INFO - 'NO_EM_RESTART': '1', 12:55:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:01 INFO - 'PWD': '/builds/slave/test', 12:55:01 INFO - 'SHELL': '/bin/bash', 12:55:01 INFO - 'SHLVL': '1', 12:55:01 INFO - 'TERM': 'linux', 12:55:01 INFO - 'TMOUT': '86400', 12:55:01 INFO - 'USER': 'cltbld', 12:55:01 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1468438645.862253-1582568016', 12:55:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:01 INFO - '_': '/tools/buildbot/bin/python'} 12:55:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:55:01 INFO - Cleaning up... 12:55:01 INFO - Return code: 0 12:55:01 INFO - Running post-action listener: _resource_record_post_action 12:55:01 INFO - Running post-action listener: _start_resource_monitoring 12:55:01 INFO - Starting resource monitoring. 12:55:01 INFO - ##### 12:55:01 INFO - ##### Finished create-virtualenv step (success) 12:55:01 INFO - ##### 12:55:01 INFO - ##### 12:55:01 INFO - ##### Running install step. 12:55:01 INFO - ##### 12:55:01 INFO - Running pre-action listener: _resource_record_pre_action 12:55:01 INFO - Running main action method: install 12:55:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:55:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:55:02 INFO - Reading from file tmpfile_stdout 12:55:02 INFO - Detecting whether we're running mozinstall >=1.0... 12:55:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:55:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:55:02 INFO - Reading from file tmpfile_stdout 12:55:02 INFO - Output received: 12:55:02 INFO - Usage: mozinstall [options] installer 12:55:02 INFO - Options: 12:55:02 INFO - -h, --help show this help message and exit 12:55:02 INFO - -d DEST, --destination=DEST 12:55:02 INFO - Directory to install application into. [default: 12:55:02 INFO - "/builds/slave/test"] 12:55:02 INFO - --app=APP Application being installed. [default: firefox] 12:55:02 INFO - mkdir: /builds/slave/test/build/application 12:55:02 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'] 12:55:02 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 12:55:18 INFO - Reading from file tmpfile_stdout 12:55:18 INFO - Output received: 12:55:18 INFO - /builds/slave/test/build/application/firefox/firefox 12:55:18 INFO - Running post-action listener: _resource_record_post_action 12:55:18 INFO - ##### 12:55:18 INFO - ##### Finished install step (success) 12:55:18 INFO - ##### 12:55:18 INFO - ##### 12:55:18 INFO - ##### Running run-tests step. 12:55:18 INFO - ##### 12:55:18 INFO - Running pre-action listener: _resource_record_pre_action 12:55:18 INFO - Running main action method: run_tests 12:55:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:55:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:55:18 INFO - Python 2.7.3 12:55:18 INFO - Return code: 0 12:55:18 INFO - grabbing minidump binary from tooltool 12:55:18 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')]} 12:55:18 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 0x28a83b0>, '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 0x28a92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a9740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:55:18 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 12:55:18 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 12:55:18 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 12:55:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:55:18 INFO - Return code: 0 12:55:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:55:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:55:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:55:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:55:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:55:18 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/ZzXSWHxXTX6nznBB3pQQYA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 12:55:18 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/ZzXSWHxXTX6nznBB3pQQYA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 12:55:18 INFO - Using env: {'DISPLAY': ':0', 12:55:18 INFO - 'HOME': '/home/cltbld', 12:55:18 INFO - 'LANG': 'en_US.UTF-8', 12:55:18 INFO - 'LANGUAGE': 'en_US:en', 12:55:18 INFO - 'LOGNAME': 'cltbld', 12:55:18 INFO - 'MAIL': '/var/mail/cltbld', 12:55:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:55:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:55:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:18 INFO - 'MOZ_NO_REMOTE': '1', 12:55:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:55:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:18 INFO - 'NO_EM_RESTART': '1', 12:55:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:18 INFO - 'PWD': '/builds/slave/test', 12:55:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:55:18 INFO - 'SHELL': '/bin/bash', 12:55:18 INFO - 'SHLVL': '1', 12:55:18 INFO - 'TERM': 'linux', 12:55:18 INFO - 'TMOUT': '86400', 12:55:18 INFO - 'USER': 'cltbld', 12:55:18 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1468438645.862253-1582568016', 12:55:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:18 INFO - '_': '/tools/buildbot/bin/python'} 12:55:18 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/ZzXSWHxXTX6nznBB3pQQYA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 12:55:18 INFO - mozversion application_buildid: 20160713122141 12:55:18 INFO - mozversion application_changeset: a097b61f58102776941bd3fa0023092ac3f27a3f 12:55:18 INFO - mozversion application_display_name: Nightly 12:55:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:55:18 INFO - mozversion application_name: Firefox 12:55:18 INFO - mozversion application_remotingname: firefox 12:55:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:55:18 INFO - mozversion application_vendor: Mozilla 12:55:18 INFO - mozversion application_version: 50.0a1 12:55:18 INFO - mozversion platform_buildid: 20160713122141 12:55:18 INFO - mozversion platform_changeset: a097b61f58102776941bd3fa0023092ac3f27a3f 12:55:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:55:18 INFO - mozversion platform_version: 50.0a1 12:55:18 INFO - using testdate: 1468439718 12:55:18 INFO - actual date: 1468439718 12:55:18 INFO - starting webserver on 'localhost:44122' 12:55:18 INFO - SUITE-START | Running 2 tests 12:55:18 INFO - TEST-START | dromaeo_css 12:55:18 INFO - operating with platform_type : linux_ 12:55:18 INFO - Initialising browser for dromaeo_css test... 12:55:18 INFO - TEST-INFO | started process 7542 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8yjpGv/profile http://localhost:44122/getInfo.html) 12:55:23 INFO - PROCESS | 7542 | __metrics Screen width/height:1600/1200 12:55:23 INFO - PROCESS | 7542 | colorDepth:24 12:55:23 INFO - PROCESS | 7542 | Browser inner width/height: 1024/697 12:55:23 INFO - PROCESS | 7542 | __metrics 12:55:24 INFO - PROCESS | 7542 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:55:24 INFO - PROCESS | 7542 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:55:25 INFO - TEST-INFO | 7542: exit 0 12:55:25 INFO - Browser initialized. 12:55:25 INFO - Running cycle 1/1 for dromaeo_css test... 12:55:25 INFO - TEST-INFO | started process 7626 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8yjpGv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:55:37 INFO - PROCESS | 7626 | RSS: Main: 159145984 12:55:37 INFO - PROCESS | 7626 | 12:56:28 INFO - PROCESS | 7626 | 1468439788698 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] 12:58:40 INFO - PROCESS | 7626 | Cycle 1(1): loaded http://localhost:44122/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44122/tests/dromaeo/cssquery-ext.html) 12:58:42 INFO - PROCESS | 7626 | RSS: Main: 269127680 12:58:42 INFO - PROCESS | 7626 | 13:01:44 INFO - PROCESS | 7626 | Cycle 1(1): loaded http://localhost:44122/tests/dromaeo/cssquery-ext.html (next: http://localhost:44122/tests/dromaeo/cssquery-jquery.html) 13:01:45 INFO - PROCESS | 7626 | RSS: Main: 247005184 13:01:45 INFO - PROCESS | 7626 | 13:04:47 INFO - PROCESS | 7626 | Cycle 1(1): loaded http://localhost:44122/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44122/tests/dromaeo/cssquery-mootools.html) 13:04:48 INFO - PROCESS | 7626 | RSS: Main: 244899840 13:04:48 INFO - PROCESS | 7626 | 13:07:50 INFO - PROCESS | 7626 | Cycle 1(1): loaded http://localhost:44122/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44122/tests/dromaeo/cssquery-prototype.html) 13:07:51 INFO - PROCESS | 7626 | RSS: Main: 235720704 13:07:51 INFO - PROCESS | 7626 | 13:10:54 INFO - PROCESS | 7626 | Cycle 1(1): loaded http://localhost:44122/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44122/tests/dromaeo/cssquery-yui.html) 13:10:54 INFO - PROCESS | 7626 | RSS: Main: 233431040 13:10:54 INFO - PROCESS | 7626 | 13:13:57 INFO - PROCESS | 7626 | Cycle 1(1): loaded http://localhost:44122/tests/dromaeo/cssquery-yui.html (next: http://localhost:44122/tests/dromaeo/cssquery-dojo.html) 13:13:57 INFO - PROCESS | 7626 | RSS: Main: 294801408 13:13:57 INFO - PROCESS | 7626 | 13:13:57 INFO - PROCESS | 7626 | __start_tp_report 13:13:57 INFO - PROCESS | 7626 | _x_x_mozilla_page_load 13:13:57 INFO - PROCESS | 7626 | _x_x_mozilla_page_load_details 13:13:57 INFO - PROCESS | 7626 | |i|pagename|runs| 13:13:57 INFO - PROCESS | 7626 | |0;dojo.html;2575.5106529759346;2590.7409259074084;2620.0305886821875;2628.8422694638325;2631.763141317282;4435.489918659355;4467.553244675531;4596.609288210502;4628.328892310617;4629.213033784256;4530.297803840402;4535.863924082283;4551.7041392309475;4599.034202817404;4604.240300350447;4150.107726838722;4152.335626299792;4160.188763191179;4188.664906807463;4230.7250028748185;4232.957670423302;4247.511536173349;4310.353446982962;4347.152305300468;4352.455943007124;4135.77253251071;4181.247375472413;4278.807453664593;4300.3764454154125;4325.005248792764;4210.726302790309;4216.2199993001395;4220.261454245526;4221.704480686353;4225.04936389313;4192.098698779777;4193.874183774492;4194.979025104885;4199.139176468817;4199.223143718422;4525.343825145368;4547.363369128325;4553.658475614342;4564.771761411949;4567.543245675439;4820.39745031871;4867.050925069613;4869.902601947942;4870.464248932614;4871.293662418965;4905.681130726527;4921.064997650435;4955.90088198234;4967.90064198714;4969.701817890938;4405.295152775605;4504.054148628759;4575.58819706228;4575.9771201143785;4617.653675974316;5022.598192144693;5035.521625445577;5070.8225212117395;5079;5079.085764562415;4841.782119804618;4870.245112007645;4870.902581948341;4877.341558889575;4880.194767863334;4707.176244157259;4840.419149702058;4898.436679781799;4899;4961.578265847444;4859.1010663027455;4881.121398148296;4886.638129863909;4895.412550493964;4922.827701030446;4661.790219440133;4887.535684110004;4888;4904.558589726942;4933.531314525115;4043.332850079704;4080.755154690728;4126.793660317032;4130.235906357333;4138.8344466221015;3622.185008373095;3632.073821175636;3645.453182022718;3656.4149736042104;3670.9082272942856;4060.045889216032;4207.534607319923;4211.178820130045;4259.084296876186;4266.5093514246255;4753.857384278408;4811.615070794328;4866.659333846596;4871.293662419001;4871.48849370811;4152.91694166115;4161.83352665896;4164.06308580573;4208;4209.3896385024;4187.644050255702;4365.345198220292;4367.126574685076;4368.126374725004;4409.338599210144;4543.045960348364;4578.244589642672;4596.103759766947;4611.884702882455;4614.123316569841;4849.781759820887;4876.024795040935;4876.024795041077;4876.683015604116;4924.187509060965;4453.621442177451;4596.678232523691;4605.102005108972;4605.309203619484;4639.118567472169;4750.477447480844;4772.713637181641;4781.163296423181;4791.233402655558;4811.4707382188635;4852.902941941212;4861;4864.148773964613;4872.90254194907;4918.778654960463;4632.745199014086;4689.859304220879;4761.6428767843245;4769.284607308931;4820.9517904821905;4669.7431641260055;4733.952660473351;4774.76126193682;4788.401449818773;4801.9915817678675;4724.811007559659;4730.314104454766;4731.976340118277;4751.417084925268;4770.0936822003705;4621.537846215486;4712.59942904857;4776.259679749644;4819.084373968934;4864.489228631084;4680.7191568506;4700.412448443944;4704.647151463722;4736;4747.026859493726 13:13:57 INFO - PROCESS | 7626 | |1;ext.html;564.6724899558257;579.0445764488596;579.5624303650743;584.7251791657922;586.2788769813129;26971.32571685709;38302;40272.99999999996;40411.59588404115;44305.335419968724;41099.794501027456;41467.170656586924;41482.377764333556;41500.16999660005;41529.37705934406;7872.567008814527;8006.759797206093;8017.919820801776;8023.157568455286;8026.558539280337;7899.368050555941;7973.32226760726;7998.12020677725;7998.840023199533;8005.039395272546;8008.119106898236;8043.155468675793;8057.315128214109;8064.798380040487;8068.233517815798;8019.639116239754;8040.115587285394;8054.476459030145;8063.27430531255;8070.9192908071045;7905.2490013449205;7966.880496792553;7968.7609371718945;7975.2423519765525;7978.481398709066;39007.21985560273;39464.40803387952;39488.40767388463;39527.604723952965;39579.20841583152;2731.207949694586;2956.911292661224;3093.6442309134513;3175.301433684586;3571.2143328467696;29441.411171776657;29893;30070;30120;30353.848230758704;2755.5040092783292;2787.693353731088;2788.3029242689327;2791.6650001999687;2877.6115224444643;257874;258221;258334;258952;259119.9999999981;31355.68644313573;32496.675033249365;32517;53173.202401964;53534.464655353724;33694.3261134776;33712.325753484794;33790;33792.1551961198;33804.32391352209;13602.319884005958;13803.447862085604;13845.515406960909;13848.515301964584;13849.238291894042;11456.369899655432;11479.25384849982;11488.195826292247;11542.711432214093;11570.247933884439;7924.167962363984;7945.523268603903;7981.68073277074;8049.879251811228;8051.919480805234;3151.936961260762;3152.7793054485965;3168.366326734616;3172.095952653529;3190.760692948038;796.9083555391088;819.5656302159865;835.2065537739172;887.9911200888038;933.1881263300836;27338.863305683346;27735;27818;28181;28211;766.6703317573497;920.4523308631353;962.20617990157;978.7650963768644;1010.8483727440943;14773.778393324108;14850.331735071948;14855.108693478425;15005.549833505012;15041.623959401102;378496;378527;382254;384925;386543;50041.74979125081;50706.23940640893;50718.239226411635;50745.23882141771;50811;1069.1286601419818;1101.515333253366;1156.392893730798;1164.1967042740482;1211.249025604131;26671.599926000737;29505.557416639196;29556.261093472836;30261.697383025887;30272.5459118109;42396.5760342405;42783.35824962566;42943.57056429396;42964;42964.570354297306;304497;307355;307377;308235;308437;22488.66267006029;24253.151139710026;25241.495170096863;25255.242342729747;25279.11523096683;41366.793166033975;41629.16741665089;42745.35881961711;42995.78502107469;43415.56584434242;36107.55569777179;36672.63327366692;37295.44056839095;37412.43881341837;37514.624853752204;36609.633903661685;36714.4492832613;37020;37150.44274335833;37805.62194378021;35527.11182220465;35693.28613427769;35799.10502237465;36432.63567364292;37429.812850935574;32522.67477325291;33264.54230648086;33682.831585841916;33683.452733880615;33824;25795;26202.213933582025;26303.73696263013;26398.736012639627;26877.193684189504 13:13:57 INFO - PROCESS | 7626 | |2;jquery.html;361.20534823388545;366.68098754083945;369.12149085177276;381.3669308947148;389.6901962939465;16463.695082688417;17379.30482780689;18242.908785456086;18254.087295635214;18265.634687306247;16092.1953902305;16603.335866565354;16741.748873766905;16844.915775421137;16952.576185595368;5070.79716811328;5250.684958902478;5288.048151332759;5288.233206185101;5290.365156181264;3818.885433437001;3997.320455522568;5153.845384638448;5865.706714664271;6182.659953702545;6147.446729794317;6240.656763877985;6251.499880009611;6258.06129080637;6262.530310226728;5885.529157667376;6194.65929373882;6195.256569211679;6202.8449288767915;6203.87592248157;3465.480177973299;5186.455422180692;5367.758450869681;5479.068558345051;5490.670559766387;22228.666570001464;22421.215257465912;22489.775102248932;23565.646515302284;23781.286561403187;1830.3685228596114;1859.665260253154;1893.6307420053095;1916.8849869007904;2247.898844551999;13824.861751382457;14790.778138327934;14892.180930048842;15142.394304227817;15699.136547489883;1693.6866679664179;1745.8952462852142;1760.505396787376;1768.7170052791491;1812.5831058856404;75594.24405755928;80834;82929.58535207286;83467.16532834654;83480;16419.507414777574;16941;16977.132515423295;17032.48902532926;17211.762470878704;29450.263743406158;29707.257318567208;30016.39967200644;30051.849740751593;30054.84972575167;8266;8500.44747091437;8551.102134275936;8610.311175105977;8628.697995570124;6937.7224911002995;6953.478489113337;6978.302169782981;7089.14930208368;7102.467314951399;8288.668453261922;8568.785780355416;8645.221930026202;8677.913220867711;8788.78028049291;2626.7110617832022;2998.7001299870276;3222.726068284222;3391.033555436689;3397.1676939150066;714.5284112485734;786.598834594361;786.8937693411316;813.0934008580508;828.6643909216776;16421.507354779376;17311;17383.826161738474;17634;17738.467845964642;788.5505262000719;836;843.2495079379357;863.5941107679381;868.3964644571962;9385.57764900581;9795.853062204073;9813.067758562926;9853.655122070693;9886.505674716236;349678;352953;353296;356214;356801;78460.21539784643;78575.60712196403;79473.20526794659;79747;80001;829.3613917283778;853.8463076646264;870.3341943413294;878.1613559051091;878.5826732302233;12058.974987126192;15696.92151539235;16031.919840400724;16666.58333541671;16818.66362672764;38547;38558;38579.42130867983;38796.61203388043;39073.41389879211;47472.7626361866;49515.50484495109;49744.75127624339;49934.250986235966;50033.24950125824;7121.252268511939;7314.670839812327;7343.742968996059;7360.411167106511;7433.145188303414;9006.59470323824;10709.410982396043;10745.516451759533;11166.16253780986;11359.261647992855;9609.375390599589;9632.662856799978;9732.318737688576;9739.707808765748;9909.851352229867;9417.340786144903;9472.336936414385;9534.189593884597;9580.95209523948;9821.214302855897;9720.222382209548;9737.805243895224;9799.167070799062;9922.702318930444;10001.849972250568;7218.27817218274;7281.308275713799;7415.073115860518;7422.591757453176;7483.32650061497;8660.523671198145;9599.47202903847;9732.854007189757;9821.950890245504;9938.602455901682 13:13:57 INFO - PROCESS | 7626 | |3;mootools.html;1380.2201756007858;1411.4706984880668;1503.7819516170155;1683.2593658790124;1729.3428497171064;7720.498167619108;8192.7951801205;8223.465474744153;8249.340052795777;8260.967379077616;6697.866042679144;6795.184577850652;7641.961790191055;7811.609419529029;8063.435559510836;2194.890255487227;2217.2239716099316;2224.899879505418;2226.1651880544796;2227.4765430123907;2172.73927128744;2205.151016858505;2265.263789268486;2266.320103968811;2268.5803126421583;1855.0539224995282;2174.749903761064;2232.9888350558226;2235.865848049114;2270.0579259607243;2214.9889250553806;2219.7447293561286;2237.955240895189;2238.7089678341713;2241.1483636218295;2231.5871563760757;2232.8213742900693;2238.0712004518105;2238.9888050559643;2241.6525438556887;8149.103598604149;8200.302974247195;8219.383546234056;8224.465409748347;8225.95887020567;4554.931676024862;4602.401687780601;4732.195526760459;4737.431508219001;4745.715257084586;2576.254708956131;2591.935201619956;2646.8411895286345;2658.1095333063445;2659.946801063987;834.407570624857;836.7071524966274;852.4927668037508;853.5433543054498;854.9444286121383;11070.667879963614;11107.444627768578;11119.332840029625;11119.610813621484;11120.666380008613;4076;4213.199492096492;4308.009157893639;4360.215161271001;4361;9499.525023748785;9530.285228607881;9546.665866694633;9546.856797148048;9548.809023819624;4737.38414006177;4751.311059896296;4751.548602882721;4751.738654373973;4753.904921901542;4091.2226676931286;4296.613304802583;4320.265554855682;4322.135572885435;4325.070109926381;3441.587009558819;3444.328355970612;3451.6548345165284;3510.64893510652;3533.593636731757;934.5233930695258;1078.094400703413;1083.967480975572;1087.075985412409;1088.7588149509565;629.9275583307979;667.7829705345782;671.8992151177363;751.2825251884437;818.1613845808095;5095.923561146586;5529.834104976857;5586;5750.396208398058;5781.5952883298605;792.298815548244;835.9456635318685;855.8373908957278;869.3957699398984;883.3110174064241;3549.680528752425;3574.7318951078773;3713.5729391119826;3723.0506220913494;3777.33896568105;9269.953650231706;9787.510624468749;9800.82390113191;9874.210063194927;9888.110070093726;8268.669253229924;9801.411915285105;9807.75480612976;9825.312228143961;9827.803443931225;7212.531185472927;7497.325240728361;7502.84994300111;7728.149903510609;7729.652165652559;5300.893982120413;5404.243405923253;5553.750081246434;5594.992901277809;5695.202671625892;9047.230985366054;9265.861012084959;9422.19911307519;9426.575804088696;9438.85841712361;9215.078492150731;9435.716928492157;9474;9530.571124299284;9608.75978100525;6537.477001839937;6622.304658010839;6646.202455705153;6663.800085997428;6679.732810687518;7419.29516695913;7594.050743657043;7671.53970761756;7675.731349402744;7677.385809135144;6649.567778094409;6735.25912149673;6909.654517274217;6975.720971161097;7014.333638304353;6577.375149360803;6604.966975165094;6630.569013014138;6868.381845633717;6871.347222013901;6514.4788416925585;6581.6709164542535;6646.335366463315;6714.563553369016;6738.191417029988;4624.398828152319;4651.883702907319;4681.555252251031;4715.552022557851;4746.691465054899;4488.259437192826;4536.160810250114;4582.473015603248;4617.422822147231;4635.096156249499 13:13:57 INFO - PROCESS | 7626 | |4;prototype.html;290.3698973228093;297.89275860690157;304.47326125802374;304.82015610789637;305.7859498351155;4673.369095172151;4763.928541071878;4815.8796030099265;4838.419389673235;4855.878603034921;4587.151376995258;4725.267583524551;4742.881427964294;4758.214894542405;4770.904581908359;3778.394182472452;3782.451544526042;3787.20468701573;3790.2798468291076;3798.6771124454385;3626.9455958160647;3711.2391959648344;3795.8861234162882;3825.215830754689;3830.616938306175;3664.5602527696715;3750.1187221003042;3777.9811100944457;3797.7721336719746;3804.9239015219678;3739.551253849528;3746.3256613809504;3763.5510328523715;3763.9247215055684;3770.811459427018;3342.1143396999814;3345.916352091193;3354.76516643835;3362.310726301127;3375.970329049639;4537.137943790669;4663.9766801166115;4679.719216847;4683.648726345537;4734.644901632357;4317.136572685444;4324.767441279252;4325.3079507279;4340.133742490728;4350.2387082260475;4819.783109760034;4982.82560110398;4982.956987635052;4992.375953005874;5008.620905070099;3591.8506078055034;3599.6040435552068;3606.891793246207;3615.0600843780544;3623.836927338276;5262.631615786858;5283.709395983219;5288.233206185082;5311.123664595337;5315.867103322409;3702.889133260011;3705.9814700926863;3715;3715.9442608360896;3717.368047431943;3655.61616030313;3722.2927643747603;3726.2547490502006;3729.9440508392395;3754.1365485938386;4210.221109094766;4233.322668373107;4240.936385954213;4247;4261.914761704748;5032.496750324938;5042.369703787027;5043.36957880265;5045.965577056694;5047.369078865142;1193.7254431480808;1212.7392610588765;1269.041873385588;1273.1666400383417;1293.6507143071317;866.5667166416791;887.8179973105498;890.2121622364125;890.8708237305555;894.0433735902652;4422.955770442319;4448.710833795858;4448.799804008762;4456.64346852251;4462.843800467033;5115.232715092766;5155.407128180233;5157.510036546597;5157.974210128926;5194;4269.295566231537;4385.539518350591;4408.853698038533;4430.689851710349;4450.488193857683;2409.5663080467093;2424.3454267347715;2450.6814114165045;2453.8650374229587;2458.655788189619;4300.311950087971;4309.095090031128;4321.395004699345;4363.759993200404;4364.6290065344165;4333.569921925757;4627.7143228307605;4632.814687412466;4662.6269898408045;4676.55572720591;4262.808173632194;4316.848910288125;4336.978315108404;4342.196693611692;4356.82365761249;4526.909461810811;4547.839776106323;4566.566176213254;4584.083183363274;4637.701443595799;4170.812313445842;4456.509783923831;4480.283154695233;4483.327500874895;4502.45970483531;4268.039691069484;4295.892602684958;4328.420126653686;4340.131973605355;4370.278903980808;3337.0489410517885;3339.282054358325;3380.5267262582765;3476.878309259164;3540.451230059345;5122.975404918957;5126.231065340229;5144.151215049475;5153.7165455900285;5161.277421161116;4979.555928780613;4987.775550100182;4992.80028798844;5007.574356179765;5011.924821127613;4790.77835152034;4970.975145124251;4991.800327986985;5010.69935803853;5074.746262686925;4969.82605608802;4987.3017777511905;4987.800487980585;4995.375578052744;5009.5491405773655;5080.806010587583;5084.847454576368;5099.949000509948;5105.438401775876;5105.744712764273;4766.3327134200545;4981.37732783402;4982.62630302736;4985.52637499437;5007.69953802773 13:13:57 INFO - PROCESS | 7626 | |5;yui.html;588.3369117247846;602.32840382973;616.7440512187443;660.5275294187654;677.7560078371786;13326;13711.10877792944;13823.447062117502;13832.515861944834;13899.791503127435;13733.93133034336;13769.793453098211;13875.30623468825;13904.58286251414;13914.721705565882;639.0733436517046;764.4075841223068;781.820181358288;803.0483876606211;806.8628333183343;789.3803364358979;810.6473683947472;811.0267678785451;811.6469335838929;811.8011087283594;841.6002398860553;845.2815107158897;845.6363763581658;846.3102571404316;846.3736834742277;655.5673255651247;794.4121350200868;817.8691409374532;838.6226198210799;839.6851180807228;603.7977277612006;604.8185544336682;605.05913304811;605.1255935173632;605.5579427018301;13583.660408489768;13599.524016659469;13612.115212511155;13618.18290902549;13620.863791362059;12493.625191244277;13006.219626822422;13036.674083147996;13123.868761312455;13468.93265533676;10570.15438764897;10600.628977985734;10886.782264354668;10957.726056848564;11166.553337866475;4066.5323487798987;4134.297169481196;4140.130572579762;4144.834206631731;4223.577642235782;58691;58765.41234587642;58825.41174588242;58897.705511472595;62644;9752.707418777449;9832.754181145385;9963.551640176209;10035.096841284174;10195;18321.908390457964;18388.816111838976;18415.26338946454;18435.815641843677;18829.152688129067;6334.651594162273;6558.278589355167;6623.834404139935;6633.104530888365;6737.191537015589;3439.8452069656423;3494.4583589543663;3522.4188008978745;3688.9262214755554;3721.906952326159;2716.687580928179;2816.1973837456226;2832.872520736572;2834.5039618066758;2838.929026774306;484.5227450960801;486.9780859861315;489.60586727683847;494.3968358602499;503.6373810856178;365.98902032939054;392.09817419934035;442.1267995708514;454.8317122664635;455.4875764764574;6930.861382772317;6978.81573119812;7258.564486130849;7599.734009309647;7945.1657575953695;465.8276437718066;488.44073535802016;505.6662602682212;507.11761534929695;519.2626470412024;3514.947275790865;3559.768615040014;3601.513795637608;3624.220792529619;3655.8903232903053;88363;92204.53897730468;92950.53524732334;93228.53385733027;96101;67282.66358668273;76982;82385.58807206046;82675.5866220665;83312.16687833166;43162.784186079494;45450.77274613672;62951.685241574414;63541.36458635354;76009.23990760022;7887.763367098996;8035.678572857254;8054.516728996279;8150.388720845842;8294;42921;45491.09017819559;45996;47448.762756186;47451.76274118746;65913.67043164754;68433;69039.65480172567;69289.30710692829;69555.65222173856;10257.32897401833;10332.380057196593;10393.9480302598;10968.23222374426;10978.341299521735;12456.626301210978;12763.361831908182;13008;13063.150895191782;13066.869331306565;8533.487990720576;8639.740807775777;10016.799664006534;10572.471376431302;10962.725931851768;9761.951190244003;9904.950475247577;10167.237457190593;10761.784764304826;11163.051140652811;10419.322744021614;10635.680929572125;10828.729281768019;11078.889211107786;11299.09607231403;9672.70981870545;9892.661729970047;10072.143867771321;10322.432266225429;10511.73720656959;8919.687810926587;9017.188453039258;9286.674966376144;9488.136113877463;9984.950075249868 13:13:57 INFO - PROCESS | 7626 | __end_tp_report 13:13:57 INFO - PROCESS | 7626 | __start_cc_report 13:13:57 INFO - PROCESS | 7626 | _x_x_mozilla_cycle_collect,1009 13:13:57 INFO - PROCESS | 7626 | __end_cc_report 13:13:57 INFO - PROCESS | 7626 | __startTimestamp1468440837895__endTimestamp 13:13:57 INFO - PROCESS | 7626 | 13:13:57 INFO - PROCESS | 7626 | ------- Summary: start ------- 13:13:57 INFO - PROCESS | 7626 | Number of tests: 6 13:13:57 INFO - PROCESS | 7626 | 13:13:57 INFO - PROCESS | 7626 | [#0] dojo.html Cycles:165 Average:4514.91 Median:4621.54 stddev:465.48 (10.1%) stddev-sans-first:441.34 13:13:57 INFO - PROCESS | 7626 | Values: 2575.5 2590.7 2620.0 2628.8 2631.8 4435.5 4467.6 4596.6 4628.3 4629.2 4530.3 4535.9 4551.7 4599.0 4604.2 4150.1 4152.3 4160.2 4188.7 4230.7 4233.0 4247.5 4310.4 4347.2 4352.5 4135.8 4181.2 4278.8 4300.4 4325.0 4210.7 4216.2 4220.3 4221.7 4225.0 4192.1 4193.9 4195.0 4199.1 4199.2 4525.3 4547.4 4553.7 4564.8 4567.5 4820.4 4867.1 4869.9 4870.5 4871.3 4905.7 4921.1 4955.9 4967.9 4969.7 4405.3 4504.1 4575.6 4576.0 4617.7 5022.6 5035.5 5070.8 5079.0 5079.1 4841.8 4870.2 4870.9 4877.3 4880.2 4707.2 4840.4 4898.4 4899.0 4961.6 4859.1 4881.1 4886.6 4895.4 4922.8 4661.8 4887.5 4888.0 4904.6 4933.5 4043.3 4080.8 4126.8 4130.2 4138.8 3622.2 3632.1 3645.5 3656.4 3670.9 4060.0 4207.5 4211.2 4259.1 4266.5 4753.9 4811.6 4866.7 4871.3 4871.5 4152.9 4161.8 4164.1 4208.0 4209.4 4187.6 4365.3 4367.1 4368.1 4409.3 4543.0 4578.2 4596.1 4611.9 4614.1 4849.8 4876.0 4876.0 4876.7 4924.2 4453.6 4596.7 4605.1 4605.3 4639.1 4750.5 4772.7 4781.2 4791.2 4811.5 4852.9 4861.0 4864.1 4872.9 4918.8 4632.7 4689.9 4761.6 4769.3 4821.0 4669.7 4734.0 4774.8 4788.4 4802.0 4724.8 4730.3 4732.0 4751.4 4770.1 4621.5 4712.6 4776.3 4819.1 4864.5 4680.7 4700.4 4704.6 4736.0 4747.0 13:13:57 INFO - PROCESS | 7626 | 13:13:57 INFO - PROCESS | 7626 | [#1] ext.html Cycles:180 Average:46090.47 Median:36641.13 stddev:84323.52 (230.1%) stddev-sans-first:84490.79 13:13:57 INFO - PROCESS | 7626 | Values: 564.7 579.0 579.6 584.7 586.3 26971.3 38302.0 40273.0 40411.6 44305.3 41099.8 41467.2 41482.4 41500.2 41529.4 7872.6 8006.8 8017.9 8023.2 8026.6 7899.4 7973.3 7998.1 7998.8 8005.0 8008.1 8043.2 8057.3 8064.8 8068.2 8019.6 8040.1 8054.5 8063.3 8070.9 7905.2 7966.9 7968.8 7975.2 7978.5 39007.2 39464.4 39488.4 39527.6 39579.2 2731.2 2956.9 3093.6 3175.3 3571.2 29441.4 29893.0 30070.0 30120.0 30353.8 2755.5 2787.7 2788.3 2791.7 2877.6 257874.0 258221.0 258334.0 258952.0 259120.0 31355.7 32496.7 32517.0 53173.2 53534.5 33694.3 33712.3 33790.0 33792.2 33804.3 13602.3 13803.4 13845.5 13848.5 13849.2 11456.4 11479.3 11488.2 11542.7 11570.2 7924.2 7945.5 7981.7 8049.9 8051.9 3151.9 3152.8 3168.4 3172.1 3190.8 796.9 819.6 835.2 888.0 933.2 27338.9 27735.0 27818.0 28181.0 28211.0 766.7 920.5 962.2 978.8 1010.8 14773.8 14850.3 14855.1 15005.5 15041.6 378496.0 378527.0 382254.0 384925.0 386543.0 50041.7 50706.2 50718.2 50745.2 50811.0 1069.1 1101.5 1156.4 1164.2 1211.2 26671.6 29505.6 29556.3 30261.7 30272.5 42396.6 42783.4 42943.6 42964.0 42964.6 304497.0 307355.0 307377.0 308235.0 308437.0 22488.7 24253.2 25241.5 25255.2 25279.1 41366.8 41629.2 42745.4 42995.8 43415.6 36107.6 36672.6 37295.4 37412.4 37514.6 36609.6 36714.4 37020.0 37150.4 37805.6 35527.1 35693.3 35799.1 36432.6 37429.8 32522.7 33264.5 33682.8 33683.5 33824.0 25795.0 26202.2 26303.7 26398.7 26877.2 13:13:57 INFO - PROCESS | 7626 | 13:13:57 INFO - PROCESS | 7626 | [#2] jquery.html Cycles:180 Average:24698.11 Median:5423.41 stddev:58890.43 (1085.9%) stddev-sans-first:59027.28 13:13:57 INFO - PROCESS | 7626 | Values: 361.2 366.7 369.1 381.4 389.7 16463.7 17379.3 18242.9 18254.1 18265.6 16092.2 16603.3 16741.7 16844.9 16952.6 5070.8 5250.7 5288.0 5288.2 5290.4 3818.9 3997.3 5153.8 5865.7 6182.7 6147.4 6240.7 6251.5 6258.1 6262.5 5885.5 6194.7 6195.3 6202.8 6203.9 3465.5 5186.5 5367.8 5479.1 5490.7 22228.7 22421.2 22489.8 23565.6 23781.3 1830.4 1859.7 1893.6 1916.9 2247.9 13824.9 14790.8 14892.2 15142.4 15699.1 1693.7 1745.9 1760.5 1768.7 1812.6 75594.2 80834.0 82929.6 83467.2 83480.0 16419.5 16941.0 16977.1 17032.5 17211.8 29450.3 29707.3 30016.4 30051.8 30054.8 8266.0 8500.4 8551.1 8610.3 8628.7 6937.7 6953.5 6978.3 7089.1 7102.5 8288.7 8568.8 8645.2 8677.9 8788.8 2626.7 2998.7 3222.7 3391.0 3397.2 714.5 786.6 786.9 813.1 828.7 16421.5 17311.0 17383.8 17634.0 17738.5 788.6 836.0 843.2 863.6 868.4 9385.6 9795.9 9813.1 9853.7 9886.5 349678.0 352953.0 353296.0 356214.0 356801.0 78460.2 78575.6 79473.2 79747.0 80001.0 829.4 853.8 870.3 878.2 878.6 12059.0 15696.9 16031.9 16666.6 16818.7 38547.0 38558.0 38579.4 38796.6 39073.4 47472.8 49515.5 49744.8 49934.3 50033.2 7121.3 7314.7 7343.7 7360.4 7433.1 9006.6 10709.4 10745.5 11166.2 11359.3 9609.4 9632.7 9732.3 9739.7 9909.9 9417.3 9472.3 9534.2 9581.0 9821.2 9720.2 9737.8 9799.2 9922.7 10001.8 7218.3 7281.3 7415.1 7422.6 7483.3 8660.5 9599.5 9732.9 9822.0 9938.6 13:13:57 INFO - PROCESS | 7626 | 13:13:57 INFO - PROCESS | 7626 | [#3] mootools.html Cycles:180 Average:5235.40 Median:5645.10 stddev:2989.24 (53.0%) stddev-sans-first:2983.59 13:13:57 INFO - PROCESS | 7626 | Values: 1380.2 1411.5 1503.8 1683.3 1729.3 7720.5 8192.8 8223.5 8249.3 8261.0 6697.9 6795.2 7642.0 7811.6 8063.4 2194.9 2217.2 2224.9 2226.2 2227.5 2172.7 2205.2 2265.3 2266.3 2268.6 1855.1 2174.7 2233.0 2235.9 2270.1 2215.0 2219.7 2238.0 2238.7 2241.1 2231.6 2232.8 2238.1 2239.0 2241.7 8149.1 8200.3 8219.4 8224.5 8226.0 4554.9 4602.4 4732.2 4737.4 4745.7 2576.3 2591.9 2646.8 2658.1 2659.9 834.4 836.7 852.5 853.5 854.9 11070.7 11107.4 11119.3 11119.6 11120.7 4076.0 4213.2 4308.0 4360.2 4361.0 9499.5 9530.3 9546.7 9546.9 9548.8 4737.4 4751.3 4751.5 4751.7 4753.9 4091.2 4296.6 4320.3 4322.1 4325.1 3441.6 3444.3 3451.7 3510.6 3533.6 934.5 1078.1 1084.0 1087.1 1088.8 629.9 667.8 671.9 751.3 818.2 5095.9 5529.8 5586.0 5750.4 5781.6 792.3 835.9 855.8 869.4 883.3 3549.7 3574.7 3713.6 3723.1 3777.3 9270.0 9787.5 9800.8 9874.2 9888.1 8268.7 9801.4 9807.8 9825.3 9827.8 7212.5 7497.3 7502.8 7728.1 7729.7 5300.9 5404.2 5553.8 5595.0 5695.2 9047.2 9265.9 9422.2 9426.6 9438.9 9215.1 9435.7 9474.0 9530.6 9608.8 6537.5 6622.3 6646.2 6663.8 6679.7 7419.3 7594.1 7671.5 7675.7 7677.4 6649.6 6735.3 6909.7 6975.7 7014.3 6577.4 6605.0 6630.6 6868.4 6871.3 6514.5 6581.7 6646.3 6714.6 6738.2 4624.4 4651.9 4681.6 4715.6 4746.7 4488.3 4536.2 4582.5 4617.4 4635.1 13:13:57 INFO - PROCESS | 7626 | 13:13:57 INFO - PROCESS | 7626 | [#4] prototype.html Cycles:180 Average:4068.15 Median:4426.82 stddev:1172.10 (26.5%) stddev-sans-first:1140.58 13:13:57 INFO - PROCESS | 7626 | Values: 290.4 297.9 304.5 304.8 305.8 4673.4 4763.9 4815.9 4838.4 4855.9 4587.2 4725.3 4742.9 4758.2 4770.9 3778.4 3782.5 3787.2 3790.3 3798.7 3626.9 3711.2 3795.9 3825.2 3830.6 3664.6 3750.1 3778.0 3797.8 3804.9 3739.6 3746.3 3763.6 3763.9 3770.8 3342.1 3345.9 3354.8 3362.3 3376.0 4537.1 4664.0 4679.7 4683.6 4734.6 4317.1 4324.8 4325.3 4340.1 4350.2 4819.8 4982.8 4983.0 4992.4 5008.6 3591.9 3599.6 3606.9 3615.1 3623.8 5262.6 5283.7 5288.2 5311.1 5315.9 3702.9 3706.0 3715.0 3715.9 3717.4 3655.6 3722.3 3726.3 3729.9 3754.1 4210.2 4233.3 4240.9 4247.0 4261.9 5032.5 5042.4 5043.4 5046.0 5047.4 1193.7 1212.7 1269.0 1273.2 1293.7 866.6 887.8 890.2 890.9 894.0 4423.0 4448.7 4448.8 4456.6 4462.8 5115.2 5155.4 5157.5 5158.0 5194.0 4269.3 4385.5 4408.9 4430.7 4450.5 2409.6 2424.3 2450.7 2453.9 2458.7 4300.3 4309.1 4321.4 4363.8 4364.6 4333.6 4627.7 4632.8 4662.6 4676.6 4262.8 4316.8 4337.0 4342.2 4356.8 4526.9 4547.8 4566.6 4584.1 4637.7 4170.8 4456.5 4480.3 4483.3 4502.5 4268.0 4295.9 4328.4 4340.1 4370.3 3337.0 3339.3 3380.5 3476.9 3540.5 5123.0 5126.2 5144.2 5153.7 5161.3 4979.6 4987.8 4992.8 5007.6 5011.9 4790.8 4971.0 4991.8 5010.7 5074.7 4969.8 4987.3 4987.8 4995.4 5009.5 5080.8 5084.8 5099.9 5105.4 5105.7 4766.3 4981.4 4982.6 4985.5 5007.7 13:13:57 INFO - PROCESS | 7626 | 13:13:57 INFO - PROCESS | 7626 | [#5] yui.html Cycles:180 Average:17012.76 Median:487.71 stddev:23954.18 (4911.6%) stddev-sans-first:23989.63 13:13:57 INFO - PROCESS | 7626 | Values: 588.3 602.3 616.7 660.5 677.8 13326.0 13711.1 13823.4 13832.5 13899.8 13733.9 13769.8 13875.3 13904.6 13914.7 639.1 764.4 781.8 803.0 806.9 789.4 810.6 811.0 811.6 811.8 841.6 845.3 845.6 846.3 846.4 655.6 794.4 817.9 838.6 839.7 603.8 604.8 605.1 605.1 605.6 13583.7 13599.5 13612.1 13618.2 13620.9 12493.6 13006.2 13036.7 13123.9 13468.9 10570.2 10600.6 10886.8 10957.7 11166.6 4066.5 4134.3 4140.1 4144.8 4223.6 58691.0 58765.4 58825.4 58897.7 62644.0 9752.7 9832.8 9963.6 10035.1 10195.0 18321.9 18388.8 18415.3 18435.8 18829.2 6334.7 6558.3 6623.8 6633.1 6737.2 3439.8 3494.5 3522.4 3688.9 3721.9 2716.7 2816.2 2832.9 2834.5 2838.9 484.5 487.0 489.6 494.4 503.6 366.0 392.1 442.1 454.8 455.5 6930.9 6978.8 7258.6 7599.7 7945.2 465.8 488.4 505.7 507.1 519.3 3514.9 3559.8 3601.5 3624.2 3655.9 88363.0 92204.5 92950.5 93228.5 96101.0 67282.7 76982.0 82385.6 82675.6 83312.2 43162.8 45450.8 62951.7 63541.4 76009.2 7887.8 8035.7 8054.5 8150.4 8294.0 42921.0 45491.1 45996.0 47448.8 47451.8 65913.7 68433.0 69039.7 69289.3 69555.7 10257.3 10332.4 10393.9 10968.2 10978.3 12456.6 12763.4 13008.0 13063.2 13066.9 8533.5 8639.7 10016.8 10572.5 10962.7 9762.0 9905.0 10167.2 10761.8 11163.1 10419.3 10635.7 10828.7 11078.9 11299.1 9672.7 9892.7 10072.1 10322.4 10511.7 8919.7 9017.2 9286.7 9488.1 9985.0 13:13:57 INFO - PROCESS | 7626 | -------- Summary: end -------- 13:13:57 INFO - PROCESS | 7626 | 13:13:58 INFO - TEST-INFO | 7626: exit 0 13:13:58 INFO - TEST-OK | dromaeo_css | took 1119782ms 13:13:58 INFO - TEST-START | kraken 13:13:58 INFO - operating with platform_type : linux_ 13:13:58 INFO - Initialising browser for kraken test... 13:13:58 INFO - TEST-INFO | started process 7816 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw4K9Cn/profile http://localhost:44122/getInfo.html) 13:14:02 INFO - PROCESS | 7816 | __metrics Screen width/height:1600/1200 13:14:02 INFO - PROCESS | 7816 | colorDepth:24 13:14:02 INFO - PROCESS | 7816 | Browser inner width/height: 1024/697 13:14:02 INFO - PROCESS | 7816 | __metrics 13:14:03 INFO - PROCESS | 7816 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:14:03 INFO - PROCESS | 7816 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:14:04 INFO - PROCESS | 7816 | console.error: PushService: 13:14:04 INFO - PROCESS | 7816 | stateChangeProcessEnqueue: Error transitioning state 13:14:04 INFO - PROCESS | 7816 | UnknownError 13:14:04 INFO - TEST-INFO | 7816: exit 0 13:14:04 INFO - Browser initialized. 13:14:04 INFO - Running cycle 1/1 for kraken test... 13:14:04 INFO - TEST-INFO | started process 7897 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw4K9Cn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:14:16 INFO - PROCESS | 7897 | RSS: Main: 159121408 13:14:16 INFO - PROCESS | 7897 | 13:14:19 INFO - PROCESS | 7897 | Cycle 1(1): loaded http://localhost:44122/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44122/tests/kraken/driver.html?testName=audio-beat-detection) 13:14:20 INFO - PROCESS | 7897 | RSS: Main: 217841664 13:14:20 INFO - PROCESS | 7897 | 13:14:23 INFO - PROCESS | 7897 | Cycle 1(1): loaded http://localhost:44122/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44122/tests/kraken/driver.html?testName=audio-dft) 13:14:23 INFO - PROCESS | 7897 | RSS: Main: 203468800 13:14:23 INFO - PROCESS | 7897 | 13:14:27 INFO - PROCESS | 7897 | Cycle 1(1): loaded http://localhost:44122/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44122/tests/kraken/driver.html?testName=audio-fft) 13:14:27 INFO - PROCESS | 7897 | RSS: Main: 271495168 13:14:27 INFO - PROCESS | 7897 | 13:14:29 INFO - PROCESS | 7897 | Cycle 1(1): loaded http://localhost:44122/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44122/tests/kraken/driver.html?testName=audio-oscillator) 13:14:30 INFO - PROCESS | 7897 | RSS: Main: 182222848 13:14:30 INFO - PROCESS | 7897 | 13:14:32 INFO - PROCESS | 7897 | Cycle 1(1): loaded http://localhost:44122/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44122/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:14:33 INFO - PROCESS | 7897 | RSS: Main: 186544128 13:14:33 INFO - PROCESS | 7897 | 13:14:36 INFO - PROCESS | 7897 | Cycle 1(1): loaded http://localhost:44122/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44122/tests/kraken/driver.html?testName=imaging-darkroom) 13:14:37 INFO - PROCESS | 7897 | RSS: Main: 222023680 13:14:37 INFO - PROCESS | 7897 | 13:14:40 INFO - PROCESS | 7897 | Cycle 1(1): loaded http://localhost:44122/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44122/tests/kraken/driver.html?testName=imaging-desaturate) 13:14:41 INFO - PROCESS | 7897 | RSS: Main: 217628672 13:14:41 INFO - PROCESS | 7897 | 13:14:44 INFO - PROCESS | 7897 | Cycle 1(1): loaded http://localhost:44122/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44122/tests/kraken/driver.html?testName=json-parse-financial) 13:14:44 INFO - PROCESS | 7897 | RSS: Main: 220450816 13:14:44 INFO - PROCESS | 7897 | 13:14:46 INFO - PROCESS | 7897 | Cycle 1(1): loaded http://localhost:44122/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44122/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:14:47 INFO - PROCESS | 7897 | RSS: Main: 205574144 13:14:47 INFO - PROCESS | 7897 | 13:14:48 INFO - PROCESS | 7897 | Cycle 1(1): loaded http://localhost:44122/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44122/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:14:49 INFO - PROCESS | 7897 | RSS: Main: 210518016 13:14:49 INFO - PROCESS | 7897 | 13:14:51 INFO - PROCESS | 7897 | Cycle 1(1): loaded http://localhost:44122/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44122/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:14:52 INFO - PROCESS | 7897 | RSS: Main: 211615744 13:14:52 INFO - PROCESS | 7897 | 13:14:55 INFO - PROCESS | 7897 | Cycle 1(1): loaded http://localhost:44122/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44122/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:14:55 INFO - PROCESS | 7897 | RSS: Main: 223002624 13:14:55 INFO - PROCESS | 7897 | 13:14:58 INFO - PROCESS | 7897 | Cycle 1(1): loaded http://localhost:44122/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44122/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:14:59 INFO - PROCESS | 7897 | RSS: Main: 224915456 13:14:59 INFO - PROCESS | 7897 | 13:15:00 INFO - PROCESS | 7897 | Cycle 1(1): loaded http://localhost:44122/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44122/tests/kraken/driver.html?testName=ai-astar) 13:15:01 INFO - PROCESS | 7897 | RSS: Main: 267190272 13:15:01 INFO - PROCESS | 7897 | 13:15:01 INFO - PROCESS | 7897 | __start_tp_report 13:15:01 INFO - PROCESS | 7897 | _x_x_mozilla_page_load 13:15:01 INFO - PROCESS | 7897 | _x_x_mozilla_page_load_details 13:15:01 INFO - PROCESS | 7897 | |i|pagename|runs| 13:15:01 INFO - PROCESS | 7897 | |0;ai-astar;107;115;115;115;113;115;113;113;114;114 13:15:01 INFO - PROCESS | 7897 | |1;audio-beat-detection;153;128;123;172;126;123;148;123;157;123 13:15:01 INFO - PROCESS | 7897 | |2;audio-dft;161;161;161;161;161;161;164;162;160;160 13:15:01 INFO - PROCESS | 7897 | |3;audio-fft;76;76;77;139;76;77;75;76;98;76 13:15:01 INFO - PROCESS | 7897 | |4;audio-oscillator;85;86;116;86;87;85;117;86;85;121 13:15:01 INFO - PROCESS | 7897 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;116;116;117 13:15:01 INFO - PROCESS | 7897 | |6;imaging-darkroom;148;149;148;149;148;148;148;149;148;145 13:15:01 INFO - PROCESS | 7897 | |7;imaging-desaturate;95;95;96;96;96;96;95;95;95;95 13:15:01 INFO - PROCESS | 7897 | |8;json-parse-financial;65;63;63;64;64;66;65;65;65;64 13:15:01 INFO - PROCESS | 7897 | |9;json-stringify-tinderbox;66;66;66;65;66;65;66;65;66;66 13:15:01 INFO - PROCESS | 7897 | |10;stanford-crypto-aes;79;79;78;78;79;80;89;78;84;83 13:15:01 INFO - PROCESS | 7897 | |11;stanford-crypto-ccm;131;125;144;138;128;134;127;130;177;132 13:15:01 INFO - PROCESS | 7897 | |12;stanford-crypto-pbkdf2;173;166;166;164;168;165;163;168;166;166 13:15:01 INFO - PROCESS | 7897 | |13;stanford-crypto-sha256-iterative;66;68;68;68;66;66;65;65;65;65 13:15:01 INFO - PROCESS | 7897 | __end_tp_report 13:15:01 INFO - PROCESS | 7897 | __start_cc_report 13:15:01 INFO - PROCESS | 7897 | _x_x_mozilla_cycle_collect,1916 13:15:01 INFO - PROCESS | 7897 | __end_cc_report 13:15:01 INFO - PROCESS | 7897 | __startTimestamp1468440901201__endTimestamp 13:15:01 INFO - PROCESS | 7897 | 13:15:01 INFO - PROCESS | 7897 | ------- Summary: start ------- 13:15:01 INFO - PROCESS | 7897 | Number of tests: 14 13:15:01 INFO - PROCESS | 7897 | 13:15:01 INFO - PROCESS | 7897 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.50 stddev:2.41 (2.1%) stddev-sans-first:0.93 13:15:01 INFO - PROCESS | 7897 | Values: 107.0 115.0 115.0 115.0 113.0 115.0 113.0 113.0 114.0 114.0 13:15:01 INFO - PROCESS | 7897 | 13:15:01 INFO - PROCESS | 7897 | [#1] audio-beat-detection Cycles:10 Average:137.60 Median:138.00 stddev:18.21 (13.2%) stddev-sans-first:18.44 13:15:01 INFO - PROCESS | 7897 | Values: 153.0 128.0 123.0 172.0 126.0 123.0 148.0 123.0 157.0 123.0 13:15:01 INFO - PROCESS | 7897 | 13:15:01 INFO - PROCESS | 7897 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.14 (0.7%) stddev-sans-first:1.20 13:15:01 INFO - PROCESS | 7897 | Values: 161.0 161.0 161.0 161.0 161.0 161.0 164.0 162.0 160.0 160.0 13:15:01 INFO - PROCESS | 7897 | 13:15:01 INFO - PROCESS | 7897 | [#3] audio-fft Cycles:10 Average:84.60 Median:76.00 stddev:20.32 (26.7%) stddev-sans-first:21.31 13:15:01 INFO - PROCESS | 7897 | Values: 76.0 76.0 77.0 139.0 76.0 77.0 75.0 76.0 98.0 76.0 13:15:01 INFO - PROCESS | 7897 | 13:15:01 INFO - PROCESS | 7897 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:85.50 stddev:15.66 (18.3%) stddev-sans-first:16.15 13:15:01 INFO - PROCESS | 7897 | Values: 85.0 86.0 116.0 86.0 87.0 85.0 117.0 86.0 85.0 121.0 13:15:01 INFO - PROCESS | 7897 | 13:15:01 INFO - PROCESS | 7897 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:15:01 INFO - PROCESS | 7897 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 13:15:01 INFO - PROCESS | 7897 | 13:15:01 INFO - PROCESS | 7897 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:1.15 (0.8%) stddev-sans-first:1.22 13:15:01 INFO - PROCESS | 7897 | Values: 148.0 149.0 148.0 149.0 148.0 148.0 148.0 149.0 148.0 145.0 13:15:01 INFO - PROCESS | 7897 | 13:15:01 INFO - PROCESS | 7897 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 13:15:01 INFO - PROCESS | 7897 | Values: 95.0 95.0 96.0 96.0 96.0 96.0 95.0 95.0 95.0 95.0 13:15:01 INFO - PROCESS | 7897 | 13:15:01 INFO - PROCESS | 7897 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:65.00 stddev:0.97 (1.5%) stddev-sans-first:1.00 13:15:01 INFO - PROCESS | 7897 | Values: 65.0 63.0 63.0 64.0 64.0 66.0 65.0 65.0 65.0 64.0 13:15:01 INFO - PROCESS | 7897 | 13:15:01 INFO - PROCESS | 7897 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 13:15:01 INFO - PROCESS | 7897 | Values: 66.0 66.0 66.0 65.0 66.0 65.0 66.0 65.0 66.0 66.0 13:15:01 INFO - PROCESS | 7897 | 13:15:01 INFO - PROCESS | 7897 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:79.50 stddev:3.59 (4.5%) stddev-sans-first:3.76 13:15:01 INFO - PROCESS | 7897 | Values: 79.0 79.0 78.0 78.0 79.0 80.0 89.0 78.0 84.0 83.0 13:15:01 INFO - PROCESS | 7897 | 13:15:01 INFO - PROCESS | 7897 | [#11] stanford-crypto-ccm Cycles:10 Average:136.60 Median:133.00 stddev:15.25 (11.5%) stddev-sans-first:16.04 13:15:01 INFO - PROCESS | 7897 | Values: 131.0 125.0 144.0 138.0 128.0 134.0 127.0 130.0 177.0 132.0 13:15:01 INFO - PROCESS | 7897 | 13:15:01 INFO - PROCESS | 7897 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.50 Median:166.00 stddev:2.76 (1.7%) stddev-sans-first:1.64 13:15:01 INFO - PROCESS | 7897 | Values: 173.0 166.0 166.0 164.0 168.0 165.0 163.0 168.0 166.0 166.0 13:15:01 INFO - PROCESS | 7897 | 13:15:01 INFO - PROCESS | 7897 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.00 stddev:1.32 (2.0%) stddev-sans-first:1.39 13:15:01 INFO - PROCESS | 7897 | Values: 66.0 68.0 68.0 68.0 66.0 66.0 65.0 65.0 65.0 65.0 13:15:01 INFO - PROCESS | 7897 | -------- Summary: end -------- 13:15:01 INFO - PROCESS | 7897 | 13:15:02 INFO - TEST-INFO | 7897: exit 0 13:15:02 INFO - TEST-OK | kraken | took 63658ms 13:15:02 INFO - SUITE-END | took 1183s 13:15:02 INFO - Completed test suite (00:19:43) 13:15:02 INFO - javascript benchmark 13:15:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2575.5106529759346, 2590.7409259074084, 2620.0305886821875, 2628.8422694638325, 2631.763141317282, 4435.489918659355, 4467.553244675531, 4596.609288210502, 4628.328892310617, 4629.213033784256, 4530.297803840402, 4535.863924082283, 4551.7041392309475, 4599.034202817404, 4604.240300350447, 4150.107726838722, 4152.335626299792, 4160.188763191179, 4188.664906807463, 4230.7250028748185, 4232.957670423302, 4247.511536173349, 4310.353446982962, 4347.152305300468, 4352.455943007124, 4135.77253251071, 4181.247375472413, 4278.807453664593, 4300.3764454154125, 4325.005248792764, 4210.726302790309, 4216.2199993001395, 4220.261454245526, 4221.704480686353, 4225.04936389313, 4192.098698779777, 4193.874183774492, 4194.979025104885, 4199.139176468817, 4199.223143718422, 4525.343825145368, 4547.363369128325, 4553.658475614342, 4564.771761411949, 4567.543245675439, 4820.39745031871, 4867.050925069613, 4869.902601947942, 4870.464248932614, 4871.293662418965, 4905.681130726527, 4921.064997650435, 4955.90088198234, 4967.90064198714, 4969.701817890938, 4405.295152775605, 4504.054148628759, 4575.58819706228, 4575.9771201143785, 4617.653675974316, 5022.598192144693, 5035.521625445577, 5070.8225212117395, 5079.0, 5079.085764562415, 4841.782119804618, 4870.245112007645, 4870.902581948341, 4877.341558889575, 4880.194767863334, 4707.176244157259, 4840.419149702058, 4898.436679781799, 4899.0, 4961.578265847444, 4859.1010663027455, 4881.121398148296, 4886.638129863909, 4895.412550493964, 4922.827701030446, 4661.790219440133, 4887.535684110004, 4888.0, 4904.558589726942, 4933.531314525115, 4043.332850079704, 4080.755154690728, 4126.793660317032, 4130.235906357333, 4138.8344466221015, 3622.185008373095, 3632.073821175636, 3645.453182022718, 3656.4149736042104, 3670.9082272942856, 4060.045889216032, 4207.534607319923, 4211.178820130045, 4259.084296876186, 4266.5093514246255, 4753.857384278408, 4811.615070794328, 4866.659333846596, 4871.293662419001, 4871.48849370811, 4152.91694166115, 4161.83352665896, 4164.06308580573, 4208.0, 4209.3896385024, 4187.644050255702, 4365.345198220292, 4367.126574685076, 4368.126374725004, 4409.338599210144, 4543.045960348364, 4578.244589642672, 4596.103759766947, 4611.884702882455, 4614.123316569841, 4849.781759820887, 4876.024795040935, 4876.024795041077, 4876.683015604116, 4924.187509060965, 4453.621442177451, 4596.678232523691, 4605.102005108972, 4605.309203619484, 4639.118567472169, 4750.477447480844, 4772.713637181641, 4781.163296423181, 4791.233402655558, 4811.4707382188635, 4852.902941941212, 4861.0, 4864.148773964613, 4872.90254194907, 4918.778654960463, 4632.745199014086, 4689.859304220879, 4761.6428767843245, 4769.284607308931, 4820.9517904821905, 4669.7431641260055, 4733.952660473351, 4774.76126193682, 4788.401449818773, 4801.9915817678675, 4724.811007559659, 4730.314104454766, 4731.976340118277, 4751.417084925268, 4770.0936822003705, 4621.537846215486, 4712.59942904857, 4776.259679749644, 4819.084373968934, 4864.489228631084, 4680.7191568506, 4700.412448443944, 4704.647151463722, 4736.0, 4747.026859493726], "value": 4486.133043945642, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.6724899558257, 579.0445764488596, 579.5624303650743, 584.7251791657922, 586.2788769813129, 26971.32571685709, 38302.0, 40272.99999999996, 40411.59588404115, 44305.335419968724, 41099.794501027456, 41467.170656586924, 41482.377764333556, 41500.16999660005, 41529.37705934406, 7872.567008814527, 8006.759797206093, 8017.919820801776, 8023.157568455286, 8026.558539280337, 7899.368050555941, 7973.32226760726, 7998.12020677725, 7998.840023199533, 8005.039395272546, 8008.119106898236, 8043.155468675793, 8057.315128214109, 8064.798380040487, 8068.233517815798, 8019.639116239754, 8040.115587285394, 8054.476459030145, 8063.27430531255, 8070.9192908071045, 7905.2490013449205, 7966.880496792553, 7968.7609371718945, 7975.2423519765525, 7978.481398709066, 39007.21985560273, 39464.40803387952, 39488.40767388463, 39527.604723952965, 39579.20841583152, 2731.207949694586, 2956.911292661224, 3093.6442309134513, 3175.301433684586, 3571.2143328467696, 29441.411171776657, 29893.0, 30070.0, 30120.0, 30353.848230758704, 2755.5040092783292, 2787.693353731088, 2788.3029242689327, 2791.6650001999687, 2877.6115224444643, 257874.0, 258221.0, 258334.0, 258952.0, 259119.9999999981, 31355.68644313573, 32496.675033249365, 32517.0, 53173.202401964, 53534.464655353724, 33694.3261134776, 33712.325753484794, 33790.0, 33792.1551961198, 33804.32391352209, 13602.319884005958, 13803.447862085604, 13845.515406960909, 13848.515301964584, 13849.238291894042, 11456.369899655432, 11479.25384849982, 11488.195826292247, 11542.711432214093, 11570.247933884439, 7924.167962363984, 7945.523268603903, 7981.68073277074, 8049.879251811228, 8051.919480805234, 3151.936961260762, 3152.7793054485965, 3168.366326734616, 3172.095952653529, 3190.760692948038, 796.9083555391088, 819.5656302159865, 835.2065537739172, 887.9911200888038, 933.1881263300836, 27338.863305683346, 27735.0, 27818.0, 28181.0, 28211.0, 766.6703317573497, 920.4523308631353, 962.20617990157, 978.7650963768644, 1010.8483727440943, 14773.778393324108, 14850.331735071948, 14855.108693478425, 15005.549833505012, 15041.623959401102, 378496.0, 378527.0, 382254.0, 384925.0, 386543.0, 50041.74979125081, 50706.23940640893, 50718.239226411635, 50745.23882141771, 50811.0, 1069.1286601419818, 1101.515333253366, 1156.392893730798, 1164.1967042740482, 1211.249025604131, 26671.599926000737, 29505.557416639196, 29556.261093472836, 30261.697383025887, 30272.5459118109, 42396.5760342405, 42783.35824962566, 42943.57056429396, 42964.0, 42964.570354297306, 304497.0, 307355.0, 307377.0, 308235.0, 308437.0, 22488.66267006029, 24253.151139710026, 25241.495170096863, 25255.242342729747, 25279.11523096683, 41366.793166033975, 41629.16741665089, 42745.35881961711, 42995.78502107469, 43415.56584434242, 36107.55569777179, 36672.63327366692, 37295.44056839095, 37412.43881341837, 37514.624853752204, 36609.633903661685, 36714.4492832613, 37020.0, 37150.44274335833, 37805.62194378021, 35527.11182220465, 35693.28613427769, 35799.10502237465, 36432.63567364292, 37429.812850935574, 32522.67477325291, 33264.54230648086, 33682.831585841916, 33683.452733880615, 33824.0, 25795.0, 26202.213933582025, 26303.73696263013, 26398.736012639627, 26877.193684189504], "value": 16412.66750669406, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.20534823388545, 366.68098754083945, 369.12149085177276, 381.3669308947148, 389.6901962939465, 16463.695082688417, 17379.30482780689, 18242.908785456086, 18254.087295635214, 18265.634687306247, 16092.1953902305, 16603.335866565354, 16741.748873766905, 16844.915775421137, 16952.576185595368, 5070.79716811328, 5250.684958902478, 5288.048151332759, 5288.233206185101, 5290.365156181264, 3818.885433437001, 3997.320455522568, 5153.845384638448, 5865.706714664271, 6182.659953702545, 6147.446729794317, 6240.656763877985, 6251.499880009611, 6258.06129080637, 6262.530310226728, 5885.529157667376, 6194.65929373882, 6195.256569211679, 6202.8449288767915, 6203.87592248157, 3465.480177973299, 5186.455422180692, 5367.758450869681, 5479.068558345051, 5490.670559766387, 22228.666570001464, 22421.215257465912, 22489.775102248932, 23565.646515302284, 23781.286561403187, 1830.3685228596114, 1859.665260253154, 1893.6307420053095, 1916.8849869007904, 2247.898844551999, 13824.861751382457, 14790.778138327934, 14892.180930048842, 15142.394304227817, 15699.136547489883, 1693.6866679664179, 1745.8952462852142, 1760.505396787376, 1768.7170052791491, 1812.5831058856404, 75594.24405755928, 80834.0, 82929.58535207286, 83467.16532834654, 83480.0, 16419.507414777574, 16941.0, 16977.132515423295, 17032.48902532926, 17211.762470878704, 29450.263743406158, 29707.257318567208, 30016.39967200644, 30051.849740751593, 30054.84972575167, 8266.0, 8500.44747091437, 8551.102134275936, 8610.311175105977, 8628.697995570124, 6937.7224911002995, 6953.478489113337, 6978.302169782981, 7089.14930208368, 7102.467314951399, 8288.668453261922, 8568.785780355416, 8645.221930026202, 8677.913220867711, 8788.78028049291, 2626.7110617832022, 2998.7001299870276, 3222.726068284222, 3391.033555436689, 3397.1676939150066, 714.5284112485734, 786.598834594361, 786.8937693411316, 813.0934008580508, 828.6643909216776, 16421.507354779376, 17311.0, 17383.826161738474, 17634.0, 17738.467845964642, 788.5505262000719, 836.0, 843.2495079379357, 863.5941107679381, 868.3964644571962, 9385.57764900581, 9795.853062204073, 9813.067758562926, 9853.655122070693, 9886.505674716236, 349678.0, 352953.0, 353296.0, 356214.0, 356801.0, 78460.21539784643, 78575.60712196403, 79473.20526794659, 79747.0, 80001.0, 829.3613917283778, 853.8463076646264, 870.3341943413294, 878.1613559051091, 878.5826732302233, 12058.974987126192, 15696.92151539235, 16031.919840400724, 16666.58333541671, 16818.66362672764, 38547.0, 38558.0, 38579.42130867983, 38796.61203388043, 39073.41389879211, 47472.7626361866, 49515.50484495109, 49744.75127624339, 49934.250986235966, 50033.24950125824, 7121.252268511939, 7314.670839812327, 7343.742968996059, 7360.411167106511, 7433.145188303414, 9006.59470323824, 10709.410982396043, 10745.516451759533, 11166.16253780986, 11359.261647992855, 9609.375390599589, 9632.662856799978, 9732.318737688576, 9739.707808765748, 9909.851352229867, 9417.340786144903, 9472.336936414385, 9534.189593884597, 9580.95209523948, 9821.214302855897, 9720.222382209548, 9737.805243895224, 9799.167070799062, 9922.702318930444, 10001.849972250568, 7218.27817218274, 7281.308275713799, 7415.073115860518, 7422.591757453176, 7483.32650061497, 8660.523671198145, 9599.47202903847, 9732.854007189757, 9821.950890245504, 9938.602455901682], "value": 8928.308520746483, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1380.2201756007858, 1411.4706984880668, 1503.7819516170155, 1683.2593658790124, 1729.3428497171064, 7720.498167619108, 8192.7951801205, 8223.465474744153, 8249.340052795777, 8260.967379077616, 6697.866042679144, 6795.184577850652, 7641.961790191055, 7811.609419529029, 8063.435559510836, 2194.890255487227, 2217.2239716099316, 2224.899879505418, 2226.1651880544796, 2227.4765430123907, 2172.73927128744, 2205.151016858505, 2265.263789268486, 2266.320103968811, 2268.5803126421583, 1855.0539224995282, 2174.749903761064, 2232.9888350558226, 2235.865848049114, 2270.0579259607243, 2214.9889250553806, 2219.7447293561286, 2237.955240895189, 2238.7089678341713, 2241.1483636218295, 2231.5871563760757, 2232.8213742900693, 2238.0712004518105, 2238.9888050559643, 2241.6525438556887, 8149.103598604149, 8200.302974247195, 8219.383546234056, 8224.465409748347, 8225.95887020567, 4554.931676024862, 4602.401687780601, 4732.195526760459, 4737.431508219001, 4745.715257084586, 2576.254708956131, 2591.935201619956, 2646.8411895286345, 2658.1095333063445, 2659.946801063987, 834.407570624857, 836.7071524966274, 852.4927668037508, 853.5433543054498, 854.9444286121383, 11070.667879963614, 11107.444627768578, 11119.332840029625, 11119.610813621484, 11120.666380008613, 4076.0, 4213.199492096492, 4308.009157893639, 4360.215161271001, 4361.0, 9499.525023748785, 9530.285228607881, 9546.665866694633, 9546.856797148048, 9548.809023819624, 4737.38414006177, 4751.311059896296, 4751.548602882721, 4751.738654373973, 4753.904921901542, 4091.2226676931286, 4296.613304802583, 4320.265554855682, 4322.135572885435, 4325.070109926381, 3441.587009558819, 3444.328355970612, 3451.6548345165284, 3510.64893510652, 3533.593636731757, 934.5233930695258, 1078.094400703413, 1083.967480975572, 1087.075985412409, 1088.7588149509565, 629.9275583307979, 667.7829705345782, 671.8992151177363, 751.2825251884437, 818.1613845808095, 5095.923561146586, 5529.834104976857, 5586.0, 5750.396208398058, 5781.5952883298605, 792.298815548244, 835.9456635318685, 855.8373908957278, 869.3957699398984, 883.3110174064241, 3549.680528752425, 3574.7318951078773, 3713.5729391119826, 3723.0506220913494, 3777.33896568105, 9269.953650231706, 9787.510624468749, 9800.82390113191, 9874.210063194927, 9888.110070093726, 8268.669253229924, 9801.411915285105, 9807.75480612976, 9825.312228143961, 9827.803443931225, 7212.531185472927, 7497.325240728361, 7502.84994300111, 7728.149903510609, 7729.652165652559, 5300.893982120413, 5404.243405923253, 5553.750081246434, 5594.992901277809, 5695.202671625892, 9047.230985366054, 9265.861012084959, 9422.19911307519, 9426.575804088696, 9438.85841712361, 9215.078492150731, 9435.716928492157, 9474.0, 9530.571124299284, 9608.75978100525, 6537.477001839937, 6622.304658010839, 6646.202455705153, 6663.800085997428, 6679.732810687518, 7419.29516695913, 7594.050743657043, 7671.53970761756, 7675.731349402744, 7677.385809135144, 6649.567778094409, 6735.25912149673, 6909.654517274217, 6975.720971161097, 7014.333638304353, 6577.375149360803, 6604.966975165094, 6630.569013014138, 6868.381845633717, 6871.347222013901, 6514.4788416925585, 6581.6709164542535, 6646.335366463315, 6714.563553369016, 6738.191417029988, 4624.398828152319, 4651.883702907319, 4681.555252251031, 4715.552022557851, 4746.691465054899, 4488.259437192826, 4536.160810250114, 4582.473015603248, 4617.422822147231, 4635.096156249499], "value": 4159.705871367344, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.3698973228093, 297.89275860690157, 304.47326125802374, 304.82015610789637, 305.7859498351155, 4673.369095172151, 4763.928541071878, 4815.8796030099265, 4838.419389673235, 4855.878603034921, 4587.151376995258, 4725.267583524551, 4742.881427964294, 4758.214894542405, 4770.904581908359, 3778.394182472452, 3782.451544526042, 3787.20468701573, 3790.2798468291076, 3798.6771124454385, 3626.9455958160647, 3711.2391959648344, 3795.8861234162882, 3825.215830754689, 3830.616938306175, 3664.5602527696715, 3750.1187221003042, 3777.9811100944457, 3797.7721336719746, 3804.9239015219678, 3739.551253849528, 3746.3256613809504, 3763.5510328523715, 3763.9247215055684, 3770.811459427018, 3342.1143396999814, 3345.916352091193, 3354.76516643835, 3362.310726301127, 3375.970329049639, 4537.137943790669, 4663.9766801166115, 4679.719216847, 4683.648726345537, 4734.644901632357, 4317.136572685444, 4324.767441279252, 4325.3079507279, 4340.133742490728, 4350.2387082260475, 4819.783109760034, 4982.82560110398, 4982.956987635052, 4992.375953005874, 5008.620905070099, 3591.8506078055034, 3599.6040435552068, 3606.891793246207, 3615.0600843780544, 3623.836927338276, 5262.631615786858, 5283.709395983219, 5288.233206185082, 5311.123664595337, 5315.867103322409, 3702.889133260011, 3705.9814700926863, 3715.0, 3715.9442608360896, 3717.368047431943, 3655.61616030313, 3722.2927643747603, 3726.2547490502006, 3729.9440508392395, 3754.1365485938386, 4210.221109094766, 4233.322668373107, 4240.936385954213, 4247.0, 4261.914761704748, 5032.496750324938, 5042.369703787027, 5043.36957880265, 5045.965577056694, 5047.369078865142, 1193.7254431480808, 1212.7392610588765, 1269.041873385588, 1273.1666400383417, 1293.6507143071317, 866.5667166416791, 887.8179973105498, 890.2121622364125, 890.8708237305555, 894.0433735902652, 4422.955770442319, 4448.710833795858, 4448.799804008762, 4456.64346852251, 4462.843800467033, 5115.232715092766, 5155.407128180233, 5157.510036546597, 5157.974210128926, 5194.0, 4269.295566231537, 4385.539518350591, 4408.853698038533, 4430.689851710349, 4450.488193857683, 2409.5663080467093, 2424.3454267347715, 2450.6814114165045, 2453.8650374229587, 2458.655788189619, 4300.311950087971, 4309.095090031128, 4321.395004699345, 4363.759993200404, 4364.6290065344165, 4333.569921925757, 4627.7143228307605, 4632.814687412466, 4662.6269898408045, 4676.55572720591, 4262.808173632194, 4316.848910288125, 4336.978315108404, 4342.196693611692, 4356.82365761249, 4526.909461810811, 4547.839776106323, 4566.566176213254, 4584.083183363274, 4637.701443595799, 4170.812313445842, 4456.509783923831, 4480.283154695233, 4483.327500874895, 4502.45970483531, 4268.039691069484, 4295.892602684958, 4328.420126653686, 4340.131973605355, 4370.278903980808, 3337.0489410517885, 3339.282054358325, 3380.5267262582765, 3476.878309259164, 3540.451230059345, 5122.975404918957, 5126.231065340229, 5144.151215049475, 5153.7165455900285, 5161.277421161116, 4979.555928780613, 4987.775550100182, 4992.80028798844, 5007.574356179765, 5011.924821127613, 4790.77835152034, 4970.975145124251, 4991.800327986985, 5010.69935803853, 5074.746262686925, 4969.82605608802, 4987.3017777511905, 4987.800487980585, 4995.375578052744, 5009.5491405773655, 5080.806010587583, 5084.847454576368, 5099.949000509948, 5105.438401775876, 5105.744712764273, 4766.3327134200545, 4981.37732783402, 4982.62630302736, 4985.52637499437, 5007.69953802773], "value": 3701.312085851729, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.3369117247846, 602.32840382973, 616.7440512187443, 660.5275294187654, 677.7560078371786, 13326.0, 13711.10877792944, 13823.447062117502, 13832.515861944834, 13899.791503127435, 13733.93133034336, 13769.793453098211, 13875.30623468825, 13904.58286251414, 13914.721705565882, 639.0733436517046, 764.4075841223068, 781.820181358288, 803.0483876606211, 806.8628333183343, 789.3803364358979, 810.6473683947472, 811.0267678785451, 811.6469335838929, 811.8011087283594, 841.6002398860553, 845.2815107158897, 845.6363763581658, 846.3102571404316, 846.3736834742277, 655.5673255651247, 794.4121350200868, 817.8691409374532, 838.6226198210799, 839.6851180807228, 603.7977277612006, 604.8185544336682, 605.05913304811, 605.1255935173632, 605.5579427018301, 13583.660408489768, 13599.524016659469, 13612.115212511155, 13618.18290902549, 13620.863791362059, 12493.625191244277, 13006.219626822422, 13036.674083147996, 13123.868761312455, 13468.93265533676, 10570.15438764897, 10600.628977985734, 10886.782264354668, 10957.726056848564, 11166.553337866475, 4066.5323487798987, 4134.297169481196, 4140.130572579762, 4144.834206631731, 4223.577642235782, 58691.0, 58765.41234587642, 58825.41174588242, 58897.705511472595, 62644.0, 9752.707418777449, 9832.754181145385, 9963.551640176209, 10035.096841284174, 10195.0, 18321.908390457964, 18388.816111838976, 18415.26338946454, 18435.815641843677, 18829.152688129067, 6334.651594162273, 6558.278589355167, 6623.834404139935, 6633.104530888365, 6737.191537015589, 3439.8452069656423, 3494.4583589543663, 3522.4188008978745, 3688.9262214755554, 3721.906952326159, 2716.687580928179, 2816.1973837456226, 2832.872520736572, 2834.5039618066758, 2838.929026774306, 484.5227450960801, 486.9780859861315, 489.60586727683847, 494.3968358602499, 503.6373810856178, 365.98902032939054, 392.09817419934035, 442.1267995708514, 454.8317122664635, 455.4875764764574, 6930.861382772317, 6978.81573119812, 7258.564486130849, 7599.734009309647, 7945.1657575953695, 465.8276437718066, 488.44073535802016, 505.6662602682212, 507.11761534929695, 519.2626470412024, 3514.947275790865, 3559.768615040014, 3601.513795637608, 3624.220792529619, 3655.8903232903053, 88363.0, 92204.53897730468, 92950.53524732334, 93228.53385733027, 96101.0, 67282.66358668273, 76982.0, 82385.58807206046, 82675.5866220665, 83312.16687833166, 43162.784186079494, 45450.77274613672, 62951.685241574414, 63541.36458635354, 76009.23990760022, 7887.763367098996, 8035.678572857254, 8054.516728996279, 8150.388720845842, 8294.0, 42921.0, 45491.09017819559, 45996.0, 47448.762756186, 47451.76274118746, 65913.67043164754, 68433.0, 69039.65480172567, 69289.30710692829, 69555.65222173856, 10257.32897401833, 10332.380057196593, 10393.9480302598, 10968.23222374426, 10978.341299521735, 12456.626301210978, 12763.361831908182, 13008.0, 13063.150895191782, 13066.869331306565, 8533.487990720576, 8639.740807775777, 10016.799664006534, 10572.471376431302, 10962.725931851768, 9761.951190244003, 9904.950475247577, 10167.237457190593, 10761.784764304826, 11163.051140652811, 10419.322744021614, 10635.680929572125, 10828.729281768019, 11078.889211107786, 11299.09607231403, 9672.70981870545, 9892.661729970047, 10072.143867771321, 10322.432266225429, 10511.73720656959, 8919.687810926587, 9017.188453039258, 9286.674966376144, 9488.136113877463, 9984.950075249868], "value": 6329.414630303739, "unit": "score"}], "name": "dromaeo_css", "value": 6325.702803476612, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 115.0, 115.0, 115.0, 113.0, 115.0, 113.0, 113.0, 114.0, 114.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 128.0, 123.0, 172.0, 126.0, 123.0, 148.0, 123.0, 157.0, 123.0], "value": 137.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 161.0, 161.0, 164.0, 162.0, 160.0, 160.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 139.0, 76.0, 77.0, 75.0, 76.0, 98.0, 76.0], "value": 84.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 116.0, 86.0, 87.0, 85.0, 117.0, 86.0, 85.0, 121.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 149.0, 148.0, 148.0, 148.0, 149.0, 148.0, 145.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 63.0, 64.0, 64.0, 66.0, 65.0, 65.0, 65.0, 64.0], "value": 64.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 65.0, 66.0, 65.0, 66.0, 65.0, 66.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 78.0, 79.0, 80.0, 89.0, 78.0, 84.0, 83.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 125.0, 144.0, 138.0, 128.0, 134.0, 127.0, 130.0, 177.0, 132.0], "value": 136.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 166.0, 166.0, 164.0, 168.0, 165.0, 163.0, 168.0, 166.0, 166.0], "value": 166.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 68.0, 68.0, 66.0, 66.0, 65.0, 65.0, 65.0, 65.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1532.4999999999998, "alertThreshold": 2.0}]} 13:15:02 INFO - Return code: 0 13:15:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:15:02 INFO - # TBPL SUCCESS # 13:15:02 INFO - Running post-action listener: _resource_record_post_action 13:15:02 INFO - ##### 13:15:02 INFO - ##### Finished run-tests step (success) 13:15:02 INFO - ##### 13:15:02 INFO - Running post-run listener: _resource_record_post_run 13:15:02 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 536428544; Read time: 8; Write time: 551696 13:15:02 INFO - TinderboxPrint: CPU usage
13.0% 13:15:02 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 13:15:02 INFO - TinderboxPrint: I/O write bytes / time
536,428,544 / 551,696 13:15:02 INFO - TinderboxPrint: CPU idle
8,330.0 (87.0%) 13:15:02 INFO - TinderboxPrint: CPU user
1,203.4 (12.6%) 13:15:02 INFO - TinderboxPrint: Swap in / out
0 / 0 13:15:02 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246460416; Read time: 0; Write time: 268172 13:15:02 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289681408; Read time: 8; Write time: 283504 13:15:03 INFO - Running post-run listener: _upload_blobber_files 13:15:03 INFO - Blob upload gear active. 13:15:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:15:03 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 13:15:03 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'] 13:15:03 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 13:15:03 INFO - (blobuploader) - INFO - Open directory for files ... 13:15:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:15:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:15:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:15:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:15:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:15:04 INFO - (blobuploader) - INFO - Done attempting. 13:15:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:15:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:15:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:15:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:15:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:15:08 INFO - (blobuploader) - INFO - Done attempting. 13:15:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:15:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:15:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:15:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:15:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:15:08 INFO - (blobuploader) - INFO - Done attempting. 13:15:08 INFO - (blobuploader) - INFO - Iteration through files over. 13:15:08 INFO - Return code: 0 13:15:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:15:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:15:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d5095a0af01441c2bca6660037f8126e1b68e5672e52bbef32a058bb3c9bceecc59d2015bf137f4b4f72f49a9cf62cc44fcb83d50e876e8a1debab10b3325da5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/31bc60cec39736798ba91d616ff43d097839d77377adf1b9a5ce15310f22f06da9768f0ba3d1f3d1c30cb0114514811a1eff2863c648703510b3855369febfb9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/82f317c77c1cc848d7c628f6b64eb50b73cde6dbe69e6269ca7e8c09e2a8e3bd9a1ef126ed554236ecfd05c9dc20801d0213e9d404b21907989c75b90787dcb0"} 13:15:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:15:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:15:08 INFO - Contents: 13:15:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d5095a0af01441c2bca6660037f8126e1b68e5672e52bbef32a058bb3c9bceecc59d2015bf137f4b4f72f49a9cf62cc44fcb83d50e876e8a1debab10b3325da5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/31bc60cec39736798ba91d616ff43d097839d77377adf1b9a5ce15310f22f06da9768f0ba3d1f3d1c30cb0114514811a1eff2863c648703510b3855369febfb9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/82f317c77c1cc848d7c628f6b64eb50b73cde6dbe69e6269ca7e8c09e2a8e3bd9a1ef126ed554236ecfd05c9dc20801d0213e9d404b21907989c75b90787dcb0"} 13:15:08 INFO - Running post-run listener: copy_logs_to_upload_dir 13:15:08 INFO - Copying logs to upload dir... 13:15:08 INFO - mkdir: /builds/slave/test/build/upload/logs 13:15:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.388643 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-13 13:15:08.194382) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 13:15:08.199485) ========= 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=836cfdc75598d54cb747368e000001a9-1468438645.862253-1582568016 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/d5095a0af01441c2bca6660037f8126e1b68e5672e52bbef32a058bb3c9bceecc59d2015bf137f4b4f72f49a9cf62cc44fcb83d50e876e8a1debab10b3325da5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/31bc60cec39736798ba91d616ff43d097839d77377adf1b9a5ce15310f22f06da9768f0ba3d1f3d1c30cb0114514811a1eff2863c648703510b3855369febfb9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/82f317c77c1cc848d7c628f6b64eb50b73cde6dbe69e6269ca7e8c09e2a8e3bd9a1ef126ed554236ecfd05c9dc20801d0213e9d404b21907989c75b90787dcb0"} build_url:https://queue.taskcluster.net/v1/task/ZzXSWHxXTX6nznBB3pQQYA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011382 build_url: 'https://queue.taskcluster.net/v1/task/ZzXSWHxXTX6nznBB3pQQYA/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/d5095a0af01441c2bca6660037f8126e1b68e5672e52bbef32a058bb3c9bceecc59d2015bf137f4b4f72f49a9cf62cc44fcb83d50e876e8a1debab10b3325da5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/31bc60cec39736798ba91d616ff43d097839d77377adf1b9a5ce15310f22f06da9768f0ba3d1f3d1c30cb0114514811a1eff2863c648703510b3855369febfb9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/82f317c77c1cc848d7c628f6b64eb50b73cde6dbe69e6269ca7e8c09e2a8e3bd9a1ef126ed554236ecfd05c9dc20801d0213e9d404b21907989c75b90787dcb0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 13:15:08.224738) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 13:15:08.225042) ========= 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=836cfdc75598d54cb747368e000001a9-1468438645.862253-1582568016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004449 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 13:15:08.308734) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 13:15:08.309040) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 13:15:08.309344) ========= ========= Total master_lag: 0.16 =========