builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-040 starttime: 1467211740.69 results: success (0) buildid: 20160629045731 builduid: a5090e4dfa684123a0c8d07a5f49f6d2 revision: 72993ec9d303 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 07:49:00.691050) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 07:49:00.691562) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 07:49:00.691837) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 07:49:00.706964) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 07:49:00.707491) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1467211367.800440-534111710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-29 07:49:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 17.4M=0.001s 2016-06-29 07:49:00 (17.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107696 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 07:49:00.828876) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 07:49:00.829161) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1467211367.800440-534111710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019053 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 07:49:00.878224) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-29 07:49:00.878580) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 72993ec9d303 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 72993ec9d303 --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=9e0dfe3369c33a1556e63f89000001d8-1467211367.800440-534111710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-29 07:49:00,976 Setting DEBUG logging. 2016-06-29 07:49:00,976 attempt 1/10 2016-06-29 07:49:00,976 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/72993ec9d303?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-29 07:49:01,965 unpacking tar archive at: mozilla-inbound-72993ec9d303/testing/mozharness/ program finished with exit code 0 elapsedTime=1.348595 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-29 07:49:02.241907) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 07:49:02.242290) ========= script_repo_revision: 72993ec9d303 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 07:49:02.242806) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 07:49:02.243122) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 07:49:02.253949) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-29 07:49:02.254423) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=9e0dfe3369c33a1556e63f89000001d8-1467211367.800440-534111710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:49:02 INFO - MultiFileLogger online at 20160629 07:49:02 in /builds/slave/test 07:49:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 07:49:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:49:02 INFO - {'append_to_log': False, 07:49:02 INFO - 'base_work_dir': '/builds/slave/test', 07:49:02 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:49:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:49:02 INFO - 'branch': 'Mozilla-Inbound', 07:49:02 INFO - 'buildbot_json_path': 'buildprops.json', 07:49:02 INFO - 'config_files': ('talos/linux_config.py',), 07:49:02 INFO - 'default_actions': ('clobber', 07:49:02 INFO - 'read-buildbot-config', 07:49:02 INFO - 'download-and-extract', 07:49:02 INFO - 'populate-webroot', 07:49:02 INFO - 'create-virtualenv', 07:49:02 INFO - 'install', 07:49:02 INFO - 'run-tests'), 07:49:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:49:02 INFO - 'download_minidump_stackwalk': True, 07:49:02 INFO - 'download_symbols': 'ondemand', 07:49:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:49:02 INFO - 'tooltool.py': '/tools/tooltool.py', 07:49:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:49:02 INFO - '/tools/misc-python/virtualenv.py')}, 07:49:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:49:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:49:02 INFO - 'installer_path': 'installer.exe', 07:49:02 INFO - 'log_level': 'info', 07:49:02 INFO - 'log_name': 'talos', 07:49:02 INFO - 'log_to_console': True, 07:49:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:49:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:49:02 INFO - 'opt_config_files': (), 07:49:02 INFO - 'pip_index': False, 07:49:02 INFO - 'sps_profile': False, 07:49:02 INFO - 'sps_profile_interval': 0, 07:49:02 INFO - 'suite': 'dromaeojs', 07:49:02 INFO - 'system_bits': '32', 07:49:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:49:02 INFO - 'title': 'talos-linux64-ix-040', 07:49:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:49:02 INFO - 'use_talos_json': True, 07:49:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:49:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:49:02 INFO - 'work_dir': 'build'} 07:49:02 INFO - ##### 07:49:02 INFO - ##### Running clobber step. 07:49:02 INFO - ##### 07:49:02 INFO - Running pre-action listener: _resource_record_pre_action 07:49:02 INFO - Running main action method: clobber 07:49:02 INFO - rmtree: /builds/slave/test/build 07:49:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:49:02 INFO - Running post-action listener: _resource_record_post_action 07:49:02 INFO - ##### 07:49:02 INFO - ##### Finished clobber step (success) 07:49:02 INFO - ##### 07:49:02 INFO - ##### 07:49:02 INFO - ##### Running read-buildbot-config step. 07:49:02 INFO - ##### 07:49:02 INFO - Running pre-action listener: _resource_record_pre_action 07:49:02 INFO - Running main action method: read_buildbot_config 07:49:02 INFO - Using buildbot properties: 07:49:02 INFO - { 07:49:02 INFO - "project": "", 07:49:02 INFO - "product": "firefox", 07:49:02 INFO - "script_repo_revision": "production", 07:49:02 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 07:49:02 INFO - "repository": "", 07:49:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 07:49:02 INFO - "buildid": "20160629045731", 07:49:02 INFO - "pgo_build": "True", 07:49:02 INFO - "basedir": "/builds/slave/test", 07:49:02 INFO - "buildnumber": 1191, 07:49:02 INFO - "slavename": "talos-linux64-ix-040", 07:49:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:49:02 INFO - "platform": "ubuntu64_hw", 07:49:02 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 07:49:02 INFO - "branch": "mozilla-inbound", 07:49:02 INFO - "repo_path": "integration/mozilla-inbound", 07:49:02 INFO - "revision": "72993ec9d303", 07:49:02 INFO - "stage_platform": "linux64-pgo", 07:49:02 INFO - "builduid": "a5090e4dfa684123a0c8d07a5f49f6d2", 07:49:02 INFO - "slavebuilddir": "test" 07:49:02 INFO - } 07:49:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/RGIsLmdCQoKBMiO512mSaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:49:02 INFO - Running post-action listener: _resource_record_post_action 07:49:02 INFO - ##### 07:49:02 INFO - ##### Finished read-buildbot-config step (success) 07:49:02 INFO - ##### 07:49:02 INFO - ##### 07:49:02 INFO - ##### Running download-and-extract step. 07:49:02 INFO - ##### 07:49:02 INFO - Running pre-action listener: _resource_record_pre_action 07:49:02 INFO - Running main action method: download_and_extract 07:49:02 INFO - mkdir: /builds/slave/test/build/tests 07:49:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:49:02 INFO - https://queue.taskcluster.net/v1/task/RGIsLmdCQoKBMiO512mSaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:49:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGIsLmdCQoKBMiO512mSaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:49:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGIsLmdCQoKBMiO512mSaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:49:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGIsLmdCQoKBMiO512mSaA/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 07:49:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGIsLmdCQoKBMiO512mSaA/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 07:49:07 INFO - Downloaded 1361 bytes. 07:49:07 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:49:07 INFO - Using the following test package requirements: 07:49:07 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:49:07 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:49:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:49:07 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:49:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:49:07 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:49:07 INFO - u'jsshell-linux-x86_64.zip'], 07:49:07 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:49:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:49:07 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:49:07 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:49:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:49:07 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:49:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:49:07 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:49:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:49:07 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:49:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:49:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:49:07 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')]} 07:49:07 INFO - https://queue.taskcluster.net/v1/task/RGIsLmdCQoKBMiO512mSaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:49:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGIsLmdCQoKBMiO512mSaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:49:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGIsLmdCQoKBMiO512mSaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:49:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGIsLmdCQoKBMiO512mSaA/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 07:49:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGIsLmdCQoKBMiO512mSaA/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 07:49:10 INFO - Downloaded 24267267 bytes. 07:49: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'] 07:49: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 07:49:11 INFO - Return code: 0 07:49:11 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 07:49:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:49:11 INFO - https://queue.taskcluster.net/v1/task/RGIsLmdCQoKBMiO512mSaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:49:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGIsLmdCQoKBMiO512mSaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:49:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGIsLmdCQoKBMiO512mSaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:49:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGIsLmdCQoKBMiO512mSaA/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 07:49:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGIsLmdCQoKBMiO512mSaA/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 07:49:12 INFO - Downloaded 24267267 bytes. 07:49:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:49:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:49:13 INFO - Return code: 0 07:49:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:49:13 INFO - https://queue.taskcluster.net/v1/task/RGIsLmdCQoKBMiO512mSaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:49:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGIsLmdCQoKBMiO512mSaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:49:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGIsLmdCQoKBMiO512mSaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:49:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGIsLmdCQoKBMiO512mSaA/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 07:49:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGIsLmdCQoKBMiO512mSaA/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 07:49:14 INFO - Downloaded 14405245 bytes. 07:49:14 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'] 07:49:14 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 07:49:15 INFO - Return code: 0 07:49: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')]} 07:49:15 INFO - https://queue.taskcluster.net/v1/task/RGIsLmdCQoKBMiO512mSaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:49:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGIsLmdCQoKBMiO512mSaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:49:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGIsLmdCQoKBMiO512mSaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:49:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGIsLmdCQoKBMiO512mSaA/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 07:49:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGIsLmdCQoKBMiO512mSaA/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 07:49:16 INFO - Downloaded 60340752 bytes. 07:49:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RGIsLmdCQoKBMiO512mSaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:49:16 INFO - mkdir: /builds/slave/test/properties 07:49:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:49:16 INFO - Writing to file /builds/slave/test/properties/build_url 07:49:16 INFO - Contents: 07:49:16 INFO - build_url:https://queue.taskcluster.net/v1/task/RGIsLmdCQoKBMiO512mSaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:49:17 INFO - Running post-action listener: _resource_record_post_action 07:49:17 INFO - Running post-action listener: set_extra_try_arguments 07:49:17 INFO - ##### 07:49:17 INFO - ##### Finished download-and-extract step (success) 07:49:17 INFO - ##### 07:49:17 INFO - ##### 07:49:17 INFO - ##### Running populate-webroot step. 07:49:17 INFO - ##### 07:49:17 INFO - Running pre-action listener: _resource_record_pre_action 07:49:17 INFO - Running main action method: populate_webroot 07:49:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:49:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:49:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:49:17 INFO - '--tppagecycles', 07:49:17 INFO - '7'], 07:49:17 INFO - 'tests': ['tsvgm']}}, 07:49:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:49:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:49:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:49:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:49:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:49:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:49:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:49:17 INFO - 'talos_options': ['--disable-e10s'], 07:49:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:49:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:49:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:49:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:49:17 INFO - 'talos_options': ['--disable-e10s'], 07:49:17 INFO - 'tests': ['damp', 'tps']}, 07:49:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:49:17 INFO - 'tests': ['damp', 'tps']}, 07:49:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:49:17 INFO - 'tests': ['dromaeo_dom']}, 07:49:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:49:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:49:17 INFO - 'tests': ['basic_compositor_video']}, 07:49:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:49:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:49:17 INFO - 'tests': ['a11yr', 07:49:17 INFO - 'ts_paint', 07:49:17 INFO - 'tpaint', 07:49:17 INFO - 'sessionrestore', 07:49:17 INFO - 'sessionrestore_no_auto_restore', 07:49:17 INFO - 'tabpaint']}, 07:49:17 INFO - 'other-e10s': {'tests': ['a11yr', 07:49:17 INFO - 'ts_paint', 07:49:17 INFO - 'tpaint', 07:49:17 INFO - 'sessionrestore', 07:49:17 INFO - 'sessionrestore_no_auto_restore', 07:49:17 INFO - 'tabpaint']}, 07:49:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:49:17 INFO - 'ts_paint', 07:49:17 INFO - 'tpaint', 07:49:17 INFO - 'sessionrestore', 07:49:17 INFO - 'sessionrestore_no_auto_restore', 07:49:17 INFO - 'tabpaint']}, 07:49:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:49:17 INFO - 'ts_paint', 07:49:17 INFO - 'tpaint', 07:49:17 INFO - 'sessionrestore', 07:49:17 INFO - 'sessionrestore_no_auto_restore', 07:49:17 INFO - 'tabpaint']}, 07:49:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:49:17 INFO - 'tests': ['a11yr', 07:49:17 INFO - 'ts_paint', 07:49:17 INFO - 'tpaint', 07:49:17 INFO - 'sessionrestore', 07:49:17 INFO - 'sessionrestore_no_auto_restore', 07:49:17 INFO - 'tabpaint']}, 07:49:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:49:17 INFO - 'tests': ['a11yr', 07:49:17 INFO - 'ts_paint', 07:49:17 INFO - 'tpaint', 07:49:17 INFO - 'sessionrestore', 07:49:17 INFO - 'sessionrestore_no_auto_restore', 07:49:17 INFO - 'tabpaint']}, 07:49:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:49:17 INFO - 'tests': ['tsvgx', 07:49:17 INFO - 'tsvgr_opacity', 07:49:17 INFO - 'tart', 07:49:17 INFO - 'tscrollx', 07:49:17 INFO - 'cart']}, 07:49:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:49:17 INFO - 'tsvgr_opacity', 07:49:17 INFO - 'tart', 07:49:17 INFO - 'tscrollx', 07:49:17 INFO - 'cart']}, 07:49:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:49:17 INFO - 'talos_options': ['--disable-e10s'], 07:49:17 INFO - 'tests': ['tp5o']}, 07:49:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:49:17 INFO - 'tests': ['tp5o']}, 07:49:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:49:17 INFO - 'talos_options': ['--disable-e10s', 07:49:17 INFO - '--xperf_path', 07:49:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:49:17 INFO - 'tests': ['tp5n']}, 07:49:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:49:17 INFO - 'talos_options': ['--xperf_path', 07:49:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:49:17 INFO - 'tests': ['tp5n']}}, 07:49:17 INFO - 'talos.zip': {'path': '', 07:49:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:49:17 INFO - Running post-action listener: _resource_record_post_action 07:49:17 INFO - ##### 07:49:17 INFO - ##### Finished populate-webroot step (success) 07:49:17 INFO - ##### 07:49:17 INFO - ##### 07:49:17 INFO - ##### Running create-virtualenv step. 07:49:17 INFO - ##### 07:49:17 INFO - Running pre-action listener: _resource_record_pre_action 07:49:17 INFO - Running main action method: create_virtualenv 07:49:17 INFO - Creating virtualenv /builds/slave/test/build/venv 07:49:17 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 07:49:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:49:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:49:17 INFO - Using real prefix '/usr' 07:49:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:49:18 INFO - Installing distribute.............................................................................................................................................................................................done. 07:49:20 INFO - Installing pip.................done. 07:49:20 INFO - Return code: 0 07:49:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:49:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:49:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:49:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49:20 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 0x1fee030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22af180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ad3b0>, '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 0x22ae2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ae740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467211367.800440-534111710', '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 07:49:20 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 07:49:20 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 07:49:20 INFO - Using env: {'DISPLAY': ':0', 07:49:20 INFO - 'HOME': '/home/cltbld', 07:49:20 INFO - 'LANG': 'en_US.UTF-8', 07:49:20 INFO - 'LANGUAGE': 'en_US:en', 07:49:20 INFO - 'LOGNAME': 'cltbld', 07:49:20 INFO - 'MAIL': '/var/mail/cltbld', 07:49:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:49:20 INFO - 'MOZ_NO_REMOTE': '1', 07:49:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:49:20 INFO - 'NO_EM_RESTART': '1', 07:49:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:49:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:49:20 INFO - 'PWD': '/builds/slave/test', 07:49:20 INFO - 'SHELL': '/bin/bash', 07:49:20 INFO - 'SHLVL': '1', 07:49:20 INFO - 'TERM': 'linux', 07:49:20 INFO - 'TMOUT': '86400', 07:49:20 INFO - 'USER': 'cltbld', 07:49:20 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467211367.800440-534111710', 07:49:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:49:20 INFO - '_': '/tools/buildbot/bin/python'} 07:49:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:49:20 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 07:49:20 INFO - Cleaning up... 07:49:20 INFO - Return code: 0 07:49:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:49:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:49:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:49:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49:20 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 0x1fee030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22af180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ad3b0>, '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 0x22ae2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ae740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467211367.800440-534111710', '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 07:49:20 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 07:49:20 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 07:49:20 INFO - Using env: {'DISPLAY': ':0', 07:49:20 INFO - 'HOME': '/home/cltbld', 07:49:20 INFO - 'LANG': 'en_US.UTF-8', 07:49:20 INFO - 'LANGUAGE': 'en_US:en', 07:49:20 INFO - 'LOGNAME': 'cltbld', 07:49:20 INFO - 'MAIL': '/var/mail/cltbld', 07:49:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:49:20 INFO - 'MOZ_NO_REMOTE': '1', 07:49:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:49:20 INFO - 'NO_EM_RESTART': '1', 07:49:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:49:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:49:20 INFO - 'PWD': '/builds/slave/test', 07:49:20 INFO - 'SHELL': '/bin/bash', 07:49:20 INFO - 'SHLVL': '1', 07:49:20 INFO - 'TERM': 'linux', 07:49:20 INFO - 'TMOUT': '86400', 07:49:20 INFO - 'USER': 'cltbld', 07:49:20 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467211367.800440-534111710', 07:49:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:49:20 INFO - '_': '/tools/buildbot/bin/python'} 07:49:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:49:20 INFO - Downloading/unpacking psutil>=3.1.1 07:49:20 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 07:49:20 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 07:49:20 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 07:49:20 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 07:49:20 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 07:49:20 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 07:49:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:49:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:49:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:49:22 INFO - Installing collected packages: psutil 07:49:22 INFO - Running setup.py install for psutil 07:49:22 INFO - building 'psutil._psutil_linux' extension 07:49:22 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 07:49:22 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 07:49:22 INFO - building 'psutil._psutil_posix' extension 07:49:22 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 07:49:23 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 07:49:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:49:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:49:23 INFO - Successfully installed psutil 07:49:23 INFO - Cleaning up... 07:49:23 INFO - Return code: 0 07:49:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:49:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:49:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:49:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:49:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49:23 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 0x1fee030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22af180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ad3b0>, '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 0x22ae2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ae740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467211367.800440-534111710', '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 07:49:23 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 07:49:23 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 07:49:23 INFO - Using env: {'DISPLAY': ':0', 07:49:23 INFO - 'HOME': '/home/cltbld', 07:49:23 INFO - 'LANG': 'en_US.UTF-8', 07:49:23 INFO - 'LANGUAGE': 'en_US:en', 07:49:23 INFO - 'LOGNAME': 'cltbld', 07:49:23 INFO - 'MAIL': '/var/mail/cltbld', 07:49:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:49:23 INFO - 'MOZ_NO_REMOTE': '1', 07:49:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:49:23 INFO - 'NO_EM_RESTART': '1', 07:49:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:49:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:49:23 INFO - 'PWD': '/builds/slave/test', 07:49:23 INFO - 'SHELL': '/bin/bash', 07:49:23 INFO - 'SHLVL': '1', 07:49:23 INFO - 'TERM': 'linux', 07:49:23 INFO - 'TMOUT': '86400', 07:49:23 INFO - 'USER': 'cltbld', 07:49:23 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467211367.800440-534111710', 07:49:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:49:23 INFO - '_': '/tools/buildbot/bin/python'} 07:49:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:49:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:49:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:49:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:49:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:49:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:49:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:49:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:49:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:49:25 INFO - Installing collected packages: mozsystemmonitor 07:49:25 INFO - Running setup.py install for mozsystemmonitor 07:49:25 INFO - Successfully installed mozsystemmonitor 07:49:25 INFO - Cleaning up... 07:49:25 INFO - Return code: 0 07:49:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:49:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:49:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:49:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:49:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:49:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1fee030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22af180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ad3b0>, '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 0x22ae2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ae740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467211367.800440-534111710', '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 07:49:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:49:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:49:25 INFO - Using env: {'DISPLAY': ':0', 07:49:25 INFO - 'HOME': '/home/cltbld', 07:49:25 INFO - 'LANG': 'en_US.UTF-8', 07:49:25 INFO - 'LANGUAGE': 'en_US:en', 07:49:25 INFO - 'LOGNAME': 'cltbld', 07:49:25 INFO - 'MAIL': '/var/mail/cltbld', 07:49:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:49:25 INFO - 'MOZ_NO_REMOTE': '1', 07:49:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:49:25 INFO - 'NO_EM_RESTART': '1', 07:49:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:49:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:49:25 INFO - 'PWD': '/builds/slave/test', 07:49:25 INFO - 'SHELL': '/bin/bash', 07:49:25 INFO - 'SHLVL': '1', 07:49:25 INFO - 'TERM': 'linux', 07:49:25 INFO - 'TMOUT': '86400', 07:49:25 INFO - 'USER': 'cltbld', 07:49:25 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467211367.800440-534111710', 07:49:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:49:25 INFO - '_': '/tools/buildbot/bin/python'} 07:49:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:49:25 INFO - Downloading/unpacking jsonschema==2.5.1 07:49: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 07:49: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 07:49: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 07:49: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 07:49: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 07:49: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 07:49:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:49:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:49: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 07:49: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 07:49: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 07:49: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 07:49: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 07:49: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 07:49:27 INFO - Downloading functools32-3.2.3-2.tar.gz 07:49:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:49:27 INFO - warning: no files found matching '*.txt' 07:49:27 INFO - no previously-included directories found matching 'build' 07:49:27 INFO - no previously-included directories found matching 'dist' 07:49:27 INFO - no previously-included directories found matching '.git*' 07:49:27 INFO - Installing collected packages: jsonschema, functools32 07:49:27 INFO - Running setup.py install for functools32 07:49:27 INFO - warning: no files found matching '*.txt' 07:49:27 INFO - no previously-included directories found matching 'build' 07:49:27 INFO - no previously-included directories found matching 'dist' 07:49:27 INFO - no previously-included directories found matching '.git*' 07:49:28 INFO - Successfully installed jsonschema functools32 07:49:28 INFO - Cleaning up... 07:49:28 INFO - Return code: 0 07:49:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:49:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:49:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:49:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:49:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1fee030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22af180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ad3b0>, '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 0x22ae2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ae740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467211367.800440-534111710', '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 07:49:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:49:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:49:28 INFO - Using env: {'DISPLAY': ':0', 07:49:28 INFO - 'HOME': '/home/cltbld', 07:49:28 INFO - 'LANG': 'en_US.UTF-8', 07:49:28 INFO - 'LANGUAGE': 'en_US:en', 07:49:28 INFO - 'LOGNAME': 'cltbld', 07:49:28 INFO - 'MAIL': '/var/mail/cltbld', 07:49:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:49:28 INFO - 'MOZ_NO_REMOTE': '1', 07:49:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:49:28 INFO - 'NO_EM_RESTART': '1', 07:49:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:49:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:49:28 INFO - 'PWD': '/builds/slave/test', 07:49:28 INFO - 'SHELL': '/bin/bash', 07:49:28 INFO - 'SHLVL': '1', 07:49:28 INFO - 'TERM': 'linux', 07:49:28 INFO - 'TMOUT': '86400', 07:49:28 INFO - 'USER': 'cltbld', 07:49:28 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467211367.800440-534111710', 07:49:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:49:28 INFO - '_': '/tools/buildbot/bin/python'} 07:49:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:49:28 INFO - Downloading/unpacking blobuploader==1.2.4 07:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:49:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:49:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:49:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:49:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:49:30 INFO - Downloading blobuploader-1.2.4.tar.gz 07:49:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:49:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:49: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 07:49: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 07:49:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:49: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 07:49: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 07:49: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 07:49:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:49:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:49: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 07:49: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 07:49:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:49: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 07:49: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 07:49: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 07:49:30 INFO - Downloading docopt-0.6.1.tar.gz 07:49:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:49:30 INFO - Installing collected packages: blobuploader, requests, docopt 07:49:30 INFO - Running setup.py install for blobuploader 07:49:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:49:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:49:31 INFO - Running setup.py install for requests 07:49:31 INFO - Running setup.py install for docopt 07:49:31 INFO - Successfully installed blobuploader requests docopt 07:49:31 INFO - Cleaning up... 07:49:31 INFO - Return code: 0 07:49:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:49:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:49:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:49:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:49:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49:31 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 0x1fee030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22af180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ad3b0>, '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 0x22ae2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ae740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467211367.800440-534111710', '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 07:49:31 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 07:49:31 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 07:49:31 INFO - Using env: {'DISPLAY': ':0', 07:49:31 INFO - 'HOME': '/home/cltbld', 07:49:31 INFO - 'LANG': 'en_US.UTF-8', 07:49:31 INFO - 'LANGUAGE': 'en_US:en', 07:49:31 INFO - 'LOGNAME': 'cltbld', 07:49:31 INFO - 'MAIL': '/var/mail/cltbld', 07:49:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:49:31 INFO - 'MOZ_NO_REMOTE': '1', 07:49:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:49:31 INFO - 'NO_EM_RESTART': '1', 07:49:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:49:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:49:31 INFO - 'PWD': '/builds/slave/test', 07:49:31 INFO - 'SHELL': '/bin/bash', 07:49:31 INFO - 'SHLVL': '1', 07:49:31 INFO - 'TERM': 'linux', 07:49:31 INFO - 'TMOUT': '86400', 07:49:31 INFO - 'USER': 'cltbld', 07:49:31 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467211367.800440-534111710', 07:49:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:49:31 INFO - '_': '/tools/buildbot/bin/python'} 07:49:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:49:31 INFO - Running setup.py (path:/tmp/pip-PxJzRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:49:31 INFO - Running setup.py (path:/tmp/pip-dSIsfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:49:31 INFO - Running setup.py (path:/tmp/pip-o8KFE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:49:31 INFO - Running setup.py (path:/tmp/pip-kHsnDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:49:32 INFO - Running setup.py (path:/tmp/pip-aOqKsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:49:32 INFO - Running setup.py (path:/tmp/pip-rO_2xx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:49:32 INFO - Running setup.py (path:/tmp/pip-KpV67w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:49:32 INFO - Running setup.py (path:/tmp/pip-uGj7lL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:49:32 INFO - Running setup.py (path:/tmp/pip-No5oug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:49:32 INFO - Running setup.py (path:/tmp/pip-6ptJXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:49:32 INFO - Running setup.py (path:/tmp/pip-jEwRhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:49:32 INFO - Running setup.py (path:/tmp/pip-4ilpqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:49:32 INFO - Running setup.py (path:/tmp/pip-y6ZtMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:49:32 INFO - Running setup.py (path:/tmp/pip-fucGej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:49:32 INFO - Running setup.py (path:/tmp/pip-O5zNkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:49:32 INFO - Running setup.py (path:/tmp/pip-I42IeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:49:32 INFO - Running setup.py (path:/tmp/pip-MPSw9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:49:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:49:32 INFO - Running setup.py install for manifestparser 07:49:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:49:33 INFO - Running setup.py install for mozcrash 07:49:33 INFO - Running setup.py install for mozdebug 07:49:33 INFO - Running setup.py install for mozdevice 07:49:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:49:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:49:33 INFO - Running setup.py install for mozfile 07:49:33 INFO - Running setup.py install for mozhttpd 07:49:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:49:33 INFO - Running setup.py install for mozinfo 07:49:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:49:33 INFO - Running setup.py install for mozInstall 07:49:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:49:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:49:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:49:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:49:33 INFO - Running setup.py install for mozleak 07:49:33 INFO - Running setup.py install for mozlog 07:49:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:49:34 INFO - Running setup.py install for moznetwork 07:49:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:49:34 INFO - Running setup.py install for mozprocess 07:49:34 INFO - Running setup.py install for mozprofile 07:49:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:49:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:49:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:49:34 INFO - Running setup.py install for mozrunner 07:49:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:49:34 INFO - Running setup.py install for mozscreenshot 07:49:34 INFO - Running setup.py install for moztest 07:49:34 INFO - Running setup.py install for mozversion 07:49:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:49:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:49:34 INFO - Cleaning up... 07:49:34 INFO - Return code: 0 07:49:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:49:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:49:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:49:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:49:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49:34 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 0x1fee030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22af180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ad3b0>, '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 0x22ae2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ae740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467211367.800440-534111710', '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 07:49:34 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 07:49:34 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 07:49:34 INFO - Using env: {'DISPLAY': ':0', 07:49:34 INFO - 'HOME': '/home/cltbld', 07:49:34 INFO - 'LANG': 'en_US.UTF-8', 07:49:34 INFO - 'LANGUAGE': 'en_US:en', 07:49:34 INFO - 'LOGNAME': 'cltbld', 07:49:34 INFO - 'MAIL': '/var/mail/cltbld', 07:49:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:49:34 INFO - 'MOZ_NO_REMOTE': '1', 07:49:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:49:34 INFO - 'NO_EM_RESTART': '1', 07:49:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:49:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:49:34 INFO - 'PWD': '/builds/slave/test', 07:49:34 INFO - 'SHELL': '/bin/bash', 07:49:34 INFO - 'SHLVL': '1', 07:49:34 INFO - 'TERM': 'linux', 07:49:34 INFO - 'TMOUT': '86400', 07:49:34 INFO - 'USER': 'cltbld', 07:49:34 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467211367.800440-534111710', 07:49:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:49:34 INFO - '_': '/tools/buildbot/bin/python'} 07:49:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:49:35 INFO - Running setup.py (path:/tmp/pip-U3h4PZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:49:35 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)) 07:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:49:35 INFO - Running setup.py (path:/tmp/pip-Q_f9Yj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:49:35 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)) 07:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:49:35 INFO - Running setup.py (path:/tmp/pip-finR0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:49:35 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)) 07:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:49:35 INFO - Running setup.py (path:/tmp/pip-OygD85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:49:35 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)) 07:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:49:35 INFO - Running setup.py (path:/tmp/pip-hWFRJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:49:35 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)) 07:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:49:35 INFO - Running setup.py (path:/tmp/pip-5YAHvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:49:35 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)) 07:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:49:35 INFO - Running setup.py (path:/tmp/pip-_v6yxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:49:35 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)) 07:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:49:35 INFO - Running setup.py (path:/tmp/pip-dnH1On-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:49:35 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)) 07:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:49:35 INFO - Running setup.py (path:/tmp/pip-Whhy8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:49:35 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)) 07:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:49:35 INFO - Running setup.py (path:/tmp/pip-jPumGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:49:35 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)) 07:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:49:35 INFO - Running setup.py (path:/tmp/pip-J_C2Wc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:49:35 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)) 07:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:49:35 INFO - Running setup.py (path:/tmp/pip-78lmQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:49:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:49:35 INFO - Running setup.py (path:/tmp/pip-yBshN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:49:35 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)) 07:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:49:35 INFO - Running setup.py (path:/tmp/pip-z7Li9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:49:36 INFO - Running setup.py (path:/tmp/pip-6KFzHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:49:36 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)) 07:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:49:36 INFO - Running setup.py (path:/tmp/pip-jGENdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:49:36 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)) 07:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:49:36 INFO - Running setup.py (path:/tmp/pip-oOdvB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:49:36 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)) 07:49:36 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)) 07:49:36 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)) 07:49:36 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)) 07:49:36 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)) 07:49:36 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)) 07:49:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:49:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:49:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:49:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:49:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:49:38 INFO - Downloading blessings-1.6.tar.gz 07:49:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:49:38 INFO - Installing collected packages: blessings 07:49:38 INFO - Running setup.py install for blessings 07:49:38 INFO - Successfully installed blessings 07:49:38 INFO - Cleaning up... 07:49:38 INFO - Return code: 0 07:49:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:49:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:49:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:49:38 INFO - Reading from file tmpfile_stdout 07:49:38 INFO - Current package versions: 07:49:38 INFO - argparse == 1.2.1 07:49:38 INFO - blessings == 1.6 07:49:38 INFO - blobuploader == 1.2.4 07:49:38 INFO - docopt == 0.6.1 07:49:38 INFO - functools32 == 3.2.3-2 07:49:38 INFO - jsonschema == 2.5.1 07:49:38 INFO - manifestparser == 1.1 07:49:38 INFO - mozInstall == 1.12 07:49:38 INFO - mozcrash == 0.17 07:49:38 INFO - mozdebug == 0.1 07:49:38 INFO - mozdevice == 0.48 07:49:38 INFO - mozfile == 1.2 07:49:38 INFO - mozhttpd == 0.7 07:49:38 INFO - mozinfo == 0.9 07:49:38 INFO - mozleak == 0.1 07:49:38 INFO - mozlog == 3.2 07:49:38 INFO - moznetwork == 0.27 07:49:38 INFO - mozprocess == 0.22 07:49:38 INFO - mozprofile == 0.28 07:49:38 INFO - mozrunner == 6.11 07:49:38 INFO - mozscreenshot == 0.1 07:49:38 INFO - mozsystemmonitor == 0.3 07:49:38 INFO - moztest == 0.7 07:49:38 INFO - mozversion == 1.4 07:49:38 INFO - psutil == 3.1.1 07:49:38 INFO - requests == 1.2.3 07:49:38 INFO - wsgiref == 0.1.2 07:49:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:49:38 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')]} 07:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:49:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49:38 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')]} 07:49:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:49:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49:38 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 0x1fee030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22af180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ad3b0>, '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 0x22ae2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ae740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467211367.800440-534111710', '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 07:49:38 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 07:49:38 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 07:49:38 INFO - Using env: {'DISPLAY': ':0', 07:49:38 INFO - 'HOME': '/home/cltbld', 07:49:38 INFO - 'LANG': 'en_US.UTF-8', 07:49:38 INFO - 'LANGUAGE': 'en_US:en', 07:49:38 INFO - 'LOGNAME': 'cltbld', 07:49:38 INFO - 'MAIL': '/var/mail/cltbld', 07:49:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:49:38 INFO - 'MOZ_NO_REMOTE': '1', 07:49:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:49:38 INFO - 'NO_EM_RESTART': '1', 07:49:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:49:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:49:38 INFO - 'PWD': '/builds/slave/test', 07:49:38 INFO - 'SHELL': '/bin/bash', 07:49:38 INFO - 'SHLVL': '1', 07:49:38 INFO - 'TERM': 'linux', 07:49:38 INFO - 'TMOUT': '86400', 07:49:38 INFO - 'USER': 'cltbld', 07:49:38 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467211367.800440-534111710', 07:49:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:49:38 INFO - '_': '/tools/buildbot/bin/python'} 07:49:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:49:38 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)) 07:49:38 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)) 07:49:38 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)) 07:49:38 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)) 07:49:38 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)) 07:49:38 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)) 07:49:38 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)) 07:49:38 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)) 07:49:38 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)) 07:49:38 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)) 07:49:38 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)) 07:49:38 INFO - Cleaning up... 07:49:38 INFO - Return code: 0 07:49:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:49:38 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')]} 07:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:49:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49:38 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')]} 07:49:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:49:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49:38 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 0x1fee030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22af180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ad3b0>, '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 0x22ae2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ae740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467211367.800440-534111710', '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 07:49:38 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 07:49:38 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 07:49:38 INFO - Using env: {'DISPLAY': ':0', 07:49:38 INFO - 'HOME': '/home/cltbld', 07:49:38 INFO - 'LANG': 'en_US.UTF-8', 07:49:38 INFO - 'LANGUAGE': 'en_US:en', 07:49:38 INFO - 'LOGNAME': 'cltbld', 07:49:38 INFO - 'MAIL': '/var/mail/cltbld', 07:49:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:49:38 INFO - 'MOZ_NO_REMOTE': '1', 07:49:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:49:38 INFO - 'NO_EM_RESTART': '1', 07:49:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:49:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:49:38 INFO - 'PWD': '/builds/slave/test', 07:49:38 INFO - 'SHELL': '/bin/bash', 07:49:38 INFO - 'SHLVL': '1', 07:49:38 INFO - 'TERM': 'linux', 07:49:38 INFO - 'TMOUT': '86400', 07:49:38 INFO - 'USER': 'cltbld', 07:49:38 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467211367.800440-534111710', 07:49:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:49:38 INFO - '_': '/tools/buildbot/bin/python'} 07:49:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:49:39 INFO - Cleaning up... 07:49:39 INFO - Return code: 0 07:49:39 INFO - Running post-action listener: _resource_record_post_action 07:49:39 INFO - Running post-action listener: _start_resource_monitoring 07:49:39 INFO - Starting resource monitoring. 07:49:39 INFO - ##### 07:49:39 INFO - ##### Finished create-virtualenv step (success) 07:49:39 INFO - ##### 07:49:39 INFO - ##### 07:49:39 INFO - ##### Running install step. 07:49:39 INFO - ##### 07:49:39 INFO - Running pre-action listener: _resource_record_pre_action 07:49:39 INFO - Running main action method: install 07:49:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:49:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:49:39 INFO - Reading from file tmpfile_stdout 07:49:39 INFO - Detecting whether we're running mozinstall >=1.0... 07:49:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:49:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:49:39 INFO - Reading from file tmpfile_stdout 07:49:39 INFO - Output received: 07:49:39 INFO - Usage: mozinstall [options] installer 07:49:39 INFO - Options: 07:49:39 INFO - -h, --help show this help message and exit 07:49:39 INFO - -d DEST, --destination=DEST 07:49:39 INFO - Directory to install application into. [default: 07:49:39 INFO - "/builds/slave/test"] 07:49:39 INFO - --app=APP Application being installed. [default: firefox] 07:49:39 INFO - mkdir: /builds/slave/test/build/application 07:49:39 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'] 07:49:39 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 07:49:56 INFO - Reading from file tmpfile_stdout 07:49:56 INFO - Output received: 07:49:56 INFO - /builds/slave/test/build/application/firefox/firefox 07:49:56 INFO - Running post-action listener: _resource_record_post_action 07:49:56 INFO - ##### 07:49:56 INFO - ##### Finished install step (success) 07:49:56 INFO - ##### 07:49:56 INFO - ##### 07:49:56 INFO - ##### Running run-tests step. 07:49:56 INFO - ##### 07:49:56 INFO - Running pre-action listener: _resource_record_pre_action 07:49:56 INFO - Running main action method: run_tests 07:49:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:49:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:49:56 INFO - Python 2.7.3 07:49:56 INFO - Return code: 0 07:49:56 INFO - grabbing minidump binary from tooltool 07:49:56 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')]} 07:49:56 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 0x22ad3b0>, '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 0x22ae2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ae740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:49:56 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 07:49:56 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 07:49:56 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 07:49:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:49:56 INFO - Return code: 0 07:49:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:49:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:49:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:49:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:49:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:49:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RGIsLmdCQoKBMiO512mSaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 07:49:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RGIsLmdCQoKBMiO512mSaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --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 07:49:56 INFO - Using env: {'DISPLAY': ':0', 07:49:56 INFO - 'HOME': '/home/cltbld', 07:49:56 INFO - 'LANG': 'en_US.UTF-8', 07:49:56 INFO - 'LANGUAGE': 'en_US:en', 07:49:56 INFO - 'LOGNAME': 'cltbld', 07:49:56 INFO - 'MAIL': '/var/mail/cltbld', 07:49:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:49:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:49:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:49:56 INFO - 'MOZ_NO_REMOTE': '1', 07:49:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:49:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:49:56 INFO - 'NO_EM_RESTART': '1', 07:49:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:49:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:49:56 INFO - 'PWD': '/builds/slave/test', 07:49:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:49:56 INFO - 'SHELL': '/bin/bash', 07:49:56 INFO - 'SHLVL': '1', 07:49:56 INFO - 'TERM': 'linux', 07:49:56 INFO - 'TMOUT': '86400', 07:49:56 INFO - 'USER': 'cltbld', 07:49:56 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467211367.800440-534111710', 07:49:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:49:56 INFO - '_': '/tools/buildbot/bin/python'} 07:49:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RGIsLmdCQoKBMiO512mSaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 07:49:56 INFO - mozversion application_buildid: 20160629045731 07:49:56 INFO - mozversion application_changeset: 72993ec9d3030d7d479a0da71551a17fc490124f 07:49:56 INFO - mozversion application_display_name: Nightly 07:49:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:49:56 INFO - mozversion application_name: Firefox 07:49:56 INFO - mozversion application_remotingname: firefox 07:49:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:49:56 INFO - mozversion application_vendor: Mozilla 07:49:56 INFO - mozversion application_version: 50.0a1 07:49:56 INFO - mozversion platform_buildid: 20160629045731 07:49:56 INFO - mozversion platform_changeset: 72993ec9d3030d7d479a0da71551a17fc490124f 07:49:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:49:56 INFO - mozversion platform_version: 50.0a1 07:49:56 INFO - using testdate: 1467211796 07:49:56 INFO - actual date: 1467211796 07:49:56 INFO - starting webserver on 'localhost:56700' 07:49:56 INFO - SUITE-START | Running 2 tests 07:49:56 INFO - TEST-START | dromaeo_css 07:49:56 INFO - operating with platform_type : linux_ 07:49:56 INFO - Initialising browser for dromaeo_css test... 07:49:56 INFO - TEST-INFO | started process 29281 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUm599h/profile http://localhost:56700/getInfo.html) 07:50:00 INFO - PROCESS | 29281 | __metrics Screen width/height:1600/1200 07:50:00 INFO - PROCESS | 29281 | colorDepth:24 07:50:00 INFO - PROCESS | 29281 | Browser inner width/height: 1024/697 07:50:00 INFO - PROCESS | 29281 | __metrics 07:50:01 INFO - PROCESS | 29281 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:50:02 INFO - TEST-INFO | 29281: exit 0 07:50:02 INFO - Browser initialized. 07:50:02 INFO - Running cycle 1/1 for dromaeo_css test... 07:50:02 INFO - TEST-INFO | started process 29368 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUm599h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:50:14 INFO - PROCESS | 29368 | RSS: Main: 157650944 07:50:14 INFO - PROCESS | 29368 | 07:51:06 INFO - PROCESS | 29368 | 1467211866012 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] 07:53:14 INFO - PROCESS | 29368 | Cycle 1(1): loaded http://localhost:56700/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56700/tests/dromaeo/cssquery-ext.html) 07:53:15 INFO - PROCESS | 29368 | RSS: Main: 278335488 07:53:15 INFO - PROCESS | 29368 | 07:56:17 INFO - PROCESS | 29368 | Cycle 1(1): loaded http://localhost:56700/tests/dromaeo/cssquery-ext.html (next: http://localhost:56700/tests/dromaeo/cssquery-jquery.html) 07:56:18 INFO - PROCESS | 29368 | RSS: Main: 234487808 07:56:18 INFO - PROCESS | 29368 | 07:59:20 INFO - PROCESS | 29368 | Cycle 1(1): loaded http://localhost:56700/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56700/tests/dromaeo/cssquery-mootools.html) 07:59:20 INFO - PROCESS | 29368 | RSS: Main: 237551616 07:59:20 INFO - PROCESS | 29368 | 08:02:22 INFO - PROCESS | 29368 | Cycle 1(1): loaded http://localhost:56700/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56700/tests/dromaeo/cssquery-prototype.html) 08:02:23 INFO - PROCESS | 29368 | RSS: Main: 234369024 08:02:23 INFO - PROCESS | 29368 | 08:05:26 INFO - PROCESS | 29368 | Cycle 1(1): loaded http://localhost:56700/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56700/tests/dromaeo/cssquery-yui.html) 08:05:26 INFO - PROCESS | 29368 | RSS: Main: 228040704 08:05:26 INFO - PROCESS | 29368 | 08:08:29 INFO - PROCESS | 29368 | Cycle 1(1): loaded http://localhost:56700/tests/dromaeo/cssquery-yui.html (next: http://localhost:56700/tests/dromaeo/cssquery-dojo.html) 08:08:30 INFO - PROCESS | 29368 | RSS: Main: 269160448 08:08:30 INFO - PROCESS | 29368 | 08:08:30 INFO - PROCESS | 29368 | __start_tp_report 08:08:30 INFO - PROCESS | 29368 | _x_x_mozilla_page_load 08:08:30 INFO - PROCESS | 29368 | _x_x_mozilla_page_load_details 08:08:30 INFO - PROCESS | 29368 | |i|pagename|runs| 08:08:30 INFO - PROCESS | 29368 | |0;dojo.html;3143.355612099519;3145.779795414322;3165.5884734984447;3186.537951996962;3206.871725130995;5235.607329450288;5330.067238233303;5423.701696406696;5512.33851937768;5531.474509921561;5422.267993820833;5481;5487.506124448799;5534.308211473566;5623.690697011673;4969.776360063805;5057.0897238497055;5070.5183007614405;5089.949100509003;5103.157978933472;5098.719570423644;5109.540141387274;5113.207452844815;5154.201098829687;5156.845294641148;4832.830850920236;4866.221404575251;4872.244802055651;5026.497350264981;5033.194688849785;4917.606591472673;4932.8766780830765;4934.40787105546;4936.432310284292;4962.578180854632;4920.680155789898;4922.26166075088;4937.481564435719;4942.5304596063315;4976.776045077981;5507;5524.972375138099;5543.223948647193;5553.72231388433;5554.91667624986;5633.380328163898;5846.473817356416;5877.706114694248;5957.1957785698805;5971.522278217775;5932.466078052996;6046.27444706638;6053.303870054956;6061;6067.089936509559;5586.55307575393;5634.352049514277;5637.3517045539875;5638.661680299195;5642.379338272786;5900.350961394243;5972.970135149383;6034.2155519782145;6043.8186854394435;6101.755929762849;5827.067669172912;5837.941620583825;5883.529317654577;5885.323187833368;5893.793717219876;5936.109583562414;5976.133460648181;5990.221271234712;5990.670513121733;5990.7304171311525;5574.275344205227;5832.096025116114;5881.705914704247;5892.322382925932;5929.851753706192;5923.052311630118;5937.940620593825;5944;5944.4352786485215;5949.345571987078;4389.824407023747;4457.064016556559;4504.121696269196;4505.752183629932;4548.909021819545;3900.863469778544;3916.1971795781797;3967.7024223183375;4003.499562554681;4044.0698639312536;5600.383957764642;5617.157426386075;5622.381538030813;5633.436656334416;5635.605507614509;5742.052561327418;5846.912296315559;5925.674087925119;5927.1405646181065;5961.105834124829;5618.831435056954;5649.4633009864;5672.4894759471845;5680.5455563554815;5727.05503591911;5124.948750512522;5131.692098474029;5131.743412829418;5134.229865520202;5177.404598471148;5957.851053723692;6059.48494377974;6123.173371594778;6217.720202590804;6229.56393052482;5938.851528711817;5946.494547963472;5952.702364881652;5956.731947062306;5996.310424301261;6147.815565533041;6149.907751383822;6157.938420615916;6158.753649853956;6159.630422174684;5665.065264231355;5718.313802343745;5753.252077229933;5789.79735709265;5810.883782324246;5860.882782344414;5930.347661757117;5942.257217847769;5951.613145145551;5952.494038006645;5670.262865827416;5716.42835716425;5773.8556536086935;5777.62445441045;5782.653040817564;5572.944270557405;5626.493615574618;5640.097584386478;5679.091345384719;5730.169125476866;5606.6636001840025;5624.100143976944;5626.859328516656;5630.943690563042;5643.209950607001;5585.078462053878;5738.110592858114;5766.798162064308;5825.737841797045;5835.241418615553;5449.264349312792;5492.862678433071;5619.241402410622;5623.606347555796;5667.659940403589 08:08:30 INFO - PROCESS | 29368 | |1;ext.html;588.3381196154327;605.9424354686305;624.5908929651079;629.8173529676397;635.1140159477532;30099.24751881201;33160;43868.56131438688;44694.32958505617;44799;45167.257437968954;45527.089458210816;45527.77236113823;45559.77220113895;45631;8127.349812015054;9010.423175944215;9153.771155721128;9170.266378689688;9172.357934944523;10664.093552048085;10945.507452164631;10955.56177752889;11343.659690209266;11366.659000230007;10914.126869850394;11001.559937602486;11015.559377624926;11020.063294619968;11021.228514004022;8078.7172448964;10753.139748820076;10823;10881.619143329985;10906.727331816688;10477.63328283514;10876.945615271952;10881.12950963921;10892.128629709605;10908.890911090866;42736.35895461571;43133;43179.136417271795;43305.783471082446;43382.78308608468;2952.3800001999607;3621.149029977953;3751.5498140223076;3840.8271627776817;3913.6477717005605;33051.3389732204;35090.12274693127;35111.96212435577;35145.64854351475;35151;4404.515503294635;4551.4083169188125;4563.70335928167;4609.631229501631;4614.884627884297;408150;408435;408668;409346;410942;64792.352076479576;65312.67343663251;65394;65395;65740.34259657342;39491.2101757969;40182.59817401847;40291.798541007694;42120.57879421228;67842;17774.555636109202;17966.101694915204;18026.36907708224;18058;18071.186796594186;12466.189697669623;13680.589582312547;13791.655208619864;13957.58127256184;13981.720365592631;21014.47463813417;21043.15827366919;21112.9443527823;21185.364439066852;21190.15239390438;7794.883076753853;7882.369410447265;7984.600769961478;8039.155888631726;8066.83866322682;1012.1902478017556;1063.197286049028;1115.4534278203785;1119.9776004480027;1158.7740390623746;33589.66410335866;33778.49332260018;33876.120529755244;33880.49179262313;34475.65524344725;1138.5104405105883;1146.1747541769912;1160.4081918221768;1188.786018516658;1200.273834330235;17603;17731.37940172088;17736.822631773517;17838.732419013726;17900.46298611018;601917;607751;609449;610892;611557;59720.701396493605;60634.39365606376;60705.39294607086;60753;60754.39245607487;1268.2834198677717;1369.4932874836375;1386.9944290389387;1389.4025569005425;1415.035500626166;32974.83512582422;33854;33945;34482.65517344794;34643.30713385668;51455.22817157821;51839.74080129726;51873.22190167075;51906.74046629743;51946.74026629994;404720;410392;412515;412670;412834;26457.603135953363;29295.414091718474;29654.851725741235;29830;32049.198770030936;48352.27471587999;49110;49764;50109.74945125251;50521.49478505168;41576.168476630904;41734.37398439086;41837.37243941282;42265;42946.35580466358;42124.57875421329;42238.57761422346;42627;42653.146937061705;43335.34996974985;38057;38121.42817857679;38354.232915342094;38781;42246.366304504845;36056.63943360533;37149.25701485901;37571;37928;38229.80885095557;28995.85502072476;29359.853200733858;29380.853095734383;29676.406471870872;29724.256893577833 08:08:30 INFO - PROCESS | 29368 | |2;jquery.html;402.3662731198363;402.873094975083;410.3454989292079;410.554548315078;418.3432011741567;18660.813391866093;20456.284030058952;20479.283225087125;20516.384508464733;21601;19926.302579409723;20514.46141539383;20747.174110756874;20912.26807061753;20976.685349719766;5549.77800887965;5795.739191736361;5805.36141024487;5806.042003069489;5809.215755872967;5631.099024156136;5712.314522257314;5727.684977326267;5798.2172406725185;5800.5788581797515;5608.4391560844;5701.800436984707;5714.142878568227;5726.3700992890745;5743.885122297573;5653.660780353192;5722.055860782966;5727.398623144572;5774.566907481913;5786.855328616818;5178.559822415099;5192.532672059495;5213.869653258661;5214.478552144793;5216.713080780555;23185.188518401945;24430.755692443025;24556.754432455626;24711.258662239983;24922.750772492407;2496.1388321029217;2509.849409035464;2682.9865850670817;2711.7288271172924;3105.7515398768046;15022.323995420233;15166.69150891839;15451.150186739726;15564;15565.688686226213;1982.3161009451717;2003.7795842457317;2025.2810252360348;2050.8872012039333;2132.893355332227;87936.56031719864;89830;90809.54595226982;91511.08488915092;91894;10972.780544389068;11035.282706624204;11135.610253641084;11160.944195278971;11350.318980861175;15718.607034823992;15784.526464206092;15835.920820395824;15882.205889705469;15898.443554475538;8453.112423195598;8701.17338852808;8745.169208925143;8836.425632334007;8883.200511953955;8607.311415086779;8609.182127697859;8621.310295176496;8775.648974041094;8777.517236551923;6640.970649549327;6790.354916282945;6839.316068393121;6877.105976223059;6933.722651094001;1797.640471905624;1861.3950466098572;1932.3719791067679;1990.2636024670965;2031.3499680102225;979.7844474215661;1017.6285655735751;1042.2704107125044;1058.3544038136731;1058.3635994272195;20638.17447302091;20841.166353345696;21000.264990725253;21018;21187.78812211889;1016.5120742043713;1028.6142696488816;1037.3101887245048;1076.5586109694987;1093.6227001684406;11327;11994.580189693319;12102.273863568214;12105;12183.208091474025;471442;478529;478934;486498;490675;87109.12890871137;89888;91123.54438227766;91581.5420922891;91695;1039.7608550033535;1069.609592498717;1080.1250986700798;1101.4107452512867;1103.5199688135688;15046.398144074114;18626.44120676382;19035;19077.80922190816;19315;42726;43553;43560.564394356916;43652.34521482244;44412.11175776531;53712.462875370744;55019.72490137524;55454.44545554493;56063;56114.719426402604;7930.325922296439;8480.575971201291;8870.201681848665;8902.109789021306;9399.624015039595;13670.863291366959;13913.443462261395;14185.645358865699;14261.24367605472;14346.856531434552;12496.93751531273;12503.4373453193;12625.81061284063;12784.808227876776;12837.358132093545;5402.270693456333;9937.503124843874;12054.879451205376;12245.448954796877;12338.938305308417;12744.61766147017;12883.291418972047;12921.353932303535;12941.223526588436;13032.348382581024;8144.348452123934;8554.57227138653;8792.868106978272;8799.648014079621;8815.955920220358;12292.508299667914;12398.81401778992;12487;12675.112742108333;12744 08:08:30 INFO - PROCESS | 29368 | |3;mootools.html;1453.186215719197;1502.5792778022153;1627.5361521966236;1756.9648607027852;1785.1609743420588;8633.913660863389;9189.816203675922;9304.441733495994;9307.813843723121;9327.20718738908;7884.881726774103;8675.305975521958;8900.19898209161;8940.687075952343;9240.445573265592;2433.367324495631;2462.310553045141;2468.3212116667883;2475.9752402476015;2476.158106243877;2052.538178909741;2407.410184504799;2478.330850670318;2486.714027886789;2487.179230853814;2341.321016905104;2421.6609674645565;2432.72023717273;2443.6701045358914;2450.571150048743;2405.8436201646837;2417.613181890898;2419.9395015124674;2426.7694569015916;2429.9028038878423;2397.520495900827;2407.8796060197096;2408.879556022192;2413.408714864869;2434.6226334918115;9066.821313229239;9112.772180695536;9126.13301736334;9134.77163070922;9143;5460.754266058037;5479.863003424906;5523.502884740353;5524.14375771756;5528.391876893538;3528.400171970771;3585.551806024247;3616.2948225096115;3646.033801042726;3657.487951686766;1187.7505723797926;1228.2753175626333;1233.8889499944958;1241.050596293836;1255.9372031398393;12556.623301300884;12561.183523071062;12571.497140114385;12593.433295501633;12674.619761407173;4746.715197088117;4839.927401088987;4960.156773348539;5003.049420610072;5015.498450154955;10725.892741072645;10760.461976901124;10766.46167691628;10775.245732798785;10781.137508999262;5566.944330556643;5572.080606699849;5576.219329293902;5577.609567330248;5578.721063946787;5014.448410674823;5099.184130539096;5108.565771909355;5119.769610367543;5120.641555091108;4134.235166494208;4152.771597562102;4214.093969796509;4222.978885105555;4260.488741351058;1223.247702662856;1298.337847697662;1338.1569611144917;1367.6649220940933;1412.032757561074;984.5717113055844;990.5245482168456;996.1283876607968;1011.3325205364424;1012.2003617142375;6162.414570615784;6207.379262073757;6311.33730958252;6337.809865704036;6403.711832967528;947.0860619502214;987.7185002274317;1004.2367800471694;1036.5698235232444;1036.5801850250662;4311.719738217006;4320.978395108067;4352.73883566987;4384.7369157850635;4413.183561041154;10576.52405641748;11000.834987475195;11009.06422954058;11012.834807477895;11017.283876548;10259.640912568024;10854.620088296871;10931.890681093246;10965.122790176927;11067.280626759235;8199.836003279901;8432;8614.310855131574;8644.78388040304;8667.609957551926;6311.463525600192;6459.741610335534;6573.441257493167;6577.967110164419;6648.867022659617;10501.369917804956;10699.090577301016;10833.783324333312;11107.83338249943;11123.443827808738;10761.139108871428;10995.34027958325;11161;11163.051140653135;11288.153388495732;8278.089410164997;8295.709650162456;8376.581170941306;8389.538575378412;8452.830943380975;8428.45215061019;8435.95782021086;8463.788405289917;8505.489670619536;8515.02077261123;7706.267904549059;7988.960055199686;8001.599920004093;8014.053789682317;8014.118446970712;7807;7834;8020.157883422156;8071.556064416513;8078.23256790604;6973.965130174317;7100.112485939258;7190.5326153801925;7191.964040179766;7194.748183813751;5137.768800403916;5155.407128180157;5205.271262023395;5263.315768950012;5275.076861549291;5339.759710812945;5390.62265641417;5514.117741161395;5518.310211223597;5530.91703624454 08:08:30 INFO - PROCESS | 29368 | |4;prototype.html;333.44314993960086;346.7416774502994;352.40795463621106;352.73721077797035;355.46325049175744;5379.596530260232;5448.8365349039495;5456.863578410542;5468.398476167618;5506.201600767887;5351.411344752074;5353.946460535393;5437.6465529740535;5437.71615921313;5443.727813609324;4196.601322874322;4305.26810442224;4318.589733975267;4332.830135863315;4339.761313127777;4236.4916210054835;4262.893427664318;4278.42241297424;4288.52826189119;4297.183535128315;4015.07653239755;4242.766647834368;4263.594958478955;4266.829326826939;4285.99279169395;3915.686745060388;4041.6564592009713;4140.3375459926265;4150.771707556083;4218.620324170839;3758.6805121564425;3772.8868133956025;3806.020869148055;3808.9428658570146;3821.2739579479808;5226.634135610509;5251.715503755879;5257.316548848664;5276.0214919405225;5295.735213239361;4643.396358473411;4709.71741695496;4834.613230941516;4855.781489832966;4901.950980490185;5557.972210138963;5558.138488534284;5560.6941618210985;5593.52455041322;5599.524040456566;4146.543880173179;4191.1827193697245;4207;4208.3687446882905;4210.536840947493;5528.226048353234;5692.6299790513485;5749.770009199627;5834.708264586796;5838.386969368197;4079.224947260011;4093.953023488256;4115.71190016702;4225.556316586714;4325.502567204749;4322.956770432318;4364.650827933758;4374.431323927933;4374.890627734332;4385.824567017347;4794.352762377104;4805.711657300573;4896.2410826321975;4936.950630493721;4938;5647.407022262603;5659.179418984224;5664.801731939362;5666.235058267163;5684.459976302244;1469.1846025455975;1483.5326872035275;1492.8656420921952;1493.089215578518;1494.2528735632184;953.5565961827783;996.2080146283722;1001.1640280365976;1006.3961623026125;1017.5268500147467;4789.568938795455;4798.256270278042;4823.782929768169;4893.608511319086;4914.287428322873;5051.6716413433005;5078.365204349457;5089.4147173074825;5109.335786347825;5121.4878512149235;4496.213162696515;4804.495527969582;4810.037992401533;4831.637627177975;4859.805607775649;2678.5312570300507;2679.825811322258;2709.647745793034;2710.3766133788945;2724.346156922364;5198.350206224222;5240.502152295526;5276.868078297996;5281.392639846466;5298.28473156119;5153.814622636814;5210.6613070150315;5493.890122197534;5925.318588362307;5960.821175364746;6020.969895150496;6031.909521357183;6058.303295121029;6071.210742603434;6078.6871155220515;5528.391876893619;5823.679697616672;5861.413858614104;5915.704214789157;5937.554683398676;5775.81595772874;5778.739956701875;5807.593468457168;5810.663547384041;5815.476607105212;5786.594938354275;5912.586118971631;5917.497012753965;5999.080294305781;6000.369961154016;4171.144915292297;4172.949223625694;4198.307279298881;4231.40760293553;4236.78816059202;5709.343425505954;5868.119782032729;5872.618279811799;5888.381719919346;5921.911171332347;5592.692401917933;5598.816461580069;5612.793249451388;5619.466150715675;5630.690312032713;5619.831405057855;5626.324841019104;5628.85927851807;5654.236678048411;5712.686082201034;5412.7293635318865;5518.91721624184;5552.305961754781;5553.0559804832465;5558.360788509373;5570.660322664409;5649.4350564944825;5658;5665.546756259571;5700.429957004267;5405.540529055074;5552.445315311719;5554.527865131509;5568.526675232489;5597.356304025089 08:08:30 INFO - PROCESS | 29368 | |5;yui.html;726.0887586079469;732.0556482138043;740.2523451314174;754.1478129713424;833.8248967716779;13979.580612581613;14726.926365368172;14776.852231477695;14789.556313310592;14791.92604036981;12024;14814.111153330809;15524.301406436709;16208.432704855333;16283.51149465515;784.5057613703373;799.9840003199962;811.3955103447939;811.8741595052746;814.7555733280022;794.031281836159;796.1998191817215;798.4051881348374;798.648594618366;798.7763426240662;696.216756149332;826.6734639817269;844.2823599940033;855.5593869157389;858.6222062292571;836.8535506286375;838.0697425857294;840.2269911681268;840.3235395506615;842.2798507276314;611.5046812082184;614.6435067660746;615.1019511513196;615.178736386924;615.3538784276536;14715.63210919725;14718.0433271837;14736.263186840722;14741.041832280867;14751.26243687822;14377.928110359486;14874.405023799143;14912.62718432037;15704.450344237897;15894.125823079727;12197.878021219763;12735;13072.542461013914;13227.66930826737;13452.1256118352;3966.3257246267917;3975.987299067264;4043.716939814214;4080.489938757655;4095.9180816383805;75428.62285688591;75979;76217;77226.22773772247;77467.61266193633;11197.16021298406;11233.66299011031;11301.773964520664;11375.658730238107;11640.35978021217;21318.57362852734;21503.89248053781;21783.782162178493;23548.764512355;23570.0571977119;8646.308295336357;8675.089115642766;8685.131486851264;8755.605997730117;8807.691730789391;4649.465311489222;4853.150698627726;4856.198727210041;4914.483979182206;4922.163232250526;3526.453399723047;3693.9630603693618;3811.4282857571584;3815.790131542736;3819.694424446038;714.8248679073661;726.7165805335924;737.0676094740159;746.6975874770726;747.9364254038468;660.8543333731473;738.1474397071391;744.5681504727245;777.5995362388375;781.3397678961269;9763.365381250196;9780.31537792362;9906.356086854332;10045.748856278506;10632;691.778630838127;734.6840858430819;776.6311002273987;777.4907435629672;793.80551764818;4570.840020599263;4620.561046700558;4628.629709623289;4641.164590373698;4678.368420263289;110054;114256;114560;117899.41050294694;120605;102252.48873755583;105325.47337263418;106180;106896;107316.46341768398;92115;92234.53882730678;92766;93815.53092234631;94130;9700.369475984038;9748.221756799278;9770.120689138012;9883;9943.900560994298;52049.739751301;52509.474905250456;52928.73535632297;53703.46296536984;54510.18234726562;73313.96773177526;78616.60691696504;80220;81055.59472202837;81910.54268371958;12768.74462510763;12993.155444896052;13048.217106973612;13377.799333009818;13455.932720336727;13417.329133543479;13608.93195534016;13670.52153174634;13959.162450253018;15125.924370378518;10087.495625218857;14053.437862485385;14230.288485575888;14442;15464.072155670696;14643.63390915193;14961.850381496046;15104.924475377553;15712.76430853561;15751.291191896164;13123.146995445266;13428.328583570978;14088.22514761657;14526.128432294096;15369.462068827537;11560.884391155982;11947.701307467383;12256.88656029202;12322.568710095104;12623.116381853182;11359.375234362189;11363.318200907972;11811.409429528661;12357.443915023665;12419.689507762378 08:08:30 INFO - PROCESS | 29368 | __end_tp_report 08:08:30 INFO - PROCESS | 29368 | __start_cc_report 08:08:30 INFO - PROCESS | 29368 | _x_x_mozilla_cycle_collect,998 08:08:30 INFO - PROCESS | 29368 | __end_cc_report 08:08:30 INFO - PROCESS | 29368 | __startTimestamp1467212909997__endTimestamp 08:08:30 INFO - PROCESS | 29368 | 08:08:30 INFO - PROCESS | 29368 | ------- Summary: start ------- 08:08:30 INFO - PROCESS | 29368 | Number of tests: 6 08:08:30 INFO - PROCESS | 29368 | 08:08:30 INFO - PROCESS | 29368 | [#0] dojo.html Cycles:165 Average:5477.22 Median:5638.66 stddev:637.23 (11.3%) stddev-sans-first:612.32 08:08:30 INFO - PROCESS | 29368 | Values: 3143.4 3145.8 3165.6 3186.5 3206.9 5235.6 5330.1 5423.7 5512.3 5531.5 5422.3 5481.0 5487.5 5534.3 5623.7 4969.8 5057.1 5070.5 5089.9 5103.2 5098.7 5109.5 5113.2 5154.2 5156.8 4832.8 4866.2 4872.2 5026.5 5033.2 4917.6 4932.9 4934.4 4936.4 4962.6 4920.7 4922.3 4937.5 4942.5 4976.8 5507.0 5525.0 5543.2 5553.7 5554.9 5633.4 5846.5 5877.7 5957.2 5971.5 5932.5 6046.3 6053.3 6061.0 6067.1 5586.6 5634.4 5637.4 5638.7 5642.4 5900.4 5973.0 6034.2 6043.8 6101.8 5827.1 5837.9 5883.5 5885.3 5893.8 5936.1 5976.1 5990.2 5990.7 5990.7 5574.3 5832.1 5881.7 5892.3 5929.9 5923.1 5937.9 5944.0 5944.4 5949.3 4389.8 4457.1 4504.1 4505.8 4548.9 3900.9 3916.2 3967.7 4003.5 4044.1 5600.4 5617.2 5622.4 5633.4 5635.6 5742.1 5846.9 5925.7 5927.1 5961.1 5618.8 5649.5 5672.5 5680.5 5727.1 5124.9 5131.7 5131.7 5134.2 5177.4 5957.9 6059.5 6123.2 6217.7 6229.6 5938.9 5946.5 5952.7 5956.7 5996.3 6147.8 6149.9 6157.9 6158.8 6159.6 5665.1 5718.3 5753.3 5789.8 5810.9 5860.9 5930.3 5942.3 5951.6 5952.5 5670.3 5716.4 5773.9 5777.6 5782.7 5572.9 5626.5 5640.1 5679.1 5730.2 5606.7 5624.1 5626.9 5630.9 5643.2 5585.1 5738.1 5766.8 5825.7 5835.2 5449.3 5492.9 5619.2 5623.6 5667.7 08:08:30 INFO - PROCESS | 29368 | 08:08:30 INFO - PROCESS | 29368 | [#1] ext.html Cycles:180 Average:63742.37 Median:38292.02 stddev:128841.49 (336.5%) stddev-sans-first:129115.67 08:08:30 INFO - PROCESS | 29368 | Values: 588.3 605.9 624.6 629.8 635.1 30099.2 33160.0 43868.6 44694.3 44799.0 45167.3 45527.1 45527.8 45559.8 45631.0 8127.3 9010.4 9153.8 9170.3 9172.4 10664.1 10945.5 10955.6 11343.7 11366.7 10914.1 11001.6 11015.6 11020.1 11021.2 8078.7 10753.1 10823.0 10881.6 10906.7 10477.6 10876.9 10881.1 10892.1 10908.9 42736.4 43133.0 43179.1 43305.8 43382.8 2952.4 3621.1 3751.5 3840.8 3913.6 33051.3 35090.1 35112.0 35145.6 35151.0 4404.5 4551.4 4563.7 4609.6 4614.9 408150.0 408435.0 408668.0 409346.0 410942.0 64792.4 65312.7 65394.0 65395.0 65740.3 39491.2 40182.6 40291.8 42120.6 67842.0 17774.6 17966.1 18026.4 18058.0 18071.2 12466.2 13680.6 13791.7 13957.6 13981.7 21014.5 21043.2 21112.9 21185.4 21190.2 7794.9 7882.4 7984.6 8039.2 8066.8 1012.2 1063.2 1115.5 1120.0 1158.8 33589.7 33778.5 33876.1 33880.5 34475.7 1138.5 1146.2 1160.4 1188.8 1200.3 17603.0 17731.4 17736.8 17838.7 17900.5 601917.0 607751.0 609449.0 610892.0 611557.0 59720.7 60634.4 60705.4 60753.0 60754.4 1268.3 1369.5 1387.0 1389.4 1415.0 32974.8 33854.0 33945.0 34482.7 34643.3 51455.2 51839.7 51873.2 51906.7 51946.7 404720.0 410392.0 412515.0 412670.0 412834.0 26457.6 29295.4 29654.9 29830.0 32049.2 48352.3 49110.0 49764.0 50109.7 50521.5 41576.2 41734.4 41837.4 42265.0 42946.4 42124.6 42238.6 42627.0 42653.1 43335.3 38057.0 38121.4 38354.2 38781.0 42246.4 36056.6 37149.3 37571.0 37928.0 38229.8 28995.9 29359.9 29380.9 29676.4 29724.3 08:08:30 INFO - PROCESS | 29368 | 08:08:30 INFO - PROCESS | 29368 | [#2] jquery.html Cycles:180 Average:29498.03 Median:24817.00 stddev:79427.54 (320.1%) stddev-sans-first:79620.31 08:08:30 INFO - PROCESS | 29368 | Values: 402.4 402.9 410.3 410.6 418.3 18660.8 20456.3 20479.3 20516.4 21601.0 19926.3 20514.5 20747.2 20912.3 20976.7 5549.8 5795.7 5805.4 5806.0 5809.2 5631.1 5712.3 5727.7 5798.2 5800.6 5608.4 5701.8 5714.1 5726.4 5743.9 5653.7 5722.1 5727.4 5774.6 5786.9 5178.6 5192.5 5213.9 5214.5 5216.7 23185.2 24430.8 24556.8 24711.3 24922.8 2496.1 2509.8 2683.0 2711.7 3105.8 15022.3 15166.7 15451.2 15564.0 15565.7 1982.3 2003.8 2025.3 2050.9 2132.9 87936.6 89830.0 90809.5 91511.1 91894.0 10972.8 11035.3 11135.6 11160.9 11350.3 15718.6 15784.5 15835.9 15882.2 15898.4 8453.1 8701.2 8745.2 8836.4 8883.2 8607.3 8609.2 8621.3 8775.6 8777.5 6641.0 6790.4 6839.3 6877.1 6933.7 1797.6 1861.4 1932.4 1990.3 2031.3 979.8 1017.6 1042.3 1058.4 1058.4 20638.2 20841.2 21000.3 21018.0 21187.8 1016.5 1028.6 1037.3 1076.6 1093.6 11327.0 11994.6 12102.3 12105.0 12183.2 471442.0 478529.0 478934.0 486498.0 490675.0 87109.1 89888.0 91123.5 91581.5 91695.0 1039.8 1069.6 1080.1 1101.4 1103.5 15046.4 18626.4 19035.0 19077.8 19315.0 42726.0 43553.0 43560.6 43652.3 44412.1 53712.5 55019.7 55454.4 56063.0 56114.7 7930.3 8480.6 8870.2 8902.1 9399.6 13670.9 13913.4 14185.6 14261.2 14346.9 12496.9 12503.4 12625.8 12784.8 12837.4 5402.3 9937.5 12054.9 12245.4 12338.9 12744.6 12883.3 12921.4 12941.2 13032.3 8144.3 8554.6 8792.9 8799.6 8816.0 12292.5 12398.8 12487.0 12675.1 12744.0 08:08:30 INFO - PROCESS | 29368 | 08:08:30 INFO - PROCESS | 29368 | [#3] mootools.html Cycles:180 Average:6038.41 Median:4793.32 stddev:3386.79 (70.7%) stddev-sans-first:3378.76 08:08:30 INFO - PROCESS | 29368 | Values: 1453.2 1502.6 1627.5 1757.0 1785.2 8633.9 9189.8 9304.4 9307.8 9327.2 7884.9 8675.3 8900.2 8940.7 9240.4 2433.4 2462.3 2468.3 2476.0 2476.2 2052.5 2407.4 2478.3 2486.7 2487.2 2341.3 2421.7 2432.7 2443.7 2450.6 2405.8 2417.6 2419.9 2426.8 2429.9 2397.5 2407.9 2408.9 2413.4 2434.6 9066.8 9112.8 9126.1 9134.8 9143.0 5460.8 5479.9 5523.5 5524.1 5528.4 3528.4 3585.6 3616.3 3646.0 3657.5 1187.8 1228.3 1233.9 1241.1 1255.9 12556.6 12561.2 12571.5 12593.4 12674.6 4746.7 4839.9 4960.2 5003.0 5015.5 10725.9 10760.5 10766.5 10775.2 10781.1 5566.9 5572.1 5576.2 5577.6 5578.7 5014.4 5099.2 5108.6 5119.8 5120.6 4134.2 4152.8 4214.1 4223.0 4260.5 1223.2 1298.3 1338.2 1367.7 1412.0 984.6 990.5 996.1 1011.3 1012.2 6162.4 6207.4 6311.3 6337.8 6403.7 947.1 987.7 1004.2 1036.6 1036.6 4311.7 4321.0 4352.7 4384.7 4413.2 10576.5 11000.8 11009.1 11012.8 11017.3 10259.6 10854.6 10931.9 10965.1 11067.3 8199.8 8432.0 8614.3 8644.8 8667.6 6311.5 6459.7 6573.4 6578.0 6648.9 10501.4 10699.1 10833.8 11107.8 11123.4 10761.1 10995.3 11161.0 11163.1 11288.2 8278.1 8295.7 8376.6 8389.5 8452.8 8428.5 8436.0 8463.8 8505.5 8515.0 7706.3 7989.0 8001.6 8014.1 8014.1 7807.0 7834.0 8020.2 8071.6 8078.2 6974.0 7100.1 7190.5 7192.0 7194.7 5137.8 5155.4 5205.3 5263.3 5275.1 5339.8 5390.6 5514.1 5518.3 5530.9 08:08:30 INFO - PROCESS | 29368 | 08:08:30 INFO - PROCESS | 29368 | [#4] prototype.html Cycles:180 Average:4688.43 Median:5218.65 stddev:1361.67 (26.1%) stddev-sans-first:1325.68 08:08:30 INFO - PROCESS | 29368 | Values: 333.4 346.7 352.4 352.7 355.5 5379.6 5448.8 5456.9 5468.4 5506.2 5351.4 5353.9 5437.6 5437.7 5443.7 4196.6 4305.3 4318.6 4332.8 4339.8 4236.5 4262.9 4278.4 4288.5 4297.2 4015.1 4242.8 4263.6 4266.8 4286.0 3915.7 4041.7 4140.3 4150.8 4218.6 3758.7 3772.9 3806.0 3808.9 3821.3 5226.6 5251.7 5257.3 5276.0 5295.7 4643.4 4709.7 4834.6 4855.8 4902.0 5558.0 5558.1 5560.7 5593.5 5599.5 4146.5 4191.2 4207.0 4208.4 4210.5 5528.2 5692.6 5749.8 5834.7 5838.4 4079.2 4094.0 4115.7 4225.6 4325.5 4323.0 4364.7 4374.4 4374.9 4385.8 4794.4 4805.7 4896.2 4937.0 4938.0 5647.4 5659.2 5664.8 5666.2 5684.5 1469.2 1483.5 1492.9 1493.1 1494.3 953.6 996.2 1001.2 1006.4 1017.5 4789.6 4798.3 4823.8 4893.6 4914.3 5051.7 5078.4 5089.4 5109.3 5121.5 4496.2 4804.5 4810.0 4831.6 4859.8 2678.5 2679.8 2709.6 2710.4 2724.3 5198.4 5240.5 5276.9 5281.4 5298.3 5153.8 5210.7 5493.9 5925.3 5960.8 6021.0 6031.9 6058.3 6071.2 6078.7 5528.4 5823.7 5861.4 5915.7 5937.6 5775.8 5778.7 5807.6 5810.7 5815.5 5786.6 5912.6 5917.5 5999.1 6000.4 4171.1 4172.9 4198.3 4231.4 4236.8 5709.3 5868.1 5872.6 5888.4 5921.9 5592.7 5598.8 5612.8 5619.5 5630.7 5619.8 5626.3 5628.9 5654.2 5712.7 5412.7 5518.9 5552.3 5553.1 5558.4 5570.7 5649.4 5658.0 5665.5 5700.4 5405.5 5552.4 5554.5 5568.5 5597.4 08:08:30 INFO - PROCESS | 29368 | 08:08:30 INFO - PROCESS | 29368 | [#5] yui.html Cycles:180 Average:21542.70 Median:4088.20 stddev:31126.99 (761.4%) stddev-sans-first:31175.06 08:08:30 INFO - PROCESS | 29368 | Values: 726.1 732.1 740.3 754.1 833.8 13979.6 14726.9 14776.9 14789.6 14791.9 12024.0 14814.1 15524.3 16208.4 16283.5 784.5 800.0 811.4 811.9 814.8 794.0 796.2 798.4 798.6 798.8 696.2 826.7 844.3 855.6 858.6 836.9 838.1 840.2 840.3 842.3 611.5 614.6 615.1 615.2 615.4 14715.6 14718.0 14736.3 14741.0 14751.3 14377.9 14874.4 14912.6 15704.5 15894.1 12197.9 12735.0 13072.5 13227.7 13452.1 3966.3 3976.0 4043.7 4080.5 4095.9 75428.6 75979.0 76217.0 77226.2 77467.6 11197.2 11233.7 11301.8 11375.7 11640.4 21318.6 21503.9 21783.8 23548.8 23570.1 8646.3 8675.1 8685.1 8755.6 8807.7 4649.5 4853.2 4856.2 4914.5 4922.2 3526.5 3694.0 3811.4 3815.8 3819.7 714.8 726.7 737.1 746.7 747.9 660.9 738.1 744.6 777.6 781.3 9763.4 9780.3 9906.4 10045.7 10632.0 691.8 734.7 776.6 777.5 793.8 4570.8 4620.6 4628.6 4641.2 4678.4 110054.0 114256.0 114560.0 117899.4 120605.0 102252.5 105325.5 106180.0 106896.0 107316.5 92115.0 92234.5 92766.0 93815.5 94130.0 9700.4 9748.2 9770.1 9883.0 9943.9 52049.7 52509.5 52928.7 53703.5 54510.2 73314.0 78616.6 80220.0 81055.6 81910.5 12768.7 12993.2 13048.2 13377.8 13455.9 13417.3 13608.9 13670.5 13959.2 15125.9 10087.5 14053.4 14230.3 14442.0 15464.1 14643.6 14961.9 15104.9 15712.8 15751.3 13123.1 13428.3 14088.2 14526.1 15369.5 11560.9 11947.7 12256.9 12322.6 12623.1 11359.4 11363.3 11811.4 12357.4 12419.7 08:08:30 INFO - PROCESS | 29368 | -------- Summary: end -------- 08:08:30 INFO - PROCESS | 29368 | 08:08:30 INFO - TEST-INFO | 29368: exit 0 08:08:30 INFO - TEST-OK | dromaeo_css | took 1113953ms 08:08:30 INFO - TEST-START | kraken 08:08:30 INFO - operating with platform_type : linux_ 08:08:30 INFO - Initialising browser for kraken test... 08:08:30 INFO - TEST-INFO | started process 29567 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYJh7u8/profile http://localhost:56700/getInfo.html) 08:08:34 INFO - PROCESS | 29567 | __metrics Screen width/height:1600/1200 08:08:34 INFO - PROCESS | 29567 | colorDepth:24 08:08:34 INFO - PROCESS | 29567 | Browser inner width/height: 1024/697 08:08:34 INFO - PROCESS | 29567 | __metrics 08:08:35 INFO - PROCESS | 29567 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:08:36 INFO - PROCESS | 29567 | console.error: PushService: 08:08:36 INFO - PROCESS | 29567 | stateChangeProcessEnqueue: Error transitioning state 08:08:36 INFO - PROCESS | 29567 | UnknownError 08:08:36 INFO - TEST-INFO | 29567: exit 0 08:08:36 INFO - Browser initialized. 08:08:36 INFO - Running cycle 1/1 for kraken test... 08:08:36 INFO - TEST-INFO | started process 29647 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYJh7u8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:08:48 INFO - PROCESS | 29647 | RSS: Main: 156876800 08:08:48 INFO - PROCESS | 29647 | 08:08:50 INFO - PROCESS | 29647 | Cycle 1(1): loaded http://localhost:56700/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56700/tests/kraken/driver.html?testName=audio-beat-detection) 08:08:51 INFO - PROCESS | 29647 | RSS: Main: 214675456 08:08:51 INFO - PROCESS | 29647 | 08:08:54 INFO - PROCESS | 29647 | Cycle 1(1): loaded http://localhost:56700/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56700/tests/kraken/driver.html?testName=audio-dft) 08:08:54 INFO - PROCESS | 29647 | RSS: Main: 202444800 08:08:54 INFO - PROCESS | 29647 | 08:08:57 INFO - PROCESS | 29647 | Cycle 1(1): loaded http://localhost:56700/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56700/tests/kraken/driver.html?testName=audio-fft) 08:08:58 INFO - PROCESS | 29647 | RSS: Main: 269242368 08:08:58 INFO - PROCESS | 29647 | 08:09:00 INFO - PROCESS | 29647 | Cycle 1(1): loaded http://localhost:56700/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56700/tests/kraken/driver.html?testName=audio-oscillator) 08:09:01 INFO - PROCESS | 29647 | RSS: Main: 180191232 08:09:01 INFO - PROCESS | 29647 | 08:09:03 INFO - PROCESS | 29647 | Cycle 1(1): loaded http://localhost:56700/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56700/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:09:04 INFO - PROCESS | 29647 | RSS: Main: 185036800 08:09:04 INFO - PROCESS | 29647 | 08:09:07 INFO - PROCESS | 29647 | Cycle 1(1): loaded http://localhost:56700/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56700/tests/kraken/driver.html?testName=imaging-darkroom) 08:09:07 INFO - PROCESS | 29647 | RSS: Main: 219312128 08:09:07 INFO - PROCESS | 29647 | 08:09:10 INFO - PROCESS | 29647 | Cycle 1(1): loaded http://localhost:56700/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56700/tests/kraken/driver.html?testName=imaging-desaturate) 08:09:11 INFO - PROCESS | 29647 | RSS: Main: 221712384 08:09:11 INFO - PROCESS | 29647 | 08:09:14 INFO - PROCESS | 29647 | Cycle 1(1): loaded http://localhost:56700/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56700/tests/kraken/driver.html?testName=json-parse-financial) 08:09:15 INFO - PROCESS | 29647 | RSS: Main: 221401088 08:09:15 INFO - PROCESS | 29647 | 08:09:16 INFO - PROCESS | 29647 | Cycle 1(1): loaded http://localhost:56700/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56700/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:09:17 INFO - PROCESS | 29647 | RSS: Main: 209125376 08:09:17 INFO - PROCESS | 29647 | 08:09:18 INFO - PROCESS | 29647 | Cycle 1(1): loaded http://localhost:56700/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56700/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:09:19 INFO - PROCESS | 29647 | RSS: Main: 210718720 08:09:19 INFO - PROCESS | 29647 | 08:09:21 INFO - PROCESS | 29647 | Cycle 1(1): loaded http://localhost:56700/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56700/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:09:22 INFO - PROCESS | 29647 | RSS: Main: 209707008 08:09:22 INFO - PROCESS | 29647 | 08:09:24 INFO - PROCESS | 29647 | Cycle 1(1): loaded http://localhost:56700/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56700/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:09:25 INFO - PROCESS | 29647 | RSS: Main: 226332672 08:09:25 INFO - PROCESS | 29647 | 08:09:27 INFO - PROCESS | 29647 | Cycle 1(1): loaded http://localhost:56700/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56700/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:09:28 INFO - PROCESS | 29647 | RSS: Main: 225595392 08:09:28 INFO - PROCESS | 29647 | 08:09:30 INFO - PROCESS | 29647 | Cycle 1(1): loaded http://localhost:56700/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56700/tests/kraken/driver.html?testName=ai-astar) 08:09:30 INFO - PROCESS | 29647 | RSS: Main: 268505088 08:09:30 INFO - PROCESS | 29647 | 08:09:30 INFO - PROCESS | 29647 | __start_tp_report 08:09:30 INFO - PROCESS | 29647 | _x_x_mozilla_page_load 08:09:30 INFO - PROCESS | 29647 | _x_x_mozilla_page_load_details 08:09:30 INFO - PROCESS | 29647 | |i|pagename|runs| 08:09:30 INFO - PROCESS | 29647 | |0;ai-astar;100;110;109;109;110;109;108;109;108;108 08:09:30 INFO - PROCESS | 29647 | |1;audio-beat-detection;149;118;120;169;121;123;143;122;153;117 08:09:30 INFO - PROCESS | 29647 | |2;audio-dft;161;160;159;161;159;161;159;162;162;161 08:09:30 INFO - PROCESS | 29647 | |3;audio-fft;74;75;75;107;75;76;75;74;98;75 08:09:30 INFO - PROCESS | 29647 | |4;audio-oscillator;83;83;115;84;84;84;131;83;83;122 08:09:30 INFO - PROCESS | 29647 | |5;imaging-gaussian-blur;117;117;116;116;116;117;117;117;117;117 08:09:30 INFO - PROCESS | 29647 | |6;imaging-darkroom;146;146;146;146;145;146;146;146;146;146 08:09:30 INFO - PROCESS | 29647 | |7;imaging-desaturate;95;95;95;95;95;95;94;96;96;95 08:09:30 INFO - PROCESS | 29647 | |8;json-parse-financial;52;52;52;52;53;55;52;54;52;52 08:09:30 INFO - PROCESS | 29647 | |9;json-stringify-tinderbox;61;60;61;61;69;62;62;62;60;61 08:09:30 INFO - PROCESS | 29647 | |10;stanford-crypto-aes;75;75;79;74;84;78;74;75;80;77 08:09:30 INFO - PROCESS | 29647 | |11;stanford-crypto-ccm;125;119;116;118;133;123;133;119;172;130 08:09:30 INFO - PROCESS | 29647 | |12;stanford-crypto-pbkdf2;163;154;157;155;156;156;155;156;158;157 08:09:30 INFO - PROCESS | 29647 | |13;stanford-crypto-sha256-iterative;65;64;63;64;64;67;63;64;66;62 08:09:30 INFO - PROCESS | 29647 | __end_tp_report 08:09:30 INFO - PROCESS | 29647 | __start_cc_report 08:09:30 INFO - PROCESS | 29647 | _x_x_mozilla_cycle_collect,1632 08:09:30 INFO - PROCESS | 29647 | __end_cc_report 08:09:30 INFO - PROCESS | 29647 | __startTimestamp1467212970471__endTimestamp 08:09:30 INFO - PROCESS | 29647 | 08:09:30 INFO - PROCESS | 29647 | ------- Summary: start ------- 08:09:30 INFO - PROCESS | 29647 | Number of tests: 14 08:09:30 INFO - PROCESS | 29647 | 08:09:30 INFO - PROCESS | 29647 | [#0] ai-astar Cycles:10 Average:108.00 Median:109.00 stddev:2.91 (2.7%) stddev-sans-first:0.78 08:09:30 INFO - PROCESS | 29647 | Values: 100.0 110.0 109.0 109.0 110.0 109.0 108.0 109.0 108.0 108.0 08:09:30 INFO - PROCESS | 29647 | 08:09:30 INFO - PROCESS | 29647 | [#1] audio-beat-detection Cycles:10 Average:133.50 Median:133.00 stddev:18.45 (13.9%) stddev-sans-first:18.70 08:09:30 INFO - PROCESS | 29647 | Values: 149.0 118.0 120.0 169.0 121.0 123.0 143.0 122.0 153.0 117.0 08:09:30 INFO - PROCESS | 29647 | 08:09:30 INFO - PROCESS | 29647 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:1.18 (0.7%) stddev-sans-first:1.24 08:09:30 INFO - PROCESS | 29647 | Values: 161.0 160.0 159.0 161.0 159.0 161.0 159.0 162.0 162.0 161.0 08:09:30 INFO - PROCESS | 29647 | 08:09:30 INFO - PROCESS | 29647 | [#3] audio-fft Cycles:10 Average:80.40 Median:75.00 stddev:11.85 (15.8%) stddev-sans-first:12.34 08:09:30 INFO - PROCESS | 29647 | Values: 74.0 75.0 75.0 107.0 75.0 76.0 75.0 74.0 98.0 75.0 08:09:30 INFO - PROCESS | 29647 | 08:09:30 INFO - PROCESS | 29647 | [#4] audio-oscillator Cycles:10 Average:95.20 Median:83.00 stddev:19.33 (23.3%) stddev-sans-first:19.99 08:09:30 INFO - PROCESS | 29647 | Values: 83.0 83.0 115.0 84.0 84.0 84.0 131.0 83.0 83.0 122.0 08:09:30 INFO - PROCESS | 29647 | 08:09:30 INFO - PROCESS | 29647 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 08:09:30 INFO - PROCESS | 29647 | Values: 117.0 117.0 116.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 08:09:30 INFO - PROCESS | 29647 | 08:09:30 INFO - PROCESS | 29647 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 08:09:30 INFO - PROCESS | 29647 | Values: 146.0 146.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 08:09:30 INFO - PROCESS | 29647 | 08:09:30 INFO - PROCESS | 29647 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 08:09:30 INFO - PROCESS | 29647 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 96.0 96.0 95.0 08:09:30 INFO - PROCESS | 29647 | 08:09:30 INFO - PROCESS | 29647 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:52.00 stddev:1.07 (2.1%) stddev-sans-first:1.12 08:09:30 INFO - PROCESS | 29647 | Values: 52.0 52.0 52.0 52.0 53.0 55.0 52.0 54.0 52.0 52.0 08:09:30 INFO - PROCESS | 29647 | 08:09:30 INFO - PROCESS | 29647 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:61.50 stddev:2.60 (4.2%) stddev-sans-first:2.74 08:09:30 INFO - PROCESS | 29647 | Values: 61.0 60.0 61.0 61.0 69.0 62.0 62.0 62.0 60.0 61.0 08:09:30 INFO - PROCESS | 29647 | 08:09:30 INFO - PROCESS | 29647 | [#10] stanford-crypto-aes Cycles:10 Average:77.10 Median:77.50 stddev:3.21 (4.1%) stddev-sans-first:3.32 08:09:30 INFO - PROCESS | 29647 | Values: 75.0 75.0 79.0 74.0 84.0 78.0 74.0 75.0 80.0 77.0 08:09:30 INFO - PROCESS | 29647 | 08:09:30 INFO - PROCESS | 29647 | [#11] stanford-crypto-ccm Cycles:10 Average:128.80 Median:127.50 stddev:16.41 (12.9%) stddev-sans-first:17.35 08:09:30 INFO - PROCESS | 29647 | Values: 125.0 119.0 116.0 118.0 133.0 123.0 133.0 119.0 172.0 130.0 08:09:30 INFO - PROCESS | 29647 | 08:09:30 INFO - PROCESS | 29647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.70 Median:156.50 stddev:2.50 (1.6%) stddev-sans-first:1.22 08:09:30 INFO - PROCESS | 29647 | Values: 163.0 154.0 157.0 155.0 156.0 156.0 155.0 156.0 158.0 157.0 08:09:30 INFO - PROCESS | 29647 | 08:09:30 INFO - PROCESS | 29647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.00 stddev:1.48 (2.3%) stddev-sans-first:1.54 08:09:30 INFO - PROCESS | 29647 | Values: 65.0 64.0 63.0 64.0 64.0 67.0 63.0 64.0 66.0 62.0 08:09:30 INFO - PROCESS | 29647 | -------- Summary: end -------- 08:09:30 INFO - PROCESS | 29647 | 08:09:31 INFO - TEST-INFO | 29647: exit 0 08:09:31 INFO - TEST-OK | kraken | took 60681ms 08:09:31 INFO - SUITE-END | took 1174s 08:09:31 INFO - Completed test suite (00:19:34) 08:09:31 INFO - javascript benchmark 08:09:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3143.355612099519, 3145.779795414322, 3165.5884734984447, 3186.537951996962, 3206.871725130995, 5235.607329450288, 5330.067238233303, 5423.701696406696, 5512.33851937768, 5531.474509921561, 5422.267993820833, 5481.0, 5487.506124448799, 5534.308211473566, 5623.690697011673, 4969.776360063805, 5057.0897238497055, 5070.5183007614405, 5089.949100509003, 5103.157978933472, 5098.719570423644, 5109.540141387274, 5113.207452844815, 5154.201098829687, 5156.845294641148, 4832.830850920236, 4866.221404575251, 4872.244802055651, 5026.497350264981, 5033.194688849785, 4917.606591472673, 4932.8766780830765, 4934.40787105546, 4936.432310284292, 4962.578180854632, 4920.680155789898, 4922.26166075088, 4937.481564435719, 4942.5304596063315, 4976.776045077981, 5507.0, 5524.972375138099, 5543.223948647193, 5553.72231388433, 5554.91667624986, 5633.380328163898, 5846.473817356416, 5877.706114694248, 5957.1957785698805, 5971.522278217775, 5932.466078052996, 6046.27444706638, 6053.303870054956, 6061.0, 6067.089936509559, 5586.55307575393, 5634.352049514277, 5637.3517045539875, 5638.661680299195, 5642.379338272786, 5900.350961394243, 5972.970135149383, 6034.2155519782145, 6043.8186854394435, 6101.755929762849, 5827.067669172912, 5837.941620583825, 5883.529317654577, 5885.323187833368, 5893.793717219876, 5936.109583562414, 5976.133460648181, 5990.221271234712, 5990.670513121733, 5990.7304171311525, 5574.275344205227, 5832.096025116114, 5881.705914704247, 5892.322382925932, 5929.851753706192, 5923.052311630118, 5937.940620593825, 5944.0, 5944.4352786485215, 5949.345571987078, 4389.824407023747, 4457.064016556559, 4504.121696269196, 4505.752183629932, 4548.909021819545, 3900.863469778544, 3916.1971795781797, 3967.7024223183375, 4003.499562554681, 4044.0698639312536, 5600.383957764642, 5617.157426386075, 5622.381538030813, 5633.436656334416, 5635.605507614509, 5742.052561327418, 5846.912296315559, 5925.674087925119, 5927.1405646181065, 5961.105834124829, 5618.831435056954, 5649.4633009864, 5672.4894759471845, 5680.5455563554815, 5727.05503591911, 5124.948750512522, 5131.692098474029, 5131.743412829418, 5134.229865520202, 5177.404598471148, 5957.851053723692, 6059.48494377974, 6123.173371594778, 6217.720202590804, 6229.56393052482, 5938.851528711817, 5946.494547963472, 5952.702364881652, 5956.731947062306, 5996.310424301261, 6147.815565533041, 6149.907751383822, 6157.938420615916, 6158.753649853956, 6159.630422174684, 5665.065264231355, 5718.313802343745, 5753.252077229933, 5789.79735709265, 5810.883782324246, 5860.882782344414, 5930.347661757117, 5942.257217847769, 5951.613145145551, 5952.494038006645, 5670.262865827416, 5716.42835716425, 5773.8556536086935, 5777.62445441045, 5782.653040817564, 5572.944270557405, 5626.493615574618, 5640.097584386478, 5679.091345384719, 5730.169125476866, 5606.6636001840025, 5624.100143976944, 5626.859328516656, 5630.943690563042, 5643.209950607001, 5585.078462053878, 5738.110592858114, 5766.798162064308, 5825.737841797045, 5835.241418615553, 5449.264349312792, 5492.862678433071, 5619.241402410622, 5623.606347555796, 5667.659940403589], "value": 5433.187396131447, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.3381196154327, 605.9424354686305, 624.5908929651079, 629.8173529676397, 635.1140159477532, 30099.24751881201, 33160.0, 43868.56131438688, 44694.32958505617, 44799.0, 45167.257437968954, 45527.089458210816, 45527.77236113823, 45559.77220113895, 45631.0, 8127.349812015054, 9010.423175944215, 9153.771155721128, 9170.266378689688, 9172.357934944523, 10664.093552048085, 10945.507452164631, 10955.56177752889, 11343.659690209266, 11366.659000230007, 10914.126869850394, 11001.559937602486, 11015.559377624926, 11020.063294619968, 11021.228514004022, 8078.7172448964, 10753.139748820076, 10823.0, 10881.619143329985, 10906.727331816688, 10477.63328283514, 10876.945615271952, 10881.12950963921, 10892.128629709605, 10908.890911090866, 42736.35895461571, 43133.0, 43179.136417271795, 43305.783471082446, 43382.78308608468, 2952.3800001999607, 3621.149029977953, 3751.5498140223076, 3840.8271627776817, 3913.6477717005605, 33051.3389732204, 35090.12274693127, 35111.96212435577, 35145.64854351475, 35151.0, 4404.515503294635, 4551.4083169188125, 4563.70335928167, 4609.631229501631, 4614.884627884297, 408150.0, 408435.0, 408668.0, 409346.0, 410942.0, 64792.352076479576, 65312.67343663251, 65394.0, 65395.0, 65740.34259657342, 39491.2101757969, 40182.59817401847, 40291.798541007694, 42120.57879421228, 67842.0, 17774.555636109202, 17966.101694915204, 18026.36907708224, 18058.0, 18071.186796594186, 12466.189697669623, 13680.589582312547, 13791.655208619864, 13957.58127256184, 13981.720365592631, 21014.47463813417, 21043.15827366919, 21112.9443527823, 21185.364439066852, 21190.15239390438, 7794.883076753853, 7882.369410447265, 7984.600769961478, 8039.155888631726, 8066.83866322682, 1012.1902478017556, 1063.197286049028, 1115.4534278203785, 1119.9776004480027, 1158.7740390623746, 33589.66410335866, 33778.49332260018, 33876.120529755244, 33880.49179262313, 34475.65524344725, 1138.5104405105883, 1146.1747541769912, 1160.4081918221768, 1188.786018516658, 1200.273834330235, 17603.0, 17731.37940172088, 17736.822631773517, 17838.732419013726, 17900.46298611018, 601917.0, 607751.0, 609449.0, 610892.0, 611557.0, 59720.701396493605, 60634.39365606376, 60705.39294607086, 60753.0, 60754.39245607487, 1268.2834198677717, 1369.4932874836375, 1386.9944290389387, 1389.4025569005425, 1415.035500626166, 32974.83512582422, 33854.0, 33945.0, 34482.65517344794, 34643.30713385668, 51455.22817157821, 51839.74080129726, 51873.22190167075, 51906.74046629743, 51946.74026629994, 404720.0, 410392.0, 412515.0, 412670.0, 412834.0, 26457.603135953363, 29295.414091718474, 29654.851725741235, 29830.0, 32049.198770030936, 48352.27471587999, 49110.0, 49764.0, 50109.74945125251, 50521.49478505168, 41576.168476630904, 41734.37398439086, 41837.37243941282, 42265.0, 42946.35580466358, 42124.57875421329, 42238.57761422346, 42627.0, 42653.146937061705, 43335.34996974985, 38057.0, 38121.42817857679, 38354.232915342094, 38781.0, 42246.366304504845, 36056.63943360533, 37149.25701485901, 37571.0, 37928.0, 38229.80885095557, 28995.85502072476, 29359.853200733858, 29380.853095734383, 29676.406471870872, 29724.256893577833], "value": 21158.588138402185, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.3662731198363, 402.873094975083, 410.3454989292079, 410.554548315078, 418.3432011741567, 18660.813391866093, 20456.284030058952, 20479.283225087125, 20516.384508464733, 21601.0, 19926.302579409723, 20514.46141539383, 20747.174110756874, 20912.26807061753, 20976.685349719766, 5549.77800887965, 5795.739191736361, 5805.36141024487, 5806.042003069489, 5809.215755872967, 5631.099024156136, 5712.314522257314, 5727.684977326267, 5798.2172406725185, 5800.5788581797515, 5608.4391560844, 5701.800436984707, 5714.142878568227, 5726.3700992890745, 5743.885122297573, 5653.660780353192, 5722.055860782966, 5727.398623144572, 5774.566907481913, 5786.855328616818, 5178.559822415099, 5192.532672059495, 5213.869653258661, 5214.478552144793, 5216.713080780555, 23185.188518401945, 24430.755692443025, 24556.754432455626, 24711.258662239983, 24922.750772492407, 2496.1388321029217, 2509.849409035464, 2682.9865850670817, 2711.7288271172924, 3105.7515398768046, 15022.323995420233, 15166.69150891839, 15451.150186739726, 15564.0, 15565.688686226213, 1982.3161009451717, 2003.7795842457317, 2025.2810252360348, 2050.8872012039333, 2132.893355332227, 87936.56031719864, 89830.0, 90809.54595226982, 91511.08488915092, 91894.0, 10972.780544389068, 11035.282706624204, 11135.610253641084, 11160.944195278971, 11350.318980861175, 15718.607034823992, 15784.526464206092, 15835.920820395824, 15882.205889705469, 15898.443554475538, 8453.112423195598, 8701.17338852808, 8745.169208925143, 8836.425632334007, 8883.200511953955, 8607.311415086779, 8609.182127697859, 8621.310295176496, 8775.648974041094, 8777.517236551923, 6640.970649549327, 6790.354916282945, 6839.316068393121, 6877.105976223059, 6933.722651094001, 1797.640471905624, 1861.3950466098572, 1932.3719791067679, 1990.2636024670965, 2031.3499680102225, 979.7844474215661, 1017.6285655735751, 1042.2704107125044, 1058.3544038136731, 1058.3635994272195, 20638.17447302091, 20841.166353345696, 21000.264990725253, 21018.0, 21187.78812211889, 1016.5120742043713, 1028.6142696488816, 1037.3101887245048, 1076.5586109694987, 1093.6227001684406, 11327.0, 11994.580189693319, 12102.273863568214, 12105.0, 12183.208091474025, 471442.0, 478529.0, 478934.0, 486498.0, 490675.0, 87109.12890871137, 89888.0, 91123.54438227766, 91581.5420922891, 91695.0, 1039.7608550033535, 1069.609592498717, 1080.1250986700798, 1101.4107452512867, 1103.5199688135688, 15046.398144074114, 18626.44120676382, 19035.0, 19077.80922190816, 19315.0, 42726.0, 43553.0, 43560.564394356916, 43652.34521482244, 44412.11175776531, 53712.462875370744, 55019.72490137524, 55454.44545554493, 56063.0, 56114.719426402604, 7930.325922296439, 8480.575971201291, 8870.201681848665, 8902.109789021306, 9399.624015039595, 13670.863291366959, 13913.443462261395, 14185.645358865699, 14261.24367605472, 14346.856531434552, 12496.93751531273, 12503.4373453193, 12625.81061284063, 12784.808227876776, 12837.358132093545, 5402.270693456333, 9937.503124843874, 12054.879451205376, 12245.448954796877, 12338.938305308417, 12744.61766147017, 12883.291418972047, 12921.353932303535, 12941.223526588436, 13032.348382581024, 8144.348452123934, 8554.57227138653, 8792.868106978272, 8799.648014079621, 8815.955920220358, 12292.508299667914, 12398.81401778992, 12487.0, 12675.112742108333, 12744.0], "value": 9744.666147321186, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1453.186215719197, 1502.5792778022153, 1627.5361521966236, 1756.9648607027852, 1785.1609743420588, 8633.913660863389, 9189.816203675922, 9304.441733495994, 9307.813843723121, 9327.20718738908, 7884.881726774103, 8675.305975521958, 8900.19898209161, 8940.687075952343, 9240.445573265592, 2433.367324495631, 2462.310553045141, 2468.3212116667883, 2475.9752402476015, 2476.158106243877, 2052.538178909741, 2407.410184504799, 2478.330850670318, 2486.714027886789, 2487.179230853814, 2341.321016905104, 2421.6609674645565, 2432.72023717273, 2443.6701045358914, 2450.571150048743, 2405.8436201646837, 2417.613181890898, 2419.9395015124674, 2426.7694569015916, 2429.9028038878423, 2397.520495900827, 2407.8796060197096, 2408.879556022192, 2413.408714864869, 2434.6226334918115, 9066.821313229239, 9112.772180695536, 9126.13301736334, 9134.77163070922, 9143.0, 5460.754266058037, 5479.863003424906, 5523.502884740353, 5524.14375771756, 5528.391876893538, 3528.400171970771, 3585.551806024247, 3616.2948225096115, 3646.033801042726, 3657.487951686766, 1187.7505723797926, 1228.2753175626333, 1233.8889499944958, 1241.050596293836, 1255.9372031398393, 12556.623301300884, 12561.183523071062, 12571.497140114385, 12593.433295501633, 12674.619761407173, 4746.715197088117, 4839.927401088987, 4960.156773348539, 5003.049420610072, 5015.498450154955, 10725.892741072645, 10760.461976901124, 10766.46167691628, 10775.245732798785, 10781.137508999262, 5566.944330556643, 5572.080606699849, 5576.219329293902, 5577.609567330248, 5578.721063946787, 5014.448410674823, 5099.184130539096, 5108.565771909355, 5119.769610367543, 5120.641555091108, 4134.235166494208, 4152.771597562102, 4214.093969796509, 4222.978885105555, 4260.488741351058, 1223.247702662856, 1298.337847697662, 1338.1569611144917, 1367.6649220940933, 1412.032757561074, 984.5717113055844, 990.5245482168456, 996.1283876607968, 1011.3325205364424, 1012.2003617142375, 6162.414570615784, 6207.379262073757, 6311.33730958252, 6337.809865704036, 6403.711832967528, 947.0860619502214, 987.7185002274317, 1004.2367800471694, 1036.5698235232444, 1036.5801850250662, 4311.719738217006, 4320.978395108067, 4352.73883566987, 4384.7369157850635, 4413.183561041154, 10576.52405641748, 11000.834987475195, 11009.06422954058, 11012.834807477895, 11017.283876548, 10259.640912568024, 10854.620088296871, 10931.890681093246, 10965.122790176927, 11067.280626759235, 8199.836003279901, 8432.0, 8614.310855131574, 8644.78388040304, 8667.609957551926, 6311.463525600192, 6459.741610335534, 6573.441257493167, 6577.967110164419, 6648.867022659617, 10501.369917804956, 10699.090577301016, 10833.783324333312, 11107.83338249943, 11123.443827808738, 10761.139108871428, 10995.34027958325, 11161.0, 11163.051140653135, 11288.153388495732, 8278.089410164997, 8295.709650162456, 8376.581170941306, 8389.538575378412, 8452.830943380975, 8428.45215061019, 8435.95782021086, 8463.788405289917, 8505.489670619536, 8515.02077261123, 7706.267904549059, 7988.960055199686, 8001.599920004093, 8014.053789682317, 8014.118446970712, 7807.0, 7834.0, 8020.157883422156, 8071.556064416513, 8078.23256790604, 6973.965130174317, 7100.112485939258, 7190.5326153801925, 7191.964040179766, 7194.748183813751, 5137.768800403916, 5155.407128180157, 5205.271262023395, 5263.315768950012, 5275.076861549291, 5339.759710812945, 5390.62265641417, 5514.117741161395, 5518.310211223597, 5530.91703624454], "value": 4852.472308776903, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.44314993960086, 346.7416774502994, 352.40795463621106, 352.73721077797035, 355.46325049175744, 5379.596530260232, 5448.8365349039495, 5456.863578410542, 5468.398476167618, 5506.201600767887, 5351.411344752074, 5353.946460535393, 5437.6465529740535, 5437.71615921313, 5443.727813609324, 4196.601322874322, 4305.26810442224, 4318.589733975267, 4332.830135863315, 4339.761313127777, 4236.4916210054835, 4262.893427664318, 4278.42241297424, 4288.52826189119, 4297.183535128315, 4015.07653239755, 4242.766647834368, 4263.594958478955, 4266.829326826939, 4285.99279169395, 3915.686745060388, 4041.6564592009713, 4140.3375459926265, 4150.771707556083, 4218.620324170839, 3758.6805121564425, 3772.8868133956025, 3806.020869148055, 3808.9428658570146, 3821.2739579479808, 5226.634135610509, 5251.715503755879, 5257.316548848664, 5276.0214919405225, 5295.735213239361, 4643.396358473411, 4709.71741695496, 4834.613230941516, 4855.781489832966, 4901.950980490185, 5557.972210138963, 5558.138488534284, 5560.6941618210985, 5593.52455041322, 5599.524040456566, 4146.543880173179, 4191.1827193697245, 4207.0, 4208.3687446882905, 4210.536840947493, 5528.226048353234, 5692.6299790513485, 5749.770009199627, 5834.708264586796, 5838.386969368197, 4079.224947260011, 4093.953023488256, 4115.71190016702, 4225.556316586714, 4325.502567204749, 4322.956770432318, 4364.650827933758, 4374.431323927933, 4374.890627734332, 4385.824567017347, 4794.352762377104, 4805.711657300573, 4896.2410826321975, 4936.950630493721, 4938.0, 5647.407022262603, 5659.179418984224, 5664.801731939362, 5666.235058267163, 5684.459976302244, 1469.1846025455975, 1483.5326872035275, 1492.8656420921952, 1493.089215578518, 1494.2528735632184, 953.5565961827783, 996.2080146283722, 1001.1640280365976, 1006.3961623026125, 1017.5268500147467, 4789.568938795455, 4798.256270278042, 4823.782929768169, 4893.608511319086, 4914.287428322873, 5051.6716413433005, 5078.365204349457, 5089.4147173074825, 5109.335786347825, 5121.4878512149235, 4496.213162696515, 4804.495527969582, 4810.037992401533, 4831.637627177975, 4859.805607775649, 2678.5312570300507, 2679.825811322258, 2709.647745793034, 2710.3766133788945, 2724.346156922364, 5198.350206224222, 5240.502152295526, 5276.868078297996, 5281.392639846466, 5298.28473156119, 5153.814622636814, 5210.6613070150315, 5493.890122197534, 5925.318588362307, 5960.821175364746, 6020.969895150496, 6031.909521357183, 6058.303295121029, 6071.210742603434, 6078.6871155220515, 5528.391876893619, 5823.679697616672, 5861.413858614104, 5915.704214789157, 5937.554683398676, 5775.81595772874, 5778.739956701875, 5807.593468457168, 5810.663547384041, 5815.476607105212, 5786.594938354275, 5912.586118971631, 5917.497012753965, 5999.080294305781, 6000.369961154016, 4171.144915292297, 4172.949223625694, 4198.307279298881, 4231.40760293553, 4236.78816059202, 5709.343425505954, 5868.119782032729, 5872.618279811799, 5888.381719919346, 5921.911171332347, 5592.692401917933, 5598.816461580069, 5612.793249451388, 5619.466150715675, 5630.690312032713, 5619.831405057855, 5626.324841019104, 5628.85927851807, 5654.236678048411, 5712.686082201034, 5412.7293635318865, 5518.91721624184, 5552.305961754781, 5553.0559804832465, 5558.360788509373, 5570.660322664409, 5649.4350564944825, 5658.0, 5665.546756259571, 5700.429957004267, 5405.540529055074, 5552.445315311719, 5554.527865131509, 5568.526675232489, 5597.356304025089], "value": 4262.612319646543, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.0887586079469, 732.0556482138043, 740.2523451314174, 754.1478129713424, 833.8248967716779, 13979.580612581613, 14726.926365368172, 14776.852231477695, 14789.556313310592, 14791.92604036981, 12024.0, 14814.111153330809, 15524.301406436709, 16208.432704855333, 16283.51149465515, 784.5057613703373, 799.9840003199962, 811.3955103447939, 811.8741595052746, 814.7555733280022, 794.031281836159, 796.1998191817215, 798.4051881348374, 798.648594618366, 798.7763426240662, 696.216756149332, 826.6734639817269, 844.2823599940033, 855.5593869157389, 858.6222062292571, 836.8535506286375, 838.0697425857294, 840.2269911681268, 840.3235395506615, 842.2798507276314, 611.5046812082184, 614.6435067660746, 615.1019511513196, 615.178736386924, 615.3538784276536, 14715.63210919725, 14718.0433271837, 14736.263186840722, 14741.041832280867, 14751.26243687822, 14377.928110359486, 14874.405023799143, 14912.62718432037, 15704.450344237897, 15894.125823079727, 12197.878021219763, 12735.0, 13072.542461013914, 13227.66930826737, 13452.1256118352, 3966.3257246267917, 3975.987299067264, 4043.716939814214, 4080.489938757655, 4095.9180816383805, 75428.62285688591, 75979.0, 76217.0, 77226.22773772247, 77467.61266193633, 11197.16021298406, 11233.66299011031, 11301.773964520664, 11375.658730238107, 11640.35978021217, 21318.57362852734, 21503.89248053781, 21783.782162178493, 23548.764512355, 23570.0571977119, 8646.308295336357, 8675.089115642766, 8685.131486851264, 8755.605997730117, 8807.691730789391, 4649.465311489222, 4853.150698627726, 4856.198727210041, 4914.483979182206, 4922.163232250526, 3526.453399723047, 3693.9630603693618, 3811.4282857571584, 3815.790131542736, 3819.694424446038, 714.8248679073661, 726.7165805335924, 737.0676094740159, 746.6975874770726, 747.9364254038468, 660.8543333731473, 738.1474397071391, 744.5681504727245, 777.5995362388375, 781.3397678961269, 9763.365381250196, 9780.31537792362, 9906.356086854332, 10045.748856278506, 10632.0, 691.778630838127, 734.6840858430819, 776.6311002273987, 777.4907435629672, 793.80551764818, 4570.840020599263, 4620.561046700558, 4628.629709623289, 4641.164590373698, 4678.368420263289, 110054.0, 114256.0, 114560.0, 117899.41050294694, 120605.0, 102252.48873755583, 105325.47337263418, 106180.0, 106896.0, 107316.46341768398, 92115.0, 92234.53882730678, 92766.0, 93815.53092234631, 94130.0, 9700.369475984038, 9748.221756799278, 9770.120689138012, 9883.0, 9943.900560994298, 52049.739751301, 52509.474905250456, 52928.73535632297, 53703.46296536984, 54510.18234726562, 73313.96773177526, 78616.60691696504, 80220.0, 81055.59472202837, 81910.54268371958, 12768.74462510763, 12993.155444896052, 13048.217106973612, 13377.799333009818, 13455.932720336727, 13417.329133543479, 13608.93195534016, 13670.52153174634, 13959.162450253018, 15125.924370378518, 10087.495625218857, 14053.437862485385, 14230.288485575888, 14442.0, 15464.072155670696, 14643.63390915193, 14961.850381496046, 15104.924475377553, 15712.76430853561, 15751.291191896164, 13123.146995445266, 13428.328583570978, 14088.22514761657, 14526.128432294096, 15369.462068827537, 11560.884391155982, 11947.701307467383, 12256.88656029202, 12322.568710095104, 12623.116381853182, 11359.375234362189, 11363.318200907972, 11811.409429528661, 12357.443915023665, 12419.689507762378], "value": 7764.551061797658, "unit": "score"}], "name": "dromaeo_css", "value": 7513.659655479441, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 110.0, 109.0, 109.0, 110.0, 109.0, 108.0, 109.0, 108.0, 108.0], "value": 108.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 118.0, 120.0, 169.0, 121.0, 123.0, 143.0, 122.0, 153.0, 117.0], "value": 133.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 159.0, 161.0, 159.0, 161.0, 159.0, 162.0, 162.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 107.0, 75.0, 76.0, 75.0, 74.0, 98.0, 75.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 115.0, 84.0, 84.0, 84.0, 131.0, 83.0, 83.0, 122.0], "value": 95.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 96.0, 96.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 52.0, 52.0, 53.0, 55.0, 52.0, 54.0, 52.0, 52.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 61.0, 61.0, 69.0, 62.0, 62.0, 62.0, 60.0, 61.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 79.0, 74.0, 84.0, 78.0, 74.0, 75.0, 80.0, 77.0], "value": 77.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 119.0, 116.0, 118.0, 133.0, 123.0, 133.0, 119.0, 172.0, 130.0], "value": 128.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 154.0, 157.0, 155.0, 156.0, 156.0, 155.0, 156.0, 158.0, 157.0], "value": 156.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 63.0, 64.0, 64.0, 67.0, 63.0, 64.0, 66.0, 62.0], "value": 64.2, "unit": "score"}], "name": "kraken", "value": 1476.6000000000001, "alertThreshold": 2.0}]} 08:09:31 INFO - Return code: 0 08:09:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:09:31 INFO - # TBPL SUCCESS # 08:09:31 INFO - Running post-action listener: _resource_record_post_action 08:09:31 INFO - ##### 08:09:31 INFO - ##### Finished run-tests step (success) 08:09:31 INFO - ##### 08:09:31 INFO - Running post-run listener: _resource_record_post_run 08:09:31 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 564981760; Read time: 8; Write time: 517740 08:09:31 INFO - TinderboxPrint: CPU usage
13.0% 08:09:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 08:09:31 INFO - TinderboxPrint: I/O write bytes / time
564,981,760 / 517,740 08:09:31 INFO - TinderboxPrint: CPU idle
8,277.8 (87.0%) 08:09:31 INFO - TinderboxPrint: CPU user
1,192.7 (12.5%) 08:09:31 INFO - TinderboxPrint: Swap in / out
0 / 0 08:09:31 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 267890688; Read time: 0; Write time: 290520 08:09:31 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 297091072; Read time: 0; Write time: 227220 08:09:32 INFO - Running post-run listener: _upload_blobber_files 08:09:32 INFO - Blob upload gear active. 08:09:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:09:32 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:09:32 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:09:32 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:09:32 INFO - (blobuploader) - INFO - Open directory for files ... 08:09:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:09:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:09:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:09:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:09:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:09:36 INFO - (blobuploader) - INFO - Done attempting. 08:09:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:09:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:09:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:09:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:09:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:09:37 INFO - (blobuploader) - INFO - Done attempting. 08:09:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:09:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:09:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:09:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:09:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:09:37 INFO - (blobuploader) - INFO - Done attempting. 08:09:37 INFO - (blobuploader) - INFO - Iteration through files over. 08:09:37 INFO - Return code: 0 08:09:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:09:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:09:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/419ff369478b785c2f0c28e58f7bfafbf1e59580c82aebdaf71b7fc025af79f1876905313da717e1e4cd654801658c0abf157b2e677bcf3c8e814d666659b484", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8cc0f1d29e770c9eadf9a46ad691056a230e6af6c0e846ef150a7114f55317ca5ea186ce89a4cf8f302d061c8cea44e6fe59874eb3b5b79a0609cc049acb8117", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9cef6b08f6d7e9af87ecd12ee5ad9e91cad2ac0e8ef026f173b961f38b420ee869be6c0d66cbc8d5cf10254e2c69f4829c8ba8ffff02b1d56aa49f4e469e79b9"} 08:09:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:09:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:09:37 INFO - Contents: 08:09:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/419ff369478b785c2f0c28e58f7bfafbf1e59580c82aebdaf71b7fc025af79f1876905313da717e1e4cd654801658c0abf157b2e677bcf3c8e814d666659b484", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8cc0f1d29e770c9eadf9a46ad691056a230e6af6c0e846ef150a7114f55317ca5ea186ce89a4cf8f302d061c8cea44e6fe59874eb3b5b79a0609cc049acb8117", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9cef6b08f6d7e9af87ecd12ee5ad9e91cad2ac0e8ef026f173b961f38b420ee869be6c0d66cbc8d5cf10254e2c69f4829c8ba8ffff02b1d56aa49f4e469e79b9"} 08:09:37 INFO - Running post-run listener: copy_logs_to_upload_dir 08:09:37 INFO - Copying logs to upload dir... 08:09:37 INFO - mkdir: /builds/slave/test/build/upload/logs 08:09:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.601335 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-29 08:09:37.871291) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 08:09:37.875135) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1467211367.800440-534111710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/419ff369478b785c2f0c28e58f7bfafbf1e59580c82aebdaf71b7fc025af79f1876905313da717e1e4cd654801658c0abf157b2e677bcf3c8e814d666659b484", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8cc0f1d29e770c9eadf9a46ad691056a230e6af6c0e846ef150a7114f55317ca5ea186ce89a4cf8f302d061c8cea44e6fe59874eb3b5b79a0609cc049acb8117", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9cef6b08f6d7e9af87ecd12ee5ad9e91cad2ac0e8ef026f173b961f38b420ee869be6c0d66cbc8d5cf10254e2c69f4829c8ba8ffff02b1d56aa49f4e469e79b9"} build_url:https://queue.taskcluster.net/v1/task/RGIsLmdCQoKBMiO512mSaA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011252 build_url: 'https://queue.taskcluster.net/v1/task/RGIsLmdCQoKBMiO512mSaA/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/Mozilla-Inbound/sha512/419ff369478b785c2f0c28e58f7bfafbf1e59580c82aebdaf71b7fc025af79f1876905313da717e1e4cd654801658c0abf157b2e677bcf3c8e814d666659b484", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8cc0f1d29e770c9eadf9a46ad691056a230e6af6c0e846ef150a7114f55317ca5ea186ce89a4cf8f302d061c8cea44e6fe59874eb3b5b79a0609cc049acb8117", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9cef6b08f6d7e9af87ecd12ee5ad9e91cad2ac0e8ef026f173b961f38b420ee869be6c0d66cbc8d5cf10254e2c69f4829c8ba8ffff02b1d56aa49f4e469e79b9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 08:09:37.901271) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 08:09:37.901680) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1467211367.800440-534111710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004489 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 08:09:37.983984) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 08:09:37.984386) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 08:09:37.984802) ========= ========= Total master_lag: 0.17 =========