builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-054 starttime: 1468238825.79 results: success (0) buildid: 20160711021319 builduid: b81e2b480c9746b681c6bdce7fb3ff22 revision: 0136b1e24160 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 05:07:05.788956) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 05:07:05.789443) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 05:07:05.789720) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 05:07:05.804601) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 05:07:05.804875) ========= 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=cbe409c6de289db6ac707de3000001d4-1468238825.818490-903465473 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-11 05:07:06-- 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% 111M=0s 2016-07-11 05:07:06 (111 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.341777 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 05:07:06.160363) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 05:07:06.160686) ========= 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=cbe409c6de289db6ac707de3000001d4-1468238825.818490-903465473 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014380 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 05:07:06.209718) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 05:07:06.210054) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0136b1e24160 --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 0136b1e24160 --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=cbe409c6de289db6ac707de3000001d4-1468238825.818490-903465473 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-11 05:07:07,097 Setting DEBUG logging. 2016-07-11 05:07:07,097 attempt 1/10 2016-07-11 05:07:07,097 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0136b1e24160?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-11 05:07:07,445 unpacking tar archive at: fx-team-0136b1e24160/testing/mozharness/ program finished with exit code 0 elapsedTime=0.669932 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 05:07:06.893569) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 05:07:06.893875) ========= script_repo_revision: 0136b1e24160 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 05:07:06.894274) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 05:07:06.894543) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 05:07:06.902449) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-11 05:07:06.902723) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=cbe409c6de289db6ac707de3000001d4-1468238825.818490-903465473 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:07:07 INFO - MultiFileLogger online at 20160711 05:07:07 in /builds/slave/test 05:07:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:07:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:07:07 INFO - {'append_to_log': False, 05:07:07 INFO - 'base_work_dir': '/builds/slave/test', 05:07:07 INFO - 'blob_upload_branch': 'Fx-Team', 05:07:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:07:07 INFO - 'branch': 'Fx-Team', 05:07:07 INFO - 'buildbot_json_path': 'buildprops.json', 05:07:07 INFO - 'config_files': ('talos/linux_config.py',), 05:07:07 INFO - 'default_actions': ('clobber', 05:07:07 INFO - 'read-buildbot-config', 05:07:07 INFO - 'download-and-extract', 05:07:07 INFO - 'populate-webroot', 05:07:07 INFO - 'create-virtualenv', 05:07:07 INFO - 'install', 05:07:07 INFO - 'run-tests'), 05:07:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:07:07 INFO - 'download_minidump_stackwalk': True, 05:07:07 INFO - 'download_symbols': 'ondemand', 05:07:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:07:07 INFO - 'tooltool.py': '/tools/tooltool.py', 05:07:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:07:07 INFO - '/tools/misc-python/virtualenv.py')}, 05:07:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:07:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:07:07 INFO - 'installer_path': 'installer.exe', 05:07:07 INFO - 'log_level': 'info', 05:07:07 INFO - 'log_name': 'talos', 05:07:07 INFO - 'log_to_console': True, 05:07:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:07:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:07:07 INFO - 'opt_config_files': (), 05:07:07 INFO - 'pip_index': False, 05:07:07 INFO - 'sps_profile': False, 05:07:07 INFO - 'sps_profile_interval': 0, 05:07:07 INFO - 'suite': 'dromaeojs', 05:07:07 INFO - 'system_bits': '32', 05:07:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:07:07 INFO - 'title': 'talos-linux64-ix-054', 05:07:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:07:07 INFO - 'use_talos_json': True, 05:07:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:07:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:07:07 INFO - 'work_dir': 'build'} 05:07:07 INFO - ##### 05:07:07 INFO - ##### Running clobber step. 05:07:07 INFO - ##### 05:07:07 INFO - Running pre-action listener: _resource_record_pre_action 05:07:07 INFO - Running main action method: clobber 05:07:07 INFO - rmtree: /builds/slave/test/build 05:07:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:07:08 INFO - Running post-action listener: _resource_record_post_action 05:07:08 INFO - ##### 05:07:08 INFO - ##### Finished clobber step (success) 05:07:08 INFO - ##### 05:07:08 INFO - ##### 05:07:08 INFO - ##### Running read-buildbot-config step. 05:07:08 INFO - ##### 05:07:08 INFO - Running pre-action listener: _resource_record_pre_action 05:07:08 INFO - Running main action method: read_buildbot_config 05:07:08 INFO - Using buildbot properties: 05:07:08 INFO - { 05:07:08 INFO - "project": "", 05:07:08 INFO - "product": "firefox", 05:07:08 INFO - "script_repo_revision": "production", 05:07:08 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:07:08 INFO - "repository": "", 05:07:08 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:07:08 INFO - "buildid": "20160711021319", 05:07:08 INFO - "pgo_build": "True", 05:07:08 INFO - "basedir": "/builds/slave/test", 05:07:08 INFO - "buildnumber": 881, 05:07:08 INFO - "slavename": "talos-linux64-ix-054", 05:07:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:07:08 INFO - "platform": "ubuntu64_hw", 05:07:08 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:07:08 INFO - "branch": "fx-team", 05:07:08 INFO - "repo_path": "integration/fx-team", 05:07:08 INFO - "revision": "0136b1e24160", 05:07:08 INFO - "stage_platform": "linux64-pgo", 05:07:08 INFO - "builduid": "b81e2b480c9746b681c6bdce7fb3ff22", 05:07:08 INFO - "slavebuilddir": "test" 05:07:08 INFO - } 05:07:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:07:08 INFO - Running post-action listener: _resource_record_post_action 05:07:08 INFO - ##### 05:07:08 INFO - ##### Finished read-buildbot-config step (success) 05:07:08 INFO - ##### 05:07:08 INFO - ##### 05:07:08 INFO - ##### Running download-and-extract step. 05:07:08 INFO - ##### 05:07:08 INFO - Running pre-action listener: _resource_record_pre_action 05:07:08 INFO - Running main action method: download_and_extract 05:07:08 INFO - mkdir: /builds/slave/test/build/tests 05:07:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:08 INFO - https://queue.taskcluster.net/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:07:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:07:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:07:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coEJbLhqTci38c6RWN6rzw/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 05:07:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coEJbLhqTci38c6RWN6rzw/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 05:07:09 INFO - Downloaded 1361 bytes. 05:07:09 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:07:09 INFO - Using the following test package requirements: 05:07:09 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:07:09 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:07:09 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:07:09 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:09 INFO - u'jsshell-linux-x86_64.zip'], 05:07:09 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:07:09 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:07:09 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:07:09 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:07:09 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:07:09 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:07:09 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:09 INFO - https://queue.taskcluster.net/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:07:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:07:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:07:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coEJbLhqTci38c6RWN6rzw/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 05:07:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coEJbLhqTci38c6RWN6rzw/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 05:07:10 INFO - Downloaded 24304453 bytes. 05:07:10 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'] 05:07:10 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 05:07:12 INFO - Return code: 0 05:07: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 05:07: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')]} 05:07:12 INFO - https://queue.taskcluster.net/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:07:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:07:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:07:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coEJbLhqTci38c6RWN6rzw/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 05:07:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coEJbLhqTci38c6RWN6rzw/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 05:07:13 INFO - Downloaded 24304453 bytes. 05:07:13 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'] 05:07:13 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 05:07:14 INFO - Return code: 0 05:07:14 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')]} 05:07:14 INFO - https://queue.taskcluster.net/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:07:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:07:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:07:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coEJbLhqTci38c6RWN6rzw/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 05:07:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coEJbLhqTci38c6RWN6rzw/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 05:07:15 INFO - Downloaded 14403333 bytes. 05:07:15 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'] 05:07:15 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 05:07:15 INFO - Return code: 0 05:07:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:15 INFO - https://queue.taskcluster.net/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:07:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:07:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:07:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coEJbLhqTci38c6RWN6rzw/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 05:07:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coEJbLhqTci38c6RWN6rzw/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 05:07:18 INFO - Downloaded 60469528 bytes. 05:07:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:07:18 INFO - mkdir: /builds/slave/test/properties 05:07:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:07:18 INFO - Writing to file /builds/slave/test/properties/build_url 05:07:18 INFO - Contents: 05:07:18 INFO - build_url:https://queue.taskcluster.net/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:07:19 INFO - Running post-action listener: _resource_record_post_action 05:07:19 INFO - Running post-action listener: set_extra_try_arguments 05:07:19 INFO - ##### 05:07:19 INFO - ##### Finished download-and-extract step (success) 05:07:19 INFO - ##### 05:07:19 INFO - ##### 05:07:19 INFO - ##### Running populate-webroot step. 05:07:19 INFO - ##### 05:07:19 INFO - Running pre-action listener: _resource_record_pre_action 05:07:19 INFO - Running main action method: populate_webroot 05:07:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:07:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:07:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:07:19 INFO - '--tppagecycles', 05:07:19 INFO - '7'], 05:07:19 INFO - 'tests': ['tsvgm']}}, 05:07:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:07:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:07:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:07:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:07:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:07:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:07:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:19 INFO - 'talos_options': ['--disable-e10s'], 05:07:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:07:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:07:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:19 INFO - 'talos_options': ['--disable-e10s'], 05:07:19 INFO - 'tests': ['damp', 'tps']}, 05:07:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:19 INFO - 'tests': ['damp', 'tps']}, 05:07:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:07:19 INFO - 'tests': ['dromaeo_dom']}, 05:07:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:07:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:07:19 INFO - 'tests': ['basic_compositor_video']}, 05:07:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:07:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:07:19 INFO - 'tests': ['a11yr', 05:07:19 INFO - 'ts_paint', 05:07:19 INFO - 'tpaint', 05:07:19 INFO - 'sessionrestore', 05:07:19 INFO - 'sessionrestore_no_auto_restore', 05:07:19 INFO - 'tabpaint']}, 05:07:19 INFO - 'other-e10s': {'tests': ['a11yr', 05:07:19 INFO - 'ts_paint', 05:07:19 INFO - 'tpaint', 05:07:19 INFO - 'sessionrestore', 05:07:19 INFO - 'sessionrestore_no_auto_restore', 05:07:19 INFO - 'tabpaint']}, 05:07:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:07:19 INFO - 'ts_paint', 05:07:19 INFO - 'tpaint', 05:07:19 INFO - 'sessionrestore', 05:07:19 INFO - 'sessionrestore_no_auto_restore', 05:07:19 INFO - 'tabpaint']}, 05:07:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:07:19 INFO - 'ts_paint', 05:07:19 INFO - 'tpaint', 05:07:19 INFO - 'sessionrestore', 05:07:19 INFO - 'sessionrestore_no_auto_restore', 05:07:19 INFO - 'tabpaint']}, 05:07:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:07:19 INFO - 'tests': ['a11yr', 05:07:19 INFO - 'ts_paint', 05:07:19 INFO - 'tpaint', 05:07:19 INFO - 'sessionrestore', 05:07:19 INFO - 'sessionrestore_no_auto_restore', 05:07:19 INFO - 'tabpaint']}, 05:07:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:07:19 INFO - 'tests': ['a11yr', 05:07:19 INFO - 'ts_paint', 05:07:19 INFO - 'tpaint', 05:07:19 INFO - 'sessionrestore', 05:07:19 INFO - 'sessionrestore_no_auto_restore', 05:07:19 INFO - 'tabpaint']}, 05:07:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:07:19 INFO - 'tests': ['tsvgx', 05:07:19 INFO - 'tsvgr_opacity', 05:07:19 INFO - 'tart', 05:07:19 INFO - 'tscrollx', 05:07:19 INFO - 'cart']}, 05:07:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:07:19 INFO - 'tsvgr_opacity', 05:07:19 INFO - 'tart', 05:07:19 INFO - 'tscrollx', 05:07:19 INFO - 'cart']}, 05:07:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:19 INFO - 'talos_options': ['--disable-e10s'], 05:07:19 INFO - 'tests': ['tp5o']}, 05:07:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:19 INFO - 'tests': ['tp5o']}, 05:07:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:19 INFO - 'talos_options': ['--disable-e10s', 05:07:19 INFO - '--xperf_path', 05:07:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:07:19 INFO - 'tests': ['tp5n']}, 05:07:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:19 INFO - 'talos_options': ['--xperf_path', 05:07:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:07:19 INFO - 'tests': ['tp5n']}}, 05:07:19 INFO - 'talos.zip': {'path': '', 05:07:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:07:19 INFO - Running post-action listener: _resource_record_post_action 05:07:19 INFO - ##### 05:07:19 INFO - ##### Finished populate-webroot step (success) 05:07:19 INFO - ##### 05:07:19 INFO - ##### 05:07:19 INFO - ##### Running create-virtualenv step. 05:07:19 INFO - ##### 05:07:19 INFO - Running pre-action listener: _resource_record_pre_action 05:07:19 INFO - Running main action method: create_virtualenv 05:07:19 INFO - Creating virtualenv /builds/slave/test/build/venv 05:07:19 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 05:07:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:07:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:07:19 INFO - Using real prefix '/usr' 05:07:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:07:19 INFO - Installing distribute.............................................................................................................................................................................................done. 05:07:21 INFO - Installing pip.................done. 05:07:21 INFO - Return code: 0 05:07:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:07: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')]} 05:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07: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')]} 05:07:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:21 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 0x2a94030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d55180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d533b0>, '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 0x2d542b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d54740>, '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': 'cbe409c6de289db6ac707de3000001d4-1468238825.818490-903465473', '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 05:07:21 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 05:07:21 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 05:07:21 INFO - Using env: {'DISPLAY': ':0', 05:07:21 INFO - 'HOME': '/home/cltbld', 05:07:21 INFO - 'LANG': 'en_US.UTF-8', 05:07:21 INFO - 'LANGUAGE': 'en_US:en', 05:07:21 INFO - 'LOGNAME': 'cltbld', 05:07:21 INFO - 'MAIL': '/var/mail/cltbld', 05:07:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:21 INFO - 'MOZ_NO_REMOTE': '1', 05:07:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:21 INFO - 'NO_EM_RESTART': '1', 05:07:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:21 INFO - 'PWD': '/builds/slave/test', 05:07:21 INFO - 'SHELL': '/bin/bash', 05:07:21 INFO - 'SHLVL': '1', 05:07:21 INFO - 'TERM': 'linux', 05:07:21 INFO - 'TMOUT': '86400', 05:07:21 INFO - 'USER': 'cltbld', 05:07:21 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1468238825.818490-903465473', 05:07:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:21 INFO - '_': '/tools/buildbot/bin/python'} 05:07:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:07:22 INFO - Cleaning up... 05:07:22 INFO - Return code: 0 05:07:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:07:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a94030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d55180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d533b0>, '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 0x2d542b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d54740>, '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': 'cbe409c6de289db6ac707de3000001d4-1468238825.818490-903465473', '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 05:07:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:07:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:07:22 INFO - Using env: {'DISPLAY': ':0', 05:07:22 INFO - 'HOME': '/home/cltbld', 05:07:22 INFO - 'LANG': 'en_US.UTF-8', 05:07:22 INFO - 'LANGUAGE': 'en_US:en', 05:07:22 INFO - 'LOGNAME': 'cltbld', 05:07:22 INFO - 'MAIL': '/var/mail/cltbld', 05:07:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:22 INFO - 'MOZ_NO_REMOTE': '1', 05:07:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:22 INFO - 'NO_EM_RESTART': '1', 05:07:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:22 INFO - 'PWD': '/builds/slave/test', 05:07:22 INFO - 'SHELL': '/bin/bash', 05:07:22 INFO - 'SHLVL': '1', 05:07:22 INFO - 'TERM': 'linux', 05:07:22 INFO - 'TMOUT': '86400', 05:07:22 INFO - 'USER': 'cltbld', 05:07:22 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1468238825.818490-903465473', 05:07:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:22 INFO - '_': '/tools/buildbot/bin/python'} 05:07:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:22 INFO - Downloading/unpacking psutil>=3.1.1 05:07:22 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 05:07:22 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 05:07:22 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 05:07:22 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 05:07:22 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 05:07:22 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 05:07:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:07:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:07:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:07:24 INFO - Installing collected packages: psutil 05:07:24 INFO - Running setup.py install for psutil 05:07:24 INFO - building 'psutil._psutil_linux' extension 05:07:24 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 05:07:24 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 05:07:24 INFO - building 'psutil._psutil_posix' extension 05:07:24 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 05:07:24 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 05:07:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:07:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:07:24 INFO - Successfully installed psutil 05:07:24 INFO - Cleaning up... 05:07:24 INFO - Return code: 0 05:07:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:07:24 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')]} 05:07:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:24 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')]} 05:07:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:24 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 0x2a94030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d55180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d533b0>, '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 0x2d542b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d54740>, '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': 'cbe409c6de289db6ac707de3000001d4-1468238825.818490-903465473', '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 05:07:24 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 05:07:24 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 05:07:24 INFO - Using env: {'DISPLAY': ':0', 05:07:24 INFO - 'HOME': '/home/cltbld', 05:07:24 INFO - 'LANG': 'en_US.UTF-8', 05:07:24 INFO - 'LANGUAGE': 'en_US:en', 05:07:24 INFO - 'LOGNAME': 'cltbld', 05:07:24 INFO - 'MAIL': '/var/mail/cltbld', 05:07:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:24 INFO - 'MOZ_NO_REMOTE': '1', 05:07:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:24 INFO - 'NO_EM_RESTART': '1', 05:07:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:24 INFO - 'PWD': '/builds/slave/test', 05:07:24 INFO - 'SHELL': '/bin/bash', 05:07:24 INFO - 'SHLVL': '1', 05:07:24 INFO - 'TERM': 'linux', 05:07:24 INFO - 'TMOUT': '86400', 05:07:24 INFO - 'USER': 'cltbld', 05:07:24 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1468238825.818490-903465473', 05:07:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:24 INFO - '_': '/tools/buildbot/bin/python'} 05:07:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:07:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:07:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:07:27 INFO - Installing collected packages: mozsystemmonitor 05:07:27 INFO - Running setup.py install for mozsystemmonitor 05:07:27 INFO - Successfully installed mozsystemmonitor 05:07:27 INFO - Cleaning up... 05:07:27 INFO - Return code: 0 05:07:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:07: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')]} 05:07:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07: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')]} 05:07:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07: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', '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 0x2a94030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d55180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d533b0>, '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 0x2d542b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d54740>, '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': 'cbe409c6de289db6ac707de3000001d4-1468238825.818490-903465473', '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 05:07: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:07: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 jsonschema==2.5.1 05:07:27 INFO - Using env: {'DISPLAY': ':0', 05:07:27 INFO - 'HOME': '/home/cltbld', 05:07:27 INFO - 'LANG': 'en_US.UTF-8', 05:07:27 INFO - 'LANGUAGE': 'en_US:en', 05:07:27 INFO - 'LOGNAME': 'cltbld', 05:07:27 INFO - 'MAIL': '/var/mail/cltbld', 05:07:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:27 INFO - 'MOZ_NO_REMOTE': '1', 05:07:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:27 INFO - 'NO_EM_RESTART': '1', 05:07:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:27 INFO - 'PWD': '/builds/slave/test', 05:07:27 INFO - 'SHELL': '/bin/bash', 05:07:27 INFO - 'SHLVL': '1', 05:07:27 INFO - 'TERM': 'linux', 05:07:27 INFO - 'TMOUT': '86400', 05:07:27 INFO - 'USER': 'cltbld', 05:07:27 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1468238825.818490-903465473', 05:07:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:27 INFO - '_': '/tools/buildbot/bin/python'} 05:07:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:27 INFO - Downloading/unpacking jsonschema==2.5.1 05:07:27 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 05:07:27 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 05:07:27 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 05:07:27 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 05:07:27 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 05:07:27 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 05:07:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:07:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:07:29 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 05:07:29 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 05:07:29 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 05:07:29 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 05:07:29 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 05:07:29 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 05:07:29 INFO - Downloading functools32-3.2.3-2.tar.gz 05:07:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:07:29 INFO - warning: no files found matching '*.txt' 05:07:29 INFO - no previously-included directories found matching 'build' 05:07:29 INFO - no previously-included directories found matching 'dist' 05:07:29 INFO - no previously-included directories found matching '.git*' 05:07:29 INFO - Installing collected packages: jsonschema, functools32 05:07:29 INFO - Running setup.py install for functools32 05:07:29 INFO - warning: no files found matching '*.txt' 05:07:29 INFO - no previously-included directories found matching 'build' 05:07:29 INFO - no previously-included directories found matching 'dist' 05:07:29 INFO - no previously-included directories found matching '.git*' 05:07:29 INFO - Successfully installed jsonschema functools32 05:07:29 INFO - Cleaning up... 05:07:29 INFO - Return code: 0 05:07:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:07:29 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')]} 05:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:29 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')]} 05:07:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:29 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 0x2a94030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d55180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d533b0>, '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 0x2d542b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d54740>, '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': 'cbe409c6de289db6ac707de3000001d4-1468238825.818490-903465473', '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 05:07:29 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 05:07:29 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 05:07:29 INFO - Using env: {'DISPLAY': ':0', 05:07:29 INFO - 'HOME': '/home/cltbld', 05:07:29 INFO - 'LANG': 'en_US.UTF-8', 05:07:29 INFO - 'LANGUAGE': 'en_US:en', 05:07:29 INFO - 'LOGNAME': 'cltbld', 05:07:29 INFO - 'MAIL': '/var/mail/cltbld', 05:07:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:29 INFO - 'MOZ_NO_REMOTE': '1', 05:07:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:29 INFO - 'NO_EM_RESTART': '1', 05:07:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:29 INFO - 'PWD': '/builds/slave/test', 05:07:29 INFO - 'SHELL': '/bin/bash', 05:07:29 INFO - 'SHLVL': '1', 05:07:29 INFO - 'TERM': 'linux', 05:07:29 INFO - 'TMOUT': '86400', 05:07:29 INFO - 'USER': 'cltbld', 05:07:29 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1468238825.818490-903465473', 05:07:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:29 INFO - '_': '/tools/buildbot/bin/python'} 05:07:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:29 INFO - Downloading/unpacking blobuploader==1.2.4 05:07:29 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 05:07:29 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 05:07:29 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 05:07:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:31 INFO - Downloading blobuploader-1.2.4.tar.gz 05:07:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:07:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:07: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 05:07: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 05:07: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 05:07: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 05:07: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 05:07: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 05:07:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:07:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:32 INFO - Downloading docopt-0.6.1.tar.gz 05:07:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:07:32 INFO - Installing collected packages: blobuploader, requests, docopt 05:07:32 INFO - Running setup.py install for blobuploader 05:07:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:07:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:07:32 INFO - Running setup.py install for requests 05:07:33 INFO - Running setup.py install for docopt 05:07:33 INFO - Successfully installed blobuploader requests docopt 05:07:33 INFO - Cleaning up... 05:07:33 INFO - Return code: 0 05:07:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:07: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')]} 05:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07: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')]} 05:07:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:33 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 0x2a94030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d55180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d533b0>, '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 0x2d542b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d54740>, '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': 'cbe409c6de289db6ac707de3000001d4-1468238825.818490-903465473', '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 05:07:33 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 05:07:33 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 05:07:33 INFO - Using env: {'DISPLAY': ':0', 05:07:33 INFO - 'HOME': '/home/cltbld', 05:07:33 INFO - 'LANG': 'en_US.UTF-8', 05:07:33 INFO - 'LANGUAGE': 'en_US:en', 05:07:33 INFO - 'LOGNAME': 'cltbld', 05:07:33 INFO - 'MAIL': '/var/mail/cltbld', 05:07:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:33 INFO - 'MOZ_NO_REMOTE': '1', 05:07:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:33 INFO - 'NO_EM_RESTART': '1', 05:07:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:33 INFO - 'PWD': '/builds/slave/test', 05:07:33 INFO - 'SHELL': '/bin/bash', 05:07:33 INFO - 'SHLVL': '1', 05:07:33 INFO - 'TERM': 'linux', 05:07:33 INFO - 'TMOUT': '86400', 05:07:33 INFO - 'USER': 'cltbld', 05:07:33 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1468238825.818490-903465473', 05:07:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:33 INFO - '_': '/tools/buildbot/bin/python'} 05:07:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:07:33 INFO - Running setup.py (path:/tmp/pip-YA2j3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:07:33 INFO - Running setup.py (path:/tmp/pip-x9yrno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:07:33 INFO - Running setup.py (path:/tmp/pip-rxFRkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:07:33 INFO - Running setup.py (path:/tmp/pip-SaSUD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:07:33 INFO - Running setup.py (path:/tmp/pip-LctKgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:07:33 INFO - Running setup.py (path:/tmp/pip-gSTeE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:07:33 INFO - Running setup.py (path:/tmp/pip-HbvzkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:07:33 INFO - Running setup.py (path:/tmp/pip-ZAygIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:07:34 INFO - Running setup.py (path:/tmp/pip-EoiS4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:07:34 INFO - Running setup.py (path:/tmp/pip-9b1t4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:07:34 INFO - Running setup.py (path:/tmp/pip-uULKns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:07:34 INFO - Running setup.py (path:/tmp/pip-7QrjlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:07:34 INFO - Running setup.py (path:/tmp/pip-g5DbeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:07:34 INFO - Running setup.py (path:/tmp/pip-v47E15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:34 INFO - Running setup.py (path:/tmp/pip-sheLck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:07:34 INFO - Running setup.py (path:/tmp/pip-wwYLuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:07:34 INFO - Running setup.py (path:/tmp/pip-mYYpYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:07:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:07:34 INFO - Running setup.py install for manifestparser 05:07:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:07:34 INFO - Running setup.py install for mozcrash 05:07:34 INFO - Running setup.py install for mozdebug 05:07:34 INFO - Running setup.py install for mozdevice 05:07:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:07:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:07:35 INFO - Running setup.py install for mozfile 05:07:35 INFO - Running setup.py install for mozhttpd 05:07:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:07:35 INFO - Running setup.py install for mozinfo 05:07:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:07:35 INFO - Running setup.py install for mozInstall 05:07:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:07:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:07:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:07:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:07:35 INFO - Running setup.py install for mozleak 05:07:35 INFO - Running setup.py install for mozlog 05:07:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:07:35 INFO - Running setup.py install for moznetwork 05:07:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:07:35 INFO - Running setup.py install for mozprocess 05:07:35 INFO - Running setup.py install for mozprofile 05:07:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:07:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:07:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:07:36 INFO - Running setup.py install for mozrunner 05:07:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:07:36 INFO - Running setup.py install for mozscreenshot 05:07:36 INFO - Running setup.py install for moztest 05:07:36 INFO - Running setup.py install for mozversion 05:07:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:07:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:07:36 INFO - Cleaning up... 05:07:36 INFO - Return code: 0 05:07:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:07: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')]} 05:07:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07: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')]} 05:07:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:36 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 0x2a94030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d55180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d533b0>, '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 0x2d542b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d54740>, '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': 'cbe409c6de289db6ac707de3000001d4-1468238825.818490-903465473', '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 05:07:36 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 05:07:36 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 05:07:36 INFO - Using env: {'DISPLAY': ':0', 05:07:36 INFO - 'HOME': '/home/cltbld', 05:07:36 INFO - 'LANG': 'en_US.UTF-8', 05:07:36 INFO - 'LANGUAGE': 'en_US:en', 05:07:36 INFO - 'LOGNAME': 'cltbld', 05:07:36 INFO - 'MAIL': '/var/mail/cltbld', 05:07:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:36 INFO - 'MOZ_NO_REMOTE': '1', 05:07:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:36 INFO - 'NO_EM_RESTART': '1', 05:07:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:36 INFO - 'PWD': '/builds/slave/test', 05:07:36 INFO - 'SHELL': '/bin/bash', 05:07:36 INFO - 'SHLVL': '1', 05:07:36 INFO - 'TERM': 'linux', 05:07:36 INFO - 'TMOUT': '86400', 05:07:36 INFO - 'USER': 'cltbld', 05:07:36 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1468238825.818490-903465473', 05:07:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:36 INFO - '_': '/tools/buildbot/bin/python'} 05:07:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:07:36 INFO - Running setup.py (path:/tmp/pip-X2iZz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:07:36 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)) 05:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:07:36 INFO - Running setup.py (path:/tmp/pip-aPQyNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:07:36 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)) 05:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:07:36 INFO - Running setup.py (path:/tmp/pip-chcUAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:07:36 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)) 05:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:07:36 INFO - Running setup.py (path:/tmp/pip-NMnN0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:07:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:07:37 INFO - Running setup.py (path:/tmp/pip-qmDIih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:07:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:07:37 INFO - Running setup.py (path:/tmp/pip-Irtsin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:07:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:07:37 INFO - Running setup.py (path:/tmp/pip-EkY9if-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:07:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:07:37 INFO - Running setup.py (path:/tmp/pip-FVL4ED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:07:37 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)) 05:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:07:37 INFO - Running setup.py (path:/tmp/pip-p21XkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:07:37 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)) 05:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:07:37 INFO - Running setup.py (path:/tmp/pip-aM8fuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:07:37 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)) 05:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:07:37 INFO - Running setup.py (path:/tmp/pip-97zEQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:07:37 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)) 05:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:07:37 INFO - Running setup.py (path:/tmp/pip-mjJ1eu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:07:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:07:37 INFO - Running setup.py (path:/tmp/pip-J_D5_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:07:37 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)) 05:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:07:37 INFO - Running setup.py (path:/tmp/pip-1Fns6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:07:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:37 INFO - Running setup.py (path:/tmp/pip-yoyQu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:37 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)) 05:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:07:37 INFO - Running setup.py (path:/tmp/pip-jTKRWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:07:37 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)) 05:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:07:37 INFO - Running setup.py (path:/tmp/pip-M4DRir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:07:37 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)) 05:07:37 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)) 05:07:37 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)) 05:07:37 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)) 05:07:37 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)) 05:07:37 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)) 05:07:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:39 INFO - Downloading blessings-1.6.tar.gz 05:07:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:07:39 INFO - Installing collected packages: blessings 05:07:39 INFO - Running setup.py install for blessings 05:07:40 INFO - Successfully installed blessings 05:07:40 INFO - Cleaning up... 05:07:40 INFO - Return code: 0 05:07:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:07:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:07:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:07:40 INFO - Reading from file tmpfile_stdout 05:07:40 INFO - Current package versions: 05:07:40 INFO - argparse == 1.2.1 05:07:40 INFO - blessings == 1.6 05:07:40 INFO - blobuploader == 1.2.4 05:07:40 INFO - docopt == 0.6.1 05:07:40 INFO - functools32 == 3.2.3-2 05:07:40 INFO - jsonschema == 2.5.1 05:07:40 INFO - manifestparser == 1.1 05:07:40 INFO - mozInstall == 1.12 05:07:40 INFO - mozcrash == 0.17 05:07:40 INFO - mozdebug == 0.1 05:07:40 INFO - mozdevice == 0.48 05:07:40 INFO - mozfile == 1.2 05:07:40 INFO - mozhttpd == 0.7 05:07:40 INFO - mozinfo == 0.9 05:07:40 INFO - mozleak == 0.1 05:07:40 INFO - mozlog == 3.2 05:07:40 INFO - moznetwork == 0.27 05:07:40 INFO - mozprocess == 0.23 05:07:40 INFO - mozprofile == 0.28 05:07:40 INFO - mozrunner == 6.12 05:07:40 INFO - mozscreenshot == 0.1 05:07:40 INFO - mozsystemmonitor == 0.3 05:07:40 INFO - moztest == 0.7 05:07:40 INFO - mozversion == 1.4 05:07:40 INFO - psutil == 3.1.1 05:07:40 INFO - requests == 1.2.3 05:07:40 INFO - wsgiref == 0.1.2 05:07:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:07:40 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')]} 05:07:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:40 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')]} 05:07:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:40 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 0x2a94030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d55180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d533b0>, '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 0x2d542b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d54740>, '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': 'cbe409c6de289db6ac707de3000001d4-1468238825.818490-903465473', '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 05:07:40 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 05:07:40 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 05:07:40 INFO - Using env: {'DISPLAY': ':0', 05:07:40 INFO - 'HOME': '/home/cltbld', 05:07:40 INFO - 'LANG': 'en_US.UTF-8', 05:07:40 INFO - 'LANGUAGE': 'en_US:en', 05:07:40 INFO - 'LOGNAME': 'cltbld', 05:07:40 INFO - 'MAIL': '/var/mail/cltbld', 05:07:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:40 INFO - 'MOZ_NO_REMOTE': '1', 05:07:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:40 INFO - 'NO_EM_RESTART': '1', 05:07:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:40 INFO - 'PWD': '/builds/slave/test', 05:07:40 INFO - 'SHELL': '/bin/bash', 05:07:40 INFO - 'SHLVL': '1', 05:07:40 INFO - 'TERM': 'linux', 05:07:40 INFO - 'TMOUT': '86400', 05:07:40 INFO - 'USER': 'cltbld', 05:07:40 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1468238825.818490-903465473', 05:07:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:40 INFO - '_': '/tools/buildbot/bin/python'} 05:07:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:40 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)) 05:07:40 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)) 05:07:40 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)) 05:07:40 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)) 05:07:40 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)) 05:07:40 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)) 05:07:40 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)) 05:07:40 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)) 05:07:40 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)) 05:07:40 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)) 05:07:40 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)) 05:07:40 INFO - Cleaning up... 05:07:40 INFO - Return code: 0 05:07:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:07:40 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')]} 05:07:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:40 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')]} 05:07:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:40 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 0x2a94030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d55180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d533b0>, '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 0x2d542b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d54740>, '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': 'cbe409c6de289db6ac707de3000001d4-1468238825.818490-903465473', '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 05:07:40 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 05:07:40 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 05:07:40 INFO - Using env: {'DISPLAY': ':0', 05:07:40 INFO - 'HOME': '/home/cltbld', 05:07:40 INFO - 'LANG': 'en_US.UTF-8', 05:07:40 INFO - 'LANGUAGE': 'en_US:en', 05:07:40 INFO - 'LOGNAME': 'cltbld', 05:07:40 INFO - 'MAIL': '/var/mail/cltbld', 05:07:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:40 INFO - 'MOZ_NO_REMOTE': '1', 05:07:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:40 INFO - 'NO_EM_RESTART': '1', 05:07:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:40 INFO - 'PWD': '/builds/slave/test', 05:07:40 INFO - 'SHELL': '/bin/bash', 05:07:40 INFO - 'SHLVL': '1', 05:07:40 INFO - 'TERM': 'linux', 05:07:40 INFO - 'TMOUT': '86400', 05:07:40 INFO - 'USER': 'cltbld', 05:07:40 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1468238825.818490-903465473', 05:07:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:40 INFO - '_': '/tools/buildbot/bin/python'} 05:07:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:07:40 INFO - Cleaning up... 05:07:40 INFO - Return code: 0 05:07:40 INFO - Running post-action listener: _resource_record_post_action 05:07:40 INFO - Running post-action listener: _start_resource_monitoring 05:07:40 INFO - Starting resource monitoring. 05:07:40 INFO - ##### 05:07:40 INFO - ##### Finished create-virtualenv step (success) 05:07:40 INFO - ##### 05:07:40 INFO - ##### 05:07:40 INFO - ##### Running install step. 05:07:40 INFO - ##### 05:07:40 INFO - Running pre-action listener: _resource_record_pre_action 05:07:40 INFO - Running main action method: install 05:07:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:07:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:07:41 INFO - Reading from file tmpfile_stdout 05:07:41 INFO - Detecting whether we're running mozinstall >=1.0... 05:07:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:07:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:07:41 INFO - Reading from file tmpfile_stdout 05:07:41 INFO - Output received: 05:07:41 INFO - Usage: mozinstall [options] installer 05:07:41 INFO - Options: 05:07:41 INFO - -h, --help show this help message and exit 05:07:41 INFO - -d DEST, --destination=DEST 05:07:41 INFO - Directory to install application into. [default: 05:07:41 INFO - "/builds/slave/test"] 05:07:41 INFO - --app=APP Application being installed. [default: firefox] 05:07:41 INFO - mkdir: /builds/slave/test/build/application 05:07:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:07:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:07:58 INFO - Reading from file tmpfile_stdout 05:07:58 INFO - Output received: 05:07:58 INFO - /builds/slave/test/build/application/firefox/firefox 05:07:58 INFO - Running post-action listener: _resource_record_post_action 05:07:58 INFO - ##### 05:07:58 INFO - ##### Finished install step (success) 05:07:58 INFO - ##### 05:07:58 INFO - ##### 05:07:58 INFO - ##### Running run-tests step. 05:07:58 INFO - ##### 05:07:58 INFO - Running pre-action listener: _resource_record_pre_action 05:07:58 INFO - Running main action method: run_tests 05:07:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:07:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:07:58 INFO - Python 2.7.3 05:07:58 INFO - Return code: 0 05:07:58 INFO - grabbing minidump binary from tooltool 05:07:58 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')]} 05:07:58 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 0x2d533b0>, '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 0x2d542b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d54740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:07:58 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 05:07:58 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 05:07:58 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 05:07:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:07:58 INFO - Return code: 0 05:07:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:07:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:07:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:07:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:07:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:07:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 05:07:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 05:07:58 INFO - Using env: {'DISPLAY': ':0', 05:07:58 INFO - 'HOME': '/home/cltbld', 05:07:58 INFO - 'LANG': 'en_US.UTF-8', 05:07:58 INFO - 'LANGUAGE': 'en_US:en', 05:07:58 INFO - 'LOGNAME': 'cltbld', 05:07:58 INFO - 'MAIL': '/var/mail/cltbld', 05:07:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:07:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:07:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:58 INFO - 'MOZ_NO_REMOTE': '1', 05:07:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:07:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:58 INFO - 'NO_EM_RESTART': '1', 05:07:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:58 INFO - 'PWD': '/builds/slave/test', 05:07:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:07:58 INFO - 'SHELL': '/bin/bash', 05:07:58 INFO - 'SHLVL': '1', 05:07:58 INFO - 'TERM': 'linux', 05:07:58 INFO - 'TMOUT': '86400', 05:07:58 INFO - 'USER': 'cltbld', 05:07:58 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1468238825.818490-903465473', 05:07:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:58 INFO - '_': '/tools/buildbot/bin/python'} 05:07:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 05:07:58 INFO - mozversion application_buildid: 20160711021319 05:07:58 INFO - mozversion application_changeset: 0136b1e24160b1daf36846fb5aaf4a52e6f6d457 05:07:58 INFO - mozversion application_display_name: Nightly 05:07:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:07:58 INFO - mozversion application_name: Firefox 05:07:58 INFO - mozversion application_remotingname: firefox 05:07:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:07:58 INFO - mozversion application_vendor: Mozilla 05:07:58 INFO - mozversion application_version: 50.0a1 05:07:58 INFO - mozversion platform_buildid: 20160711021319 05:07:58 INFO - mozversion platform_changeset: 0136b1e24160b1daf36846fb5aaf4a52e6f6d457 05:07:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:07:58 INFO - mozversion platform_version: 50.0a1 05:07:58 INFO - using testdate: 1468238878 05:07:58 INFO - actual date: 1468238878 05:07:58 INFO - starting webserver on 'localhost:57682' 05:07:58 INFO - SUITE-START | Running 2 tests 05:07:58 INFO - TEST-START | dromaeo_css 05:07:58 INFO - operating with platform_type : linux_ 05:07:58 INFO - Initialising browser for dromaeo_css test... 05:07:58 INFO - TEST-INFO | started process 3047 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEPYveW/profile http://localhost:57682/getInfo.html) 05:08:02 INFO - PROCESS | 3047 | __metrics Screen width/height:1600/1200 05:08:02 INFO - PROCESS | 3047 | colorDepth:24 05:08:02 INFO - PROCESS | 3047 | Browser inner width/height: 1024/697 05:08:02 INFO - PROCESS | 3047 | __metrics 05:08:03 INFO - PROCESS | 3047 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:08:03 INFO - PROCESS | 3047 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:08:04 INFO - TEST-INFO | 3047: exit 0 05:08:04 INFO - Browser initialized. 05:08:04 INFO - Running cycle 1/1 for dromaeo_css test... 05:08:04 INFO - TEST-INFO | started process 3131 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEPYveW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:08:16 INFO - PROCESS | 3131 | RSS: Main: 157310976 05:08:16 INFO - PROCESS | 3131 | 05:09:07 INFO - PROCESS | 3131 | 1468238947854 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] 05:11:15 INFO - PROCESS | 3131 | Cycle 1(1): loaded http://localhost:57682/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57682/tests/dromaeo/cssquery-ext.html) 05:11:17 INFO - PROCESS | 3131 | RSS: Main: 283373568 05:11:17 INFO - PROCESS | 3131 | 05:14:19 INFO - PROCESS | 3131 | Cycle 1(1): loaded http://localhost:57682/tests/dromaeo/cssquery-ext.html (next: http://localhost:57682/tests/dromaeo/cssquery-jquery.html) 05:14:20 INFO - PROCESS | 3131 | RSS: Main: 240558080 05:14:20 INFO - PROCESS | 3131 | 05:17:22 INFO - PROCESS | 3131 | Cycle 1(1): loaded http://localhost:57682/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57682/tests/dromaeo/cssquery-mootools.html) 05:17:22 INFO - PROCESS | 3131 | RSS: Main: 244137984 05:17:22 INFO - PROCESS | 3131 | 05:20:24 INFO - PROCESS | 3131 | Cycle 1(1): loaded http://localhost:57682/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57682/tests/dromaeo/cssquery-prototype.html) 05:20:25 INFO - PROCESS | 3131 | RSS: Main: 235405312 05:20:25 INFO - PROCESS | 3131 | 05:23:28 INFO - PROCESS | 3131 | Cycle 1(1): loaded http://localhost:57682/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57682/tests/dromaeo/cssquery-yui.html) 05:23:28 INFO - PROCESS | 3131 | RSS: Main: 200798208 05:23:28 INFO - PROCESS | 3131 | 05:26:31 INFO - PROCESS | 3131 | Cycle 1(1): loaded http://localhost:57682/tests/dromaeo/cssquery-yui.html (next: http://localhost:57682/tests/dromaeo/cssquery-dojo.html) 05:26:31 INFO - PROCESS | 3131 | RSS: Main: 280567808 05:26:31 INFO - PROCESS | 3131 | 05:26:31 INFO - PROCESS | 3131 | __start_tp_report 05:26:31 INFO - PROCESS | 3131 | _x_x_mozilla_page_load 05:26:31 INFO - PROCESS | 3131 | _x_x_mozilla_page_load_details 05:26:31 INFO - PROCESS | 3131 | |i|pagename|runs| 05:26:31 INFO - PROCESS | 3131 | |0;dojo.html;3013.578099066131;3076.1233048581157;3080.768942329325;3108.502639577668;3125.1562078238876;5222.373315202181;5225.085610018241;5408.864778380543;5505.532029777469;5521.227028216048;5315.7873685052555;5406.59450541209;5431.538319242859;5501.092319767234;5508.944910550893;4865.8783530411665;4872.951270487303;4880.8047678092835;4941.505849415065;5098.413682426512;4997.800087996476;5031.547160755531;5036.194208926554;5037.672551284155;5059.696418214919;4790.257510085942;4803.615710743132;4818.373611430492;4837.637177211724;5020.924686129692;4904.926426103611;4933.777979990909;4934.210526315772;4942.703437793743;4954.777035033432;4889.951100489021;4914.336564563774;4923.679960802537;4934.654574179809;4972.651914365996;5258.526732594047;5277.9971805357245;5501.614886957915;5534.225208470817;5547.25112109864;5692.77228910843;5770.394108618619;5797.942020579782;5803.390643982363;5815.738291776838;5765.452282033242;5790.7104644768015;5793.855153621151;5834.824955251349;5836.503897168745;5223.425423203445;5263.684178949199;5385.8114965976;5410.431904650034;5411.080116380225;6020.247469066367;6051.697415129226;6059.303180134341;6067.302260240041;6071.848203794941;5793.652380857162;5800.071988481823;5807.564432667482;5808.709564521757;5817.0983497557945;5572.3034620672415;5720.713964301768;5747.396523364986;5763.279590051244;5893.764249430061;5765.106408506688;5778.335491418541;5789.594728368974;5790.71046447676;5849.912251316234;5721.742521586539;5754.079347304411;5762;5773.884522309614;5782;4276.5295817460055;4291.2061268664775;4317.56824317572;4380.123975204971;4404.427424434803;3935.2129574084724;3945.270125026879;3963.4847469829315;3977.76133431995;4019.9598004019585;5510.311211098613;5516.668999860021;5520.641158324696;5525.889482210333;5542.085555883315;5630.774769009194;5792.304923409133;5822.970885145547;5831.79588714393;5884.411558844167;5583.888322233533;5586;5589.133684278943;5589.580781441408;5627.887442251132;5065.493450654905;5067.5185857343495;5073.568746656501;5074.188129899272;5124.743762811844;5840.8539786504825;5978.701064946736;5990.6705131218205;6018.21763170785;6100.206973093558;5803.158542011469;5816.796412125555;5819.15622234782;5825.854353641193;5827.79602713903;6024.246969128859;6035.305939816977;6036.667983260787;6043.3050199227655;6043.848903777265;5520.254765606592;5609.298837645294;5623.409541998031;5657.43425657431;5686.289213848269;5790.420957904176;5794.594378393472;5796.304443466811;5797.8550536236935;5798.304203495608;5530.198121272473;5642.60501764889;5654.06707893193;5654.208410822571;5654.688992105309;5668.291463567054;5688.77244910199;5717.685527296038;5745.8563535911935;5755.5683323750045;5641.464060914206;5660.915086273627;5671.064274394678;5676.631018983753;5680.176374425768;5525.143602741581;5586.497215250484;5748.195252664546;5774.989376858949;5840.977828879844;5360.16917377807;5421.5391691706645;5494.697791621339;5549.472800083986;5607.158926160945 05:26:31 INFO - PROCESS | 3131 | |1;ext.html;586.1998372221916;618.0975775367963;634.5209366927969;635.6758053392768;640.2221301119139;31949.201269968235;43957.340639890426;44719.55280447195;44770.552294477086;44841.32738008932;46776;47107.52892471074;47224.291635625494;47257.52742472574;47284.76357618207;8955.149260820212;9077.36458447909;9093.318001149908;9097.090290970917;9106.772330691752;8970.955145224265;9052;9061.184493395593;9064.410813297147;9077.409968352036;9127.817443651124;9180.770480738001;9189.678361257358;9190.035046320141;9199.632014719404;9060.818783624323;9093.77265568366;9103.681371151977;9111.544422778901;9112.271018318519;8760.912390876074;8821.691240806542;8825.161609647073;8825.691100811506;8828.337874659426;42653.78673106646;42667.35998960018;42747.78626106881;43003.569964300266;43186;3666.853325866962;3731.0858839584203;3734.850605975758;3776.093737503007;3833.3483307837732;32740.181495462803;32883.3423331532;33438.33123337544;33462.6653733462;33742.493862592084;4304.182205380967;4352.151330490556;4405.427294451732;4418.182636212311;4503.707259028152;350669;350751;351755;351767;353461;58103.41896581065;58139.127913081335;58393;58552.41447585555;58643;53731.19403208955;57797.42202578005;58781.415765502206;58905.70547147237;65398;16874.578135546464;17094.57263568396;17154.31382744701;17157.142142892804;17167.57081072983;11438.714032149097;12275.57035503771;12275.754484910252;12279.631611051684;12285.57000504996;16127.919360403122;16566.917165414336;16613.91693041527;16900.661986760195;17093.743593846102;6436.131122298523;6468.6442245676;6478.562184903356;6525.249596296392;6571.868562628721;999.2954966748425;1007.1087087927237;1086.538221255963;1093.830456279278;1096.629213483146;32549;32769.67230327714;33127.17182070419;33212;33455.16362090967;1079.7624522605015;1097.5006372100675;1112.7162573543694;1157.3287493253893;1208.4199584199635;16366.672666546841;17203.827961720224;17278.308867645406;17345;17405.47783566495;527649;530256;532831;532871;532960;59639.701801490715;59822.40177598255;59900;59900.10149847756;59921;1238.0900038471716;1327.9933600331935;1330.3215360166384;1358.1375826350338;1393.6794537256487;32011.35977280488;33590.83204583961;33688.32623347568;33753.49369759505;34357.31285374228;51527.74236128795;55029;57209.42790572041;57292.713536433715;61616.38383616106;472648;475118;479626;480385;480410;24787.752122478545;27139.82881369525;27484.58773118445;27675.308117296423;28041.43917121687;49279.07209279187;49989.500104998486;50466.49533504618;50696;51054;40860.13979021559;42695.35956960586;42866.5713342875;43364.56635433605;43803.34294985514;40609;41024;41285.38071928863;42022.36966445445;42053.36919946264;41798;42806.571934280255;42813;43040.784796077074;43176;35898;37044.25911481701;37348.06629834276;38016.619833801306;38156.2368752629;28457;28884;28982.565261521515;29003.41993160167;29103.272418188866 05:26:31 INFO - PROCESS | 3131 | |2;jquery.html;387.94568760373545;394.9980250098749;397.1679331799878;399.75015615240477;415.67369614852345;13138.243538855502;18288.26846926123;20060.097295621694;20061.99999999998;20081.297154599593;14518.12891226527;18170.72743908839;18631.53421164468;19462.318818841344;19864.304749333776;5763.711814409284;5905.4980326672285;5914.112883067532;5934.080217566284;5946.375630558772;5739;5800.15897694834;5811.099279611646;5811.941880581204;5831.5626328025355;4063.2686116499017;6232.439080482755;6545.770898018571;6561.114249576318;6573.408393244607;6408.67956602168;6517.967410162966;6537.509686773511;6540.182477190351;6565.573237739532;5749.051406517961;5755.107958266433;5771.451712087345;5782.9421705782825;5786.392428795;22153.224637137784;23205.88397058021;23703.76296237033;24053.15813946521;24157.87921060401;2340.8010319122895;2507.398224426143;2531.5696331623667;2966.792324537283;3204.118867311485;13525.256110913895;14085;14398.424063037466;15042.172680502568;15099.54701358961;1913.4164079955608;1921;1931.420573827846;2029.8680585761879;2032.298856894369;51866.48133518692;51983.48016519862;53172;53173;79449.60275198644;10409.230430826627;10451;10678.1991350649;10847.566097356017;10866.293690910066;14979;15076.849231507764;15109.093454392772;15111.4710985115;15114.470993515175;7525.172231054579;7778.261065198797;7800.882986755203;7846.882296765553;7866.134725180225;7295.562266264041;7361.889571656429;7403.481756277117;7492.737754178577;7535.660895259726;5896.498797602252;6151.415615516519;6160.9383906161265;6588.374104460068;6691.59850408977;1775.5042075499882;1832.166364304265;1889.3292881027312;1973.3093417304117;1998.3904909002895;904.7421484876778;991.9900800991898;1023.6263763726336;1045.2892033417197;1052.768390953989;18287.542811429554;19714.408567742703;19819.405417837486;19862.801371986094;20074;1005.5776573839005;1018.7758693087509;1026.7946410717886;1030.8144533983955;1041.2555023158477;10857.945710271557;11212.66362009141;11235.83146252807;11248.26886252391;11284.492197851116;453764;458819;477537;481578;486973;84619.13770785597;84768;86407;86567.56716216379;86741;1015.5430056474615;1022.9079382855579;1039.3555995282973;1040.484959944832;1043.6451606453843;17210.31158753636;17260.568485787957;17617.559561011076;17638.38265660696;17957;39686.60313396829;39935.80032099821;40004.1999160021;41832.79083604563;42821.78589107034;52842.73578632082;55318.44681553294;55464.16803747867;55490;55498.16752748793;8719.651213951625;8802.29581633455;8911.821763564563;9063.592138353659;9125.5437228137;10328.483575821028;13478.66303342385;13609.863901360859;13753.931230343784;13899;12043.397830108635;12045.879541204476;12136.393180341125;12154.209976351509;12260.816087758512;11603;11788.23376480526;11921.761564768829;12061.879381206076;12145.210561313486;11665.183437159318;12418;12439.129260951646;12474.313912734886;12613.936930315289;8459.703910363107;8466.74599762008;8481.491110533389;8533.829323413622;8655.3508486865;11366.659000230007;12001.939990299992;12083.275003499819;12253.081018923438;12346.876531234573 05:26:31 INFO - PROCESS | 3131 | |3;mootools.html;1350.6015725361017;1459.5110637936293;1520.7946927164833;1630.494546690526;1768.177797324244;8172.754817355474;8492.532910689917;8499.065102838682;8686.174813392734;8688.261497772697;8511.914880851189;8686.218240358367;8705.738827835175;8719.738407847759;8722.956385218065;2043.274637503687;2313.9190128345513;2353.635186546088;2378.369732021016;2385.3917251100943;2429.720582133051;2437.890294936732;2442.8167887408426;2442.926712198628;2443.780059794618;2338.7895089441945;2372.193454225563;2395.4969456414174;2397.808175345977;2398.5322862041908;1937.9127939242696;2198.4613769626385;2218.534107837348;2267.025179172955;2274.2608652188105;2340.8010319122895;2342.9179978700836;2357.446000189954;2363.6809030780796;2365.184011516041;9182.173604375572;9210.49342286174;9216.677416290398;9231.399959002643;9235.907640923571;5147.639665223436;5359.22291267764;5398.055340315468;5399.136138217906;5409.350877894639;3384.7122994545493;3495.24852156785;3546.078019714893;3578.4095624221973;3578.5169002184634;1116.8994790468817;1138.908887289015;1140.6235942139074;1142.2232881640482;1153.1524329617723;12675.873241267469;12753.936230318881;12763.042771792152;12763.936180319131;12769.87230127696;4535.478419981744;4730.597899178609;4797.160496913027;4809.495003024632;4826.7827947742435;10661.733456663645;10695.679129626124;10698.090662293636;10698.304610200312;10715.089217416451;5352;5356.357237131491;5356.625036247503;5356.839294821161;5359.410464848864;4204.3903633972905;4718.740469274223;4897.877553061202;4903.53416425439;4987.476314986874;4102.712810103324;4116.45834892599;4182.602652747984;4183.867894569734;4212.389203565527;1108.933463992163;1284.3770771175973;1284.6017734502334;1290;1294.799306107555;876.8640860666607;952.8237276103943;965.6378857928277;967.2842096848423;988.5452691761726;5713.257276554022;5762.711864406763;5947.49446297061;5993.310769261503;6051.76522308209;931.469062634292;940.9320421321712;969.6509256667593;979.1921664626711;992.3549692699659;4149.896252593649;4175.728577642443;4182.7490350578455;4210.894727631834;4214.1150358425075;10459.110975567162;10883.23817332779;10937.234393592531;10946.507407166697;10947.50736216872;10772.192085593455;10785.13718902486;10789.56841726338;10797.56809727602;10807.40559269232;7778.611069446505;8085.757427277191;8090.7168249111;8090.797730056795;8202.425830191829;6068.908966365596;6187.133801267736;6195.690215489298;6306.810795676137;6316.021016742412;10326.328788628714;10584.153267738408;10659.46702664848;10705.090067344363;10707.089897358812;10382.584696612052;10499.842502362319;10627.468626568796;10832;11096;6994.510384273052;7876.803079923047;8083.312918402002;8120.066192387951;8243.505389676639;8950.23922966529;8976;9033;9037.412568183046;9046.185843274137;7378.372838308804;7561.810954726176;7595.734149304748;7610.277023682741;7852.254035866584;7526.698932042876;7669.424793140425;7698.422618303762;7752.26353496417;7780.1052878919645;7370.5946172961;7393.630318484162;7430.294122058396;7434;7434.59109748969;5269.710165940756;5345.1447768356875;5431.4840090191365;5481.342238931354;5482.150266708507;5316.920246196233;5447.319085114361;5458.153986132156;5505.614606977473;5530.364008138955 05:26:31 INFO - PROCESS | 3131 | |4;prototype.html;330.33743679398816;337.05624252094134;343.22773759042155;343.8572992208234;344.0607142500971;5273.34083239595;5370.113931201347;5370.221317908906;5370.570354371651;5410.972945135279;5013.598912087034;5141.974290128554;5143.27994080829;5184.53339199472;5329.946700532993;3997.480327557428;4046.0896298332787;4127.772972486512;4137;4181.770002649853;4128.814203360856;4156.750594964312;4164.791760411982;4166.8749937501925;4171.707980441371;4073.226087043467;4092.774897380643;4134.379843023556;4143.34266293482;4147.709660323779;4080.3471444569022;4100.466939297902;4122.237386083569;4152;4161.9375709364385;3698.815059247054;3717.5724791649036;3726.795026273554;3733.8879833605033;3735.0662334416397;5080.187170052811;5209.973950130225;5235.240890070956;5258.264772625024;5269.815556455544;4765.404324459442;4774.594159496447;4784.138855006097;4805.663603547753;4826.155422801031;5451.972740136274;5467.480589344006;5478.315210598676;5478.835634930959;5552.222688823568;4003.719739618228;4077.225327187825;4102.405151253081;4108.979455102705;4113.506379234481;5719.313682358102;5724.284464441903;5727.9427205727825;5742.196092547047;5789.855253618651;4191.497020357577;4193.874183774492;4200.831966721297;4203.6637069034405;4223.598758117974;4102.425660407545;4270.871873843789;4274.6793990450215;4277.550857159953;4279.636230920344;4709.128811169944;4720.173969555314;4728.739919304471;4742.770897678086;4772.546608072227;5453.836384908459;5486.753096110685;5500.669959802424;5526.889462210734;5579.972100139474;1352.1481466676128;1372.108129715673;1431.9427222911174;1447.4572035486692;1451.5137428961204;970.9368891022202;990.7424069741775;992.6327258914248;1004.4475538453967;1006.5470538257813;5264.263003179558;5305.708186049805;5320;5343.332083489564;5388.973055134699;5601.663900166003;5618;5626.662400255997;5632;5678.346990096192;5125.820596279187;5277.366715994105;5322.121849894724;5330.147176451749;5339.46605339463;2649.244965184913;2650.204938518437;2683.6511253536914;2702.2705468500176;2702.581099929475;5135.255387968724;5163.715995620277;5199.454057324002;5256.109139973076;5588.189712491666;5814.244148260699;5837.970810145922;5841.153032810219;5844.912326315109;5868.918817620698;5918.763249469973;5931.673757943268;5934.495567876693;5948.791792287249;6002.969985150046;5539.534906966362;5734.7132643368495;5745.942540574708;5757.65454072757;5792.189093526994;5637.689927053887;5675.65136569426;5684.9431505684415;5690.772369105355;5709.743061562157;5668.858278542904;5967.582269241111;5968.671723055274;5979.820605381846;5980.491658209101;3796.4495148202805;4034.3545032794614;4035.7780322081394;4045.7370270932297;4048.7246517346944;5574.721263936706;5720.6853623049465;5748.425157484218;5792.855178620568;5836.890990711751;5608.635438696471;5655.151727240782;5661.547076233974;5668.178114173505;5692.6299790513485;5249.317588713596;5560.666360018412;5571.498565129158;5589.245451864109;5657.547396208376;5507.557776389756;5514.255575497417;5533.142362933751;5535.16972454119;5550.333959924835;5659.943400565941;5683;5690.231818704422;5696.401877802771;5722.570807189561;5232.5552328052545;5502.174673798962;5510.421405752499;5512.200730894078;5529.640573362719 05:26:31 INFO - PROCESS | 3131 | |5;yui.html;745.8997977982475;788.0661416221774;802.9116797152312;805.5569436809755;870.5516658920653;15406.460773872917;16026.919865400685;16033.118178500177;16033.83966160338;16052.277647505847;15072.39710411585;15233;15237.771433428508;15248.618784530392;15264.923675381635;657.2704298228962;778.8014056415606;789.9723509677162;801.5751651624648;808.3210103513048;802.229859335039;804.2279411764683;805.4522924411398;805.4724155678011;809.9149589293128;850.1795767084762;850.7660393391805;851.8296340731879;852.7058164933088;852.9147085291484;686.204003356107;837.0917554453395;845.71245776436;857.3698331726176;860.1140824950311;625.1841347042108;627.269231345482;627.3945642455008;628.5443053786014;630.483003936772;14969.850301496954;14984.250787460693;15006;15034.548963531111;15053;14247.216403097826;14326.283685815668;14331.713365732627;14349.78475322871;14429.567112986628;12736.936315318457;13178.406971686298;13195.736085278337;13244.668883277898;13433.798493022612;4401.339799030171;4459.464864216315;4462.7991740371435;4511.052678937427;4572.513932971798;73613.63193184053;76650.61674691591;76685.61657191678;76722.61638691771;79027.20972790256;11598.826017609743;11976.88023119775;12032.518699251932;12222.694432639255;12241.571544995883;21546.353609391743;21692.89153554222;21693.24073657446;21698.783012169675;21701.565968680537;8299.792505187419;8748.91251087481;8770.429922055046;8779.473231606124;9031.77420564478;4578.45058592971;4732.432108147044;4744.69159504638;4853.12643724126;4963.429205641398;3461.8615255390005;3564.091156755063;3574.5174401455993;3577.94633080504;3579.2483578448296;642.9196350456193;661.1075048684334;661.7253839656489;681.7647911470535;685.9725610975605;669.7454967112466;698.4447364345358;727.5634619228421;759.4342215049713;764.5489161394804;9883.851742223873;10014;10565.366078035342;10587;10830.40432776205;746.2388363868823;754.6415452659943;771.9459637825411;773.0568706178453;786.1384560200873;4661.184292748755;4795.352627395257;4832.855014349575;4872.829450969199;4924.359833221658;125157.37421312835;125575;127698;129840;131403.34298328447;115643;118364.40817795855;119005;119645.40177299232;119913;96333;96622;97273.51363243138;97395;98241;9296.58165382573;9318.627254909728;9340.579673914826;9428.340016198801;9524.095210954949;50827.49172508228;56611.85705226464;57802.71098644648;58321.4167858316;58636.706816465645;64078.67960660167;69675.65162174156;69959.65020174866;74983.62639175731;84640.57679711809;14141.717165656835;14273.286335682966;14609.92695036518;14806.703865922405;15234.847651523343;15186.696266074396;15506.689866202838;15575.532734017997;15883.444079457164;16581.336746530487;14376.640583985065;14659.267036648338;14785.334659940543;14808.925955370585;15165;14792.260386980823;14813.629659258604;14849;14970.326335315154;15059.247037648292;14410.495632653226;14596.489122880648;14869;14887.844244128808;14898.925505372405;11876.881231187577;11898.345590992578;12066.276023438622;12121.090918180995;12140.93929530382;12278;12304.692382690504;12366.134370593973;12505.56230531927;12600 05:26:31 INFO - PROCESS | 3131 | __end_tp_report 05:26:31 INFO - PROCESS | 3131 | __start_cc_report 05:26:31 INFO - PROCESS | 3131 | _x_x_mozilla_cycle_collect,1070 05:26:31 INFO - PROCESS | 3131 | __end_cc_report 05:26:31 INFO - PROCESS | 3131 | __startTimestamp1468239991714__endTimestamp 05:26:31 INFO - PROCESS | 3131 | 05:26:31 INFO - PROCESS | 3131 | ------- Summary: start ------- 05:26:31 INFO - PROCESS | 3131 | Number of tests: 6 05:26:31 INFO - PROCESS | 3131 | 05:26:31 INFO - PROCESS | 3131 | [#0] dojo.html Cycles:165 Average:5388.06 Median:5589.58 stddev:625.53 (11.2%) stddev-sans-first:599.07 05:26:31 INFO - PROCESS | 3131 | Values: 3013.6 3076.1 3080.8 3108.5 3125.2 5222.4 5225.1 5408.9 5505.5 5521.2 5315.8 5406.6 5431.5 5501.1 5508.9 4865.9 4873.0 4880.8 4941.5 5098.4 4997.8 5031.5 5036.2 5037.7 5059.7 4790.3 4803.6 4818.4 4837.6 5020.9 4904.9 4933.8 4934.2 4942.7 4954.8 4890.0 4914.3 4923.7 4934.7 4972.7 5258.5 5278.0 5501.6 5534.2 5547.3 5692.8 5770.4 5797.9 5803.4 5815.7 5765.5 5790.7 5793.9 5834.8 5836.5 5223.4 5263.7 5385.8 5410.4 5411.1 6020.2 6051.7 6059.3 6067.3 6071.8 5793.7 5800.1 5807.6 5808.7 5817.1 5572.3 5720.7 5747.4 5763.3 5893.8 5765.1 5778.3 5789.6 5790.7 5849.9 5721.7 5754.1 5762.0 5773.9 5782.0 4276.5 4291.2 4317.6 4380.1 4404.4 3935.2 3945.3 3963.5 3977.8 4020.0 5510.3 5516.7 5520.6 5525.9 5542.1 5630.8 5792.3 5823.0 5831.8 5884.4 5583.9 5586.0 5589.1 5589.6 5627.9 5065.5 5067.5 5073.6 5074.2 5124.7 5840.9 5978.7 5990.7 6018.2 6100.2 5803.2 5816.8 5819.2 5825.9 5827.8 6024.2 6035.3 6036.7 6043.3 6043.8 5520.3 5609.3 5623.4 5657.4 5686.3 5790.4 5794.6 5796.3 5797.9 5798.3 5530.2 5642.6 5654.1 5654.2 5654.7 5668.3 5688.8 5717.7 5745.9 5755.6 5641.5 5660.9 5671.1 5676.6 5680.2 5525.1 5586.5 5748.2 5775.0 5841.0 5360.2 5421.5 5494.7 5549.5 5607.2 05:26:31 INFO - PROCESS | 3131 | 05:26:31 INFO - PROCESS | 3131 | [#1] ext.html Cycles:180 Average:61760.64 Median:23672.48 stddev:121904.13 (515.0%) stddev-sans-first:122159.57 05:26:31 INFO - PROCESS | 3131 | Values: 586.2 618.1 634.5 635.7 640.2 31949.2 43957.3 44719.6 44770.6 44841.3 46776.0 47107.5 47224.3 47257.5 47284.8 8955.1 9077.4 9093.3 9097.1 9106.8 8971.0 9052.0 9061.2 9064.4 9077.4 9127.8 9180.8 9189.7 9190.0 9199.6 9060.8 9093.8 9103.7 9111.5 9112.3 8760.9 8821.7 8825.2 8825.7 8828.3 42653.8 42667.4 42747.8 43003.6 43186.0 3666.9 3731.1 3734.9 3776.1 3833.3 32740.2 32883.3 33438.3 33462.7 33742.5 4304.2 4352.2 4405.4 4418.2 4503.7 350669.0 350751.0 351755.0 351767.0 353461.0 58103.4 58139.1 58393.0 58552.4 58643.0 53731.2 57797.4 58781.4 58905.7 65398.0 16874.6 17094.6 17154.3 17157.1 17167.6 11438.7 12275.6 12275.8 12279.6 12285.6 16127.9 16566.9 16613.9 16900.7 17093.7 6436.1 6468.6 6478.6 6525.2 6571.9 999.3 1007.1 1086.5 1093.8 1096.6 32549.0 32769.7 33127.2 33212.0 33455.2 1079.8 1097.5 1112.7 1157.3 1208.4 16366.7 17203.8 17278.3 17345.0 17405.5 527649.0 530256.0 532831.0 532871.0 532960.0 59639.7 59822.4 59900.0 59900.1 59921.0 1238.1 1328.0 1330.3 1358.1 1393.7 32011.4 33590.8 33688.3 33753.5 34357.3 51527.7 55029.0 57209.4 57292.7 61616.4 472648.0 475118.0 479626.0 480385.0 480410.0 24787.8 27139.8 27484.6 27675.3 28041.4 49279.1 49989.5 50466.5 50696.0 51054.0 40860.1 42695.4 42866.6 43364.6 43803.3 40609.0 41024.0 41285.4 42022.4 42053.4 41798.0 42806.6 42813.0 43040.8 43176.0 35898.0 37044.3 37348.1 38016.6 38156.2 28457.0 28884.0 28982.6 29003.4 29103.3 05:26:31 INFO - PROCESS | 3131 | 05:26:31 INFO - PROCESS | 3131 | [#2] jquery.html Cycles:180 Average:27774.68 Median:13022.28 stddev:77371.56 (594.1%) stddev-sans-first:77561.28 05:26:31 INFO - PROCESS | 3131 | Values: 387.9 395.0 397.2 399.8 415.7 13138.2 18288.3 20060.1 20062.0 20081.3 14518.1 18170.7 18631.5 19462.3 19864.3 5763.7 5905.5 5914.1 5934.1 5946.4 5739.0 5800.2 5811.1 5811.9 5831.6 4063.3 6232.4 6545.8 6561.1 6573.4 6408.7 6518.0 6537.5 6540.2 6565.6 5749.1 5755.1 5771.5 5782.9 5786.4 22153.2 23205.9 23703.8 24053.2 24157.9 2340.8 2507.4 2531.6 2966.8 3204.1 13525.3 14085.0 14398.4 15042.2 15099.5 1913.4 1921.0 1931.4 2029.9 2032.3 51866.5 51983.5 53172.0 53173.0 79449.6 10409.2 10451.0 10678.2 10847.6 10866.3 14979.0 15076.8 15109.1 15111.5 15114.5 7525.2 7778.3 7800.9 7846.9 7866.1 7295.6 7361.9 7403.5 7492.7 7535.7 5896.5 6151.4 6160.9 6588.4 6691.6 1775.5 1832.2 1889.3 1973.3 1998.4 904.7 992.0 1023.6 1045.3 1052.8 18287.5 19714.4 19819.4 19862.8 20074.0 1005.6 1018.8 1026.8 1030.8 1041.3 10857.9 11212.7 11235.8 11248.3 11284.5 453764.0 458819.0 477537.0 481578.0 486973.0 84619.1 84768.0 86407.0 86567.6 86741.0 1015.5 1022.9 1039.4 1040.5 1043.6 17210.3 17260.6 17617.6 17638.4 17957.0 39686.6 39935.8 40004.2 41832.8 42821.8 52842.7 55318.4 55464.2 55490.0 55498.2 8719.7 8802.3 8911.8 9063.6 9125.5 10328.5 13478.7 13609.9 13753.9 13899.0 12043.4 12045.9 12136.4 12154.2 12260.8 11603.0 11788.2 11921.8 12061.9 12145.2 11665.2 12418.0 12439.1 12474.3 12613.9 8459.7 8466.7 8481.5 8533.8 8655.4 11366.7 12001.9 12083.3 12253.1 12346.9 05:26:31 INFO - PROCESS | 3131 | 05:26:31 INFO - PROCESS | 3131 | [#3] mootools.html Cycles:180 Average:5912.90 Median:4818.14 stddev:3371.92 (70.0%) stddev-sans-first:3363.94 05:26:31 INFO - PROCESS | 3131 | Values: 1350.6 1459.5 1520.8 1630.5 1768.2 8172.8 8492.5 8499.1 8686.2 8688.3 8511.9 8686.2 8705.7 8719.7 8723.0 2043.3 2313.9 2353.6 2378.4 2385.4 2429.7 2437.9 2442.8 2442.9 2443.8 2338.8 2372.2 2395.5 2397.8 2398.5 1937.9 2198.5 2218.5 2267.0 2274.3 2340.8 2342.9 2357.4 2363.7 2365.2 9182.2 9210.5 9216.7 9231.4 9235.9 5147.6 5359.2 5398.1 5399.1 5409.4 3384.7 3495.2 3546.1 3578.4 3578.5 1116.9 1138.9 1140.6 1142.2 1153.2 12675.9 12753.9 12763.0 12763.9 12769.9 4535.5 4730.6 4797.2 4809.5 4826.8 10661.7 10695.7 10698.1 10698.3 10715.1 5352.0 5356.4 5356.6 5356.8 5359.4 4204.4 4718.7 4897.9 4903.5 4987.5 4102.7 4116.5 4182.6 4183.9 4212.4 1108.9 1284.4 1284.6 1290.0 1294.8 876.9 952.8 965.6 967.3 988.5 5713.3 5762.7 5947.5 5993.3 6051.8 931.5 940.9 969.7 979.2 992.4 4149.9 4175.7 4182.7 4210.9 4214.1 10459.1 10883.2 10937.2 10946.5 10947.5 10772.2 10785.1 10789.6 10797.6 10807.4 7778.6 8085.8 8090.7 8090.8 8202.4 6068.9 6187.1 6195.7 6306.8 6316.0 10326.3 10584.2 10659.5 10705.1 10707.1 10382.6 10499.8 10627.5 10832.0 11096.0 6994.5 7876.8 8083.3 8120.1 8243.5 8950.2 8976.0 9033.0 9037.4 9046.2 7378.4 7561.8 7595.7 7610.3 7852.3 7526.7 7669.4 7698.4 7752.3 7780.1 7370.6 7393.6 7430.3 7434.0 7434.6 5269.7 5345.1 5431.5 5481.3 5482.2 5316.9 5447.3 5458.2 5505.6 5530.4 05:26:31 INFO - PROCESS | 3131 | 05:26:31 INFO - PROCESS | 3131 | [#4] prototype.html Cycles:180 Average:4676.26 Median:5291.54 stddev:1376.51 (26.0%) stddev-sans-first:1341.17 05:26:31 INFO - PROCESS | 3131 | Values: 330.3 337.1 343.2 343.9 344.1 5273.3 5370.1 5370.2 5370.6 5411.0 5013.6 5142.0 5143.3 5184.5 5329.9 3997.5 4046.1 4127.8 4137.0 4181.8 4128.8 4156.8 4164.8 4166.9 4171.7 4073.2 4092.8 4134.4 4143.3 4147.7 4080.3 4100.5 4122.2 4152.0 4161.9 3698.8 3717.6 3726.8 3733.9 3735.1 5080.2 5210.0 5235.2 5258.3 5269.8 4765.4 4774.6 4784.1 4805.7 4826.2 5452.0 5467.5 5478.3 5478.8 5552.2 4003.7 4077.2 4102.4 4109.0 4113.5 5719.3 5724.3 5727.9 5742.2 5789.9 4191.5 4193.9 4200.8 4203.7 4223.6 4102.4 4270.9 4274.7 4277.6 4279.6 4709.1 4720.2 4728.7 4742.8 4772.5 5453.8 5486.8 5500.7 5526.9 5580.0 1352.1 1372.1 1431.9 1447.5 1451.5 970.9 990.7 992.6 1004.4 1006.5 5264.3 5305.7 5320.0 5343.3 5389.0 5601.7 5618.0 5626.7 5632.0 5678.3 5125.8 5277.4 5322.1 5330.1 5339.5 2649.2 2650.2 2683.7 2702.3 2702.6 5135.3 5163.7 5199.5 5256.1 5588.2 5814.2 5838.0 5841.2 5844.9 5868.9 5918.8 5931.7 5934.5 5948.8 6003.0 5539.5 5734.7 5745.9 5757.7 5792.2 5637.7 5675.7 5684.9 5690.8 5709.7 5668.9 5967.6 5968.7 5979.8 5980.5 3796.4 4034.4 4035.8 4045.7 4048.7 5574.7 5720.7 5748.4 5792.9 5836.9 5608.6 5655.2 5661.5 5668.2 5692.6 5249.3 5560.7 5571.5 5589.2 5657.5 5507.6 5514.3 5533.1 5535.2 5550.3 5659.9 5683.0 5690.2 5696.4 5722.6 5232.6 5502.2 5510.4 5512.2 5529.6 05:26:31 INFO - PROCESS | 3131 | 05:26:31 INFO - PROCESS | 3131 | [#5] yui.html Cycles:180 Average:22463.73 Median:4461.13 stddev:33240.73 (745.1%) stddev-sans-first:33293.98 05:26:31 INFO - PROCESS | 3131 | Values: 745.9 788.1 802.9 805.6 870.6 15406.5 16026.9 16033.1 16033.8 16052.3 15072.4 15233.0 15237.8 15248.6 15264.9 657.3 778.8 790.0 801.6 808.3 802.2 804.2 805.5 805.5 809.9 850.2 850.8 851.8 852.7 852.9 686.2 837.1 845.7 857.4 860.1 625.2 627.3 627.4 628.5 630.5 14969.9 14984.3 15006.0 15034.5 15053.0 14247.2 14326.3 14331.7 14349.8 14429.6 12736.9 13178.4 13195.7 13244.7 13433.8 4401.3 4459.5 4462.8 4511.1 4572.5 73613.6 76650.6 76685.6 76722.6 79027.2 11598.8 11976.9 12032.5 12222.7 12241.6 21546.4 21692.9 21693.2 21698.8 21701.6 8299.8 8748.9 8770.4 8779.5 9031.8 4578.5 4732.4 4744.7 4853.1 4963.4 3461.9 3564.1 3574.5 3577.9 3579.2 642.9 661.1 661.7 681.8 686.0 669.7 698.4 727.6 759.4 764.5 9883.9 10014.0 10565.4 10587.0 10830.4 746.2 754.6 771.9 773.1 786.1 4661.2 4795.4 4832.9 4872.8 4924.4 125157.4 125575.0 127698.0 129840.0 131403.3 115643.0 118364.4 119005.0 119645.4 119913.0 96333.0 96622.0 97273.5 97395.0 98241.0 9296.6 9318.6 9340.6 9428.3 9524.1 50827.5 56611.9 57802.7 58321.4 58636.7 64078.7 69675.7 69959.7 74983.6 84640.6 14141.7 14273.3 14609.9 14806.7 15234.8 15186.7 15506.7 15575.5 15883.4 16581.3 14376.6 14659.3 14785.3 14808.9 15165.0 14792.3 14813.6 14849.0 14970.3 15059.2 14410.5 14596.5 14869.0 14887.8 14898.9 11876.9 11898.3 12066.3 12121.1 12140.9 12278.0 12304.7 12366.1 12505.6 12600.0 05:26:31 INFO - PROCESS | 3131 | -------- Summary: end -------- 05:26:31 INFO - PROCESS | 3131 | 05:26:32 INFO - TEST-INFO | 3131: exit 0 05:26:32 INFO - TEST-OK | dromaeo_css | took 1113909ms 05:26:32 INFO - TEST-START | kraken 05:26:32 INFO - operating with platform_type : linux_ 05:26:32 INFO - Initialising browser for kraken test... 05:26:32 INFO - TEST-INFO | started process 3323 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2OG4x6/profile http://localhost:57682/getInfo.html) 05:26:36 INFO - PROCESS | 3323 | __metrics Screen width/height:1600/1200 05:26:36 INFO - PROCESS | 3323 | colorDepth:24 05:26:36 INFO - PROCESS | 3323 | Browser inner width/height: 1024/697 05:26:36 INFO - PROCESS | 3323 | __metrics 05:26:37 INFO - PROCESS | 3323 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:26:37 INFO - PROCESS | 3323 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:26:38 INFO - TEST-INFO | 3323: exit 0 05:26:38 INFO - Browser initialized. 05:26:38 INFO - Running cycle 1/1 for kraken test... 05:26:38 INFO - TEST-INFO | started process 3405 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2OG4x6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:26:50 INFO - PROCESS | 3405 | RSS: Main: 157306880 05:26:50 INFO - PROCESS | 3405 | 05:26:52 INFO - PROCESS | 3405 | Cycle 1(1): loaded http://localhost:57682/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57682/tests/kraken/driver.html?testName=audio-beat-detection) 05:26:53 INFO - PROCESS | 3405 | RSS: Main: 215711744 05:26:53 INFO - PROCESS | 3405 | 05:26:56 INFO - PROCESS | 3405 | Cycle 1(1): loaded http://localhost:57682/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57682/tests/kraken/driver.html?testName=audio-dft) 05:26:56 INFO - PROCESS | 3405 | RSS: Main: 203419648 05:26:56 INFO - PROCESS | 3405 | 05:26:59 INFO - PROCESS | 3405 | Cycle 1(1): loaded http://localhost:57682/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57682/tests/kraken/driver.html?testName=audio-fft) 05:27:00 INFO - PROCESS | 3405 | RSS: Main: 269430784 05:27:00 INFO - PROCESS | 3405 | 05:27:02 INFO - PROCESS | 3405 | Cycle 1(1): loaded http://localhost:57682/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57682/tests/kraken/driver.html?testName=audio-oscillator) 05:27:03 INFO - PROCESS | 3405 | RSS: Main: 180981760 05:27:03 INFO - PROCESS | 3405 | 05:27:05 INFO - PROCESS | 3405 | Cycle 1(1): loaded http://localhost:57682/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57682/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:27:05 INFO - PROCESS | 3405 | RSS: Main: 184193024 05:27:05 INFO - PROCESS | 3405 | 05:27:08 INFO - PROCESS | 3405 | Cycle 1(1): loaded http://localhost:57682/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57682/tests/kraken/driver.html?testName=imaging-darkroom) 05:27:09 INFO - PROCESS | 3405 | RSS: Main: 218845184 05:27:09 INFO - PROCESS | 3405 | 05:27:12 INFO - PROCESS | 3405 | Cycle 1(1): loaded http://localhost:57682/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57682/tests/kraken/driver.html?testName=imaging-desaturate) 05:27:13 INFO - PROCESS | 3405 | RSS: Main: 220868608 05:27:13 INFO - PROCESS | 3405 | 05:27:16 INFO - PROCESS | 3405 | Cycle 1(1): loaded http://localhost:57682/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57682/tests/kraken/driver.html?testName=json-parse-financial) 05:27:16 INFO - PROCESS | 3405 | RSS: Main: 221413376 05:27:16 INFO - PROCESS | 3405 | 05:27:18 INFO - PROCESS | 3405 | Cycle 1(1): loaded http://localhost:57682/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57682/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:27:18 INFO - PROCESS | 3405 | RSS: Main: 209367040 05:27:18 INFO - PROCESS | 3405 | 05:27:20 INFO - PROCESS | 3405 | Cycle 1(1): loaded http://localhost:57682/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57682/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:27:21 INFO - PROCESS | 3405 | RSS: Main: 212283392 05:27:21 INFO - PROCESS | 3405 | 05:27:23 INFO - PROCESS | 3405 | Cycle 1(1): loaded http://localhost:57682/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57682/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:27:23 INFO - PROCESS | 3405 | RSS: Main: 209793024 05:27:23 INFO - PROCESS | 3405 | 05:27:26 INFO - PROCESS | 3405 | Cycle 1(1): loaded http://localhost:57682/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57682/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:27:27 INFO - PROCESS | 3405 | RSS: Main: 223703040 05:27:27 INFO - PROCESS | 3405 | 05:27:29 INFO - PROCESS | 3405 | Cycle 1(1): loaded http://localhost:57682/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57682/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:27:30 INFO - PROCESS | 3405 | RSS: Main: 225259520 05:27:30 INFO - PROCESS | 3405 | 05:27:32 INFO - PROCESS | 3405 | Cycle 1(1): loaded http://localhost:57682/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57682/tests/kraken/driver.html?testName=ai-astar) 05:27:32 INFO - PROCESS | 3405 | RSS: Main: 267358208 05:27:32 INFO - PROCESS | 3405 | 05:27:32 INFO - PROCESS | 3405 | __start_tp_report 05:27:32 INFO - PROCESS | 3405 | _x_x_mozilla_page_load 05:27:32 INFO - PROCESS | 3405 | _x_x_mozilla_page_load_details 05:27:32 INFO - PROCESS | 3405 | |i|pagename|runs| 05:27:32 INFO - PROCESS | 3405 | |0;ai-astar;102;112;111;109;112;110;109;111;109;108 05:27:32 INFO - PROCESS | 3405 | |1;audio-beat-detection;146;117;122;175;117;119;147;116;151;118 05:27:32 INFO - PROCESS | 3405 | |2;audio-dft;160;160;158;159;160;160;160;160;161;160 05:27:32 INFO - PROCESS | 3405 | |3;audio-fft;74;75;76;126;75;75;74;74;102;75 05:27:32 INFO - PROCESS | 3405 | |4;audio-oscillator;84;85;124;84;84;84;124;85;84;126 05:27:32 INFO - PROCESS | 3405 | |5;imaging-gaussian-blur;116;116;117;117;117;117;116;118;117;117 05:27:32 INFO - PROCESS | 3405 | |6;imaging-darkroom;147;147;147;146;146;147;147;147;147;146 05:27:32 INFO - PROCESS | 3405 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 05:27:32 INFO - PROCESS | 3405 | |8;json-parse-financial;53;54;54;53;53;55;56;54;54;54 05:27:32 INFO - PROCESS | 3405 | |9;json-stringify-tinderbox;63;62;63;62;63;63;63;63;63;63 05:27:32 INFO - PROCESS | 3405 | |10;stanford-crypto-aes;76;75;75;76;74;75;75;76;74;79 05:27:32 INFO - PROCESS | 3405 | |11;stanford-crypto-ccm;118;125;118;117;122;119;149;128;202;131 05:27:32 INFO - PROCESS | 3405 | |12;stanford-crypto-pbkdf2;160;154;155;156;155;155;154;159;155;157 05:27:32 INFO - PROCESS | 3405 | |13;stanford-crypto-sha256-iterative;63;66;63;64;62;64;62;62;60;61 05:27:32 INFO - PROCESS | 3405 | __end_tp_report 05:27:32 INFO - PROCESS | 3405 | __start_cc_report 05:27:32 INFO - PROCESS | 3405 | _x_x_mozilla_cycle_collect,1656 05:27:32 INFO - PROCESS | 3405 | __end_cc_report 05:27:32 INFO - PROCESS | 3405 | __startTimestamp1468240052267__endTimestamp 05:27:32 INFO - PROCESS | 3405 | 05:27:32 INFO - PROCESS | 3405 | ------- Summary: start ------- 05:27:32 INFO - PROCESS | 3405 | Number of tests: 14 05:27:32 INFO - PROCESS | 3405 | 05:27:32 INFO - PROCESS | 3405 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.50 stddev:2.91 (2.6%) stddev-sans-first:1.45 05:27:32 INFO - PROCESS | 3405 | Values: 102.0 112.0 111.0 109.0 112.0 110.0 109.0 111.0 109.0 108.0 05:27:32 INFO - PROCESS | 3405 | 05:27:32 INFO - PROCESS | 3405 | [#1] audio-beat-detection Cycles:10 Average:132.80 Median:134.00 stddev:20.54 (15.3%) stddev-sans-first:21.22 05:27:32 INFO - PROCESS | 3405 | Values: 146.0 117.0 122.0 175.0 117.0 119.0 147.0 116.0 151.0 118.0 05:27:32 INFO - PROCESS | 3405 | 05:27:32 INFO - PROCESS | 3405 | [#2] audio-dft Cycles:10 Average:159.80 Median:160.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 05:27:32 INFO - PROCESS | 3405 | Values: 160.0 160.0 158.0 159.0 160.0 160.0 160.0 160.0 161.0 160.0 05:27:32 INFO - PROCESS | 3405 | 05:27:32 INFO - PROCESS | 3405 | [#3] audio-fft Cycles:10 Average:82.60 Median:75.00 stddev:17.50 (23.3%) stddev-sans-first:18.28 05:27:32 INFO - PROCESS | 3405 | Values: 74.0 75.0 76.0 126.0 75.0 75.0 74.0 74.0 102.0 75.0 05:27:32 INFO - PROCESS | 3405 | 05:27:32 INFO - PROCESS | 3405 | [#4] audio-oscillator Cycles:10 Average:96.40 Median:84.00 stddev:19.52 (23.2%) stddev-sans-first:20.18 05:27:32 INFO - PROCESS | 3405 | Values: 84.0 85.0 124.0 84.0 84.0 84.0 124.0 85.0 84.0 126.0 05:27:32 INFO - PROCESS | 3405 | 05:27:32 INFO - PROCESS | 3405 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 05:27:32 INFO - PROCESS | 3405 | Values: 116.0 116.0 117.0 117.0 117.0 117.0 116.0 118.0 117.0 117.0 05:27:32 INFO - PROCESS | 3405 | 05:27:32 INFO - PROCESS | 3405 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 05:27:32 INFO - PROCESS | 3405 | Values: 147.0 147.0 147.0 146.0 146.0 147.0 147.0 147.0 147.0 146.0 05:27:32 INFO - PROCESS | 3405 | 05:27:32 INFO - PROCESS | 3405 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 05:27:32 INFO - PROCESS | 3405 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 05:27:32 INFO - PROCESS | 3405 | 05:27:32 INFO - PROCESS | 3405 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:0.94 (1.7%) stddev-sans-first:0.93 05:27:32 INFO - PROCESS | 3405 | Values: 53.0 54.0 54.0 53.0 53.0 55.0 56.0 54.0 54.0 54.0 05:27:32 INFO - PROCESS | 3405 | 05:27:32 INFO - PROCESS | 3405 | [#9] json-stringify-tinderbox Cycles:10 Average:62.80 Median:63.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 05:27:32 INFO - PROCESS | 3405 | Values: 63.0 62.0 63.0 62.0 63.0 63.0 63.0 63.0 63.0 63.0 05:27:32 INFO - PROCESS | 3405 | 05:27:32 INFO - PROCESS | 3405 | [#10] stanford-crypto-aes Cycles:10 Average:75.50 Median:75.50 stddev:1.43 (1.9%) stddev-sans-first:1.51 05:27:32 INFO - PROCESS | 3405 | Values: 76.0 75.0 75.0 76.0 74.0 75.0 75.0 76.0 74.0 79.0 05:27:32 INFO - PROCESS | 3405 | 05:27:32 INFO - PROCESS | 3405 | [#11] stanford-crypto-ccm Cycles:10 Average:132.90 Median:126.50 stddev:26.10 (20.6%) stddev-sans-first:27.13 05:27:32 INFO - PROCESS | 3405 | Values: 118.0 125.0 118.0 117.0 122.0 119.0 149.0 128.0 202.0 131.0 05:27:32 INFO - PROCESS | 3405 | 05:27:32 INFO - PROCESS | 3405 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.00 Median:155.50 stddev:2.05 (1.3%) stddev-sans-first:1.59 05:27:32 INFO - PROCESS | 3405 | Values: 160.0 154.0 155.0 156.0 155.0 155.0 154.0 159.0 155.0 157.0 05:27:32 INFO - PROCESS | 3405 | 05:27:32 INFO - PROCESS | 3405 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:1.70 (2.7%) stddev-sans-first:1.80 05:27:32 INFO - PROCESS | 3405 | Values: 63.0 66.0 63.0 64.0 62.0 64.0 62.0 62.0 60.0 61.0 05:27:32 INFO - PROCESS | 3405 | -------- Summary: end -------- 05:27:32 INFO - PROCESS | 3405 | 05:27:33 INFO - TEST-INFO | 3405: exit 0 05:27:33 INFO - TEST-OK | kraken | took 60848ms 05:27:33 INFO - SUITE-END | took 1174s 05:27:33 INFO - Completed test suite (00:19:34) 05:27:33 INFO - javascript benchmark 05:27:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3013.578099066131, 3076.1233048581157, 3080.768942329325, 3108.502639577668, 3125.1562078238876, 5222.373315202181, 5225.085610018241, 5408.864778380543, 5505.532029777469, 5521.227028216048, 5315.7873685052555, 5406.59450541209, 5431.538319242859, 5501.092319767234, 5508.944910550893, 4865.8783530411665, 4872.951270487303, 4880.8047678092835, 4941.505849415065, 5098.413682426512, 4997.800087996476, 5031.547160755531, 5036.194208926554, 5037.672551284155, 5059.696418214919, 4790.257510085942, 4803.615710743132, 4818.373611430492, 4837.637177211724, 5020.924686129692, 4904.926426103611, 4933.777979990909, 4934.210526315772, 4942.703437793743, 4954.777035033432, 4889.951100489021, 4914.336564563774, 4923.679960802537, 4934.654574179809, 4972.651914365996, 5258.526732594047, 5277.9971805357245, 5501.614886957915, 5534.225208470817, 5547.25112109864, 5692.77228910843, 5770.394108618619, 5797.942020579782, 5803.390643982363, 5815.738291776838, 5765.452282033242, 5790.7104644768015, 5793.855153621151, 5834.824955251349, 5836.503897168745, 5223.425423203445, 5263.684178949199, 5385.8114965976, 5410.431904650034, 5411.080116380225, 6020.247469066367, 6051.697415129226, 6059.303180134341, 6067.302260240041, 6071.848203794941, 5793.652380857162, 5800.071988481823, 5807.564432667482, 5808.709564521757, 5817.0983497557945, 5572.3034620672415, 5720.713964301768, 5747.396523364986, 5763.279590051244, 5893.764249430061, 5765.106408506688, 5778.335491418541, 5789.594728368974, 5790.71046447676, 5849.912251316234, 5721.742521586539, 5754.079347304411, 5762.0, 5773.884522309614, 5782.0, 4276.5295817460055, 4291.2061268664775, 4317.56824317572, 4380.123975204971, 4404.427424434803, 3935.2129574084724, 3945.270125026879, 3963.4847469829315, 3977.76133431995, 4019.9598004019585, 5510.311211098613, 5516.668999860021, 5520.641158324696, 5525.889482210333, 5542.085555883315, 5630.774769009194, 5792.304923409133, 5822.970885145547, 5831.79588714393, 5884.411558844167, 5583.888322233533, 5586.0, 5589.133684278943, 5589.580781441408, 5627.887442251132, 5065.493450654905, 5067.5185857343495, 5073.568746656501, 5074.188129899272, 5124.743762811844, 5840.8539786504825, 5978.701064946736, 5990.6705131218205, 6018.21763170785, 6100.206973093558, 5803.158542011469, 5816.796412125555, 5819.15622234782, 5825.854353641193, 5827.79602713903, 6024.246969128859, 6035.305939816977, 6036.667983260787, 6043.3050199227655, 6043.848903777265, 5520.254765606592, 5609.298837645294, 5623.409541998031, 5657.43425657431, 5686.289213848269, 5790.420957904176, 5794.594378393472, 5796.304443466811, 5797.8550536236935, 5798.304203495608, 5530.198121272473, 5642.60501764889, 5654.06707893193, 5654.208410822571, 5654.688992105309, 5668.291463567054, 5688.77244910199, 5717.685527296038, 5745.8563535911935, 5755.5683323750045, 5641.464060914206, 5660.915086273627, 5671.064274394678, 5676.631018983753, 5680.176374425768, 5525.143602741581, 5586.497215250484, 5748.195252664546, 5774.989376858949, 5840.977828879844, 5360.16917377807, 5421.5391691706645, 5494.697791621339, 5549.472800083986, 5607.158926160945], "value": 5344.688861568122, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.1998372221916, 618.0975775367963, 634.5209366927969, 635.6758053392768, 640.2221301119139, 31949.201269968235, 43957.340639890426, 44719.55280447195, 44770.552294477086, 44841.32738008932, 46776.0, 47107.52892471074, 47224.291635625494, 47257.52742472574, 47284.76357618207, 8955.149260820212, 9077.36458447909, 9093.318001149908, 9097.090290970917, 9106.772330691752, 8970.955145224265, 9052.0, 9061.184493395593, 9064.410813297147, 9077.409968352036, 9127.817443651124, 9180.770480738001, 9189.678361257358, 9190.035046320141, 9199.632014719404, 9060.818783624323, 9093.77265568366, 9103.681371151977, 9111.544422778901, 9112.271018318519, 8760.912390876074, 8821.691240806542, 8825.161609647073, 8825.691100811506, 8828.337874659426, 42653.78673106646, 42667.35998960018, 42747.78626106881, 43003.569964300266, 43186.0, 3666.853325866962, 3731.0858839584203, 3734.850605975758, 3776.093737503007, 3833.3483307837732, 32740.181495462803, 32883.3423331532, 33438.33123337544, 33462.6653733462, 33742.493862592084, 4304.182205380967, 4352.151330490556, 4405.427294451732, 4418.182636212311, 4503.707259028152, 350669.0, 350751.0, 351755.0, 351767.0, 353461.0, 58103.41896581065, 58139.127913081335, 58393.0, 58552.41447585555, 58643.0, 53731.19403208955, 57797.42202578005, 58781.415765502206, 58905.70547147237, 65398.0, 16874.578135546464, 17094.57263568396, 17154.31382744701, 17157.142142892804, 17167.57081072983, 11438.714032149097, 12275.57035503771, 12275.754484910252, 12279.631611051684, 12285.57000504996, 16127.919360403122, 16566.917165414336, 16613.91693041527, 16900.661986760195, 17093.743593846102, 6436.131122298523, 6468.6442245676, 6478.562184903356, 6525.249596296392, 6571.868562628721, 999.2954966748425, 1007.1087087927237, 1086.538221255963, 1093.830456279278, 1096.629213483146, 32549.0, 32769.67230327714, 33127.17182070419, 33212.0, 33455.16362090967, 1079.7624522605015, 1097.5006372100675, 1112.7162573543694, 1157.3287493253893, 1208.4199584199635, 16366.672666546841, 17203.827961720224, 17278.308867645406, 17345.0, 17405.47783566495, 527649.0, 530256.0, 532831.0, 532871.0, 532960.0, 59639.701801490715, 59822.40177598255, 59900.0, 59900.10149847756, 59921.0, 1238.0900038471716, 1327.9933600331935, 1330.3215360166384, 1358.1375826350338, 1393.6794537256487, 32011.35977280488, 33590.83204583961, 33688.32623347568, 33753.49369759505, 34357.31285374228, 51527.74236128795, 55029.0, 57209.42790572041, 57292.713536433715, 61616.38383616106, 472648.0, 475118.0, 479626.0, 480385.0, 480410.0, 24787.752122478545, 27139.82881369525, 27484.58773118445, 27675.308117296423, 28041.43917121687, 49279.07209279187, 49989.500104998486, 50466.49533504618, 50696.0, 51054.0, 40860.13979021559, 42695.35956960586, 42866.5713342875, 43364.56635433605, 43803.34294985514, 40609.0, 41024.0, 41285.38071928863, 42022.36966445445, 42053.36919946264, 41798.0, 42806.571934280255, 42813.0, 43040.784796077074, 43176.0, 35898.0, 37044.25911481701, 37348.06629834276, 38016.619833801306, 38156.2368752629, 28457.0, 28884.0, 28982.565261521515, 29003.41993160167, 29103.272418188866], "value": 20382.773133671013, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.94568760373545, 394.9980250098749, 397.1679331799878, 399.75015615240477, 415.67369614852345, 13138.243538855502, 18288.26846926123, 20060.097295621694, 20061.99999999998, 20081.297154599593, 14518.12891226527, 18170.72743908839, 18631.53421164468, 19462.318818841344, 19864.304749333776, 5763.711814409284, 5905.4980326672285, 5914.112883067532, 5934.080217566284, 5946.375630558772, 5739.0, 5800.15897694834, 5811.099279611646, 5811.941880581204, 5831.5626328025355, 4063.2686116499017, 6232.439080482755, 6545.770898018571, 6561.114249576318, 6573.408393244607, 6408.67956602168, 6517.967410162966, 6537.509686773511, 6540.182477190351, 6565.573237739532, 5749.051406517961, 5755.107958266433, 5771.451712087345, 5782.9421705782825, 5786.392428795, 22153.224637137784, 23205.88397058021, 23703.76296237033, 24053.15813946521, 24157.87921060401, 2340.8010319122895, 2507.398224426143, 2531.5696331623667, 2966.792324537283, 3204.118867311485, 13525.256110913895, 14085.0, 14398.424063037466, 15042.172680502568, 15099.54701358961, 1913.4164079955608, 1921.0, 1931.420573827846, 2029.8680585761879, 2032.298856894369, 51866.48133518692, 51983.48016519862, 53172.0, 53173.0, 79449.60275198644, 10409.230430826627, 10451.0, 10678.1991350649, 10847.566097356017, 10866.293690910066, 14979.0, 15076.849231507764, 15109.093454392772, 15111.4710985115, 15114.470993515175, 7525.172231054579, 7778.261065198797, 7800.882986755203, 7846.882296765553, 7866.134725180225, 7295.562266264041, 7361.889571656429, 7403.481756277117, 7492.737754178577, 7535.660895259726, 5896.498797602252, 6151.415615516519, 6160.9383906161265, 6588.374104460068, 6691.59850408977, 1775.5042075499882, 1832.166364304265, 1889.3292881027312, 1973.3093417304117, 1998.3904909002895, 904.7421484876778, 991.9900800991898, 1023.6263763726336, 1045.2892033417197, 1052.768390953989, 18287.542811429554, 19714.408567742703, 19819.405417837486, 19862.801371986094, 20074.0, 1005.5776573839005, 1018.7758693087509, 1026.7946410717886, 1030.8144533983955, 1041.2555023158477, 10857.945710271557, 11212.66362009141, 11235.83146252807, 11248.26886252391, 11284.492197851116, 453764.0, 458819.0, 477537.0, 481578.0, 486973.0, 84619.13770785597, 84768.0, 86407.0, 86567.56716216379, 86741.0, 1015.5430056474615, 1022.9079382855579, 1039.3555995282973, 1040.484959944832, 1043.6451606453843, 17210.31158753636, 17260.568485787957, 17617.559561011076, 17638.38265660696, 17957.0, 39686.60313396829, 39935.80032099821, 40004.1999160021, 41832.79083604563, 42821.78589107034, 52842.73578632082, 55318.44681553294, 55464.16803747867, 55490.0, 55498.16752748793, 8719.651213951625, 8802.29581633455, 8911.821763564563, 9063.592138353659, 9125.5437228137, 10328.483575821028, 13478.66303342385, 13609.863901360859, 13753.931230343784, 13899.0, 12043.397830108635, 12045.879541204476, 12136.393180341125, 12154.209976351509, 12260.816087758512, 11603.0, 11788.23376480526, 11921.761564768829, 12061.879381206076, 12145.210561313486, 11665.183437159318, 12418.0, 12439.129260951646, 12474.313912734886, 12613.936930315289, 8459.703910363107, 8466.74599762008, 8481.491110533389, 8533.829323413622, 8655.3508486865, 11366.659000230007, 12001.939990299992, 12083.275003499819, 12253.081018923438, 12346.876531234573], "value": 9359.649060734082, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1350.6015725361017, 1459.5110637936293, 1520.7946927164833, 1630.494546690526, 1768.177797324244, 8172.754817355474, 8492.532910689917, 8499.065102838682, 8686.174813392734, 8688.261497772697, 8511.914880851189, 8686.218240358367, 8705.738827835175, 8719.738407847759, 8722.956385218065, 2043.274637503687, 2313.9190128345513, 2353.635186546088, 2378.369732021016, 2385.3917251100943, 2429.720582133051, 2437.890294936732, 2442.8167887408426, 2442.926712198628, 2443.780059794618, 2338.7895089441945, 2372.193454225563, 2395.4969456414174, 2397.808175345977, 2398.5322862041908, 1937.9127939242696, 2198.4613769626385, 2218.534107837348, 2267.025179172955, 2274.2608652188105, 2340.8010319122895, 2342.9179978700836, 2357.446000189954, 2363.6809030780796, 2365.184011516041, 9182.173604375572, 9210.49342286174, 9216.677416290398, 9231.399959002643, 9235.907640923571, 5147.639665223436, 5359.22291267764, 5398.055340315468, 5399.136138217906, 5409.350877894639, 3384.7122994545493, 3495.24852156785, 3546.078019714893, 3578.4095624221973, 3578.5169002184634, 1116.8994790468817, 1138.908887289015, 1140.6235942139074, 1142.2232881640482, 1153.1524329617723, 12675.873241267469, 12753.936230318881, 12763.042771792152, 12763.936180319131, 12769.87230127696, 4535.478419981744, 4730.597899178609, 4797.160496913027, 4809.495003024632, 4826.7827947742435, 10661.733456663645, 10695.679129626124, 10698.090662293636, 10698.304610200312, 10715.089217416451, 5352.0, 5356.357237131491, 5356.625036247503, 5356.839294821161, 5359.410464848864, 4204.3903633972905, 4718.740469274223, 4897.877553061202, 4903.53416425439, 4987.476314986874, 4102.712810103324, 4116.45834892599, 4182.602652747984, 4183.867894569734, 4212.389203565527, 1108.933463992163, 1284.3770771175973, 1284.6017734502334, 1290.0, 1294.799306107555, 876.8640860666607, 952.8237276103943, 965.6378857928277, 967.2842096848423, 988.5452691761726, 5713.257276554022, 5762.711864406763, 5947.49446297061, 5993.310769261503, 6051.76522308209, 931.469062634292, 940.9320421321712, 969.6509256667593, 979.1921664626711, 992.3549692699659, 4149.896252593649, 4175.728577642443, 4182.7490350578455, 4210.894727631834, 4214.1150358425075, 10459.110975567162, 10883.23817332779, 10937.234393592531, 10946.507407166697, 10947.50736216872, 10772.192085593455, 10785.13718902486, 10789.56841726338, 10797.56809727602, 10807.40559269232, 7778.611069446505, 8085.757427277191, 8090.7168249111, 8090.797730056795, 8202.425830191829, 6068.908966365596, 6187.133801267736, 6195.690215489298, 6306.810795676137, 6316.021016742412, 10326.328788628714, 10584.153267738408, 10659.46702664848, 10705.090067344363, 10707.089897358812, 10382.584696612052, 10499.842502362319, 10627.468626568796, 10832.0, 11096.0, 6994.510384273052, 7876.803079923047, 8083.312918402002, 8120.066192387951, 8243.505389676639, 8950.23922966529, 8976.0, 9033.0, 9037.412568183046, 9046.185843274137, 7378.372838308804, 7561.810954726176, 7595.734149304748, 7610.277023682741, 7852.254035866584, 7526.698932042876, 7669.424793140425, 7698.422618303762, 7752.26353496417, 7780.1052878919645, 7370.5946172961, 7393.630318484162, 7430.294122058396, 7434.0, 7434.59109748969, 5269.710165940756, 5345.1447768356875, 5431.4840090191365, 5481.342238931354, 5482.150266708507, 5316.920246196233, 5447.319085114361, 5458.153986132156, 5505.614606977473, 5530.364008138955], "value": 4716.459072733849, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.33743679398816, 337.05624252094134, 343.22773759042155, 343.8572992208234, 344.0607142500971, 5273.34083239595, 5370.113931201347, 5370.221317908906, 5370.570354371651, 5410.972945135279, 5013.598912087034, 5141.974290128554, 5143.27994080829, 5184.53339199472, 5329.946700532993, 3997.480327557428, 4046.0896298332787, 4127.772972486512, 4137.0, 4181.770002649853, 4128.814203360856, 4156.750594964312, 4164.791760411982, 4166.8749937501925, 4171.707980441371, 4073.226087043467, 4092.774897380643, 4134.379843023556, 4143.34266293482, 4147.709660323779, 4080.3471444569022, 4100.466939297902, 4122.237386083569, 4152.0, 4161.9375709364385, 3698.815059247054, 3717.5724791649036, 3726.795026273554, 3733.8879833605033, 3735.0662334416397, 5080.187170052811, 5209.973950130225, 5235.240890070956, 5258.264772625024, 5269.815556455544, 4765.404324459442, 4774.594159496447, 4784.138855006097, 4805.663603547753, 4826.155422801031, 5451.972740136274, 5467.480589344006, 5478.315210598676, 5478.835634930959, 5552.222688823568, 4003.719739618228, 4077.225327187825, 4102.405151253081, 4108.979455102705, 4113.506379234481, 5719.313682358102, 5724.284464441903, 5727.9427205727825, 5742.196092547047, 5789.855253618651, 4191.497020357577, 4193.874183774492, 4200.831966721297, 4203.6637069034405, 4223.598758117974, 4102.425660407545, 4270.871873843789, 4274.6793990450215, 4277.550857159953, 4279.636230920344, 4709.128811169944, 4720.173969555314, 4728.739919304471, 4742.770897678086, 4772.546608072227, 5453.836384908459, 5486.753096110685, 5500.669959802424, 5526.889462210734, 5579.972100139474, 1352.1481466676128, 1372.108129715673, 1431.9427222911174, 1447.4572035486692, 1451.5137428961204, 970.9368891022202, 990.7424069741775, 992.6327258914248, 1004.4475538453967, 1006.5470538257813, 5264.263003179558, 5305.708186049805, 5320.0, 5343.332083489564, 5388.973055134699, 5601.663900166003, 5618.0, 5626.662400255997, 5632.0, 5678.346990096192, 5125.820596279187, 5277.366715994105, 5322.121849894724, 5330.147176451749, 5339.46605339463, 2649.244965184913, 2650.204938518437, 2683.6511253536914, 2702.2705468500176, 2702.581099929475, 5135.255387968724, 5163.715995620277, 5199.454057324002, 5256.109139973076, 5588.189712491666, 5814.244148260699, 5837.970810145922, 5841.153032810219, 5844.912326315109, 5868.918817620698, 5918.763249469973, 5931.673757943268, 5934.495567876693, 5948.791792287249, 6002.969985150046, 5539.534906966362, 5734.7132643368495, 5745.942540574708, 5757.65454072757, 5792.189093526994, 5637.689927053887, 5675.65136569426, 5684.9431505684415, 5690.772369105355, 5709.743061562157, 5668.858278542904, 5967.582269241111, 5968.671723055274, 5979.820605381846, 5980.491658209101, 3796.4495148202805, 4034.3545032794614, 4035.7780322081394, 4045.7370270932297, 4048.7246517346944, 5574.721263936706, 5720.6853623049465, 5748.425157484218, 5792.855178620568, 5836.890990711751, 5608.635438696471, 5655.151727240782, 5661.547076233974, 5668.178114173505, 5692.6299790513485, 5249.317588713596, 5560.666360018412, 5571.498565129158, 5589.245451864109, 5657.547396208376, 5507.557776389756, 5514.255575497417, 5533.142362933751, 5535.16972454119, 5550.333959924835, 5659.943400565941, 5683.0, 5690.231818704422, 5696.401877802771, 5722.570807189561, 5232.5552328052545, 5502.174673798962, 5510.421405752499, 5512.200730894078, 5529.640573362719], "value": 4241.053260044741, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [745.8997977982475, 788.0661416221774, 802.9116797152312, 805.5569436809755, 870.5516658920653, 15406.460773872917, 16026.919865400685, 16033.118178500177, 16033.83966160338, 16052.277647505847, 15072.39710411585, 15233.0, 15237.771433428508, 15248.618784530392, 15264.923675381635, 657.2704298228962, 778.8014056415606, 789.9723509677162, 801.5751651624648, 808.3210103513048, 802.229859335039, 804.2279411764683, 805.4522924411398, 805.4724155678011, 809.9149589293128, 850.1795767084762, 850.7660393391805, 851.8296340731879, 852.7058164933088, 852.9147085291484, 686.204003356107, 837.0917554453395, 845.71245776436, 857.3698331726176, 860.1140824950311, 625.1841347042108, 627.269231345482, 627.3945642455008, 628.5443053786014, 630.483003936772, 14969.850301496954, 14984.250787460693, 15006.0, 15034.548963531111, 15053.0, 14247.216403097826, 14326.283685815668, 14331.713365732627, 14349.78475322871, 14429.567112986628, 12736.936315318457, 13178.406971686298, 13195.736085278337, 13244.668883277898, 13433.798493022612, 4401.339799030171, 4459.464864216315, 4462.7991740371435, 4511.052678937427, 4572.513932971798, 73613.63193184053, 76650.61674691591, 76685.61657191678, 76722.61638691771, 79027.20972790256, 11598.826017609743, 11976.88023119775, 12032.518699251932, 12222.694432639255, 12241.571544995883, 21546.353609391743, 21692.89153554222, 21693.24073657446, 21698.783012169675, 21701.565968680537, 8299.792505187419, 8748.91251087481, 8770.429922055046, 8779.473231606124, 9031.77420564478, 4578.45058592971, 4732.432108147044, 4744.69159504638, 4853.12643724126, 4963.429205641398, 3461.8615255390005, 3564.091156755063, 3574.5174401455993, 3577.94633080504, 3579.2483578448296, 642.9196350456193, 661.1075048684334, 661.7253839656489, 681.7647911470535, 685.9725610975605, 669.7454967112466, 698.4447364345358, 727.5634619228421, 759.4342215049713, 764.5489161394804, 9883.851742223873, 10014.0, 10565.366078035342, 10587.0, 10830.40432776205, 746.2388363868823, 754.6415452659943, 771.9459637825411, 773.0568706178453, 786.1384560200873, 4661.184292748755, 4795.352627395257, 4832.855014349575, 4872.829450969199, 4924.359833221658, 125157.37421312835, 125575.0, 127698.0, 129840.0, 131403.34298328447, 115643.0, 118364.40817795855, 119005.0, 119645.40177299232, 119913.0, 96333.0, 96622.0, 97273.51363243138, 97395.0, 98241.0, 9296.58165382573, 9318.627254909728, 9340.579673914826, 9428.340016198801, 9524.095210954949, 50827.49172508228, 56611.85705226464, 57802.71098644648, 58321.4167858316, 58636.706816465645, 64078.67960660167, 69675.65162174156, 69959.65020174866, 74983.62639175731, 84640.57679711809, 14141.717165656835, 14273.286335682966, 14609.92695036518, 14806.703865922405, 15234.847651523343, 15186.696266074396, 15506.689866202838, 15575.532734017997, 15883.444079457164, 16581.336746530487, 14376.640583985065, 14659.267036648338, 14785.334659940543, 14808.925955370585, 15165.0, 14792.260386980823, 14813.629659258604, 14849.0, 14970.326335315154, 15059.247037648292, 14410.495632653226, 14596.489122880648, 14869.0, 14887.844244128808, 14898.925505372405, 11876.881231187577, 11898.345590992578, 12066.276023438622, 12121.090918180995, 12140.93929530382, 12278.0, 12304.692382690504, 12366.134370593973, 12505.56230531927, 12600.0], "value": 7924.750752485456, "unit": "score"}], "name": "dromaeo_css", "value": 7380.64487472967, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 111.0, 109.0, 112.0, 110.0, 109.0, 111.0, 109.0, 108.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 117.0, 122.0, 175.0, 117.0, 119.0, 147.0, 116.0, 151.0, 118.0], "value": 132.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 158.0, 159.0, 160.0, 160.0, 160.0, 160.0, 161.0, 160.0], "value": 159.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 126.0, 75.0, 75.0, 74.0, 74.0, 102.0, 75.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 124.0, 84.0, 84.0, 84.0, 124.0, 85.0, 84.0, 126.0], "value": 96.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 118.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 53.0, 53.0, 55.0, 56.0, 54.0, 54.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 62.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0], "value": 62.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 76.0, 74.0, 75.0, 75.0, 76.0, 74.0, 79.0], "value": 75.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 125.0, 118.0, 117.0, 122.0, 119.0, 149.0, 128.0, 202.0, 131.0], "value": 132.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 154.0, 155.0, 156.0, 155.0, 155.0, 154.0, 159.0, 155.0, 157.0], "value": 156.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 63.0, 64.0, 62.0, 64.0, 62.0, 62.0, 60.0, 61.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1483.3, "alertThreshold": 2.0}]} 05:27:33 INFO - Return code: 0 05:27:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:27:33 INFO - # TBPL SUCCESS # 05:27:33 INFO - Running post-action listener: _resource_record_post_action 05:27:33 INFO - ##### 05:27:33 INFO - ##### Finished run-tests step (success) 05:27:33 INFO - ##### 05:27:33 INFO - Running post-run listener: _resource_record_post_run 05:27:33 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 557449216; Read time: 12; Write time: 520432 05:27:33 INFO - TinderboxPrint: CPU usage
12.9% 05:27:33 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 05:27:33 INFO - TinderboxPrint: I/O write bytes / time
557,449,216 / 520,432 05:27:33 INFO - TinderboxPrint: CPU idle
8,282.7 (87.0%) 05:27:33 INFO - TinderboxPrint: CPU user
1,189.1 (12.5%) 05:27:33 INFO - TinderboxPrint: Swap in / out
0 / 0 05:27:33 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 262602752; Read time: 0; Write time: 328396 05:27:33 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 290291712; Read time: 0; Write time: 191428 05:27:34 INFO - Running post-run listener: _upload_blobber_files 05:27:34 INFO - Blob upload gear active. 05:27:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:27:34 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 05:27:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:27:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:27:34 INFO - (blobuploader) - INFO - Open directory for files ... 05:27:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:27:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:27:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:27:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:27:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:27:35 INFO - (blobuploader) - INFO - Done attempting. 05:27:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:27:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:27:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:27:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:27:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:27:38 INFO - (blobuploader) - INFO - Done attempting. 05:27:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:27:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:27:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:27:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:27:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:27:39 INFO - (blobuploader) - INFO - Done attempting. 05:27:39 INFO - (blobuploader) - INFO - Iteration through files over. 05:27:39 INFO - Return code: 0 05:27:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:27:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:27:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee8b087e2a4e59f8428a0260bf572dfcc0236895c6ad14155802d69ef7eb53d2f753a6e38639837fd40c3c2c3bfe16b522c4fbad62d426376efc4d6c573aa90c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/edcce94a9fe65e5ae060c328340b0292562c25e16b6e2990d785f32fec7a6601f350ba7bf44f01848d9abb5c94058617d25878fb22240cd645e1241cd79ddf08", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d8f1bcec558e4b04f78835ca3b2c414e0def18825b03066b65d2217078be0a770d860f098c83dc91fbc0a49b3981d1aeedab5c283ae61a261ebf75bfef2cea47"} 05:27:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:27:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:27:39 INFO - Contents: 05:27:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee8b087e2a4e59f8428a0260bf572dfcc0236895c6ad14155802d69ef7eb53d2f753a6e38639837fd40c3c2c3bfe16b522c4fbad62d426376efc4d6c573aa90c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/edcce94a9fe65e5ae060c328340b0292562c25e16b6e2990d785f32fec7a6601f350ba7bf44f01848d9abb5c94058617d25878fb22240cd645e1241cd79ddf08", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d8f1bcec558e4b04f78835ca3b2c414e0def18825b03066b65d2217078be0a770d860f098c83dc91fbc0a49b3981d1aeedab5c283ae61a261ebf75bfef2cea47"} 05:27:39 INFO - Running post-run listener: copy_logs_to_upload_dir 05:27:39 INFO - Copying logs to upload dir... 05:27:39 INFO - mkdir: /builds/slave/test/build/upload/logs 05:27:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.694229 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-11 05:27:38.607212) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 05:27:38.610684) ========= 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=cbe409c6de289db6ac707de3000001d4-1468238825.818490-903465473 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee8b087e2a4e59f8428a0260bf572dfcc0236895c6ad14155802d69ef7eb53d2f753a6e38639837fd40c3c2c3bfe16b522c4fbad62d426376efc4d6c573aa90c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/edcce94a9fe65e5ae060c328340b0292562c25e16b6e2990d785f32fec7a6601f350ba7bf44f01848d9abb5c94058617d25878fb22240cd645e1241cd79ddf08", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d8f1bcec558e4b04f78835ca3b2c414e0def18825b03066b65d2217078be0a770d860f098c83dc91fbc0a49b3981d1aeedab5c283ae61a261ebf75bfef2cea47"} build_url:https://queue.taskcluster.net/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011222 build_url: 'https://queue.taskcluster.net/v1/task/coEJbLhqTci38c6RWN6rzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee8b087e2a4e59f8428a0260bf572dfcc0236895c6ad14155802d69ef7eb53d2f753a6e38639837fd40c3c2c3bfe16b522c4fbad62d426376efc4d6c573aa90c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/edcce94a9fe65e5ae060c328340b0292562c25e16b6e2990d785f32fec7a6601f350ba7bf44f01848d9abb5c94058617d25878fb22240cd645e1241cd79ddf08", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d8f1bcec558e4b04f78835ca3b2c414e0def18825b03066b65d2217078be0a770d860f098c83dc91fbc0a49b3981d1aeedab5c283ae61a261ebf75bfef2cea47"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 05:27:38.636266) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 05:27:38.636612) ========= 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=cbe409c6de289db6ac707de3000001d4-1468238825.818490-903465473 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004502 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 05:27:38.722898) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 05:27:38.723565) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 05:27:38.724131) ========= ========= Total master_lag: 0.17 =========