builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-014 starttime: 1467817559.39 results: success (0) buildid: 20160706071026 builduid: dd9f5df0a2fd4df48e2f8624da8b715a revision: cc1d6ac8152de5394ca090ff24aa89c590ef87a4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 08:05:59.389821) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 08:05:59.390553) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 08:05:59.391100) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 08:05:59.436833) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 08:05:59.437255) ========= 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=31acecf42b6a79ec49471d4a000001bb-1467815367.329965-313946457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-06 08:05:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 214M=0s 2016-07-06 08:05:59 (214 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.343324 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 08:05:59.795920) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 08:05:59.796293) ========= 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=31acecf42b6a79ec49471d4a000001bb-1467815367.329965-313946457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013621 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 08:05:59.849187) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 08:05:59.849736) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev cc1d6ac8152de5394ca090ff24aa89c590ef87a4 --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 cc1d6ac8152de5394ca090ff24aa89c590ef87a4 --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=31acecf42b6a79ec49471d4a000001bb-1467815367.329965-313946457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-06 08:05:59,966 truncating revision to first 12 chars 2016-07-06 08:05:59,966 Setting DEBUG logging. 2016-07-06 08:05:59,967 attempt 1/10 2016-07-06 08:05:59,967 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/cc1d6ac8152d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-06 08:06:00,329 unpacking tar archive at: fx-team-cc1d6ac8152d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.715607 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 08:06:00.581363) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 08:06:00.581683) ========= script_repo_revision: cc1d6ac8152de5394ca090ff24aa89c590ef87a4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 08:06:00.582137) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 08:06:00.582449) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 08:06:00.593546) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-07-06 08:06:00.593863) ========= /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=31acecf42b6a79ec49471d4a000001bb-1467815367.329965-313946457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:06:00 INFO - MultiFileLogger online at 20160706 08:06:00 in /builds/slave/test 08:06:00 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 08:06:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:06:00 INFO - {'append_to_log': False, 08:06:00 INFO - 'base_work_dir': '/builds/slave/test', 08:06:00 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:06:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:06:00 INFO - 'branch': 'Fx-Team-Non-PGO', 08:06:00 INFO - 'buildbot_json_path': 'buildprops.json', 08:06:00 INFO - 'config_files': ('talos/linux_config.py',), 08:06:00 INFO - 'default_actions': ('clobber', 08:06:00 INFO - 'read-buildbot-config', 08:06:00 INFO - 'download-and-extract', 08:06:00 INFO - 'populate-webroot', 08:06:00 INFO - 'create-virtualenv', 08:06:00 INFO - 'install', 08:06:00 INFO - 'run-tests'), 08:06:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:06:00 INFO - 'download_minidump_stackwalk': True, 08:06:00 INFO - 'download_symbols': 'ondemand', 08:06:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:06:00 INFO - 'tooltool.py': '/tools/tooltool.py', 08:06:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:06:00 INFO - '/tools/misc-python/virtualenv.py')}, 08:06:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:06:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:06:00 INFO - 'installer_path': 'installer.exe', 08:06:00 INFO - 'log_level': 'info', 08:06:00 INFO - 'log_name': 'talos', 08:06:00 INFO - 'log_to_console': True, 08:06:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:06:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:06:00 INFO - 'opt_config_files': (), 08:06:00 INFO - 'pip_index': False, 08:06:00 INFO - 'sps_profile': False, 08:06:00 INFO - 'sps_profile_interval': 0, 08:06:00 INFO - 'suite': 'dromaeojs', 08:06:00 INFO - 'system_bits': '32', 08:06:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:06:00 INFO - 'title': 'talos-linux64-ix-014', 08:06:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:06:00 INFO - 'use_talos_json': True, 08:06:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:06:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:06:00 INFO - 'work_dir': 'build'} 08:06:00 INFO - ##### 08:06:00 INFO - ##### Running clobber step. 08:06:00 INFO - ##### 08:06:00 INFO - Running pre-action listener: _resource_record_pre_action 08:06:00 INFO - Running main action method: clobber 08:06:00 INFO - rmtree: /builds/slave/test/build 08:06:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:06:01 INFO - Running post-action listener: _resource_record_post_action 08:06:01 INFO - ##### 08:06:01 INFO - ##### Finished clobber step (success) 08:06:01 INFO - ##### 08:06:01 INFO - ##### 08:06:01 INFO - ##### Running read-buildbot-config step. 08:06:01 INFO - ##### 08:06:01 INFO - Running pre-action listener: _resource_record_pre_action 08:06:01 INFO - Running main action method: read_buildbot_config 08:06:01 INFO - Using buildbot properties: 08:06:01 INFO - { 08:06:01 INFO - "project": "", 08:06:01 INFO - "product": "firefox", 08:06:01 INFO - "script_repo_revision": "production", 08:06:01 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:06:01 INFO - "repository": "", 08:06:01 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:06:01 INFO - "buildid": "20160706071026", 08:06:01 INFO - "pgo_build": "False", 08:06:01 INFO - "basedir": "/builds/slave/test", 08:06:01 INFO - "buildnumber": 3135, 08:06:01 INFO - "slavename": "talos-linux64-ix-014", 08:06:01 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:06:01 INFO - "platform": "ubuntu64_hw", 08:06:01 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:06:01 INFO - "branch": "fx-team", 08:06:01 INFO - "repo_path": "integration/fx-team", 08:06:01 INFO - "revision": "cc1d6ac8152de5394ca090ff24aa89c590ef87a4", 08:06:01 INFO - "stage_platform": "linux64", 08:06:01 INFO - "builduid": "dd9f5df0a2fd4df48e2f8624da8b715a", 08:06:01 INFO - "slavebuilddir": "test" 08:06:01 INFO - } 08:06:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/dJ2K4PIbRval5oKEKRccyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:06:01 INFO - Running post-action listener: _resource_record_post_action 08:06:01 INFO - ##### 08:06:01 INFO - ##### Finished read-buildbot-config step (success) 08:06:01 INFO - ##### 08:06:01 INFO - ##### 08:06:01 INFO - ##### Running download-and-extract step. 08:06:01 INFO - ##### 08:06:01 INFO - Running pre-action listener: _resource_record_pre_action 08:06:01 INFO - Running main action method: download_and_extract 08:06:01 INFO - mkdir: /builds/slave/test/build/tests 08:06:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:01 INFO - https://queue.taskcluster.net/v1/task/dJ2K4PIbRval5oKEKRccyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:06:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dJ2K4PIbRval5oKEKRccyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:06:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dJ2K4PIbRval5oKEKRccyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:06:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dJ2K4PIbRval5oKEKRccyw/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 08:06:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dJ2K4PIbRval5oKEKRccyw/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 08:06:06 INFO - Downloaded 1361 bytes. 08:06:06 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:06:06 INFO - Using the following test package requirements: 08:06:06 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:06:06 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:06:06 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:06:06 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:06 INFO - u'jsshell-linux-x86_64.zip'], 08:06:06 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:06:06 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:06:06 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:06:06 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:06:06 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:06:06 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:06:06 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:06:06 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')]} 08:06:06 INFO - https://queue.taskcluster.net/v1/task/dJ2K4PIbRval5oKEKRccyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:06:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dJ2K4PIbRval5oKEKRccyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:06:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dJ2K4PIbRval5oKEKRccyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:06:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dJ2K4PIbRval5oKEKRccyw/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 08:06:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dJ2K4PIbRval5oKEKRccyw/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 08:06:11 INFO - Downloaded 22730934 bytes. 08:06:11 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'] 08:06:11 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 08:06:12 INFO - Return code: 0 08:06:12 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 08:06:12 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')]} 08:06:12 INFO - https://queue.taskcluster.net/v1/task/dJ2K4PIbRval5oKEKRccyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:06:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dJ2K4PIbRval5oKEKRccyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:06:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dJ2K4PIbRval5oKEKRccyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:06:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dJ2K4PIbRval5oKEKRccyw/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 08:06:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dJ2K4PIbRval5oKEKRccyw/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 08:06:20 INFO - Downloaded 22730934 bytes. 08:06:20 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'] 08:06:20 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 08:06:21 INFO - Return code: 0 08:06:21 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')]} 08:06:21 INFO - https://queue.taskcluster.net/v1/task/dJ2K4PIbRval5oKEKRccyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:06:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dJ2K4PIbRval5oKEKRccyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:06:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dJ2K4PIbRval5oKEKRccyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:06:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dJ2K4PIbRval5oKEKRccyw/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 08:06:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dJ2K4PIbRval5oKEKRccyw/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 08:06:23 INFO - Downloaded 14403333 bytes. 08:06:23 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'] 08:06:23 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 08:06:23 INFO - Return code: 0 08:06:23 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')]} 08:06:23 INFO - https://queue.taskcluster.net/v1/task/dJ2K4PIbRval5oKEKRccyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:06:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dJ2K4PIbRval5oKEKRccyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:06:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dJ2K4PIbRval5oKEKRccyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:06:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dJ2K4PIbRval5oKEKRccyw/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 08:06:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dJ2K4PIbRval5oKEKRccyw/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 08:06:24 INFO - Downloaded 56481377 bytes. 08:06:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dJ2K4PIbRval5oKEKRccyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:06:24 INFO - mkdir: /builds/slave/test/properties 08:06:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:06:24 INFO - Writing to file /builds/slave/test/properties/build_url 08:06:24 INFO - Contents: 08:06:24 INFO - build_url:https://queue.taskcluster.net/v1/task/dJ2K4PIbRval5oKEKRccyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:06:25 INFO - Running post-action listener: _resource_record_post_action 08:06:25 INFO - Running post-action listener: set_extra_try_arguments 08:06:25 INFO - ##### 08:06:25 INFO - ##### Finished download-and-extract step (success) 08:06:25 INFO - ##### 08:06:25 INFO - ##### 08:06:25 INFO - ##### Running populate-webroot step. 08:06:25 INFO - ##### 08:06:25 INFO - Running pre-action listener: _resource_record_pre_action 08:06:25 INFO - Running main action method: populate_webroot 08:06:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:06:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:06:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:06:25 INFO - '--tppagecycles', 08:06:25 INFO - '7'], 08:06:25 INFO - 'tests': ['tsvgm']}}, 08:06:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:06:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:06:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:06:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:06:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:06:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:06:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:06:25 INFO - 'talos_options': ['--disable-e10s'], 08:06:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:06:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:06:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:06:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:06:25 INFO - 'talos_options': ['--disable-e10s'], 08:06:25 INFO - 'tests': ['damp', 'tps']}, 08:06:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:06:25 INFO - 'tests': ['damp', 'tps']}, 08:06:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:06:25 INFO - 'tests': ['dromaeo_dom']}, 08:06:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:06:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:06:25 INFO - 'tests': ['basic_compositor_video']}, 08:06:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:06:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:06:25 INFO - 'tests': ['a11yr', 08:06:25 INFO - 'ts_paint', 08:06:25 INFO - 'tpaint', 08:06:25 INFO - 'sessionrestore', 08:06:25 INFO - 'sessionrestore_no_auto_restore', 08:06:25 INFO - 'tabpaint']}, 08:06:25 INFO - 'other-e10s': {'tests': ['a11yr', 08:06:25 INFO - 'ts_paint', 08:06:25 INFO - 'tpaint', 08:06:25 INFO - 'sessionrestore', 08:06:25 INFO - 'sessionrestore_no_auto_restore', 08:06:25 INFO - 'tabpaint']}, 08:06:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:06:25 INFO - 'ts_paint', 08:06:25 INFO - 'tpaint', 08:06:25 INFO - 'sessionrestore', 08:06:25 INFO - 'sessionrestore_no_auto_restore', 08:06:25 INFO - 'tabpaint']}, 08:06:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:06:25 INFO - 'ts_paint', 08:06:25 INFO - 'tpaint', 08:06:25 INFO - 'sessionrestore', 08:06:25 INFO - 'sessionrestore_no_auto_restore', 08:06:25 INFO - 'tabpaint']}, 08:06:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:06:25 INFO - 'tests': ['a11yr', 08:06:25 INFO - 'ts_paint', 08:06:25 INFO - 'tpaint', 08:06:25 INFO - 'sessionrestore', 08:06:25 INFO - 'sessionrestore_no_auto_restore', 08:06:25 INFO - 'tabpaint']}, 08:06:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:06:25 INFO - 'tests': ['a11yr', 08:06:25 INFO - 'ts_paint', 08:06:25 INFO - 'tpaint', 08:06:25 INFO - 'sessionrestore', 08:06:25 INFO - 'sessionrestore_no_auto_restore', 08:06:25 INFO - 'tabpaint']}, 08:06:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:06:25 INFO - 'tests': ['tsvgx', 08:06:25 INFO - 'tsvgr_opacity', 08:06:25 INFO - 'tart', 08:06:25 INFO - 'tscrollx', 08:06:25 INFO - 'cart']}, 08:06:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:06:25 INFO - 'tsvgr_opacity', 08:06:25 INFO - 'tart', 08:06:25 INFO - 'tscrollx', 08:06:25 INFO - 'cart']}, 08:06:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:06:25 INFO - 'talos_options': ['--disable-e10s'], 08:06:25 INFO - 'tests': ['tp5o']}, 08:06:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:06:25 INFO - 'tests': ['tp5o']}, 08:06:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:06:25 INFO - 'talos_options': ['--disable-e10s', 08:06:25 INFO - '--xperf_path', 08:06:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:06:25 INFO - 'tests': ['tp5n']}, 08:06:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:06:25 INFO - 'talos_options': ['--xperf_path', 08:06:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:06:25 INFO - 'tests': ['tp5n']}}, 08:06:25 INFO - 'talos.zip': {'path': '', 08:06:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:06:25 INFO - Running post-action listener: _resource_record_post_action 08:06:25 INFO - ##### 08:06:25 INFO - ##### Finished populate-webroot step (success) 08:06:25 INFO - ##### 08:06:25 INFO - ##### 08:06:25 INFO - ##### Running create-virtualenv step. 08:06:25 INFO - ##### 08:06:25 INFO - Running pre-action listener: _resource_record_pre_action 08:06:25 INFO - Running main action method: create_virtualenv 08:06:25 INFO - Creating virtualenv /builds/slave/test/build/venv 08:06:25 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 08:06:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:06:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:06:25 INFO - Using real prefix '/usr' 08:06:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:06:25 INFO - Installing distribute.............................................................................................................................................................................................done. 08:06:27 INFO - Installing pip.................done. 08:06:27 INFO - Return code: 0 08:06:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:27 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 0x180a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1acb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac93b0>, '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 0x1aca2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aca740>, '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': '31acecf42b6a79ec49471d4a000001bb-1467815367.329965-313946457', '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 08:06:27 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 08:06:27 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 08:06:27 INFO - Using env: {'DISPLAY': ':0', 08:06:27 INFO - 'HOME': '/home/cltbld', 08:06:27 INFO - 'LANG': 'en_US.UTF-8', 08:06:27 INFO - 'LANGUAGE': 'en_US:en', 08:06:27 INFO - 'LOGNAME': 'cltbld', 08:06:27 INFO - 'MAIL': '/var/mail/cltbld', 08:06:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:27 INFO - 'MOZ_NO_REMOTE': '1', 08:06:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:27 INFO - 'NO_EM_RESTART': '1', 08:06:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:27 INFO - 'PWD': '/builds/slave/test', 08:06:27 INFO - 'SHELL': '/bin/bash', 08:06:27 INFO - 'SHLVL': '1', 08:06:27 INFO - 'TERM': 'linux', 08:06:27 INFO - 'TMOUT': '86400', 08:06:27 INFO - 'USER': 'cltbld', 08:06:27 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1467815367.329965-313946457', 08:06:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:27 INFO - '_': '/tools/buildbot/bin/python'} 08:06:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:28 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 08:06:28 INFO - Cleaning up... 08:06:28 INFO - Return code: 0 08:06:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x180a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1acb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac93b0>, '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 0x1aca2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aca740>, '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': '31acecf42b6a79ec49471d4a000001bb-1467815367.329965-313946457', '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 08:06:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:06:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:06:28 INFO - Using env: {'DISPLAY': ':0', 08:06:28 INFO - 'HOME': '/home/cltbld', 08:06:28 INFO - 'LANG': 'en_US.UTF-8', 08:06:28 INFO - 'LANGUAGE': 'en_US:en', 08:06:28 INFO - 'LOGNAME': 'cltbld', 08:06:28 INFO - 'MAIL': '/var/mail/cltbld', 08:06:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:28 INFO - 'MOZ_NO_REMOTE': '1', 08:06:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:28 INFO - 'NO_EM_RESTART': '1', 08:06:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:28 INFO - 'PWD': '/builds/slave/test', 08:06:28 INFO - 'SHELL': '/bin/bash', 08:06:28 INFO - 'SHLVL': '1', 08:06:28 INFO - 'TERM': 'linux', 08:06:28 INFO - 'TMOUT': '86400', 08:06:28 INFO - 'USER': 'cltbld', 08:06:28 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1467815367.329965-313946457', 08:06:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:28 INFO - '_': '/tools/buildbot/bin/python'} 08:06:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:28 INFO - Downloading/unpacking psutil>=3.1.1 08:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:06:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:06:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:06:30 INFO - Installing collected packages: psutil 08:06:30 INFO - Running setup.py install for psutil 08:06:31 INFO - building 'psutil._psutil_linux' extension 08:06:31 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 08:06:31 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 08:06:31 INFO - building 'psutil._psutil_posix' extension 08:06:31 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 08:06:31 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 08:06:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:06:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:06:31 INFO - Successfully installed psutil 08:06:31 INFO - Cleaning up... 08:06:31 INFO - Return code: 0 08:06:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:06:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1acb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac93b0>, '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 0x1aca2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aca740>, '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': '31acecf42b6a79ec49471d4a000001bb-1467815367.329965-313946457', '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 08:06:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:06:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:06:31 INFO - Using env: {'DISPLAY': ':0', 08:06:31 INFO - 'HOME': '/home/cltbld', 08:06:31 INFO - 'LANG': 'en_US.UTF-8', 08:06:31 INFO - 'LANGUAGE': 'en_US:en', 08:06:31 INFO - 'LOGNAME': 'cltbld', 08:06:31 INFO - 'MAIL': '/var/mail/cltbld', 08:06:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:31 INFO - 'MOZ_NO_REMOTE': '1', 08:06:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:31 INFO - 'NO_EM_RESTART': '1', 08:06:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:31 INFO - 'PWD': '/builds/slave/test', 08:06:31 INFO - 'SHELL': '/bin/bash', 08:06:31 INFO - 'SHLVL': '1', 08:06:31 INFO - 'TERM': 'linux', 08:06:31 INFO - 'TMOUT': '86400', 08:06:31 INFO - 'USER': 'cltbld', 08:06:31 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1467815367.329965-313946457', 08:06:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:31 INFO - '_': '/tools/buildbot/bin/python'} 08:06:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:06:31 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 08:06:31 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 08:06:31 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 08:06:31 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 08:06:31 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 08:06:31 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 08:06:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:06:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:06:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:06:33 INFO - Installing collected packages: mozsystemmonitor 08:06:33 INFO - Running setup.py install for mozsystemmonitor 08:06:33 INFO - Successfully installed mozsystemmonitor 08:06:33 INFO - Cleaning up... 08:06:33 INFO - Return code: 0 08:06:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:06:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:33 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 0x180a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1acb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac93b0>, '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 0x1aca2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aca740>, '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': '31acecf42b6a79ec49471d4a000001bb-1467815367.329965-313946457', '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 08:06:33 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 08:06:33 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 08:06:33 INFO - Using env: {'DISPLAY': ':0', 08:06:33 INFO - 'HOME': '/home/cltbld', 08:06:33 INFO - 'LANG': 'en_US.UTF-8', 08:06:33 INFO - 'LANGUAGE': 'en_US:en', 08:06:33 INFO - 'LOGNAME': 'cltbld', 08:06:33 INFO - 'MAIL': '/var/mail/cltbld', 08:06:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:33 INFO - 'MOZ_NO_REMOTE': '1', 08:06:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:33 INFO - 'NO_EM_RESTART': '1', 08:06:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:33 INFO - 'PWD': '/builds/slave/test', 08:06:33 INFO - 'SHELL': '/bin/bash', 08:06:33 INFO - 'SHLVL': '1', 08:06:33 INFO - 'TERM': 'linux', 08:06:33 INFO - 'TMOUT': '86400', 08:06:33 INFO - 'USER': 'cltbld', 08:06:33 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1467815367.329965-313946457', 08:06:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:33 INFO - '_': '/tools/buildbot/bin/python'} 08:06:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:34 INFO - Downloading/unpacking jsonschema==2.5.1 08:06:34 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 08:06:34 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 08:06:34 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 08:06:34 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 08:06:34 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 08:06:34 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 08:06:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:06:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:36 INFO - Downloading functools32-3.2.3-2.tar.gz 08:06:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:06:36 INFO - warning: no files found matching '*.txt' 08:06:36 INFO - no previously-included directories found matching 'build' 08:06:36 INFO - no previously-included directories found matching 'dist' 08:06:36 INFO - no previously-included directories found matching '.git*' 08:06:36 INFO - Installing collected packages: jsonschema, functools32 08:06:36 INFO - Running setup.py install for functools32 08:06:36 INFO - warning: no files found matching '*.txt' 08:06:36 INFO - no previously-included directories found matching 'build' 08:06:36 INFO - no previously-included directories found matching 'dist' 08:06:36 INFO - no previously-included directories found matching '.git*' 08:06:36 INFO - Successfully installed jsonschema functools32 08:06:36 INFO - Cleaning up... 08:06:36 INFO - Return code: 0 08:06:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:06:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:36 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 0x180a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1acb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac93b0>, '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 0x1aca2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aca740>, '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': '31acecf42b6a79ec49471d4a000001bb-1467815367.329965-313946457', '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 08:06:36 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 08:06:36 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 08:06:36 INFO - Using env: {'DISPLAY': ':0', 08:06:36 INFO - 'HOME': '/home/cltbld', 08:06:36 INFO - 'LANG': 'en_US.UTF-8', 08:06:36 INFO - 'LANGUAGE': 'en_US:en', 08:06:36 INFO - 'LOGNAME': 'cltbld', 08:06:36 INFO - 'MAIL': '/var/mail/cltbld', 08:06:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:36 INFO - 'MOZ_NO_REMOTE': '1', 08:06:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:36 INFO - 'NO_EM_RESTART': '1', 08:06:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:36 INFO - 'PWD': '/builds/slave/test', 08:06:36 INFO - 'SHELL': '/bin/bash', 08:06:36 INFO - 'SHLVL': '1', 08:06:36 INFO - 'TERM': 'linux', 08:06:36 INFO - 'TMOUT': '86400', 08:06:36 INFO - 'USER': 'cltbld', 08:06:36 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1467815367.329965-313946457', 08:06:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:36 INFO - '_': '/tools/buildbot/bin/python'} 08:06:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:36 INFO - Downloading/unpacking blobuploader==1.2.4 08:06:36 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 08:06:36 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 08:06:36 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 08:06:36 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 08:06:36 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 08:06:36 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 08:06:38 INFO - Downloading blobuploader-1.2.4.tar.gz 08:06:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:06:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:06:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:39 INFO - Downloading docopt-0.6.1.tar.gz 08:06:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:06:39 INFO - Installing collected packages: blobuploader, requests, docopt 08:06:39 INFO - Running setup.py install for blobuploader 08:06:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:06:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:06:39 INFO - Running setup.py install for requests 08:06:39 INFO - Running setup.py install for docopt 08:06:39 INFO - Successfully installed blobuploader requests docopt 08:06:39 INFO - Cleaning up... 08:06:39 INFO - Return code: 0 08:06:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:39 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 0x180a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1acb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac93b0>, '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 0x1aca2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aca740>, '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': '31acecf42b6a79ec49471d4a000001bb-1467815367.329965-313946457', '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 08:06:39 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 08:06:39 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 08:06:39 INFO - Using env: {'DISPLAY': ':0', 08:06:39 INFO - 'HOME': '/home/cltbld', 08:06:39 INFO - 'LANG': 'en_US.UTF-8', 08:06:39 INFO - 'LANGUAGE': 'en_US:en', 08:06:39 INFO - 'LOGNAME': 'cltbld', 08:06:39 INFO - 'MAIL': '/var/mail/cltbld', 08:06:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:39 INFO - 'MOZ_NO_REMOTE': '1', 08:06:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:39 INFO - 'NO_EM_RESTART': '1', 08:06:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:39 INFO - 'PWD': '/builds/slave/test', 08:06:39 INFO - 'SHELL': '/bin/bash', 08:06:39 INFO - 'SHLVL': '1', 08:06:39 INFO - 'TERM': 'linux', 08:06:39 INFO - 'TMOUT': '86400', 08:06:39 INFO - 'USER': 'cltbld', 08:06:39 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1467815367.329965-313946457', 08:06:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:39 INFO - '_': '/tools/buildbot/bin/python'} 08:06:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:06:40 INFO - Running setup.py (path:/tmp/pip-3pVApi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:06:40 INFO - Running setup.py (path:/tmp/pip-NEoWGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:06:40 INFO - Running setup.py (path:/tmp/pip-JLZ845-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:06:40 INFO - Running setup.py (path:/tmp/pip-xnUNda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:06:40 INFO - Running setup.py (path:/tmp/pip-eehxdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:06:40 INFO - Running setup.py (path:/tmp/pip-S2QHrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:06:40 INFO - Running setup.py (path:/tmp/pip-3raxmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:06:40 INFO - Running setup.py (path:/tmp/pip-qou1Mu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:06:40 INFO - Running setup.py (path:/tmp/pip-gueNlw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:06:40 INFO - Running setup.py (path:/tmp/pip-xXAWkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:06:40 INFO - Running setup.py (path:/tmp/pip-1JpSm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:06:40 INFO - Running setup.py (path:/tmp/pip-uh9Woc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:06:40 INFO - Running setup.py (path:/tmp/pip-pPiMmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:06:41 INFO - Running setup.py (path:/tmp/pip-i1Vb28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:06:41 INFO - Running setup.py (path:/tmp/pip-wifl2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:06:41 INFO - Running setup.py (path:/tmp/pip-TLbY98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:06:41 INFO - Running setup.py (path:/tmp/pip-MOoaHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:06:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:06:41 INFO - Running setup.py install for manifestparser 08:06:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:06:41 INFO - Running setup.py install for mozcrash 08:06:41 INFO - Running setup.py install for mozdebug 08:06:41 INFO - Running setup.py install for mozdevice 08:06:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:06:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:06:41 INFO - Running setup.py install for mozfile 08:06:41 INFO - Running setup.py install for mozhttpd 08:06:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:06:41 INFO - Running setup.py install for mozinfo 08:06:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:06:42 INFO - Running setup.py install for mozInstall 08:06:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:06:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:06:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:06:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:06:42 INFO - Running setup.py install for mozleak 08:06:42 INFO - Running setup.py install for mozlog 08:06:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:06:42 INFO - Running setup.py install for moznetwork 08:06:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:06:42 INFO - Running setup.py install for mozprocess 08:06:42 INFO - Running setup.py install for mozprofile 08:06:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:06:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:06:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:06:42 INFO - Running setup.py install for mozrunner 08:06:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:06:42 INFO - Running setup.py install for mozscreenshot 08:06:42 INFO - Running setup.py install for moztest 08:06:42 INFO - Running setup.py install for mozversion 08:06:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:06:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:06:43 INFO - Cleaning up... 08:06:43 INFO - Return code: 0 08:06:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:43 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 0x180a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1acb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac93b0>, '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 0x1aca2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aca740>, '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': '31acecf42b6a79ec49471d4a000001bb-1467815367.329965-313946457', '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 08:06:43 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 08:06:43 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 08:06:43 INFO - Using env: {'DISPLAY': ':0', 08:06:43 INFO - 'HOME': '/home/cltbld', 08:06:43 INFO - 'LANG': 'en_US.UTF-8', 08:06:43 INFO - 'LANGUAGE': 'en_US:en', 08:06:43 INFO - 'LOGNAME': 'cltbld', 08:06:43 INFO - 'MAIL': '/var/mail/cltbld', 08:06:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:43 INFO - 'MOZ_NO_REMOTE': '1', 08:06:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:43 INFO - 'NO_EM_RESTART': '1', 08:06:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:43 INFO - 'PWD': '/builds/slave/test', 08:06:43 INFO - 'SHELL': '/bin/bash', 08:06:43 INFO - 'SHLVL': '1', 08:06:43 INFO - 'TERM': 'linux', 08:06:43 INFO - 'TMOUT': '86400', 08:06:43 INFO - 'USER': 'cltbld', 08:06:43 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1467815367.329965-313946457', 08:06:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:43 INFO - '_': '/tools/buildbot/bin/python'} 08:06:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:06:43 INFO - Running setup.py (path:/tmp/pip-Ruqx89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:06:43 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)) 08:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:06:43 INFO - Running setup.py (path:/tmp/pip-LosF0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:06:43 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)) 08:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:06:43 INFO - Running setup.py (path:/tmp/pip-cAcRh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:06:43 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)) 08:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:06:43 INFO - Running setup.py (path:/tmp/pip-t0TmaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:06:43 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)) 08:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:06:43 INFO - Running setup.py (path:/tmp/pip-SnK5mR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:06:43 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)) 08:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:06:43 INFO - Running setup.py (path:/tmp/pip-SwImWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:06:43 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)) 08:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:06:43 INFO - Running setup.py (path:/tmp/pip-hdOWQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:06:43 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)) 08:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:06:43 INFO - Running setup.py (path:/tmp/pip-gfogVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:06:43 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)) 08:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:06:43 INFO - Running setup.py (path:/tmp/pip-OaIFS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:06:43 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)) 08:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:06:43 INFO - Running setup.py (path:/tmp/pip-rHtO2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:06:44 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)) 08:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:06:44 INFO - Running setup.py (path:/tmp/pip-_CNUlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:06:44 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)) 08:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:06:44 INFO - Running setup.py (path:/tmp/pip-HnuyQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:06:44 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)) 08:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:06:44 INFO - Running setup.py (path:/tmp/pip-Q0p4xa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:06:44 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)) 08:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:06:44 INFO - Running setup.py (path:/tmp/pip-RLaO0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:06:44 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)) 08:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:06:44 INFO - Running setup.py (path:/tmp/pip-xlhYn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:06:44 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)) 08:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:06:44 INFO - Running setup.py (path:/tmp/pip-jtmSbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:06:44 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)) 08:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:06:44 INFO - Running setup.py (path:/tmp/pip-dO72YD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:06:44 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)) 08:06:44 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)) 08:06:44 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)) 08:06:44 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)) 08:06:44 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)) 08:06:44 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)) 08:06:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:46 INFO - Downloading blessings-1.6.tar.gz 08:06:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:06:46 INFO - Installing collected packages: blessings 08:06:46 INFO - Running setup.py install for blessings 08:06:46 INFO - Successfully installed blessings 08:06:46 INFO - Cleaning up... 08:06:46 INFO - Return code: 0 08:06:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:06:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:06:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:06:46 INFO - Reading from file tmpfile_stdout 08:06:46 INFO - Current package versions: 08:06:46 INFO - argparse == 1.2.1 08:06:46 INFO - blessings == 1.6 08:06:46 INFO - blobuploader == 1.2.4 08:06:46 INFO - docopt == 0.6.1 08:06:46 INFO - functools32 == 3.2.3-2 08:06:46 INFO - jsonschema == 2.5.1 08:06:46 INFO - manifestparser == 1.1 08:06:46 INFO - mozInstall == 1.12 08:06:46 INFO - mozcrash == 0.17 08:06:46 INFO - mozdebug == 0.1 08:06:46 INFO - mozdevice == 0.48 08:06:46 INFO - mozfile == 1.2 08:06:46 INFO - mozhttpd == 0.7 08:06:46 INFO - mozinfo == 0.9 08:06:46 INFO - mozleak == 0.1 08:06:46 INFO - mozlog == 3.2 08:06:46 INFO - moznetwork == 0.27 08:06:46 INFO - mozprocess == 0.22 08:06:46 INFO - mozprofile == 0.28 08:06:46 INFO - mozrunner == 6.11 08:06:46 INFO - mozscreenshot == 0.1 08:06:46 INFO - mozsystemmonitor == 0.3 08:06:46 INFO - moztest == 0.7 08:06:46 INFO - mozversion == 1.4 08:06:46 INFO - psutil == 3.1.1 08:06:46 INFO - requests == 1.2.3 08:06:46 INFO - wsgiref == 0.1.2 08:06:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:46 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 0x180a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1acb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac93b0>, '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 0x1aca2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aca740>, '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': '31acecf42b6a79ec49471d4a000001bb-1467815367.329965-313946457', '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 08:06:46 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 08:06:46 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 08:06:46 INFO - Using env: {'DISPLAY': ':0', 08:06:46 INFO - 'HOME': '/home/cltbld', 08:06:46 INFO - 'LANG': 'en_US.UTF-8', 08:06:46 INFO - 'LANGUAGE': 'en_US:en', 08:06:46 INFO - 'LOGNAME': 'cltbld', 08:06:46 INFO - 'MAIL': '/var/mail/cltbld', 08:06:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:46 INFO - 'MOZ_NO_REMOTE': '1', 08:06:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:46 INFO - 'NO_EM_RESTART': '1', 08:06:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:46 INFO - 'PWD': '/builds/slave/test', 08:06:46 INFO - 'SHELL': '/bin/bash', 08:06:46 INFO - 'SHLVL': '1', 08:06:46 INFO - 'TERM': 'linux', 08:06:46 INFO - 'TMOUT': '86400', 08:06:46 INFO - 'USER': 'cltbld', 08:06:46 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1467815367.329965-313946457', 08:06:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:46 INFO - '_': '/tools/buildbot/bin/python'} 08:06:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:47 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)) 08:06:47 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)) 08:06:47 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)) 08:06:47 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)) 08:06:47 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)) 08:06:47 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)) 08:06:47 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)) 08:06:47 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)) 08:06:47 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)) 08:06:47 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)) 08:06:47 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)) 08:06:47 INFO - Cleaning up... 08:06:47 INFO - Return code: 0 08:06:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1acb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac93b0>, '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 0x1aca2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aca740>, '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': '31acecf42b6a79ec49471d4a000001bb-1467815367.329965-313946457', '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 08:06:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:06:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:06:47 INFO - Using env: {'DISPLAY': ':0', 08:06:47 INFO - 'HOME': '/home/cltbld', 08:06:47 INFO - 'LANG': 'en_US.UTF-8', 08:06:47 INFO - 'LANGUAGE': 'en_US:en', 08:06:47 INFO - 'LOGNAME': 'cltbld', 08:06:47 INFO - 'MAIL': '/var/mail/cltbld', 08:06:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:47 INFO - 'MOZ_NO_REMOTE': '1', 08:06:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:47 INFO - 'NO_EM_RESTART': '1', 08:06:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:47 INFO - 'PWD': '/builds/slave/test', 08:06:47 INFO - 'SHELL': '/bin/bash', 08:06:47 INFO - 'SHLVL': '1', 08:06:47 INFO - 'TERM': 'linux', 08:06:47 INFO - 'TMOUT': '86400', 08:06:47 INFO - 'USER': 'cltbld', 08:06:47 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1467815367.329965-313946457', 08:06:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:47 INFO - '_': '/tools/buildbot/bin/python'} 08:06:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:06:47 INFO - Cleaning up... 08:06:47 INFO - Return code: 0 08:06:47 INFO - Running post-action listener: _resource_record_post_action 08:06:47 INFO - Running post-action listener: _start_resource_monitoring 08:06:47 INFO - Starting resource monitoring. 08:06:47 INFO - ##### 08:06:47 INFO - ##### Finished create-virtualenv step (success) 08:06:47 INFO - ##### 08:06:47 INFO - ##### 08:06:47 INFO - ##### Running install step. 08:06:47 INFO - ##### 08:06:47 INFO - Running pre-action listener: _resource_record_pre_action 08:06:47 INFO - Running main action method: install 08:06:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:06:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:06:47 INFO - Reading from file tmpfile_stdout 08:06:47 INFO - Detecting whether we're running mozinstall >=1.0... 08:06:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:06:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:06:47 INFO - Reading from file tmpfile_stdout 08:06:47 INFO - Output received: 08:06:47 INFO - Usage: mozinstall [options] installer 08:06:47 INFO - Options: 08:06:47 INFO - -h, --help show this help message and exit 08:06:47 INFO - -d DEST, --destination=DEST 08:06:47 INFO - Directory to install application into. [default: 08:06:47 INFO - "/builds/slave/test"] 08:06:47 INFO - --app=APP Application being installed. [default: firefox] 08:06:47 INFO - mkdir: /builds/slave/test/build/application 08:06:47 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'] 08:06:47 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 08:07:03 INFO - Reading from file tmpfile_stdout 08:07:03 INFO - Output received: 08:07:03 INFO - /builds/slave/test/build/application/firefox/firefox 08:07:03 INFO - Running post-action listener: _resource_record_post_action 08:07:03 INFO - ##### 08:07:03 INFO - ##### Finished install step (success) 08:07:03 INFO - ##### 08:07:03 INFO - ##### 08:07:03 INFO - ##### Running run-tests step. 08:07:03 INFO - ##### 08:07:03 INFO - Running pre-action listener: _resource_record_pre_action 08:07:03 INFO - Running main action method: run_tests 08:07:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:07:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:07:03 INFO - Python 2.7.3 08:07:03 INFO - Return code: 0 08:07:03 INFO - grabbing minidump binary from tooltool 08:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:03 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 0x1ac93b0>, '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 0x1aca2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aca740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:07:03 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 08:07:03 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 08:07:03 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 08:07:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:07:04 INFO - Return code: 0 08:07:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:07:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:07:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:07:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:07:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:07:04 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/dJ2K4PIbRval5oKEKRccyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 08:07:04 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/dJ2K4PIbRval5oKEKRccyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --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 08:07:04 INFO - Using env: {'DISPLAY': ':0', 08:07:04 INFO - 'HOME': '/home/cltbld', 08:07:04 INFO - 'LANG': 'en_US.UTF-8', 08:07:04 INFO - 'LANGUAGE': 'en_US:en', 08:07:04 INFO - 'LOGNAME': 'cltbld', 08:07:04 INFO - 'MAIL': '/var/mail/cltbld', 08:07:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:07:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:07:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:04 INFO - 'MOZ_NO_REMOTE': '1', 08:07:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:07:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:04 INFO - 'NO_EM_RESTART': '1', 08:07:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:04 INFO - 'PWD': '/builds/slave/test', 08:07:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:07:04 INFO - 'SHELL': '/bin/bash', 08:07:04 INFO - 'SHLVL': '1', 08:07:04 INFO - 'TERM': 'linux', 08:07:04 INFO - 'TMOUT': '86400', 08:07:04 INFO - 'USER': 'cltbld', 08:07:04 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1467815367.329965-313946457', 08:07:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:04 INFO - '_': '/tools/buildbot/bin/python'} 08:07:04 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/dJ2K4PIbRval5oKEKRccyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 08:07:04 INFO - mozversion application_buildid: 20160706071026 08:07:04 INFO - mozversion application_changeset: cc1d6ac8152de5394ca090ff24aa89c590ef87a4 08:07:04 INFO - mozversion application_display_name: Nightly 08:07:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:07:04 INFO - mozversion application_name: Firefox 08:07:04 INFO - mozversion application_remotingname: firefox 08:07:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:07:04 INFO - mozversion application_vendor: Mozilla 08:07:04 INFO - mozversion application_version: 50.0a1 08:07:04 INFO - mozversion platform_buildid: 20160706071026 08:07:04 INFO - mozversion platform_changeset: cc1d6ac8152de5394ca090ff24aa89c590ef87a4 08:07:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:07:04 INFO - mozversion platform_version: 50.0a1 08:07:04 INFO - using testdate: 1467817624 08:07:04 INFO - actual date: 1467817624 08:07:04 INFO - starting webserver on 'localhost:38824' 08:07:04 INFO - SUITE-START | Running 2 tests 08:07:04 INFO - TEST-START | dromaeo_css 08:07:04 INFO - operating with platform_type : linux_ 08:07:04 INFO - Initialising browser for dromaeo_css test... 08:07:04 INFO - TEST-INFO | started process 7134 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMsIH3s/profile http://localhost:38824/getInfo.html) 08:07:08 INFO - PROCESS | 7134 | __metrics Screen width/height:1600/1200 08:07:08 INFO - PROCESS | 7134 | colorDepth:24 08:07:08 INFO - PROCESS | 7134 | Browser inner width/height: 1024/697 08:07:08 INFO - PROCESS | 7134 | __metrics 08:07:09 INFO - PROCESS | 7134 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:07:10 INFO - TEST-INFO | 7134: exit 0 08:07:10 INFO - Browser initialized. 08:07:10 INFO - Running cycle 1/1 for dromaeo_css test... 08:07:10 INFO - TEST-INFO | started process 7213 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMsIH3s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:07:22 INFO - PROCESS | 7213 | RSS: Main: 158085120 08:07:22 INFO - PROCESS | 7213 | 08:08:13 INFO - PROCESS | 7213 | 1467817693606 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] 08:10:26 INFO - PROCESS | 7213 | Cycle 1(1): loaded http://localhost:38824/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38824/tests/dromaeo/cssquery-ext.html) 08:10:28 INFO - PROCESS | 7213 | RSS: Main: 272637952 08:10:28 INFO - PROCESS | 7213 | 08:13:30 INFO - PROCESS | 7213 | Cycle 1(1): loaded http://localhost:38824/tests/dromaeo/cssquery-ext.html (next: http://localhost:38824/tests/dromaeo/cssquery-jquery.html) 08:13:31 INFO - PROCESS | 7213 | RSS: Main: 247160832 08:13:31 INFO - PROCESS | 7213 | 08:16:33 INFO - PROCESS | 7213 | Cycle 1(1): loaded http://localhost:38824/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38824/tests/dromaeo/cssquery-mootools.html) 08:16:34 INFO - PROCESS | 7213 | RSS: Main: 243277824 08:16:34 INFO - PROCESS | 7213 | 08:19:36 INFO - PROCESS | 7213 | Cycle 1(1): loaded http://localhost:38824/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38824/tests/dromaeo/cssquery-prototype.html) 08:19:37 INFO - PROCESS | 7213 | RSS: Main: 234958848 08:19:37 INFO - PROCESS | 7213 | 08:22:40 INFO - PROCESS | 7213 | Cycle 1(1): loaded http://localhost:38824/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38824/tests/dromaeo/cssquery-yui.html) 08:22:40 INFO - PROCESS | 7213 | RSS: Main: 233091072 08:22:40 INFO - PROCESS | 7213 | 08:25:43 INFO - PROCESS | 7213 | Cycle 1(1): loaded http://localhost:38824/tests/dromaeo/cssquery-yui.html (next: http://localhost:38824/tests/dromaeo/cssquery-dojo.html) 08:25:43 INFO - PROCESS | 7213 | RSS: Main: 276250624 08:25:43 INFO - PROCESS | 7213 | 08:25:43 INFO - PROCESS | 7213 | __start_tp_report 08:25:43 INFO - PROCESS | 7213 | _x_x_mozilla_page_load 08:25:43 INFO - PROCESS | 7213 | _x_x_mozilla_page_load_details 08:25:43 INFO - PROCESS | 7213 | |i|pagename|runs| 08:25:43 INFO - PROCESS | 7213 | |0;dojo.html;2613.6732908386452;2624.40950786073;2654.5221860065185;2666.053550989399;2669.5461771498844;4590.219662657348;4651.88370290742;4712.811487540499;4722.1972264715;4780.354652121962;4657.813687452506;4697;4727.763611819412;4730.621550275978;4747.691400058994;4306.892327691801;4328.285832837578;4342.609165175134;4387.3857659927635;4493.033997690496;4370.847020354288;4426.77866106695;4454.910901781978;4486.439195100613;4496.392986946753;4246.7876606169875;4397.802098905557;4426.358178064179;4448.221561226773;4457.732536047832;4277.572242775728;4281.400603915455;4290.184864875695;4295.377170310318;4330.935035974463;4251.511076226243;4312.978435107836;4331.631811296043;4331.913361732748;4384.693071484998;4620.630349572026;4740.217864052427;4753.453352864431;4772.451168115676;4779.378680771512;4989.675671081368;5033.597312215014;5061.949380506185;5068.163752980754;5121;5127.846164615067;5130.615203859688;5141.177411614124;5150.330457040561;5163.251328557376;4563.566461186182;4693.9765301173275;4718.669693121448;4739.028499157665;4750.548697873696;5204.271402003723;5229.686218826882;5300.44345343741;5310.787568497294;5311.070562651597;5004.674696144812;5005.5745261653165;5048.62135339851;5063.063333283354;5069.315642388304;4915.557599816034;4987.1771157759285;5077.974610126926;5148.922766158511;5155.6391052626705;5045.167547354646;5058.595312375001;5064;5064.164412871834;5087.618428617869;5045.84862454127;5047.520485553867;5048.3184770056305;5048.899022019539;5080;4086.8569600063856;4137.81379837908;4149.232392007489;4183.707140500136;4278.871633850989;3670.908227294339;3684.8526058957877;3687.078230442389;3719.795411252353;3741.363968125371;4345.543717909637;4349.13017396522;4353.477582690034;4388.429504164502;4393.143337049309;4876.780544875489;4934.703917764946;4934.9753251233515;5004.824831130893;5097.260897169889;4334.1548398062705;4335.544767799399;4337.067530480898;4367.956320436819;4388.27593447084;4464.330350447459;4465.754383508938;4471.433611783319;4477.686561940698;4517.661175411858;4680.5085466025575;4740.881477963078;4792.592629626521;4809.759512024315;4815.566599005966;5089.414717307557;5097.311862898461;5101.336826212717;5106.69359838396;5156.484351564814;4820.71075735457;4830.565249127455;4833.540813622701;4833.637477189295;4881.682690625098;4802.27965805132;4914.115459217375;4962.652614316963;4972.453030166606;5004.149294619996;5031.723255220998;5042.193249080129;5064.82273120439;5067.189249720027;5108.055009823194;4717.882052948704;4880.6583539153335;4891.144049791201;4892.877678058077;4946.851594452172;4830.951690483191;4871.8294859679745;4882.389701287339;4900.093482705711;4910.361652985232;4824.589909857701;4826.8793280168275;4871.926921096116;4874.171390863491;4875.463698993179;4804.375431193923;4881.365422495053;4919.0899683558655;4939.061578300255;4942.061008408391;4687.531246875285;4708.811647534198;4725.952740472551;4773.09311230865;4823.589994850477 08:25:43 INFO - PROCESS | 7213 | |1;ext.html;553.0625589625585;582.1645938078858;587.9323877754057;593.8218534439669;598.5780025082317;27576.86211568942;30166.69833301669;30180.396392072173;39088.80455597725;40368.79815600918;40315.395269070985;40662.593374066324;40683.79658101713;40686.59313406865;40703.38944915828;7867.881981770263;8015;8016.799580010517;8019.919800801976;8022.19778022199;7591.848163036736;7675.695131827602;7678.308952194301;7678.69285228593;7680.807979800522;7690.192529784376;7712.035995500562;7727.6522556484815;7728.613569321539;7730.458867879251;7701;7717.536947783151;7732.149463559004;7737.226277372274;7740.109887362969;7674.117476490219;7748.380129589619;7946.920530794676;7949.205079492062;7953.164917683618;37682.434763478566;38167.8091609543;38211.23577528434;38241.043973900596;38314.23371532582;2973.732364087221;3198.2484116232667;3368.309496553201;3527.735419843522;3679.816009199556;29500.557491637643;29699.851500742574;29956.550651740243;30073.699263007307;30367.696323036707;3297.4888892221743;3302.9174270643184;3331.1505566080496;3346.966530334714;3402.42158832999;239165;239740;239788;240225;240450;51865.7406712964;52047.47952520502;52214.73892630589;52271.73864130655;52326;33293;34178;34219.315613688086;35764.821175894474;35775.64224357775;14958.925205373904;14980.176090314919;14992.100473971597;15087.396504139711;15159.696806063817;11416.828747568794;11469.827952580717;11500.712482188012;11502.424878756028;11509.827352589718;18347.63304733898;18447.16987735555;18524;18552;18553;6754.3245675433045;6900.896486552706;7030.156381234285;7038.120234970629;7101.254368291255;774.6436639145943;831.2477208126655;884.5842454046588;907.4011152639226;920.7513971227731;28398.432031359258;28646;28675.422851743355;28921.23099651642;29236.561451578244;807.3500831830315;988.3526290279879;1018.0398250804377;1022.3661329975463;1054.920880933933;14487.275636218146;14911.478098266509;15064.774028389584;15085.314768417074;15085.773713394308;377040;383854;384052;386257;386952;48105.5189448101;48636.513634863906;48674.756626216644;48718.999999999294;48720.756396217796;1064.5635289531256;1124.3759713359163;1137.5961533655434;1141.714571357144;1172.6306213542707;27522.724772752015;29582.556261655664;29722.55416168716;29914.70085299206;30721.231969200056;42638;42841.1431771369;43362.349564755925;43378.56621433745;43415.78292108519;333167;337676;337792;338756;404816;39284.41073383844;40123.59876401316;40235.39646905357;41523.7923810379;42316.576834231266;42623.360649590904;42909.785451072545;43613.56386436095;43724.56275437205;44117.77941110274;36630.267394651426;37353.252934941695;37569.62430375661;38034.61965380421;38120.80939595284;37553.436698449;37682.8115859419;38229.61770382261;38477.6152238474;38713;36017.639823602476;36616.26767464689;36755.81622091872;36916;36996.07509812276;31809.363812724077;33542;33898;34138.48792268168;34479.31041379208;25539;25903.48193036091;25987.870060649577;26017.479650407266;26099.73900261049 08:25:43 INFO - PROCESS | 7213 | |2;jquery.html;351.47103609068347;374.59730789401397;380.2300341807837;382.64031810098504;393.9606039396059;13204.801927971075;16563.50309490716;17004.234809433558;18211.90894045528;19151.616967660637;17986.190621422036;18068.548286292815;18163;18335.449936501893;18391.540211494685;4563.863084107474;4858.295547145662;4858.368412106422;4914.189158788796;4918.409790825088;3614.6566076222716;4807.61539076873;5463.125899856024;5779.162021506879;5810;5751.971240143794;5766.884662306751;5793.102069179284;5797;5800.9709951450395;5795.362510123883;6349.968250158766;6352.1742173517605;6354;6356.586821856587;3446.9655303446893;5043.949560504385;5291.3650361956425;5297.973510132463;5618.381977982419;12475.376231188404;12651.177673451197;12712.237265764084;14568.417263309455;21174.153033878625;1938.4572319750494;1949.6100779844087;1958.5593241520544;2076.9407602123024;2082.6875968604677;9113.544322783835;9304.348695591312;9328.39365441244;9710.708678739578;9804.65683701067;1754.7104727719911;1821.6720990221754;1831.395639438982;1846.759921210234;1877.1646617255326;68450;70598;71125.64437177782;71532.28467715309;71812;8970.86543701845;9481.620735170654;10220.335678180894;10221.488925553693;10371.429571373646;12883.742325153444;13603.387847546686;13626.318684065756;14022.929885350508;14095.94280428972;7417.517861339104;7597.810054748676;7645.541267523967;7720.227977202235;7728.613569321511;7172.282771722786;7229.783106506813;7320.560766354036;7367.300106489874;7396.667149978264;3975.3043217436834;4186.727862688916;4318.352247162888;4322.394864718942;4330.155619654201;1773.8846974946587;1841.539615096226;1867.5797945462434;1876.3807943378652;1879.257693211174;843.325339728215;856.118198255785;918.807050519385;925.1904583489446;947.7346343023964;16954.321827126776;17672.646547068987;18157.7276340855;18352.63294734098;18519;865.1564724393666;871.3987348729356;888.7778055486128;898.793277546155;965.3339195954909;9722.75693107678;9914.851277230848;9939.900600994042;9989.30074894765;10051.497425128715;373062;373640;377464;380430;384459;81154;81641;82671;82860.58569707234;83388;880.1805904833659;889.8932128144664;895.3866601377947;910.940788848736;937.8593211018265;15436.45972390961;15720.056796592242;15746.76379854326;15945.920270398574;16187.190640468165;37392.62607373892;37892.24215515729;38167.427488587135;38229;38361.616383835804;50190;51182;51454;53186;53291.46708532865;6830.180378354629;7768.262015108556;7810.57041862703;7970.601469926364;8012.439129261129;10237.692869213935;12792.04059695508;12860.614181574567;12900.09699321076;13025.544105956245;10968.725781855517;11041.39272340029;11151.386673732699;11231.26996745209;11326.263792853439;6191.81424557264;10362.274640775073;10961.56153753841;11029.61396351124;11049.668509944715;11046.779064418828;11175.608853690082;11224.887751122384;11241.943790280997;11420.486078126338;6866.485013623898;7187.8562428752175;7337.853242935218;7368.557886526825;7579.0905091387185;7894.171112033384;10736.570537178426;10878.836817447585;10922.126229901747;11178.441077946232 08:25:43 INFO - PROCESS | 7213 | |3;mootools.html;1400.096937475328;1450.4850777973818;1537.3235776258452;1734.8698847586434;1765.8057613662495;6889.242183359826;7142.464315176369;7514.774556763299;7993.080795708495;7996.560189189599;7579.621018949044;7903.328217101539;7906.090799558038;7960.323372513343;8070.91929080709;2234.8770817605064;2259.3560835161984;2264.5810525052916;2264.977350226493;2265.0939624150387;1901.9334323298688;2125.5855108253895;2212.1040978403694;2214.678871563622;2233.486298151426;2238.977610223901;2259.6949411829355;2261.1407665087245;2263.875486848223;2263.909443622253;2149.2047942261383;2179.9863063675466;2180.149741600777;2181.476445653048;2181.901814418355;2173.576152650234;2189.770074142224;2194.7585765565773;2216.5788500184913;2220.367195349334;8130;8134.430589858713;8137.145599712004;8138.877916831252;8147.063087744867;4613.5847773700525;4624.260118381077;4767.904641907177;4770.117528257283;4787.0904528139545;2784.303924018995;2854.4005758790677;2854.9714502854913;2936.8531573421456;2948.7346138847606;900.0954041188629;908.0964440381862;917.857732051533;937.8640097185938;942.9622815087388;10753.623623173151;10793.460326983697;10821.783564328669;10837;10848.620298289521;4185.707000509996;4287.549807270254;4334.804933777988;4411.139827733626;4436.578525040116;9221.354505184572;9238.58426370815;9252.074792520829;9272.582733776997;9277.953610231905;4738.455077666113;4748.905021899543;4751;4754.976225118921;4759.16714574948;4218.894527636772;4315.11540134278;4319.805608747551;4325.178216138924;4334.956650433455;3516.876909308162;3549.0772399175885;3550.9644903551152;3585.8565657373933;3603.0632035670915;1058.3279617442824;1059.3114475590928;1060.2154405739852;1068;1069.9411532365639;783.9882401763978;789.7867575754514;791.6714563456217;807.6284908941952;809.0210844877764;4902.264660300983;5001.274815151783;5059.924101138486;5177.611679124081;5363.812266570651;826.4999675196419;858.4463021351194;888.391451855481;890.8307421589877;895.2345744388454;3323.7203676584204;3366.5118557808983;3427.845746941394;3442.535257740173;3514.6309637488207;9674.806503869882;9704.369216000938;10005.299629026043;10022.849657255147;10035.448050357301;9815.509224538744;9824.557894894748;9827.459489727991;9832.705018849447;9835.75410614726;7337.88993165103;7504.437167212481;7518.173000969889;7529.736459223901;7532.849343013109;4841.298011788342;5021.824236151863;5101.821436249714;5150.072986862401;5156.948430515647;9105.362624616213;9121.315901307562;9134;9281.535923203677;9340.065993400605;8942.016378198263;9466.810663786824;9472.715818525456;9488.288378371511;9494.192993595621;5763.452472015152;6286.27707813589;6467.708953097028;6491.837704057248;6602.801915942529;7796.805079873048;7800.336971357271;7821.256980586835;7825.647845846836;7861.921380786119;6492.513061520311;6701.731930722716;6910.44716422695;6960.3735663788475;7093.574385536885;6645.368689974444;6774.830629234309;6828.863422731617;6830.419414349836;6945.131858517685;6166.445019948226;6185.041318595625;6300.527460440394;6308.936910631019;6313.494920406265;4435.534268901848;4450.933236001398;4526.275795872644;4537.137943790669;4554.997900461893;4305.374790298471;4381.649468042613;4391.297392417198;4396.96671282242;4438.467383913951 08:25:43 INFO - PROCESS | 7213 | |4;prototype.html;295.37233379069477;300.24488411644717;302.531076830912;307.7799373447985;311.1474559706405;4603.286490593955;4803.447603525596;4813.205821039524;4833.299171620118;4853.344798452204;4590.472095708995;4728.3380326754195;4746.525347465252;4768.380110585619;4773.331733557305;3806.1626442182815;3806.257779732953;3816.866409675662;3820.9044773880596;3821.789801560913;3609.9278014439697;3680.613535578766;3807.6953843692577;3841.7118716096265;3857.8842634721004;3806.0675134591925;3812.6759225465867;3820.2932457495313;3821.254855303217;3838.5777564467885;3818.2554401891643;3818.427235914607;3830.367989281765;3833.9808300958593;3841.5966323535904;3374.696277335027;3383.1203886989315;3386.7976868211676;3387.7120444762227;3389.559357283562;4569.109023740372;4629.722216667011;4635.513271106553;4672.976635116803;4687.273472611751;4247.299195632717;4270.572942705736;4271.423357846682;4301.440812694361;4327.8485253016;4989.201727723583;5013.172826483626;5019.824306149304;5034.155702028343;5043.193089105725;3540.9822950885336;3658.9817050914576;3682.097886017916;3691.0956815580353;3704.4072948328408;5170.5346518813485;5196.45437229093;5205.401378841406;5215.322008138955;5221.190715439113;3751.849926002984;3753.6434038766274;3756.7370284079852;3777.8099898531873;3797.0697179191275;3552.5381700378784;3834.9616503834604;3842.692584593226;3845.1732877431486;3850.0759817643566;4192.413062171298;4251.341042138473;4257.957420425818;4264.616184543406;4268.893277668083;4976.154053810861;4989.675671081441;4993.550580447704;4998.2256299013325;5006.64953453262;1217.3061355027548;1244.4773195258012;1249.075683993838;1249.4564864284066;1251.205484517338;859.2996707683218;885.3271513649672;892.5492626223715;899.5412339706796;901.324006994754;4408.448943882015;4413.514513403523;4431;4444.8444304449185;4467.374567560544;5013.949860501421;5132.050570644368;5138.3833939927445;5144.842410457617;5150.665206761623;4389.31965545341;4404.361367601679;4408.118376324748;4408.118376324748;4415.315626077963;2678.9464210716064;2696.4067905060856;2701.689305729866;2706.3640044589506;2708.3093811078443;4614.423197100363;4829.830955916526;4833.758312084382;4841.03937905149;4843.176659967814;5194.376674798973;5205.9739701302005;5208.739563021833;5216.21756736485;5223.373195216523;4839.628581994797;4840.636952228597;4849.975750121297;4853.126437241331;4855.927161092657;4907.558319751097;5060.1663068681655;5086.872828179326;5129.615278854027;5225.477452254744;5070.416902056163;5097.286379906742;5097.286379906742;5100.719460429712;5108.974455127701;4903.41159060915;4920.286558449076;4929.654924155275;4931.3835770528685;4936.777844996912;3458.2564748579175;3665.963340366669;3699.8335074922234;3707.666310032002;3715.869944551928;5128.666636668605;5146.588272938231;5155.458676838878;5155.819546315861;5157.690538567698;4966.900661986668;4984.981082661528;4989.2808419410785;5007.073691367109;5023.6985780853265;4772.20825816901;4991.975040124777;5015;5020.698758074527;5055.620828437955;4701.905961880811;4785.928211076906;4924.458309586014;4929.950700492949;4934.851954441372;5014.52362025607;5046.914913293659;5071.290019397214;5071.898562028812;5081.415637201621;4774.641901857305;4897.559219670246;4917.868890155356;4923.187674033744;4966.6771659842 08:25:43 INFO - PROCESS | 7213 | |5;yui.html;566.0518631292585;685.4858855858106;725.0791494801599;743.5464366736292;748.2367984655651;11586.942065289672;11978.22141560799;12020.398980050995;12320.137590368679;12332.691682707937;11477.655670329883;11634.709132271697;12162.087843411757;12178.634640960785;12180.451879665414;625.9718312675941;762.6872982077349;775.4300589067032;779.5868189859384;780.254856611937;747.1818358896999;777.0403551613753;781.3397678961297;782.4327362662082;784.1766145547181;828.5028982610446;829.7842560934171;829.8215883585028;829.85062688716;830.2527725047476;642.8167972127968;788.7949133225345;823.5840900345318;824.0194168938943;824.2087595907935;594.5392320951254;597.0059850349163;597.2981746447949;597.5846786483396;598.0670154558902;11459.713507162387;11471.598494052669;11499.712507187303;11510.424478776027;11512.654620361318;12024.699382515508;12654.177478463871;12710.555130570478;12778.872211277861;12841.614751557374;11857.466414011304;11859.407029648482;12103.39483025854;12104.2448844917;12182.573609923611;4025.1144748155357;4072.6538244249273;4086.468759061303;4222.155568886235;4222.408862759216;68100;68275.65862170707;69382.65308673424;71896.28103719;72760;9672.95163524192;9787.559559819825;9938.304318697621;9958.900410995942;10147.34042287249;19518.219271229274;19537.218511259674;19550.31573894907;19568.510787230432;19571.021448927495;6577.408033277028;6695.296993815677;6747.696353664097;6800.183977922582;6944.270851560514;3420.298838738053;3478.91302717429;3520.119970007498;3530.2057037166946;3531.593866705362;2727.372704278027;2813;2825.0959692898077;2827.2649111231226;2831.320483084045;484.9490803465656;508.3518513894814;509.15480302697347;511.836212412032;514.1388174807183;487.2909916072107;492.42140484930064;496.19616221721043;512.0552580488992;516.4783568595745;7443.516171448839;7479.439042071866;7498.812529686801;7624.390048796083;7735.7679269622;481.8434008947106;535.1010302691516;542.2733537060279;544.8120398462524;563.2508763344741;3557.1996300832625;3570.285942811448;3681.5029970954115;3745.1386181177936;3785.337565925952;59917.70041149853;60188.69905650531;60300.69849650723;60411.39588604146;92929;88455.55772221097;90366.54816726006;91687.54156229309;92601.5369923146;93546;81410;81540.59229703814;81559.59220203743;82238.58880705558;83352;7022.12223472066;7123.394511466583;7161.991532767242;7193.496455248082;7236.529625574321;46653.53346466492;46703.766481167375;47397;47986.760066199444;48747.26879096746;38371.424428633036;38904.41643375295;39048.6095139045;52154.478455214965;66434.6678266625;8930.106989301017;8942.73171804847;9208.953955230181;9378.437293762396;9508.952455237679;10022.248331375322;10422.084515972547;10489;10647.148228141576;10800.945995269973;8590.82818343642;8728.08355122703;8805.867911981197;8823.205911467998;9361.344705870524;9572.712818615453;9579.85041794989;9734.853977190207;9769.804603908024;10034;8736.486183663388;8786.912130878609;8914.37599368064;8998.280137589109;9153.63385464574;8093.919060809317;8127.552984585905;8289.129641387808;8517.063123056583;8600.311975041857;7125.82185445368;7127.572345659277;7253.8186545336785;7414.518056326321;7624.161342252459 08:25:43 INFO - PROCESS | 7213 | __end_tp_report 08:25:43 INFO - PROCESS | 7213 | __start_cc_report 08:25:43 INFO - PROCESS | 7213 | _x_x_mozilla_cycle_collect,1049 08:25:43 INFO - PROCESS | 7213 | __end_cc_report 08:25:43 INFO - PROCESS | 7213 | __startTimestamp1467818743661__endTimestamp 08:25:43 INFO - PROCESS | 7213 | 08:25:43 INFO - PROCESS | 7213 | ------- Summary: start ------- 08:25:43 INFO - PROCESS | 7213 | Number of tests: 6 08:25:43 INFO - PROCESS | 7213 | 08:25:43 INFO - PROCESS | 7213 | [#0] dojo.html Cycles:165 Average:4666.00 Median:4792.59 stddev:497.43 (10.4%) stddev-sans-first:472.18 08:25:43 INFO - PROCESS | 7213 | Values: 2613.7 2624.4 2654.5 2666.1 2669.5 4590.2 4651.9 4712.8 4722.2 4780.4 4657.8 4697.0 4727.8 4730.6 4747.7 4306.9 4328.3 4342.6 4387.4 4493.0 4370.8 4426.8 4454.9 4486.4 4496.4 4246.8 4397.8 4426.4 4448.2 4457.7 4277.6 4281.4 4290.2 4295.4 4330.9 4251.5 4313.0 4331.6 4331.9 4384.7 4620.6 4740.2 4753.5 4772.5 4779.4 4989.7 5033.6 5061.9 5068.2 5121.0 5127.8 5130.6 5141.2 5150.3 5163.3 4563.6 4694.0 4718.7 4739.0 4750.5 5204.3 5229.7 5300.4 5310.8 5311.1 5004.7 5005.6 5048.6 5063.1 5069.3 4915.6 4987.2 5078.0 5148.9 5155.6 5045.2 5058.6 5064.0 5064.2 5087.6 5045.8 5047.5 5048.3 5048.9 5080.0 4086.9 4137.8 4149.2 4183.7 4278.9 3670.9 3684.9 3687.1 3719.8 3741.4 4345.5 4349.1 4353.5 4388.4 4393.1 4876.8 4934.7 4935.0 5004.8 5097.3 4334.2 4335.5 4337.1 4368.0 4388.3 4464.3 4465.8 4471.4 4477.7 4517.7 4680.5 4740.9 4792.6 4809.8 4815.6 5089.4 5097.3 5101.3 5106.7 5156.5 4820.7 4830.6 4833.5 4833.6 4881.7 4802.3 4914.1 4962.7 4972.5 5004.1 5031.7 5042.2 5064.8 5067.2 5108.1 4717.9 4880.7 4891.1 4892.9 4946.9 4831.0 4871.8 4882.4 4900.1 4910.4 4824.6 4826.9 4871.9 4874.2 4875.5 4804.4 4881.4 4919.1 4939.1 4942.1 4687.5 4708.8 4726.0 4773.1 4823.6 08:25:43 INFO - PROCESS | 7213 | 08:25:43 INFO - PROCESS | 7213 | [#1] ext.html Cycles:180 Average:47911.75 Median:207361.41 stddev:87080.28 (42.0%) stddev-sans-first:87251.96 08:25:43 INFO - PROCESS | 7213 | Values: 553.1 582.2 587.9 593.8 598.6 27576.9 30166.7 30180.4 39088.8 40368.8 40315.4 40662.6 40683.8 40686.6 40703.4 7867.9 8015.0 8016.8 8019.9 8022.2 7591.8 7675.7 7678.3 7678.7 7680.8 7690.2 7712.0 7727.7 7728.6 7730.5 7701.0 7717.5 7732.1 7737.2 7740.1 7674.1 7748.4 7946.9 7949.2 7953.2 37682.4 38167.8 38211.2 38241.0 38314.2 2973.7 3198.2 3368.3 3527.7 3679.8 29500.6 29699.9 29956.6 30073.7 30367.7 3297.5 3302.9 3331.2 3347.0 3402.4 239165.0 239740.0 239788.0 240225.0 240450.0 51865.7 52047.5 52214.7 52271.7 52326.0 33293.0 34178.0 34219.3 35764.8 35775.6 14958.9 14980.2 14992.1 15087.4 15159.7 11416.8 11469.8 11500.7 11502.4 11509.8 18347.6 18447.2 18524.0 18552.0 18553.0 6754.3 6900.9 7030.2 7038.1 7101.3 774.6 831.2 884.6 907.4 920.8 28398.4 28646.0 28675.4 28921.2 29236.6 807.4 988.4 1018.0 1022.4 1054.9 14487.3 14911.5 15064.8 15085.3 15085.8 377040.0 383854.0 384052.0 386257.0 386952.0 48105.5 48636.5 48674.8 48719.0 48720.8 1064.6 1124.4 1137.6 1141.7 1172.6 27522.7 29582.6 29722.6 29914.7 30721.2 42638.0 42841.1 43362.3 43378.6 43415.8 333167.0 337676.0 337792.0 338756.0 404816.0 39284.4 40123.6 40235.4 41523.8 42316.6 42623.4 42909.8 43613.6 43724.6 44117.8 36630.3 37353.3 37569.6 38034.6 38120.8 37553.4 37682.8 38229.6 38477.6 38713.0 36017.6 36616.3 36755.8 36916.0 36996.1 31809.4 33542.0 33898.0 34138.5 34479.3 25539.0 25903.5 25987.9 26017.5 26099.7 08:25:43 INFO - PROCESS | 7213 | 08:25:43 INFO - PROCESS | 7213 | [#2] jquery.html Cycles:180 Average:24215.76 Median:4252.54 stddev:62640.08 (1473.0%) stddev-sans-first:62790.17 08:25:43 INFO - PROCESS | 7213 | Values: 351.5 374.6 380.2 382.6 394.0 13204.8 16563.5 17004.2 18211.9 19151.6 17986.2 18068.5 18163.0 18335.4 18391.5 4563.9 4858.3 4858.4 4914.2 4918.4 3614.7 4807.6 5463.1 5779.2 5810.0 5752.0 5766.9 5793.1 5797.0 5801.0 5795.4 6350.0 6352.2 6354.0 6356.6 3447.0 5043.9 5291.4 5298.0 5618.4 12475.4 12651.2 12712.2 14568.4 21174.2 1938.5 1949.6 1958.6 2076.9 2082.7 9113.5 9304.3 9328.4 9710.7 9804.7 1754.7 1821.7 1831.4 1846.8 1877.2 68450.0 70598.0 71125.6 71532.3 71812.0 8970.9 9481.6 10220.3 10221.5 10371.4 12883.7 13603.4 13626.3 14022.9 14095.9 7417.5 7597.8 7645.5 7720.2 7728.6 7172.3 7229.8 7320.6 7367.3 7396.7 3975.3 4186.7 4318.4 4322.4 4330.2 1773.9 1841.5 1867.6 1876.4 1879.3 843.3 856.1 918.8 925.2 947.7 16954.3 17672.6 18157.7 18352.6 18519.0 865.2 871.4 888.8 898.8 965.3 9722.8 9914.9 9939.9 9989.3 10051.5 373062.0 373640.0 377464.0 380430.0 384459.0 81154.0 81641.0 82671.0 82860.6 83388.0 880.2 889.9 895.4 910.9 937.9 15436.5 15720.1 15746.8 15945.9 16187.2 37392.6 37892.2 38167.4 38229.0 38361.6 50190.0 51182.0 51454.0 53186.0 53291.5 6830.2 7768.3 7810.6 7970.6 8012.4 10237.7 12792.0 12860.6 12900.1 13025.5 10968.7 11041.4 11151.4 11231.3 11326.3 6191.8 10362.3 10961.6 11029.6 11049.7 11046.8 11175.6 11224.9 11241.9 11420.5 6866.5 7187.9 7337.9 7368.6 7579.1 7894.2 10736.6 10878.8 10922.1 11178.4 08:25:43 INFO - PROCESS | 7213 | 08:25:43 INFO - PROCESS | 7213 | [#3] mootools.html Cycles:180 Average:5184.50 Median:5011.55 stddev:2952.50 (58.9%) stddev-sans-first:2947.09 08:25:43 INFO - PROCESS | 7213 | Values: 1400.1 1450.5 1537.3 1734.9 1765.8 6889.2 7142.5 7514.8 7993.1 7996.6 7579.6 7903.3 7906.1 7960.3 8070.9 2234.9 2259.4 2264.6 2265.0 2265.1 1901.9 2125.6 2212.1 2214.7 2233.5 2239.0 2259.7 2261.1 2263.9 2263.9 2149.2 2180.0 2180.1 2181.5 2181.9 2173.6 2189.8 2194.8 2216.6 2220.4 8130.0 8134.4 8137.1 8138.9 8147.1 4613.6 4624.3 4767.9 4770.1 4787.1 2784.3 2854.4 2855.0 2936.9 2948.7 900.1 908.1 917.9 937.9 943.0 10753.6 10793.5 10821.8 10837.0 10848.6 4185.7 4287.5 4334.8 4411.1 4436.6 9221.4 9238.6 9252.1 9272.6 9278.0 4738.5 4748.9 4751.0 4755.0 4759.2 4218.9 4315.1 4319.8 4325.2 4335.0 3516.9 3549.1 3551.0 3585.9 3603.1 1058.3 1059.3 1060.2 1068.0 1069.9 784.0 789.8 791.7 807.6 809.0 4902.3 5001.3 5059.9 5177.6 5363.8 826.5 858.4 888.4 890.8 895.2 3323.7 3366.5 3427.8 3442.5 3514.6 9674.8 9704.4 10005.3 10022.8 10035.4 9815.5 9824.6 9827.5 9832.7 9835.8 7337.9 7504.4 7518.2 7529.7 7532.8 4841.3 5021.8 5101.8 5150.1 5156.9 9105.4 9121.3 9134.0 9281.5 9340.1 8942.0 9466.8 9472.7 9488.3 9494.2 5763.5 6286.3 6467.7 6491.8 6602.8 7796.8 7800.3 7821.3 7825.6 7861.9 6492.5 6701.7 6910.4 6960.4 7093.6 6645.4 6774.8 6828.9 6830.4 6945.1 6166.4 6185.0 6300.5 6308.9 6313.5 4435.5 4450.9 4526.3 4537.1 4555.0 4305.4 4381.6 4391.3 4397.0 4438.5 08:25:43 INFO - PROCESS | 7213 | 08:25:43 INFO - PROCESS | 7213 | [#4] prototype.html Cycles:180 Average:4175.31 Median:4757.45 stddev:1195.97 (25.1%) stddev-sans-first:1163.33 08:25:43 INFO - PROCESS | 7213 | Values: 295.4 300.2 302.5 307.8 311.1 4603.3 4803.4 4813.2 4833.3 4853.3 4590.5 4728.3 4746.5 4768.4 4773.3 3806.2 3806.3 3816.9 3820.9 3821.8 3609.9 3680.6 3807.7 3841.7 3857.9 3806.1 3812.7 3820.3 3821.3 3838.6 3818.3 3818.4 3830.4 3834.0 3841.6 3374.7 3383.1 3386.8 3387.7 3389.6 4569.1 4629.7 4635.5 4673.0 4687.3 4247.3 4270.6 4271.4 4301.4 4327.8 4989.2 5013.2 5019.8 5034.2 5043.2 3541.0 3659.0 3682.1 3691.1 3704.4 5170.5 5196.5 5205.4 5215.3 5221.2 3751.8 3753.6 3756.7 3777.8 3797.1 3552.5 3835.0 3842.7 3845.2 3850.1 4192.4 4251.3 4258.0 4264.6 4268.9 4976.2 4989.7 4993.6 4998.2 5006.6 1217.3 1244.5 1249.1 1249.5 1251.2 859.3 885.3 892.5 899.5 901.3 4408.4 4413.5 4431.0 4444.8 4467.4 5013.9 5132.1 5138.4 5144.8 5150.7 4389.3 4404.4 4408.1 4408.1 4415.3 2678.9 2696.4 2701.7 2706.4 2708.3 4614.4 4829.8 4833.8 4841.0 4843.2 5194.4 5206.0 5208.7 5216.2 5223.4 4839.6 4840.6 4850.0 4853.1 4855.9 4907.6 5060.2 5086.9 5129.6 5225.5 5070.4 5097.3 5097.3 5100.7 5109.0 4903.4 4920.3 4929.7 4931.4 4936.8 3458.3 3666.0 3699.8 3707.7 3715.9 5128.7 5146.6 5155.5 5155.8 5157.7 4966.9 4985.0 4989.3 5007.1 5023.7 4772.2 4992.0 5015.0 5020.7 5055.6 4701.9 4785.9 4924.5 4930.0 4934.9 5014.5 5046.9 5071.3 5071.9 5081.4 4774.6 4897.6 4917.9 4923.2 4966.7 08:25:43 INFO - PROCESS | 7213 | 08:25:43 INFO - PROCESS | 7213 | [#5] yui.html Cycles:180 Average:16626.05 Median:30518.68 stddev:24352.36 (79.8%) stddev-sans-first:24390.82 08:25:43 INFO - PROCESS | 7213 | Values: 566.1 685.5 725.1 743.5 748.2 11586.9 11978.2 12020.4 12320.1 12332.7 11477.7 11634.7 12162.1 12178.6 12180.5 626.0 762.7 775.4 779.6 780.3 747.2 777.0 781.3 782.4 784.2 828.5 829.8 829.8 829.9 830.3 642.8 788.8 823.6 824.0 824.2 594.5 597.0 597.3 597.6 598.1 11459.7 11471.6 11499.7 11510.4 11512.7 12024.7 12654.2 12710.6 12778.9 12841.6 11857.5 11859.4 12103.4 12104.2 12182.6 4025.1 4072.7 4086.5 4222.2 4222.4 68100.0 68275.7 69382.7 71896.3 72760.0 9673.0 9787.6 9938.3 9958.9 10147.3 19518.2 19537.2 19550.3 19568.5 19571.0 6577.4 6695.3 6747.7 6800.2 6944.3 3420.3 3478.9 3520.1 3530.2 3531.6 2727.4 2813.0 2825.1 2827.3 2831.3 484.9 508.4 509.2 511.8 514.1 487.3 492.4 496.2 512.1 516.5 7443.5 7479.4 7498.8 7624.4 7735.8 481.8 535.1 542.3 544.8 563.3 3557.2 3570.3 3681.5 3745.1 3785.3 59917.7 60188.7 60300.7 60411.4 92929.0 88455.6 90366.5 91687.5 92601.5 93546.0 81410.0 81540.6 81559.6 82238.6 83352.0 7022.1 7123.4 7162.0 7193.5 7236.5 46653.5 46703.8 47397.0 47986.8 48747.3 38371.4 38904.4 39048.6 52154.5 66434.7 8930.1 8942.7 9209.0 9378.4 9509.0 10022.2 10422.1 10489.0 10647.1 10800.9 8590.8 8728.1 8805.9 8823.2 9361.3 9572.7 9579.9 9734.9 9769.8 10034.0 8736.5 8786.9 8914.4 8998.3 9153.6 8093.9 8127.6 8289.1 8517.1 8600.3 7125.8 7127.6 7253.8 7414.5 7624.2 08:25:43 INFO - PROCESS | 7213 | -------- Summary: end -------- 08:25:43 INFO - PROCESS | 7213 | 08:25:44 INFO - TEST-INFO | 7213: exit 0 08:25:44 INFO - TEST-OK | dromaeo_css | took 1120136ms 08:25:44 INFO - TEST-START | kraken 08:25:44 INFO - operating with platform_type : linux_ 08:25:44 INFO - Initialising browser for kraken test... 08:25:44 INFO - TEST-INFO | started process 7405 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwQHxtw/profile http://localhost:38824/getInfo.html) 08:25:48 INFO - PROCESS | 7405 | __metrics Screen width/height:1600/1200 08:25:48 INFO - PROCESS | 7405 | colorDepth:24 08:25:48 INFO - PROCESS | 7405 | Browser inner width/height: 1024/697 08:25:48 INFO - PROCESS | 7405 | __metrics 08:25:49 INFO - PROCESS | 7405 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:25:50 INFO - TEST-INFO | 7405: exit 0 08:25:50 INFO - Browser initialized. 08:25:50 INFO - Running cycle 1/1 for kraken test... 08:25:50 INFO - TEST-INFO | started process 7488 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwQHxtw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:26:02 INFO - PROCESS | 7488 | RSS: Main: 158732288 08:26:02 INFO - PROCESS | 7488 | 08:26:05 INFO - PROCESS | 7488 | Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38824/tests/kraken/driver.html?testName=audio-beat-detection) 08:26:06 INFO - PROCESS | 7488 | RSS: Main: 216801280 08:26:06 INFO - PROCESS | 7488 | 08:26:08 INFO - PROCESS | 7488 | Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38824/tests/kraken/driver.html?testName=audio-dft) 08:26:09 INFO - PROCESS | 7488 | RSS: Main: 204423168 08:26:09 INFO - PROCESS | 7488 | 08:26:12 INFO - PROCESS | 7488 | Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38824/tests/kraken/driver.html?testName=audio-fft) 08:26:13 INFO - PROCESS | 7488 | RSS: Main: 271060992 08:26:13 INFO - PROCESS | 7488 | 08:26:15 INFO - PROCESS | 7488 | Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38824/tests/kraken/driver.html?testName=audio-oscillator) 08:26:16 INFO - PROCESS | 7488 | RSS: Main: 182046720 08:26:16 INFO - PROCESS | 7488 | 08:26:18 INFO - PROCESS | 7488 | Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38824/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:26:18 INFO - PROCESS | 7488 | RSS: Main: 185655296 08:26:18 INFO - PROCESS | 7488 | 08:26:22 INFO - PROCESS | 7488 | Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38824/tests/kraken/driver.html?testName=imaging-darkroom) 08:26:22 INFO - PROCESS | 7488 | RSS: Main: 222511104 08:26:22 INFO - PROCESS | 7488 | 08:26:26 INFO - PROCESS | 7488 | Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38824/tests/kraken/driver.html?testName=imaging-desaturate) 08:26:26 INFO - PROCESS | 7488 | RSS: Main: 222887936 08:26:26 INFO - PROCESS | 7488 | 08:26:29 INFO - PROCESS | 7488 | Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38824/tests/kraken/driver.html?testName=json-parse-financial) 08:26:30 INFO - PROCESS | 7488 | RSS: Main: 222838784 08:26:30 INFO - PROCESS | 7488 | 08:26:31 INFO - PROCESS | 7488 | Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38824/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:26:32 INFO - PROCESS | 7488 | RSS: Main: 211701760 08:26:32 INFO - PROCESS | 7488 | 08:26:34 INFO - PROCESS | 7488 | Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38824/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:26:35 INFO - PROCESS | 7488 | RSS: Main: 214745088 08:26:35 INFO - PROCESS | 7488 | 08:26:37 INFO - PROCESS | 7488 | Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38824/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:26:37 INFO - PROCESS | 7488 | RSS: Main: 211812352 08:26:37 INFO - PROCESS | 7488 | 08:26:40 INFO - PROCESS | 7488 | Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38824/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:26:41 INFO - PROCESS | 7488 | RSS: Main: 224403456 08:26:41 INFO - PROCESS | 7488 | 08:26:44 INFO - PROCESS | 7488 | Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38824/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:26:44 INFO - PROCESS | 7488 | RSS: Main: 224948224 08:26:44 INFO - PROCESS | 7488 | 08:26:46 INFO - PROCESS | 7488 | Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38824/tests/kraken/driver.html?testName=ai-astar) 08:26:46 INFO - PROCESS | 7488 | RSS: Main: 267972608 08:26:46 INFO - PROCESS | 7488 | 08:26:46 INFO - PROCESS | 7488 | __start_tp_report 08:26:46 INFO - PROCESS | 7488 | _x_x_mozilla_page_load 08:26:46 INFO - PROCESS | 7488 | _x_x_mozilla_page_load_details 08:26:46 INFO - PROCESS | 7488 | |i|pagename|runs| 08:26:46 INFO - PROCESS | 7488 | |0;ai-astar;104;113;113;114;111;114;111;112;112;113 08:26:46 INFO - PROCESS | 7488 | |1;audio-beat-detection;152;130;125;192;124;130;155;122;164;123 08:26:46 INFO - PROCESS | 7488 | |2;audio-dft;163;161;160;161;163;161;161;161;162;161 08:26:46 INFO - PROCESS | 7488 | |3;audio-fft;76;76;78;114;76;77;75;75;97;75 08:26:46 INFO - PROCESS | 7488 | |4;audio-oscillator;87;85;124;85;86;86;112;84;85;131 08:26:46 INFO - PROCESS | 7488 | |5;imaging-gaussian-blur;117;116;117;117;117;117;116;117;117;116 08:26:46 INFO - PROCESS | 7488 | |6;imaging-darkroom;146;147;146;146;147;147;147;147;147;147 08:26:46 INFO - PROCESS | 7488 | |7;imaging-desaturate;95;95;95;95;96;95;95;95;95;96 08:26:46 INFO - PROCESS | 7488 | |8;json-parse-financial;63;62;66;69;64;63;63;67;62;62 08:26:46 INFO - PROCESS | 7488 | |9;json-stringify-tinderbox;65;64;64;64;63;64;64;64;66;64 08:26:46 INFO - PROCESS | 7488 | |10;stanford-crypto-aes;79;86;79;80;79;80;79;78;79;82 08:26:46 INFO - PROCESS | 7488 | |11;stanford-crypto-ccm;137;129;130;127;129;132;133;137;176;130 08:26:46 INFO - PROCESS | 7488 | |12;stanford-crypto-pbkdf2;167;173;164;163;163;165;165;165;163;164 08:26:46 INFO - PROCESS | 7488 | |13;stanford-crypto-sha256-iterative;68;69;69;68;67;67;67;67;67;65 08:26:46 INFO - PROCESS | 7488 | __end_tp_report 08:26:46 INFO - PROCESS | 7488 | __start_cc_report 08:26:46 INFO - PROCESS | 7488 | _x_x_mozilla_cycle_collect,1918 08:26:46 INFO - PROCESS | 7488 | __end_cc_report 08:26:46 INFO - PROCESS | 7488 | __startTimestamp1467818806700__endTimestamp 08:26:46 INFO - PROCESS | 7488 | 08:26:46 INFO - PROCESS | 7488 | ------- Summary: start ------- 08:26:46 INFO - PROCESS | 7488 | Number of tests: 14 08:26:46 INFO - PROCESS | 7488 | 08:26:46 INFO - PROCESS | 7488 | [#0] ai-astar Cycles:10 Average:111.70 Median:113.00 stddev:2.91 (2.6%) stddev-sans-first:1.13 08:26:46 INFO - PROCESS | 7488 | Values: 104.0 113.0 113.0 114.0 111.0 114.0 111.0 112.0 112.0 113.0 08:26:46 INFO - PROCESS | 7488 | 08:26:46 INFO - PROCESS | 7488 | [#1] audio-beat-detection Cycles:10 Average:141.70 Median:141.00 stddev:23.37 (16.6%) stddev-sans-first:24.49 08:26:46 INFO - PROCESS | 7488 | Values: 152.0 130.0 125.0 192.0 124.0 130.0 155.0 122.0 164.0 123.0 08:26:46 INFO - PROCESS | 7488 | 08:26:46 INFO - PROCESS | 7488 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:0.83 08:26:46 INFO - PROCESS | 7488 | Values: 163.0 161.0 160.0 161.0 163.0 161.0 161.0 161.0 162.0 161.0 08:26:46 INFO - PROCESS | 7488 | 08:26:46 INFO - PROCESS | 7488 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.00 stddev:13.10 (17.2%) stddev-sans-first:13.72 08:26:46 INFO - PROCESS | 7488 | Values: 76.0 76.0 78.0 114.0 76.0 77.0 75.0 75.0 97.0 75.0 08:26:46 INFO - PROCESS | 7488 | 08:26:46 INFO - PROCESS | 7488 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:85.00 stddev:18.41 (21.7%) stddev-sans-first:19.20 08:26:46 INFO - PROCESS | 7488 | Values: 87.0 85.0 124.0 85.0 86.0 86.0 112.0 84.0 85.0 131.0 08:26:46 INFO - PROCESS | 7488 | 08:26:46 INFO - PROCESS | 7488 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 08:26:46 INFO - PROCESS | 7488 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 08:26:46 INFO - PROCESS | 7488 | 08:26:46 INFO - PROCESS | 7488 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 08:26:46 INFO - PROCESS | 7488 | Values: 146.0 147.0 146.0 146.0 147.0 147.0 147.0 147.0 147.0 147.0 08:26:46 INFO - PROCESS | 7488 | 08:26:46 INFO - PROCESS | 7488 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:26:46 INFO - PROCESS | 7488 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 08:26:46 INFO - PROCESS | 7488 | 08:26:46 INFO - PROCESS | 7488 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:63.50 stddev:2.42 (3.8%) stddev-sans-first:2.54 08:26:46 INFO - PROCESS | 7488 | Values: 63.0 62.0 66.0 69.0 64.0 63.0 63.0 67.0 62.0 62.0 08:26:46 INFO - PROCESS | 7488 | 08:26:46 INFO - PROCESS | 7488 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 08:26:46 INFO - PROCESS | 7488 | Values: 65.0 64.0 64.0 64.0 63.0 64.0 64.0 64.0 66.0 64.0 08:26:46 INFO - PROCESS | 7488 | 08:26:46 INFO - PROCESS | 7488 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:79.50 stddev:2.33 (2.9%) stddev-sans-first:2.44 08:26:46 INFO - PROCESS | 7488 | Values: 79.0 86.0 79.0 80.0 79.0 80.0 79.0 78.0 79.0 82.0 08:26:46 INFO - PROCESS | 7488 | 08:26:46 INFO - PROCESS | 7488 | [#11] stanford-crypto-ccm Cycles:10 Average:136.00 Median:132.50 stddev:14.45 (10.9%) stddev-sans-first:15.32 08:26:46 INFO - PROCESS | 7488 | Values: 137.0 129.0 130.0 127.0 129.0 132.0 133.0 137.0 176.0 130.0 08:26:46 INFO - PROCESS | 7488 | 08:26:46 INFO - PROCESS | 7488 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.20 Median:165.00 stddev:3.01 (1.8%) stddev-sans-first:3.12 08:26:46 INFO - PROCESS | 7488 | Values: 167.0 173.0 164.0 163.0 163.0 165.0 165.0 165.0 163.0 164.0 08:26:46 INFO - PROCESS | 7488 | 08:26:46 INFO - PROCESS | 7488 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.50 stddev:1.17 (1.7%) stddev-sans-first:1.22 08:26:46 INFO - PROCESS | 7488 | Values: 68.0 69.0 69.0 68.0 67.0 67.0 67.0 67.0 67.0 65.0 08:26:46 INFO - PROCESS | 7488 | -------- Summary: end -------- 08:26:46 INFO - PROCESS | 7488 | 08:26:47 INFO - TEST-INFO | 7488: exit 0 08:26:47 INFO - TEST-OK | kraken | took 63407ms 08:26:47 INFO - SUITE-END | took 1183s 08:26:47 INFO - Completed test suite (00:19:43) 08:26:47 INFO - javascript benchmark 08:26:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2613.6732908386452, 2624.40950786073, 2654.5221860065185, 2666.053550989399, 2669.5461771498844, 4590.219662657348, 4651.88370290742, 4712.811487540499, 4722.1972264715, 4780.354652121962, 4657.813687452506, 4697.0, 4727.763611819412, 4730.621550275978, 4747.691400058994, 4306.892327691801, 4328.285832837578, 4342.609165175134, 4387.3857659927635, 4493.033997690496, 4370.847020354288, 4426.77866106695, 4454.910901781978, 4486.439195100613, 4496.392986946753, 4246.7876606169875, 4397.802098905557, 4426.358178064179, 4448.221561226773, 4457.732536047832, 4277.572242775728, 4281.400603915455, 4290.184864875695, 4295.377170310318, 4330.935035974463, 4251.511076226243, 4312.978435107836, 4331.631811296043, 4331.913361732748, 4384.693071484998, 4620.630349572026, 4740.217864052427, 4753.453352864431, 4772.451168115676, 4779.378680771512, 4989.675671081368, 5033.597312215014, 5061.949380506185, 5068.163752980754, 5121.0, 5127.846164615067, 5130.615203859688, 5141.177411614124, 5150.330457040561, 5163.251328557376, 4563.566461186182, 4693.9765301173275, 4718.669693121448, 4739.028499157665, 4750.548697873696, 5204.271402003723, 5229.686218826882, 5300.44345343741, 5310.787568497294, 5311.070562651597, 5004.674696144812, 5005.5745261653165, 5048.62135339851, 5063.063333283354, 5069.315642388304, 4915.557599816034, 4987.1771157759285, 5077.974610126926, 5148.922766158511, 5155.6391052626705, 5045.167547354646, 5058.595312375001, 5064.0, 5064.164412871834, 5087.618428617869, 5045.84862454127, 5047.520485553867, 5048.3184770056305, 5048.899022019539, 5080.0, 4086.8569600063856, 4137.81379837908, 4149.232392007489, 4183.707140500136, 4278.871633850989, 3670.908227294339, 3684.8526058957877, 3687.078230442389, 3719.795411252353, 3741.363968125371, 4345.543717909637, 4349.13017396522, 4353.477582690034, 4388.429504164502, 4393.143337049309, 4876.780544875489, 4934.703917764946, 4934.9753251233515, 5004.824831130893, 5097.260897169889, 4334.1548398062705, 4335.544767799399, 4337.067530480898, 4367.956320436819, 4388.27593447084, 4464.330350447459, 4465.754383508938, 4471.433611783319, 4477.686561940698, 4517.661175411858, 4680.5085466025575, 4740.881477963078, 4792.592629626521, 4809.759512024315, 4815.566599005966, 5089.414717307557, 5097.311862898461, 5101.336826212717, 5106.69359838396, 5156.484351564814, 4820.71075735457, 4830.565249127455, 4833.540813622701, 4833.637477189295, 4881.682690625098, 4802.27965805132, 4914.115459217375, 4962.652614316963, 4972.453030166606, 5004.149294619996, 5031.723255220998, 5042.193249080129, 5064.82273120439, 5067.189249720027, 5108.055009823194, 4717.882052948704, 4880.6583539153335, 4891.144049791201, 4892.877678058077, 4946.851594452172, 4830.951690483191, 4871.8294859679745, 4882.389701287339, 4900.093482705711, 4910.361652985232, 4824.589909857701, 4826.8793280168275, 4871.926921096116, 4874.171390863491, 4875.463698993179, 4804.375431193923, 4881.365422495053, 4919.0899683558655, 4939.061578300255, 4942.061008408391, 4687.531246875285, 4708.811647534198, 4725.952740472551, 4773.09311230865, 4823.589994850477], "value": 4633.973309603359, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.0625589625585, 582.1645938078858, 587.9323877754057, 593.8218534439669, 598.5780025082317, 27576.86211568942, 30166.69833301669, 30180.396392072173, 39088.80455597725, 40368.79815600918, 40315.395269070985, 40662.593374066324, 40683.79658101713, 40686.59313406865, 40703.38944915828, 7867.881981770263, 8015.0, 8016.799580010517, 8019.919800801976, 8022.19778022199, 7591.848163036736, 7675.695131827602, 7678.308952194301, 7678.69285228593, 7680.807979800522, 7690.192529784376, 7712.035995500562, 7727.6522556484815, 7728.613569321539, 7730.458867879251, 7701.0, 7717.536947783151, 7732.149463559004, 7737.226277372274, 7740.109887362969, 7674.117476490219, 7748.380129589619, 7946.920530794676, 7949.205079492062, 7953.164917683618, 37682.434763478566, 38167.8091609543, 38211.23577528434, 38241.043973900596, 38314.23371532582, 2973.732364087221, 3198.2484116232667, 3368.309496553201, 3527.735419843522, 3679.816009199556, 29500.557491637643, 29699.851500742574, 29956.550651740243, 30073.699263007307, 30367.696323036707, 3297.4888892221743, 3302.9174270643184, 3331.1505566080496, 3346.966530334714, 3402.42158832999, 239165.0, 239740.0, 239788.0, 240225.0, 240450.0, 51865.7406712964, 52047.47952520502, 52214.73892630589, 52271.73864130655, 52326.0, 33293.0, 34178.0, 34219.315613688086, 35764.821175894474, 35775.64224357775, 14958.925205373904, 14980.176090314919, 14992.100473971597, 15087.396504139711, 15159.696806063817, 11416.828747568794, 11469.827952580717, 11500.712482188012, 11502.424878756028, 11509.827352589718, 18347.63304733898, 18447.16987735555, 18524.0, 18552.0, 18553.0, 6754.3245675433045, 6900.896486552706, 7030.156381234285, 7038.120234970629, 7101.254368291255, 774.6436639145943, 831.2477208126655, 884.5842454046588, 907.4011152639226, 920.7513971227731, 28398.432031359258, 28646.0, 28675.422851743355, 28921.23099651642, 29236.561451578244, 807.3500831830315, 988.3526290279879, 1018.0398250804377, 1022.3661329975463, 1054.920880933933, 14487.275636218146, 14911.478098266509, 15064.774028389584, 15085.314768417074, 15085.773713394308, 377040.0, 383854.0, 384052.0, 386257.0, 386952.0, 48105.5189448101, 48636.513634863906, 48674.756626216644, 48718.999999999294, 48720.756396217796, 1064.5635289531256, 1124.3759713359163, 1137.5961533655434, 1141.714571357144, 1172.6306213542707, 27522.724772752015, 29582.556261655664, 29722.55416168716, 29914.70085299206, 30721.231969200056, 42638.0, 42841.1431771369, 43362.349564755925, 43378.56621433745, 43415.78292108519, 333167.0, 337676.0, 337792.0, 338756.0, 404816.0, 39284.41073383844, 40123.59876401316, 40235.39646905357, 41523.7923810379, 42316.576834231266, 42623.360649590904, 42909.785451072545, 43613.56386436095, 43724.56275437205, 44117.77941110274, 36630.267394651426, 37353.252934941695, 37569.62430375661, 38034.61965380421, 38120.80939595284, 37553.436698449, 37682.8115859419, 38229.61770382261, 38477.6152238474, 38713.0, 36017.639823602476, 36616.26767464689, 36755.81622091872, 36916.0, 36996.07509812276, 31809.363812724077, 33542.0, 33898.0, 34138.48792268168, 34479.31041379208, 25539.0, 25903.48193036091, 25987.870060649577, 26017.479650407266, 26099.73900261049], "value": 17653.135571431532, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.47103609068347, 374.59730789401397, 380.2300341807837, 382.64031810098504, 393.9606039396059, 13204.801927971075, 16563.50309490716, 17004.234809433558, 18211.90894045528, 19151.616967660637, 17986.190621422036, 18068.548286292815, 18163.0, 18335.449936501893, 18391.540211494685, 4563.863084107474, 4858.295547145662, 4858.368412106422, 4914.189158788796, 4918.409790825088, 3614.6566076222716, 4807.61539076873, 5463.125899856024, 5779.162021506879, 5810.0, 5751.971240143794, 5766.884662306751, 5793.102069179284, 5797.0, 5800.9709951450395, 5795.362510123883, 6349.968250158766, 6352.1742173517605, 6354.0, 6356.586821856587, 3446.9655303446893, 5043.949560504385, 5291.3650361956425, 5297.973510132463, 5618.381977982419, 12475.376231188404, 12651.177673451197, 12712.237265764084, 14568.417263309455, 21174.153033878625, 1938.4572319750494, 1949.6100779844087, 1958.5593241520544, 2076.9407602123024, 2082.6875968604677, 9113.544322783835, 9304.348695591312, 9328.39365441244, 9710.708678739578, 9804.65683701067, 1754.7104727719911, 1821.6720990221754, 1831.395639438982, 1846.759921210234, 1877.1646617255326, 68450.0, 70598.0, 71125.64437177782, 71532.28467715309, 71812.0, 8970.86543701845, 9481.620735170654, 10220.335678180894, 10221.488925553693, 10371.429571373646, 12883.742325153444, 13603.387847546686, 13626.318684065756, 14022.929885350508, 14095.94280428972, 7417.517861339104, 7597.810054748676, 7645.541267523967, 7720.227977202235, 7728.613569321511, 7172.282771722786, 7229.783106506813, 7320.560766354036, 7367.300106489874, 7396.667149978264, 3975.3043217436834, 4186.727862688916, 4318.352247162888, 4322.394864718942, 4330.155619654201, 1773.8846974946587, 1841.539615096226, 1867.5797945462434, 1876.3807943378652, 1879.257693211174, 843.325339728215, 856.118198255785, 918.807050519385, 925.1904583489446, 947.7346343023964, 16954.321827126776, 17672.646547068987, 18157.7276340855, 18352.63294734098, 18519.0, 865.1564724393666, 871.3987348729356, 888.7778055486128, 898.793277546155, 965.3339195954909, 9722.75693107678, 9914.851277230848, 9939.900600994042, 9989.30074894765, 10051.497425128715, 373062.0, 373640.0, 377464.0, 380430.0, 384459.0, 81154.0, 81641.0, 82671.0, 82860.58569707234, 83388.0, 880.1805904833659, 889.8932128144664, 895.3866601377947, 910.940788848736, 937.8593211018265, 15436.45972390961, 15720.056796592242, 15746.76379854326, 15945.920270398574, 16187.190640468165, 37392.62607373892, 37892.24215515729, 38167.427488587135, 38229.0, 38361.616383835804, 50190.0, 51182.0, 51454.0, 53186.0, 53291.46708532865, 6830.180378354629, 7768.262015108556, 7810.57041862703, 7970.601469926364, 8012.439129261129, 10237.692869213935, 12792.04059695508, 12860.614181574567, 12900.09699321076, 13025.544105956245, 10968.725781855517, 11041.39272340029, 11151.386673732699, 11231.26996745209, 11326.263792853439, 6191.81424557264, 10362.274640775073, 10961.56153753841, 11029.61396351124, 11049.668509944715, 11046.779064418828, 11175.608853690082, 11224.887751122384, 11241.943790280997, 11420.486078126338, 6866.485013623898, 7187.8562428752175, 7337.853242935218, 7368.557886526825, 7579.0905091387185, 7894.171112033384, 10736.570537178426, 10878.836817447585, 10922.126229901747, 11178.441077946232], "value": 8292.725813452862, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1400.096937475328, 1450.4850777973818, 1537.3235776258452, 1734.8698847586434, 1765.8057613662495, 6889.242183359826, 7142.464315176369, 7514.774556763299, 7993.080795708495, 7996.560189189599, 7579.621018949044, 7903.328217101539, 7906.090799558038, 7960.323372513343, 8070.91929080709, 2234.8770817605064, 2259.3560835161984, 2264.5810525052916, 2264.977350226493, 2265.0939624150387, 1901.9334323298688, 2125.5855108253895, 2212.1040978403694, 2214.678871563622, 2233.486298151426, 2238.977610223901, 2259.6949411829355, 2261.1407665087245, 2263.875486848223, 2263.909443622253, 2149.2047942261383, 2179.9863063675466, 2180.149741600777, 2181.476445653048, 2181.901814418355, 2173.576152650234, 2189.770074142224, 2194.7585765565773, 2216.5788500184913, 2220.367195349334, 8130.0, 8134.430589858713, 8137.145599712004, 8138.877916831252, 8147.063087744867, 4613.5847773700525, 4624.260118381077, 4767.904641907177, 4770.117528257283, 4787.0904528139545, 2784.303924018995, 2854.4005758790677, 2854.9714502854913, 2936.8531573421456, 2948.7346138847606, 900.0954041188629, 908.0964440381862, 917.857732051533, 937.8640097185938, 942.9622815087388, 10753.623623173151, 10793.460326983697, 10821.783564328669, 10837.0, 10848.620298289521, 4185.707000509996, 4287.549807270254, 4334.804933777988, 4411.139827733626, 4436.578525040116, 9221.354505184572, 9238.58426370815, 9252.074792520829, 9272.582733776997, 9277.953610231905, 4738.455077666113, 4748.905021899543, 4751.0, 4754.976225118921, 4759.16714574948, 4218.894527636772, 4315.11540134278, 4319.805608747551, 4325.178216138924, 4334.956650433455, 3516.876909308162, 3549.0772399175885, 3550.9644903551152, 3585.8565657373933, 3603.0632035670915, 1058.3279617442824, 1059.3114475590928, 1060.2154405739852, 1068.0, 1069.9411532365639, 783.9882401763978, 789.7867575754514, 791.6714563456217, 807.6284908941952, 809.0210844877764, 4902.264660300983, 5001.274815151783, 5059.924101138486, 5177.611679124081, 5363.812266570651, 826.4999675196419, 858.4463021351194, 888.391451855481, 890.8307421589877, 895.2345744388454, 3323.7203676584204, 3366.5118557808983, 3427.845746941394, 3442.535257740173, 3514.6309637488207, 9674.806503869882, 9704.369216000938, 10005.299629026043, 10022.849657255147, 10035.448050357301, 9815.509224538744, 9824.557894894748, 9827.459489727991, 9832.705018849447, 9835.75410614726, 7337.88993165103, 7504.437167212481, 7518.173000969889, 7529.736459223901, 7532.849343013109, 4841.298011788342, 5021.824236151863, 5101.821436249714, 5150.072986862401, 5156.948430515647, 9105.362624616213, 9121.315901307562, 9134.0, 9281.535923203677, 9340.065993400605, 8942.016378198263, 9466.810663786824, 9472.715818525456, 9488.288378371511, 9494.192993595621, 5763.452472015152, 6286.27707813589, 6467.708953097028, 6491.837704057248, 6602.801915942529, 7796.805079873048, 7800.336971357271, 7821.256980586835, 7825.647845846836, 7861.921380786119, 6492.513061520311, 6701.731930722716, 6910.44716422695, 6960.3735663788475, 7093.574385536885, 6645.368689974444, 6774.830629234309, 6828.863422731617, 6830.419414349836, 6945.131858517685, 6166.445019948226, 6185.041318595625, 6300.527460440394, 6308.936910631019, 6313.494920406265, 4435.534268901848, 4450.933236001398, 4526.275795872644, 4537.137943790669, 4554.997900461893, 4305.374790298471, 4381.649468042613, 4391.297392417198, 4396.96671282242, 4438.467383913951], "value": 4151.969420464187, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.37233379069477, 300.24488411644717, 302.531076830912, 307.7799373447985, 311.1474559706405, 4603.286490593955, 4803.447603525596, 4813.205821039524, 4833.299171620118, 4853.344798452204, 4590.472095708995, 4728.3380326754195, 4746.525347465252, 4768.380110585619, 4773.331733557305, 3806.1626442182815, 3806.257779732953, 3816.866409675662, 3820.9044773880596, 3821.789801560913, 3609.9278014439697, 3680.613535578766, 3807.6953843692577, 3841.7118716096265, 3857.8842634721004, 3806.0675134591925, 3812.6759225465867, 3820.2932457495313, 3821.254855303217, 3838.5777564467885, 3818.2554401891643, 3818.427235914607, 3830.367989281765, 3833.9808300958593, 3841.5966323535904, 3374.696277335027, 3383.1203886989315, 3386.7976868211676, 3387.7120444762227, 3389.559357283562, 4569.109023740372, 4629.722216667011, 4635.513271106553, 4672.976635116803, 4687.273472611751, 4247.299195632717, 4270.572942705736, 4271.423357846682, 4301.440812694361, 4327.8485253016, 4989.201727723583, 5013.172826483626, 5019.824306149304, 5034.155702028343, 5043.193089105725, 3540.9822950885336, 3658.9817050914576, 3682.097886017916, 3691.0956815580353, 3704.4072948328408, 5170.5346518813485, 5196.45437229093, 5205.401378841406, 5215.322008138955, 5221.190715439113, 3751.849926002984, 3753.6434038766274, 3756.7370284079852, 3777.8099898531873, 3797.0697179191275, 3552.5381700378784, 3834.9616503834604, 3842.692584593226, 3845.1732877431486, 3850.0759817643566, 4192.413062171298, 4251.341042138473, 4257.957420425818, 4264.616184543406, 4268.893277668083, 4976.154053810861, 4989.675671081441, 4993.550580447704, 4998.2256299013325, 5006.64953453262, 1217.3061355027548, 1244.4773195258012, 1249.075683993838, 1249.4564864284066, 1251.205484517338, 859.2996707683218, 885.3271513649672, 892.5492626223715, 899.5412339706796, 901.324006994754, 4408.448943882015, 4413.514513403523, 4431.0, 4444.8444304449185, 4467.374567560544, 5013.949860501421, 5132.050570644368, 5138.3833939927445, 5144.842410457617, 5150.665206761623, 4389.31965545341, 4404.361367601679, 4408.118376324748, 4408.118376324748, 4415.315626077963, 2678.9464210716064, 2696.4067905060856, 2701.689305729866, 2706.3640044589506, 2708.3093811078443, 4614.423197100363, 4829.830955916526, 4833.758312084382, 4841.03937905149, 4843.176659967814, 5194.376674798973, 5205.9739701302005, 5208.739563021833, 5216.21756736485, 5223.373195216523, 4839.628581994797, 4840.636952228597, 4849.975750121297, 4853.126437241331, 4855.927161092657, 4907.558319751097, 5060.1663068681655, 5086.872828179326, 5129.615278854027, 5225.477452254744, 5070.416902056163, 5097.286379906742, 5097.286379906742, 5100.719460429712, 5108.974455127701, 4903.41159060915, 4920.286558449076, 4929.654924155275, 4931.3835770528685, 4936.777844996912, 3458.2564748579175, 3665.963340366669, 3699.8335074922234, 3707.666310032002, 3715.869944551928, 5128.666636668605, 5146.588272938231, 5155.458676838878, 5155.819546315861, 5157.690538567698, 4966.900661986668, 4984.981082661528, 4989.2808419410785, 5007.073691367109, 5023.6985780853265, 4772.20825816901, 4991.975040124777, 5015.0, 5020.698758074527, 5055.620828437955, 4701.905961880811, 4785.928211076906, 4924.458309586014, 4929.950700492949, 4934.851954441372, 5014.52362025607, 5046.914913293659, 5071.290019397214, 5071.898562028812, 5081.415637201621, 4774.641901857305, 4897.559219670246, 4917.868890155356, 4923.187674033744, 4966.6771659842], "value": 3796.3548327591766, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.0518631292585, 685.4858855858106, 725.0791494801599, 743.5464366736292, 748.2367984655651, 11586.942065289672, 11978.22141560799, 12020.398980050995, 12320.137590368679, 12332.691682707937, 11477.655670329883, 11634.709132271697, 12162.087843411757, 12178.634640960785, 12180.451879665414, 625.9718312675941, 762.6872982077349, 775.4300589067032, 779.5868189859384, 780.254856611937, 747.1818358896999, 777.0403551613753, 781.3397678961297, 782.4327362662082, 784.1766145547181, 828.5028982610446, 829.7842560934171, 829.8215883585028, 829.85062688716, 830.2527725047476, 642.8167972127968, 788.7949133225345, 823.5840900345318, 824.0194168938943, 824.2087595907935, 594.5392320951254, 597.0059850349163, 597.2981746447949, 597.5846786483396, 598.0670154558902, 11459.713507162387, 11471.598494052669, 11499.712507187303, 11510.424478776027, 11512.654620361318, 12024.699382515508, 12654.177478463871, 12710.555130570478, 12778.872211277861, 12841.614751557374, 11857.466414011304, 11859.407029648482, 12103.39483025854, 12104.2448844917, 12182.573609923611, 4025.1144748155357, 4072.6538244249273, 4086.468759061303, 4222.155568886235, 4222.408862759216, 68100.0, 68275.65862170707, 69382.65308673424, 71896.28103719, 72760.0, 9672.95163524192, 9787.559559819825, 9938.304318697621, 9958.900410995942, 10147.34042287249, 19518.219271229274, 19537.218511259674, 19550.31573894907, 19568.510787230432, 19571.021448927495, 6577.408033277028, 6695.296993815677, 6747.696353664097, 6800.183977922582, 6944.270851560514, 3420.298838738053, 3478.91302717429, 3520.119970007498, 3530.2057037166946, 3531.593866705362, 2727.372704278027, 2813.0, 2825.0959692898077, 2827.2649111231226, 2831.320483084045, 484.9490803465656, 508.3518513894814, 509.15480302697347, 511.836212412032, 514.1388174807183, 487.2909916072107, 492.42140484930064, 496.19616221721043, 512.0552580488992, 516.4783568595745, 7443.516171448839, 7479.439042071866, 7498.812529686801, 7624.390048796083, 7735.7679269622, 481.8434008947106, 535.1010302691516, 542.2733537060279, 544.8120398462524, 563.2508763344741, 3557.1996300832625, 3570.285942811448, 3681.5029970954115, 3745.1386181177936, 3785.337565925952, 59917.70041149853, 60188.69905650531, 60300.69849650723, 60411.39588604146, 92929.0, 88455.55772221097, 90366.54816726006, 91687.54156229309, 92601.5369923146, 93546.0, 81410.0, 81540.59229703814, 81559.59220203743, 82238.58880705558, 83352.0, 7022.12223472066, 7123.394511466583, 7161.991532767242, 7193.496455248082, 7236.529625574321, 46653.53346466492, 46703.766481167375, 47397.0, 47986.760066199444, 48747.26879096746, 38371.424428633036, 38904.41643375295, 39048.6095139045, 52154.478455214965, 66434.6678266625, 8930.106989301017, 8942.73171804847, 9208.953955230181, 9378.437293762396, 9508.952455237679, 10022.248331375322, 10422.084515972547, 10489.0, 10647.148228141576, 10800.945995269973, 8590.82818343642, 8728.08355122703, 8805.867911981197, 8823.205911467998, 9361.344705870524, 9572.712818615453, 9579.85041794989, 9734.853977190207, 9769.804603908024, 10034.0, 8736.486183663388, 8786.912130878609, 8914.37599368064, 8998.280137589109, 9153.63385464574, 8093.919060809317, 8127.552984585905, 8289.129641387808, 8517.063123056583, 8600.311975041857, 7125.82185445368, 7127.572345659277, 7253.8186545336785, 7414.518056326321, 7624.161342252459], "value": 6107.413660570849, "unit": "score"}], "name": "dromaeo_css", "value": 6346.001783434516, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 113.0, 114.0, 111.0, 114.0, 111.0, 112.0, 112.0, 113.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 130.0, 125.0, 192.0, 124.0, 130.0, 155.0, 122.0, 164.0, 123.0], "value": 141.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 160.0, 161.0, 163.0, 161.0, 161.0, 161.0, 162.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 78.0, 114.0, 76.0, 77.0, 75.0, 75.0, 97.0, 75.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 124.0, 85.0, 86.0, 86.0, 112.0, 84.0, 85.0, 131.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 66.0, 69.0, 64.0, 63.0, 63.0, 67.0, 62.0, 62.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 64.0, 63.0, 64.0, 64.0, 64.0, 66.0, 64.0], "value": 64.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 86.0, 79.0, 80.0, 79.0, 80.0, 79.0, 78.0, 79.0, 82.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 129.0, 130.0, 127.0, 129.0, 132.0, 133.0, 137.0, 176.0, 130.0], "value": 136.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 173.0, 164.0, 163.0, 163.0, 165.0, 165.0, 165.0, 163.0, 164.0], "value": 165.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 68.0, 67.0, 67.0, 67.0, 67.0, 67.0, 65.0], "value": 67.4, "unit": "score"}], "name": "kraken", "value": 1528.8, "alertThreshold": 2.0}]} 08:26:47 INFO - Return code: 0 08:26:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:26:48 INFO - # TBPL SUCCESS # 08:26:48 INFO - Running post-action listener: _resource_record_post_action 08:26:48 INFO - ##### 08:26:48 INFO - ##### Finished run-tests step (success) 08:26:48 INFO - ##### 08:26:48 INFO - Running post-run listener: _resource_record_post_run 08:26:48 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 3305472; Write bytes: 300896256; Read time: 256; Write time: 198504 08:26:48 INFO - TinderboxPrint: CPU usage
12.9% 08:26:48 INFO - TinderboxPrint: I/O read bytes / time
3,305,472 / 256 08:26:48 INFO - TinderboxPrint: I/O write bytes / time
300,896,256 / 198,504 08:26:48 INFO - TinderboxPrint: CPU idle
8,338.8 (87.1%) 08:26:48 INFO - TinderboxPrint: CPU user
1,198.5 (12.5%) 08:26:48 INFO - TinderboxPrint: Swap in / out
0 / 0 08:26:48 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 13320192; Read time: 0; Write time: 3336 08:26:48 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 3301376; Write bytes: 287576064; Read time: 240; Write time: 195168 08:26:48 INFO - Running post-run listener: _upload_blobber_files 08:26:48 INFO - Blob upload gear active. 08:26:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:26:48 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 08:26:48 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'] 08:26:48 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 08:26:49 INFO - (blobuploader) - INFO - Open directory for files ... 08:26:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:26:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:26:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:26:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:26:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:26:49 INFO - (blobuploader) - INFO - Done attempting. 08:26:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:26:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:26:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:26:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:26:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:26:53 INFO - (blobuploader) - INFO - Done attempting. 08:26:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:26:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:26:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:26:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:26:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:26:54 INFO - (blobuploader) - INFO - Done attempting. 08:26:54 INFO - (blobuploader) - INFO - Iteration through files over. 08:26:54 INFO - Return code: 0 08:26:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:26:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:26:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b8c879605bc3b52691558b5c4690aa0fb0dae9ba913c5552b813eb59747ce71e70c6b808b1b0c991588f45453456cd52545d5139b87ba42897e137ca94cf9c82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e1fd92ddf91ee9a355daf3954ba622d10bd95b1b9eb8bc52fad89041e440f2c7c0ea27c0ff8dd1046d71c77cfd4d5f64a962ff1012dde4963958297952cf300c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4401f2f9da53a344b357b809a56523047e422a81351fb245329e57c0085528748230ce92fde9fa140143c4b3cfeec7650a4a485e20c8114fd3e92b651dfd40f8"} 08:26:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:26:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:26:54 INFO - Contents: 08:26:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b8c879605bc3b52691558b5c4690aa0fb0dae9ba913c5552b813eb59747ce71e70c6b808b1b0c991588f45453456cd52545d5139b87ba42897e137ca94cf9c82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e1fd92ddf91ee9a355daf3954ba622d10bd95b1b9eb8bc52fad89041e440f2c7c0ea27c0ff8dd1046d71c77cfd4d5f64a962ff1012dde4963958297952cf300c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4401f2f9da53a344b357b809a56523047e422a81351fb245329e57c0085528748230ce92fde9fa140143c4b3cfeec7650a4a485e20c8114fd3e92b651dfd40f8"} 08:26:54 INFO - Running post-run listener: copy_logs_to_upload_dir 08:26:54 INFO - Copying logs to upload dir... 08:26:54 INFO - mkdir: /builds/slave/test/build/upload/logs 08:26:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.906928 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-07-06 08:26:54.515920) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 08:26:54.519482) ========= 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=31acecf42b6a79ec49471d4a000001bb-1467815367.329965-313946457 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/b8c879605bc3b52691558b5c4690aa0fb0dae9ba913c5552b813eb59747ce71e70c6b808b1b0c991588f45453456cd52545d5139b87ba42897e137ca94cf9c82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e1fd92ddf91ee9a355daf3954ba622d10bd95b1b9eb8bc52fad89041e440f2c7c0ea27c0ff8dd1046d71c77cfd4d5f64a962ff1012dde4963958297952cf300c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4401f2f9da53a344b357b809a56523047e422a81351fb245329e57c0085528748230ce92fde9fa140143c4b3cfeec7650a4a485e20c8114fd3e92b651dfd40f8"} build_url:https://queue.taskcluster.net/v1/task/dJ2K4PIbRval5oKEKRccyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011443 build_url: 'https://queue.taskcluster.net/v1/task/dJ2K4PIbRval5oKEKRccyw/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/b8c879605bc3b52691558b5c4690aa0fb0dae9ba913c5552b813eb59747ce71e70c6b808b1b0c991588f45453456cd52545d5139b87ba42897e137ca94cf9c82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e1fd92ddf91ee9a355daf3954ba622d10bd95b1b9eb8bc52fad89041e440f2c7c0ea27c0ff8dd1046d71c77cfd4d5f64a962ff1012dde4963958297952cf300c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4401f2f9da53a344b357b809a56523047e422a81351fb245329e57c0085528748230ce92fde9fa140143c4b3cfeec7650a4a485e20c8114fd3e92b651dfd40f8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 08:26:54.545220) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 08:26:54.545523) ========= 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=31acecf42b6a79ec49471d4a000001bb-1467815367.329965-313946457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004411 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 08:26:54.627897) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 08:26:54.628216) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 08:26:54.628510) ========= ========= Total master_lag: 0.18 =========