builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-039 starttime: 1468678320.15 results: success (0) buildid: 20160716043058 builduid: fadb60bc50644bb58230ed4f52c18fc9 revision: ccb0ca7468c1524ae532d70c1ca3380d296f097c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 07:12:00.147741) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 07:12:00.148217) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-16 07:12:00.148492) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-16 07:12:00.164649) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 07:12:00.164939) ========= 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=5bd038846534b2fdfa68eeae000001e2-1468670011.126945-326616824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-16 07:12: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% 66.5M=0s 2016-07-16 07:12:00 (66.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.189744 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 07:12:00.368495) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 07:12:00.368805) ========= 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=5bd038846534b2fdfa68eeae000001e2-1468670011.126945-326616824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015963 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 07:12:00.419093) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 07:12:00.419470) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev ccb0ca7468c1524ae532d70c1ca3380d296f097c --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 ccb0ca7468c1524ae532d70c1ca3380d296f097c --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=5bd038846534b2fdfa68eeae000001e2-1468670011.126945-326616824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-16 07:12:00,720 truncating revision to first 12 chars 2016-07-16 07:12:00,720 Setting DEBUG logging. 2016-07-16 07:12:00,720 attempt 1/10 2016-07-16 07:12:00,720 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/ccb0ca7468c1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-16 07:12:01,024 unpacking tar archive at: mozilla-inbound-ccb0ca7468c1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.652375 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 07:12:01.086651) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 07:12:01.086958) ========= script_repo_revision: ccb0ca7468c1524ae532d70c1ca3380d296f097c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 07:12:01.087476) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 07:12:01.087737) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 07:12:01.097870) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-16 07:12:01.098289) ========= /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=5bd038846534b2fdfa68eeae000001e2-1468670011.126945-326616824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:12:01 INFO - MultiFileLogger online at 20160716 07:12:01 in /builds/slave/test 07:12:01 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:12:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:12:01 INFO - {'append_to_log': False, 07:12:01 INFO - 'base_work_dir': '/builds/slave/test', 07:12:01 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:12:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:12:01 INFO - 'branch': 'Mozilla-Inbound', 07:12:01 INFO - 'buildbot_json_path': 'buildprops.json', 07:12:01 INFO - 'config_files': ('talos/linux_config.py',), 07:12:01 INFO - 'default_actions': ('clobber', 07:12:01 INFO - 'read-buildbot-config', 07:12:01 INFO - 'download-and-extract', 07:12:01 INFO - 'populate-webroot', 07:12:01 INFO - 'create-virtualenv', 07:12:01 INFO - 'install', 07:12:01 INFO - 'run-tests'), 07:12:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:12:01 INFO - 'download_minidump_stackwalk': True, 07:12:01 INFO - 'download_symbols': 'ondemand', 07:12:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:12:01 INFO - 'tooltool.py': '/tools/tooltool.py', 07:12:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:12:01 INFO - '/tools/misc-python/virtualenv.py')}, 07:12:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:12:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:12:01 INFO - 'installer_path': 'installer.exe', 07:12:01 INFO - 'log_level': 'info', 07:12:01 INFO - 'log_name': 'talos', 07:12:01 INFO - 'log_to_console': True, 07:12:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:12:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:12:01 INFO - 'opt_config_files': (), 07:12:01 INFO - 'pip_index': False, 07:12:01 INFO - 'sps_profile': False, 07:12:01 INFO - 'sps_profile_interval': 0, 07:12:01 INFO - 'suite': 'dromaeojs', 07:12:01 INFO - 'system_bits': '32', 07:12:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:12:01 INFO - 'title': 'talos-linux64-ix-039', 07:12:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:12:01 INFO - 'use_talos_json': True, 07:12:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:12:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:12:01 INFO - 'work_dir': 'build'} 07:12:01 INFO - ##### 07:12:01 INFO - ##### Running clobber step. 07:12:01 INFO - ##### 07:12:01 INFO - Running pre-action listener: _resource_record_pre_action 07:12:01 INFO - Running main action method: clobber 07:12:01 INFO - rmtree: /builds/slave/test/build 07:12:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:12:01 INFO - Running post-action listener: _resource_record_post_action 07:12:01 INFO - ##### 07:12:01 INFO - ##### Finished clobber step (success) 07:12:01 INFO - ##### 07:12:01 INFO - ##### 07:12:01 INFO - ##### Running read-buildbot-config step. 07:12:01 INFO - ##### 07:12:01 INFO - Running pre-action listener: _resource_record_pre_action 07:12:01 INFO - Running main action method: read_buildbot_config 07:12:01 INFO - Using buildbot properties: 07:12:01 INFO - { 07:12:01 INFO - "project": "", 07:12:01 INFO - "product": "firefox", 07:12:01 INFO - "script_repo_revision": "production", 07:12:01 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 07:12:01 INFO - "repository": "", 07:12:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 07:12:01 INFO - "buildid": "20160716043058", 07:12:01 INFO - "pgo_build": "True", 07:12:01 INFO - "basedir": "/builds/slave/test", 07:12:01 INFO - "buildnumber": 1246, 07:12:01 INFO - "slavename": "talos-linux64-ix-039", 07:12:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:12:01 INFO - "platform": "ubuntu64_hw", 07:12:01 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 07:12:01 INFO - "branch": "mozilla-inbound", 07:12:01 INFO - "repo_path": "integration/mozilla-inbound", 07:12:01 INFO - "revision": "ccb0ca7468c1524ae532d70c1ca3380d296f097c", 07:12:01 INFO - "stage_platform": "linux64-pgo", 07:12:01 INFO - "builduid": "fadb60bc50644bb58230ed4f52c18fc9", 07:12:01 INFO - "slavebuilddir": "test" 07:12:01 INFO - } 07:12:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/M3_-nNhuRme4CoLfTj3kQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:12:01 INFO - Running post-action listener: _resource_record_post_action 07:12:01 INFO - ##### 07:12:01 INFO - ##### Finished read-buildbot-config step (success) 07:12:01 INFO - ##### 07:12:01 INFO - ##### 07:12:01 INFO - ##### Running download-and-extract step. 07:12:01 INFO - ##### 07:12:01 INFO - Running pre-action listener: _resource_record_pre_action 07:12:01 INFO - Running main action method: download_and_extract 07:12:01 INFO - mkdir: /builds/slave/test/build/tests 07:12:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:01 INFO - https://queue.taskcluster.net/v1/task/M3_-nNhuRme4CoLfTj3kQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:12:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_-nNhuRme4CoLfTj3kQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:12:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_-nNhuRme4CoLfTj3kQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:12:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_-nNhuRme4CoLfTj3kQg/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:12:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_-nNhuRme4CoLfTj3kQg/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:12:12 INFO - Downloaded 1361 bytes. 07:12:12 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:12:12 INFO - Using the following test package requirements: 07:12:12 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:12:12 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:12:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:12:12 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:12:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:12:12 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:12:12 INFO - u'jsshell-linux-x86_64.zip'], 07:12:12 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:12:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:12:12 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:12:12 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:12:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:12:12 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:12:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:12:12 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:12:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:12:12 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:12:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:12:12 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:12:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:12 INFO - https://queue.taskcluster.net/v1/task/M3_-nNhuRme4CoLfTj3kQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:12:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_-nNhuRme4CoLfTj3kQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:12:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_-nNhuRme4CoLfTj3kQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:12:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_-nNhuRme4CoLfTj3kQg/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:12:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_-nNhuRme4CoLfTj3kQg/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:12:15 INFO - Downloaded 24332434 bytes. 07:12:15 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:12:15 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:12:16 INFO - Return code: 0 07:12:16 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:12:16 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:12:16 INFO - https://queue.taskcluster.net/v1/task/M3_-nNhuRme4CoLfTj3kQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:12:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_-nNhuRme4CoLfTj3kQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:12:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_-nNhuRme4CoLfTj3kQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:12:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_-nNhuRme4CoLfTj3kQg/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:12:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_-nNhuRme4CoLfTj3kQg/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:12:17 INFO - Downloaded 24332434 bytes. 07:12:17 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:12:17 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:12:19 INFO - Return code: 0 07:12:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:19 INFO - https://queue.taskcluster.net/v1/task/M3_-nNhuRme4CoLfTj3kQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:12:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_-nNhuRme4CoLfTj3kQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:12:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_-nNhuRme4CoLfTj3kQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:12:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_-nNhuRme4CoLfTj3kQg/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:12:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_-nNhuRme4CoLfTj3kQg/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:12:20 INFO - Downloaded 14403317 bytes. 07:12:20 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:12:20 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:12:20 INFO - Return code: 0 07:12: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:12:20 INFO - https://queue.taskcluster.net/v1/task/M3_-nNhuRme4CoLfTj3kQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:12:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_-nNhuRme4CoLfTj3kQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:12:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_-nNhuRme4CoLfTj3kQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:12:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_-nNhuRme4CoLfTj3kQg/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:12:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3_-nNhuRme4CoLfTj3kQg/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:12:21 INFO - Downloaded 60812184 bytes. 07:12:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M3_-nNhuRme4CoLfTj3kQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:12:21 INFO - mkdir: /builds/slave/test/properties 07:12:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:12:21 INFO - Writing to file /builds/slave/test/properties/build_url 07:12:21 INFO - Contents: 07:12:21 INFO - build_url:https://queue.taskcluster.net/v1/task/M3_-nNhuRme4CoLfTj3kQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:12:22 INFO - Running post-action listener: _resource_record_post_action 07:12:22 INFO - Running post-action listener: set_extra_try_arguments 07:12:22 INFO - ##### 07:12:22 INFO - ##### Finished download-and-extract step (success) 07:12:22 INFO - ##### 07:12:22 INFO - ##### 07:12:22 INFO - ##### Running populate-webroot step. 07:12:22 INFO - ##### 07:12:22 INFO - Running pre-action listener: _resource_record_pre_action 07:12:22 INFO - Running main action method: populate_webroot 07:12:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:12:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:12:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:12:22 INFO - '--tppagecycles', 07:12:22 INFO - '7'], 07:12:22 INFO - 'tests': ['tsvgm']}}, 07:12:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:12:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:12:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:12:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:12:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:12:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:12:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:12:22 INFO - 'talos_options': ['--disable-e10s'], 07:12:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:12:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:12:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:12:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:12:22 INFO - 'talos_options': ['--disable-e10s'], 07:12:22 INFO - 'tests': ['damp', 'tps']}, 07:12:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:12:22 INFO - 'tests': ['damp', 'tps']}, 07:12:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:12:22 INFO - 'tests': ['dromaeo_dom']}, 07:12:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:12:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:12:22 INFO - 'tests': ['basic_compositor_video']}, 07:12:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:12:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:12:22 INFO - 'tests': ['a11yr', 07:12:22 INFO - 'ts_paint', 07:12:22 INFO - 'tpaint', 07:12:22 INFO - 'sessionrestore', 07:12:22 INFO - 'sessionrestore_no_auto_restore', 07:12:22 INFO - 'tabpaint']}, 07:12:22 INFO - 'other-e10s': {'tests': ['a11yr', 07:12:22 INFO - 'ts_paint', 07:12:22 INFO - 'tpaint', 07:12:22 INFO - 'sessionrestore', 07:12:22 INFO - 'sessionrestore_no_auto_restore', 07:12:22 INFO - 'tabpaint']}, 07:12:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:12:22 INFO - 'ts_paint', 07:12:22 INFO - 'tpaint', 07:12:22 INFO - 'sessionrestore', 07:12:22 INFO - 'sessionrestore_no_auto_restore', 07:12:22 INFO - 'tabpaint']}, 07:12:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:12:22 INFO - 'ts_paint', 07:12:22 INFO - 'tpaint', 07:12:22 INFO - 'sessionrestore', 07:12:22 INFO - 'sessionrestore_no_auto_restore', 07:12:22 INFO - 'tabpaint']}, 07:12:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:12:22 INFO - 'tests': ['a11yr', 07:12:22 INFO - 'ts_paint', 07:12:22 INFO - 'tpaint', 07:12:22 INFO - 'sessionrestore', 07:12:22 INFO - 'sessionrestore_no_auto_restore', 07:12:22 INFO - 'tabpaint']}, 07:12:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:12:22 INFO - 'tests': ['a11yr', 07:12:22 INFO - 'ts_paint', 07:12:22 INFO - 'tpaint', 07:12:22 INFO - 'sessionrestore', 07:12:22 INFO - 'sessionrestore_no_auto_restore', 07:12:22 INFO - 'tabpaint']}, 07:12:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:12:22 INFO - 'tests': ['tsvgx', 07:12:22 INFO - 'tsvgr_opacity', 07:12:22 INFO - 'tart', 07:12:22 INFO - 'tscrollx', 07:12:22 INFO - 'cart']}, 07:12:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:12:22 INFO - 'tsvgr_opacity', 07:12:22 INFO - 'tart', 07:12:22 INFO - 'tscrollx', 07:12:22 INFO - 'cart']}, 07:12:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:12:22 INFO - 'talos_options': ['--disable-e10s'], 07:12:22 INFO - 'tests': ['tp5o']}, 07:12:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:12:22 INFO - 'tests': ['tp5o']}, 07:12:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:12:22 INFO - 'talos_options': ['--disable-e10s', 07:12:22 INFO - '--xperf_path', 07:12:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:12:22 INFO - 'tests': ['tp5n']}, 07:12:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:12:22 INFO - 'talos_options': ['--xperf_path', 07:12:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:12:22 INFO - 'tests': ['tp5n']}}, 07:12:22 INFO - 'talos.zip': {'path': '', 07:12:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:12:22 INFO - Running post-action listener: _resource_record_post_action 07:12:22 INFO - ##### 07:12:22 INFO - ##### Finished populate-webroot step (success) 07:12:22 INFO - ##### 07:12:22 INFO - ##### 07:12:22 INFO - ##### Running create-virtualenv step. 07:12:22 INFO - ##### 07:12:22 INFO - Running pre-action listener: _resource_record_pre_action 07:12:22 INFO - Running main action method: create_virtualenv 07:12:22 INFO - Creating virtualenv /builds/slave/test/build/venv 07:12:22 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:12:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:12:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:12:22 INFO - Using real prefix '/usr' 07:12:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:12:23 INFO - Installing distribute.............................................................................................................................................................................................done. 07:12:25 INFO - Installing pip.................done. 07:12:25 INFO - Return code: 0 07:12:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:12: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:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12: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:12:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcd9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf983b0>, '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 0xf992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf99740>, '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': '5bd038846534b2fdfa68eeae000001e2-1468670011.126945-326616824', '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:12: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', 'pip>=1.5'] in /builds/slave/test/build 07:12: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 pip>=1.5 07:12:25 INFO - Using env: {'DISPLAY': ':0', 07:12:25 INFO - 'HOME': '/home/cltbld', 07:12:25 INFO - 'LANG': 'en_US.UTF-8', 07:12:25 INFO - 'LANGUAGE': 'en_US:en', 07:12:25 INFO - 'LOGNAME': 'cltbld', 07:12:25 INFO - 'MAIL': '/var/mail/cltbld', 07:12:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:25 INFO - 'MOZ_NO_REMOTE': '1', 07:12:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:25 INFO - 'NO_EM_RESTART': '1', 07:12:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:25 INFO - 'PWD': '/builds/slave/test', 07:12:25 INFO - 'SHELL': '/bin/bash', 07:12:25 INFO - 'SHLVL': '1', 07:12:25 INFO - 'TERM': 'linux', 07:12:25 INFO - 'TMOUT': '86400', 07:12:25 INFO - 'USER': 'cltbld', 07:12:25 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468670011.126945-326616824', 07:12:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:25 INFO - '_': '/tools/buildbot/bin/python'} 07:12:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:25 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:12:25 INFO - Cleaning up... 07:12:25 INFO - Return code: 0 07:12:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:12: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:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12: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:12:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12: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', '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 0xcd9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf983b0>, '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 0xf992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf99740>, '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': '5bd038846534b2fdfa68eeae000001e2-1468670011.126945-326616824', '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:12: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', 'psutil>=3.1.1'] in /builds/slave/test/build 07:12: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 psutil>=3.1.1 07:12:25 INFO - Using env: {'DISPLAY': ':0', 07:12:25 INFO - 'HOME': '/home/cltbld', 07:12:25 INFO - 'LANG': 'en_US.UTF-8', 07:12:25 INFO - 'LANGUAGE': 'en_US:en', 07:12:25 INFO - 'LOGNAME': 'cltbld', 07:12:25 INFO - 'MAIL': '/var/mail/cltbld', 07:12:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:25 INFO - 'MOZ_NO_REMOTE': '1', 07:12:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:25 INFO - 'NO_EM_RESTART': '1', 07:12:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:25 INFO - 'PWD': '/builds/slave/test', 07:12:25 INFO - 'SHELL': '/bin/bash', 07:12:25 INFO - 'SHLVL': '1', 07:12:25 INFO - 'TERM': 'linux', 07:12:25 INFO - 'TMOUT': '86400', 07:12:25 INFO - 'USER': 'cltbld', 07:12:25 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468670011.126945-326616824', 07:12:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:25 INFO - '_': '/tools/buildbot/bin/python'} 07:12:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:25 INFO - Downloading/unpacking psutil>=3.1.1 07:12: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:12: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:12: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:12: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:12: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:12: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:12:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:12:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:12:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:12:27 INFO - Installing collected packages: psutil 07:12:27 INFO - Running setup.py install for psutil 07:12:27 INFO - building 'psutil._psutil_linux' extension 07:12:27 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:12:27 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:12:27 INFO - building 'psutil._psutil_posix' extension 07:12:27 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:12:28 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:12:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:12:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:12:28 INFO - Successfully installed psutil 07:12:28 INFO - Cleaning up... 07:12:28 INFO - Return code: 0 07:12:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:12: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:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12: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:12:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcd9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf983b0>, '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 0xf992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf99740>, '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': '5bd038846534b2fdfa68eeae000001e2-1468670011.126945-326616824', '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:12: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:12: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 mozsystemmonitor==0.3 07:12:28 INFO - Using env: {'DISPLAY': ':0', 07:12:28 INFO - 'HOME': '/home/cltbld', 07:12:28 INFO - 'LANG': 'en_US.UTF-8', 07:12:28 INFO - 'LANGUAGE': 'en_US:en', 07:12:28 INFO - 'LOGNAME': 'cltbld', 07:12:28 INFO - 'MAIL': '/var/mail/cltbld', 07:12:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:28 INFO - 'MOZ_NO_REMOTE': '1', 07:12:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:28 INFO - 'NO_EM_RESTART': '1', 07:12:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:28 INFO - 'PWD': '/builds/slave/test', 07:12:28 INFO - 'SHELL': '/bin/bash', 07:12:28 INFO - 'SHLVL': '1', 07:12:28 INFO - 'TERM': 'linux', 07:12:28 INFO - 'TMOUT': '86400', 07:12:28 INFO - 'USER': 'cltbld', 07:12:28 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468670011.126945-326616824', 07:12:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:28 INFO - '_': '/tools/buildbot/bin/python'} 07:12:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:12: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:12: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:12: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:12: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:12: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:12: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:12:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:12:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:12:30 INFO - Installing collected packages: mozsystemmonitor 07:12:30 INFO - Running setup.py install for mozsystemmonitor 07:12:30 INFO - Successfully installed mozsystemmonitor 07:12:30 INFO - Cleaning up... 07:12:30 INFO - Return code: 0 07:12:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:12:30 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:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:30 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:12:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:30 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 0xcd9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf983b0>, '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 0xf992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf99740>, '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': '5bd038846534b2fdfa68eeae000001e2-1468670011.126945-326616824', '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:12:30 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:12:30 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:12:30 INFO - Using env: {'DISPLAY': ':0', 07:12:30 INFO - 'HOME': '/home/cltbld', 07:12:30 INFO - 'LANG': 'en_US.UTF-8', 07:12:30 INFO - 'LANGUAGE': 'en_US:en', 07:12:30 INFO - 'LOGNAME': 'cltbld', 07:12:30 INFO - 'MAIL': '/var/mail/cltbld', 07:12:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:30 INFO - 'MOZ_NO_REMOTE': '1', 07:12:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:30 INFO - 'NO_EM_RESTART': '1', 07:12:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:30 INFO - 'PWD': '/builds/slave/test', 07:12:30 INFO - 'SHELL': '/bin/bash', 07:12:30 INFO - 'SHLVL': '1', 07:12:30 INFO - 'TERM': 'linux', 07:12:30 INFO - 'TMOUT': '86400', 07:12:30 INFO - 'USER': 'cltbld', 07:12:30 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468670011.126945-326616824', 07:12:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:30 INFO - '_': '/tools/buildbot/bin/python'} 07:12:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:30 INFO - Downloading/unpacking jsonschema==2.5.1 07:12: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:12: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:12: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:12: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:12: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:12: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:12:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:12:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:12:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:32 INFO - Downloading functools32-3.2.3-2.tar.gz 07:12:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:12:32 INFO - warning: no files found matching '*.txt' 07:12:32 INFO - no previously-included directories found matching 'build' 07:12:32 INFO - no previously-included directories found matching 'dist' 07:12:32 INFO - no previously-included directories found matching '.git*' 07:12:32 INFO - Installing collected packages: jsonschema, functools32 07:12:32 INFO - Running setup.py install for functools32 07:12:33 INFO - warning: no files found matching '*.txt' 07:12:33 INFO - no previously-included directories found matching 'build' 07:12:33 INFO - no previously-included directories found matching 'dist' 07:12:33 INFO - no previously-included directories found matching '.git*' 07:12:33 INFO - Successfully installed jsonschema functools32 07:12:33 INFO - Cleaning up... 07:12:33 INFO - Return code: 0 07:12:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xcd9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf983b0>, '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 0xf992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf99740>, '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': '5bd038846534b2fdfa68eeae000001e2-1468670011.126945-326616824', '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:12:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:12:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:12:33 INFO - Using env: {'DISPLAY': ':0', 07:12:33 INFO - 'HOME': '/home/cltbld', 07:12:33 INFO - 'LANG': 'en_US.UTF-8', 07:12:33 INFO - 'LANGUAGE': 'en_US:en', 07:12:33 INFO - 'LOGNAME': 'cltbld', 07:12:33 INFO - 'MAIL': '/var/mail/cltbld', 07:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:33 INFO - 'MOZ_NO_REMOTE': '1', 07:12:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:33 INFO - 'NO_EM_RESTART': '1', 07:12:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:33 INFO - 'PWD': '/builds/slave/test', 07:12:33 INFO - 'SHELL': '/bin/bash', 07:12:33 INFO - 'SHLVL': '1', 07:12:33 INFO - 'TERM': 'linux', 07:12:33 INFO - 'TMOUT': '86400', 07:12:33 INFO - 'USER': 'cltbld', 07:12:33 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468670011.126945-326616824', 07:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:33 INFO - '_': '/tools/buildbot/bin/python'} 07:12:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:33 INFO - Downloading/unpacking blobuploader==1.2.4 07:12:33 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:12:33 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:12:33 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:12:33 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:12:33 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:12:33 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:12:35 INFO - Downloading blobuploader-1.2.4.tar.gz 07:12:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:12:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:12:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:35 INFO - Downloading docopt-0.6.1.tar.gz 07:12:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:12:36 INFO - Installing collected packages: blobuploader, requests, docopt 07:12:36 INFO - Running setup.py install for blobuploader 07:12:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:12:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:12:36 INFO - Running setup.py install for requests 07:12:36 INFO - Running setup.py install for docopt 07:12:36 INFO - Successfully installed blobuploader requests docopt 07:12:36 INFO - Cleaning up... 07:12:36 INFO - Return code: 0 07:12:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:36 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 0xcd9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf983b0>, '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 0xf992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf99740>, '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': '5bd038846534b2fdfa68eeae000001e2-1468670011.126945-326616824', '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:12:36 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:12:36 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:12:36 INFO - Using env: {'DISPLAY': ':0', 07:12:36 INFO - 'HOME': '/home/cltbld', 07:12:36 INFO - 'LANG': 'en_US.UTF-8', 07:12:36 INFO - 'LANGUAGE': 'en_US:en', 07:12:36 INFO - 'LOGNAME': 'cltbld', 07:12:36 INFO - 'MAIL': '/var/mail/cltbld', 07:12:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:36 INFO - 'MOZ_NO_REMOTE': '1', 07:12:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:36 INFO - 'NO_EM_RESTART': '1', 07:12:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:36 INFO - 'PWD': '/builds/slave/test', 07:12:36 INFO - 'SHELL': '/bin/bash', 07:12:36 INFO - 'SHLVL': '1', 07:12:36 INFO - 'TERM': 'linux', 07:12:36 INFO - 'TMOUT': '86400', 07:12:36 INFO - 'USER': 'cltbld', 07:12:36 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468670011.126945-326616824', 07:12:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:36 INFO - '_': '/tools/buildbot/bin/python'} 07:12:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:12:36 INFO - Running setup.py (path:/tmp/pip-_xHACd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:12:36 INFO - Running setup.py (path:/tmp/pip-uJR8WK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:12:37 INFO - Running setup.py (path:/tmp/pip-wOn4_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:12:37 INFO - Running setup.py (path:/tmp/pip-yndKpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:12:37 INFO - Running setup.py (path:/tmp/pip-PZ_iHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:12:37 INFO - Running setup.py (path:/tmp/pip-dQkBK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:12:37 INFO - Running setup.py (path:/tmp/pip-ylozoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:12:37 INFO - Running setup.py (path:/tmp/pip-ktAwJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:12:37 INFO - Running setup.py (path:/tmp/pip-ULF2mh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:12:37 INFO - Running setup.py (path:/tmp/pip-VUy4Zp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:12:37 INFO - Running setup.py (path:/tmp/pip-GsocQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:12:37 INFO - Running setup.py (path:/tmp/pip-6lo2sS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:12:37 INFO - Running setup.py (path:/tmp/pip-_HlSLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:12:37 INFO - Running setup.py (path:/tmp/pip-QAQU1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:12:37 INFO - Running setup.py (path:/tmp/pip-KrWyqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:12:37 INFO - Running setup.py (path:/tmp/pip-cKtznq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:12:38 INFO - Running setup.py (path:/tmp/pip-chLgzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:12:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:12:38 INFO - Running setup.py install for manifestparser 07:12:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:12:38 INFO - Running setup.py install for mozcrash 07:12:38 INFO - Running setup.py install for mozdebug 07:12:38 INFO - Running setup.py install for mozdevice 07:12:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:12:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:12:38 INFO - Running setup.py install for mozfile 07:12:38 INFO - Running setup.py install for mozhttpd 07:12:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:12:38 INFO - Running setup.py install for mozinfo 07:12:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:12:38 INFO - Running setup.py install for mozInstall 07:12:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:12:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:12:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:12:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:12:38 INFO - Running setup.py install for mozleak 07:12:38 INFO - Running setup.py install for mozlog 07:12:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:12:39 INFO - Running setup.py install for moznetwork 07:12:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:12:39 INFO - Running setup.py install for mozprocess 07:12:39 INFO - Running setup.py install for mozprofile 07:12:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:12:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:12:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:12:39 INFO - Running setup.py install for mozrunner 07:12:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:12:39 INFO - Running setup.py install for mozscreenshot 07:12:39 INFO - Running setup.py install for moztest 07:12:39 INFO - Running setup.py install for mozversion 07:12:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:12:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:12:39 INFO - Cleaning up... 07:12:39 INFO - Return code: 0 07:12:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:39 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 0xcd9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf983b0>, '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 0xf992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf99740>, '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': '5bd038846534b2fdfa68eeae000001e2-1468670011.126945-326616824', '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:12:39 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:12:39 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:12:39 INFO - Using env: {'DISPLAY': ':0', 07:12:39 INFO - 'HOME': '/home/cltbld', 07:12:39 INFO - 'LANG': 'en_US.UTF-8', 07:12:39 INFO - 'LANGUAGE': 'en_US:en', 07:12:39 INFO - 'LOGNAME': 'cltbld', 07:12:39 INFO - 'MAIL': '/var/mail/cltbld', 07:12:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:39 INFO - 'MOZ_NO_REMOTE': '1', 07:12:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:39 INFO - 'NO_EM_RESTART': '1', 07:12:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:39 INFO - 'PWD': '/builds/slave/test', 07:12:39 INFO - 'SHELL': '/bin/bash', 07:12:39 INFO - 'SHLVL': '1', 07:12:39 INFO - 'TERM': 'linux', 07:12:39 INFO - 'TMOUT': '86400', 07:12:39 INFO - 'USER': 'cltbld', 07:12:39 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468670011.126945-326616824', 07:12:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:39 INFO - '_': '/tools/buildbot/bin/python'} 07:12:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:12:40 INFO - Running setup.py (path:/tmp/pip-TdvvMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:12:40 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:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:12:40 INFO - Running setup.py (path:/tmp/pip-HYq5OI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:12:40 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:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:12:40 INFO - Running setup.py (path:/tmp/pip-nsNFNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:12:40 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:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:12:40 INFO - Running setup.py (path:/tmp/pip-w6fGdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:12:40 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:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:12:40 INFO - Running setup.py (path:/tmp/pip-KCJh5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:12:40 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:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:12:40 INFO - Running setup.py (path:/tmp/pip-xEpr5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:12:40 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:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:12:40 INFO - Running setup.py (path:/tmp/pip-D2z6dp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:12:40 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:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:12:40 INFO - Running setup.py (path:/tmp/pip-ZrKyMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:12:40 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:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:12:40 INFO - Running setup.py (path:/tmp/pip-V7O1S9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:12:40 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:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:12:40 INFO - Running setup.py (path:/tmp/pip-jKijot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:12:40 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:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:12:40 INFO - Running setup.py (path:/tmp/pip-6p08Mq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:12:40 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:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:12:40 INFO - Running setup.py (path:/tmp/pip-nlAuj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:12:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:12:40 INFO - Running setup.py (path:/tmp/pip-9mij8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:12:41 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:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:12:41 INFO - Running setup.py (path:/tmp/pip-eJOwCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:12:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:12:41 INFO - Running setup.py (path:/tmp/pip-9u_9F4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:12:41 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:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:12:41 INFO - Running setup.py (path:/tmp/pip-aZsRyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:12:41 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:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:12:41 INFO - Running setup.py (path:/tmp/pip-MBkUh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:12:41 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:12:41 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:12:41 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:12:41 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:12:41 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:12:41 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:12:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:12:41 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:12:41 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:12:41 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:12:41 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:12:41 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:12:41 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:12:43 INFO - Downloading blessings-1.6.tar.gz 07:12:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:12:43 INFO - Installing collected packages: blessings 07:12:43 INFO - Running setup.py install for blessings 07:12:43 INFO - Successfully installed blessings 07:12:43 INFO - Cleaning up... 07:12:43 INFO - Return code: 0 07:12:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:12:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:12:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:12:43 INFO - Reading from file tmpfile_stdout 07:12:43 INFO - Current package versions: 07:12:43 INFO - argparse == 1.2.1 07:12:43 INFO - blessings == 1.6 07:12:43 INFO - blobuploader == 1.2.4 07:12:43 INFO - docopt == 0.6.1 07:12:43 INFO - functools32 == 3.2.3-2 07:12:43 INFO - jsonschema == 2.5.1 07:12:43 INFO - manifestparser == 1.1 07:12:43 INFO - mozInstall == 1.12 07:12:43 INFO - mozcrash == 0.17 07:12:43 INFO - mozdebug == 0.1 07:12:43 INFO - mozdevice == 0.48 07:12:43 INFO - mozfile == 1.2 07:12:43 INFO - mozhttpd == 0.7 07:12:43 INFO - mozinfo == 0.9 07:12:43 INFO - mozleak == 0.1 07:12:43 INFO - mozlog == 3.2 07:12:43 INFO - moznetwork == 0.27 07:12:43 INFO - mozprocess == 0.23 07:12:43 INFO - mozprofile == 0.28 07:12:43 INFO - mozrunner == 6.12 07:12:43 INFO - mozscreenshot == 0.1 07:12:43 INFO - mozsystemmonitor == 0.3 07:12:43 INFO - moztest == 0.7 07:12:43 INFO - mozversion == 1.4 07:12:43 INFO - psutil == 3.1.1 07:12:43 INFO - requests == 1.2.3 07:12:43 INFO - wsgiref == 0.1.2 07:12:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:12:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:43 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 0xcd9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf983b0>, '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 0xf992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf99740>, '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': '5bd038846534b2fdfa68eeae000001e2-1468670011.126945-326616824', '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:12:43 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:12:43 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:12:43 INFO - Using env: {'DISPLAY': ':0', 07:12:43 INFO - 'HOME': '/home/cltbld', 07:12:43 INFO - 'LANG': 'en_US.UTF-8', 07:12:43 INFO - 'LANGUAGE': 'en_US:en', 07:12:43 INFO - 'LOGNAME': 'cltbld', 07:12:43 INFO - 'MAIL': '/var/mail/cltbld', 07:12:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:43 INFO - 'MOZ_NO_REMOTE': '1', 07:12:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:43 INFO - 'NO_EM_RESTART': '1', 07:12:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:43 INFO - 'PWD': '/builds/slave/test', 07:12:43 INFO - 'SHELL': '/bin/bash', 07:12:43 INFO - 'SHLVL': '1', 07:12:43 INFO - 'TERM': 'linux', 07:12:43 INFO - 'TMOUT': '86400', 07:12:43 INFO - 'USER': 'cltbld', 07:12:43 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468670011.126945-326616824', 07:12:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:43 INFO - '_': '/tools/buildbot/bin/python'} 07:12:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:43 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:12:43 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:12:43 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:12:43 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:12:43 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:12:43 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:12:43 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:12:43 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:12:43 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:12:43 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:12:43 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:12:43 INFO - Cleaning up... 07:12:43 INFO - Return code: 0 07:12:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:12:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:43 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 0xcd9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf983b0>, '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 0xf992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf99740>, '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': '5bd038846534b2fdfa68eeae000001e2-1468670011.126945-326616824', '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:12:43 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:12:43 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:12:43 INFO - Using env: {'DISPLAY': ':0', 07:12:43 INFO - 'HOME': '/home/cltbld', 07:12:43 INFO - 'LANG': 'en_US.UTF-8', 07:12:43 INFO - 'LANGUAGE': 'en_US:en', 07:12:43 INFO - 'LOGNAME': 'cltbld', 07:12:43 INFO - 'MAIL': '/var/mail/cltbld', 07:12:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:43 INFO - 'MOZ_NO_REMOTE': '1', 07:12:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:43 INFO - 'NO_EM_RESTART': '1', 07:12:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:43 INFO - 'PWD': '/builds/slave/test', 07:12:43 INFO - 'SHELL': '/bin/bash', 07:12:43 INFO - 'SHLVL': '1', 07:12:43 INFO - 'TERM': 'linux', 07:12:43 INFO - 'TMOUT': '86400', 07:12:43 INFO - 'USER': 'cltbld', 07:12:43 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468670011.126945-326616824', 07:12:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:43 INFO - '_': '/tools/buildbot/bin/python'} 07:12:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:12:44 INFO - Cleaning up... 07:12:44 INFO - Return code: 0 07:12:44 INFO - Running post-action listener: _resource_record_post_action 07:12:44 INFO - Running post-action listener: _start_resource_monitoring 07:12:44 INFO - Starting resource monitoring. 07:12:44 INFO - ##### 07:12:44 INFO - ##### Finished create-virtualenv step (success) 07:12:44 INFO - ##### 07:12:44 INFO - ##### 07:12:44 INFO - ##### Running install step. 07:12:44 INFO - ##### 07:12:44 INFO - Running pre-action listener: _resource_record_pre_action 07:12:44 INFO - Running main action method: install 07:12:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:12:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:12:44 INFO - Reading from file tmpfile_stdout 07:12:44 INFO - Detecting whether we're running mozinstall >=1.0... 07:12:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:12:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:12:44 INFO - Reading from file tmpfile_stdout 07:12:44 INFO - Output received: 07:12:44 INFO - Usage: mozinstall [options] installer 07:12:44 INFO - Options: 07:12:44 INFO - -h, --help show this help message and exit 07:12:44 INFO - -d DEST, --destination=DEST 07:12:44 INFO - Directory to install application into. [default: 07:12:44 INFO - "/builds/slave/test"] 07:12:44 INFO - --app=APP Application being installed. [default: firefox] 07:12:44 INFO - mkdir: /builds/slave/test/build/application 07:12:44 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:12:44 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:13:01 INFO - Reading from file tmpfile_stdout 07:13:01 INFO - Output received: 07:13:01 INFO - /builds/slave/test/build/application/firefox/firefox 07:13:01 INFO - Running post-action listener: _resource_record_post_action 07:13:01 INFO - ##### 07:13:01 INFO - ##### Finished install step (success) 07:13:01 INFO - ##### 07:13:01 INFO - ##### 07:13:01 INFO - ##### Running run-tests step. 07:13:01 INFO - ##### 07:13:01 INFO - Running pre-action listener: _resource_record_pre_action 07:13:01 INFO - Running main action method: run_tests 07:13:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:13:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:13:01 INFO - Python 2.7.3 07:13:01 INFO - Return code: 0 07:13:01 INFO - grabbing minidump binary from tooltool 07:13:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:01 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 0xf983b0>, '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 0xf992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf99740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:13:01 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:13:01 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:13:01 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:13:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:13:01 INFO - Return code: 0 07:13:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:13:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:13:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:13:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:13:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:13:01 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/M3_-nNhuRme4CoLfTj3kQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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:13:01 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/M3_-nNhuRme4CoLfTj3kQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --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:13:01 INFO - Using env: {'DISPLAY': ':0', 07:13:01 INFO - 'HOME': '/home/cltbld', 07:13:01 INFO - 'LANG': 'en_US.UTF-8', 07:13:01 INFO - 'LANGUAGE': 'en_US:en', 07:13:01 INFO - 'LOGNAME': 'cltbld', 07:13:01 INFO - 'MAIL': '/var/mail/cltbld', 07:13:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:13:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:13:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:01 INFO - 'MOZ_NO_REMOTE': '1', 07:13:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:13:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:01 INFO - 'NO_EM_RESTART': '1', 07:13:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:01 INFO - 'PWD': '/builds/slave/test', 07:13:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:13:01 INFO - 'SHELL': '/bin/bash', 07:13:01 INFO - 'SHLVL': '1', 07:13:01 INFO - 'TERM': 'linux', 07:13:01 INFO - 'TMOUT': '86400', 07:13:01 INFO - 'USER': 'cltbld', 07:13:01 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468670011.126945-326616824', 07:13:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:01 INFO - '_': '/tools/buildbot/bin/python'} 07:13:01 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/M3_-nNhuRme4CoLfTj3kQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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:13:01 INFO - mozversion application_buildid: 20160716043058 07:13:01 INFO - mozversion application_changeset: ccb0ca7468c1524ae532d70c1ca3380d296f097c 07:13:01 INFO - mozversion application_display_name: Nightly 07:13:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:13:01 INFO - mozversion application_name: Firefox 07:13:01 INFO - mozversion application_remotingname: firefox 07:13:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:13:01 INFO - mozversion application_vendor: Mozilla 07:13:01 INFO - mozversion application_version: 50.0a1 07:13:01 INFO - mozversion platform_buildid: 20160716043058 07:13:01 INFO - mozversion platform_changeset: ccb0ca7468c1524ae532d70c1ca3380d296f097c 07:13:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:13:01 INFO - mozversion platform_version: 50.0a1 07:13:01 INFO - using testdate: 1468678381 07:13:01 INFO - actual date: 1468678381 07:13:01 INFO - starting webserver on 'localhost:35882' 07:13:01 INFO - SUITE-START | Running 2 tests 07:13:01 INFO - TEST-START | dromaeo_css 07:13:01 INFO - operating with platform_type : linux_ 07:13:01 INFO - Initialising browser for dromaeo_css test... 07:13:01 INFO - TEST-INFO | started process 27732 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp54hfsl/profile http://localhost:35882/getInfo.html) 07:13:05 INFO - PROCESS | 27732 | __metrics Screen width/height:1600/1200 07:13:05 INFO - PROCESS | 27732 | colorDepth:24 07:13:05 INFO - PROCESS | 27732 | Browser inner width/height: 1024/697 07:13:05 INFO - PROCESS | 27732 | __metrics 07:13:06 INFO - PROCESS | 27732 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:13:06 INFO - PROCESS | 27732 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:13:07 INFO - TEST-INFO | 27732: exit 0 07:13:07 INFO - Browser initialized. 07:13:07 INFO - Running cycle 1/1 for dromaeo_css test... 07:13:07 INFO - TEST-INFO | started process 27814 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp54hfsl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:13:19 INFO - PROCESS | 27814 | RSS: Main: 158142464 07:13:19 INFO - PROCESS | 27814 | 07:14:11 INFO - PROCESS | 27814 | 1468678451023 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:16:18 INFO - PROCESS | 27814 | Cycle 1(1): loaded http://localhost:35882/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35882/tests/dromaeo/cssquery-ext.html) 07:16:19 INFO - PROCESS | 27814 | RSS: Main: 247042048 07:16:19 INFO - PROCESS | 27814 | 07:19:22 INFO - PROCESS | 27814 | Cycle 1(1): loaded http://localhost:35882/tests/dromaeo/cssquery-ext.html (next: http://localhost:35882/tests/dromaeo/cssquery-jquery.html) 07:19:22 INFO - PROCESS | 27814 | RSS: Main: 244056064 07:19:22 INFO - PROCESS | 27814 | 07:22:24 INFO - PROCESS | 27814 | Cycle 1(1): loaded http://localhost:35882/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35882/tests/dromaeo/cssquery-mootools.html) 07:22:25 INFO - PROCESS | 27814 | RSS: Main: 239411200 07:22:25 INFO - PROCESS | 27814 | 07:25:27 INFO - PROCESS | 27814 | Cycle 1(1): loaded http://localhost:35882/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35882/tests/dromaeo/cssquery-prototype.html) 07:25:28 INFO - PROCESS | 27814 | RSS: Main: 239394816 07:25:28 INFO - PROCESS | 27814 | 07:28:30 INFO - PROCESS | 27814 | Cycle 1(1): loaded http://localhost:35882/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35882/tests/dromaeo/cssquery-yui.html) 07:28:31 INFO - PROCESS | 27814 | RSS: Main: 227500032 07:28:31 INFO - PROCESS | 27814 | 07:31:34 INFO - PROCESS | 27814 | Cycle 1(1): loaded http://localhost:35882/tests/dromaeo/cssquery-yui.html (next: http://localhost:35882/tests/dromaeo/cssquery-dojo.html) 07:31:34 INFO - PROCESS | 27814 | RSS: Main: 272306176 07:31:34 INFO - PROCESS | 27814 | 07:31:34 INFO - PROCESS | 27814 | __start_tp_report 07:31:34 INFO - PROCESS | 27814 | _x_x_mozilla_page_load 07:31:34 INFO - PROCESS | 27814 | _x_x_mozilla_page_load_details 07:31:34 INFO - PROCESS | 27814 | |i|pagename|runs| 07:31:34 INFO - PROCESS | 27814 | |0;dojo.html;3007.067808979217;3027.7123673251062;3056.4040012197624;3059.11285727139;3076.3078307380842;5159.22611608258;5229.267902493649;5326.920096198555;5327.307450031495;5330.200469929512;5289.920651190235;5291.841244762653;5316.787328506855;5324.148136298193;5384.0847056000475;4734.928976065362;4793.352897358846;4809.879753006167;4812.23004319309;5006.399232092136;4909.7545122743895;4922.852314430573;4925.113479573693;4977.925331120036;4997.700137991714;4641.303804429345;4706.482286948433;4749.572538471554;4763.118823017736;4773.76131193439;4726.243800991825;4748.264019077049;4813;4828.5654291113615;4853.296272040534;4674.789634466423;4771.355866957951;4793.712377257376;4798.256270278112;4838.419389673227;5178.6116041297055;5286.207068939651;5299.788008479656;5369.731513424314;5382.219578161144;5626.465485778845;5638.182463542763;5662.433756624346;5681.346645135821;5687.374388817227;5494.203340515643;5614.466625670555;5666.376698563155;5674.489295963342;5674.773009079632;5292.682439053669;5368.973155134199;5390.733177703237;5417.485338892799;5419.783208671688;5945.940540594625;5958.344582095966;5959.165716799652;5962.970185149134;5963.4931030862;5481.479259470424;5481.616286859961;5501.174823776386;5717.399673034354;5729.541636669056;5655.349634792052;5657.151427285858;5664.461876121762;5664.745086471119;5666.886662266814;5580.776768929279;5584.357798853184;5628.662280263197;5634.7182640867795;5639.379668236491;5501.229827824108;5602.159676048625;5627.5779316551425;5667.206591077253;5676.744546495418;4393.626541743987;4395.230834603932;4400.933985990213;4401.18578063053;4441.311596702516;3905.8437662493184;3919.980400097981;3944.7633142011573;3980.0049987503126;3990.3016972029777;5171.405288391883;5178.844634660966;5326.201069839555;5338.97330513345;5354.866128346823;5734.16854556087;5739.339975902824;5747.224124743107;5748.9425105748405;5789.45000224978;5340.813071542555;5382.2464854920345;5385.649932754359;5389.245505629215;5391.865203369947;4781.258904869751;4931.876703082452;4972;4972.825951091694;4991.226359914219;5973.372795856372;5981.820545383645;5984.371640977722;5985.371535988746;5996.190514280516;5602.215689803512;5765.365809761007;5778.94221057784;5783.248177736868;5789.478946894799;5808.738606762621;5873.823785286449;5878.853028674317;5921.911171332347;5923.555733320104;5572.637778544382;5613.214150018919;5614.101743720985;5614.88770224585;5618.494335509824;5616.85957851057;5688.715564221689;5699.658020518782;5715.057015592547;5716.885662286648;5575.470330318613;5636.239107720406;5683.71581420919;5686.232358631697;5687.43125687428;5587.525060369751;5634.492895639412;5640.54875609942;5641.210230567642;5643.604947653625;5416;5618.185363122243;5635.605507614591;5640.54875609942;5641.971790141023;5579.079451890555;5598.748056337556;5627.831165065055;5645.463680950304;5714.3999880012;5477.233187353853;5501.834944951658;5520;5530.7511161997;5534.08687566547 07:31:34 INFO - PROCESS | 27814 | |1;ext.html;611.1505008038827;633.3033662970731;644.6100109433793;645.7417033186728;662.4965026579804;44193.55806441935;44874.55125448749;45279.32081018779;48753;48836.51163488364;47416.525834741646;48056.75971620137;48063.51936480634;48069.759651201784;48075.759621201934;9076.727698169048;9195.21840643546;9197.264218862509;9201.033891441402;9205.631774729036;9038.909610903906;9089.318301127409;9109.134632209963;9112.954435227815;9117.863232051524;9169.908300917006;9172.31207659425;9187.862182067274;9196.908030919672;9209.309301802392;9128.40665356753;9165.541722913827;9168.816623667555;9173.495457749821;9175.908240917572;9034.186923176945;9103.135202155785;9116.680916167968;9118.58966346516;9122.452652840851;43650;43940.340894886605;43965.560344396465;44012.3398149028;44023.559764402264;3532.205253817896;3727.9440808387894;4107.096438783463;4265.509466411371;4361.084172323815;33825.83087084573;33827;34506;35647.4652880207;35772;4392.89017774555;4437.889052773707;4527;4549.704269222523;4697.812087516495;368123;372690;373971;374602.126989366;374929;55349.169762453595;62148;62931.370686292554;63995.6800215996;64012.35987640157;59369.70315148397;62903;63289.68355158287;63403;63556.68221658862;15232.3907043717;15271.083734975937;15281.847181528265;15288.847111528965;15296;10937.56249750001;13300.73398532024;13453.663658408617;13558.45766169362;13562.389692463863;19703.802961970483;19792;20010.499737506678;20072.397828065183;20161.49596260076;7126.893096603555;7196.255639172469;7297.227053719553;7374.778756637309;7644.770656880302;1004.5680357446222;1032.3083534032216;1072.6084978982772;1084.8481212630238;1097.4183682648209;32891;33171;33550;33657.32685346279;34067;1073.3398959639765;1083.3878858444953;1086.6522712732008;1125.9318357475813;1178.4915308405255;17219.65560688779;17543.473695789147;17552.38566650161;17565.82434175642;17576.824231757775;625580;627681;631900;632711;632715;63184.684076579324;63919.36080639227;64003.679981599795;64071.359286407474;64105;1243.154654834721;1344.9058565900293;1379.7654398752036;1394.7698629726185;1400.796884451769;32582;33781.324373512885;33898.49152262669;34417.13957151091;34432.82783586166;52401.213981791065;52486.47513524816;53064;53159.46840531545;53385.19922201248;410447;412881;413351;413440;414160;25397.238082857544;29266.122016339545;30315.848420758637;30372.24069398283;30392.240193995327;49499.50500494949;50411.74794126006;50916.490835092656;51137.48862511327;51446;42349;42450;42818;43073.13853722846;44197.779011104736;42238.366424503045;42927.57072429236;43029.18779827277;43289.567104328555;44478;43068;43085.13829723325;43858.56141438545;43946.78026609847;44164.55835441605;36613.63386366102;38523;39165;39855;39935.80032099821;28422.22200180515;29187;29192;29276.414471710872;29367.265818354714 07:31:34 INFO - PROCESS | 27814 | |2;jquery.html;383.76590279929246;388.79005337117957;390.5021098099924;397.76333081816347;412.3258472397631;18810.529736756587;19628.9018554907;20570.794292057075;20579.073941672625;20580.691289630668;12185.756284874296;12786.104972651918;12824.935875320634;13806.654833629163;20354.287599934007;5273.762680679369;5432.103702889019;5478.780848766045;5493.890122197554;5495.065838807413;3962.7820469874146;4205.5163656179475;6427.646479443629;6437.6781160942;6553.705083271264;5973.671448070354;6472.64400457977;6485.740570377179;6512.511561632873;6517.934820651804;5874.089516125007;5881.911771323434;5898.262717160355;5898.793542226044;5901.911471327933;3821.541415030214;5474.370447398521;5776.508996735282;5805.477507024346;5861.677607731573;13636.522721704792;13861.514846980308;13866.168029918237;13868.167909925436;14007.229602371866;2401.7838394544574;2444.6577479152934;2484.018812569025;2844.48799216141;2965.9851700741574;10173;10356.79286414275;10415.114715249212;10725.14198864089;10750.247482676215;1921.3659492367485;1941.6505029094758;1946.4744518979937;1949.483386902472;1965.066593368153;64969.67515162394;76377;81103.59448202721;85705.57147214287;90458;10676.51955661997;10853.782924341469;10930.56277748897;10943.23397362193;11044.502997365138;14764.187969661773;14775.630609234855;15017.24913754308;15044.62388440276;15053.924730376279;8056;8199.303059240032;8250.174982501701;8331.166883311742;8449.281811046007;8172.42793004484;8191.467554608931;8202.671893124209;8405.201505856934;8408.621612027473;4595.425571803525;4600.35595016698;4619.676622636383;4676.251799712029;4798.160321943646;1729.2823478256635;1764.5941433470373;1802.7476153338544;1806.9096545172688;1835.164999925031;915.6932427636816;944.263474489899;986.9569990120382;1066.9253152279266;1095.0856035210688;19084.90457547731;19248.422547323604;20218;20300.695489567668;21411.78588214098;979.7452662307851;982.6020461713018;998.6754304850807;1033.6278939581744;1046.706922061824;9212.677556285498;11005.17461190414;11218.831717524243;11295.209335346612;11336.71658208535;505885;510564;512105;514094;531994;59116.704416478504;59367.703161483914;60192.09711854326;93979.53010234905;99455.50272248738;990.3513198854762;1027.3835698580792;1036.7770929250248;1041.6927006533092;1044.6709286574858;16516.339346426008;17720.113994300493;17811.55471113181;18103.728444073087;18805.717914231023;41247.381289281286;44305.778471107435;44664.33003505015;45003;45392;58887;59717.701411492664;60098;60100;61416.38583614286;8430.283425908867;8491.5329656867;8641.697540586048;8666.263367613572;8710.21608055278;12616.74766504683;13528.458861645817;13546.72906541844;13861.79207311871;14095.506657266946;11685.649430517098;11774.823377649513;11976.682564918026;12105.334206618369;12262.20295680778;11435.542578297107;11615;11712.648620541397;11835.52657893709;11879.940600296943;11739.295642261492;11844.644660660195;11948.880511194777;11953.342566158944;12239.571614993432;7316.085489313836;7472.850542989001;7548.8490230196185;8420.410571260198;8845.955770221366;8361.581920904053;10567.048965592827;10627.787444250916;10711.410872402093;11010.284331518425 07:31:34 INFO - PROCESS | 27814 | |3;mootools.html;1352.09409695504;1453.2007395932237;1502.068717395215;1622.4078211452822;1768.4871387297685;8159.755207343782;8460.788480287989;8473.491590504565;8734.694285700001;8757.255633271163;8536.487810731345;8723.47659140452;8724.38929274951;8738.388312818106;8759.737207883758;2000.3598848368529;2057.783932687069;2063.9690404643943;2269.704938358015;2294.8967296471615;2253.954920901581;2334.486412989148;2336.4976530046038;2361.0437772702;2366.881655917206;2246.831487638434;2275.12407723027;2280.486890449652;2297.1041293895396;2298.54029194161;1969.4977780665838;2041.173324803457;2234.1510226114137;2237.2057919438607;2240.5070884405404;2045.9693104603443;2186.8469207155504;2256.627656436686;2263.8981245843975;2278.225403362848;8662.783430414227;8728.127187281285;8732.51971141587;8735.825283494294;8744.387892847502;4791.592714619262;4895.265710143472;4895.804167833282;4900.289458028602;4900.387451568554;3277.213468767479;3327.7670563060597;3367.5958884933966;3379.9662003380145;3383.8646454141804;1062.5696592879897;1068.7061058208976;1099.4228030284164;1101.7355834599718;1149.0692539043318;11751.529938802523;11761.235519691107;11767.470463829148;11783.116266280063;11805.94097029518;4243.087736136746;4326.805293761789;4436.689431739747;4456.77716114193;4469.145304698579;9774.95112524447;9829.066238707312;9849.064338887794;9924.751881202883;9954.153896918699;5072.746362681851;5082.974585127051;5089.338386009795;5091.974540127276;5092.770825312869;4074.409210664437;4480.260756975063;4641.767911604406;4686.671932964659;4690.953090469052;3705.110773414361;3713.851445942132;3780.8865734028022;3805.60041195676;3929.1159489115294;1131.3664347965166;1143.4054291768234;1147.6442302886132;1156.242661057009;1158.223989926751;771.4676872957754;913.9680111196209;956.3018996132723;965.7493545858131;1041.7916416716535;6005.3694362091355;6155.84610384735;6218.5647004710145;6397.040443933447;6419.935800641933;943.9622415103319;964.3105179796479;964.9276304277207;983.439439519467;993.4039576254335;4125.64931980779;4131.586841315844;4168.18720349535;4169.937450938239;4209.957900421018;10661.307015043998;10831.24181307301;10836;10907.127429805756;10912.127029837595;10763.300385474919;10787.83818242727;10803.13574914005;10810.621628242974;10828.675139745821;7416.666250018762;7686.192949740197;7700.345470634947;7838.137804841463;8153.959230203811;6169.938300617116;6321.083442900662;6381.457576106083;6383.147617110383;6383.776567820104;9902.603895844086;10016.849747253651;10194.133498652402;10195.490225488844;10243.334183278062;10046.196304295785;10346.844797328196;10366.274360794672;10409.1672666185;10425.165986720893;6599.208095028627;7307.41540676734;7519.360854327443;7561.735339263099;7701.037370328709;8512.361572881935;8539.530325832138;8542.615582298688;8544.718292256211;8553.230209281195;7429;7642.694292228249;7669.501482403626;7693.461457698131;7756.108047574601;7323.12122545298;7327.963360183165;7406.518576292524;7471.514351567131;7544.622768861425;6535.803925882231;6536.117624120683;6584.901226481511;6586.176727909012;6588.604683718992;5252.684838909678;5315.149576067965;5375.381831089475;5453.563714902878;5469.781208751605;5238.76425560843;5240.606954478506;5306.852353217373;5462.399136095106;5477.67133971963 07:31:34 INFO - PROCESS | 27814 | |4;prototype.html;322.9160418291244;324.96912793284645;330.93546758382115;334.49310854600037;334.52831507574325;5248.553872920802;5253.290805741224;5333.573314134869;5342.519173274404;5373.220882971967;5001.924971125436;5107.974460127694;5221.216817477381;5225.190095535198;5253.185756207784;4080.1431699343025;4095.344744840826;4102.17956408718;4113.074558224405;4118.6499147572495;4116.526599441073;4145.585441455861;4151.46031015969;4165.062860856314;4172.123853990665;3774.074573158244;3915.451836742858;4034.4150098235737;4081.571434999327;4091.2022155679656;4065.715399921977;4099.323611604082;4101.651359634435;4106.691998100139;4119.134981653826;3644.908877278063;3650.2881938022097;3652.068722475778;3653.7442379033478;3660.963390366089;4917.950820491785;5128.640995130342;5128.794848206105;5143.768530416103;5148.845534633967;4666.766661666903;4699.130660827758;4717.646176536739;4718.457377401608;4727.5272472752795;5449.264349312832;5452.154915988028;5475.479829416199;5554.527865131468;5562.582806289544;3809.5618604325928;3967.7619342839234;3971.7687516869864;3993.7004724645476;4004.519457665099;5718.542516598662;5725.141228815669;5755.302185855183;5761.740721667535;5773.105168698817;3995.300822356076;3998.7200895937585;4010.8997275068355;4015.5382131055303;4019.4774679291504;3889.5997440921246;4054.1891621675195;4057.2494088593703;4058.8432296795863;4063.927397027537;4615.076984603093;4624.491305956342;4624.560666736655;4632.467266264355;4649.790759415834;5424.810131645373;5476.91784623231;5519.530839878575;5542.75057622408;5557.305336832896;1372.773492373767;1412.1385954567706;1415.2640626873967;1426.322496814005;1428.8785453236592;900.3787386703154;925.1349987761464;930.9860352094724;955.4171955107379;959.3620242538773;5270.710110943858;5285.440794965494;5297.940411917555;5304.575633949275;5310.433422140401;5562.552476910228;5575.888482230333;5584.692841893735;5613.298337707786;5614.466625670637;5114.386273647112;5271.710055946883;5382.730863456812;5414.566834653218;5415.160650099241;3013.0960711786374;3015.1858998070397;3016.3062495626127;3026.2585666511845;3033.2416895776055;5721.5136713379;5902.2622172228475;5913.9112913306335;5921.615095018896;5921.792737254175;5741.62679425836;5748.166515855178;5759.337676167211;5800.53595712342;5803.100519419497;5875.618084824473;5881.3530511643685;5882.205902203234;5888.351261646746;5892.734826932799;5406.540444062299;5584.720763961867;5637.661740295595;5661.66030038199;5705.429457054262;5522.581934452342;5538.667679939216;5568.610197286151;5576.247206627054;5578.470045345685;5730.971345143247;5826.796062137805;5866.738651190015;5879.5002424794375;5882.852928676646;4163.937540936828;4163.937540936949;4180.498340199196;4188.015816283232;4194.161167766398;5601.60788744784;5601.747921343468;5612.747426365905;5616.494515493625;5632.49307562305;5332.78668853257;5395.838124856261;5465.262189604353;5520.806771763129;5540.833774986757;5426.693655196605;5448.673079615236;5449.264349312951;5467.17992301158;5488.451154884479;5231.189165679326;5321.521063104339;5410.567154627699;5470.781168753205;5536.2249285099315;5428.864278393072;5546.833594992157;5547.389787123494;5553.861153471195;5586.944130558642;5394.973025134849;5396.3524377075;5398.9472052949295;5410.648307859977;5424.5660347172925 07:31:34 INFO - PROCESS | 27814 | |5;yui.html;675.0549231076492;727.2327694282529;742.3133601418687;773.2190487607515;895.1227796759174;15166.620834479143;15896.602584935354;16044.598885027866;16065.839341606596;16115.435959741411;14450.427337678822;14673.633159171026;15132.848671513282;15302.693946121071;15414.922925385385;674.8616533610598;830.883676285322;845.3997661660229;845.9450135741188;846.1073567386405;789.6249281591256;824.7814329202766;825.3149885594971;835.5947365527715;841.5413599588209;890.7416849113749;893.066745251214;893.1782759860911;893.1827377949202;893.3791015244408;700.1353328639127;835.7200337886816;883.2668884825612;883.6465413834453;885.2210055151457;634.1470721879065;638.3903372279462;640.0623087177261;641.0128402260514;641.9679016049179;15743.717161011704;15770.526884193378;15824.841751582568;15875.682486350324;15883.126428046453;14462.699161165456;14558.199299038548;14808.407663693439;15011.099334039993;15036.699266014619;13828.792568111487;13875.791863122062;13933.372998215105;13950.372233249529;13956.72086558263;4517.141743068806;4521.954780452186;4562.703424277412;4571.794269257858;4634.050019745944;84131.15868841356;87679.56160219222;88929;89132.55433722789;89389.55305223432;11391.544338226544;11420.42897855104;11566.30602163873;11580.826287605692;11591.188616796911;20186.495337616383;21633.242836500645;21753;21934.341969740934;21948;7661.731839385595;7811.4922530035365;7974.720884769005;8042.517448953082;8176.3867709922;4988.426330971912;5068.543831055223;5097.46476619957;5135.255387968724;5162.1224391853475;3430.5711786026745;3655.817209139532;3676.1361080146144;3714.257148570297;3724.7020238380865;663.9302873198342;672.700648211551;675.7634827810227;684.3430306905327;695.523566357047;609.8749756299948;640.0591131037368;650.067153634536;779.766070178944;795.3358945280639;9978.850317245247;9983.151432128205;10007.949960250153;10151.796964060677;10191.133753631024;717.2970488920782;717.4224749077043;761.5202422473806;770.2720928722416;776.3207193705508;4899.681520701143;5026.29631851541;5134.743262836918;5148.279240906276;5149.2791009258735;74722.62638686772;100567.49716251518;103557;104573;117625;96525.20848749098;97999.51000244953;98023.62846415103;98239;99540;67960.3203967964;80067.59966200015;83597;87027;87383;9232.261419086322;9583.904160958302;9788.706338809847;9795.951020244853;9871.901280987098;43225.35161972636;51185;51622.74188629033;51676.66011494479;53153.202701960276;69091.65454172697;71148.64425677838;71283.28716712973;71684;71831;12764.808527871903;12808.615741527768;12855.550055748005;13008.47966081384;13617.727645447234;14815.777763333343;14821.333040013009;15430.30563624662;15578.610534736723;15809.446669366516;12555.372231388577;12848.935755321163;12859.357032148167;13359;13409.396577153857;13430.127041742255;13638.93180534091;13688.315584220949;13709.108907920952;13740.793888091886;11066.502007409525;11496.655100347003;11511.42442877836;11597.6520704379;12003.339816310187;11583.710407239887;11945.581904633296;12025.518979240733;12338.13633045714;12577.559785407468;10736.30214036085;10755.156701102684;10811.837822432513;10817.783644327226;10972.177086718368 07:31:34 INFO - PROCESS | 27814 | __end_tp_report 07:31:34 INFO - PROCESS | 27814 | __start_cc_report 07:31:34 INFO - PROCESS | 27814 | _x_x_mozilla_cycle_collect,903 07:31:34 INFO - PROCESS | 27814 | __end_cc_report 07:31:34 INFO - PROCESS | 27814 | __startTimestamp1468679494250__endTimestamp 07:31:34 INFO - PROCESS | 27814 | 07:31:34 INFO - PROCESS | 27814 | ------- Summary: start ------- 07:31:34 INFO - PROCESS | 27814 | Number of tests: 6 07:31:34 INFO - PROCESS | 27814 | 07:31:34 INFO - PROCESS | 27814 | [#0] dojo.html Cycles:165 Average:5294.62 Median:5501.83 stddev:608.77 (11.1%) stddev-sans-first:583.59 07:31:34 INFO - PROCESS | 27814 | Values: 3007.1 3027.7 3056.4 3059.1 3076.3 5159.2 5229.3 5326.9 5327.3 5330.2 5289.9 5291.8 5316.8 5324.1 5384.1 4734.9 4793.4 4809.9 4812.2 5006.4 4909.8 4922.9 4925.1 4977.9 4997.7 4641.3 4706.5 4749.6 4763.1 4773.8 4726.2 4748.3 4813.0 4828.6 4853.3 4674.8 4771.4 4793.7 4798.3 4838.4 5178.6 5286.2 5299.8 5369.7 5382.2 5626.5 5638.2 5662.4 5681.3 5687.4 5494.2 5614.5 5666.4 5674.5 5674.8 5292.7 5369.0 5390.7 5417.5 5419.8 5945.9 5958.3 5959.2 5963.0 5963.5 5481.5 5481.6 5501.2 5717.4 5729.5 5655.3 5657.2 5664.5 5664.7 5666.9 5580.8 5584.4 5628.7 5634.7 5639.4 5501.2 5602.2 5627.6 5667.2 5676.7 4393.6 4395.2 4400.9 4401.2 4441.3 3905.8 3920.0 3944.8 3980.0 3990.3 5171.4 5178.8 5326.2 5339.0 5354.9 5734.2 5739.3 5747.2 5748.9 5789.5 5340.8 5382.2 5385.6 5389.2 5391.9 4781.3 4931.9 4972.0 4972.8 4991.2 5973.4 5981.8 5984.4 5985.4 5996.2 5602.2 5765.4 5778.9 5783.2 5789.5 5808.7 5873.8 5878.9 5921.9 5923.6 5572.6 5613.2 5614.1 5614.9 5618.5 5616.9 5688.7 5699.7 5715.1 5716.9 5575.5 5636.2 5683.7 5686.2 5687.4 5587.5 5634.5 5640.5 5641.2 5643.6 5416.0 5618.2 5635.6 5640.5 5642.0 5579.1 5598.7 5627.8 5645.5 5714.4 5477.2 5501.8 5520.0 5530.8 5534.1 07:31:34 INFO - PROCESS | 27814 | 07:31:34 INFO - PROCESS | 27814 | [#1] ext.html Cycles:180 Average:64054.62 Median:43754.28 stddev:129059.90 (295.0%) stddev-sans-first:129334.04 07:31:34 INFO - PROCESS | 27814 | Values: 611.2 633.3 644.6 645.7 662.5 44193.6 44874.6 45279.3 48753.0 48836.5 47416.5 48056.8 48063.5 48069.8 48075.8 9076.7 9195.2 9197.3 9201.0 9205.6 9038.9 9089.3 9109.1 9113.0 9117.9 9169.9 9172.3 9187.9 9196.9 9209.3 9128.4 9165.5 9168.8 9173.5 9175.9 9034.2 9103.1 9116.7 9118.6 9122.5 43650.0 43940.3 43965.6 44012.3 44023.6 3532.2 3727.9 4107.1 4265.5 4361.1 33825.8 33827.0 34506.0 35647.5 35772.0 4392.9 4437.9 4527.0 4549.7 4697.8 368123.0 372690.0 373971.0 374602.1 374929.0 55349.2 62148.0 62931.4 63995.7 64012.4 59369.7 62903.0 63289.7 63403.0 63556.7 15232.4 15271.1 15281.8 15288.8 15296.0 10937.6 13300.7 13453.7 13558.5 13562.4 19703.8 19792.0 20010.5 20072.4 20161.5 7126.9 7196.3 7297.2 7374.8 7644.8 1004.6 1032.3 1072.6 1084.8 1097.4 32891.0 33171.0 33550.0 33657.3 34067.0 1073.3 1083.4 1086.7 1125.9 1178.5 17219.7 17543.5 17552.4 17565.8 17576.8 625580.0 627681.0 631900.0 632711.0 632715.0 63184.7 63919.4 64003.7 64071.4 64105.0 1243.2 1344.9 1379.8 1394.8 1400.8 32582.0 33781.3 33898.5 34417.1 34432.8 52401.2 52486.5 53064.0 53159.5 53385.2 410447.0 412881.0 413351.0 413440.0 414160.0 25397.2 29266.1 30315.8 30372.2 30392.2 49499.5 50411.7 50916.5 51137.5 51446.0 42349.0 42450.0 42818.0 43073.1 44197.8 42238.4 42927.6 43029.2 43289.6 44478.0 43068.0 43085.1 43858.6 43946.8 44164.6 36613.6 38523.0 39165.0 39855.0 39935.8 28422.2 29187.0 29192.0 29276.4 29367.3 07:31:34 INFO - PROCESS | 27814 | 07:31:34 INFO - PROCESS | 27814 | [#2] jquery.html Cycles:180 Average:28942.80 Median:3393.76 stddev:84599.70 (2492.8%) stddev-sans-first:84809.85 07:31:34 INFO - PROCESS | 27814 | Values: 383.8 388.8 390.5 397.8 412.3 18810.5 19628.9 20570.8 20579.1 20580.7 12185.8 12786.1 12824.9 13806.7 20354.3 5273.8 5432.1 5478.8 5493.9 5495.1 3962.8 4205.5 6427.6 6437.7 6553.7 5973.7 6472.6 6485.7 6512.5 6517.9 5874.1 5881.9 5898.3 5898.8 5901.9 3821.5 5474.4 5776.5 5805.5 5861.7 13636.5 13861.5 13866.2 13868.2 14007.2 2401.8 2444.7 2484.0 2844.5 2966.0 10173.0 10356.8 10415.1 10725.1 10750.2 1921.4 1941.7 1946.5 1949.5 1965.1 64969.7 76377.0 81103.6 85705.6 90458.0 10676.5 10853.8 10930.6 10943.2 11044.5 14764.2 14775.6 15017.2 15044.6 15053.9 8056.0 8199.3 8250.2 8331.2 8449.3 8172.4 8191.5 8202.7 8405.2 8408.6 4595.4 4600.4 4619.7 4676.3 4798.2 1729.3 1764.6 1802.7 1806.9 1835.2 915.7 944.3 987.0 1066.9 1095.1 19084.9 19248.4 20218.0 20300.7 21411.8 979.7 982.6 998.7 1033.6 1046.7 9212.7 11005.2 11218.8 11295.2 11336.7 505885.0 510564.0 512105.0 514094.0 531994.0 59116.7 59367.7 60192.1 93979.5 99455.5 990.4 1027.4 1036.8 1041.7 1044.7 16516.3 17720.1 17811.6 18103.7 18805.7 41247.4 44305.8 44664.3 45003.0 45392.0 58887.0 59717.7 60098.0 60100.0 61416.4 8430.3 8491.5 8641.7 8666.3 8710.2 12616.7 13528.5 13546.7 13861.8 14095.5 11685.6 11774.8 11976.7 12105.3 12262.2 11435.5 11615.0 11712.6 11835.5 11879.9 11739.3 11844.6 11948.9 11953.3 12239.6 7316.1 7472.9 7548.8 8420.4 8846.0 8361.6 10567.0 10627.8 10711.4 11010.3 07:31:34 INFO - PROCESS | 27814 | 07:31:34 INFO - PROCESS | 27814 | [#3] mootools.html Cycles:180 Average:5697.59 Median:4843.43 stddev:3249.19 (67.1%) stddev-sans-first:3241.89 07:31:34 INFO - PROCESS | 27814 | Values: 1352.1 1453.2 1502.1 1622.4 1768.5 8159.8 8460.8 8473.5 8734.7 8757.3 8536.5 8723.5 8724.4 8738.4 8759.7 2000.4 2057.8 2064.0 2269.7 2294.9 2254.0 2334.5 2336.5 2361.0 2366.9 2246.8 2275.1 2280.5 2297.1 2298.5 1969.5 2041.2 2234.2 2237.2 2240.5 2046.0 2186.8 2256.6 2263.9 2278.2 8662.8 8728.1 8732.5 8735.8 8744.4 4791.6 4895.3 4895.8 4900.3 4900.4 3277.2 3327.8 3367.6 3380.0 3383.9 1062.6 1068.7 1099.4 1101.7 1149.1 11751.5 11761.2 11767.5 11783.1 11805.9 4243.1 4326.8 4436.7 4456.8 4469.1 9775.0 9829.1 9849.1 9924.8 9954.2 5072.7 5083.0 5089.3 5092.0 5092.8 4074.4 4480.3 4641.8 4686.7 4691.0 3705.1 3713.9 3780.9 3805.6 3929.1 1131.4 1143.4 1147.6 1156.2 1158.2 771.5 914.0 956.3 965.7 1041.8 6005.4 6155.8 6218.6 6397.0 6419.9 944.0 964.3 964.9 983.4 993.4 4125.6 4131.6 4168.2 4169.9 4210.0 10661.3 10831.2 10836.0 10907.1 10912.1 10763.3 10787.8 10803.1 10810.6 10828.7 7416.7 7686.2 7700.3 7838.1 8154.0 6169.9 6321.1 6381.5 6383.1 6383.8 9902.6 10016.8 10194.1 10195.5 10243.3 10046.2 10346.8 10366.3 10409.2 10425.2 6599.2 7307.4 7519.4 7561.7 7701.0 8512.4 8539.5 8542.6 8544.7 8553.2 7429.0 7642.7 7669.5 7693.5 7756.1 7323.1 7328.0 7406.5 7471.5 7544.6 6535.8 6536.1 6584.9 6586.2 6588.6 5252.7 5315.1 5375.4 5453.6 5469.8 5238.8 5240.6 5306.9 5462.4 5477.7 07:31:34 INFO - PROCESS | 27814 | 07:31:34 INFO - PROCESS | 27814 | [#4] prototype.html Cycles:180 Average:4640.81 Median:5327.15 stddev:1361.63 (25.6%) stddev-sans-first:1326.32 07:31:34 INFO - PROCESS | 27814 | Values: 322.9 325.0 330.9 334.5 334.5 5248.6 5253.3 5333.6 5342.5 5373.2 5001.9 5108.0 5221.2 5225.2 5253.2 4080.1 4095.3 4102.2 4113.1 4118.6 4116.5 4145.6 4151.5 4165.1 4172.1 3774.1 3915.5 4034.4 4081.6 4091.2 4065.7 4099.3 4101.7 4106.7 4119.1 3644.9 3650.3 3652.1 3653.7 3661.0 4918.0 5128.6 5128.8 5143.8 5148.8 4666.8 4699.1 4717.6 4718.5 4727.5 5449.3 5452.2 5475.5 5554.5 5562.6 3809.6 3967.8 3971.8 3993.7 4004.5 5718.5 5725.1 5755.3 5761.7 5773.1 3995.3 3998.7 4010.9 4015.5 4019.5 3889.6 4054.2 4057.2 4058.8 4063.9 4615.1 4624.5 4624.6 4632.5 4649.8 5424.8 5476.9 5519.5 5542.8 5557.3 1372.8 1412.1 1415.3 1426.3 1428.9 900.4 925.1 931.0 955.4 959.4 5270.7 5285.4 5297.9 5304.6 5310.4 5562.6 5575.9 5584.7 5613.3 5614.5 5114.4 5271.7 5382.7 5414.6 5415.2 3013.1 3015.2 3016.3 3026.3 3033.2 5721.5 5902.3 5913.9 5921.6 5921.8 5741.6 5748.2 5759.3 5800.5 5803.1 5875.6 5881.4 5882.2 5888.4 5892.7 5406.5 5584.7 5637.7 5661.7 5705.4 5522.6 5538.7 5568.6 5576.2 5578.5 5731.0 5826.8 5866.7 5879.5 5882.9 4163.9 4163.9 4180.5 4188.0 4194.2 5601.6 5601.7 5612.7 5616.5 5632.5 5332.8 5395.8 5465.3 5520.8 5540.8 5426.7 5448.7 5449.3 5467.2 5488.5 5231.2 5321.5 5410.6 5470.8 5536.2 5428.9 5546.8 5547.4 5553.9 5586.9 5395.0 5396.4 5398.9 5410.6 5424.6 07:31:34 INFO - PROCESS | 27814 | 07:31:34 INFO - PROCESS | 27814 | [#5] yui.html Cycles:180 Average:20532.51 Median:5047.42 stddev:28878.85 (572.2%) stddev-sans-first:28921.38 07:31:34 INFO - PROCESS | 27814 | Values: 675.1 727.2 742.3 773.2 895.1 15166.6 15896.6 16044.6 16065.8 16115.4 14450.4 14673.6 15132.8 15302.7 15414.9 674.9 830.9 845.4 845.9 846.1 789.6 824.8 825.3 835.6 841.5 890.7 893.1 893.2 893.2 893.4 700.1 835.7 883.3 883.6 885.2 634.1 638.4 640.1 641.0 642.0 15743.7 15770.5 15824.8 15875.7 15883.1 14462.7 14558.2 14808.4 15011.1 15036.7 13828.8 13875.8 13933.4 13950.4 13956.7 4517.1 4522.0 4562.7 4571.8 4634.1 84131.2 87679.6 88929.0 89132.6 89389.6 11391.5 11420.4 11566.3 11580.8 11591.2 20186.5 21633.2 21753.0 21934.3 21948.0 7661.7 7811.5 7974.7 8042.5 8176.4 4988.4 5068.5 5097.5 5135.3 5162.1 3430.6 3655.8 3676.1 3714.3 3724.7 663.9 672.7 675.8 684.3 695.5 609.9 640.1 650.1 779.8 795.3 9978.9 9983.2 10007.9 10151.8 10191.1 717.3 717.4 761.5 770.3 776.3 4899.7 5026.3 5134.7 5148.3 5149.3 74722.6 100567.5 103557.0 104573.0 117625.0 96525.2 97999.5 98023.6 98239.0 99540.0 67960.3 80067.6 83597.0 87027.0 87383.0 9232.3 9583.9 9788.7 9796.0 9871.9 43225.4 51185.0 51622.7 51676.7 53153.2 69091.7 71148.6 71283.3 71684.0 71831.0 12764.8 12808.6 12855.6 13008.5 13617.7 14815.8 14821.3 15430.3 15578.6 15809.4 12555.4 12848.9 12859.4 13359.0 13409.4 13430.1 13638.9 13688.3 13709.1 13740.8 11066.5 11496.7 11511.4 11597.7 12003.3 11583.7 11945.6 12025.5 12338.1 12577.6 10736.3 10755.2 10811.8 10817.8 10972.2 07:31:34 INFO - PROCESS | 27814 | -------- Summary: end -------- 07:31:34 INFO - PROCESS | 27814 | 07:31:34 INFO - TEST-INFO | 27814: exit 0 07:31:34 INFO - TEST-OK | dromaeo_css | took 1113005ms 07:31:34 INFO - TEST-START | kraken 07:31:34 INFO - operating with platform_type : linux_ 07:31:34 INFO - Initialising browser for kraken test... 07:31:34 INFO - TEST-INFO | started process 28013 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5B6pnS/profile http://localhost:35882/getInfo.html) 07:31:39 INFO - PROCESS | 28013 | __metrics Screen width/height:1600/1200 07:31:39 INFO - PROCESS | 28013 | colorDepth:24 07:31:39 INFO - PROCESS | 28013 | Browser inner width/height: 1024/697 07:31:39 INFO - PROCESS | 28013 | __metrics 07:31:39 INFO - PROCESS | 28013 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:31:39 INFO - PROCESS | 28013 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:31:40 INFO - PROCESS | 28013 | console.error: PushService: 07:31:40 INFO - PROCESS | 28013 | stateChangeProcessEnqueue: Error transitioning state 07:31:40 INFO - PROCESS | 28013 | UnknownError 07:31:40 INFO - TEST-INFO | 28013: exit 0 07:31:40 INFO - Browser initialized. 07:31:40 INFO - Running cycle 1/1 for kraken test... 07:31:40 INFO - TEST-INFO | started process 28096 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5B6pnS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:31:52 INFO - PROCESS | 28096 | RSS: Main: 157491200 07:31:52 INFO - PROCESS | 28096 | 07:31:55 INFO - PROCESS | 28096 | Cycle 1(1): loaded http://localhost:35882/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35882/tests/kraken/driver.html?testName=audio-beat-detection) 07:31:56 INFO - PROCESS | 28096 | RSS: Main: 217006080 07:31:56 INFO - PROCESS | 28096 | 07:31:58 INFO - PROCESS | 28096 | Cycle 1(1): loaded http://localhost:35882/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35882/tests/kraken/driver.html?testName=audio-dft) 07:31:59 INFO - PROCESS | 28096 | RSS: Main: 204566528 07:31:59 INFO - PROCESS | 28096 | 07:32:02 INFO - PROCESS | 28096 | Cycle 1(1): loaded http://localhost:35882/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35882/tests/kraken/driver.html?testName=audio-fft) 07:32:02 INFO - PROCESS | 28096 | RSS: Main: 268804096 07:32:02 INFO - PROCESS | 28096 | 07:32:04 INFO - PROCESS | 28096 | Cycle 1(1): loaded http://localhost:35882/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35882/tests/kraken/driver.html?testName=audio-oscillator) 07:32:05 INFO - PROCESS | 28096 | RSS: Main: 180514816 07:32:05 INFO - PROCESS | 28096 | 07:32:07 INFO - PROCESS | 28096 | Cycle 1(1): loaded http://localhost:35882/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35882/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:32:08 INFO - PROCESS | 28096 | RSS: Main: 184229888 07:32:08 INFO - PROCESS | 28096 | 07:32:11 INFO - PROCESS | 28096 | Cycle 1(1): loaded http://localhost:35882/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35882/tests/kraken/driver.html?testName=imaging-darkroom) 07:32:11 INFO - PROCESS | 28096 | RSS: Main: 221343744 07:32:11 INFO - PROCESS | 28096 | 07:32:15 INFO - PROCESS | 28096 | Cycle 1(1): loaded http://localhost:35882/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35882/tests/kraken/driver.html?testName=imaging-desaturate) 07:32:15 INFO - PROCESS | 28096 | RSS: Main: 221360128 07:32:15 INFO - PROCESS | 28096 | 07:32:18 INFO - PROCESS | 28096 | Cycle 1(1): loaded http://localhost:35882/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35882/tests/kraken/driver.html?testName=json-parse-financial) 07:32:19 INFO - PROCESS | 28096 | RSS: Main: 220762112 07:32:19 INFO - PROCESS | 28096 | 07:32:20 INFO - PROCESS | 28096 | Cycle 1(1): loaded http://localhost:35882/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35882/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:32:21 INFO - PROCESS | 28096 | RSS: Main: 208445440 07:32:21 INFO - PROCESS | 28096 | 07:32:22 INFO - PROCESS | 28096 | Cycle 1(1): loaded http://localhost:35882/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35882/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:32:23 INFO - PROCESS | 28096 | RSS: Main: 213798912 07:32:23 INFO - PROCESS | 28096 | 07:32:25 INFO - PROCESS | 28096 | Cycle 1(1): loaded http://localhost:35882/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35882/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:32:26 INFO - PROCESS | 28096 | RSS: Main: 212410368 07:32:26 INFO - PROCESS | 28096 | 07:32:28 INFO - PROCESS | 28096 | Cycle 1(1): loaded http://localhost:35882/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35882/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:32:29 INFO - PROCESS | 28096 | RSS: Main: 223936512 07:32:29 INFO - PROCESS | 28096 | 07:32:31 INFO - PROCESS | 28096 | Cycle 1(1): loaded http://localhost:35882/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35882/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:32:32 INFO - PROCESS | 28096 | RSS: Main: 225722368 07:32:32 INFO - PROCESS | 28096 | 07:32:34 INFO - PROCESS | 28096 | Cycle 1(1): loaded http://localhost:35882/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35882/tests/kraken/driver.html?testName=ai-astar) 07:32:34 INFO - PROCESS | 28096 | RSS: Main: 268349440 07:32:34 INFO - PROCESS | 28096 | 07:32:34 INFO - PROCESS | 28096 | __start_tp_report 07:32:34 INFO - PROCESS | 28096 | _x_x_mozilla_page_load 07:32:34 INFO - PROCESS | 28096 | _x_x_mozilla_page_load_details 07:32:34 INFO - PROCESS | 28096 | |i|pagename|runs| 07:32:34 INFO - PROCESS | 28096 | |0;ai-astar;103;113;112;112;112;111;111;110;111;110 07:32:34 INFO - PROCESS | 28096 | |1;audio-beat-detection;146;117;119;173;119;119;143;116;150;115 07:32:34 INFO - PROCESS | 28096 | |2;audio-dft;161;161;160;161;160;160;160;161;160;161 07:32:34 INFO - PROCESS | 28096 | |3;audio-fft;74;73;74;125;74;76;74;73;102;74 07:32:34 INFO - PROCESS | 28096 | |4;audio-oscillator;85;84;114;84;84;83;115;83;85;139 07:32:34 INFO - PROCESS | 28096 | |5;imaging-gaussian-blur;117;117;117;116;116;117;117;116;117;117 07:32:34 INFO - PROCESS | 28096 | |6;imaging-darkroom;145;146;145;146;145;145;146;145;145;146 07:32:34 INFO - PROCESS | 28096 | |7;imaging-desaturate;94;94;94;95;95;95;95;94;96;95 07:32:34 INFO - PROCESS | 28096 | |8;json-parse-financial;50;48;51;49;48;49;49;50;49;49 07:32:34 INFO - PROCESS | 28096 | |9;json-stringify-tinderbox;61;62;61;62;63;62;62;62;63;63 07:32:34 INFO - PROCESS | 28096 | |10;stanford-crypto-aes;75;75;75;75;82;74;83;78;74;75 07:32:34 INFO - PROCESS | 28096 | |11;stanford-crypto-ccm;118;122;117;121;119;127;117;117;163;122 07:32:34 INFO - PROCESS | 28096 | |12;stanford-crypto-pbkdf2;158;161;161;157;155;154;155;158;154;155 07:32:34 INFO - PROCESS | 28096 | |13;stanford-crypto-sha256-iterative;62;62;62;61;63;62;63;62;65;61 07:32:34 INFO - PROCESS | 28096 | __end_tp_report 07:32:34 INFO - PROCESS | 28096 | __start_cc_report 07:32:34 INFO - PROCESS | 28096 | _x_x_mozilla_cycle_collect,1630 07:32:34 INFO - PROCESS | 28096 | __end_cc_report 07:32:34 INFO - PROCESS | 28096 | __startTimestamp1468679554416__endTimestamp 07:32:34 INFO - PROCESS | 28096 | 07:32:34 INFO - PROCESS | 28096 | ------- Summary: start ------- 07:32:34 INFO - PROCESS | 28096 | Number of tests: 14 07:32:34 INFO - PROCESS | 28096 | 07:32:34 INFO - PROCESS | 28096 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.50 stddev:2.80 (2.5%) stddev-sans-first:1.00 07:32:34 INFO - PROCESS | 28096 | Values: 103.0 113.0 112.0 112.0 112.0 111.0 111.0 110.0 111.0 110.0 07:32:34 INFO - PROCESS | 28096 | 07:32:34 INFO - PROCESS | 28096 | [#1] audio-beat-detection Cycles:10 Average:131.70 Median:131.00 stddev:19.99 (15.3%) stddev-sans-first:20.53 07:32:34 INFO - PROCESS | 28096 | Values: 146.0 117.0 119.0 173.0 119.0 119.0 143.0 116.0 150.0 115.0 07:32:34 INFO - PROCESS | 28096 | 07:32:34 INFO - PROCESS | 28096 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.53 (0.3%) stddev-sans-first:0.53 07:32:34 INFO - PROCESS | 28096 | Values: 161.0 161.0 160.0 161.0 160.0 160.0 160.0 161.0 160.0 161.0 07:32:34 INFO - PROCESS | 28096 | 07:32:34 INFO - PROCESS | 28096 | [#3] audio-fft Cycles:10 Average:81.90 Median:74.00 stddev:17.53 (23.7%) stddev-sans-first:18.36 07:32:34 INFO - PROCESS | 28096 | Values: 74.0 73.0 74.0 125.0 74.0 76.0 74.0 73.0 102.0 74.0 07:32:34 INFO - PROCESS | 28096 | 07:32:34 INFO - PROCESS | 28096 | [#4] audio-oscillator Cycles:10 Average:95.60 Median:84.00 stddev:19.84 (23.6%) stddev-sans-first:20.67 07:32:34 INFO - PROCESS | 28096 | Values: 85.0 84.0 114.0 84.0 84.0 83.0 115.0 83.0 85.0 139.0 07:32:34 INFO - PROCESS | 28096 | 07:32:34 INFO - PROCESS | 28096 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 07:32:34 INFO - PROCESS | 28096 | Values: 117.0 117.0 117.0 116.0 116.0 117.0 117.0 116.0 117.0 117.0 07:32:34 INFO - PROCESS | 28096 | 07:32:34 INFO - PROCESS | 28096 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 07:32:34 INFO - PROCESS | 28096 | Values: 145.0 146.0 145.0 146.0 145.0 145.0 146.0 145.0 145.0 146.0 07:32:34 INFO - PROCESS | 28096 | 07:32:34 INFO - PROCESS | 28096 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 07:32:34 INFO - PROCESS | 28096 | Values: 94.0 94.0 94.0 95.0 95.0 95.0 95.0 94.0 96.0 95.0 07:32:34 INFO - PROCESS | 28096 | 07:32:34 INFO - PROCESS | 28096 | [#8] json-parse-financial Cycles:10 Average:49.20 Median:49.00 stddev:0.92 (1.9%) stddev-sans-first:0.93 07:32:34 INFO - PROCESS | 28096 | Values: 50.0 48.0 51.0 49.0 48.0 49.0 49.0 50.0 49.0 49.0 07:32:34 INFO - PROCESS | 28096 | 07:32:34 INFO - PROCESS | 28096 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.74 (1.2%) stddev-sans-first:0.67 07:32:34 INFO - PROCESS | 28096 | Values: 61.0 62.0 61.0 62.0 63.0 62.0 62.0 62.0 63.0 63.0 07:32:34 INFO - PROCESS | 28096 | 07:32:34 INFO - PROCESS | 28096 | [#10] stanford-crypto-aes Cycles:10 Average:76.60 Median:75.00 stddev:3.31 (4.4%) stddev-sans-first:3.46 07:32:34 INFO - PROCESS | 28096 | Values: 75.0 75.0 75.0 75.0 82.0 74.0 83.0 78.0 74.0 75.0 07:32:34 INFO - PROCESS | 28096 | 07:32:34 INFO - PROCESS | 28096 | [#11] stanford-crypto-ccm Cycles:10 Average:124.30 Median:121.50 stddev:13.96 (11.5%) stddev-sans-first:14.62 07:32:34 INFO - PROCESS | 28096 | Values: 118.0 122.0 117.0 121.0 119.0 127.0 117.0 117.0 163.0 122.0 07:32:34 INFO - PROCESS | 28096 | 07:32:34 INFO - PROCESS | 28096 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.80 Median:157.50 stddev:2.66 (1.7%) stddev-sans-first:2.78 07:32:34 INFO - PROCESS | 28096 | Values: 158.0 161.0 161.0 157.0 155.0 154.0 155.0 158.0 154.0 155.0 07:32:34 INFO - PROCESS | 28096 | 07:32:34 INFO - PROCESS | 28096 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:62.00 stddev:1.16 (1.9%) stddev-sans-first:1.22 07:32:34 INFO - PROCESS | 28096 | Values: 62.0 62.0 62.0 61.0 63.0 62.0 63.0 62.0 65.0 61.0 07:32:34 INFO - PROCESS | 28096 | -------- Summary: end -------- 07:32:34 INFO - PROCESS | 28096 | 07:32:35 INFO - TEST-INFO | 28096: exit 0 07:32:35 INFO - TEST-OK | kraken | took 60523ms 07:32:35 INFO - SUITE-END | took 1173s 07:32:35 INFO - Completed test suite (00:19:33) 07:32:35 INFO - javascript benchmark 07:32:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3007.067808979217, 3027.7123673251062, 3056.4040012197624, 3059.11285727139, 3076.3078307380842, 5159.22611608258, 5229.267902493649, 5326.920096198555, 5327.307450031495, 5330.200469929512, 5289.920651190235, 5291.841244762653, 5316.787328506855, 5324.148136298193, 5384.0847056000475, 4734.928976065362, 4793.352897358846, 4809.879753006167, 4812.23004319309, 5006.399232092136, 4909.7545122743895, 4922.852314430573, 4925.113479573693, 4977.925331120036, 4997.700137991714, 4641.303804429345, 4706.482286948433, 4749.572538471554, 4763.118823017736, 4773.76131193439, 4726.243800991825, 4748.264019077049, 4813.0, 4828.5654291113615, 4853.296272040534, 4674.789634466423, 4771.355866957951, 4793.712377257376, 4798.256270278112, 4838.419389673227, 5178.6116041297055, 5286.207068939651, 5299.788008479656, 5369.731513424314, 5382.219578161144, 5626.465485778845, 5638.182463542763, 5662.433756624346, 5681.346645135821, 5687.374388817227, 5494.203340515643, 5614.466625670555, 5666.376698563155, 5674.489295963342, 5674.773009079632, 5292.682439053669, 5368.973155134199, 5390.733177703237, 5417.485338892799, 5419.783208671688, 5945.940540594625, 5958.344582095966, 5959.165716799652, 5962.970185149134, 5963.4931030862, 5481.479259470424, 5481.616286859961, 5501.174823776386, 5717.399673034354, 5729.541636669056, 5655.349634792052, 5657.151427285858, 5664.461876121762, 5664.745086471119, 5666.886662266814, 5580.776768929279, 5584.357798853184, 5628.662280263197, 5634.7182640867795, 5639.379668236491, 5501.229827824108, 5602.159676048625, 5627.5779316551425, 5667.206591077253, 5676.744546495418, 4393.626541743987, 4395.230834603932, 4400.933985990213, 4401.18578063053, 4441.311596702516, 3905.8437662493184, 3919.980400097981, 3944.7633142011573, 3980.0049987503126, 3990.3016972029777, 5171.405288391883, 5178.844634660966, 5326.201069839555, 5338.97330513345, 5354.866128346823, 5734.16854556087, 5739.339975902824, 5747.224124743107, 5748.9425105748405, 5789.45000224978, 5340.813071542555, 5382.2464854920345, 5385.649932754359, 5389.245505629215, 5391.865203369947, 4781.258904869751, 4931.876703082452, 4972.0, 4972.825951091694, 4991.226359914219, 5973.372795856372, 5981.820545383645, 5984.371640977722, 5985.371535988746, 5996.190514280516, 5602.215689803512, 5765.365809761007, 5778.94221057784, 5783.248177736868, 5789.478946894799, 5808.738606762621, 5873.823785286449, 5878.853028674317, 5921.911171332347, 5923.555733320104, 5572.637778544382, 5613.214150018919, 5614.101743720985, 5614.88770224585, 5618.494335509824, 5616.85957851057, 5688.715564221689, 5699.658020518782, 5715.057015592547, 5716.885662286648, 5575.470330318613, 5636.239107720406, 5683.71581420919, 5686.232358631697, 5687.43125687428, 5587.525060369751, 5634.492895639412, 5640.54875609942, 5641.210230567642, 5643.604947653625, 5416.0, 5618.185363122243, 5635.605507614591, 5640.54875609942, 5641.971790141023, 5579.079451890555, 5598.748056337556, 5627.831165065055, 5645.463680950304, 5714.3999880012, 5477.233187353853, 5501.834944951658, 5520.0, 5530.7511161997, 5534.08687566547], "value": 5253.041586507917, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.1505008038827, 633.3033662970731, 644.6100109433793, 645.7417033186728, 662.4965026579804, 44193.55806441935, 44874.55125448749, 45279.32081018779, 48753.0, 48836.51163488364, 47416.525834741646, 48056.75971620137, 48063.51936480634, 48069.759651201784, 48075.759621201934, 9076.727698169048, 9195.21840643546, 9197.264218862509, 9201.033891441402, 9205.631774729036, 9038.909610903906, 9089.318301127409, 9109.134632209963, 9112.954435227815, 9117.863232051524, 9169.908300917006, 9172.31207659425, 9187.862182067274, 9196.908030919672, 9209.309301802392, 9128.40665356753, 9165.541722913827, 9168.816623667555, 9173.495457749821, 9175.908240917572, 9034.186923176945, 9103.135202155785, 9116.680916167968, 9118.58966346516, 9122.452652840851, 43650.0, 43940.340894886605, 43965.560344396465, 44012.3398149028, 44023.559764402264, 3532.205253817896, 3727.9440808387894, 4107.096438783463, 4265.509466411371, 4361.084172323815, 33825.83087084573, 33827.0, 34506.0, 35647.4652880207, 35772.0, 4392.89017774555, 4437.889052773707, 4527.0, 4549.704269222523, 4697.812087516495, 368123.0, 372690.0, 373971.0, 374602.126989366, 374929.0, 55349.169762453595, 62148.0, 62931.370686292554, 63995.6800215996, 64012.35987640157, 59369.70315148397, 62903.0, 63289.68355158287, 63403.0, 63556.68221658862, 15232.3907043717, 15271.083734975937, 15281.847181528265, 15288.847111528965, 15296.0, 10937.56249750001, 13300.73398532024, 13453.663658408617, 13558.45766169362, 13562.389692463863, 19703.802961970483, 19792.0, 20010.499737506678, 20072.397828065183, 20161.49596260076, 7126.893096603555, 7196.255639172469, 7297.227053719553, 7374.778756637309, 7644.770656880302, 1004.5680357446222, 1032.3083534032216, 1072.6084978982772, 1084.8481212630238, 1097.4183682648209, 32891.0, 33171.0, 33550.0, 33657.32685346279, 34067.0, 1073.3398959639765, 1083.3878858444953, 1086.6522712732008, 1125.9318357475813, 1178.4915308405255, 17219.65560688779, 17543.473695789147, 17552.38566650161, 17565.82434175642, 17576.824231757775, 625580.0, 627681.0, 631900.0, 632711.0, 632715.0, 63184.684076579324, 63919.36080639227, 64003.679981599795, 64071.359286407474, 64105.0, 1243.154654834721, 1344.9058565900293, 1379.7654398752036, 1394.7698629726185, 1400.796884451769, 32582.0, 33781.324373512885, 33898.49152262669, 34417.13957151091, 34432.82783586166, 52401.213981791065, 52486.47513524816, 53064.0, 53159.46840531545, 53385.19922201248, 410447.0, 412881.0, 413351.0, 413440.0, 414160.0, 25397.238082857544, 29266.122016339545, 30315.848420758637, 30372.24069398283, 30392.240193995327, 49499.50500494949, 50411.74794126006, 50916.490835092656, 51137.48862511327, 51446.0, 42349.0, 42450.0, 42818.0, 43073.13853722846, 44197.779011104736, 42238.366424503045, 42927.57072429236, 43029.18779827277, 43289.567104328555, 44478.0, 43068.0, 43085.13829723325, 43858.56141438545, 43946.78026609847, 44164.55835441605, 36613.63386366102, 38523.0, 39165.0, 39855.0, 39935.80032099821, 28422.22200180515, 29187.0, 29192.0, 29276.414471710872, 29367.265818354714], "value": 20989.293057611445, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.76590279929246, 388.79005337117957, 390.5021098099924, 397.76333081816347, 412.3258472397631, 18810.529736756587, 19628.9018554907, 20570.794292057075, 20579.073941672625, 20580.691289630668, 12185.756284874296, 12786.104972651918, 12824.935875320634, 13806.654833629163, 20354.287599934007, 5273.762680679369, 5432.103702889019, 5478.780848766045, 5493.890122197554, 5495.065838807413, 3962.7820469874146, 4205.5163656179475, 6427.646479443629, 6437.6781160942, 6553.705083271264, 5973.671448070354, 6472.64400457977, 6485.740570377179, 6512.511561632873, 6517.934820651804, 5874.089516125007, 5881.911771323434, 5898.262717160355, 5898.793542226044, 5901.911471327933, 3821.541415030214, 5474.370447398521, 5776.508996735282, 5805.477507024346, 5861.677607731573, 13636.522721704792, 13861.514846980308, 13866.168029918237, 13868.167909925436, 14007.229602371866, 2401.7838394544574, 2444.6577479152934, 2484.018812569025, 2844.48799216141, 2965.9851700741574, 10173.0, 10356.79286414275, 10415.114715249212, 10725.14198864089, 10750.247482676215, 1921.3659492367485, 1941.6505029094758, 1946.4744518979937, 1949.483386902472, 1965.066593368153, 64969.67515162394, 76377.0, 81103.59448202721, 85705.57147214287, 90458.0, 10676.51955661997, 10853.782924341469, 10930.56277748897, 10943.23397362193, 11044.502997365138, 14764.187969661773, 14775.630609234855, 15017.24913754308, 15044.62388440276, 15053.924730376279, 8056.0, 8199.303059240032, 8250.174982501701, 8331.166883311742, 8449.281811046007, 8172.42793004484, 8191.467554608931, 8202.671893124209, 8405.201505856934, 8408.621612027473, 4595.425571803525, 4600.35595016698, 4619.676622636383, 4676.251799712029, 4798.160321943646, 1729.2823478256635, 1764.5941433470373, 1802.7476153338544, 1806.9096545172688, 1835.164999925031, 915.6932427636816, 944.263474489899, 986.9569990120382, 1066.9253152279266, 1095.0856035210688, 19084.90457547731, 19248.422547323604, 20218.0, 20300.695489567668, 21411.78588214098, 979.7452662307851, 982.6020461713018, 998.6754304850807, 1033.6278939581744, 1046.706922061824, 9212.677556285498, 11005.17461190414, 11218.831717524243, 11295.209335346612, 11336.71658208535, 505885.0, 510564.0, 512105.0, 514094.0, 531994.0, 59116.704416478504, 59367.703161483914, 60192.09711854326, 93979.53010234905, 99455.50272248738, 990.3513198854762, 1027.3835698580792, 1036.7770929250248, 1041.6927006533092, 1044.6709286574858, 16516.339346426008, 17720.113994300493, 17811.55471113181, 18103.728444073087, 18805.717914231023, 41247.381289281286, 44305.778471107435, 44664.33003505015, 45003.0, 45392.0, 58887.0, 59717.701411492664, 60098.0, 60100.0, 61416.38583614286, 8430.283425908867, 8491.5329656867, 8641.697540586048, 8666.263367613572, 8710.21608055278, 12616.74766504683, 13528.458861645817, 13546.72906541844, 13861.79207311871, 14095.506657266946, 11685.649430517098, 11774.823377649513, 11976.682564918026, 12105.334206618369, 12262.20295680778, 11435.542578297107, 11615.0, 11712.648620541397, 11835.52657893709, 11879.940600296943, 11739.295642261492, 11844.644660660195, 11948.880511194777, 11953.342566158944, 12239.571614993432, 7316.085489313836, 7472.850542989001, 7548.8490230196185, 8420.410571260198, 8845.955770221366, 8361.581920904053, 10567.048965592827, 10627.787444250916, 10711.410872402093, 11010.284331518425], "value": 9018.62060035134, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1352.09409695504, 1453.2007395932237, 1502.068717395215, 1622.4078211452822, 1768.4871387297685, 8159.755207343782, 8460.788480287989, 8473.491590504565, 8734.694285700001, 8757.255633271163, 8536.487810731345, 8723.47659140452, 8724.38929274951, 8738.388312818106, 8759.737207883758, 2000.3598848368529, 2057.783932687069, 2063.9690404643943, 2269.704938358015, 2294.8967296471615, 2253.954920901581, 2334.486412989148, 2336.4976530046038, 2361.0437772702, 2366.881655917206, 2246.831487638434, 2275.12407723027, 2280.486890449652, 2297.1041293895396, 2298.54029194161, 1969.4977780665838, 2041.173324803457, 2234.1510226114137, 2237.2057919438607, 2240.5070884405404, 2045.9693104603443, 2186.8469207155504, 2256.627656436686, 2263.8981245843975, 2278.225403362848, 8662.783430414227, 8728.127187281285, 8732.51971141587, 8735.825283494294, 8744.387892847502, 4791.592714619262, 4895.265710143472, 4895.804167833282, 4900.289458028602, 4900.387451568554, 3277.213468767479, 3327.7670563060597, 3367.5958884933966, 3379.9662003380145, 3383.8646454141804, 1062.5696592879897, 1068.7061058208976, 1099.4228030284164, 1101.7355834599718, 1149.0692539043318, 11751.529938802523, 11761.235519691107, 11767.470463829148, 11783.116266280063, 11805.94097029518, 4243.087736136746, 4326.805293761789, 4436.689431739747, 4456.77716114193, 4469.145304698579, 9774.95112524447, 9829.066238707312, 9849.064338887794, 9924.751881202883, 9954.153896918699, 5072.746362681851, 5082.974585127051, 5089.338386009795, 5091.974540127276, 5092.770825312869, 4074.409210664437, 4480.260756975063, 4641.767911604406, 4686.671932964659, 4690.953090469052, 3705.110773414361, 3713.851445942132, 3780.8865734028022, 3805.60041195676, 3929.1159489115294, 1131.3664347965166, 1143.4054291768234, 1147.6442302886132, 1156.242661057009, 1158.223989926751, 771.4676872957754, 913.9680111196209, 956.3018996132723, 965.7493545858131, 1041.7916416716535, 6005.3694362091355, 6155.84610384735, 6218.5647004710145, 6397.040443933447, 6419.935800641933, 943.9622415103319, 964.3105179796479, 964.9276304277207, 983.439439519467, 993.4039576254335, 4125.64931980779, 4131.586841315844, 4168.18720349535, 4169.937450938239, 4209.957900421018, 10661.307015043998, 10831.24181307301, 10836.0, 10907.127429805756, 10912.127029837595, 10763.300385474919, 10787.83818242727, 10803.13574914005, 10810.621628242974, 10828.675139745821, 7416.666250018762, 7686.192949740197, 7700.345470634947, 7838.137804841463, 8153.959230203811, 6169.938300617116, 6321.083442900662, 6381.457576106083, 6383.147617110383, 6383.776567820104, 9902.603895844086, 10016.849747253651, 10194.133498652402, 10195.490225488844, 10243.334183278062, 10046.196304295785, 10346.844797328196, 10366.274360794672, 10409.1672666185, 10425.165986720893, 6599.208095028627, 7307.41540676734, 7519.360854327443, 7561.735339263099, 7701.037370328709, 8512.361572881935, 8539.530325832138, 8542.615582298688, 8544.718292256211, 8553.230209281195, 7429.0, 7642.694292228249, 7669.501482403626, 7693.461457698131, 7756.108047574601, 7323.12122545298, 7327.963360183165, 7406.518576292524, 7471.514351567131, 7544.622768861425, 6535.803925882231, 6536.117624120683, 6584.901226481511, 6586.176727909012, 6588.604683718992, 5252.684838909678, 5315.149576067965, 5375.381831089475, 5453.563714902878, 5469.781208751605, 5238.76425560843, 5240.606954478506, 5306.852353217373, 5462.399136095106, 5477.67133971963], "value": 4541.90535201623, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.9160418291244, 324.96912793284645, 330.93546758382115, 334.49310854600037, 334.52831507574325, 5248.553872920802, 5253.290805741224, 5333.573314134869, 5342.519173274404, 5373.220882971967, 5001.924971125436, 5107.974460127694, 5221.216817477381, 5225.190095535198, 5253.185756207784, 4080.1431699343025, 4095.344744840826, 4102.17956408718, 4113.074558224405, 4118.6499147572495, 4116.526599441073, 4145.585441455861, 4151.46031015969, 4165.062860856314, 4172.123853990665, 3774.074573158244, 3915.451836742858, 4034.4150098235737, 4081.571434999327, 4091.2022155679656, 4065.715399921977, 4099.323611604082, 4101.651359634435, 4106.691998100139, 4119.134981653826, 3644.908877278063, 3650.2881938022097, 3652.068722475778, 3653.7442379033478, 3660.963390366089, 4917.950820491785, 5128.640995130342, 5128.794848206105, 5143.768530416103, 5148.845534633967, 4666.766661666903, 4699.130660827758, 4717.646176536739, 4718.457377401608, 4727.5272472752795, 5449.264349312832, 5452.154915988028, 5475.479829416199, 5554.527865131468, 5562.582806289544, 3809.5618604325928, 3967.7619342839234, 3971.7687516869864, 3993.7004724645476, 4004.519457665099, 5718.542516598662, 5725.141228815669, 5755.302185855183, 5761.740721667535, 5773.105168698817, 3995.300822356076, 3998.7200895937585, 4010.8997275068355, 4015.5382131055303, 4019.4774679291504, 3889.5997440921246, 4054.1891621675195, 4057.2494088593703, 4058.8432296795863, 4063.927397027537, 4615.076984603093, 4624.491305956342, 4624.560666736655, 4632.467266264355, 4649.790759415834, 5424.810131645373, 5476.91784623231, 5519.530839878575, 5542.75057622408, 5557.305336832896, 1372.773492373767, 1412.1385954567706, 1415.2640626873967, 1426.322496814005, 1428.8785453236592, 900.3787386703154, 925.1349987761464, 930.9860352094724, 955.4171955107379, 959.3620242538773, 5270.710110943858, 5285.440794965494, 5297.940411917555, 5304.575633949275, 5310.433422140401, 5562.552476910228, 5575.888482230333, 5584.692841893735, 5613.298337707786, 5614.466625670637, 5114.386273647112, 5271.710055946883, 5382.730863456812, 5414.566834653218, 5415.160650099241, 3013.0960711786374, 3015.1858998070397, 3016.3062495626127, 3026.2585666511845, 3033.2416895776055, 5721.5136713379, 5902.2622172228475, 5913.9112913306335, 5921.615095018896, 5921.792737254175, 5741.62679425836, 5748.166515855178, 5759.337676167211, 5800.53595712342, 5803.100519419497, 5875.618084824473, 5881.3530511643685, 5882.205902203234, 5888.351261646746, 5892.734826932799, 5406.540444062299, 5584.720763961867, 5637.661740295595, 5661.66030038199, 5705.429457054262, 5522.581934452342, 5538.667679939216, 5568.610197286151, 5576.247206627054, 5578.470045345685, 5730.971345143247, 5826.796062137805, 5866.738651190015, 5879.5002424794375, 5882.852928676646, 4163.937540936828, 4163.937540936949, 4180.498340199196, 4188.015816283232, 4194.161167766398, 5601.60788744784, 5601.747921343468, 5612.747426365905, 5616.494515493625, 5632.49307562305, 5332.78668853257, 5395.838124856261, 5465.262189604353, 5520.806771763129, 5540.833774986757, 5426.693655196605, 5448.673079615236, 5449.264349312951, 5467.17992301158, 5488.451154884479, 5231.189165679326, 5321.521063104339, 5410.567154627699, 5470.781168753205, 5536.2249285099315, 5428.864278393072, 5546.833594992157, 5547.389787123494, 5553.861153471195, 5586.944130558642, 5394.973025134849, 5396.3524377075, 5398.9472052949295, 5410.648307859977, 5424.5660347172925], "value": 4206.359993728164, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [675.0549231076492, 727.2327694282529, 742.3133601418687, 773.2190487607515, 895.1227796759174, 15166.620834479143, 15896.602584935354, 16044.598885027866, 16065.839341606596, 16115.435959741411, 14450.427337678822, 14673.633159171026, 15132.848671513282, 15302.693946121071, 15414.922925385385, 674.8616533610598, 830.883676285322, 845.3997661660229, 845.9450135741188, 846.1073567386405, 789.6249281591256, 824.7814329202766, 825.3149885594971, 835.5947365527715, 841.5413599588209, 890.7416849113749, 893.066745251214, 893.1782759860911, 893.1827377949202, 893.3791015244408, 700.1353328639127, 835.7200337886816, 883.2668884825612, 883.6465413834453, 885.2210055151457, 634.1470721879065, 638.3903372279462, 640.0623087177261, 641.0128402260514, 641.9679016049179, 15743.717161011704, 15770.526884193378, 15824.841751582568, 15875.682486350324, 15883.126428046453, 14462.699161165456, 14558.199299038548, 14808.407663693439, 15011.099334039993, 15036.699266014619, 13828.792568111487, 13875.791863122062, 13933.372998215105, 13950.372233249529, 13956.72086558263, 4517.141743068806, 4521.954780452186, 4562.703424277412, 4571.794269257858, 4634.050019745944, 84131.15868841356, 87679.56160219222, 88929.0, 89132.55433722789, 89389.55305223432, 11391.544338226544, 11420.42897855104, 11566.30602163873, 11580.826287605692, 11591.188616796911, 20186.495337616383, 21633.242836500645, 21753.0, 21934.341969740934, 21948.0, 7661.731839385595, 7811.4922530035365, 7974.720884769005, 8042.517448953082, 8176.3867709922, 4988.426330971912, 5068.543831055223, 5097.46476619957, 5135.255387968724, 5162.1224391853475, 3430.5711786026745, 3655.817209139532, 3676.1361080146144, 3714.257148570297, 3724.7020238380865, 663.9302873198342, 672.700648211551, 675.7634827810227, 684.3430306905327, 695.523566357047, 609.8749756299948, 640.0591131037368, 650.067153634536, 779.766070178944, 795.3358945280639, 9978.850317245247, 9983.151432128205, 10007.949960250153, 10151.796964060677, 10191.133753631024, 717.2970488920782, 717.4224749077043, 761.5202422473806, 770.2720928722416, 776.3207193705508, 4899.681520701143, 5026.29631851541, 5134.743262836918, 5148.279240906276, 5149.2791009258735, 74722.62638686772, 100567.49716251518, 103557.0, 104573.0, 117625.0, 96525.20848749098, 97999.51000244953, 98023.62846415103, 98239.0, 99540.0, 67960.3203967964, 80067.59966200015, 83597.0, 87027.0, 87383.0, 9232.261419086322, 9583.904160958302, 9788.706338809847, 9795.951020244853, 9871.901280987098, 43225.35161972636, 51185.0, 51622.74188629033, 51676.66011494479, 53153.202701960276, 69091.65454172697, 71148.64425677838, 71283.28716712973, 71684.0, 71831.0, 12764.808527871903, 12808.615741527768, 12855.550055748005, 13008.47966081384, 13617.727645447234, 14815.777763333343, 14821.333040013009, 15430.30563624662, 15578.610534736723, 15809.446669366516, 12555.372231388577, 12848.935755321163, 12859.357032148167, 13359.0, 13409.396577153857, 13430.127041742255, 13638.93180534091, 13688.315584220949, 13709.108907920952, 13740.793888091886, 11066.502007409525, 11496.655100347003, 11511.42442877836, 11597.6520704379, 12003.339816310187, 11583.710407239887, 11945.581904633296, 12025.518979240733, 12338.13633045714, 12577.559785407468, 10736.30214036085, 10755.156701102684, 10811.837822432513, 10817.783644327226, 10972.177086718368], "value": 7674.360309564024, "unit": "score"}], "name": "dromaeo_css", "value": 7254.885184789171, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 112.0, 112.0, 112.0, 111.0, 111.0, 110.0, 111.0, 110.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 117.0, 119.0, 173.0, 119.0, 119.0, 143.0, 116.0, 150.0, 115.0], "value": 131.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 161.0, 160.0, 160.0, 160.0, 161.0, 160.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 74.0, 125.0, 74.0, 76.0, 74.0, 73.0, 102.0, 74.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 114.0, 84.0, 84.0, 83.0, 115.0, 83.0, 85.0, 139.0], "value": 95.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 96.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 48.0, 51.0, 49.0, 48.0, 49.0, 49.0, 50.0, 49.0, 49.0], "value": 49.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 62.0, 63.0, 62.0, 62.0, 62.0, 63.0, 63.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 75.0, 82.0, 74.0, 83.0, 78.0, 74.0, 75.0], "value": 76.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 122.0, 117.0, 121.0, 119.0, 127.0, 117.0, 117.0, 163.0, 122.0], "value": 124.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 161.0, 161.0, 157.0, 155.0, 154.0, 155.0, 158.0, 154.0, 155.0], "value": 156.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 61.0, 63.0, 62.0, 63.0, 62.0, 65.0, 61.0], "value": 62.3, "unit": "score"}], "name": "kraken", "value": 1468.3, "alertThreshold": 2.0}]} 07:32:35 INFO - Return code: 0 07:32:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:32:35 INFO - # TBPL SUCCESS # 07:32:35 INFO - Running post-action listener: _resource_record_post_action 07:32:35 INFO - ##### 07:32:35 INFO - ##### Finished run-tests step (success) 07:32:35 INFO - ##### 07:32:35 INFO - Running post-run listener: _resource_record_post_run 07:32:35 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 554692608; Read time: 12; Write time: 623316 07:32:35 INFO - TinderboxPrint: CPU usage
13.0% 07:32:35 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 07:32:35 INFO - TinderboxPrint: I/O write bytes / time
554,692,608 / 623,316 07:32:35 INFO - TinderboxPrint: CPU idle
8,273.3 (87.0%) 07:32:35 INFO - TinderboxPrint: CPU user
1,189.5 (12.5%) 07:32:35 INFO - TinderboxPrint: Swap in / out
0 / 0 07:32:35 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256770048; Read time: 0; Write time: 300616 07:32:35 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 297308160; Read time: 0; Write time: 322620 07:32:36 INFO - Running post-run listener: _upload_blobber_files 07:32:36 INFO - Blob upload gear active. 07:32:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:32:36 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 07:32:36 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'] 07:32:36 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 07:32:36 INFO - (blobuploader) - INFO - Open directory for files ... 07:32:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:32:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:32:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:32:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:32:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:32:41 INFO - (blobuploader) - INFO - Done attempting. 07:32:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:32:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:32:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:32:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:32:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:32:42 INFO - (blobuploader) - INFO - Done attempting. 07:32:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:32:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:32:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:32:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:32:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:32:43 INFO - (blobuploader) - INFO - Done attempting. 07:32:43 INFO - (blobuploader) - INFO - Iteration through files over. 07:32:43 INFO - Return code: 0 07:32:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:32:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:32:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d7f37d09f5436c26ed7dad605d77b1ac88ff82ed3b72d00e78e0b49feb5ce529cfe8fdded29501b760e0eae9e26bdb902f79069ce84ad8f91b478bd53bd867db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aefdf3cfc12a7dc43ca7676c44359335f414f99774f4205f478cb399258cff61173d2d97fa3731602ba96a91024252973d28eb74156e61e6c079f93f7847f70f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/12ff41eecd2c5459b4ebfa1b1a00a295bd3d75111b6ba347b578e3ab7d8d46acdfe21bf823ba464aad0b1fbba41eeeade121325ede0d7a5dbe4d637ee5573530"} 07:32:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:32:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:32:43 INFO - Contents: 07:32:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d7f37d09f5436c26ed7dad605d77b1ac88ff82ed3b72d00e78e0b49feb5ce529cfe8fdded29501b760e0eae9e26bdb902f79069ce84ad8f91b478bd53bd867db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aefdf3cfc12a7dc43ca7676c44359335f414f99774f4205f478cb399258cff61173d2d97fa3731602ba96a91024252973d28eb74156e61e6c079f93f7847f70f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/12ff41eecd2c5459b4ebfa1b1a00a295bd3d75111b6ba347b578e3ab7d8d46acdfe21bf823ba464aad0b1fbba41eeeade121325ede0d7a5dbe4d637ee5573530"} 07:32:43 INFO - Running post-run listener: copy_logs_to_upload_dir 07:32:43 INFO - Copying logs to upload dir... 07:32:43 INFO - mkdir: /builds/slave/test/build/upload/logs 07:32:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.066334 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-16 07:32:43.173253) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 07:32:43.176625) ========= 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=5bd038846534b2fdfa68eeae000001e2-1468670011.126945-326616824 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/d7f37d09f5436c26ed7dad605d77b1ac88ff82ed3b72d00e78e0b49feb5ce529cfe8fdded29501b760e0eae9e26bdb902f79069ce84ad8f91b478bd53bd867db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aefdf3cfc12a7dc43ca7676c44359335f414f99774f4205f478cb399258cff61173d2d97fa3731602ba96a91024252973d28eb74156e61e6c079f93f7847f70f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/12ff41eecd2c5459b4ebfa1b1a00a295bd3d75111b6ba347b578e3ab7d8d46acdfe21bf823ba464aad0b1fbba41eeeade121325ede0d7a5dbe4d637ee5573530"} build_url:https://queue.taskcluster.net/v1/task/M3_-nNhuRme4CoLfTj3kQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011387 build_url: 'https://queue.taskcluster.net/v1/task/M3_-nNhuRme4CoLfTj3kQg/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/d7f37d09f5436c26ed7dad605d77b1ac88ff82ed3b72d00e78e0b49feb5ce529cfe8fdded29501b760e0eae9e26bdb902f79069ce84ad8f91b478bd53bd867db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aefdf3cfc12a7dc43ca7676c44359335f414f99774f4205f478cb399258cff61173d2d97fa3731602ba96a91024252973d28eb74156e61e6c079f93f7847f70f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/12ff41eecd2c5459b4ebfa1b1a00a295bd3d75111b6ba347b578e3ab7d8d46acdfe21bf823ba464aad0b1fbba41eeeade121325ede0d7a5dbe4d637ee5573530"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 07:32:43.210096) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 07:32:43.210734) ========= 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=5bd038846534b2fdfa68eeae000001e2-1468670011.126945-326616824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004441 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 07:32:43.295394) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 07:32:43.295708) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 07:32:43.295997) ========= ========= Total master_lag: 0.17 =========