builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-047 starttime: 1468593364.59 results: success (0) buildid: 20160713163005 builduid: 4e27467b6b114389b436cd7afdc62c4a revision: 5fd14a66be3191e5628af3cfb0a456dd70f179b8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:04.594284) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:04.594756) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:04.595036) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:04.632688) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:04.632984) ========= 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=03627c79f6bb3d1578c4a402000001ba-1468592163.765302-177079187 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-15 07:36:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 112M=0s 2016-07-15 07:36:04 (112 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113852 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:04.761752) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:04.762059) ========= 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=03627c79f6bb3d1578c4a402000001ba-1468592163.765302-177079187 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019094 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:04.811817) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:04.812148) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5fd14a66be3191e5628af3cfb0a456dd70f179b8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 5fd14a66be3191e5628af3cfb0a456dd70f179b8 --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=03627c79f6bb3d1578c4a402000001ba-1468592163.765302-177079187 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-15 07:36:04,821 truncating revision to first 12 chars 2016-07-15 07:36:04,821 Setting DEBUG logging. 2016-07-15 07:36:04,821 attempt 1/10 2016-07-15 07:36:04,821 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5fd14a66be31?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-15 07:36:05,139 unpacking tar archive at: mozilla-central-5fd14a66be31/testing/mozharness/ program finished with exit code 0 elapsedTime=0.701690 ========= master_lag: 0.15 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:05.663930) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:05.664261) ========= script_repo_revision: 5fd14a66be3191e5628af3cfb0a456dd70f179b8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:05.664655) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:05.664907) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:06.023419) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-15 07:36:06.023716) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=03627c79f6bb3d1578c4a402000001ba-1468592163.765302-177079187 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:36:06 INFO - MultiFileLogger online at 20160715 07:36:06 in /builds/slave/test 07:36:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:36:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:36:06 INFO - {'append_to_log': False, 07:36:06 INFO - 'base_work_dir': '/builds/slave/test', 07:36:06 INFO - 'blob_upload_branch': 'Firefox', 07:36:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:36:06 INFO - 'branch': 'Firefox', 07:36:06 INFO - 'buildbot_json_path': 'buildprops.json', 07:36:06 INFO - 'config_files': ('talos/linux_config.py',), 07:36:06 INFO - 'default_actions': ('clobber', 07:36:06 INFO - 'read-buildbot-config', 07:36:06 INFO - 'download-and-extract', 07:36:06 INFO - 'populate-webroot', 07:36:06 INFO - 'create-virtualenv', 07:36:06 INFO - 'install', 07:36:06 INFO - 'run-tests'), 07:36:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:36:06 INFO - 'download_minidump_stackwalk': True, 07:36:06 INFO - 'download_symbols': 'ondemand', 07:36:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:36:06 INFO - 'tooltool.py': '/tools/tooltool.py', 07:36:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:36:06 INFO - '/tools/misc-python/virtualenv.py')}, 07:36:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:36:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:36:06 INFO - 'installer_path': 'installer.exe', 07:36:06 INFO - 'log_level': 'info', 07:36:06 INFO - 'log_name': 'talos', 07:36:06 INFO - 'log_to_console': True, 07:36:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:36:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:36:06 INFO - 'opt_config_files': (), 07:36:06 INFO - 'pip_index': False, 07:36:06 INFO - 'sps_profile': False, 07:36:06 INFO - 'sps_profile_interval': 0, 07:36:06 INFO - 'suite': 'dromaeojs', 07:36:06 INFO - 'system_bits': '32', 07:36:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:36:06 INFO - 'title': 'talos-linux64-ix-047', 07:36:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:36:06 INFO - 'use_talos_json': True, 07:36:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:36:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:36:06 INFO - 'work_dir': 'build'} 07:36:06 INFO - ##### 07:36:06 INFO - ##### Running clobber step. 07:36:06 INFO - ##### 07:36:06 INFO - Running pre-action listener: _resource_record_pre_action 07:36:06 INFO - Running main action method: clobber 07:36:06 INFO - rmtree: /builds/slave/test/build 07:36:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:36:07 INFO - Running post-action listener: _resource_record_post_action 07:36:07 INFO - ##### 07:36:07 INFO - ##### Finished clobber step (success) 07:36:07 INFO - ##### 07:36:07 INFO - ##### 07:36:07 INFO - ##### Running read-buildbot-config step. 07:36:07 INFO - ##### 07:36:07 INFO - Running pre-action listener: _resource_record_pre_action 07:36:07 INFO - Running main action method: read_buildbot_config 07:36:07 INFO - Using buildbot properties: 07:36:07 INFO - { 07:36:07 INFO - "project": "", 07:36:07 INFO - "product": "firefox", 07:36:07 INFO - "script_repo_revision": "production", 07:36:07 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:36:07 INFO - "repository": "", 07:36:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 07:36:07 INFO - "buildid": "20160713163005", 07:36:07 INFO - "pgo_build": "True", 07:36:07 INFO - "basedir": "/builds/slave/test", 07:36:07 INFO - "buildnumber": 393, 07:36:07 INFO - "slavename": "talos-linux64-ix-047", 07:36:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:36:07 INFO - "platform": "ubuntu64_hw", 07:36:07 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:36:07 INFO - "branch": "mozilla-central", 07:36:07 INFO - "repo_path": "mozilla-central", 07:36:07 INFO - "revision": "5fd14a66be3191e5628af3cfb0a456dd70f179b8", 07:36:07 INFO - "stage_platform": "linux64-pgo", 07:36:07 INFO - "builduid": "4e27467b6b114389b436cd7afdc62c4a", 07:36:07 INFO - "slavebuilddir": "test" 07:36:07 INFO - } 07:36:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:36:07 INFO - Running post-action listener: _resource_record_post_action 07:36:07 INFO - ##### 07:36:07 INFO - ##### Finished read-buildbot-config step (success) 07:36:07 INFO - ##### 07:36:07 INFO - ##### 07:36:07 INFO - ##### Running download-and-extract step. 07:36:07 INFO - ##### 07:36:07 INFO - Running pre-action listener: _resource_record_pre_action 07:36:07 INFO - Running main action method: download_and_extract 07:36:07 INFO - mkdir: /builds/slave/test/build/tests 07:36:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:07 INFO - https://queue.taskcluster.net/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:36:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:36:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:36:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/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:36:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/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:36:09 INFO - Downloaded 1361 bytes. 07:36:09 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:36:09 INFO - Using the following test package requirements: 07:36:09 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:36:09 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:36:09 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:36:09 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:09 INFO - u'jsshell-linux-x86_64.zip'], 07:36:09 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:36:09 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:36:09 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:36:09 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:36:09 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:36:09 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:36:09 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:36:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:09 INFO - https://queue.taskcluster.net/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:36:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:36:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:36:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/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:36:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/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:36:27 INFO - Downloaded 24326108 bytes. 07:36:27 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:36:27 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:36:29 INFO - Return code: 0 07:36:29 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:36:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:29 INFO - https://queue.taskcluster.net/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:36:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:36:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:36:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/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:36:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/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:36:31 INFO - Downloaded 24326108 bytes. 07:36:31 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:36:31 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:36:32 INFO - Return code: 0 07:36:32 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:36:32 INFO - https://queue.taskcluster.net/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:36:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:36:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:36:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/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:36:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/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:36:34 INFO - Downloaded 14403317 bytes. 07:36:34 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:36:34 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:36:34 INFO - Return code: 0 07:36:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:34 INFO - https://queue.taskcluster.net/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:36:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:36:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:36:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/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:36:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/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:36:35 INFO - Downloaded 60811395 bytes. 07:36:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:36:35 INFO - mkdir: /builds/slave/test/properties 07:36:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:36:35 INFO - Writing to file /builds/slave/test/properties/build_url 07:36:35 INFO - Contents: 07:36:35 INFO - build_url:https://queue.taskcluster.net/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:36:36 INFO - Running post-action listener: _resource_record_post_action 07:36:36 INFO - Running post-action listener: set_extra_try_arguments 07:36:36 INFO - ##### 07:36:36 INFO - ##### Finished download-and-extract step (success) 07:36:36 INFO - ##### 07:36:36 INFO - ##### 07:36:36 INFO - ##### Running populate-webroot step. 07:36:36 INFO - ##### 07:36:36 INFO - Running pre-action listener: _resource_record_pre_action 07:36:36 INFO - Running main action method: populate_webroot 07:36:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:36:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:36:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:36:36 INFO - '--tppagecycles', 07:36:36 INFO - '7'], 07:36:36 INFO - 'tests': ['tsvgm']}}, 07:36:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:36:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:36:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:36:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:36:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:36:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:36:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:36 INFO - 'talos_options': ['--disable-e10s'], 07:36:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:36:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:36:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:36 INFO - 'talos_options': ['--disable-e10s'], 07:36:36 INFO - 'tests': ['damp', 'tps']}, 07:36:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:36 INFO - 'tests': ['damp', 'tps']}, 07:36:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:36:36 INFO - 'tests': ['dromaeo_dom']}, 07:36:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:36:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:36:36 INFO - 'tests': ['basic_compositor_video']}, 07:36:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:36:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:36:36 INFO - 'tests': ['a11yr', 07:36:36 INFO - 'ts_paint', 07:36:36 INFO - 'tpaint', 07:36:36 INFO - 'sessionrestore', 07:36:36 INFO - 'sessionrestore_no_auto_restore', 07:36:36 INFO - 'tabpaint']}, 07:36:36 INFO - 'other-e10s': {'tests': ['a11yr', 07:36:36 INFO - 'ts_paint', 07:36:36 INFO - 'tpaint', 07:36:36 INFO - 'sessionrestore', 07:36:36 INFO - 'sessionrestore_no_auto_restore', 07:36:36 INFO - 'tabpaint']}, 07:36:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:36:36 INFO - 'ts_paint', 07:36:36 INFO - 'tpaint', 07:36:36 INFO - 'sessionrestore', 07:36:36 INFO - 'sessionrestore_no_auto_restore', 07:36:36 INFO - 'tabpaint']}, 07:36:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:36:36 INFO - 'ts_paint', 07:36:36 INFO - 'tpaint', 07:36:36 INFO - 'sessionrestore', 07:36:36 INFO - 'sessionrestore_no_auto_restore', 07:36:36 INFO - 'tabpaint']}, 07:36:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:36:36 INFO - 'tests': ['a11yr', 07:36:36 INFO - 'ts_paint', 07:36:36 INFO - 'tpaint', 07:36:36 INFO - 'sessionrestore', 07:36:36 INFO - 'sessionrestore_no_auto_restore', 07:36:36 INFO - 'tabpaint']}, 07:36:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:36:36 INFO - 'tests': ['a11yr', 07:36:36 INFO - 'ts_paint', 07:36:36 INFO - 'tpaint', 07:36:36 INFO - 'sessionrestore', 07:36:36 INFO - 'sessionrestore_no_auto_restore', 07:36:36 INFO - 'tabpaint']}, 07:36:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:36:36 INFO - 'tests': ['tsvgx', 07:36:36 INFO - 'tsvgr_opacity', 07:36:36 INFO - 'tart', 07:36:36 INFO - 'tscrollx', 07:36:36 INFO - 'cart']}, 07:36:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:36:36 INFO - 'tsvgr_opacity', 07:36:36 INFO - 'tart', 07:36:36 INFO - 'tscrollx', 07:36:36 INFO - 'cart']}, 07:36:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:36 INFO - 'talos_options': ['--disable-e10s'], 07:36:36 INFO - 'tests': ['tp5o']}, 07:36:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:36 INFO - 'tests': ['tp5o']}, 07:36:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:36 INFO - 'talos_options': ['--disable-e10s', 07:36:36 INFO - '--xperf_path', 07:36:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:36:36 INFO - 'tests': ['tp5n']}, 07:36:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:36 INFO - 'talos_options': ['--xperf_path', 07:36:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:36:36 INFO - 'tests': ['tp5n']}}, 07:36:36 INFO - 'talos.zip': {'path': '', 07:36:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:36:36 INFO - Running post-action listener: _resource_record_post_action 07:36:36 INFO - ##### 07:36:36 INFO - ##### Finished populate-webroot step (success) 07:36:36 INFO - ##### 07:36:36 INFO - ##### 07:36:36 INFO - ##### Running create-virtualenv step. 07:36:36 INFO - ##### 07:36:36 INFO - Running pre-action listener: _resource_record_pre_action 07:36:36 INFO - Running main action method: create_virtualenv 07:36:36 INFO - Creating virtualenv /builds/slave/test/build/venv 07:36:36 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:36:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:36:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:36:36 INFO - Using real prefix '/usr' 07:36:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:36:37 INFO - Installing distribute.............................................................................................................................................................................................done. 07:36:39 INFO - Installing pip.................done. 07:36:39 INFO - Return code: 0 07:36:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:36: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:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36: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:36:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:39 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 0x10f6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b53b0>, '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 0x13b62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b6740>, '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': '03627c79f6bb3d1578c4a402000001ba-1468592163.765302-177079187', '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:36:39 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:36:39 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:36:39 INFO - Using env: {'DISPLAY': ':0', 07:36:39 INFO - 'HOME': '/home/cltbld', 07:36:39 INFO - 'LANG': 'en_US.UTF-8', 07:36:39 INFO - 'LANGUAGE': 'en_US:en', 07:36:39 INFO - 'LOGNAME': 'cltbld', 07:36:39 INFO - 'MAIL': '/var/mail/cltbld', 07:36:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:39 INFO - 'MOZ_NO_REMOTE': '1', 07:36:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:39 INFO - 'NO_EM_RESTART': '1', 07:36:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:39 INFO - 'PWD': '/builds/slave/test', 07:36:39 INFO - 'SHELL': '/bin/bash', 07:36:39 INFO - 'SHLVL': '1', 07:36:39 INFO - 'TERM': 'linux', 07:36:39 INFO - 'TMOUT': '86400', 07:36:39 INFO - 'USER': 'cltbld', 07:36:39 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468592163.765302-177079187', 07:36:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:39 INFO - '_': '/tools/buildbot/bin/python'} 07:36:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:39 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:36:39 INFO - Cleaning up... 07:36:39 INFO - Return code: 0 07:36:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:36: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:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36: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:36:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:39 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 0x10f6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b53b0>, '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 0x13b62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b6740>, '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': '03627c79f6bb3d1578c4a402000001ba-1468592163.765302-177079187', '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:36:39 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:36:39 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:36:39 INFO - Using env: {'DISPLAY': ':0', 07:36:39 INFO - 'HOME': '/home/cltbld', 07:36:39 INFO - 'LANG': 'en_US.UTF-8', 07:36:39 INFO - 'LANGUAGE': 'en_US:en', 07:36:39 INFO - 'LOGNAME': 'cltbld', 07:36:39 INFO - 'MAIL': '/var/mail/cltbld', 07:36:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:39 INFO - 'MOZ_NO_REMOTE': '1', 07:36:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:39 INFO - 'NO_EM_RESTART': '1', 07:36:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:39 INFO - 'PWD': '/builds/slave/test', 07:36:39 INFO - 'SHELL': '/bin/bash', 07:36:39 INFO - 'SHLVL': '1', 07:36:39 INFO - 'TERM': 'linux', 07:36:39 INFO - 'TMOUT': '86400', 07:36:39 INFO - 'USER': 'cltbld', 07:36:39 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468592163.765302-177079187', 07:36:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:39 INFO - '_': '/tools/buildbot/bin/python'} 07:36:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:39 INFO - Downloading/unpacking psutil>=3.1.1 07:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:36:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:36:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:36:41 INFO - Installing collected packages: psutil 07:36:41 INFO - Running setup.py install for psutil 07:36:41 INFO - building 'psutil._psutil_linux' extension 07:36:41 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:36:41 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:36:41 INFO - building 'psutil._psutil_posix' extension 07:36:41 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:36:42 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:36:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:36:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:36:42 INFO - Successfully installed psutil 07:36:42 INFO - Cleaning up... 07:36:42 INFO - Return code: 0 07:36:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:36:42 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:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:42 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:36:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:42 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 0x10f6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b53b0>, '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 0x13b62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b6740>, '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': '03627c79f6bb3d1578c4a402000001ba-1468592163.765302-177079187', '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:36:42 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:36:42 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:36:42 INFO - Using env: {'DISPLAY': ':0', 07:36:42 INFO - 'HOME': '/home/cltbld', 07:36:42 INFO - 'LANG': 'en_US.UTF-8', 07:36:42 INFO - 'LANGUAGE': 'en_US:en', 07:36:42 INFO - 'LOGNAME': 'cltbld', 07:36:42 INFO - 'MAIL': '/var/mail/cltbld', 07:36:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:42 INFO - 'MOZ_NO_REMOTE': '1', 07:36:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:42 INFO - 'NO_EM_RESTART': '1', 07:36:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:42 INFO - 'PWD': '/builds/slave/test', 07:36:42 INFO - 'SHELL': '/bin/bash', 07:36:42 INFO - 'SHLVL': '1', 07:36:42 INFO - 'TERM': 'linux', 07:36:42 INFO - 'TMOUT': '86400', 07:36:42 INFO - 'USER': 'cltbld', 07:36:42 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468592163.765302-177079187', 07:36:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:42 INFO - '_': '/tools/buildbot/bin/python'} 07:36:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:36:42 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:36:42 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:36:42 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:36:42 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:36:42 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:36:42 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:36:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:36:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:36:44 INFO - Installing collected packages: mozsystemmonitor 07:36:44 INFO - Running setup.py install for mozsystemmonitor 07:36:44 INFO - Successfully installed mozsystemmonitor 07:36:44 INFO - Cleaning up... 07:36:44 INFO - Return code: 0 07:36:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:36:44 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:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:44 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:36:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:44 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 0x10f6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b53b0>, '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 0x13b62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b6740>, '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': '03627c79f6bb3d1578c4a402000001ba-1468592163.765302-177079187', '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:36:44 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:36:44 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:36:44 INFO - Using env: {'DISPLAY': ':0', 07:36:44 INFO - 'HOME': '/home/cltbld', 07:36:44 INFO - 'LANG': 'en_US.UTF-8', 07:36:44 INFO - 'LANGUAGE': 'en_US:en', 07:36:44 INFO - 'LOGNAME': 'cltbld', 07:36:44 INFO - 'MAIL': '/var/mail/cltbld', 07:36:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:44 INFO - 'MOZ_NO_REMOTE': '1', 07:36:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:44 INFO - 'NO_EM_RESTART': '1', 07:36:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:44 INFO - 'PWD': '/builds/slave/test', 07:36:44 INFO - 'SHELL': '/bin/bash', 07:36:44 INFO - 'SHLVL': '1', 07:36:44 INFO - 'TERM': 'linux', 07:36:44 INFO - 'TMOUT': '86400', 07:36:44 INFO - 'USER': 'cltbld', 07:36:44 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468592163.765302-177079187', 07:36:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:44 INFO - '_': '/tools/buildbot/bin/python'} 07:36:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:44 INFO - Downloading/unpacking jsonschema==2.5.1 07:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:36:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:36:46 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:36:46 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:36:46 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:36:46 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:36:46 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:36:46 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:36:46 INFO - Downloading functools32-3.2.3-2.tar.gz 07:36:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:36:46 INFO - warning: no files found matching '*.txt' 07:36:46 INFO - no previously-included directories found matching 'build' 07:36:46 INFO - no previously-included directories found matching 'dist' 07:36:46 INFO - no previously-included directories found matching '.git*' 07:36:46 INFO - Installing collected packages: jsonschema, functools32 07:36:47 INFO - Running setup.py install for functools32 07:36:47 INFO - warning: no files found matching '*.txt' 07:36:47 INFO - no previously-included directories found matching 'build' 07:36:47 INFO - no previously-included directories found matching 'dist' 07:36:47 INFO - no previously-included directories found matching '.git*' 07:36:47 INFO - Successfully installed jsonschema functools32 07:36:47 INFO - Cleaning up... 07:36:47 INFO - Return code: 0 07:36:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:36:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b53b0>, '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 0x13b62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b6740>, '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': '03627c79f6bb3d1578c4a402000001ba-1468592163.765302-177079187', '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:36:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:36:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:36:47 INFO - Using env: {'DISPLAY': ':0', 07:36:47 INFO - 'HOME': '/home/cltbld', 07:36:47 INFO - 'LANG': 'en_US.UTF-8', 07:36:47 INFO - 'LANGUAGE': 'en_US:en', 07:36:47 INFO - 'LOGNAME': 'cltbld', 07:36:47 INFO - 'MAIL': '/var/mail/cltbld', 07:36:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:47 INFO - 'MOZ_NO_REMOTE': '1', 07:36:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:47 INFO - 'NO_EM_RESTART': '1', 07:36:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:47 INFO - 'PWD': '/builds/slave/test', 07:36:47 INFO - 'SHELL': '/bin/bash', 07:36:47 INFO - 'SHLVL': '1', 07:36:47 INFO - 'TERM': 'linux', 07:36:47 INFO - 'TMOUT': '86400', 07:36:47 INFO - 'USER': 'cltbld', 07:36:47 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468592163.765302-177079187', 07:36:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:47 INFO - '_': '/tools/buildbot/bin/python'} 07:36:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:47 INFO - Downloading/unpacking blobuploader==1.2.4 07:36:47 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:36:47 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:36:47 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:36:47 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:36:47 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:36:47 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:36:49 INFO - Downloading blobuploader-1.2.4.tar.gz 07:36:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:36:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:36:49 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:36:49 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:36:49 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:36:49 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:36:49 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:36:49 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:36:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:36:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:36:50 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:36:50 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:36:50 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:36:50 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:36:50 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:36:50 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:36:50 INFO - Downloading docopt-0.6.1.tar.gz 07:36:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:36:50 INFO - Installing collected packages: blobuploader, requests, docopt 07:36:50 INFO - Running setup.py install for blobuploader 07:36:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:36:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:36:50 INFO - Running setup.py install for requests 07:36:51 INFO - Running setup.py install for docopt 07:36:51 INFO - Successfully installed blobuploader requests docopt 07:36:51 INFO - Cleaning up... 07:36:51 INFO - Return code: 0 07:36:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:51 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 0x10f6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b53b0>, '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 0x13b62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b6740>, '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': '03627c79f6bb3d1578c4a402000001ba-1468592163.765302-177079187', '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:36:51 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:36:51 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:36:51 INFO - Using env: {'DISPLAY': ':0', 07:36:51 INFO - 'HOME': '/home/cltbld', 07:36:51 INFO - 'LANG': 'en_US.UTF-8', 07:36:51 INFO - 'LANGUAGE': 'en_US:en', 07:36:51 INFO - 'LOGNAME': 'cltbld', 07:36:51 INFO - 'MAIL': '/var/mail/cltbld', 07:36:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:51 INFO - 'MOZ_NO_REMOTE': '1', 07:36:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:51 INFO - 'NO_EM_RESTART': '1', 07:36:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:51 INFO - 'PWD': '/builds/slave/test', 07:36:51 INFO - 'SHELL': '/bin/bash', 07:36:51 INFO - 'SHLVL': '1', 07:36:51 INFO - 'TERM': 'linux', 07:36:51 INFO - 'TMOUT': '86400', 07:36:51 INFO - 'USER': 'cltbld', 07:36:51 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468592163.765302-177079187', 07:36:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:51 INFO - '_': '/tools/buildbot/bin/python'} 07:36:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:36:51 INFO - Running setup.py (path:/tmp/pip-x_EWzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:36:51 INFO - Running setup.py (path:/tmp/pip-BI_73y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:36:51 INFO - Running setup.py (path:/tmp/pip-0GUXbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:36:51 INFO - Running setup.py (path:/tmp/pip-lQK3tI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:36:51 INFO - Running setup.py (path:/tmp/pip-xl4w1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:36:51 INFO - Running setup.py (path:/tmp/pip-avbXVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:36:51 INFO - Running setup.py (path:/tmp/pip-fGAwY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:36:51 INFO - Running setup.py (path:/tmp/pip-WkNpAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:36:51 INFO - Running setup.py (path:/tmp/pip-T47F5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:36:52 INFO - Running setup.py (path:/tmp/pip-mJdMfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:36:52 INFO - Running setup.py (path:/tmp/pip-VsbRet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:36:52 INFO - Running setup.py (path:/tmp/pip-aZ8guO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:36:52 INFO - Running setup.py (path:/tmp/pip-ZqhwUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:36:52 INFO - Running setup.py (path:/tmp/pip-xNndQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:52 INFO - Running setup.py (path:/tmp/pip-YAcLiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:36:52 INFO - Running setup.py (path:/tmp/pip-MLGls7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:36:52 INFO - Running setup.py (path:/tmp/pip-YUrZ1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:36:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:36:52 INFO - Running setup.py install for manifestparser 07:36:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:36:52 INFO - Running setup.py install for mozcrash 07:36:52 INFO - Running setup.py install for mozdebug 07:36:52 INFO - Running setup.py install for mozdevice 07:36:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:36:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:36:53 INFO - Running setup.py install for mozfile 07:36:53 INFO - Running setup.py install for mozhttpd 07:36:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:36:53 INFO - Running setup.py install for mozinfo 07:36:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:36:53 INFO - Running setup.py install for mozInstall 07:36:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:36:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:36:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:36:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:36:53 INFO - Running setup.py install for mozleak 07:36:53 INFO - Running setup.py install for mozlog 07:36:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:36:53 INFO - Running setup.py install for moznetwork 07:36:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:36:53 INFO - Running setup.py install for mozprocess 07:36:53 INFO - Running setup.py install for mozprofile 07:36:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:36:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:36:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:36:53 INFO - Running setup.py install for mozrunner 07:36:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:36:54 INFO - Running setup.py install for mozscreenshot 07:36:54 INFO - Running setup.py install for moztest 07:36:54 INFO - Running setup.py install for mozversion 07:36:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:36:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:36:54 INFO - Cleaning up... 07:36:54 INFO - Return code: 0 07:36:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36:54 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:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:54 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:36:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:54 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 0x10f6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b53b0>, '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 0x13b62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b6740>, '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': '03627c79f6bb3d1578c4a402000001ba-1468592163.765302-177079187', '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:36:54 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:36:54 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:36:54 INFO - Using env: {'DISPLAY': ':0', 07:36:54 INFO - 'HOME': '/home/cltbld', 07:36:54 INFO - 'LANG': 'en_US.UTF-8', 07:36:54 INFO - 'LANGUAGE': 'en_US:en', 07:36:54 INFO - 'LOGNAME': 'cltbld', 07:36:54 INFO - 'MAIL': '/var/mail/cltbld', 07:36:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:54 INFO - 'MOZ_NO_REMOTE': '1', 07:36:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:54 INFO - 'NO_EM_RESTART': '1', 07:36:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:54 INFO - 'PWD': '/builds/slave/test', 07:36:54 INFO - 'SHELL': '/bin/bash', 07:36:54 INFO - 'SHLVL': '1', 07:36:54 INFO - 'TERM': 'linux', 07:36:54 INFO - 'TMOUT': '86400', 07:36:54 INFO - 'USER': 'cltbld', 07:36:54 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468592163.765302-177079187', 07:36:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:54 INFO - '_': '/tools/buildbot/bin/python'} 07:36:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:36:54 INFO - Running setup.py (path:/tmp/pip-CN_LXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:36:54 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:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:36:54 INFO - Running setup.py (path:/tmp/pip-4Hggxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:36:54 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:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:36:54 INFO - Running setup.py (path:/tmp/pip-FkVdMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:36:54 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:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:36:54 INFO - Running setup.py (path:/tmp/pip-8oka66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:36:54 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:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:36:54 INFO - Running setup.py (path:/tmp/pip-scFlKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:36:54 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:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:36:54 INFO - Running setup.py (path:/tmp/pip-8D8fDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:36:55 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:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:36:55 INFO - Running setup.py (path:/tmp/pip-xY8byl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:36:55 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:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:36:55 INFO - Running setup.py (path:/tmp/pip-7gA0PF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:36:55 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:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:36:55 INFO - Running setup.py (path:/tmp/pip-2Zc2yZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:36:55 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:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:36:55 INFO - Running setup.py (path:/tmp/pip-WNyQw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:36:55 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:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:36:55 INFO - Running setup.py (path:/tmp/pip-HL_zYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:36:55 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:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:36:55 INFO - Running setup.py (path:/tmp/pip-2rtFrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:36:55 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:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:36:55 INFO - Running setup.py (path:/tmp/pip-DlzhMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:36:55 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:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:36:55 INFO - Running setup.py (path:/tmp/pip-9EkOiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:36:55 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:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:55 INFO - Running setup.py (path:/tmp/pip-5TK33Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:55 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:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:36:55 INFO - Running setup.py (path:/tmp/pip-KllPPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:36:55 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:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:36:55 INFO - Running setup.py (path:/tmp/pip-UZTdMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:36:55 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:36:55 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:36:55 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:36:55 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:36:55 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:36:55 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:36:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:36:55 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:36:55 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:36:55 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:36:55 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:36:55 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:36:55 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:36:57 INFO - Downloading blessings-1.6.tar.gz 07:36:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:36:57 INFO - Installing collected packages: blessings 07:36:57 INFO - Running setup.py install for blessings 07:36:57 INFO - Successfully installed blessings 07:36:57 INFO - Cleaning up... 07:36:57 INFO - Return code: 0 07:36:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:36:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:36:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:36:58 INFO - Reading from file tmpfile_stdout 07:36:58 INFO - Current package versions: 07:36:58 INFO - argparse == 1.2.1 07:36:58 INFO - blessings == 1.6 07:36:58 INFO - blobuploader == 1.2.4 07:36:58 INFO - docopt == 0.6.1 07:36:58 INFO - functools32 == 3.2.3-2 07:36:58 INFO - jsonschema == 2.5.1 07:36:58 INFO - manifestparser == 1.1 07:36:58 INFO - mozInstall == 1.12 07:36:58 INFO - mozcrash == 0.17 07:36:58 INFO - mozdebug == 0.1 07:36:58 INFO - mozdevice == 0.48 07:36:58 INFO - mozfile == 1.2 07:36:58 INFO - mozhttpd == 0.7 07:36:58 INFO - mozinfo == 0.9 07:36:58 INFO - mozleak == 0.1 07:36:58 INFO - mozlog == 3.2 07:36:58 INFO - moznetwork == 0.27 07:36:58 INFO - mozprocess == 0.23 07:36:58 INFO - mozprofile == 0.28 07:36:58 INFO - mozrunner == 6.12 07:36:58 INFO - mozscreenshot == 0.1 07:36:58 INFO - mozsystemmonitor == 0.3 07:36:58 INFO - moztest == 0.7 07:36:58 INFO - mozversion == 1.4 07:36:58 INFO - psutil == 3.1.1 07:36:58 INFO - requests == 1.2.3 07:36:58 INFO - wsgiref == 0.1.2 07:36:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:58 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 0x10f6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b53b0>, '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 0x13b62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b6740>, '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': '03627c79f6bb3d1578c4a402000001ba-1468592163.765302-177079187', '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:36:58 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:36:58 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:36:58 INFO - Using env: {'DISPLAY': ':0', 07:36:58 INFO - 'HOME': '/home/cltbld', 07:36:58 INFO - 'LANG': 'en_US.UTF-8', 07:36:58 INFO - 'LANGUAGE': 'en_US:en', 07:36:58 INFO - 'LOGNAME': 'cltbld', 07:36:58 INFO - 'MAIL': '/var/mail/cltbld', 07:36:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:58 INFO - 'MOZ_NO_REMOTE': '1', 07:36:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:58 INFO - 'NO_EM_RESTART': '1', 07:36:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:58 INFO - 'PWD': '/builds/slave/test', 07:36:58 INFO - 'SHELL': '/bin/bash', 07:36:58 INFO - 'SHLVL': '1', 07:36:58 INFO - 'TERM': 'linux', 07:36:58 INFO - 'TMOUT': '86400', 07:36:58 INFO - 'USER': 'cltbld', 07:36:58 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468592163.765302-177079187', 07:36:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:58 INFO - '_': '/tools/buildbot/bin/python'} 07:36:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:58 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:36:58 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:36:58 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:36:58 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:36:58 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:36:58 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:36:58 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:36:58 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:36:58 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:36:58 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:36:58 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:36:58 INFO - Cleaning up... 07:36:58 INFO - Return code: 0 07:36:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:36:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:58 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 0x10f6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b53b0>, '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 0x13b62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b6740>, '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': '03627c79f6bb3d1578c4a402000001ba-1468592163.765302-177079187', '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:36:58 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:36:58 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:36:58 INFO - Using env: {'DISPLAY': ':0', 07:36:58 INFO - 'HOME': '/home/cltbld', 07:36:58 INFO - 'LANG': 'en_US.UTF-8', 07:36:58 INFO - 'LANGUAGE': 'en_US:en', 07:36:58 INFO - 'LOGNAME': 'cltbld', 07:36:58 INFO - 'MAIL': '/var/mail/cltbld', 07:36:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:58 INFO - 'MOZ_NO_REMOTE': '1', 07:36:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:58 INFO - 'NO_EM_RESTART': '1', 07:36:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:58 INFO - 'PWD': '/builds/slave/test', 07:36:58 INFO - 'SHELL': '/bin/bash', 07:36:58 INFO - 'SHLVL': '1', 07:36:58 INFO - 'TERM': 'linux', 07:36:58 INFO - 'TMOUT': '86400', 07:36:58 INFO - 'USER': 'cltbld', 07:36:58 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468592163.765302-177079187', 07:36:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:58 INFO - '_': '/tools/buildbot/bin/python'} 07:36:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:36:58 INFO - Cleaning up... 07:36:58 INFO - Return code: 0 07:36:58 INFO - Running post-action listener: _resource_record_post_action 07:36:58 INFO - Running post-action listener: _start_resource_monitoring 07:36:58 INFO - Starting resource monitoring. 07:36:58 INFO - ##### 07:36:58 INFO - ##### Finished create-virtualenv step (success) 07:36:58 INFO - ##### 07:36:58 INFO - ##### 07:36:58 INFO - ##### Running install step. 07:36:58 INFO - ##### 07:36:58 INFO - Running pre-action listener: _resource_record_pre_action 07:36:58 INFO - Running main action method: install 07:36:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:36:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:36:58 INFO - Reading from file tmpfile_stdout 07:36:58 INFO - Detecting whether we're running mozinstall >=1.0... 07:36:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:36:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:36:58 INFO - Reading from file tmpfile_stdout 07:36:58 INFO - Output received: 07:36:58 INFO - Usage: mozinstall [options] installer 07:36:58 INFO - Options: 07:36:58 INFO - -h, --help show this help message and exit 07:36:58 INFO - -d DEST, --destination=DEST 07:36:58 INFO - Directory to install application into. [default: 07:36:58 INFO - "/builds/slave/test"] 07:36:58 INFO - --app=APP Application being installed. [default: firefox] 07:36:58 INFO - mkdir: /builds/slave/test/build/application 07:36:58 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:36:58 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:37:16 INFO - Reading from file tmpfile_stdout 07:37:16 INFO - Output received: 07:37:16 INFO - /builds/slave/test/build/application/firefox/firefox 07:37:16 INFO - Running post-action listener: _resource_record_post_action 07:37:16 INFO - ##### 07:37:16 INFO - ##### Finished install step (success) 07:37:16 INFO - ##### 07:37:16 INFO - ##### 07:37:16 INFO - ##### Running run-tests step. 07:37:16 INFO - ##### 07:37:16 INFO - Running pre-action listener: _resource_record_pre_action 07:37:16 INFO - Running main action method: run_tests 07:37:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:37:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:37:16 INFO - Python 2.7.3 07:37:16 INFO - Return code: 0 07:37:16 INFO - grabbing minidump binary from tooltool 07:37: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:37:16 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 0x13b53b0>, '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 0x13b62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b6740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:37:16 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:37:16 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:37:16 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:37:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:37:16 INFO - Return code: 0 07:37:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:37:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:37:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:37:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:37:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:37:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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:37:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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:37:16 INFO - Using env: {'DISPLAY': ':0', 07:37:16 INFO - 'HOME': '/home/cltbld', 07:37:16 INFO - 'LANG': 'en_US.UTF-8', 07:37:16 INFO - 'LANGUAGE': 'en_US:en', 07:37:16 INFO - 'LOGNAME': 'cltbld', 07:37:16 INFO - 'MAIL': '/var/mail/cltbld', 07:37:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:37:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:37:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:16 INFO - 'MOZ_NO_REMOTE': '1', 07:37:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:37:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:16 INFO - 'NO_EM_RESTART': '1', 07:37:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:16 INFO - 'PWD': '/builds/slave/test', 07:37:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:37:16 INFO - 'SHELL': '/bin/bash', 07:37:16 INFO - 'SHLVL': '1', 07:37:16 INFO - 'TERM': 'linux', 07:37:16 INFO - 'TMOUT': '86400', 07:37:16 INFO - 'USER': 'cltbld', 07:37:16 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468592163.765302-177079187', 07:37:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:16 INFO - '_': '/tools/buildbot/bin/python'} 07:37:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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:37:16 INFO - mozversion application_buildid: 20160713163005 07:37:16 INFO - mozversion application_changeset: 5fd14a66be3191e5628af3cfb0a456dd70f179b8 07:37:16 INFO - mozversion application_display_name: Nightly 07:37:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:37:16 INFO - mozversion application_name: Firefox 07:37:16 INFO - mozversion application_remotingname: firefox 07:37:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:37:16 INFO - mozversion application_vendor: Mozilla 07:37:16 INFO - mozversion application_version: 50.0a1 07:37:16 INFO - mozversion platform_buildid: 20160713163005 07:37:16 INFO - mozversion platform_changeset: 5fd14a66be3191e5628af3cfb0a456dd70f179b8 07:37:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:37:16 INFO - mozversion platform_version: 50.0a1 07:37:16 INFO - using testdate: 1468593436 07:37:16 INFO - actual date: 1468593436 07:37:16 INFO - starting webserver on 'localhost:54332' 07:37:16 INFO - SUITE-START | Running 2 tests 07:37:16 INFO - TEST-START | dromaeo_css 07:37:16 INFO - operating with platform_type : linux_ 07:37:16 INFO - Initialising browser for dromaeo_css test... 07:37:16 INFO - TEST-INFO | started process 12328 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkGxxON/profile http://localhost:54332/getInfo.html) 07:37:20 INFO - PROCESS | 12328 | __metrics Screen width/height:1600/1200 07:37:20 INFO - PROCESS | 12328 | colorDepth:24 07:37:20 INFO - PROCESS | 12328 | Browser inner width/height: 1024/697 07:37:20 INFO - PROCESS | 12328 | __metrics 07:37:21 INFO - PROCESS | 12328 | 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:37:21 INFO - PROCESS | 12328 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:37:21 INFO - PROCESS | 12328 | console.error: PushService: 07:37:21 INFO - PROCESS | 12328 | stateChangeProcessEnqueue: Error transitioning state 07:37:21 INFO - PROCESS | 12328 | UnknownError 07:37:22 INFO - TEST-INFO | 12328: exit 0 07:37:22 INFO - Browser initialized. 07:37:22 INFO - Running cycle 1/1 for dromaeo_css test... 07:37:22 INFO - TEST-INFO | started process 12411 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkGxxON/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:37:34 INFO - PROCESS | 12411 | RSS: Main: 158408704 07:37:34 INFO - PROCESS | 12411 | 07:38:25 INFO - PROCESS | 12411 | 1468593505474 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:40:33 INFO - PROCESS | 12411 | Cycle 1(1): loaded http://localhost:54332/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54332/tests/dromaeo/cssquery-ext.html) 07:40:34 INFO - PROCESS | 12411 | RSS: Main: 237113344 07:40:34 INFO - PROCESS | 12411 | 07:43:36 INFO - PROCESS | 12411 | Cycle 1(1): loaded http://localhost:54332/tests/dromaeo/cssquery-ext.html (next: http://localhost:54332/tests/dromaeo/cssquery-jquery.html) 07:43:37 INFO - PROCESS | 12411 | RSS: Main: 240517120 07:43:37 INFO - PROCESS | 12411 | 07:46:39 INFO - PROCESS | 12411 | Cycle 1(1): loaded http://localhost:54332/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54332/tests/dromaeo/cssquery-mootools.html) 07:46:39 INFO - PROCESS | 12411 | RSS: Main: 245354496 07:46:39 INFO - PROCESS | 12411 | 07:49:41 INFO - PROCESS | 12411 | Cycle 1(1): loaded http://localhost:54332/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54332/tests/dromaeo/cssquery-prototype.html) 07:49:42 INFO - PROCESS | 12411 | RSS: Main: 235515904 07:49:42 INFO - PROCESS | 12411 | 07:52:45 INFO - PROCESS | 12411 | Cycle 1(1): loaded http://localhost:54332/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54332/tests/dromaeo/cssquery-yui.html) 07:52:45 INFO - PROCESS | 12411 | RSS: Main: 228962304 07:52:45 INFO - PROCESS | 12411 | 07:55:48 INFO - PROCESS | 12411 | Cycle 1(1): loaded http://localhost:54332/tests/dromaeo/cssquery-yui.html (next: http://localhost:54332/tests/dromaeo/cssquery-dojo.html) 07:55:48 INFO - PROCESS | 12411 | RSS: Main: 303251456 07:55:48 INFO - PROCESS | 12411 | 07:55:48 INFO - PROCESS | 12411 | __start_tp_report 07:55:48 INFO - PROCESS | 12411 | _x_x_mozilla_page_load 07:55:48 INFO - PROCESS | 12411 | _x_x_mozilla_page_load_details 07:55:48 INFO - PROCESS | 12411 | |i|pagename|runs| 07:55:48 INFO - PROCESS | 12411 | |0;dojo.html;3024.7277745002943;3025.0924722583227;3063.6323641163062;3073.3392320651055;3079.476488996872;5217.608679349045;5259.8422047338545;5320.441353657869;5337.973310133449;5355.410904800474;5372.9462705373035;5385.030694474993;5405.945940540603;5409.161579955104;5477.589180811435;4800.399950006241;4853.126437241295;4853.223484242522;4886.78009489572;5070.163423035195;4967.875803104916;4980.402351717781;5010.150992901779;5032.194848824189;5038.319826823387;4817.51824817519;4818.614510839125;4832.130216561018;4884.120858245515;4932.062908047477;4829.420469543677;4847.491013443609;4896.2655601660035;4914.655974081816;4950.4307004694565;4761.880952976203;4863.78112984913;4886.438059623118;4893.339399181101;4916.975415122937;5343.946560534423;5402.37872644647;5434.83695489136;5484.698341591211;5486.231927530149;5768.077107662796;5819.185314056035;5827.155062515912;5841.85395365115;5841.970790146022;5618.943810561924;5638.492535671769;5710.2862142232225;5732.598718089694;5787.074068149076;5301.257823904656;5376.193570964387;5377.623566350357;5377.7580008899695;5383.676979381211;5875.265591801025;5880.176775251468;5883.382244864313;5886.529077673861;5890.1164825276555;5475.534579560703;5614.129809879475;5630.521405680481;5662.7734890603915;5664.6034777566;5797.072468405035;5799.2750906136735;5805.332386775491;5805.709714514257;5805.767769289181;5703.230063941398;5743.913841292384;5751.482366587027;5752.108423194411;5791.160281759121;5601.327840659147;5656.971715141398;5702.144678298288;5710.086386178192;5758.049921762862;4364.4980827204645;4366.8034938427845;4368.4102646143;4370.104128653618;4399.758013309235;3917.8236979335998;3921.156951255494;3937.6062393760394;3966.2265858157957;3985.720999530063;5188.688678679291;5189.974050129726;5203.557697595671;5321.521063104262;5372.973135134377;5734.913976290359;5761.48146666802;5767.106098554731;5785.0454674978155;5789.189513468118;5382.085045542189;5393.649412788156;5394.056040192951;5400.432954539795;5400.513953744182;4871.585915197177;4911.607071434277;4933.45731969483;4957.801687932514;4998.275250088789;5875.324337701134;5888.911666325009;5920.052791553331;5937.317208521075;5950.821475355746;5729.828105156852;5741.2536370273265;5746.827595172152;5750.252467179407;5753.971230143822;5641.8589535261945;5842.1820945068575;5857.5313974881055;5866.325372582208;5866.823995280149;5663.461971112738;5684.459976302244;5699.34457537372;5705.429457054262;5751.367349591458;5734.197212390352;5736.4550367715;5777.3356064051495;5784.392638772868;5790.247267855152;5431.701256430934;5581.525570326406;5626.5780066496;5667.093265077568;5676.489115979582;5620.915686264628;5629.634073785191;5635.380108188178;5640.492355688008;5675.886482270249;5511.4213007633625;5553.805616803393;5560.082586373365;5565.30433695788;5566.471185237396;5451.536619387396;5558.305211848519;5599.244102046335;5618.6628802272;5646;5482.506574408322;5500.4499550044675;5516.61383703153;5516.724163791714;5522.420145884625 07:55:48 INFO - PROCESS | 12411 | |1;ext.html;591.9378465261148;607.9057696146932;608.5831205624148;625.9561830671853;642.6818724731258;31130.53304200436;31647.367052658963;44346;45252.54747452524;45296.77351613237;43621;46376;46378.30432543514;46401;46413;8929.955350223256;9071.183593476586;9073.54632268384;9075.546222688872;9075.682351117712;8870.37907346486;8938.240249578794;8959.820803583925;8961.05908879568;8965.686200982967;8994.190522852941;9027.187553120219;9033.864492032624;9039.774005649846;9044.140806623393;8957.462552246887;8998.100189981014;9012.819743605156;9026.45841249527;9033.412828166181;8941.6870409536;9003.954980225122;9016.504092274923;9018.233450156744;9019.503927283997;43685.34471982923;43981;44103.117937641066;44125.117497650186;44139.337909931375;3491.4762785582366;3546.113471632092;3572.5534308211472;3588.3899737044503;3618.7105031597407;32996.67003329984;33645.08381310953;34132.31735365304;34226.82886585576;34305;4202.844217840088;4228.365745138223;4304.139172165579;4308.956910430887;4379.715318504319;376071.11964440276;377890;379054;380996;381039;64105.35894640994;64645;64665.35334646687;64735.35264647293;64741;58837.70581147067;67008.66495667491;67125.32874671288;68255.3174468259;68712.6564367175;15553.611159721098;15553.844461555465;15644.530664080095;15650.060996340257;15653.060816351055;12205.694857628452;12290.508379664714;12296.077794165474;12301.815472767916;12313.199642023239;17607;17955.371561995267;17958.19188136537;19545.511362216057;19929.302474413325;7079.539829911039;7104.3961263293195;7368.447366447538;7455.837807035899;7549.773506794805;1006.2654262388497;1007.6120693533043;1029.156092004564;1083.3987137138806;1115.676453828397;33004.66995330064;33243.33513329768;33313.833430833176;33383;34010.82994585011;1096.17786660005;1102.1513434655271;1133.1274918312854;1152.6484422251294;1154.2612727854012;17477.213525391388;17879.195436205402;17889.28442862271;17973.281068757366;17973.820261797475;585986;590343;590859;592613;594047;60235;60860.39139608636;60882.39117608856;60896;60919.390806092255;1307.2809954524973;1347.42734337906;1350.966225844342;1363.8295213098363;1367.5213675213795;32118.83940580282;32722.83638581792;32744.672553275115;32966.83516582402;33525.329493410485;55326.72336638291;55404.44595553993;55509;55903.52771778329;55962.440375595725;459196;459592;460542;461837;462023;28848.567271491363;29122.854385727936;29638;29926.401471970876;29931.251718707208;41064.384034238916;45858;49805.252921206935;50218.49781502138;53625.731871340395;41735.165296694504;42372.52058035859;43273.13453730845;45376.77311613421;46234;38839.6116038836;39226.6077339223;39239.41140882946;39467.605323946394;39875.40186897257;42933.57066429421;43470;43626.56373436225;44050.779746102344;44066.779666101465;37225;38336.42495362516;38440.80779596084;39207;39298.6070139295;28809.42381152407;29099;29132.27169320784;29347.559786603644;29506.852465738393 07:55:48 INFO - PROCESS | 12411 | |2;jquery.html;384.450236162288;390.4982098004065;393.8680542018422;400.61340806122087;401.8171731862002;13838.616329376264;18959.52601184969;20360.389188324374;20456.69314960275;21699.132034718594;15619.609509762262;20117.195312187494;20120;20142.395728128144;20944;5885.970570147154;6021.187139736124;6027.156198132265;6027.789027384042;6051.27384713835;5965.791197308095;5990.041593345066;5990.430909063632;6000.249968753906;6009.5192384609345;4263.637590804786;4904.36243288372;6599.109120268774;6601.7359305627715;6727.024581435689;6552.213734351908;6676.532642714988;6718.6304753238555;6720.462363010947;6727.293634168415;5907.852303692399;5911.793087241926;5923.437273459014;5951.613145145551;5954.791582294599;23764;24526.386840328956;25464.49071018569;25675.614865777028;25692.100776472922;2396.085101303973;2429.6477010833332;2456.5332586808627;2583.457473930458;2690.811643184978;14899.255037248202;15017.699646007128;15332.923335383362;15348.155851428168;15453.227338633136;1905.3902751119647;2014.3956812956055;2050.9692354614695;2054.6404379233572;2091.383042002613;79371.6031419845;80612.59693701494;82196.17803822005;83710;88927;10926.508307126198;11211.775764484664;11311.547538098384;11334.886651133547;11603.477843497063;15678.76481852773;15831.683366332609;15934.442294519637;15936;15956.76064859028;7903.525788452711;8288.254057134765;8301.29438997692;8334.249917507454;8351.3736469765;7904.407169462198;8004.919950800418;8044;8120.309773669186;8189.1401402853035;4470.240059189946;4669.276262179367;4874.36633237684;4877.829275975324;4971.577415919615;1964.4106767969838;2005.227987224929;2013.1242909334487;2043.5708501214615;2045.9795402046086;936.8735220745249;991.8859331177007;994.2592768387598;1020.6172685243034;1042.9426381549088;20568.794312056987;20776.792232077787;20858.37424877256;21078.252889157084;21220.469488262916;974.0989584634185;1002.7242508310127;1019.2864994503728;1020.2959957629361;1048.8059708953867;11008.174386921013;11605.477753501113;11619.593314233962;11622.128340374506;11622.88377116235;479846;497496;502151;504374;518510;92559.53720231491;92654.53672731594;94187;94215;96833;1022.7085280694967;1034.591336422094;1044.9634262800766;1048.8531605575226;1053.3258714422775;17616.207270672596;17916.104194789947;18276.81723182751;18381.81618183801;18612.720809188144;36710.63289367072;42230;42253;43032.78483607562;43353.13293734171;60002.39997599968;62549.37450625435;63980.36019639744;63986;68507;12555.43500542496;13017.934910325388;13359.732805343645;13378.665533361744;13395.598132056053;10515;14772.33524491422;15096.698066038838;15183.240837957837;15462.226888655747;12179.573714919936;12800.6799830005;13014.349282536024;13045.217286962812;13106.73786524245;12784.296863672587;13084.214947102824;13104.410301536644;13136.343182840628;13337.399817008063;13131.409086590935;13195.60413187606;13241;13316.733665326832;13558.593242202749;13383.39774710121;13414.32928353559;13430.328483575588;13442.663933401353;13448.663783405493;12711.55509557161;12799.29603871796;12907.677308067374;12944;12993.870061299265 07:55:48 INFO - PROCESS | 12411 | |3;mootools.html;1305.9804102938451;1444.2201211345873;1482.3477669825277;1596.2338077722693;1745.716898079911;8182.877256841145;8526.44578102423;8573.271271941892;8716.477011379306;8746.344024198179;8460.36547258955;8669.869951950726;8689.391742578022;8708.12918708129;8712.869306960401;2018.5458271888854;2268.6029944759684;2337.1586228957603;2354.6232602783557;2373.4659701567184;2354.8822558872075;2393.234165067179;2399;2399.1243196233336;2400.7359190489033;2311.410590299471;2332.078828862598;2337.55586438577;2337.5792357375667;2339.0526836631193;1964.8231659150674;2227.1091563374616;2301.551197516485;2305.296884450242;2305.9308220753405;2362.1968530699473;2380.6905102336586;2381.1903952656007;2384.952300953971;2387.188355958965;8477.321814254845;8536.44513106646;8542.18849209324;8547.273481754059;8552.957235213784;5061.063703214917;5169.586433085344;5181.663191892515;5181.663191892552;5183.403908550527;3368.882089126869;3424.9315013699834;3521.2605352875926;3524.594671612772;3529.717622590212;1210.8002179640437;1234.0682784497646;1247;1252.7682378759866;1259.1563652352854;11692.590759323382;11910.761784764343;11950.581729639422;11951.701207469796;11964.70088247792;4345.283028300359;4427.313766366218;4555.2483840166005;4575.405197324327;4623.815047398134;10175.236857235737;10175.964807038474;10195.28632995698;10216.489175541194;10234.33476824004;5208.374995000624;5210;5210.452902445264;5211.42674305826;5211.530962213343;4202.852900148541;4679.649026322972;4810.254410566367;4827.541383568555;4864.173090574611;3943.0930885896405;3994.960050399517;4014.979925100356;4093.2222877653153;4103.753774773523;1108.152263518409;1214.678110300771;1242.6334231401759;1257.0697683714168;1275.6428200103985;999.5002498750624;1012.3217444312328;1012.7215015870547;1021.581151727788;1031.6234574380446;6117.082437634391;6275.152854364694;6339.334369891095;6383.808485745435;6489.740410383626;985.5170966226498;1030.2221822523945;1032.83990981398;1036.6371769880632;1046.795874804406;4173.7078404512;4206.516250631155;4224.640905523003;4284.400183974246;4441.888952776207;10414.114800241912;10783.352998819939;10809.67570972872;10848.62029828968;10877.564897404174;10611.469426528643;10621.203409744145;10662.253642244968;10711;10713;7512.549247045085;8134.471259368122;8247.95876020616;8265.090840007595;8278.254957053894;6097.847553811191;6183.659898705434;6242.563020588696;6261.123442717932;6268.780592679417;9969.152622027208;10174.898251017396;10182;10184.217761891492;10188;9836.114749672277;10149.543270552991;10448.843267350843;10459.320144190604;10476.214283928888;7516.699332026657;7563.168051514439;7604.619769011417;7609;7616.314531692175;8012.639431225492;8094.15011423792;8110.716124935599;8113.59432028408;8162.5510596915365;6088.5737998341465;7498.100227972678;7514.248575142661;7699.34555562761;7752.14726380109;7292.96353518229;7592.050993625797;7608.277213664693;7654.387648988179;7767.184445633127;6862.318731910714;7021.789346319619;7049.612271325126;7049.859002820018;7061.82345441368;5315.441878602691;5412.134058550613;5512;5529.391766905556;5600.327960644749;5425.077736784835;5437.619366644297;5467;5513.062779327443;5606.85982850432 07:55:48 INFO - PROCESS | 12411 | |4;prototype.html;330.5042436345482;336.1428357687896;338.97796643218174;339.29765385651694;345.7182396346978;5259.605529585282;5296.828300396838;5303.734813259341;5313.335833020872;5327.813526526573;5218.530332270095;5238.973805130979;5285.524302812746;5289.920651190235;5294.1529355303155;3884.8251828667635;4000.039990402297;4114.6091121343425;4116.682661548306;4157.896052598679;4106.7125301228925;4113.827559145644;4121.752694838305;4150.83396664133;4162.875113746592;3856.267309211241;4071.1043570414463;4086.754794712312;4105.50733911931;4114.094899122203;4026.2752704513177;4092.754434733896;4106.486689163855;4134.689898257612;4143.585641435848;3636.818159092035;3658.323210206094;3664.871729489482;3676.246369494247;3678.521792167001;5094.79620815167;5101.668391554537;5105.438401775802;5106.897862042739;5109.9744501277255;4567.223571992769;4704.741239231841;4714.952850471485;4770.809167633291;4774.832880849153;5373.489518495737;5376.892462150774;5395.838124856261;5431.6740995540395;5466.480684334982;4069.8982525436804;4071.816768245436;4074.2666320062376;4087.2438598859308;4090.7750073745933;5601.215829783793;5606.729274643817;5642.633228840154;5715.742791574389;5734.627249228787;4014.157027024299;4032.8790136295956;4037.37420699792;4042.91914161721;4053.398907431548;4088.468499095158;4114.629683328455;4126.566710495415;4133.9793301033305;4138.503379594407;4597.073867723729;4598.149342371672;4673.859784206411;4677.503198976363;4685;5417.458254174551;5425.945740542544;5460.754266058037;5462.5083742462575;5467.863303417367;1411.9269355289848;1431.8639729225706;1439.7336492748666;1464.8281374900037;1465.7068586282787;912.4935660708238;923.8013827027221;954.9331546791658;970.5729479029346;996.7458298133929;5122.92315615266;5123.231515272664;5154.9484505155215;5158.45836187195;5172.818951336685;5482.259894914216;5490.423505531941;5497;5506.504414602705;5534.667919924817;5036.697798132051;5123.436421993578;5158;5178.689278643218;5315.415304316522;2962.155785601093;2970.5395663672166;2970.628671416073;2987.14866263114;2991.8952836651047;5735.827925162252;5772.5670574707065;5823.970880145572;5831.854203644858;5848.093545500455;5662.5753068520025;5701.942980570141;5719.971400142973;5723.456271654186;5748.770049197985;5721.256236689203;5735.11105778605;5744.047024011856;5748.367679555246;5819.352194751463;5417.566594672496;5576.776928922797;5607.383187849415;5652.85867853307;5653.830385088454;5512.779488820403;5554.250176226158;5559.444055594408;5572.972135139298;5579.716665166953;5704.914426283692;5753.539716822561;5783.681897495678;5784.595078344475;5786.392428794916;3918.8040597969416;4031.9596804031585;4033.4353190553934;4038.2327357803097;4065.9390109147794;5340.706261155674;5421.3765416975975;5560.471755183251;5561.610687251854;5568.303962004749;5511.366192887869;5514.641548299348;5517.668939863621;5524.640898341595;5526.972365138148;5439;5460.798624302647;5465.754041068241;5472.699001554953;5485.6434331768305;5150.536451719363;5393.379761327497;5397.271368365377;5409.29679141709;5418.701971391612;5481.232627432083;5486.710623003671;5528.682790325773;5529.198266251291;5534.501894829485;5305.549028332635;5413.485718856702;5418.214358918013;5448.536874365724;5450.364890532904 07:55:48 INFO - PROCESS | 12411 | |5;yui.html;766.2911806578915;784.4469648897527;787.8503084413961;810.7891948093496;827.6565225431442;13255.33723313834;14018.859811401882;14044.438222471115;14084.859151408496;14090.718185636293;10968;13180.20918744876;13325.333733313344;13353.53262635808;13384.59846204613;796.9481983671043;813.6419975210918;823.5429336718119;825.2778818533783;826.5495305058728;825.8513467575834;827.9751607451786;831.0442990560842;833.9041010283804;834.566025666653;710.6553321639001;865.7229686500323;872.084311472954;872.2978002707817;873.8995015573227;839.2404873589381;863.0765081362944;866.1079088538816;866.8786369908217;867.4144952157332;633.2053273142177;633.3286716080969;633.4457349818908;633.708494092718;634.4638780230698;13513.797293040612;13527.729445411036;13551.932240338834;13553.39009744564;13581.864181358158;13792.724145517033;13932.37304321308;13947.454746071062;14065.226412547307;14274.429022839075;13059.425533190726;13109.737805243936;13269.137506062172;13560;13637.454501820015;4322.373255877911;4342.761148136851;4384.649228061748;4430.623397011258;4453.755043472608;74960.62519687366;75914.24085759127;76097.99999999945;76870;77413;10991.505382257817;10995.835062474069;11118.888811111785;11126.944365278283;11323.773524529463;19696.70454943177;19845.702314465296;19867.105980230925;19897.403077907686;21018.369448916557;8736.388452808242;9341.252699784001;9365.953170234105;9366.2038726709;9485.952570237105;4764.642651801059;4812.614990800727;4832.178529649968;4876.926846097312;4927.630427717935;3706.4255040468233;3811.504504414464;3826.598207188261;3828.674562662205;3832.080300727805;648.251269783401;659.4032400677298;659.4691273524859;659.7624855052273;663.9070530125787;739.548875186136;790.814158672723;798.5767543202112;803.1727320859524;815.9061707903667;9571.28215383849;9642.084002019797;9782.315237933277;9824.459654718916;9905.950470247602;606.7724603273772;621.9751209951552;637.7480895046524;717.6949796336536;743.5907659184204;4662.557057079572;4684.695494792896;4737.526247375304;4757.381540399795;4835.395575553056;68432;109475;109995.45002275097;111550;112143.4392828047;98216;98945.50527247318;99907;100138;100447.49776251071;72614.63692681503;84692;85137;88581;89270.55364723265;9302.534873256445;9353.20497757671;9368.531573421438;9411.928887205313;9526.666566670134;46511;47670;52863.73568132135;54003.72998134984;54846;59112.11331830112;59964.301606428686;76346.23653763391;77281;77457;12808.551700690432;12881.291528965998;13325.267110308638;13466;13620.591382258548;15012.849871501581;15024.549263522113;15740.68518629644;15753.606159845636;15972.041677499386;14645.414183432544;14818.62953426173;14984.700305994038;15252.847471525143;15747.370105195663;13985.720285594027;14018.299085045503;14309.35607897668;14429.711405772036;15152.621184470476;14617.853821462075;14652.12087274767;14722.263886805831;15566.766498502759;15584.298706558458;12076.637700868989;12245.427940750478;12592.181508201938;12641.431135599105;12764.68088297763;12064.396780160781;12393.938030309791;12455;12683.302418367079;12803.487860485477 07:55:48 INFO - PROCESS | 12411 | __end_tp_report 07:55:48 INFO - PROCESS | 12411 | __start_cc_report 07:55:48 INFO - PROCESS | 12411 | _x_x_mozilla_cycle_collect,981 07:55:48 INFO - PROCESS | 12411 | __end_cc_report 07:55:48 INFO - PROCESS | 12411 | __startTimestamp1468594548502__endTimestamp 07:55:48 INFO - PROCESS | 12411 | 07:55:48 INFO - PROCESS | 12411 | ------- Summary: start ------- 07:55:48 INFO - PROCESS | 12411 | Number of tests: 6 07:55:48 INFO - PROCESS | 12411 | 07:55:48 INFO - PROCESS | 12411 | [#0] dojo.html Cycles:165 Average:5326.99 Median:5516.72 stddev:606.35 (11.0%) stddev-sans-first:580.69 07:55:48 INFO - PROCESS | 12411 | Values: 3024.7 3025.1 3063.6 3073.3 3079.5 5217.6 5259.8 5320.4 5338.0 5355.4 5372.9 5385.0 5405.9 5409.2 5477.6 4800.4 4853.1 4853.2 4886.8 5070.2 4967.9 4980.4 5010.2 5032.2 5038.3 4817.5 4818.6 4832.1 4884.1 4932.1 4829.4 4847.5 4896.3 4914.7 4950.4 4761.9 4863.8 4886.4 4893.3 4917.0 5343.9 5402.4 5434.8 5484.7 5486.2 5768.1 5819.2 5827.2 5841.9 5842.0 5618.9 5638.5 5710.3 5732.6 5787.1 5301.3 5376.2 5377.6 5377.8 5383.7 5875.3 5880.2 5883.4 5886.5 5890.1 5475.5 5614.1 5630.5 5662.8 5664.6 5797.1 5799.3 5805.3 5805.7 5805.8 5703.2 5743.9 5751.5 5752.1 5791.2 5601.3 5657.0 5702.1 5710.1 5758.0 4364.5 4366.8 4368.4 4370.1 4399.8 3917.8 3921.2 3937.6 3966.2 3985.7 5188.7 5190.0 5203.6 5321.5 5373.0 5734.9 5761.5 5767.1 5785.0 5789.2 5382.1 5393.6 5394.1 5400.4 5400.5 4871.6 4911.6 4933.5 4957.8 4998.3 5875.3 5888.9 5920.1 5937.3 5950.8 5729.8 5741.3 5746.8 5750.3 5754.0 5641.9 5842.2 5857.5 5866.3 5866.8 5663.5 5684.5 5699.3 5705.4 5751.4 5734.2 5736.5 5777.3 5784.4 5790.2 5431.7 5581.5 5626.6 5667.1 5676.5 5620.9 5629.6 5635.4 5640.5 5675.9 5511.4 5553.8 5560.1 5565.3 5566.5 5451.5 5558.3 5599.2 5618.7 5646.0 5482.5 5500.4 5516.6 5516.7 5522.4 07:55:48 INFO - PROCESS | 12411 | 07:55:48 INFO - PROCESS | 12411 | [#1] ext.html Cycles:180 Average:64097.32 Median:43371.57 stddev:128780.81 (296.9%) stddev-sans-first:129053.81 07:55:48 INFO - PROCESS | 12411 | Values: 591.9 607.9 608.6 626.0 642.7 31130.5 31647.4 44346.0 45252.5 45296.8 43621.0 46376.0 46378.3 46401.0 46413.0 8930.0 9071.2 9073.5 9075.5 9075.7 8870.4 8938.2 8959.8 8961.1 8965.7 8994.2 9027.2 9033.9 9039.8 9044.1 8957.5 8998.1 9012.8 9026.5 9033.4 8941.7 9004.0 9016.5 9018.2 9019.5 43685.3 43981.0 44103.1 44125.1 44139.3 3491.5 3546.1 3572.6 3588.4 3618.7 32996.7 33645.1 34132.3 34226.8 34305.0 4202.8 4228.4 4304.1 4309.0 4379.7 376071.1 377890.0 379054.0 380996.0 381039.0 64105.4 64645.0 64665.4 64735.4 64741.0 58837.7 67008.7 67125.3 68255.3 68712.7 15553.6 15553.8 15644.5 15650.1 15653.1 12205.7 12290.5 12296.1 12301.8 12313.2 17607.0 17955.4 17958.2 19545.5 19929.3 7079.5 7104.4 7368.4 7455.8 7549.8 1006.3 1007.6 1029.2 1083.4 1115.7 33004.7 33243.3 33313.8 33383.0 34010.8 1096.2 1102.2 1133.1 1152.6 1154.3 17477.2 17879.2 17889.3 17973.3 17973.8 585986.0 590343.0 590859.0 592613.0 594047.0 60235.0 60860.4 60882.4 60896.0 60919.4 1307.3 1347.4 1351.0 1363.8 1367.5 32118.8 32722.8 32744.7 32966.8 33525.3 55326.7 55404.4 55509.0 55903.5 55962.4 459196.0 459592.0 460542.0 461837.0 462023.0 28848.6 29122.9 29638.0 29926.4 29931.3 41064.4 45858.0 49805.3 50218.5 53625.7 41735.2 42372.5 43273.1 45376.8 46234.0 38839.6 39226.6 39239.4 39467.6 39875.4 42933.6 43470.0 43626.6 44050.8 44066.8 37225.0 38336.4 38440.8 39207.0 39298.6 28809.4 29099.0 29132.3 29347.6 29506.9 07:55:48 INFO - PROCESS | 12411 | 07:55:48 INFO - PROCESS | 12411 | [#2] jquery.html Cycles:180 Average:30376.82 Median:11474.88 stddev:82464.31 (718.7%) stddev-sans-first:82664.89 07:55:48 INFO - PROCESS | 12411 | Values: 384.5 390.5 393.9 400.6 401.8 13838.6 18959.5 20360.4 20456.7 21699.1 15619.6 20117.2 20120.0 20142.4 20944.0 5886.0 6021.2 6027.2 6027.8 6051.3 5965.8 5990.0 5990.4 6000.2 6009.5 4263.6 4904.4 6599.1 6601.7 6727.0 6552.2 6676.5 6718.6 6720.5 6727.3 5907.9 5911.8 5923.4 5951.6 5954.8 23764.0 24526.4 25464.5 25675.6 25692.1 2396.1 2429.6 2456.5 2583.5 2690.8 14899.3 15017.7 15332.9 15348.2 15453.2 1905.4 2014.4 2051.0 2054.6 2091.4 79371.6 80612.6 82196.2 83710.0 88927.0 10926.5 11211.8 11311.5 11334.9 11603.5 15678.8 15831.7 15934.4 15936.0 15956.8 7903.5 8288.3 8301.3 8334.2 8351.4 7904.4 8004.9 8044.0 8120.3 8189.1 4470.2 4669.3 4874.4 4877.8 4971.6 1964.4 2005.2 2013.1 2043.6 2046.0 936.9 991.9 994.3 1020.6 1042.9 20568.8 20776.8 20858.4 21078.3 21220.5 974.1 1002.7 1019.3 1020.3 1048.8 11008.2 11605.5 11619.6 11622.1 11622.9 479846.0 497496.0 502151.0 504374.0 518510.0 92559.5 92654.5 94187.0 94215.0 96833.0 1022.7 1034.6 1045.0 1048.9 1053.3 17616.2 17916.1 18276.8 18381.8 18612.7 36710.6 42230.0 42253.0 43032.8 43353.1 60002.4 62549.4 63980.4 63986.0 68507.0 12555.4 13017.9 13359.7 13378.7 13395.6 10515.0 14772.3 15096.7 15183.2 15462.2 12179.6 12800.7 13014.3 13045.2 13106.7 12784.3 13084.2 13104.4 13136.3 13337.4 13131.4 13195.6 13241.0 13316.7 13558.6 13383.4 13414.3 13430.3 13442.7 13448.7 12711.6 12799.3 12907.7 12944.0 12993.9 07:55:48 INFO - PROCESS | 12411 | 07:55:48 INFO - PROCESS | 12411 | [#3] mootools.html Cycles:180 Average:5770.55 Median:4314.84 stddev:3213.57 (74.5%) stddev-sans-first:3205.06 07:55:48 INFO - PROCESS | 12411 | Values: 1306.0 1444.2 1482.3 1596.2 1745.7 8182.9 8526.4 8573.3 8716.5 8746.3 8460.4 8669.9 8689.4 8708.1 8712.9 2018.5 2268.6 2337.2 2354.6 2373.5 2354.9 2393.2 2399.0 2399.1 2400.7 2311.4 2332.1 2337.6 2337.6 2339.1 1964.8 2227.1 2301.6 2305.3 2305.9 2362.2 2380.7 2381.2 2385.0 2387.2 8477.3 8536.4 8542.2 8547.3 8553.0 5061.1 5169.6 5181.7 5181.7 5183.4 3368.9 3424.9 3521.3 3524.6 3529.7 1210.8 1234.1 1247.0 1252.8 1259.2 11692.6 11910.8 11950.6 11951.7 11964.7 4345.3 4427.3 4555.2 4575.4 4623.8 10175.2 10176.0 10195.3 10216.5 10234.3 5208.4 5210.0 5210.5 5211.4 5211.5 4202.9 4679.6 4810.3 4827.5 4864.2 3943.1 3995.0 4015.0 4093.2 4103.8 1108.2 1214.7 1242.6 1257.1 1275.6 999.5 1012.3 1012.7 1021.6 1031.6 6117.1 6275.2 6339.3 6383.8 6489.7 985.5 1030.2 1032.8 1036.6 1046.8 4173.7 4206.5 4224.6 4284.4 4441.9 10414.1 10783.4 10809.7 10848.6 10877.6 10611.5 10621.2 10662.3 10711.0 10713.0 7512.5 8134.5 8248.0 8265.1 8278.3 6097.8 6183.7 6242.6 6261.1 6268.8 9969.2 10174.9 10182.0 10184.2 10188.0 9836.1 10149.5 10448.8 10459.3 10476.2 7516.7 7563.2 7604.6 7609.0 7616.3 8012.6 8094.2 8110.7 8113.6 8162.6 6088.6 7498.1 7514.2 7699.3 7752.1 7293.0 7592.1 7608.3 7654.4 7767.2 6862.3 7021.8 7049.6 7049.9 7061.8 5315.4 5412.1 5512.0 5529.4 5600.3 5425.1 5437.6 5467.0 5513.1 5606.9 07:55:48 INFO - PROCESS | 12411 | 07:55:48 INFO - PROCESS | 12411 | [#4] prototype.html Cycles:180 Average:4617.31 Median:5295.49 stddev:1337.71 (25.3%) stddev-sans-first:1302.19 07:55:48 INFO - PROCESS | 12411 | Values: 330.5 336.1 339.0 339.3 345.7 5259.6 5296.8 5303.7 5313.3 5327.8 5218.5 5239.0 5285.5 5289.9 5294.2 3884.8 4000.0 4114.6 4116.7 4157.9 4106.7 4113.8 4121.8 4150.8 4162.9 3856.3 4071.1 4086.8 4105.5 4114.1 4026.3 4092.8 4106.5 4134.7 4143.6 3636.8 3658.3 3664.9 3676.2 3678.5 5094.8 5101.7 5105.4 5106.9 5110.0 4567.2 4704.7 4715.0 4770.8 4774.8 5373.5 5376.9 5395.8 5431.7 5466.5 4069.9 4071.8 4074.3 4087.2 4090.8 5601.2 5606.7 5642.6 5715.7 5734.6 4014.2 4032.9 4037.4 4042.9 4053.4 4088.5 4114.6 4126.6 4134.0 4138.5 4597.1 4598.1 4673.9 4677.5 4685.0 5417.5 5425.9 5460.8 5462.5 5467.9 1411.9 1431.9 1439.7 1464.8 1465.7 912.5 923.8 954.9 970.6 996.7 5122.9 5123.2 5154.9 5158.5 5172.8 5482.3 5490.4 5497.0 5506.5 5534.7 5036.7 5123.4 5158.0 5178.7 5315.4 2962.2 2970.5 2970.6 2987.1 2991.9 5735.8 5772.6 5824.0 5831.9 5848.1 5662.6 5701.9 5720.0 5723.5 5748.8 5721.3 5735.1 5744.0 5748.4 5819.4 5417.6 5576.8 5607.4 5652.9 5653.8 5512.8 5554.3 5559.4 5573.0 5579.7 5704.9 5753.5 5783.7 5784.6 5786.4 3918.8 4032.0 4033.4 4038.2 4065.9 5340.7 5421.4 5560.5 5561.6 5568.3 5511.4 5514.6 5517.7 5524.6 5527.0 5439.0 5460.8 5465.8 5472.7 5485.6 5150.5 5393.4 5397.3 5409.3 5418.7 5481.2 5486.7 5528.7 5529.2 5534.5 5305.5 5413.5 5418.2 5448.5 5450.4 07:55:48 INFO - PROCESS | 12411 | 07:55:48 INFO - PROCESS | 12411 | [#5] yui.html Cycles:180 Average:20371.66 Median:4761.01 stddev:28673.72 (602.3%) stddev-sans-first:28716.37 07:55:48 INFO - PROCESS | 12411 | Values: 766.3 784.4 787.9 810.8 827.7 13255.3 14018.9 14044.4 14084.9 14090.7 10968.0 13180.2 13325.3 13353.5 13384.6 796.9 813.6 823.5 825.3 826.5 825.9 828.0 831.0 833.9 834.6 710.7 865.7 872.1 872.3 873.9 839.2 863.1 866.1 866.9 867.4 633.2 633.3 633.4 633.7 634.5 13513.8 13527.7 13551.9 13553.4 13581.9 13792.7 13932.4 13947.5 14065.2 14274.4 13059.4 13109.7 13269.1 13560.0 13637.5 4322.4 4342.8 4384.6 4430.6 4453.8 74960.6 75914.2 76098.0 76870.0 77413.0 10991.5 10995.8 11118.9 11126.9 11323.8 19696.7 19845.7 19867.1 19897.4 21018.4 8736.4 9341.3 9366.0 9366.2 9486.0 4764.6 4812.6 4832.2 4876.9 4927.6 3706.4 3811.5 3826.6 3828.7 3832.1 648.3 659.4 659.5 659.8 663.9 739.5 790.8 798.6 803.2 815.9 9571.3 9642.1 9782.3 9824.5 9906.0 606.8 622.0 637.7 717.7 743.6 4662.6 4684.7 4737.5 4757.4 4835.4 68432.0 109475.0 109995.5 111550.0 112143.4 98216.0 98945.5 99907.0 100138.0 100447.5 72614.6 84692.0 85137.0 88581.0 89270.6 9302.5 9353.2 9368.5 9411.9 9526.7 46511.0 47670.0 52863.7 54003.7 54846.0 59112.1 59964.3 76346.2 77281.0 77457.0 12808.6 12881.3 13325.3 13466.0 13620.6 15012.8 15024.5 15740.7 15753.6 15972.0 14645.4 14818.6 14984.7 15252.8 15747.4 13985.7 14018.3 14309.4 14429.7 15152.6 14617.9 14652.1 14722.3 15566.8 15584.3 12076.6 12245.4 12592.2 12641.4 12764.7 12064.4 12393.9 12455.0 12683.3 12803.5 07:55:48 INFO - PROCESS | 12411 | -------- Summary: end -------- 07:55:48 INFO - PROCESS | 12411 | 07:55:49 INFO - TEST-INFO | 12411: exit 0 07:55:49 INFO - TEST-OK | dromaeo_css | took 1112867ms 07:55:49 INFO - TEST-START | kraken 07:55:49 INFO - operating with platform_type : linux_ 07:55:49 INFO - Initialising browser for kraken test... 07:55:49 INFO - TEST-INFO | started process 12602 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcJ5fna/profile http://localhost:54332/getInfo.html) 07:55:53 INFO - PROCESS | 12602 | __metrics Screen width/height:1600/1200 07:55:53 INFO - PROCESS | 12602 | colorDepth:24 07:55:53 INFO - PROCESS | 12602 | Browser inner width/height: 1024/697 07:55:53 INFO - PROCESS | 12602 | __metrics 07:55:54 INFO - PROCESS | 12602 | 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:55:54 INFO - PROCESS | 12602 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:55:54 INFO - PROCESS | 12602 | console.error: PushService: 07:55:54 INFO - PROCESS | 12602 | stateChangeProcessEnqueue: Error transitioning state 07:55:54 INFO - PROCESS | 12602 | UnknownError 07:55:55 INFO - TEST-INFO | 12602: exit 0 07:55:55 INFO - Browser initialized. 07:55:55 INFO - Running cycle 1/1 for kraken test... 07:55:55 INFO - TEST-INFO | started process 12687 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcJ5fna/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:56:06 INFO - PROCESS | 12687 | RSS: Main: 156848128 07:56:06 INFO - PROCESS | 12687 | 07:56:09 INFO - PROCESS | 12687 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54332/tests/kraken/driver.html?testName=audio-beat-detection) 07:56:10 INFO - PROCESS | 12687 | RSS: Main: 215412736 07:56:10 INFO - PROCESS | 12687 | 07:56:12 INFO - PROCESS | 12687 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54332/tests/kraken/driver.html?testName=audio-dft) 07:56:13 INFO - PROCESS | 12687 | RSS: Main: 203677696 07:56:13 INFO - PROCESS | 12687 | 07:56:16 INFO - PROCESS | 12687 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54332/tests/kraken/driver.html?testName=audio-fft) 07:56:17 INFO - PROCESS | 12687 | RSS: Main: 269688832 07:56:17 INFO - PROCESS | 12687 | 07:56:19 INFO - PROCESS | 12687 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54332/tests/kraken/driver.html?testName=audio-oscillator) 07:56:19 INFO - PROCESS | 12687 | RSS: Main: 179920896 07:56:19 INFO - PROCESS | 12687 | 07:56:21 INFO - PROCESS | 12687 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54332/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:56:22 INFO - PROCESS | 12687 | RSS: Main: 184487936 07:56:22 INFO - PROCESS | 12687 | 07:56:25 INFO - PROCESS | 12687 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54332/tests/kraken/driver.html?testName=imaging-darkroom) 07:56:26 INFO - PROCESS | 12687 | RSS: Main: 219246592 07:56:26 INFO - PROCESS | 12687 | 07:56:29 INFO - PROCESS | 12687 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54332/tests/kraken/driver.html?testName=imaging-desaturate) 07:56:30 INFO - PROCESS | 12687 | RSS: Main: 221282304 07:56:30 INFO - PROCESS | 12687 | 07:56:32 INFO - PROCESS | 12687 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54332/tests/kraken/driver.html?testName=json-parse-financial) 07:56:33 INFO - PROCESS | 12687 | RSS: Main: 221118464 07:56:33 INFO - PROCESS | 12687 | 07:56:34 INFO - PROCESS | 12687 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54332/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:56:35 INFO - PROCESS | 12687 | RSS: Main: 208588800 07:56:35 INFO - PROCESS | 12687 | 07:56:37 INFO - PROCESS | 12687 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54332/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:56:37 INFO - PROCESS | 12687 | RSS: Main: 211226624 07:56:37 INFO - PROCESS | 12687 | 07:56:39 INFO - PROCESS | 12687 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54332/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:56:40 INFO - PROCESS | 12687 | RSS: Main: 211513344 07:56:40 INFO - PROCESS | 12687 | 07:56:43 INFO - PROCESS | 12687 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54332/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:56:43 INFO - PROCESS | 12687 | RSS: Main: 224493568 07:56:43 INFO - PROCESS | 12687 | 07:56:46 INFO - PROCESS | 12687 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54332/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:56:47 INFO - PROCESS | 12687 | RSS: Main: 225374208 07:56:47 INFO - PROCESS | 12687 | 07:56:48 INFO - PROCESS | 12687 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54332/tests/kraken/driver.html?testName=ai-astar) 07:56:48 INFO - PROCESS | 12687 | RSS: Main: 267935744 07:56:48 INFO - PROCESS | 12687 | 07:56:48 INFO - PROCESS | 12687 | __start_tp_report 07:56:48 INFO - PROCESS | 12687 | _x_x_mozilla_page_load 07:56:48 INFO - PROCESS | 12687 | _x_x_mozilla_page_load_details 07:56:48 INFO - PROCESS | 12687 | |i|pagename|runs| 07:56:48 INFO - PROCESS | 12687 | |0;ai-astar;102;111;110;110;112;111;111;111;111;111 07:56:48 INFO - PROCESS | 12687 | |1;audio-beat-detection;149;116;123;192;118;117;140;117;146;118 07:56:48 INFO - PROCESS | 12687 | |2;audio-dft;160;161;160;160;161;160;158;162;161;161 07:56:48 INFO - PROCESS | 12687 | |3;audio-fft;75;75;75;113;74;75;74;73;98;74 07:56:48 INFO - PROCESS | 12687 | |4;audio-oscillator;84;84;121;84;84;83;114;84;84;121 07:56:48 INFO - PROCESS | 12687 | |5;imaging-gaussian-blur;117;117;118;117;117;117;117;116;117;117 07:56:48 INFO - PROCESS | 12687 | |6;imaging-darkroom;145;146;145;146;145;146;145;146;145;146 07:56:48 INFO - PROCESS | 12687 | |7;imaging-desaturate;95;95;95;95;94;95;95;94;95;95 07:56:48 INFO - PROCESS | 12687 | |8;json-parse-financial;53;51;52;52;51;53;53;53;52;52 07:56:48 INFO - PROCESS | 12687 | |9;json-stringify-tinderbox;62;63;61;63;62;61;62;61;62;61 07:56:48 INFO - PROCESS | 12687 | |10;stanford-crypto-aes;82;75;75;73;82;75;74;74;76;83 07:56:48 INFO - PROCESS | 12687 | |11;stanford-crypto-ccm;134;117;116;117;116;118;133;117;194;120 07:56:48 INFO - PROCESS | 12687 | |12;stanford-crypto-pbkdf2;153;153;158;159;154;156;152;155;151;155 07:56:48 INFO - PROCESS | 12687 | |13;stanford-crypto-sha256-iterative;63;66;69;65;61;62;61;61;62;63 07:56:48 INFO - PROCESS | 12687 | __end_tp_report 07:56:48 INFO - PROCESS | 12687 | __start_cc_report 07:56:48 INFO - PROCESS | 12687 | _x_x_mozilla_cycle_collect,1641 07:56:48 INFO - PROCESS | 12687 | __end_cc_report 07:56:48 INFO - PROCESS | 12687 | __startTimestamp1468594608940__endTimestamp 07:56:48 INFO - PROCESS | 12687 | 07:56:48 INFO - PROCESS | 12687 | ------- Summary: start ------- 07:56:48 INFO - PROCESS | 12687 | Number of tests: 14 07:56:48 INFO - PROCESS | 12687 | 07:56:48 INFO - PROCESS | 12687 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:2.87 (2.6%) stddev-sans-first:0.60 07:56:48 INFO - PROCESS | 12687 | Values: 102.0 111.0 110.0 110.0 112.0 111.0 111.0 111.0 111.0 111.0 07:56:48 INFO - PROCESS | 12687 | 07:56:48 INFO - PROCESS | 12687 | [#1] audio-beat-detection Cycles:10 Average:133.60 Median:131.50 stddev:24.27 (18.5%) stddev-sans-first:25.10 07:56:48 INFO - PROCESS | 12687 | Values: 149.0 116.0 123.0 192.0 118.0 117.0 140.0 117.0 146.0 118.0 07:56:48 INFO - PROCESS | 12687 | 07:56:48 INFO - PROCESS | 12687 | [#2] audio-dft Cycles:10 Average:160.40 Median:161.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 07:56:48 INFO - PROCESS | 12687 | Values: 160.0 161.0 160.0 160.0 161.0 160.0 158.0 162.0 161.0 161.0 07:56:48 INFO - PROCESS | 12687 | 07:56:48 INFO - PROCESS | 12687 | [#3] audio-fft Cycles:10 Average:80.60 Median:75.00 stddev:13.61 (18.1%) stddev-sans-first:14.28 07:56:48 INFO - PROCESS | 12687 | Values: 75.0 75.0 75.0 113.0 74.0 75.0 74.0 73.0 98.0 74.0 07:56:48 INFO - PROCESS | 12687 | 07:56:48 INFO - PROCESS | 12687 | [#4] audio-oscillator Cycles:10 Average:94.30 Median:84.00 stddev:16.92 (20.1%) stddev-sans-first:17.54 07:56:48 INFO - PROCESS | 12687 | Values: 84.0 84.0 121.0 84.0 84.0 83.0 114.0 84.0 84.0 121.0 07:56:48 INFO - PROCESS | 12687 | 07:56:48 INFO - PROCESS | 12687 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 07:56:48 INFO - PROCESS | 12687 | Values: 117.0 117.0 118.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 07:56:48 INFO - PROCESS | 12687 | 07:56:48 INFO - PROCESS | 12687 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 07:56:48 INFO - PROCESS | 12687 | Values: 145.0 146.0 145.0 146.0 145.0 146.0 145.0 146.0 145.0 146.0 07:56:48 INFO - PROCESS | 12687 | 07:56:48 INFO - PROCESS | 12687 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:56:48 INFO - PROCESS | 12687 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 94.0 95.0 95.0 07:56:48 INFO - PROCESS | 12687 | 07:56:48 INFO - PROCESS | 12687 | [#8] json-parse-financial Cycles:10 Average:52.20 Median:52.50 stddev:0.79 (1.5%) stddev-sans-first:0.78 07:56:48 INFO - PROCESS | 12687 | Values: 53.0 51.0 52.0 52.0 51.0 53.0 53.0 53.0 52.0 52.0 07:56:48 INFO - PROCESS | 12687 | 07:56:48 INFO - PROCESS | 12687 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:0.79 (1.3%) stddev-sans-first:0.83 07:56:48 INFO - PROCESS | 12687 | Values: 62.0 63.0 61.0 63.0 62.0 61.0 62.0 61.0 62.0 61.0 07:56:48 INFO - PROCESS | 12687 | 07:56:48 INFO - PROCESS | 12687 | [#10] stanford-crypto-aes Cycles:10 Average:76.90 Median:75.50 stddev:3.84 (5.1%) stddev-sans-first:3.61 07:56:48 INFO - PROCESS | 12687 | Values: 82.0 75.0 75.0 73.0 82.0 75.0 74.0 74.0 76.0 83.0 07:56:48 INFO - PROCESS | 12687 | 07:56:48 INFO - PROCESS | 12687 | [#11] stanford-crypto-ccm Cycles:10 Average:128.20 Median:119.00 stddev:24.11 (20.3%) stddev-sans-first:25.48 07:56:48 INFO - PROCESS | 12687 | Values: 134.0 117.0 116.0 117.0 116.0 118.0 133.0 117.0 194.0 120.0 07:56:48 INFO - PROCESS | 12687 | 07:56:48 INFO - PROCESS | 12687 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.60 Median:155.00 stddev:2.55 (1.6%) stddev-sans-first:2.64 07:56:48 INFO - PROCESS | 12687 | Values: 153.0 153.0 158.0 159.0 154.0 156.0 152.0 155.0 151.0 155.0 07:56:48 INFO - PROCESS | 12687 | 07:56:48 INFO - PROCESS | 12687 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.00 stddev:2.63 (4.2%) stddev-sans-first:2.78 07:56:48 INFO - PROCESS | 12687 | Values: 63.0 66.0 69.0 65.0 61.0 62.0 61.0 61.0 62.0 63.0 07:56:48 INFO - PROCESS | 12687 | -------- Summary: end -------- 07:56:48 INFO - PROCESS | 12687 | 07:56:49 INFO - TEST-INFO | 12687: exit 0 07:56:49 INFO - TEST-OK | kraken | took 60680ms 07:56:49 INFO - SUITE-END | took 1173s 07:56:50 INFO - Completed test suite (00:19:33) 07:56:50 INFO - javascript benchmark 07:56:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3024.7277745002943, 3025.0924722583227, 3063.6323641163062, 3073.3392320651055, 3079.476488996872, 5217.608679349045, 5259.8422047338545, 5320.441353657869, 5337.973310133449, 5355.410904800474, 5372.9462705373035, 5385.030694474993, 5405.945940540603, 5409.161579955104, 5477.589180811435, 4800.399950006241, 4853.126437241295, 4853.223484242522, 4886.78009489572, 5070.163423035195, 4967.875803104916, 4980.402351717781, 5010.150992901779, 5032.194848824189, 5038.319826823387, 4817.51824817519, 4818.614510839125, 4832.130216561018, 4884.120858245515, 4932.062908047477, 4829.420469543677, 4847.491013443609, 4896.2655601660035, 4914.655974081816, 4950.4307004694565, 4761.880952976203, 4863.78112984913, 4886.438059623118, 4893.339399181101, 4916.975415122937, 5343.946560534423, 5402.37872644647, 5434.83695489136, 5484.698341591211, 5486.231927530149, 5768.077107662796, 5819.185314056035, 5827.155062515912, 5841.85395365115, 5841.970790146022, 5618.943810561924, 5638.492535671769, 5710.2862142232225, 5732.598718089694, 5787.074068149076, 5301.257823904656, 5376.193570964387, 5377.623566350357, 5377.7580008899695, 5383.676979381211, 5875.265591801025, 5880.176775251468, 5883.382244864313, 5886.529077673861, 5890.1164825276555, 5475.534579560703, 5614.129809879475, 5630.521405680481, 5662.7734890603915, 5664.6034777566, 5797.072468405035, 5799.2750906136735, 5805.332386775491, 5805.709714514257, 5805.767769289181, 5703.230063941398, 5743.913841292384, 5751.482366587027, 5752.108423194411, 5791.160281759121, 5601.327840659147, 5656.971715141398, 5702.144678298288, 5710.086386178192, 5758.049921762862, 4364.4980827204645, 4366.8034938427845, 4368.4102646143, 4370.104128653618, 4399.758013309235, 3917.8236979335998, 3921.156951255494, 3937.6062393760394, 3966.2265858157957, 3985.720999530063, 5188.688678679291, 5189.974050129726, 5203.557697595671, 5321.521063104262, 5372.973135134377, 5734.913976290359, 5761.48146666802, 5767.106098554731, 5785.0454674978155, 5789.189513468118, 5382.085045542189, 5393.649412788156, 5394.056040192951, 5400.432954539795, 5400.513953744182, 4871.585915197177, 4911.607071434277, 4933.45731969483, 4957.801687932514, 4998.275250088789, 5875.324337701134, 5888.911666325009, 5920.052791553331, 5937.317208521075, 5950.821475355746, 5729.828105156852, 5741.2536370273265, 5746.827595172152, 5750.252467179407, 5753.971230143822, 5641.8589535261945, 5842.1820945068575, 5857.5313974881055, 5866.325372582208, 5866.823995280149, 5663.461971112738, 5684.459976302244, 5699.34457537372, 5705.429457054262, 5751.367349591458, 5734.197212390352, 5736.4550367715, 5777.3356064051495, 5784.392638772868, 5790.247267855152, 5431.701256430934, 5581.525570326406, 5626.5780066496, 5667.093265077568, 5676.489115979582, 5620.915686264628, 5629.634073785191, 5635.380108188178, 5640.492355688008, 5675.886482270249, 5511.4213007633625, 5553.805616803393, 5560.082586373365, 5565.30433695788, 5566.471185237396, 5451.536619387396, 5558.305211848519, 5599.244102046335, 5618.6628802272, 5646.0, 5482.506574408322, 5500.4499550044675, 5516.61383703153, 5516.724163791714, 5522.420145884625], "value": 5285.557471587215, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.9378465261148, 607.9057696146932, 608.5831205624148, 625.9561830671853, 642.6818724731258, 31130.53304200436, 31647.367052658963, 44346.0, 45252.54747452524, 45296.77351613237, 43621.0, 46376.0, 46378.30432543514, 46401.0, 46413.0, 8929.955350223256, 9071.183593476586, 9073.54632268384, 9075.546222688872, 9075.682351117712, 8870.37907346486, 8938.240249578794, 8959.820803583925, 8961.05908879568, 8965.686200982967, 8994.190522852941, 9027.187553120219, 9033.864492032624, 9039.774005649846, 9044.140806623393, 8957.462552246887, 8998.100189981014, 9012.819743605156, 9026.45841249527, 9033.412828166181, 8941.6870409536, 9003.954980225122, 9016.504092274923, 9018.233450156744, 9019.503927283997, 43685.34471982923, 43981.0, 44103.117937641066, 44125.117497650186, 44139.337909931375, 3491.4762785582366, 3546.113471632092, 3572.5534308211472, 3588.3899737044503, 3618.7105031597407, 32996.67003329984, 33645.08381310953, 34132.31735365304, 34226.82886585576, 34305.0, 4202.844217840088, 4228.365745138223, 4304.139172165579, 4308.956910430887, 4379.715318504319, 376071.11964440276, 377890.0, 379054.0, 380996.0, 381039.0, 64105.35894640994, 64645.0, 64665.35334646687, 64735.35264647293, 64741.0, 58837.70581147067, 67008.66495667491, 67125.32874671288, 68255.3174468259, 68712.6564367175, 15553.611159721098, 15553.844461555465, 15644.530664080095, 15650.060996340257, 15653.060816351055, 12205.694857628452, 12290.508379664714, 12296.077794165474, 12301.815472767916, 12313.199642023239, 17607.0, 17955.371561995267, 17958.19188136537, 19545.511362216057, 19929.302474413325, 7079.539829911039, 7104.3961263293195, 7368.447366447538, 7455.837807035899, 7549.773506794805, 1006.2654262388497, 1007.6120693533043, 1029.156092004564, 1083.3987137138806, 1115.676453828397, 33004.66995330064, 33243.33513329768, 33313.833430833176, 33383.0, 34010.82994585011, 1096.17786660005, 1102.1513434655271, 1133.1274918312854, 1152.6484422251294, 1154.2612727854012, 17477.213525391388, 17879.195436205402, 17889.28442862271, 17973.281068757366, 17973.820261797475, 585986.0, 590343.0, 590859.0, 592613.0, 594047.0, 60235.0, 60860.39139608636, 60882.39117608856, 60896.0, 60919.390806092255, 1307.2809954524973, 1347.42734337906, 1350.966225844342, 1363.8295213098363, 1367.5213675213795, 32118.83940580282, 32722.83638581792, 32744.672553275115, 32966.83516582402, 33525.329493410485, 55326.72336638291, 55404.44595553993, 55509.0, 55903.52771778329, 55962.440375595725, 459196.0, 459592.0, 460542.0, 461837.0, 462023.0, 28848.567271491363, 29122.854385727936, 29638.0, 29926.401471970876, 29931.251718707208, 41064.384034238916, 45858.0, 49805.252921206935, 50218.49781502138, 53625.731871340395, 41735.165296694504, 42372.52058035859, 43273.13453730845, 45376.77311613421, 46234.0, 38839.6116038836, 39226.6077339223, 39239.41140882946, 39467.605323946394, 39875.40186897257, 42933.57066429421, 43470.0, 43626.56373436225, 44050.779746102344, 44066.779666101465, 37225.0, 38336.42495362516, 38440.80779596084, 39207.0, 39298.6070139295, 28809.42381152407, 29099.0, 29132.27169320784, 29347.559786603644, 29506.852465738393], "value": 20651.3413049183, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.450236162288, 390.4982098004065, 393.8680542018422, 400.61340806122087, 401.8171731862002, 13838.616329376264, 18959.52601184969, 20360.389188324374, 20456.69314960275, 21699.132034718594, 15619.609509762262, 20117.195312187494, 20120.0, 20142.395728128144, 20944.0, 5885.970570147154, 6021.187139736124, 6027.156198132265, 6027.789027384042, 6051.27384713835, 5965.791197308095, 5990.041593345066, 5990.430909063632, 6000.249968753906, 6009.5192384609345, 4263.637590804786, 4904.36243288372, 6599.109120268774, 6601.7359305627715, 6727.024581435689, 6552.213734351908, 6676.532642714988, 6718.6304753238555, 6720.462363010947, 6727.293634168415, 5907.852303692399, 5911.793087241926, 5923.437273459014, 5951.613145145551, 5954.791582294599, 23764.0, 24526.386840328956, 25464.49071018569, 25675.614865777028, 25692.100776472922, 2396.085101303973, 2429.6477010833332, 2456.5332586808627, 2583.457473930458, 2690.811643184978, 14899.255037248202, 15017.699646007128, 15332.923335383362, 15348.155851428168, 15453.227338633136, 1905.3902751119647, 2014.3956812956055, 2050.9692354614695, 2054.6404379233572, 2091.383042002613, 79371.6031419845, 80612.59693701494, 82196.17803822005, 83710.0, 88927.0, 10926.508307126198, 11211.775764484664, 11311.547538098384, 11334.886651133547, 11603.477843497063, 15678.76481852773, 15831.683366332609, 15934.442294519637, 15936.0, 15956.76064859028, 7903.525788452711, 8288.254057134765, 8301.29438997692, 8334.249917507454, 8351.3736469765, 7904.407169462198, 8004.919950800418, 8044.0, 8120.309773669186, 8189.1401402853035, 4470.240059189946, 4669.276262179367, 4874.36633237684, 4877.829275975324, 4971.577415919615, 1964.4106767969838, 2005.227987224929, 2013.1242909334487, 2043.5708501214615, 2045.9795402046086, 936.8735220745249, 991.8859331177007, 994.2592768387598, 1020.6172685243034, 1042.9426381549088, 20568.794312056987, 20776.792232077787, 20858.37424877256, 21078.252889157084, 21220.469488262916, 974.0989584634185, 1002.7242508310127, 1019.2864994503728, 1020.2959957629361, 1048.8059708953867, 11008.174386921013, 11605.477753501113, 11619.593314233962, 11622.128340374506, 11622.88377116235, 479846.0, 497496.0, 502151.0, 504374.0, 518510.0, 92559.53720231491, 92654.53672731594, 94187.0, 94215.0, 96833.0, 1022.7085280694967, 1034.591336422094, 1044.9634262800766, 1048.8531605575226, 1053.3258714422775, 17616.207270672596, 17916.104194789947, 18276.81723182751, 18381.81618183801, 18612.720809188144, 36710.63289367072, 42230.0, 42253.0, 43032.78483607562, 43353.13293734171, 60002.39997599968, 62549.37450625435, 63980.36019639744, 63986.0, 68507.0, 12555.43500542496, 13017.934910325388, 13359.732805343645, 13378.665533361744, 13395.598132056053, 10515.0, 14772.33524491422, 15096.698066038838, 15183.240837957837, 15462.226888655747, 12179.573714919936, 12800.6799830005, 13014.349282536024, 13045.217286962812, 13106.73786524245, 12784.296863672587, 13084.214947102824, 13104.410301536644, 13136.343182840628, 13337.399817008063, 13131.409086590935, 13195.60413187606, 13241.0, 13316.733665326832, 13558.593242202749, 13383.39774710121, 13414.32928353559, 13430.328483575588, 13442.663933401353, 13448.663783405493, 12711.55509557161, 12799.29603871796, 12907.677308067374, 12944.0, 12993.870061299265], "value": 9975.724166760177, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1305.9804102938451, 1444.2201211345873, 1482.3477669825277, 1596.2338077722693, 1745.716898079911, 8182.877256841145, 8526.44578102423, 8573.271271941892, 8716.477011379306, 8746.344024198179, 8460.36547258955, 8669.869951950726, 8689.391742578022, 8708.12918708129, 8712.869306960401, 2018.5458271888854, 2268.6029944759684, 2337.1586228957603, 2354.6232602783557, 2373.4659701567184, 2354.8822558872075, 2393.234165067179, 2399.0, 2399.1243196233336, 2400.7359190489033, 2311.410590299471, 2332.078828862598, 2337.55586438577, 2337.5792357375667, 2339.0526836631193, 1964.8231659150674, 2227.1091563374616, 2301.551197516485, 2305.296884450242, 2305.9308220753405, 2362.1968530699473, 2380.6905102336586, 2381.1903952656007, 2384.952300953971, 2387.188355958965, 8477.321814254845, 8536.44513106646, 8542.18849209324, 8547.273481754059, 8552.957235213784, 5061.063703214917, 5169.586433085344, 5181.663191892515, 5181.663191892552, 5183.403908550527, 3368.882089126869, 3424.9315013699834, 3521.2605352875926, 3524.594671612772, 3529.717622590212, 1210.8002179640437, 1234.0682784497646, 1247.0, 1252.7682378759866, 1259.1563652352854, 11692.590759323382, 11910.761784764343, 11950.581729639422, 11951.701207469796, 11964.70088247792, 4345.283028300359, 4427.313766366218, 4555.2483840166005, 4575.405197324327, 4623.815047398134, 10175.236857235737, 10175.964807038474, 10195.28632995698, 10216.489175541194, 10234.33476824004, 5208.374995000624, 5210.0, 5210.452902445264, 5211.42674305826, 5211.530962213343, 4202.852900148541, 4679.649026322972, 4810.254410566367, 4827.541383568555, 4864.173090574611, 3943.0930885896405, 3994.960050399517, 4014.979925100356, 4093.2222877653153, 4103.753774773523, 1108.152263518409, 1214.678110300771, 1242.6334231401759, 1257.0697683714168, 1275.6428200103985, 999.5002498750624, 1012.3217444312328, 1012.7215015870547, 1021.581151727788, 1031.6234574380446, 6117.082437634391, 6275.152854364694, 6339.334369891095, 6383.808485745435, 6489.740410383626, 985.5170966226498, 1030.2221822523945, 1032.83990981398, 1036.6371769880632, 1046.795874804406, 4173.7078404512, 4206.516250631155, 4224.640905523003, 4284.400183974246, 4441.888952776207, 10414.114800241912, 10783.352998819939, 10809.67570972872, 10848.62029828968, 10877.564897404174, 10611.469426528643, 10621.203409744145, 10662.253642244968, 10711.0, 10713.0, 7512.549247045085, 8134.471259368122, 8247.95876020616, 8265.090840007595, 8278.254957053894, 6097.847553811191, 6183.659898705434, 6242.563020588696, 6261.123442717932, 6268.780592679417, 9969.152622027208, 10174.898251017396, 10182.0, 10184.217761891492, 10188.0, 9836.114749672277, 10149.543270552991, 10448.843267350843, 10459.320144190604, 10476.214283928888, 7516.699332026657, 7563.168051514439, 7604.619769011417, 7609.0, 7616.314531692175, 8012.639431225492, 8094.15011423792, 8110.716124935599, 8113.59432028408, 8162.5510596915365, 6088.5737998341465, 7498.100227972678, 7514.248575142661, 7699.34555562761, 7752.14726380109, 7292.96353518229, 7592.050993625797, 7608.277213664693, 7654.387648988179, 7767.184445633127, 6862.318731910714, 7021.789346319619, 7049.612271325126, 7049.859002820018, 7061.82345441368, 5315.441878602691, 5412.134058550613, 5512.0, 5529.391766905556, 5600.327960644749, 5425.077736784835, 5437.619366644297, 5467.0, 5513.062779327443, 5606.85982850432], "value": 4656.891477602148, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.5042436345482, 336.1428357687896, 338.97796643218174, 339.29765385651694, 345.7182396346978, 5259.605529585282, 5296.828300396838, 5303.734813259341, 5313.335833020872, 5327.813526526573, 5218.530332270095, 5238.973805130979, 5285.524302812746, 5289.920651190235, 5294.1529355303155, 3884.8251828667635, 4000.039990402297, 4114.6091121343425, 4116.682661548306, 4157.896052598679, 4106.7125301228925, 4113.827559145644, 4121.752694838305, 4150.83396664133, 4162.875113746592, 3856.267309211241, 4071.1043570414463, 4086.754794712312, 4105.50733911931, 4114.094899122203, 4026.2752704513177, 4092.754434733896, 4106.486689163855, 4134.689898257612, 4143.585641435848, 3636.818159092035, 3658.323210206094, 3664.871729489482, 3676.246369494247, 3678.521792167001, 5094.79620815167, 5101.668391554537, 5105.438401775802, 5106.897862042739, 5109.9744501277255, 4567.223571992769, 4704.741239231841, 4714.952850471485, 4770.809167633291, 4774.832880849153, 5373.489518495737, 5376.892462150774, 5395.838124856261, 5431.6740995540395, 5466.480684334982, 4069.8982525436804, 4071.816768245436, 4074.2666320062376, 4087.2438598859308, 4090.7750073745933, 5601.215829783793, 5606.729274643817, 5642.633228840154, 5715.742791574389, 5734.627249228787, 4014.157027024299, 4032.8790136295956, 4037.37420699792, 4042.91914161721, 4053.398907431548, 4088.468499095158, 4114.629683328455, 4126.566710495415, 4133.9793301033305, 4138.503379594407, 4597.073867723729, 4598.149342371672, 4673.859784206411, 4677.503198976363, 4685.0, 5417.458254174551, 5425.945740542544, 5460.754266058037, 5462.5083742462575, 5467.863303417367, 1411.9269355289848, 1431.8639729225706, 1439.7336492748666, 1464.8281374900037, 1465.7068586282787, 912.4935660708238, 923.8013827027221, 954.9331546791658, 970.5729479029346, 996.7458298133929, 5122.92315615266, 5123.231515272664, 5154.9484505155215, 5158.45836187195, 5172.818951336685, 5482.259894914216, 5490.423505531941, 5497.0, 5506.504414602705, 5534.667919924817, 5036.697798132051, 5123.436421993578, 5158.0, 5178.689278643218, 5315.415304316522, 2962.155785601093, 2970.5395663672166, 2970.628671416073, 2987.14866263114, 2991.8952836651047, 5735.827925162252, 5772.5670574707065, 5823.970880145572, 5831.854203644858, 5848.093545500455, 5662.5753068520025, 5701.942980570141, 5719.971400142973, 5723.456271654186, 5748.770049197985, 5721.256236689203, 5735.11105778605, 5744.047024011856, 5748.367679555246, 5819.352194751463, 5417.566594672496, 5576.776928922797, 5607.383187849415, 5652.85867853307, 5653.830385088454, 5512.779488820403, 5554.250176226158, 5559.444055594408, 5572.972135139298, 5579.716665166953, 5704.914426283692, 5753.539716822561, 5783.681897495678, 5784.595078344475, 5786.392428794916, 3918.8040597969416, 4031.9596804031585, 4033.4353190553934, 4038.2327357803097, 4065.9390109147794, 5340.706261155674, 5421.3765416975975, 5560.471755183251, 5561.610687251854, 5568.303962004749, 5511.366192887869, 5514.641548299348, 5517.668939863621, 5524.640898341595, 5526.972365138148, 5439.0, 5460.798624302647, 5465.754041068241, 5472.699001554953, 5485.6434331768305, 5150.536451719363, 5393.379761327497, 5397.271368365377, 5409.29679141709, 5418.701971391612, 5481.232627432083, 5486.710623003671, 5528.682790325773, 5529.198266251291, 5534.501894829485, 5305.549028332635, 5413.485718856702, 5418.214358918013, 5448.536874365724, 5450.364890532904], "value": 4195.4140998689845, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [766.2911806578915, 784.4469648897527, 787.8503084413961, 810.7891948093496, 827.6565225431442, 13255.33723313834, 14018.859811401882, 14044.438222471115, 14084.859151408496, 14090.718185636293, 10968.0, 13180.20918744876, 13325.333733313344, 13353.53262635808, 13384.59846204613, 796.9481983671043, 813.6419975210918, 823.5429336718119, 825.2778818533783, 826.5495305058728, 825.8513467575834, 827.9751607451786, 831.0442990560842, 833.9041010283804, 834.566025666653, 710.6553321639001, 865.7229686500323, 872.084311472954, 872.2978002707817, 873.8995015573227, 839.2404873589381, 863.0765081362944, 866.1079088538816, 866.8786369908217, 867.4144952157332, 633.2053273142177, 633.3286716080969, 633.4457349818908, 633.708494092718, 634.4638780230698, 13513.797293040612, 13527.729445411036, 13551.932240338834, 13553.39009744564, 13581.864181358158, 13792.724145517033, 13932.37304321308, 13947.454746071062, 14065.226412547307, 14274.429022839075, 13059.425533190726, 13109.737805243936, 13269.137506062172, 13560.0, 13637.454501820015, 4322.373255877911, 4342.761148136851, 4384.649228061748, 4430.623397011258, 4453.755043472608, 74960.62519687366, 75914.24085759127, 76097.99999999945, 76870.0, 77413.0, 10991.505382257817, 10995.835062474069, 11118.888811111785, 11126.944365278283, 11323.773524529463, 19696.70454943177, 19845.702314465296, 19867.105980230925, 19897.403077907686, 21018.369448916557, 8736.388452808242, 9341.252699784001, 9365.953170234105, 9366.2038726709, 9485.952570237105, 4764.642651801059, 4812.614990800727, 4832.178529649968, 4876.926846097312, 4927.630427717935, 3706.4255040468233, 3811.504504414464, 3826.598207188261, 3828.674562662205, 3832.080300727805, 648.251269783401, 659.4032400677298, 659.4691273524859, 659.7624855052273, 663.9070530125787, 739.548875186136, 790.814158672723, 798.5767543202112, 803.1727320859524, 815.9061707903667, 9571.28215383849, 9642.084002019797, 9782.315237933277, 9824.459654718916, 9905.950470247602, 606.7724603273772, 621.9751209951552, 637.7480895046524, 717.6949796336536, 743.5907659184204, 4662.557057079572, 4684.695494792896, 4737.526247375304, 4757.381540399795, 4835.395575553056, 68432.0, 109475.0, 109995.45002275097, 111550.0, 112143.4392828047, 98216.0, 98945.50527247318, 99907.0, 100138.0, 100447.49776251071, 72614.63692681503, 84692.0, 85137.0, 88581.0, 89270.55364723265, 9302.534873256445, 9353.20497757671, 9368.531573421438, 9411.928887205313, 9526.666566670134, 46511.0, 47670.0, 52863.73568132135, 54003.72998134984, 54846.0, 59112.11331830112, 59964.301606428686, 76346.23653763391, 77281.0, 77457.0, 12808.551700690432, 12881.291528965998, 13325.267110308638, 13466.0, 13620.591382258548, 15012.849871501581, 15024.549263522113, 15740.68518629644, 15753.606159845636, 15972.041677499386, 14645.414183432544, 14818.62953426173, 14984.700305994038, 15252.847471525143, 15747.370105195663, 13985.720285594027, 14018.299085045503, 14309.35607897668, 14429.711405772036, 15152.621184470476, 14617.853821462075, 14652.12087274767, 14722.263886805831, 15566.766498502759, 15584.298706558458, 12076.637700868989, 12245.427940750478, 12592.181508201938, 12641.431135599105, 12764.68088297763, 12064.396780160781, 12393.938030309791, 12455.0, 12683.302418367079, 12803.487860485477], "value": 7661.313333471559, "unit": "score"}], "name": "dromaeo_css", "value": 7390.960507588021, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 110.0, 110.0, 112.0, 111.0, 111.0, 111.0, 111.0, 111.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 116.0, 123.0, 192.0, 118.0, 117.0, 140.0, 117.0, 146.0, 118.0], "value": 133.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 160.0, 161.0, 160.0, 158.0, 162.0, 161.0, 161.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 113.0, 74.0, 75.0, 74.0, 73.0, 98.0, 74.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 121.0, 84.0, 84.0, 83.0, 114.0, 84.0, 84.0, 121.0], "value": 94.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 52.0, 52.0, 51.0, 53.0, 53.0, 53.0, 52.0, 52.0], "value": 52.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 61.0, 63.0, 62.0, 61.0, 62.0, 61.0, 62.0, 61.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 75.0, 75.0, 73.0, 82.0, 75.0, 74.0, 74.0, 76.0, 83.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 117.0, 116.0, 117.0, 116.0, 118.0, 133.0, 117.0, 194.0, 120.0], "value": 128.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 153.0, 158.0, 159.0, 154.0, 156.0, 152.0, 155.0, 151.0, 155.0], "value": 154.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 69.0, 65.0, 61.0, 62.0, 61.0, 61.0, 62.0, 63.0], "value": 63.3, "unit": "score"}], "name": "kraken", "value": 1473.2, "alertThreshold": 2.0}]} 07:56:50 INFO - Return code: 0 07:56:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:56:50 INFO - # TBPL SUCCESS # 07:56:50 INFO - Running post-action listener: _resource_record_post_action 07:56:50 INFO - ##### 07:56:50 INFO - ##### Finished run-tests step (success) 07:56:50 INFO - ##### 07:56:50 INFO - Running post-run listener: _resource_record_post_run 07:56:50 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 155648; Write bytes: 299737088; Read time: 204; Write time: 177692 07:56:50 INFO - TinderboxPrint: CPU usage
12.9% 07:56:50 INFO - TinderboxPrint: I/O read bytes / time
155,648 / 204 07:56:50 INFO - TinderboxPrint: I/O write bytes / time
299,737,088 / 177,692 07:56:50 INFO - TinderboxPrint: CPU idle
8,273.7 (87.0%) 07:56:50 INFO - TinderboxPrint: CPU user
1,191.8 (12.5%) 07:56:50 INFO - TinderboxPrint: Swap in / out
0 / 0 07:56:50 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 5210112; Read time: 0; Write time: 372 07:56:50 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 147456; Write bytes: 294526976; Read time: 180; Write time: 177320 07:56:50 INFO - Running post-run listener: _upload_blobber_files 07:56:50 INFO - Blob upload gear active. 07:56:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:56:50 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:56:50 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:56:50 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:56:51 INFO - (blobuploader) - INFO - Open directory for files ... 07:56:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:56:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:56:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:55 INFO - (blobuploader) - INFO - Done attempting. 07:56:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:56:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:56:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:55 INFO - (blobuploader) - INFO - Done attempting. 07:56:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:56:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:56:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:56 INFO - (blobuploader) - INFO - Done attempting. 07:56:56 INFO - (blobuploader) - INFO - Iteration through files over. 07:56:56 INFO - Return code: 0 07:56:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:56:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:56:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e36d80ee5718ed0dacfd771ae6eb052a106f4b94c0b33c7aae9155975e47ea0e3cf0ce79173e58176724afda998a847ec5f36393bcfd6c418612dd9516918a6e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c0f5188ba103b5636b1dc09664a49685c26fa18b9d8119d7da52b03da2240df47cb69da4700226c43c9aed52fb3be4108358e15788affb9384d38ed5ed31e6f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fc8621e41554ae3eb5ea61f07d91a0c50b8045ec5caed9daeb6337a1d229a85faad6325cd93ba5eade917a7260ccf32c2cd505c03567473e0782a9fe20987d0"} 07:56:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:56:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:56:56 INFO - Contents: 07:56:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e36d80ee5718ed0dacfd771ae6eb052a106f4b94c0b33c7aae9155975e47ea0e3cf0ce79173e58176724afda998a847ec5f36393bcfd6c418612dd9516918a6e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c0f5188ba103b5636b1dc09664a49685c26fa18b9d8119d7da52b03da2240df47cb69da4700226c43c9aed52fb3be4108358e15788affb9384d38ed5ed31e6f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fc8621e41554ae3eb5ea61f07d91a0c50b8045ec5caed9daeb6337a1d229a85faad6325cd93ba5eade917a7260ccf32c2cd505c03567473e0782a9fe20987d0"} 07:56:56 INFO - Running post-run listener: copy_logs_to_upload_dir 07:56:56 INFO - Copying logs to upload dir... 07:56:56 INFO - mkdir: /builds/slave/test/build/upload/logs 07:56:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.605206 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-15 07:56:56.650776) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 07:56:56.654683) ========= 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=03627c79f6bb3d1578c4a402000001ba-1468592163.765302-177079187 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e36d80ee5718ed0dacfd771ae6eb052a106f4b94c0b33c7aae9155975e47ea0e3cf0ce79173e58176724afda998a847ec5f36393bcfd6c418612dd9516918a6e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c0f5188ba103b5636b1dc09664a49685c26fa18b9d8119d7da52b03da2240df47cb69da4700226c43c9aed52fb3be4108358e15788affb9384d38ed5ed31e6f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fc8621e41554ae3eb5ea61f07d91a0c50b8045ec5caed9daeb6337a1d229a85faad6325cd93ba5eade917a7260ccf32c2cd505c03567473e0782a9fe20987d0"} build_url:https://queue.taskcluster.net/v1/task/AeKnLAWLTt2AXK4wg48S7w/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/AeKnLAWLTt2AXK4wg48S7w/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/Firefox/sha512/e36d80ee5718ed0dacfd771ae6eb052a106f4b94c0b33c7aae9155975e47ea0e3cf0ce79173e58176724afda998a847ec5f36393bcfd6c418612dd9516918a6e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c0f5188ba103b5636b1dc09664a49685c26fa18b9d8119d7da52b03da2240df47cb69da4700226c43c9aed52fb3be4108358e15788affb9384d38ed5ed31e6f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fc8621e41554ae3eb5ea61f07d91a0c50b8045ec5caed9daeb6337a1d229a85faad6325cd93ba5eade917a7260ccf32c2cd505c03567473e0782a9fe20987d0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 07:56:56.680328) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 07:56:56.680641) ========= 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=03627c79f6bb3d1578c4a402000001ba-1468592163.765302-177079187 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004390 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 07:56:56.764010) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 07:56:56.764327) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 07:56:56.764620) ========= ========= Total master_lag: 0.31 =========