builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-030 starttime: 1468908641.06 results: success (0) buildid: 20160718193132 builduid: 63fddb1cd36a48a0a6c1a63e55f7bc6d revision: fc189ba3703da6ae63a9fd39977c889e1970a486 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 23:10:41.062081) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 23:10:41.062580) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 23:10:41.062852) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 23:10:41.133292) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 23:10:41.133564) ========= 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=4ac8d263c7293b36a1be1aed000001be-1468908639.943238-767283259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-18 23:10:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 86.8M=0s 2016-07-18 23:10:41 (86.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128390 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 23:10:41.275649) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 23:10:41.276028) ========= 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=4ac8d263c7293b36a1be1aed000001be-1468908639.943238-767283259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017564 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 23:10:41.325769) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 23:10:41.326119) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev fc189ba3703da6ae63a9fd39977c889e1970a486 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev fc189ba3703da6ae63a9fd39977c889e1970a486 --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=4ac8d263c7293b36a1be1aed000001be-1468908639.943238-767283259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-18 23:10:41,446 truncating revision to first 12 chars 2016-07-18 23:10:41,446 Setting DEBUG logging. 2016-07-18 23:10:41,446 attempt 1/10 2016-07-18 23:10:41,446 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/fc189ba3703d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-18 23:10:42,510 unpacking tar archive at: mozilla-inbound-fc189ba3703d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.488076 ========= master_lag: 0.27 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 23:10:43.084362) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 23:10:43.084703) ========= script_repo_revision: fc189ba3703da6ae63a9fd39977c889e1970a486 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 23:10:43.085106) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 23:10:43.085372) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 23:10:43.096073) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-18 23:10:43.096462) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4ac8d263c7293b36a1be1aed000001be-1468908639.943238-767283259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:10:43 INFO - MultiFileLogger online at 20160718 23:10:43 in /builds/slave/test 23:10:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 23:10:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:10:43 INFO - {'append_to_log': False, 23:10:43 INFO - 'base_work_dir': '/builds/slave/test', 23:10:43 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 23:10:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:10:43 INFO - 'branch': 'Mozilla-Inbound', 23:10:43 INFO - 'buildbot_json_path': 'buildprops.json', 23:10:43 INFO - 'config_files': ('talos/linux_config.py',), 23:10:43 INFO - 'default_actions': ('clobber', 23:10:43 INFO - 'read-buildbot-config', 23:10:43 INFO - 'download-and-extract', 23:10:43 INFO - 'populate-webroot', 23:10:43 INFO - 'create-virtualenv', 23:10:43 INFO - 'install', 23:10:43 INFO - 'run-tests'), 23:10:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:10:43 INFO - 'download_minidump_stackwalk': True, 23:10:43 INFO - 'download_symbols': 'ondemand', 23:10:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:10:43 INFO - 'tooltool.py': '/tools/tooltool.py', 23:10:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:10:43 INFO - '/tools/misc-python/virtualenv.py')}, 23:10:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:10:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:10:43 INFO - 'installer_path': 'installer.exe', 23:10:43 INFO - 'log_level': 'info', 23:10:43 INFO - 'log_name': 'talos', 23:10:43 INFO - 'log_to_console': True, 23:10:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:10:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:10:43 INFO - 'opt_config_files': (), 23:10:43 INFO - 'pip_index': False, 23:10:43 INFO - 'sps_profile': False, 23:10:43 INFO - 'sps_profile_interval': 0, 23:10:43 INFO - 'suite': 'dromaeojs', 23:10:43 INFO - 'system_bits': '32', 23:10:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:10:43 INFO - 'title': 'talos-linux64-ix-030', 23:10:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:10:43 INFO - 'use_talos_json': True, 23:10:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:10:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:10:43 INFO - 'work_dir': 'build'} 23:10:43 INFO - ##### 23:10:43 INFO - ##### Running clobber step. 23:10:43 INFO - ##### 23:10:43 INFO - Running pre-action listener: _resource_record_pre_action 23:10:43 INFO - Running main action method: clobber 23:10:43 INFO - rmtree: /builds/slave/test/build 23:10:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:10:43 INFO - Running post-action listener: _resource_record_post_action 23:10:43 INFO - ##### 23:10:43 INFO - ##### Finished clobber step (success) 23:10:43 INFO - ##### 23:10:43 INFO - ##### 23:10:43 INFO - ##### Running read-buildbot-config step. 23:10:43 INFO - ##### 23:10:43 INFO - Running pre-action listener: _resource_record_pre_action 23:10:43 INFO - Running main action method: read_buildbot_config 23:10:43 INFO - Using buildbot properties: 23:10:43 INFO - { 23:10:43 INFO - "project": "", 23:10:43 INFO - "product": "firefox", 23:10:43 INFO - "script_repo_revision": "production", 23:10:43 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 23:10:43 INFO - "repository": "", 23:10:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 23:10:43 INFO - "buildid": "20160718193132", 23:10:43 INFO - "pgo_build": "True", 23:10:43 INFO - "basedir": "/builds/slave/test", 23:10:43 INFO - "buildnumber": 1360, 23:10:43 INFO - "slavename": "talos-linux64-ix-030", 23:10:43 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:10:43 INFO - "platform": "ubuntu64_hw", 23:10:43 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 23:10:43 INFO - "branch": "mozilla-inbound", 23:10:43 INFO - "repo_path": "integration/mozilla-inbound", 23:10:43 INFO - "revision": "fc189ba3703da6ae63a9fd39977c889e1970a486", 23:10:43 INFO - "stage_platform": "linux64-pgo", 23:10:43 INFO - "builduid": "63fddb1cd36a48a0a6c1a63e55f7bc6d", 23:10:43 INFO - "slavebuilddir": "test" 23:10:43 INFO - } 23:10:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/dxFeDfqSTfq0CJd9MiiL4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 23:10:43 INFO - Running post-action listener: _resource_record_post_action 23:10:43 INFO - ##### 23:10:43 INFO - ##### Finished read-buildbot-config step (success) 23:10:43 INFO - ##### 23:10:43 INFO - ##### 23:10:43 INFO - ##### Running download-and-extract step. 23:10:43 INFO - ##### 23:10:43 INFO - Running pre-action listener: _resource_record_pre_action 23:10:43 INFO - Running main action method: download_and_extract 23:10:43 INFO - mkdir: /builds/slave/test/build/tests 23:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:43 INFO - https://queue.taskcluster.net/v1/task/dxFeDfqSTfq0CJd9MiiL4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:10:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxFeDfqSTfq0CJd9MiiL4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:10:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxFeDfqSTfq0CJd9MiiL4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:10:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxFeDfqSTfq0CJd9MiiL4g/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 23:10:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxFeDfqSTfq0CJd9MiiL4g/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 23:10:44 INFO - Downloaded 1361 bytes. 23:10:44 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:10:44 INFO - Using the following test package requirements: 23:10:44 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:10:44 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:10:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:10:44 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:10:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:10:44 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:10:44 INFO - u'jsshell-linux-x86_64.zip'], 23:10:44 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:10:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:10:44 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:10:44 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:10:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:10:44 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:10:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:10:44 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:10:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:10:44 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:10:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:10:44 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:10:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:44 INFO - https://queue.taskcluster.net/v1/task/dxFeDfqSTfq0CJd9MiiL4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:10:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxFeDfqSTfq0CJd9MiiL4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:10:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxFeDfqSTfq0CJd9MiiL4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:10:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxFeDfqSTfq0CJd9MiiL4g/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 23:10:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxFeDfqSTfq0CJd9MiiL4g/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 23:10:45 INFO - Downloaded 24336005 bytes. 23:10:45 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'] 23:10:45 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 23:10:46 INFO - Return code: 0 23:10:46 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 23:10:46 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')]} 23:10:46 INFO - https://queue.taskcluster.net/v1/task/dxFeDfqSTfq0CJd9MiiL4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:10:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxFeDfqSTfq0CJd9MiiL4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:10:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxFeDfqSTfq0CJd9MiiL4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:10:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxFeDfqSTfq0CJd9MiiL4g/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 23:10:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxFeDfqSTfq0CJd9MiiL4g/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 23:10:47 INFO - Downloaded 24336005 bytes. 23:10:47 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'] 23:10:47 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 23:10:49 INFO - Return code: 0 23:10:49 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')]} 23:10:49 INFO - https://queue.taskcluster.net/v1/task/dxFeDfqSTfq0CJd9MiiL4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:10:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxFeDfqSTfq0CJd9MiiL4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:10:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxFeDfqSTfq0CJd9MiiL4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:10:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxFeDfqSTfq0CJd9MiiL4g/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 23:10:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxFeDfqSTfq0CJd9MiiL4g/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 23:10:50 INFO - Downloaded 14403317 bytes. 23:10:50 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'] 23:10:50 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 23:10:50 INFO - Return code: 0 23:10:50 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')]} 23:10:50 INFO - https://queue.taskcluster.net/v1/task/dxFeDfqSTfq0CJd9MiiL4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:10:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxFeDfqSTfq0CJd9MiiL4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:10:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxFeDfqSTfq0CJd9MiiL4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:10:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxFeDfqSTfq0CJd9MiiL4g/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 23:10:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxFeDfqSTfq0CJd9MiiL4g/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 23:10:51 INFO - Downloaded 60848221 bytes. 23:10:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dxFeDfqSTfq0CJd9MiiL4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:10:51 INFO - mkdir: /builds/slave/test/properties 23:10:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:10:51 INFO - Writing to file /builds/slave/test/properties/build_url 23:10:51 INFO - Contents: 23:10:51 INFO - build_url:https://queue.taskcluster.net/v1/task/dxFeDfqSTfq0CJd9MiiL4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:10:52 INFO - Running post-action listener: _resource_record_post_action 23:10:52 INFO - Running post-action listener: set_extra_try_arguments 23:10:52 INFO - ##### 23:10:52 INFO - ##### Finished download-and-extract step (success) 23:10:52 INFO - ##### 23:10:52 INFO - ##### 23:10:52 INFO - ##### Running populate-webroot step. 23:10:52 INFO - ##### 23:10:52 INFO - Running pre-action listener: _resource_record_pre_action 23:10:52 INFO - Running main action method: populate_webroot 23:10:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:10:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:10:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:10:52 INFO - '--tppagecycles', 23:10:52 INFO - '7'], 23:10:52 INFO - 'tests': ['tsvgm']}}, 23:10:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:10:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:10:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:10:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:10:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:10:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:10:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:10:52 INFO - 'talos_options': ['--disable-e10s'], 23:10:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:10:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:10:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:10:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:10:52 INFO - 'talos_options': ['--disable-e10s'], 23:10:52 INFO - 'tests': ['damp', 'tps']}, 23:10:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:10:52 INFO - 'tests': ['damp', 'tps']}, 23:10:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:10:52 INFO - 'tests': ['dromaeo_dom']}, 23:10:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:10:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:10:52 INFO - 'tests': ['basic_compositor_video']}, 23:10:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:10:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:10:52 INFO - 'tests': ['a11yr', 23:10:52 INFO - 'ts_paint', 23:10:52 INFO - 'tpaint', 23:10:52 INFO - 'sessionrestore', 23:10:52 INFO - 'sessionrestore_no_auto_restore', 23:10:52 INFO - 'tabpaint']}, 23:10:52 INFO - 'other-e10s': {'tests': ['a11yr', 23:10:52 INFO - 'ts_paint', 23:10:52 INFO - 'tpaint', 23:10:52 INFO - 'sessionrestore', 23:10:52 INFO - 'sessionrestore_no_auto_restore', 23:10:52 INFO - 'tabpaint']}, 23:10:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:10:52 INFO - 'ts_paint', 23:10:52 INFO - 'tpaint', 23:10:52 INFO - 'sessionrestore', 23:10:52 INFO - 'sessionrestore_no_auto_restore', 23:10:52 INFO - 'tabpaint']}, 23:10:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:10:52 INFO - 'ts_paint', 23:10:52 INFO - 'tpaint', 23:10:52 INFO - 'sessionrestore', 23:10:52 INFO - 'sessionrestore_no_auto_restore', 23:10:52 INFO - 'tabpaint']}, 23:10:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:10:52 INFO - 'tests': ['a11yr', 23:10:52 INFO - 'ts_paint', 23:10:52 INFO - 'tpaint', 23:10:52 INFO - 'sessionrestore', 23:10:52 INFO - 'sessionrestore_no_auto_restore', 23:10:52 INFO - 'tabpaint']}, 23:10:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:10:52 INFO - 'tests': ['a11yr', 23:10:52 INFO - 'ts_paint', 23:10:52 INFO - 'tpaint', 23:10:52 INFO - 'sessionrestore', 23:10:52 INFO - 'sessionrestore_no_auto_restore', 23:10:52 INFO - 'tabpaint']}, 23:10:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:10:52 INFO - 'tests': ['tsvgx', 23:10:52 INFO - 'tsvgr_opacity', 23:10:52 INFO - 'tart', 23:10:52 INFO - 'tscrollx', 23:10:52 INFO - 'cart']}, 23:10:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:10:52 INFO - 'tsvgr_opacity', 23:10:52 INFO - 'tart', 23:10:52 INFO - 'tscrollx', 23:10:52 INFO - 'cart']}, 23:10:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:10:52 INFO - 'talos_options': ['--disable-e10s'], 23:10:52 INFO - 'tests': ['tp5o']}, 23:10:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:10:52 INFO - 'tests': ['tp5o']}, 23:10:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:10:52 INFO - 'talos_options': ['--disable-e10s', 23:10:52 INFO - '--xperf_path', 23:10:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:10:52 INFO - 'tests': ['tp5n']}, 23:10:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:10:52 INFO - 'talos_options': ['--xperf_path', 23:10:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:10:52 INFO - 'tests': ['tp5n']}}, 23:10:52 INFO - 'talos.zip': {'path': '', 23:10:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:10:52 INFO - Running post-action listener: _resource_record_post_action 23:10:52 INFO - ##### 23:10:52 INFO - ##### Finished populate-webroot step (success) 23:10:52 INFO - ##### 23:10:52 INFO - ##### 23:10:52 INFO - ##### Running create-virtualenv step. 23:10:52 INFO - ##### 23:10:52 INFO - Running pre-action listener: _resource_record_pre_action 23:10:52 INFO - Running main action method: create_virtualenv 23:10:52 INFO - Creating virtualenv /builds/slave/test/build/venv 23:10:52 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 23:10:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:10:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:10:52 INFO - Using real prefix '/usr' 23:10:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:10:53 INFO - Installing distribute.............................................................................................................................................................................................done. 23:10:55 INFO - Installing pip.................done. 23:10:55 INFO - Return code: 0 23:10:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:10:55 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')]} 23:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:55 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')]} 23:10:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:55 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 0xe1c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db3b0>, '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 0x10dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc740>, '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': '4ac8d263c7293b36a1be1aed000001be-1468908639.943238-767283259', '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 23:10:55 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 23:10:55 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 23:10:55 INFO - Using env: {'DISPLAY': ':0', 23:10:55 INFO - 'HOME': '/home/cltbld', 23:10:55 INFO - 'LANG': 'en_US.UTF-8', 23:10:55 INFO - 'LANGUAGE': 'en_US:en', 23:10:55 INFO - 'LOGNAME': 'cltbld', 23:10:55 INFO - 'MAIL': '/var/mail/cltbld', 23:10:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:55 INFO - 'MOZ_NO_REMOTE': '1', 23:10:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:55 INFO - 'NO_EM_RESTART': '1', 23:10:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:55 INFO - 'PWD': '/builds/slave/test', 23:10:55 INFO - 'SHELL': '/bin/bash', 23:10:55 INFO - 'SHLVL': '1', 23:10:55 INFO - 'TERM': 'linux', 23:10:55 INFO - 'TMOUT': '86400', 23:10:55 INFO - 'USER': 'cltbld', 23:10:55 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1468908639.943238-767283259', 23:10:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:55 INFO - '_': '/tools/buildbot/bin/python'} 23:10:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:55 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 23:10:55 INFO - Cleaning up... 23:10:55 INFO - Return code: 0 23:10:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:10:55 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')]} 23:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:55 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')]} 23:10:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:55 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 0xe1c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db3b0>, '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 0x10dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc740>, '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': '4ac8d263c7293b36a1be1aed000001be-1468908639.943238-767283259', '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 23:10:55 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 23:10:55 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 23:10:55 INFO - Using env: {'DISPLAY': ':0', 23:10:55 INFO - 'HOME': '/home/cltbld', 23:10:55 INFO - 'LANG': 'en_US.UTF-8', 23:10:55 INFO - 'LANGUAGE': 'en_US:en', 23:10:55 INFO - 'LOGNAME': 'cltbld', 23:10:55 INFO - 'MAIL': '/var/mail/cltbld', 23:10:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:55 INFO - 'MOZ_NO_REMOTE': '1', 23:10:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:55 INFO - 'NO_EM_RESTART': '1', 23:10:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:55 INFO - 'PWD': '/builds/slave/test', 23:10:55 INFO - 'SHELL': '/bin/bash', 23:10:55 INFO - 'SHLVL': '1', 23:10:55 INFO - 'TERM': 'linux', 23:10:55 INFO - 'TMOUT': '86400', 23:10:55 INFO - 'USER': 'cltbld', 23:10:55 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1468908639.943238-767283259', 23:10:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:55 INFO - '_': '/tools/buildbot/bin/python'} 23:10:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:55 INFO - Downloading/unpacking psutil>=3.1.1 23:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:10:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:10:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:10:57 INFO - Installing collected packages: psutil 23:10:57 INFO - Running setup.py install for psutil 23:10:57 INFO - building 'psutil._psutil_linux' extension 23:10:57 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 23:10: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_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 23:10:57 INFO - building 'psutil._psutil_posix' extension 23:10:57 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 23:10:58 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 23:10:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:10:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:10:58 INFO - Successfully installed psutil 23:10:58 INFO - Cleaning up... 23:10:58 INFO - Return code: 0 23:10:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db3b0>, '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 0x10dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc740>, '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': '4ac8d263c7293b36a1be1aed000001be-1468908639.943238-767283259', '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 23:10:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:10:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:10:58 INFO - Using env: {'DISPLAY': ':0', 23:10:58 INFO - 'HOME': '/home/cltbld', 23:10:58 INFO - 'LANG': 'en_US.UTF-8', 23:10:58 INFO - 'LANGUAGE': 'en_US:en', 23:10:58 INFO - 'LOGNAME': 'cltbld', 23:10:58 INFO - 'MAIL': '/var/mail/cltbld', 23:10:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:58 INFO - 'MOZ_NO_REMOTE': '1', 23:10:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:58 INFO - 'NO_EM_RESTART': '1', 23:10:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:58 INFO - 'PWD': '/builds/slave/test', 23:10:58 INFO - 'SHELL': '/bin/bash', 23:10:58 INFO - 'SHLVL': '1', 23:10:58 INFO - 'TERM': 'linux', 23:10:58 INFO - 'TMOUT': '86400', 23:10:58 INFO - 'USER': 'cltbld', 23:10:58 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1468908639.943238-767283259', 23:10:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:58 INFO - '_': '/tools/buildbot/bin/python'} 23:10:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:10:58 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 23:10:58 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 23:10:58 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 23:10:58 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 23:10:58 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 23:10:58 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 23:11:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:11:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:11:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:11:00 INFO - Installing collected packages: mozsystemmonitor 23:11:00 INFO - Running setup.py install for mozsystemmonitor 23:11:00 INFO - Successfully installed mozsystemmonitor 23:11:00 INFO - Cleaning up... 23:11:00 INFO - Return code: 0 23:11:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:11:00 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')]} 23:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:11:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:00 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')]} 23:11:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:11:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:00 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 0xe1c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db3b0>, '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 0x10dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc740>, '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': '4ac8d263c7293b36a1be1aed000001be-1468908639.943238-767283259', '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 23:11:00 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 23:11:00 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 23:11:00 INFO - Using env: {'DISPLAY': ':0', 23:11:00 INFO - 'HOME': '/home/cltbld', 23:11:00 INFO - 'LANG': 'en_US.UTF-8', 23:11:00 INFO - 'LANGUAGE': 'en_US:en', 23:11:00 INFO - 'LOGNAME': 'cltbld', 23:11:00 INFO - 'MAIL': '/var/mail/cltbld', 23:11:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:11:00 INFO - 'MOZ_NO_REMOTE': '1', 23:11:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:11:00 INFO - 'NO_EM_RESTART': '1', 23:11:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:11:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:11:00 INFO - 'PWD': '/builds/slave/test', 23:11:00 INFO - 'SHELL': '/bin/bash', 23:11:00 INFO - 'SHLVL': '1', 23:11:00 INFO - 'TERM': 'linux', 23:11:00 INFO - 'TMOUT': '86400', 23:11:00 INFO - 'USER': 'cltbld', 23:11:00 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1468908639.943238-767283259', 23:11:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:11:00 INFO - '_': '/tools/buildbot/bin/python'} 23:11:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:11:00 INFO - Downloading/unpacking jsonschema==2.5.1 23:11:00 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 23:11:00 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 23:11:00 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 23:11:00 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 23:11:00 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 23:11:00 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 23:11:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:11:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:11: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 23:11: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 23:11: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 23:11: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 23:11: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 23:11: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 23:11:02 INFO - Downloading functools32-3.2.3-2.tar.gz 23:11:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:11:02 INFO - warning: no files found matching '*.txt' 23:11:02 INFO - no previously-included directories found matching 'build' 23:11:02 INFO - no previously-included directories found matching 'dist' 23:11:02 INFO - no previously-included directories found matching '.git*' 23:11:02 INFO - Installing collected packages: jsonschema, functools32 23:11:02 INFO - Running setup.py install for functools32 23:11:03 INFO - warning: no files found matching '*.txt' 23:11:03 INFO - no previously-included directories found matching 'build' 23:11:03 INFO - no previously-included directories found matching 'dist' 23:11:03 INFO - no previously-included directories found matching '.git*' 23:11:03 INFO - Successfully installed jsonschema functools32 23:11:03 INFO - Cleaning up... 23:11:03 INFO - Return code: 0 23:11:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:11:03 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')]} 23:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:11:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:03 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')]} 23:11:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:11:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:03 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 0xe1c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db3b0>, '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 0x10dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc740>, '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': '4ac8d263c7293b36a1be1aed000001be-1468908639.943238-767283259', '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 23:11:03 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 23:11:03 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 23:11:03 INFO - Using env: {'DISPLAY': ':0', 23:11:03 INFO - 'HOME': '/home/cltbld', 23:11:03 INFO - 'LANG': 'en_US.UTF-8', 23:11:03 INFO - 'LANGUAGE': 'en_US:en', 23:11:03 INFO - 'LOGNAME': 'cltbld', 23:11:03 INFO - 'MAIL': '/var/mail/cltbld', 23:11:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:11:03 INFO - 'MOZ_NO_REMOTE': '1', 23:11:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:11:03 INFO - 'NO_EM_RESTART': '1', 23:11:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:11:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:11:03 INFO - 'PWD': '/builds/slave/test', 23:11:03 INFO - 'SHELL': '/bin/bash', 23:11:03 INFO - 'SHLVL': '1', 23:11:03 INFO - 'TERM': 'linux', 23:11:03 INFO - 'TMOUT': '86400', 23:11:03 INFO - 'USER': 'cltbld', 23:11:03 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1468908639.943238-767283259', 23:11:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:11:03 INFO - '_': '/tools/buildbot/bin/python'} 23:11:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:11:03 INFO - Downloading/unpacking blobuploader==1.2.4 23:11:03 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 23:11:03 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 23:11:03 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 23:11:03 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 23:11:03 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 23:11:03 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 23:11:05 INFO - Downloading blobuploader-1.2.4.tar.gz 23:11:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:11:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:11:05 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 23:11:05 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 23:11:05 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 23:11:05 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 23:11:05 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 23:11:05 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 23:11:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:11:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:11:05 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 23:11:05 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 23:11:05 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 23:11:05 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 23:11:05 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 23:11:05 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 23:11:05 INFO - Downloading docopt-0.6.1.tar.gz 23:11:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:11:06 INFO - Installing collected packages: blobuploader, requests, docopt 23:11:06 INFO - Running setup.py install for blobuploader 23:11:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:11:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:11:06 INFO - Running setup.py install for requests 23:11:06 INFO - Running setup.py install for docopt 23:11:06 INFO - Successfully installed blobuploader requests docopt 23:11:06 INFO - Cleaning up... 23:11:06 INFO - Return code: 0 23:11:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:11:06 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')]} 23:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:11:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:06 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')]} 23:11:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:11:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:06 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 0xe1c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db3b0>, '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 0x10dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc740>, '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': '4ac8d263c7293b36a1be1aed000001be-1468908639.943238-767283259', '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 23:11:06 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 23:11:06 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 23:11:06 INFO - Using env: {'DISPLAY': ':0', 23:11:06 INFO - 'HOME': '/home/cltbld', 23:11:06 INFO - 'LANG': 'en_US.UTF-8', 23:11:06 INFO - 'LANGUAGE': 'en_US:en', 23:11:06 INFO - 'LOGNAME': 'cltbld', 23:11:06 INFO - 'MAIL': '/var/mail/cltbld', 23:11:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:11:06 INFO - 'MOZ_NO_REMOTE': '1', 23:11:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:11:06 INFO - 'NO_EM_RESTART': '1', 23:11:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:11:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:11:06 INFO - 'PWD': '/builds/slave/test', 23:11:06 INFO - 'SHELL': '/bin/bash', 23:11:06 INFO - 'SHLVL': '1', 23:11:06 INFO - 'TERM': 'linux', 23:11:06 INFO - 'TMOUT': '86400', 23:11:06 INFO - 'USER': 'cltbld', 23:11:06 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1468908639.943238-767283259', 23:11:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:11:06 INFO - '_': '/tools/buildbot/bin/python'} 23:11:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:11:06 INFO - Running setup.py (path:/tmp/pip-YDKK19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:11:06 INFO - Running setup.py (path:/tmp/pip-Ol1CNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:11:06 INFO - Running setup.py (path:/tmp/pip-eDi18m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:11:07 INFO - Running setup.py (path:/tmp/pip-xBiilF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:11:07 INFO - Running setup.py (path:/tmp/pip-yfuePz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:11:07 INFO - Running setup.py (path:/tmp/pip-P0qJx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:11:07 INFO - Running setup.py (path:/tmp/pip-fvTWud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:11:07 INFO - Running setup.py (path:/tmp/pip-wZxOXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:11:07 INFO - Running setup.py (path:/tmp/pip-ojJWT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:11:07 INFO - Running setup.py (path:/tmp/pip-nRuCIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:11:07 INFO - Running setup.py (path:/tmp/pip-ANkPa1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:11:07 INFO - Running setup.py (path:/tmp/pip-vrI6Zm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:11:07 INFO - Running setup.py (path:/tmp/pip-LiVRv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:11:07 INFO - Running setup.py (path:/tmp/pip-jfZ9ze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:11:07 INFO - Running setup.py (path:/tmp/pip-0qnxlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:11:07 INFO - Running setup.py (path:/tmp/pip-bk5WMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:11:07 INFO - Running setup.py (path:/tmp/pip-kT2UAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:11:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:11:08 INFO - Running setup.py install for manifestparser 23:11:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:11:08 INFO - Running setup.py install for mozcrash 23:11:08 INFO - Running setup.py install for mozdebug 23:11:08 INFO - Running setup.py install for mozdevice 23:11:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:11:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:11:08 INFO - Running setup.py install for mozfile 23:11:08 INFO - Running setup.py install for mozhttpd 23:11:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:11:08 INFO - Running setup.py install for mozinfo 23:11:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:11:08 INFO - Running setup.py install for mozInstall 23:11:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:11:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:11:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:11:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:11:08 INFO - Running setup.py install for mozleak 23:11:08 INFO - Running setup.py install for mozlog 23:11:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:11:09 INFO - Running setup.py install for moznetwork 23:11:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:11:09 INFO - Running setup.py install for mozprocess 23:11:09 INFO - Running setup.py install for mozprofile 23:11:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:11:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:11:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:11:09 INFO - Running setup.py install for mozrunner 23:11:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:11:09 INFO - Running setup.py install for mozscreenshot 23:11:09 INFO - Running setup.py install for moztest 23:11:09 INFO - Running setup.py install for mozversion 23:11:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:11:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:11:09 INFO - Cleaning up... 23:11:09 INFO - Return code: 0 23:11:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:11:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:11:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:11:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:11:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:09 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 0xe1c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db3b0>, '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 0x10dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc740>, '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': '4ac8d263c7293b36a1be1aed000001be-1468908639.943238-767283259', '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 23:11:09 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 23:11:09 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 23:11:09 INFO - Using env: {'DISPLAY': ':0', 23:11:09 INFO - 'HOME': '/home/cltbld', 23:11:09 INFO - 'LANG': 'en_US.UTF-8', 23:11:09 INFO - 'LANGUAGE': 'en_US:en', 23:11:09 INFO - 'LOGNAME': 'cltbld', 23:11:09 INFO - 'MAIL': '/var/mail/cltbld', 23:11:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:11:09 INFO - 'MOZ_NO_REMOTE': '1', 23:11:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:11:09 INFO - 'NO_EM_RESTART': '1', 23:11:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:11:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:11:09 INFO - 'PWD': '/builds/slave/test', 23:11:09 INFO - 'SHELL': '/bin/bash', 23:11:09 INFO - 'SHLVL': '1', 23:11:09 INFO - 'TERM': 'linux', 23:11:09 INFO - 'TMOUT': '86400', 23:11:09 INFO - 'USER': 'cltbld', 23:11:09 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1468908639.943238-767283259', 23:11:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:11:09 INFO - '_': '/tools/buildbot/bin/python'} 23:11:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:11:10 INFO - Running setup.py (path:/tmp/pip-cM4PT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:11:10 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)) 23:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:11:10 INFO - Running setup.py (path:/tmp/pip-3hguOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:11:10 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)) 23:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:11:10 INFO - Running setup.py (path:/tmp/pip-LPMlXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:11:10 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)) 23:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:11:10 INFO - Running setup.py (path:/tmp/pip-sINzJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:11:10 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)) 23:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:11:10 INFO - Running setup.py (path:/tmp/pip-9dCdN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:11:10 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)) 23:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:11:10 INFO - Running setup.py (path:/tmp/pip-w_NiCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:11:10 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)) 23:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:11:10 INFO - Running setup.py (path:/tmp/pip-XiOjwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:11:10 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)) 23:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:11:10 INFO - Running setup.py (path:/tmp/pip-oCbJ4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:11:10 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)) 23:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:11:10 INFO - Running setup.py (path:/tmp/pip-FFTslL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:11:10 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)) 23:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:11:10 INFO - Running setup.py (path:/tmp/pip-UplB8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:11:10 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)) 23:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:11:10 INFO - Running setup.py (path:/tmp/pip-frs6NQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:11:10 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)) 23:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:11:10 INFO - Running setup.py (path:/tmp/pip-dUItC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:11: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)) 23:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:11:10 INFO - Running setup.py (path:/tmp/pip-jCAU9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:11: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)) 23:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:11:11 INFO - Running setup.py (path:/tmp/pip-fR6UuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:11:11 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)) 23:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:11:11 INFO - Running setup.py (path:/tmp/pip-miudfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:11:11 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)) 23:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:11:11 INFO - Running setup.py (path:/tmp/pip-LOiTEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:11:11 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)) 23:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:11:11 INFO - Running setup.py (path:/tmp/pip-zlSzzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:11:11 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)) 23:11:11 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)) 23:11:11 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)) 23:11:11 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)) 23:11:11 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)) 23:11:11 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)) 23:11:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:11:11 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 23:11:11 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 23:11:11 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 23:11:11 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 23:11:11 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 23:11:11 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 23:11:13 INFO - Downloading blessings-1.6.tar.gz 23:11:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:11:13 INFO - Installing collected packages: blessings 23:11:13 INFO - Running setup.py install for blessings 23:11:13 INFO - Successfully installed blessings 23:11:13 INFO - Cleaning up... 23:11:13 INFO - Return code: 0 23:11:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:11:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:11:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:11:13 INFO - Reading from file tmpfile_stdout 23:11:13 INFO - Current package versions: 23:11:13 INFO - argparse == 1.2.1 23:11:13 INFO - blessings == 1.6 23:11:13 INFO - blobuploader == 1.2.4 23:11:13 INFO - docopt == 0.6.1 23:11:13 INFO - functools32 == 3.2.3-2 23:11:13 INFO - jsonschema == 2.5.1 23:11:13 INFO - manifestparser == 1.1 23:11:13 INFO - mozInstall == 1.12 23:11:13 INFO - mozcrash == 0.17 23:11:13 INFO - mozdebug == 0.1 23:11:13 INFO - mozdevice == 0.48 23:11:13 INFO - mozfile == 1.2 23:11:13 INFO - mozhttpd == 0.7 23:11:13 INFO - mozinfo == 0.9 23:11:13 INFO - mozleak == 0.1 23:11:13 INFO - mozlog == 3.2 23:11:13 INFO - moznetwork == 0.27 23:11:13 INFO - mozprocess == 0.23 23:11:13 INFO - mozprofile == 0.28 23:11:13 INFO - mozrunner == 6.12 23:11:13 INFO - mozscreenshot == 0.1 23:11:13 INFO - mozsystemmonitor == 0.3 23:11:13 INFO - moztest == 0.7 23:11:13 INFO - mozversion == 1.4 23:11:13 INFO - psutil == 3.1.1 23:11:13 INFO - requests == 1.2.3 23:11:13 INFO - wsgiref == 0.1.2 23:11:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:11:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:11:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:11:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:11:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:13 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 0xe1c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db3b0>, '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 0x10dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc740>, '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': '4ac8d263c7293b36a1be1aed000001be-1468908639.943238-767283259', '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 23:11:13 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 23:11:13 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 23:11:13 INFO - Using env: {'DISPLAY': ':0', 23:11:13 INFO - 'HOME': '/home/cltbld', 23:11:13 INFO - 'LANG': 'en_US.UTF-8', 23:11:13 INFO - 'LANGUAGE': 'en_US:en', 23:11:13 INFO - 'LOGNAME': 'cltbld', 23:11:13 INFO - 'MAIL': '/var/mail/cltbld', 23:11:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:11:13 INFO - 'MOZ_NO_REMOTE': '1', 23:11:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:11:13 INFO - 'NO_EM_RESTART': '1', 23:11:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:11:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:11:13 INFO - 'PWD': '/builds/slave/test', 23:11:13 INFO - 'SHELL': '/bin/bash', 23:11:13 INFO - 'SHLVL': '1', 23:11:13 INFO - 'TERM': 'linux', 23:11:13 INFO - 'TMOUT': '86400', 23:11:13 INFO - 'USER': 'cltbld', 23:11:13 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1468908639.943238-767283259', 23:11:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:11:13 INFO - '_': '/tools/buildbot/bin/python'} 23:11:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:11:13 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)) 23:11:13 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)) 23:11:13 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)) 23:11:13 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)) 23:11:13 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)) 23:11:13 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)) 23:11:13 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)) 23:11:13 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)) 23:11:13 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)) 23:11:13 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)) 23:11:13 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)) 23:11:13 INFO - Cleaning up... 23:11:13 INFO - Return code: 0 23:11:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:11:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:11:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:11:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:11:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:13 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 0xe1c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db3b0>, '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 0x10dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc740>, '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': '4ac8d263c7293b36a1be1aed000001be-1468908639.943238-767283259', '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 23:11:13 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 23:11:13 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 23:11:13 INFO - Using env: {'DISPLAY': ':0', 23:11:13 INFO - 'HOME': '/home/cltbld', 23:11:13 INFO - 'LANG': 'en_US.UTF-8', 23:11:13 INFO - 'LANGUAGE': 'en_US:en', 23:11:13 INFO - 'LOGNAME': 'cltbld', 23:11:13 INFO - 'MAIL': '/var/mail/cltbld', 23:11:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:11:13 INFO - 'MOZ_NO_REMOTE': '1', 23:11:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:11:13 INFO - 'NO_EM_RESTART': '1', 23:11:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:11:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:11:13 INFO - 'PWD': '/builds/slave/test', 23:11:13 INFO - 'SHELL': '/bin/bash', 23:11:13 INFO - 'SHLVL': '1', 23:11:13 INFO - 'TERM': 'linux', 23:11:13 INFO - 'TMOUT': '86400', 23:11:13 INFO - 'USER': 'cltbld', 23:11:13 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1468908639.943238-767283259', 23:11:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:11:13 INFO - '_': '/tools/buildbot/bin/python'} 23:11:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:11:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:11:14 INFO - Cleaning up... 23:11:14 INFO - Return code: 0 23:11:14 INFO - Running post-action listener: _resource_record_post_action 23:11:14 INFO - Running post-action listener: _start_resource_monitoring 23:11:14 INFO - Starting resource monitoring. 23:11:14 INFO - ##### 23:11:14 INFO - ##### Finished create-virtualenv step (success) 23:11:14 INFO - ##### 23:11:14 INFO - ##### 23:11:14 INFO - ##### Running install step. 23:11:14 INFO - ##### 23:11:14 INFO - Running pre-action listener: _resource_record_pre_action 23:11:14 INFO - Running main action method: install 23:11:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:11:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:11:14 INFO - Reading from file tmpfile_stdout 23:11:14 INFO - Detecting whether we're running mozinstall >=1.0... 23:11:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:11:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:11:14 INFO - Reading from file tmpfile_stdout 23:11:14 INFO - Output received: 23:11:14 INFO - Usage: mozinstall [options] installer 23:11:14 INFO - Options: 23:11:14 INFO - -h, --help show this help message and exit 23:11:14 INFO - -d DEST, --destination=DEST 23:11:14 INFO - Directory to install application into. [default: 23:11:14 INFO - "/builds/slave/test"] 23:11:14 INFO - --app=APP Application being installed. [default: firefox] 23:11:14 INFO - mkdir: /builds/slave/test/build/application 23:11:14 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'] 23:11:14 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 23:11:31 INFO - Reading from file tmpfile_stdout 23:11:31 INFO - Output received: 23:11:31 INFO - /builds/slave/test/build/application/firefox/firefox 23:11:31 INFO - Running post-action listener: _resource_record_post_action 23:11:31 INFO - ##### 23:11:31 INFO - ##### Finished install step (success) 23:11:31 INFO - ##### 23:11:31 INFO - ##### 23:11:31 INFO - ##### Running run-tests step. 23:11:31 INFO - ##### 23:11:31 INFO - Running pre-action listener: _resource_record_pre_action 23:11:31 INFO - Running main action method: run_tests 23:11:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:11:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:11:31 INFO - Python 2.7.3 23:11:31 INFO - Return code: 0 23:11:31 INFO - grabbing minidump binary from tooltool 23:11: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')]} 23:11:31 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 0x10db3b0>, '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 0x10dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:11:31 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 23:11:31 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 23:11:31 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 23:11:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:11:31 INFO - Return code: 0 23:11:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:11:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:11:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:11:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:11:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:11:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dxFeDfqSTfq0CJd9MiiL4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 23:11:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dxFeDfqSTfq0CJd9MiiL4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 23:11:31 INFO - Using env: {'DISPLAY': ':0', 23:11:31 INFO - 'HOME': '/home/cltbld', 23:11:31 INFO - 'LANG': 'en_US.UTF-8', 23:11:31 INFO - 'LANGUAGE': 'en_US:en', 23:11:31 INFO - 'LOGNAME': 'cltbld', 23:11:31 INFO - 'MAIL': '/var/mail/cltbld', 23:11:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:11:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:11:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:11:31 INFO - 'MOZ_NO_REMOTE': '1', 23:11:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:11:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:11:31 INFO - 'NO_EM_RESTART': '1', 23:11:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:11:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:11:31 INFO - 'PWD': '/builds/slave/test', 23:11:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:11:31 INFO - 'SHELL': '/bin/bash', 23:11:31 INFO - 'SHLVL': '1', 23:11:31 INFO - 'TERM': 'linux', 23:11:31 INFO - 'TMOUT': '86400', 23:11:31 INFO - 'USER': 'cltbld', 23:11:31 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1468908639.943238-767283259', 23:11:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:11:31 INFO - '_': '/tools/buildbot/bin/python'} 23:11:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dxFeDfqSTfq0CJd9MiiL4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 23:11:31 INFO - mozversion application_buildid: 20160718193132 23:11:31 INFO - mozversion application_changeset: fc189ba3703da6ae63a9fd39977c889e1970a486 23:11:31 INFO - mozversion application_display_name: Nightly 23:11:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:11:31 INFO - mozversion application_name: Firefox 23:11:31 INFO - mozversion application_remotingname: firefox 23:11:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 23:11:31 INFO - mozversion application_vendor: Mozilla 23:11:31 INFO - mozversion application_version: 50.0a1 23:11:31 INFO - mozversion platform_buildid: 20160718193132 23:11:31 INFO - mozversion platform_changeset: fc189ba3703da6ae63a9fd39977c889e1970a486 23:11:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 23:11:31 INFO - mozversion platform_version: 50.0a1 23:11:31 INFO - using testdate: 1468908691 23:11:31 INFO - actual date: 1468908691 23:11:31 INFO - starting webserver on 'localhost:45773' 23:11:31 INFO - SUITE-START | Running 2 tests 23:11:31 INFO - TEST-START | dromaeo_css 23:11:31 INFO - operating with platform_type : linux_ 23:11:31 INFO - Initialising browser for dromaeo_css test... 23:11:31 INFO - TEST-INFO | started process 32428 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKyc0oL/profile http://localhost:45773/getInfo.html) 23:11:35 INFO - PROCESS | 32428 | __metrics Screen width/height:1600/1200 23:11:35 INFO - PROCESS | 32428 | colorDepth:24 23:11:35 INFO - PROCESS | 32428 | Browser inner width/height: 1024/697 23:11:35 INFO - PROCESS | 32428 | __metrics 23:11:36 INFO - PROCESS | 32428 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 23:11:36 INFO - PROCESS | 32428 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:11:37 INFO - TEST-INFO | 32428: exit 0 23:11:37 INFO - Browser initialized. 23:11:37 INFO - Running cycle 1/1 for dromaeo_css test... 23:11:37 INFO - TEST-INFO | started process 32514 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKyc0oL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:11:49 INFO - PROCESS | 32514 | RSS: Main: 157622272 23:11:49 INFO - PROCESS | 32514 | 23:12:41 INFO - PROCESS | 32514 | 1468908761129 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] 23:14:48 INFO - PROCESS | 32514 | Cycle 1(1): loaded http://localhost:45773/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45773/tests/dromaeo/cssquery-ext.html) 23:14:50 INFO - PROCESS | 32514 | RSS: Main: 323837952 23:14:50 INFO - PROCESS | 32514 | 23:17:52 INFO - PROCESS | 32514 | Cycle 1(1): loaded http://localhost:45773/tests/dromaeo/cssquery-ext.html (next: http://localhost:45773/tests/dromaeo/cssquery-jquery.html) 23:17:53 INFO - PROCESS | 32514 | RSS: Main: 248619008 23:17:53 INFO - PROCESS | 32514 | 23:20:55 INFO - PROCESS | 32514 | Cycle 1(1): loaded http://localhost:45773/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45773/tests/dromaeo/cssquery-mootools.html) 23:20:56 INFO - PROCESS | 32514 | RSS: Main: 252354560 23:20:56 INFO - PROCESS | 32514 | 23:23:58 INFO - PROCESS | 32514 | Cycle 1(1): loaded http://localhost:45773/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45773/tests/dromaeo/cssquery-prototype.html) 23:23:58 INFO - PROCESS | 32514 | RSS: Main: 245874688 23:23:58 INFO - PROCESS | 32514 | 23:27:01 INFO - PROCESS | 32514 | Cycle 1(1): loaded http://localhost:45773/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45773/tests/dromaeo/cssquery-yui.html) 23:27:01 INFO - PROCESS | 32514 | RSS: Main: 215838720 23:27:01 INFO - PROCESS | 32514 | 23:30:04 INFO - PROCESS | 32514 | Cycle 1(1): loaded http://localhost:45773/tests/dromaeo/cssquery-yui.html (next: http://localhost:45773/tests/dromaeo/cssquery-dojo.html) 23:30:05 INFO - PROCESS | 32514 | RSS: Main: 300187648 23:30:05 INFO - PROCESS | 32514 | 23:30:05 INFO - PROCESS | 32514 | __start_tp_report 23:30:05 INFO - PROCESS | 32514 | _x_x_mozilla_page_load 23:30:05 INFO - PROCESS | 32514 | _x_x_mozilla_page_load_details 23:30:05 INFO - PROCESS | 32514 | |i|pagename|runs| 23:30:05 INFO - PROCESS | 32514 | |0;dojo.html;3033.2265272355544;3036.9088927332173;3039.2249976256053;3081;3102.16241614764;5354.598405119617;5365.946340536593;5433.701146436944;5445.50990410863;5485.149801780725;5412.756425960832;5429.619926605139;5437.8368648940595;5449.155380915964;5487.780488780454;4892.8532144035735;4969.900601987958;4987.276844857493;4993.725345106018;5102.948970510284;5005.199168133099;5017.096922553938;5058.468860769622;5068.594512438996;5077.5684066854365;4880.755962201893;4925.605951523869;4926.507349265081;4950.133726597831;4977.452480227154;4953.0836795192645;4958.454569997298;5009.624278179152;5010.048090862724;5050.949490505084;4871.5128487151005;4945.381827271591;4986.750662466862;4996.150654388763;5024.145895197825;5331.413544510101;5390.757415916293;5402.864928376783;5454.91817622736;5457.781688732446;5801;5820.185174075633;5829.09649004405;5829.88340233193;5831.795887143972;5688.943110568883;5753.338366087912;5872.7357268923;5878.118282257653;5879.029960056586;5370.91943620846;5391;5395.433479484676;5433.4566543345745;5439.292891924025;5925.111233315038;6013.6993150342305;6016.669083200466;6016.969915150396;6026.969865150646;5574.052411090124;5637.520810731134;5678.744456499468;5773.364929857712;5776.277965254343;5862.12068189775;5901.911471327933;5902.675352855548;5908.763649453974;5911.467967882825;5765.85585360361;5806.970965145148;5817.331006934172;5818.185454036438;5821.854453638608;5710.685912274865;5741.138829175574;5762.798302059407;5777.653340799566;5825.79609713658;4415.801288942005;4416.183006143874;4417.933730994037;4418.5802348776815;4453.888652783641;3933.6066393361007;3951.2887680217837;3955.7033222508426;3992.960070399317;4009.7393669411395;5336.599755018389;5439.048166570834;5447.428020057916;5476.835694929158;5512.944870551323;5839.328477225088;5841.561882858718;5851.21008663825;5865.941340586625;5866.8533286667325;5541.889162216814;5544.473275038865;5545.833624991256;5550.056490396642;5553.750081246354;4929.728864912464;5023.799048038038;5069.112905241568;5079.822206222764;5133.050385678662;6105.725242364104;6107.816765497042;6114.38856114385;6116.3577824328695;6119.785807496716;5912.349641539513;5918.023526118142;5920.585559010828;5921.052631578927;5924.526037917042;5884.7940322088525;5930.851728706817;5973.1338955852025;5981.820545383472;6037;5714.771409143587;5747.942520574741;5749.195112684144;5757.8560535986935;5760.0783874579865;5768.50967667753;5800.24596802413;5836.445537673914;5856.560757943086;5862.296524417097;5672.092465205712;5776.480116789509;5777.6822274775295;5779.248697669276;5779.884402312015;5738.626989245686;5750.367459579359;5750.9424905752085;5752.511036561772;5757.596968212185;5632.571996027806;5663.66018038919;5666.46168613981;5669.064604340238;5673.092305231308;5701.087825947994;5769.451902069297;5769.74036168365;5775.27809023872;5783.277090363705;5607.411221821813;5649.406812284651;5663.32040155184;5663.631863928831;5676.517496012885 23:30:05 INFO - PROCESS | 32514 | |1;ext.html;621.5214285000549;632.7279269913938;639.8336432527542;650.6356440393383;653.784251197105;42536;44208.77895610521;44465.999999999956;48422.27366589495;48589.25393429181;44895.55104448955;44953.7752311238;45294.547054529445;45370.546294537045;45371.09257814842;9015.098490150998;9140.72577822663;9143.268538516902;9149.725508234731;9149.771255718593;8993.190612844843;9028.774280643003;9086.136817002374;9086.182243598076;9096.681616143436;9124.726258212264;9146.359754817166;9153.221976132003;9153.67962121326;9160.770980725501;9007.864882026775;9030.50332231727;9046.140616641442;9076.591553380047;9080.137386948229;8912.688055918012;8958.37291389603;8968.730938071803;8974.730758077269;8978.955105224431;43907.560924390666;44329.335059974124;44353.334699979525;44362.778186108866;44450.33324500103;3701.648343407372;3794.2221844521805;4190.329547272422;4241.957580424187;4317.546657600969;33239.66760332414;33578.54215820191;33680;34552.48171277433;34730.65269347299;4213.494380674308;4285.892852678677;4289.2922667759785;4343.587359200902;4469.061497085616;257052;257708;257860;258581;259751;51501.227481587805;59376.70311648414;59617;59791.40208597858;59906.400935990954;58939.41060589339;60833.695831520556;60846.39153608496;65838.34161658418;65967.34032659708;17009.14954252307;17090.230939607747;17146.05696686694;17179.742303865452;17244.310227591006;11571.247868888495;11837;13268.800967985488;13343.132696374705;13394.464221431033;15336.769948450783;16278.75581866273;16693.582660433345;16708.08105554206;16773.496795096165;6359.872802543923;6422.133012043408;6480.773172938924;6525.4779617630475;6546.279909209983;1046.602291129366;1091.841682955967;1099.725068732817;1150.4017910686396;1170.5551890281638;32421.351572968408;32909.83545082307;33290.167745806066;33511.497327540106;33564.328713425595;1117.385438009108;1129.6272230164027;1145.3299819605456;1211.787937111002;1217.3548019549653;17352.39266625662;17393.65212695739;17404.39084632032;17496.662083258685;17560.473185804447;481673;482243;482763;485985;486540;59286.703566482756;59301.11048334278;59312;59328.11007834886;59370.406295937355;1235.2958813476232;1331.2478449675903;1350.8514063453013;1385.6605131742788;1389.7428975639539;30856.691433085383;34704;34749.652503475656;34776.65223347835;35047.12382190364;52131;52209;53131.20303195532;53142.73428632987;53156.468435316696;521099;530106;530546;530999;531015;36982.815085925475;38157.236855262185;38415.6158438412;38484.61515384923;42422.575774243094;49960;50579;51013.744931275105;51109.744451277504;51972.22041669454;42442.78778606087;43563.78218108889;44304.778476107414;44599;45088.54911450975;42872.14255714806;42897.571024289355;43064.13871722485;43578.78210608927;44185;41842.37236441517;42846.78576607097;42955.14089718251;43255.567444325156;43309.350359744;35590;37716.43425348567;37967.00340725611;38148;38431;27727.861360693067;28410.289742756595;28422;28610.70976837607;28706.282342941595 23:30:05 INFO - PROCESS | 32514 | |2;jquery.html;400.1736414304461;400.9879703608893;404.1069236986262;407.2181411689556;414.1055320507702;18834.434966950997;19654;20639.277625283117;20653.586928261426;20675;19032.33386831461;19211.711824322647;20547.075381607825;20577.27979520717;20636.277730279442;5682.289713785777;5848.502877255417;5979.701014949257;5985.700714964234;6008.579399442041;5840.299164100293;5867.76528938842;5912.17229587858;5915.792947246847;5919.1713160157615;5809.448102430262;5922.3485416604135;5924.644521328734;5952.58331916766;5965.552583556229;5637.605367624268;5930.288365396159;5935.64386136831;5939.495142912858;5972.134040564138;5716.256886604757;5803.651780893118;5843.795467158671;5851.76592936282;5853.76584936602;23414.53170936589;23680.526389472114;24316.7568324318;24953.126640567494;24955.126570569944;2349.694539709844;2394.365493144318;2445.6942882139733;2514.6856642919633;2829.957550636742;10343;10552.47237638115;10641.308314959502;10728.517216725188;10751.731206719816;1940.3111895277113;1941.1264930781206;1968.4193163016944;1997.510609900569;2008.8794672319561;52547;74762.62618686871;74874;87659.56170219109;88991.55504222437;10192.28653994228;10462.110720588684;10588.470576471145;10940.070094042096;10952.069074128629;14417.567472975617;14509.637259068397;14892.627684307763;14917.70164596702;15389.846101538842;8098.959505202436;8129.390295727844;8285.751427457186;8326.833463330699;8397.412181147383;7784.338331241908;7800.609969501502;7894.60526973649;7960.164182760843;8017.8396432072195;4698.543451530037;4840.420785452906;4844.346013288232;4927.236278376858;4974.577160941288;1968.4980330015753;2017.1427143463968;2060.526079001838;2062.61841559309;2086.290661175208;952.6665667016628;988.17981075707;1001.7896241789306;1029.4389557691077;1076.424113099488;19968.600627987358;20732.792672073087;20954.37136885896;21094.367168984954;21269.46826329354;993.2947607198826;1000.484750353554;1008.8839783425;1023.2070145637191;1089.700332408578;10895.945520272506;11491.195616306946;11585.131115166396;11598.594049208406;11620.302781832948;473022;484793;492726;495459;496186;89883.55058224667;92108;95335.52332238294;96929;98419;1004.487711267259;1036.8237399642078;1054.135608800776;1054.920880933933;1058.0371861605902;14275.571732847615;16256.268467918735;17138.828611713725;17967.5508112293;18849.717254240924;45446.09107817891;45797.64922332373;46036.30945535753;46082.308765367874;47616.000319965904;58308;60002;61565;61623.383766163555;62697;8522.616482258189;8630.180132887366;8747.081556436737;8892.599833007402;9029.367944244103;10499.527521261409;13446.327683615584;13940.442382304595;14143.222122783345;14153.858461415253;11326.660200194008;11528.884711153116;11535.192536522363;11811.350375729417;12214;11540.480678369662;11676.065914726632;11916.821247681119;12136.878631213927;12316.384180791103;11392.145589080686;11399.544018239178;11453.141014424118;11621.709457263636;12700.936495317834;8623.396362254582;8651.6971905983;8695.652173912973;8702.782430439289;8750.562471876254;11020.118390528898;11990.28058316469;12012.819807703067;12119.091068170099;12367.62897113088 23:30:05 INFO - PROCESS | 32514 | |3;mootools.html;1491.0382803092007;1536.9538913832585;1696.2366934879299;1817.2095138614695;1856.2389420337656;8887.11128887111;9196;9241.861372079424;9248.260139188866;9269.536523173849;7808.570528620923;8399.244068033875;8678.349123815708;8694.347923905716;9089.545522723854;2365.5978483657777;2391.210900402863;2395.4490467192554;2398.0168131066266;2405.170216275391;2368.3723813189517;2373.6320870265135;2403.639454081893;2407.67496387988;2407.9277621671376;2106.3680895731295;2318.6406107053435;2391.1152873436854;2391.390195500154;2396.388920825187;2416.6375043743406;2441.926742197728;2443.230382429529;2451.080844683244;2464.4208610976407;2366.893489792946;2367.360812580611;2397.772211639909;2402.423418379594;2410.8553486790847;9160.083991600786;9274.629014839398;9280.396774209723;9281;9301.72094837156;5350.0904846176245;5483.588730845203;5495.972520137414;5501.724913754297;5504.972475137599;3322.966770332314;3397.6262611112757;3443.5351227584456;3445.0353900907785;3521.295740851814;1037.5227395398126;1058.714147180257;1103.0954617213888;1111.9777604447947;1112.238116889933;12898.032647551378;12920.41858116387;12934.805977910339;12944.288064156373;12963.740725185538;4646.4888862225125;4692.601128904082;4890.070886531547;4893.804247830047;4935.284383764334;10721.731956701145;10737.409442480583;10739.355638661706;10752.731181720363;10769.569217231223;5498.505134537911;5498.642588231752;5499.7250137492965;5503.6147469677535;5509.090999985037;5001.174806156943;5066.974665126724;5067.5185857343495;5133.307003554472;5149.562287205629;4092.544473316046;4120.690948178899;4133.772642504631;4186.995121170897;4188.623023927861;1189.2210602055668;1209.9274043557414;1264.9620511384674;1295.559509766684;1300.2133709106045;682.5290549520814;910.644848509082;981.2787601113176;1004.864343313658;1007.0885848307147;5964.940350596526;6032.577719559677;6187.969060154671;6188.257409110935;6223.533235007392;987.980240395188;994.2791476179856;1018.3737001743874;1022.2180032275315;1029.4955471818755;3953.881383558498;3977.3238549446664;3977.960220397817;4016.658584020391;4022.8390864365683;10877.619283325046;11301.717457063474;11324.37715925632;11363.659090227306;11487.827682584768;10168.389896606228;11314.490847911864;11367.772644547063;11374;11375.772484550263;7922.801929951682;8313.958430207811;8327.875736775457;8468.49189048659;8503.489790612459;6216.751329946932;6255.499560035278;6374.93625063762;6392.776252831129;6411.743530258924;10440.738981525523;10473.581056757645;10682.679519614425;10703;10732.73168170802;10637.414942178255;10733.570657173626;10887.129029677766;10973.615923442641;11033.117350611772;8108.351331893552;8120.106788253405;8201.71294004707;8205.097439281793;8214.05538363096;8184.181581841768;8443.07126216128;8481.491110533389;8800.867986980073;8884.77788055278;6325.620462772248;7870.29167374939;7962.562059086806;8142.552159631277;8160.347172226327;7911.208879112043;8048.5975701215875;8125.146859579659;8128.349732021542;8196.262336389753;7140.07179066718;7217.097862767154;7251.093613298338;7289.1981881994;7321.816954576178;5111.846644600668;5216.165413533817;5217.556507696889;5340.359156901197;5391.487808658171;5127.79488820443;5230.555402790653;5272.0773864572775;5316.734163291742;5379.031774280511 23:30:05 INFO - PROCESS | 32514 | |4;prototype.html;336.7171575876264;338.34361339002334;342.9279851231241;346.3073852295409;348.4842433198864;5400.756965936533;5402.972985135074;5418.2685337479425;5440.891182176359;5446.863828404292;5294.841154765353;5365.678059316444;5371.623986320959;5393.406725260218;5407.972960135194;3997.9600203998025;4174.394712766647;4254.27677294859;4255.2978758504805;4267.530571637133;4115.485564304462;4191.329387298033;4202.684798640099;4234.788260586958;4251.915761480818;4171.582841715835;4181.707280490367;4182;4200.894977625569;4228.5137209220875;3958.3072962231495;4004.279229738646;4137.110521237948;4174.519930208035;4191.721524934894;3665.4318580620047;3670.3209906167444;3700.4449332600057;3702.426123950792;3702.9629703702885;4933.2486967126515;5093.1850903855575;5118.616103792193;5164.715940623264;5184.144616138333;4591.701539399928;4710;4728.432588089417;4750.809967601292;4762.547557981986;5534.778608855641;5545.033407127208;5554.555635549146;5559.471850174267;5570.136628822539;3885.6502914737525;3916.74541154824;3964.781936993464;3983.322835118037;4012.9197416051516;5575.212393803098;5646.830595082154;5657.971710141464;5660.122680984454;5662.263905692274;4063.817128229237;4065.8576949806616;4070.1249231415386;4078.1639763848934;4082.142750022469;4190.120074784269;4192.203481338597;4193.370994350811;4193.790310484464;4202.726822756511;4500.412262948752;4727.621790256771;4738.507370178383;4766.404199475066;4779.259214821708;5511.889762204733;5533.280673512418;5537.473939975695;5602.6918519481005;5615.747291371898;1418.936147873348;1440.6974535347485;1445.7542217822995;1448.8406275309708;1449.0219102106037;913.5706218077493;964.286428043243;973.9318247722733;978.5254151736402;979.1725991537139;5352;5366.6779993200535;5378.220158077057;5384.838454846283;5390.595705322116;5396.3524377075;5605.887882242332;5616.494515493625;5646.407127251579;5693.3168019837885;5170.612204084633;5200.5059519345605;5270.761371077793;5317.760700768475;5381.165919282517;2926.5024945759274;2976.4493568689863;2984.1495173875774;3019.04899956513;3042.452358575433;5696.8860622787315;5810.738516766755;5812.59311848175;5825.368896708928;5832.9708351457975;5795.1165871091225;5798.246227990334;5808.941910580925;5819.53443724501;5824.94175058244;5840.474357307863;5845.766169353264;5852.912206316909;5853.678047707417;5857.707114644166;5535.280413546213;5654.717264136694;5733.942660573508;5740.13897915316;5763.164341170591;5544.085225937675;5650.717464126859;5655.264815573949;5679.602427830012;5691.4877661010705;5729.656220626775;5813.94186058134;5886.999210134373;5893.499052580579;5913.911291330547;3998.940015899822;4004.1190937993597;4010;4010.418489319091;4012.6990475713856;5683.829485115453;5692.402297758676;5698.831739493477;5778.682172480554;5811.476967072984;5528.585356098229;5608.551315894637;5623.003833639163;5644.153376993484;5663.801766938137;5514.283143191359;5523.944760552343;5588.105903055492;5589.860253493695;5601.859953501195;5473.781048758165;5482.081271554924;5495.340559132929;5512.614117011771;5514.255575497256;5319.38827034896;5584.86037849057;5600.467955544217;5655.547556195576;5677.261955945701;5553.861153471195;5569.359523654832;5575.526080283059;5588.720563971867;5591.552675786009 23:30:05 INFO - PROCESS | 32514 | |5;yui.html;750.0998801438269;776.6776787633136;786.5634572812087;802.1457148137233;811.298227033616;15251.694966100671;16797.66404671906;16800.159992000397;16802.495925122235;16807.075610841413;15272.618184545392;15392.461263855766;15413.07521548705;15416.537503874903;15455.072695638242;658.0918332700878;788.9408294377915;810.116972499975;812.7114874219656;816.4162623724036;821.4044817507319;824.4435006370705;826.1573195340749;828.7555171224503;829.0093338460512;691.8028361916855;869.6390997735964;871.333429926107;873.4977388001893;874.0647507167333;850.995745021274;866.1079088538816;867.6009035843457;869.1656010230187;869.5174178331024;637.7544645311542;638.936106389362;639.2169592249504;639.4596565901805;639.4820195641498;15851.365945362171;15863.286152123066;15883.205839708084;15901.1254381009;15903.840961590467;12691.428885700165;12806.743865122738;12839.679008024781;13073.411696473682;13486.932565337209;13162.670933226651;13168.407421665952;13217.20696758188;13383.799243011264;13469;4320.675949303814;4339.609435150852;4343.118323029381;4475.39582156408;4479.3504941783585;74544.25455745481;74695.62652186705;75381.62309188474;77652.28217012434;79578;11385.14611404148;11412.543498260142;11515.366654833897;11600.361980091177;11858.347790871585;20501.17995280172;20523.38429847077;20540.691889621667;20548.486287842923;20759.68860467094;8722.084181160886;8745.912540874637;8770.473771573726;8792.208701216921;8829.11708829112;4718.575328220477;4817.325574419584;5026.899462010812;5040.722760248222;5087.745612719349;3480.599731030913;3584.802835844054;3599.460080987873;3599.478075679064;3600.531930848973;635.1996484429652;678.8710145072421;710.0946293475756;716.7563028570311;718.7960166720826;722.631457956446;742.9665665045086;748.8764353881548;752.27405553641;770.9922900771032;9567.61729530825;9764.316497845082;9934.701958941243;10582.470876456146;10830.891691083147;634.5938599296454;664.6244871647503;747.723342363329;757.238974830292;768.3085223299075;4621.907561848744;4639.930401043987;4641.234196357631;4674.836380726658;4765.26138448541;98802;100657;102794;117553.41223293828;130722.34638826746;84100.57949710212;103779.481102594;105017;106265.46867265615;108105;94953;96272;97040.51479742557;97870.21297870156;97885.51057244668;10199.31230556262;10498.055175034284;10563.495893300409;10945.83581246298;10988.230823842254;55209.44790552043;56154.43845561492;56625.43374566202;57046.144307834584;58933.705331473066;80370;84655.57672211599;84919;85066.74666266785;85300.57349713212;12723.172993755376;13030.4136313868;13047.673808154872;13113.207078608624;13620.65948351299;15117.95667791013;16050.839491604935;16051.197440127713;16085.678286433971;16821.831781682027;14901;15041.172735499653;15367.385304587691;15990.920045399698;16002;13984.300784960915;14175.291235438393;14201.147931124166;14244.715105698035;14299.785503217669;14034;14381;14496;14740.705185896008;14784.260786960824;10550;10625.628103016357;10826.621068262573;10914;10934.507947142238;11662;11666.941665291619;11888.28670279786;11907.642770716893;12140.878591214328 23:30:05 INFO - PROCESS | 32514 | __end_tp_report 23:30:05 INFO - PROCESS | 32514 | __start_cc_report 23:30:05 INFO - PROCESS | 32514 | _x_x_mozilla_cycle_collect,1697 23:30:05 INFO - PROCESS | 32514 | __end_cc_report 23:30:05 INFO - PROCESS | 32514 | __startTimestamp1468909805162__endTimestamp 23:30:05 INFO - PROCESS | 32514 | 23:30:05 INFO - PROCESS | 32514 | ------- Summary: start ------- 23:30:05 INFO - PROCESS | 32514 | Number of tests: 6 23:30:05 INFO - PROCESS | 32514 | 23:30:05 INFO - PROCESS | 32514 | [#0] dojo.html Cycles:165 Average:5420.59 Median:5663.66 stddev:629.13 (11.1%) stddev-sans-first:602.53 23:30:05 INFO - PROCESS | 32514 | Values: 3033.2 3036.9 3039.2 3081.0 3102.2 5354.6 5365.9 5433.7 5445.5 5485.1 5412.8 5429.6 5437.8 5449.2 5487.8 4892.9 4969.9 4987.3 4993.7 5102.9 5005.2 5017.1 5058.5 5068.6 5077.6 4880.8 4925.6 4926.5 4950.1 4977.5 4953.1 4958.5 5009.6 5010.0 5050.9 4871.5 4945.4 4986.8 4996.2 5024.1 5331.4 5390.8 5402.9 5454.9 5457.8 5801.0 5820.2 5829.1 5829.9 5831.8 5688.9 5753.3 5872.7 5878.1 5879.0 5370.9 5391.0 5395.4 5433.5 5439.3 5925.1 6013.7 6016.7 6017.0 6027.0 5574.1 5637.5 5678.7 5773.4 5776.3 5862.1 5901.9 5902.7 5908.8 5911.5 5765.9 5807.0 5817.3 5818.2 5821.9 5710.7 5741.1 5762.8 5777.7 5825.8 4415.8 4416.2 4417.9 4418.6 4453.9 3933.6 3951.3 3955.7 3993.0 4009.7 5336.6 5439.0 5447.4 5476.8 5512.9 5839.3 5841.6 5851.2 5865.9 5866.9 5541.9 5544.5 5545.8 5550.1 5553.8 4929.7 5023.8 5069.1 5079.8 5133.1 6105.7 6107.8 6114.4 6116.4 6119.8 5912.3 5918.0 5920.6 5921.1 5924.5 5884.8 5930.9 5973.1 5981.8 6037.0 5714.8 5747.9 5749.2 5757.9 5760.1 5768.5 5800.2 5836.4 5856.6 5862.3 5672.1 5776.5 5777.7 5779.2 5779.9 5738.6 5750.4 5750.9 5752.5 5757.6 5632.6 5663.7 5666.5 5669.1 5673.1 5701.1 5769.5 5769.7 5775.3 5783.3 5607.4 5649.4 5663.3 5663.6 5676.5 23:30:05 INFO - PROCESS | 32514 | 23:30:05 INFO - PROCESS | 32514 | [#1] ext.html Cycles:180 Average:59821.46 Median:43743.17 stddev:116768.42 (266.9%) stddev-sans-first:117011.39 23:30:05 INFO - PROCESS | 32514 | Values: 621.5 632.7 639.8 650.6 653.8 42536.0 44208.8 44466.0 48422.3 48589.3 44895.6 44953.8 45294.5 45370.5 45371.1 9015.1 9140.7 9143.3 9149.7 9149.8 8993.2 9028.8 9086.1 9086.2 9096.7 9124.7 9146.4 9153.2 9153.7 9160.8 9007.9 9030.5 9046.1 9076.6 9080.1 8912.7 8958.4 8968.7 8974.7 8979.0 43907.6 44329.3 44353.3 44362.8 44450.3 3701.6 3794.2 4190.3 4242.0 4317.5 33239.7 33578.5 33680.0 34552.5 34730.7 4213.5 4285.9 4289.3 4343.6 4469.1 257052.0 257708.0 257860.0 258581.0 259751.0 51501.2 59376.7 59617.0 59791.4 59906.4 58939.4 60833.7 60846.4 65838.3 65967.3 17009.1 17090.2 17146.1 17179.7 17244.3 11571.2 11837.0 13268.8 13343.1 13394.5 15336.8 16278.8 16693.6 16708.1 16773.5 6359.9 6422.1 6480.8 6525.5 6546.3 1046.6 1091.8 1099.7 1150.4 1170.6 32421.4 32909.8 33290.2 33511.5 33564.3 1117.4 1129.6 1145.3 1211.8 1217.4 17352.4 17393.7 17404.4 17496.7 17560.5 481673.0 482243.0 482763.0 485985.0 486540.0 59286.7 59301.1 59312.0 59328.1 59370.4 1235.3 1331.2 1350.9 1385.7 1389.7 30856.7 34704.0 34749.7 34776.7 35047.1 52131.0 52209.0 53131.2 53142.7 53156.5 521099.0 530106.0 530546.0 530999.0 531015.0 36982.8 38157.2 38415.6 38484.6 42422.6 49960.0 50579.0 51013.7 51109.7 51972.2 42442.8 43563.8 44304.8 44599.0 45088.5 42872.1 42897.6 43064.1 43578.8 44185.0 41842.4 42846.8 42955.1 43255.6 43309.4 35590.0 37716.4 37967.0 38148.0 38431.0 27727.9 28410.3 28422.0 28610.7 28706.3 23:30:05 INFO - PROCESS | 32514 | 23:30:05 INFO - PROCESS | 32514 | [#2] jquery.html Cycles:180 Average:29267.35 Median:13355.56 stddev:80575.81 (603.3%) stddev-sans-first:80772.69 23:30:05 INFO - PROCESS | 32514 | Values: 400.2 401.0 404.1 407.2 414.1 18834.4 19654.0 20639.3 20653.6 20675.0 19032.3 19211.7 20547.1 20577.3 20636.3 5682.3 5848.5 5979.7 5985.7 6008.6 5840.3 5867.8 5912.2 5915.8 5919.2 5809.4 5922.3 5924.6 5952.6 5965.6 5637.6 5930.3 5935.6 5939.5 5972.1 5716.3 5803.7 5843.8 5851.8 5853.8 23414.5 23680.5 24316.8 24953.1 24955.1 2349.7 2394.4 2445.7 2514.7 2830.0 10343.0 10552.5 10641.3 10728.5 10751.7 1940.3 1941.1 1968.4 1997.5 2008.9 52547.0 74762.6 74874.0 87659.6 88991.6 10192.3 10462.1 10588.5 10940.1 10952.1 14417.6 14509.6 14892.6 14917.7 15389.8 8099.0 8129.4 8285.8 8326.8 8397.4 7784.3 7800.6 7894.6 7960.2 8017.8 4698.5 4840.4 4844.3 4927.2 4974.6 1968.5 2017.1 2060.5 2062.6 2086.3 952.7 988.2 1001.8 1029.4 1076.4 19968.6 20732.8 20954.4 21094.4 21269.5 993.3 1000.5 1008.9 1023.2 1089.7 10895.9 11491.2 11585.1 11598.6 11620.3 473022.0 484793.0 492726.0 495459.0 496186.0 89883.6 92108.0 95335.5 96929.0 98419.0 1004.5 1036.8 1054.1 1054.9 1058.0 14275.6 16256.3 17138.8 17967.6 18849.7 45446.1 45797.6 46036.3 46082.3 47616.0 58308.0 60002.0 61565.0 61623.4 62697.0 8522.6 8630.2 8747.1 8892.6 9029.4 10499.5 13446.3 13940.4 14143.2 14153.9 11326.7 11528.9 11535.2 11811.4 12214.0 11540.5 11676.1 11916.8 12136.9 12316.4 11392.1 11399.5 11453.1 11621.7 12700.9 8623.4 8651.7 8695.7 8702.8 8750.6 11020.1 11990.3 12012.8 12119.1 12367.6 23:30:05 INFO - PROCESS | 32514 | 23:30:05 INFO - PROCESS | 32514 | [#3] mootools.html Cycles:180 Average:5994.98 Median:4669.55 stddev:3435.13 (73.6%) stddev-sans-first:3428.09 23:30:05 INFO - PROCESS | 32514 | Values: 1491.0 1537.0 1696.2 1817.2 1856.2 8887.1 9196.0 9241.9 9248.3 9269.5 7808.6 8399.2 8678.3 8694.3 9089.5 2365.6 2391.2 2395.4 2398.0 2405.2 2368.4 2373.6 2403.6 2407.7 2407.9 2106.4 2318.6 2391.1 2391.4 2396.4 2416.6 2441.9 2443.2 2451.1 2464.4 2366.9 2367.4 2397.8 2402.4 2410.9 9160.1 9274.6 9280.4 9281.0 9301.7 5350.1 5483.6 5496.0 5501.7 5505.0 3323.0 3397.6 3443.5 3445.0 3521.3 1037.5 1058.7 1103.1 1112.0 1112.2 12898.0 12920.4 12934.8 12944.3 12963.7 4646.5 4692.6 4890.1 4893.8 4935.3 10721.7 10737.4 10739.4 10752.7 10769.6 5498.5 5498.6 5499.7 5503.6 5509.1 5001.2 5067.0 5067.5 5133.3 5149.6 4092.5 4120.7 4133.8 4187.0 4188.6 1189.2 1209.9 1265.0 1295.6 1300.2 682.5 910.6 981.3 1004.9 1007.1 5964.9 6032.6 6188.0 6188.3 6223.5 988.0 994.3 1018.4 1022.2 1029.5 3953.9 3977.3 3978.0 4016.7 4022.8 10877.6 11301.7 11324.4 11363.7 11487.8 10168.4 11314.5 11367.8 11374.0 11375.8 7922.8 8314.0 8327.9 8468.5 8503.5 6216.8 6255.5 6374.9 6392.8 6411.7 10440.7 10473.6 10682.7 10703.0 10732.7 10637.4 10733.6 10887.1 10973.6 11033.1 8108.4 8120.1 8201.7 8205.1 8214.1 8184.2 8443.1 8481.5 8800.9 8884.8 6325.6 7870.3 7962.6 8142.6 8160.3 7911.2 8048.6 8125.1 8128.3 8196.3 7140.1 7217.1 7251.1 7289.2 7321.8 5111.8 5216.2 5217.6 5340.4 5391.5 5127.8 5230.6 5272.1 5316.7 5379.0 23:30:05 INFO - PROCESS | 32514 | 23:30:05 INFO - PROCESS | 32514 | [#4] prototype.html Cycles:180 Average:4688.69 Median:5398.55 stddev:1370.54 (25.4%) stddev-sans-first:1334.90 23:30:05 INFO - PROCESS | 32514 | Values: 336.7 338.3 342.9 346.3 348.5 5400.8 5403.0 5418.3 5440.9 5446.9 5294.8 5365.7 5371.6 5393.4 5408.0 3998.0 4174.4 4254.3 4255.3 4267.5 4115.5 4191.3 4202.7 4234.8 4251.9 4171.6 4181.7 4182.0 4200.9 4228.5 3958.3 4004.3 4137.1 4174.5 4191.7 3665.4 3670.3 3700.4 3702.4 3703.0 4933.2 5093.2 5118.6 5164.7 5184.1 4591.7 4710.0 4728.4 4750.8 4762.5 5534.8 5545.0 5554.6 5559.5 5570.1 3885.7 3916.7 3964.8 3983.3 4012.9 5575.2 5646.8 5658.0 5660.1 5662.3 4063.8 4065.9 4070.1 4078.2 4082.1 4190.1 4192.2 4193.4 4193.8 4202.7 4500.4 4727.6 4738.5 4766.4 4779.3 5511.9 5533.3 5537.5 5602.7 5615.7 1418.9 1440.7 1445.8 1448.8 1449.0 913.6 964.3 973.9 978.5 979.2 5352.0 5366.7 5378.2 5384.8 5390.6 5396.4 5605.9 5616.5 5646.4 5693.3 5170.6 5200.5 5270.8 5317.8 5381.2 2926.5 2976.4 2984.1 3019.0 3042.5 5696.9 5810.7 5812.6 5825.4 5833.0 5795.1 5798.2 5808.9 5819.5 5824.9 5840.5 5845.8 5852.9 5853.7 5857.7 5535.3 5654.7 5733.9 5740.1 5763.2 5544.1 5650.7 5655.3 5679.6 5691.5 5729.7 5813.9 5887.0 5893.5 5913.9 3998.9 4004.1 4010.0 4010.4 4012.7 5683.8 5692.4 5698.8 5778.7 5811.5 5528.6 5608.6 5623.0 5644.2 5663.8 5514.3 5523.9 5588.1 5589.9 5601.9 5473.8 5482.1 5495.3 5512.6 5514.3 5319.4 5584.9 5600.5 5655.5 5677.3 5553.9 5569.4 5575.5 5588.7 5591.6 23:30:05 INFO - PROCESS | 32514 | 23:30:05 INFO - PROCESS | 32514 | [#5] yui.html Cycles:180 Average:21711.85 Median:4330.14 stddev:31067.78 (717.5%) stddev-sans-first:31115.06 23:30:05 INFO - PROCESS | 32514 | Values: 750.1 776.7 786.6 802.1 811.3 15251.7 16797.7 16800.2 16802.5 16807.1 15272.6 15392.5 15413.1 15416.5 15455.1 658.1 788.9 810.1 812.7 816.4 821.4 824.4 826.2 828.8 829.0 691.8 869.6 871.3 873.5 874.1 851.0 866.1 867.6 869.2 869.5 637.8 638.9 639.2 639.5 639.5 15851.4 15863.3 15883.2 15901.1 15903.8 12691.4 12806.7 12839.7 13073.4 13486.9 13162.7 13168.4 13217.2 13383.8 13469.0 4320.7 4339.6 4343.1 4475.4 4479.4 74544.3 74695.6 75381.6 77652.3 79578.0 11385.1 11412.5 11515.4 11600.4 11858.3 20501.2 20523.4 20540.7 20548.5 20759.7 8722.1 8745.9 8770.5 8792.2 8829.1 4718.6 4817.3 5026.9 5040.7 5087.7 3480.6 3584.8 3599.5 3599.5 3600.5 635.2 678.9 710.1 716.8 718.8 722.6 743.0 748.9 752.3 771.0 9567.6 9764.3 9934.7 10582.5 10830.9 634.6 664.6 747.7 757.2 768.3 4621.9 4639.9 4641.2 4674.8 4765.3 98802.0 100657.0 102794.0 117553.4 130722.3 84100.6 103779.5 105017.0 106265.5 108105.0 94953.0 96272.0 97040.5 97870.2 97885.5 10199.3 10498.1 10563.5 10945.8 10988.2 55209.4 56154.4 56625.4 57046.1 58933.7 80370.0 84655.6 84919.0 85066.7 85300.6 12723.2 13030.4 13047.7 13113.2 13620.7 15118.0 16050.8 16051.2 16085.7 16821.8 14901.0 15041.2 15367.4 15990.9 16002.0 13984.3 14175.3 14201.1 14244.7 14299.8 14034.0 14381.0 14496.0 14740.7 14784.3 10550.0 10625.6 10826.6 10914.0 10934.5 11662.0 11666.9 11888.3 11907.6 12140.9 23:30:05 INFO - PROCESS | 32514 | -------- Summary: end -------- 23:30:05 INFO - PROCESS | 32514 | 23:30:05 INFO - TEST-INFO | 32514: exit 0 23:30:05 INFO - TEST-OK | dromaeo_css | took 1114026ms 23:30:05 INFO - TEST-START | kraken 23:30:05 INFO - operating with platform_type : linux_ 23:30:05 INFO - Initialising browser for kraken test... 23:30:05 INFO - TEST-INFO | started process 32713 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8oMiFj/profile http://localhost:45773/getInfo.html) 23:30:09 INFO - PROCESS | 32713 | __metrics Screen width/height:1600/1200 23:30:09 INFO - PROCESS | 32713 | colorDepth:24 23:30:09 INFO - PROCESS | 32713 | Browser inner width/height: 1024/697 23:30:09 INFO - PROCESS | 32713 | __metrics 23:30:10 INFO - PROCESS | 32713 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 23:30:10 INFO - PROCESS | 32713 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:30:11 INFO - TEST-INFO | 32713: exit 0 23:30:11 INFO - Browser initialized. 23:30:11 INFO - Running cycle 1/1 for kraken test... 23:30:11 INFO - TEST-INFO | started process 327 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8oMiFj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:30:23 INFO - PROCESS | 327 | RSS: Main: 157872128 23:30:23 INFO - PROCESS | 327 | 23:30:25 INFO - PROCESS | 327 | Cycle 1(1): loaded http://localhost:45773/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45773/tests/kraken/driver.html?testName=audio-beat-detection) 23:30:26 INFO - PROCESS | 327 | RSS: Main: 216965120 23:30:26 INFO - PROCESS | 327 | 23:30:29 INFO - PROCESS | 327 | Cycle 1(1): loaded http://localhost:45773/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45773/tests/kraken/driver.html?testName=audio-dft) 23:30:29 INFO - PROCESS | 327 | RSS: Main: 205131776 23:30:29 INFO - PROCESS | 327 | 23:30:32 INFO - PROCESS | 327 | Cycle 1(1): loaded http://localhost:45773/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45773/tests/kraken/driver.html?testName=audio-fft) 23:30:33 INFO - PROCESS | 327 | RSS: Main: 269357056 23:30:33 INFO - PROCESS | 327 | 23:30:35 INFO - PROCESS | 327 | Cycle 1(1): loaded http://localhost:45773/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45773/tests/kraken/driver.html?testName=audio-oscillator) 23:30:36 INFO - PROCESS | 327 | RSS: Main: 180654080 23:30:36 INFO - PROCESS | 327 | 23:30:38 INFO - PROCESS | 327 | Cycle 1(1): loaded http://localhost:45773/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45773/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:30:38 INFO - PROCESS | 327 | RSS: Main: 184971264 23:30:38 INFO - PROCESS | 327 | 23:30:41 INFO - PROCESS | 327 | Cycle 1(1): loaded http://localhost:45773/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45773/tests/kraken/driver.html?testName=imaging-darkroom) 23:30:42 INFO - PROCESS | 327 | RSS: Main: 221130752 23:30:42 INFO - PROCESS | 327 | 23:30:45 INFO - PROCESS | 327 | Cycle 1(1): loaded http://localhost:45773/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45773/tests/kraken/driver.html?testName=imaging-desaturate) 23:30:46 INFO - PROCESS | 327 | RSS: Main: 221134848 23:30:46 INFO - PROCESS | 327 | 23:30:49 INFO - PROCESS | 327 | Cycle 1(1): loaded http://localhost:45773/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45773/tests/kraken/driver.html?testName=json-parse-financial) 23:30:49 INFO - PROCESS | 327 | RSS: Main: 221085696 23:30:49 INFO - PROCESS | 327 | 23:30:51 INFO - PROCESS | 327 | Cycle 1(1): loaded http://localhost:45773/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45773/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:30:51 INFO - PROCESS | 327 | RSS: Main: 209850368 23:30:51 INFO - PROCESS | 327 | 23:30:53 INFO - PROCESS | 327 | Cycle 1(1): loaded http://localhost:45773/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45773/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:30:54 INFO - PROCESS | 327 | RSS: Main: 214188032 23:30:54 INFO - PROCESS | 327 | 23:30:56 INFO - PROCESS | 327 | Cycle 1(1): loaded http://localhost:45773/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45773/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:30:56 INFO - PROCESS | 327 | RSS: Main: 210976768 23:30:56 INFO - PROCESS | 327 | 23:30:59 INFO - PROCESS | 327 | Cycle 1(1): loaded http://localhost:45773/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45773/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:30:59 INFO - PROCESS | 327 | RSS: Main: 223821824 23:30:59 INFO - PROCESS | 327 | 23:31:02 INFO - PROCESS | 327 | Cycle 1(1): loaded http://localhost:45773/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45773/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:31:03 INFO - PROCESS | 327 | RSS: Main: 224104448 23:31:03 INFO - PROCESS | 327 | 23:31:04 INFO - PROCESS | 327 | Cycle 1(1): loaded http://localhost:45773/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45773/tests/kraken/driver.html?testName=ai-astar) 23:31:05 INFO - PROCESS | 327 | RSS: Main: 266887168 23:31:05 INFO - PROCESS | 327 | 23:31:05 INFO - PROCESS | 327 | __start_tp_report 23:31:05 INFO - PROCESS | 327 | _x_x_mozilla_page_load 23:31:05 INFO - PROCESS | 327 | _x_x_mozilla_page_load_details 23:31:05 INFO - PROCESS | 327 | |i|pagename|runs| 23:31:05 INFO - PROCESS | 327 | |0;ai-astar;99;109;110;110;109;110;108;110;111;109 23:31:05 INFO - PROCESS | 327 | |1;audio-beat-detection;145;115;116;181;116;117;142;116;150;117 23:31:05 INFO - PROCESS | 327 | |2;audio-dft;160;160;161;160;160;160;158;161;160;161 23:31:05 INFO - PROCESS | 327 | |3;audio-fft;74;74;75;109;75;75;75;75;111;74 23:31:05 INFO - PROCESS | 327 | |4;audio-oscillator;83;83;109;83;83;82;127;82;84;125 23:31:05 INFO - PROCESS | 327 | |5;imaging-gaussian-blur;117;116;116;116;117;117;116;117;116;116 23:31:05 INFO - PROCESS | 327 | |6;imaging-darkroom;145;145;146;146;146;145;145;145;145;145 23:31:05 INFO - PROCESS | 327 | |7;imaging-desaturate;94;95;95;95;95;95;95;95;95;94 23:31:05 INFO - PROCESS | 327 | |8;json-parse-financial;50;50;50;50;50;50;51;50;50;50 23:31:05 INFO - PROCESS | 327 | |9;json-stringify-tinderbox;62;63;62;63;63;62;63;62;62;63 23:31:05 INFO - PROCESS | 327 | |10;stanford-crypto-aes;75;80;75;74;77;74;75;73;74;83 23:31:05 INFO - PROCESS | 327 | |11;stanford-crypto-ccm;118;116;124;117;118;137;129;118;167;118 23:31:05 INFO - PROCESS | 327 | |12;stanford-crypto-pbkdf2;153;157;156;153;157;155;153;157;155;155 23:31:05 INFO - PROCESS | 327 | |13;stanford-crypto-sha256-iterative;63;63;63;61;63;61;62;61;62;61 23:31:05 INFO - PROCESS | 327 | __end_tp_report 23:31:05 INFO - PROCESS | 327 | __start_cc_report 23:31:05 INFO - PROCESS | 327 | _x_x_mozilla_cycle_collect,1675 23:31:05 INFO - PROCESS | 327 | __end_cc_report 23:31:05 INFO - PROCESS | 327 | __startTimestamp1468909865067__endTimestamp 23:31:05 INFO - PROCESS | 327 | 23:31:05 INFO - PROCESS | 327 | ------- Summary: start ------- 23:31:05 INFO - PROCESS | 327 | Number of tests: 14 23:31:05 INFO - PROCESS | 327 | 23:31:05 INFO - PROCESS | 327 | [#0] ai-astar Cycles:10 Average:108.50 Median:110.00 stddev:3.44 (3.1%) stddev-sans-first:0.88 23:31:05 INFO - PROCESS | 327 | Values: 99.0 109.0 110.0 110.0 109.0 110.0 108.0 110.0 111.0 109.0 23:31:05 INFO - PROCESS | 327 | 23:31:05 INFO - PROCESS | 327 | [#1] audio-beat-detection Cycles:10 Average:131.50 Median:129.50 stddev:22.36 (17.3%) stddev-sans-first:23.17 23:31:05 INFO - PROCESS | 327 | Values: 145.0 115.0 116.0 181.0 116.0 117.0 142.0 116.0 150.0 117.0 23:31:05 INFO - PROCESS | 327 | 23:31:05 INFO - PROCESS | 327 | [#2] audio-dft Cycles:10 Average:160.10 Median:160.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 23:31:05 INFO - PROCESS | 327 | Values: 160.0 160.0 161.0 160.0 160.0 160.0 158.0 161.0 160.0 161.0 23:31:05 INFO - PROCESS | 327 | 23:31:05 INFO - PROCESS | 327 | [#3] audio-fft Cycles:10 Average:81.70 Median:75.00 stddev:14.93 (19.9%) stddev-sans-first:15.57 23:31:05 INFO - PROCESS | 327 | Values: 74.0 74.0 75.0 109.0 75.0 75.0 75.0 75.0 111.0 74.0 23:31:05 INFO - PROCESS | 327 | 23:31:05 INFO - PROCESS | 327 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:83.00 stddev:18.70 (22.5%) stddev-sans-first:19.40 23:31:05 INFO - PROCESS | 327 | Values: 83.0 83.0 109.0 83.0 83.0 82.0 127.0 82.0 84.0 125.0 23:31:05 INFO - PROCESS | 327 | 23:31:05 INFO - PROCESS | 327 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 23:31:05 INFO - PROCESS | 327 | Values: 117.0 116.0 116.0 116.0 117.0 117.0 116.0 117.0 116.0 116.0 23:31:05 INFO - PROCESS | 327 | 23:31:05 INFO - PROCESS | 327 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 23:31:05 INFO - PROCESS | 327 | Values: 145.0 145.0 146.0 146.0 146.0 145.0 145.0 145.0 145.0 145.0 23:31:05 INFO - PROCESS | 327 | 23:31:05 INFO - PROCESS | 327 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 23:31:05 INFO - PROCESS | 327 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 23:31:05 INFO - PROCESS | 327 | 23:31:05 INFO - PROCESS | 327 | [#8] json-parse-financial Cycles:10 Average:50.10 Median:50.00 stddev:0.32 (0.6%) stddev-sans-first:0.33 23:31:05 INFO - PROCESS | 327 | Values: 50.0 50.0 50.0 50.0 50.0 50.0 51.0 50.0 50.0 50.0 23:31:05 INFO - PROCESS | 327 | 23:31:05 INFO - PROCESS | 327 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:63.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 23:31:05 INFO - PROCESS | 327 | Values: 62.0 63.0 62.0 63.0 63.0 62.0 63.0 62.0 62.0 63.0 23:31:05 INFO - PROCESS | 327 | 23:31:05 INFO - PROCESS | 327 | [#10] stanford-crypto-aes Cycles:10 Average:76.00 Median:75.00 stddev:3.16 (4.2%) stddev-sans-first:3.33 23:31:05 INFO - PROCESS | 327 | Values: 75.0 80.0 75.0 74.0 77.0 74.0 75.0 73.0 74.0 83.0 23:31:05 INFO - PROCESS | 327 | 23:31:05 INFO - PROCESS | 327 | [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:121.00 stddev:15.82 (13.1%) stddev-sans-first:16.50 23:31:05 INFO - PROCESS | 327 | Values: 118.0 116.0 124.0 117.0 118.0 137.0 129.0 118.0 167.0 118.0 23:31:05 INFO - PROCESS | 327 | 23:31:05 INFO - PROCESS | 327 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.10 Median:155.50 stddev:1.66 (1.1%) stddev-sans-first:1.58 23:31:05 INFO - PROCESS | 327 | Values: 153.0 157.0 156.0 153.0 157.0 155.0 153.0 157.0 155.0 155.0 23:31:05 INFO - PROCESS | 327 | 23:31:05 INFO - PROCESS | 327 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.00 Median:62.50 stddev:0.94 (1.5%) stddev-sans-first:0.93 23:31:05 INFO - PROCESS | 327 | Values: 63.0 63.0 63.0 61.0 63.0 61.0 62.0 61.0 62.0 61.0 23:31:05 INFO - PROCESS | 327 | -------- Summary: end -------- 23:31:05 INFO - PROCESS | 327 | 23:31:06 INFO - TEST-INFO | 327: exit 0 23:31:06 INFO - TEST-OK | kraken | took 60235ms 23:31:06 INFO - SUITE-END | took 1174s 23:31:06 INFO - Completed test suite (00:19:34) 23:31:06 INFO - javascript benchmark 23:31:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3033.2265272355544, 3036.9088927332173, 3039.2249976256053, 3081.0, 3102.16241614764, 5354.598405119617, 5365.946340536593, 5433.701146436944, 5445.50990410863, 5485.149801780725, 5412.756425960832, 5429.619926605139, 5437.8368648940595, 5449.155380915964, 5487.780488780454, 4892.8532144035735, 4969.900601987958, 4987.276844857493, 4993.725345106018, 5102.948970510284, 5005.199168133099, 5017.096922553938, 5058.468860769622, 5068.594512438996, 5077.5684066854365, 4880.755962201893, 4925.605951523869, 4926.507349265081, 4950.133726597831, 4977.452480227154, 4953.0836795192645, 4958.454569997298, 5009.624278179152, 5010.048090862724, 5050.949490505084, 4871.5128487151005, 4945.381827271591, 4986.750662466862, 4996.150654388763, 5024.145895197825, 5331.413544510101, 5390.757415916293, 5402.864928376783, 5454.91817622736, 5457.781688732446, 5801.0, 5820.185174075633, 5829.09649004405, 5829.88340233193, 5831.795887143972, 5688.943110568883, 5753.338366087912, 5872.7357268923, 5878.118282257653, 5879.029960056586, 5370.91943620846, 5391.0, 5395.433479484676, 5433.4566543345745, 5439.292891924025, 5925.111233315038, 6013.6993150342305, 6016.669083200466, 6016.969915150396, 6026.969865150646, 5574.052411090124, 5637.520810731134, 5678.744456499468, 5773.364929857712, 5776.277965254343, 5862.12068189775, 5901.911471327933, 5902.675352855548, 5908.763649453974, 5911.467967882825, 5765.85585360361, 5806.970965145148, 5817.331006934172, 5818.185454036438, 5821.854453638608, 5710.685912274865, 5741.138829175574, 5762.798302059407, 5777.653340799566, 5825.79609713658, 4415.801288942005, 4416.183006143874, 4417.933730994037, 4418.5802348776815, 4453.888652783641, 3933.6066393361007, 3951.2887680217837, 3955.7033222508426, 3992.960070399317, 4009.7393669411395, 5336.599755018389, 5439.048166570834, 5447.428020057916, 5476.835694929158, 5512.944870551323, 5839.328477225088, 5841.561882858718, 5851.21008663825, 5865.941340586625, 5866.8533286667325, 5541.889162216814, 5544.473275038865, 5545.833624991256, 5550.056490396642, 5553.750081246354, 4929.728864912464, 5023.799048038038, 5069.112905241568, 5079.822206222764, 5133.050385678662, 6105.725242364104, 6107.816765497042, 6114.38856114385, 6116.3577824328695, 6119.785807496716, 5912.349641539513, 5918.023526118142, 5920.585559010828, 5921.052631578927, 5924.526037917042, 5884.7940322088525, 5930.851728706817, 5973.1338955852025, 5981.820545383472, 6037.0, 5714.771409143587, 5747.942520574741, 5749.195112684144, 5757.8560535986935, 5760.0783874579865, 5768.50967667753, 5800.24596802413, 5836.445537673914, 5856.560757943086, 5862.296524417097, 5672.092465205712, 5776.480116789509, 5777.6822274775295, 5779.248697669276, 5779.884402312015, 5738.626989245686, 5750.367459579359, 5750.9424905752085, 5752.511036561772, 5757.596968212185, 5632.571996027806, 5663.66018038919, 5666.46168613981, 5669.064604340238, 5673.092305231308, 5701.087825947994, 5769.451902069297, 5769.74036168365, 5775.27809023872, 5783.277090363705, 5607.411221821813, 5649.406812284651, 5663.32040155184, 5663.631863928831, 5676.517496012885], "value": 5376.39533802293, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [621.5214285000549, 632.7279269913938, 639.8336432527542, 650.6356440393383, 653.784251197105, 42536.0, 44208.77895610521, 44465.999999999956, 48422.27366589495, 48589.25393429181, 44895.55104448955, 44953.7752311238, 45294.547054529445, 45370.546294537045, 45371.09257814842, 9015.098490150998, 9140.72577822663, 9143.268538516902, 9149.725508234731, 9149.771255718593, 8993.190612844843, 9028.774280643003, 9086.136817002374, 9086.182243598076, 9096.681616143436, 9124.726258212264, 9146.359754817166, 9153.221976132003, 9153.67962121326, 9160.770980725501, 9007.864882026775, 9030.50332231727, 9046.140616641442, 9076.591553380047, 9080.137386948229, 8912.688055918012, 8958.37291389603, 8968.730938071803, 8974.730758077269, 8978.955105224431, 43907.560924390666, 44329.335059974124, 44353.334699979525, 44362.778186108866, 44450.33324500103, 3701.648343407372, 3794.2221844521805, 4190.329547272422, 4241.957580424187, 4317.546657600969, 33239.66760332414, 33578.54215820191, 33680.0, 34552.48171277433, 34730.65269347299, 4213.494380674308, 4285.892852678677, 4289.2922667759785, 4343.587359200902, 4469.061497085616, 257052.0, 257708.0, 257860.0, 258581.0, 259751.0, 51501.227481587805, 59376.70311648414, 59617.0, 59791.40208597858, 59906.400935990954, 58939.41060589339, 60833.695831520556, 60846.39153608496, 65838.34161658418, 65967.34032659708, 17009.14954252307, 17090.230939607747, 17146.05696686694, 17179.742303865452, 17244.310227591006, 11571.247868888495, 11837.0, 13268.800967985488, 13343.132696374705, 13394.464221431033, 15336.769948450783, 16278.75581866273, 16693.582660433345, 16708.08105554206, 16773.496795096165, 6359.872802543923, 6422.133012043408, 6480.773172938924, 6525.4779617630475, 6546.279909209983, 1046.602291129366, 1091.841682955967, 1099.725068732817, 1150.4017910686396, 1170.5551890281638, 32421.351572968408, 32909.83545082307, 33290.167745806066, 33511.497327540106, 33564.328713425595, 1117.385438009108, 1129.6272230164027, 1145.3299819605456, 1211.787937111002, 1217.3548019549653, 17352.39266625662, 17393.65212695739, 17404.39084632032, 17496.662083258685, 17560.473185804447, 481673.0, 482243.0, 482763.0, 485985.0, 486540.0, 59286.703566482756, 59301.11048334278, 59312.0, 59328.11007834886, 59370.406295937355, 1235.2958813476232, 1331.2478449675903, 1350.8514063453013, 1385.6605131742788, 1389.7428975639539, 30856.691433085383, 34704.0, 34749.652503475656, 34776.65223347835, 35047.12382190364, 52131.0, 52209.0, 53131.20303195532, 53142.73428632987, 53156.468435316696, 521099.0, 530106.0, 530546.0, 530999.0, 531015.0, 36982.815085925475, 38157.236855262185, 38415.6158438412, 38484.61515384923, 42422.575774243094, 49960.0, 50579.0, 51013.744931275105, 51109.744451277504, 51972.22041669454, 42442.78778606087, 43563.78218108889, 44304.778476107414, 44599.0, 45088.54911450975, 42872.14255714806, 42897.571024289355, 43064.13871722485, 43578.78210608927, 44185.0, 41842.37236441517, 42846.78576607097, 42955.14089718251, 43255.567444325156, 43309.350359744, 35590.0, 37716.43425348567, 37967.00340725611, 38148.0, 38431.0, 27727.861360693067, 28410.289742756595, 28422.0, 28610.70976837607, 28706.282342941595], "value": 20646.791621593864, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.1736414304461, 400.9879703608893, 404.1069236986262, 407.2181411689556, 414.1055320507702, 18834.434966950997, 19654.0, 20639.277625283117, 20653.586928261426, 20675.0, 19032.33386831461, 19211.711824322647, 20547.075381607825, 20577.27979520717, 20636.277730279442, 5682.289713785777, 5848.502877255417, 5979.701014949257, 5985.700714964234, 6008.579399442041, 5840.299164100293, 5867.76528938842, 5912.17229587858, 5915.792947246847, 5919.1713160157615, 5809.448102430262, 5922.3485416604135, 5924.644521328734, 5952.58331916766, 5965.552583556229, 5637.605367624268, 5930.288365396159, 5935.64386136831, 5939.495142912858, 5972.134040564138, 5716.256886604757, 5803.651780893118, 5843.795467158671, 5851.76592936282, 5853.76584936602, 23414.53170936589, 23680.526389472114, 24316.7568324318, 24953.126640567494, 24955.126570569944, 2349.694539709844, 2394.365493144318, 2445.6942882139733, 2514.6856642919633, 2829.957550636742, 10343.0, 10552.47237638115, 10641.308314959502, 10728.517216725188, 10751.731206719816, 1940.3111895277113, 1941.1264930781206, 1968.4193163016944, 1997.510609900569, 2008.8794672319561, 52547.0, 74762.62618686871, 74874.0, 87659.56170219109, 88991.55504222437, 10192.28653994228, 10462.110720588684, 10588.470576471145, 10940.070094042096, 10952.069074128629, 14417.567472975617, 14509.637259068397, 14892.627684307763, 14917.70164596702, 15389.846101538842, 8098.959505202436, 8129.390295727844, 8285.751427457186, 8326.833463330699, 8397.412181147383, 7784.338331241908, 7800.609969501502, 7894.60526973649, 7960.164182760843, 8017.8396432072195, 4698.543451530037, 4840.420785452906, 4844.346013288232, 4927.236278376858, 4974.577160941288, 1968.4980330015753, 2017.1427143463968, 2060.526079001838, 2062.61841559309, 2086.290661175208, 952.6665667016628, 988.17981075707, 1001.7896241789306, 1029.4389557691077, 1076.424113099488, 19968.600627987358, 20732.792672073087, 20954.37136885896, 21094.367168984954, 21269.46826329354, 993.2947607198826, 1000.484750353554, 1008.8839783425, 1023.2070145637191, 1089.700332408578, 10895.945520272506, 11491.195616306946, 11585.131115166396, 11598.594049208406, 11620.302781832948, 473022.0, 484793.0, 492726.0, 495459.0, 496186.0, 89883.55058224667, 92108.0, 95335.52332238294, 96929.0, 98419.0, 1004.487711267259, 1036.8237399642078, 1054.135608800776, 1054.920880933933, 1058.0371861605902, 14275.571732847615, 16256.268467918735, 17138.828611713725, 17967.5508112293, 18849.717254240924, 45446.09107817891, 45797.64922332373, 46036.30945535753, 46082.308765367874, 47616.000319965904, 58308.0, 60002.0, 61565.0, 61623.383766163555, 62697.0, 8522.616482258189, 8630.180132887366, 8747.081556436737, 8892.599833007402, 9029.367944244103, 10499.527521261409, 13446.327683615584, 13940.442382304595, 14143.222122783345, 14153.858461415253, 11326.660200194008, 11528.884711153116, 11535.192536522363, 11811.350375729417, 12214.0, 11540.480678369662, 11676.065914726632, 11916.821247681119, 12136.878631213927, 12316.384180791103, 11392.145589080686, 11399.544018239178, 11453.141014424118, 11621.709457263636, 12700.936495317834, 8623.396362254582, 8651.6971905983, 8695.652173912973, 8702.782430439289, 8750.562471876254, 11020.118390528898, 11990.28058316469, 12012.819807703067, 12119.091068170099, 12367.62897113088], "value": 9436.105357123695, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1491.0382803092007, 1536.9538913832585, 1696.2366934879299, 1817.2095138614695, 1856.2389420337656, 8887.11128887111, 9196.0, 9241.861372079424, 9248.260139188866, 9269.536523173849, 7808.570528620923, 8399.244068033875, 8678.349123815708, 8694.347923905716, 9089.545522723854, 2365.5978483657777, 2391.210900402863, 2395.4490467192554, 2398.0168131066266, 2405.170216275391, 2368.3723813189517, 2373.6320870265135, 2403.639454081893, 2407.67496387988, 2407.9277621671376, 2106.3680895731295, 2318.6406107053435, 2391.1152873436854, 2391.390195500154, 2396.388920825187, 2416.6375043743406, 2441.926742197728, 2443.230382429529, 2451.080844683244, 2464.4208610976407, 2366.893489792946, 2367.360812580611, 2397.772211639909, 2402.423418379594, 2410.8553486790847, 9160.083991600786, 9274.629014839398, 9280.396774209723, 9281.0, 9301.72094837156, 5350.0904846176245, 5483.588730845203, 5495.972520137414, 5501.724913754297, 5504.972475137599, 3322.966770332314, 3397.6262611112757, 3443.5351227584456, 3445.0353900907785, 3521.295740851814, 1037.5227395398126, 1058.714147180257, 1103.0954617213888, 1111.9777604447947, 1112.238116889933, 12898.032647551378, 12920.41858116387, 12934.805977910339, 12944.288064156373, 12963.740725185538, 4646.4888862225125, 4692.601128904082, 4890.070886531547, 4893.804247830047, 4935.284383764334, 10721.731956701145, 10737.409442480583, 10739.355638661706, 10752.731181720363, 10769.569217231223, 5498.505134537911, 5498.642588231752, 5499.7250137492965, 5503.6147469677535, 5509.090999985037, 5001.174806156943, 5066.974665126724, 5067.5185857343495, 5133.307003554472, 5149.562287205629, 4092.544473316046, 4120.690948178899, 4133.772642504631, 4186.995121170897, 4188.623023927861, 1189.2210602055668, 1209.9274043557414, 1264.9620511384674, 1295.559509766684, 1300.2133709106045, 682.5290549520814, 910.644848509082, 981.2787601113176, 1004.864343313658, 1007.0885848307147, 5964.940350596526, 6032.577719559677, 6187.969060154671, 6188.257409110935, 6223.533235007392, 987.980240395188, 994.2791476179856, 1018.3737001743874, 1022.2180032275315, 1029.4955471818755, 3953.881383558498, 3977.3238549446664, 3977.960220397817, 4016.658584020391, 4022.8390864365683, 10877.619283325046, 11301.717457063474, 11324.37715925632, 11363.659090227306, 11487.827682584768, 10168.389896606228, 11314.490847911864, 11367.772644547063, 11374.0, 11375.772484550263, 7922.801929951682, 8313.958430207811, 8327.875736775457, 8468.49189048659, 8503.489790612459, 6216.751329946932, 6255.499560035278, 6374.93625063762, 6392.776252831129, 6411.743530258924, 10440.738981525523, 10473.581056757645, 10682.679519614425, 10703.0, 10732.73168170802, 10637.414942178255, 10733.570657173626, 10887.129029677766, 10973.615923442641, 11033.117350611772, 8108.351331893552, 8120.106788253405, 8201.71294004707, 8205.097439281793, 8214.05538363096, 8184.181581841768, 8443.07126216128, 8481.491110533389, 8800.867986980073, 8884.77788055278, 6325.620462772248, 7870.29167374939, 7962.562059086806, 8142.552159631277, 8160.347172226327, 7911.208879112043, 8048.5975701215875, 8125.146859579659, 8128.349732021542, 8196.262336389753, 7140.07179066718, 7217.097862767154, 7251.093613298338, 7289.1981881994, 7321.816954576178, 5111.846644600668, 5216.165413533817, 5217.556507696889, 5340.359156901197, 5391.487808658171, 5127.79488820443, 5230.555402790653, 5272.0773864572775, 5316.734163291742, 5379.031774280511], "value": 4775.746507635579, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.7171575876264, 338.34361339002334, 342.9279851231241, 346.3073852295409, 348.4842433198864, 5400.756965936533, 5402.972985135074, 5418.2685337479425, 5440.891182176359, 5446.863828404292, 5294.841154765353, 5365.678059316444, 5371.623986320959, 5393.406725260218, 5407.972960135194, 3997.9600203998025, 4174.394712766647, 4254.27677294859, 4255.2978758504805, 4267.530571637133, 4115.485564304462, 4191.329387298033, 4202.684798640099, 4234.788260586958, 4251.915761480818, 4171.582841715835, 4181.707280490367, 4182.0, 4200.894977625569, 4228.5137209220875, 3958.3072962231495, 4004.279229738646, 4137.110521237948, 4174.519930208035, 4191.721524934894, 3665.4318580620047, 3670.3209906167444, 3700.4449332600057, 3702.426123950792, 3702.9629703702885, 4933.2486967126515, 5093.1850903855575, 5118.616103792193, 5164.715940623264, 5184.144616138333, 4591.701539399928, 4710.0, 4728.432588089417, 4750.809967601292, 4762.547557981986, 5534.778608855641, 5545.033407127208, 5554.555635549146, 5559.471850174267, 5570.136628822539, 3885.6502914737525, 3916.74541154824, 3964.781936993464, 3983.322835118037, 4012.9197416051516, 5575.212393803098, 5646.830595082154, 5657.971710141464, 5660.122680984454, 5662.263905692274, 4063.817128229237, 4065.8576949806616, 4070.1249231415386, 4078.1639763848934, 4082.142750022469, 4190.120074784269, 4192.203481338597, 4193.370994350811, 4193.790310484464, 4202.726822756511, 4500.412262948752, 4727.621790256771, 4738.507370178383, 4766.404199475066, 4779.259214821708, 5511.889762204733, 5533.280673512418, 5537.473939975695, 5602.6918519481005, 5615.747291371898, 1418.936147873348, 1440.6974535347485, 1445.7542217822995, 1448.8406275309708, 1449.0219102106037, 913.5706218077493, 964.286428043243, 973.9318247722733, 978.5254151736402, 979.1725991537139, 5352.0, 5366.6779993200535, 5378.220158077057, 5384.838454846283, 5390.595705322116, 5396.3524377075, 5605.887882242332, 5616.494515493625, 5646.407127251579, 5693.3168019837885, 5170.612204084633, 5200.5059519345605, 5270.761371077793, 5317.760700768475, 5381.165919282517, 2926.5024945759274, 2976.4493568689863, 2984.1495173875774, 3019.04899956513, 3042.452358575433, 5696.8860622787315, 5810.738516766755, 5812.59311848175, 5825.368896708928, 5832.9708351457975, 5795.1165871091225, 5798.246227990334, 5808.941910580925, 5819.53443724501, 5824.94175058244, 5840.474357307863, 5845.766169353264, 5852.912206316909, 5853.678047707417, 5857.707114644166, 5535.280413546213, 5654.717264136694, 5733.942660573508, 5740.13897915316, 5763.164341170591, 5544.085225937675, 5650.717464126859, 5655.264815573949, 5679.602427830012, 5691.4877661010705, 5729.656220626775, 5813.94186058134, 5886.999210134373, 5893.499052580579, 5913.911291330547, 3998.940015899822, 4004.1190937993597, 4010.0, 4010.418489319091, 4012.6990475713856, 5683.829485115453, 5692.402297758676, 5698.831739493477, 5778.682172480554, 5811.476967072984, 5528.585356098229, 5608.551315894637, 5623.003833639163, 5644.153376993484, 5663.801766938137, 5514.283143191359, 5523.944760552343, 5588.105903055492, 5589.860253493695, 5601.859953501195, 5473.781048758165, 5482.081271554924, 5495.340559132929, 5512.614117011771, 5514.255575497256, 5319.38827034896, 5584.86037849057, 5600.467955544217, 5655.547556195576, 5677.261955945701, 5553.861153471195, 5569.359523654832, 5575.526080283059, 5588.720563971867, 5591.552675786009], "value": 4255.454653129637, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.0998801438269, 776.6776787633136, 786.5634572812087, 802.1457148137233, 811.298227033616, 15251.694966100671, 16797.66404671906, 16800.159992000397, 16802.495925122235, 16807.075610841413, 15272.618184545392, 15392.461263855766, 15413.07521548705, 15416.537503874903, 15455.072695638242, 658.0918332700878, 788.9408294377915, 810.116972499975, 812.7114874219656, 816.4162623724036, 821.4044817507319, 824.4435006370705, 826.1573195340749, 828.7555171224503, 829.0093338460512, 691.8028361916855, 869.6390997735964, 871.333429926107, 873.4977388001893, 874.0647507167333, 850.995745021274, 866.1079088538816, 867.6009035843457, 869.1656010230187, 869.5174178331024, 637.7544645311542, 638.936106389362, 639.2169592249504, 639.4596565901805, 639.4820195641498, 15851.365945362171, 15863.286152123066, 15883.205839708084, 15901.1254381009, 15903.840961590467, 12691.428885700165, 12806.743865122738, 12839.679008024781, 13073.411696473682, 13486.932565337209, 13162.670933226651, 13168.407421665952, 13217.20696758188, 13383.799243011264, 13469.0, 4320.675949303814, 4339.609435150852, 4343.118323029381, 4475.39582156408, 4479.3504941783585, 74544.25455745481, 74695.62652186705, 75381.62309188474, 77652.28217012434, 79578.0, 11385.14611404148, 11412.543498260142, 11515.366654833897, 11600.361980091177, 11858.347790871585, 20501.17995280172, 20523.38429847077, 20540.691889621667, 20548.486287842923, 20759.68860467094, 8722.084181160886, 8745.912540874637, 8770.473771573726, 8792.208701216921, 8829.11708829112, 4718.575328220477, 4817.325574419584, 5026.899462010812, 5040.722760248222, 5087.745612719349, 3480.599731030913, 3584.802835844054, 3599.460080987873, 3599.478075679064, 3600.531930848973, 635.1996484429652, 678.8710145072421, 710.0946293475756, 716.7563028570311, 718.7960166720826, 722.631457956446, 742.9665665045086, 748.8764353881548, 752.27405553641, 770.9922900771032, 9567.61729530825, 9764.316497845082, 9934.701958941243, 10582.470876456146, 10830.891691083147, 634.5938599296454, 664.6244871647503, 747.723342363329, 757.238974830292, 768.3085223299075, 4621.907561848744, 4639.930401043987, 4641.234196357631, 4674.836380726658, 4765.26138448541, 98802.0, 100657.0, 102794.0, 117553.41223293828, 130722.34638826746, 84100.57949710212, 103779.481102594, 105017.0, 106265.46867265615, 108105.0, 94953.0, 96272.0, 97040.51479742557, 97870.21297870156, 97885.51057244668, 10199.31230556262, 10498.055175034284, 10563.495893300409, 10945.83581246298, 10988.230823842254, 55209.44790552043, 56154.43845561492, 56625.43374566202, 57046.144307834584, 58933.705331473066, 80370.0, 84655.57672211599, 84919.0, 85066.74666266785, 85300.57349713212, 12723.172993755376, 13030.4136313868, 13047.673808154872, 13113.207078608624, 13620.65948351299, 15117.95667791013, 16050.839491604935, 16051.197440127713, 16085.678286433971, 16821.831781682027, 14901.0, 15041.172735499653, 15367.385304587691, 15990.920045399698, 16002.0, 13984.300784960915, 14175.291235438393, 14201.147931124166, 14244.715105698035, 14299.785503217669, 14034.0, 14381.0, 14496.0, 14740.705185896008, 14784.260786960824, 10550.0, 10625.628103016357, 10826.621068262573, 10914.0, 10934.507947142238, 11662.0, 11666.941665291619, 11888.28670279786, 11907.642770716893, 12140.878591214328], "value": 7851.0103125777605, "unit": "score"}], "name": "dromaeo_css", "value": 7421.9107862278515, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 109.0, 110.0, 110.0, 109.0, 110.0, 108.0, 110.0, 111.0, 109.0], "value": 108.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 115.0, 116.0, 181.0, 116.0, 117.0, 142.0, 116.0, 150.0, 117.0], "value": 131.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 160.0, 160.0, 160.0, 158.0, 161.0, 160.0, 161.0], "value": 160.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 109.0, 75.0, 75.0, 75.0, 75.0, 111.0, 74.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 109.0, 83.0, 83.0, 82.0, 127.0, 82.0, 84.0, 125.0], "value": 94.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 50.0, 50.0, 50.0, 50.0, 51.0, 50.0, 50.0, 50.0], "value": 50.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 63.0, 63.0, 62.0, 63.0, 62.0, 62.0, 63.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 80.0, 75.0, 74.0, 77.0, 74.0, 75.0, 73.0, 74.0, 83.0], "value": 76.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 116.0, 124.0, 117.0, 118.0, 137.0, 129.0, 118.0, 167.0, 118.0], "value": 126.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 157.0, 156.0, 153.0, 157.0, 155.0, 153.0, 157.0, 155.0, 155.0], "value": 155.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 61.0, 63.0, 61.0, 62.0, 61.0, 62.0, 61.0], "value": 62.0, "unit": "score"}], "name": "kraken", "value": 1464.3, "alertThreshold": 2.0}]} 23:31:06 INFO - Return code: 0 23:31:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:31:06 INFO - # TBPL SUCCESS # 23:31:06 INFO - Running post-action listener: _resource_record_post_action 23:31:06 INFO - ##### 23:31:06 INFO - ##### Finished run-tests step (success) 23:31:06 INFO - ##### 23:31:06 INFO - Running post-run listener: _resource_record_post_run 23:31:06 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 559755264; Read time: 0; Write time: 681248 23:31:06 INFO - TinderboxPrint: CPU usage
13.0% 23:31:06 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 23:31:06 INFO - TinderboxPrint: I/O write bytes / time
559,755,264 / 681,248 23:31:06 INFO - TinderboxPrint: CPU idle
8,274.9 (87.0%) 23:31:06 INFO - TinderboxPrint: CPU user
1,196.6 (12.6%) 23:31:06 INFO - TinderboxPrint: Swap in / out
0 / 0 23:31:06 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 261246976; Read time: 0; Write time: 345696 23:31:06 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 298319872; Read time: 0; Write time: 335520 23:31:07 INFO - Running post-run listener: _upload_blobber_files 23:31:07 INFO - Blob upload gear active. 23:31:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:31:07 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 23:31:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:31:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:31:07 INFO - (blobuploader) - INFO - Open directory for files ... 23:31:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:31:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:31:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:31:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:31:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:31:08 INFO - (blobuploader) - INFO - Done attempting. 23:31:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:31:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:31:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:31:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:31:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:31:09 INFO - (blobuploader) - INFO - Done attempting. 23:31:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:31:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:31:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:31:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:31:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:31:21 INFO - (blobuploader) - INFO - Done attempting. 23:31:21 INFO - (blobuploader) - INFO - Iteration through files over. 23:31:21 INFO - Return code: 0 23:31:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:31:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:31:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6ab1b72a0339900d2774f25b4a2833aba65f01e064c8e3f089b756e430f5613c098e7afe0b315802c5fb7570ab98148df30eb26a4cbd18fa94748a1118915d7f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4594854a7e70f68d77eb15ee936c2230ff7b2b1e013e37fa0a85cc60e5ebbdd5426ce43dea7f9e8af29cd68f3add89a97cb313841a91a505bafa3c5316e232f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8a1685873d784fea3f0bd94329cd8ca978e8db0c3908745822c425074739f184d3d02177de64319921aca63b366b7f988c5d2806c07d951c9b8f1cafc45aee5a"} 23:31:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:31:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:31:21 INFO - Contents: 23:31:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6ab1b72a0339900d2774f25b4a2833aba65f01e064c8e3f089b756e430f5613c098e7afe0b315802c5fb7570ab98148df30eb26a4cbd18fa94748a1118915d7f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4594854a7e70f68d77eb15ee936c2230ff7b2b1e013e37fa0a85cc60e5ebbdd5426ce43dea7f9e8af29cd68f3add89a97cb313841a91a505bafa3c5316e232f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8a1685873d784fea3f0bd94329cd8ca978e8db0c3908745822c425074739f184d3d02177de64319921aca63b366b7f988c5d2806c07d951c9b8f1cafc45aee5a"} 23:31:21 INFO - Running post-run listener: copy_logs_to_upload_dir 23:31:21 INFO - Copying logs to upload dir... 23:31:21 INFO - mkdir: /builds/slave/test/build/upload/logs 23:31:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.430704 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-18 23:31:21.548644) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 23:31:21.552335) ========= 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=4ac8d263c7293b36a1be1aed000001be-1468908639.943238-767283259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6ab1b72a0339900d2774f25b4a2833aba65f01e064c8e3f089b756e430f5613c098e7afe0b315802c5fb7570ab98148df30eb26a4cbd18fa94748a1118915d7f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4594854a7e70f68d77eb15ee936c2230ff7b2b1e013e37fa0a85cc60e5ebbdd5426ce43dea7f9e8af29cd68f3add89a97cb313841a91a505bafa3c5316e232f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8a1685873d784fea3f0bd94329cd8ca978e8db0c3908745822c425074739f184d3d02177de64319921aca63b366b7f988c5d2806c07d951c9b8f1cafc45aee5a"} build_url:https://queue.taskcluster.net/v1/task/dxFeDfqSTfq0CJd9MiiL4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011311 build_url: 'https://queue.taskcluster.net/v1/task/dxFeDfqSTfq0CJd9MiiL4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6ab1b72a0339900d2774f25b4a2833aba65f01e064c8e3f089b756e430f5613c098e7afe0b315802c5fb7570ab98148df30eb26a4cbd18fa94748a1118915d7f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4594854a7e70f68d77eb15ee936c2230ff7b2b1e013e37fa0a85cc60e5ebbdd5426ce43dea7f9e8af29cd68f3add89a97cb313841a91a505bafa3c5316e232f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8a1685873d784fea3f0bd94329cd8ca978e8db0c3908745822c425074739f184d3d02177de64319921aca63b366b7f988c5d2806c07d951c9b8f1cafc45aee5a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 23:31:21.580569) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 23:31:21.580924) ========= 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=4ac8d263c7293b36a1be1aed000001be-1468908639.943238-767283259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 23:31:21.660847) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 23:31:21.661170) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 23:31:21.661489) ========= ========= Total master_lag: 0.43 =========