builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-048 starttime: 1467829636.82 results: success (0) buildid: 20160706101143 builduid: ee359ac03b0f4b72828703fee84e8bc6 revision: 372bb24e7acdd5d5baeaa548decc1f9a5c5504ba ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 11:27:16.815899) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 11:27:16.816392) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 11:27:16.816735) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 11:27:16.832901) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 11:27:16.833299) ========= 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=fa44defc139c4ba8574fe040000001db-1467829623.222370-406378999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-06 11:27:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 65.7M=0s 2016-07-06 11:27:17 (65.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109551 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 11:27:16.957477) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 11:27:16.957851) ========= 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=fa44defc139c4ba8574fe040000001db-1467829623.222370-406378999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019657 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 11:27:17.007638) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 11:27:17.008019) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 372bb24e7acdd5d5baeaa548decc1f9a5c5504ba --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 372bb24e7acdd5d5baeaa548decc1f9a5c5504ba --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=fa44defc139c4ba8574fe040000001db-1467829623.222370-406378999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-06 11:27:17,301 truncating revision to first 12 chars 2016-07-06 11:27:17,301 Setting DEBUG logging. 2016-07-06 11:27:17,301 attempt 1/10 2016-07-06 11:27:17,302 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/372bb24e7acd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-06 11:27:17,604 unpacking tar archive at: autoland-372bb24e7acd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.702194 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 11:27:17.729586) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 11:27:17.729889) ========= script_repo_revision: 372bb24e7acdd5d5baeaa548decc1f9a5c5504ba ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 11:27:17.730312) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 11:27:17.730603) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 11:27:17.744138) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-07-06 11:27:17.744455) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1467829623.222370-406378999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:27:18 INFO - MultiFileLogger online at 20160706 11:27:18 in /builds/slave/test 11:27:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 11:27:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:27:18 INFO - {'append_to_log': False, 11:27:18 INFO - 'base_work_dir': '/builds/slave/test', 11:27:18 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 11:27:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:27:18 INFO - 'branch': 'Autoland-Non-PGO', 11:27:18 INFO - 'buildbot_json_path': 'buildprops.json', 11:27:18 INFO - 'config_files': ('talos/linux_config.py',), 11:27:18 INFO - 'default_actions': ('clobber', 11:27:18 INFO - 'read-buildbot-config', 11:27:18 INFO - 'download-and-extract', 11:27:18 INFO - 'populate-webroot', 11:27:18 INFO - 'create-virtualenv', 11:27:18 INFO - 'install', 11:27:18 INFO - 'run-tests'), 11:27:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:27:18 INFO - 'download_minidump_stackwalk': True, 11:27:18 INFO - 'download_symbols': 'ondemand', 11:27:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:27:18 INFO - 'tooltool.py': '/tools/tooltool.py', 11:27:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:27:18 INFO - '/tools/misc-python/virtualenv.py')}, 11:27:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:27:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:27:18 INFO - 'installer_path': 'installer.exe', 11:27:18 INFO - 'log_level': 'info', 11:27:18 INFO - 'log_name': 'talos', 11:27:18 INFO - 'log_to_console': True, 11:27:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:27:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:27:18 INFO - 'opt_config_files': (), 11:27:18 INFO - 'pip_index': False, 11:27:18 INFO - 'sps_profile': False, 11:27:18 INFO - 'sps_profile_interval': 0, 11:27:18 INFO - 'suite': 'dromaeojs', 11:27:18 INFO - 'system_bits': '32', 11:27:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:27:18 INFO - 'title': 'talos-linux64-ix-048', 11:27:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:27:18 INFO - 'use_talos_json': True, 11:27:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:27:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:27:18 INFO - 'work_dir': 'build'} 11:27:18 INFO - ##### 11:27:18 INFO - ##### Running clobber step. 11:27:18 INFO - ##### 11:27:18 INFO - Running pre-action listener: _resource_record_pre_action 11:27:18 INFO - Running main action method: clobber 11:27:18 INFO - rmtree: /builds/slave/test/build 11:27:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:27:18 INFO - Running post-action listener: _resource_record_post_action 11:27:18 INFO - ##### 11:27:18 INFO - ##### Finished clobber step (success) 11:27:18 INFO - ##### 11:27:18 INFO - ##### 11:27:18 INFO - ##### Running read-buildbot-config step. 11:27:18 INFO - ##### 11:27:18 INFO - Running pre-action listener: _resource_record_pre_action 11:27:18 INFO - Running main action method: read_buildbot_config 11:27:18 INFO - Using buildbot properties: 11:27:18 INFO - { 11:27:18 INFO - "project": "", 11:27:18 INFO - "product": "firefox", 11:27:18 INFO - "script_repo_revision": "production", 11:27:18 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 11:27:18 INFO - "repository": "", 11:27:18 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 11:27:18 INFO - "buildid": "20160706101143", 11:27:18 INFO - "pgo_build": "False", 11:27:18 INFO - "basedir": "/builds/slave/test", 11:27:18 INFO - "buildnumber": 28, 11:27:18 INFO - "slavename": "talos-linux64-ix-048", 11:27:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:27:18 INFO - "platform": "ubuntu64_hw", 11:27:18 INFO - "scheduler": "tests-autoland-linux64-talos", 11:27:18 INFO - "branch": "autoland", 11:27:18 INFO - "repo_path": "integration/autoland", 11:27:18 INFO - "revision": "372bb24e7acdd5d5baeaa548decc1f9a5c5504ba", 11:27:18 INFO - "stage_platform": "linux64", 11:27:18 INFO - "builduid": "ee359ac03b0f4b72828703fee84e8bc6", 11:27:18 INFO - "slavebuilddir": "test" 11:27:18 INFO - } 11:27:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZIDZC_w1R3OuBUR55IjKOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 11:27:18 INFO - Running post-action listener: _resource_record_post_action 11:27:18 INFO - ##### 11:27:18 INFO - ##### Finished read-buildbot-config step (success) 11:27:18 INFO - ##### 11:27:18 INFO - ##### 11:27:18 INFO - ##### Running download-and-extract step. 11:27:18 INFO - ##### 11:27:18 INFO - Running pre-action listener: _resource_record_pre_action 11:27:18 INFO - Running main action method: download_and_extract 11:27:18 INFO - mkdir: /builds/slave/test/build/tests 11:27:18 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')]} 11:27:18 INFO - https://queue.taskcluster.net/v1/task/ZIDZC_w1R3OuBUR55IjKOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:27:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIDZC_w1R3OuBUR55IjKOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:27:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIDZC_w1R3OuBUR55IjKOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:27:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIDZC_w1R3OuBUR55IjKOQ/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 11:27:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIDZC_w1R3OuBUR55IjKOQ/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 11:27:31 INFO - Downloaded 1361 bytes. 11:27:31 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:27:31 INFO - Using the following test package requirements: 11:27:31 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:27:31 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:27:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:27:31 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:27:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:27:31 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:27:31 INFO - u'jsshell-linux-x86_64.zip'], 11:27:31 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:27:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:27:31 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:27:31 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:27:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:27:31 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:27:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:27:31 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:27:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:27:31 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:27:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:27:31 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:27:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:31 INFO - https://queue.taskcluster.net/v1/task/ZIDZC_w1R3OuBUR55IjKOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:27:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIDZC_w1R3OuBUR55IjKOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:27:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIDZC_w1R3OuBUR55IjKOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:27:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIDZC_w1R3OuBUR55IjKOQ/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 11:27:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIDZC_w1R3OuBUR55IjKOQ/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 11:27:43 INFO - Downloaded 22733072 bytes. 11:27:43 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'] 11:27:43 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 11:27:45 INFO - Return code: 0 11:27:45 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 11:27:45 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')]} 11:27:45 INFO - https://queue.taskcluster.net/v1/task/ZIDZC_w1R3OuBUR55IjKOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:27:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIDZC_w1R3OuBUR55IjKOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:27:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIDZC_w1R3OuBUR55IjKOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:27:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIDZC_w1R3OuBUR55IjKOQ/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 11:27:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIDZC_w1R3OuBUR55IjKOQ/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 11:27:46 INFO - Downloaded 22733072 bytes. 11:27:46 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'] 11:27:46 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 11:27:47 INFO - Return code: 0 11:27: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')]} 11:27:47 INFO - https://queue.taskcluster.net/v1/task/ZIDZC_w1R3OuBUR55IjKOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:27:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIDZC_w1R3OuBUR55IjKOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:27:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIDZC_w1R3OuBUR55IjKOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:27:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIDZC_w1R3OuBUR55IjKOQ/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 11:27:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIDZC_w1R3OuBUR55IjKOQ/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 11:27:48 INFO - Downloaded 14403333 bytes. 11:27:48 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'] 11:27:48 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 11:27:48 INFO - Return code: 0 11:27:48 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')]} 11:27:48 INFO - https://queue.taskcluster.net/v1/task/ZIDZC_w1R3OuBUR55IjKOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:27:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIDZC_w1R3OuBUR55IjKOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:27:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIDZC_w1R3OuBUR55IjKOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:27:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIDZC_w1R3OuBUR55IjKOQ/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 11:27:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIDZC_w1R3OuBUR55IjKOQ/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 11:27:50 INFO - Downloaded 56603019 bytes. 11:27:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZIDZC_w1R3OuBUR55IjKOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:27:50 INFO - mkdir: /builds/slave/test/properties 11:27:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:27:50 INFO - Writing to file /builds/slave/test/properties/build_url 11:27:50 INFO - Contents: 11:27:50 INFO - build_url:https://queue.taskcluster.net/v1/task/ZIDZC_w1R3OuBUR55IjKOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:27:51 INFO - Running post-action listener: _resource_record_post_action 11:27:51 INFO - Running post-action listener: set_extra_try_arguments 11:27:51 INFO - ##### 11:27:51 INFO - ##### Finished download-and-extract step (success) 11:27:51 INFO - ##### 11:27:51 INFO - ##### 11:27:51 INFO - ##### Running populate-webroot step. 11:27:51 INFO - ##### 11:27:51 INFO - Running pre-action listener: _resource_record_pre_action 11:27:51 INFO - Running main action method: populate_webroot 11:27:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:27:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:27:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:27:51 INFO - '--tppagecycles', 11:27:51 INFO - '7'], 11:27:51 INFO - 'tests': ['tsvgm']}}, 11:27:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:27:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:27:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:27:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:27:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:27:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:27:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:27:51 INFO - 'talos_options': ['--disable-e10s'], 11:27:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:27:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:27:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:27:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:27:51 INFO - 'talos_options': ['--disable-e10s'], 11:27:51 INFO - 'tests': ['damp', 'tps']}, 11:27:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:27:51 INFO - 'tests': ['damp', 'tps']}, 11:27:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:27:51 INFO - 'tests': ['dromaeo_dom']}, 11:27:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:27:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:27:51 INFO - 'tests': ['basic_compositor_video']}, 11:27:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:27:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:27:51 INFO - 'tests': ['a11yr', 11:27:51 INFO - 'ts_paint', 11:27:51 INFO - 'tpaint', 11:27:51 INFO - 'sessionrestore', 11:27:51 INFO - 'sessionrestore_no_auto_restore', 11:27:51 INFO - 'tabpaint']}, 11:27:51 INFO - 'other-e10s': {'tests': ['a11yr', 11:27:51 INFO - 'ts_paint', 11:27:51 INFO - 'tpaint', 11:27:51 INFO - 'sessionrestore', 11:27:51 INFO - 'sessionrestore_no_auto_restore', 11:27:51 INFO - 'tabpaint']}, 11:27:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:27:51 INFO - 'ts_paint', 11:27:51 INFO - 'tpaint', 11:27:51 INFO - 'sessionrestore', 11:27:51 INFO - 'sessionrestore_no_auto_restore', 11:27:51 INFO - 'tabpaint']}, 11:27:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:27:51 INFO - 'ts_paint', 11:27:51 INFO - 'tpaint', 11:27:51 INFO - 'sessionrestore', 11:27:51 INFO - 'sessionrestore_no_auto_restore', 11:27:51 INFO - 'tabpaint']}, 11:27:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:27:51 INFO - 'tests': ['a11yr', 11:27:51 INFO - 'ts_paint', 11:27:51 INFO - 'tpaint', 11:27:51 INFO - 'sessionrestore', 11:27:51 INFO - 'sessionrestore_no_auto_restore', 11:27:51 INFO - 'tabpaint']}, 11:27:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:27:51 INFO - 'tests': ['a11yr', 11:27:51 INFO - 'ts_paint', 11:27:51 INFO - 'tpaint', 11:27:51 INFO - 'sessionrestore', 11:27:51 INFO - 'sessionrestore_no_auto_restore', 11:27:51 INFO - 'tabpaint']}, 11:27:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:27:51 INFO - 'tests': ['tsvgx', 11:27:51 INFO - 'tsvgr_opacity', 11:27:51 INFO - 'tart', 11:27:51 INFO - 'tscrollx', 11:27:51 INFO - 'cart']}, 11:27:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:27:51 INFO - 'tsvgr_opacity', 11:27:51 INFO - 'tart', 11:27:51 INFO - 'tscrollx', 11:27:51 INFO - 'cart']}, 11:27:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:27:51 INFO - 'talos_options': ['--disable-e10s'], 11:27:51 INFO - 'tests': ['tp5o']}, 11:27:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:27:51 INFO - 'tests': ['tp5o']}, 11:27:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:27:51 INFO - 'talos_options': ['--disable-e10s', 11:27:51 INFO - '--xperf_path', 11:27:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:27:51 INFO - 'tests': ['tp5n']}, 11:27:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:27:51 INFO - 'talos_options': ['--xperf_path', 11:27:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:27:51 INFO - 'tests': ['tp5n']}}, 11:27:51 INFO - 'talos.zip': {'path': '', 11:27:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:27:51 INFO - Running post-action listener: _resource_record_post_action 11:27:51 INFO - ##### 11:27:51 INFO - ##### Finished populate-webroot step (success) 11:27:51 INFO - ##### 11:27:51 INFO - ##### 11:27:51 INFO - ##### Running create-virtualenv step. 11:27:51 INFO - ##### 11:27:51 INFO - Running pre-action listener: _resource_record_pre_action 11:27:51 INFO - Running main action method: create_virtualenv 11:27:51 INFO - Creating virtualenv /builds/slave/test/build/venv 11:27:51 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 11:27:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:27:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:27:51 INFO - Using real prefix '/usr' 11:27:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:27:52 INFO - Installing distribute.............................................................................................................................................................................................done. 11:27:54 INFO - Installing pip.................done. 11:27:54 INFO - Return code: 0 11:27:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:27: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')]} 11:27:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27: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')]} 11:27:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:54 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 0x1c4a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f0b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f093b0>, '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 0x1f0a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0a740>, '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': 'fa44defc139c4ba8574fe040000001db-1467829623.222370-406378999', '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 11:27:54 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 11:27:54 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 11:27:54 INFO - Using env: {'DISPLAY': ':0', 11:27:54 INFO - 'HOME': '/home/cltbld', 11:27:54 INFO - 'LANG': 'en_US.UTF-8', 11:27:54 INFO - 'LANGUAGE': 'en_US:en', 11:27:54 INFO - 'LOGNAME': 'cltbld', 11:27:54 INFO - 'MAIL': '/var/mail/cltbld', 11:27:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:54 INFO - 'MOZ_NO_REMOTE': '1', 11:27:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:54 INFO - 'NO_EM_RESTART': '1', 11:27:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:54 INFO - 'PWD': '/builds/slave/test', 11:27:54 INFO - 'SHELL': '/bin/bash', 11:27:54 INFO - 'SHLVL': '1', 11:27:54 INFO - 'TERM': 'linux', 11:27:54 INFO - 'TMOUT': '86400', 11:27:54 INFO - 'USER': 'cltbld', 11:27:54 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467829623.222370-406378999', 11:27:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:54 INFO - '_': '/tools/buildbot/bin/python'} 11:27:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:54 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 11:27:54 INFO - Cleaning up... 11:27:54 INFO - Return code: 0 11:27:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:27: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')]} 11:27:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27: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')]} 11:27:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:54 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 0x1c4a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f0b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f093b0>, '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 0x1f0a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0a740>, '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': 'fa44defc139c4ba8574fe040000001db-1467829623.222370-406378999', '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 11:27:54 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 11:27:54 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 11:27:54 INFO - Using env: {'DISPLAY': ':0', 11:27:54 INFO - 'HOME': '/home/cltbld', 11:27:54 INFO - 'LANG': 'en_US.UTF-8', 11:27:54 INFO - 'LANGUAGE': 'en_US:en', 11:27:54 INFO - 'LOGNAME': 'cltbld', 11:27:54 INFO - 'MAIL': '/var/mail/cltbld', 11:27:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:54 INFO - 'MOZ_NO_REMOTE': '1', 11:27:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:54 INFO - 'NO_EM_RESTART': '1', 11:27:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:54 INFO - 'PWD': '/builds/slave/test', 11:27:54 INFO - 'SHELL': '/bin/bash', 11:27:54 INFO - 'SHLVL': '1', 11:27:54 INFO - 'TERM': 'linux', 11:27:54 INFO - 'TMOUT': '86400', 11:27:54 INFO - 'USER': 'cltbld', 11:27:54 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467829623.222370-406378999', 11:27:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:54 INFO - '_': '/tools/buildbot/bin/python'} 11:27:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:54 INFO - Downloading/unpacking psutil>=3.1.1 11:27:54 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 11:27:54 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 11:27:54 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 11:27:54 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 11:27:54 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 11:27:54 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 11:27:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:27:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:27:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:27:56 INFO - Installing collected packages: psutil 11:27:56 INFO - Running setup.py install for psutil 11:27:56 INFO - building 'psutil._psutil_linux' extension 11:27:56 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 11:27:56 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 11:27:56 INFO - building 'psutil._psutil_posix' extension 11:27:56 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 11:27:57 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 11:27:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:27:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:27:57 INFO - Successfully installed psutil 11:27:57 INFO - Cleaning up... 11:27:57 INFO - Return code: 0 11:27:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:27:57 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')]} 11:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:57 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')]} 11:27:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:57 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 0x1c4a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f0b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f093b0>, '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 0x1f0a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0a740>, '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': 'fa44defc139c4ba8574fe040000001db-1467829623.222370-406378999', '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 11:27:57 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 11:27:57 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 11:27:57 INFO - Using env: {'DISPLAY': ':0', 11:27:57 INFO - 'HOME': '/home/cltbld', 11:27:57 INFO - 'LANG': 'en_US.UTF-8', 11:27:57 INFO - 'LANGUAGE': 'en_US:en', 11:27:57 INFO - 'LOGNAME': 'cltbld', 11:27:57 INFO - 'MAIL': '/var/mail/cltbld', 11:27:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:57 INFO - 'MOZ_NO_REMOTE': '1', 11:27:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:57 INFO - 'NO_EM_RESTART': '1', 11:27:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:57 INFO - 'PWD': '/builds/slave/test', 11:27:57 INFO - 'SHELL': '/bin/bash', 11:27:57 INFO - 'SHLVL': '1', 11:27:57 INFO - 'TERM': 'linux', 11:27:57 INFO - 'TMOUT': '86400', 11:27:57 INFO - 'USER': 'cltbld', 11:27:57 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467829623.222370-406378999', 11:27:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:57 INFO - '_': '/tools/buildbot/bin/python'} 11:27:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:27:57 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 11:27:57 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 11:27:57 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 11:27:57 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 11:27:57 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 11:27:57 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 11:27:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:27:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:27:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:27:59 INFO - Installing collected packages: mozsystemmonitor 11:27:59 INFO - Running setup.py install for mozsystemmonitor 11:27:59 INFO - Successfully installed mozsystemmonitor 11:27:59 INFO - Cleaning up... 11:27:59 INFO - Return code: 0 11:27:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:27:59 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')]} 11:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:59 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')]} 11:27:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:59 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 0x1c4a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f0b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f093b0>, '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 0x1f0a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0a740>, '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': 'fa44defc139c4ba8574fe040000001db-1467829623.222370-406378999', '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 11:27:59 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 11:27:59 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 11:27:59 INFO - Using env: {'DISPLAY': ':0', 11:27:59 INFO - 'HOME': '/home/cltbld', 11:27:59 INFO - 'LANG': 'en_US.UTF-8', 11:27:59 INFO - 'LANGUAGE': 'en_US:en', 11:27:59 INFO - 'LOGNAME': 'cltbld', 11:27:59 INFO - 'MAIL': '/var/mail/cltbld', 11:27:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:59 INFO - 'MOZ_NO_REMOTE': '1', 11:27:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:59 INFO - 'NO_EM_RESTART': '1', 11:27:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:59 INFO - 'PWD': '/builds/slave/test', 11:27:59 INFO - 'SHELL': '/bin/bash', 11:27:59 INFO - 'SHLVL': '1', 11:27:59 INFO - 'TERM': 'linux', 11:27:59 INFO - 'TMOUT': '86400', 11:27:59 INFO - 'USER': 'cltbld', 11:27:59 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467829623.222370-406378999', 11:27:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:59 INFO - '_': '/tools/buildbot/bin/python'} 11:27:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:59 INFO - Downloading/unpacking jsonschema==2.5.1 11:27:59 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 11:27:59 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 11:27:59 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 11:27:59 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 11:27:59 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 11:27:59 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 11:28:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:28:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:28:01 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 11:28:01 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 11:28:01 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 11:28:01 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 11:28:01 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 11:28:01 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 11:28:01 INFO - Downloading functools32-3.2.3-2.tar.gz 11:28:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:28:01 INFO - warning: no files found matching '*.txt' 11:28:01 INFO - no previously-included directories found matching 'build' 11:28:01 INFO - no previously-included directories found matching 'dist' 11:28:01 INFO - no previously-included directories found matching '.git*' 11:28:01 INFO - Installing collected packages: jsonschema, functools32 11:28:02 INFO - Running setup.py install for functools32 11:28:02 INFO - warning: no files found matching '*.txt' 11:28:02 INFO - no previously-included directories found matching 'build' 11:28:02 INFO - no previously-included directories found matching 'dist' 11:28:02 INFO - no previously-included directories found matching '.git*' 11:28:02 INFO - Successfully installed jsonschema functools32 11:28:02 INFO - Cleaning up... 11:28:02 INFO - Return code: 0 11:28:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:28:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:28:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:28:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:28:02 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 0x1c4a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f0b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f093b0>, '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 0x1f0a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0a740>, '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': 'fa44defc139c4ba8574fe040000001db-1467829623.222370-406378999', '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 11:28:02 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 11:28:02 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 11:28:02 INFO - Using env: {'DISPLAY': ':0', 11:28:02 INFO - 'HOME': '/home/cltbld', 11:28:02 INFO - 'LANG': 'en_US.UTF-8', 11:28:02 INFO - 'LANGUAGE': 'en_US:en', 11:28:02 INFO - 'LOGNAME': 'cltbld', 11:28:02 INFO - 'MAIL': '/var/mail/cltbld', 11:28:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:02 INFO - 'MOZ_NO_REMOTE': '1', 11:28:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:02 INFO - 'NO_EM_RESTART': '1', 11:28:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:02 INFO - 'PWD': '/builds/slave/test', 11:28:02 INFO - 'SHELL': '/bin/bash', 11:28:02 INFO - 'SHLVL': '1', 11:28:02 INFO - 'TERM': 'linux', 11:28:02 INFO - 'TMOUT': '86400', 11:28:02 INFO - 'USER': 'cltbld', 11:28:02 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467829623.222370-406378999', 11:28:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:02 INFO - '_': '/tools/buildbot/bin/python'} 11:28:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:02 INFO - Downloading/unpacking blobuploader==1.2.4 11:28:02 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 11:28:02 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 11:28:02 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 11:28:02 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 11:28:02 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 11:28:02 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 11:28:04 INFO - Downloading blobuploader-1.2.4.tar.gz 11:28:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:28:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:28:04 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 11:28:04 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 11:28:04 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 11:28:04 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 11:28:04 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 11:28:04 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 11:28:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:28:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:28:04 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 11:28:04 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 11:28:04 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 11:28:04 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 11:28:04 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 11:28:04 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 11:28:05 INFO - Downloading docopt-0.6.1.tar.gz 11:28:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:28:05 INFO - Installing collected packages: blobuploader, requests, docopt 11:28:05 INFO - Running setup.py install for blobuploader 11:28:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:28:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:28:05 INFO - Running setup.py install for requests 11:28:05 INFO - Running setup.py install for docopt 11:28:05 INFO - Successfully installed blobuploader requests docopt 11:28:05 INFO - Cleaning up... 11:28:05 INFO - Return code: 0 11:28:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:28:05 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')]} 11:28:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:28:05 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')]} 11:28:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:28:05 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 0x1c4a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f0b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f093b0>, '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 0x1f0a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0a740>, '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': 'fa44defc139c4ba8574fe040000001db-1467829623.222370-406378999', '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 11:28:05 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 11:28:05 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 11:28:05 INFO - Using env: {'DISPLAY': ':0', 11:28:05 INFO - 'HOME': '/home/cltbld', 11:28:05 INFO - 'LANG': 'en_US.UTF-8', 11:28:05 INFO - 'LANGUAGE': 'en_US:en', 11:28:05 INFO - 'LOGNAME': 'cltbld', 11:28:05 INFO - 'MAIL': '/var/mail/cltbld', 11:28:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:05 INFO - 'MOZ_NO_REMOTE': '1', 11:28:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:05 INFO - 'NO_EM_RESTART': '1', 11:28:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:05 INFO - 'PWD': '/builds/slave/test', 11:28:05 INFO - 'SHELL': '/bin/bash', 11:28:05 INFO - 'SHLVL': '1', 11:28:05 INFO - 'TERM': 'linux', 11:28:05 INFO - 'TMOUT': '86400', 11:28:05 INFO - 'USER': 'cltbld', 11:28:05 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467829623.222370-406378999', 11:28:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:05 INFO - '_': '/tools/buildbot/bin/python'} 11:28:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:28:05 INFO - Running setup.py (path:/tmp/pip-pGUIhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:28:05 INFO - Running setup.py (path:/tmp/pip-fpqzwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:28:06 INFO - Running setup.py (path:/tmp/pip-I8plBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:28:06 INFO - Running setup.py (path:/tmp/pip-Mf3lad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:28:06 INFO - Running setup.py (path:/tmp/pip-pWp028-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:28:06 INFO - Running setup.py (path:/tmp/pip-3I7TEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:28:06 INFO - Running setup.py (path:/tmp/pip-yocaBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:28:06 INFO - Running setup.py (path:/tmp/pip-9z7dju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:28:06 INFO - Running setup.py (path:/tmp/pip-jiRcz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:28:06 INFO - Running setup.py (path:/tmp/pip-PUVC01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:28:06 INFO - Running setup.py (path:/tmp/pip-KBm9s4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:28:06 INFO - Running setup.py (path:/tmp/pip-Yd4ES8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:28:06 INFO - Running setup.py (path:/tmp/pip-YDHi9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:28:06 INFO - Running setup.py (path:/tmp/pip-BYF2P9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:28:06 INFO - Running setup.py (path:/tmp/pip-bnTLpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:28:06 INFO - Running setup.py (path:/tmp/pip-D9HD6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:28:07 INFO - Running setup.py (path:/tmp/pip-uc01ag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:28:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:28:07 INFO - Running setup.py install for manifestparser 11:28:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:28:07 INFO - Running setup.py install for mozcrash 11:28:07 INFO - Running setup.py install for mozdebug 11:28:07 INFO - Running setup.py install for mozdevice 11:28:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:28:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:28:07 INFO - Running setup.py install for mozfile 11:28:07 INFO - Running setup.py install for mozhttpd 11:28:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:28:07 INFO - Running setup.py install for mozinfo 11:28:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:28:07 INFO - Running setup.py install for mozInstall 11:28:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:28:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:28:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:28:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:28:07 INFO - Running setup.py install for mozleak 11:28:08 INFO - Running setup.py install for mozlog 11:28:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:28:08 INFO - Running setup.py install for moznetwork 11:28:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:28:08 INFO - Running setup.py install for mozprocess 11:28:08 INFO - Running setup.py install for mozprofile 11:28:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:28:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:28:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:28:08 INFO - Running setup.py install for mozrunner 11:28:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:28:08 INFO - Running setup.py install for mozscreenshot 11:28:08 INFO - Running setup.py install for moztest 11:28:08 INFO - Running setup.py install for mozversion 11:28:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:28:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:28:08 INFO - Cleaning up... 11:28:08 INFO - Return code: 0 11:28:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:28:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:28:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:28:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:28:08 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 0x1c4a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f0b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f093b0>, '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 0x1f0a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0a740>, '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': 'fa44defc139c4ba8574fe040000001db-1467829623.222370-406378999', '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 11:28:08 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 11:28:08 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 11:28:08 INFO - Using env: {'DISPLAY': ':0', 11:28:08 INFO - 'HOME': '/home/cltbld', 11:28:08 INFO - 'LANG': 'en_US.UTF-8', 11:28:08 INFO - 'LANGUAGE': 'en_US:en', 11:28:08 INFO - 'LOGNAME': 'cltbld', 11:28:08 INFO - 'MAIL': '/var/mail/cltbld', 11:28:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:08 INFO - 'MOZ_NO_REMOTE': '1', 11:28:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:08 INFO - 'NO_EM_RESTART': '1', 11:28:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:08 INFO - 'PWD': '/builds/slave/test', 11:28:08 INFO - 'SHELL': '/bin/bash', 11:28:08 INFO - 'SHLVL': '1', 11:28:08 INFO - 'TERM': 'linux', 11:28:08 INFO - 'TMOUT': '86400', 11:28:08 INFO - 'USER': 'cltbld', 11:28:08 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467829623.222370-406378999', 11:28:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:08 INFO - '_': '/tools/buildbot/bin/python'} 11:28:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:28:09 INFO - Running setup.py (path:/tmp/pip-Jr5xJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:28:09 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)) 11:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:28:09 INFO - Running setup.py (path:/tmp/pip-GLGXwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:28:09 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)) 11:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:28:09 INFO - Running setup.py (path:/tmp/pip-ZhRBcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:28:09 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)) 11:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:28:09 INFO - Running setup.py (path:/tmp/pip-AdP1_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:28:09 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)) 11:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:28:09 INFO - Running setup.py (path:/tmp/pip-_Hqylw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:28:09 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)) 11:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:28:09 INFO - Running setup.py (path:/tmp/pip-o630AI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:28:09 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)) 11:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:28:09 INFO - Running setup.py (path:/tmp/pip-p_Dx42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:28:09 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)) 11:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:28:09 INFO - Running setup.py (path:/tmp/pip-1pNoOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:28:09 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)) 11:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:28:09 INFO - Running setup.py (path:/tmp/pip-wzCVuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:28:09 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)) 11:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:28:09 INFO - Running setup.py (path:/tmp/pip-CuIk81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:28:09 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)) 11:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:28:09 INFO - Running setup.py (path:/tmp/pip-NiyP9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:28:09 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)) 11:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:28:09 INFO - Running setup.py (path:/tmp/pip-dUuzry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:28:10 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)) 11:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:28:10 INFO - Running setup.py (path:/tmp/pip-TyeHfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:28:10 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)) 11:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:28:10 INFO - Running setup.py (path:/tmp/pip-_sw1FF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:28:10 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)) 11:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:28:10 INFO - Running setup.py (path:/tmp/pip-WQuRkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:28:10 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)) 11:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:28:10 INFO - Running setup.py (path:/tmp/pip-zRUdAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:28:10 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)) 11:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:28:10 INFO - Running setup.py (path:/tmp/pip-Rdt1DM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:28:10 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)) 11:28:10 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)) 11:28:10 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)) 11:28:10 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)) 11:28:10 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)) 11:28:10 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)) 11:28:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:28:10 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 11:28:10 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 11:28:10 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 11:28:10 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 11:28:10 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 11:28:10 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 11:28:12 INFO - Downloading blessings-1.6.tar.gz 11:28:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:28:12 INFO - Installing collected packages: blessings 11:28:12 INFO - Running setup.py install for blessings 11:28:12 INFO - Successfully installed blessings 11:28:12 INFO - Cleaning up... 11:28:12 INFO - Return code: 0 11:28:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:28:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:28:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:28:12 INFO - Reading from file tmpfile_stdout 11:28:12 INFO - Current package versions: 11:28:12 INFO - argparse == 1.2.1 11:28:12 INFO - blessings == 1.6 11:28:12 INFO - blobuploader == 1.2.4 11:28:12 INFO - docopt == 0.6.1 11:28:12 INFO - functools32 == 3.2.3-2 11:28:12 INFO - jsonschema == 2.5.1 11:28:12 INFO - manifestparser == 1.1 11:28:12 INFO - mozInstall == 1.12 11:28:12 INFO - mozcrash == 0.17 11:28:12 INFO - mozdebug == 0.1 11:28:12 INFO - mozdevice == 0.48 11:28:12 INFO - mozfile == 1.2 11:28:12 INFO - mozhttpd == 0.7 11:28:12 INFO - mozinfo == 0.9 11:28:12 INFO - mozleak == 0.1 11:28:12 INFO - mozlog == 3.2 11:28:12 INFO - moznetwork == 0.27 11:28:12 INFO - mozprocess == 0.23 11:28:12 INFO - mozprofile == 0.28 11:28:12 INFO - mozrunner == 6.12 11:28:12 INFO - mozscreenshot == 0.1 11:28:12 INFO - mozsystemmonitor == 0.3 11:28:12 INFO - moztest == 0.7 11:28:12 INFO - mozversion == 1.4 11:28:12 INFO - psutil == 3.1.1 11:28:12 INFO - requests == 1.2.3 11:28:12 INFO - wsgiref == 0.1.2 11:28:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:28:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:28:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:28:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:28:12 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 0x1c4a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f0b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f093b0>, '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 0x1f0a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0a740>, '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': 'fa44defc139c4ba8574fe040000001db-1467829623.222370-406378999', '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 11:28:12 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 11:28:12 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 11:28:12 INFO - Using env: {'DISPLAY': ':0', 11:28:12 INFO - 'HOME': '/home/cltbld', 11:28:12 INFO - 'LANG': 'en_US.UTF-8', 11:28:12 INFO - 'LANGUAGE': 'en_US:en', 11:28:12 INFO - 'LOGNAME': 'cltbld', 11:28:12 INFO - 'MAIL': '/var/mail/cltbld', 11:28:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:12 INFO - 'MOZ_NO_REMOTE': '1', 11:28:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:12 INFO - 'NO_EM_RESTART': '1', 11:28:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:12 INFO - 'PWD': '/builds/slave/test', 11:28:12 INFO - 'SHELL': '/bin/bash', 11:28:12 INFO - 'SHLVL': '1', 11:28:12 INFO - 'TERM': 'linux', 11:28:12 INFO - 'TMOUT': '86400', 11:28:12 INFO - 'USER': 'cltbld', 11:28:12 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467829623.222370-406378999', 11:28:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:12 INFO - '_': '/tools/buildbot/bin/python'} 11:28:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:12 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)) 11:28:12 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)) 11:28:12 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)) 11:28:12 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)) 11:28:12 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)) 11:28:12 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)) 11:28:12 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)) 11:28:12 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)) 11:28:12 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)) 11:28:12 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)) 11:28:12 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)) 11:28:12 INFO - Cleaning up... 11:28:12 INFO - Return code: 0 11:28:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:28:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:28:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:28:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:28:12 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 0x1c4a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f0b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f093b0>, '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 0x1f0a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0a740>, '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': 'fa44defc139c4ba8574fe040000001db-1467829623.222370-406378999', '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 11:28:12 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 11:28:12 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 11:28:12 INFO - Using env: {'DISPLAY': ':0', 11:28:12 INFO - 'HOME': '/home/cltbld', 11:28:12 INFO - 'LANG': 'en_US.UTF-8', 11:28:12 INFO - 'LANGUAGE': 'en_US:en', 11:28:12 INFO - 'LOGNAME': 'cltbld', 11:28:12 INFO - 'MAIL': '/var/mail/cltbld', 11:28:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:12 INFO - 'MOZ_NO_REMOTE': '1', 11:28:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:12 INFO - 'NO_EM_RESTART': '1', 11:28:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:12 INFO - 'PWD': '/builds/slave/test', 11:28:12 INFO - 'SHELL': '/bin/bash', 11:28:12 INFO - 'SHLVL': '1', 11:28:12 INFO - 'TERM': 'linux', 11:28:12 INFO - 'TMOUT': '86400', 11:28:12 INFO - 'USER': 'cltbld', 11:28:12 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467829623.222370-406378999', 11:28:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:12 INFO - '_': '/tools/buildbot/bin/python'} 11:28:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:28:13 INFO - Cleaning up... 11:28:13 INFO - Return code: 0 11:28:13 INFO - Running post-action listener: _resource_record_post_action 11:28:13 INFO - Running post-action listener: _start_resource_monitoring 11:28:13 INFO - Starting resource monitoring. 11:28:13 INFO - ##### 11:28:13 INFO - ##### Finished create-virtualenv step (success) 11:28:13 INFO - ##### 11:28:13 INFO - ##### 11:28:13 INFO - ##### Running install step. 11:28:13 INFO - ##### 11:28:13 INFO - Running pre-action listener: _resource_record_pre_action 11:28:13 INFO - Running main action method: install 11:28:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:28:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:28:13 INFO - Reading from file tmpfile_stdout 11:28:13 INFO - Detecting whether we're running mozinstall >=1.0... 11:28:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:28:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:28:13 INFO - Reading from file tmpfile_stdout 11:28:13 INFO - Output received: 11:28:13 INFO - Usage: mozinstall [options] installer 11:28:13 INFO - Options: 11:28:13 INFO - -h, --help show this help message and exit 11:28:13 INFO - -d DEST, --destination=DEST 11:28:13 INFO - Directory to install application into. [default: 11:28:13 INFO - "/builds/slave/test"] 11:28:13 INFO - --app=APP Application being installed. [default: firefox] 11:28:13 INFO - mkdir: /builds/slave/test/build/application 11:28:13 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'] 11:28:13 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 11:28:29 INFO - Reading from file tmpfile_stdout 11:28:29 INFO - Output received: 11:28:29 INFO - /builds/slave/test/build/application/firefox/firefox 11:28:29 INFO - Running post-action listener: _resource_record_post_action 11:28:29 INFO - ##### 11:28:29 INFO - ##### Finished install step (success) 11:28:29 INFO - ##### 11:28:29 INFO - ##### 11:28:29 INFO - ##### Running run-tests step. 11:28:29 INFO - ##### 11:28:29 INFO - Running pre-action listener: _resource_record_pre_action 11:28:29 INFO - Running main action method: run_tests 11:28:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:28:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:28:29 INFO - Python 2.7.3 11:28:29 INFO - Return code: 0 11:28:29 INFO - grabbing minidump binary from tooltool 11:28: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')]} 11:28:29 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 0x1f093b0>, '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 0x1f0a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0a740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:28:29 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 11:28:29 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 11:28:29 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 11:28:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:28:29 INFO - Return code: 0 11:28:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:28:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:28:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:28:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:28:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:28:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZIDZC_w1R3OuBUR55IjKOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 11:28:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZIDZC_w1R3OuBUR55IjKOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 11:28:29 INFO - Using env: {'DISPLAY': ':0', 11:28:29 INFO - 'HOME': '/home/cltbld', 11:28:29 INFO - 'LANG': 'en_US.UTF-8', 11:28:29 INFO - 'LANGUAGE': 'en_US:en', 11:28:29 INFO - 'LOGNAME': 'cltbld', 11:28:29 INFO - 'MAIL': '/var/mail/cltbld', 11:28:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:28:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:28:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:29 INFO - 'MOZ_NO_REMOTE': '1', 11:28:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:28:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:29 INFO - 'NO_EM_RESTART': '1', 11:28:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:29 INFO - 'PWD': '/builds/slave/test', 11:28:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:28:29 INFO - 'SHELL': '/bin/bash', 11:28:29 INFO - 'SHLVL': '1', 11:28:29 INFO - 'TERM': 'linux', 11:28:29 INFO - 'TMOUT': '86400', 11:28:29 INFO - 'USER': 'cltbld', 11:28:29 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467829623.222370-406378999', 11:28:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:29 INFO - '_': '/tools/buildbot/bin/python'} 11:28:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZIDZC_w1R3OuBUR55IjKOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 11:28:30 INFO - mozversion application_buildid: 20160706101143 11:28:30 INFO - mozversion application_changeset: 372bb24e7acdd5d5baeaa548decc1f9a5c5504ba 11:28:30 INFO - mozversion application_display_name: Nightly 11:28:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:28:30 INFO - mozversion application_name: Firefox 11:28:30 INFO - mozversion application_remotingname: firefox 11:28:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 11:28:30 INFO - mozversion application_vendor: Mozilla 11:28:30 INFO - mozversion application_version: 50.0a1 11:28:30 INFO - mozversion platform_buildid: 20160706101143 11:28:30 INFO - mozversion platform_changeset: 372bb24e7acdd5d5baeaa548decc1f9a5c5504ba 11:28:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 11:28:30 INFO - mozversion platform_version: 50.0a1 11:28:30 INFO - using testdate: 1467829710 11:28:30 INFO - actual date: 1467829710 11:28:30 INFO - starting webserver on 'localhost:43876' 11:28:30 INFO - SUITE-START | Running 2 tests 11:28:30 INFO - TEST-START | dromaeo_css 11:28:30 INFO - operating with platform_type : linux_ 11:28:30 INFO - Initialising browser for dromaeo_css test... 11:28:30 INFO - TEST-INFO | started process 30621 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjqC3lA/profile http://localhost:43876/getInfo.html) 11:28:34 INFO - PROCESS | 30621 | __metrics Screen width/height:1600/1200 11:28:34 INFO - PROCESS | 30621 | colorDepth:24 11:28:34 INFO - PROCESS | 30621 | Browser inner width/height: 1024/697 11:28:34 INFO - PROCESS | 30621 | __metrics 11:28:35 INFO - PROCESS | 30621 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:28:36 INFO - TEST-INFO | 30621: exit 0 11:28:36 INFO - Browser initialized. 11:28:36 INFO - Running cycle 1/1 for dromaeo_css test... 11:28:36 INFO - TEST-INFO | started process 30704 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjqC3lA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:28:48 INFO - PROCESS | 30704 | RSS: Main: 159178752 11:28:48 INFO - PROCESS | 30704 | 11:29:39 INFO - PROCESS | 30704 | 1467829779247 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] 11:31:52 INFO - PROCESS | 30704 | Cycle 1(1): loaded http://localhost:43876/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43876/tests/dromaeo/cssquery-ext.html) 11:31:53 INFO - PROCESS | 30704 | RSS: Main: 241848320 11:31:53 INFO - PROCESS | 30704 | 11:34:55 INFO - PROCESS | 30704 | Cycle 1(1): loaded http://localhost:43876/tests/dromaeo/cssquery-ext.html (next: http://localhost:43876/tests/dromaeo/cssquery-jquery.html) 11:34:56 INFO - PROCESS | 30704 | RSS: Main: 237834240 11:34:56 INFO - PROCESS | 30704 | 11:37:58 INFO - PROCESS | 30704 | Cycle 1(1): loaded http://localhost:43876/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43876/tests/dromaeo/cssquery-mootools.html) 11:37:59 INFO - PROCESS | 30704 | RSS: Main: 238116864 11:37:59 INFO - PROCESS | 30704 | 11:41:01 INFO - PROCESS | 30704 | Cycle 1(1): loaded http://localhost:43876/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43876/tests/dromaeo/cssquery-prototype.html) 11:41:02 INFO - PROCESS | 30704 | RSS: Main: 236175360 11:41:02 INFO - PROCESS | 30704 | 11:44:05 INFO - PROCESS | 30704 | Cycle 1(1): loaded http://localhost:43876/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43876/tests/dromaeo/cssquery-yui.html) 11:44:05 INFO - PROCESS | 30704 | RSS: Main: 216485888 11:44:05 INFO - PROCESS | 30704 | 11:47:08 INFO - PROCESS | 30704 | Cycle 1(1): loaded http://localhost:43876/tests/dromaeo/cssquery-yui.html (next: http://localhost:43876/tests/dromaeo/cssquery-dojo.html) 11:47:08 INFO - PROCESS | 30704 | RSS: Main: 295276544 11:47:08 INFO - PROCESS | 30704 | 11:47:08 INFO - PROCESS | 30704 | __start_tp_report 11:47:08 INFO - PROCESS | 30704 | _x_x_mozilla_page_load 11:47:08 INFO - PROCESS | 30704 | _x_x_mozilla_page_load_details 11:47:08 INFO - PROCESS | 30704 | |i|pagename|runs| 11:47:08 INFO - PROCESS | 30704 | |0;dojo.html;2626.422187118834;2636.3672718547555;2636.947261054779;2672.746089121533;2678.0760637580042;4699.647526435522;4750.07373562155;4753.786079626417;4835.516448355158;4911.189653707139;4657.441107067149;4685.1566717990745;4704.717716936986;4820.204666230068;4825.083234185502;4391.055922976551;4451.977740111295;4480.417545719052;4523.027549076948;4567.429071366079;4477.3731677565165;4518.954810451903;4522.072975040109;4536.5236650151755;4545.36364908913;4280.293751530994;4325.805338759764;4333;4338.783060846977;4394.604485596312;4397.582229688174;4405.11897620474;4461.196984542781;4463;4485.775711214426;4435.844745433894;4456.754878481682;4476.194285028693;4498.955010449887;4503.2569626012;4666;4728.952710472886;4795.088933102699;4797.928031079502;4816.903661926742;5134.255532947702;5145.614078944094;5146.150885103953;5172.715500647463;5173.146430838907;5069.290299358093;5175.01674681813;5182.222666600041;5185.870353241199;5192.662476938987;4775.188218002948;4831.589314908272;4833.10587541306;4835.975820120877;4852.320675105488;5375.919361209585;5381.946180538144;5388.91916621251;5391.218273350342;5392.0294347017125;4933.777979990909;4967.05625931072;5147.871303217375;5156.845294641167;5157.432682404932;5078.568321692624;5082.2122571001555;5088.796448142107;5102;5154.30416893722;5032.84901452957;5038.3198268234055;5040.143175660073;5045.84862454127;5091.974540127276;4934.703917764946;4966.776495057731;5011.624128190328;5016.247562865599;5019.0965626187635;4245.532991370947;4251.87244382669;4261.2542805009;4301.139772045603;4304.16068866568;3729.1050147964293;3741.8503259869844;3744.64425879541;3768.9246215075545;3791.5071040765074;4398.4941731701265;4433.667474939392;4439.378487011821;4454.821807127743;4490.685652004394;5171.043356978971;5193.792248310026;5196.272521846944;5198.4801519847715;5240.318758561362;4493.550644935545;4496.550344965477;4496.572825581565;4529.456465224194;4540.477845047796;4464.754438505914;4534.342520334533;4541.886452838706;4571.337156112345;4605.815767369268;4814.542618451242;4836.975815120902;4841.05599408112;4848.10310092627;4882.6826256293225;5152.5620322271525;5156.97421512905;5157.458466860926;5164.638475306692;5192.83161288707;4757.381540399726;4789.898323385711;4794.184988552024;4807.110684523374;4811.374521312207;4964.950350496449;5001.124803159505;5008.69947803133;5027.698338099725;5044.1172794761505;4986.650934434555;5062.519060689228;5065.493450654905;5072.492750725046;5125.666831655931;4904.068227036852;4935.827246046371;4955.529224723646;4974;4992.051510213048;4968.900621987467;4984.2025275955675;4994.275830004702;5009.273655320031;5038.294638750504;4802.951970480251;4827.348307978378;4915.139850526072;4927.802887884588;4970.229614409773;4575.496695363441;4891.486393928586;4968.205087186033;4994.425641051181;5041.8487445376695;4828.565429111397;4849.684770489906;4853.781579828846;4857.562819346276;4887.144749668722 11:47:08 INFO - PROCESS | 30704 | |1;ext.html;553.2715290108596;565.6606036378176;587.9823605291841;601.9789307374241;602.6113157013726;28533.714662853366;39952.60047399525;40507.39238911412;40715.38926916099;44988.550114498845;40408.191836163336;40845.183096338056;40873;40974.79512602433;41105;7386.335229829314;7882.60586970652;8015.198480151997;8035.517868927854;10047.246456515753;9974.551145198484;10344.586216551328;10345;10346.793064138712;10347.741306467324;10320.896791032068;10353.430561319125;10366.326188797742;10366.844497332546;10370.118539924115;7449.441291903129;10180.338278011906;10271.178305735522;10321.896781032168;10441.79116417675;10153.847692284622;10217.897821021843;10223.591056357736;10231.181505479544;10239.539220735085;38970.41544376837;39067.41398879019;39283.60716392828;39354.803225983975;39401.21197576032;3169.5404166395742;3230;3247.983760081208;3265.575475188234;3275.1157187559224;29648.8517557413;30090.699093009007;30167.69832301671;30412.695873041208;30518.389632207232;3326.6799733865537;3335.633080361158;3357.3285342931513;3419.4186988211814;3432.845521951518;247725;249727;249940;249984;250565;31093;32544.83727581347;51701;51957.96084078297;52175.73912130415;33650.326993459996;33814;33821;33838.66161338355;33851.153721156676;12646;12723.300218488072;12729.872701273054;12740.108192426627;12740.80888786669;10616.628418005334;10968.670939871816;11004.559817607365;11288.209825312313;11307.378094204732;7819.475202335604;7832.921670783219;7836.647350869224;7898.407619428566;7904.4071694623135;3053;3065.1417603071177;3089.212250876012;3111.6888311169155;3120.1731541141617;933.453929451265;972.4748635736623;991.8065977134389;1002.7292630989592;1004.5730564510054;27518.724812752018;28718.856405717837;29044.564331535043;29087.56368654472;29511.26221844428;929.4748467116193;967.327707243459;979.5347210075157;986.541258314887;1012.9189664826796;14873.256337183098;15165.583101378841;15233.695326093417;15370.924035317421;15708.60728481797;403862;406748;408246;409538;411200;33378.3324333512;33699.15752106168;33740.49389259163;33881.32237355288;34006;1071.12703146935;1177.5584155941692;1178.4637989714658;1224.2165014390796;1227.3617718786359;28205.71794282031;29392.41215175727;29490.85254573799;30309.242268943453;30382.240443989078;42014.36978445265;42329.365059524745;42363.57636423596;42383.576164237966;42435.1512969745;247631;247946;248611;249028;249549;22339.66490502611;24331.51336973286;25283.87358063198;25291.850192733087;26639;42342;42400.15199696051;42484.575154248065;43289.783551082044;43399.78300108479;36019.639803601625;37016.444753328185;37362.43956340603;37427.81286093552;37882.810585948;35848;36930;37019.07452313714;37382.439263411616;37842;35522;35558.11104722299;35909.64090359167;39466.40800388054;40339.596604033584;31768.841155794074;32759.836200818845;33365.16587085342;33451.665483344856;33727.83136084304;25694.614580781676;26008.34979125537;26114.73885261199;26485.867570662795;26669.466610668067 11:47:08 INFO - PROCESS | 30704 | |2;jquery.html;349.1080289859408;375.63375708684026;376.34891637467183;378.3549048871674;390.4865102390356;13712;16570.26590612549;16843.989360638356;17342;18321.267149314044;16683.749743753855;17602.943823370606;18161.182746776427;18179.18193681284;18193.454196374096;4995.950040499594;5313.521783039526;5336.9733151334185;5340.038793017256;5342.732863356836;3689.428138638502;5205.906759580493;5887.411258874121;6212.596181248227;6247.344028876971;6229.408206220402;6262.937370626281;6321.74713011479;6322.810315690536;6329.430351268408;6154.753809847623;6285.811425657238;6305.274893387274;6305.968470157666;6306.999999999977;3399.9830000850084;5121.590272778169;5433.7283135843445;5454.836354909359;5522.2544956431175;21059.262925797677;21856.453588660253;21873;21879;21903.452413689625;1922.08700867087;1944.212593899473;1956.1001939108028;2001.7998200180011;2237.9216727414464;13507.797383039262;13546.661333466644;13698.246596437191;14028.859711402858;14136;1787.195761907147;1829.3231504343346;1839.5860931290354;1842.6591080650123;1890.6502297074949;70403.2959670407;72136.63931680308;72284;72662.63668681623;73241.63379183123;8912.598933047899;9586.712398628053;9813.754656133653;9854.655087071918;10737;12451.688707782198;13421.127626704232;13429.39567719455;13862.653433664038;13932.791008134885;7614.885776713354;7658.2724641159;7661.808454788675;7763.805904852424;7863.764087077397;7224.530405523624;7308.451866110063;7418.851622967511;7431.591262480507;7487;6254.405831446005;6354;6472.870542589122;6522.869542609216;6529.54293199481;1799.9190036448392;1819.9272029118952;1831.285798538571;1843.972340414895;1854.1934258597553;813.8413009463217;912.0833562270009;912.7991841794794;950.7480517662825;973.4013581647235;17367.91316043437;17746.822531774516;18175.72736408955;18303.35938242155;18840.717389239173;879.6921077622909;895.4045559702855;895.6596493332491;914.2000749344323;933.4912472702393;10020.799584008424;10243.180545556337;10247;10302.33034852732;10366.118879895143;380984;385184;387100;388067;389992;72364.63817680984;74558;74687;74698.62650686712;75081.24918750742;912.2063804490136;932.128459890005;943.4622265308845;949.4540639132526;952.2429668413628;15642.217889105726;15843.207839607743;15847.762283565986;16109;16175.352985880903;24009;33546.496802547495;34452.82773586116;36399;36617.63382366249;46198.769006154755;46353;46590.76704616591;46804.765976171264;47113;6984.4063254623925;7231.927680723125;8066.153053929253;8164.550949697824;8231.670733170606;7619.809504762204;12671.493140274286;12750.489980401051;12841.35793210317;13006.349682516025;9471.337006409485;9643.132118109404;10783.784324313312;10892.18308626872;11056.060234880126;10639.361638301727;10841.837372439577;11151.442427878736;11189.552417903193;11381.54473821038;10860.185486088418;11061.22571420025;11101.38942358178;11189.160812938899;11248.550057997589;6979.092717946634;7163.283671632795;7483.401327893646;7494.587797670963;7515.098188217449;10179.338343007681;10879.292845965303;11035.227534072537;11140.554377824796;11419.942900285445 11:47:08 INFO - PROCESS | 30704 | |3;mootools.html;1397.7693680542711;1427.9928600357;1505;1716.124776364054;1735.392612585596;7695.884561731572;8118.51288922665;8208.753737387873;8217.342612590994;8227.712030078948;6910.447164226863;7609;7909.209079092088;7931.801704957379;8001.159878212791;2277.0436416704983;2300.6779050932882;2306.527161931808;2308.572914010905;2309.214866945238;2212.6459766437374;2231.553689262146;2293.0598454633605;2295.357299956015;2295.724513058427;1892.2998490558443;1966.223341779996;1966.9901650491727;1973.2600274896913;2143.9785602143934;2214.745304290003;2242.1703969531377;2245.8764767937755;2249.898754556049;2250.4261413339577;2217.7449593296815;2220.555888822226;2229.687843701883;2255.492514184312;2256.345659758668;6831.487638427137;7592.278733520307;7880.0937892142565;8050.597470126529;8122.7157049502985;4656.697314674535;4772.2125849234835;4777.737224452654;4779.904401911977;4785.234362501983;2855.300451389423;2930.721581449759;2973.9553906691417;2978.0470249520163;2985.402919416104;896.4307664633005;897.2507955856802;910.3400034974657;917.3991035871514;920.4017388697333;10821.891781082168;10930.344179349186;10940.945295273552;10947.83578246319;10958.28771129874;4209.4948606166845;4280.079782846703;4433.1577000369825;4487.169873573399;4490.820367185276;9441.622335106656;9484.241260699127;9491;9499.572519236652;9500.42997420157;4755.809767609326;4757.548032936935;4766.642501812308;4774.236122220497;4775.2359622460235;4247.851325203603;4335.067960388532;4338.82644694215;4340.52254252032;4340.826366945287;3613.9277214455565;3650.762700424464;3651.4887915691825;3705.9808552648237;3723.6834869035893;1163.2380790582183;1169.859616845984;1183.1185766603935;1198.7542553776454;1204.4941124727636;586.8796896636179;706.8692291925908;815.6288888555692;847.8855354527183;871.2420194430886;4873.6832105913;5253.185756207794;5288.338957630296;5309.017831701148;5355.839324820262;849.0726051862362;870.8824308718368;886.8093359927647;894.8768301474009;899.7570655922864;3492.7729697569575;3565.893023209308;3617.6382361763613;3694.8706795262574;3720.5535335759882;9577.138057574852;9896.752581185385;9966.103050725469;10081.596736130472;10085.899141008642;9317.16145546904;9696.70909872705;9729.416235025921;9949.353292035994;9993.750156246007;7328.816779580553;7501.512401693873;7503.212162722944;7505.812354691067;7509.061367329084;5205.921911171411;5377.758000889891;5420.376656684532;5505.146702261156;5536.390996990247;8935.642574296955;9267.258619310303;9273.53632318395;9390.342676012613;9501.619935202514;9350.719478415658;9375.156235938799;9443.527823608654;9480.573374198315;9586.185174259987;6947.4789390796905;6994.895076573754;7097.787066388017;7111.573305601681;7117.039199707973;7805.726799561988;7806.687732490636;7807.804804879924;7836.138024817379;7836.647350869111;5411.540019098264;6853.17761868579;6856.828579285558;6966.3730264276455;6988.161420629557;6632.104665870046;6763.8985415219795;6791;6869.072675188786;6910.274421185703;6229.470495007975;6244.438000579969;6342.270638876588;6352.777652782315;6353.491720662429;4618.284165954283;4641.071785642953;4699.342092107039;4747.952520474751;4776;4751.049790041936;4759.143354196278;4799.352087468147;4871.171900776805;4941 11:47:08 INFO - PROCESS | 30704 | |4;prototype.html;294.1719060843725;297.4868352092639;301.75407043259753;304.3547678920688;304.4687021148094;4943.209086546153;4950.504949505048;4959.900801983958;4971.726555039476;4979.327790748257;4835.202191638376;4908.386451693538;4917.803287868481;4919.70481771094;4925.581325587329;3647.872324468644;3793.2413517296513;3795.013296542891;3879.844806207748;3918.09883726743;3850.2107068051123;3852.614738526153;3866.033491627093;3874.651281384675;3925.6663183629425;3679.2825399047197;3829.961700383002;3846.653801157895;3855.1711382052854;3870.2259548090356;3762.1723220891495;3806.505154329947;3843.5195600549932;3855.1325951660933;3872.244912242114;3371.1290233920163;3394.35507253621;3398.711109555666;3399.507071474647;3428.8285585720614;4807.42310922688;4828.686135401223;4847.175980083394;4855.927161092586;4861.197902346109;4268.658507319407;4445.977770111129;4450.132224216279;4454.5990860822685;4460.219461594208;5132.640715149941;5134.589232861362;5141.640085194038;5144.305518754958;5161.81933632321;3720.832562534665;3724.2737666155112;3724.2737666155112;3724.3110024645257;3738.5887552369218;5237.476252374732;5388.410418926426;5390.434004429557;5452.781888724447;5466.644668096601;3746.6253374662315;3752.981235093807;3758.4926034985474;3770.8680196193;3773.6792372648633;3829.7702137871815;3832.137769001952;3845.7115716320827;3848.692104631623;3877.418387241936;4378.64970802335;4387.978060109743;4392.407025051641;4401.911961760811;4402.471703395549;4906.239532872411;5119.206522988943;5119.517034238392;5128.974355128201;5144.408393034774;1274.8271590137097;1295.3070107492636;1295.8185853980451;1300.6033159886135;1312.7308901675324;831.5717405536154;834.3742193354984;846.627483907079;870.3124531620076;874.5933141089424;4509.301058335963;4531.818727250873;4543.136804007228;4547.909041819145;4552.476465206543;5224.648907991419;5231.659942103827;5235.424103348629;5311.336082989626;5319.547838433777;4378.671599630041;4498.302763071663;4500.527444618333;4511.142882852248;4646.6747327686735;2809.0449247256033;2841.3606938438684;2844.615976843141;2847.2454799478155;2860.4565132624734;5040.47075057121;5041.495850414929;5045.318881950963;5052.7726252318735;5059.406287019577;5329.840104796862;5384.326959130109;5436.157395603609;5471.671699698031;5516;4981.227909674007;4989.70473582149;5024.924626130611;5030.471800461045;5031.270465782514;5306.187720508137;5317.893642127213;5321.308229930084;5325.254464374913;5344.679319240858;5052.317937078447;5150.793968241228;5218.112920803548;5252.842414727565;5257.763400646903;4967.081089998362;4978.377702787152;5022.447530771539;5030.57240134578;5039.143345631325;3731.888043358595;3738.7009039277336;3740.17716102457;3774.735768496179;3786.8106594670708;5101.872453188552;5232.37211534603;5278.287431196739;5321.255024296524;5357.70532620694;5085.64400491962;5112.539871411591;5137.689889078261;5146.202338637517;5150.99555586657;5118.232265160255;5130.769115389891;5133.409657889241;5181.2746215529105;5215.55667768244;4793.616510679068;4908.852734417973;5027.818462661198;5035.295058691713;5040.168372218543;4999.425066117443;5012.248162775612;5142.254373115952;5148.613853960893;5158.97420512895;5014.423341315795;5032.169692000779;5064.290999260033;5083.38999320084;5085.720285384339 11:47:08 INFO - PROCESS | 30704 | |5;yui.html;637.5186734015817;656.478099910571;659.7328082126737;661.087698975414;666.6233578028414;12894.677633059178;12923.870761292384;13459.5289164879;13465.057445978786;13488.527901523448;13134.146280491785;13251.668708282297;13259.337033148327;13275.668108297274;13587.728245435086;623.9188905442309;759.851828893366;773.9883901741479;788.5347644889514;794.3922898982283;798.0582912163644;805.4281460163292;807.8667019941703;808.7290757596212;808.9029316482031;842.2503971465401;845.4462327175679;845.5856630251163;845.71245776436;845.9577021148949;646.7219095788832;801.7795106345801;833.5290560833109;843.725789118539;844.3667249562828;605.530713696884;606.4602503771647;606.5087279303734;606.9878602427926;607.4502575169479;12977.480900763958;12984.740305193938;12995.480180792756;13015.349232538336;13019.414126364336;11783.175177737561;12565.74868502634;12667.936660316731;12894.548690795871;12929.224246545238;11403;11686.24039437434;11873.550519075936;11942.641720748305;12254.693632659166;4185.790710464465;4193.559676234013;4245.23585754564;4267.658587313039;4346.1090476452255;64704;66033;66107.66946165287;66186.66906665484;66204.33795662079;9627.181689556326;9668.178204852666;9965;10240.53917573696;10394.792104157874;16162;16201.513954581382;16510.504684859232;16524.83475165257;16644.50066498007;6185.783497577563;6525.967370163119;6608.43828274602;6807.115075040213;6811.591304521745;3633.94549081764;3650.5071815305123;3693.1505753676806;3742.6257374262354;3748.756330838487;2782.2905159184684;2869.7130286971137;3290.391277613649;3459.0314711880715;3464.7055000325254;560.966342019472;561.9438056194348;565.2877374508067;566.7676252736359;567.86655136043;525.3931708876254;533.378613914785;582.6620560075146;597.7071235094772;624.0545573456218;8639.308855291561;8673.826523469621;8731.947992221823;8837.779055523535;9135.497547634945;502.3018004973017;577.3302968556454;586.6157666728215;591.3199820206711;596.931352894414;4096.651784598283;4210.5578914214175;4373.934390984138;4403.581659742319;4405.977970110129;109426.45286773515;109888.45055774829;110033;113560.35481679766;115378;93290;97413.51293243488;98021.50989245008;98357;98404.50797745965;83441.58279208565;83884;85933.57033214919;86129;86981.56509217413;8020.197980201933;8089.110197878346;8217.917820821714;8254.215849494289;8373.413861029669;48023.75988120037;48872;48965.755171223915;50887;51097.48902511076;69135;70278.89163325109;71424.5715085685;72547;72918.27081729115;10608.89391106079;10622.681319560426;10663.89336106629;10734.355938643706;10803.297785643908;12637.2417654941;12791.296478693388;13036.087473876738;13777.655558611115;14115.294235287989;8696.608652610774;11028.944855275673;12074.698132546757;12122.818157727817;12256.509739610316;12065.767957564109;12142.453589588666;12148.878511214774;12222.633321000385;12334.75330493403;11810.527578897092;11827.408629568316;11943.522259109539;12191.756164876475;12347.320897350732;10074.288461252558;10332.380057196593;10383.325083869524;10451.16390688728;10625.415602141647;9665.661701840401;10059.49702514886;10160.983723416812;10162.949185254027;10173.796524069625 11:47:08 INFO - PROCESS | 30704 | __end_tp_report 11:47:08 INFO - PROCESS | 30704 | __start_cc_report 11:47:08 INFO - PROCESS | 30704 | _x_x_mozilla_cycle_collect,869 11:47:08 INFO - PROCESS | 30704 | __end_cc_report 11:47:08 INFO - PROCESS | 30704 | __startTimestamp1467830828753__endTimestamp 11:47:08 INFO - PROCESS | 30704 | 11:47:08 INFO - PROCESS | 30704 | ------- Summary: start ------- 11:47:08 INFO - PROCESS | 30704 | Number of tests: 6 11:47:08 INFO - PROCESS | 30704 | 11:47:08 INFO - PROCESS | 30704 | [#0] dojo.html Cycles:165 Average:4731.01 Median:4835.98 stddev:499.36 (10.3%) stddev-sans-first:472.82 11:47:08 INFO - PROCESS | 30704 | Values: 2626.4 2636.4 2636.9 2672.7 2678.1 4699.6 4750.1 4753.8 4835.5 4911.2 4657.4 4685.2 4704.7 4820.2 4825.1 4391.1 4452.0 4480.4 4523.0 4567.4 4477.4 4519.0 4522.1 4536.5 4545.4 4280.3 4325.8 4333.0 4338.8 4394.6 4397.6 4405.1 4461.2 4463.0 4485.8 4435.8 4456.8 4476.2 4499.0 4503.3 4666.0 4729.0 4795.1 4797.9 4816.9 5134.3 5145.6 5146.2 5172.7 5173.1 5069.3 5175.0 5182.2 5185.9 5192.7 4775.2 4831.6 4833.1 4836.0 4852.3 5375.9 5381.9 5388.9 5391.2 5392.0 4933.8 4967.1 5147.9 5156.8 5157.4 5078.6 5082.2 5088.8 5102.0 5154.3 5032.8 5038.3 5040.1 5045.8 5092.0 4934.7 4966.8 5011.6 5016.2 5019.1 4245.5 4251.9 4261.3 4301.1 4304.2 3729.1 3741.9 3744.6 3768.9 3791.5 4398.5 4433.7 4439.4 4454.8 4490.7 5171.0 5193.8 5196.3 5198.5 5240.3 4493.6 4496.6 4496.6 4529.5 4540.5 4464.8 4534.3 4541.9 4571.3 4605.8 4814.5 4837.0 4841.1 4848.1 4882.7 5152.6 5157.0 5157.5 5164.6 5192.8 4757.4 4789.9 4794.2 4807.1 4811.4 4965.0 5001.1 5008.7 5027.7 5044.1 4986.7 5062.5 5065.5 5072.5 5125.7 4904.1 4935.8 4955.5 4974.0 4992.1 4968.9 4984.2 4994.3 5009.3 5038.3 4803.0 4827.3 4915.1 4927.8 4970.2 4575.5 4891.5 4968.2 4994.4 5041.8 4828.6 4849.7 4853.8 4857.6 4887.1 11:47:08 INFO - PROCESS | 30704 | 11:47:08 INFO - PROCESS | 30704 | [#1] ext.html Cycles:180 Average:44853.05 Median:18017.48 stddev:82044.87 (455.4%) stddev-sans-first:82207.61 11:47:08 INFO - PROCESS | 30704 | Values: 553.3 565.7 588.0 602.0 602.6 28533.7 39952.6 40507.4 40715.4 44988.6 40408.2 40845.2 40873.0 40974.8 41105.0 7386.3 7882.6 8015.2 8035.5 10047.2 9974.6 10344.6 10345.0 10346.8 10347.7 10320.9 10353.4 10366.3 10366.8 10370.1 7449.4 10180.3 10271.2 10321.9 10441.8 10153.8 10217.9 10223.6 10231.2 10239.5 38970.4 39067.4 39283.6 39354.8 39401.2 3169.5 3230.0 3248.0 3265.6 3275.1 29648.9 30090.7 30167.7 30412.7 30518.4 3326.7 3335.6 3357.3 3419.4 3432.8 247725.0 249727.0 249940.0 249984.0 250565.0 31093.0 32544.8 51701.0 51958.0 52175.7 33650.3 33814.0 33821.0 33838.7 33851.2 12646.0 12723.3 12729.9 12740.1 12740.8 10616.6 10968.7 11004.6 11288.2 11307.4 7819.5 7832.9 7836.6 7898.4 7904.4 3053.0 3065.1 3089.2 3111.7 3120.2 933.5 972.5 991.8 1002.7 1004.6 27518.7 28718.9 29044.6 29087.6 29511.3 929.5 967.3 979.5 986.5 1012.9 14873.3 15165.6 15233.7 15370.9 15708.6 403862.0 406748.0 408246.0 409538.0 411200.0 33378.3 33699.2 33740.5 33881.3 34006.0 1071.1 1177.6 1178.5 1224.2 1227.4 28205.7 29392.4 29490.9 30309.2 30382.2 42014.4 42329.4 42363.6 42383.6 42435.2 247631.0 247946.0 248611.0 249028.0 249549.0 22339.7 24331.5 25283.9 25291.9 26639.0 42342.0 42400.2 42484.6 43289.8 43399.8 36019.6 37016.4 37362.4 37427.8 37882.8 35848.0 36930.0 37019.1 37382.4 37842.0 35522.0 35558.1 35909.6 39466.4 40339.6 31768.8 32759.8 33365.2 33451.7 33727.8 25694.6 26008.3 26114.7 26485.9 26669.5 11:47:08 INFO - PROCESS | 30704 | 11:47:08 INFO - PROCESS | 30704 | [#2] jquery.html Cycles:180 Average:24400.94 Median:386142.00 stddev:63655.13 (16.5%) stddev-sans-first:63808.09 11:47:08 INFO - PROCESS | 30704 | Values: 349.1 375.6 376.3 378.4 390.5 13712.0 16570.3 16844.0 17342.0 18321.3 16683.7 17602.9 18161.2 18179.2 18193.5 4996.0 5313.5 5337.0 5340.0 5342.7 3689.4 5205.9 5887.4 6212.6 6247.3 6229.4 6262.9 6321.7 6322.8 6329.4 6154.8 6285.8 6305.3 6306.0 6307.0 3400.0 5121.6 5433.7 5454.8 5522.3 21059.3 21856.5 21873.0 21879.0 21903.5 1922.1 1944.2 1956.1 2001.8 2237.9 13507.8 13546.7 13698.2 14028.9 14136.0 1787.2 1829.3 1839.6 1842.7 1890.7 70403.3 72136.6 72284.0 72662.6 73241.6 8912.6 9586.7 9813.8 9854.7 10737.0 12451.7 13421.1 13429.4 13862.7 13932.8 7614.9 7658.3 7661.8 7763.8 7863.8 7224.5 7308.5 7418.9 7431.6 7487.0 6254.4 6354.0 6472.9 6522.9 6529.5 1799.9 1819.9 1831.3 1844.0 1854.2 813.8 912.1 912.8 950.7 973.4 17367.9 17746.8 18175.7 18303.4 18840.7 879.7 895.4 895.7 914.2 933.5 10020.8 10243.2 10247.0 10302.3 10366.1 380984.0 385184.0 387100.0 388067.0 389992.0 72364.6 74558.0 74687.0 74698.6 75081.2 912.2 932.1 943.5 949.5 952.2 15642.2 15843.2 15847.8 16109.0 16175.4 24009.0 33546.5 34452.8 36399.0 36617.6 46198.8 46353.0 46590.8 46804.8 47113.0 6984.4 7231.9 8066.2 8164.6 8231.7 7619.8 12671.5 12750.5 12841.4 13006.3 9471.3 9643.1 10783.8 10892.2 11056.1 10639.4 10841.8 11151.4 11189.6 11381.5 10860.2 11061.2 11101.4 11189.2 11248.6 6979.1 7163.3 7483.4 7494.6 7515.1 10179.3 10879.3 11035.2 11140.6 11419.9 11:47:08 INFO - PROCESS | 30704 | 11:47:08 INFO - PROCESS | 30704 | [#3] mootools.html Cycles:180 Average:5256.24 Median:5298.68 stddev:2964.77 (56.0%) stddev-sans-first:2958.91 11:47:08 INFO - PROCESS | 30704 | Values: 1397.8 1428.0 1505.0 1716.1 1735.4 7695.9 8118.5 8208.8 8217.3 8227.7 6910.4 7609.0 7909.2 7931.8 8001.2 2277.0 2300.7 2306.5 2308.6 2309.2 2212.6 2231.6 2293.1 2295.4 2295.7 1892.3 1966.2 1967.0 1973.3 2144.0 2214.7 2242.2 2245.9 2249.9 2250.4 2217.7 2220.6 2229.7 2255.5 2256.3 6831.5 7592.3 7880.1 8050.6 8122.7 4656.7 4772.2 4777.7 4779.9 4785.2 2855.3 2930.7 2974.0 2978.0 2985.4 896.4 897.3 910.3 917.4 920.4 10821.9 10930.3 10940.9 10947.8 10958.3 4209.5 4280.1 4433.2 4487.2 4490.8 9441.6 9484.2 9491.0 9499.6 9500.4 4755.8 4757.5 4766.6 4774.2 4775.2 4247.9 4335.1 4338.8 4340.5 4340.8 3613.9 3650.8 3651.5 3706.0 3723.7 1163.2 1169.9 1183.1 1198.8 1204.5 586.9 706.9 815.6 847.9 871.2 4873.7 5253.2 5288.3 5309.0 5355.8 849.1 870.9 886.8 894.9 899.8 3492.8 3565.9 3617.6 3694.9 3720.6 9577.1 9896.8 9966.1 10081.6 10085.9 9317.2 9696.7 9729.4 9949.4 9993.8 7328.8 7501.5 7503.2 7505.8 7509.1 5205.9 5377.8 5420.4 5505.1 5536.4 8935.6 9267.3 9273.5 9390.3 9501.6 9350.7 9375.2 9443.5 9480.6 9586.2 6947.5 6994.9 7097.8 7111.6 7117.0 7805.7 7806.7 7807.8 7836.1 7836.6 5411.5 6853.2 6856.8 6966.4 6988.2 6632.1 6763.9 6791.0 6869.1 6910.3 6229.5 6244.4 6342.3 6352.8 6353.5 4618.3 4641.1 4699.3 4748.0 4776.0 4751.0 4759.1 4799.4 4871.2 4941.0 11:47:08 INFO - PROCESS | 30704 | 11:47:08 INFO - PROCESS | 30704 | [#4] prototype.html Cycles:180 Average:4282.98 Median:4918.75 stddev:1242.01 (25.3%) stddev-sans-first:1208.87 11:47:08 INFO - PROCESS | 30704 | Values: 294.2 297.5 301.8 304.4 304.5 4943.2 4950.5 4959.9 4971.7 4979.3 4835.2 4908.4 4917.8 4919.7 4925.6 3647.9 3793.2 3795.0 3879.8 3918.1 3850.2 3852.6 3866.0 3874.7 3925.7 3679.3 3830.0 3846.7 3855.2 3870.2 3762.2 3806.5 3843.5 3855.1 3872.2 3371.1 3394.4 3398.7 3399.5 3428.8 4807.4 4828.7 4847.2 4855.9 4861.2 4268.7 4446.0 4450.1 4454.6 4460.2 5132.6 5134.6 5141.6 5144.3 5161.8 3720.8 3724.3 3724.3 3724.3 3738.6 5237.5 5388.4 5390.4 5452.8 5466.6 3746.6 3753.0 3758.5 3770.9 3773.7 3829.8 3832.1 3845.7 3848.7 3877.4 4378.6 4388.0 4392.4 4401.9 4402.5 4906.2 5119.2 5119.5 5129.0 5144.4 1274.8 1295.3 1295.8 1300.6 1312.7 831.6 834.4 846.6 870.3 874.6 4509.3 4531.8 4543.1 4547.9 4552.5 5224.6 5231.7 5235.4 5311.3 5319.5 4378.7 4498.3 4500.5 4511.1 4646.7 2809.0 2841.4 2844.6 2847.2 2860.5 5040.5 5041.5 5045.3 5052.8 5059.4 5329.8 5384.3 5436.2 5471.7 5516.0 4981.2 4989.7 5024.9 5030.5 5031.3 5306.2 5317.9 5321.3 5325.3 5344.7 5052.3 5150.8 5218.1 5252.8 5257.8 4967.1 4978.4 5022.4 5030.6 5039.1 3731.9 3738.7 3740.2 3774.7 3786.8 5101.9 5232.4 5278.3 5321.3 5357.7 5085.6 5112.5 5137.7 5146.2 5151.0 5118.2 5130.8 5133.4 5181.3 5215.6 4793.6 4908.9 5027.8 5035.3 5040.2 4999.4 5012.2 5142.3 5148.6 5159.0 5014.4 5032.2 5064.3 5083.4 5085.7 11:47:08 INFO - PROCESS | 30704 | 11:47:08 INFO - PROCESS | 30704 | [#5] yui.html Cycles:180 Average:19333.84 Median:48447.88 stddev:28927.76 (59.7%) stddev-sans-first:28974.85 11:47:08 INFO - PROCESS | 30704 | Values: 637.5 656.5 659.7 661.1 666.6 12894.7 12923.9 13459.5 13465.1 13488.5 13134.1 13251.7 13259.3 13275.7 13587.7 623.9 759.9 774.0 788.5 794.4 798.1 805.4 807.9 808.7 808.9 842.3 845.4 845.6 845.7 846.0 646.7 801.8 833.5 843.7 844.4 605.5 606.5 606.5 607.0 607.5 12977.5 12984.7 12995.5 13015.3 13019.4 11783.2 12565.7 12667.9 12894.5 12929.2 11403.0 11686.2 11873.6 11942.6 12254.7 4185.8 4193.6 4245.2 4267.7 4346.1 64704.0 66033.0 66107.7 66186.7 66204.3 9627.2 9668.2 9965.0 10240.5 10394.8 16162.0 16201.5 16510.5 16524.8 16644.5 6185.8 6526.0 6608.4 6807.1 6811.6 3633.9 3650.5 3693.2 3742.6 3748.8 2782.3 2869.7 3290.4 3459.0 3464.7 561.0 561.9 565.3 566.8 567.9 525.4 533.4 582.7 597.7 624.1 8639.3 8673.8 8731.9 8837.8 9135.5 502.3 577.3 586.6 591.3 596.9 4096.7 4210.6 4373.9 4403.6 4406.0 109426.5 109888.5 110033.0 113560.4 115378.0 93290.0 97413.5 98021.5 98357.0 98404.5 83441.6 83884.0 85933.6 86129.0 86981.6 8020.2 8089.1 8217.9 8254.2 8373.4 48023.8 48872.0 48965.8 50887.0 51097.5 69135.0 70278.9 71424.6 72547.0 72918.3 10608.9 10622.7 10663.9 10734.4 10803.3 12637.2 12791.3 13036.1 13777.7 14115.3 8696.6 11028.9 12074.7 12122.8 12256.5 12065.8 12142.5 12148.9 12222.6 12334.8 11810.5 11827.4 11943.5 12191.8 12347.3 10074.3 10332.4 10383.3 10451.2 10625.4 9665.7 10059.5 10161.0 10162.9 10173.8 11:47:08 INFO - PROCESS | 30704 | -------- Summary: end -------- 11:47:08 INFO - PROCESS | 30704 | 11:47:09 INFO - TEST-INFO | 30704: exit 0 11:47:09 INFO - TEST-OK | dromaeo_css | took 1119439ms 11:47:09 INFO - TEST-START | kraken 11:47:09 INFO - operating with platform_type : linux_ 11:47:09 INFO - Initialising browser for kraken test... 11:47:09 INFO - TEST-INFO | started process 30890 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXhVKyr/profile http://localhost:43876/getInfo.html) 11:47:13 INFO - PROCESS | 30890 | __metrics Screen width/height:1600/1200 11:47:13 INFO - PROCESS | 30890 | colorDepth:24 11:47:13 INFO - PROCESS | 30890 | Browser inner width/height: 1024/697 11:47:13 INFO - PROCESS | 30890 | __metrics 11:47:14 INFO - PROCESS | 30890 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:47:15 INFO - PROCESS | 30890 | console.error: PushService: 11:47:15 INFO - PROCESS | 30890 | stateChangeProcessEnqueue: Error transitioning state 11:47:15 INFO - PROCESS | 30890 | UnknownError 11:47:15 INFO - TEST-INFO | 30890: exit 0 11:47:15 INFO - Browser initialized. 11:47:15 INFO - Running cycle 1/1 for kraken test... 11:47:15 INFO - TEST-INFO | started process 30971 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXhVKyr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:47:27 INFO - PROCESS | 30971 | RSS: Main: 159137792 11:47:27 INFO - PROCESS | 30971 | 11:47:30 INFO - PROCESS | 30971 | Cycle 1(1): loaded http://localhost:43876/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43876/tests/kraken/driver.html?testName=audio-beat-detection) 11:47:31 INFO - PROCESS | 30971 | RSS: Main: 216424448 11:47:31 INFO - PROCESS | 30971 | 11:47:34 INFO - PROCESS | 30971 | Cycle 1(1): loaded http://localhost:43876/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43876/tests/kraken/driver.html?testName=audio-dft) 11:47:34 INFO - PROCESS | 30971 | RSS: Main: 203579392 11:47:34 INFO - PROCESS | 30971 | 11:47:38 INFO - PROCESS | 30971 | Cycle 1(1): loaded http://localhost:43876/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43876/tests/kraken/driver.html?testName=audio-fft) 11:47:38 INFO - PROCESS | 30971 | RSS: Main: 271343616 11:47:38 INFO - PROCESS | 30971 | 11:47:40 INFO - PROCESS | 30971 | Cycle 1(1): loaded http://localhost:43876/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43876/tests/kraken/driver.html?testName=audio-oscillator) 11:47:41 INFO - PROCESS | 30971 | RSS: Main: 181145600 11:47:41 INFO - PROCESS | 30971 | 11:47:43 INFO - PROCESS | 30971 | Cycle 1(1): loaded http://localhost:43876/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43876/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:47:44 INFO - PROCESS | 30971 | RSS: Main: 185348096 11:47:44 INFO - PROCESS | 30971 | 11:47:47 INFO - PROCESS | 30971 | Cycle 1(1): loaded http://localhost:43876/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43876/tests/kraken/driver.html?testName=imaging-darkroom) 11:47:48 INFO - PROCESS | 30971 | RSS: Main: 221532160 11:47:48 INFO - PROCESS | 30971 | 11:47:51 INFO - PROCESS | 30971 | Cycle 1(1): loaded http://localhost:43876/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43876/tests/kraken/driver.html?testName=imaging-desaturate) 11:47:52 INFO - PROCESS | 30971 | RSS: Main: 217374720 11:47:52 INFO - PROCESS | 30971 | 11:47:55 INFO - PROCESS | 30971 | Cycle 1(1): loaded http://localhost:43876/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43876/tests/kraken/driver.html?testName=json-parse-financial) 11:47:55 INFO - PROCESS | 30971 | RSS: Main: 220721152 11:47:55 INFO - PROCESS | 30971 | 11:47:57 INFO - PROCESS | 30971 | Cycle 1(1): loaded http://localhost:43876/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43876/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:47:57 INFO - PROCESS | 30971 | RSS: Main: 206430208 11:47:57 INFO - PROCESS | 30971 | 11:47:59 INFO - PROCESS | 30971 | Cycle 1(1): loaded http://localhost:43876/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43876/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:48:00 INFO - PROCESS | 30971 | RSS: Main: 212811776 11:48:00 INFO - PROCESS | 30971 | 11:48:02 INFO - PROCESS | 30971 | Cycle 1(1): loaded http://localhost:43876/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43876/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:48:03 INFO - PROCESS | 30971 | RSS: Main: 209727488 11:48:03 INFO - PROCESS | 30971 | 11:48:06 INFO - PROCESS | 30971 | Cycle 1(1): loaded http://localhost:43876/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43876/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:48:06 INFO - PROCESS | 30971 | RSS: Main: 223899648 11:48:06 INFO - PROCESS | 30971 | 11:48:09 INFO - PROCESS | 30971 | Cycle 1(1): loaded http://localhost:43876/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43876/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:48:10 INFO - PROCESS | 30971 | RSS: Main: 224149504 11:48:10 INFO - PROCESS | 30971 | 11:48:11 INFO - PROCESS | 30971 | Cycle 1(1): loaded http://localhost:43876/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43876/tests/kraken/driver.html?testName=ai-astar) 11:48:12 INFO - PROCESS | 30971 | RSS: Main: 266072064 11:48:12 INFO - PROCESS | 30971 | 11:48:12 INFO - PROCESS | 30971 | __start_tp_report 11:48:12 INFO - PROCESS | 30971 | _x_x_mozilla_page_load 11:48:12 INFO - PROCESS | 30971 | _x_x_mozilla_page_load_details 11:48:12 INFO - PROCESS | 30971 | |i|pagename|runs| 11:48:12 INFO - PROCESS | 30971 | |0;ai-astar;105;115;116;115;113;115;112;112;113;113 11:48:12 INFO - PROCESS | 30971 | |1;audio-beat-detection;156;123;128;183;130;129;142;122;168;122 11:48:12 INFO - PROCESS | 30971 | |2;audio-dft;162;161;160;162;162;162;161;161;160;161 11:48:12 INFO - PROCESS | 30971 | |3;audio-fft;75;76;76;114;76;77;75;74;110;75 11:48:12 INFO - PROCESS | 30971 | |4;audio-oscillator;84;85;119;85;85;84;130;86;86;126 11:48:12 INFO - PROCESS | 30971 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;116;116 11:48:12 INFO - PROCESS | 30971 | |6;imaging-darkroom;146;146;146;146;147;146;146;146;146;146 11:48:12 INFO - PROCESS | 30971 | |7;imaging-desaturate;95;95;95;95;95;95;96;95;94;95 11:48:12 INFO - PROCESS | 30971 | |8;json-parse-financial;64;64;63;65;64;65;64;64;63;63 11:48:12 INFO - PROCESS | 30971 | |9;json-stringify-tinderbox;64;64;64;64;64;64;63;66;65;64 11:48:12 INFO - PROCESS | 30971 | |10;stanford-crypto-aes;79;77;78;77;77;77;83;77;78;78 11:48:12 INFO - PROCESS | 30971 | |11;stanford-crypto-ccm;126;138;130;129;137;127;139;145;202;138 11:48:12 INFO - PROCESS | 30971 | |12;stanford-crypto-pbkdf2;167;167;168;169;169;166;168;176;166;165 11:48:12 INFO - PROCESS | 30971 | |13;stanford-crypto-sha256-iterative;67;67;67;67;66;69;67;65;65;65 11:48:12 INFO - PROCESS | 30971 | __end_tp_report 11:48:12 INFO - PROCESS | 30971 | __start_cc_report 11:48:12 INFO - PROCESS | 30971 | _x_x_mozilla_cycle_collect,1880 11:48:12 INFO - PROCESS | 30971 | __end_cc_report 11:48:12 INFO - PROCESS | 30971 | __startTimestamp1467830892169__endTimestamp 11:48:12 INFO - PROCESS | 30971 | 11:48:12 INFO - PROCESS | 30971 | ------- Summary: start ------- 11:48:12 INFO - PROCESS | 30971 | Number of tests: 14 11:48:12 INFO - PROCESS | 30971 | 11:48:12 INFO - PROCESS | 30971 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:3.11 (2.7%) stddev-sans-first:1.48 11:48:12 INFO - PROCESS | 30971 | Values: 105.0 115.0 116.0 115.0 113.0 115.0 112.0 112.0 113.0 113.0 11:48:12 INFO - PROCESS | 30971 | 11:48:12 INFO - PROCESS | 30971 | [#1] audio-beat-detection Cycles:10 Average:140.30 Median:136.00 stddev:21.59 (15.9%) stddev-sans-first:22.14 11:48:12 INFO - PROCESS | 30971 | Values: 156.0 123.0 128.0 183.0 130.0 129.0 142.0 122.0 168.0 122.0 11:48:12 INFO - PROCESS | 30971 | 11:48:12 INFO - PROCESS | 30971 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 11:48:12 INFO - PROCESS | 30971 | Values: 162.0 161.0 160.0 162.0 162.0 162.0 161.0 161.0 160.0 161.0 11:48:12 INFO - PROCESS | 30971 | 11:48:12 INFO - PROCESS | 30971 | [#3] audio-fft Cycles:10 Average:82.80 Median:75.50 stddev:15.44 (20.5%) stddev-sans-first:16.12 11:48:12 INFO - PROCESS | 30971 | Values: 75.0 76.0 76.0 114.0 76.0 77.0 75.0 74.0 110.0 75.0 11:48:12 INFO - PROCESS | 30971 | 11:48:12 INFO - PROCESS | 30971 | [#4] audio-oscillator Cycles:10 Average:97.00 Median:85.00 stddev:19.51 (23.0%) stddev-sans-first:20.12 11:48:12 INFO - PROCESS | 30971 | Values: 84.0 85.0 119.0 85.0 85.0 84.0 130.0 86.0 86.0 126.0 11:48:12 INFO - PROCESS | 30971 | 11:48:12 INFO - PROCESS | 30971 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:48:12 INFO - PROCESS | 30971 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 11:48:12 INFO - PROCESS | 30971 | 11:48:12 INFO - PROCESS | 30971 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 11:48:12 INFO - PROCESS | 30971 | Values: 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 11:48:12 INFO - PROCESS | 30971 | 11:48:12 INFO - PROCESS | 30971 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 11:48:12 INFO - PROCESS | 30971 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 94.0 95.0 11:48:12 INFO - PROCESS | 30971 | 11:48:12 INFO - PROCESS | 30971 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 11:48:12 INFO - PROCESS | 30971 | Values: 64.0 64.0 63.0 65.0 64.0 65.0 64.0 64.0 63.0 63.0 11:48:12 INFO - PROCESS | 30971 | 11:48:12 INFO - PROCESS | 30971 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 11:48:12 INFO - PROCESS | 30971 | Values: 64.0 64.0 64.0 64.0 64.0 64.0 63.0 66.0 65.0 64.0 11:48:12 INFO - PROCESS | 30971 | 11:48:12 INFO - PROCESS | 30971 | [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:78.00 stddev:1.85 (2.4%) stddev-sans-first:1.94 11:48:12 INFO - PROCESS | 30971 | Values: 79.0 77.0 78.0 77.0 77.0 77.0 83.0 77.0 78.0 78.0 11:48:12 INFO - PROCESS | 30971 | 11:48:12 INFO - PROCESS | 30971 | [#11] stanford-crypto-ccm Cycles:10 Average:141.10 Median:138.00 stddev:22.26 (16.1%) stddev-sans-first:22.93 11:48:12 INFO - PROCESS | 30971 | Values: 126.0 138.0 130.0 129.0 137.0 127.0 139.0 145.0 202.0 138.0 11:48:12 INFO - PROCESS | 30971 | 11:48:12 INFO - PROCESS | 30971 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.10 Median:168.00 stddev:3.07 (1.8%) stddev-sans-first:3.23 11:48:12 INFO - PROCESS | 30971 | Values: 167.0 167.0 168.0 169.0 169.0 166.0 168.0 176.0 166.0 165.0 11:48:12 INFO - PROCESS | 30971 | 11:48:12 INFO - PROCESS | 30971 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:1.27 (1.9%) stddev-sans-first:1.33 11:48:12 INFO - PROCESS | 30971 | Values: 67.0 67.0 67.0 67.0 66.0 69.0 67.0 65.0 65.0 65.0 11:48:12 INFO - PROCESS | 30971 | -------- Summary: end -------- 11:48:12 INFO - PROCESS | 30971 | 11:48:13 INFO - TEST-INFO | 30971: exit 0 11:48:13 INFO - TEST-OK | kraken | took 63686ms 11:48:13 INFO - SUITE-END | took 1183s 11:48:13 INFO - Completed test suite (00:19:43) 11:48:13 INFO - javascript benchmark 11:48:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2626.422187118834, 2636.3672718547555, 2636.947261054779, 2672.746089121533, 2678.0760637580042, 4699.647526435522, 4750.07373562155, 4753.786079626417, 4835.516448355158, 4911.189653707139, 4657.441107067149, 4685.1566717990745, 4704.717716936986, 4820.204666230068, 4825.083234185502, 4391.055922976551, 4451.977740111295, 4480.417545719052, 4523.027549076948, 4567.429071366079, 4477.3731677565165, 4518.954810451903, 4522.072975040109, 4536.5236650151755, 4545.36364908913, 4280.293751530994, 4325.805338759764, 4333.0, 4338.783060846977, 4394.604485596312, 4397.582229688174, 4405.11897620474, 4461.196984542781, 4463.0, 4485.775711214426, 4435.844745433894, 4456.754878481682, 4476.194285028693, 4498.955010449887, 4503.2569626012, 4666.0, 4728.952710472886, 4795.088933102699, 4797.928031079502, 4816.903661926742, 5134.255532947702, 5145.614078944094, 5146.150885103953, 5172.715500647463, 5173.146430838907, 5069.290299358093, 5175.01674681813, 5182.222666600041, 5185.870353241199, 5192.662476938987, 4775.188218002948, 4831.589314908272, 4833.10587541306, 4835.975820120877, 4852.320675105488, 5375.919361209585, 5381.946180538144, 5388.91916621251, 5391.218273350342, 5392.0294347017125, 4933.777979990909, 4967.05625931072, 5147.871303217375, 5156.845294641167, 5157.432682404932, 5078.568321692624, 5082.2122571001555, 5088.796448142107, 5102.0, 5154.30416893722, 5032.84901452957, 5038.3198268234055, 5040.143175660073, 5045.84862454127, 5091.974540127276, 4934.703917764946, 4966.776495057731, 5011.624128190328, 5016.247562865599, 5019.0965626187635, 4245.532991370947, 4251.87244382669, 4261.2542805009, 4301.139772045603, 4304.16068866568, 3729.1050147964293, 3741.8503259869844, 3744.64425879541, 3768.9246215075545, 3791.5071040765074, 4398.4941731701265, 4433.667474939392, 4439.378487011821, 4454.821807127743, 4490.685652004394, 5171.043356978971, 5193.792248310026, 5196.272521846944, 5198.4801519847715, 5240.318758561362, 4493.550644935545, 4496.550344965477, 4496.572825581565, 4529.456465224194, 4540.477845047796, 4464.754438505914, 4534.342520334533, 4541.886452838706, 4571.337156112345, 4605.815767369268, 4814.542618451242, 4836.975815120902, 4841.05599408112, 4848.10310092627, 4882.6826256293225, 5152.5620322271525, 5156.97421512905, 5157.458466860926, 5164.638475306692, 5192.83161288707, 4757.381540399726, 4789.898323385711, 4794.184988552024, 4807.110684523374, 4811.374521312207, 4964.950350496449, 5001.124803159505, 5008.69947803133, 5027.698338099725, 5044.1172794761505, 4986.650934434555, 5062.519060689228, 5065.493450654905, 5072.492750725046, 5125.666831655931, 4904.068227036852, 4935.827246046371, 4955.529224723646, 4974.0, 4992.051510213048, 4968.900621987467, 4984.2025275955675, 4994.275830004702, 5009.273655320031, 5038.294638750504, 4802.951970480251, 4827.348307978378, 4915.139850526072, 4927.802887884588, 4970.229614409773, 4575.496695363441, 4891.486393928586, 4968.205087186033, 4994.425641051181, 5041.8487445376695, 4828.565429111397, 4849.684770489906, 4853.781579828846, 4857.562819346276, 4887.144749668722], "value": 4698.771215368731, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.2715290108596, 565.6606036378176, 587.9823605291841, 601.9789307374241, 602.6113157013726, 28533.714662853366, 39952.60047399525, 40507.39238911412, 40715.38926916099, 44988.550114498845, 40408.191836163336, 40845.183096338056, 40873.0, 40974.79512602433, 41105.0, 7386.335229829314, 7882.60586970652, 8015.198480151997, 8035.517868927854, 10047.246456515753, 9974.551145198484, 10344.586216551328, 10345.0, 10346.793064138712, 10347.741306467324, 10320.896791032068, 10353.430561319125, 10366.326188797742, 10366.844497332546, 10370.118539924115, 7449.441291903129, 10180.338278011906, 10271.178305735522, 10321.896781032168, 10441.79116417675, 10153.847692284622, 10217.897821021843, 10223.591056357736, 10231.181505479544, 10239.539220735085, 38970.41544376837, 39067.41398879019, 39283.60716392828, 39354.803225983975, 39401.21197576032, 3169.5404166395742, 3230.0, 3247.983760081208, 3265.575475188234, 3275.1157187559224, 29648.8517557413, 30090.699093009007, 30167.69832301671, 30412.695873041208, 30518.389632207232, 3326.6799733865537, 3335.633080361158, 3357.3285342931513, 3419.4186988211814, 3432.845521951518, 247725.0, 249727.0, 249940.0, 249984.0, 250565.0, 31093.0, 32544.83727581347, 51701.0, 51957.96084078297, 52175.73912130415, 33650.326993459996, 33814.0, 33821.0, 33838.66161338355, 33851.153721156676, 12646.0, 12723.300218488072, 12729.872701273054, 12740.108192426627, 12740.80888786669, 10616.628418005334, 10968.670939871816, 11004.559817607365, 11288.209825312313, 11307.378094204732, 7819.475202335604, 7832.921670783219, 7836.647350869224, 7898.407619428566, 7904.4071694623135, 3053.0, 3065.1417603071177, 3089.212250876012, 3111.6888311169155, 3120.1731541141617, 933.453929451265, 972.4748635736623, 991.8065977134389, 1002.7292630989592, 1004.5730564510054, 27518.724812752018, 28718.856405717837, 29044.564331535043, 29087.56368654472, 29511.26221844428, 929.4748467116193, 967.327707243459, 979.5347210075157, 986.541258314887, 1012.9189664826796, 14873.256337183098, 15165.583101378841, 15233.695326093417, 15370.924035317421, 15708.60728481797, 403862.0, 406748.0, 408246.0, 409538.0, 411200.0, 33378.3324333512, 33699.15752106168, 33740.49389259163, 33881.32237355288, 34006.0, 1071.12703146935, 1177.5584155941692, 1178.4637989714658, 1224.2165014390796, 1227.3617718786359, 28205.71794282031, 29392.41215175727, 29490.85254573799, 30309.242268943453, 30382.240443989078, 42014.36978445265, 42329.365059524745, 42363.57636423596, 42383.576164237966, 42435.1512969745, 247631.0, 247946.0, 248611.0, 249028.0, 249549.0, 22339.66490502611, 24331.51336973286, 25283.87358063198, 25291.850192733087, 26639.0, 42342.0, 42400.15199696051, 42484.575154248065, 43289.783551082044, 43399.78300108479, 36019.639803601625, 37016.444753328185, 37362.43956340603, 37427.81286093552, 37882.810585948, 35848.0, 36930.0, 37019.07452313714, 37382.439263411616, 37842.0, 35522.0, 35558.11104722299, 35909.64090359167, 39466.40800388054, 40339.596604033584, 31768.841155794074, 32759.836200818845, 33365.16587085342, 33451.665483344856, 33727.83136084304, 25694.614580781676, 26008.34979125537, 26114.73885261199, 26485.867570662795, 26669.466610668067], "value": 16810.191824468417, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.1080289859408, 375.63375708684026, 376.34891637467183, 378.3549048871674, 390.4865102390356, 13712.0, 16570.26590612549, 16843.989360638356, 17342.0, 18321.267149314044, 16683.749743753855, 17602.943823370606, 18161.182746776427, 18179.18193681284, 18193.454196374096, 4995.950040499594, 5313.521783039526, 5336.9733151334185, 5340.038793017256, 5342.732863356836, 3689.428138638502, 5205.906759580493, 5887.411258874121, 6212.596181248227, 6247.344028876971, 6229.408206220402, 6262.937370626281, 6321.74713011479, 6322.810315690536, 6329.430351268408, 6154.753809847623, 6285.811425657238, 6305.274893387274, 6305.968470157666, 6306.999999999977, 3399.9830000850084, 5121.590272778169, 5433.7283135843445, 5454.836354909359, 5522.2544956431175, 21059.262925797677, 21856.453588660253, 21873.0, 21879.0, 21903.452413689625, 1922.08700867087, 1944.212593899473, 1956.1001939108028, 2001.7998200180011, 2237.9216727414464, 13507.797383039262, 13546.661333466644, 13698.246596437191, 14028.859711402858, 14136.0, 1787.195761907147, 1829.3231504343346, 1839.5860931290354, 1842.6591080650123, 1890.6502297074949, 70403.2959670407, 72136.63931680308, 72284.0, 72662.63668681623, 73241.63379183123, 8912.598933047899, 9586.712398628053, 9813.754656133653, 9854.655087071918, 10737.0, 12451.688707782198, 13421.127626704232, 13429.39567719455, 13862.653433664038, 13932.791008134885, 7614.885776713354, 7658.2724641159, 7661.808454788675, 7763.805904852424, 7863.764087077397, 7224.530405523624, 7308.451866110063, 7418.851622967511, 7431.591262480507, 7487.0, 6254.405831446005, 6354.0, 6472.870542589122, 6522.869542609216, 6529.54293199481, 1799.9190036448392, 1819.9272029118952, 1831.285798538571, 1843.972340414895, 1854.1934258597553, 813.8413009463217, 912.0833562270009, 912.7991841794794, 950.7480517662825, 973.4013581647235, 17367.91316043437, 17746.822531774516, 18175.72736408955, 18303.35938242155, 18840.717389239173, 879.6921077622909, 895.4045559702855, 895.6596493332491, 914.2000749344323, 933.4912472702393, 10020.799584008424, 10243.180545556337, 10247.0, 10302.33034852732, 10366.118879895143, 380984.0, 385184.0, 387100.0, 388067.0, 389992.0, 72364.63817680984, 74558.0, 74687.0, 74698.62650686712, 75081.24918750742, 912.2063804490136, 932.128459890005, 943.4622265308845, 949.4540639132526, 952.2429668413628, 15642.217889105726, 15843.207839607743, 15847.762283565986, 16109.0, 16175.352985880903, 24009.0, 33546.496802547495, 34452.82773586116, 36399.0, 36617.63382366249, 46198.769006154755, 46353.0, 46590.76704616591, 46804.765976171264, 47113.0, 6984.4063254623925, 7231.927680723125, 8066.153053929253, 8164.550949697824, 8231.670733170606, 7619.809504762204, 12671.493140274286, 12750.489980401051, 12841.35793210317, 13006.349682516025, 9471.337006409485, 9643.132118109404, 10783.784324313312, 10892.18308626872, 11056.060234880126, 10639.361638301727, 10841.837372439577, 11151.442427878736, 11189.552417903193, 11381.54473821038, 10860.185486088418, 11061.22571420025, 11101.38942358178, 11189.160812938899, 11248.550057997589, 6979.092717946634, 7163.283671632795, 7483.401327893646, 7494.587797670963, 7515.098188217449, 10179.338343007681, 10879.292845965303, 11035.227534072537, 11140.554377824796, 11419.942900285445], "value": 8583.184822570782, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1397.7693680542711, 1427.9928600357, 1505.0, 1716.124776364054, 1735.392612585596, 7695.884561731572, 8118.51288922665, 8208.753737387873, 8217.342612590994, 8227.712030078948, 6910.447164226863, 7609.0, 7909.209079092088, 7931.801704957379, 8001.159878212791, 2277.0436416704983, 2300.6779050932882, 2306.527161931808, 2308.572914010905, 2309.214866945238, 2212.6459766437374, 2231.553689262146, 2293.0598454633605, 2295.357299956015, 2295.724513058427, 1892.2998490558443, 1966.223341779996, 1966.9901650491727, 1973.2600274896913, 2143.9785602143934, 2214.745304290003, 2242.1703969531377, 2245.8764767937755, 2249.898754556049, 2250.4261413339577, 2217.7449593296815, 2220.555888822226, 2229.687843701883, 2255.492514184312, 2256.345659758668, 6831.487638427137, 7592.278733520307, 7880.0937892142565, 8050.597470126529, 8122.7157049502985, 4656.697314674535, 4772.2125849234835, 4777.737224452654, 4779.904401911977, 4785.234362501983, 2855.300451389423, 2930.721581449759, 2973.9553906691417, 2978.0470249520163, 2985.402919416104, 896.4307664633005, 897.2507955856802, 910.3400034974657, 917.3991035871514, 920.4017388697333, 10821.891781082168, 10930.344179349186, 10940.945295273552, 10947.83578246319, 10958.28771129874, 4209.4948606166845, 4280.079782846703, 4433.1577000369825, 4487.169873573399, 4490.820367185276, 9441.622335106656, 9484.241260699127, 9491.0, 9499.572519236652, 9500.42997420157, 4755.809767609326, 4757.548032936935, 4766.642501812308, 4774.236122220497, 4775.2359622460235, 4247.851325203603, 4335.067960388532, 4338.82644694215, 4340.52254252032, 4340.826366945287, 3613.9277214455565, 3650.762700424464, 3651.4887915691825, 3705.9808552648237, 3723.6834869035893, 1163.2380790582183, 1169.859616845984, 1183.1185766603935, 1198.7542553776454, 1204.4941124727636, 586.8796896636179, 706.8692291925908, 815.6288888555692, 847.8855354527183, 871.2420194430886, 4873.6832105913, 5253.185756207794, 5288.338957630296, 5309.017831701148, 5355.839324820262, 849.0726051862362, 870.8824308718368, 886.8093359927647, 894.8768301474009, 899.7570655922864, 3492.7729697569575, 3565.893023209308, 3617.6382361763613, 3694.8706795262574, 3720.5535335759882, 9577.138057574852, 9896.752581185385, 9966.103050725469, 10081.596736130472, 10085.899141008642, 9317.16145546904, 9696.70909872705, 9729.416235025921, 9949.353292035994, 9993.750156246007, 7328.816779580553, 7501.512401693873, 7503.212162722944, 7505.812354691067, 7509.061367329084, 5205.921911171411, 5377.758000889891, 5420.376656684532, 5505.146702261156, 5536.390996990247, 8935.642574296955, 9267.258619310303, 9273.53632318395, 9390.342676012613, 9501.619935202514, 9350.719478415658, 9375.156235938799, 9443.527823608654, 9480.573374198315, 9586.185174259987, 6947.4789390796905, 6994.895076573754, 7097.787066388017, 7111.573305601681, 7117.039199707973, 7805.726799561988, 7806.687732490636, 7807.804804879924, 7836.138024817379, 7836.647350869111, 5411.540019098264, 6853.17761868579, 6856.828579285558, 6966.3730264276455, 6988.161420629557, 6632.104665870046, 6763.8985415219795, 6791.0, 6869.072675188786, 6910.274421185703, 6229.470495007975, 6244.438000579969, 6342.270638876588, 6352.777652782315, 6353.491720662429, 4618.284165954283, 4641.071785642953, 4699.342092107039, 4747.952520474751, 4776.0, 4751.049790041936, 4759.143354196278, 4799.352087468147, 4871.171900776805, 4941.0], "value": 4213.834713487249, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.1719060843725, 297.4868352092639, 301.75407043259753, 304.3547678920688, 304.4687021148094, 4943.209086546153, 4950.504949505048, 4959.900801983958, 4971.726555039476, 4979.327790748257, 4835.202191638376, 4908.386451693538, 4917.803287868481, 4919.70481771094, 4925.581325587329, 3647.872324468644, 3793.2413517296513, 3795.013296542891, 3879.844806207748, 3918.09883726743, 3850.2107068051123, 3852.614738526153, 3866.033491627093, 3874.651281384675, 3925.6663183629425, 3679.2825399047197, 3829.961700383002, 3846.653801157895, 3855.1711382052854, 3870.2259548090356, 3762.1723220891495, 3806.505154329947, 3843.5195600549932, 3855.1325951660933, 3872.244912242114, 3371.1290233920163, 3394.35507253621, 3398.711109555666, 3399.507071474647, 3428.8285585720614, 4807.42310922688, 4828.686135401223, 4847.175980083394, 4855.927161092586, 4861.197902346109, 4268.658507319407, 4445.977770111129, 4450.132224216279, 4454.5990860822685, 4460.219461594208, 5132.640715149941, 5134.589232861362, 5141.640085194038, 5144.305518754958, 5161.81933632321, 3720.832562534665, 3724.2737666155112, 3724.2737666155112, 3724.3110024645257, 3738.5887552369218, 5237.476252374732, 5388.410418926426, 5390.434004429557, 5452.781888724447, 5466.644668096601, 3746.6253374662315, 3752.981235093807, 3758.4926034985474, 3770.8680196193, 3773.6792372648633, 3829.7702137871815, 3832.137769001952, 3845.7115716320827, 3848.692104631623, 3877.418387241936, 4378.64970802335, 4387.978060109743, 4392.407025051641, 4401.911961760811, 4402.471703395549, 4906.239532872411, 5119.206522988943, 5119.517034238392, 5128.974355128201, 5144.408393034774, 1274.8271590137097, 1295.3070107492636, 1295.8185853980451, 1300.6033159886135, 1312.7308901675324, 831.5717405536154, 834.3742193354984, 846.627483907079, 870.3124531620076, 874.5933141089424, 4509.301058335963, 4531.818727250873, 4543.136804007228, 4547.909041819145, 4552.476465206543, 5224.648907991419, 5231.659942103827, 5235.424103348629, 5311.336082989626, 5319.547838433777, 4378.671599630041, 4498.302763071663, 4500.527444618333, 4511.142882852248, 4646.6747327686735, 2809.0449247256033, 2841.3606938438684, 2844.615976843141, 2847.2454799478155, 2860.4565132624734, 5040.47075057121, 5041.495850414929, 5045.318881950963, 5052.7726252318735, 5059.406287019577, 5329.840104796862, 5384.326959130109, 5436.157395603609, 5471.671699698031, 5516.0, 4981.227909674007, 4989.70473582149, 5024.924626130611, 5030.471800461045, 5031.270465782514, 5306.187720508137, 5317.893642127213, 5321.308229930084, 5325.254464374913, 5344.679319240858, 5052.317937078447, 5150.793968241228, 5218.112920803548, 5252.842414727565, 5257.763400646903, 4967.081089998362, 4978.377702787152, 5022.447530771539, 5030.57240134578, 5039.143345631325, 3731.888043358595, 3738.7009039277336, 3740.17716102457, 3774.735768496179, 3786.8106594670708, 5101.872453188552, 5232.37211534603, 5278.287431196739, 5321.255024296524, 5357.70532620694, 5085.64400491962, 5112.539871411591, 5137.689889078261, 5146.202338637517, 5150.99555586657, 5118.232265160255, 5130.769115389891, 5133.409657889241, 5181.2746215529105, 5215.55667768244, 4793.616510679068, 4908.852734417973, 5027.818462661198, 5035.295058691713, 5040.168372218543, 4999.425066117443, 5012.248162775612, 5142.254373115952, 5148.613853960893, 5158.97420512895, 5014.423341315795, 5032.169692000779, 5064.290999260033, 5083.38999320084, 5085.720285384339], "value": 3883.7414141812897, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [637.5186734015817, 656.478099910571, 659.7328082126737, 661.087698975414, 666.6233578028414, 12894.677633059178, 12923.870761292384, 13459.5289164879, 13465.057445978786, 13488.527901523448, 13134.146280491785, 13251.668708282297, 13259.337033148327, 13275.668108297274, 13587.728245435086, 623.9188905442309, 759.851828893366, 773.9883901741479, 788.5347644889514, 794.3922898982283, 798.0582912163644, 805.4281460163292, 807.8667019941703, 808.7290757596212, 808.9029316482031, 842.2503971465401, 845.4462327175679, 845.5856630251163, 845.71245776436, 845.9577021148949, 646.7219095788832, 801.7795106345801, 833.5290560833109, 843.725789118539, 844.3667249562828, 605.530713696884, 606.4602503771647, 606.5087279303734, 606.9878602427926, 607.4502575169479, 12977.480900763958, 12984.740305193938, 12995.480180792756, 13015.349232538336, 13019.414126364336, 11783.175177737561, 12565.74868502634, 12667.936660316731, 12894.548690795871, 12929.224246545238, 11403.0, 11686.24039437434, 11873.550519075936, 11942.641720748305, 12254.693632659166, 4185.790710464465, 4193.559676234013, 4245.23585754564, 4267.658587313039, 4346.1090476452255, 64704.0, 66033.0, 66107.66946165287, 66186.66906665484, 66204.33795662079, 9627.181689556326, 9668.178204852666, 9965.0, 10240.53917573696, 10394.792104157874, 16162.0, 16201.513954581382, 16510.504684859232, 16524.83475165257, 16644.50066498007, 6185.783497577563, 6525.967370163119, 6608.43828274602, 6807.115075040213, 6811.591304521745, 3633.94549081764, 3650.5071815305123, 3693.1505753676806, 3742.6257374262354, 3748.756330838487, 2782.2905159184684, 2869.7130286971137, 3290.391277613649, 3459.0314711880715, 3464.7055000325254, 560.966342019472, 561.9438056194348, 565.2877374508067, 566.7676252736359, 567.86655136043, 525.3931708876254, 533.378613914785, 582.6620560075146, 597.7071235094772, 624.0545573456218, 8639.308855291561, 8673.826523469621, 8731.947992221823, 8837.779055523535, 9135.497547634945, 502.3018004973017, 577.3302968556454, 586.6157666728215, 591.3199820206711, 596.931352894414, 4096.651784598283, 4210.5578914214175, 4373.934390984138, 4403.581659742319, 4405.977970110129, 109426.45286773515, 109888.45055774829, 110033.0, 113560.35481679766, 115378.0, 93290.0, 97413.51293243488, 98021.50989245008, 98357.0, 98404.50797745965, 83441.58279208565, 83884.0, 85933.57033214919, 86129.0, 86981.56509217413, 8020.197980201933, 8089.110197878346, 8217.917820821714, 8254.215849494289, 8373.413861029669, 48023.75988120037, 48872.0, 48965.755171223915, 50887.0, 51097.48902511076, 69135.0, 70278.89163325109, 71424.5715085685, 72547.0, 72918.27081729115, 10608.89391106079, 10622.681319560426, 10663.89336106629, 10734.355938643706, 10803.297785643908, 12637.2417654941, 12791.296478693388, 13036.087473876738, 13777.655558611115, 14115.294235287989, 8696.608652610774, 11028.944855275673, 12074.698132546757, 12122.818157727817, 12256.509739610316, 12065.767957564109, 12142.453589588666, 12148.878511214774, 12222.633321000385, 12334.75330493403, 11810.527578897092, 11827.408629568316, 11943.522259109539, 12191.756164876475, 12347.320897350732, 10074.288461252558, 10332.380057196593, 10383.325083869524, 10451.16390688728, 10625.415602141647, 9665.661701840401, 10059.49702514886, 10160.983723416812, 10162.949185254027, 10173.796524069625], "value": 6791.086879559999, "unit": "score"}], "name": "dromaeo_css", "value": 6499.0998711678585, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 116.0, 115.0, 113.0, 115.0, 112.0, 112.0, 113.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 123.0, 128.0, 183.0, 130.0, 129.0, 142.0, 122.0, 168.0, 122.0], "value": 140.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 162.0, 162.0, 162.0, 161.0, 161.0, 160.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 114.0, 76.0, 77.0, 75.0, 74.0, 110.0, 75.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 119.0, 85.0, 85.0, 84.0, 130.0, 86.0, 86.0, 126.0], "value": 97.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 94.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 65.0, 64.0, 65.0, 64.0, 64.0, 63.0, 63.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 63.0, 66.0, 65.0, 64.0], "value": 64.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 78.0, 77.0, 77.0, 77.0, 83.0, 77.0, 78.0, 78.0], "value": 78.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 138.0, 130.0, 129.0, 137.0, 127.0, 139.0, 145.0, 202.0, 138.0], "value": 141.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 167.0, 168.0, 169.0, 169.0, 166.0, 168.0, 176.0, 166.0, 165.0], "value": 168.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 67.0, 66.0, 69.0, 67.0, 65.0, 65.0, 65.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1533.9999999999998, "alertThreshold": 2.0}]} 11:48:13 INFO - Return code: 0 11:48:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:48:13 INFO - # TBPL SUCCESS # 11:48:13 INFO - Running post-action listener: _resource_record_post_action 11:48:13 INFO - ##### 11:48:13 INFO - ##### Finished run-tests step (success) 11:48:13 INFO - ##### 11:48:13 INFO - Running post-run listener: _resource_record_post_run 11:48:13 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 534429696; Read time: 16; Write time: 499264 11:48:13 INFO - TinderboxPrint: CPU usage
13.0% 11:48:13 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 11:48:13 INFO - TinderboxPrint: I/O write bytes / time
534,429,696 / 499,264 11:48:13 INFO - TinderboxPrint: CPU idle
8,334.4 (87.0%) 11:48:13 INFO - TinderboxPrint: CPU user
1,201.3 (12.5%) 11:48:13 INFO - TinderboxPrint: Swap in / out
0 / 0 11:48:13 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 246636544; Read time: 0; Write time: 250252 11:48:13 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 287793152; Read time: 0; Write time: 249012 11:48:14 INFO - Running post-run listener: _upload_blobber_files 11:48:14 INFO - Blob upload gear active. 11:48:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:48:14 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 11:48:14 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:48:14 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:48:14 INFO - (blobuploader) - INFO - Open directory for files ... 11:48:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:48:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:48:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:48:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:48:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:48:19 INFO - (blobuploader) - INFO - Done attempting. 11:48:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:48:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:48:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:48:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:48:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:48:20 INFO - (blobuploader) - INFO - Done attempting. 11:48:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:48:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:48:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:48:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:48:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:48:21 INFO - (blobuploader) - INFO - Done attempting. 11:48:21 INFO - (blobuploader) - INFO - Iteration through files over. 11:48:21 INFO - Return code: 0 11:48:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:48:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:48:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1a3aeaca1dec6b89eb8abc7dd7c4570bd67dc7998093c447b1e17c4fdcca62f8e7dbdf3eaaa31ee52baf257a8060fc69087df9ddc25ff964dd03399abb47e2f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/de2f6e6027a2a77681e12e0ca43fd3e8352e8305541727d5e1fb4357cbb3080d62aadff7e6b1fe35cab8891023c2b578b64951fe8d13f82685a166121afd4805", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ace12ff512ebbf09839c85ff8d54bc7a52b995a87b867569573817ea8439f47e39db967dca65841ce25432c339c96d48e38e25dc88e0ccbff443c48da8f451f7"} 11:48:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:48:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:48:21 INFO - Contents: 11:48:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1a3aeaca1dec6b89eb8abc7dd7c4570bd67dc7998093c447b1e17c4fdcca62f8e7dbdf3eaaa31ee52baf257a8060fc69087df9ddc25ff964dd03399abb47e2f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/de2f6e6027a2a77681e12e0ca43fd3e8352e8305541727d5e1fb4357cbb3080d62aadff7e6b1fe35cab8891023c2b578b64951fe8d13f82685a166121afd4805", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ace12ff512ebbf09839c85ff8d54bc7a52b995a87b867569573817ea8439f47e39db967dca65841ce25432c339c96d48e38e25dc88e0ccbff443c48da8f451f7"} 11:48:21 INFO - Running post-run listener: copy_logs_to_upload_dir 11:48:21 INFO - Copying logs to upload dir... 11:48:21 INFO - mkdir: /builds/slave/test/build/upload/logs 11:48:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.132161 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-07-06 11:48:20.881714) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 11:48:20.887024) ========= 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=fa44defc139c4ba8574fe040000001db-1467829623.222370-406378999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1a3aeaca1dec6b89eb8abc7dd7c4570bd67dc7998093c447b1e17c4fdcca62f8e7dbdf3eaaa31ee52baf257a8060fc69087df9ddc25ff964dd03399abb47e2f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/de2f6e6027a2a77681e12e0ca43fd3e8352e8305541727d5e1fb4357cbb3080d62aadff7e6b1fe35cab8891023c2b578b64951fe8d13f82685a166121afd4805", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ace12ff512ebbf09839c85ff8d54bc7a52b995a87b867569573817ea8439f47e39db967dca65841ce25432c339c96d48e38e25dc88e0ccbff443c48da8f451f7"} build_url:https://queue.taskcluster.net/v1/task/ZIDZC_w1R3OuBUR55IjKOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011224 build_url: 'https://queue.taskcluster.net/v1/task/ZIDZC_w1R3OuBUR55IjKOQ/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/Autoland-Non-PGO/sha512/1a3aeaca1dec6b89eb8abc7dd7c4570bd67dc7998093c447b1e17c4fdcca62f8e7dbdf3eaaa31ee52baf257a8060fc69087df9ddc25ff964dd03399abb47e2f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/de2f6e6027a2a77681e12e0ca43fd3e8352e8305541727d5e1fb4357cbb3080d62aadff7e6b1fe35cab8891023c2b578b64951fe8d13f82685a166121afd4805", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ace12ff512ebbf09839c85ff8d54bc7a52b995a87b867569573817ea8439f47e39db967dca65841ce25432c339c96d48e38e25dc88e0ccbff443c48da8f451f7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 11:48:20.912409) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 11:48:20.912764) ========= 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=fa44defc139c4ba8574fe040000001db-1467829623.222370-406378999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004447 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 11:48:20.997552) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 11:48:20.997880) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 11:48:20.998170) ========= ========= Total master_lag: 0.16 =========