builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-049 starttime: 1467803205.41 results: success (0) buildid: 20160706032423 builduid: 2fa55cbb8fa14f0fb1676bc22d3f1114 revision: 4eedf5c4e7e25be86832759f4a834608fb88ac6c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 04:06:45.405967) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 04:06:45.406443) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 04:06:45.406760) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 04:06:45.423203) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 04:06:45.423641) ========= 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-1467803203.72708-96206001 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-06 04:06:45-- 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 04:06:45 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085130 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 04:06:45.524288) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 04:06:45.524704) ========= 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-1467803203.72708-96206001 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019534 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 04:06:45.575777) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-06 04:06:45.576232) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4eedf5c4e7e25be86832759f4a834608fb88ac6c --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 4eedf5c4e7e25be86832759f4a834608fb88ac6c --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-1467803203.72708-96206001 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-06 04:06:45,929 truncating revision to first 12 chars 2016-07-06 04:06:45,929 Setting DEBUG logging. 2016-07-06 04:06:45,929 attempt 1/10 2016-07-06 04:06:45,929 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4eedf5c4e7e2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-06 04:06:47,017 unpacking tar archive at: fx-team-4eedf5c4e7e2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.425590 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-06 04:06:47.018820) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 04:06:47.019425) ========= script_repo_revision: 4eedf5c4e7e25be86832759f4a834608fb88ac6c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 04:06:47.020168) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 04:06:47.020680) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 04:06:47.033830) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-06 04:06:47.034264) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1467803203.72708-96206001 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:06:47 INFO - MultiFileLogger online at 20160706 04:06:47 in /builds/slave/test 04:06:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 04:06:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:06:47 INFO - {'append_to_log': False, 04:06:47 INFO - 'base_work_dir': '/builds/slave/test', 04:06:47 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:06:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:06:47 INFO - 'branch': 'Fx-Team-Non-PGO', 04:06:47 INFO - 'buildbot_json_path': 'buildprops.json', 04:06:47 INFO - 'config_files': ('talos/linux_config.py',), 04:06:47 INFO - 'default_actions': ('clobber', 04:06:47 INFO - 'read-buildbot-config', 04:06:47 INFO - 'download-and-extract', 04:06:47 INFO - 'populate-webroot', 04:06:47 INFO - 'create-virtualenv', 04:06:47 INFO - 'install', 04:06:47 INFO - 'run-tests'), 04:06:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:06:47 INFO - 'download_minidump_stackwalk': True, 04:06:47 INFO - 'download_symbols': 'ondemand', 04:06:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:06:47 INFO - 'tooltool.py': '/tools/tooltool.py', 04:06:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:06:47 INFO - '/tools/misc-python/virtualenv.py')}, 04:06:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:06:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:06:47 INFO - 'installer_path': 'installer.exe', 04:06:47 INFO - 'log_level': 'info', 04:06:47 INFO - 'log_name': 'talos', 04:06:47 INFO - 'log_to_console': True, 04:06:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:06:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:06:47 INFO - 'opt_config_files': (), 04:06:47 INFO - 'pip_index': False, 04:06:47 INFO - 'sps_profile': False, 04:06:47 INFO - 'sps_profile_interval': 0, 04:06:47 INFO - 'suite': 'dromaeojs', 04:06:47 INFO - 'system_bits': '32', 04:06:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:06:47 INFO - 'title': 'talos-linux64-ix-049', 04:06:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:06:47 INFO - 'use_talos_json': True, 04:06:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:06:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:06:47 INFO - 'work_dir': 'build'} 04:06:47 INFO - ##### 04:06:47 INFO - ##### Running clobber step. 04:06:47 INFO - ##### 04:06:47 INFO - Running pre-action listener: _resource_record_pre_action 04:06:47 INFO - Running main action method: clobber 04:06:47 INFO - rmtree: /builds/slave/test/build 04:06:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:06:48 INFO - Running post-action listener: _resource_record_post_action 04:06:48 INFO - ##### 04:06:48 INFO - ##### Finished clobber step (success) 04:06:48 INFO - ##### 04:06:48 INFO - ##### 04:06:48 INFO - ##### Running read-buildbot-config step. 04:06:48 INFO - ##### 04:06:48 INFO - Running pre-action listener: _resource_record_pre_action 04:06:48 INFO - Running main action method: read_buildbot_config 04:06:48 INFO - Using buildbot properties: 04:06:48 INFO - { 04:06:48 INFO - "project": "", 04:06:48 INFO - "product": "firefox", 04:06:48 INFO - "script_repo_revision": "production", 04:06:48 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:06:48 INFO - "repository": "", 04:06:48 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:06:48 INFO - "buildid": "20160706032423", 04:06:48 INFO - "pgo_build": "False", 04:06:48 INFO - "basedir": "/builds/slave/test", 04:06:48 INFO - "buildnumber": 1936, 04:06:48 INFO - "slavename": "talos-linux64-ix-049", 04:06:48 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:06:48 INFO - "platform": "ubuntu64_hw", 04:06:48 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:06:48 INFO - "branch": "fx-team", 04:06:48 INFO - "repo_path": "integration/fx-team", 04:06:48 INFO - "revision": "4eedf5c4e7e25be86832759f4a834608fb88ac6c", 04:06:48 INFO - "stage_platform": "linux64", 04:06:48 INFO - "builduid": "2fa55cbb8fa14f0fb1676bc22d3f1114", 04:06:48 INFO - "slavebuilddir": "test" 04:06:48 INFO - } 04:06:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/Kbljgn8EREeLU84WFBVQNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:06:48 INFO - Running post-action listener: _resource_record_post_action 04:06:48 INFO - ##### 04:06:48 INFO - ##### Finished read-buildbot-config step (success) 04:06:48 INFO - ##### 04:06:48 INFO - ##### 04:06:48 INFO - ##### Running download-and-extract step. 04:06:48 INFO - ##### 04:06:48 INFO - Running pre-action listener: _resource_record_pre_action 04:06:48 INFO - Running main action method: download_and_extract 04:06:48 INFO - mkdir: /builds/slave/test/build/tests 04:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:48 INFO - https://queue.taskcluster.net/v1/task/Kbljgn8EREeLU84WFBVQNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:06:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kbljgn8EREeLU84WFBVQNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:06:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kbljgn8EREeLU84WFBVQNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:06:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kbljgn8EREeLU84WFBVQNw/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 04:06:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kbljgn8EREeLU84WFBVQNw/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 04:06:49 INFO - Downloaded 1361 bytes. 04:06:49 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:06:49 INFO - Using the following test package requirements: 04:06:49 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:06:49 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:06:49 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:06:49 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:49 INFO - u'jsshell-linux-x86_64.zip'], 04:06:49 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:06:49 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:06:49 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:06:49 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:06:49 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:06:49 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:06:49 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:06:49 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')]} 04:06:49 INFO - https://queue.taskcluster.net/v1/task/Kbljgn8EREeLU84WFBVQNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:06:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kbljgn8EREeLU84WFBVQNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:06:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kbljgn8EREeLU84WFBVQNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:06:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kbljgn8EREeLU84WFBVQNw/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 04:06:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kbljgn8EREeLU84WFBVQNw/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 04:06:50 INFO - Downloaded 22730934 bytes. 04:06:50 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'] 04:06:50 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 04:06:51 INFO - Return code: 0 04:06:51 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 04:06:51 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')]} 04:06:51 INFO - https://queue.taskcluster.net/v1/task/Kbljgn8EREeLU84WFBVQNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:06:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kbljgn8EREeLU84WFBVQNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:06:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kbljgn8EREeLU84WFBVQNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:06:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kbljgn8EREeLU84WFBVQNw/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 04:06:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kbljgn8EREeLU84WFBVQNw/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 04:06:52 INFO - Downloaded 22730934 bytes. 04:06:52 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'] 04:06:52 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 04:06:53 INFO - Return code: 0 04:06:53 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')]} 04:06:53 INFO - https://queue.taskcluster.net/v1/task/Kbljgn8EREeLU84WFBVQNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:06:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kbljgn8EREeLU84WFBVQNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:06:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kbljgn8EREeLU84WFBVQNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:06:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kbljgn8EREeLU84WFBVQNw/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 04:06:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kbljgn8EREeLU84WFBVQNw/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 04:06:54 INFO - Downloaded 14403333 bytes. 04:06:54 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'] 04:06:54 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 04:06:55 INFO - Return code: 0 04:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:55 INFO - https://queue.taskcluster.net/v1/task/Kbljgn8EREeLU84WFBVQNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:06:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kbljgn8EREeLU84WFBVQNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:06:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kbljgn8EREeLU84WFBVQNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:06:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kbljgn8EREeLU84WFBVQNw/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 04:06:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kbljgn8EREeLU84WFBVQNw/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 04:06:56 INFO - Downloaded 56464878 bytes. 04:06:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Kbljgn8EREeLU84WFBVQNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:06:56 INFO - mkdir: /builds/slave/test/properties 04:06:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:06:56 INFO - Writing to file /builds/slave/test/properties/build_url 04:06:56 INFO - Contents: 04:06:56 INFO - build_url:https://queue.taskcluster.net/v1/task/Kbljgn8EREeLU84WFBVQNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:06:57 INFO - Running post-action listener: _resource_record_post_action 04:06:57 INFO - Running post-action listener: set_extra_try_arguments 04:06:57 INFO - ##### 04:06:57 INFO - ##### Finished download-and-extract step (success) 04:06:57 INFO - ##### 04:06:57 INFO - ##### 04:06:57 INFO - ##### Running populate-webroot step. 04:06:57 INFO - ##### 04:06:57 INFO - Running pre-action listener: _resource_record_pre_action 04:06:57 INFO - Running main action method: populate_webroot 04:06:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:06:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:06:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:06:57 INFO - '--tppagecycles', 04:06:57 INFO - '7'], 04:06:57 INFO - 'tests': ['tsvgm']}}, 04:06:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:06:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:06:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:06:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:06:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:06:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:06:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:57 INFO - 'talos_options': ['--disable-e10s'], 04:06:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:06:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:06:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:57 INFO - 'talos_options': ['--disable-e10s'], 04:06:57 INFO - 'tests': ['damp', 'tps']}, 04:06:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:57 INFO - 'tests': ['damp', 'tps']}, 04:06:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:06:57 INFO - 'tests': ['dromaeo_dom']}, 04:06:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:06:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:06:57 INFO - 'tests': ['basic_compositor_video']}, 04:06:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:06:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:06:57 INFO - 'tests': ['a11yr', 04:06:57 INFO - 'ts_paint', 04:06:57 INFO - 'tpaint', 04:06:57 INFO - 'sessionrestore', 04:06:57 INFO - 'sessionrestore_no_auto_restore', 04:06:57 INFO - 'tabpaint']}, 04:06:57 INFO - 'other-e10s': {'tests': ['a11yr', 04:06:57 INFO - 'ts_paint', 04:06:57 INFO - 'tpaint', 04:06:57 INFO - 'sessionrestore', 04:06:57 INFO - 'sessionrestore_no_auto_restore', 04:06:57 INFO - 'tabpaint']}, 04:06:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:06:57 INFO - 'ts_paint', 04:06:57 INFO - 'tpaint', 04:06:57 INFO - 'sessionrestore', 04:06:57 INFO - 'sessionrestore_no_auto_restore', 04:06:57 INFO - 'tabpaint']}, 04:06:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:06:57 INFO - 'ts_paint', 04:06:57 INFO - 'tpaint', 04:06:57 INFO - 'sessionrestore', 04:06:57 INFO - 'sessionrestore_no_auto_restore', 04:06:57 INFO - 'tabpaint']}, 04:06:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:06:57 INFO - 'tests': ['a11yr', 04:06:57 INFO - 'ts_paint', 04:06:57 INFO - 'tpaint', 04:06:57 INFO - 'sessionrestore', 04:06:57 INFO - 'sessionrestore_no_auto_restore', 04:06:57 INFO - 'tabpaint']}, 04:06:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:06:57 INFO - 'tests': ['a11yr', 04:06:57 INFO - 'ts_paint', 04:06:57 INFO - 'tpaint', 04:06:57 INFO - 'sessionrestore', 04:06:57 INFO - 'sessionrestore_no_auto_restore', 04:06:57 INFO - 'tabpaint']}, 04:06:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:06:57 INFO - 'tests': ['tsvgx', 04:06:57 INFO - 'tsvgr_opacity', 04:06:57 INFO - 'tart', 04:06:57 INFO - 'tscrollx', 04:06:57 INFO - 'cart']}, 04:06:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:06:57 INFO - 'tsvgr_opacity', 04:06:57 INFO - 'tart', 04:06:57 INFO - 'tscrollx', 04:06:57 INFO - 'cart']}, 04:06:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:57 INFO - 'talos_options': ['--disable-e10s'], 04:06:57 INFO - 'tests': ['tp5o']}, 04:06:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:57 INFO - 'tests': ['tp5o']}, 04:06:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:57 INFO - 'talos_options': ['--disable-e10s', 04:06:57 INFO - '--xperf_path', 04:06:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:06:57 INFO - 'tests': ['tp5n']}, 04:06:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:57 INFO - 'talos_options': ['--xperf_path', 04:06:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:06:57 INFO - 'tests': ['tp5n']}}, 04:06:57 INFO - 'talos.zip': {'path': '', 04:06:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:06:57 INFO - Running post-action listener: _resource_record_post_action 04:06:57 INFO - ##### 04:06:57 INFO - ##### Finished populate-webroot step (success) 04:06:57 INFO - ##### 04:06:57 INFO - ##### 04:06:57 INFO - ##### Running create-virtualenv step. 04:06:57 INFO - ##### 04:06:57 INFO - Running pre-action listener: _resource_record_pre_action 04:06:57 INFO - Running main action method: create_virtualenv 04:06:57 INFO - Creating virtualenv /builds/slave/test/build/venv 04:06:57 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 04:06:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:06:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:06:57 INFO - Using real prefix '/usr' 04:06:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:06:57 INFO - Installing distribute.............................................................................................................................................................................................done. 04:06:59 INFO - Installing pip.................done. 04:06:59 INFO - Return code: 0 04:06:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:06:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:59 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 0x2922030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be13b0>, '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 0x2be22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be2740>, '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-1467803203.72708-96206001', '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 04:06:59 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 04:06:59 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 04:06:59 INFO - Using env: {'DISPLAY': ':0', 04:06:59 INFO - 'HOME': '/home/cltbld', 04:06:59 INFO - 'LANG': 'en_US.UTF-8', 04:06:59 INFO - 'LANGUAGE': 'en_US:en', 04:06:59 INFO - 'LOGNAME': 'cltbld', 04:06:59 INFO - 'MAIL': '/var/mail/cltbld', 04:06:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:59 INFO - 'MOZ_NO_REMOTE': '1', 04:06:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:59 INFO - 'NO_EM_RESTART': '1', 04:06:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:59 INFO - 'PWD': '/builds/slave/test', 04:06:59 INFO - 'SHELL': '/bin/bash', 04:06:59 INFO - 'SHLVL': '1', 04:06:59 INFO - 'TERM': 'linux', 04:06:59 INFO - 'TMOUT': '86400', 04:06:59 INFO - 'USER': 'cltbld', 04:06:59 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467803203.72708-96206001', 04:06:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:59 INFO - '_': '/tools/buildbot/bin/python'} 04:06:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:59 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 04:06:59 INFO - Cleaning up... 04:06:59 INFO - Return code: 0 04:06:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:06:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:59 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 0x2922030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be13b0>, '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 0x2be22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be2740>, '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-1467803203.72708-96206001', '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 04:06:59 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 04:06:59 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 04:06:59 INFO - Using env: {'DISPLAY': ':0', 04:06:59 INFO - 'HOME': '/home/cltbld', 04:06:59 INFO - 'LANG': 'en_US.UTF-8', 04:06:59 INFO - 'LANGUAGE': 'en_US:en', 04:06:59 INFO - 'LOGNAME': 'cltbld', 04:06:59 INFO - 'MAIL': '/var/mail/cltbld', 04:06:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:59 INFO - 'MOZ_NO_REMOTE': '1', 04:06:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:59 INFO - 'NO_EM_RESTART': '1', 04:06:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:59 INFO - 'PWD': '/builds/slave/test', 04:06:59 INFO - 'SHELL': '/bin/bash', 04:06:59 INFO - 'SHLVL': '1', 04:06:59 INFO - 'TERM': 'linux', 04:06:59 INFO - 'TMOUT': '86400', 04:06:59 INFO - 'USER': 'cltbld', 04:06:59 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467803203.72708-96206001', 04:06:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:59 INFO - '_': '/tools/buildbot/bin/python'} 04:07:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:00 INFO - Downloading/unpacking psutil>=3.1.1 04:07:00 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 04:07:00 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 04:07:00 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 04:07:00 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 04:07:00 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 04:07:00 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 04:07:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:07:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:07:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:07:02 INFO - Installing collected packages: psutil 04:07:02 INFO - Running setup.py install for psutil 04:07:02 INFO - building 'psutil._psutil_linux' extension 04:07:02 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 04:07:02 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 04:07:02 INFO - building 'psutil._psutil_posix' extension 04:07:02 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 04:07:02 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 04:07:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:07:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:07:02 INFO - Successfully installed psutil 04:07:02 INFO - Cleaning up... 04:07:02 INFO - Return code: 0 04:07:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:07: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')]} 04:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07: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')]} 04:07:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:02 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 0x2922030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be13b0>, '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 0x2be22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be2740>, '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-1467803203.72708-96206001', '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 04:07:02 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 04:07:02 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 04:07:02 INFO - Using env: {'DISPLAY': ':0', 04:07:02 INFO - 'HOME': '/home/cltbld', 04:07:02 INFO - 'LANG': 'en_US.UTF-8', 04:07:02 INFO - 'LANGUAGE': 'en_US:en', 04:07:02 INFO - 'LOGNAME': 'cltbld', 04:07:02 INFO - 'MAIL': '/var/mail/cltbld', 04:07:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:02 INFO - 'MOZ_NO_REMOTE': '1', 04:07:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:02 INFO - 'NO_EM_RESTART': '1', 04:07:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:02 INFO - 'PWD': '/builds/slave/test', 04:07:02 INFO - 'SHELL': '/bin/bash', 04:07:02 INFO - 'SHLVL': '1', 04:07:02 INFO - 'TERM': 'linux', 04:07:02 INFO - 'TMOUT': '86400', 04:07:02 INFO - 'USER': 'cltbld', 04:07:02 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467803203.72708-96206001', 04:07:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:02 INFO - '_': '/tools/buildbot/bin/python'} 04:07:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:07:02 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 04:07:02 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 04:07:02 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 04:07:02 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 04:07:02 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 04:07:02 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 04:07:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:07:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:07:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:07:05 INFO - Installing collected packages: mozsystemmonitor 04:07:05 INFO - Running setup.py install for mozsystemmonitor 04:07:05 INFO - Successfully installed mozsystemmonitor 04:07:05 INFO - Cleaning up... 04:07:05 INFO - Return code: 0 04:07:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:05 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 0x2922030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be13b0>, '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 0x2be22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be2740>, '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-1467803203.72708-96206001', '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 04:07:05 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 04:07:05 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 04:07:05 INFO - Using env: {'DISPLAY': ':0', 04:07:05 INFO - 'HOME': '/home/cltbld', 04:07:05 INFO - 'LANG': 'en_US.UTF-8', 04:07:05 INFO - 'LANGUAGE': 'en_US:en', 04:07:05 INFO - 'LOGNAME': 'cltbld', 04:07:05 INFO - 'MAIL': '/var/mail/cltbld', 04:07:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:05 INFO - 'MOZ_NO_REMOTE': '1', 04:07:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:05 INFO - 'NO_EM_RESTART': '1', 04:07:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:05 INFO - 'PWD': '/builds/slave/test', 04:07:05 INFO - 'SHELL': '/bin/bash', 04:07:05 INFO - 'SHLVL': '1', 04:07:05 INFO - 'TERM': 'linux', 04:07:05 INFO - 'TMOUT': '86400', 04:07:05 INFO - 'USER': 'cltbld', 04:07:05 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467803203.72708-96206001', 04:07:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:05 INFO - '_': '/tools/buildbot/bin/python'} 04:07:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:05 INFO - Downloading/unpacking jsonschema==2.5.1 04:07:05 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 04:07:05 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 04:07:05 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 04:07:05 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 04:07:05 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 04:07:05 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 04:07:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:07:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:07:07 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 04:07:07 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 04:07:07 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 04:07:07 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 04:07:07 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 04:07:07 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 04:07:08 INFO - Downloading functools32-3.2.3-2.tar.gz 04:07:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:07:08 INFO - warning: no files found matching '*.txt' 04:07:08 INFO - no previously-included directories found matching 'build' 04:07:08 INFO - no previously-included directories found matching 'dist' 04:07:08 INFO - no previously-included directories found matching '.git*' 04:07:08 INFO - Installing collected packages: jsonschema, functools32 04:07:08 INFO - Running setup.py install for functools32 04:07:08 INFO - warning: no files found matching '*.txt' 04:07:08 INFO - no previously-included directories found matching 'build' 04:07:08 INFO - no previously-included directories found matching 'dist' 04:07:08 INFO - no previously-included directories found matching '.git*' 04:07:08 INFO - Successfully installed jsonschema functools32 04:07:08 INFO - Cleaning up... 04:07:08 INFO - Return code: 0 04:07:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:07: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')]} 04:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07: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')]} 04:07:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:08 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 0x2922030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be13b0>, '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 0x2be22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be2740>, '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-1467803203.72708-96206001', '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 04:07:08 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 04:07:08 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 04:07:08 INFO - Using env: {'DISPLAY': ':0', 04:07:08 INFO - 'HOME': '/home/cltbld', 04:07:08 INFO - 'LANG': 'en_US.UTF-8', 04:07:08 INFO - 'LANGUAGE': 'en_US:en', 04:07:08 INFO - 'LOGNAME': 'cltbld', 04:07:08 INFO - 'MAIL': '/var/mail/cltbld', 04:07:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:08 INFO - 'MOZ_NO_REMOTE': '1', 04:07:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:08 INFO - 'NO_EM_RESTART': '1', 04:07:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:08 INFO - 'PWD': '/builds/slave/test', 04:07:08 INFO - 'SHELL': '/bin/bash', 04:07:08 INFO - 'SHLVL': '1', 04:07:08 INFO - 'TERM': 'linux', 04:07:08 INFO - 'TMOUT': '86400', 04:07:08 INFO - 'USER': 'cltbld', 04:07:08 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467803203.72708-96206001', 04:07:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:08 INFO - '_': '/tools/buildbot/bin/python'} 04:07:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:08 INFO - Downloading/unpacking blobuploader==1.2.4 04:07:08 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 04:07:08 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 04:07:08 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 04:07:08 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 04:07:08 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 04:07:08 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 04:07:10 INFO - Downloading blobuploader-1.2.4.tar.gz 04:07:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:07:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:07:10 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 04:07:10 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 04:07:10 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 04:07:10 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 04:07:10 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 04:07:10 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 04:07:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:07:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:07:10 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 04:07:10 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 04:07:10 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 04:07:10 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 04:07:10 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 04:07:10 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 04:07:11 INFO - Downloading docopt-0.6.1.tar.gz 04:07:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:07:11 INFO - Installing collected packages: blobuploader, requests, docopt 04:07:11 INFO - Running setup.py install for blobuploader 04:07:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:07:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:07:11 INFO - Running setup.py install for requests 04:07:11 INFO - Running setup.py install for docopt 04:07:11 INFO - Successfully installed blobuploader requests docopt 04:07:11 INFO - Cleaning up... 04:07:11 INFO - Return code: 0 04:07:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:07: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')]} 04:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07: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')]} 04:07:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:11 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 0x2922030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be13b0>, '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 0x2be22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be2740>, '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-1467803203.72708-96206001', '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 04:07:11 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 04:07:11 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 04:07:11 INFO - Using env: {'DISPLAY': ':0', 04:07:11 INFO - 'HOME': '/home/cltbld', 04:07:11 INFO - 'LANG': 'en_US.UTF-8', 04:07:11 INFO - 'LANGUAGE': 'en_US:en', 04:07:11 INFO - 'LOGNAME': 'cltbld', 04:07:11 INFO - 'MAIL': '/var/mail/cltbld', 04:07:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:11 INFO - 'MOZ_NO_REMOTE': '1', 04:07:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:11 INFO - 'NO_EM_RESTART': '1', 04:07:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:11 INFO - 'PWD': '/builds/slave/test', 04:07:11 INFO - 'SHELL': '/bin/bash', 04:07:11 INFO - 'SHLVL': '1', 04:07:11 INFO - 'TERM': 'linux', 04:07:11 INFO - 'TMOUT': '86400', 04:07:11 INFO - 'USER': 'cltbld', 04:07:11 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467803203.72708-96206001', 04:07:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:11 INFO - '_': '/tools/buildbot/bin/python'} 04:07:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:07:12 INFO - Running setup.py (path:/tmp/pip-xaFVCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:07:12 INFO - Running setup.py (path:/tmp/pip-VM90OH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:07:12 INFO - Running setup.py (path:/tmp/pip-wGwTrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:07:12 INFO - Running setup.py (path:/tmp/pip-PF2RW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:07:12 INFO - Running setup.py (path:/tmp/pip-W4LKQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:07:12 INFO - Running setup.py (path:/tmp/pip-bCMQDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:07:12 INFO - Running setup.py (path:/tmp/pip-iNjHWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:07:12 INFO - Running setup.py (path:/tmp/pip-sQoIng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:07:12 INFO - Running setup.py (path:/tmp/pip-AerdNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:07:12 INFO - Running setup.py (path:/tmp/pip-zwGPsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:07:12 INFO - Running setup.py (path:/tmp/pip-1loIXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:07:12 INFO - Running setup.py (path:/tmp/pip-fkuGFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:07:12 INFO - Running setup.py (path:/tmp/pip-twwYqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:07:12 INFO - Running setup.py (path:/tmp/pip-sPZXnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:13 INFO - Running setup.py (path:/tmp/pip-SB6ofB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:07:13 INFO - Running setup.py (path:/tmp/pip-UvHDlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:07:13 INFO - Running setup.py (path:/tmp/pip-zndpxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:07:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:07:13 INFO - Running setup.py install for manifestparser 04:07:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:07:13 INFO - Running setup.py install for mozcrash 04:07:13 INFO - Running setup.py install for mozdebug 04:07:13 INFO - Running setup.py install for mozdevice 04:07:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:07:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:07:13 INFO - Running setup.py install for mozfile 04:07:13 INFO - Running setup.py install for mozhttpd 04:07:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:07:13 INFO - Running setup.py install for mozinfo 04:07:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:07:13 INFO - Running setup.py install for mozInstall 04:07:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:07:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:07:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:07:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:07:14 INFO - Running setup.py install for mozleak 04:07:14 INFO - Running setup.py install for mozlog 04:07:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:07:14 INFO - Running setup.py install for moznetwork 04:07:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:07:14 INFO - Running setup.py install for mozprocess 04:07:14 INFO - Running setup.py install for mozprofile 04:07:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:07:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:07:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:07:14 INFO - Running setup.py install for mozrunner 04:07:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:07:14 INFO - Running setup.py install for mozscreenshot 04:07:14 INFO - Running setup.py install for moztest 04:07:14 INFO - Running setup.py install for mozversion 04:07:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:07:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:07:15 INFO - Cleaning up... 04:07:15 INFO - Return code: 0 04:07:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:07:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:15 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 0x2922030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be13b0>, '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 0x2be22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be2740>, '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-1467803203.72708-96206001', '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 04:07:15 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 04:07:15 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 04:07:15 INFO - Using env: {'DISPLAY': ':0', 04:07:15 INFO - 'HOME': '/home/cltbld', 04:07:15 INFO - 'LANG': 'en_US.UTF-8', 04:07:15 INFO - 'LANGUAGE': 'en_US:en', 04:07:15 INFO - 'LOGNAME': 'cltbld', 04:07:15 INFO - 'MAIL': '/var/mail/cltbld', 04:07:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:15 INFO - 'MOZ_NO_REMOTE': '1', 04:07:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:15 INFO - 'NO_EM_RESTART': '1', 04:07:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:15 INFO - 'PWD': '/builds/slave/test', 04:07:15 INFO - 'SHELL': '/bin/bash', 04:07:15 INFO - 'SHLVL': '1', 04:07:15 INFO - 'TERM': 'linux', 04:07:15 INFO - 'TMOUT': '86400', 04:07:15 INFO - 'USER': 'cltbld', 04:07:15 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467803203.72708-96206001', 04:07:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:15 INFO - '_': '/tools/buildbot/bin/python'} 04:07:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:07:15 INFO - Running setup.py (path:/tmp/pip-c3zQIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:07:15 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)) 04:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:07:15 INFO - Running setup.py (path:/tmp/pip-rGZtWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:07:15 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)) 04:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:07:15 INFO - Running setup.py (path:/tmp/pip-PzZTgk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:07:15 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)) 04:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:07:15 INFO - Running setup.py (path:/tmp/pip-3HXlQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:07:15 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)) 04:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:07:15 INFO - Running setup.py (path:/tmp/pip-5hdazQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:07:15 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)) 04:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:07:15 INFO - Running setup.py (path:/tmp/pip-VtO1Py-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:07:15 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)) 04:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:07:15 INFO - Running setup.py (path:/tmp/pip-FtlyOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:07:15 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)) 04:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:07:15 INFO - Running setup.py (path:/tmp/pip-en6G0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:07:15 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)) 04:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:07:15 INFO - Running setup.py (path:/tmp/pip-j0K5wb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:07:15 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)) 04:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:07:15 INFO - Running setup.py (path:/tmp/pip-ns3c4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:07:16 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)) 04:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:07:16 INFO - Running setup.py (path:/tmp/pip-yyvhbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:07:16 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)) 04:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:07:16 INFO - Running setup.py (path:/tmp/pip-IUyKfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:07:16 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)) 04:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:07:16 INFO - Running setup.py (path:/tmp/pip-lkrsVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:07:16 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)) 04:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:07:16 INFO - Running setup.py (path:/tmp/pip-WDVH7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:07:16 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)) 04:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:16 INFO - Running setup.py (path:/tmp/pip-0n5Zj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:16 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)) 04:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:07:16 INFO - Running setup.py (path:/tmp/pip-tqkSji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:07:16 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)) 04:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:07:16 INFO - Running setup.py (path:/tmp/pip-9b4ABj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:07:16 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)) 04:07:16 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)) 04:07:16 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)) 04:07:16 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)) 04:07:16 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)) 04:07:16 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)) 04:07:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:07:16 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 04:07:16 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 04:07:16 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 04:07:16 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 04:07:16 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 04:07:16 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 04:07:18 INFO - Downloading blessings-1.6.tar.gz 04:07:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:07:18 INFO - Installing collected packages: blessings 04:07:18 INFO - Running setup.py install for blessings 04:07:18 INFO - Successfully installed blessings 04:07:18 INFO - Cleaning up... 04:07:18 INFO - Return code: 0 04:07:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:07:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:07:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:07:18 INFO - Reading from file tmpfile_stdout 04:07:18 INFO - Current package versions: 04:07:18 INFO - argparse == 1.2.1 04:07:18 INFO - blessings == 1.6 04:07:18 INFO - blobuploader == 1.2.4 04:07:18 INFO - docopt == 0.6.1 04:07:18 INFO - functools32 == 3.2.3-2 04:07:18 INFO - jsonschema == 2.5.1 04:07:18 INFO - manifestparser == 1.1 04:07:18 INFO - mozInstall == 1.12 04:07:18 INFO - mozcrash == 0.17 04:07:18 INFO - mozdebug == 0.1 04:07:18 INFO - mozdevice == 0.48 04:07:18 INFO - mozfile == 1.2 04:07:18 INFO - mozhttpd == 0.7 04:07:18 INFO - mozinfo == 0.9 04:07:18 INFO - mozleak == 0.1 04:07:18 INFO - mozlog == 3.2 04:07:18 INFO - moznetwork == 0.27 04:07:18 INFO - mozprocess == 0.22 04:07:18 INFO - mozprofile == 0.28 04:07:18 INFO - mozrunner == 6.11 04:07:18 INFO - mozscreenshot == 0.1 04:07:18 INFO - mozsystemmonitor == 0.3 04:07:18 INFO - moztest == 0.7 04:07:18 INFO - mozversion == 1.4 04:07:18 INFO - psutil == 3.1.1 04:07:18 INFO - requests == 1.2.3 04:07:18 INFO - wsgiref == 0.1.2 04:07:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:07:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:18 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 0x2922030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be13b0>, '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 0x2be22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be2740>, '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-1467803203.72708-96206001', '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 04:07:18 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 04:07:18 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 04:07:18 INFO - Using env: {'DISPLAY': ':0', 04:07:18 INFO - 'HOME': '/home/cltbld', 04:07:18 INFO - 'LANG': 'en_US.UTF-8', 04:07:18 INFO - 'LANGUAGE': 'en_US:en', 04:07:18 INFO - 'LOGNAME': 'cltbld', 04:07:18 INFO - 'MAIL': '/var/mail/cltbld', 04:07:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:18 INFO - 'MOZ_NO_REMOTE': '1', 04:07:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:18 INFO - 'NO_EM_RESTART': '1', 04:07:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:18 INFO - 'PWD': '/builds/slave/test', 04:07:18 INFO - 'SHELL': '/bin/bash', 04:07:18 INFO - 'SHLVL': '1', 04:07:18 INFO - 'TERM': 'linux', 04:07:18 INFO - 'TMOUT': '86400', 04:07:18 INFO - 'USER': 'cltbld', 04:07:18 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467803203.72708-96206001', 04:07:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:18 INFO - '_': '/tools/buildbot/bin/python'} 04:07:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:19 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)) 04:07:19 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)) 04:07:19 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)) 04:07:19 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)) 04:07:19 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)) 04:07:19 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)) 04:07:19 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)) 04:07:19 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)) 04:07:19 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)) 04:07:19 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)) 04:07:19 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)) 04:07:19 INFO - Cleaning up... 04:07:19 INFO - Return code: 0 04:07:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:19 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 0x2922030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be13b0>, '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 0x2be22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be2740>, '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-1467803203.72708-96206001', '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 04:07:19 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 04:07:19 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 04:07:19 INFO - Using env: {'DISPLAY': ':0', 04:07:19 INFO - 'HOME': '/home/cltbld', 04:07:19 INFO - 'LANG': 'en_US.UTF-8', 04:07:19 INFO - 'LANGUAGE': 'en_US:en', 04:07:19 INFO - 'LOGNAME': 'cltbld', 04:07:19 INFO - 'MAIL': '/var/mail/cltbld', 04:07:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:19 INFO - 'MOZ_NO_REMOTE': '1', 04:07:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:19 INFO - 'NO_EM_RESTART': '1', 04:07:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:19 INFO - 'PWD': '/builds/slave/test', 04:07:19 INFO - 'SHELL': '/bin/bash', 04:07:19 INFO - 'SHLVL': '1', 04:07:19 INFO - 'TERM': 'linux', 04:07:19 INFO - 'TMOUT': '86400', 04:07:19 INFO - 'USER': 'cltbld', 04:07:19 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467803203.72708-96206001', 04:07:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:19 INFO - '_': '/tools/buildbot/bin/python'} 04:07:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:07:19 INFO - Cleaning up... 04:07:19 INFO - Return code: 0 04:07:19 INFO - Running post-action listener: _resource_record_post_action 04:07:19 INFO - Running post-action listener: _start_resource_monitoring 04:07:19 INFO - Starting resource monitoring. 04:07:19 INFO - ##### 04:07:19 INFO - ##### Finished create-virtualenv step (success) 04:07:19 INFO - ##### 04:07:19 INFO - ##### 04:07:19 INFO - ##### Running install step. 04:07:19 INFO - ##### 04:07:19 INFO - Running pre-action listener: _resource_record_pre_action 04:07:19 INFO - Running main action method: install 04:07:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:07:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:07:19 INFO - Reading from file tmpfile_stdout 04:07:19 INFO - Detecting whether we're running mozinstall >=1.0... 04:07:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:07:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:07:19 INFO - Reading from file tmpfile_stdout 04:07:19 INFO - Output received: 04:07:19 INFO - Usage: mozinstall [options] installer 04:07:19 INFO - Options: 04:07:19 INFO - -h, --help show this help message and exit 04:07:19 INFO - -d DEST, --destination=DEST 04:07:19 INFO - Directory to install application into. [default: 04:07:19 INFO - "/builds/slave/test"] 04:07:19 INFO - --app=APP Application being installed. [default: firefox] 04:07:19 INFO - mkdir: /builds/slave/test/build/application 04:07:19 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'] 04:07:19 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 04:07:35 INFO - Reading from file tmpfile_stdout 04:07:35 INFO - Output received: 04:07:35 INFO - /builds/slave/test/build/application/firefox/firefox 04:07:35 INFO - Running post-action listener: _resource_record_post_action 04:07:35 INFO - ##### 04:07:35 INFO - ##### Finished install step (success) 04:07:35 INFO - ##### 04:07:35 INFO - ##### 04:07:35 INFO - ##### Running run-tests step. 04:07:35 INFO - ##### 04:07:35 INFO - Running pre-action listener: _resource_record_pre_action 04:07:35 INFO - Running main action method: run_tests 04:07:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:07:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:07:35 INFO - Python 2.7.3 04:07:35 INFO - Return code: 0 04:07:35 INFO - grabbing minidump binary from tooltool 04:07:35 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')]} 04:07:35 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 0x2be13b0>, '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 0x2be22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be2740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:07:35 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 04:07:35 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 04:07:35 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 04:07:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:07:36 INFO - Return code: 0 04:07:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:07:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:07:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:07:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:07:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:07:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Kbljgn8EREeLU84WFBVQNw/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 04:07:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Kbljgn8EREeLU84WFBVQNw/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 04:07:36 INFO - Using env: {'DISPLAY': ':0', 04:07:36 INFO - 'HOME': '/home/cltbld', 04:07:36 INFO - 'LANG': 'en_US.UTF-8', 04:07:36 INFO - 'LANGUAGE': 'en_US:en', 04:07:36 INFO - 'LOGNAME': 'cltbld', 04:07:36 INFO - 'MAIL': '/var/mail/cltbld', 04:07:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:07:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:07:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:36 INFO - 'MOZ_NO_REMOTE': '1', 04:07:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:07:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:36 INFO - 'NO_EM_RESTART': '1', 04:07:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:36 INFO - 'PWD': '/builds/slave/test', 04:07:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:07:36 INFO - 'SHELL': '/bin/bash', 04:07:36 INFO - 'SHLVL': '1', 04:07:36 INFO - 'TERM': 'linux', 04:07:36 INFO - 'TMOUT': '86400', 04:07:36 INFO - 'USER': 'cltbld', 04:07:36 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467803203.72708-96206001', 04:07:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:36 INFO - '_': '/tools/buildbot/bin/python'} 04:07:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Kbljgn8EREeLU84WFBVQNw/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 04:07:36 INFO - mozversion application_buildid: 20160706032423 04:07:36 INFO - mozversion application_changeset: 4eedf5c4e7e25be86832759f4a834608fb88ac6c 04:07:36 INFO - mozversion application_display_name: Nightly 04:07:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:07:36 INFO - mozversion application_name: Firefox 04:07:36 INFO - mozversion application_remotingname: firefox 04:07:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:07:36 INFO - mozversion application_vendor: Mozilla 04:07:36 INFO - mozversion application_version: 50.0a1 04:07:36 INFO - mozversion platform_buildid: 20160706032423 04:07:36 INFO - mozversion platform_changeset: 4eedf5c4e7e25be86832759f4a834608fb88ac6c 04:07:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:07:36 INFO - mozversion platform_version: 50.0a1 04:07:36 INFO - using testdate: 1467803256 04:07:36 INFO - actual date: 1467803256 04:07:36 INFO - starting webserver on 'localhost:60141' 04:07:36 INFO - SUITE-START | Running 2 tests 04:07:36 INFO - TEST-START | dromaeo_css 04:07:36 INFO - operating with platform_type : linux_ 04:07:36 INFO - Initialising browser for dromaeo_css test... 04:07:36 INFO - TEST-INFO | started process 7531 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_ggehk/profile http://localhost:60141/getInfo.html) 04:07:40 INFO - PROCESS | 7531 | __metrics Screen width/height:1600/1200 04:07:40 INFO - PROCESS | 7531 | colorDepth:24 04:07:40 INFO - PROCESS | 7531 | Browser inner width/height: 1024/697 04:07:40 INFO - PROCESS | 7531 | __metrics 04:07:41 INFO - PROCESS | 7531 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:07:42 INFO - TEST-INFO | 7531: exit 0 04:07:42 INFO - Browser initialized. 04:07:42 INFO - Running cycle 1/1 for dromaeo_css test... 04:07:42 INFO - TEST-INFO | started process 7614 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_ggehk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:07:54 INFO - PROCESS | 7614 | RSS: Main: 159227904 04:07:54 INFO - PROCESS | 7614 | 04:08:45 INFO - PROCESS | 7614 | 1467803325107 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] 04:10:57 INFO - PROCESS | 7614 | Cycle 1(1): loaded http://localhost:60141/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60141/tests/dromaeo/cssquery-ext.html) 04:10:59 INFO - PROCESS | 7614 | RSS: Main: 271011840 04:10:59 INFO - PROCESS | 7614 | 04:14:02 INFO - PROCESS | 7614 | Cycle 1(1): loaded http://localhost:60141/tests/dromaeo/cssquery-ext.html (next: http://localhost:60141/tests/dromaeo/cssquery-jquery.html) 04:14:02 INFO - PROCESS | 7614 | RSS: Main: 235581440 04:14:02 INFO - PROCESS | 7614 | 04:17:04 INFO - PROCESS | 7614 | Cycle 1(1): loaded http://localhost:60141/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60141/tests/dromaeo/cssquery-mootools.html) 04:17:05 INFO - PROCESS | 7614 | RSS: Main: 241709056 04:17:05 INFO - PROCESS | 7614 | 04:20:07 INFO - PROCESS | 7614 | Cycle 1(1): loaded http://localhost:60141/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60141/tests/dromaeo/cssquery-prototype.html) 04:20:08 INFO - PROCESS | 7614 | RSS: Main: 239607808 04:20:08 INFO - PROCESS | 7614 | 04:23:11 INFO - PROCESS | 7614 | Cycle 1(1): loaded http://localhost:60141/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60141/tests/dromaeo/cssquery-yui.html) 04:23:11 INFO - PROCESS | 7614 | RSS: Main: 212246528 04:23:11 INFO - PROCESS | 7614 | 04:26:14 INFO - PROCESS | 7614 | Cycle 1(1): loaded http://localhost:60141/tests/dromaeo/cssquery-yui.html (next: http://localhost:60141/tests/dromaeo/cssquery-dojo.html) 04:26:14 INFO - PROCESS | 7614 | RSS: Main: 271917056 04:26:14 INFO - PROCESS | 7614 | 04:26:14 INFO - PROCESS | 7614 | __start_tp_report 04:26:14 INFO - PROCESS | 7614 | _x_x_mozilla_page_load 04:26:14 INFO - PROCESS | 7614 | _x_x_mozilla_page_load_details 04:26:14 INFO - PROCESS | 7614 | |i|pagename|runs| 04:26:14 INFO - PROCESS | 7614 | |0;dojo.html;2593.053535459557;2597.5454295498284;2628.2378110348;2632.9341766455836;2635.262126604551;4555.498895121534;4661.603763680091;4680.157571637108;4680.344751734756;4690.0385420988705;4646.767661616923;4691.319758634996;4693.108309421207;4725.362076119723;4727.101850648374;4287.592678695519;4289.806958686859;4357.586029327209;4391.538888416718;4477.70894891831;4401.493828209749;4434.623057040139;4437.179121862449;4446.066326071513;4472.262076757347;4249.575042495757;4296.699231053827;4305.655547556188;4317.460317460317;4369.519352871213;4311.8490852820005;4325.52419233884;4366.454193225847;4374.212641724488;4375.846845360429;4366.235908715962;4368.995131119828;4371.038371558252;4394.033312671208;4409.536998615131;4589.862304130881;4661.673682842203;4764.666473346867;4782.904341913142;4797.52024797521;5102.38771347437;5106.259592359124;5121.155009423441;5121.308623335839;5122.795088196468;4933.260010998343;5113.335266415379;5153.458886816905;5159.406668233126;5160.225966105077;4678.883027924295;4725.976370118196;4730.361401210793;4763.54746299101;4778.832740854054;5218.191180367049;5231.189165679326;5233.502817232356;5233.842984710464;5238.97380513095;4875.756212189376;4927.236278376858;4938.901221975612;4960.379952505937;4984.800607975641;5089.3638295213095;5127.077126117335;5156.04613146569;5170.870728231825;5175.585953123741;5074.3657042869645;5083.339165908408;5087.186050231945;5087.26234695967;5138.486151384906;4819.831305904277;5036.194208926554;5043.823466178666;5044.344235249394;5046.84859454217;4152.875413737593;4171.0615111600255;4213.494380674339;4216.7259128156575;4256.148770245902;3708.517892673935;3709.629037096269;3711.1649878777057;3745.569259535134;3749.1751814600743;4373.322135069069;4382.430284063052;4387;4422.447194100738;4426.667999900021;4878.487758785347;4918.827841025547;5019.372578427697;5066.316047333637;5082.415522214918;4369.781510924441;4377.737335759864;4384.978075109604;4388.166248412791;4431.069475410135;4502.549745025537;4504.752238626907;4514.367988481616;4514.932276015862;4555.293929440942;4669.252919532859;4713.929291060568;4791.401074865642;4791.688540244873;4803.471618121934;4991.47589503097;4992.475790041994;5051.4443411224;5051.696898186121;5084.1102807009365;4690.132325519789;4755.857324280277;4758.262469317261;4760.238361862085;4812.181929071996;4967.3542439482635;4997.375328083989;5031.84904452867;5038.974805125951;5047.722375269395;5083.6187285952965;5107.9489205107475;5113.846584602468;5116.488351164854;5165.845024649267;4804.759762011955;4838.322634831056;4936.75316234194;4951.455339912679;4957.479464656303;4855.830045948375;4888.804447822047;4907.484714104968;4913.140200464976;4960.851174464772;4825.420949486084;4831.202851529459;4832.420109586872;4863.513648635108;4880.755962201947;4777.641676874179;4888.095702295087;4939.234418665113;4942.357493525962;4984;4824.107540105092;4845.515448455268;4846.709197448165;4888.144574699342;4895.363602731622 04:26:14 INFO - PROCESS | 7614 | |1;ext.html;547.2860935657942;576.5733357315588;581.2414798687711;592.1502643706282;603.577495752973;27550.311242218955;27958.301042473922;39898.2020359593;40585.79707101468;40647.59352406475;39657.20685586294;40300.19399612006;40316;40356.19287614253;40382.19235615286;7913.920860791391;8053.838923221532;8060.838783224332;8067.515949043076;8072.475289106189;7491.138519070322;10184.388936663787;10452.634157804478;10473.057424831764;10768;10419.218558608096;10498.055175034246;10503.894961050406;10511.106555942753;10528.842067368996;10180.949095254513;10239.385636861738;10241.948790256076;10245.948770256176;10250.487475626263;10312.1234695051;10370.37777733331;10379.948100259451;10389.168866490738;10392.220583456272;38302.80848595767;38583.614163858285;38651.8067409664;38672.41991370132;38706.80646596777;3059.938801223985;3078.5228289615147;3121.0480803354967;3299.6700329967052;3363.445031569788;29245.26886827825;29390.265243368875;29619.40761184786;30405;30539.694603053907;3345.5149003394613;3542.1144713821545;3548.520949671787;3568.3220188164164;3636.4181730922924;256345;256846;257141;257684;258088.7095564529;52810.99999999923;52811.471885280655;52911.470885290655;53100.73449632727;53118.73440632772;55699.72150139305;55749.72125139349;55850;55919;55945.16082258769;11628.127890408085;13321.66695832612;13540.661483462993;13551.932240338736;13566.728665426635;9919.156871665846;10151.390916544884;10265.897341026643;10282.28024038325;10471.057604815604;16104.597385065234;16175.19124043793;16179.110148941685;16206.594835129215;16237;5245.895082098336;6080.14877917092;6263.78076767311;6286.9056964145575;6334.461570766444;810.5866008335792;863.7322430046705;886.663068034143;917.559571405729;940.5391358234416;27025;27754.72245277562;28417.71582284192;28781.424371512872;28869;920.0661328751323;955.5413401567148;965.6909788867495;975.6975337645353;1004.8191325561323;14403.226925401994;14761.483348082766;14874.330655120546;14942.775858362133;14988.925055374653;384304;384376;386444;387093;387351;48821.511784881695;48938.510614894105;48944.75527622339;48948;48949;1081.1566977757361;1122.1303489795312;1187.441902305915;1208.945597448117;1244.2223610243598;26391.832980042516;28951;29262.268443288238;29270.466598333125;29774.702252977193;41684.79157604314;41810.790946045076;42088;42134;42262.15475690408;294242;295442;296375;296912;297259;22215.55568888581;24373.3906652328;24648.630270546313;25292.74707252904;25484.872575637004;41107.58892411038;41476.377854332815;42084.789576051924;42104.3684344729;42388.78805605952;35644.643553564136;35723.28553428969;37223.441648374755;37230.44154337741;37264.44103338398;35816.46275305925;35821.28357432889;36139.27721445609;36422.8178859104;36460;35262.647373525935;35437.29125417529;35758.28483430369;36377.27245455129;36424;31783;32924.34151317008;33196.33607327792;33318.66681333253;33529.49705754367;24900.62649060302;24982.250532484053;25250.873745631154;25378.873105634353;25477.74522254754 04:26:14 INFO - PROCESS | 7614 | |2;jquery.html;345.68715312642036;377.12883239716257;379.6090027271909;383.83878770916203;397.49319617487697;12691.873081269185;15967.600809979756;16254.674906501878;16886.071266080362;17716.64566708665;16735.66528669429;16893.564047055985;17045.403410880623;17501.299948002095;17635.55911102223;4604.963883126304;5005.19916813309;5197;5200.479952004788;5208.947910520903;5124.052050370675;5140.640155189139;5171.095058364771;5180.663256888309;5198.246254293125;4953.876153096166;5131.717755523445;5138.383393992726;5140.640155189139;5160.354955630546;5107.672005278636;5113.386393632769;5119.616028797818;5128.512791284803;5132.255822905658;4424.446944131983;4598.816047358102;4606.286025666027;4611.538846115395;4617.861464156081;21229.25697600592;21296.574068518545;21497;21966.450838729;21996.340109796733;1945.319138301583;1978.584497255578;2025.5645036317262;2486.8010559155223;2529.8988040478357;13267.137636053625;13459.327033648278;13545.45818167272;13918.791218131737;14008;1756.4291605228225;1764.126757255167;1769.619531800669;1790.8477779388638;1803.0984507746127;66324.3367566323;68734.65632671854;69152.30847691509;69516.304836952;69637.65181174062;8579.528125953007;9247.907520924704;9587.568559414844;9679.419234845791;9977.777887273236;12071.879281207252;12985.740285194242;12998.480060797652;13456.25990570528;13484.730305393838;7137.393321567621;7260.41916646667;7323.963380183065;7394.223606521346;7410.073740782403;6780.796576102724;6803.965980170166;6827.658617069127;6879.071325371111;6900.171979362408;6077.453029227391;6210.130581718563;6269.019783056551;6285.340039295808;6303.684815759194;1747.475757272813;1766.9116544172998;1784.5092599534971;1812.592166762468;1850.2229063793238;790.7785819970418;885.9867101993475;918.320442872283;950.8114856429463;980.4803454169302;17023;17984.370547031052;17996.9100154501;18017.009064501315;18299.81700182981;870.3559366069063;876.5748611923212;896.0815164456354;910.2490445382585;913.5021413329752;9691.563879625433;10297.227707921937;10359.533820978075;10500.684979450476;10540.683779486628;354784;369746;370930;373539;375779;67290;67567;68031;68347;68369.31630683629;916.1617120334952;928.03020843219;930.8510638297976;935.420039575454;937.6108914800418;15685.529434116996;15797.921010394875;15908.76136857925;15933.920330398274;16104.67790644204;25037.374065648506;32695.346093078482;33468.33063338768;34913.65086349104;35048.47427288644;43076;44101;45295;45632.087358251985;45804;7469.663865125974;7594.620268986418;7707.2292770724725;7757.1467138615835;7914.1294457608465;11753.941230293794;11864.288142711464;12056.578019769266;12099.57651482194;12142.150049496451;9765.804683906425;10106.242031847787;10379.429131397847;10411.11505522039;10653.934606539284;10728.195385345975;10749.462526873782;10947.56209751601;11050.226484146033;11133.276337038067;10522;10644.946775266075;10700.571977120828;10907.181961352771;10995.065419439437;7511.73708920207;7690.884636730341;7691.769246922601;7818.413618978486;7869.685212591432;9459.432434053704;9523.142917137491;9564.856527151958;9726.610935562498;9741.415515069119 04:26:14 INFO - PROCESS | 7614 | |3;mootools.html;1253.6176466177817;1327.6017194841545;1355.0920883008384;1694.5509439998402;1701.072915261184;7754.457187996843;8258.587070646474;8303.460275082123;8304.377171712116;8306.460080094797;7026.508144429879;7693.807654808633;7989.5605741684185;8031.558264295461;8145.91854081459;2250.6511490718963;2271.65925111233;2279.099755596538;2280.065173278956;2281.4296425893526;2220.733511978565;2228.6434170532716;2286.039863257436;2286.965695514569;2289.3589794857467;1947.2405761752927;2085.4994801247744;2172.1311475409884;2178.1287485005964;2193.7367515898113;2229.8216142708543;2233.9888300558555;2258.525709600986;2258.9887050564644;2288.0962020002007;2250.9887450562805;2257.0745994142485;2257.1422859313357;2258.9096436142536;2259.480319526518;8132.674693012332;8194.836103277961;8199.22107399796;8199.42604017719;8207.261346478786;4732.1482133216;4738.265568836836;4759.190937540592;4868.196747536652;4873.31773551703;2764.958525622117;2822.7318404751722;2836.5886946392657;2860.6567211934703;2897.6522817261853;867.6269204242174;892.9151730585584;902.7878448564582;908.1644886704182;923.9907600923972;10834.133269338434;10838.566457341696;10843.566257349776;10859.891401085966;10875.782484350348;4112.355057976773;4267.039916018933;4382.364557139197;4384.3204303332395;4424.402705634762;9332.533373331305;9339.766505837408;9341.626334946663;9403.57683904226;9424.717258482257;4840.782164802592;4847.61219102478;4848.5636292733825;4849.199882019498;4851.029794041206;4330.870073897788;4354.150940566622;4386.1447017831215;4392.143532011291;4394.626456751148;3722.8696995605565;3804.2962052020466;3856.4793752843007;3871.322518559241;3877.8254978526033;1054.267284237463;1176.847009888726;1198.7003249187703;1205.5057426455112;1214.5991822698666;667.4093427316859;719.1909102259957;795.3442303048829;800.627708115729;824.6330382979517;4965.8013679452415;5143.27994080829;5194.6104042196985;5216.713080780593;5241.764120614582;868.0885070675765;875.9912400876037;884.540039179623;893.9821203576022;903.1781079218011;3459.567554055743;3531.735119865969;3531.9823400883347;3535.876244331436;3549.07723991764;9554.808903821884;9974.501274936225;10084.596616135272;10087.646932357333;10127.797444051077;10020.549075291628;10025.849612255823;10027.29808913369;10038.44788536623;10045;6637.336266373421;7237.565746055148;7476;7577.621118944031;7584.886226706604;5331.733413329241;5477.068898287221;5477.507024367666;5651.689157096399;5711.114777209539;9179.862302065609;9290.535473226448;9291.117343852324;9303.72088837336;9303.953480232556;9087.500187489752;9278.768030799283;9344.065593440602;9395.436273823592;9628.18160456369;6737.528373013842;6747.730090796314;6814.93185068143;6852.794416167523;6860.348266914635;7691.923080769121;7746.109197442366;7784.532928024337;7861.331786798186;7907.051153861574;5369.57043436532;7028.402585780266;7049.29507049291;7127.928720712934;7310.780676579711;6926.341997510229;7027.367536921497;7038.085048943604;7075.433965282662;7193.2087470379265;6051.788187413419;6065.6663883486835;6122.265328160649;6124.5712800103565;6126.754929802936;4548.795304211252;4633.397658304399;4636.466806317317;4693.647976401715;4744.1460537102275;4397.2964325707735;4433.623142032834;4440.6669499788295;4506.459224893034;4621.260598304255 04:26:14 INFO - PROCESS | 7614 | |4;prototype.html;301.30849699938653;303.4295524414102;307.5540466323831;311.2731771313982;311.5980385302959;4855.635827312948;4903.264510323449;4928.3593132892765;4933.309336692866;4960.379952505937;4851.587615052716;4880.46314905361;4882.829100981467;4886.169351210294;4898.240772680231;3873.876575793017;3881.941770873425;3885.747426417274;3887.2225554888996;3896.941545876814;3742;3859.649122807023;3861.1813376235364;3875.360565506688;3879.7866117363533;3764.491793607869;3767.321882061228;3795.924081518368;3813.504244448218;3815.798023622564;3761.661450469457;3793.3172029034763;3806.5812760596314;3808.1622043150464;3818.694504439638;3209.679032096795;3315.1712071982006;3316.507571592793;3319.767616266862;3326.268220991378;4425.645948324159;4587.9082418351445;4634.582887540104;4698.882527936795;4718.961828397747;4324.329728892027;4329.956700433018;4341.481940474518;4346.869593912188;4381.422687832378;5033.84898453047;5046.899062018776;5060.7722652480725;5060.873478163038;5115.2071428928575;3378.847951842173;3517.384457719889;3632.891013269606;3635.8727444539577;3655.798931058791;4981.676191047571;5153.175491921274;5248.553872920768;5257.526822585985;5263.421023687391;3639.490471334015;3681.650243226889;3689.524190323892;3689.6863766579604;3767.246550689873;3809.1619843634357;3819.770813751128;3828;3831.3946516369137;3844.942325865114;4343.717658352197;4357.869263922024;4369.75966321849;4371.366151907955;4378.642620787566;4913.459519452857;5005.424376196784;5018.222175562793;5040.39515258164;5056.26684130799;1278.4247088810073;1297.1309222820544;1310.1549500572078;1310.4037662863375;1311.895048396126;839.8698201778734;854.4275335525213;870.6909047288248;872.4372779557277;881.9735407937773;4000.4999375078114;4000.6999475038906;4015.7791321477016;4031.737937034083;4049.838006479708;4573.565511276423;4580.633549316113;4599.034202817379;4601.5168407317415;4656.67403281767;4016.4376987221813;4041.818118184689;4054.675625949917;4061.050695666097;4061.5532291447917;2486.6767320248614;2578.742125787444;2747.738964798341;2779.2357101796765;2791.232411086967;4950.886050638577;4956.330895329156;4959.2809042688605;4964.808445972941;4971.975140124277;5348.171033489815;5362.731863406814;5387.191921211771;5390.380106287748;5391.676499410048;4843.878903027382;5010.448850626428;5010.974945125251;5019.222020586742;5030.3963524377305;5255.395629502656;5265.552428043659;5267.3384055112265;5270.657407268515;5333.439988801275;4918.901621967469;5171.663841850268;5175.870603234949;5193.37679478465;5224.738763061908;4784.545468180518;4828.396450443694;4992.550670439678;4993.675411098267;4998.800047998039;3714.9628503714616;3716.646918542734;3722.516072910504;3737.2151848112203;3754.9624503754612;5220.347456567929;5298.178782288752;5299.602529810357;5302.814401495929;5313.176457648916;4843.854684359475;5023.6985780853265;5052.418971818288;5065.518775716301;5123.257127716534;5043.218301163325;5047.798088076436;5051.494850514919;5059.760358712139;5060.51925067118;4972.378452693413;4980.601551875769;4991.326170967018;4999.77501012448;5010.248462730619;4829.782659780389;5124.488275958526;5129.7691603877165;5133.486651334837;5160.354955630546;4964.00719856023;4966.994968044281;4970.950290497049;4975.477574854588;5022.397312322545 04:26:14 INFO - PROCESS | 7614 | |5;yui.html;634.6921742954667;667.2826711285369;683.9726410943563;693.8785712500311;729.227019359479;11635.883641163586;12269.693257668563;12340.382980850967;12345.938270308658;12362.381880905952;13265.33673316335;14033.78949315761;14048.71902561948;14666.706665866675;14676.119432834037;625.7403177681257;758.0562200060932;777.2616014785933;793.9087004994412;796.6574373019599;783.0720596093647;797.1669605262485;797.8085259537698;797.8404319136167;798.6126728536684;832.7418500264937;838.0153319849153;838.6393850644221;839.1440730454932;841.877927700483;644.8613548087137;789.2107892107892;815.9510429374257;835.4110352201683;836.5273620404452;599.868029033612;600.0818747316613;602.2592211579781;602.4577879908118;602.7980626490131;12458.501659933592;12485.56300529477;12495.375231238493;12502.312372819491;12510.37448127599;10969.945150274198;11431.428428578538;11790.410479476077;11959.701007474796;12277.20198187124;11356.943215283953;11458.312501249868;11511.251768635011;11578.71053223676;11705.005074568671;4014.879553613396;4015.477987861559;4057.1479989202303;4091.7954102294766;4122.484689413824;60555.394446055856;62730;62970.685146573975;63291;63620;9789.706308810748;9828.705138845846;9846.753831154278;9887.30788844774;9972.551235194434;17242.482725518003;17371.218295176746;17396.565085872702;17433.21550530229;17823.37618183383;6422.614643121427;6494.675266236669;6591.6374599397495;6676.608925088895;6728.259891411941;3558.365139949103;3563.251717139378;3570.4644303354185;3618.656227658421;3689.7786132832116;2772.334639686461;2873.6838947715733;2876.827390356543;2889.6532416110203;2904.361040571071;483.32817383836493;484.4549881383444;494.4388119484411;506.45556027270834;511.10046318479743;488.0824050784502;535.1010302691437;564.2720890051869;613.9754409823646;625.1154616218091;8022.157673444321;8239.95880020596;8314.210150035737;8420.4947703138;8448.788780280542;576.5358886096649;581.7469400810661;586.7799575159315;614.6035806904522;618.038949433626;4084.3873418986796;4201.327787553977;4237.512686041083;4259.734585768135;4296.462942132233;77972.61013694895;94380;100166.4991675037;100539.97300134964;100624.4968775166;48270.27594586084;71001.2899871005;75818;81372.59313703394;81512.59243703862;43809.56190438118;45629;54848.45151548513;55115;66176;8671.08953559867;8845.115488451103;8890.911090889009;8932.86600700977;8940.329475289249;39561;40861.38707919443;45113.32330015118;45166.32250516311;45902.54097458983;40902.772916812544;40936.38595421011;41011;55515;63735.3626463748;11815.76368472643;12001.63995080149;12019;12233.449494772578;12311.261324320569;13573.79639305431;13582.524611638546;13836.930815345859;13858.653533661336;14349.282535873373;7607.695692172251;11164;11298.60454884075;12615.180013299107;12913.806292905427;11921.761564768483;12989.870101298866;13375.331233438095;13412.93293533526;13470.79793803074;12645.620631381073;12806.167599106027;13094.607161785161;13241.740724504827;13379.464821407035;10888.455577221266;11078.944605277244;11134;11163.330200188015;11269.943650281695;10721.142308615448;10833.566657333618;10910.61812836547;11027.669169924915;11030.393328367018 04:26:14 INFO - PROCESS | 7614 | __end_tp_report 04:26:14 INFO - PROCESS | 7614 | __start_cc_report 04:26:14 INFO - PROCESS | 7614 | _x_x_mozilla_cycle_collect,1102 04:26:14 INFO - PROCESS | 7614 | __end_cc_report 04:26:14 INFO - PROCESS | 7614 | __startTimestamp1467804374928__endTimestamp 04:26:14 INFO - PROCESS | 7614 | 04:26:14 INFO - PROCESS | 7614 | ------- Summary: start ------- 04:26:14 INFO - PROCESS | 7614 | Number of tests: 6 04:26:14 INFO - PROCESS | 7614 | 04:26:14 INFO - PROCESS | 7614 | [#0] dojo.html Cycles:165 Average:4672.92 Median:4791.69 stddev:497.74 (10.4%) stddev-sans-first:471.77 04:26:14 INFO - PROCESS | 7614 | Values: 2593.1 2597.5 2628.2 2632.9 2635.3 4555.5 4661.6 4680.2 4680.3 4690.0 4646.8 4691.3 4693.1 4725.4 4727.1 4287.6 4289.8 4357.6 4391.5 4477.7 4401.5 4434.6 4437.2 4446.1 4472.3 4249.6 4296.7 4305.7 4317.5 4369.5 4311.8 4325.5 4366.5 4374.2 4375.8 4366.2 4369.0 4371.0 4394.0 4409.5 4589.9 4661.7 4764.7 4782.9 4797.5 5102.4 5106.3 5121.2 5121.3 5122.8 4933.3 5113.3 5153.5 5159.4 5160.2 4678.9 4726.0 4730.4 4763.5 4778.8 5218.2 5231.2 5233.5 5233.8 5239.0 4875.8 4927.2 4938.9 4960.4 4984.8 5089.4 5127.1 5156.0 5170.9 5175.6 5074.4 5083.3 5087.2 5087.3 5138.5 4819.8 5036.2 5043.8 5044.3 5046.8 4152.9 4171.1 4213.5 4216.7 4256.1 3708.5 3709.6 3711.2 3745.6 3749.2 4373.3 4382.4 4387.0 4422.4 4426.7 4878.5 4918.8 5019.4 5066.3 5082.4 4369.8 4377.7 4385.0 4388.2 4431.1 4502.5 4504.8 4514.4 4514.9 4555.3 4669.3 4713.9 4791.4 4791.7 4803.5 4991.5 4992.5 5051.4 5051.7 5084.1 4690.1 4755.9 4758.3 4760.2 4812.2 4967.4 4997.4 5031.8 5039.0 5047.7 5083.6 5107.9 5113.8 5116.5 5165.8 4804.8 4838.3 4936.8 4951.5 4957.5 4855.8 4888.8 4907.5 4913.1 4960.9 4825.4 4831.2 4832.4 4863.5 4880.8 4777.6 4888.1 4939.2 4942.4 4984.0 4824.1 4845.5 4846.7 4888.1 4895.4 04:26:14 INFO - PROCESS | 7614 | 04:26:14 INFO - PROCESS | 7614 | [#1] ext.html Cycles:180 Average:47010.71 Median:18446.47 stddev:83476.54 (452.5%) stddev-sans-first:83637.82 04:26:14 INFO - PROCESS | 7614 | Values: 547.3 576.6 581.2 592.2 603.6 27550.3 27958.3 39898.2 40585.8 40647.6 39657.2 40300.2 40316.0 40356.2 40382.2 7913.9 8053.8 8060.8 8067.5 8072.5 7491.1 10184.4 10452.6 10473.1 10768.0 10419.2 10498.1 10503.9 10511.1 10528.8 10180.9 10239.4 10241.9 10245.9 10250.5 10312.1 10370.4 10379.9 10389.2 10392.2 38302.8 38583.6 38651.8 38672.4 38706.8 3059.9 3078.5 3121.0 3299.7 3363.4 29245.3 29390.3 29619.4 30405.0 30539.7 3345.5 3542.1 3548.5 3568.3 3636.4 256345.0 256846.0 257141.0 257684.0 258088.7 52811.0 52811.5 52911.5 53100.7 53118.7 55699.7 55749.7 55850.0 55919.0 55945.2 11628.1 13321.7 13540.7 13551.9 13566.7 9919.2 10151.4 10265.9 10282.3 10471.1 16104.6 16175.2 16179.1 16206.6 16237.0 5245.9 6080.1 6263.8 6286.9 6334.5 810.6 863.7 886.7 917.6 940.5 27025.0 27754.7 28417.7 28781.4 28869.0 920.1 955.5 965.7 975.7 1004.8 14403.2 14761.5 14874.3 14942.8 14988.9 384304.0 384376.0 386444.0 387093.0 387351.0 48821.5 48938.5 48944.8 48948.0 48949.0 1081.2 1122.1 1187.4 1208.9 1244.2 26391.8 28951.0 29262.3 29270.5 29774.7 41684.8 41810.8 42088.0 42134.0 42262.2 294242.0 295442.0 296375.0 296912.0 297259.0 22215.6 24373.4 24648.6 25292.7 25484.9 41107.6 41476.4 42084.8 42104.4 42388.8 35644.6 35723.3 37223.4 37230.4 37264.4 35816.5 35821.3 36139.3 36422.8 36460.0 35262.6 35437.3 35758.3 36377.3 36424.0 31783.0 32924.3 33196.3 33318.7 33529.5 24900.6 24982.3 25250.9 25378.9 25477.7 04:26:14 INFO - PROCESS | 7614 | 04:26:14 INFO - PROCESS | 7614 | [#2] jquery.html Cycles:180 Average:23346.73 Median:24859.72 stddev:60736.22 (244.3%) stddev-sans-first:60882.05 04:26:14 INFO - PROCESS | 7614 | Values: 345.7 377.1 379.6 383.8 397.5 12691.9 15967.6 16254.7 16886.1 17716.6 16735.7 16893.6 17045.4 17501.3 17635.6 4605.0 5005.2 5197.0 5200.5 5208.9 5124.1 5140.6 5171.1 5180.7 5198.2 4953.9 5131.7 5138.4 5140.6 5160.4 5107.7 5113.4 5119.6 5128.5 5132.3 4424.4 4598.8 4606.3 4611.5 4617.9 21229.3 21296.6 21497.0 21966.5 21996.3 1945.3 1978.6 2025.6 2486.8 2529.9 13267.1 13459.3 13545.5 13918.8 14008.0 1756.4 1764.1 1769.6 1790.8 1803.1 66324.3 68734.7 69152.3 69516.3 69637.7 8579.5 9247.9 9587.6 9679.4 9977.8 12071.9 12985.7 12998.5 13456.3 13484.7 7137.4 7260.4 7324.0 7394.2 7410.1 6780.8 6804.0 6827.7 6879.1 6900.2 6077.5 6210.1 6269.0 6285.3 6303.7 1747.5 1766.9 1784.5 1812.6 1850.2 790.8 886.0 918.3 950.8 980.5 17023.0 17984.4 17996.9 18017.0 18299.8 870.4 876.6 896.1 910.2 913.5 9691.6 10297.2 10359.5 10500.7 10540.7 354784.0 369746.0 370930.0 373539.0 375779.0 67290.0 67567.0 68031.0 68347.0 68369.3 916.2 928.0 930.9 935.4 937.6 15685.5 15797.9 15908.8 15933.9 16104.7 25037.4 32695.3 33468.3 34913.7 35048.5 43076.0 44101.0 45295.0 45632.1 45804.0 7469.7 7594.6 7707.2 7757.1 7914.1 11753.9 11864.3 12056.6 12099.6 12142.2 9765.8 10106.2 10379.4 10411.1 10653.9 10728.2 10749.5 10947.6 11050.2 11133.3 10522.0 10644.9 10700.6 10907.2 10995.1 7511.7 7690.9 7691.8 7818.4 7869.7 9459.4 9523.1 9564.9 9726.6 9741.4 04:26:14 INFO - PROCESS | 7614 | 04:26:14 INFO - PROCESS | 7614 | [#3] mootools.html Cycles:180 Average:5263.50 Median:4859.61 stddev:2985.24 (61.4%) stddev-sans-first:2978.41 04:26:14 INFO - PROCESS | 7614 | Values: 1253.6 1327.6 1355.1 1694.6 1701.1 7754.5 8258.6 8303.5 8304.4 8306.5 7026.5 7693.8 7989.6 8031.6 8145.9 2250.7 2271.7 2279.1 2280.1 2281.4 2220.7 2228.6 2286.0 2287.0 2289.4 1947.2 2085.5 2172.1 2178.1 2193.7 2229.8 2234.0 2258.5 2259.0 2288.1 2251.0 2257.1 2257.1 2258.9 2259.5 8132.7 8194.8 8199.2 8199.4 8207.3 4732.1 4738.3 4759.2 4868.2 4873.3 2765.0 2822.7 2836.6 2860.7 2897.7 867.6 892.9 902.8 908.2 924.0 10834.1 10838.6 10843.6 10859.9 10875.8 4112.4 4267.0 4382.4 4384.3 4424.4 9332.5 9339.8 9341.6 9403.6 9424.7 4840.8 4847.6 4848.6 4849.2 4851.0 4330.9 4354.2 4386.1 4392.1 4394.6 3722.9 3804.3 3856.5 3871.3 3877.8 1054.3 1176.8 1198.7 1205.5 1214.6 667.4 719.2 795.3 800.6 824.6 4965.8 5143.3 5194.6 5216.7 5241.8 868.1 876.0 884.5 894.0 903.2 3459.6 3531.7 3532.0 3535.9 3549.1 9554.8 9974.5 10084.6 10087.6 10127.8 10020.5 10025.8 10027.3 10038.4 10045.0 6637.3 7237.6 7476.0 7577.6 7584.9 5331.7 5477.1 5477.5 5651.7 5711.1 9179.9 9290.5 9291.1 9303.7 9304.0 9087.5 9278.8 9344.1 9395.4 9628.2 6737.5 6747.7 6814.9 6852.8 6860.3 7691.9 7746.1 7784.5 7861.3 7907.1 5369.6 7028.4 7049.3 7127.9 7310.8 6926.3 7027.4 7038.1 7075.4 7193.2 6051.8 6065.7 6122.3 6124.6 6126.8 4548.8 4633.4 4636.5 4693.6 4744.1 4397.3 4433.6 4440.7 4506.5 4621.3 04:26:14 INFO - PROCESS | 7614 | 04:26:14 INFO - PROCESS | 7614 | [#4] prototype.html Cycles:180 Average:4185.53 Median:4806.47 stddev:1216.66 (25.3%) stddev-sans-first:1184.63 04:26:14 INFO - PROCESS | 7614 | Values: 301.3 303.4 307.6 311.3 311.6 4855.6 4903.3 4928.4 4933.3 4960.4 4851.6 4880.5 4882.8 4886.2 4898.2 3873.9 3881.9 3885.7 3887.2 3896.9 3742.0 3859.6 3861.2 3875.4 3879.8 3764.5 3767.3 3795.9 3813.5 3815.8 3761.7 3793.3 3806.6 3808.2 3818.7 3209.7 3315.2 3316.5 3319.8 3326.3 4425.6 4587.9 4634.6 4698.9 4719.0 4324.3 4330.0 4341.5 4346.9 4381.4 5033.8 5046.9 5060.8 5060.9 5115.2 3378.8 3517.4 3632.9 3635.9 3655.8 4981.7 5153.2 5248.6 5257.5 5263.4 3639.5 3681.7 3689.5 3689.7 3767.2 3809.2 3819.8 3828.0 3831.4 3844.9 4343.7 4357.9 4369.8 4371.4 4378.6 4913.5 5005.4 5018.2 5040.4 5056.3 1278.4 1297.1 1310.2 1310.4 1311.9 839.9 854.4 870.7 872.4 882.0 4000.5 4000.7 4015.8 4031.7 4049.8 4573.6 4580.6 4599.0 4601.5 4656.7 4016.4 4041.8 4054.7 4061.1 4061.6 2486.7 2578.7 2747.7 2779.2 2791.2 4950.9 4956.3 4959.3 4964.8 4972.0 5348.2 5362.7 5387.2 5390.4 5391.7 4843.9 5010.4 5011.0 5019.2 5030.4 5255.4 5265.6 5267.3 5270.7 5333.4 4918.9 5171.7 5175.9 5193.4 5224.7 4784.5 4828.4 4992.6 4993.7 4998.8 3715.0 3716.6 3722.5 3737.2 3755.0 5220.3 5298.2 5299.6 5302.8 5313.2 4843.9 5023.7 5052.4 5065.5 5123.3 5043.2 5047.8 5051.5 5059.8 5060.5 4972.4 4980.6 4991.3 4999.8 5010.2 4829.8 5124.5 5129.8 5133.5 5160.4 4964.0 4967.0 4971.0 4975.5 5022.4 04:26:14 INFO - PROCESS | 7614 | 04:26:14 INFO - PROCESS | 7614 | [#5] yui.html Cycles:180 Average:16468.29 Median:4278.10 stddev:22526.29 (526.5%) stddev-sans-first:22558.11 04:26:14 INFO - PROCESS | 7614 | Values: 634.7 667.3 684.0 693.9 729.2 11635.9 12269.7 12340.4 12345.9 12362.4 13265.3 14033.8 14048.7 14666.7 14676.1 625.7 758.1 777.3 793.9 796.7 783.1 797.2 797.8 797.8 798.6 832.7 838.0 838.6 839.1 841.9 644.9 789.2 816.0 835.4 836.5 599.9 600.1 602.3 602.5 602.8 12458.5 12485.6 12495.4 12502.3 12510.4 10969.9 11431.4 11790.4 11959.7 12277.2 11356.9 11458.3 11511.3 11578.7 11705.0 4014.9 4015.5 4057.1 4091.8 4122.5 60555.4 62730.0 62970.7 63291.0 63620.0 9789.7 9828.7 9846.8 9887.3 9972.6 17242.5 17371.2 17396.6 17433.2 17823.4 6422.6 6494.7 6591.6 6676.6 6728.3 3558.4 3563.3 3570.5 3618.7 3689.8 2772.3 2873.7 2876.8 2889.7 2904.4 483.3 484.5 494.4 506.5 511.1 488.1 535.1 564.3 614.0 625.1 8022.2 8240.0 8314.2 8420.5 8448.8 576.5 581.7 586.8 614.6 618.0 4084.4 4201.3 4237.5 4259.7 4296.5 77972.6 94380.0 100166.5 100540.0 100624.5 48270.3 71001.3 75818.0 81372.6 81512.6 43809.6 45629.0 54848.5 55115.0 66176.0 8671.1 8845.1 8890.9 8932.9 8940.3 39561.0 40861.4 45113.3 45166.3 45902.5 40902.8 40936.4 41011.0 55515.0 63735.4 11815.8 12001.6 12019.0 12233.4 12311.3 13573.8 13582.5 13836.9 13858.7 14349.3 7607.7 11164.0 11298.6 12615.2 12913.8 11921.8 12989.9 13375.3 13412.9 13470.8 12645.6 12806.2 13094.6 13241.7 13379.5 10888.5 11078.9 11134.0 11163.3 11269.9 10721.1 10833.6 10910.6 11027.7 11030.4 04:26:14 INFO - PROCESS | 7614 | -------- Summary: end -------- 04:26:14 INFO - PROCESS | 7614 | 04:26:15 INFO - TEST-INFO | 7614: exit 0 04:26:15 INFO - TEST-OK | dromaeo_css | took 1119503ms 04:26:15 INFO - TEST-START | kraken 04:26:15 INFO - operating with platform_type : linux_ 04:26:15 INFO - Initialising browser for kraken test... 04:26:15 INFO - TEST-INFO | started process 7811 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbFwA0G/profile http://localhost:60141/getInfo.html) 04:26:20 INFO - PROCESS | 7811 | __metrics Screen width/height:1600/1200 04:26:20 INFO - PROCESS | 7811 | colorDepth:24 04:26:20 INFO - PROCESS | 7811 | Browser inner width/height: 1024/697 04:26:20 INFO - PROCESS | 7811 | __metrics 04:26:20 INFO - PROCESS | 7811 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:26:21 INFO - TEST-INFO | 7811: exit 0 04:26:21 INFO - Browser initialized. 04:26:21 INFO - Running cycle 1/1 for kraken test... 04:26:21 INFO - TEST-INFO | started process 7893 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbFwA0G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:26:33 INFO - PROCESS | 7893 | RSS: Main: 158851072 04:26:33 INFO - PROCESS | 7893 | 04:26:36 INFO - PROCESS | 7893 | Cycle 1(1): loaded http://localhost:60141/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60141/tests/kraken/driver.html?testName=audio-beat-detection) 04:26:37 INFO - PROCESS | 7893 | RSS: Main: 216580096 04:26:37 INFO - PROCESS | 7893 | 04:26:40 INFO - PROCESS | 7893 | Cycle 1(1): loaded http://localhost:60141/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60141/tests/kraken/driver.html?testName=audio-dft) 04:26:40 INFO - PROCESS | 7893 | RSS: Main: 204230656 04:26:40 INFO - PROCESS | 7893 | 04:26:43 INFO - PROCESS | 7893 | Cycle 1(1): loaded http://localhost:60141/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60141/tests/kraken/driver.html?testName=audio-fft) 04:26:44 INFO - PROCESS | 7893 | RSS: Main: 271327232 04:26:44 INFO - PROCESS | 7893 | 04:26:46 INFO - PROCESS | 7893 | Cycle 1(1): loaded http://localhost:60141/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60141/tests/kraken/driver.html?testName=audio-oscillator) 04:26:47 INFO - PROCESS | 7893 | RSS: Main: 181534720 04:26:47 INFO - PROCESS | 7893 | 04:26:49 INFO - PROCESS | 7893 | Cycle 1(1): loaded http://localhost:60141/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60141/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:26:50 INFO - PROCESS | 7893 | RSS: Main: 185528320 04:26:50 INFO - PROCESS | 7893 | 04:26:53 INFO - PROCESS | 7893 | Cycle 1(1): loaded http://localhost:60141/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60141/tests/kraken/driver.html?testName=imaging-darkroom) 04:26:53 INFO - PROCESS | 7893 | RSS: Main: 221700096 04:26:53 INFO - PROCESS | 7893 | 04:26:57 INFO - PROCESS | 7893 | Cycle 1(1): loaded http://localhost:60141/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60141/tests/kraken/driver.html?testName=imaging-desaturate) 04:26:58 INFO - PROCESS | 7893 | RSS: Main: 217456640 04:26:58 INFO - PROCESS | 7893 | 04:27:00 INFO - PROCESS | 7893 | Cycle 1(1): loaded http://localhost:60141/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60141/tests/kraken/driver.html?testName=json-parse-financial) 04:27:01 INFO - PROCESS | 7893 | RSS: Main: 219799552 04:27:01 INFO - PROCESS | 7893 | 04:27:03 INFO - PROCESS | 7893 | Cycle 1(1): loaded http://localhost:60141/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60141/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:27:03 INFO - PROCESS | 7893 | RSS: Main: 206061568 04:27:03 INFO - PROCESS | 7893 | 04:27:05 INFO - PROCESS | 7893 | Cycle 1(1): loaded http://localhost:60141/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60141/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:27:06 INFO - PROCESS | 7893 | RSS: Main: 211845120 04:27:06 INFO - PROCESS | 7893 | 04:27:08 INFO - PROCESS | 7893 | Cycle 1(1): loaded http://localhost:60141/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60141/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:27:09 INFO - PROCESS | 7893 | RSS: Main: 207826944 04:27:09 INFO - PROCESS | 7893 | 04:27:11 INFO - PROCESS | 7893 | Cycle 1(1): loaded http://localhost:60141/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60141/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:27:12 INFO - PROCESS | 7893 | RSS: Main: 223657984 04:27:12 INFO - PROCESS | 7893 | 04:27:15 INFO - PROCESS | 7893 | Cycle 1(1): loaded http://localhost:60141/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60141/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:27:16 INFO - PROCESS | 7893 | RSS: Main: 222855168 04:27:16 INFO - PROCESS | 7893 | 04:27:17 INFO - PROCESS | 7893 | Cycle 1(1): loaded http://localhost:60141/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60141/tests/kraken/driver.html?testName=ai-astar) 04:27:18 INFO - PROCESS | 7893 | RSS: Main: 263954432 04:27:18 INFO - PROCESS | 7893 | 04:27:18 INFO - PROCESS | 7893 | __start_tp_report 04:27:18 INFO - PROCESS | 7893 | _x_x_mozilla_page_load 04:27:18 INFO - PROCESS | 7893 | _x_x_mozilla_page_load_details 04:27:18 INFO - PROCESS | 7893 | |i|pagename|runs| 04:27:18 INFO - PROCESS | 7893 | |0;ai-astar;102;114;113;114;113;114;113;112;112;114 04:27:18 INFO - PROCESS | 7893 | |1;audio-beat-detection;152;128;123;178;128;126;146;122;172;124 04:27:18 INFO - PROCESS | 7893 | |2;audio-dft;161;160;162;161;161;162;162;162;161;160 04:27:18 INFO - PROCESS | 7893 | |3;audio-fft;75;75;77;130;75;77;76;75;104;75 04:27:18 INFO - PROCESS | 7893 | |4;audio-oscillator;86;86;115;86;86;86;126;86;85;120 04:27:18 INFO - PROCESS | 7893 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;117;118 04:27:18 INFO - PROCESS | 7893 | |6;imaging-darkroom;146;147;147;146;146;146;146;146;146;146 04:27:18 INFO - PROCESS | 7893 | |7;imaging-desaturate;95;95;95;96;95;95;95;95;94;95 04:27:18 INFO - PROCESS | 7893 | |8;json-parse-financial;63;64;63;64;65;63;64;64;63;65 04:27:18 INFO - PROCESS | 7893 | |9;json-stringify-tinderbox;63;65;64;63;64;65;64;64;64;64 04:27:18 INFO - PROCESS | 7893 | |10;stanford-crypto-aes;79;79;79;77;78;79;80;79;78;79 04:27:18 INFO - PROCESS | 7893 | |11;stanford-crypto-ccm;142;127;133;133;139;138;139;130;205;131 04:27:18 INFO - PROCESS | 7893 | |12;stanford-crypto-pbkdf2;167;170;165;165;168;164;170;165;164;168 04:27:18 INFO - PROCESS | 7893 | |13;stanford-crypto-sha256-iterative;67;66;68;66;66;69;66;66;68;65 04:27:18 INFO - PROCESS | 7893 | __end_tp_report 04:27:18 INFO - PROCESS | 7893 | __start_cc_report 04:27:18 INFO - PROCESS | 7893 | _x_x_mozilla_cycle_collect,1889 04:27:18 INFO - PROCESS | 7893 | __end_cc_report 04:27:18 INFO - PROCESS | 7893 | __startTimestamp1467804438070__endTimestamp 04:27:18 INFO - PROCESS | 7893 | 04:27:18 INFO - PROCESS | 7893 | ------- Summary: start ------- 04:27:18 INFO - PROCESS | 7893 | Number of tests: 14 04:27:18 INFO - PROCESS | 7893 | 04:27:18 INFO - PROCESS | 7893 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.50 stddev:3.63 (3.2%) stddev-sans-first:0.83 04:27:18 INFO - PROCESS | 7893 | Values: 102.0 114.0 113.0 114.0 113.0 114.0 113.0 112.0 112.0 114.0 04:27:18 INFO - PROCESS | 7893 | 04:27:18 INFO - PROCESS | 7893 | [#1] audio-beat-detection Cycles:10 Average:139.90 Median:137.00 stddev:21.08 (15.4%) stddev-sans-first:21.90 04:27:18 INFO - PROCESS | 7893 | Values: 152.0 128.0 123.0 178.0 128.0 126.0 146.0 122.0 172.0 124.0 04:27:18 INFO - PROCESS | 7893 | 04:27:18 INFO - PROCESS | 7893 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 04:27:18 INFO - PROCESS | 7893 | Values: 161.0 160.0 162.0 161.0 161.0 162.0 162.0 162.0 161.0 160.0 04:27:18 INFO - PROCESS | 7893 | 04:27:18 INFO - PROCESS | 7893 | [#3] audio-fft Cycles:10 Average:83.90 Median:75.00 stddev:18.51 (24.7%) stddev-sans-first:19.35 04:27:18 INFO - PROCESS | 7893 | Values: 75.0 75.0 77.0 130.0 75.0 77.0 76.0 75.0 104.0 75.0 04:27:18 INFO - PROCESS | 7893 | 04:27:18 INFO - PROCESS | 7893 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:86.00 stddev:16.86 (19.6%) stddev-sans-first:17.47 04:27:18 INFO - PROCESS | 7893 | Values: 86.0 86.0 115.0 86.0 86.0 86.0 126.0 86.0 85.0 120.0 04:27:18 INFO - PROCESS | 7893 | 04:27:18 INFO - PROCESS | 7893 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 04:27:18 INFO - PROCESS | 7893 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 118.0 04:27:18 INFO - PROCESS | 7893 | 04:27:18 INFO - PROCESS | 7893 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 04:27:18 INFO - PROCESS | 7893 | Values: 146.0 147.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 04:27:18 INFO - PROCESS | 7893 | 04:27:18 INFO - PROCESS | 7893 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 04:27:18 INFO - PROCESS | 7893 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 94.0 95.0 04:27:18 INFO - PROCESS | 7893 | 04:27:18 INFO - PROCESS | 7893 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:64.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 04:27:18 INFO - PROCESS | 7893 | Values: 63.0 64.0 63.0 64.0 65.0 63.0 64.0 64.0 63.0 65.0 04:27:18 INFO - PROCESS | 7893 | 04:27:18 INFO - PROCESS | 7893 | [#9] json-stringify-tinderbox Cycles:10 Average:64.00 Median:64.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 04:27:18 INFO - PROCESS | 7893 | Values: 63.0 65.0 64.0 63.0 64.0 65.0 64.0 64.0 64.0 64.0 04:27:18 INFO - PROCESS | 7893 | 04:27:18 INFO - PROCESS | 7893 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:79.00 stddev:0.82 (1.0%) stddev-sans-first:0.87 04:27:18 INFO - PROCESS | 7893 | Values: 79.0 79.0 79.0 77.0 78.0 79.0 80.0 79.0 78.0 79.0 04:27:18 INFO - PROCESS | 7893 | 04:27:18 INFO - PROCESS | 7893 | [#11] stanford-crypto-ccm Cycles:10 Average:141.70 Median:138.50 stddev:22.74 (16.4%) stddev-sans-first:24.12 04:27:18 INFO - PROCESS | 7893 | Values: 142.0 127.0 133.0 133.0 139.0 138.0 139.0 130.0 205.0 131.0 04:27:18 INFO - PROCESS | 7893 | 04:27:18 INFO - PROCESS | 7893 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.60 Median:167.50 stddev:2.32 (1.4%) stddev-sans-first:2.46 04:27:18 INFO - PROCESS | 7893 | Values: 167.0 170.0 165.0 165.0 168.0 164.0 170.0 165.0 164.0 168.0 04:27:18 INFO - PROCESS | 7893 | 04:27:18 INFO - PROCESS | 7893 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:66.50 stddev:1.25 (1.9%) stddev-sans-first:1.32 04:27:18 INFO - PROCESS | 7893 | Values: 67.0 66.0 68.0 66.0 66.0 69.0 66.0 66.0 68.0 65.0 04:27:18 INFO - PROCESS | 7893 | -------- Summary: end -------- 04:27:18 INFO - PROCESS | 7893 | 04:27:19 INFO - TEST-INFO | 7893: exit 0 04:27:19 INFO - TEST-OK | kraken | took 63405ms 04:27:19 INFO - SUITE-END | took 1182s 04:27:19 INFO - Completed test suite (00:19:42) 04:27:19 INFO - javascript benchmark 04:27:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2593.053535459557, 2597.5454295498284, 2628.2378110348, 2632.9341766455836, 2635.262126604551, 4555.498895121534, 4661.603763680091, 4680.157571637108, 4680.344751734756, 4690.0385420988705, 4646.767661616923, 4691.319758634996, 4693.108309421207, 4725.362076119723, 4727.101850648374, 4287.592678695519, 4289.806958686859, 4357.586029327209, 4391.538888416718, 4477.70894891831, 4401.493828209749, 4434.623057040139, 4437.179121862449, 4446.066326071513, 4472.262076757347, 4249.575042495757, 4296.699231053827, 4305.655547556188, 4317.460317460317, 4369.519352871213, 4311.8490852820005, 4325.52419233884, 4366.454193225847, 4374.212641724488, 4375.846845360429, 4366.235908715962, 4368.995131119828, 4371.038371558252, 4394.033312671208, 4409.536998615131, 4589.862304130881, 4661.673682842203, 4764.666473346867, 4782.904341913142, 4797.52024797521, 5102.38771347437, 5106.259592359124, 5121.155009423441, 5121.308623335839, 5122.795088196468, 4933.260010998343, 5113.335266415379, 5153.458886816905, 5159.406668233126, 5160.225966105077, 4678.883027924295, 4725.976370118196, 4730.361401210793, 4763.54746299101, 4778.832740854054, 5218.191180367049, 5231.189165679326, 5233.502817232356, 5233.842984710464, 5238.97380513095, 4875.756212189376, 4927.236278376858, 4938.901221975612, 4960.379952505937, 4984.800607975641, 5089.3638295213095, 5127.077126117335, 5156.04613146569, 5170.870728231825, 5175.585953123741, 5074.3657042869645, 5083.339165908408, 5087.186050231945, 5087.26234695967, 5138.486151384906, 4819.831305904277, 5036.194208926554, 5043.823466178666, 5044.344235249394, 5046.84859454217, 4152.875413737593, 4171.0615111600255, 4213.494380674339, 4216.7259128156575, 4256.148770245902, 3708.517892673935, 3709.629037096269, 3711.1649878777057, 3745.569259535134, 3749.1751814600743, 4373.322135069069, 4382.430284063052, 4387.0, 4422.447194100738, 4426.667999900021, 4878.487758785347, 4918.827841025547, 5019.372578427697, 5066.316047333637, 5082.415522214918, 4369.781510924441, 4377.737335759864, 4384.978075109604, 4388.166248412791, 4431.069475410135, 4502.549745025537, 4504.752238626907, 4514.367988481616, 4514.932276015862, 4555.293929440942, 4669.252919532859, 4713.929291060568, 4791.401074865642, 4791.688540244873, 4803.471618121934, 4991.47589503097, 4992.475790041994, 5051.4443411224, 5051.696898186121, 5084.1102807009365, 4690.132325519789, 4755.857324280277, 4758.262469317261, 4760.238361862085, 4812.181929071996, 4967.3542439482635, 4997.375328083989, 5031.84904452867, 5038.974805125951, 5047.722375269395, 5083.6187285952965, 5107.9489205107475, 5113.846584602468, 5116.488351164854, 5165.845024649267, 4804.759762011955, 4838.322634831056, 4936.75316234194, 4951.455339912679, 4957.479464656303, 4855.830045948375, 4888.804447822047, 4907.484714104968, 4913.140200464976, 4960.851174464772, 4825.420949486084, 4831.202851529459, 4832.420109586872, 4863.513648635108, 4880.755962201947, 4777.641676874179, 4888.095702295087, 4939.234418665113, 4942.357493525962, 4984.0, 4824.107540105092, 4845.515448455268, 4846.709197448165, 4888.144574699342, 4895.363602731622], "value": 4640.564820276267, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.2860935657942, 576.5733357315588, 581.2414798687711, 592.1502643706282, 603.577495752973, 27550.311242218955, 27958.301042473922, 39898.2020359593, 40585.79707101468, 40647.59352406475, 39657.20685586294, 40300.19399612006, 40316.0, 40356.19287614253, 40382.19235615286, 7913.920860791391, 8053.838923221532, 8060.838783224332, 8067.515949043076, 8072.475289106189, 7491.138519070322, 10184.388936663787, 10452.634157804478, 10473.057424831764, 10768.0, 10419.218558608096, 10498.055175034246, 10503.894961050406, 10511.106555942753, 10528.842067368996, 10180.949095254513, 10239.385636861738, 10241.948790256076, 10245.948770256176, 10250.487475626263, 10312.1234695051, 10370.37777733331, 10379.948100259451, 10389.168866490738, 10392.220583456272, 38302.80848595767, 38583.614163858285, 38651.8067409664, 38672.41991370132, 38706.80646596777, 3059.938801223985, 3078.5228289615147, 3121.0480803354967, 3299.6700329967052, 3363.445031569788, 29245.26886827825, 29390.265243368875, 29619.40761184786, 30405.0, 30539.694603053907, 3345.5149003394613, 3542.1144713821545, 3548.520949671787, 3568.3220188164164, 3636.4181730922924, 256345.0, 256846.0, 257141.0, 257684.0, 258088.7095564529, 52810.99999999923, 52811.471885280655, 52911.470885290655, 53100.73449632727, 53118.73440632772, 55699.72150139305, 55749.72125139349, 55850.0, 55919.0, 55945.16082258769, 11628.127890408085, 13321.66695832612, 13540.661483462993, 13551.932240338736, 13566.728665426635, 9919.156871665846, 10151.390916544884, 10265.897341026643, 10282.28024038325, 10471.057604815604, 16104.597385065234, 16175.19124043793, 16179.110148941685, 16206.594835129215, 16237.0, 5245.895082098336, 6080.14877917092, 6263.78076767311, 6286.9056964145575, 6334.461570766444, 810.5866008335792, 863.7322430046705, 886.663068034143, 917.559571405729, 940.5391358234416, 27025.0, 27754.72245277562, 28417.71582284192, 28781.424371512872, 28869.0, 920.0661328751323, 955.5413401567148, 965.6909788867495, 975.6975337645353, 1004.8191325561323, 14403.226925401994, 14761.483348082766, 14874.330655120546, 14942.775858362133, 14988.925055374653, 384304.0, 384376.0, 386444.0, 387093.0, 387351.0, 48821.511784881695, 48938.510614894105, 48944.75527622339, 48948.0, 48949.0, 1081.1566977757361, 1122.1303489795312, 1187.441902305915, 1208.945597448117, 1244.2223610243598, 26391.832980042516, 28951.0, 29262.268443288238, 29270.466598333125, 29774.702252977193, 41684.79157604314, 41810.790946045076, 42088.0, 42134.0, 42262.15475690408, 294242.0, 295442.0, 296375.0, 296912.0, 297259.0, 22215.55568888581, 24373.3906652328, 24648.630270546313, 25292.74707252904, 25484.872575637004, 41107.58892411038, 41476.377854332815, 42084.789576051924, 42104.3684344729, 42388.78805605952, 35644.643553564136, 35723.28553428969, 37223.441648374755, 37230.44154337741, 37264.44103338398, 35816.46275305925, 35821.28357432889, 36139.27721445609, 36422.8178859104, 36460.0, 35262.647373525935, 35437.29125417529, 35758.28483430369, 36377.27245455129, 36424.0, 31783.0, 32924.34151317008, 33196.33607327792, 33318.66681333253, 33529.49705754367, 24900.62649060302, 24982.250532484053, 25250.873745631154, 25378.873105634353, 25477.74522254754], "value": 17812.076926987, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.68715312642036, 377.12883239716257, 379.6090027271909, 383.83878770916203, 397.49319617487697, 12691.873081269185, 15967.600809979756, 16254.674906501878, 16886.071266080362, 17716.64566708665, 16735.66528669429, 16893.564047055985, 17045.403410880623, 17501.299948002095, 17635.55911102223, 4604.963883126304, 5005.19916813309, 5197.0, 5200.479952004788, 5208.947910520903, 5124.052050370675, 5140.640155189139, 5171.095058364771, 5180.663256888309, 5198.246254293125, 4953.876153096166, 5131.717755523445, 5138.383393992726, 5140.640155189139, 5160.354955630546, 5107.672005278636, 5113.386393632769, 5119.616028797818, 5128.512791284803, 5132.255822905658, 4424.446944131983, 4598.816047358102, 4606.286025666027, 4611.538846115395, 4617.861464156081, 21229.25697600592, 21296.574068518545, 21497.0, 21966.450838729, 21996.340109796733, 1945.319138301583, 1978.584497255578, 2025.5645036317262, 2486.8010559155223, 2529.8988040478357, 13267.137636053625, 13459.327033648278, 13545.45818167272, 13918.791218131737, 14008.0, 1756.4291605228225, 1764.126757255167, 1769.619531800669, 1790.8477779388638, 1803.0984507746127, 66324.3367566323, 68734.65632671854, 69152.30847691509, 69516.304836952, 69637.65181174062, 8579.528125953007, 9247.907520924704, 9587.568559414844, 9679.419234845791, 9977.777887273236, 12071.879281207252, 12985.740285194242, 12998.480060797652, 13456.25990570528, 13484.730305393838, 7137.393321567621, 7260.41916646667, 7323.963380183065, 7394.223606521346, 7410.073740782403, 6780.796576102724, 6803.965980170166, 6827.658617069127, 6879.071325371111, 6900.171979362408, 6077.453029227391, 6210.130581718563, 6269.019783056551, 6285.340039295808, 6303.684815759194, 1747.475757272813, 1766.9116544172998, 1784.5092599534971, 1812.592166762468, 1850.2229063793238, 790.7785819970418, 885.9867101993475, 918.320442872283, 950.8114856429463, 980.4803454169302, 17023.0, 17984.370547031052, 17996.9100154501, 18017.009064501315, 18299.81700182981, 870.3559366069063, 876.5748611923212, 896.0815164456354, 910.2490445382585, 913.5021413329752, 9691.563879625433, 10297.227707921937, 10359.533820978075, 10500.684979450476, 10540.683779486628, 354784.0, 369746.0, 370930.0, 373539.0, 375779.0, 67290.0, 67567.0, 68031.0, 68347.0, 68369.31630683629, 916.1617120334952, 928.03020843219, 930.8510638297976, 935.420039575454, 937.6108914800418, 15685.529434116996, 15797.921010394875, 15908.76136857925, 15933.920330398274, 16104.67790644204, 25037.374065648506, 32695.346093078482, 33468.33063338768, 34913.65086349104, 35048.47427288644, 43076.0, 44101.0, 45295.0, 45632.087358251985, 45804.0, 7469.663865125974, 7594.620268986418, 7707.2292770724725, 7757.1467138615835, 7914.1294457608465, 11753.941230293794, 11864.288142711464, 12056.578019769266, 12099.57651482194, 12142.150049496451, 9765.804683906425, 10106.242031847787, 10379.429131397847, 10411.11505522039, 10653.934606539284, 10728.195385345975, 10749.462526873782, 10947.56209751601, 11050.226484146033, 11133.276337038067, 10522.0, 10644.946775266075, 10700.571977120828, 10907.181961352771, 10995.065419439437, 7511.73708920207, 7690.884636730341, 7691.769246922601, 7818.413618978486, 7869.685212591432, 9459.432434053704, 9523.142917137491, 9564.856527151958, 9726.610935562498, 9741.415515069119], "value": 8282.284610222432, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1253.6176466177817, 1327.6017194841545, 1355.0920883008384, 1694.5509439998402, 1701.072915261184, 7754.457187996843, 8258.587070646474, 8303.460275082123, 8304.377171712116, 8306.460080094797, 7026.508144429879, 7693.807654808633, 7989.5605741684185, 8031.558264295461, 8145.91854081459, 2250.6511490718963, 2271.65925111233, 2279.099755596538, 2280.065173278956, 2281.4296425893526, 2220.733511978565, 2228.6434170532716, 2286.039863257436, 2286.965695514569, 2289.3589794857467, 1947.2405761752927, 2085.4994801247744, 2172.1311475409884, 2178.1287485005964, 2193.7367515898113, 2229.8216142708543, 2233.9888300558555, 2258.525709600986, 2258.9887050564644, 2288.0962020002007, 2250.9887450562805, 2257.0745994142485, 2257.1422859313357, 2258.9096436142536, 2259.480319526518, 8132.674693012332, 8194.836103277961, 8199.22107399796, 8199.42604017719, 8207.261346478786, 4732.1482133216, 4738.265568836836, 4759.190937540592, 4868.196747536652, 4873.31773551703, 2764.958525622117, 2822.7318404751722, 2836.5886946392657, 2860.6567211934703, 2897.6522817261853, 867.6269204242174, 892.9151730585584, 902.7878448564582, 908.1644886704182, 923.9907600923972, 10834.133269338434, 10838.566457341696, 10843.566257349776, 10859.891401085966, 10875.782484350348, 4112.355057976773, 4267.039916018933, 4382.364557139197, 4384.3204303332395, 4424.402705634762, 9332.533373331305, 9339.766505837408, 9341.626334946663, 9403.57683904226, 9424.717258482257, 4840.782164802592, 4847.61219102478, 4848.5636292733825, 4849.199882019498, 4851.029794041206, 4330.870073897788, 4354.150940566622, 4386.1447017831215, 4392.143532011291, 4394.626456751148, 3722.8696995605565, 3804.2962052020466, 3856.4793752843007, 3871.322518559241, 3877.8254978526033, 1054.267284237463, 1176.847009888726, 1198.7003249187703, 1205.5057426455112, 1214.5991822698666, 667.4093427316859, 719.1909102259957, 795.3442303048829, 800.627708115729, 824.6330382979517, 4965.8013679452415, 5143.27994080829, 5194.6104042196985, 5216.713080780593, 5241.764120614582, 868.0885070675765, 875.9912400876037, 884.540039179623, 893.9821203576022, 903.1781079218011, 3459.567554055743, 3531.735119865969, 3531.9823400883347, 3535.876244331436, 3549.07723991764, 9554.808903821884, 9974.501274936225, 10084.596616135272, 10087.646932357333, 10127.797444051077, 10020.549075291628, 10025.849612255823, 10027.29808913369, 10038.44788536623, 10045.0, 6637.336266373421, 7237.565746055148, 7476.0, 7577.621118944031, 7584.886226706604, 5331.733413329241, 5477.068898287221, 5477.507024367666, 5651.689157096399, 5711.114777209539, 9179.862302065609, 9290.535473226448, 9291.117343852324, 9303.72088837336, 9303.953480232556, 9087.500187489752, 9278.768030799283, 9344.065593440602, 9395.436273823592, 9628.18160456369, 6737.528373013842, 6747.730090796314, 6814.93185068143, 6852.794416167523, 6860.348266914635, 7691.923080769121, 7746.109197442366, 7784.532928024337, 7861.331786798186, 7907.051153861574, 5369.57043436532, 7028.402585780266, 7049.29507049291, 7127.928720712934, 7310.780676579711, 6926.341997510229, 7027.367536921497, 7038.085048943604, 7075.433965282662, 7193.2087470379265, 6051.788187413419, 6065.6663883486835, 6122.265328160649, 6124.5712800103565, 6126.754929802936, 4548.795304211252, 4633.397658304399, 4636.466806317317, 4693.647976401715, 4744.1460537102275, 4397.2964325707735, 4433.623142032834, 4440.6669499788295, 4506.459224893034, 4621.260598304255], "value": 4209.809348934491, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.30849699938653, 303.4295524414102, 307.5540466323831, 311.2731771313982, 311.5980385302959, 4855.635827312948, 4903.264510323449, 4928.3593132892765, 4933.309336692866, 4960.379952505937, 4851.587615052716, 4880.46314905361, 4882.829100981467, 4886.169351210294, 4898.240772680231, 3873.876575793017, 3881.941770873425, 3885.747426417274, 3887.2225554888996, 3896.941545876814, 3742.0, 3859.649122807023, 3861.1813376235364, 3875.360565506688, 3879.7866117363533, 3764.491793607869, 3767.321882061228, 3795.924081518368, 3813.504244448218, 3815.798023622564, 3761.661450469457, 3793.3172029034763, 3806.5812760596314, 3808.1622043150464, 3818.694504439638, 3209.679032096795, 3315.1712071982006, 3316.507571592793, 3319.767616266862, 3326.268220991378, 4425.645948324159, 4587.9082418351445, 4634.582887540104, 4698.882527936795, 4718.961828397747, 4324.329728892027, 4329.956700433018, 4341.481940474518, 4346.869593912188, 4381.422687832378, 5033.84898453047, 5046.899062018776, 5060.7722652480725, 5060.873478163038, 5115.2071428928575, 3378.847951842173, 3517.384457719889, 3632.891013269606, 3635.8727444539577, 3655.798931058791, 4981.676191047571, 5153.175491921274, 5248.553872920768, 5257.526822585985, 5263.421023687391, 3639.490471334015, 3681.650243226889, 3689.524190323892, 3689.6863766579604, 3767.246550689873, 3809.1619843634357, 3819.770813751128, 3828.0, 3831.3946516369137, 3844.942325865114, 4343.717658352197, 4357.869263922024, 4369.75966321849, 4371.366151907955, 4378.642620787566, 4913.459519452857, 5005.424376196784, 5018.222175562793, 5040.39515258164, 5056.26684130799, 1278.4247088810073, 1297.1309222820544, 1310.1549500572078, 1310.4037662863375, 1311.895048396126, 839.8698201778734, 854.4275335525213, 870.6909047288248, 872.4372779557277, 881.9735407937773, 4000.4999375078114, 4000.6999475038906, 4015.7791321477016, 4031.737937034083, 4049.838006479708, 4573.565511276423, 4580.633549316113, 4599.034202817379, 4601.5168407317415, 4656.67403281767, 4016.4376987221813, 4041.818118184689, 4054.675625949917, 4061.050695666097, 4061.5532291447917, 2486.6767320248614, 2578.742125787444, 2747.738964798341, 2779.2357101796765, 2791.232411086967, 4950.886050638577, 4956.330895329156, 4959.2809042688605, 4964.808445972941, 4971.975140124277, 5348.171033489815, 5362.731863406814, 5387.191921211771, 5390.380106287748, 5391.676499410048, 4843.878903027382, 5010.448850626428, 5010.974945125251, 5019.222020586742, 5030.3963524377305, 5255.395629502656, 5265.552428043659, 5267.3384055112265, 5270.657407268515, 5333.439988801275, 4918.901621967469, 5171.663841850268, 5175.870603234949, 5193.37679478465, 5224.738763061908, 4784.545468180518, 4828.396450443694, 4992.550670439678, 4993.675411098267, 4998.800047998039, 3714.9628503714616, 3716.646918542734, 3722.516072910504, 3737.2151848112203, 3754.9624503754612, 5220.347456567929, 5298.178782288752, 5299.602529810357, 5302.814401495929, 5313.176457648916, 4843.854684359475, 5023.6985780853265, 5052.418971818288, 5065.518775716301, 5123.257127716534, 5043.218301163325, 5047.798088076436, 5051.494850514919, 5059.760358712139, 5060.51925067118, 4972.378452693413, 4980.601551875769, 4991.326170967018, 4999.77501012448, 5010.248462730619, 4829.782659780389, 5124.488275958526, 5129.7691603877165, 5133.486651334837, 5160.354955630546, 4964.00719856023, 4966.994968044281, 4970.950290497049, 4975.477574854588, 5022.397312322545], "value": 3802.7075651751015, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [634.6921742954667, 667.2826711285369, 683.9726410943563, 693.8785712500311, 729.227019359479, 11635.883641163586, 12269.693257668563, 12340.382980850967, 12345.938270308658, 12362.381880905952, 13265.33673316335, 14033.78949315761, 14048.71902561948, 14666.706665866675, 14676.119432834037, 625.7403177681257, 758.0562200060932, 777.2616014785933, 793.9087004994412, 796.6574373019599, 783.0720596093647, 797.1669605262485, 797.8085259537698, 797.8404319136167, 798.6126728536684, 832.7418500264937, 838.0153319849153, 838.6393850644221, 839.1440730454932, 841.877927700483, 644.8613548087137, 789.2107892107892, 815.9510429374257, 835.4110352201683, 836.5273620404452, 599.868029033612, 600.0818747316613, 602.2592211579781, 602.4577879908118, 602.7980626490131, 12458.501659933592, 12485.56300529477, 12495.375231238493, 12502.312372819491, 12510.37448127599, 10969.945150274198, 11431.428428578538, 11790.410479476077, 11959.701007474796, 12277.20198187124, 11356.943215283953, 11458.312501249868, 11511.251768635011, 11578.71053223676, 11705.005074568671, 4014.879553613396, 4015.477987861559, 4057.1479989202303, 4091.7954102294766, 4122.484689413824, 60555.394446055856, 62730.0, 62970.685146573975, 63291.0, 63620.0, 9789.706308810748, 9828.705138845846, 9846.753831154278, 9887.30788844774, 9972.551235194434, 17242.482725518003, 17371.218295176746, 17396.565085872702, 17433.21550530229, 17823.37618183383, 6422.614643121427, 6494.675266236669, 6591.6374599397495, 6676.608925088895, 6728.259891411941, 3558.365139949103, 3563.251717139378, 3570.4644303354185, 3618.656227658421, 3689.7786132832116, 2772.334639686461, 2873.6838947715733, 2876.827390356543, 2889.6532416110203, 2904.361040571071, 483.32817383836493, 484.4549881383444, 494.4388119484411, 506.45556027270834, 511.10046318479743, 488.0824050784502, 535.1010302691437, 564.2720890051869, 613.9754409823646, 625.1154616218091, 8022.157673444321, 8239.95880020596, 8314.210150035737, 8420.4947703138, 8448.788780280542, 576.5358886096649, 581.7469400810661, 586.7799575159315, 614.6035806904522, 618.038949433626, 4084.3873418986796, 4201.327787553977, 4237.512686041083, 4259.734585768135, 4296.462942132233, 77972.61013694895, 94380.0, 100166.4991675037, 100539.97300134964, 100624.4968775166, 48270.27594586084, 71001.2899871005, 75818.0, 81372.59313703394, 81512.59243703862, 43809.56190438118, 45629.0, 54848.45151548513, 55115.0, 66176.0, 8671.08953559867, 8845.115488451103, 8890.911090889009, 8932.86600700977, 8940.329475289249, 39561.0, 40861.38707919443, 45113.32330015118, 45166.32250516311, 45902.54097458983, 40902.772916812544, 40936.38595421011, 41011.0, 55515.0, 63735.3626463748, 11815.76368472643, 12001.63995080149, 12019.0, 12233.449494772578, 12311.261324320569, 13573.79639305431, 13582.524611638546, 13836.930815345859, 13858.653533661336, 14349.282535873373, 7607.695692172251, 11164.0, 11298.60454884075, 12615.180013299107, 12913.806292905427, 11921.761564768483, 12989.870101298866, 13375.331233438095, 13412.93293533526, 13470.79793803074, 12645.620631381073, 12806.167599106027, 13094.607161785161, 13241.740724504827, 13379.464821407035, 10888.455577221266, 11078.944605277244, 11134.0, 11163.330200188015, 11269.943650281695, 10721.142308615448, 10833.566657333618, 10910.61812836547, 11027.669169924915, 11030.393328367018], "value": 6523.073892008797, "unit": "score"}], "name": "dromaeo_css", "value": 6442.417211702811, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 114.0, 113.0, 114.0, 113.0, 114.0, 113.0, 112.0, 112.0, 114.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 128.0, 123.0, 178.0, 128.0, 126.0, 146.0, 122.0, 172.0, 124.0], "value": 139.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 161.0, 161.0, 162.0, 162.0, 162.0, 161.0, 160.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 130.0, 75.0, 77.0, 76.0, 75.0, 104.0, 75.0], "value": 83.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 115.0, 86.0, 86.0, 86.0, 126.0, 86.0, 85.0, 120.0], "value": 96.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 64.0, 65.0, 63.0, 64.0, 64.0, 63.0, 65.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 64.0, 63.0, 64.0, 65.0, 64.0, 64.0, 64.0, 64.0], "value": 64.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 77.0, 78.0, 79.0, 80.0, 79.0, 78.0, 79.0], "value": 78.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 127.0, 133.0, 133.0, 139.0, 138.0, 139.0, 130.0, 205.0, 131.0], "value": 141.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 170.0, 165.0, 165.0, 168.0, 164.0, 170.0, 165.0, 164.0, 168.0], "value": 166.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 68.0, 66.0, 66.0, 69.0, 66.0, 66.0, 68.0, 65.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1533.0, "alertThreshold": 2.0}]} 04:27:19 INFO - Return code: 0 04:27:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:27:19 INFO - # TBPL SUCCESS # 04:27:19 INFO - Running post-action listener: _resource_record_post_action 04:27:19 INFO - ##### 04:27:19 INFO - ##### Finished run-tests step (success) 04:27:19 INFO - ##### 04:27:19 INFO - Running post-run listener: _resource_record_post_run 04:27:19 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 538288128; Read time: 0; Write time: 462316 04:27:19 INFO - TinderboxPrint: CPU usage
13.0% 04:27:19 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 04:27:19 INFO - TinderboxPrint: I/O write bytes / time
538,288,128 / 462,316 04:27:19 INFO - TinderboxPrint: CPU idle
8,327.6 (87.0%) 04:27:19 INFO - TinderboxPrint: CPU user
1,201.0 (12.5%) 04:27:19 INFO - TinderboxPrint: Swap in / out
0 / 0 04:27:19 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 250175488; Read time: 0; Write time: 271216 04:27:19 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 288112640; Read time: 0; Write time: 191100 04:27:19 INFO - Running post-run listener: _upload_blobber_files 04:27:19 INFO - Blob upload gear active. 04:27:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:27:19 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 04:27:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:27:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:27:20 INFO - (blobuploader) - INFO - Open directory for files ... 04:27:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:27:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:27:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:27:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:27:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:27:21 INFO - (blobuploader) - INFO - Done attempting. 04:27:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:27:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:27:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:27:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:27:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:27:21 INFO - (blobuploader) - INFO - Done attempting. 04:27:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:27:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:27:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:27:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:27:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:27:25 INFO - (blobuploader) - INFO - Done attempting. 04:27:25 INFO - (blobuploader) - INFO - Iteration through files over. 04:27:25 INFO - Return code: 0 04:27:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:27:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:27:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e4f3b2055dc76b072b46f0b42eb1a905a80e8f2184b0c1673b9457348dfa4ce03830e6e7f0267a0fa8166c135995b5563d500e20c5751268e543c5009aab59aa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/085429a17c685f1d2ad88070a8f25296a1ca7845197bc3e5fb06b35e2d234e59d125d4120de879337872fb46c05b8335f0a7cb551ea37b889cd2adddce0b5db4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4a21eeaed8a1cfcd9f9e5c231759480f329e0c5dc28e413b4272feca9d30acd20619b7e3f609d86bb70daa5d8d4650bd0da7743875b695c83377e332d7a6d719"} 04:27:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:27:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:27:25 INFO - Contents: 04:27:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e4f3b2055dc76b072b46f0b42eb1a905a80e8f2184b0c1673b9457348dfa4ce03830e6e7f0267a0fa8166c135995b5563d500e20c5751268e543c5009aab59aa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/085429a17c685f1d2ad88070a8f25296a1ca7845197bc3e5fb06b35e2d234e59d125d4120de879337872fb46c05b8335f0a7cb551ea37b889cd2adddce0b5db4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4a21eeaed8a1cfcd9f9e5c231759480f329e0c5dc28e413b4272feca9d30acd20619b7e3f609d86bb70daa5d8d4650bd0da7743875b695c83377e332d7a6d719"} 04:27:25 INFO - Running post-run listener: copy_logs_to_upload_dir 04:27:25 INFO - Copying logs to upload dir... 04:27:25 INFO - mkdir: /builds/slave/test/build/upload/logs 04:27:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.940407 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-06 04:27:24.985498) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 04:27:24.988963) ========= 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-1467803203.72708-96206001 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e4f3b2055dc76b072b46f0b42eb1a905a80e8f2184b0c1673b9457348dfa4ce03830e6e7f0267a0fa8166c135995b5563d500e20c5751268e543c5009aab59aa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/085429a17c685f1d2ad88070a8f25296a1ca7845197bc3e5fb06b35e2d234e59d125d4120de879337872fb46c05b8335f0a7cb551ea37b889cd2adddce0b5db4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4a21eeaed8a1cfcd9f9e5c231759480f329e0c5dc28e413b4272feca9d30acd20619b7e3f609d86bb70daa5d8d4650bd0da7743875b695c83377e332d7a6d719"} build_url:https://queue.taskcluster.net/v1/task/Kbljgn8EREeLU84WFBVQNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011344 build_url: 'https://queue.taskcluster.net/v1/task/Kbljgn8EREeLU84WFBVQNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e4f3b2055dc76b072b46f0b42eb1a905a80e8f2184b0c1673b9457348dfa4ce03830e6e7f0267a0fa8166c135995b5563d500e20c5751268e543c5009aab59aa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/085429a17c685f1d2ad88070a8f25296a1ca7845197bc3e5fb06b35e2d234e59d125d4120de879337872fb46c05b8335f0a7cb551ea37b889cd2adddce0b5db4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4a21eeaed8a1cfcd9f9e5c231759480f329e0c5dc28e413b4272feca9d30acd20619b7e3f609d86bb70daa5d8d4650bd0da7743875b695c83377e332d7a6d719"}' ========= master_lag: 0.12 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 04:27:25.119562) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 04:27:25.120021) ========= 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-1467803203.72708-96206001 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004431 ========= master_lag: 0.23 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 04:27:25.353845) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 04:27:25.354214) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 04:27:25.357617) ========= ========= Total master_lag: 0.42 =========