builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-009 starttime: 1467861067.07 results: success (0) buildid: 20160706173002 builduid: 12c2d2029d214d2d932fbd5f13a78840 revision: 1dd03896ee5f2165822f36235523e39394826531 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 20:11:07.073670) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 20:11:07.074138) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 20:11:07.078866) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 20:11:07.098186) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 20:11:07.098499) ========= 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=17051fcd5208b27b50bedfeb000001dd-1467860438.892864-1846552983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-06 20:11:07-- 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% 32.7M=0s 2016-07-06 20:11:07 (32.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.151202 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 20:11:07.263898) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 20:11:07.267257) ========= 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=17051fcd5208b27b50bedfeb000001dd-1467860438.892864-1846552983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020552 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 20:11:07.317816) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 20:11:07.321261) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1dd03896ee5f2165822f36235523e39394826531 --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 1dd03896ee5f2165822f36235523e39394826531 --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=17051fcd5208b27b50bedfeb000001dd-1467860438.892864-1846552983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-06 20:11:07,833 truncating revision to first 12 chars 2016-07-06 20:11:07,833 Setting DEBUG logging. 2016-07-06 20:11:07,833 attempt 1/10 2016-07-06 20:11:07,833 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1dd03896ee5f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-06 20:11:08,155 unpacking tar archive at: fx-team-1dd03896ee5f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.654180 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 20:11:07.989226) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 20:11:07.989554) ========= script_repo_revision: 1dd03896ee5f2165822f36235523e39394826531 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 20:11:07.989932) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 20:11:07.990212) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 20:11:07.999753) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-07-06 20:11:08.000110) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=17051fcd5208b27b50bedfeb000001dd-1467860438.892864-1846552983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:11:08 INFO - MultiFileLogger online at 20160706 20:11:08 in /builds/slave/test 20:11:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:11:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:11:08 INFO - {'append_to_log': False, 20:11:08 INFO - 'base_work_dir': '/builds/slave/test', 20:11:08 INFO - 'blob_upload_branch': 'Fx-Team', 20:11:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:11:08 INFO - 'branch': 'Fx-Team', 20:11:08 INFO - 'buildbot_json_path': 'buildprops.json', 20:11:08 INFO - 'config_files': ('talos/linux_config.py',), 20:11:08 INFO - 'default_actions': ('clobber', 20:11:08 INFO - 'read-buildbot-config', 20:11:08 INFO - 'download-and-extract', 20:11:08 INFO - 'populate-webroot', 20:11:08 INFO - 'create-virtualenv', 20:11:08 INFO - 'install', 20:11:08 INFO - 'run-tests'), 20:11:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:11:08 INFO - 'download_minidump_stackwalk': True, 20:11:08 INFO - 'download_symbols': 'ondemand', 20:11:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:11:08 INFO - 'tooltool.py': '/tools/tooltool.py', 20:11:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:11:08 INFO - '/tools/misc-python/virtualenv.py')}, 20:11:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:11:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:11:08 INFO - 'installer_path': 'installer.exe', 20:11:08 INFO - 'log_level': 'info', 20:11:08 INFO - 'log_name': 'talos', 20:11:08 INFO - 'log_to_console': True, 20:11:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:11:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:11:08 INFO - 'opt_config_files': (), 20:11:08 INFO - 'pip_index': False, 20:11:08 INFO - 'sps_profile': False, 20:11:08 INFO - 'sps_profile_interval': 0, 20:11:08 INFO - 'suite': 'dromaeojs', 20:11:08 INFO - 'system_bits': '32', 20:11:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:11:08 INFO - 'title': 'talos-linux64-ix-009', 20:11:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:11:08 INFO - 'use_talos_json': True, 20:11:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:11:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:11:08 INFO - 'work_dir': 'build'} 20:11:08 INFO - ##### 20:11:08 INFO - ##### Running clobber step. 20:11:08 INFO - ##### 20:11:08 INFO - Running pre-action listener: _resource_record_pre_action 20:11:08 INFO - Running main action method: clobber 20:11:08 INFO - rmtree: /builds/slave/test/build 20:11:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:11:09 INFO - Running post-action listener: _resource_record_post_action 20:11:09 INFO - ##### 20:11:09 INFO - ##### Finished clobber step (success) 20:11:09 INFO - ##### 20:11:09 INFO - ##### 20:11:09 INFO - ##### Running read-buildbot-config step. 20:11:09 INFO - ##### 20:11:09 INFO - Running pre-action listener: _resource_record_pre_action 20:11:09 INFO - Running main action method: read_buildbot_config 20:11:09 INFO - Using buildbot properties: 20:11:09 INFO - { 20:11:09 INFO - "project": "", 20:11:09 INFO - "product": "firefox", 20:11:09 INFO - "script_repo_revision": "production", 20:11:09 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:11:09 INFO - "repository": "", 20:11:09 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:11:09 INFO - "buildid": "20160706173002", 20:11:09 INFO - "pgo_build": "True", 20:11:09 INFO - "basedir": "/builds/slave/test", 20:11:09 INFO - "buildnumber": 1310, 20:11:09 INFO - "slavename": "talos-linux64-ix-009", 20:11:09 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:11:09 INFO - "platform": "ubuntu64_hw", 20:11:09 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:11:09 INFO - "branch": "fx-team", 20:11:09 INFO - "repo_path": "integration/fx-team", 20:11:09 INFO - "revision": "1dd03896ee5f2165822f36235523e39394826531", 20:11:09 INFO - "stage_platform": "linux64-pgo", 20:11:09 INFO - "builduid": "12c2d2029d214d2d932fbd5f13a78840", 20:11:09 INFO - "slavebuilddir": "test" 20:11:09 INFO - } 20:11:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/VFgtFnOFRI-0DiV3eauzqg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 20:11:09 INFO - Running post-action listener: _resource_record_post_action 20:11:09 INFO - ##### 20:11:09 INFO - ##### Finished read-buildbot-config step (success) 20:11:09 INFO - ##### 20:11:09 INFO - ##### 20:11:09 INFO - ##### Running download-and-extract step. 20:11:09 INFO - ##### 20:11:09 INFO - Running pre-action listener: _resource_record_pre_action 20:11:09 INFO - Running main action method: download_and_extract 20:11:09 INFO - mkdir: /builds/slave/test/build/tests 20:11:09 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')]} 20:11:09 INFO - https://queue.taskcluster.net/v1/task/VFgtFnOFRI-0DiV3eauzqg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:11:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFgtFnOFRI-0DiV3eauzqg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:11:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFgtFnOFRI-0DiV3eauzqg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:11:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFgtFnOFRI-0DiV3eauzqg/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 20:11:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFgtFnOFRI-0DiV3eauzqg/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 20:11:11 INFO - Downloaded 1361 bytes. 20:11:11 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:11:11 INFO - Using the following test package requirements: 20:11:11 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:11:11 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:11:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:11:11 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:11:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:11:11 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:11:11 INFO - u'jsshell-linux-x86_64.zip'], 20:11:11 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:11:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:11:11 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:11:11 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:11:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:11:11 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:11:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:11:11 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:11:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:11:11 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:11:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:11:11 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:11:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:11 INFO - https://queue.taskcluster.net/v1/task/VFgtFnOFRI-0DiV3eauzqg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:11:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFgtFnOFRI-0DiV3eauzqg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:11:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFgtFnOFRI-0DiV3eauzqg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:11:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFgtFnOFRI-0DiV3eauzqg/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 20:11:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFgtFnOFRI-0DiV3eauzqg/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 20:11:12 INFO - Downloaded 24300742 bytes. 20:11:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:11:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:11:13 INFO - Return code: 0 20:11:13 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 20:11:13 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')]} 20:11:13 INFO - https://queue.taskcluster.net/v1/task/VFgtFnOFRI-0DiV3eauzqg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:11:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFgtFnOFRI-0DiV3eauzqg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:11:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFgtFnOFRI-0DiV3eauzqg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:11:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFgtFnOFRI-0DiV3eauzqg/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 20:11:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFgtFnOFRI-0DiV3eauzqg/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 20:11:15 INFO - Downloaded 24300742 bytes. 20:11:15 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'] 20:11:15 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 20:11:16 INFO - Return code: 0 20:11:16 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')]} 20:11:16 INFO - https://queue.taskcluster.net/v1/task/VFgtFnOFRI-0DiV3eauzqg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:11:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFgtFnOFRI-0DiV3eauzqg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:11:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFgtFnOFRI-0DiV3eauzqg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:11:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFgtFnOFRI-0DiV3eauzqg/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 20:11:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFgtFnOFRI-0DiV3eauzqg/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 20:11:17 INFO - Downloaded 14403333 bytes. 20:11:17 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'] 20:11:17 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 20:11:18 INFO - Return code: 0 20:11:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:18 INFO - https://queue.taskcluster.net/v1/task/VFgtFnOFRI-0DiV3eauzqg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:11:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFgtFnOFRI-0DiV3eauzqg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:11:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFgtFnOFRI-0DiV3eauzqg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:11:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFgtFnOFRI-0DiV3eauzqg/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 20:11:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFgtFnOFRI-0DiV3eauzqg/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 20:11:19 INFO - Downloaded 60350722 bytes. 20:11:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VFgtFnOFRI-0DiV3eauzqg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:11:19 INFO - mkdir: /builds/slave/test/properties 20:11:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:11:19 INFO - Writing to file /builds/slave/test/properties/build_url 20:11:19 INFO - Contents: 20:11:19 INFO - build_url:https://queue.taskcluster.net/v1/task/VFgtFnOFRI-0DiV3eauzqg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:11:20 INFO - Running post-action listener: _resource_record_post_action 20:11:20 INFO - Running post-action listener: set_extra_try_arguments 20:11:20 INFO - ##### 20:11:20 INFO - ##### Finished download-and-extract step (success) 20:11:20 INFO - ##### 20:11:20 INFO - ##### 20:11:20 INFO - ##### Running populate-webroot step. 20:11:20 INFO - ##### 20:11:20 INFO - Running pre-action listener: _resource_record_pre_action 20:11:20 INFO - Running main action method: populate_webroot 20:11:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:11:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:11:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:11:20 INFO - '--tppagecycles', 20:11:20 INFO - '7'], 20:11:20 INFO - 'tests': ['tsvgm']}}, 20:11:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:11:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:11:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:11:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:11:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:11:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:11:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:20 INFO - 'talos_options': ['--disable-e10s'], 20:11:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:11:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:11:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:20 INFO - 'talos_options': ['--disable-e10s'], 20:11:20 INFO - 'tests': ['damp', 'tps']}, 20:11:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:20 INFO - 'tests': ['damp', 'tps']}, 20:11:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:11:20 INFO - 'tests': ['dromaeo_dom']}, 20:11:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:11:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:11:20 INFO - 'tests': ['basic_compositor_video']}, 20:11:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:11:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:11:20 INFO - 'tests': ['a11yr', 20:11:20 INFO - 'ts_paint', 20:11:20 INFO - 'tpaint', 20:11:20 INFO - 'sessionrestore', 20:11:20 INFO - 'sessionrestore_no_auto_restore', 20:11:20 INFO - 'tabpaint']}, 20:11:20 INFO - 'other-e10s': {'tests': ['a11yr', 20:11:20 INFO - 'ts_paint', 20:11:20 INFO - 'tpaint', 20:11:20 INFO - 'sessionrestore', 20:11:20 INFO - 'sessionrestore_no_auto_restore', 20:11:20 INFO - 'tabpaint']}, 20:11:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:11:20 INFO - 'ts_paint', 20:11:20 INFO - 'tpaint', 20:11:20 INFO - 'sessionrestore', 20:11:20 INFO - 'sessionrestore_no_auto_restore', 20:11:20 INFO - 'tabpaint']}, 20:11:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:11:20 INFO - 'ts_paint', 20:11:20 INFO - 'tpaint', 20:11:20 INFO - 'sessionrestore', 20:11:20 INFO - 'sessionrestore_no_auto_restore', 20:11:20 INFO - 'tabpaint']}, 20:11:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:11:20 INFO - 'tests': ['a11yr', 20:11:20 INFO - 'ts_paint', 20:11:20 INFO - 'tpaint', 20:11:20 INFO - 'sessionrestore', 20:11:20 INFO - 'sessionrestore_no_auto_restore', 20:11:20 INFO - 'tabpaint']}, 20:11:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:11:20 INFO - 'tests': ['a11yr', 20:11:20 INFO - 'ts_paint', 20:11:20 INFO - 'tpaint', 20:11:20 INFO - 'sessionrestore', 20:11:20 INFO - 'sessionrestore_no_auto_restore', 20:11:20 INFO - 'tabpaint']}, 20:11:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:11:20 INFO - 'tests': ['tsvgx', 20:11:20 INFO - 'tsvgr_opacity', 20:11:20 INFO - 'tart', 20:11:20 INFO - 'tscrollx', 20:11:20 INFO - 'cart']}, 20:11:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:11:20 INFO - 'tsvgr_opacity', 20:11:20 INFO - 'tart', 20:11:20 INFO - 'tscrollx', 20:11:20 INFO - 'cart']}, 20:11:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:20 INFO - 'talos_options': ['--disable-e10s'], 20:11:20 INFO - 'tests': ['tp5o']}, 20:11:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:20 INFO - 'tests': ['tp5o']}, 20:11:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:20 INFO - 'talos_options': ['--disable-e10s', 20:11:20 INFO - '--xperf_path', 20:11:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:11:20 INFO - 'tests': ['tp5n']}, 20:11:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:20 INFO - 'talos_options': ['--xperf_path', 20:11:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:11:20 INFO - 'tests': ['tp5n']}}, 20:11:20 INFO - 'talos.zip': {'path': '', 20:11:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:11:20 INFO - Running post-action listener: _resource_record_post_action 20:11:20 INFO - ##### 20:11:20 INFO - ##### Finished populate-webroot step (success) 20:11:20 INFO - ##### 20:11:20 INFO - ##### 20:11:20 INFO - ##### Running create-virtualenv step. 20:11:20 INFO - ##### 20:11:20 INFO - Running pre-action listener: _resource_record_pre_action 20:11:20 INFO - Running main action method: create_virtualenv 20:11:20 INFO - Creating virtualenv /builds/slave/test/build/venv 20:11:20 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 20:11:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:11:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:11:20 INFO - Using real prefix '/usr' 20:11:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:11:20 INFO - Installing distribute.............................................................................................................................................................................................done. 20:11:22 INFO - Installing pip.................done. 20:11:22 INFO - Return code: 0 20:11:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x161b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16193b0>, '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 0x161a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x161a740>, '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': '17051fcd5208b27b50bedfeb000001dd-1467860438.892864-1846552983', '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 20:11:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:11:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:11:22 INFO - Using env: {'DISPLAY': ':0', 20:11:22 INFO - 'HOME': '/home/cltbld', 20:11:22 INFO - 'LANG': 'en_US.UTF-8', 20:11:22 INFO - 'LANGUAGE': 'en_US:en', 20:11:22 INFO - 'LOGNAME': 'cltbld', 20:11:22 INFO - 'MAIL': '/var/mail/cltbld', 20:11:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:22 INFO - 'MOZ_NO_REMOTE': '1', 20:11:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:22 INFO - 'NO_EM_RESTART': '1', 20:11:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:22 INFO - 'PWD': '/builds/slave/test', 20:11:22 INFO - 'SHELL': '/bin/bash', 20:11:22 INFO - 'SHLVL': '1', 20:11:22 INFO - 'TERM': 'linux', 20:11:22 INFO - 'TMOUT': '86400', 20:11:22 INFO - 'USER': 'cltbld', 20:11:22 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467860438.892864-1846552983', 20:11:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:22 INFO - '_': '/tools/buildbot/bin/python'} 20:11:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:22 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 20:11:22 INFO - Cleaning up... 20:11:22 INFO - Return code: 0 20:11:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x135a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x161b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16193b0>, '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 0x161a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x161a740>, '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': '17051fcd5208b27b50bedfeb000001dd-1467860438.892864-1846552983', '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 20:11:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:11:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:11:22 INFO - Using env: {'DISPLAY': ':0', 20:11:22 INFO - 'HOME': '/home/cltbld', 20:11:22 INFO - 'LANG': 'en_US.UTF-8', 20:11:22 INFO - 'LANGUAGE': 'en_US:en', 20:11:22 INFO - 'LOGNAME': 'cltbld', 20:11:22 INFO - 'MAIL': '/var/mail/cltbld', 20:11:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:22 INFO - 'MOZ_NO_REMOTE': '1', 20:11:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:22 INFO - 'NO_EM_RESTART': '1', 20:11:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:22 INFO - 'PWD': '/builds/slave/test', 20:11:22 INFO - 'SHELL': '/bin/bash', 20:11:22 INFO - 'SHLVL': '1', 20:11:22 INFO - 'TERM': 'linux', 20:11:22 INFO - 'TMOUT': '86400', 20:11:22 INFO - 'USER': 'cltbld', 20:11:22 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467860438.892864-1846552983', 20:11:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:22 INFO - '_': '/tools/buildbot/bin/python'} 20:11:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:23 INFO - Downloading/unpacking psutil>=3.1.1 20:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:11:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:11:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:11:25 INFO - Installing collected packages: psutil 20:11:25 INFO - Running setup.py install for psutil 20:11:25 INFO - building 'psutil._psutil_linux' extension 20:11:25 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 20:11:25 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 20:11:25 INFO - building 'psutil._psutil_posix' extension 20:11:25 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 20:11:25 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 20:11:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:11:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:11:25 INFO - Successfully installed psutil 20:11:25 INFO - Cleaning up... 20:11:25 INFO - Return code: 0 20:11:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:11:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x161b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16193b0>, '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 0x161a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x161a740>, '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': '17051fcd5208b27b50bedfeb000001dd-1467860438.892864-1846552983', '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 20:11:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:11:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:11:25 INFO - Using env: {'DISPLAY': ':0', 20:11:25 INFO - 'HOME': '/home/cltbld', 20:11:25 INFO - 'LANG': 'en_US.UTF-8', 20:11:25 INFO - 'LANGUAGE': 'en_US:en', 20:11:25 INFO - 'LOGNAME': 'cltbld', 20:11:25 INFO - 'MAIL': '/var/mail/cltbld', 20:11:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:25 INFO - 'MOZ_NO_REMOTE': '1', 20:11:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:25 INFO - 'NO_EM_RESTART': '1', 20:11:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:25 INFO - 'PWD': '/builds/slave/test', 20:11:25 INFO - 'SHELL': '/bin/bash', 20:11:25 INFO - 'SHLVL': '1', 20:11:25 INFO - 'TERM': 'linux', 20:11:25 INFO - 'TMOUT': '86400', 20:11:25 INFO - 'USER': 'cltbld', 20:11:25 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467860438.892864-1846552983', 20:11:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:25 INFO - '_': '/tools/buildbot/bin/python'} 20:11:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:11:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:11:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:11:27 INFO - Installing collected packages: mozsystemmonitor 20:11:27 INFO - Running setup.py install for mozsystemmonitor 20:11:27 INFO - Successfully installed mozsystemmonitor 20:11:27 INFO - Cleaning up... 20:11:28 INFO - Return code: 0 20:11:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:11: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')]} 20:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11: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')]} 20:11:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x135a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x161b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16193b0>, '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 0x161a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x161a740>, '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': '17051fcd5208b27b50bedfeb000001dd-1467860438.892864-1846552983', '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 20:11:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:11:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:11:28 INFO - Using env: {'DISPLAY': ':0', 20:11:28 INFO - 'HOME': '/home/cltbld', 20:11:28 INFO - 'LANG': 'en_US.UTF-8', 20:11:28 INFO - 'LANGUAGE': 'en_US:en', 20:11:28 INFO - 'LOGNAME': 'cltbld', 20:11:28 INFO - 'MAIL': '/var/mail/cltbld', 20:11:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:28 INFO - 'MOZ_NO_REMOTE': '1', 20:11:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:28 INFO - 'NO_EM_RESTART': '1', 20:11:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:28 INFO - 'PWD': '/builds/slave/test', 20:11:28 INFO - 'SHELL': '/bin/bash', 20:11:28 INFO - 'SHLVL': '1', 20:11:28 INFO - 'TERM': 'linux', 20:11:28 INFO - 'TMOUT': '86400', 20:11:28 INFO - 'USER': 'cltbld', 20:11:28 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467860438.892864-1846552983', 20:11:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:28 INFO - '_': '/tools/buildbot/bin/python'} 20:11:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:28 INFO - Downloading/unpacking jsonschema==2.5.1 20:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:11:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:30 INFO - Downloading functools32-3.2.3-2.tar.gz 20:11:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:11:30 INFO - warning: no files found matching '*.txt' 20:11:30 INFO - no previously-included directories found matching 'build' 20:11:30 INFO - no previously-included directories found matching 'dist' 20:11:30 INFO - no previously-included directories found matching '.git*' 20:11:30 INFO - Installing collected packages: jsonschema, functools32 20:11:30 INFO - Running setup.py install for functools32 20:11:30 INFO - warning: no files found matching '*.txt' 20:11:30 INFO - no previously-included directories found matching 'build' 20:11:30 INFO - no previously-included directories found matching 'dist' 20:11:30 INFO - no previously-included directories found matching '.git*' 20:11:30 INFO - Successfully installed jsonschema functools32 20:11:30 INFO - Cleaning up... 20:11:30 INFO - Return code: 0 20:11:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:11:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:30 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 0x135a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x161b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16193b0>, '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 0x161a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x161a740>, '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': '17051fcd5208b27b50bedfeb000001dd-1467860438.892864-1846552983', '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 20:11:30 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 20:11:30 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 20:11:30 INFO - Using env: {'DISPLAY': ':0', 20:11:30 INFO - 'HOME': '/home/cltbld', 20:11:30 INFO - 'LANG': 'en_US.UTF-8', 20:11:30 INFO - 'LANGUAGE': 'en_US:en', 20:11:30 INFO - 'LOGNAME': 'cltbld', 20:11:30 INFO - 'MAIL': '/var/mail/cltbld', 20:11:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:30 INFO - 'MOZ_NO_REMOTE': '1', 20:11:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:30 INFO - 'NO_EM_RESTART': '1', 20:11:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:30 INFO - 'PWD': '/builds/slave/test', 20:11:30 INFO - 'SHELL': '/bin/bash', 20:11:30 INFO - 'SHLVL': '1', 20:11:30 INFO - 'TERM': 'linux', 20:11:30 INFO - 'TMOUT': '86400', 20:11:30 INFO - 'USER': 'cltbld', 20:11:30 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467860438.892864-1846552983', 20:11:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:30 INFO - '_': '/tools/buildbot/bin/python'} 20:11:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:30 INFO - Downloading/unpacking blobuploader==1.2.4 20:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:32 INFO - Downloading blobuploader-1.2.4.tar.gz 20:11:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:11:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:11:32 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 20:11:32 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 20:11:32 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 20:11:32 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 20:11:32 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 20:11:32 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 20:11:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:11:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:33 INFO - Downloading docopt-0.6.1.tar.gz 20:11:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:11:33 INFO - Installing collected packages: blobuploader, requests, docopt 20:11:33 INFO - Running setup.py install for blobuploader 20:11:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:11:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:11:33 INFO - Running setup.py install for requests 20:11:33 INFO - Running setup.py install for docopt 20:11:33 INFO - Successfully installed blobuploader requests docopt 20:11:33 INFO - Cleaning up... 20:11:34 INFO - Return code: 0 20:11:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:11:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:34 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 0x135a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x161b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16193b0>, '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 0x161a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x161a740>, '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': '17051fcd5208b27b50bedfeb000001dd-1467860438.892864-1846552983', '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 20:11:34 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 20:11:34 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 20:11:34 INFO - Using env: {'DISPLAY': ':0', 20:11:34 INFO - 'HOME': '/home/cltbld', 20:11:34 INFO - 'LANG': 'en_US.UTF-8', 20:11:34 INFO - 'LANGUAGE': 'en_US:en', 20:11:34 INFO - 'LOGNAME': 'cltbld', 20:11:34 INFO - 'MAIL': '/var/mail/cltbld', 20:11:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:34 INFO - 'MOZ_NO_REMOTE': '1', 20:11:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:34 INFO - 'NO_EM_RESTART': '1', 20:11:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:34 INFO - 'PWD': '/builds/slave/test', 20:11:34 INFO - 'SHELL': '/bin/bash', 20:11:34 INFO - 'SHLVL': '1', 20:11:34 INFO - 'TERM': 'linux', 20:11:34 INFO - 'TMOUT': '86400', 20:11:34 INFO - 'USER': 'cltbld', 20:11:34 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467860438.892864-1846552983', 20:11:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:34 INFO - '_': '/tools/buildbot/bin/python'} 20:11:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:11:34 INFO - Running setup.py (path:/tmp/pip-gXCxgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:11:34 INFO - Running setup.py (path:/tmp/pip-mE4VRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:11:34 INFO - Running setup.py (path:/tmp/pip-8JQAEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:11:34 INFO - Running setup.py (path:/tmp/pip-8fE7Ct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:11:34 INFO - Running setup.py (path:/tmp/pip-tbxLqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:11:34 INFO - Running setup.py (path:/tmp/pip-sjBnKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:11:34 INFO - Running setup.py (path:/tmp/pip-3MmiTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:11:34 INFO - Running setup.py (path:/tmp/pip-Zta2No-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:11:34 INFO - Running setup.py (path:/tmp/pip-_dS9fi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:11:34 INFO - Running setup.py (path:/tmp/pip-941Ije-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:11:34 INFO - Running setup.py (path:/tmp/pip-RaBPyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:11:35 INFO - Running setup.py (path:/tmp/pip-t1BP6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:11:35 INFO - Running setup.py (path:/tmp/pip-dD0f3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:11:35 INFO - Running setup.py (path:/tmp/pip-IvQQ6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:11:35 INFO - Running setup.py (path:/tmp/pip-wuzAzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:11:35 INFO - Running setup.py (path:/tmp/pip-GN77Vm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:11:35 INFO - Running setup.py (path:/tmp/pip-d38P6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:11:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:11:35 INFO - Running setup.py install for manifestparser 20:11:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:11:35 INFO - Running setup.py install for mozcrash 20:11:35 INFO - Running setup.py install for mozdebug 20:11:35 INFO - Running setup.py install for mozdevice 20:11:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:11:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:11:35 INFO - Running setup.py install for mozfile 20:11:35 INFO - Running setup.py install for mozhttpd 20:11:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:11:36 INFO - Running setup.py install for mozinfo 20:11:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:11:36 INFO - Running setup.py install for mozInstall 20:11:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:11:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:11:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:11:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:11:36 INFO - Running setup.py install for mozleak 20:11:36 INFO - Running setup.py install for mozlog 20:11:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:11:36 INFO - Running setup.py install for moznetwork 20:11:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:11:36 INFO - Running setup.py install for mozprocess 20:11:36 INFO - Running setup.py install for mozprofile 20:11:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:11:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:11:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:11:36 INFO - Running setup.py install for mozrunner 20:11:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:11:36 INFO - Running setup.py install for mozscreenshot 20:11:37 INFO - Running setup.py install for moztest 20:11:37 INFO - Running setup.py install for mozversion 20:11:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:11:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:11:37 INFO - Cleaning up... 20:11:37 INFO - Return code: 0 20:11:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:11: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')]} 20:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11: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')]} 20:11:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:37 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 0x135a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x161b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16193b0>, '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 0x161a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x161a740>, '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': '17051fcd5208b27b50bedfeb000001dd-1467860438.892864-1846552983', '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 20:11:37 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 20:11:37 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 20:11:37 INFO - Using env: {'DISPLAY': ':0', 20:11:37 INFO - 'HOME': '/home/cltbld', 20:11:37 INFO - 'LANG': 'en_US.UTF-8', 20:11:37 INFO - 'LANGUAGE': 'en_US:en', 20:11:37 INFO - 'LOGNAME': 'cltbld', 20:11:37 INFO - 'MAIL': '/var/mail/cltbld', 20:11:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:37 INFO - 'MOZ_NO_REMOTE': '1', 20:11:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:37 INFO - 'NO_EM_RESTART': '1', 20:11:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:37 INFO - 'PWD': '/builds/slave/test', 20:11:37 INFO - 'SHELL': '/bin/bash', 20:11:37 INFO - 'SHLVL': '1', 20:11:37 INFO - 'TERM': 'linux', 20:11:37 INFO - 'TMOUT': '86400', 20:11:37 INFO - 'USER': 'cltbld', 20:11:37 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467860438.892864-1846552983', 20:11:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:37 INFO - '_': '/tools/buildbot/bin/python'} 20:11:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:11:37 INFO - Running setup.py (path:/tmp/pip-_BbSZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:11:37 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)) 20:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:11:37 INFO - Running setup.py (path:/tmp/pip-beSd84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:11:37 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)) 20:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:11:37 INFO - Running setup.py (path:/tmp/pip-h2OQA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:11:37 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)) 20:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:11:37 INFO - Running setup.py (path:/tmp/pip-Qhlmqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:11:37 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)) 20:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:11:37 INFO - Running setup.py (path:/tmp/pip-WTMLtF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:11:37 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)) 20:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:11:37 INFO - Running setup.py (path:/tmp/pip-h5LYF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:11:37 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)) 20:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:11:37 INFO - Running setup.py (path:/tmp/pip-dOa5fz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:11:37 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)) 20:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:11:37 INFO - Running setup.py (path:/tmp/pip-dsf8Wn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:11:38 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)) 20:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:11:38 INFO - Running setup.py (path:/tmp/pip-bzUCFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:11:38 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)) 20:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:11:38 INFO - Running setup.py (path:/tmp/pip-wje3WW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:11:38 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)) 20:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:11:38 INFO - Running setup.py (path:/tmp/pip-kqeTFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:11:38 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)) 20:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:11:38 INFO - Running setup.py (path:/tmp/pip-fEQOKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:11:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:11:38 INFO - Running setup.py (path:/tmp/pip-725MYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:11:38 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)) 20:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:11:38 INFO - Running setup.py (path:/tmp/pip-y03R8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:11:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:11:38 INFO - Running setup.py (path:/tmp/pip-OqJYAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:11:38 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)) 20:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:11:38 INFO - Running setup.py (path:/tmp/pip-nxK1JQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:11:38 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)) 20:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:11:38 INFO - Running setup.py (path:/tmp/pip-Sr4p4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:11:38 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)) 20:11:38 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)) 20:11:38 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)) 20:11:38 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)) 20:11:38 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)) 20:11:38 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)) 20:11:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:11:38 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 20:11:38 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 20:11:38 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 20:11:38 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 20:11:38 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 20:11:38 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 20:11:40 INFO - Downloading blessings-1.6.tar.gz 20:11:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:11:40 INFO - Installing collected packages: blessings 20:11:40 INFO - Running setup.py install for blessings 20:11:40 INFO - Successfully installed blessings 20:11:40 INFO - Cleaning up... 20:11:40 INFO - Return code: 0 20:11:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:11:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:11:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:11:41 INFO - Reading from file tmpfile_stdout 20:11:41 INFO - Current package versions: 20:11:41 INFO - argparse == 1.2.1 20:11:41 INFO - blessings == 1.6 20:11:41 INFO - blobuploader == 1.2.4 20:11:41 INFO - docopt == 0.6.1 20:11:41 INFO - functools32 == 3.2.3-2 20:11:41 INFO - jsonschema == 2.5.1 20:11:41 INFO - manifestparser == 1.1 20:11:41 INFO - mozInstall == 1.12 20:11:41 INFO - mozcrash == 0.17 20:11:41 INFO - mozdebug == 0.1 20:11:41 INFO - mozdevice == 0.48 20:11:41 INFO - mozfile == 1.2 20:11:41 INFO - mozhttpd == 0.7 20:11:41 INFO - mozinfo == 0.9 20:11:41 INFO - mozleak == 0.1 20:11:41 INFO - mozlog == 3.2 20:11:41 INFO - moznetwork == 0.27 20:11:41 INFO - mozprocess == 0.22 20:11:41 INFO - mozprofile == 0.28 20:11:41 INFO - mozrunner == 6.11 20:11:41 INFO - mozscreenshot == 0.1 20:11:41 INFO - mozsystemmonitor == 0.3 20:11:41 INFO - moztest == 0.7 20:11:41 INFO - mozversion == 1.4 20:11:41 INFO - psutil == 3.1.1 20:11:41 INFO - requests == 1.2.3 20:11:41 INFO - wsgiref == 0.1.2 20:11:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:11:41 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')]} 20:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:41 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')]} 20:11:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:41 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 0x135a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x161b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16193b0>, '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 0x161a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x161a740>, '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': '17051fcd5208b27b50bedfeb000001dd-1467860438.892864-1846552983', '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 20:11:41 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 20:11:41 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 20:11:41 INFO - Using env: {'DISPLAY': ':0', 20:11:41 INFO - 'HOME': '/home/cltbld', 20:11:41 INFO - 'LANG': 'en_US.UTF-8', 20:11:41 INFO - 'LANGUAGE': 'en_US:en', 20:11:41 INFO - 'LOGNAME': 'cltbld', 20:11:41 INFO - 'MAIL': '/var/mail/cltbld', 20:11:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:41 INFO - 'MOZ_NO_REMOTE': '1', 20:11:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:41 INFO - 'NO_EM_RESTART': '1', 20:11:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:41 INFO - 'PWD': '/builds/slave/test', 20:11:41 INFO - 'SHELL': '/bin/bash', 20:11:41 INFO - 'SHLVL': '1', 20:11:41 INFO - 'TERM': 'linux', 20:11:41 INFO - 'TMOUT': '86400', 20:11:41 INFO - 'USER': 'cltbld', 20:11:41 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467860438.892864-1846552983', 20:11:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:41 INFO - '_': '/tools/buildbot/bin/python'} 20:11:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:41 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)) 20:11:41 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)) 20:11:41 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)) 20:11:41 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)) 20:11:41 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)) 20:11:41 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)) 20:11:41 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)) 20:11:41 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)) 20:11:41 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)) 20:11:41 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)) 20:11:41 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)) 20:11:41 INFO - Cleaning up... 20:11:41 INFO - Return code: 0 20:11:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:11:41 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')]} 20:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:41 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')]} 20:11:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:41 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 0x135a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x161b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16193b0>, '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 0x161a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x161a740>, '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': '17051fcd5208b27b50bedfeb000001dd-1467860438.892864-1846552983', '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 20:11:41 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 20:11:41 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 20:11:41 INFO - Using env: {'DISPLAY': ':0', 20:11:41 INFO - 'HOME': '/home/cltbld', 20:11:41 INFO - 'LANG': 'en_US.UTF-8', 20:11:41 INFO - 'LANGUAGE': 'en_US:en', 20:11:41 INFO - 'LOGNAME': 'cltbld', 20:11:41 INFO - 'MAIL': '/var/mail/cltbld', 20:11:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:41 INFO - 'MOZ_NO_REMOTE': '1', 20:11:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:41 INFO - 'NO_EM_RESTART': '1', 20:11:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:41 INFO - 'PWD': '/builds/slave/test', 20:11:41 INFO - 'SHELL': '/bin/bash', 20:11:41 INFO - 'SHLVL': '1', 20:11:41 INFO - 'TERM': 'linux', 20:11:41 INFO - 'TMOUT': '86400', 20:11:41 INFO - 'USER': 'cltbld', 20:11:41 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467860438.892864-1846552983', 20:11:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:41 INFO - '_': '/tools/buildbot/bin/python'} 20:11:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:11:41 INFO - Cleaning up... 20:11:41 INFO - Return code: 0 20:11:41 INFO - Running post-action listener: _resource_record_post_action 20:11:41 INFO - Running post-action listener: _start_resource_monitoring 20:11:41 INFO - Starting resource monitoring. 20:11:41 INFO - ##### 20:11:41 INFO - ##### Finished create-virtualenv step (success) 20:11:41 INFO - ##### 20:11:41 INFO - ##### 20:11:41 INFO - ##### Running install step. 20:11:41 INFO - ##### 20:11:41 INFO - Running pre-action listener: _resource_record_pre_action 20:11:41 INFO - Running main action method: install 20:11:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:11:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:11:41 INFO - Reading from file tmpfile_stdout 20:11:41 INFO - Detecting whether we're running mozinstall >=1.0... 20:11:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:11:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:11:41 INFO - Reading from file tmpfile_stdout 20:11:41 INFO - Output received: 20:11:41 INFO - Usage: mozinstall [options] installer 20:11:41 INFO - Options: 20:11:41 INFO - -h, --help show this help message and exit 20:11:41 INFO - -d DEST, --destination=DEST 20:11:41 INFO - Directory to install application into. [default: 20:11:41 INFO - "/builds/slave/test"] 20:11:41 INFO - --app=APP Application being installed. [default: firefox] 20:11:41 INFO - mkdir: /builds/slave/test/build/application 20:11:41 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'] 20:11:41 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 20:11:59 INFO - Reading from file tmpfile_stdout 20:11:59 INFO - Output received: 20:11:59 INFO - /builds/slave/test/build/application/firefox/firefox 20:11:59 INFO - Running post-action listener: _resource_record_post_action 20:11:59 INFO - ##### 20:11:59 INFO - ##### Finished install step (success) 20:11:59 INFO - ##### 20:11:59 INFO - ##### 20:11:59 INFO - ##### Running run-tests step. 20:11:59 INFO - ##### 20:11:59 INFO - Running pre-action listener: _resource_record_pre_action 20:11:59 INFO - Running main action method: run_tests 20:11:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:11:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:11:59 INFO - Python 2.7.3 20:11:59 INFO - Return code: 0 20:11:59 INFO - grabbing minidump binary from tooltool 20:11: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')]} 20:11:59 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 0x16193b0>, '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 0x161a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x161a740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:11:59 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 20:11:59 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 20:11:59 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 20:11:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:11:59 INFO - Return code: 0 20:11:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:11:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:11:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:11:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:11:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:11:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VFgtFnOFRI-0DiV3eauzqg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:11:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VFgtFnOFRI-0DiV3eauzqg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:11:59 INFO - Using env: {'DISPLAY': ':0', 20:11:59 INFO - 'HOME': '/home/cltbld', 20:11:59 INFO - 'LANG': 'en_US.UTF-8', 20:11:59 INFO - 'LANGUAGE': 'en_US:en', 20:11:59 INFO - 'LOGNAME': 'cltbld', 20:11:59 INFO - 'MAIL': '/var/mail/cltbld', 20:11:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:11:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:59 INFO - 'MOZ_NO_REMOTE': '1', 20:11:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:11:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:59 INFO - 'NO_EM_RESTART': '1', 20:11:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:59 INFO - 'PWD': '/builds/slave/test', 20:11:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:11:59 INFO - 'SHELL': '/bin/bash', 20:11:59 INFO - 'SHLVL': '1', 20:11:59 INFO - 'TERM': 'linux', 20:11:59 INFO - 'TMOUT': '86400', 20:11:59 INFO - 'USER': 'cltbld', 20:11:59 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467860438.892864-1846552983', 20:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:59 INFO - '_': '/tools/buildbot/bin/python'} 20:11:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VFgtFnOFRI-0DiV3eauzqg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:11:59 INFO - mozversion application_buildid: 20160706173002 20:11:59 INFO - mozversion application_changeset: 1dd03896ee5f2165822f36235523e39394826531 20:11:59 INFO - mozversion application_display_name: Nightly 20:11:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:11:59 INFO - mozversion application_name: Firefox 20:11:59 INFO - mozversion application_remotingname: firefox 20:11:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:11:59 INFO - mozversion application_vendor: Mozilla 20:11:59 INFO - mozversion application_version: 50.0a1 20:11:59 INFO - mozversion platform_buildid: 20160706173002 20:11:59 INFO - mozversion platform_changeset: 1dd03896ee5f2165822f36235523e39394826531 20:11:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:11:59 INFO - mozversion platform_version: 50.0a1 20:11:59 INFO - using testdate: 1467861119 20:11:59 INFO - actual date: 1467861119 20:11:59 INFO - starting webserver on 'localhost:52041' 20:11:59 INFO - SUITE-START | Running 2 tests 20:11:59 INFO - TEST-START | dromaeo_css 20:11:59 INFO - operating with platform_type : linux_ 20:11:59 INFO - Initialising browser for dromaeo_css test... 20:11:59 INFO - TEST-INFO | started process 21556 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJf855K/profile http://localhost:52041/getInfo.html) 20:12:03 INFO - PROCESS | 21556 | __metrics Screen width/height:1600/1200 20:12:03 INFO - PROCESS | 21556 | colorDepth:24 20:12:03 INFO - PROCESS | 21556 | Browser inner width/height: 1024/697 20:12:03 INFO - PROCESS | 21556 | __metrics 20:12:04 INFO - PROCESS | 21556 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:12:05 INFO - TEST-INFO | 21556: exit 0 20:12:05 INFO - Browser initialized. 20:12:05 INFO - Running cycle 1/1 for dromaeo_css test... 20:12:05 INFO - TEST-INFO | started process 21640 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJf855K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:12:17 INFO - PROCESS | 21640 | RSS: Main: 157290496 20:12:17 INFO - PROCESS | 21640 | 20:13:07 INFO - PROCESS | 21640 | 1467861187991 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] 20:15:17 INFO - PROCESS | 21640 | Cycle 1(1): loaded http://localhost:52041/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52041/tests/dromaeo/cssquery-ext.html) 20:15:18 INFO - PROCESS | 21640 | RSS: Main: 277364736 20:15:18 INFO - PROCESS | 21640 | 20:18:20 INFO - PROCESS | 21640 | Cycle 1(1): loaded http://localhost:52041/tests/dromaeo/cssquery-ext.html (next: http://localhost:52041/tests/dromaeo/cssquery-jquery.html) 20:18:21 INFO - PROCESS | 21640 | RSS: Main: 243630080 20:18:21 INFO - PROCESS | 21640 | 20:21:23 INFO - PROCESS | 21640 | Cycle 1(1): loaded http://localhost:52041/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52041/tests/dromaeo/cssquery-mootools.html) 20:21:23 INFO - PROCESS | 21640 | RSS: Main: 236347392 20:21:23 INFO - PROCESS | 21640 | 20:24:25 INFO - PROCESS | 21640 | Cycle 1(1): loaded http://localhost:52041/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52041/tests/dromaeo/cssquery-prototype.html) 20:24:26 INFO - PROCESS | 21640 | RSS: Main: 233992192 20:24:26 INFO - PROCESS | 21640 | 20:27:29 INFO - PROCESS | 21640 | Cycle 1(1): loaded http://localhost:52041/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52041/tests/dromaeo/cssquery-yui.html) 20:27:29 INFO - PROCESS | 21640 | RSS: Main: 202870784 20:27:29 INFO - PROCESS | 21640 | 20:30:32 INFO - PROCESS | 21640 | Cycle 1(1): loaded http://localhost:52041/tests/dromaeo/cssquery-yui.html (next: http://localhost:52041/tests/dromaeo/cssquery-dojo.html) 20:30:32 INFO - PROCESS | 21640 | RSS: Main: 283865088 20:30:32 INFO - PROCESS | 21640 | 20:30:32 INFO - PROCESS | 21640 | __start_tp_report 20:30:32 INFO - PROCESS | 21640 | _x_x_mozilla_page_load 20:30:32 INFO - PROCESS | 21640 | _x_x_mozilla_page_load_details 20:30:32 INFO - PROCESS | 21640 | |i|pagename|runs| 20:30:32 INFO - PROCESS | 21640 | |0;dojo.html;3150.7951983121097;3166.192620881675;3181.347823696142;3199.456092464281;3235.223546348877;5199.324087868572;5303.787848486056;5496.917546236809;5535.474129957653;5590.217369568264;5498.642588231762;5513.917291240635;5523.226748255248;5569.498745112939;5602.691851948141;5007.12375334315;5013.197888337867;5045.621578381618;5054.241863720435;5109.41241757199;4951.356323677916;5018.222175562793;5022.070916880389;5025.221090730943;5027.723475208862;4872.269159626049;4914.262860570907;4938.209886418192;4951.8019279228965;5008.273800298936;4881.365422495053;4895;4908.901821963541;4962.702237865739;5054.9241761373605;4920.237363208708;4942.827001054981;4949.529794669501;4958.752062396866;4988.55103040728;5323.30796996388;5414.35027796663;5440.646357986758;5453.182022696587;5467.17992301158;5868.911966320508;5914.615549989237;5922.822315330547;5925.022371308772;5938.940610593882;5992.910106348409;6002.849928751816;6002.909956350658;6004.459598636144;6007.549433792483;5347.171188465794;5495.835124946298;5565.1374037024325;5567.972160139255;5573.804916827891;6082.1789058477425;6087.4521293083835;6093.360197179321;6095.4818840398175;6097.512199024068;5887.76448942046;5897.410258974069;5901.557383196277;5905.645661260338;5905.911411328833;5684.6589204647025;5836.533077353802;5903.3801450847905;5923;5931.940680593225;5851.32709738377;5858.5898987070495;5863.120531920246;5866.5893387462465;5907.822765317047;5805.245318108703;5816.883662326814;5864.47219750216;5867.589268751231;5871.060630299217;4373.562643735601;4400.515943246241;4420.049689316812;4422.756748378806;4456.75487848165;3941.4481972523868;3945.92108157841;3954.189391174802;3975.125472396126;4001.679865610744;5514.558835293167;5532.889342213133;5558.722063896789;5564.888702225933;5604.159376093537;5733.741981610754;5778.711064446761;5801.53587712982;5807.157962095473;5942.970285148546;5546.362168350611;5553.333599968029;5554.1946417769195;5592.356878958891;5597.440255974451;5049.141645920203;5049.722265275445;5055.469175736568;5061.468545802712;5100;5924.911126333109;5965.463108320272;6023.668698221464;6045.758169673251;6053.969730151321;5856.355800861987;5859.2090067842;5859.707014649165;5870.618409803349;5930.169776231245;5960.731767070405;6010.338862725184;6018.127371531016;6019.337872833898;6022.427869352405;5687.8862422752145;5714.9142762857755;5746.885062298814;5766.394528574607;5767.452092051249;5897.439743224387;5907.4683278505145;5923.466887980103;5930.199423077829;5933.465988061095;5769.711514424178;5771.624844385102;5777.191193233035;5784.42155784435;5793.131030345482;5591.189277554813;5611.046122159324;5636.267285253055;5652.7173641318595;5684.7157642118555;5585.664860108406;5590.245316882331;5612.242347283064;5621;5621.184928185472;5569.303837020372;5700.287464066992;5714.228579141929;5764.884702306014;5772.538196944319;5524.364698059774;5565.749541270571;5583.302087239095;5607.971960140173;5621.297337832771 20:30:32 INFO - PROCESS | 21640 | |1;ext.html;591.6716222496513;608.9056196289575;616.987660246795;629.4492319220681;637.6970938804071;44410.555894441044;45319.32021019687;45531.31703024457;45543;48548.51451485484;46104.76947615266;46174.076518469614;46216.76891615537;46397.7680111599;46426;9064.592093355799;9192.034836342187;9197.356185067049;9203.309751768611;9212.953935230315;9021.278297736199;9097.681581144661;9116.179543841054;9122;9124.452532848018;9172.403793753418;9218.17036466718;9218.723438296862;9222.21611163052;9226.354155209137;9101.317401194938;9135.588898499584;9139.131782480654;9141.954290228572;9147.039560846115;8989;9027.097290270985;9056.320775941831;9058.864117038249;9059.728208153765;42382;42466.150676986595;42554.78722606398;42635;42806;3610.2418492116426;3830.693544516432;3903.082775547744;4146.3365861462025;4479.865604031885;32687;33389.666103338895;33765.831170844234;33775;33805.49291760626;4417.580329868657;4589.2886602576655;4618.49196588375;4683.2038553446;4692.718436893763;370697;371044.1447792771;371630;371730;372417;57906.420935790105;58044.709776451695;58361;58365.12452313219;58397;61418;61459;61496;61499.6925015372;61553;15757.68484630301;15916.204189790697;15926.28331725075;15948.681026379407;15973.041617502988;12036.338001409831;12039.518419263306;12044.15690901646;12046.939765301293;12048.638540843613;14819;16246.187690615421;16474;16502.504924852274;16577.336906523844;5110.897782044338;6083;6090.756369745249;6120.540959428061;6287.591306565058;1014.0923873133504;1014.6448742939912;1017.4963393120453;1040.2250323508883;1073.7961970544886;32490.512642310383;32796.18009549733;33014.3397132056;33147.66852331494;33159.502607460905;1041.770810421721;1094.4090191296611;1152.6657269391783;1168.5793114478781;1199.2804317409484;16795.563549160623;17178.484645460656;17284.654306914043;17375.47873563795;17504.03727794958;512156;514623;515790;516741;518522;59378;59469;59580.10629840556;59597.40402596005;59621;1228.956986505468;1245.7757603631253;1275.579058910576;1347.1041757231528;1387.9097858639157;30108.9564174332;34268.82865585656;34377.48433773445;34597.48103778395;35035;50071.49928500814;50198.49801501938;50442.24336635027;50609.746951265006;50843.2373514405;392735;394100;394667;395116;395760;35145.64854351424;41272.58727412808;41331.380029300184;42684.78657606692;42721.78639106784;48959;49366.50633493619;49598.25602616036;50388.49611503838;51348.74325628497;41864;42281.365779512715;43009.56990430056;43283;43732.78133609312;41665.37501937413;41826.581734183485;42214.366784497644;42398;42907;41259.38110928278;41754.16491670089;41809.79095104505;42073.579264206965;42264.577354227295;35590;37494;37855.62144378521;38136.61863381442;38302.61697382991;28290.292742680773;28645.427091457637;28858.7114128856;28920.566191507565;28929.710702892702 20:30:32 INFO - PROCESS | 21640 | |2;jquery.html;396.29657358189195;397.2967846910968;400.2774991140991;406.25046788674894;415.21109891206703;18651.533711657197;19233.61532769344;20030.799692003075;20171.899140504276;20199.596008079847;18978.145983430742;18999.620007599875;19711;20242.39272821814;20301.898490507527;5767.33675627304;5815.040518314484;5857.26784151981;5915.73379197935;5920.733566989475;5848.444397782204;5855.326637436707;5866.44268794466;5868.325142608591;5869.148973398855;6138.324784273726;6406.93593064068;6409.391107844771;6473.352664733513;6503.772367967122;5773.076307790754;5806.245188125537;5828.970855145697;5988.550858685572;6348.365163483661;5731.083026715747;5781.4507621775865;5793.391693872125;5817.680027598481;5834.183214349994;13652.453901843914;13738.587842364745;14174.929125354307;14178.929105354511;14243;2204.7795220477983;2274.863508189514;2482.8262021658493;2495.4011037350906;3121.094882484077;10004.299699021072;10047.598096076148;10181.440020798853;10352.275340726152;10718;1875.184294831739;1883.0961138653386;1884.4252502986583;1884.5382881194057;1939.5539026024094;55078;70404;71497.64251178764;76777.23222767757;81441;10399.168066554657;10605.575776968835;10719.410432426135;10897.237193396386;10996.945015275032;12911.483540658457;14735.410583576751;14739.157605299337;14747.410103595736;14749.188794616399;7349.8162545936775;7705.4220933430215;7777.72777952769;7782.533048017137;8167.550784706779;7751.689932402754;7871.960640196762;7927.841443171104;7977.960110199412;8016.238457346542;4569.086182763461;4782.33047373368;4822.132016237041;4848.684835485682;4899.093667671421;1885.896275704822;1894.507428068712;1931.6329897319745;1933.632609804161;1959.314240015983;929.6560272699145;983.5967253426204;1009.5759780892043;1010.5351538292468;1012.448215722433;19221;20190.899045504677;20436.28473003438;21772;21895.343139705834;965.1169180200038;985.669800616787;987.9456629885425;1009.5507499162802;1013.361582203222;11229.887701123047;11610.361430121424;11637.53449861996;11649.184557080924;11761.235519691192;510854;513259;514959;519648;527178;93464;94381;94552.52723736338;94659;95473.04526954642;1028.1671845804772;1063.4788953412772;1082.837574363836;1088.7441451258949;1088.983665245022;18098.728519072487;18346.541336466697;18865.811341886954;19125.732221755643;19348.903255483634;43336;43450.56549434465;43624.12751744884;43710;44285;58973.70513147407;59177;59464.108038378596;60318.39681603128;61982;8604.397692161489;8750.256228220673;8945.910540894507;8962.596683149144;9143.360885908376;12271;13815.654608634864;14104.365303561159;14142;14564.271786410425;12399.938000309941;12473.812892806796;12531.686707832378;12630.87369126297;12752.298623575793;12049.277043377426;12215.755684886075;12412.56556020535;12494.187877787916;12670.936645316715;12398.380080995734;12584.559540416407;12610.117291789853;12672.239665620093;12681.429335679732;7644.655990480331;8039.758807235792;8070.717524886601;8427.283680887193;8868.201861832466;11386.146039047271;12041.578544750892;12182;12626.873731262936;13165.210087394787 20:30:32 INFO - PROCESS | 21640 | |3;mootools.html;1371.0539727587957;1494.7085318362917;1530.0819508295021;1654.2969238073815;1799.6580649676553;8114.91885081149;8398.496090234583;8426;8432.325413966882;8722.258608018326;8315.085340612528;8552;8658.480491170534;8660.350473714481;8676.566171691422;2030.8984550772477;2276.943076423086;2301.056566807609;2320.5590937721863;2363.633636786301;2339.7777211165;2340.847844890077;2345.1323010486144;2348.53029394121;2352.0826877517784;2321.210788331967;2324.2794733632627;2351.5532048910736;2354.1407386304045;2364.869932153731;1942.8154325339142;2214.8449608527408;2291.209532711229;2296.3225848374686;2301.7698230177016;2312.826538009639;2320.1995311617466;2336.380859072347;2336.556054349668;2342.601757701195;8635.222829945335;8771.342149338825;8777.29781617469;8778.60496277669;8782.824343513093;5133.794648214067;5260.079486089919;5261.289725886994;5261.710605916673;5265.473452654742;3214.4214041472524;3313.950290745641;3325.90022299329;3373.5614370131725;3381.357542067024;1066.3974854207427;1079.9298045627008;1099.0767755085767;1115.1580556679737;1125.3585456289918;12304;12412.56556020544;12423.813642795365;12454.75090498194;12581.748365032649;4617.607503362185;4724.244120940702;4827.468978412372;4845.127876982177;4883.267509873476;10609.416482093558;10629.5216715248;10635.893641063645;10648.094911932572;10681.305715128492;5384.757685904144;5386.703731294738;5387.568994480433;5388.407275199725;5390.757415916293;4263.104748002954;4683.110209060268;4819.759012049383;4824.541668541483;4900.705957642482;3948.802559871995;4011.6991225658194;4042.5957404259925;4079.6940229482907;4095.7952102395357;1205.2467207995003;1273.7834568123442;1300.0379719008056;1309.3911331231022;1324.8807607315196;846.5428668519054;888.9288407468985;1010.434156872154;1012.6101450941293;1029.897010298979;6169.629822210682;6179.69101544921;6268.811935641938;6343.207099112611;6436.066770318278;1001.2090448545713;1002.5588740953957;1012.2003617142523;1018.1803648063232;1024.6721049264313;4230.725002874865;4350.869473915787;4369.80335884886;4413.7351758894565;4419.315006174048;10624.150067994697;10779.67660970172;11007.834882476769;11072.833907491395;11079.50142243601;10840.945795270973;10871.45642717861;10986.285891417032;10989.780204395867;11010.174236932262;8244.587770611446;8374.120717324593;8375.539345335943;8405.117462666454;8424.873626895602;5980.700964951648;6014.669193194416;6108.633481991094;6193.287771906288;6351.491880649629;9875.604975800887;10390.168786497214;10537.262391632512;10626.043656070991;10653.627123050655;10425.53085111187;10672.413017284123;10755.623553175914;10780.892191078303;10809.35143891369;7555.24447555262;7710.306072453506;7735.187805280365;7738.187490313661;7738.303552680286;8030.558319292261;8074.87887681697;8085.110637829716;8098.554579497949;8106.067802202586;7377.3360397564475;7537.849243014999;7551.584662843597;7565.583892885944;7585.127710313384;7485.251474852471;7557.886631700639;7635.198304177981;7713.6143192841255;7780.766577002699;6948.652567371712;6965.930340696528;6987.231404545394;7005.159380874327;7019.6490175492045;5136.280920671034;5191.636585438983;5261.631685781958;5369.382521010134;5374.355077390738;5274.182501712241;5322.33470816148;5328.600354973315;5424.864378390572;5560.5551555876245 20:30:32 INFO - PROCESS | 21640 | |4;prototype.html;326.333166967405;335.3276680256087;346.05181801862904;347.461434776097;347.69750317224003;5393.703346315951;5439.864003399917;5443;5448.645838020526;5473.507384335409;5121.846344609658;5177.498525427631;5340.279062326585;5349.545288650469;5406.864828379293;4147.3778933159965;4190.811413486401;4197.866576024471;4211.1577684463155;4244.660427165819;4208.579142085782;4226.852060177895;4233.343831706091;4240.900754126712;4242;3983.2830090583684;4015.397690346457;4179.331306990882;4185.769782661952;4200.201961627281;4153.819244896454;4155.97922010388;4171.541130475645;4187.204431158086;4190.601892820192;3665.890023299305;3686.3548878946076;3708.42519409492;3710.628937106295;3715.349813782604;5139.794408223666;5168.689878607295;5171.5087066728975;5230.398504172031;5278.498542638443;4747.881302967419;4757.002059135137;4764.6426518011285;4765.380500534943;4767.593559899838;5553.72231388433;5557.138643510262;5559.527440167591;5604.4587738371865;5622.465865742789;3918.666913312372;4055.371417430303;4065;4077.2049450357194;4080.3471444569022;5792.7972520961985;5809.883802323972;5828;5828.825135245949;5837.620554663976;4131.35963925592;4139.710220284551;4152.563980782034;4157.792110394468;4166.104287578185;3911.78485183312;4104.958950410517;4141.659962121392;4172.102997855475;4185.518665353523;4717.410323709536;4718.504557021532;4740.909590794067;4755.738434386073;4759.8814278644495;5586.190002449704;5589;5616.157576363496;5666.053652100884;5674.319081710221;1348.2449828096298;1404.1996062244423;1430.7996880436747;1430.8640679135465;1430.985690143106;902.6479672927563;907.7140700679265;908.0420156734576;916.1754421021134;921.1433366968784;4725.929111063337;4737.810487580458;4773.355596994431;4781.497942716034;4810.5670489656095;5054.570361519312;5061.367329083864;5064.215046667772;5079.4412614612365;5110.390227078458;4393.780310984502;4750.5249475052215;4762.9761851191215;4763.428388593322;4774.045190961821;2696.8921243150053;2699.298182472571;2702.7972202654773;2703.6079768433465;2711.701712811589;5129.615278854101;5156.922646160236;5188.481151884781;5220.634555581149;5224.249876291409;4896.95103048972;5221.425643179247;5226.268322434862;5227.837158519117;5229.52934235913;5130.639905643446;5155.639105262596;5202.661826981234;5235.685858848481;5250.369955605352;4988.575971042357;5056.216286475602;5065;5076.0863044652315;5096.617753668415;4763.54746299101;4947.579455746302;4966.404031516096;5004.824831130893;5031.7735701894235;5122.718250496258;5123.564497017646;5135.589152867837;5163.690178589297;5181.326427564392;3684.2263124744104;3702.685546630907;3721.2929543387754;3811.7331786775767;3867.806609669449;5573.470520300565;5577.693226872561;5597.6641401516035;5605.439456054362;5617.269754931833;5486.972565137149;5488.231647569263;5522.116461366323;5539.224508568723;5552.916706249491;5290.047791397586;5511.511891789275;5521.82495065331;5530.474604912527;5536.667799932017;5422.078246697992;5429.484199001088;5453.400125986059;5462.8907421850545;5468.375179913584;5314.28257185275;5390.649607775482;5439.374471935778;5562;5569.888602227852;5368.57051435892;5402.486763757437;5416.7270691388285;5464.961657285103;5471.343438787212 20:30:32 INFO - PROCESS | 21640 | |5;yui.html;764.6406189091126;786.1509569664761;797.461713343493;822.8683410654293;854.5727136431784;15560.610984725388;16909.915450422763;17067.743983840253;17087.743683844754;17118.657626847456;14705.264736763173;15247.92376038121;15341.539753807376;15379.538613841603;15380.61548461289;784.3646646216569;823.8558252305852;829.5147338806805;836.8953880764905;837.4472847920374;679.5073571660556;796.1004065406083;821.6795449774593;825.6243409248777;826.1903334731966;888.2671795768484;889.4129874282975;889.4218757807445;890.5725251879102;891.3849443883732;882.7704796752827;882.9426087304305;885.4598694796169;886.2156991062891;886.264400547544;513.4147072337538;525.7476411322548;529.8172130614931;614.8893199224137;638.7540796793221;15266.236688165547;15277.694446111016;15311.617209569738;15382.000169988914;15390.692186156326;14589.197594132318;14753.557393278219;14789.186594737284;15049.398024079024;15151.924240378838;12940.48238070476;13161.210327380388;13225.86774132256;13324.133931294531;13735.381907814173;4519.638428925711;4530.365748795171;4602.148602508513;4603.608693261077;4704.976475117603;74768;78300.21699782986;78812.60593697052;79004;79152.20847791563;11032.227744057838;11434.714132146597;11503.482343294572;11721.296722196696;11851.075510305865;22038.449038773837;22051.448713781963;22145.778542214695;22355.217567385065;22404.103835846385;8713.390062695551;8933.776655583662;8942.50816205115;9042.231410330063;9285.675001374919;4674.719516829001;4719.1033703596895;4742.288656701453;4759.143354196278;4906.509349065065;3587.461880717913;3701.555813302421;3704.9259014819554;3726.5341832270965;3731.6268373162466;651.4007113455632;658.3515237491067;660.6564586415037;672.6603065451916;678.09812948778;647.2491909385185;743.2381808646181;759.9620018999028;776.3245976000802;777.7316825695126;9595.28035397348;9685.467299298607;9926.851097233548;10121.240906931862;10132.288485854113;643.4819969924163;655.0469067506766;722.7434260837327;778.1518145221736;792.7542461836849;4413.801378937956;4875.853724388274;5096.745162741922;5126;5199.246109314204;70362;70815.64592177006;95076.39388848876;97783.51108244414;99338.503307483;84894.15105848863;87363.88452808242;102148.48925755324;104239;104379.43430848543;86920;89884.5505772467;90033;91074;95233;9920.801583968425;10262.58949642006;10269.356922771038;10753.946230268799;10997.505112270128;47528.287075694585;52190;53628;53907.46092539181;54175.18737218866;72652;80661.59669201616;81222.59388703019;81244.59377703074;82021;13755.243461609707;13760.862391375958;14026.719465610835;14623.268836557916;14756.409743610564;14580.250369955249;15097.54707358781;15536.61158471002;15681.60795980064;15937.601559961095;12081.456334465145;14552.345144468312;14710.211225585777;15366;15648.608784780472;12473.903190133373;12862.742745145231;13321.200727956353;13394.598162055154;14105.647358816112;14133;14369.784453233;14538.927305363406;14673.26633668291;14693.706125877636;11177.273477223955;11360.261582997078;11478.562577447336;11898.286102833858;12039.578614748792;11682.532698691957;12000.519979201083;12171.81742273849;12364.690882728004;12460.376981150725 20:30:32 INFO - PROCESS | 21640 | __end_tp_report 20:30:32 INFO - PROCESS | 21640 | __start_cc_report 20:30:32 INFO - PROCESS | 21640 | _x_x_mozilla_cycle_collect,998 20:30:32 INFO - PROCESS | 21640 | __end_cc_report 20:30:32 INFO - PROCESS | 21640 | __startTimestamp1467862232700__endTimestamp 20:30:32 INFO - PROCESS | 21640 | 20:30:32 INFO - PROCESS | 21640 | ------- Summary: start ------- 20:30:32 INFO - PROCESS | 21640 | Number of tests: 6 20:30:32 INFO - PROCESS | 21640 | 20:30:32 INFO - PROCESS | 21640 | [#0] dojo.html Cycles:165 Average:5444.47 Median:5607.97 stddev:627.18 (11.2%) stddev-sans-first:602.74 20:30:32 INFO - PROCESS | 21640 | Values: 3150.8 3166.2 3181.3 3199.5 3235.2 5199.3 5303.8 5496.9 5535.5 5590.2 5498.6 5513.9 5523.2 5569.5 5602.7 5007.1 5013.2 5045.6 5054.2 5109.4 4951.4 5018.2 5022.1 5025.2 5027.7 4872.3 4914.3 4938.2 4951.8 5008.3 4881.4 4895.0 4908.9 4962.7 5054.9 4920.2 4942.8 4949.5 4958.8 4988.6 5323.3 5414.4 5440.6 5453.2 5467.2 5868.9 5914.6 5922.8 5925.0 5938.9 5992.9 6002.8 6002.9 6004.5 6007.5 5347.2 5495.8 5565.1 5568.0 5573.8 6082.2 6087.5 6093.4 6095.5 6097.5 5887.8 5897.4 5901.6 5905.6 5905.9 5684.7 5836.5 5903.4 5923.0 5931.9 5851.3 5858.6 5863.1 5866.6 5907.8 5805.2 5816.9 5864.5 5867.6 5871.1 4373.6 4400.5 4420.0 4422.8 4456.8 3941.4 3945.9 3954.2 3975.1 4001.7 5514.6 5532.9 5558.7 5564.9 5604.2 5733.7 5778.7 5801.5 5807.2 5943.0 5546.4 5553.3 5554.2 5592.4 5597.4 5049.1 5049.7 5055.5 5061.5 5100.0 5924.9 5965.5 6023.7 6045.8 6054.0 5856.4 5859.2 5859.7 5870.6 5930.2 5960.7 6010.3 6018.1 6019.3 6022.4 5687.9 5714.9 5746.9 5766.4 5767.5 5897.4 5907.5 5923.5 5930.2 5933.5 5769.7 5771.6 5777.2 5784.4 5793.1 5591.2 5611.0 5636.3 5652.7 5684.7 5585.7 5590.2 5612.2 5621.0 5621.2 5569.3 5700.3 5714.2 5764.9 5772.5 5524.4 5565.7 5583.3 5608.0 5621.3 20:30:32 INFO - PROCESS | 21640 | 20:30:32 INFO - PROCESS | 21640 | [#1] ext.html Cycles:180 Average:59866.50 Median:42594.89 stddev:114124.55 (267.9%) stddev-sans-first:114357.92 20:30:32 INFO - PROCESS | 21640 | Values: 591.7 608.9 617.0 629.4 637.7 44410.6 45319.3 45531.3 45543.0 48548.5 46104.8 46174.1 46216.8 46397.8 46426.0 9064.6 9192.0 9197.4 9203.3 9213.0 9021.3 9097.7 9116.2 9122.0 9124.5 9172.4 9218.2 9218.7 9222.2 9226.4 9101.3 9135.6 9139.1 9142.0 9147.0 8989.0 9027.1 9056.3 9058.9 9059.7 42382.0 42466.2 42554.8 42635.0 42806.0 3610.2 3830.7 3903.1 4146.3 4479.9 32687.0 33389.7 33765.8 33775.0 33805.5 4417.6 4589.3 4618.5 4683.2 4692.7 370697.0 371044.1 371630.0 371730.0 372417.0 57906.4 58044.7 58361.0 58365.1 58397.0 61418.0 61459.0 61496.0 61499.7 61553.0 15757.7 15916.2 15926.3 15948.7 15973.0 12036.3 12039.5 12044.2 12046.9 12048.6 14819.0 16246.2 16474.0 16502.5 16577.3 5110.9 6083.0 6090.8 6120.5 6287.6 1014.1 1014.6 1017.5 1040.2 1073.8 32490.5 32796.2 33014.3 33147.7 33159.5 1041.8 1094.4 1152.7 1168.6 1199.3 16795.6 17178.5 17284.7 17375.5 17504.0 512156.0 514623.0 515790.0 516741.0 518522.0 59378.0 59469.0 59580.1 59597.4 59621.0 1229.0 1245.8 1275.6 1347.1 1387.9 30109.0 34268.8 34377.5 34597.5 35035.0 50071.5 50198.5 50442.2 50609.7 50843.2 392735.0 394100.0 394667.0 395116.0 395760.0 35145.6 41272.6 41331.4 42684.8 42721.8 48959.0 49366.5 49598.3 50388.5 51348.7 41864.0 42281.4 43009.6 43283.0 43732.8 41665.4 41826.6 42214.4 42398.0 42907.0 41259.4 41754.2 41809.8 42073.6 42264.6 35590.0 37494.0 37855.6 38136.6 38302.6 28290.3 28645.4 28858.7 28920.6 28929.7 20:30:32 INFO - PROCESS | 21640 | 20:30:32 INFO - PROCESS | 21640 | [#2] jquery.html Cycles:180 Average:29634.32 Median:2239.82 stddev:85068.01 (3798.0%) stddev-sans-first:85278.32 20:30:32 INFO - PROCESS | 21640 | Values: 396.3 397.3 400.3 406.3 415.2 18651.5 19233.6 20030.8 20171.9 20199.6 18978.1 18999.6 19711.0 20242.4 20301.9 5767.3 5815.0 5857.3 5915.7 5920.7 5848.4 5855.3 5866.4 5868.3 5869.1 6138.3 6406.9 6409.4 6473.4 6503.8 5773.1 5806.2 5829.0 5988.6 6348.4 5731.1 5781.5 5793.4 5817.7 5834.2 13652.5 13738.6 14174.9 14178.9 14243.0 2204.8 2274.9 2482.8 2495.4 3121.1 10004.3 10047.6 10181.4 10352.3 10718.0 1875.2 1883.1 1884.4 1884.5 1939.6 55078.0 70404.0 71497.6 76777.2 81441.0 10399.2 10605.6 10719.4 10897.2 10996.9 12911.5 14735.4 14739.2 14747.4 14749.2 7349.8 7705.4 7777.7 7782.5 8167.6 7751.7 7872.0 7927.8 7978.0 8016.2 4569.1 4782.3 4822.1 4848.7 4899.1 1885.9 1894.5 1931.6 1933.6 1959.3 929.7 983.6 1009.6 1010.5 1012.4 19221.0 20190.9 20436.3 21772.0 21895.3 965.1 985.7 987.9 1009.6 1013.4 11229.9 11610.4 11637.5 11649.2 11761.2 510854.0 513259.0 514959.0 519648.0 527178.0 93464.0 94381.0 94552.5 94659.0 95473.0 1028.2 1063.5 1082.8 1088.7 1089.0 18098.7 18346.5 18865.8 19125.7 19348.9 43336.0 43450.6 43624.1 43710.0 44285.0 58973.7 59177.0 59464.1 60318.4 61982.0 8604.4 8750.3 8945.9 8962.6 9143.4 12271.0 13815.7 14104.4 14142.0 14564.3 12399.9 12473.8 12531.7 12630.9 12752.3 12049.3 12215.8 12412.6 12494.2 12670.9 12398.4 12584.6 12610.1 12672.2 12681.4 7644.7 8039.8 8070.7 8427.3 8868.2 11386.1 12041.6 12182.0 12626.9 13165.2 20:30:32 INFO - PROCESS | 21640 | 20:30:32 INFO - PROCESS | 21640 | [#3] mootools.html Cycles:180 Average:5842.69 Median:4391.77 stddev:3321.51 (75.6%) stddev-sans-first:3313.83 20:30:32 INFO - PROCESS | 21640 | Values: 1371.1 1494.7 1530.1 1654.3 1799.7 8114.9 8398.5 8426.0 8432.3 8722.3 8315.1 8552.0 8658.5 8660.4 8676.6 2030.9 2276.9 2301.1 2320.6 2363.6 2339.8 2340.8 2345.1 2348.5 2352.1 2321.2 2324.3 2351.6 2354.1 2364.9 1942.8 2214.8 2291.2 2296.3 2301.8 2312.8 2320.2 2336.4 2336.6 2342.6 8635.2 8771.3 8777.3 8778.6 8782.8 5133.8 5260.1 5261.3 5261.7 5265.5 3214.4 3314.0 3325.9 3373.6 3381.4 1066.4 1079.9 1099.1 1115.2 1125.4 12304.0 12412.6 12423.8 12454.8 12581.7 4617.6 4724.2 4827.5 4845.1 4883.3 10609.4 10629.5 10635.9 10648.1 10681.3 5384.8 5386.7 5387.6 5388.4 5390.8 4263.1 4683.1 4819.8 4824.5 4900.7 3948.8 4011.7 4042.6 4079.7 4095.8 1205.2 1273.8 1300.0 1309.4 1324.9 846.5 888.9 1010.4 1012.6 1029.9 6169.6 6179.7 6268.8 6343.2 6436.1 1001.2 1002.6 1012.2 1018.2 1024.7 4230.7 4350.9 4369.8 4413.7 4419.3 10624.2 10779.7 11007.8 11072.8 11079.5 10840.9 10871.5 10986.3 10989.8 11010.2 8244.6 8374.1 8375.5 8405.1 8424.9 5980.7 6014.7 6108.6 6193.3 6351.5 9875.6 10390.2 10537.3 10626.0 10653.6 10425.5 10672.4 10755.6 10780.9 10809.4 7555.2 7710.3 7735.2 7738.2 7738.3 8030.6 8074.9 8085.1 8098.6 8106.1 7377.3 7537.8 7551.6 7565.6 7585.1 7485.3 7557.9 7635.2 7713.6 7780.8 6948.7 6965.9 6987.2 7005.2 7019.6 5136.3 5191.6 5261.6 5369.4 5374.4 5274.2 5322.3 5328.6 5424.9 5560.6 20:30:32 INFO - PROCESS | 21640 | 20:30:32 INFO - PROCESS | 21640 | [#4] prototype.html Cycles:180 Average:4510.98 Median:5064.61 stddev:1295.37 (25.6%) stddev-sans-first:1260.35 20:30:32 INFO - PROCESS | 21640 | Values: 326.3 335.3 346.1 347.5 347.7 5393.7 5439.9 5443.0 5448.6 5473.5 5121.8 5177.5 5340.3 5349.5 5406.9 4147.4 4190.8 4197.9 4211.2 4244.7 4208.6 4226.9 4233.3 4240.9 4242.0 3983.3 4015.4 4179.3 4185.8 4200.2 4153.8 4156.0 4171.5 4187.2 4190.6 3665.9 3686.4 3708.4 3710.6 3715.3 5139.8 5168.7 5171.5 5230.4 5278.5 4747.9 4757.0 4764.6 4765.4 4767.6 5553.7 5557.1 5559.5 5604.5 5622.5 3918.7 4055.4 4065.0 4077.2 4080.3 5792.8 5809.9 5828.0 5828.8 5837.6 4131.4 4139.7 4152.6 4157.8 4166.1 3911.8 4105.0 4141.7 4172.1 4185.5 4717.4 4718.5 4740.9 4755.7 4759.9 5586.2 5589.0 5616.2 5666.1 5674.3 1348.2 1404.2 1430.8 1430.9 1431.0 902.6 907.7 908.0 916.2 921.1 4725.9 4737.8 4773.4 4781.5 4810.6 5054.6 5061.4 5064.2 5079.4 5110.4 4393.8 4750.5 4763.0 4763.4 4774.0 2696.9 2699.3 2702.8 2703.6 2711.7 5129.6 5156.9 5188.5 5220.6 5224.2 4897.0 5221.4 5226.3 5227.8 5229.5 5130.6 5155.6 5202.7 5235.7 5250.4 4988.6 5056.2 5065.0 5076.1 5096.6 4763.5 4947.6 4966.4 5004.8 5031.8 5122.7 5123.6 5135.6 5163.7 5181.3 3684.2 3702.7 3721.3 3811.7 3867.8 5573.5 5577.7 5597.7 5605.4 5617.3 5487.0 5488.2 5522.1 5539.2 5552.9 5290.0 5511.5 5521.8 5530.5 5536.7 5422.1 5429.5 5453.4 5462.9 5468.4 5314.3 5390.6 5439.4 5562.0 5569.9 5368.6 5402.5 5416.7 5465.0 5471.3 20:30:32 INFO - PROCESS | 21640 | 20:30:32 INFO - PROCESS | 21640 | [#5] yui.html Cycles:180 Average:20626.24 Median:4712.04 stddev:28279.00 (600.1%) stddev-sans-first:28319.00 20:30:32 INFO - PROCESS | 21640 | Values: 764.6 786.2 797.5 822.9 854.6 15560.6 16909.9 17067.7 17087.7 17118.7 14705.3 15247.9 15341.5 15379.5 15380.6 784.4 823.9 829.5 836.9 837.4 679.5 796.1 821.7 825.6 826.2 888.3 889.4 889.4 890.6 891.4 882.8 882.9 885.5 886.2 886.3 513.4 525.7 529.8 614.9 638.8 15266.2 15277.7 15311.6 15382.0 15390.7 14589.2 14753.6 14789.2 15049.4 15151.9 12940.5 13161.2 13225.9 13324.1 13735.4 4519.6 4530.4 4602.1 4603.6 4705.0 74768.0 78300.2 78812.6 79004.0 79152.2 11032.2 11434.7 11503.5 11721.3 11851.1 22038.4 22051.4 22145.8 22355.2 22404.1 8713.4 8933.8 8942.5 9042.2 9285.7 4674.7 4719.1 4742.3 4759.1 4906.5 3587.5 3701.6 3704.9 3726.5 3731.6 651.4 658.4 660.7 672.7 678.1 647.2 743.2 760.0 776.3 777.7 9595.3 9685.5 9926.9 10121.2 10132.3 643.5 655.0 722.7 778.2 792.8 4413.8 4875.9 5096.7 5126.0 5199.2 70362.0 70815.6 95076.4 97783.5 99338.5 84894.2 87363.9 102148.5 104239.0 104379.4 86920.0 89884.6 90033.0 91074.0 95233.0 9920.8 10262.6 10269.4 10753.9 10997.5 47528.3 52190.0 53628.0 53907.5 54175.2 72652.0 80661.6 81222.6 81244.6 82021.0 13755.2 13760.9 14026.7 14623.3 14756.4 14580.3 15097.5 15536.6 15681.6 15937.6 12081.5 14552.3 14710.2 15366.0 15648.6 12473.9 12862.7 13321.2 13394.6 14105.6 14133.0 14369.8 14538.9 14673.3 14693.7 11177.3 11360.3 11478.6 11898.3 12039.6 11682.5 12000.5 12171.8 12364.7 12460.4 20:30:32 INFO - PROCESS | 21640 | -------- Summary: end -------- 20:30:32 INFO - PROCESS | 21640 | 20:30:33 INFO - TEST-INFO | 21640: exit 0 20:30:33 INFO - TEST-OK | dromaeo_css | took 1114111ms 20:30:33 INFO - TEST-START | kraken 20:30:33 INFO - operating with platform_type : linux_ 20:30:33 INFO - Initialising browser for kraken test... 20:30:33 INFO - TEST-INFO | started process 21838 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkdlJ90/profile http://localhost:52041/getInfo.html) 20:30:37 INFO - PROCESS | 21838 | __metrics Screen width/height:1600/1200 20:30:37 INFO - PROCESS | 21838 | colorDepth:24 20:30:37 INFO - PROCESS | 21838 | Browser inner width/height: 1024/697 20:30:37 INFO - PROCESS | 21838 | __metrics 20:30:38 INFO - PROCESS | 21838 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:30:39 INFO - TEST-INFO | 21838: exit 0 20:30:39 INFO - Browser initialized. 20:30:39 INFO - Running cycle 1/1 for kraken test... 20:30:39 INFO - TEST-INFO | started process 21925 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkdlJ90/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:30:51 INFO - PROCESS | 21925 | RSS: Main: 156753920 20:30:51 INFO - PROCESS | 21925 | 20:30:53 INFO - PROCESS | 21925 | Cycle 1(1): loaded http://localhost:52041/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52041/tests/kraken/driver.html?testName=audio-beat-detection) 20:30:54 INFO - PROCESS | 21925 | RSS: Main: 215601152 20:30:54 INFO - PROCESS | 21925 | 20:30:57 INFO - PROCESS | 21925 | Cycle 1(1): loaded http://localhost:52041/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52041/tests/kraken/driver.html?testName=audio-dft) 20:30:57 INFO - PROCESS | 21925 | RSS: Main: 203649024 20:30:57 INFO - PROCESS | 21925 | 20:31:00 INFO - PROCESS | 21925 | Cycle 1(1): loaded http://localhost:52041/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52041/tests/kraken/driver.html?testName=audio-fft) 20:31:01 INFO - PROCESS | 21925 | RSS: Main: 269467648 20:31:01 INFO - PROCESS | 21925 | 20:31:03 INFO - PROCESS | 21925 | Cycle 1(1): loaded http://localhost:52041/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52041/tests/kraken/driver.html?testName=audio-oscillator) 20:31:04 INFO - PROCESS | 21925 | RSS: Main: 180047872 20:31:04 INFO - PROCESS | 21925 | 20:31:06 INFO - PROCESS | 21925 | Cycle 1(1): loaded http://localhost:52041/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52041/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:31:06 INFO - PROCESS | 21925 | RSS: Main: 183832576 20:31:06 INFO - PROCESS | 21925 | 20:31:09 INFO - PROCESS | 21925 | Cycle 1(1): loaded http://localhost:52041/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52041/tests/kraken/driver.html?testName=imaging-darkroom) 20:31:10 INFO - PROCESS | 21925 | RSS: Main: 218570752 20:31:10 INFO - PROCESS | 21925 | 20:31:13 INFO - PROCESS | 21925 | Cycle 1(1): loaded http://localhost:52041/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52041/tests/kraken/driver.html?testName=imaging-desaturate) 20:31:14 INFO - PROCESS | 21925 | RSS: Main: 220721152 20:31:14 INFO - PROCESS | 21925 | 20:31:17 INFO - PROCESS | 21925 | Cycle 1(1): loaded http://localhost:52041/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52041/tests/kraken/driver.html?testName=json-parse-financial) 20:31:17 INFO - PROCESS | 21925 | RSS: Main: 220753920 20:31:17 INFO - PROCESS | 21925 | 20:31:19 INFO - PROCESS | 21925 | Cycle 1(1): loaded http://localhost:52041/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52041/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:31:19 INFO - PROCESS | 21925 | RSS: Main: 207761408 20:31:19 INFO - PROCESS | 21925 | 20:31:21 INFO - PROCESS | 21925 | Cycle 1(1): loaded http://localhost:52041/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52041/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:31:22 INFO - PROCESS | 21925 | RSS: Main: 211918848 20:31:22 INFO - PROCESS | 21925 | 20:31:24 INFO - PROCESS | 21925 | Cycle 1(1): loaded http://localhost:52041/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52041/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:31:24 INFO - PROCESS | 21925 | RSS: Main: 210214912 20:31:24 INFO - PROCESS | 21925 | 20:31:27 INFO - PROCESS | 21925 | Cycle 1(1): loaded http://localhost:52041/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52041/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:31:28 INFO - PROCESS | 21925 | RSS: Main: 229908480 20:31:28 INFO - PROCESS | 21925 | 20:31:30 INFO - PROCESS | 21925 | Cycle 1(1): loaded http://localhost:52041/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52041/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:31:31 INFO - PROCESS | 21925 | RSS: Main: 225665024 20:31:31 INFO - PROCESS | 21925 | 20:31:32 INFO - PROCESS | 21925 | Cycle 1(1): loaded http://localhost:52041/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52041/tests/kraken/driver.html?testName=ai-astar) 20:31:33 INFO - PROCESS | 21925 | RSS: Main: 268562432 20:31:33 INFO - PROCESS | 21925 | 20:31:33 INFO - PROCESS | 21925 | __start_tp_report 20:31:33 INFO - PROCESS | 21925 | _x_x_mozilla_page_load 20:31:33 INFO - PROCESS | 21925 | _x_x_mozilla_page_load_details 20:31:33 INFO - PROCESS | 21925 | |i|pagename|runs| 20:31:33 INFO - PROCESS | 21925 | |0;ai-astar;102;112;110;111;110;111;109;109;110;109 20:31:33 INFO - PROCESS | 21925 | |1;audio-beat-detection;144;116;117;189;120;124;140;117;149;117 20:31:33 INFO - PROCESS | 21925 | |2;audio-dft;161;161;160;160;160;160;161;161;161;160 20:31:33 INFO - PROCESS | 21925 | |3;audio-fft;74;76;75;137;76;75;74;75;102;75 20:31:33 INFO - PROCESS | 21925 | |4;audio-oscillator;82;84;114;84;84;84;119;83;83;131 20:31:33 INFO - PROCESS | 21925 | |5;imaging-gaussian-blur;116;116;116;116;117;117;116;117;117;118 20:31:33 INFO - PROCESS | 21925 | |6;imaging-darkroom;146;146;146;145;145;146;145;146;146;146 20:31:33 INFO - PROCESS | 21925 | |7;imaging-desaturate;94;95;95;95;95;95;95;95;94;95 20:31:33 INFO - PROCESS | 21925 | |8;json-parse-financial;51;52;51;52;51;52;54;53;51;52 20:31:33 INFO - PROCESS | 21925 | |9;json-stringify-tinderbox;62;62;62;62;62;61;62;62;62;62 20:31:33 INFO - PROCESS | 21925 | |10;stanford-crypto-aes;80;75;74;74;77;75;75;81;76;79 20:31:33 INFO - PROCESS | 21925 | |11;stanford-crypto-ccm;132;128;118;126;117;129;121;119;161;133 20:31:33 INFO - PROCESS | 21925 | |12;stanford-crypto-pbkdf2;154;158;155;155;153;153;173;155;157;153 20:31:33 INFO - PROCESS | 21925 | |13;stanford-crypto-sha256-iterative;62;62;63;62;63;63;61;61;60;62 20:31:33 INFO - PROCESS | 21925 | __end_tp_report 20:31:33 INFO - PROCESS | 21925 | __start_cc_report 20:31:33 INFO - PROCESS | 21925 | _x_x_mozilla_cycle_collect,1668 20:31:33 INFO - PROCESS | 21925 | __end_cc_report 20:31:33 INFO - PROCESS | 21925 | __startTimestamp1467862293228__endTimestamp 20:31:33 INFO - PROCESS | 21925 | 20:31:33 INFO - PROCESS | 21925 | ------- Summary: start ------- 20:31:33 INFO - PROCESS | 21925 | Number of tests: 14 20:31:33 INFO - PROCESS | 21925 | 20:31:33 INFO - PROCESS | 21925 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.00 stddev:2.75 (2.5%) stddev-sans-first:1.05 20:31:33 INFO - PROCESS | 21925 | Values: 102.0 112.0 110.0 111.0 110.0 111.0 109.0 109.0 110.0 109.0 20:31:33 INFO - PROCESS | 21925 | 20:31:33 INFO - PROCESS | 21925 | [#1] audio-beat-detection Cycles:10 Average:133.30 Median:132.00 stddev:23.26 (17.6%) stddev-sans-first:24.34 20:31:33 INFO - PROCESS | 21925 | Values: 144.0 116.0 117.0 189.0 120.0 124.0 140.0 117.0 149.0 117.0 20:31:33 INFO - PROCESS | 21925 | 20:31:33 INFO - PROCESS | 21925 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.53 (0.3%) stddev-sans-first:0.53 20:31:33 INFO - PROCESS | 21925 | Values: 161.0 161.0 160.0 160.0 160.0 160.0 161.0 161.0 161.0 160.0 20:31:33 INFO - PROCESS | 21925 | 20:31:33 INFO - PROCESS | 21925 | [#3] audio-fft Cycles:10 Average:83.90 Median:75.00 stddev:20.51 (27.3%) stddev-sans-first:21.44 20:31:33 INFO - PROCESS | 21925 | Values: 74.0 76.0 75.0 137.0 76.0 75.0 74.0 75.0 102.0 75.0 20:31:33 INFO - PROCESS | 21925 | 20:31:33 INFO - PROCESS | 21925 | [#4] audio-oscillator Cycles:10 Average:94.80 Median:83.50 stddev:18.78 (22.5%) stddev-sans-first:19.34 20:31:33 INFO - PROCESS | 21925 | Values: 82.0 84.0 114.0 84.0 84.0 84.0 119.0 83.0 83.0 131.0 20:31:33 INFO - PROCESS | 21925 | 20:31:33 INFO - PROCESS | 21925 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 20:31:33 INFO - PROCESS | 21925 | Values: 116.0 116.0 116.0 116.0 117.0 117.0 116.0 117.0 117.0 118.0 20:31:33 INFO - PROCESS | 21925 | 20:31:33 INFO - PROCESS | 21925 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 20:31:33 INFO - PROCESS | 21925 | Values: 146.0 146.0 146.0 145.0 145.0 146.0 145.0 146.0 146.0 146.0 20:31:33 INFO - PROCESS | 21925 | 20:31:33 INFO - PROCESS | 21925 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 20:31:33 INFO - PROCESS | 21925 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 20:31:33 INFO - PROCESS | 21925 | 20:31:33 INFO - PROCESS | 21925 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.00 stddev:0.99 (1.9%) stddev-sans-first:1.00 20:31:33 INFO - PROCESS | 21925 | Values: 51.0 52.0 51.0 52.0 51.0 52.0 54.0 53.0 51.0 52.0 20:31:33 INFO - PROCESS | 21925 | 20:31:33 INFO - PROCESS | 21925 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 20:31:33 INFO - PROCESS | 21925 | Values: 62.0 62.0 62.0 62.0 62.0 61.0 62.0 62.0 62.0 62.0 20:31:33 INFO - PROCESS | 21925 | 20:31:33 INFO - PROCESS | 21925 | [#10] stanford-crypto-aes Cycles:10 Average:76.60 Median:76.50 stddev:2.55 (3.3%) stddev-sans-first:2.39 20:31:33 INFO - PROCESS | 21925 | Values: 80.0 75.0 74.0 74.0 77.0 75.0 75.0 81.0 76.0 79.0 20:31:33 INFO - PROCESS | 21925 | 20:31:33 INFO - PROCESS | 21925 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:128.50 stddev:12.84 (10.0%) stddev-sans-first:13.56 20:31:33 INFO - PROCESS | 21925 | Values: 132.0 128.0 118.0 126.0 117.0 129.0 121.0 119.0 161.0 133.0 20:31:33 INFO - PROCESS | 21925 | 20:31:33 INFO - PROCESS | 21925 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.60 Median:155.00 stddev:6.00 (3.9%) stddev-sans-first:6.29 20:31:33 INFO - PROCESS | 21925 | Values: 154.0 158.0 155.0 155.0 153.0 153.0 173.0 155.0 157.0 153.0 20:31:33 INFO - PROCESS | 21925 | 20:31:33 INFO - PROCESS | 21925 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:62.00 stddev:0.99 (1.6%) stddev-sans-first:1.05 20:31:33 INFO - PROCESS | 21925 | Values: 62.0 62.0 63.0 62.0 63.0 63.0 61.0 61.0 60.0 62.0 20:31:33 INFO - PROCESS | 21925 | -------- Summary: end -------- 20:31:33 INFO - PROCESS | 21925 | 20:31:34 INFO - TEST-INFO | 21925: exit 0 20:31:34 INFO - TEST-OK | kraken | took 60869ms 20:31:34 INFO - SUITE-END | took 1174s 20:31:34 INFO - Completed test suite (00:19:35) 20:31:34 INFO - javascript benchmark 20:31:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3150.7951983121097, 3166.192620881675, 3181.347823696142, 3199.456092464281, 3235.223546348877, 5199.324087868572, 5303.787848486056, 5496.917546236809, 5535.474129957653, 5590.217369568264, 5498.642588231762, 5513.917291240635, 5523.226748255248, 5569.498745112939, 5602.691851948141, 5007.12375334315, 5013.197888337867, 5045.621578381618, 5054.241863720435, 5109.41241757199, 4951.356323677916, 5018.222175562793, 5022.070916880389, 5025.221090730943, 5027.723475208862, 4872.269159626049, 4914.262860570907, 4938.209886418192, 4951.8019279228965, 5008.273800298936, 4881.365422495053, 4895.0, 4908.901821963541, 4962.702237865739, 5054.9241761373605, 4920.237363208708, 4942.827001054981, 4949.529794669501, 4958.752062396866, 4988.55103040728, 5323.30796996388, 5414.35027796663, 5440.646357986758, 5453.182022696587, 5467.17992301158, 5868.911966320508, 5914.615549989237, 5922.822315330547, 5925.022371308772, 5938.940610593882, 5992.910106348409, 6002.849928751816, 6002.909956350658, 6004.459598636144, 6007.549433792483, 5347.171188465794, 5495.835124946298, 5565.1374037024325, 5567.972160139255, 5573.804916827891, 6082.1789058477425, 6087.4521293083835, 6093.360197179321, 6095.4818840398175, 6097.512199024068, 5887.76448942046, 5897.410258974069, 5901.557383196277, 5905.645661260338, 5905.911411328833, 5684.6589204647025, 5836.533077353802, 5903.3801450847905, 5923.0, 5931.940680593225, 5851.32709738377, 5858.5898987070495, 5863.120531920246, 5866.5893387462465, 5907.822765317047, 5805.245318108703, 5816.883662326814, 5864.47219750216, 5867.589268751231, 5871.060630299217, 4373.562643735601, 4400.515943246241, 4420.049689316812, 4422.756748378806, 4456.75487848165, 3941.4481972523868, 3945.92108157841, 3954.189391174802, 3975.125472396126, 4001.679865610744, 5514.558835293167, 5532.889342213133, 5558.722063896789, 5564.888702225933, 5604.159376093537, 5733.741981610754, 5778.711064446761, 5801.53587712982, 5807.157962095473, 5942.970285148546, 5546.362168350611, 5553.333599968029, 5554.1946417769195, 5592.356878958891, 5597.440255974451, 5049.141645920203, 5049.722265275445, 5055.469175736568, 5061.468545802712, 5100.0, 5924.911126333109, 5965.463108320272, 6023.668698221464, 6045.758169673251, 6053.969730151321, 5856.355800861987, 5859.2090067842, 5859.707014649165, 5870.618409803349, 5930.169776231245, 5960.731767070405, 6010.338862725184, 6018.127371531016, 6019.337872833898, 6022.427869352405, 5687.8862422752145, 5714.9142762857755, 5746.885062298814, 5766.394528574607, 5767.452092051249, 5897.439743224387, 5907.4683278505145, 5923.466887980103, 5930.199423077829, 5933.465988061095, 5769.711514424178, 5771.624844385102, 5777.191193233035, 5784.42155784435, 5793.131030345482, 5591.189277554813, 5611.046122159324, 5636.267285253055, 5652.7173641318595, 5684.7157642118555, 5585.664860108406, 5590.245316882331, 5612.242347283064, 5621.0, 5621.184928185472, 5569.303837020372, 5700.287464066992, 5714.228579141929, 5764.884702306014, 5772.538196944319, 5524.364698059774, 5565.749541270571, 5583.302087239095, 5607.971960140173, 5621.297337832771], "value": 5401.63714781629, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.6716222496513, 608.9056196289575, 616.987660246795, 629.4492319220681, 637.6970938804071, 44410.555894441044, 45319.32021019687, 45531.31703024457, 45543.0, 48548.51451485484, 46104.76947615266, 46174.076518469614, 46216.76891615537, 46397.7680111599, 46426.0, 9064.592093355799, 9192.034836342187, 9197.356185067049, 9203.309751768611, 9212.953935230315, 9021.278297736199, 9097.681581144661, 9116.179543841054, 9122.0, 9124.452532848018, 9172.403793753418, 9218.17036466718, 9218.723438296862, 9222.21611163052, 9226.354155209137, 9101.317401194938, 9135.588898499584, 9139.131782480654, 9141.954290228572, 9147.039560846115, 8989.0, 9027.097290270985, 9056.320775941831, 9058.864117038249, 9059.728208153765, 42382.0, 42466.150676986595, 42554.78722606398, 42635.0, 42806.0, 3610.2418492116426, 3830.693544516432, 3903.082775547744, 4146.3365861462025, 4479.865604031885, 32687.0, 33389.666103338895, 33765.831170844234, 33775.0, 33805.49291760626, 4417.580329868657, 4589.2886602576655, 4618.49196588375, 4683.2038553446, 4692.718436893763, 370697.0, 371044.1447792771, 371630.0, 371730.0, 372417.0, 57906.420935790105, 58044.709776451695, 58361.0, 58365.12452313219, 58397.0, 61418.0, 61459.0, 61496.0, 61499.6925015372, 61553.0, 15757.68484630301, 15916.204189790697, 15926.28331725075, 15948.681026379407, 15973.041617502988, 12036.338001409831, 12039.518419263306, 12044.15690901646, 12046.939765301293, 12048.638540843613, 14819.0, 16246.187690615421, 16474.0, 16502.504924852274, 16577.336906523844, 5110.897782044338, 6083.0, 6090.756369745249, 6120.540959428061, 6287.591306565058, 1014.0923873133504, 1014.6448742939912, 1017.4963393120453, 1040.2250323508883, 1073.7961970544886, 32490.512642310383, 32796.18009549733, 33014.3397132056, 33147.66852331494, 33159.502607460905, 1041.770810421721, 1094.4090191296611, 1152.6657269391783, 1168.5793114478781, 1199.2804317409484, 16795.563549160623, 17178.484645460656, 17284.654306914043, 17375.47873563795, 17504.03727794958, 512156.0, 514623.0, 515790.0, 516741.0, 518522.0, 59378.0, 59469.0, 59580.10629840556, 59597.40402596005, 59621.0, 1228.956986505468, 1245.7757603631253, 1275.579058910576, 1347.1041757231528, 1387.9097858639157, 30108.9564174332, 34268.82865585656, 34377.48433773445, 34597.48103778395, 35035.0, 50071.49928500814, 50198.49801501938, 50442.24336635027, 50609.746951265006, 50843.2373514405, 392735.0, 394100.0, 394667.0, 395116.0, 395760.0, 35145.64854351424, 41272.58727412808, 41331.380029300184, 42684.78657606692, 42721.78639106784, 48959.0, 49366.50633493619, 49598.25602616036, 50388.49611503838, 51348.74325628497, 41864.0, 42281.365779512715, 43009.56990430056, 43283.0, 43732.78133609312, 41665.37501937413, 41826.581734183485, 42214.366784497644, 42398.0, 42907.0, 41259.38110928278, 41754.16491670089, 41809.79095104505, 42073.579264206965, 42264.577354227295, 35590.0, 37494.0, 37855.62144378521, 38136.61863381442, 38302.61697382991, 28290.292742680773, 28645.427091457637, 28858.7114128856, 28920.566191507565, 28929.710702892702], "value": 20458.776527568836, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.29657358189195, 397.2967846910968, 400.2774991140991, 406.25046788674894, 415.21109891206703, 18651.533711657197, 19233.61532769344, 20030.799692003075, 20171.899140504276, 20199.596008079847, 18978.145983430742, 18999.620007599875, 19711.0, 20242.39272821814, 20301.898490507527, 5767.33675627304, 5815.040518314484, 5857.26784151981, 5915.73379197935, 5920.733566989475, 5848.444397782204, 5855.326637436707, 5866.44268794466, 5868.325142608591, 5869.148973398855, 6138.324784273726, 6406.93593064068, 6409.391107844771, 6473.352664733513, 6503.772367967122, 5773.076307790754, 5806.245188125537, 5828.970855145697, 5988.550858685572, 6348.365163483661, 5731.083026715747, 5781.4507621775865, 5793.391693872125, 5817.680027598481, 5834.183214349994, 13652.453901843914, 13738.587842364745, 14174.929125354307, 14178.929105354511, 14243.0, 2204.7795220477983, 2274.863508189514, 2482.8262021658493, 2495.4011037350906, 3121.094882484077, 10004.299699021072, 10047.598096076148, 10181.440020798853, 10352.275340726152, 10718.0, 1875.184294831739, 1883.0961138653386, 1884.4252502986583, 1884.5382881194057, 1939.5539026024094, 55078.0, 70404.0, 71497.64251178764, 76777.23222767757, 81441.0, 10399.168066554657, 10605.575776968835, 10719.410432426135, 10897.237193396386, 10996.945015275032, 12911.483540658457, 14735.410583576751, 14739.157605299337, 14747.410103595736, 14749.188794616399, 7349.8162545936775, 7705.4220933430215, 7777.72777952769, 7782.533048017137, 8167.550784706779, 7751.689932402754, 7871.960640196762, 7927.841443171104, 7977.960110199412, 8016.238457346542, 4569.086182763461, 4782.33047373368, 4822.132016237041, 4848.684835485682, 4899.093667671421, 1885.896275704822, 1894.507428068712, 1931.6329897319745, 1933.632609804161, 1959.314240015983, 929.6560272699145, 983.5967253426204, 1009.5759780892043, 1010.5351538292468, 1012.448215722433, 19221.0, 20190.899045504677, 20436.28473003438, 21772.0, 21895.343139705834, 965.1169180200038, 985.669800616787, 987.9456629885425, 1009.5507499162802, 1013.361582203222, 11229.887701123047, 11610.361430121424, 11637.53449861996, 11649.184557080924, 11761.235519691192, 510854.0, 513259.0, 514959.0, 519648.0, 527178.0, 93464.0, 94381.0, 94552.52723736338, 94659.0, 95473.04526954642, 1028.1671845804772, 1063.4788953412772, 1082.837574363836, 1088.7441451258949, 1088.983665245022, 18098.728519072487, 18346.541336466697, 18865.811341886954, 19125.732221755643, 19348.903255483634, 43336.0, 43450.56549434465, 43624.12751744884, 43710.0, 44285.0, 58973.70513147407, 59177.0, 59464.108038378596, 60318.39681603128, 61982.0, 8604.397692161489, 8750.256228220673, 8945.910540894507, 8962.596683149144, 9143.360885908376, 12271.0, 13815.654608634864, 14104.365303561159, 14142.0, 14564.271786410425, 12399.938000309941, 12473.812892806796, 12531.686707832378, 12630.87369126297, 12752.298623575793, 12049.277043377426, 12215.755684886075, 12412.56556020535, 12494.187877787916, 12670.936645316715, 12398.380080995734, 12584.559540416407, 12610.117291789853, 12672.239665620093, 12681.429335679732, 7644.655990480331, 8039.758807235792, 8070.717524886601, 8427.283680887193, 8868.201861832466, 11386.146039047271, 12041.578544750892, 12182.0, 12626.873731262936, 13165.210087394787], "value": 9298.401340652812, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1371.0539727587957, 1494.7085318362917, 1530.0819508295021, 1654.2969238073815, 1799.6580649676553, 8114.91885081149, 8398.496090234583, 8426.0, 8432.325413966882, 8722.258608018326, 8315.085340612528, 8552.0, 8658.480491170534, 8660.350473714481, 8676.566171691422, 2030.8984550772477, 2276.943076423086, 2301.056566807609, 2320.5590937721863, 2363.633636786301, 2339.7777211165, 2340.847844890077, 2345.1323010486144, 2348.53029394121, 2352.0826877517784, 2321.210788331967, 2324.2794733632627, 2351.5532048910736, 2354.1407386304045, 2364.869932153731, 1942.8154325339142, 2214.8449608527408, 2291.209532711229, 2296.3225848374686, 2301.7698230177016, 2312.826538009639, 2320.1995311617466, 2336.380859072347, 2336.556054349668, 2342.601757701195, 8635.222829945335, 8771.342149338825, 8777.29781617469, 8778.60496277669, 8782.824343513093, 5133.794648214067, 5260.079486089919, 5261.289725886994, 5261.710605916673, 5265.473452654742, 3214.4214041472524, 3313.950290745641, 3325.90022299329, 3373.5614370131725, 3381.357542067024, 1066.3974854207427, 1079.9298045627008, 1099.0767755085767, 1115.1580556679737, 1125.3585456289918, 12304.0, 12412.56556020544, 12423.813642795365, 12454.75090498194, 12581.748365032649, 4617.607503362185, 4724.244120940702, 4827.468978412372, 4845.127876982177, 4883.267509873476, 10609.416482093558, 10629.5216715248, 10635.893641063645, 10648.094911932572, 10681.305715128492, 5384.757685904144, 5386.703731294738, 5387.568994480433, 5388.407275199725, 5390.757415916293, 4263.104748002954, 4683.110209060268, 4819.759012049383, 4824.541668541483, 4900.705957642482, 3948.802559871995, 4011.6991225658194, 4042.5957404259925, 4079.6940229482907, 4095.7952102395357, 1205.2467207995003, 1273.7834568123442, 1300.0379719008056, 1309.3911331231022, 1324.8807607315196, 846.5428668519054, 888.9288407468985, 1010.434156872154, 1012.6101450941293, 1029.897010298979, 6169.629822210682, 6179.69101544921, 6268.811935641938, 6343.207099112611, 6436.066770318278, 1001.2090448545713, 1002.5588740953957, 1012.2003617142523, 1018.1803648063232, 1024.6721049264313, 4230.725002874865, 4350.869473915787, 4369.80335884886, 4413.7351758894565, 4419.315006174048, 10624.150067994697, 10779.67660970172, 11007.834882476769, 11072.833907491395, 11079.50142243601, 10840.945795270973, 10871.45642717861, 10986.285891417032, 10989.780204395867, 11010.174236932262, 8244.587770611446, 8374.120717324593, 8375.539345335943, 8405.117462666454, 8424.873626895602, 5980.700964951648, 6014.669193194416, 6108.633481991094, 6193.287771906288, 6351.491880649629, 9875.604975800887, 10390.168786497214, 10537.262391632512, 10626.043656070991, 10653.627123050655, 10425.53085111187, 10672.413017284123, 10755.623553175914, 10780.892191078303, 10809.35143891369, 7555.24447555262, 7710.306072453506, 7735.187805280365, 7738.187490313661, 7738.303552680286, 8030.558319292261, 8074.87887681697, 8085.110637829716, 8098.554579497949, 8106.067802202586, 7377.3360397564475, 7537.849243014999, 7551.584662843597, 7565.583892885944, 7585.127710313384, 7485.251474852471, 7557.886631700639, 7635.198304177981, 7713.6143192841255, 7780.766577002699, 6948.652567371712, 6965.930340696528, 6987.231404545394, 7005.159380874327, 7019.6490175492045, 5136.280920671034, 5191.636585438983, 5261.631685781958, 5369.382521010134, 5374.355077390738, 5274.182501712241, 5322.33470816148, 5328.600354973315, 5424.864378390572, 5560.5551555876245], "value": 4673.85060835363, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.333166967405, 335.3276680256087, 346.05181801862904, 347.461434776097, 347.69750317224003, 5393.703346315951, 5439.864003399917, 5443.0, 5448.645838020526, 5473.507384335409, 5121.846344609658, 5177.498525427631, 5340.279062326585, 5349.545288650469, 5406.864828379293, 4147.3778933159965, 4190.811413486401, 4197.866576024471, 4211.1577684463155, 4244.660427165819, 4208.579142085782, 4226.852060177895, 4233.343831706091, 4240.900754126712, 4242.0, 3983.2830090583684, 4015.397690346457, 4179.331306990882, 4185.769782661952, 4200.201961627281, 4153.819244896454, 4155.97922010388, 4171.541130475645, 4187.204431158086, 4190.601892820192, 3665.890023299305, 3686.3548878946076, 3708.42519409492, 3710.628937106295, 3715.349813782604, 5139.794408223666, 5168.689878607295, 5171.5087066728975, 5230.398504172031, 5278.498542638443, 4747.881302967419, 4757.002059135137, 4764.6426518011285, 4765.380500534943, 4767.593559899838, 5553.72231388433, 5557.138643510262, 5559.527440167591, 5604.4587738371865, 5622.465865742789, 3918.666913312372, 4055.371417430303, 4065.0, 4077.2049450357194, 4080.3471444569022, 5792.7972520961985, 5809.883802323972, 5828.0, 5828.825135245949, 5837.620554663976, 4131.35963925592, 4139.710220284551, 4152.563980782034, 4157.792110394468, 4166.104287578185, 3911.78485183312, 4104.958950410517, 4141.659962121392, 4172.102997855475, 4185.518665353523, 4717.410323709536, 4718.504557021532, 4740.909590794067, 4755.738434386073, 4759.8814278644495, 5586.190002449704, 5589.0, 5616.157576363496, 5666.053652100884, 5674.319081710221, 1348.2449828096298, 1404.1996062244423, 1430.7996880436747, 1430.8640679135465, 1430.985690143106, 902.6479672927563, 907.7140700679265, 908.0420156734576, 916.1754421021134, 921.1433366968784, 4725.929111063337, 4737.810487580458, 4773.355596994431, 4781.497942716034, 4810.5670489656095, 5054.570361519312, 5061.367329083864, 5064.215046667772, 5079.4412614612365, 5110.390227078458, 4393.780310984502, 4750.5249475052215, 4762.9761851191215, 4763.428388593322, 4774.045190961821, 2696.8921243150053, 2699.298182472571, 2702.7972202654773, 2703.6079768433465, 2711.701712811589, 5129.615278854101, 5156.922646160236, 5188.481151884781, 5220.634555581149, 5224.249876291409, 4896.95103048972, 5221.425643179247, 5226.268322434862, 5227.837158519117, 5229.52934235913, 5130.639905643446, 5155.639105262596, 5202.661826981234, 5235.685858848481, 5250.369955605352, 4988.575971042357, 5056.216286475602, 5065.0, 5076.0863044652315, 5096.617753668415, 4763.54746299101, 4947.579455746302, 4966.404031516096, 5004.824831130893, 5031.7735701894235, 5122.718250496258, 5123.564497017646, 5135.589152867837, 5163.690178589297, 5181.326427564392, 3684.2263124744104, 3702.685546630907, 3721.2929543387754, 3811.7331786775767, 3867.806609669449, 5573.470520300565, 5577.693226872561, 5597.6641401516035, 5605.439456054362, 5617.269754931833, 5486.972565137149, 5488.231647569263, 5522.116461366323, 5539.224508568723, 5552.916706249491, 5290.047791397586, 5511.511891789275, 5521.82495065331, 5530.474604912527, 5536.667799932017, 5422.078246697992, 5429.484199001088, 5453.400125986059, 5462.8907421850545, 5468.375179913584, 5314.28257185275, 5390.649607775482, 5439.374471935778, 5562.0, 5569.888602227852, 5368.57051435892, 5402.486763757437, 5416.7270691388285, 5464.961657285103, 5471.343438787212], "value": 4102.352680892371, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [764.6406189091126, 786.1509569664761, 797.461713343493, 822.8683410654293, 854.5727136431784, 15560.610984725388, 16909.915450422763, 17067.743983840253, 17087.743683844754, 17118.657626847456, 14705.264736763173, 15247.92376038121, 15341.539753807376, 15379.538613841603, 15380.61548461289, 784.3646646216569, 823.8558252305852, 829.5147338806805, 836.8953880764905, 837.4472847920374, 679.5073571660556, 796.1004065406083, 821.6795449774593, 825.6243409248777, 826.1903334731966, 888.2671795768484, 889.4129874282975, 889.4218757807445, 890.5725251879102, 891.3849443883732, 882.7704796752827, 882.9426087304305, 885.4598694796169, 886.2156991062891, 886.264400547544, 513.4147072337538, 525.7476411322548, 529.8172130614931, 614.8893199224137, 638.7540796793221, 15266.236688165547, 15277.694446111016, 15311.617209569738, 15382.000169988914, 15390.692186156326, 14589.197594132318, 14753.557393278219, 14789.186594737284, 15049.398024079024, 15151.924240378838, 12940.48238070476, 13161.210327380388, 13225.86774132256, 13324.133931294531, 13735.381907814173, 4519.638428925711, 4530.365748795171, 4602.148602508513, 4603.608693261077, 4704.976475117603, 74768.0, 78300.21699782986, 78812.60593697052, 79004.0, 79152.20847791563, 11032.227744057838, 11434.714132146597, 11503.482343294572, 11721.296722196696, 11851.075510305865, 22038.449038773837, 22051.448713781963, 22145.778542214695, 22355.217567385065, 22404.103835846385, 8713.390062695551, 8933.776655583662, 8942.50816205115, 9042.231410330063, 9285.675001374919, 4674.719516829001, 4719.1033703596895, 4742.288656701453, 4759.143354196278, 4906.509349065065, 3587.461880717913, 3701.555813302421, 3704.9259014819554, 3726.5341832270965, 3731.6268373162466, 651.4007113455632, 658.3515237491067, 660.6564586415037, 672.6603065451916, 678.09812948778, 647.2491909385185, 743.2381808646181, 759.9620018999028, 776.3245976000802, 777.7316825695126, 9595.28035397348, 9685.467299298607, 9926.851097233548, 10121.240906931862, 10132.288485854113, 643.4819969924163, 655.0469067506766, 722.7434260837327, 778.1518145221736, 792.7542461836849, 4413.801378937956, 4875.853724388274, 5096.745162741922, 5126.0, 5199.246109314204, 70362.0, 70815.64592177006, 95076.39388848876, 97783.51108244414, 99338.503307483, 84894.15105848863, 87363.88452808242, 102148.48925755324, 104239.0, 104379.43430848543, 86920.0, 89884.5505772467, 90033.0, 91074.0, 95233.0, 9920.801583968425, 10262.58949642006, 10269.356922771038, 10753.946230268799, 10997.505112270128, 47528.287075694585, 52190.0, 53628.0, 53907.46092539181, 54175.18737218866, 72652.0, 80661.59669201616, 81222.59388703019, 81244.59377703074, 82021.0, 13755.243461609707, 13760.862391375958, 14026.719465610835, 14623.268836557916, 14756.409743610564, 14580.250369955249, 15097.54707358781, 15536.61158471002, 15681.60795980064, 15937.601559961095, 12081.456334465145, 14552.345144468312, 14710.211225585777, 15366.0, 15648.608784780472, 12473.903190133373, 12862.742745145231, 13321.200727956353, 13394.598162055154, 14105.647358816112, 14133.0, 14369.784453233, 14538.927305363406, 14673.26633668291, 14693.706125877636, 11177.273477223955, 11360.261582997078, 11478.562577447336, 11898.286102833858, 12039.578614748792, 11682.532698691957, 12000.519979201083, 12171.81742273849, 12364.690882728004, 12460.376981150725], "value": 7793.432153657177, "unit": "score"}], "name": "dromaeo_css", "value": 7317.8378191846405, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 110.0, 111.0, 110.0, 111.0, 109.0, 109.0, 110.0, 109.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 116.0, 117.0, 189.0, 120.0, 124.0, 140.0, 117.0, 149.0, 117.0], "value": 133.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 160.0, 160.0, 160.0, 161.0, 161.0, 161.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 137.0, 76.0, 75.0, 74.0, 75.0, 102.0, 75.0], "value": 83.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 114.0, 84.0, 84.0, 84.0, 119.0, 83.0, 83.0, 131.0], "value": 94.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 118.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 51.0, 52.0, 51.0, 52.0, 54.0, 53.0, 51.0, 52.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 62.0, 61.0, 62.0, 62.0, 62.0, 62.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 75.0, 74.0, 74.0, 77.0, 75.0, 75.0, 81.0, 76.0, 79.0], "value": 76.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 128.0, 118.0, 126.0, 117.0, 129.0, 121.0, 119.0, 161.0, 133.0], "value": 128.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 158.0, 155.0, 155.0, 153.0, 153.0, 173.0, 155.0, 157.0, 153.0], "value": 156.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 62.0, 63.0, 63.0, 61.0, 61.0, 60.0, 62.0], "value": 61.9, "unit": "score"}], "name": "kraken", "value": 1476.1999999999998, "alertThreshold": 2.0}]} 20:31:34 INFO - Return code: 0 20:31:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:31:34 INFO - # TBPL SUCCESS # 20:31:34 INFO - Running post-action listener: _resource_record_post_action 20:31:34 INFO - ##### 20:31:34 INFO - ##### Finished run-tests step (success) 20:31:34 INFO - ##### 20:31:34 INFO - Running post-run listener: _resource_record_post_run 20:31:34 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 569536512; Read time: 0; Write time: 707104 20:31:34 INFO - TinderboxPrint: CPU usage
13.1% 20:31:34 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 20:31:34 INFO - TinderboxPrint: I/O write bytes / time
569,536,512 / 707,104 20:31:34 INFO - TinderboxPrint: CPU idle
8,267.2 (86.9%) 20:31:34 INFO - TinderboxPrint: CPU user
1,201.9 (12.6%) 20:31:34 INFO - TinderboxPrint: Swap in / out
0 / 0 20:31:34 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 269303808; Read time: 0; Write time: 357524 20:31:34 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 296792064; Read time: 0; Write time: 349256 20:31:35 INFO - Running post-run listener: _upload_blobber_files 20:31:35 INFO - Blob upload gear active. 20:31:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:31:35 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 20:31:35 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:31:35 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:31:35 INFO - (blobuploader) - INFO - Open directory for files ... 20:31:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:31:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:31:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:31:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:31:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:31:36 INFO - (blobuploader) - INFO - Done attempting. 20:31:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:31:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:31:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:31:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:31:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:31:37 INFO - (blobuploader) - INFO - Done attempting. 20:31:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:31:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:31:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:31:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:31:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:31:42 INFO - (blobuploader) - INFO - Done attempting. 20:31:42 INFO - (blobuploader) - INFO - Iteration through files over. 20:31:42 INFO - Return code: 0 20:31:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:31:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:31:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b61df0edfce71450abb389a5562c3367a1876f184e3b9bc5f06bbd6433941630351a9c3cf6a815efb135ca33e93f8720ebe73bbeb9e5482a57ce1f9fcd4f4863", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c43246d326bb2c04ff8c1068fd119a70136fb7199524444285572ea53ae314b09d2c15c040f461ae76d4f5216f371210d2829d00ffd5c1a7ef17fe3502336348", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4823123cfa8504a5c578fc2a94fd5f3de85ccf6c17eeac853afcedbc40e60442205147926d933003f67ed9caaab2cb58ae82447d5e2277b37fdb86d3f27bae0a"} 20:31:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:31:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:31:42 INFO - Contents: 20:31:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b61df0edfce71450abb389a5562c3367a1876f184e3b9bc5f06bbd6433941630351a9c3cf6a815efb135ca33e93f8720ebe73bbeb9e5482a57ce1f9fcd4f4863", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c43246d326bb2c04ff8c1068fd119a70136fb7199524444285572ea53ae314b09d2c15c040f461ae76d4f5216f371210d2829d00ffd5c1a7ef17fe3502336348", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4823123cfa8504a5c578fc2a94fd5f3de85ccf6c17eeac853afcedbc40e60442205147926d933003f67ed9caaab2cb58ae82447d5e2277b37fdb86d3f27bae0a"} 20:31:42 INFO - Running post-run listener: copy_logs_to_upload_dir 20:31:42 INFO - Copying logs to upload dir... 20:31:42 INFO - mkdir: /builds/slave/test/build/upload/logs 20:31:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.704377 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-07-06 20:31:41.721155) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 20:31:41.724399) ========= 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=17051fcd5208b27b50bedfeb000001dd-1467860438.892864-1846552983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b61df0edfce71450abb389a5562c3367a1876f184e3b9bc5f06bbd6433941630351a9c3cf6a815efb135ca33e93f8720ebe73bbeb9e5482a57ce1f9fcd4f4863", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c43246d326bb2c04ff8c1068fd119a70136fb7199524444285572ea53ae314b09d2c15c040f461ae76d4f5216f371210d2829d00ffd5c1a7ef17fe3502336348", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4823123cfa8504a5c578fc2a94fd5f3de85ccf6c17eeac853afcedbc40e60442205147926d933003f67ed9caaab2cb58ae82447d5e2277b37fdb86d3f27bae0a"} build_url:https://queue.taskcluster.net/v1/task/VFgtFnOFRI-0DiV3eauzqg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011294 build_url: 'https://queue.taskcluster.net/v1/task/VFgtFnOFRI-0DiV3eauzqg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b61df0edfce71450abb389a5562c3367a1876f184e3b9bc5f06bbd6433941630351a9c3cf6a815efb135ca33e93f8720ebe73bbeb9e5482a57ce1f9fcd4f4863", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c43246d326bb2c04ff8c1068fd119a70136fb7199524444285572ea53ae314b09d2c15c040f461ae76d4f5216f371210d2829d00ffd5c1a7ef17fe3502336348", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4823123cfa8504a5c578fc2a94fd5f3de85ccf6c17eeac853afcedbc40e60442205147926d933003f67ed9caaab2cb58ae82447d5e2277b37fdb86d3f27bae0a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 20:31:41.749023) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 20:31:41.749381) ========= 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=17051fcd5208b27b50bedfeb000001dd-1467860438.892864-1846552983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004526 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 20:31:41.833201) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 20:31:41.833474) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 20:31:41.833744) ========= ========= Total master_lag: 0.17 =========