builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-049 starttime: 1467860460.78 results: success (0) buildid: 20160706173002 builduid: 12c2d2029d214d2d932fbd5f13a78840 revision: 1dd03896ee5f2165822f36235523e39394826531 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 20:01:00.778592) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 20:01:00.779064) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 20:01:00.779340) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 20:01:00.826106) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 20:01:00.826397) ========= 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=db7e7c15f3ca076d53731445000001ba-1467860149.775553-1015131102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-06 20:01:01-- 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% 226M=0s 2016-07-06 20:01:01 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122768 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 20:01:00.972344) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 20:01:00.972707) ========= 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=db7e7c15f3ca076d53731445000001ba-1467860149.775553-1015131102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017418 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 20:01:01.031309) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 20:01:01.031683) ========= 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=db7e7c15f3ca076d53731445000001ba-1467860149.775553-1015131102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-06 20:01:01,524 truncating revision to first 12 chars 2016-07-06 20:01:01,524 Setting DEBUG logging. 2016-07-06 20:01:01,524 attempt 1/10 2016-07-06 20:01:01,524 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:01:01,844 unpacking tar archive at: fx-team-1dd03896ee5f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.654180 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 20:01:01.702766) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 20:01:01.703139) ========= script_repo_revision: 1dd03896ee5f2165822f36235523e39394826531 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 20:01:01.703603) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 20:01:01.703892) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 20:01:01.750151) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-07-06 20:01:01.750623) ========= /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=db7e7c15f3ca076d53731445000001ba-1467860149.775553-1015131102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:01:02 INFO - MultiFileLogger online at 20160706 20:01:02 in /builds/slave/test 20:01:02 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:01:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:01:02 INFO - {'append_to_log': False, 20:01:02 INFO - 'base_work_dir': '/builds/slave/test', 20:01:02 INFO - 'blob_upload_branch': 'Fx-Team', 20:01:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:01:02 INFO - 'branch': 'Fx-Team', 20:01:02 INFO - 'buildbot_json_path': 'buildprops.json', 20:01:02 INFO - 'config_files': ('talos/linux_config.py',), 20:01:02 INFO - 'default_actions': ('clobber', 20:01:02 INFO - 'read-buildbot-config', 20:01:02 INFO - 'download-and-extract', 20:01:02 INFO - 'populate-webroot', 20:01:02 INFO - 'create-virtualenv', 20:01:02 INFO - 'install', 20:01:02 INFO - 'run-tests'), 20:01:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:01:02 INFO - 'download_minidump_stackwalk': True, 20:01:02 INFO - 'download_symbols': 'ondemand', 20:01:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:01:02 INFO - 'tooltool.py': '/tools/tooltool.py', 20:01:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:01:02 INFO - '/tools/misc-python/virtualenv.py')}, 20:01:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:01:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:01:02 INFO - 'installer_path': 'installer.exe', 20:01:02 INFO - 'log_level': 'info', 20:01:02 INFO - 'log_name': 'talos', 20:01:02 INFO - 'log_to_console': True, 20:01:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:01:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:01:02 INFO - 'opt_config_files': (), 20:01:02 INFO - 'pip_index': False, 20:01:02 INFO - 'sps_profile': False, 20:01:02 INFO - 'sps_profile_interval': 0, 20:01:02 INFO - 'suite': 'dromaeojs', 20:01:02 INFO - 'system_bits': '32', 20:01:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:01:02 INFO - 'title': 'talos-linux64-ix-049', 20:01:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:01:02 INFO - 'use_talos_json': True, 20:01:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:01:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:01:02 INFO - 'work_dir': 'build'} 20:01:02 INFO - ##### 20:01:02 INFO - ##### Running clobber step. 20:01:02 INFO - ##### 20:01:02 INFO - Running pre-action listener: _resource_record_pre_action 20:01:02 INFO - Running main action method: clobber 20:01:02 INFO - rmtree: /builds/slave/test/build 20:01:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:01:02 INFO - Running post-action listener: _resource_record_post_action 20:01:02 INFO - ##### 20:01:02 INFO - ##### Finished clobber step (success) 20:01:02 INFO - ##### 20:01:02 INFO - ##### 20:01:02 INFO - ##### Running read-buildbot-config step. 20:01:02 INFO - ##### 20:01:02 INFO - Running pre-action listener: _resource_record_pre_action 20:01:02 INFO - Running main action method: read_buildbot_config 20:01:02 INFO - Using buildbot properties: 20:01:02 INFO - { 20:01:02 INFO - "project": "", 20:01:02 INFO - "product": "firefox", 20:01:02 INFO - "script_repo_revision": "production", 20:01:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:01:02 INFO - "repository": "", 20:01:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:01:02 INFO - "buildid": "20160706173002", 20:01:02 INFO - "pgo_build": "True", 20:01:02 INFO - "basedir": "/builds/slave/test", 20:01:02 INFO - "buildnumber": 253, 20:01:02 INFO - "slavename": "talos-linux64-ix-049", 20:01:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:01:02 INFO - "platform": "ubuntu64_hw", 20:01:02 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:01:02 INFO - "branch": "fx-team", 20:01:02 INFO - "repo_path": "integration/fx-team", 20:01:02 INFO - "revision": "1dd03896ee5f2165822f36235523e39394826531", 20:01:02 INFO - "stage_platform": "linux64-pgo", 20:01:02 INFO - "builduid": "12c2d2029d214d2d932fbd5f13a78840", 20:01:02 INFO - "slavebuilddir": "test" 20:01:02 INFO - } 20:01:02 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:01:02 INFO - Running post-action listener: _resource_record_post_action 20:01:02 INFO - ##### 20:01:02 INFO - ##### Finished read-buildbot-config step (success) 20:01:02 INFO - ##### 20:01:02 INFO - ##### 20:01:02 INFO - ##### Running download-and-extract step. 20:01:02 INFO - ##### 20:01:02 INFO - Running pre-action listener: _resource_record_pre_action 20:01:02 INFO - Running main action method: download_and_extract 20:01:02 INFO - mkdir: /builds/slave/test/build/tests 20:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:02 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:01:02 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:01:02 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:01:02 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:01:02 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:01:11 INFO - Downloaded 1361 bytes. 20:01:11 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:01:11 INFO - Using the following test package requirements: 20:01:11 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:01:11 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:01:11 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:01:11 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:11 INFO - u'jsshell-linux-x86_64.zip'], 20:01:11 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:01:11 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:01:11 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:01:11 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:01:11 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:01:11 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:01:11 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:01: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:01: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:01: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:01: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:01: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:01: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:01:19 INFO - Downloaded 24300742 bytes. 20:01:19 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:01:19 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:01:20 INFO - Return code: 0 20:01:20 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:01:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:20 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:01:20 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:01:20 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:01:20 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:01:20 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:01:24 INFO - Downloaded 24300742 bytes. 20:01:24 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:01:24 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:01:25 INFO - Return code: 0 20:01: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:01:25 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:01:25 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:01:25 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:01:25 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:01:25 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:01:26 INFO - Downloaded 14403333 bytes. 20:01:26 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:01:26 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:01:27 INFO - Return code: 0 20:01:27 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:01:27 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:01:27 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:01:27 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:01:27 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:01:27 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:01:28 INFO - Downloaded 60350722 bytes. 20:01:28 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:01:28 INFO - mkdir: /builds/slave/test/properties 20:01:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:01:28 INFO - Writing to file /builds/slave/test/properties/build_url 20:01:28 INFO - Contents: 20:01:28 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:01:29 INFO - Running post-action listener: _resource_record_post_action 20:01:29 INFO - Running post-action listener: set_extra_try_arguments 20:01:29 INFO - ##### 20:01:29 INFO - ##### Finished download-and-extract step (success) 20:01:29 INFO - ##### 20:01:29 INFO - ##### 20:01:29 INFO - ##### Running populate-webroot step. 20:01:29 INFO - ##### 20:01:29 INFO - Running pre-action listener: _resource_record_pre_action 20:01:29 INFO - Running main action method: populate_webroot 20:01:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:01:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:01:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:01:29 INFO - '--tppagecycles', 20:01:29 INFO - '7'], 20:01:29 INFO - 'tests': ['tsvgm']}}, 20:01:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:01:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:01:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:01:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:01:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:01:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:01:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:29 INFO - 'talos_options': ['--disable-e10s'], 20:01:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:01:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:01:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:29 INFO - 'talos_options': ['--disable-e10s'], 20:01:29 INFO - 'tests': ['damp', 'tps']}, 20:01:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:29 INFO - 'tests': ['damp', 'tps']}, 20:01:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:01:29 INFO - 'tests': ['dromaeo_dom']}, 20:01:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:01:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:01:29 INFO - 'tests': ['basic_compositor_video']}, 20:01:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:01:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:01:29 INFO - 'tests': ['a11yr', 20:01:29 INFO - 'ts_paint', 20:01:29 INFO - 'tpaint', 20:01:29 INFO - 'sessionrestore', 20:01:29 INFO - 'sessionrestore_no_auto_restore', 20:01:29 INFO - 'tabpaint']}, 20:01:29 INFO - 'other-e10s': {'tests': ['a11yr', 20:01:29 INFO - 'ts_paint', 20:01:29 INFO - 'tpaint', 20:01:29 INFO - 'sessionrestore', 20:01:29 INFO - 'sessionrestore_no_auto_restore', 20:01:29 INFO - 'tabpaint']}, 20:01:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:01:29 INFO - 'ts_paint', 20:01:29 INFO - 'tpaint', 20:01:29 INFO - 'sessionrestore', 20:01:29 INFO - 'sessionrestore_no_auto_restore', 20:01:29 INFO - 'tabpaint']}, 20:01:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:01:29 INFO - 'ts_paint', 20:01:29 INFO - 'tpaint', 20:01:29 INFO - 'sessionrestore', 20:01:29 INFO - 'sessionrestore_no_auto_restore', 20:01:29 INFO - 'tabpaint']}, 20:01:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:01:29 INFO - 'tests': ['a11yr', 20:01:29 INFO - 'ts_paint', 20:01:29 INFO - 'tpaint', 20:01:29 INFO - 'sessionrestore', 20:01:29 INFO - 'sessionrestore_no_auto_restore', 20:01:29 INFO - 'tabpaint']}, 20:01:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:01:29 INFO - 'tests': ['a11yr', 20:01:29 INFO - 'ts_paint', 20:01:29 INFO - 'tpaint', 20:01:29 INFO - 'sessionrestore', 20:01:29 INFO - 'sessionrestore_no_auto_restore', 20:01:29 INFO - 'tabpaint']}, 20:01:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:01:29 INFO - 'tests': ['tsvgx', 20:01:29 INFO - 'tsvgr_opacity', 20:01:29 INFO - 'tart', 20:01:29 INFO - 'tscrollx', 20:01:29 INFO - 'cart']}, 20:01:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:01:29 INFO - 'tsvgr_opacity', 20:01:29 INFO - 'tart', 20:01:29 INFO - 'tscrollx', 20:01:29 INFO - 'cart']}, 20:01:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:29 INFO - 'talos_options': ['--disable-e10s'], 20:01:29 INFO - 'tests': ['tp5o']}, 20:01:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:29 INFO - 'tests': ['tp5o']}, 20:01:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:29 INFO - 'talos_options': ['--disable-e10s', 20:01:29 INFO - '--xperf_path', 20:01:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:01:29 INFO - 'tests': ['tp5n']}, 20:01:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:29 INFO - 'talos_options': ['--xperf_path', 20:01:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:01:29 INFO - 'tests': ['tp5n']}}, 20:01:29 INFO - 'talos.zip': {'path': '', 20:01:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:01:29 INFO - Running post-action listener: _resource_record_post_action 20:01:29 INFO - ##### 20:01:29 INFO - ##### Finished populate-webroot step (success) 20:01:29 INFO - ##### 20:01:29 INFO - ##### 20:01:29 INFO - ##### Running create-virtualenv step. 20:01:29 INFO - ##### 20:01:29 INFO - Running pre-action listener: _resource_record_pre_action 20:01:29 INFO - Running main action method: create_virtualenv 20:01:29 INFO - Creating virtualenv /builds/slave/test/build/venv 20:01:29 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:01:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:01:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:01:29 INFO - Using real prefix '/usr' 20:01:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:01:29 INFO - Installing distribute.............................................................................................................................................................................................done. 20:01:31 INFO - Installing pip.................done. 20:01:31 INFO - Return code: 0 20:01:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:01:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:31 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 0xd77030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1038180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10363b0>, '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 0x10372b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037740>, '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': 'db7e7c15f3ca076d53731445000001ba-1467860149.775553-1015131102', '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:01:31 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:01:31 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:01:31 INFO - Using env: {'DISPLAY': ':0', 20:01:31 INFO - 'HOME': '/home/cltbld', 20:01:31 INFO - 'LANG': 'en_US.UTF-8', 20:01:31 INFO - 'LANGUAGE': 'en_US:en', 20:01:31 INFO - 'LOGNAME': 'cltbld', 20:01:31 INFO - 'MAIL': '/var/mail/cltbld', 20:01:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:31 INFO - 'MOZ_NO_REMOTE': '1', 20:01:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:31 INFO - 'NO_EM_RESTART': '1', 20:01:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:31 INFO - 'PWD': '/builds/slave/test', 20:01:31 INFO - 'SHELL': '/bin/bash', 20:01:31 INFO - 'SHLVL': '1', 20:01:31 INFO - 'TERM': 'linux', 20:01:31 INFO - 'TMOUT': '86400', 20:01:31 INFO - 'USER': 'cltbld', 20:01:31 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467860149.775553-1015131102', 20:01:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:31 INFO - '_': '/tools/buildbot/bin/python'} 20:01:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:32 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:01:32 INFO - Cleaning up... 20:01:32 INFO - Return code: 0 20:01:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:01:32 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:01:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:32 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:01:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:32 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 0xd77030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1038180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10363b0>, '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 0x10372b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037740>, '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': 'db7e7c15f3ca076d53731445000001ba-1467860149.775553-1015131102', '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:01:32 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:01:32 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:01:32 INFO - Using env: {'DISPLAY': ':0', 20:01:32 INFO - 'HOME': '/home/cltbld', 20:01:32 INFO - 'LANG': 'en_US.UTF-8', 20:01:32 INFO - 'LANGUAGE': 'en_US:en', 20:01:32 INFO - 'LOGNAME': 'cltbld', 20:01:32 INFO - 'MAIL': '/var/mail/cltbld', 20:01:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:32 INFO - 'MOZ_NO_REMOTE': '1', 20:01:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:32 INFO - 'NO_EM_RESTART': '1', 20:01:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:32 INFO - 'PWD': '/builds/slave/test', 20:01:32 INFO - 'SHELL': '/bin/bash', 20:01:32 INFO - 'SHLVL': '1', 20:01:32 INFO - 'TERM': 'linux', 20:01:32 INFO - 'TMOUT': '86400', 20:01:32 INFO - 'USER': 'cltbld', 20:01:32 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467860149.775553-1015131102', 20:01:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:32 INFO - '_': '/tools/buildbot/bin/python'} 20:01:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:32 INFO - Downloading/unpacking psutil>=3.1.1 20:01: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:01: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:01: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:01: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:01: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:01: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:01:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:01:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:01:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:01:34 INFO - Installing collected packages: psutil 20:01:34 INFO - Running setup.py install for psutil 20:01:34 INFO - building 'psutil._psutil_linux' extension 20:01:34 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:01:34 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:01:34 INFO - building 'psutil._psutil_posix' extension 20:01:34 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:01:34 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:01:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:01:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:01:34 INFO - Successfully installed psutil 20:01:34 INFO - Cleaning up... 20:01:34 INFO - Return code: 0 20:01:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:01: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:01:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01: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:01:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:34 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 0xd77030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1038180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10363b0>, '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 0x10372b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037740>, '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': 'db7e7c15f3ca076d53731445000001ba-1467860149.775553-1015131102', '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:01:34 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:01:34 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:01:34 INFO - Using env: {'DISPLAY': ':0', 20:01:34 INFO - 'HOME': '/home/cltbld', 20:01:34 INFO - 'LANG': 'en_US.UTF-8', 20:01:34 INFO - 'LANGUAGE': 'en_US:en', 20:01:34 INFO - 'LOGNAME': 'cltbld', 20:01:34 INFO - 'MAIL': '/var/mail/cltbld', 20:01:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:34 INFO - 'MOZ_NO_REMOTE': '1', 20:01:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:34 INFO - 'NO_EM_RESTART': '1', 20:01:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:34 INFO - 'PWD': '/builds/slave/test', 20:01:34 INFO - 'SHELL': '/bin/bash', 20:01:34 INFO - 'SHLVL': '1', 20:01:34 INFO - 'TERM': 'linux', 20:01:34 INFO - 'TMOUT': '86400', 20:01:34 INFO - 'USER': 'cltbld', 20:01:34 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467860149.775553-1015131102', 20:01:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:34 INFO - '_': '/tools/buildbot/bin/python'} 20:01:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:01:35 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:01:35 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:01:35 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:01:35 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:01:35 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:01:35 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:01:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:01:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:01:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:01:37 INFO - Installing collected packages: mozsystemmonitor 20:01:37 INFO - Running setup.py install for mozsystemmonitor 20:01:37 INFO - Successfully installed mozsystemmonitor 20:01:37 INFO - Cleaning up... 20:01:37 INFO - Return code: 0 20:01:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:01: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:01:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01: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:01:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:37 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 0xd77030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1038180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10363b0>, '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 0x10372b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037740>, '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': 'db7e7c15f3ca076d53731445000001ba-1467860149.775553-1015131102', '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:01:37 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:01:37 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:01:37 INFO - Using env: {'DISPLAY': ':0', 20:01:37 INFO - 'HOME': '/home/cltbld', 20:01:37 INFO - 'LANG': 'en_US.UTF-8', 20:01:37 INFO - 'LANGUAGE': 'en_US:en', 20:01:37 INFO - 'LOGNAME': 'cltbld', 20:01:37 INFO - 'MAIL': '/var/mail/cltbld', 20:01:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:37 INFO - 'MOZ_NO_REMOTE': '1', 20:01:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:37 INFO - 'NO_EM_RESTART': '1', 20:01:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:37 INFO - 'PWD': '/builds/slave/test', 20:01:37 INFO - 'SHELL': '/bin/bash', 20:01:37 INFO - 'SHLVL': '1', 20:01:37 INFO - 'TERM': 'linux', 20:01:37 INFO - 'TMOUT': '86400', 20:01:37 INFO - 'USER': 'cltbld', 20:01:37 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467860149.775553-1015131102', 20:01:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:37 INFO - '_': '/tools/buildbot/bin/python'} 20:01:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:37 INFO - Downloading/unpacking jsonschema==2.5.1 20:01:37 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:01:37 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:01:37 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:01:37 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:01:37 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:01:37 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:01:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:01:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:01:39 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:01:39 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:01:39 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:01:39 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:01:39 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:01:39 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:01:39 INFO - Downloading functools32-3.2.3-2.tar.gz 20:01:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:01:39 INFO - warning: no files found matching '*.txt' 20:01:39 INFO - no previously-included directories found matching 'build' 20:01:39 INFO - no previously-included directories found matching 'dist' 20:01:39 INFO - no previously-included directories found matching '.git*' 20:01:39 INFO - Installing collected packages: jsonschema, functools32 20:01:39 INFO - Running setup.py install for functools32 20:01:39 INFO - warning: no files found matching '*.txt' 20:01:39 INFO - no previously-included directories found matching 'build' 20:01:39 INFO - no previously-included directories found matching 'dist' 20:01:39 INFO - no previously-included directories found matching '.git*' 20:01:39 INFO - Successfully installed jsonschema functools32 20:01:39 INFO - Cleaning up... 20:01:39 INFO - Return code: 0 20:01:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:01:39 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:01:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:39 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:01:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:39 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 0xd77030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1038180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10363b0>, '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 0x10372b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037740>, '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': 'db7e7c15f3ca076d53731445000001ba-1467860149.775553-1015131102', '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:01:39 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:01:39 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:01:39 INFO - Using env: {'DISPLAY': ':0', 20:01:39 INFO - 'HOME': '/home/cltbld', 20:01:39 INFO - 'LANG': 'en_US.UTF-8', 20:01:39 INFO - 'LANGUAGE': 'en_US:en', 20:01:39 INFO - 'LOGNAME': 'cltbld', 20:01:39 INFO - 'MAIL': '/var/mail/cltbld', 20:01:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:39 INFO - 'MOZ_NO_REMOTE': '1', 20:01:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:39 INFO - 'NO_EM_RESTART': '1', 20:01:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:39 INFO - 'PWD': '/builds/slave/test', 20:01:39 INFO - 'SHELL': '/bin/bash', 20:01:39 INFO - 'SHLVL': '1', 20:01:39 INFO - 'TERM': 'linux', 20:01:39 INFO - 'TMOUT': '86400', 20:01:39 INFO - 'USER': 'cltbld', 20:01:39 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467860149.775553-1015131102', 20:01:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:39 INFO - '_': '/tools/buildbot/bin/python'} 20:01:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:40 INFO - Downloading/unpacking blobuploader==1.2.4 20:01:40 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:01:40 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:01:40 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:01:40 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:01:40 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:01:40 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:01:41 INFO - Downloading blobuploader-1.2.4.tar.gz 20:01:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:01:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:01:42 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:01:42 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:01:42 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:01:42 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:01:42 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:01:42 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:01:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:01:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:01:42 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:01:42 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:01:42 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:01:42 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:01:42 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:01:42 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:01:42 INFO - Downloading docopt-0.6.1.tar.gz 20:01:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:01:42 INFO - Installing collected packages: blobuploader, requests, docopt 20:01:42 INFO - Running setup.py install for blobuploader 20:01:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:01:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:01:42 INFO - Running setup.py install for requests 20:01:43 INFO - Running setup.py install for docopt 20:01:43 INFO - Successfully installed blobuploader requests docopt 20:01:43 INFO - Cleaning up... 20:01:43 INFO - Return code: 0 20:01:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:01:43 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:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:43 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:01:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:43 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 0xd77030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1038180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10363b0>, '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 0x10372b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037740>, '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': 'db7e7c15f3ca076d53731445000001ba-1467860149.775553-1015131102', '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:01:43 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:01:43 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:01:43 INFO - Using env: {'DISPLAY': ':0', 20:01:43 INFO - 'HOME': '/home/cltbld', 20:01:43 INFO - 'LANG': 'en_US.UTF-8', 20:01:43 INFO - 'LANGUAGE': 'en_US:en', 20:01:43 INFO - 'LOGNAME': 'cltbld', 20:01:43 INFO - 'MAIL': '/var/mail/cltbld', 20:01:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:43 INFO - 'MOZ_NO_REMOTE': '1', 20:01:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:43 INFO - 'NO_EM_RESTART': '1', 20:01:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:43 INFO - 'PWD': '/builds/slave/test', 20:01:43 INFO - 'SHELL': '/bin/bash', 20:01:43 INFO - 'SHLVL': '1', 20:01:43 INFO - 'TERM': 'linux', 20:01:43 INFO - 'TMOUT': '86400', 20:01:43 INFO - 'USER': 'cltbld', 20:01:43 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467860149.775553-1015131102', 20:01:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:43 INFO - '_': '/tools/buildbot/bin/python'} 20:01:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:01:43 INFO - Running setup.py (path:/tmp/pip-NQ7Ne7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:01:43 INFO - Running setup.py (path:/tmp/pip-hs6_IA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:01:43 INFO - Running setup.py (path:/tmp/pip-yt3KRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:01:43 INFO - Running setup.py (path:/tmp/pip-Wna5X9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:01:43 INFO - Running setup.py (path:/tmp/pip-hb3w8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:01:43 INFO - Running setup.py (path:/tmp/pip-1YEBFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:01:44 INFO - Running setup.py (path:/tmp/pip-QxKA2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:01:44 INFO - Running setup.py (path:/tmp/pip-RE66m2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:01:44 INFO - Running setup.py (path:/tmp/pip-CWB2uE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:01:44 INFO - Running setup.py (path:/tmp/pip-_0f2CU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:01:44 INFO - Running setup.py (path:/tmp/pip-hstDyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:01:44 INFO - Running setup.py (path:/tmp/pip-Cxvu7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:01:44 INFO - Running setup.py (path:/tmp/pip-ReIjZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:01:44 INFO - Running setup.py (path:/tmp/pip-JQRxS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:01:44 INFO - Running setup.py (path:/tmp/pip-NhCX11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:01:44 INFO - Running setup.py (path:/tmp/pip-5iG8RH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:01:44 INFO - Running setup.py (path:/tmp/pip-pnZ0S4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:01:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:01:44 INFO - Running setup.py install for manifestparser 20:01:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:01:44 INFO - Running setup.py install for mozcrash 20:01:45 INFO - Running setup.py install for mozdebug 20:01:45 INFO - Running setup.py install for mozdevice 20:01:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:01:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:01:45 INFO - Running setup.py install for mozfile 20:01:45 INFO - Running setup.py install for mozhttpd 20:01:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:01:45 INFO - Running setup.py install for mozinfo 20:01:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:01:45 INFO - Running setup.py install for mozInstall 20:01:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:01:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:01:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:01:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:01:45 INFO - Running setup.py install for mozleak 20:01:45 INFO - Running setup.py install for mozlog 20:01:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:01:45 INFO - Running setup.py install for moznetwork 20:01:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:01:45 INFO - Running setup.py install for mozprocess 20:01:46 INFO - Running setup.py install for mozprofile 20:01:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:01:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:01:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:01:46 INFO - Running setup.py install for mozrunner 20:01:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:01:46 INFO - Running setup.py install for mozscreenshot 20:01:46 INFO - Running setup.py install for moztest 20:01:46 INFO - Running setup.py install for mozversion 20:01:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:01:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:01:46 INFO - Cleaning up... 20:01:46 INFO - Return code: 0 20:01:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:01:46 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:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:46 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:01:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:46 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 0xd77030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1038180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10363b0>, '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 0x10372b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037740>, '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': 'db7e7c15f3ca076d53731445000001ba-1467860149.775553-1015131102', '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:01:46 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:01:46 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:01:46 INFO - Using env: {'DISPLAY': ':0', 20:01:46 INFO - 'HOME': '/home/cltbld', 20:01:46 INFO - 'LANG': 'en_US.UTF-8', 20:01:46 INFO - 'LANGUAGE': 'en_US:en', 20:01:46 INFO - 'LOGNAME': 'cltbld', 20:01:46 INFO - 'MAIL': '/var/mail/cltbld', 20:01:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:46 INFO - 'MOZ_NO_REMOTE': '1', 20:01:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:46 INFO - 'NO_EM_RESTART': '1', 20:01:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:46 INFO - 'PWD': '/builds/slave/test', 20:01:46 INFO - 'SHELL': '/bin/bash', 20:01:46 INFO - 'SHLVL': '1', 20:01:46 INFO - 'TERM': 'linux', 20:01:46 INFO - 'TMOUT': '86400', 20:01:46 INFO - 'USER': 'cltbld', 20:01:46 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467860149.775553-1015131102', 20:01:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:46 INFO - '_': '/tools/buildbot/bin/python'} 20:01:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:01:46 INFO - Running setup.py (path:/tmp/pip-hpswp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:01:46 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:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:01:46 INFO - Running setup.py (path:/tmp/pip-kvJM7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:01:46 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:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:01:46 INFO - Running setup.py (path:/tmp/pip-XdCiBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:01:47 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:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:01:47 INFO - Running setup.py (path:/tmp/pip-gAUOVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:01:47 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:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:01:47 INFO - Running setup.py (path:/tmp/pip-3w1Lda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:01:47 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:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:01:47 INFO - Running setup.py (path:/tmp/pip-r7w8Gf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:01:47 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:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:01:47 INFO - Running setup.py (path:/tmp/pip-fQ7xh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:01:47 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:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:01:47 INFO - Running setup.py (path:/tmp/pip-Ej4Ysy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:01:47 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:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:01:47 INFO - Running setup.py (path:/tmp/pip-z9oAoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:01:47 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:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:01:47 INFO - Running setup.py (path:/tmp/pip-aEQDdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:01:47 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:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:01:47 INFO - Running setup.py (path:/tmp/pip-RoV04v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:01:47 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:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:01:47 INFO - Running setup.py (path:/tmp/pip-PPJDWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:01:47 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:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:01:47 INFO - Running setup.py (path:/tmp/pip-yMjByk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:01:47 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:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:01:47 INFO - Running setup.py (path:/tmp/pip-nIpdC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:01:47 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:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:01:47 INFO - Running setup.py (path:/tmp/pip-AWS0wv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:01:47 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:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:01:47 INFO - Running setup.py (path:/tmp/pip-R62Hep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:01:47 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:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:01:47 INFO - Running setup.py (path:/tmp/pip-qNeIpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:01:48 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:01:48 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:01:48 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:01:48 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:01:48 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:01:48 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:01:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:49 INFO - Downloading blessings-1.6.tar.gz 20:01:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:01:50 INFO - Installing collected packages: blessings 20:01:50 INFO - Running setup.py install for blessings 20:01:50 INFO - Successfully installed blessings 20:01:50 INFO - Cleaning up... 20:01:50 INFO - Return code: 0 20:01:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:01:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:01:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:01:50 INFO - Reading from file tmpfile_stdout 20:01:50 INFO - Current package versions: 20:01:50 INFO - argparse == 1.2.1 20:01:50 INFO - blessings == 1.6 20:01:50 INFO - blobuploader == 1.2.4 20:01:50 INFO - docopt == 0.6.1 20:01:50 INFO - functools32 == 3.2.3-2 20:01:50 INFO - jsonschema == 2.5.1 20:01:50 INFO - manifestparser == 1.1 20:01:50 INFO - mozInstall == 1.12 20:01:50 INFO - mozcrash == 0.17 20:01:50 INFO - mozdebug == 0.1 20:01:50 INFO - mozdevice == 0.48 20:01:50 INFO - mozfile == 1.2 20:01:50 INFO - mozhttpd == 0.7 20:01:50 INFO - mozinfo == 0.9 20:01:50 INFO - mozleak == 0.1 20:01:50 INFO - mozlog == 3.2 20:01:50 INFO - moznetwork == 0.27 20:01:50 INFO - mozprocess == 0.22 20:01:50 INFO - mozprofile == 0.28 20:01:50 INFO - mozrunner == 6.11 20:01:50 INFO - mozscreenshot == 0.1 20:01:50 INFO - mozsystemmonitor == 0.3 20:01:50 INFO - moztest == 0.7 20:01:50 INFO - mozversion == 1.4 20:01:50 INFO - psutil == 3.1.1 20:01:50 INFO - requests == 1.2.3 20:01:50 INFO - wsgiref == 0.1.2 20:01:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:50 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 0xd77030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1038180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10363b0>, '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 0x10372b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037740>, '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': 'db7e7c15f3ca076d53731445000001ba-1467860149.775553-1015131102', '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:01:50 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:01:50 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:01:50 INFO - Using env: {'DISPLAY': ':0', 20:01:50 INFO - 'HOME': '/home/cltbld', 20:01:50 INFO - 'LANG': 'en_US.UTF-8', 20:01:50 INFO - 'LANGUAGE': 'en_US:en', 20:01:50 INFO - 'LOGNAME': 'cltbld', 20:01:50 INFO - 'MAIL': '/var/mail/cltbld', 20:01:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:50 INFO - 'MOZ_NO_REMOTE': '1', 20:01:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:50 INFO - 'NO_EM_RESTART': '1', 20:01:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:50 INFO - 'PWD': '/builds/slave/test', 20:01:50 INFO - 'SHELL': '/bin/bash', 20:01:50 INFO - 'SHLVL': '1', 20:01:50 INFO - 'TERM': 'linux', 20:01:50 INFO - 'TMOUT': '86400', 20:01:50 INFO - 'USER': 'cltbld', 20:01:50 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467860149.775553-1015131102', 20:01:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:50 INFO - '_': '/tools/buildbot/bin/python'} 20:01:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:50 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:01:50 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:01:50 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:01:50 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:01:50 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:01:50 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:01:50 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:01:50 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:01:50 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:01:50 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:01:50 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:01:50 INFO - Cleaning up... 20:01:50 INFO - Return code: 0 20:01:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd77030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1038180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10363b0>, '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 0x10372b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037740>, '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': 'db7e7c15f3ca076d53731445000001ba-1467860149.775553-1015131102', '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:01:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:01:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:01:50 INFO - Using env: {'DISPLAY': ':0', 20:01:50 INFO - 'HOME': '/home/cltbld', 20:01:50 INFO - 'LANG': 'en_US.UTF-8', 20:01:50 INFO - 'LANGUAGE': 'en_US:en', 20:01:50 INFO - 'LOGNAME': 'cltbld', 20:01:50 INFO - 'MAIL': '/var/mail/cltbld', 20:01:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:50 INFO - 'MOZ_NO_REMOTE': '1', 20:01:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:50 INFO - 'NO_EM_RESTART': '1', 20:01:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:50 INFO - 'PWD': '/builds/slave/test', 20:01:50 INFO - 'SHELL': '/bin/bash', 20:01:50 INFO - 'SHLVL': '1', 20:01:50 INFO - 'TERM': 'linux', 20:01:50 INFO - 'TMOUT': '86400', 20:01:50 INFO - 'USER': 'cltbld', 20:01:50 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467860149.775553-1015131102', 20:01:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:50 INFO - '_': '/tools/buildbot/bin/python'} 20:01:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:01:51 INFO - Cleaning up... 20:01:51 INFO - Return code: 0 20:01:51 INFO - Running post-action listener: _resource_record_post_action 20:01:51 INFO - Running post-action listener: _start_resource_monitoring 20:01:51 INFO - Starting resource monitoring. 20:01:51 INFO - ##### 20:01:51 INFO - ##### Finished create-virtualenv step (success) 20:01:51 INFO - ##### 20:01:51 INFO - ##### 20:01:51 INFO - ##### Running install step. 20:01:51 INFO - ##### 20:01:51 INFO - Running pre-action listener: _resource_record_pre_action 20:01:51 INFO - Running main action method: install 20:01:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:01:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:01:51 INFO - Reading from file tmpfile_stdout 20:01:51 INFO - Detecting whether we're running mozinstall >=1.0... 20:01:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:01:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:01:51 INFO - Reading from file tmpfile_stdout 20:01:51 INFO - Output received: 20:01:51 INFO - Usage: mozinstall [options] installer 20:01:51 INFO - Options: 20:01:51 INFO - -h, --help show this help message and exit 20:01:51 INFO - -d DEST, --destination=DEST 20:01:51 INFO - Directory to install application into. [default: 20:01:51 INFO - "/builds/slave/test"] 20:01:51 INFO - --app=APP Application being installed. [default: firefox] 20:01:51 INFO - mkdir: /builds/slave/test/build/application 20:01:51 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:01:51 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:02:08 INFO - Reading from file tmpfile_stdout 20:02:08 INFO - Output received: 20:02:08 INFO - /builds/slave/test/build/application/firefox/firefox 20:02:08 INFO - Running post-action listener: _resource_record_post_action 20:02:08 INFO - ##### 20:02:08 INFO - ##### Finished install step (success) 20:02:08 INFO - ##### 20:02:08 INFO - ##### 20:02:08 INFO - ##### Running run-tests step. 20:02:08 INFO - ##### 20:02:08 INFO - Running pre-action listener: _resource_record_pre_action 20:02:08 INFO - Running main action method: run_tests 20:02:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:02:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:02:08 INFO - Python 2.7.3 20:02:08 INFO - Return code: 0 20:02:08 INFO - grabbing minidump binary from tooltool 20:02:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:08 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 0x10363b0>, '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 0x10372b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:02:08 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:02:08 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:02:08 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:02:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:02:08 INFO - Return code: 0 20:02:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:02:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:02:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:02:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:02:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:02:08 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-049', '--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:02:08 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-049 --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:02:08 INFO - Using env: {'DISPLAY': ':0', 20:02:08 INFO - 'HOME': '/home/cltbld', 20:02:08 INFO - 'LANG': 'en_US.UTF-8', 20:02:08 INFO - 'LANGUAGE': 'en_US:en', 20:02:08 INFO - 'LOGNAME': 'cltbld', 20:02:08 INFO - 'MAIL': '/var/mail/cltbld', 20:02:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:02:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:02:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:08 INFO - 'MOZ_NO_REMOTE': '1', 20:02:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:02:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:08 INFO - 'NO_EM_RESTART': '1', 20:02:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:08 INFO - 'PWD': '/builds/slave/test', 20:02:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:02:08 INFO - 'SHELL': '/bin/bash', 20:02:08 INFO - 'SHLVL': '1', 20:02:08 INFO - 'TERM': 'linux', 20:02:08 INFO - 'TMOUT': '86400', 20:02:08 INFO - 'USER': 'cltbld', 20:02:08 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467860149.775553-1015131102', 20:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:08 INFO - '_': '/tools/buildbot/bin/python'} 20:02:08 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-049', '--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:02:08 INFO - mozversion application_buildid: 20160706173002 20:02:08 INFO - mozversion application_changeset: 1dd03896ee5f2165822f36235523e39394826531 20:02:08 INFO - mozversion application_display_name: Nightly 20:02:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:02:08 INFO - mozversion application_name: Firefox 20:02:08 INFO - mozversion application_remotingname: firefox 20:02:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:02:08 INFO - mozversion application_vendor: Mozilla 20:02:08 INFO - mozversion application_version: 50.0a1 20:02:08 INFO - mozversion platform_buildid: 20160706173002 20:02:08 INFO - mozversion platform_changeset: 1dd03896ee5f2165822f36235523e39394826531 20:02:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:02:08 INFO - mozversion platform_version: 50.0a1 20:02:08 INFO - using testdate: 1467860528 20:02:08 INFO - actual date: 1467860528 20:02:08 INFO - starting webserver on 'localhost:38238' 20:02:08 INFO - SUITE-START | Running 2 tests 20:02:08 INFO - TEST-START | dromaeo_css 20:02:08 INFO - operating with platform_type : linux_ 20:02:08 INFO - Initialising browser for dromaeo_css test... 20:02:08 INFO - TEST-INFO | started process 2095 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmposm4US/profile http://localhost:38238/getInfo.html) 20:02:12 INFO - PROCESS | 2095 | __metrics Screen width/height:1600/1200 20:02:12 INFO - PROCESS | 2095 | colorDepth:24 20:02:12 INFO - PROCESS | 2095 | Browser inner width/height: 1024/697 20:02:12 INFO - PROCESS | 2095 | __metrics 20:02:14 INFO - PROCESS | 2095 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:02:14 INFO - TEST-INFO | 2095: exit 0 20:02:14 INFO - Browser initialized. 20:02:14 INFO - Running cycle 1/1 for dromaeo_css test... 20:02:14 INFO - TEST-INFO | started process 2179 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmposm4US/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:02:26 INFO - PROCESS | 2179 | RSS: Main: 157102080 20:02:26 INFO - PROCESS | 2179 | 20:03:17 INFO - PROCESS | 2179 | 1467860597452 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:05:26 INFO - PROCESS | 2179 | Cycle 1(1): loaded http://localhost:38238/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38238/tests/dromaeo/cssquery-ext.html) 20:05:27 INFO - PROCESS | 2179 | RSS: Main: 243322880 20:05:27 INFO - PROCESS | 2179 | 20:08:30 INFO - PROCESS | 2179 | Cycle 1(1): loaded http://localhost:38238/tests/dromaeo/cssquery-ext.html (next: http://localhost:38238/tests/dromaeo/cssquery-jquery.html) 20:08:30 INFO - PROCESS | 2179 | RSS: Main: 242978816 20:08:30 INFO - PROCESS | 2179 | 20:11:32 INFO - PROCESS | 2179 | Cycle 1(1): loaded http://localhost:38238/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38238/tests/dromaeo/cssquery-mootools.html) 20:11:33 INFO - PROCESS | 2179 | RSS: Main: 239386624 20:11:33 INFO - PROCESS | 2179 | 20:14:35 INFO - PROCESS | 2179 | Cycle 1(1): loaded http://localhost:38238/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38238/tests/dromaeo/cssquery-prototype.html) 20:14:35 INFO - PROCESS | 2179 | RSS: Main: 245932032 20:14:35 INFO - PROCESS | 2179 | 20:17:38 INFO - PROCESS | 2179 | Cycle 1(1): loaded http://localhost:38238/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38238/tests/dromaeo/cssquery-yui.html) 20:17:39 INFO - PROCESS | 2179 | RSS: Main: 223166464 20:17:39 INFO - PROCESS | 2179 | 20:20:42 INFO - PROCESS | 2179 | Cycle 1(1): loaded http://localhost:38238/tests/dromaeo/cssquery-yui.html (next: http://localhost:38238/tests/dromaeo/cssquery-dojo.html) 20:20:42 INFO - PROCESS | 2179 | RSS: Main: 286089216 20:20:42 INFO - PROCESS | 2179 | 20:20:42 INFO - PROCESS | 2179 | __start_tp_report 20:20:42 INFO - PROCESS | 2179 | _x_x_mozilla_page_load 20:20:42 INFO - PROCESS | 2179 | _x_x_mozilla_page_load_details 20:20:42 INFO - PROCESS | 2179 | |i|pagename|runs| 20:20:42 INFO - PROCESS | 2179 | |0;dojo.html;3119.5164749463843;3123.125524853041;3142.858571364287;3151.5272709093642;3156.558081868539;5254.238135470364;5298.682079075258;5362.35651721793;5444.183372494128;5447.155690867917;5378.112611419121;5396.514313711765;5448.91826622601;5473.0969390050595;5514.393416724157;4920.040592084554;4941.604671626261;4948.529889660476;5036.068327359432;5119.718415487147;5019.247112933052;5061.240813877929;5072.695638261697;5084.542391184793;5087.084324821531;4875;4885.145099607572;4905.215165573527;4918.04098200851;5045.596352291826;4955.876103097416;4963.726995015273;4967.205247160473;4970.279309500138;5026.497350264981;4982.60139188864;5013.849584512434;5018.47306032865;5019.447860735316;5040.621953353513;5318.202269659543;5325.627206095575;5393.056215162331;5394.838154855361;5587.1339942309005;5770.538356931477;5773.047447171254;5777.537796976274;5794.68129252891;5826.038703613898;5910.586258961875;5915.3788852170765;5931.495822855062;5932.9406705932815;5934.970325148347;5357.357117145967;5370.865728356784;5371.328583927009;5391.487808658171;5468.4531546845;5969.313528944227;5969.373215812364;5973;5973.49225315853;5974.3726908674835;5686.346070201897;5727.31272247333;5728.226689396962;5735.3977832327;5736.827895163152;5774.68239246837;5825.563082768809;5832.737526811304;5909.527237820964;5914.674692891932;5837.9124313135335;5837.941620583825;5840.59115861894;5842.737076831553;5844.795432159854;5665.3768085510565;5741.282339707536;5799.8550036249435;5863.794767183128;5867.706614669335;4415.690901636919;4453.1316393303;4460.8661740147845;4482.686211965196;4492.303692927601;3968.345223038224;3970.3845903884944;3983.521977362735;3996.220736956324;4009.3985902114914;5353.785848566092;5402.945970540323;5481.123020316731;5524.06090964537;5528.336599608073;5733.77064917407;5779.3642699303045;5789.594728368974;5833.533317334603;5835.095560188178;5435.945640543544;5490.505854473116;5494.2582751328055;5499.092649712833;5499.560035197174;4958.057968985881;4996.800127994912;5020.7740651670765;5021.472745361684;5064.240363945438;6009.429104235091;6093.329733729375;6093.715917428453;6099.672983688876;6142.170806941006;5871.060630299132;5873.4126587340925;5876.471117599436;5877.294724633071;5878.882422351615;5850.882982340244;5864.266966629171;5911.467967882912;6075.27096748393;6086.665233412028;5664.688442135722;5681.17622944679;5683.147527870852;5684.63049901755;5725.255716756795;5720.771169153188;5773.826785196451;5776.075827867521;5778;5781.335146458211;5512.090505066619;5616.4383561645145;5644.887102258014;5684.175794509855;5699.5725320600295;5707.7716891325545;5710.628809127394;5719.857003574777;5719.942800572107;5726.255586773693;5594.720263986866;5614.606977511535;5643.407442218508;5644.096944488862;5647.887042259214;5575.860603484945;5605.747741351731;5643.661380317194;5662.065759149694;5689.857753556194;5558.777648893999;5576;5577.972110139423;5583.832485025456;5604.971975140098 20:20:42 INFO - PROCESS | 2179 | |1;ext.html;601.0923505506684;616.1497133955141;635.2091645900853;636.6975686548886;653.5947712418301;31105;31626.525602115988;33631.49552756704;33779.98660040199;33824.49263261053;44243.77878110613;45582.77208613961;45891;49176;49319;8982.910170898305;9103.180713735763;9105.226055785266;9113.635454581809;9118.270538356915;9012.459252444842;9101.590428430736;9104.863427048567;9114.680986165486;9114.817703645924;9152.72541823743;9159.908400915972;9164.541772911361;9209.95395023024;9213.2168765655;9062.45625262483;9068.68259610917;9116.772080697969;9140.680076197368;9142.314326425545;8994.460332380078;9063.50150741709;9066.682666106655;9066.727998160066;9069.863952040725;44133.77933110346;44526.33210501845;44530.33204501935;44531;44554;3655.4516822476576;3754.624537546251;3817.6564109230026;3926.2343842950636;4190.916181676349;32653.972253498065;33376.3324733504;33537.83231083853;34207.4868876967;34336.313273734384;4383.430154079981;4397.824087036514;4477.843275485342;4583.4041574595085;4589.586937175637;251372;252049;252092.73953630298;252150;252767;59413.40586594079;60005.69997150073;60258;60301.69849150814;60378.69810650919;54165;59780.608775648485;62219.37780622226;62308.68845655743;67110.6244906733;17789;17969.460916172535;17971.37100201487;17984.910075449538;17997.820021799875;12613.621591352274;13663.111897726814;13746.381412836447;13752.31238438074;13757.862421375858;13492.59522214335;13650.385732642055;13840.723185536433;14028.158310501403;14173.574792756233;6589.670516474157;6655.134832471747;6660.666966651648;6676.26561078281;6854.417374523122;972.7957129002847;1045.2421994054403;1068.8503609494676;1102.963214578294;1146.3007565385108;33005.834970825475;33066.66933330684;33326.833365833016;33382.33235335328;33576;1118.5022664914197;1124.8144056230794;1157.022316142858;1189.9107566932514;1202.9518819247307;17201.913990429966;17410.56473588145;17444.651106977788;17600.91199543994;17623.356496525623;536268;540942;542428;544364;545564;60729.69635151796;60785.392146078855;60965.69517152475;61002.38997610056;61082.694586526784;1219.7560487902456;1363.4750621010983;1373.5604606525815;1399.4052527675901;1400.4678222275675;33231.833840831605;34595.82702086474;34736.82631586826;34751.65248347484;34811.65188348084;52060.73969630127;52179.47820521746;52704.736476317375;52722.736386317825;52775.73612131915;367503;367851;367893;370069;370098;35742.64257357393;41074.383884241164;42375.8218133635;42723.7863810679;46316;49262;49932.750336248086;50246;51374.22938655998;51391.22913156381;42307.36538951856;42756.78621606872;43518.347224792284;43882.780586096866;44774;43222.351664724425;43330.56669433265;43350.13299733924;43907.560924391626;44100.00499026974;42193.578064218964;42749.145017100105;42884.78557607192;42930.78534607307;42961.14077718365;35689.64310356863;37448;37845.243095138496;38342.23315533729;38360.80819595884;28661.283467912635;28708.569371459027;28909.277268068465;29019.41961160807;29074.27314317159 20:20:42 INFO - PROCESS | 2179 | |2;jquery.html;388.3708392404305;391.823679344295;393.4197059337476;396.6588733689028;410.73507587605997;18448;19294.228230870747;20202.19191232349;20217.292394766187;20247.291344802936;18802.623947521075;19026.14382352794;19351.129199186034;19602.41192764216;19632.70550941737;5185.740712964355;5222.92165617516;5274.340707411574;5340.118880384732;5345.946540534604;5290.947090529084;5294.629375943667;5305.071612467803;5308.575313974873;5315.760790764405;5084.872878178056;5213.244079608455;5246.763895624687;5306.283651707009;5335.413104558495;5127.743612819363;5152.407473140562;5156.303898973647;5157.587393008588;5192.740362981855;5012.974935125338;5104.821331253388;5263.36839579253;5266.683998960075;5281.973590132025;13788;14134.15195088298;14140.858591414057;14226.502072427415;14418.495352662607;2352.235523454884;2394.1859767678898;2489;2833.3766571354267;2997.5203967365337;9955.452450115241;10053;10394;10451.895481045169;10677.893221067845;1970.4778233768063;2071.658176400892;2079.781622929586;2079.9480012999798;2083.864548804323;80591.597042015;81053.59473202596;82753;83970;84745.99999999939;10680.305780124267;10730.141588673043;11144.049791286492;11199.832002519968;11445.88554114465;15227.162506062274;15289;15340.309686064154;15376.53870383868;15383.692326153414;7878.290953814069;7916.7229146980735;7936.722214722457;8158.388120890957;8206.712765053195;7671.654775535114;7700.768976930701;7706.961465192639;7871.252231038042;7901.288884000468;4725.881852953635;4728.739919304402;4742.170120228946;4790.161721698689;4793.257045158006;1927.6144771045567;1945.3483083167014;1969.6848504239254;1997.8002199779905;2038.6126635939124;867.1761826265074;933.5612262236738;951.1629765806047;980.6077568972325;1046.6964580271635;18812;19995.60008799816;20024.199032038556;20371.069682394587;20408.28571000008;1025.5743866295404;1062.123747907979;1082.2153938394601;1087.211771465681;1087.3095584303867;10547.683569492927;11065.170112241452;11071.391073491035;11131.996240676755;11179.83230251547;475265;475701;477732;483826;484164;92308;92963.53518232501;96807.51596241974;98111.50944245375;103686.48156759319;987.195435719886;999.4503023337136;1017.6438246613626;1022.7340891368298;1039.184240371305;17271.913640431718;17480.21339039721;17771.82228177702;17949.641007180046;18072.186751595946;40958.18083638251;41323.38014929718;41457.79271103625;42865.57134428616;43577;58377.037951774575;58582;59485.702571486865;59857.40142598518;63600.363996361295;7696.422768292512;8100.837983240184;8309;8600.913990860012;8926.419782714103;10507.684769456928;14447.277636118362;14449.277536122941;14531.346089426213;14672.266386680836;5817.9127313091185;11983.580574679845;12273.938630307148;12294.262344259372;12565.623031309075;11710.297382157098;12131.878681213428;12164.878351216375;12538.561150359694;12575.245485270912;11557.88442115568;11709;12207.816882746589;12318;12523.248605083723;7882.09355924076;8131.0649275331725;8262.17378262169;8333.791655208668;8507.659693612186;6064.545159112996;11526.827097593376;11647.534098635959;11702.473388697359;11923.224990375598 20:20:42 INFO - PROCESS | 2179 | |3;mootools.html;1345.273552281768;1471.4555614422661;1513.3568233500762;1636.5663099278686;1788.09701100944;8320.459170153943;8789.208971192584;8792.252658524025;9045.27637788977;9060.184583387494;8760.430572012814;8919.063498332678;8959.865602015974;8973.147550982663;8985.730428087169;2074.388055523624;2147.892605369725;2148.3125399872047;2331.4287999440116;2378.1200955646436;2153.052656830997;2160.7299087614047;2332.615118505453;2388.7491813359607;2394.7006624171977;2359.304005318427;2379.8929048192786;2397.376682062659;2403.7115546134487;2403.8677872716994;1998.1407994562333;2248.8875556222206;2254.9436264093283;2256.289268880314;2256.650219216024;2252.5044490212126;2325.093213646679;2329.23135365329;2341.0635745701684;2345.648152777097;9020.278377729832;9091.27269818413;9100.863487047633;9104.68133615327;9109.407888487227;5397.8110766123;5522.502974732253;5536.363318218416;5538.224648549206;5542.528885044776;3253.951190732117;3322;3400.3539327527938;3402.761806673534;3406.7955922644474;1064.276292121357;1085.733995171188;1121.1927412263158;1122.9213955023151;1129.13056946151;12958.870411295955;12986.870131298756;13005.804912926315;13012.414441350162;13021.153625014344;4802.51974802517;4861.319415281792;4869.853904382874;4892.119418504632;4969.204927211629;11024.228304018801;11063.668089957315;11069.50187241576;11076.446177691245;11108.277961932448;5474.644148130359;5519;5520.834374968677;5526.115821468627;5533.059379905426;4891.364122664102;4995.375578052744;5030.622703297194;5048.495150484922;5048.823291184791;4140.109876376593;4145.606167414091;4152.356384760367;4223.429836971969;4230.64039556635;1255.8372165576423;1330.4611632288938;1334.2261488336742;1335.306398010992;1339.799030145486;878.3280790195505;985.6698006168014;994.4928086675848;1017.8447462130536;1029.361795686679;6238.282597501346;6303.653299068504;6516.315786842313;6527.640979746065;6571.047198156336;473.4697139204113;477.40562999066384;478.9185838407479;485.6794515619674;491.1012846490913;4423.845165419195;4540.8637740867825;4552.271636538138;4581.221192397234;4596.5863072323655;10734.892651073545;10969.122470202365;11233.494492747846;11332.773344533063;11338.716532086764;10771.246012779031;10778.245522813328;10796.67609971702;10807.567697292021;10834.07910327631;8193.918060819435;8511.148885111563;8567.828643427096;8682.262007729287;8729.127087291094;6067.605605635619;6460.903086453613;6579.967100164468;6604.636744979072;6656.201255849329;10752.086072683596;10903.563857445613;11004.779904402027;11014.724631883946;11031.558737650405;9602.423854568748;9728.75678108053;9864.753381165241;10104.736907886514;10110.79778404413;8079.474834135763;8239.588020599065;8434.873476897728;8620.655173792979;8643.049264581017;8460.661573536989;8778.868316975122;8842;8851.291896648125;9133.862992054992;7816.296533311802;7948.16544262844;8082.636281367235;8164.061132969785;8177.509349439053;7572.8485430292185;7791.337736292478;7831.490953088031;7880.408969327438;7915.0897646771355;7384.630768461663;7389.371903388273;7465.253474652709;7470.252974702704;7472.701091956261;4614.561616646413;5436.293281873489;5630.549556035589;5648.350439699487;5790.971045144747;5514.6691198528215;5525;5663.801766938137;5735.283089613798;5905.498032667271 20:20:42 INFO - PROCESS | 2179 | |4;prototype.html;328.44820701221954;332.59921794237937;341.06207928197455;342.6659007467721;343.53794146872445;5309.123994540906;5313.38896026957;5321.813736519222;5329.760160792764;5337.546308563772;5273.288106105674;5284.788608455658;5286.013402427626;5288.524032837044;5299.28459657946;3964.255727479914;3989.640932316091;4121.619257548725;4145.502539695241;4171;4107.835686572534;4152.771597562133;4156.251874662559;4157.5010998680045;4169.833206671745;3926.3521518949337;4127.525334586516;4134.689898257643;4139.1100913303635;4142.97928510357;4006.1787333596544;4100.753954762694;4127.40152677863;4137.565555616678;4142.1922725068625;3650.689691376236;3650.7444478886487;3651.94522082169;3654.4701018352457;3681.889543313705;5152.768125434364;5176.6117541184185;5184.844454666329;5196.194589838581;5196.45437229093;4472.262076757331;4702.083093796711;4715.811367545294;4734.2425211966265;4736.4316282046375;5486.231927530149;5494.642848214893;5520.309961254843;5528.778848846041;5532.921080389326;3812.1041555234497;3964.266610677034;3966.849613612049;3970.7419017763755;3976.483057202574;5708.71456427177;5738.245642091778;5749.540036797088;5750.367459579443;5760.855978600526;4047;4050.3924411338535;4059.3910913362643;4065.5121385433936;4067.3288907330552;3904.921901561953;4081.510218773766;4087.5912408758886;4094.733842300241;4103.281925662997;4682.367880336179;4685.586922734794;4691.929621055687;4707.741074240949;4709.670323077352;5552.4181255716285;5595;5602.159676048544;5607.243022192033;5618.061768689796;1356.3828458051562;1412.5832879300426;1424.2522675595396;1428.114568967247;1431.9642008949652;877.3902138014147;890.247740659142;897.2239013253488;955.073578628729;958.3770549142973;5285.445028272053;5291.365036195682;5297.867553311121;5301.310829592206;5314.176302673091;5594.552435805126;5603.831885043455;5603.954556586817;5627.242651100931;5635.295588051494;5155.304033955443;5285.207218917193;5301.920471192935;5439.3200849893765;5440.564754819605;3010.3377257003426;3015.703247603508;3026.8486575671127;3038.316378814749;3041.5893854329383;5668.914966275509;5868.413158684098;5882.264716910387;5883;5894;5823.708814559255;5829.766809327664;5856.209411729362;5859.589828712034;5871.266091738533;5837.532997360286;5881;5893.3793206867595;5895.970520147286;5914.615549989323;5427.5657947363325;5637.915431268616;5661.716914154358;5680.2047713321;5745.540356771532;5672.688002159921;5676.403977582295;5692.345380281155;5695.7436915338085;5707.600467967202;5693.829185124453;5864.794732184524;5890.3226128994;5916.73374698131;5938.703064846827;4069.348904175318;4085.5301640310554;4093.9385909211983;4096.692748043849;4097.344424892003;5718.428157184415;5733.168690539765;5733.426657334233;5736.623210429383;5745.6552606843725;5439.347278326626;5538.6399884007415;5565.582581306499;5566.554675626021;5572.718274796738;5548.611597188158;5557.666540007613;5561.6384934980715;5585.207396301849;5588.497035266845;5238.292830467838;5251.921221181609;5490.0941344677685;5506.752196151103;5516.310461192351;5536.695481748381;5568.972155139199;5603.327600687943;5617.494425501724;5623.550115990629;5485.862853428696;5488.670679759227;5492.5331346835965;5507.256520369699;5532.557395408438 20:20:42 INFO - PROCESS | 2179 | |5;yui.html;760.418280015788;761.6077719974211;808.1837344282274;816.9449230586417;847.7287268074218;16839.32642694291;17752.201150948207;17755;17773.466795996108;17835.46493605192;15723.056616603011;15934.920325398356;15946;15967;15985.680286394265;663.4128796015536;790.0558832195514;791.6951973490219;804.8148925747082;807.588130053671;803.7106641609016;804.2239239134234;805.899262592176;805.9435839491209;806.9515829050247;855.9871601925976;864.5979619476942;865.5196366016858;865.7705707987388;866.9739907802776;699.8705239530703;849.1762989899787;851.5231470376547;860.6084231674604;861.6381119929645;619.1486705779553;620.4013127332146;620.6307247187916;621.0125899819263;621.1707370660174;15396.461123860723;15425.305861236271;15451.150186739726;15461.381544738197;15473.690526189526;14649.121052736764;15017.474388396464;15029.924850375788;15154.469593564283;15200.16399098049;13182.67043323915;13258.204507729568;13307.66730831737;13329.533466328729;13884.652883677887;4439.977800111011;4456.55434456555;4503.707259028152;4613.031263434683;4706.5293470653005;77382;77756.22243777546;78339.21660783433;78441.21558784397;81300;12022.879771202175;12105.939470302592;12143.332116733487;12259.325737084546;12287.815682764765;22867.542649146922;22882.542349152925;22892;22901.08395664188;23005.88497057504;8987.685431010013;8993;9191.402558833654;9218.677346292847;9476.099770521789;4926.4088309403105;4959.132151873408;4990.451050384455;5019.161087335754;5285.365756109215;3524.718022558189;3636.3636363636256;3637.7635453695425;3638.9818050910108;3643;644;645.0775391190642;650.6844180572418;659.5943494750694;679.748493057562;571.7741492110594;710.7299226294078;711.6020999726348;735.4998600951404;741.1735914455451;9251.953740231256;9448.291378146667;9490.525473726286;9769.218462522982;9792.314537982273;706.6113637499458;713.3686687281689;716.6810769207757;728.639323534843;734.3390948146711;4468.79890404926;4722.173619616553;4763.380760501182;4800.759962001886;4814.7833347499445;119683.40158299153;120631.39684301698;122554;123642;124109;84440.57779711061;102596.48701756593;102752;103588;104313.47843260887;78437;92414;92557;93407;96665.51667241618;8858.822823543622;8871.290296776371;8873.73378798637;8970.282377409922;9078.954605226932;46748;47019.52980470152;54849.45150548603;56018.719906400205;57008.714956424956;47900.7604961973;50593.24110138277;53140.2028969558;63004.36995629985;71386;14153.929230353782;14167;14246.35891384911;14469.638259043608;14580.781288280896;15581.454649087227;15677.451289204822;15920.76118858195;16048.438304659281;16777;14757.704845903236;15110;15126.848731512984;15192.316345764688;15634.218289085728;14324.427022919383;14933.178675172536;14981.250937452865;15017.023893447327;15160.772588410962;13625.182489050689;14042.859571404564;14383.712325753217;14538.491152810024;14687.339069742102;12030.15788894769;12192.51229950792;12330.691732706755;12703.809442858179;12873.22760634365;11554.364509951698;12458.501659933501;12563.18339307942;12605.747885042065;12657.87342126567 20:20:42 INFO - PROCESS | 2179 | __end_tp_report 20:20:42 INFO - PROCESS | 2179 | __start_cc_report 20:20:42 INFO - PROCESS | 2179 | _x_x_mozilla_cycle_collect,1049 20:20:42 INFO - PROCESS | 2179 | __end_cc_report 20:20:42 INFO - PROCESS | 2179 | __startTimestamp1467861642335__endTimestamp 20:20:42 INFO - PROCESS | 2179 | 20:20:42 INFO - PROCESS | 2179 | ------- Summary: start ------- 20:20:42 INFO - PROCESS | 2179 | Number of tests: 6 20:20:42 INFO - PROCESS | 2179 | 20:20:42 INFO - PROCESS | 2179 | [#0] dojo.html Cycles:165 Average:5404.97 Median:5604.97 stddev:608.40 (10.9%) stddev-sans-first:583.25 20:20:42 INFO - PROCESS | 2179 | Values: 3119.5 3123.1 3142.9 3151.5 3156.6 5254.2 5298.7 5362.4 5444.2 5447.2 5378.1 5396.5 5448.9 5473.1 5514.4 4920.0 4941.6 4948.5 5036.1 5119.7 5019.2 5061.2 5072.7 5084.5 5087.1 4875.0 4885.1 4905.2 4918.0 5045.6 4955.9 4963.7 4967.2 4970.3 5026.5 4982.6 5013.8 5018.5 5019.4 5040.6 5318.2 5325.6 5393.1 5394.8 5587.1 5770.5 5773.0 5777.5 5794.7 5826.0 5910.6 5915.4 5931.5 5932.9 5935.0 5357.4 5370.9 5371.3 5391.5 5468.5 5969.3 5969.4 5973.0 5973.5 5974.4 5686.3 5727.3 5728.2 5735.4 5736.8 5774.7 5825.6 5832.7 5909.5 5914.7 5837.9 5837.9 5840.6 5842.7 5844.8 5665.4 5741.3 5799.9 5863.8 5867.7 4415.7 4453.1 4460.9 4482.7 4492.3 3968.3 3970.4 3983.5 3996.2 4009.4 5353.8 5402.9 5481.1 5524.1 5528.3 5733.8 5779.4 5789.6 5833.5 5835.1 5435.9 5490.5 5494.3 5499.1 5499.6 4958.1 4996.8 5020.8 5021.5 5064.2 6009.4 6093.3 6093.7 6099.7 6142.2 5871.1 5873.4 5876.5 5877.3 5878.9 5850.9 5864.3 5911.5 6075.3 6086.7 5664.7 5681.2 5683.1 5684.6 5725.3 5720.8 5773.8 5776.1 5778.0 5781.3 5512.1 5616.4 5644.9 5684.2 5699.6 5707.8 5710.6 5719.9 5719.9 5726.3 5594.7 5614.6 5643.4 5644.1 5647.9 5575.9 5605.7 5643.7 5662.1 5689.9 5558.8 5576.0 5578.0 5583.8 5605.0 20:20:42 INFO - PROCESS | 2179 | 20:20:42 INFO - PROCESS | 2179 | [#1] ext.html Cycles:180 Average:56623.89 Median:43276.46 stddev:107521.95 (248.5%) stddev-sans-first:107741.30 20:20:42 INFO - PROCESS | 2179 | Values: 601.1 616.1 635.2 636.7 653.6 31105.0 31626.5 33631.5 33780.0 33824.5 44243.8 45582.8 45891.0 49176.0 49319.0 8982.9 9103.2 9105.2 9113.6 9118.3 9012.5 9101.6 9104.9 9114.7 9114.8 9152.7 9159.9 9164.5 9210.0 9213.2 9062.5 9068.7 9116.8 9140.7 9142.3 8994.5 9063.5 9066.7 9066.7 9069.9 44133.8 44526.3 44530.3 44531.0 44554.0 3655.5 3754.6 3817.7 3926.2 4190.9 32654.0 33376.3 33537.8 34207.5 34336.3 4383.4 4397.8 4477.8 4583.4 4589.6 251372.0 252049.0 252092.7 252150.0 252767.0 59413.4 60005.7 60258.0 60301.7 60378.7 54165.0 59780.6 62219.4 62308.7 67110.6 17789.0 17969.5 17971.4 17984.9 17997.8 12613.6 13663.1 13746.4 13752.3 13757.9 13492.6 13650.4 13840.7 14028.2 14173.6 6589.7 6655.1 6660.7 6676.3 6854.4 972.8 1045.2 1068.9 1103.0 1146.3 33005.8 33066.7 33326.8 33382.3 33576.0 1118.5 1124.8 1157.0 1189.9 1203.0 17201.9 17410.6 17444.7 17600.9 17623.4 536268.0 540942.0 542428.0 544364.0 545564.0 60729.7 60785.4 60965.7 61002.4 61082.7 1219.8 1363.5 1373.6 1399.4 1400.5 33231.8 34595.8 34736.8 34751.7 34811.7 52060.7 52179.5 52704.7 52722.7 52775.7 367503.0 367851.0 367893.0 370069.0 370098.0 35742.6 41074.4 42375.8 42723.8 46316.0 49262.0 49932.8 50246.0 51374.2 51391.2 42307.4 42756.8 43518.3 43882.8 44774.0 43222.4 43330.6 43350.1 43907.6 44100.0 42193.6 42749.1 42884.8 42930.8 42961.1 35689.6 37448.0 37845.2 38342.2 38360.8 28661.3 28708.6 28909.3 29019.4 29074.3 20:20:42 INFO - PROCESS | 2179 | 20:20:42 INFO - PROCESS | 2179 | [#2] jquery.html Cycles:180 Average:28668.39 Median:2915.45 stddev:79312.30 (2720.4%) stddev-sans-first:79506.37 20:20:42 INFO - PROCESS | 2179 | Values: 388.4 391.8 393.4 396.7 410.7 18448.0 19294.2 20202.2 20217.3 20247.3 18802.6 19026.1 19351.1 19602.4 19632.7 5185.7 5222.9 5274.3 5340.1 5345.9 5290.9 5294.6 5305.1 5308.6 5315.8 5084.9 5213.2 5246.8 5306.3 5335.4 5127.7 5152.4 5156.3 5157.6 5192.7 5013.0 5104.8 5263.4 5266.7 5282.0 13788.0 14134.2 14140.9 14226.5 14418.5 2352.2 2394.2 2489.0 2833.4 2997.5 9955.5 10053.0 10394.0 10451.9 10677.9 1970.5 2071.7 2079.8 2079.9 2083.9 80591.6 81053.6 82753.0 83970.0 84746.0 10680.3 10730.1 11144.0 11199.8 11445.9 15227.2 15289.0 15340.3 15376.5 15383.7 7878.3 7916.7 7936.7 8158.4 8206.7 7671.7 7700.8 7707.0 7871.3 7901.3 4725.9 4728.7 4742.2 4790.2 4793.3 1927.6 1945.3 1969.7 1997.8 2038.6 867.2 933.6 951.2 980.6 1046.7 18812.0 19995.6 20024.2 20371.1 20408.3 1025.6 1062.1 1082.2 1087.2 1087.3 10547.7 11065.2 11071.4 11132.0 11179.8 475265.0 475701.0 477732.0 483826.0 484164.0 92308.0 92963.5 96807.5 98111.5 103686.5 987.2 999.5 1017.6 1022.7 1039.2 17271.9 17480.2 17771.8 17949.6 18072.2 40958.2 41323.4 41457.8 42865.6 43577.0 58377.0 58582.0 59485.7 59857.4 63600.4 7696.4 8100.8 8309.0 8600.9 8926.4 10507.7 14447.3 14449.3 14531.3 14672.3 5817.9 11983.6 12273.9 12294.3 12565.6 11710.3 12131.9 12164.9 12538.6 12575.2 11557.9 11709.0 12207.8 12318.0 12523.2 7882.1 8131.1 8262.2 8333.8 8507.7 6064.5 11526.8 11647.5 11702.5 11923.2 20:20:42 INFO - PROCESS | 2179 | 20:20:42 INFO - PROCESS | 2179 | [#3] mootools.html Cycles:180 Average:6012.99 Median:4865.59 stddev:3449.55 (70.9%) stddev-sans-first:3441.39 20:20:42 INFO - PROCESS | 2179 | Values: 1345.3 1471.5 1513.4 1636.6 1788.1 8320.5 8789.2 8792.3 9045.3 9060.2 8760.4 8919.1 8959.9 8973.1 8985.7 2074.4 2147.9 2148.3 2331.4 2378.1 2153.1 2160.7 2332.6 2388.7 2394.7 2359.3 2379.9 2397.4 2403.7 2403.9 1998.1 2248.9 2254.9 2256.3 2256.7 2252.5 2325.1 2329.2 2341.1 2345.6 9020.3 9091.3 9100.9 9104.7 9109.4 5397.8 5522.5 5536.4 5538.2 5542.5 3254.0 3322.0 3400.4 3402.8 3406.8 1064.3 1085.7 1121.2 1122.9 1129.1 12958.9 12986.9 13005.8 13012.4 13021.2 4802.5 4861.3 4869.9 4892.1 4969.2 11024.2 11063.7 11069.5 11076.4 11108.3 5474.6 5519.0 5520.8 5526.1 5533.1 4891.4 4995.4 5030.6 5048.5 5048.8 4140.1 4145.6 4152.4 4223.4 4230.6 1255.8 1330.5 1334.2 1335.3 1339.8 878.3 985.7 994.5 1017.8 1029.4 6238.3 6303.7 6516.3 6527.6 6571.0 473.5 477.4 478.9 485.7 491.1 4423.8 4540.9 4552.3 4581.2 4596.6 10734.9 10969.1 11233.5 11332.8 11338.7 10771.2 10778.2 10796.7 10807.6 10834.1 8193.9 8511.1 8567.8 8682.3 8729.1 6067.6 6460.9 6580.0 6604.6 6656.2 10752.1 10903.6 11004.8 11014.7 11031.6 9602.4 9728.8 9864.8 10104.7 10110.8 8079.5 8239.6 8434.9 8620.7 8643.0 8460.7 8778.9 8842.0 8851.3 9133.9 7816.3 7948.2 8082.6 8164.1 8177.5 7572.8 7791.3 7831.5 7880.4 7915.1 7384.6 7389.4 7465.3 7470.3 7472.7 4614.6 5436.3 5630.5 5648.4 5791.0 5514.7 5525.0 5663.8 5735.3 5905.5 20:20:42 INFO - PROCESS | 2179 | 20:20:42 INFO - PROCESS | 2179 | [#4] prototype.html Cycles:180 Average:4673.24 Median:5313.78 stddev:1379.00 (26.0%) stddev-sans-first:1343.76 20:20:42 INFO - PROCESS | 2179 | Values: 328.4 332.6 341.1 342.7 343.5 5309.1 5313.4 5321.8 5329.8 5337.5 5273.3 5284.8 5286.0 5288.5 5299.3 3964.3 3989.6 4121.6 4145.5 4171.0 4107.8 4152.8 4156.3 4157.5 4169.8 3926.4 4127.5 4134.7 4139.1 4143.0 4006.2 4100.8 4127.4 4137.6 4142.2 3650.7 3650.7 3651.9 3654.5 3681.9 5152.8 5176.6 5184.8 5196.2 5196.5 4472.3 4702.1 4715.8 4734.2 4736.4 5486.2 5494.6 5520.3 5528.8 5532.9 3812.1 3964.3 3966.8 3970.7 3976.5 5708.7 5738.2 5749.5 5750.4 5760.9 4047.0 4050.4 4059.4 4065.5 4067.3 3904.9 4081.5 4087.6 4094.7 4103.3 4682.4 4685.6 4691.9 4707.7 4709.7 5552.4 5595.0 5602.2 5607.2 5618.1 1356.4 1412.6 1424.3 1428.1 1432.0 877.4 890.2 897.2 955.1 958.4 5285.4 5291.4 5297.9 5301.3 5314.2 5594.6 5603.8 5604.0 5627.2 5635.3 5155.3 5285.2 5301.9 5439.3 5440.6 3010.3 3015.7 3026.8 3038.3 3041.6 5668.9 5868.4 5882.3 5883.0 5894.0 5823.7 5829.8 5856.2 5859.6 5871.3 5837.5 5881.0 5893.4 5896.0 5914.6 5427.6 5637.9 5661.7 5680.2 5745.5 5672.7 5676.4 5692.3 5695.7 5707.6 5693.8 5864.8 5890.3 5916.7 5938.7 4069.3 4085.5 4093.9 4096.7 4097.3 5718.4 5733.2 5733.4 5736.6 5745.7 5439.3 5538.6 5565.6 5566.6 5572.7 5548.6 5557.7 5561.6 5585.2 5588.5 5238.3 5251.9 5490.1 5506.8 5516.3 5536.7 5569.0 5603.3 5617.5 5623.6 5485.9 5488.7 5492.5 5507.3 5532.6 20:20:42 INFO - PROCESS | 2179 | 20:20:42 INFO - PROCESS | 2179 | [#5] yui.html Cycles:180 Average:21241.58 Median:25863.03 stddev:30288.78 (117.1%) stddev-sans-first:30334.70 20:20:42 INFO - PROCESS | 2179 | Values: 760.4 761.6 808.2 816.9 847.7 16839.3 17752.2 17755.0 17773.5 17835.5 15723.1 15934.9 15946.0 15967.0 15985.7 663.4 790.1 791.7 804.8 807.6 803.7 804.2 805.9 805.9 807.0 856.0 864.6 865.5 865.8 867.0 699.9 849.2 851.5 860.6 861.6 619.1 620.4 620.6 621.0 621.2 15396.5 15425.3 15451.2 15461.4 15473.7 14649.1 15017.5 15029.9 15154.5 15200.2 13182.7 13258.2 13307.7 13329.5 13884.7 4440.0 4456.6 4503.7 4613.0 4706.5 77382.0 77756.2 78339.2 78441.2 81300.0 12022.9 12105.9 12143.3 12259.3 12287.8 22867.5 22882.5 22892.0 22901.1 23005.9 8987.7 8993.0 9191.4 9218.7 9476.1 4926.4 4959.1 4990.5 5019.2 5285.4 3524.7 3636.4 3637.8 3639.0 3643.0 644.0 645.1 650.7 659.6 679.7 571.8 710.7 711.6 735.5 741.2 9252.0 9448.3 9490.5 9769.2 9792.3 706.6 713.4 716.7 728.6 734.3 4468.8 4722.2 4763.4 4800.8 4814.8 119683.4 120631.4 122554.0 123642.0 124109.0 84440.6 102596.5 102752.0 103588.0 104313.5 78437.0 92414.0 92557.0 93407.0 96665.5 8858.8 8871.3 8873.7 8970.3 9079.0 46748.0 47019.5 54849.5 56018.7 57008.7 47900.8 50593.2 53140.2 63004.4 71386.0 14153.9 14167.0 14246.4 14469.6 14580.8 15581.5 15677.5 15920.8 16048.4 16777.0 14757.7 15110.0 15126.8 15192.3 15634.2 14324.4 14933.2 14981.3 15017.0 15160.8 13625.2 14042.9 14383.7 14538.5 14687.3 12030.2 12192.5 12330.7 12703.8 12873.2 11554.4 12458.5 12563.2 12605.7 12657.9 20:20:42 INFO - PROCESS | 2179 | -------- Summary: end -------- 20:20:42 INFO - PROCESS | 2179 | 20:20:42 INFO - TEST-INFO | 2179: exit 0 20:20:43 INFO - TEST-OK | dromaeo_css | took 1114186ms 20:20:43 INFO - TEST-START | kraken 20:20:43 INFO - operating with platform_type : linux_ 20:20:43 INFO - Initialising browser for kraken test... 20:20:43 INFO - TEST-INFO | started process 2449 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoWu9L0/profile http://localhost:38238/getInfo.html) 20:20:46 INFO - PROCESS | 2449 | __metrics Screen width/height:1600/1200 20:20:46 INFO - PROCESS | 2449 | colorDepth:24 20:20:46 INFO - PROCESS | 2449 | Browser inner width/height: 1024/697 20:20:46 INFO - PROCESS | 2449 | __metrics 20:20:48 INFO - PROCESS | 2449 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:20:48 INFO - TEST-INFO | 2449: exit 0 20:20:48 INFO - Browser initialized. 20:20:48 INFO - Running cycle 1/1 for kraken test... 20:20:48 INFO - TEST-INFO | started process 2551 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoWu9L0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:21:00 INFO - PROCESS | 2551 | RSS: Main: 157122560 20:21:00 INFO - PROCESS | 2551 | 20:21:03 INFO - PROCESS | 2551 | Cycle 1(1): loaded http://localhost:38238/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38238/tests/kraken/driver.html?testName=audio-beat-detection) 20:21:03 INFO - PROCESS | 2551 | RSS: Main: 215642112 20:21:03 INFO - PROCESS | 2551 | 20:21:06 INFO - PROCESS | 2551 | Cycle 1(1): loaded http://localhost:38238/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38238/tests/kraken/driver.html?testName=audio-dft) 20:21:07 INFO - PROCESS | 2551 | RSS: Main: 202936320 20:21:07 INFO - PROCESS | 2551 | 20:21:10 INFO - PROCESS | 2551 | Cycle 1(1): loaded http://localhost:38238/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38238/tests/kraken/driver.html?testName=audio-fft) 20:21:10 INFO - PROCESS | 2551 | RSS: Main: 269402112 20:21:10 INFO - PROCESS | 2551 | 20:21:13 INFO - PROCESS | 2551 | Cycle 1(1): loaded http://localhost:38238/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38238/tests/kraken/driver.html?testName=audio-oscillator) 20:21:13 INFO - PROCESS | 2551 | RSS: Main: 180342784 20:21:13 INFO - PROCESS | 2551 | 20:21:15 INFO - PROCESS | 2551 | Cycle 1(1): loaded http://localhost:38238/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38238/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:21:16 INFO - PROCESS | 2551 | RSS: Main: 184623104 20:21:16 INFO - PROCESS | 2551 | 20:21:19 INFO - PROCESS | 2551 | Cycle 1(1): loaded http://localhost:38238/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38238/tests/kraken/driver.html?testName=imaging-darkroom) 20:21:19 INFO - PROCESS | 2551 | RSS: Main: 219381760 20:21:19 INFO - PROCESS | 2551 | 20:21:23 INFO - PROCESS | 2551 | Cycle 1(1): loaded http://localhost:38238/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38238/tests/kraken/driver.html?testName=imaging-desaturate) 20:21:23 INFO - PROCESS | 2551 | RSS: Main: 221192192 20:21:23 INFO - PROCESS | 2551 | 20:21:26 INFO - PROCESS | 2551 | Cycle 1(1): loaded http://localhost:38238/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38238/tests/kraken/driver.html?testName=json-parse-financial) 20:21:27 INFO - PROCESS | 2551 | RSS: Main: 221401088 20:21:27 INFO - PROCESS | 2551 | 20:21:28 INFO - PROCESS | 2551 | Cycle 1(1): loaded http://localhost:38238/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38238/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:21:29 INFO - PROCESS | 2551 | RSS: Main: 209158144 20:21:29 INFO - PROCESS | 2551 | 20:21:31 INFO - PROCESS | 2551 | Cycle 1(1): loaded http://localhost:38238/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38238/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:21:31 INFO - PROCESS | 2551 | RSS: Main: 213196800 20:21:31 INFO - PROCESS | 2551 | 20:21:33 INFO - PROCESS | 2551 | Cycle 1(1): loaded http://localhost:38238/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38238/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:21:34 INFO - PROCESS | 2551 | RSS: Main: 212234240 20:21:34 INFO - PROCESS | 2551 | 20:21:36 INFO - PROCESS | 2551 | Cycle 1(1): loaded http://localhost:38238/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:21:37 INFO - PROCESS | 2551 | RSS: Main: 224145408 20:21:37 INFO - PROCESS | 2551 | 20:21:40 INFO - PROCESS | 2551 | Cycle 1(1): loaded http://localhost:38238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:21:40 INFO - PROCESS | 2551 | RSS: Main: 221802496 20:21:40 INFO - PROCESS | 2551 | 20:21:42 INFO - PROCESS | 2551 | Cycle 1(1): loaded http://localhost:38238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38238/tests/kraken/driver.html?testName=ai-astar) 20:21:42 INFO - PROCESS | 2551 | RSS: Main: 264507392 20:21:42 INFO - PROCESS | 2551 | 20:21:42 INFO - PROCESS | 2551 | __start_tp_report 20:21:42 INFO - PROCESS | 2551 | _x_x_mozilla_page_load 20:21:42 INFO - PROCESS | 2551 | _x_x_mozilla_page_load_details 20:21:42 INFO - PROCESS | 2551 | |i|pagename|runs| 20:21:42 INFO - PROCESS | 2551 | |0;ai-astar;101;111;110;112;112;113;111;109;110;109 20:21:42 INFO - PROCESS | 2551 | |1;audio-beat-detection;143;118;119;173;117;117;148;116;165;122 20:21:42 INFO - PROCESS | 2551 | |2;audio-dft;160;163;159;161;161;160;160;161;161;160 20:21:42 INFO - PROCESS | 2551 | |3;audio-fft;76;74;75;124;74;74;74;74;114;74 20:21:42 INFO - PROCESS | 2551 | |4;audio-oscillator;83;83;112;83;83;84;112;84;84;122 20:21:42 INFO - PROCESS | 2551 | |5;imaging-gaussian-blur;117;117;116;117;117;118;116;117;117;116 20:21:42 INFO - PROCESS | 2551 | |6;imaging-darkroom;145;146;145;145;145;146;145;145;144;144 20:21:42 INFO - PROCESS | 2551 | |7;imaging-desaturate;96;94;95;94;94;94;94;94;95;95 20:21:42 INFO - PROCESS | 2551 | |8;json-parse-financial;53;50;54;51;52;52;51;52;52;52 20:21:42 INFO - PROCESS | 2551 | |9;json-stringify-tinderbox;61;62;62;62;62;61;61;62;61;62 20:21:42 INFO - PROCESS | 2551 | |10;stanford-crypto-aes;84;77;75;75;75;76;79;76;74;75 20:21:42 INFO - PROCESS | 2551 | |11;stanford-crypto-ccm;130;116;119;118;118;120;120;122;206;134 20:21:42 INFO - PROCESS | 2551 | |12;stanford-crypto-pbkdf2;160;153;158;159;155;152;156;159;155;156 20:21:42 INFO - PROCESS | 2551 | |13;stanford-crypto-sha256-iterative;63;61;63;61;61;65;62;60;61;60 20:21:42 INFO - PROCESS | 2551 | __end_tp_report 20:21:42 INFO - PROCESS | 2551 | __start_cc_report 20:21:42 INFO - PROCESS | 2551 | _x_x_mozilla_cycle_collect,1644 20:21:42 INFO - PROCESS | 2551 | __end_cc_report 20:21:42 INFO - PROCESS | 2551 | __startTimestamp1467861702729__endTimestamp 20:21:42 INFO - PROCESS | 2551 | 20:21:42 INFO - PROCESS | 2551 | ------- Summary: start ------- 20:21:42 INFO - PROCESS | 2551 | Number of tests: 14 20:21:42 INFO - PROCESS | 2551 | 20:21:42 INFO - PROCESS | 2551 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:3.36 (3.0%) stddev-sans-first:1.39 20:21:42 INFO - PROCESS | 2551 | Values: 101.0 111.0 110.0 112.0 112.0 113.0 111.0 109.0 110.0 109.0 20:21:42 INFO - PROCESS | 2551 | 20:21:42 INFO - PROCESS | 2551 | [#1] audio-beat-detection Cycles:10 Average:133.80 Median:132.50 stddev:21.82 (16.5%) stddev-sans-first:22.89 20:21:42 INFO - PROCESS | 2551 | Values: 143.0 118.0 119.0 173.0 117.0 117.0 148.0 116.0 165.0 122.0 20:21:42 INFO - PROCESS | 2551 | 20:21:42 INFO - PROCESS | 2551 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.07 (0.7%) stddev-sans-first:1.12 20:21:42 INFO - PROCESS | 2551 | Values: 160.0 163.0 159.0 161.0 161.0 160.0 160.0 161.0 161.0 160.0 20:21:42 INFO - PROCESS | 2551 | 20:21:42 INFO - PROCESS | 2551 | [#3] audio-fft Cycles:10 Average:83.30 Median:74.00 stddev:18.97 (25.6%) stddev-sans-first:19.94 20:21:42 INFO - PROCESS | 2551 | Values: 76.0 74.0 75.0 124.0 74.0 74.0 74.0 74.0 114.0 74.0 20:21:42 INFO - PROCESS | 2551 | 20:21:42 INFO - PROCESS | 2551 | [#4] audio-oscillator Cycles:10 Average:93.00 Median:83.00 stddev:15.66 (18.9%) stddev-sans-first:16.18 20:21:42 INFO - PROCESS | 2551 | Values: 83.0 83.0 112.0 83.0 83.0 84.0 112.0 84.0 84.0 122.0 20:21:42 INFO - PROCESS | 2551 | 20:21:42 INFO - PROCESS | 2551 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 20:21:42 INFO - PROCESS | 2551 | Values: 117.0 117.0 116.0 117.0 117.0 118.0 116.0 117.0 117.0 116.0 20:21:42 INFO - PROCESS | 2551 | 20:21:42 INFO - PROCESS | 2551 | [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 20:21:42 INFO - PROCESS | 2551 | Values: 145.0 146.0 145.0 145.0 145.0 146.0 145.0 145.0 144.0 144.0 20:21:42 INFO - PROCESS | 2551 | 20:21:42 INFO - PROCESS | 2551 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.50 stddev:0.71 (0.7%) stddev-sans-first:0.50 20:21:42 INFO - PROCESS | 2551 | Values: 96.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 95.0 95.0 20:21:42 INFO - PROCESS | 2551 | 20:21:42 INFO - PROCESS | 2551 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.00 stddev:1.10 (2.1%) stddev-sans-first:1.09 20:21:42 INFO - PROCESS | 2551 | Values: 53.0 50.0 54.0 51.0 52.0 52.0 51.0 52.0 52.0 52.0 20:21:42 INFO - PROCESS | 2551 | 20:21:42 INFO - PROCESS | 2551 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:62.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 20:21:42 INFO - PROCESS | 2551 | Values: 61.0 62.0 62.0 62.0 62.0 61.0 61.0 62.0 61.0 62.0 20:21:42 INFO - PROCESS | 2551 | 20:21:42 INFO - PROCESS | 2551 | [#10] stanford-crypto-aes Cycles:10 Average:76.60 Median:76.00 stddev:2.95 (3.9%) stddev-sans-first:1.48 20:21:42 INFO - PROCESS | 2551 | Values: 84.0 77.0 75.0 75.0 75.0 76.0 79.0 76.0 74.0 75.0 20:21:42 INFO - PROCESS | 2551 | 20:21:42 INFO - PROCESS | 2551 | [#11] stanford-crypto-ccm Cycles:10 Average:130.30 Median:121.00 stddev:27.20 (22.5%) stddev-sans-first:28.85 20:21:42 INFO - PROCESS | 2551 | Values: 130.0 116.0 119.0 118.0 118.0 120.0 120.0 122.0 206.0 134.0 20:21:42 INFO - PROCESS | 2551 | 20:21:42 INFO - PROCESS | 2551 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.30 Median:157.00 stddev:2.67 (1.7%) stddev-sans-first:2.47 20:21:42 INFO - PROCESS | 2551 | Values: 160.0 153.0 158.0 159.0 155.0 152.0 156.0 159.0 155.0 156.0 20:21:42 INFO - PROCESS | 2551 | 20:21:42 INFO - PROCESS | 2551 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.70 Median:61.50 stddev:1.57 (2.5%) stddev-sans-first:1.59 20:21:42 INFO - PROCESS | 2551 | Values: 63.0 61.0 63.0 61.0 61.0 65.0 62.0 60.0 61.0 60.0 20:21:42 INFO - PROCESS | 2551 | -------- Summary: end -------- 20:21:42 INFO - PROCESS | 2551 | 20:21:43 INFO - TEST-INFO | 2551: exit 0 20:21:43 INFO - TEST-OK | kraken | took 60742ms 20:21:43 INFO - SUITE-END | took 1174s 20:21:43 INFO - Completed test suite (00:19:35) 20:21:43 INFO - javascript benchmark 20:21:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3119.5164749463843, 3123.125524853041, 3142.858571364287, 3151.5272709093642, 3156.558081868539, 5254.238135470364, 5298.682079075258, 5362.35651721793, 5444.183372494128, 5447.155690867917, 5378.112611419121, 5396.514313711765, 5448.91826622601, 5473.0969390050595, 5514.393416724157, 4920.040592084554, 4941.604671626261, 4948.529889660476, 5036.068327359432, 5119.718415487147, 5019.247112933052, 5061.240813877929, 5072.695638261697, 5084.542391184793, 5087.084324821531, 4875.0, 4885.145099607572, 4905.215165573527, 4918.04098200851, 5045.596352291826, 4955.876103097416, 4963.726995015273, 4967.205247160473, 4970.279309500138, 5026.497350264981, 4982.60139188864, 5013.849584512434, 5018.47306032865, 5019.447860735316, 5040.621953353513, 5318.202269659543, 5325.627206095575, 5393.056215162331, 5394.838154855361, 5587.1339942309005, 5770.538356931477, 5773.047447171254, 5777.537796976274, 5794.68129252891, 5826.038703613898, 5910.586258961875, 5915.3788852170765, 5931.495822855062, 5932.9406705932815, 5934.970325148347, 5357.357117145967, 5370.865728356784, 5371.328583927009, 5391.487808658171, 5468.4531546845, 5969.313528944227, 5969.373215812364, 5973.0, 5973.49225315853, 5974.3726908674835, 5686.346070201897, 5727.31272247333, 5728.226689396962, 5735.3977832327, 5736.827895163152, 5774.68239246837, 5825.563082768809, 5832.737526811304, 5909.527237820964, 5914.674692891932, 5837.9124313135335, 5837.941620583825, 5840.59115861894, 5842.737076831553, 5844.795432159854, 5665.3768085510565, 5741.282339707536, 5799.8550036249435, 5863.794767183128, 5867.706614669335, 4415.690901636919, 4453.1316393303, 4460.8661740147845, 4482.686211965196, 4492.303692927601, 3968.345223038224, 3970.3845903884944, 3983.521977362735, 3996.220736956324, 4009.3985902114914, 5353.785848566092, 5402.945970540323, 5481.123020316731, 5524.06090964537, 5528.336599608073, 5733.77064917407, 5779.3642699303045, 5789.594728368974, 5833.533317334603, 5835.095560188178, 5435.945640543544, 5490.505854473116, 5494.2582751328055, 5499.092649712833, 5499.560035197174, 4958.057968985881, 4996.800127994912, 5020.7740651670765, 5021.472745361684, 5064.240363945438, 6009.429104235091, 6093.329733729375, 6093.715917428453, 6099.672983688876, 6142.170806941006, 5871.060630299132, 5873.4126587340925, 5876.471117599436, 5877.294724633071, 5878.882422351615, 5850.882982340244, 5864.266966629171, 5911.467967882912, 6075.27096748393, 6086.665233412028, 5664.688442135722, 5681.17622944679, 5683.147527870852, 5684.63049901755, 5725.255716756795, 5720.771169153188, 5773.826785196451, 5776.075827867521, 5778.0, 5781.335146458211, 5512.090505066619, 5616.4383561645145, 5644.887102258014, 5684.175794509855, 5699.5725320600295, 5707.7716891325545, 5710.628809127394, 5719.857003574777, 5719.942800572107, 5726.255586773693, 5594.720263986866, 5614.606977511535, 5643.407442218508, 5644.096944488862, 5647.887042259214, 5575.860603484945, 5605.747741351731, 5643.661380317194, 5662.065759149694, 5689.857753556194, 5558.777648893999, 5576.0, 5577.972110139423, 5583.832485025456, 5604.971975140098], "value": 5364.089562125281, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.0923505506684, 616.1497133955141, 635.2091645900853, 636.6975686548886, 653.5947712418301, 31105.0, 31626.525602115988, 33631.49552756704, 33779.98660040199, 33824.49263261053, 44243.77878110613, 45582.77208613961, 45891.0, 49176.0, 49319.0, 8982.910170898305, 9103.180713735763, 9105.226055785266, 9113.635454581809, 9118.270538356915, 9012.459252444842, 9101.590428430736, 9104.863427048567, 9114.680986165486, 9114.817703645924, 9152.72541823743, 9159.908400915972, 9164.541772911361, 9209.95395023024, 9213.2168765655, 9062.45625262483, 9068.68259610917, 9116.772080697969, 9140.680076197368, 9142.314326425545, 8994.460332380078, 9063.50150741709, 9066.682666106655, 9066.727998160066, 9069.863952040725, 44133.77933110346, 44526.33210501845, 44530.33204501935, 44531.0, 44554.0, 3655.4516822476576, 3754.624537546251, 3817.6564109230026, 3926.2343842950636, 4190.916181676349, 32653.972253498065, 33376.3324733504, 33537.83231083853, 34207.4868876967, 34336.313273734384, 4383.430154079981, 4397.824087036514, 4477.843275485342, 4583.4041574595085, 4589.586937175637, 251372.0, 252049.0, 252092.73953630298, 252150.0, 252767.0, 59413.40586594079, 60005.69997150073, 60258.0, 60301.69849150814, 60378.69810650919, 54165.0, 59780.608775648485, 62219.37780622226, 62308.68845655743, 67110.6244906733, 17789.0, 17969.460916172535, 17971.37100201487, 17984.910075449538, 17997.820021799875, 12613.621591352274, 13663.111897726814, 13746.381412836447, 13752.31238438074, 13757.862421375858, 13492.59522214335, 13650.385732642055, 13840.723185536433, 14028.158310501403, 14173.574792756233, 6589.670516474157, 6655.134832471747, 6660.666966651648, 6676.26561078281, 6854.417374523122, 972.7957129002847, 1045.2421994054403, 1068.8503609494676, 1102.963214578294, 1146.3007565385108, 33005.834970825475, 33066.66933330684, 33326.833365833016, 33382.33235335328, 33576.0, 1118.5022664914197, 1124.8144056230794, 1157.022316142858, 1189.9107566932514, 1202.9518819247307, 17201.913990429966, 17410.56473588145, 17444.651106977788, 17600.91199543994, 17623.356496525623, 536268.0, 540942.0, 542428.0, 544364.0, 545564.0, 60729.69635151796, 60785.392146078855, 60965.69517152475, 61002.38997610056, 61082.694586526784, 1219.7560487902456, 1363.4750621010983, 1373.5604606525815, 1399.4052527675901, 1400.4678222275675, 33231.833840831605, 34595.82702086474, 34736.82631586826, 34751.65248347484, 34811.65188348084, 52060.73969630127, 52179.47820521746, 52704.736476317375, 52722.736386317825, 52775.73612131915, 367503.0, 367851.0, 367893.0, 370069.0, 370098.0, 35742.64257357393, 41074.383884241164, 42375.8218133635, 42723.7863810679, 46316.0, 49262.0, 49932.750336248086, 50246.0, 51374.22938655998, 51391.22913156381, 42307.36538951856, 42756.78621606872, 43518.347224792284, 43882.780586096866, 44774.0, 43222.351664724425, 43330.56669433265, 43350.13299733924, 43907.560924391626, 44100.00499026974, 42193.578064218964, 42749.145017100105, 42884.78557607192, 42930.78534607307, 42961.14077718365, 35689.64310356863, 37448.0, 37845.243095138496, 38342.23315533729, 38360.80819595884, 28661.283467912635, 28708.569371459027, 28909.277268068465, 29019.41961160807, 29074.27314317159], "value": 20349.93038906903, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.3708392404305, 391.823679344295, 393.4197059337476, 396.6588733689028, 410.73507587605997, 18448.0, 19294.228230870747, 20202.19191232349, 20217.292394766187, 20247.291344802936, 18802.623947521075, 19026.14382352794, 19351.129199186034, 19602.41192764216, 19632.70550941737, 5185.740712964355, 5222.92165617516, 5274.340707411574, 5340.118880384732, 5345.946540534604, 5290.947090529084, 5294.629375943667, 5305.071612467803, 5308.575313974873, 5315.760790764405, 5084.872878178056, 5213.244079608455, 5246.763895624687, 5306.283651707009, 5335.413104558495, 5127.743612819363, 5152.407473140562, 5156.303898973647, 5157.587393008588, 5192.740362981855, 5012.974935125338, 5104.821331253388, 5263.36839579253, 5266.683998960075, 5281.973590132025, 13788.0, 14134.15195088298, 14140.858591414057, 14226.502072427415, 14418.495352662607, 2352.235523454884, 2394.1859767678898, 2489.0, 2833.3766571354267, 2997.5203967365337, 9955.452450115241, 10053.0, 10394.0, 10451.895481045169, 10677.893221067845, 1970.4778233768063, 2071.658176400892, 2079.781622929586, 2079.9480012999798, 2083.864548804323, 80591.597042015, 81053.59473202596, 82753.0, 83970.0, 84745.99999999939, 10680.305780124267, 10730.141588673043, 11144.049791286492, 11199.832002519968, 11445.88554114465, 15227.162506062274, 15289.0, 15340.309686064154, 15376.53870383868, 15383.692326153414, 7878.290953814069, 7916.7229146980735, 7936.722214722457, 8158.388120890957, 8206.712765053195, 7671.654775535114, 7700.768976930701, 7706.961465192639, 7871.252231038042, 7901.288884000468, 4725.881852953635, 4728.739919304402, 4742.170120228946, 4790.161721698689, 4793.257045158006, 1927.6144771045567, 1945.3483083167014, 1969.6848504239254, 1997.8002199779905, 2038.6126635939124, 867.1761826265074, 933.5612262236738, 951.1629765806047, 980.6077568972325, 1046.6964580271635, 18812.0, 19995.60008799816, 20024.199032038556, 20371.069682394587, 20408.28571000008, 1025.5743866295404, 1062.123747907979, 1082.2153938394601, 1087.211771465681, 1087.3095584303867, 10547.683569492927, 11065.170112241452, 11071.391073491035, 11131.996240676755, 11179.83230251547, 475265.0, 475701.0, 477732.0, 483826.0, 484164.0, 92308.0, 92963.53518232501, 96807.51596241974, 98111.50944245375, 103686.48156759319, 987.195435719886, 999.4503023337136, 1017.6438246613626, 1022.7340891368298, 1039.184240371305, 17271.913640431718, 17480.21339039721, 17771.82228177702, 17949.641007180046, 18072.186751595946, 40958.18083638251, 41323.38014929718, 41457.79271103625, 42865.57134428616, 43577.0, 58377.037951774575, 58582.0, 59485.702571486865, 59857.40142598518, 63600.363996361295, 7696.422768292512, 8100.837983240184, 8309.0, 8600.913990860012, 8926.419782714103, 10507.684769456928, 14447.277636118362, 14449.277536122941, 14531.346089426213, 14672.266386680836, 5817.9127313091185, 11983.580574679845, 12273.938630307148, 12294.262344259372, 12565.623031309075, 11710.297382157098, 12131.878681213428, 12164.878351216375, 12538.561150359694, 12575.245485270912, 11557.88442115568, 11709.0, 12207.816882746589, 12318.0, 12523.248605083723, 7882.09355924076, 8131.0649275331725, 8262.17378262169, 8333.791655208668, 8507.659693612186, 6064.545159112996, 11526.827097593376, 11647.534098635959, 11702.473388697359, 11923.224990375598], "value": 9060.997226172887, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1345.273552281768, 1471.4555614422661, 1513.3568233500762, 1636.5663099278686, 1788.09701100944, 8320.459170153943, 8789.208971192584, 8792.252658524025, 9045.27637788977, 9060.184583387494, 8760.430572012814, 8919.063498332678, 8959.865602015974, 8973.147550982663, 8985.730428087169, 2074.388055523624, 2147.892605369725, 2148.3125399872047, 2331.4287999440116, 2378.1200955646436, 2153.052656830997, 2160.7299087614047, 2332.615118505453, 2388.7491813359607, 2394.7006624171977, 2359.304005318427, 2379.8929048192786, 2397.376682062659, 2403.7115546134487, 2403.8677872716994, 1998.1407994562333, 2248.8875556222206, 2254.9436264093283, 2256.289268880314, 2256.650219216024, 2252.5044490212126, 2325.093213646679, 2329.23135365329, 2341.0635745701684, 2345.648152777097, 9020.278377729832, 9091.27269818413, 9100.863487047633, 9104.68133615327, 9109.407888487227, 5397.8110766123, 5522.502974732253, 5536.363318218416, 5538.224648549206, 5542.528885044776, 3253.951190732117, 3322.0, 3400.3539327527938, 3402.761806673534, 3406.7955922644474, 1064.276292121357, 1085.733995171188, 1121.1927412263158, 1122.9213955023151, 1129.13056946151, 12958.870411295955, 12986.870131298756, 13005.804912926315, 13012.414441350162, 13021.153625014344, 4802.51974802517, 4861.319415281792, 4869.853904382874, 4892.119418504632, 4969.204927211629, 11024.228304018801, 11063.668089957315, 11069.50187241576, 11076.446177691245, 11108.277961932448, 5474.644148130359, 5519.0, 5520.834374968677, 5526.115821468627, 5533.059379905426, 4891.364122664102, 4995.375578052744, 5030.622703297194, 5048.495150484922, 5048.823291184791, 4140.109876376593, 4145.606167414091, 4152.356384760367, 4223.429836971969, 4230.64039556635, 1255.8372165576423, 1330.4611632288938, 1334.2261488336742, 1335.306398010992, 1339.799030145486, 878.3280790195505, 985.6698006168014, 994.4928086675848, 1017.8447462130536, 1029.361795686679, 6238.282597501346, 6303.653299068504, 6516.315786842313, 6527.640979746065, 6571.047198156336, 473.4697139204113, 477.40562999066384, 478.9185838407479, 485.6794515619674, 491.1012846490913, 4423.845165419195, 4540.8637740867825, 4552.271636538138, 4581.221192397234, 4596.5863072323655, 10734.892651073545, 10969.122470202365, 11233.494492747846, 11332.773344533063, 11338.716532086764, 10771.246012779031, 10778.245522813328, 10796.67609971702, 10807.567697292021, 10834.07910327631, 8193.918060819435, 8511.148885111563, 8567.828643427096, 8682.262007729287, 8729.127087291094, 6067.605605635619, 6460.903086453613, 6579.967100164468, 6604.636744979072, 6656.201255849329, 10752.086072683596, 10903.563857445613, 11004.779904402027, 11014.724631883946, 11031.558737650405, 9602.423854568748, 9728.75678108053, 9864.753381165241, 10104.736907886514, 10110.79778404413, 8079.474834135763, 8239.588020599065, 8434.873476897728, 8620.655173792979, 8643.049264581017, 8460.661573536989, 8778.868316975122, 8842.0, 8851.291896648125, 9133.862992054992, 7816.296533311802, 7948.16544262844, 8082.636281367235, 8164.061132969785, 8177.509349439053, 7572.8485430292185, 7791.337736292478, 7831.490953088031, 7880.408969327438, 7915.0897646771355, 7384.630768461663, 7389.371903388273, 7465.253474652709, 7470.252974702704, 7472.701091956261, 4614.561616646413, 5436.293281873489, 5630.549556035589, 5648.350439699487, 5790.971045144747, 5514.6691198528215, 5525.0, 5663.801766938137, 5735.283089613798, 5905.498032667271], "value": 4700.219119042507, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.44820701221954, 332.59921794237937, 341.06207928197455, 342.6659007467721, 343.53794146872445, 5309.123994540906, 5313.38896026957, 5321.813736519222, 5329.760160792764, 5337.546308563772, 5273.288106105674, 5284.788608455658, 5286.013402427626, 5288.524032837044, 5299.28459657946, 3964.255727479914, 3989.640932316091, 4121.619257548725, 4145.502539695241, 4171.0, 4107.835686572534, 4152.771597562133, 4156.251874662559, 4157.5010998680045, 4169.833206671745, 3926.3521518949337, 4127.525334586516, 4134.689898257643, 4139.1100913303635, 4142.97928510357, 4006.1787333596544, 4100.753954762694, 4127.40152677863, 4137.565555616678, 4142.1922725068625, 3650.689691376236, 3650.7444478886487, 3651.94522082169, 3654.4701018352457, 3681.889543313705, 5152.768125434364, 5176.6117541184185, 5184.844454666329, 5196.194589838581, 5196.45437229093, 4472.262076757331, 4702.083093796711, 4715.811367545294, 4734.2425211966265, 4736.4316282046375, 5486.231927530149, 5494.642848214893, 5520.309961254843, 5528.778848846041, 5532.921080389326, 3812.1041555234497, 3964.266610677034, 3966.849613612049, 3970.7419017763755, 3976.483057202574, 5708.71456427177, 5738.245642091778, 5749.540036797088, 5750.367459579443, 5760.855978600526, 4047.0, 4050.3924411338535, 4059.3910913362643, 4065.5121385433936, 4067.3288907330552, 3904.921901561953, 4081.510218773766, 4087.5912408758886, 4094.733842300241, 4103.281925662997, 4682.367880336179, 4685.586922734794, 4691.929621055687, 4707.741074240949, 4709.670323077352, 5552.4181255716285, 5595.0, 5602.159676048544, 5607.243022192033, 5618.061768689796, 1356.3828458051562, 1412.5832879300426, 1424.2522675595396, 1428.114568967247, 1431.9642008949652, 877.3902138014147, 890.247740659142, 897.2239013253488, 955.073578628729, 958.3770549142973, 5285.445028272053, 5291.365036195682, 5297.867553311121, 5301.310829592206, 5314.176302673091, 5594.552435805126, 5603.831885043455, 5603.954556586817, 5627.242651100931, 5635.295588051494, 5155.304033955443, 5285.207218917193, 5301.920471192935, 5439.3200849893765, 5440.564754819605, 3010.3377257003426, 3015.703247603508, 3026.8486575671127, 3038.316378814749, 3041.5893854329383, 5668.914966275509, 5868.413158684098, 5882.264716910387, 5883.0, 5894.0, 5823.708814559255, 5829.766809327664, 5856.209411729362, 5859.589828712034, 5871.266091738533, 5837.532997360286, 5881.0, 5893.3793206867595, 5895.970520147286, 5914.615549989323, 5427.5657947363325, 5637.915431268616, 5661.716914154358, 5680.2047713321, 5745.540356771532, 5672.688002159921, 5676.403977582295, 5692.345380281155, 5695.7436915338085, 5707.600467967202, 5693.829185124453, 5864.794732184524, 5890.3226128994, 5916.73374698131, 5938.703064846827, 4069.348904175318, 4085.5301640310554, 4093.9385909211983, 4096.692748043849, 4097.344424892003, 5718.428157184415, 5733.168690539765, 5733.426657334233, 5736.623210429383, 5745.6552606843725, 5439.347278326626, 5538.6399884007415, 5565.582581306499, 5566.554675626021, 5572.718274796738, 5548.611597188158, 5557.666540007613, 5561.6384934980715, 5585.207396301849, 5588.497035266845, 5238.292830467838, 5251.921221181609, 5490.0941344677685, 5506.752196151103, 5516.310461192351, 5536.695481748381, 5568.972155139199, 5603.327600687943, 5617.494425501724, 5623.550115990629, 5485.862853428696, 5488.670679759227, 5492.5331346835965, 5507.256520369699, 5532.557395408438], "value": 4232.883349076819, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [760.418280015788, 761.6077719974211, 808.1837344282274, 816.9449230586417, 847.7287268074218, 16839.32642694291, 17752.201150948207, 17755.0, 17773.466795996108, 17835.46493605192, 15723.056616603011, 15934.920325398356, 15946.0, 15967.0, 15985.680286394265, 663.4128796015536, 790.0558832195514, 791.6951973490219, 804.8148925747082, 807.588130053671, 803.7106641609016, 804.2239239134234, 805.899262592176, 805.9435839491209, 806.9515829050247, 855.9871601925976, 864.5979619476942, 865.5196366016858, 865.7705707987388, 866.9739907802776, 699.8705239530703, 849.1762989899787, 851.5231470376547, 860.6084231674604, 861.6381119929645, 619.1486705779553, 620.4013127332146, 620.6307247187916, 621.0125899819263, 621.1707370660174, 15396.461123860723, 15425.305861236271, 15451.150186739726, 15461.381544738197, 15473.690526189526, 14649.121052736764, 15017.474388396464, 15029.924850375788, 15154.469593564283, 15200.16399098049, 13182.67043323915, 13258.204507729568, 13307.66730831737, 13329.533466328729, 13884.652883677887, 4439.977800111011, 4456.55434456555, 4503.707259028152, 4613.031263434683, 4706.5293470653005, 77382.0, 77756.22243777546, 78339.21660783433, 78441.21558784397, 81300.0, 12022.879771202175, 12105.939470302592, 12143.332116733487, 12259.325737084546, 12287.815682764765, 22867.542649146922, 22882.542349152925, 22892.0, 22901.08395664188, 23005.88497057504, 8987.685431010013, 8993.0, 9191.402558833654, 9218.677346292847, 9476.099770521789, 4926.4088309403105, 4959.132151873408, 4990.451050384455, 5019.161087335754, 5285.365756109215, 3524.718022558189, 3636.3636363636256, 3637.7635453695425, 3638.9818050910108, 3643.0, 644.0, 645.0775391190642, 650.6844180572418, 659.5943494750694, 679.748493057562, 571.7741492110594, 710.7299226294078, 711.6020999726348, 735.4998600951404, 741.1735914455451, 9251.953740231256, 9448.291378146667, 9490.525473726286, 9769.218462522982, 9792.314537982273, 706.6113637499458, 713.3686687281689, 716.6810769207757, 728.639323534843, 734.3390948146711, 4468.79890404926, 4722.173619616553, 4763.380760501182, 4800.759962001886, 4814.7833347499445, 119683.40158299153, 120631.39684301698, 122554.0, 123642.0, 124109.0, 84440.57779711061, 102596.48701756593, 102752.0, 103588.0, 104313.47843260887, 78437.0, 92414.0, 92557.0, 93407.0, 96665.51667241618, 8858.822823543622, 8871.290296776371, 8873.73378798637, 8970.282377409922, 9078.954605226932, 46748.0, 47019.52980470152, 54849.45150548603, 56018.719906400205, 57008.714956424956, 47900.7604961973, 50593.24110138277, 53140.2028969558, 63004.36995629985, 71386.0, 14153.929230353782, 14167.0, 14246.35891384911, 14469.638259043608, 14580.781288280896, 15581.454649087227, 15677.451289204822, 15920.76118858195, 16048.438304659281, 16777.0, 14757.704845903236, 15110.0, 15126.848731512984, 15192.316345764688, 15634.218289085728, 14324.427022919383, 14933.178675172536, 14981.250937452865, 15017.023893447327, 15160.772588410962, 13625.182489050689, 14042.859571404564, 14383.712325753217, 14538.491152810024, 14687.339069742102, 12030.15788894769, 12192.51229950792, 12330.691732706755, 12703.809442858179, 12873.22760634365, 11554.364509951698, 12458.501659933501, 12563.18339307942, 12605.747885042065, 12657.87342126567], "value": 7841.400941127118, "unit": "score"}], "name": "dromaeo_css", "value": 7323.825208149494, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 110.0, 112.0, 112.0, 113.0, 111.0, 109.0, 110.0, 109.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 118.0, 119.0, 173.0, 117.0, 117.0, 148.0, 116.0, 165.0, 122.0], "value": 133.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 159.0, 161.0, 161.0, 160.0, 160.0, 161.0, 161.0, 160.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 124.0, 74.0, 74.0, 74.0, 74.0, 114.0, 74.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 112.0, 83.0, 83.0, 84.0, 112.0, 84.0, 84.0, 122.0], "value": 93.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 118.0, 116.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 144.0, 144.0], "value": 145.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 50.0, 54.0, 51.0, 52.0, 52.0, 51.0, 52.0, 52.0, 52.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 62.0, 62.0, 61.0, 61.0, 62.0, 61.0, 62.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 77.0, 75.0, 75.0, 75.0, 76.0, 79.0, 76.0, 74.0, 75.0], "value": 76.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 116.0, 119.0, 118.0, 118.0, 120.0, 120.0, 122.0, 206.0, 134.0], "value": 130.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 153.0, 158.0, 159.0, 155.0, 152.0, 156.0, 159.0, 155.0, 156.0], "value": 156.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 63.0, 61.0, 61.0, 65.0, 62.0, 60.0, 61.0, 60.0], "value": 61.7, "unit": "score"}], "name": "kraken", "value": 1475.1999999999998, "alertThreshold": 2.0}]} 20:21:43 INFO - Return code: 0 20:21:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:21:44 INFO - # TBPL SUCCESS # 20:21:44 INFO - Running post-action listener: _resource_record_post_action 20:21:44 INFO - ##### 20:21:44 INFO - ##### Finished run-tests step (success) 20:21:44 INFO - ##### 20:21:44 INFO - Running post-run listener: _resource_record_post_run 20:21:44 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 553164800; Read time: 0; Write time: 423860 20:21:44 INFO - TinderboxPrint: CPU usage
13.0% 20:21:44 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 20:21:44 INFO - TinderboxPrint: I/O write bytes / time
553,164,800 / 423,860 20:21:44 INFO - TinderboxPrint: CPU idle
8,278.3 (87.0%) 20:21:44 INFO - TinderboxPrint: CPU user
1,191.0 (12.5%) 20:21:44 INFO - TinderboxPrint: Swap in / out
0 / 0 20:21:44 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 256806912; Read time: 0; Write time: 227796 20:21:44 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 296357888; Read time: 0; Write time: 196064 20:21:44 INFO - Running post-run listener: _upload_blobber_files 20:21:44 INFO - Blob upload gear active. 20:21:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:21:44 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:21:44 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:21:44 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:21:45 INFO - (blobuploader) - INFO - Open directory for files ... 20:21:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:21:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:21:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:21:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:21:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:21:45 INFO - (blobuploader) - INFO - Done attempting. 20:21:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:21:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:21:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:21:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:21:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:21:46 INFO - (blobuploader) - INFO - Done attempting. 20:21:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:21:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:21:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:21:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:21:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:21:49 INFO - (blobuploader) - INFO - Done attempting. 20:21:49 INFO - (blobuploader) - INFO - Iteration through files over. 20:21:49 INFO - Return code: 0 20:21:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:21:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:21:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a22ab21be488017ad4da5abd8048408cc0f49465fbf448d15bc42703a98602c8b1e403bb5a9652a66b90b6f21d06c9a9b4d140b32d7afafb7d80f5f3881db77f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7db2f991f2529b97753f6787ab85204c3115f2bd9e711a9c1ab7687536d36241864d4b340972a9e677a6a3485efd8cafa40516102d3e23ec13bdd69e258c1a49", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e09937dc242be766479f4e27e9eddf9b2de1eb362ae33885e9c2a2b7f6cd80bb645da5f4be8cbde4252489ffeee36ed0776230eff171fbad543e59aff07446bc"} 20:21:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:21:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:21:49 INFO - Contents: 20:21:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a22ab21be488017ad4da5abd8048408cc0f49465fbf448d15bc42703a98602c8b1e403bb5a9652a66b90b6f21d06c9a9b4d140b32d7afafb7d80f5f3881db77f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7db2f991f2529b97753f6787ab85204c3115f2bd9e711a9c1ab7687536d36241864d4b340972a9e677a6a3485efd8cafa40516102d3e23ec13bdd69e258c1a49", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e09937dc242be766479f4e27e9eddf9b2de1eb362ae33885e9c2a2b7f6cd80bb645da5f4be8cbde4252489ffeee36ed0776230eff171fbad543e59aff07446bc"} 20:21:49 INFO - Running post-run listener: copy_logs_to_upload_dir 20:21:49 INFO - Copying logs to upload dir... 20:21:49 INFO - mkdir: /builds/slave/test/build/upload/logs 20:21:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.721795 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-07-06 20:21:49.497179) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 20:21:49.501487) ========= 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=db7e7c15f3ca076d53731445000001ba-1467860149.775553-1015131102 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/a22ab21be488017ad4da5abd8048408cc0f49465fbf448d15bc42703a98602c8b1e403bb5a9652a66b90b6f21d06c9a9b4d140b32d7afafb7d80f5f3881db77f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7db2f991f2529b97753f6787ab85204c3115f2bd9e711a9c1ab7687536d36241864d4b340972a9e677a6a3485efd8cafa40516102d3e23ec13bdd69e258c1a49", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e09937dc242be766479f4e27e9eddf9b2de1eb362ae33885e9c2a2b7f6cd80bb645da5f4be8cbde4252489ffeee36ed0776230eff171fbad543e59aff07446bc"} 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.011226 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/a22ab21be488017ad4da5abd8048408cc0f49465fbf448d15bc42703a98602c8b1e403bb5a9652a66b90b6f21d06c9a9b4d140b32d7afafb7d80f5f3881db77f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7db2f991f2529b97753f6787ab85204c3115f2bd9e711a9c1ab7687536d36241864d4b340972a9e677a6a3485efd8cafa40516102d3e23ec13bdd69e258c1a49", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e09937dc242be766479f4e27e9eddf9b2de1eb362ae33885e9c2a2b7f6cd80bb645da5f4be8cbde4252489ffeee36ed0776230eff171fbad543e59aff07446bc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 20:21:49.533132) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 20:21:49.533683) ========= 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=db7e7c15f3ca076d53731445000001ba-1467860149.775553-1015131102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004457 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 20:21:49.618264) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 20:21:49.618853) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 20:21:49.619384) ========= ========= Total master_lag: 0.21 =========