builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-052 starttime: 1468361118.05 results: success (0) buildid: 20160712143226 builduid: bd23d6633fc3484080cf84c38b9c32e4 revision: 8c882ca5b996591a83946d9828ece838bc1faef3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 15:05:18.049878) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 15:05:18.050278) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 15:05:18.050549) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 15:05:18.082732) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 15:05:18.082990) ========= 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=826874ccc97bd7bf541b4875000001d5-1468358977.121291-1278041462 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-12 15:05:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.9M=0s 2016-07-12 15:05:18 (35.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091962 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 15:05:18.188319) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 15:05:18.188609) ========= 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=826874ccc97bd7bf541b4875000001d5-1468358977.121291-1278041462 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020544 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 15:05:18.237874) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 15:05:18.238205) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8c882ca5b996591a83946d9828ece838bc1faef3 --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 8c882ca5b996591a83946d9828ece838bc1faef3 --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=826874ccc97bd7bf541b4875000001d5-1468358977.121291-1278041462 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-12 15:05:18,365 truncating revision to first 12 chars 2016-07-12 15:05:18,365 Setting DEBUG logging. 2016-07-12 15:05:18,365 attempt 1/10 2016-07-12 15:05:18,365 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8c882ca5b996?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 15:05:18,671 unpacking tar archive at: fx-team-8c882ca5b996/testing/mozharness/ program finished with exit code 0 elapsedTime=0.640871 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 15:05:18.892416) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 15:05:18.892723) ========= script_repo_revision: 8c882ca5b996591a83946d9828ece838bc1faef3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 15:05:18.893092) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 15:05:18.893370) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 15:05:18.904408) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-07-12 15:05:18.904678) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=826874ccc97bd7bf541b4875000001d5-1468358977.121291-1278041462 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:05:19 INFO - MultiFileLogger online at 20160712 15:05:19 in /builds/slave/test 15:05:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 15:05:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:05:19 INFO - {'append_to_log': False, 15:05:19 INFO - 'base_work_dir': '/builds/slave/test', 15:05:19 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:05:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:05:19 INFO - 'branch': 'Fx-Team-Non-PGO', 15:05:19 INFO - 'buildbot_json_path': 'buildprops.json', 15:05:19 INFO - 'config_files': ('talos/linux_config.py',), 15:05:19 INFO - 'default_actions': ('clobber', 15:05:19 INFO - 'read-buildbot-config', 15:05:19 INFO - 'download-and-extract', 15:05:19 INFO - 'populate-webroot', 15:05:19 INFO - 'create-virtualenv', 15:05:19 INFO - 'install', 15:05:19 INFO - 'run-tests'), 15:05:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:05:19 INFO - 'download_minidump_stackwalk': True, 15:05:19 INFO - 'download_symbols': 'ondemand', 15:05:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:05:19 INFO - 'tooltool.py': '/tools/tooltool.py', 15:05:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:05:19 INFO - '/tools/misc-python/virtualenv.py')}, 15:05:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:05:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:05:19 INFO - 'installer_path': 'installer.exe', 15:05:19 INFO - 'log_level': 'info', 15:05:19 INFO - 'log_name': 'talos', 15:05:19 INFO - 'log_to_console': True, 15:05:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:05:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:05:19 INFO - 'opt_config_files': (), 15:05:19 INFO - 'pip_index': False, 15:05:19 INFO - 'sps_profile': False, 15:05:19 INFO - 'sps_profile_interval': 0, 15:05:19 INFO - 'suite': 'dromaeojs-e10s', 15:05:19 INFO - 'system_bits': '32', 15:05:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:05:19 INFO - 'title': 'talos-linux64-ix-052', 15:05:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:05:19 INFO - 'use_talos_json': True, 15:05:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:05:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:05:19 INFO - 'work_dir': 'build'} 15:05:19 INFO - ##### 15:05:19 INFO - ##### Running clobber step. 15:05:19 INFO - ##### 15:05:19 INFO - Running pre-action listener: _resource_record_pre_action 15:05:19 INFO - Running main action method: clobber 15:05:19 INFO - rmtree: /builds/slave/test/build 15:05:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:05:19 INFO - Running post-action listener: _resource_record_post_action 15:05:19 INFO - ##### 15:05:19 INFO - ##### Finished clobber step (success) 15:05:19 INFO - ##### 15:05:19 INFO - ##### 15:05:19 INFO - ##### Running read-buildbot-config step. 15:05:19 INFO - ##### 15:05:19 INFO - Running pre-action listener: _resource_record_pre_action 15:05:19 INFO - Running main action method: read_buildbot_config 15:05:19 INFO - Using buildbot properties: 15:05:19 INFO - { 15:05:19 INFO - "project": "", 15:05:19 INFO - "product": "firefox", 15:05:19 INFO - "script_repo_revision": "production", 15:05:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 15:05:19 INFO - "repository": "", 15:05:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 15:05:19 INFO - "buildid": "20160712143226", 15:05:19 INFO - "pgo_build": "False", 15:05:19 INFO - "basedir": "/builds/slave/test", 15:05:19 INFO - "buildnumber": 1472, 15:05:19 INFO - "slavename": "talos-linux64-ix-052", 15:05:19 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:05:19 INFO - "platform": "ubuntu64_hw", 15:05:19 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:05:19 INFO - "branch": "fx-team", 15:05:19 INFO - "repo_path": "integration/fx-team", 15:05:19 INFO - "revision": "8c882ca5b996591a83946d9828ece838bc1faef3", 15:05:19 INFO - "stage_platform": "linux64", 15:05:19 INFO - "builduid": "bd23d6633fc3484080cf84c38b9c32e4", 15:05:19 INFO - "slavebuilddir": "test" 15:05:19 INFO - } 15:05:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/HZ6mA3VuRaa_l7eyfXPiEQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 15:05:19 INFO - Running post-action listener: _resource_record_post_action 15:05:19 INFO - ##### 15:05:19 INFO - ##### Finished read-buildbot-config step (success) 15:05:19 INFO - ##### 15:05:19 INFO - ##### 15:05:19 INFO - ##### Running download-and-extract step. 15:05:19 INFO - ##### 15:05:19 INFO - Running pre-action listener: _resource_record_pre_action 15:05:19 INFO - Running main action method: download_and_extract 15:05:19 INFO - mkdir: /builds/slave/test/build/tests 15:05:19 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')]} 15:05:19 INFO - https://queue.taskcluster.net/v1/task/HZ6mA3VuRaa_l7eyfXPiEQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:05:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HZ6mA3VuRaa_l7eyfXPiEQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:05:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HZ6mA3VuRaa_l7eyfXPiEQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:05:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HZ6mA3VuRaa_l7eyfXPiEQ/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 15:05:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HZ6mA3VuRaa_l7eyfXPiEQ/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 15:05:26 INFO - Downloaded 1361 bytes. 15:05:26 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:05:26 INFO - Using the following test package requirements: 15:05:26 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:05:26 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:05:26 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:05:26 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:26 INFO - u'jsshell-linux-x86_64.zip'], 15:05:26 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:05:26 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:05:26 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:05:26 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:05:26 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:05:26 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:05:26 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:05:26 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')]} 15:05:26 INFO - https://queue.taskcluster.net/v1/task/HZ6mA3VuRaa_l7eyfXPiEQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:05:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HZ6mA3VuRaa_l7eyfXPiEQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:05:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HZ6mA3VuRaa_l7eyfXPiEQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:05:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HZ6mA3VuRaa_l7eyfXPiEQ/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 15:05:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HZ6mA3VuRaa_l7eyfXPiEQ/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 15:05:27 INFO - Downloaded 22750521 bytes. 15:05:27 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'] 15:05:27 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 15:05:28 INFO - Return code: 0 15:05:28 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 15:05: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')]} 15:05:28 INFO - https://queue.taskcluster.net/v1/task/HZ6mA3VuRaa_l7eyfXPiEQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:05:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HZ6mA3VuRaa_l7eyfXPiEQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:05:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HZ6mA3VuRaa_l7eyfXPiEQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:05:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HZ6mA3VuRaa_l7eyfXPiEQ/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 15:05:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HZ6mA3VuRaa_l7eyfXPiEQ/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 15:05:36 INFO - Downloaded 22750521 bytes. 15:05:36 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'] 15:05:36 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 15:05:37 INFO - Return code: 0 15:05: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')]} 15:05:37 INFO - https://queue.taskcluster.net/v1/task/HZ6mA3VuRaa_l7eyfXPiEQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:05:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HZ6mA3VuRaa_l7eyfXPiEQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:05:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HZ6mA3VuRaa_l7eyfXPiEQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:05:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HZ6mA3VuRaa_l7eyfXPiEQ/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 15:05:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HZ6mA3VuRaa_l7eyfXPiEQ/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 15:05:38 INFO - Downloaded 14403317 bytes. 15:05:38 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'] 15:05:38 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 15:05:38 INFO - Return code: 0 15:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:38 INFO - https://queue.taskcluster.net/v1/task/HZ6mA3VuRaa_l7eyfXPiEQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:05:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HZ6mA3VuRaa_l7eyfXPiEQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:05:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HZ6mA3VuRaa_l7eyfXPiEQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:05:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HZ6mA3VuRaa_l7eyfXPiEQ/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 15:05:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HZ6mA3VuRaa_l7eyfXPiEQ/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 15:05:40 INFO - Downloaded 56663546 bytes. 15:05:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HZ6mA3VuRaa_l7eyfXPiEQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:05:40 INFO - mkdir: /builds/slave/test/properties 15:05:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:05:40 INFO - Writing to file /builds/slave/test/properties/build_url 15:05:40 INFO - Contents: 15:05:40 INFO - build_url:https://queue.taskcluster.net/v1/task/HZ6mA3VuRaa_l7eyfXPiEQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:05:41 INFO - Running post-action listener: _resource_record_post_action 15:05:41 INFO - Running post-action listener: set_extra_try_arguments 15:05:41 INFO - ##### 15:05:41 INFO - ##### Finished download-and-extract step (success) 15:05:41 INFO - ##### 15:05:41 INFO - ##### 15:05:41 INFO - ##### Running populate-webroot step. 15:05:41 INFO - ##### 15:05:41 INFO - Running pre-action listener: _resource_record_pre_action 15:05:41 INFO - Running main action method: populate_webroot 15:05:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:05:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:05:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:05:41 INFO - '--tppagecycles', 15:05:41 INFO - '7'], 15:05:41 INFO - 'tests': ['tsvgm']}}, 15:05:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:05:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:05:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:05:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:05:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:05:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:05:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:41 INFO - 'talos_options': ['--disable-e10s'], 15:05:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:05:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:05:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:41 INFO - 'talos_options': ['--disable-e10s'], 15:05:41 INFO - 'tests': ['damp', 'tps']}, 15:05:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:41 INFO - 'tests': ['damp', 'tps']}, 15:05:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:05:41 INFO - 'tests': ['dromaeo_dom']}, 15:05:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:05:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:05:41 INFO - 'tests': ['basic_compositor_video']}, 15:05:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:05:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:05:41 INFO - 'tests': ['a11yr', 15:05:41 INFO - 'ts_paint', 15:05:41 INFO - 'tpaint', 15:05:41 INFO - 'sessionrestore', 15:05:41 INFO - 'sessionrestore_no_auto_restore', 15:05:41 INFO - 'tabpaint']}, 15:05:41 INFO - 'other-e10s': {'tests': ['a11yr', 15:05:41 INFO - 'ts_paint', 15:05:41 INFO - 'tpaint', 15:05:41 INFO - 'sessionrestore', 15:05:41 INFO - 'sessionrestore_no_auto_restore', 15:05:41 INFO - 'tabpaint']}, 15:05:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:05:41 INFO - 'ts_paint', 15:05:41 INFO - 'tpaint', 15:05:41 INFO - 'sessionrestore', 15:05:41 INFO - 'sessionrestore_no_auto_restore', 15:05:41 INFO - 'tabpaint']}, 15:05:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:05:41 INFO - 'ts_paint', 15:05:41 INFO - 'tpaint', 15:05:41 INFO - 'sessionrestore', 15:05:41 INFO - 'sessionrestore_no_auto_restore', 15:05:41 INFO - 'tabpaint']}, 15:05:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:05:41 INFO - 'tests': ['a11yr', 15:05:41 INFO - 'ts_paint', 15:05:41 INFO - 'tpaint', 15:05:41 INFO - 'sessionrestore', 15:05:41 INFO - 'sessionrestore_no_auto_restore', 15:05:41 INFO - 'tabpaint']}, 15:05:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:05:41 INFO - 'tests': ['a11yr', 15:05:41 INFO - 'ts_paint', 15:05:41 INFO - 'tpaint', 15:05:41 INFO - 'sessionrestore', 15:05:41 INFO - 'sessionrestore_no_auto_restore', 15:05:41 INFO - 'tabpaint']}, 15:05:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:05:41 INFO - 'tests': ['tsvgx', 15:05:41 INFO - 'tsvgr_opacity', 15:05:41 INFO - 'tart', 15:05:41 INFO - 'tscrollx', 15:05:41 INFO - 'cart']}, 15:05:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:05:41 INFO - 'tsvgr_opacity', 15:05:41 INFO - 'tart', 15:05:41 INFO - 'tscrollx', 15:05:41 INFO - 'cart']}, 15:05:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:41 INFO - 'talos_options': ['--disable-e10s'], 15:05:41 INFO - 'tests': ['tp5o']}, 15:05:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:41 INFO - 'tests': ['tp5o']}, 15:05:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:41 INFO - 'talos_options': ['--disable-e10s', 15:05:41 INFO - '--xperf_path', 15:05:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:05:41 INFO - 'tests': ['tp5n']}, 15:05:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:41 INFO - 'talos_options': ['--xperf_path', 15:05:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:05:41 INFO - 'tests': ['tp5n']}}, 15:05:41 INFO - 'talos.zip': {'path': '', 15:05:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:05:41 INFO - Running post-action listener: _resource_record_post_action 15:05:41 INFO - ##### 15:05:41 INFO - ##### Finished populate-webroot step (success) 15:05:41 INFO - ##### 15:05:41 INFO - ##### 15:05:41 INFO - ##### Running create-virtualenv step. 15:05:41 INFO - ##### 15:05:41 INFO - Running pre-action listener: _resource_record_pre_action 15:05:41 INFO - Running main action method: create_virtualenv 15:05:41 INFO - Creating virtualenv /builds/slave/test/build/venv 15:05:41 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 15:05:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:05:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:05:41 INFO - Using real prefix '/usr' 15:05:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:05:42 INFO - Installing distribute.............................................................................................................................................................................................done. 15:05:44 INFO - Installing pip.................done. 15:05:44 INFO - Return code: 0 15:05:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:44 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 0x271b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d9570>, '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 0x29da470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29da900>, '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': '826874ccc97bd7bf541b4875000001d5-1468358977.121291-1278041462', '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 15:05:44 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 15:05:44 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 15:05:44 INFO - Using env: {'DISPLAY': ':0', 15:05:44 INFO - 'HOME': '/home/cltbld', 15:05:44 INFO - 'LANG': 'en_US.UTF-8', 15:05:44 INFO - 'LANGUAGE': 'en_US:en', 15:05:44 INFO - 'LOGNAME': 'cltbld', 15:05:44 INFO - 'MAIL': '/var/mail/cltbld', 15:05:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:44 INFO - 'MOZ_NO_REMOTE': '1', 15:05:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:44 INFO - 'NO_EM_RESTART': '1', 15:05:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:44 INFO - 'PWD': '/builds/slave/test', 15:05:44 INFO - 'SHELL': '/bin/bash', 15:05:44 INFO - 'SHLVL': '1', 15:05:44 INFO - 'TERM': 'linux', 15:05:44 INFO - 'TMOUT': '86400', 15:05:44 INFO - 'USER': 'cltbld', 15:05:44 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1468358977.121291-1278041462', 15:05:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:44 INFO - '_': '/tools/buildbot/bin/python'} 15:05:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:44 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 15:05:44 INFO - Cleaning up... 15:05:44 INFO - Return code: 0 15:05:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:44 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 0x271b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d9570>, '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 0x29da470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29da900>, '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': '826874ccc97bd7bf541b4875000001d5-1468358977.121291-1278041462', '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 15:05:44 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 15:05:44 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 15:05:44 INFO - Using env: {'DISPLAY': ':0', 15:05:44 INFO - 'HOME': '/home/cltbld', 15:05:44 INFO - 'LANG': 'en_US.UTF-8', 15:05:44 INFO - 'LANGUAGE': 'en_US:en', 15:05:44 INFO - 'LOGNAME': 'cltbld', 15:05:44 INFO - 'MAIL': '/var/mail/cltbld', 15:05:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:44 INFO - 'MOZ_NO_REMOTE': '1', 15:05:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:44 INFO - 'NO_EM_RESTART': '1', 15:05:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:44 INFO - 'PWD': '/builds/slave/test', 15:05:44 INFO - 'SHELL': '/bin/bash', 15:05:44 INFO - 'SHLVL': '1', 15:05:44 INFO - 'TERM': 'linux', 15:05:44 INFO - 'TMOUT': '86400', 15:05:44 INFO - 'USER': 'cltbld', 15:05:44 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1468358977.121291-1278041462', 15:05:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:44 INFO - '_': '/tools/buildbot/bin/python'} 15:05:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:44 INFO - Downloading/unpacking psutil>=3.1.1 15:05:44 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 15:05:44 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 15:05:44 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 15:05:44 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 15:05:44 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 15:05:44 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 15:05:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:05:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:05:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:05:46 INFO - Installing collected packages: psutil 15:05:46 INFO - Running setup.py install for psutil 15:05:46 INFO - building 'psutil._psutil_linux' extension 15:05:46 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 15:05:46 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 15:05:46 INFO - building 'psutil._psutil_posix' extension 15:05:46 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 15:05:46 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 15:05:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:05:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:05:47 INFO - Successfully installed psutil 15:05:47 INFO - Cleaning up... 15:05:47 INFO - Return code: 0 15:05:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:47 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 0x271b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d9570>, '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 0x29da470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29da900>, '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': '826874ccc97bd7bf541b4875000001d5-1468358977.121291-1278041462', '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 15:05:47 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 15:05:47 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 15:05:47 INFO - Using env: {'DISPLAY': ':0', 15:05:47 INFO - 'HOME': '/home/cltbld', 15:05:47 INFO - 'LANG': 'en_US.UTF-8', 15:05:47 INFO - 'LANGUAGE': 'en_US:en', 15:05:47 INFO - 'LOGNAME': 'cltbld', 15:05:47 INFO - 'MAIL': '/var/mail/cltbld', 15:05:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:47 INFO - 'MOZ_NO_REMOTE': '1', 15:05:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:47 INFO - 'NO_EM_RESTART': '1', 15:05:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:47 INFO - 'PWD': '/builds/slave/test', 15:05:47 INFO - 'SHELL': '/bin/bash', 15:05:47 INFO - 'SHLVL': '1', 15:05:47 INFO - 'TERM': 'linux', 15:05:47 INFO - 'TMOUT': '86400', 15:05:47 INFO - 'USER': 'cltbld', 15:05:47 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1468358977.121291-1278041462', 15:05:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:47 INFO - '_': '/tools/buildbot/bin/python'} 15:05:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:05:47 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 15:05:47 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 15:05:47 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 15:05:47 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 15:05:47 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 15:05:47 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 15:05:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:05:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:05:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:05:49 INFO - Installing collected packages: mozsystemmonitor 15:05:49 INFO - Running setup.py install for mozsystemmonitor 15:05:49 INFO - Successfully installed mozsystemmonitor 15:05:49 INFO - Cleaning up... 15:05:50 INFO - Return code: 0 15:05:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:05: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')]} 15:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05: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')]} 15:05:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05: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', '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 0x271b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d9570>, '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 0x29da470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29da900>, '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': '826874ccc97bd7bf541b4875000001d5-1468358977.121291-1278041462', '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 15:05: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:05: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 jsonschema==2.5.1 15:05:50 INFO - Using env: {'DISPLAY': ':0', 15:05:50 INFO - 'HOME': '/home/cltbld', 15:05:50 INFO - 'LANG': 'en_US.UTF-8', 15:05:50 INFO - 'LANGUAGE': 'en_US:en', 15:05:50 INFO - 'LOGNAME': 'cltbld', 15:05:50 INFO - 'MAIL': '/var/mail/cltbld', 15:05:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:50 INFO - 'MOZ_NO_REMOTE': '1', 15:05:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:50 INFO - 'NO_EM_RESTART': '1', 15:05:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:50 INFO - 'PWD': '/builds/slave/test', 15:05:50 INFO - 'SHELL': '/bin/bash', 15:05:50 INFO - 'SHLVL': '1', 15:05:50 INFO - 'TERM': 'linux', 15:05:50 INFO - 'TMOUT': '86400', 15:05:50 INFO - 'USER': 'cltbld', 15:05:50 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1468358977.121291-1278041462', 15:05:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:50 INFO - '_': '/tools/buildbot/bin/python'} 15:05:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:50 INFO - Downloading/unpacking jsonschema==2.5.1 15:05: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 15:05: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 15:05: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 15:05: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 15:05: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 15:05: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 15:05:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:05:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:05: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 15:05: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 15:05: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 15:05: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 15:05: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 15:05: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 15:05:52 INFO - Downloading functools32-3.2.3-2.tar.gz 15:05:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:05:52 INFO - warning: no files found matching '*.txt' 15:05:52 INFO - no previously-included directories found matching 'build' 15:05:52 INFO - no previously-included directories found matching 'dist' 15:05:52 INFO - no previously-included directories found matching '.git*' 15:05:52 INFO - Installing collected packages: jsonschema, functools32 15:05:52 INFO - Running setup.py install for functools32 15:05:52 INFO - warning: no files found matching '*.txt' 15:05:52 INFO - no previously-included directories found matching 'build' 15:05:52 INFO - no previously-included directories found matching 'dist' 15:05:52 INFO - no previously-included directories found matching '.git*' 15:05:52 INFO - Successfully installed jsonschema functools32 15:05:52 INFO - Cleaning up... 15:05:52 INFO - Return code: 0 15:05:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:52 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 0x271b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d9570>, '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 0x29da470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29da900>, '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': '826874ccc97bd7bf541b4875000001d5-1468358977.121291-1278041462', '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 15:05:52 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 15:05:52 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 15:05:52 INFO - Using env: {'DISPLAY': ':0', 15:05:52 INFO - 'HOME': '/home/cltbld', 15:05:52 INFO - 'LANG': 'en_US.UTF-8', 15:05:52 INFO - 'LANGUAGE': 'en_US:en', 15:05:52 INFO - 'LOGNAME': 'cltbld', 15:05:52 INFO - 'MAIL': '/var/mail/cltbld', 15:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:52 INFO - 'MOZ_NO_REMOTE': '1', 15:05:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:52 INFO - 'NO_EM_RESTART': '1', 15:05:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:52 INFO - 'PWD': '/builds/slave/test', 15:05:52 INFO - 'SHELL': '/bin/bash', 15:05:52 INFO - 'SHLVL': '1', 15:05:52 INFO - 'TERM': 'linux', 15:05:52 INFO - 'TMOUT': '86400', 15:05:52 INFO - 'USER': 'cltbld', 15:05:52 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1468358977.121291-1278041462', 15:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:52 INFO - '_': '/tools/buildbot/bin/python'} 15:05:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:53 INFO - Downloading/unpacking blobuploader==1.2.4 15:05: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 15:05: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 15:05: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 15:05: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 15:05: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 15:05: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 15:05:55 INFO - Downloading blobuploader-1.2.4.tar.gz 15:05:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:05:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:05:55 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 15:05:55 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 15:05:55 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 15:05:55 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 15:05:55 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 15:05:55 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 15:05:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:05:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:05:55 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 15:05:55 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 15:05:55 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 15:05:55 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 15:05:55 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 15:05:55 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 15:05:55 INFO - Downloading docopt-0.6.1.tar.gz 15:05:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:05:55 INFO - Installing collected packages: blobuploader, requests, docopt 15:05:55 INFO - Running setup.py install for blobuploader 15:05:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:05:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:05:55 INFO - Running setup.py install for requests 15:05:56 INFO - Running setup.py install for docopt 15:05:56 INFO - Successfully installed blobuploader requests docopt 15:05:56 INFO - Cleaning up... 15:05:56 INFO - Return code: 0 15:05:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:05:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:56 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 0x271b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d9570>, '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 0x29da470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29da900>, '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': '826874ccc97bd7bf541b4875000001d5-1468358977.121291-1278041462', '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 15:05:56 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 15:05:56 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 15:05:56 INFO - Using env: {'DISPLAY': ':0', 15:05:56 INFO - 'HOME': '/home/cltbld', 15:05:56 INFO - 'LANG': 'en_US.UTF-8', 15:05:56 INFO - 'LANGUAGE': 'en_US:en', 15:05:56 INFO - 'LOGNAME': 'cltbld', 15:05:56 INFO - 'MAIL': '/var/mail/cltbld', 15:05:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:56 INFO - 'MOZ_NO_REMOTE': '1', 15:05:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:56 INFO - 'NO_EM_RESTART': '1', 15:05:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:56 INFO - 'PWD': '/builds/slave/test', 15:05:56 INFO - 'SHELL': '/bin/bash', 15:05:56 INFO - 'SHLVL': '1', 15:05:56 INFO - 'TERM': 'linux', 15:05:56 INFO - 'TMOUT': '86400', 15:05:56 INFO - 'USER': 'cltbld', 15:05:56 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1468358977.121291-1278041462', 15:05:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:56 INFO - '_': '/tools/buildbot/bin/python'} 15:05:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:05:56 INFO - Running setup.py (path:/tmp/pip-P__F67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:05:56 INFO - Running setup.py (path:/tmp/pip-dCPNmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:05:56 INFO - Running setup.py (path:/tmp/pip-ZDTECs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:05:56 INFO - Running setup.py (path:/tmp/pip-qj6P28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:05:56 INFO - Running setup.py (path:/tmp/pip-gxuU9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:05:57 INFO - Running setup.py (path:/tmp/pip-kmEuCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:05:57 INFO - Running setup.py (path:/tmp/pip-DijPSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:05:57 INFO - Running setup.py (path:/tmp/pip-Y5Tufk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:05:57 INFO - Running setup.py (path:/tmp/pip-F0TZwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:05:57 INFO - Running setup.py (path:/tmp/pip-bJKn7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:05:57 INFO - Running setup.py (path:/tmp/pip-eW3MDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:05:57 INFO - Running setup.py (path:/tmp/pip-Df9r8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:05:57 INFO - Running setup.py (path:/tmp/pip-u3zR2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:05:57 INFO - Running setup.py (path:/tmp/pip-jq76b4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:05:57 INFO - Running setup.py (path:/tmp/pip-RhozDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:05:57 INFO - Running setup.py (path:/tmp/pip-uokRbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:05:57 INFO - Running setup.py (path:/tmp/pip-mKRoxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:05:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:05:57 INFO - Running setup.py install for manifestparser 15:05:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:05:58 INFO - Running setup.py install for mozcrash 15:05:58 INFO - Running setup.py install for mozdebug 15:05:58 INFO - Running setup.py install for mozdevice 15:05:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:05:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:05:58 INFO - Running setup.py install for mozfile 15:05:58 INFO - Running setup.py install for mozhttpd 15:05:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:05:58 INFO - Running setup.py install for mozinfo 15:05:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:05:58 INFO - Running setup.py install for mozInstall 15:05:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:05:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:05:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:05:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:05:58 INFO - Running setup.py install for mozleak 15:05:58 INFO - Running setup.py install for mozlog 15:05:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:05:58 INFO - Running setup.py install for moznetwork 15:05:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:05:59 INFO - Running setup.py install for mozprocess 15:05:59 INFO - Running setup.py install for mozprofile 15:05:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:05:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:05:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:05:59 INFO - Running setup.py install for mozrunner 15:05:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:05:59 INFO - Running setup.py install for mozscreenshot 15:05:59 INFO - Running setup.py install for moztest 15:05:59 INFO - Running setup.py install for mozversion 15:05:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:05:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:05:59 INFO - Cleaning up... 15:05:59 INFO - Return code: 0 15:05:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:59 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 0x271b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d9570>, '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 0x29da470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29da900>, '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': '826874ccc97bd7bf541b4875000001d5-1468358977.121291-1278041462', '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 15:05:59 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 15:05:59 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 15:05:59 INFO - Using env: {'DISPLAY': ':0', 15:05:59 INFO - 'HOME': '/home/cltbld', 15:05:59 INFO - 'LANG': 'en_US.UTF-8', 15:05:59 INFO - 'LANGUAGE': 'en_US:en', 15:05:59 INFO - 'LOGNAME': 'cltbld', 15:05:59 INFO - 'MAIL': '/var/mail/cltbld', 15:05:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:59 INFO - 'MOZ_NO_REMOTE': '1', 15:05:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:59 INFO - 'NO_EM_RESTART': '1', 15:05:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:59 INFO - 'PWD': '/builds/slave/test', 15:05:59 INFO - 'SHELL': '/bin/bash', 15:05:59 INFO - 'SHLVL': '1', 15:05:59 INFO - 'TERM': 'linux', 15:05:59 INFO - 'TMOUT': '86400', 15:05:59 INFO - 'USER': 'cltbld', 15:05:59 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1468358977.121291-1278041462', 15:05:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:59 INFO - '_': '/tools/buildbot/bin/python'} 15:05:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:05:59 INFO - Running setup.py (path:/tmp/pip-9eFMPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:05:59 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)) 15:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:05:59 INFO - Running setup.py (path:/tmp/pip-BRW8sB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:06:00 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)) 15:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:06:00 INFO - Running setup.py (path:/tmp/pip-Lss6om-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:06:00 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)) 15:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:06:00 INFO - Running setup.py (path:/tmp/pip-RmAqNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:06:00 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)) 15:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:06:00 INFO - Running setup.py (path:/tmp/pip-6ZuA3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:06:00 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)) 15:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:06:00 INFO - Running setup.py (path:/tmp/pip-jRr8Sv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:06:00 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)) 15:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:06:00 INFO - Running setup.py (path:/tmp/pip-4LRzeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:06:00 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)) 15:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:06:00 INFO - Running setup.py (path:/tmp/pip-T8NlXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:06:00 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)) 15:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:06:00 INFO - Running setup.py (path:/tmp/pip-4kkiC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:06:00 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)) 15:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:06:00 INFO - Running setup.py (path:/tmp/pip-QJF6RL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:06:00 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)) 15:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:06:00 INFO - Running setup.py (path:/tmp/pip-rQ_fps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:06:00 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)) 15:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:06:00 INFO - Running setup.py (path:/tmp/pip-GUBg_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:06:00 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)) 15:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:06:00 INFO - Running setup.py (path:/tmp/pip-ihqoYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:06:00 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)) 15:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:06:00 INFO - Running setup.py (path:/tmp/pip-VbTlJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:06:00 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)) 15:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:06:00 INFO - Running setup.py (path:/tmp/pip-Au2YO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:06:01 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)) 15:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:06:01 INFO - Running setup.py (path:/tmp/pip-UKsvU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:06:01 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)) 15:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:06:01 INFO - Running setup.py (path:/tmp/pip-neCRja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:06:01 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)) 15:06:01 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)) 15:06:01 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)) 15:06:01 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)) 15:06:01 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)) 15:06:01 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)) 15:06:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:06:01 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 15:06:01 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 15:06:01 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 15:06:01 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 15:06:01 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 15:06:01 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 15:06:03 INFO - Downloading blessings-1.6.tar.gz 15:06:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:06:03 INFO - Installing collected packages: blessings 15:06:03 INFO - Running setup.py install for blessings 15:06:03 INFO - Successfully installed blessings 15:06:03 INFO - Cleaning up... 15:06:03 INFO - Return code: 0 15:06:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:06:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:06:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:06:03 INFO - Reading from file tmpfile_stdout 15:06:03 INFO - Current package versions: 15:06:03 INFO - argparse == 1.2.1 15:06:03 INFO - blessings == 1.6 15:06:03 INFO - blobuploader == 1.2.4 15:06:03 INFO - docopt == 0.6.1 15:06:03 INFO - functools32 == 3.2.3-2 15:06:03 INFO - jsonschema == 2.5.1 15:06:03 INFO - manifestparser == 1.1 15:06:03 INFO - mozInstall == 1.12 15:06:03 INFO - mozcrash == 0.17 15:06:03 INFO - mozdebug == 0.1 15:06:03 INFO - mozdevice == 0.48 15:06:03 INFO - mozfile == 1.2 15:06:03 INFO - mozhttpd == 0.7 15:06:03 INFO - mozinfo == 0.9 15:06:03 INFO - mozleak == 0.1 15:06:03 INFO - mozlog == 3.2 15:06:03 INFO - moznetwork == 0.27 15:06:03 INFO - mozprocess == 0.23 15:06:03 INFO - mozprofile == 0.28 15:06:03 INFO - mozrunner == 6.12 15:06:03 INFO - mozscreenshot == 0.1 15:06:03 INFO - mozsystemmonitor == 0.3 15:06:03 INFO - moztest == 0.7 15:06:03 INFO - mozversion == 1.4 15:06:03 INFO - psutil == 3.1.1 15:06:03 INFO - requests == 1.2.3 15:06:03 INFO - wsgiref == 0.1.2 15:06:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:03 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 0x271b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d9570>, '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 0x29da470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29da900>, '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': '826874ccc97bd7bf541b4875000001d5-1468358977.121291-1278041462', '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 15:06:03 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 15:06:03 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 15:06:03 INFO - Using env: {'DISPLAY': ':0', 15:06:03 INFO - 'HOME': '/home/cltbld', 15:06:03 INFO - 'LANG': 'en_US.UTF-8', 15:06:03 INFO - 'LANGUAGE': 'en_US:en', 15:06:03 INFO - 'LOGNAME': 'cltbld', 15:06:03 INFO - 'MAIL': '/var/mail/cltbld', 15:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:03 INFO - 'MOZ_NO_REMOTE': '1', 15:06:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:03 INFO - 'NO_EM_RESTART': '1', 15:06:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:03 INFO - 'PWD': '/builds/slave/test', 15:06:03 INFO - 'SHELL': '/bin/bash', 15:06:03 INFO - 'SHLVL': '1', 15:06:03 INFO - 'TERM': 'linux', 15:06:03 INFO - 'TMOUT': '86400', 15:06:03 INFO - 'USER': 'cltbld', 15:06:03 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1468358977.121291-1278041462', 15:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:03 INFO - '_': '/tools/buildbot/bin/python'} 15:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:03 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)) 15:06:03 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)) 15:06:03 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)) 15:06:03 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)) 15:06:03 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)) 15:06:03 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)) 15:06:03 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)) 15:06:03 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)) 15:06:03 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)) 15:06:03 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)) 15:06:03 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)) 15:06:03 INFO - Cleaning up... 15:06:03 INFO - Return code: 0 15:06:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:03 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 0x271b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d9570>, '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 0x29da470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29da900>, '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': '826874ccc97bd7bf541b4875000001d5-1468358977.121291-1278041462', '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 15:06:03 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 15:06:03 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 15:06:03 INFO - Using env: {'DISPLAY': ':0', 15:06:03 INFO - 'HOME': '/home/cltbld', 15:06:03 INFO - 'LANG': 'en_US.UTF-8', 15:06:03 INFO - 'LANGUAGE': 'en_US:en', 15:06:03 INFO - 'LOGNAME': 'cltbld', 15:06:03 INFO - 'MAIL': '/var/mail/cltbld', 15:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:03 INFO - 'MOZ_NO_REMOTE': '1', 15:06:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:03 INFO - 'NO_EM_RESTART': '1', 15:06:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:03 INFO - 'PWD': '/builds/slave/test', 15:06:03 INFO - 'SHELL': '/bin/bash', 15:06:03 INFO - 'SHLVL': '1', 15:06:03 INFO - 'TERM': 'linux', 15:06:03 INFO - 'TMOUT': '86400', 15:06:03 INFO - 'USER': 'cltbld', 15:06:03 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1468358977.121291-1278041462', 15:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:03 INFO - '_': '/tools/buildbot/bin/python'} 15:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:06:03 INFO - Cleaning up... 15:06:03 INFO - Return code: 0 15:06:03 INFO - Running post-action listener: _resource_record_post_action 15:06:03 INFO - Running post-action listener: _start_resource_monitoring 15:06:04 INFO - Starting resource monitoring. 15:06:04 INFO - ##### 15:06:04 INFO - ##### Finished create-virtualenv step (success) 15:06:04 INFO - ##### 15:06:04 INFO - ##### 15:06:04 INFO - ##### Running install step. 15:06:04 INFO - ##### 15:06:04 INFO - Running pre-action listener: _resource_record_pre_action 15:06:04 INFO - Running main action method: install 15:06:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:06:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:06:04 INFO - Reading from file tmpfile_stdout 15:06:04 INFO - Detecting whether we're running mozinstall >=1.0... 15:06:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:06:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:06:04 INFO - Reading from file tmpfile_stdout 15:06:04 INFO - Output received: 15:06:04 INFO - Usage: mozinstall [options] installer 15:06:04 INFO - Options: 15:06:04 INFO - -h, --help show this help message and exit 15:06:04 INFO - -d DEST, --destination=DEST 15:06:04 INFO - Directory to install application into. [default: 15:06:04 INFO - "/builds/slave/test"] 15:06:04 INFO - --app=APP Application being installed. [default: firefox] 15:06:04 INFO - mkdir: /builds/slave/test/build/application 15:06:04 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'] 15:06:04 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 15:06:20 INFO - Reading from file tmpfile_stdout 15:06:20 INFO - Output received: 15:06:20 INFO - /builds/slave/test/build/application/firefox/firefox 15:06:20 INFO - Running post-action listener: _resource_record_post_action 15:06:20 INFO - ##### 15:06:20 INFO - ##### Finished install step (success) 15:06:20 INFO - ##### 15:06:20 INFO - ##### 15:06:20 INFO - ##### Running run-tests step. 15:06:20 INFO - ##### 15:06:20 INFO - Running pre-action listener: _resource_record_pre_action 15:06:20 INFO - Running main action method: run_tests 15:06:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:06:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:06:20 INFO - Python 2.7.3 15:06:20 INFO - Return code: 0 15:06:20 INFO - grabbing minidump binary from tooltool 15:06:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:20 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 0x29d9570>, '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 0x29da470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29da900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:06:20 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 15:06:20 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 15:06:20 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 15:06:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:06:20 INFO - Return code: 0 15:06:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:06:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:06:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:06:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:06:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:06:20 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HZ6mA3VuRaa_l7eyfXPiEQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:06:20 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HZ6mA3VuRaa_l7eyfXPiEQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:06:20 INFO - Using env: {'DISPLAY': ':0', 15:06:20 INFO - 'HOME': '/home/cltbld', 15:06:20 INFO - 'LANG': 'en_US.UTF-8', 15:06:20 INFO - 'LANGUAGE': 'en_US:en', 15:06:20 INFO - 'LOGNAME': 'cltbld', 15:06:20 INFO - 'MAIL': '/var/mail/cltbld', 15:06:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:06:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:06:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:20 INFO - 'MOZ_NO_REMOTE': '1', 15:06:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:06:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:20 INFO - 'NO_EM_RESTART': '1', 15:06:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:20 INFO - 'PWD': '/builds/slave/test', 15:06:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:06:20 INFO - 'SHELL': '/bin/bash', 15:06:20 INFO - 'SHLVL': '1', 15:06:20 INFO - 'TERM': 'linux', 15:06:20 INFO - 'TMOUT': '86400', 15:06:20 INFO - 'USER': 'cltbld', 15:06:20 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1468358977.121291-1278041462', 15:06:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:20 INFO - '_': '/tools/buildbot/bin/python'} 15:06:20 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HZ6mA3VuRaa_l7eyfXPiEQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:06:20 INFO - mozversion application_buildid: 20160712143226 15:06:20 INFO - mozversion application_changeset: 8c882ca5b996591a83946d9828ece838bc1faef3 15:06:20 INFO - mozversion application_display_name: Nightly 15:06:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:06:20 INFO - mozversion application_name: Firefox 15:06:20 INFO - mozversion application_remotingname: firefox 15:06:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:06:20 INFO - mozversion application_vendor: Mozilla 15:06:20 INFO - mozversion application_version: 50.0a1 15:06:20 INFO - mozversion platform_buildid: 20160712143226 15:06:20 INFO - mozversion platform_changeset: 8c882ca5b996591a83946d9828ece838bc1faef3 15:06:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:06:20 INFO - mozversion platform_version: 50.0a1 15:06:20 INFO - using testdate: 1468361180 15:06:20 INFO - actual date: 1468361180 15:06:20 INFO - starting webserver on 'localhost:39225' 15:06:20 INFO - SUITE-START | Running 2 tests 15:06:20 INFO - TEST-START | dromaeo_css 15:06:20 INFO - operating with platform_type : linux_ 15:06:20 INFO - Initialising browser for dromaeo_css test... 15:06:20 INFO - TEST-INFO | started process 11275 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsNC7d6/profile http://localhost:39225/getInfo.html) 15:06:25 INFO - PROCESS | 11275 | __metrics Screen width/height:1600/1200 15:06:25 INFO - PROCESS | 11275 | colorDepth:24 15:06:25 INFO - PROCESS | 11275 | Browser inner width/height: 1024/697 15:06:25 INFO - PROCESS | 11275 | __metrics 15:06:26 ERROR - PROCESS | 11275 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 15:06:27 INFO - TEST-INFO | 11275: exit 0 15:06:27 INFO - Browser initialized. 15:06:27 INFO - Running cycle 1/1 for dromaeo_css test... 15:06:27 INFO - TEST-INFO | started process 11395 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsNC7d6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:06:39 INFO - PROCESS | 11395 | RSS: Main: 168628224 15:06:39 INFO - PROCESS | 11395 | 15:07:28 INFO - PROCESS | 11395 | 1468361248906 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] 15:09:41 INFO - PROCESS | 11395 | Cycle 1(1): loaded http://localhost:39225/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39225/tests/dromaeo/cssquery-ext.html) 15:09:42 INFO - PROCESS | 11395 | RSS: Main: 171921408 15:09:42 INFO - PROCESS | 11395 | 15:12:44 INFO - PROCESS | 11395 | Cycle 1(1): loaded http://localhost:39225/tests/dromaeo/cssquery-ext.html (next: http://localhost:39225/tests/dromaeo/cssquery-jquery.html) 15:12:45 INFO - PROCESS | 11395 | RSS: Main: 168873984 15:12:45 INFO - PROCESS | 11395 | 15:15:47 INFO - PROCESS | 11395 | Cycle 1(1): loaded http://localhost:39225/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39225/tests/dromaeo/cssquery-mootools.html) 15:15:47 INFO - PROCESS | 11395 | RSS: Main: 171634688 15:15:47 INFO - PROCESS | 11395 | 15:18:49 INFO - PROCESS | 11395 | Cycle 1(1): loaded http://localhost:39225/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39225/tests/dromaeo/cssquery-prototype.html) 15:18:50 INFO - PROCESS | 11395 | RSS: Main: 167092224 15:18:50 INFO - PROCESS | 11395 | 15:21:53 INFO - PROCESS | 11395 | Cycle 1(1): loaded http://localhost:39225/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39225/tests/dromaeo/cssquery-yui.html) 15:21:53 INFO - PROCESS | 11395 | RSS: Main: 169127936 15:21:53 INFO - PROCESS | 11395 | 15:24:56 INFO - PROCESS | 11395 | Cycle 1(1): loaded http://localhost:39225/tests/dromaeo/cssquery-yui.html (next: http://localhost:39225/tests/dromaeo/cssquery-dojo.html) 15:24:56 INFO - PROCESS | 11395 | RSS: Main: 169840640 15:24:56 INFO - PROCESS | 11395 | 15:24:56 INFO - PROCESS | 11395 | __start_tp_report 15:24:56 INFO - PROCESS | 11395 | _x_x_mozilla_page_load 15:24:56 INFO - PROCESS | 11395 | _x_x_mozilla_page_load_details 15:24:56 INFO - PROCESS | 11395 | |i|pagename|runs| 15:24:56 INFO - PROCESS | 11395 | |0;dojo.html;2644.3521337272364;2667.333166708323;2683.51696694595;2698.9055383061586;2706.242252169392;4741.359916411279;4765.070811191819;4822.228443449048;4824.493428190042;4834.347363105984;4689.3669354637195;4778.546038126373;4841.636877234204;4844.152273352158;4888.828890988816;4387.978060109703;4414.6830343342035;4512.029913568582;4517.774111294439;4539.773011349436;481.65108435105464;4392.758398288093;4441.5780500852525;4512.751798651073;4547.5452454754595;4393.472783265996;4398.714083584573;4419.447569053868;4421.447319085114;4464.754438505881;4336.7831608419765;4417.204903117437;4438.889027774299;4464.040231350243;4477.1493416250805;4353.3469979503325;4393.978030109861;4415.955840441587;4433.822647094113;4434.889127771831;4768.546988036166;4805.063012712522;4831.565159135659;4835.661503694742;4867.123917694814;4945.307656928033;5109.795608175668;5180.844574662766;5190.662606930538;5242.79028838846;5191.870203244949;5230.163173892159;5250.789968401259;5251.973740131275;5303.416624171338;4868.561829435368;4876.195427754452;4905.730184839868;4907.55831975124;4946.183879659816;5172.7155006475;5250.133727934848;5313.910648317085;5357.062514060024;5370.248165256867;5127.512886275872;5147.6396652234735;5158.045761534128;5158.484151584811;5194.558462530652;5197.896042079137;5220.582353411718;5236.816711415082;5240.397354304304;5298.443663415363;4914.164592019365;5041.6470847040355;5086.516780905808;5113.53978141969;5179.067767801832;4980.90038199234;5047.848564543069;5094.694318340911;5110.514501122388;5132.615053870974;4339.848105316299;4378.868633940987;4388.8902777430185;4392.890177745582;4421.513633500313;3725.7950812705562;3728.832202550892;3774.0564858785306;3781.4327850822597;3879.7090218233743;4438.090191510797;4451.732896026248;4462.6876118672035;4467.977660111678;4515.909681806345;5157.277981082651;5159.25190847325;5160.948390516121;5161.148410512298;5194.986977539344;4396;4444.400005999213;4494.393256910341;4511.210538155809;4518.457785065747;4653.8371157010015;4669.066186762593;4674.485806561275;4697.389339385926;4705.905881882343;4751.358566593604;4913.508649135058;4922.360093187863;4926.630502712239;4941.901161976741;5104.030234255628;5148.3564554430695;5169.327987361619;5195.506426889439;5197.974010129925;4832.323474713613;4859.586935110555;4862.222044472867;4865.56209941107;4915;4954.20732682769;5001.174806157089;5102.311187989574;5107.846764597068;5152.793888244429;5114.23286507012;5118.897622047463;5163.922541161811;5186.299849520266;5243.68537887728;5015.974920125376;5019.372578427697;5063.493650634907;5071.492850715046;5114.616403769806;4905.9018819624125;4975.900481990412;5030.597552195889;5060.49395060491;5067.41724701664;4840.709557426425;4858.125537403302;4867.878303042452;4904.435989861212;5036.320096786887;4987.9750601248215;5004.749762511933;5008.624353173599;5047.066292735855;5054.4692807254705;4925.113479573711;4926.137925863031;4937.333459982857;4941.085899108676;4970.65205435616 15:24:56 INFO - PROCESS | 11395 | |1;ext.html;549.4066408279059;557.8884223155369;562.1848319936094;571.3572231239855;606.0515293565572;36269.09327266819;39634.40548391776;39693;39718;39748.2050358993;38751.80624096883;39250.214995700066;39306.21387572247;39347.80326098365;39349.80325098378;7693.884591731128;7791.88312175315;7806.60966951653;7830.686772529092;7832.1776213497615;7842.921570784276;7855.803604909895;7866.68533258669;7927.04875414951;7944.563049032301;7948.165442628528;7957.403194760387;7975.361971042332;7991.120976692559;8003.079645840716;7920.445568810185;7926.801829954268;7952.642131104057;7965.8805117923275;7974.282314591715;7868.803279917991;7914.920850791534;7926.405519586054;7929.841403171962;7945.602719863984;36879.07802304937;37202.627973720184;37209.44185837215;37210.25579488422;37294;2429.514097180553;2859.2565932857606;2991.760659147263;2993.9101826945225;3037.4228896509812;25783.74216257832;26979.595306070423;27512.862435687694;27975.30061748452;28438;3327.7670563060597;3342.498625206214;3354.798712077283;3417.9145521361916;3462.3075384922863;216049;261275;263733;264003.0399544028;265039;31695;32806.179845504055;54574.18138727922;55375.169372459444;55468;34086.48870266948;34152.48771268433;34193.145171370415;34259.143521411665;34446;11017.394043327533;11031;11039.448027598748;11041.83437248442;11091.778164436828;10621.73445663849;10805.405702686428;10830.458477076114;10833.891661083288;10843.457827108614;7909.24862138096;7930.325922296669;7982.441229113906;8017.078036025815;8029.839403211903;3065.509518477033;3150.558921750957;3164.8259345736205;3172.857221425041;3173.444647186779;893.4014210478995;911.8404279251105;975.9609615615295;1013.4780587997187;1027.0807627173788;29012.12963611095;29016.27459313492;29088;29199.416011680074;29306.7069329304;938.1697197979701;964.064857088623;997.9401235925868;1007.2646967713611;1086.223350304536;14737.705245895237;15118.244087795787;15218.619534511505;15233.6191595211;15298.388064477296;118268.40865795616;118647;419247;420706;423934;50457.747711261945;50790.74604626953;51109.23336149961;51114.744426278376;51137.23294150591;1154.3650991954391;1175.8059920113258;1175.8295047218105;1185.82805493203;1208.5769980506752;26975.190744277705;28411.289717756394;28475;28503.852676048384;28703.569446458736;43520.34719479147;43783;44066;44087.33868992032;44092.55907441013;341711;344351.22595095914;344594;345573;350339;24932.750672493043;25178.24465266045;25845.48309033771;25967.870160649833;25994.220173394828;43065.78467107644;43336.566634333256;43686.34470483009;43761;44179.77910110429;37954.311770753775;37979.24041519209;38104.618953811216;38424.42363364496;38429.80785096057;37852.86441406762;38470.615293846706;38514.614853851104;38655.80672096622;38667.613323866404;31419.214519636276;36231.27537449184;36593.26813463662;36624.81687591545;36910.8154459226;31758.841205793822;33991.66008339885;34257.82871085629;34322.65677343195;34638.653613463546;26210.213693589223;26353.868230658725;26613.334666633487;26775.598366024136;26814 15:24:56 INFO - PROCESS | 11395 | |2;jquery.html;367.54608059047086;370.5830940192284;371.2556324569238;380.9085819403344;389.861599132308;16342.428015019463;17232.74150887736;17552.47342579723;17721.822781772178;17794.911025444853;16112.919435402806;16166.676666466663;17660.38188663397;17675.116244187804;17737.29050837965;4667.836625718092;4826.420829500465;4853.199222128344;4854.611631069523;4856.708597484145;3533.505309256706;5363.651362661434;5595.720213989304;5603.691796951166;5679.034564124109;5668.319801623811;5673.12066629671;5673.234113394701;5683.971580142093;5734.254546908917;6161.137440758297;6177.907331390033;6178.135061091451;6187.443130118266;6222.688865556704;5355.464453554652;5479.835604931858;5492;5492.478214569649;5493.7802487900435;13150.934245328808;13174.27541485218;17860.642787144316;21114.788852111436;21426;1914.2917120665304;1936.457791818279;1963.1950900130878;2168.9697393738006;2203.911843526257;9125.452472851584;9206.90793092074;9424.387414818015;9476.668316608886;9815.067568580973;1651.7488226684864;1669.8413650703164;1699.5156380431517;1724.9827501725074;1732.774739283885;72270.27729722741;74359;75204.6239768803;75428.62285688591;76215.61892190503;9742.220622350336;9923.206143508502;10114.140298074746;10214.336068155695;10249.436281004468;13941;14027;14050;14060.507882224074;14093;6799.218089919624;6811.182658081062;6830.248672646005;6959.6868140933775;7027.332403421667;6175.320714721377;6368.140301059298;6443.323451037573;6448.709808058648;6450.3549645036055;4331.631811296075;4385.188740083095;4408.162449134654;4479.977600111979;4532.614727748179;1602.1428535733326;1652.107861754663;1689.298940939521;1692.2723229011642;1702.7105392083377;854.9444286121383;895.6730793260413;900.4372267332917;913.0230653201011;939.5631031570352;16932.306769322968;17185.656286874193;17526.737098943526;17578.12109394525;18032.90983545074;817.2522142239784;860.3762272352494;876.548577482597;882.5322579033123;894.7941973346167;9745.951270243604;9766.95116524427;9778.07108324708;9895.752606184902;9927.15619172364;381296;397072;397846;399566;403860;84847;91540;91898.54050729703;93446.53276733709;94048.52975735077;872.6073267029861;895.7146494780012;913.7624217703445;914.6981496106268;919.8344298026419;14739.778903316674;14857.628559286104;15063.246837658293;15108.39566417331;15377.538673839803;25416.110436134648;26593.202203933914;38847.805760971016;39736.40395394129;40071.39892901667;54966.450335497735;56676;57180.71409642925;57348.71325643345;57541.42458575361;7616.885746713693;7741.535507869546;7748.4576079676135;7827.686892524235;7918.524888506708;8570.228679418882;10562.31344962575;10770;11346.0355869752;11833.82249266279;9512.096350846936;9889.752756181153;9954;10090;10169;9657;9810.87174974887;9819.9018009819;10119.089281964658;10420.583176672848;9923.900760992297;10165.339252948535;10516.836141418578;10622.787544249226;10799.730006749895;6987.231404545598;7617.314441700052;7728.922710773045;7890.842183156419;7941.602919853869;8390.664373424994;9785.951070244602;9826.9017309826;10091.243156763125;10311.060766398688 15:24:56 INFO - PROCESS | 11395 | |3;mootools.html;1337.1041402260485;1386.154445788069;1454.8108745863037;1672.5985763416784;1686.6963946489634;6477.417032467077;7161.785146445608;7196.172440169382;7699.114601820792;7706.4990775599545;7326;7513.962430187841;7643.808904777384;7645.770626881203;7646.235376462351;2172.7284089488853;2229.788170123844;2233.352327824929;2236.586231547161;2237.1163390460756;2156.137544982012;2172.598069357174;2223.266322113707;2233.586786444505;2235.6870038194666;2166.80498755112;2187.103287652063;2191.4302281406867;2195.067096483988;2228.9777102229014;2087.092114930003;2097.2345094040643;2101.443117573844;2102.568973360457;2110.8416868734753;2109.862858914181;2151.6449785785326;2154.278316763886;2155.622766015941;2160.3302976077466;7554.131274903401;7560.508566943131;7629.084509858797;7640.885386719204;7665.961670191669;4393;4445.844395446176;4556.703814252063;4579.885502862422;4592.150452166326;2842.545192769147;2888.393437378153;2930.0184438213223;2948.3513627002026;2954.6897575754665;895.901450840407;901.4411065139656;913.488446469979;914.1087439746261;917.6375331743924;9917.057879501435;9954.751131221778;10003.299769016172;10041;10086.041826026516;3839.4432807242792;3910.3547914593773;4033.8184781684895;4050.4734384529825;4096;7602.391808655294;7672.117706463828;7673.808154796175;7701.730439434705;7716.074071111502;4447.399601053881;4472.485664148599;4483;4484.618807401407;4486.798094085774;3502.4571191465366;4008.6191811777835;4110.445089912883;4197.097624010852;4206.957930420718;3312.188513814131;3363.209645733251;3469.410200265961;3476.80877551732;3543.344481270973;1021.255438160348;1026.3995562595817;1032.2155162076876;1032.7934413117407;1055.2138656700806;759.6885277036389;784.0395515493475;786.0685088170536;798.4889670610813;807.4025221336169;5156.8968620627375;5166.457521960216;5269.868253293698;5281.788728450819;5439.5104440600535;390.65036792071504;390.89961757652117;392.6976228304247;393.5120450641184;396.17595401564677;3490.795675491951;3498.755087143926;3529.241213139136;3540.6282340354405;3566.589842168132;8492.320614350838;8946.284297256203;8962.507062111647;9245.861312080324;9345.439273643467;9182.449053056838;9185.862212066824;9213.585388657526;9245.445273283625;9291.070892910655;6887.173539175231;7024.683889224997;7029;7056.6118863463;7059.78820635392;5162.6902385856965;5436.7553460093595;5467.617266791286;5593.853260081755;5648.926703926241;8630.78423039404;8698.260647845003;8702.738917832476;8720.389572729848;8748.956255218684;8533.189347012023;8543.231109200202;8709.346798989975;8735.475871447734;8780.165884240987;5808.82573522795;6208.844778880564;6396.136521569715;6544.8363790905605;6677.465802735866;7113.893291600733;7119.394851437479;7152;7178.5692858428665;7201.675924583302;6469.2560355557835;6683.63240021784;6717.395434410926;6736.056952026622;6760.459163267025;6486.318936511599;6490.545661803629;6634.635095069818;6691.866162676622;6708.83227919306;6199.659018753831;6223.3465486125115;6264.59280146789;6266.404691554295;6268.091126786681;4200.4959404871615;4352.412424322676;4359.215341238608;4430.490493593278;4442.044960333544;4371.322445021026;4474.463064432289;4538.432695913011;4583.679142459996;4594.379758732528 15:24:56 INFO - PROCESS | 11395 | |4;prototype.html;291.0004135793548;293.1294056651744;294.1513732880641;296.4249356248878;301.4438361223543;5158.742062896849;5167.896642067157;5174.767135478908;5181.637285390024;5201.505856943589;5071.467495912932;5085.949140508594;5087.949120508793;5091.236314552819;5103.438621751604;3787.7159213059062;3855.20968201518;3951.427043078752;3967.246223217594;3981;3898.7465814721954;3934.3114954882926;3952.1107750756137;3955.20895820837;3976.2643910876436;3933.5869733677837;3951.683865290784;3951.841926322958;3968.56345801963;3970.940435893464;3802.6957843372466;3887.2031233597045;3905.3556163233034;3960.881173564798;3966.107625784204;3445.5012069749737;3451.9827400863087;3456.7580269381156;3458.515807786912;3469.5836499619954;4872.756362181876;4888.071266459397;4899.632527560448;4927.226198568513;4933.136701077297;4385.429894113777;4503.234450143484;4529.297958816356;4529.796159172845;4541.5231400703115;5266.34170728659;5307.893842123174;5315.750798562335;5332.280536926157;5346.4386239445075;3830.4062870255157;3838.9616103838885;3839.117003089277;3846.519185101862;3854.209886973164;5388.892222155535;5508.6970216638065;5566.137248726453;5597.524210442118;5600.85997850057;3857.3828187489867;3874.6900247980093;3892.4939757831303;3909.159530700913;3915.2169566086895;3943.191645712622;3976.622220889011;3978.612832300654;3979.4826672532386;3985.5416627087675;4479.507254202035;4532.161550113239;4534.863954081383;4537.228671125917;4537.481697657831;5065.670731402521;5219.947800522022;5273.736313184326;5287.365516138011;5323.361196656426;1375.2985977151525;1397.105852254558;1398.2309729648653;1399.0975820595863;1402.7685431903826;854.8974123105143;880.0451510111473;892.6607889002267;899.2670973156987;910.8952470465849;4536.8638940831825;4674.813007479663;4676.719396836133;4688.718676879398;4710.858674239778;5434.690256640991;5462.449407884827;5467.644603100785;5489.560835133179;5511.704749383892;4487.842925497592;4673.485916549177;4685.250359942393;4693.436787585511;4694.131585656596;2901.5502597097484;2934.075766133661;2939.603688248108;2943.455460739727;2959.733623973853;5126.487351264918;5139.640225184276;5156.252343410185;5172.431032586413;5174.586033117342;5421.891562168735;5558;5580.748866301026;5601.243832082698;5656.123300888369;5106.234064890296;5111.463296353903;5118.38579370478;5122.231665250242;5145.639805213599;5513.338399392099;5531.585131115263;5536.141898005815;5537;5557;5242;5260.447652996533;5331.280277162688;5340.332458442695;5359.785608575613;5033.672811267256;5086.465921078381;5087.414947280962;5107.387113546398;5113.079645663816;3910.7066969976795;3934.350832112669;3944.3491823848744;3961.504811898513;3966.9801650991562;5159.742012899415;5435.918461223006;5440.591955603267;5522.144067669517;5527.64070335443;5333.013392522395;5336.226247194213;5367.3827509836865;5367.436419176087;5422.15956526739;5213.4027521010385;5298.205269209495;5378.354597448331;5406.297181366397;5426.589086837372;5235.502627250406;5270.341207349082;5271.683698978073;5282.31329927107;5299.152135658276;5110.872228194325;5248.186531087687;5350.946490535045;5392.919106213489;5399.676019438846;5193.480651934777;5201.427842937198;5203.947960520498;5222;5227.607929405233 15:24:56 INFO - PROCESS | 11395 | |5;yui.html;641.845956970327;715.5992644119293;752.9058867641543;753.5704648350439;765.1430397954285;12948.352582370879;13337.799933001013;13349.532766353179;13375.13061650992;13399.598012059641;11632.825507617392;11714.297142171476;11747.588834390797;11783.821617838212;14403.495877644285;770.96916123355;778.4861991085885;782.2060608482395;782.9843403131933;783.9490433121857;783.5181363461487;784.9254320839511;785.8231897823001;786.7797016835295;786.8544319300947;822.7778499805049;823.390690888744;824.3364091906013;824.9628766705513;827.4993628854546;815.6941147069849;817.0440584516131;817.8773184022415;820.0610301205087;821.7534739578133;597.9790707325267;598.727578951576;599.7211296747033;600.2826622186489;601.969901504923;11487.770244595062;11507.252028618113;11510.539578416854;11532.596359127474;11561.728209896904;13484.595462136054;13683.31583420835;13765.242911639856;13806.792898106536;13815.51645692406;10668.839967400496;10710.571577136905;10942.015218630362;11033.503492342863;11080.279781814157;3343.3480471308103;3348.2131699050706;3390.6609339066144;3426.5202871597994;3426.554547908781;42179;43079.13841723148;53474;53649.731751340994;60728;10523.631672891412;10605.522751476203;10663.73340666474;10690.73273168177;10911.072558832588;17028.744568831476;17662.823371766375;17724.202410891285;18331.725024124647;18368.632627347644;6872.931270687329;6923.5499692519825;7004.754833580801;7061.89407158893;7070.505064645528;3620.8551657933913;3688.6311368863435;3730.272596843644;3779.527559055118;3867.0332416895776;2781.1100447856493;2876.8273903565855;2877.510823160068;2879.7840161987933;2880.5679148127947;516.1432022842064;524.4702850121405;531.4579129288104;536.1957064403394;539.870431096534;496.28782696830166;552.1827695011325;589.1633879890566;605.9091136329498;606.6057062909056;7889.06651838468;8088.474249173785;8135.959320203361;8182.263596276244;8313.41806073569;581.6161333519857;588.0591054313065;589.9410558048313;608.8340235429064;610.3784246660604;3918.7256892017285;3989.261986532501;4010.057636455431;4042.413849991735;4059.8579049733116;91635.54182229046;94823.52588237153;94856;95239;95344.04655953491;60717.39282607206;79285.60357198292;80447.59776201082;80995.59502202451;87565;47027;75331.62334188294;75335;75937.24062759412;76379;8610;9257.861132083159;9393.107654772786;9394.718158455258;9436.480993545421;42511.1497770049;42661;42791.572084278756;43408;44554.3316850254;61940;62062.37937620566;62799.37200627935;62885.37114628795;62917.685411572646;11454.427278636202;11474.77050459003;11492.47746209031;11623.1282653803;11869.465874035517;12638.747225055631;12685.746285074432;12845.165064270792;13132.34338283063;13702.383392747151;12166;12239.694007649523;12271.079669025037;12345;12991.350432478528;11790.469428875549;12223.93888030554;12998.675033124247;13120.343982801012;13187.736245275233;11903.851976116868;12121.75756484883;12249.265044097026;12493.312867792358;13069.15050521713;10286;10724.142068634646;11032.779344413228;11124.499397526968;11263.211575189658;9502.239820814457;9563.187129094105;9573.18627916635;9611.807763844545;9632.9036709632 15:24:56 INFO - PROCESS | 11395 | __end_tp_report 15:24:56 INFO - PROCESS | 11395 | __start_cc_report 15:24:56 INFO - PROCESS | 11395 | _x_x_mozilla_cycle_collect,408 15:24:56 INFO - PROCESS | 11395 | __end_cc_report 15:24:56 INFO - PROCESS | 11395 | __startTimestamp1468362296772__endTimestamp 15:24:56 INFO - PROCESS | 11395 | 15:24:56 INFO - PROCESS | 11395 | ------- Summary: start ------- 15:24:56 INFO - PROCESS | 11395 | Number of tests: 6 15:24:56 INFO - PROCESS | 11395 | 15:24:56 INFO - PROCESS | 11395 | [#0] dojo.html Cycles:165 Average:4746.86 Median:4905.90 stddev:604.64 (12.3%) stddev-sans-first:583.57 15:24:56 INFO - PROCESS | 11395 | Values: 2644.4 2667.3 2683.5 2698.9 2706.2 4741.4 4765.1 4822.2 4824.5 4834.3 4689.4 4778.5 4841.6 4844.2 4888.8 4388.0 4414.7 4512.0 4517.8 4539.8 481.7 4392.8 4441.6 4512.8 4547.5 4393.5 4398.7 4419.4 4421.4 4464.8 4336.8 4417.2 4438.9 4464.0 4477.1 4353.3 4394.0 4416.0 4433.8 4434.9 4768.5 4805.1 4831.6 4835.7 4867.1 4945.3 5109.8 5180.8 5190.7 5242.8 5191.9 5230.2 5250.8 5252.0 5303.4 4868.6 4876.2 4905.7 4907.6 4946.2 5172.7 5250.1 5313.9 5357.1 5370.2 5127.5 5147.6 5158.0 5158.5 5194.6 5197.9 5220.6 5236.8 5240.4 5298.4 4914.2 5041.6 5086.5 5113.5 5179.1 4980.9 5047.8 5094.7 5110.5 5132.6 4339.8 4378.9 4388.9 4392.9 4421.5 3725.8 3728.8 3774.1 3781.4 3879.7 4438.1 4451.7 4462.7 4468.0 4515.9 5157.3 5159.3 5160.9 5161.1 5195.0 4396.0 4444.4 4494.4 4511.2 4518.5 4653.8 4669.1 4674.5 4697.4 4705.9 4751.4 4913.5 4922.4 4926.6 4941.9 5104.0 5148.4 5169.3 5195.5 5198.0 4832.3 4859.6 4862.2 4865.6 4915.0 4954.2 5001.2 5102.3 5107.8 5152.8 5114.2 5118.9 5163.9 5186.3 5243.7 5016.0 5019.4 5063.5 5071.5 5114.6 4905.9 4975.9 5030.6 5060.5 5067.4 4840.7 4858.1 4867.9 4904.4 5036.3 4988.0 5004.7 5008.6 5047.1 5054.5 4925.1 4926.1 4937.3 4941.1 4970.7 15:24:56 INFO - PROCESS | 11395 | 15:24:56 INFO - PROCESS | 11395 | [#1] ext.html Cycles:180 Average:44828.77 Median:36431.18 stddev:83256.37 (228.5%) stddev-sans-first:83423.55 15:24:56 INFO - PROCESS | 11395 | Values: 549.4 557.9 562.2 571.4 606.1 36269.1 39634.4 39693.0 39718.0 39748.2 38751.8 39250.2 39306.2 39347.8 39349.8 7693.9 7791.9 7806.6 7830.7 7832.2 7842.9 7855.8 7866.7 7927.0 7944.6 7948.2 7957.4 7975.4 7991.1 8003.1 7920.4 7926.8 7952.6 7965.9 7974.3 7868.8 7914.9 7926.4 7929.8 7945.6 36879.1 37202.6 37209.4 37210.3 37294.0 2429.5 2859.3 2991.8 2993.9 3037.4 25783.7 26979.6 27512.9 27975.3 28438.0 3327.8 3342.5 3354.8 3417.9 3462.3 216049.0 261275.0 263733.0 264003.0 265039.0 31695.0 32806.2 54574.2 55375.2 55468.0 34086.5 34152.5 34193.1 34259.1 34446.0 11017.4 11031.0 11039.4 11041.8 11091.8 10621.7 10805.4 10830.5 10833.9 10843.5 7909.2 7930.3 7982.4 8017.1 8029.8 3065.5 3150.6 3164.8 3172.9 3173.4 893.4 911.8 976.0 1013.5 1027.1 29012.1 29016.3 29088.0 29199.4 29306.7 938.2 964.1 997.9 1007.3 1086.2 14737.7 15118.2 15218.6 15233.6 15298.4 118268.4 118647.0 419247.0 420706.0 423934.0 50457.7 50790.7 51109.2 51114.7 51137.2 1154.4 1175.8 1175.8 1185.8 1208.6 26975.2 28411.3 28475.0 28503.9 28703.6 43520.3 43783.0 44066.0 44087.3 44092.6 341711.0 344351.2 344594.0 345573.0 350339.0 24932.8 25178.2 25845.5 25967.9 25994.2 43065.8 43336.6 43686.3 43761.0 44179.8 37954.3 37979.2 38104.6 38424.4 38429.8 37852.9 38470.6 38514.6 38655.8 38667.6 31419.2 36231.3 36593.3 36624.8 36910.8 31758.8 33991.7 34257.8 34322.7 34638.7 26210.2 26353.9 26613.3 26775.6 26814.0 15:24:56 INFO - PROCESS | 11395 | 15:24:56 INFO - PROCESS | 11395 | [#2] jquery.html Cycles:180 Average:24989.74 Median:5485.92 stddev:65904.20 (1201.3%) stddev-sans-first:66063.15 15:24:56 INFO - PROCESS | 11395 | Values: 367.5 370.6 371.3 380.9 389.9 16342.4 17232.7 17552.5 17721.8 17794.9 16112.9 16166.7 17660.4 17675.1 17737.3 4667.8 4826.4 4853.2 4854.6 4856.7 3533.5 5363.7 5595.7 5603.7 5679.0 5668.3 5673.1 5673.2 5684.0 5734.3 6161.1 6177.9 6178.1 6187.4 6222.7 5355.5 5479.8 5492.0 5492.5 5493.8 13150.9 13174.3 17860.6 21114.8 21426.0 1914.3 1936.5 1963.2 2169.0 2203.9 9125.5 9206.9 9424.4 9476.7 9815.1 1651.7 1669.8 1699.5 1725.0 1732.8 72270.3 74359.0 75204.6 75428.6 76215.6 9742.2 9923.2 10114.1 10214.3 10249.4 13941.0 14027.0 14050.0 14060.5 14093.0 6799.2 6811.2 6830.2 6959.7 7027.3 6175.3 6368.1 6443.3 6448.7 6450.4 4331.6 4385.2 4408.2 4480.0 4532.6 1602.1 1652.1 1689.3 1692.3 1702.7 854.9 895.7 900.4 913.0 939.6 16932.3 17185.7 17526.7 17578.1 18032.9 817.3 860.4 876.5 882.5 894.8 9746.0 9767.0 9778.1 9895.8 9927.2 381296.0 397072.0 397846.0 399566.0 403860.0 84847.0 91540.0 91898.5 93446.5 94048.5 872.6 895.7 913.8 914.7 919.8 14739.8 14857.6 15063.2 15108.4 15377.5 25416.1 26593.2 38847.8 39736.4 40071.4 54966.5 56676.0 57180.7 57348.7 57541.4 7616.9 7741.5 7748.5 7827.7 7918.5 8570.2 10562.3 10770.0 11346.0 11833.8 9512.1 9889.8 9954.0 10090.0 10169.0 9657.0 9810.9 9819.9 10119.1 10420.6 9923.9 10165.3 10516.8 10622.8 10799.7 6987.2 7617.3 7728.9 7890.8 7941.6 8390.7 9786.0 9826.9 10091.2 10311.1 15:24:56 INFO - PROCESS | 11395 | 15:24:56 INFO - PROCESS | 11395 | [#3] mootools.html Cycles:180 Average:4933.95 Median:5218.16 stddev:2722.46 (52.2%) stddev-sans-first:2716.68 15:24:56 INFO - PROCESS | 11395 | Values: 1337.1 1386.2 1454.8 1672.6 1686.7 6477.4 7161.8 7196.2 7699.1 7706.5 7326.0 7514.0 7643.8 7645.8 7646.2 2172.7 2229.8 2233.4 2236.6 2237.1 2156.1 2172.6 2223.3 2233.6 2235.7 2166.8 2187.1 2191.4 2195.1 2229.0 2087.1 2097.2 2101.4 2102.6 2110.8 2109.9 2151.6 2154.3 2155.6 2160.3 7554.1 7560.5 7629.1 7640.9 7666.0 4393.0 4445.8 4556.7 4579.9 4592.2 2842.5 2888.4 2930.0 2948.4 2954.7 895.9 901.4 913.5 914.1 917.6 9917.1 9954.8 10003.3 10041.0 10086.0 3839.4 3910.4 4033.8 4050.5 4096.0 7602.4 7672.1 7673.8 7701.7 7716.1 4447.4 4472.5 4483.0 4484.6 4486.8 3502.5 4008.6 4110.4 4197.1 4207.0 3312.2 3363.2 3469.4 3476.8 3543.3 1021.3 1026.4 1032.2 1032.8 1055.2 759.7 784.0 786.1 798.5 807.4 5156.9 5166.5 5269.9 5281.8 5439.5 390.7 390.9 392.7 393.5 396.2 3490.8 3498.8 3529.2 3540.6 3566.6 8492.3 8946.3 8962.5 9245.9 9345.4 9182.4 9185.9 9213.6 9245.4 9291.1 6887.2 7024.7 7029.0 7056.6 7059.8 5162.7 5436.8 5467.6 5593.9 5648.9 8630.8 8698.3 8702.7 8720.4 8749.0 8533.2 8543.2 8709.3 8735.5 8780.2 5808.8 6208.8 6396.1 6544.8 6677.5 7113.9 7119.4 7152.0 7178.6 7201.7 6469.3 6683.6 6717.4 6736.1 6760.5 6486.3 6490.5 6634.6 6691.9 6708.8 6199.7 6223.3 6264.6 6266.4 6268.1 4200.5 4352.4 4359.2 4430.5 4442.0 4371.3 4474.5 4538.4 4583.7 4594.4 15:24:56 INFO - PROCESS | 11395 | 15:24:56 INFO - PROCESS | 11395 | [#4] prototype.html Cycles:180 Average:4418.13 Median:5087.68 stddev:1280.98 (25.2%) stddev-sans-first:1246.55 15:24:56 INFO - PROCESS | 11395 | Values: 291.0 293.1 294.2 296.4 301.4 5158.7 5167.9 5174.8 5181.6 5201.5 5071.5 5085.9 5087.9 5091.2 5103.4 3787.7 3855.2 3951.4 3967.2 3981.0 3898.7 3934.3 3952.1 3955.2 3976.3 3933.6 3951.7 3951.8 3968.6 3970.9 3802.7 3887.2 3905.4 3960.9 3966.1 3445.5 3452.0 3456.8 3458.5 3469.6 4872.8 4888.1 4899.6 4927.2 4933.1 4385.4 4503.2 4529.3 4529.8 4541.5 5266.3 5307.9 5315.8 5332.3 5346.4 3830.4 3839.0 3839.1 3846.5 3854.2 5388.9 5508.7 5566.1 5597.5 5600.9 3857.4 3874.7 3892.5 3909.2 3915.2 3943.2 3976.6 3978.6 3979.5 3985.5 4479.5 4532.2 4534.9 4537.2 4537.5 5065.7 5219.9 5273.7 5287.4 5323.4 1375.3 1397.1 1398.2 1399.1 1402.8 854.9 880.0 892.7 899.3 910.9 4536.9 4674.8 4676.7 4688.7 4710.9 5434.7 5462.4 5467.6 5489.6 5511.7 4487.8 4673.5 4685.3 4693.4 4694.1 2901.6 2934.1 2939.6 2943.5 2959.7 5126.5 5139.6 5156.3 5172.4 5174.6 5421.9 5558.0 5580.7 5601.2 5656.1 5106.2 5111.5 5118.4 5122.2 5145.6 5513.3 5531.6 5536.1 5537.0 5557.0 5242.0 5260.4 5331.3 5340.3 5359.8 5033.7 5086.5 5087.4 5107.4 5113.1 3910.7 3934.4 3944.3 3961.5 3967.0 5159.7 5435.9 5440.6 5522.1 5527.6 5333.0 5336.2 5367.4 5367.4 5422.2 5213.4 5298.2 5378.4 5406.3 5426.6 5235.5 5270.3 5271.7 5282.3 5299.2 5110.9 5248.2 5350.9 5392.9 5399.7 5193.5 5201.4 5203.9 5222.0 5227.6 15:24:56 INFO - PROCESS | 11395 | 15:24:56 INFO - PROCESS | 11395 | [#5] yui.html Cycles:180 Average:17102.65 Median:43981.17 stddev:23852.11 (54.2%) stddev-sans-first:23887.00 15:24:56 INFO - PROCESS | 11395 | Values: 641.8 715.6 752.9 753.6 765.1 12948.4 13337.8 13349.5 13375.1 13399.6 11632.8 11714.3 11747.6 11783.8 14403.5 771.0 778.5 782.2 783.0 783.9 783.5 784.9 785.8 786.8 786.9 822.8 823.4 824.3 825.0 827.5 815.7 817.0 817.9 820.1 821.8 598.0 598.7 599.7 600.3 602.0 11487.8 11507.3 11510.5 11532.6 11561.7 13484.6 13683.3 13765.2 13806.8 13815.5 10668.8 10710.6 10942.0 11033.5 11080.3 3343.3 3348.2 3390.7 3426.5 3426.6 42179.0 43079.1 53474.0 53649.7 60728.0 10523.6 10605.5 10663.7 10690.7 10911.1 17028.7 17662.8 17724.2 18331.7 18368.6 6872.9 6923.5 7004.8 7061.9 7070.5 3620.9 3688.6 3730.3 3779.5 3867.0 2781.1 2876.8 2877.5 2879.8 2880.6 516.1 524.5 531.5 536.2 539.9 496.3 552.2 589.2 605.9 606.6 7889.1 8088.5 8136.0 8182.3 8313.4 581.6 588.1 589.9 608.8 610.4 3918.7 3989.3 4010.1 4042.4 4059.9 91635.5 94823.5 94856.0 95239.0 95344.0 60717.4 79285.6 80447.6 80995.6 87565.0 47027.0 75331.6 75335.0 75937.2 76379.0 8610.0 9257.9 9393.1 9394.7 9436.5 42511.1 42661.0 42791.6 43408.0 44554.3 61940.0 62062.4 62799.4 62885.4 62917.7 11454.4 11474.8 11492.5 11623.1 11869.5 12638.7 12685.7 12845.2 13132.3 13702.4 12166.0 12239.7 12271.1 12345.0 12991.4 11790.5 12223.9 12998.7 13120.3 13187.7 11903.9 12121.8 12249.3 12493.3 13069.2 10286.0 10724.1 11032.8 11124.5 11263.2 9502.2 9563.2 9573.2 9611.8 9632.9 15:24:56 INFO - PROCESS | 11395 | -------- Summary: end -------- 15:24:56 INFO - PROCESS | 11395 | 15:24:57 INFO - TEST-INFO | 11395: exit 0 15:24:57 INFO - TEST-OK | dromaeo_css | took 1116668ms 15:24:57 INFO - TEST-START | kraken 15:24:57 INFO - operating with platform_type : linux_ 15:24:57 INFO - Initialising browser for kraken test... 15:24:57 INFO - TEST-INFO | started process 11640 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDta6B8/profile http://localhost:39225/getInfo.html) 15:25:02 INFO - PROCESS | 11640 | __metrics Screen width/height:1600/1200 15:25:02 INFO - PROCESS | 11640 | colorDepth:24 15:25:02 INFO - PROCESS | 11640 | Browser inner width/height: 1024/697 15:25:02 INFO - PROCESS | 11640 | __metrics 15:25:02 ERROR - PROCESS | 11640 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 15:25:03 INFO - TEST-INFO | 11640: exit 0 15:25:03 INFO - Browser initialized. 15:25:03 INFO - Running cycle 1/1 for kraken test... 15:25:03 INFO - TEST-INFO | started process 11761 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDta6B8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:25:15 INFO - PROCESS | 11761 | RSS: Main: 168464384 15:25:15 INFO - PROCESS | 11761 | 15:25:18 INFO - PROCESS | 11761 | Cycle 1(1): loaded http://localhost:39225/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39225/tests/kraken/driver.html?testName=audio-beat-detection) 15:25:19 INFO - PROCESS | 11761 | RSS: Main: 173682688 15:25:19 INFO - PROCESS | 11761 | 15:25:21 INFO - PROCESS | 11761 | Cycle 1(1): loaded http://localhost:39225/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39225/tests/kraken/driver.html?testName=audio-dft) 15:25:22 INFO - PROCESS | 11761 | RSS: Main: 173940736 15:25:22 INFO - PROCESS | 11761 | 15:25:25 INFO - PROCESS | 11761 | Cycle 1(1): loaded http://localhost:39225/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39225/tests/kraken/driver.html?testName=audio-fft) 15:25:26 INFO - PROCESS | 11761 | RSS: Main: 167989248 15:25:26 INFO - PROCESS | 11761 | 15:25:28 INFO - PROCESS | 11761 | Cycle 1(1): loaded http://localhost:39225/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39225/tests/kraken/driver.html?testName=audio-oscillator) 15:25:28 INFO - PROCESS | 11761 | RSS: Main: 168882176 15:25:28 INFO - PROCESS | 11761 | 15:25:31 INFO - PROCESS | 11761 | Cycle 1(1): loaded http://localhost:39225/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39225/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:25:31 INFO - PROCESS | 11761 | RSS: Main: 169648128 15:25:31 INFO - PROCESS | 11761 | 15:25:34 INFO - PROCESS | 11761 | Cycle 1(1): loaded http://localhost:39225/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39225/tests/kraken/driver.html?testName=imaging-darkroom) 15:25:35 INFO - PROCESS | 11761 | RSS: Main: 169390080 15:25:35 INFO - PROCESS | 11761 | 15:25:39 INFO - PROCESS | 11761 | Cycle 1(1): loaded http://localhost:39225/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39225/tests/kraken/driver.html?testName=imaging-desaturate) 15:25:39 INFO - PROCESS | 11761 | RSS: Main: 167444480 15:25:39 INFO - PROCESS | 11761 | 15:25:42 INFO - PROCESS | 11761 | Cycle 1(1): loaded http://localhost:39225/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39225/tests/kraken/driver.html?testName=json-parse-financial) 15:25:43 INFO - PROCESS | 11761 | RSS: Main: 168517632 15:25:43 INFO - PROCESS | 11761 | 15:25:45 INFO - PROCESS | 11761 | Cycle 1(1): loaded http://localhost:39225/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39225/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:25:45 INFO - PROCESS | 11761 | RSS: Main: 168923136 15:25:45 INFO - PROCESS | 11761 | 15:25:47 INFO - PROCESS | 11761 | Cycle 1(1): loaded http://localhost:39225/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39225/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:25:48 INFO - PROCESS | 11761 | RSS: Main: 169484288 15:25:48 INFO - PROCESS | 11761 | 15:25:50 INFO - PROCESS | 11761 | Cycle 1(1): loaded http://localhost:39225/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39225/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:25:51 INFO - PROCESS | 11761 | RSS: Main: 169582592 15:25:51 INFO - PROCESS | 11761 | 15:25:53 INFO - PROCESS | 11761 | Cycle 1(1): loaded http://localhost:39225/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39225/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:25:54 INFO - PROCESS | 11761 | RSS: Main: 169619456 15:25:54 INFO - PROCESS | 11761 | 15:25:57 INFO - PROCESS | 11761 | Cycle 1(1): loaded http://localhost:39225/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39225/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:25:58 INFO - PROCESS | 11761 | RSS: Main: 169967616 15:25:58 INFO - PROCESS | 11761 | 15:25:59 INFO - PROCESS | 11761 | Cycle 1(1): loaded http://localhost:39225/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39225/tests/kraken/driver.html?testName=ai-astar) 15:26:00 INFO - PROCESS | 11761 | RSS: Main: 170512384 15:26:00 INFO - PROCESS | 11761 | 15:26:00 INFO - PROCESS | 11761 | __start_tp_report 15:26:00 INFO - PROCESS | 11761 | _x_x_mozilla_page_load 15:26:00 INFO - PROCESS | 11761 | _x_x_mozilla_page_load_details 15:26:00 INFO - PROCESS | 11761 | |i|pagename|runs| 15:26:00 INFO - PROCESS | 11761 | |0;ai-astar;107;117;110;115;115;117;117;114;115;115 15:26:00 INFO - PROCESS | 11761 | |1;audio-beat-detection;151;125;150;175;127;149;152;125;180;122 15:26:00 INFO - PROCESS | 11761 | |2;audio-dft;161;165;163;164;172;163;161;163;163;161 15:26:00 INFO - PROCESS | 11761 | |3;audio-fft;76;77;75;152;77;76;75;75;152;77 15:26:00 INFO - PROCESS | 11761 | |4;audio-oscillator;85;85;148;86;86;85;129;86;86;144 15:26:00 INFO - PROCESS | 11761 | |5;imaging-gaussian-blur;117;119;119;118;118;118;118;118;118;118 15:26:00 INFO - PROCESS | 11761 | |6;imaging-darkroom;148;148;149;147;148;148;148;147;147;149 15:26:00 INFO - PROCESS | 11761 | |7;imaging-desaturate;95;96;95;96;96;96;95;96;95;96 15:26:00 INFO - PROCESS | 11761 | |8;json-parse-financial;65;62;62;63;63;63;63;64;63;63 15:26:00 INFO - PROCESS | 11761 | |9;json-stringify-tinderbox;64;65;65;65;65;65;65;65;65;66 15:26:00 INFO - PROCESS | 11761 | |10;stanford-crypto-aes;80;80;84;79;79;79;84;81;83;89 15:26:00 INFO - PROCESS | 11761 | |11;stanford-crypto-ccm;131;131;142;141;145;135;138;139;179;135 15:26:00 INFO - PROCESS | 11761 | |12;stanford-crypto-pbkdf2;173;169;171;167;176;174;171;169;167;167 15:26:00 INFO - PROCESS | 11761 | |13;stanford-crypto-sha256-iterative;70;69;69;68;67;68;71;72;70;67 15:26:00 INFO - PROCESS | 11761 | __end_tp_report 15:26:00 INFO - PROCESS | 11761 | __start_cc_report 15:26:00 INFO - PROCESS | 11761 | _x_x_mozilla_cycle_collect,966 15:26:00 INFO - PROCESS | 11761 | __end_cc_report 15:26:00 INFO - PROCESS | 11761 | __startTimestamp1468362360177__endTimestamp 15:26:00 INFO - PROCESS | 11761 | 15:26:00 INFO - PROCESS | 11761 | ------- Summary: start ------- 15:26:00 INFO - PROCESS | 11761 | Number of tests: 14 15:26:00 INFO - PROCESS | 11761 | 15:26:00 INFO - PROCESS | 11761 | [#0] ai-astar Cycles:10 Average:114.20 Median:115.00 stddev:3.26 (2.8%) stddev-sans-first:2.18 15:26:00 INFO - PROCESS | 11761 | Values: 107.0 117.0 110.0 115.0 115.0 117.0 117.0 114.0 115.0 115.0 15:26:00 INFO - PROCESS | 11761 | 15:26:00 INFO - PROCESS | 11761 | [#1] audio-beat-detection Cycles:10 Average:145.60 Median:150.50 stddev:20.82 (13.8%) stddev-sans-first:21.99 15:26:00 INFO - PROCESS | 11761 | Values: 151.0 125.0 150.0 175.0 127.0 149.0 152.0 125.0 180.0 122.0 15:26:00 INFO - PROCESS | 11761 | 15:26:00 INFO - PROCESS | 11761 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.00 stddev:3.24 (2.0%) stddev-sans-first:3.30 15:26:00 INFO - PROCESS | 11761 | Values: 161.0 165.0 163.0 164.0 172.0 163.0 161.0 163.0 163.0 161.0 15:26:00 INFO - PROCESS | 11761 | 15:26:00 INFO - PROCESS | 11761 | [#3] audio-fft Cycles:10 Average:91.20 Median:76.00 stddev:32.05 (42.2%) stddev-sans-first:33.52 15:26:00 INFO - PROCESS | 11761 | Values: 76.0 77.0 75.0 152.0 77.0 76.0 75.0 75.0 152.0 77.0 15:26:00 INFO - PROCESS | 11761 | 15:26:00 INFO - PROCESS | 11761 | [#4] audio-oscillator Cycles:10 Average:102.00 Median:85.50 stddev:26.87 (31.4%) stddev-sans-first:27.79 15:26:00 INFO - PROCESS | 11761 | Values: 85.0 85.0 148.0 86.0 86.0 85.0 129.0 86.0 86.0 144.0 15:26:00 INFO - PROCESS | 11761 | 15:26:00 INFO - PROCESS | 11761 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 15:26:00 INFO - PROCESS | 11761 | Values: 117.0 119.0 119.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 15:26:00 INFO - PROCESS | 11761 | 15:26:00 INFO - PROCESS | 11761 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 15:26:00 INFO - PROCESS | 11761 | Values: 148.0 148.0 149.0 147.0 148.0 148.0 148.0 147.0 147.0 149.0 15:26:00 INFO - PROCESS | 11761 | 15:26:00 INFO - PROCESS | 11761 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 15:26:00 INFO - PROCESS | 11761 | Values: 95.0 96.0 95.0 96.0 96.0 96.0 95.0 96.0 95.0 96.0 15:26:00 INFO - PROCESS | 11761 | 15:26:00 INFO - PROCESS | 11761 | [#8] json-parse-financial Cycles:10 Average:63.10 Median:63.00 stddev:0.88 (1.4%) stddev-sans-first:0.60 15:26:00 INFO - PROCESS | 11761 | Values: 65.0 62.0 62.0 63.0 63.0 63.0 63.0 64.0 63.0 63.0 15:26:00 INFO - PROCESS | 11761 | 15:26:00 INFO - PROCESS | 11761 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.47 (0.7%) stddev-sans-first:0.33 15:26:00 INFO - PROCESS | 11761 | Values: 64.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 66.0 15:26:00 INFO - PROCESS | 11761 | 15:26:00 INFO - PROCESS | 11761 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:82.00 stddev:3.22 (3.9%) stddev-sans-first:3.35 15:26:00 INFO - PROCESS | 11761 | Values: 80.0 80.0 84.0 79.0 79.0 79.0 84.0 81.0 83.0 89.0 15:26:00 INFO - PROCESS | 11761 | 15:26:00 INFO - PROCESS | 11761 | [#11] stanford-crypto-ccm Cycles:10 Average:141.60 Median:140.00 stddev:13.91 (9.9%) stddev-sans-first:14.22 15:26:00 INFO - PROCESS | 11761 | Values: 131.0 131.0 142.0 141.0 145.0 135.0 138.0 139.0 179.0 135.0 15:26:00 INFO - PROCESS | 11761 | 15:26:00 INFO - PROCESS | 11761 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.40 Median:171.00 stddev:3.17 (1.9%) stddev-sans-first:3.22 15:26:00 INFO - PROCESS | 11761 | Values: 173.0 169.0 171.0 167.0 176.0 174.0 171.0 169.0 167.0 167.0 15:26:00 INFO - PROCESS | 11761 | 15:26:00 INFO - PROCESS | 11761 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.50 stddev:1.66 (2.4%) stddev-sans-first:1.73 15:26:00 INFO - PROCESS | 11761 | Values: 70.0 69.0 69.0 68.0 67.0 68.0 71.0 72.0 70.0 67.0 15:26:00 INFO - PROCESS | 11761 | -------- Summary: end -------- 15:26:00 INFO - PROCESS | 11761 | 15:26:01 INFO - TEST-INFO | 11761: exit 0 15:26:01 INFO - TEST-OK | kraken | took 63691ms 15:26:01 INFO - SUITE-END | took 1180s 15:26:01 INFO - Completed test suite (00:19:40) 15:26:01 INFO - javascript benchmark 15:26:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6350.099074297791, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2644.3521337272364, 2667.333166708323, 2683.51696694595, 2698.9055383061586, 2706.242252169392, 4741.359916411279, 4765.070811191819, 4822.228443449048, 4824.493428190042, 4834.347363105984, 4689.3669354637195, 4778.546038126373, 4841.636877234204, 4844.152273352158, 4888.828890988816, 4387.978060109703, 4414.6830343342035, 4512.029913568582, 4517.774111294439, 4539.773011349436, 481.65108435105464, 4392.758398288093, 4441.5780500852525, 4512.751798651073, 4547.5452454754595, 4393.472783265996, 4398.714083584573, 4419.447569053868, 4421.447319085114, 4464.754438505881, 4336.7831608419765, 4417.204903117437, 4438.889027774299, 4464.040231350243, 4477.1493416250805, 4353.3469979503325, 4393.978030109861, 4415.955840441587, 4433.822647094113, 4434.889127771831, 4768.546988036166, 4805.063012712522, 4831.565159135659, 4835.661503694742, 4867.123917694814, 4945.307656928033, 5109.795608175668, 5180.844574662766, 5190.662606930538, 5242.79028838846, 5191.870203244949, 5230.163173892159, 5250.789968401259, 5251.973740131275, 5303.416624171338, 4868.561829435368, 4876.195427754452, 4905.730184839868, 4907.55831975124, 4946.183879659816, 5172.7155006475, 5250.133727934848, 5313.910648317085, 5357.062514060024, 5370.248165256867, 5127.512886275872, 5147.6396652234735, 5158.045761534128, 5158.484151584811, 5194.558462530652, 5197.896042079137, 5220.582353411718, 5236.816711415082, 5240.397354304304, 5298.443663415363, 4914.164592019365, 5041.6470847040355, 5086.516780905808, 5113.53978141969, 5179.067767801832, 4980.90038199234, 5047.848564543069, 5094.694318340911, 5110.514501122388, 5132.615053870974, 4339.848105316299, 4378.868633940987, 4388.8902777430185, 4392.890177745582, 4421.513633500313, 3725.7950812705562, 3728.832202550892, 3774.0564858785306, 3781.4327850822597, 3879.7090218233743, 4438.090191510797, 4451.732896026248, 4462.6876118672035, 4467.977660111678, 4515.909681806345, 5157.277981082651, 5159.25190847325, 5160.948390516121, 5161.148410512298, 5194.986977539344, 4396.0, 4444.400005999213, 4494.393256910341, 4511.210538155809, 4518.457785065747, 4653.8371157010015, 4669.066186762593, 4674.485806561275, 4697.389339385926, 4705.905881882343, 4751.358566593604, 4913.508649135058, 4922.360093187863, 4926.630502712239, 4941.901161976741, 5104.030234255628, 5148.3564554430695, 5169.327987361619, 5195.506426889439, 5197.974010129925, 4832.323474713613, 4859.586935110555, 4862.222044472867, 4865.56209941107, 4915.0, 4954.20732682769, 5001.174806157089, 5102.311187989574, 5107.846764597068, 5152.793888244429, 5114.23286507012, 5118.897622047463, 5163.922541161811, 5186.299849520266, 5243.68537887728, 5015.974920125376, 5019.372578427697, 5063.493650634907, 5071.492850715046, 5114.616403769806, 4905.9018819624125, 4975.900481990412, 5030.597552195889, 5060.49395060491, 5067.41724701664, 4840.709557426425, 4858.125537403302, 4867.878303042452, 4904.435989861212, 5036.320096786887, 4987.9750601248215, 5004.749762511933, 5008.624353173599, 5047.066292735855, 5054.4692807254705, 4925.113479573711, 4926.137925863031, 4937.333459982857, 4941.085899108676, 4970.65205435616], "value": 4710.319315197832, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.4066408279059, 557.8884223155369, 562.1848319936094, 571.3572231239855, 606.0515293565572, 36269.09327266819, 39634.40548391776, 39693.0, 39718.0, 39748.2050358993, 38751.80624096883, 39250.214995700066, 39306.21387572247, 39347.80326098365, 39349.80325098378, 7693.884591731128, 7791.88312175315, 7806.60966951653, 7830.686772529092, 7832.1776213497615, 7842.921570784276, 7855.803604909895, 7866.68533258669, 7927.04875414951, 7944.563049032301, 7948.165442628528, 7957.403194760387, 7975.361971042332, 7991.120976692559, 8003.079645840716, 7920.445568810185, 7926.801829954268, 7952.642131104057, 7965.8805117923275, 7974.282314591715, 7868.803279917991, 7914.920850791534, 7926.405519586054, 7929.841403171962, 7945.602719863984, 36879.07802304937, 37202.627973720184, 37209.44185837215, 37210.25579488422, 37294.0, 2429.514097180553, 2859.2565932857606, 2991.760659147263, 2993.9101826945225, 3037.4228896509812, 25783.74216257832, 26979.595306070423, 27512.862435687694, 27975.30061748452, 28438.0, 3327.7670563060597, 3342.498625206214, 3354.798712077283, 3417.9145521361916, 3462.3075384922863, 216049.0, 261275.0, 263733.0, 264003.0399544028, 265039.0, 31695.0, 32806.179845504055, 54574.18138727922, 55375.169372459444, 55468.0, 34086.48870266948, 34152.48771268433, 34193.145171370415, 34259.143521411665, 34446.0, 11017.394043327533, 11031.0, 11039.448027598748, 11041.83437248442, 11091.778164436828, 10621.73445663849, 10805.405702686428, 10830.458477076114, 10833.891661083288, 10843.457827108614, 7909.24862138096, 7930.325922296669, 7982.441229113906, 8017.078036025815, 8029.839403211903, 3065.509518477033, 3150.558921750957, 3164.8259345736205, 3172.857221425041, 3173.444647186779, 893.4014210478995, 911.8404279251105, 975.9609615615295, 1013.4780587997187, 1027.0807627173788, 29012.12963611095, 29016.27459313492, 29088.0, 29199.416011680074, 29306.7069329304, 938.1697197979701, 964.064857088623, 997.9401235925868, 1007.2646967713611, 1086.223350304536, 14737.705245895237, 15118.244087795787, 15218.619534511505, 15233.6191595211, 15298.388064477296, 118268.40865795616, 118647.0, 419247.0, 420706.0, 423934.0, 50457.747711261945, 50790.74604626953, 51109.23336149961, 51114.744426278376, 51137.23294150591, 1154.3650991954391, 1175.8059920113258, 1175.8295047218105, 1185.82805493203, 1208.5769980506752, 26975.190744277705, 28411.289717756394, 28475.0, 28503.852676048384, 28703.569446458736, 43520.34719479147, 43783.0, 44066.0, 44087.33868992032, 44092.55907441013, 341711.0, 344351.22595095914, 344594.0, 345573.0, 350339.0, 24932.750672493043, 25178.24465266045, 25845.48309033771, 25967.870160649833, 25994.220173394828, 43065.78467107644, 43336.566634333256, 43686.34470483009, 43761.0, 44179.77910110429, 37954.311770753775, 37979.24041519209, 38104.618953811216, 38424.42363364496, 38429.80785096057, 37852.86441406762, 38470.615293846706, 38514.614853851104, 38655.80672096622, 38667.613323866404, 31419.214519636276, 36231.27537449184, 36593.26813463662, 36624.81687591545, 36910.8154459226, 31758.841205793822, 33991.66008339885, 34257.82871085629, 34322.65677343195, 34638.653613463546, 26210.213693589223, 26353.868230658725, 26613.334666633487, 26775.598366024136, 26814.0], "value": 16399.390870894676, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.54608059047086, 370.5830940192284, 371.2556324569238, 380.9085819403344, 389.861599132308, 16342.428015019463, 17232.74150887736, 17552.47342579723, 17721.822781772178, 17794.911025444853, 16112.919435402806, 16166.676666466663, 17660.38188663397, 17675.116244187804, 17737.29050837965, 4667.836625718092, 4826.420829500465, 4853.199222128344, 4854.611631069523, 4856.708597484145, 3533.505309256706, 5363.651362661434, 5595.720213989304, 5603.691796951166, 5679.034564124109, 5668.319801623811, 5673.12066629671, 5673.234113394701, 5683.971580142093, 5734.254546908917, 6161.137440758297, 6177.907331390033, 6178.135061091451, 6187.443130118266, 6222.688865556704, 5355.464453554652, 5479.835604931858, 5492.0, 5492.478214569649, 5493.7802487900435, 13150.934245328808, 13174.27541485218, 17860.642787144316, 21114.788852111436, 21426.0, 1914.2917120665304, 1936.457791818279, 1963.1950900130878, 2168.9697393738006, 2203.911843526257, 9125.452472851584, 9206.90793092074, 9424.387414818015, 9476.668316608886, 9815.067568580973, 1651.7488226684864, 1669.8413650703164, 1699.5156380431517, 1724.9827501725074, 1732.774739283885, 72270.27729722741, 74359.0, 75204.6239768803, 75428.62285688591, 76215.61892190503, 9742.220622350336, 9923.206143508502, 10114.140298074746, 10214.336068155695, 10249.436281004468, 13941.0, 14027.0, 14050.0, 14060.507882224074, 14093.0, 6799.218089919624, 6811.182658081062, 6830.248672646005, 6959.6868140933775, 7027.332403421667, 6175.320714721377, 6368.140301059298, 6443.323451037573, 6448.709808058648, 6450.3549645036055, 4331.631811296075, 4385.188740083095, 4408.162449134654, 4479.977600111979, 4532.614727748179, 1602.1428535733326, 1652.107861754663, 1689.298940939521, 1692.2723229011642, 1702.7105392083377, 854.9444286121383, 895.6730793260413, 900.4372267332917, 913.0230653201011, 939.5631031570352, 16932.306769322968, 17185.656286874193, 17526.737098943526, 17578.12109394525, 18032.90983545074, 817.2522142239784, 860.3762272352494, 876.548577482597, 882.5322579033123, 894.7941973346167, 9745.951270243604, 9766.95116524427, 9778.07108324708, 9895.752606184902, 9927.15619172364, 381296.0, 397072.0, 397846.0, 399566.0, 403860.0, 84847.0, 91540.0, 91898.54050729703, 93446.53276733709, 94048.52975735077, 872.6073267029861, 895.7146494780012, 913.7624217703445, 914.6981496106268, 919.8344298026419, 14739.778903316674, 14857.628559286104, 15063.246837658293, 15108.39566417331, 15377.538673839803, 25416.110436134648, 26593.202203933914, 38847.805760971016, 39736.40395394129, 40071.39892901667, 54966.450335497735, 56676.0, 57180.71409642925, 57348.71325643345, 57541.42458575361, 7616.885746713693, 7741.535507869546, 7748.4576079676135, 7827.686892524235, 7918.524888506708, 8570.228679418882, 10562.31344962575, 10770.0, 11346.0355869752, 11833.82249266279, 9512.096350846936, 9889.752756181153, 9954.0, 10090.0, 10169.0, 9657.0, 9810.87174974887, 9819.9018009819, 10119.089281964658, 10420.583176672848, 9923.900760992297, 10165.339252948535, 10516.836141418578, 10622.787544249226, 10799.730006749895, 6987.231404545598, 7617.314441700052, 7728.922710773045, 7890.842183156419, 7941.602919853869, 8390.664373424994, 9785.951070244602, 9826.9017309826, 10091.243156763125, 10311.060766398688], "value": 8208.157207076716, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1337.1041402260485, 1386.154445788069, 1454.8108745863037, 1672.5985763416784, 1686.6963946489634, 6477.417032467077, 7161.785146445608, 7196.172440169382, 7699.114601820792, 7706.4990775599545, 7326.0, 7513.962430187841, 7643.808904777384, 7645.770626881203, 7646.235376462351, 2172.7284089488853, 2229.788170123844, 2233.352327824929, 2236.586231547161, 2237.1163390460756, 2156.137544982012, 2172.598069357174, 2223.266322113707, 2233.586786444505, 2235.6870038194666, 2166.80498755112, 2187.103287652063, 2191.4302281406867, 2195.067096483988, 2228.9777102229014, 2087.092114930003, 2097.2345094040643, 2101.443117573844, 2102.568973360457, 2110.8416868734753, 2109.862858914181, 2151.6449785785326, 2154.278316763886, 2155.622766015941, 2160.3302976077466, 7554.131274903401, 7560.508566943131, 7629.084509858797, 7640.885386719204, 7665.961670191669, 4393.0, 4445.844395446176, 4556.703814252063, 4579.885502862422, 4592.150452166326, 2842.545192769147, 2888.393437378153, 2930.0184438213223, 2948.3513627002026, 2954.6897575754665, 895.901450840407, 901.4411065139656, 913.488446469979, 914.1087439746261, 917.6375331743924, 9917.057879501435, 9954.751131221778, 10003.299769016172, 10041.0, 10086.041826026516, 3839.4432807242792, 3910.3547914593773, 4033.8184781684895, 4050.4734384529825, 4096.0, 7602.391808655294, 7672.117706463828, 7673.808154796175, 7701.730439434705, 7716.074071111502, 4447.399601053881, 4472.485664148599, 4483.0, 4484.618807401407, 4486.798094085774, 3502.4571191465366, 4008.6191811777835, 4110.445089912883, 4197.097624010852, 4206.957930420718, 3312.188513814131, 3363.209645733251, 3469.410200265961, 3476.80877551732, 3543.344481270973, 1021.255438160348, 1026.3995562595817, 1032.2155162076876, 1032.7934413117407, 1055.2138656700806, 759.6885277036389, 784.0395515493475, 786.0685088170536, 798.4889670610813, 807.4025221336169, 5156.8968620627375, 5166.457521960216, 5269.868253293698, 5281.788728450819, 5439.5104440600535, 390.65036792071504, 390.89961757652117, 392.6976228304247, 393.5120450641184, 396.17595401564677, 3490.795675491951, 3498.755087143926, 3529.241213139136, 3540.6282340354405, 3566.589842168132, 8492.320614350838, 8946.284297256203, 8962.507062111647, 9245.861312080324, 9345.439273643467, 9182.449053056838, 9185.862212066824, 9213.585388657526, 9245.445273283625, 9291.070892910655, 6887.173539175231, 7024.683889224997, 7029.0, 7056.6118863463, 7059.78820635392, 5162.6902385856965, 5436.7553460093595, 5467.617266791286, 5593.853260081755, 5648.926703926241, 8630.78423039404, 8698.260647845003, 8702.738917832476, 8720.389572729848, 8748.956255218684, 8533.189347012023, 8543.231109200202, 8709.346798989975, 8735.475871447734, 8780.165884240987, 5808.82573522795, 6208.844778880564, 6396.136521569715, 6544.8363790905605, 6677.465802735866, 7113.893291600733, 7119.394851437479, 7152.0, 7178.5692858428665, 7201.675924583302, 6469.2560355557835, 6683.63240021784, 6717.395434410926, 6736.056952026622, 6760.459163267025, 6486.318936511599, 6490.545661803629, 6634.635095069818, 6691.866162676622, 6708.83227919306, 6199.659018753831, 6223.3465486125115, 6264.59280146789, 6266.404691554295, 6268.091126786681, 4200.4959404871615, 4352.412424322676, 4359.215341238608, 4430.490493593278, 4442.044960333544, 4371.322445021026, 4474.463064432289, 4538.432695913011, 4583.679142459996, 4594.379758732528], "value": 3924.9288288945204, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.0004135793548, 293.1294056651744, 294.1513732880641, 296.4249356248878, 301.4438361223543, 5158.742062896849, 5167.896642067157, 5174.767135478908, 5181.637285390024, 5201.505856943589, 5071.467495912932, 5085.949140508594, 5087.949120508793, 5091.236314552819, 5103.438621751604, 3787.7159213059062, 3855.20968201518, 3951.427043078752, 3967.246223217594, 3981.0, 3898.7465814721954, 3934.3114954882926, 3952.1107750756137, 3955.20895820837, 3976.2643910876436, 3933.5869733677837, 3951.683865290784, 3951.841926322958, 3968.56345801963, 3970.940435893464, 3802.6957843372466, 3887.2031233597045, 3905.3556163233034, 3960.881173564798, 3966.107625784204, 3445.5012069749737, 3451.9827400863087, 3456.7580269381156, 3458.515807786912, 3469.5836499619954, 4872.756362181876, 4888.071266459397, 4899.632527560448, 4927.226198568513, 4933.136701077297, 4385.429894113777, 4503.234450143484, 4529.297958816356, 4529.796159172845, 4541.5231400703115, 5266.34170728659, 5307.893842123174, 5315.750798562335, 5332.280536926157, 5346.4386239445075, 3830.4062870255157, 3838.9616103838885, 3839.117003089277, 3846.519185101862, 3854.209886973164, 5388.892222155535, 5508.6970216638065, 5566.137248726453, 5597.524210442118, 5600.85997850057, 3857.3828187489867, 3874.6900247980093, 3892.4939757831303, 3909.159530700913, 3915.2169566086895, 3943.191645712622, 3976.622220889011, 3978.612832300654, 3979.4826672532386, 3985.5416627087675, 4479.507254202035, 4532.161550113239, 4534.863954081383, 4537.228671125917, 4537.481697657831, 5065.670731402521, 5219.947800522022, 5273.736313184326, 5287.365516138011, 5323.361196656426, 1375.2985977151525, 1397.105852254558, 1398.2309729648653, 1399.0975820595863, 1402.7685431903826, 854.8974123105143, 880.0451510111473, 892.6607889002267, 899.2670973156987, 910.8952470465849, 4536.8638940831825, 4674.813007479663, 4676.719396836133, 4688.718676879398, 4710.858674239778, 5434.690256640991, 5462.449407884827, 5467.644603100785, 5489.560835133179, 5511.704749383892, 4487.842925497592, 4673.485916549177, 4685.250359942393, 4693.436787585511, 4694.131585656596, 2901.5502597097484, 2934.075766133661, 2939.603688248108, 2943.455460739727, 2959.733623973853, 5126.487351264918, 5139.640225184276, 5156.252343410185, 5172.431032586413, 5174.586033117342, 5421.891562168735, 5558.0, 5580.748866301026, 5601.243832082698, 5656.123300888369, 5106.234064890296, 5111.463296353903, 5118.38579370478, 5122.231665250242, 5145.639805213599, 5513.338399392099, 5531.585131115263, 5536.141898005815, 5537.0, 5557.0, 5242.0, 5260.447652996533, 5331.280277162688, 5340.332458442695, 5359.785608575613, 5033.672811267256, 5086.465921078381, 5087.414947280962, 5107.387113546398, 5113.079645663816, 3910.7066969976795, 3934.350832112669, 3944.3491823848744, 3961.504811898513, 3966.9801650991562, 5159.742012899415, 5435.918461223006, 5440.591955603267, 5522.144067669517, 5527.64070335443, 5333.013392522395, 5336.226247194213, 5367.3827509836865, 5367.436419176087, 5422.15956526739, 5213.4027521010385, 5298.205269209495, 5378.354597448331, 5406.297181366397, 5426.589086837372, 5235.502627250406, 5270.341207349082, 5271.683698978073, 5282.31329927107, 5299.152135658276, 5110.872228194325, 5248.186531087687, 5350.946490535045, 5392.919106213489, 5399.676019438846, 5193.480651934777, 5201.427842937198, 5203.947960520498, 5222.0, 5227.607929405233], "value": 4004.713724092384, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [641.845956970327, 715.5992644119293, 752.9058867641543, 753.5704648350439, 765.1430397954285, 12948.352582370879, 13337.799933001013, 13349.532766353179, 13375.13061650992, 13399.598012059641, 11632.825507617392, 11714.297142171476, 11747.588834390797, 11783.821617838212, 14403.495877644285, 770.96916123355, 778.4861991085885, 782.2060608482395, 782.9843403131933, 783.9490433121857, 783.5181363461487, 784.9254320839511, 785.8231897823001, 786.7797016835295, 786.8544319300947, 822.7778499805049, 823.390690888744, 824.3364091906013, 824.9628766705513, 827.4993628854546, 815.6941147069849, 817.0440584516131, 817.8773184022415, 820.0610301205087, 821.7534739578133, 597.9790707325267, 598.727578951576, 599.7211296747033, 600.2826622186489, 601.969901504923, 11487.770244595062, 11507.252028618113, 11510.539578416854, 11532.596359127474, 11561.728209896904, 13484.595462136054, 13683.31583420835, 13765.242911639856, 13806.792898106536, 13815.51645692406, 10668.839967400496, 10710.571577136905, 10942.015218630362, 11033.503492342863, 11080.279781814157, 3343.3480471308103, 3348.2131699050706, 3390.6609339066144, 3426.5202871597994, 3426.554547908781, 42179.0, 43079.13841723148, 53474.0, 53649.731751340994, 60728.0, 10523.631672891412, 10605.522751476203, 10663.73340666474, 10690.73273168177, 10911.072558832588, 17028.744568831476, 17662.823371766375, 17724.202410891285, 18331.725024124647, 18368.632627347644, 6872.931270687329, 6923.5499692519825, 7004.754833580801, 7061.89407158893, 7070.505064645528, 3620.8551657933913, 3688.6311368863435, 3730.272596843644, 3779.527559055118, 3867.0332416895776, 2781.1100447856493, 2876.8273903565855, 2877.510823160068, 2879.7840161987933, 2880.5679148127947, 516.1432022842064, 524.4702850121405, 531.4579129288104, 536.1957064403394, 539.870431096534, 496.28782696830166, 552.1827695011325, 589.1633879890566, 605.9091136329498, 606.6057062909056, 7889.06651838468, 8088.474249173785, 8135.959320203361, 8182.263596276244, 8313.41806073569, 581.6161333519857, 588.0591054313065, 589.9410558048313, 608.8340235429064, 610.3784246660604, 3918.7256892017285, 3989.261986532501, 4010.057636455431, 4042.413849991735, 4059.8579049733116, 91635.54182229046, 94823.52588237153, 94856.0, 95239.0, 95344.04655953491, 60717.39282607206, 79285.60357198292, 80447.59776201082, 80995.59502202451, 87565.0, 47027.0, 75331.62334188294, 75335.0, 75937.24062759412, 76379.0, 8610.0, 9257.861132083159, 9393.107654772786, 9394.718158455258, 9436.480993545421, 42511.1497770049, 42661.0, 42791.572084278756, 43408.0, 44554.3316850254, 61940.0, 62062.37937620566, 62799.37200627935, 62885.37114628795, 62917.685411572646, 11454.427278636202, 11474.77050459003, 11492.47746209031, 11623.1282653803, 11869.465874035517, 12638.747225055631, 12685.746285074432, 12845.165064270792, 13132.34338283063, 13702.383392747151, 12166.0, 12239.694007649523, 12271.079669025037, 12345.0, 12991.350432478528, 11790.469428875549, 12223.93888030554, 12998.675033124247, 13120.343982801012, 13187.736245275233, 11903.851976116868, 12121.75756484883, 12249.265044097026, 12493.312867792358, 13069.15050521713, 10286.0, 10724.142068634646, 11032.779344413228, 11124.499397526968, 11263.211575189658, 9502.239820814457, 9563.187129094105, 9573.18627916635, 9611.807763844545, 9632.9036709632], "value": 6578.239311052644, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1569.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 117.0, 110.0, 115.0, 115.0, 117.0, 117.0, 114.0, 115.0, 115.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 125.0, 150.0, 175.0, 127.0, 149.0, 152.0, 125.0, 180.0, 122.0], "value": 145.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 165.0, 163.0, 164.0, 172.0, 163.0, 161.0, 163.0, 163.0, 161.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 152.0, 77.0, 76.0, 75.0, 75.0, 152.0, 77.0], "value": 91.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 148.0, 86.0, 86.0, 85.0, 129.0, 86.0, 86.0, 144.0], "value": 102.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 119.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 149.0, 147.0, 148.0, 148.0, 148.0, 147.0, 147.0, 149.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 62.0, 63.0, 63.0, 63.0, 63.0, 64.0, 63.0, 63.0], "value": 63.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 84.0, 79.0, 79.0, 79.0, 84.0, 81.0, 83.0, 89.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 131.0, 142.0, 141.0, 145.0, 135.0, 138.0, 139.0, 179.0, 135.0], "value": 141.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 169.0, 171.0, 167.0, 176.0, 174.0, 171.0, 169.0, 167.0, 167.0], "value": 170.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 69.0, 68.0, 67.0, 68.0, 71.0, 72.0, 70.0, 67.0], "value": 69.1, "unit": "score"}]}]} 15:26:01 INFO - Return code: 0 15:26:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:26:01 ERROR - # TBPL SUCCESS # 15:26:01 INFO - Running post-action listener: _resource_record_post_action 15:26:01 INFO - ##### 15:26:01 INFO - ##### Finished run-tests step (success) 15:26:01 INFO - ##### 15:26:01 INFO - Running post-run listener: _resource_record_post_run 15:26:01 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 217088; Write bytes: 290869248; Read time: 40; Write time: 255436 15:26:01 INFO - TinderboxPrint: CPU usage
13.3% 15:26:01 INFO - TinderboxPrint: I/O read bytes / time
217,088 / 40 15:26:01 INFO - TinderboxPrint: I/O write bytes / time
290,869,248 / 255,436 15:26:01 INFO - TinderboxPrint: CPU idle
8,281.2 (86.7%) 15:26:01 INFO - TinderboxPrint: CPU user
1,219.4 (12.8%) 15:26:01 INFO - TinderboxPrint: Swap in / out
0 / 0 15:26:01 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 4632576; Read time: 0; Write time: 476 15:26:01 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 212992; Write bytes: 285622272; Read time: 20; Write time: 254960 15:26:02 INFO - Running post-run listener: _upload_blobber_files 15:26:02 INFO - Blob upload gear active. 15:26:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:26:02 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 15:26:02 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'] 15:26:02 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 15:26:02 INFO - (blobuploader) - INFO - Open directory for files ... 15:26:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:26:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:26:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:26:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:26:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:26:03 INFO - (blobuploader) - INFO - Done attempting. 15:26:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:26:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:26:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:26:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:26:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:26:07 INFO - (blobuploader) - INFO - Done attempting. 15:26:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:26:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:26:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:26:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:26:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:26:07 INFO - (blobuploader) - INFO - Done attempting. 15:26:07 INFO - (blobuploader) - INFO - Iteration through files over. 15:26:07 INFO - Return code: 0 15:26:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:26:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:26:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d54400c494b605e8a0591f4214d8533846207b995a8f8eeb4dd05c1238335f5cee3ced5ff713add736eda5485c26cdaf1eec81814bdc3aec5699d1bc8dd1bed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/07a271036458b9819b9e6f44435cde84e3b6b70b6a97aa407e88a3709b4ffe78537be4cc3c332af6c5cd607312b83ba685f0b29583a949f7bfc046f8b0588ec8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/da2a564083a8cedb0c72d22e6b030ae72bfb1455b88add6fd10d9d083e00afecf1e2a2eb7efae67612596e67a7f27238aa07fa442dade4880b4c1ac57f6fd92c"} 15:26:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:26:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:26:07 INFO - Contents: 15:26:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d54400c494b605e8a0591f4214d8533846207b995a8f8eeb4dd05c1238335f5cee3ced5ff713add736eda5485c26cdaf1eec81814bdc3aec5699d1bc8dd1bed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/07a271036458b9819b9e6f44435cde84e3b6b70b6a97aa407e88a3709b4ffe78537be4cc3c332af6c5cd607312b83ba685f0b29583a949f7bfc046f8b0588ec8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/da2a564083a8cedb0c72d22e6b030ae72bfb1455b88add6fd10d9d083e00afecf1e2a2eb7efae67612596e67a7f27238aa07fa442dade4880b4c1ac57f6fd92c"} 15:26:07 INFO - Running post-run listener: copy_logs_to_upload_dir 15:26:07 INFO - Copying logs to upload dir... 15:26:07 INFO - mkdir: /builds/slave/test/build/upload/logs 15:26:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.032399 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-07-12 15:26:07.948987) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 15:26:07.952744) ========= 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=826874ccc97bd7bf541b4875000001d5-1468358977.121291-1278041462 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d54400c494b605e8a0591f4214d8533846207b995a8f8eeb4dd05c1238335f5cee3ced5ff713add736eda5485c26cdaf1eec81814bdc3aec5699d1bc8dd1bed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/07a271036458b9819b9e6f44435cde84e3b6b70b6a97aa407e88a3709b4ffe78537be4cc3c332af6c5cd607312b83ba685f0b29583a949f7bfc046f8b0588ec8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/da2a564083a8cedb0c72d22e6b030ae72bfb1455b88add6fd10d9d083e00afecf1e2a2eb7efae67612596e67a7f27238aa07fa442dade4880b4c1ac57f6fd92c"} build_url:https://queue.taskcluster.net/v1/task/HZ6mA3VuRaa_l7eyfXPiEQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011384 build_url: 'https://queue.taskcluster.net/v1/task/HZ6mA3VuRaa_l7eyfXPiEQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d54400c494b605e8a0591f4214d8533846207b995a8f8eeb4dd05c1238335f5cee3ced5ff713add736eda5485c26cdaf1eec81814bdc3aec5699d1bc8dd1bed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/07a271036458b9819b9e6f44435cde84e3b6b70b6a97aa407e88a3709b4ffe78537be4cc3c332af6c5cd607312b83ba685f0b29583a949f7bfc046f8b0588ec8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/da2a564083a8cedb0c72d22e6b030ae72bfb1455b88add6fd10d9d083e00afecf1e2a2eb7efae67612596e67a7f27238aa07fa442dade4880b4c1ac57f6fd92c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 15:26:07.979104) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 15:26:07.979510) ========= 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=826874ccc97bd7bf541b4875000001d5-1468358977.121291-1278041462 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 15:26:08.064505) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 15:26:08.064857) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 15:26:08.065199) ========= ========= Total master_lag: 0.16 =========