builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-069 starttime: 1471410994.0 results: success (0) buildid: 20160816193058 builduid: d2fd24575735416f8b449970e1ede6db revision: fe895421dfbe1f1f8f1fc6a39bb20774423a6d74 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 22:16:33.998728) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 22:16:33.999165) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 22:16:33.999460) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 22:16:34.031398) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 22:16:34.031653) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1471409982.934131-1655940122 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-16 22:16:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 19.8M=0.001s 2016-08-16 22:16:34 (19.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105341 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 22:16:34.174052) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 22:16:34.174354) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1471409982.934131-1655940122 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014704 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 22:16:34.220229) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 22:16:34.220598) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fe895421dfbe1f1f8f1fc6a39bb20774423a6d74 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev fe895421dfbe1f1f8f1fc6a39bb20774423a6d74 --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=05b19d94dfa9f3ce7b6e62cc000001f7-1471409982.934131-1655940122 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-16 22:16:34,510 truncating revision to first 12 chars 2016-08-16 22:16:34,510 Setting DEBUG logging. 2016-08-16 22:16:34,510 attempt 1/10 2016-08-16 22:16:34,510 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fe895421dfbe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-16 22:16:34,817 unpacking tar archive at: mozilla-central-fe895421dfbe/testing/mozharness/ program finished with exit code 0 elapsedTime=0.645645 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 22:16:34.885155) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 22:16:34.885501) ========= script_repo_revision: fe895421dfbe1f1f8f1fc6a39bb20774423a6d74 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 22:16:34.885983) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 22:16:34.886268) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 22:16:34.903793) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-16 22:16:34.904052) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=05b19d94dfa9f3ce7b6e62cc000001f7-1471409982.934131-1655940122 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:16:35 INFO - MultiFileLogger online at 20160816 22:16:35 in /builds/slave/test 22:16:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 22:16:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:16:35 INFO - {'append_to_log': False, 22:16:35 INFO - 'base_work_dir': '/builds/slave/test', 22:16:35 INFO - 'blob_upload_branch': 'Firefox', 22:16:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:16:35 INFO - 'branch': 'Firefox', 22:16:35 INFO - 'buildbot_json_path': 'buildprops.json', 22:16:35 INFO - 'config_files': ('talos/linux_config.py',), 22:16:35 INFO - 'default_actions': ('clobber', 22:16:35 INFO - 'read-buildbot-config', 22:16:35 INFO - 'download-and-extract', 22:16:35 INFO - 'populate-webroot', 22:16:35 INFO - 'create-virtualenv', 22:16:35 INFO - 'install', 22:16:35 INFO - 'run-tests'), 22:16:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:16:35 INFO - 'download_minidump_stackwalk': True, 22:16:35 INFO - 'download_symbols': 'ondemand', 22:16:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:16:35 INFO - 'tooltool.py': '/tools/tooltool.py', 22:16:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:16:35 INFO - '/tools/misc-python/virtualenv.py')}, 22:16:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:16:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:16:35 INFO - 'installer_path': 'installer.exe', 22:16:35 INFO - 'log_level': 'info', 22:16:35 INFO - 'log_name': 'talos', 22:16:35 INFO - 'log_to_console': True, 22:16:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:16:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:16:35 INFO - 'opt_config_files': (), 22:16:35 INFO - 'pip_index': False, 22:16:35 INFO - 'sps_profile': False, 22:16:35 INFO - 'sps_profile_interval': 0, 22:16:35 INFO - 'suite': 'dromaeojs', 22:16:35 INFO - 'system_bits': '32', 22:16:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:16:35 INFO - 'title': 'talos-linux64-ix-069', 22:16:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:16:35 INFO - 'use_talos_json': True, 22:16:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:16:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:16:35 INFO - 'work_dir': 'build'} 22:16:35 INFO - [mozharness: 2016-08-17 05:16:35.282945Z] Running clobber step. 22:16:35 INFO - Running pre-action listener: _resource_record_pre_action 22:16:35 INFO - Running main action method: clobber 22:16:35 INFO - rmtree: /builds/slave/test/build 22:16:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:16:36 INFO - Running post-action listener: _resource_record_post_action 22:16:36 INFO - [mozharness: 2016-08-17 05:16:36.248859Z] Finished clobber step (success) 22:16:36 INFO - [mozharness: 2016-08-17 05:16:36.248958Z] Running read-buildbot-config step. 22:16:36 INFO - Running pre-action listener: _resource_record_pre_action 22:16:36 INFO - Running main action method: read_buildbot_config 22:16:36 INFO - Using buildbot properties: 22:16:36 INFO - { 22:16:36 INFO - "project": "", 22:16:36 INFO - "product": "firefox", 22:16:36 INFO - "script_repo_revision": "production", 22:16:36 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 22:16:36 INFO - "repository": "", 22:16:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 22:16:36 INFO - "buildid": "20160816193058", 22:16:36 INFO - "pgo_build": "True", 22:16:36 INFO - "basedir": "/builds/slave/test", 22:16:36 INFO - "buildnumber": 422, 22:16:36 INFO - "slavename": "talos-linux64-ix-069", 22:16:36 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:16:36 INFO - "platform": "ubuntu64_hw", 22:16:36 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 22:16:36 INFO - "branch": "mozilla-central", 22:16:36 INFO - "repo_path": "mozilla-central", 22:16:36 INFO - "revision": "fe895421dfbe1f1f8f1fc6a39bb20774423a6d74", 22:16:36 INFO - "stage_platform": "linux64-pgo", 22:16:36 INFO - "builduid": "d2fd24575735416f8b449970e1ede6db", 22:16:36 INFO - "slavebuilddir": "test" 22:16:36 INFO - } 22:16:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/M1HKGyusS_aZNrKjgFNSaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 22:16:36 INFO - Running post-action listener: _resource_record_post_action 22:16:36 INFO - [mozharness: 2016-08-17 05:16:36.251499Z] Finished read-buildbot-config step (success) 22:16:36 INFO - [mozharness: 2016-08-17 05:16:36.251587Z] Running download-and-extract step. 22:16:36 INFO - Running pre-action listener: _resource_record_pre_action 22:16:36 INFO - Running main action method: download_and_extract 22:16:36 INFO - mkdir: /builds/slave/test/build/tests 22:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:16:36 INFO - trying https://queue.taskcluster.net/v1/task/M1HKGyusS_aZNrKjgFNSaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 22:16:36 INFO - Downloading https://queue.taskcluster.net/v1/task/M1HKGyusS_aZNrKjgFNSaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 22:16:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M1HKGyusS_aZNrKjgFNSaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:16:36 INFO - Downloaded 1361 bytes. 22:16:36 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 22:16:36 INFO - Using the following test package requirements: 22:16:36 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 22:16:36 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:16:36 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:16:36 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:16:36 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:16:36 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:16:36 INFO - u'jsshell-linux-x86_64.zip'], 22:16:36 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:16:36 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:16:36 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 22:16:36 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:16:36 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:16:36 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:16:36 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:16:36 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:16:36 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:16:36 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:16:36 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:16:36 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:16:36 INFO - trying https://queue.taskcluster.net/v1/task/M1HKGyusS_aZNrKjgFNSaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 22:16:36 INFO - Downloading https://queue.taskcluster.net/v1/task/M1HKGyusS_aZNrKjgFNSaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 22:16:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M1HKGyusS_aZNrKjgFNSaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:16:37 INFO - Downloaded 21902634 bytes. 22:16:37 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 22:16:42 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:16:42 INFO - trying https://queue.taskcluster.net/v1/task/M1HKGyusS_aZNrKjgFNSaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 22:16:42 INFO - Downloading https://queue.taskcluster.net/v1/task/M1HKGyusS_aZNrKjgFNSaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 22:16:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M1HKGyusS_aZNrKjgFNSaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:16:43 INFO - Downloaded 21902634 bytes. 22:16:43 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 22:16:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:16:47 INFO - trying https://queue.taskcluster.net/v1/task/M1HKGyusS_aZNrKjgFNSaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 22:16:47 INFO - Downloading https://queue.taskcluster.net/v1/task/M1HKGyusS_aZNrKjgFNSaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 22:16:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M1HKGyusS_aZNrKjgFNSaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:16:49 INFO - Downloaded 14413719 bytes. 22:16:49 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 22:16: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:16:49 INFO - trying https://queue.taskcluster.net/v1/task/M1HKGyusS_aZNrKjgFNSaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 22:16:49 INFO - Downloading https://queue.taskcluster.net/v1/task/M1HKGyusS_aZNrKjgFNSaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 22:16:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M1HKGyusS_aZNrKjgFNSaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:16:51 INFO - Downloaded 59574250 bytes. 22:16:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M1HKGyusS_aZNrKjgFNSaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 22:16:51 INFO - mkdir: /builds/slave/test/properties 22:16:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:16:51 INFO - Writing to file /builds/slave/test/properties/build_url 22:16:51 INFO - Contents: 22:16:51 INFO - build_url:https://queue.taskcluster.net/v1/task/M1HKGyusS_aZNrKjgFNSaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 22:16:52 INFO - Running post-action listener: _resource_record_post_action 22:16:52 INFO - Running post-action listener: set_extra_try_arguments 22:16:52 INFO - [mozharness: 2016-08-17 05:16:52.085716Z] Finished download-and-extract step (success) 22:16:52 INFO - [mozharness: 2016-08-17 05:16:52.085941Z] Running populate-webroot step. 22:16:52 INFO - Running pre-action listener: _resource_record_pre_action 22:16:52 INFO - Running main action method: populate_webroot 22:16:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:16:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:16:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:16:52 INFO - '--tppagecycles', 22:16:52 INFO - '7'], 22:16:52 INFO - 'tests': ['tsvgm']}}, 22:16:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:16:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:16:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:16:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:16:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:16:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:16:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:16:52 INFO - 'talos_options': ['--disable-e10s'], 22:16:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:16:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:16:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:16:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:16:52 INFO - 'talos_options': ['--disable-e10s'], 22:16:52 INFO - 'tests': ['damp', 'tps']}, 22:16:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:16:52 INFO - 'tests': ['damp', 'tps']}, 22:16:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:16:52 INFO - 'tests': ['dromaeo_dom']}, 22:16:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:16:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:16:52 INFO - 'tests': ['basic_compositor_video']}, 22:16:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:16:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:16:52 INFO - 'tests': ['a11yr', 22:16:52 INFO - 'ts_paint', 22:16:52 INFO - 'tpaint', 22:16:52 INFO - 'sessionrestore', 22:16:52 INFO - 'sessionrestore_no_auto_restore', 22:16:52 INFO - 'tabpaint']}, 22:16:52 INFO - 'other-e10s': {'tests': ['a11yr', 22:16:52 INFO - 'ts_paint', 22:16:52 INFO - 'tpaint', 22:16:52 INFO - 'sessionrestore', 22:16:52 INFO - 'sessionrestore_no_auto_restore', 22:16:52 INFO - 'tabpaint']}, 22:16:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:16:52 INFO - 'ts_paint', 22:16:52 INFO - 'tpaint', 22:16:52 INFO - 'sessionrestore', 22:16:52 INFO - 'sessionrestore_no_auto_restore', 22:16:52 INFO - 'tabpaint']}, 22:16:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:16:52 INFO - 'ts_paint', 22:16:52 INFO - 'tpaint', 22:16:52 INFO - 'sessionrestore', 22:16:52 INFO - 'sessionrestore_no_auto_restore', 22:16:52 INFO - 'tabpaint']}, 22:16:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:16:52 INFO - 'tests': ['a11yr', 22:16:52 INFO - 'ts_paint', 22:16:52 INFO - 'tpaint', 22:16:52 INFO - 'sessionrestore', 22:16:52 INFO - 'sessionrestore_no_auto_restore', 22:16:52 INFO - 'tabpaint']}, 22:16:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:16:52 INFO - 'tests': ['a11yr', 22:16:52 INFO - 'ts_paint', 22:16:52 INFO - 'tpaint', 22:16:52 INFO - 'sessionrestore', 22:16:52 INFO - 'sessionrestore_no_auto_restore', 22:16:52 INFO - 'tabpaint']}, 22:16:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:16:52 INFO - 'tests': ['tsvgx', 22:16:52 INFO - 'tsvgr_opacity', 22:16:52 INFO - 'tart', 22:16:52 INFO - 'tscrollx', 22:16:52 INFO - 'cart']}, 22:16:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:16:52 INFO - 'tsvgr_opacity', 22:16:52 INFO - 'tart', 22:16:52 INFO - 'tscrollx', 22:16:52 INFO - 'cart']}, 22:16:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:16:52 INFO - 'talos_options': ['--disable-e10s'], 22:16:52 INFO - 'tests': ['tp5o']}, 22:16:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:16:52 INFO - 'tests': ['tp5o']}, 22:16:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:16:52 INFO - 'talos_options': ['--disable-e10s', 22:16:52 INFO - '--xperf_path', 22:16:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:16:52 INFO - 'tests': ['tp5n']}, 22:16:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:16:52 INFO - 'talos_options': ['--xperf_path', 22:16:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:16:52 INFO - 'tests': ['tp5n']}}, 22:16:52 INFO - 'talos.zip': {'path': '', 22:16:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:16:52 INFO - Running post-action listener: _resource_record_post_action 22:16:52 INFO - [mozharness: 2016-08-17 05:16:52.103838Z] Finished populate-webroot step (success) 22:16:52 INFO - [mozharness: 2016-08-17 05:16:52.103926Z] Running create-virtualenv step. 22:16:52 INFO - Running pre-action listener: _resource_record_pre_action 22:16:52 INFO - Running main action method: create_virtualenv 22:16:52 INFO - Creating virtualenv /builds/slave/test/build/venv 22:16: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 22:16:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:16:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:16:52 INFO - Using real prefix '/usr' 22:16:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:16:52 INFO - Installing distribute.............................................................................................................................................................................................done. 22:16:54 INFO - Installing pip.................done. 22:16:54 INFO - Return code: 0 22:16:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:16:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:16:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:16:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:16:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8852812f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e4850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df370>, '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 0x10e28f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2d80>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1471409982.934131-1655940122', '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 22:16:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:16:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:16:54 INFO - Using env: {'DISPLAY': ':0', 22:16:54 INFO - 'HOME': '/home/cltbld', 22:16:54 INFO - 'LANG': 'en_US.UTF-8', 22:16:54 INFO - 'LANGUAGE': 'en_US:en', 22:16:54 INFO - 'LOGNAME': 'cltbld', 22:16:54 INFO - 'MAIL': '/var/mail/cltbld', 22:16:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:16:54 INFO - 'MOZ_NO_REMOTE': '1', 22:16:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:16:54 INFO - 'NO_EM_RESTART': '1', 22:16:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:16:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:16:54 INFO - 'PWD': '/builds/slave/test', 22:16:54 INFO - 'SHELL': '/bin/bash', 22:16:54 INFO - 'SHLVL': '1', 22:16:54 INFO - 'TERM': 'linux', 22:16:54 INFO - 'TMOUT': '86400', 22:16:54 INFO - 'USER': 'cltbld', 22:16:54 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1471409982.934131-1655940122', 22:16:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:16:54 INFO - '_': '/tools/buildbot/bin/python'} 22:16:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:16:54 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:16:54 INFO - Cleaning up... 22:16:54 INFO - Return code: 0 22:16:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:16:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:16:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:16:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:16:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8852812f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e4850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df370>, '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 0x10e28f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2d80>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1471409982.934131-1655940122', '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 22:16:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 22:16:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:16:54 INFO - Using env: {'DISPLAY': ':0', 22:16:54 INFO - 'HOME': '/home/cltbld', 22:16:54 INFO - 'LANG': 'en_US.UTF-8', 22:16:54 INFO - 'LANGUAGE': 'en_US:en', 22:16:54 INFO - 'LOGNAME': 'cltbld', 22:16:54 INFO - 'MAIL': '/var/mail/cltbld', 22:16:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:16:54 INFO - 'MOZ_NO_REMOTE': '1', 22:16:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:16:54 INFO - 'NO_EM_RESTART': '1', 22:16:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:16:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:16:54 INFO - 'PWD': '/builds/slave/test', 22:16:54 INFO - 'SHELL': '/bin/bash', 22:16:54 INFO - 'SHLVL': '1', 22:16:54 INFO - 'TERM': 'linux', 22:16:54 INFO - 'TMOUT': '86400', 22:16:54 INFO - 'USER': 'cltbld', 22:16:54 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1471409982.934131-1655940122', 22:16:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:16:54 INFO - '_': '/tools/buildbot/bin/python'} 22:16:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:16:55 INFO - Downloading/unpacking psutil>=3.1.1 22:16: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 22:16: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 22:16: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 22:16: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 22:16: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 22:16: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 22:16:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:16:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:16:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:16:57 INFO - Installing collected packages: psutil 22:16:57 INFO - Running setup.py install for psutil 22:16:57 INFO - building 'psutil._psutil_linux' extension 22:16: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 22:16: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 22:16:57 INFO - building 'psutil._psutil_posix' extension 22:16: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 22:16:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:16:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:16:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:16:57 INFO - Successfully installed psutil 22:16:57 INFO - Cleaning up... 22:16:57 INFO - Return code: 0 22:16:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:16:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:16:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:16:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8852812f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e4850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df370>, '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 0x10e28f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2d80>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1471409982.934131-1655940122', '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 22:16:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:16:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 22:16:57 INFO - Using env: {'DISPLAY': ':0', 22:16:57 INFO - 'HOME': '/home/cltbld', 22:16:57 INFO - 'LANG': 'en_US.UTF-8', 22:16:57 INFO - 'LANGUAGE': 'en_US:en', 22:16:57 INFO - 'LOGNAME': 'cltbld', 22:16:57 INFO - 'MAIL': '/var/mail/cltbld', 22:16:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:16:57 INFO - 'MOZ_NO_REMOTE': '1', 22:16:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:16:57 INFO - 'NO_EM_RESTART': '1', 22:16:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:16:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:16:57 INFO - 'PWD': '/builds/slave/test', 22:16:57 INFO - 'SHELL': '/bin/bash', 22:16:57 INFO - 'SHLVL': '1', 22:16:57 INFO - 'TERM': 'linux', 22:16:57 INFO - 'TMOUT': '86400', 22:16:57 INFO - 'USER': 'cltbld', 22:16:57 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1471409982.934131-1655940122', 22:16:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:16:57 INFO - '_': '/tools/buildbot/bin/python'} 22:16:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:16:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:16:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:16:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:16:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:16:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:16:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:16:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:16:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:16:59 INFO - Installing collected packages: mozsystemmonitor 22:16:59 INFO - Running setup.py install for mozsystemmonitor 22:16:59 INFO - Successfully installed mozsystemmonitor 22:16:59 INFO - Cleaning up... 22:16:59 INFO - Return code: 0 22:16:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:16:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:16:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:16:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8852812f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e4850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df370>, '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 0x10e28f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2d80>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1471409982.934131-1655940122', '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 22:16:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 22:16:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 22:16:59 INFO - Using env: {'DISPLAY': ':0', 22:16:59 INFO - 'HOME': '/home/cltbld', 22:16:59 INFO - 'LANG': 'en_US.UTF-8', 22:16:59 INFO - 'LANGUAGE': 'en_US:en', 22:16:59 INFO - 'LOGNAME': 'cltbld', 22:16:59 INFO - 'MAIL': '/var/mail/cltbld', 22:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:16:59 INFO - 'MOZ_NO_REMOTE': '1', 22:16:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:16:59 INFO - 'NO_EM_RESTART': '1', 22:16:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:16:59 INFO - 'PWD': '/builds/slave/test', 22:16:59 INFO - 'SHELL': '/bin/bash', 22:16:59 INFO - 'SHLVL': '1', 22:16:59 INFO - 'TERM': 'linux', 22:16:59 INFO - 'TMOUT': '86400', 22:16:59 INFO - 'USER': 'cltbld', 22:16:59 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1471409982.934131-1655940122', 22:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:16:59 INFO - '_': '/tools/buildbot/bin/python'} 22:17:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:17:00 INFO - Downloading/unpacking jsonschema==2.5.1 22:17: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 22:17: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 22:17: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 22:17: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 22:17: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 22:17: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 22:17:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:17:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:17: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 22:17: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 22:17: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 22:17: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 22:17: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 22:17: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 22:17:02 INFO - Downloading functools32-3.2.3-2.tar.gz 22:17:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:17:02 INFO - warning: no files found matching '*.txt' 22:17:02 INFO - no previously-included directories found matching 'build' 22:17:02 INFO - no previously-included directories found matching 'dist' 22:17:02 INFO - no previously-included directories found matching '.git*' 22:17:02 INFO - Installing collected packages: jsonschema, functools32 22:17:02 INFO - Running setup.py install for functools32 22:17:02 INFO - warning: no files found matching '*.txt' 22:17:02 INFO - no previously-included directories found matching 'build' 22:17:02 INFO - no previously-included directories found matching 'dist' 22:17:02 INFO - no previously-included directories found matching '.git*' 22:17:02 INFO - Successfully installed jsonschema functools32 22:17:02 INFO - Cleaning up... 22:17:02 INFO - Return code: 0 22:17:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:17:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:17:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:17:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8852812f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e4850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df370>, '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 0x10e28f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2d80>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1471409982.934131-1655940122', '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 22:17:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 22:17:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 22:17:02 INFO - Using env: {'DISPLAY': ':0', 22:17:02 INFO - 'HOME': '/home/cltbld', 22:17:02 INFO - 'LANG': 'en_US.UTF-8', 22:17:02 INFO - 'LANGUAGE': 'en_US:en', 22:17:02 INFO - 'LOGNAME': 'cltbld', 22:17:02 INFO - 'MAIL': '/var/mail/cltbld', 22:17:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:17:02 INFO - 'MOZ_NO_REMOTE': '1', 22:17:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:17:02 INFO - 'NO_EM_RESTART': '1', 22:17:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:17:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:17:02 INFO - 'PWD': '/builds/slave/test', 22:17:02 INFO - 'SHELL': '/bin/bash', 22:17:02 INFO - 'SHLVL': '1', 22:17:02 INFO - 'TERM': 'linux', 22:17:02 INFO - 'TMOUT': '86400', 22:17:02 INFO - 'USER': 'cltbld', 22:17:02 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1471409982.934131-1655940122', 22:17:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:17:02 INFO - '_': '/tools/buildbot/bin/python'} 22:17:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:17:02 INFO - Cleaning up... 22:17:02 INFO - Return code: 0 22:17:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:17:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:17:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:17:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8852812f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e4850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df370>, '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 0x10e28f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2d80>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1471409982.934131-1655940122', '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 22:17:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:17:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:17:02 INFO - Using env: {'DISPLAY': ':0', 22:17:02 INFO - 'HOME': '/home/cltbld', 22:17:02 INFO - 'LANG': 'en_US.UTF-8', 22:17:02 INFO - 'LANGUAGE': 'en_US:en', 22:17:02 INFO - 'LOGNAME': 'cltbld', 22:17:02 INFO - 'MAIL': '/var/mail/cltbld', 22:17:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:17:02 INFO - 'MOZ_NO_REMOTE': '1', 22:17:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:17:02 INFO - 'NO_EM_RESTART': '1', 22:17:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:17:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:17:02 INFO - 'PWD': '/builds/slave/test', 22:17:02 INFO - 'SHELL': '/bin/bash', 22:17:02 INFO - 'SHLVL': '1', 22:17:02 INFO - 'TERM': 'linux', 22:17:02 INFO - 'TMOUT': '86400', 22:17:02 INFO - 'USER': 'cltbld', 22:17:02 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1471409982.934131-1655940122', 22:17:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:17:02 INFO - '_': '/tools/buildbot/bin/python'} 22:17:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:17:02 INFO - Downloading/unpacking blobuploader==1.2.4 22:17: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 22:17: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 22:17: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 22:17: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 22:17: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 22:17: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 22:17:04 INFO - Downloading blobuploader-1.2.4.tar.gz 22:17:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:17:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:17: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 22:17: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 22:17: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 22:17: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 22:17: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 22:17: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 22:17:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:17:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:17: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 22:17: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 22:17: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 22:17: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 22:17: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 22:17: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 22:17:05 INFO - Downloading docopt-0.6.1.tar.gz 22:17:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:17:05 INFO - Installing collected packages: blobuploader, requests, docopt 22:17:05 INFO - Running setup.py install for blobuploader 22:17:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:17:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:17:05 INFO - Running setup.py install for requests 22:17:06 INFO - Running setup.py install for docopt 22:17:06 INFO - Successfully installed blobuploader requests docopt 22:17:06 INFO - Cleaning up... 22:17:06 INFO - Return code: 0 22:17:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:17: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:17:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:17:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:17:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17: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 0x7f8852812f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e4850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df370>, '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 0x10e28f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2d80>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1471409982.934131-1655940122', '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 22:17: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 22:17: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 22:17:06 INFO - Using env: {'DISPLAY': ':0', 22:17:06 INFO - 'HOME': '/home/cltbld', 22:17:06 INFO - 'LANG': 'en_US.UTF-8', 22:17:06 INFO - 'LANGUAGE': 'en_US:en', 22:17:06 INFO - 'LOGNAME': 'cltbld', 22:17:06 INFO - 'MAIL': '/var/mail/cltbld', 22:17:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:17:06 INFO - 'MOZ_NO_REMOTE': '1', 22:17:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:17:06 INFO - 'NO_EM_RESTART': '1', 22:17:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:17:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:17:06 INFO - 'PWD': '/builds/slave/test', 22:17:06 INFO - 'SHELL': '/bin/bash', 22:17:06 INFO - 'SHLVL': '1', 22:17:06 INFO - 'TERM': 'linux', 22:17:06 INFO - 'TMOUT': '86400', 22:17:06 INFO - 'USER': 'cltbld', 22:17:06 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1471409982.934131-1655940122', 22:17:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:17:06 INFO - '_': '/tools/buildbot/bin/python'} 22:17:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:17:06 INFO - Running setup.py (path:/tmp/pip-_VCZBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:17:06 INFO - Running setup.py (path:/tmp/pip-KWhflI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:17:06 INFO - Running setup.py (path:/tmp/pip-Qn9jpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:17:06 INFO - Running setup.py (path:/tmp/pip-uUnqWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:17:06 INFO - Running setup.py (path:/tmp/pip-jdYpPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:17:07 INFO - Running setup.py (path:/tmp/pip-N_SSAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:17:07 INFO - Running setup.py (path:/tmp/pip-xrtAbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:17:07 INFO - Running setup.py (path:/tmp/pip-Rk7O6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:17:07 INFO - Running setup.py (path:/tmp/pip-UIJdC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:17:07 INFO - Running setup.py (path:/tmp/pip-YNfYto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:17:07 INFO - Running setup.py (path:/tmp/pip-O7Dbuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:17:07 INFO - Running setup.py (path:/tmp/pip-cYe9fm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:17:07 INFO - Running setup.py (path:/tmp/pip-o1CQvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:17:07 INFO - Running setup.py (path:/tmp/pip-nt2wdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:17:07 INFO - Running setup.py (path:/tmp/pip-P0ZMKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:17:07 INFO - Running setup.py (path:/tmp/pip-XjmpAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:17:07 INFO - Running setup.py (path:/tmp/pip-52DUfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:17:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:17:07 INFO - Running setup.py install for manifestparser 22:17:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:17:08 INFO - Running setup.py install for mozcrash 22:17:08 INFO - Running setup.py install for mozdebug 22:17:08 INFO - Running setup.py install for mozdevice 22:17:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:17:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:17:08 INFO - Running setup.py install for mozfile 22:17:08 INFO - Running setup.py install for mozhttpd 22:17:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:17:08 INFO - Running setup.py install for mozinfo 22:17:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:17:08 INFO - Running setup.py install for mozInstall 22:17:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:17:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:17:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:17:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:17:08 INFO - Running setup.py install for mozleak 22:17:08 INFO - Running setup.py install for mozlog 22:17:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:17:08 INFO - Running setup.py install for moznetwork 22:17:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:17:09 INFO - Running setup.py install for mozprocess 22:17:09 INFO - Running setup.py install for mozprofile 22:17:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:17:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:17:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:17:09 INFO - Running setup.py install for mozrunner 22:17:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:17:09 INFO - Running setup.py install for mozscreenshot 22:17:09 INFO - Running setup.py install for moztest 22:17:09 INFO - Running setup.py install for mozversion 22:17:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:17:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:17:09 INFO - Cleaning up... 22:17:09 INFO - Return code: 0 22:17:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:17: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:17:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:17:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:17:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17: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 0x7f8852812f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e4850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df370>, '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 0x10e28f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2d80>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1471409982.934131-1655940122', '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 22:17: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 22:17: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 22:17:09 INFO - Using env: {'DISPLAY': ':0', 22:17:09 INFO - 'HOME': '/home/cltbld', 22:17:09 INFO - 'LANG': 'en_US.UTF-8', 22:17:09 INFO - 'LANGUAGE': 'en_US:en', 22:17:09 INFO - 'LOGNAME': 'cltbld', 22:17:09 INFO - 'MAIL': '/var/mail/cltbld', 22:17:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:17:09 INFO - 'MOZ_NO_REMOTE': '1', 22:17:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:17:09 INFO - 'NO_EM_RESTART': '1', 22:17:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:17:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:17:09 INFO - 'PWD': '/builds/slave/test', 22:17:09 INFO - 'SHELL': '/bin/bash', 22:17:09 INFO - 'SHLVL': '1', 22:17:09 INFO - 'TERM': 'linux', 22:17:09 INFO - 'TMOUT': '86400', 22:17:09 INFO - 'USER': 'cltbld', 22:17:09 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1471409982.934131-1655940122', 22:17:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:17:09 INFO - '_': '/tools/buildbot/bin/python'} 22:17:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:17:09 INFO - Running setup.py (path:/tmp/pip-c4BNtd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:17: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)) 22:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:17:10 INFO - Running setup.py (path:/tmp/pip-bpqQaf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:17: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)) 22:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:17:10 INFO - Running setup.py (path:/tmp/pip-J6_Vis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:17: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)) 22:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:17:10 INFO - Running setup.py (path:/tmp/pip-a2NpHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:17: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)) 22:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:17:10 INFO - Running setup.py (path:/tmp/pip-3pOWrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:17: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)) 22:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:17:10 INFO - Running setup.py (path:/tmp/pip-QlWGJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:17: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)) 22:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:17:10 INFO - Running setup.py (path:/tmp/pip-SSwa0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:17: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)) 22:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:17:10 INFO - Running setup.py (path:/tmp/pip-6uRKWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:17: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)) 22:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:17:10 INFO - Running setup.py (path:/tmp/pip-_2OEnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:17: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)) 22:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:17:10 INFO - Running setup.py (path:/tmp/pip-GpQHnc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:17:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 22:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:17:10 INFO - Running setup.py (path:/tmp/pip-MJHGOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:17: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)) 22:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:17:10 INFO - Running setup.py (path:/tmp/pip-irRnyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:17: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)) 22:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:17:10 INFO - Running setup.py (path:/tmp/pip-hYC7m2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:17: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)) 22:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:17:10 INFO - Running setup.py (path:/tmp/pip-B8OaR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:17:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:17:10 INFO - Running setup.py (path:/tmp/pip-sChKT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:17: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)) 22:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:17:11 INFO - Running setup.py (path:/tmp/pip-SP4x1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:17: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)) 22:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:17:11 INFO - Running setup.py (path:/tmp/pip-n7Obfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:17: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)) 22:17: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)) 22:17: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)) 22:17: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)) 22:17: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)) 22:17: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)) 22:17:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:17: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 22:17: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 22:17: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 22:17: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 22:17: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 22:17: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 22:17:13 INFO - Downloading blessings-1.6.tar.gz 22:17:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:17:13 INFO - Installing collected packages: blessings 22:17:13 INFO - Running setup.py install for blessings 22:17:13 INFO - Successfully installed blessings 22:17:13 INFO - Cleaning up... 22:17:13 INFO - Return code: 0 22:17:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:17:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:17:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:17:13 INFO - Reading from file tmpfile_stdout 22:17:13 INFO - Current package versions: 22:17:13 INFO - argparse == 1.2.1 22:17:13 INFO - blessings == 1.6 22:17:13 INFO - blobuploader == 1.2.4 22:17:13 INFO - docopt == 0.6.1 22:17:13 INFO - functools32 == 3.2.3-2 22:17:13 INFO - jsonschema == 2.5.1 22:17:13 INFO - manifestparser == 1.1 22:17:13 INFO - mozInstall == 1.12 22:17:13 INFO - mozcrash == 0.17 22:17:13 INFO - mozdebug == 0.1 22:17:13 INFO - mozdevice == 0.48 22:17:13 INFO - mozfile == 1.2 22:17:13 INFO - mozhttpd == 0.7 22:17:13 INFO - mozinfo == 0.9 22:17:13 INFO - mozleak == 0.1 22:17:13 INFO - mozlog == 3.3 22:17:13 INFO - moznetwork == 0.27 22:17:13 INFO - mozprocess == 0.23 22:17:13 INFO - mozprofile == 0.28 22:17:13 INFO - mozrunner == 6.12 22:17:13 INFO - mozscreenshot == 0.1 22:17:13 INFO - mozsystemmonitor == 0.3 22:17:13 INFO - moztest == 0.7 22:17:13 INFO - mozversion == 1.4 22:17:13 INFO - psutil == 3.1.1 22:17:13 INFO - requests == 1.2.3 22:17:13 INFO - wsgiref == 0.1.2 22:17:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:17: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:17:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:17:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:17:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17: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 0x7f8852812f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e4850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df370>, '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 0x10e28f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2d80>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1471409982.934131-1655940122', '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 22:17: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 22:17: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 22:17:13 INFO - Using env: {'DISPLAY': ':0', 22:17:13 INFO - 'HOME': '/home/cltbld', 22:17:13 INFO - 'LANG': 'en_US.UTF-8', 22:17:13 INFO - 'LANGUAGE': 'en_US:en', 22:17:13 INFO - 'LOGNAME': 'cltbld', 22:17:13 INFO - 'MAIL': '/var/mail/cltbld', 22:17:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:17:13 INFO - 'MOZ_NO_REMOTE': '1', 22:17:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:17:13 INFO - 'NO_EM_RESTART': '1', 22:17:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:17:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:17:13 INFO - 'PWD': '/builds/slave/test', 22:17:13 INFO - 'SHELL': '/bin/bash', 22:17:13 INFO - 'SHLVL': '1', 22:17:13 INFO - 'TERM': 'linux', 22:17:13 INFO - 'TMOUT': '86400', 22:17:13 INFO - 'USER': 'cltbld', 22:17:13 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1471409982.934131-1655940122', 22:17:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:17:13 INFO - '_': '/tools/buildbot/bin/python'} 22:17:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:17: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)) 22:17: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)) 22:17: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)) 22:17: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)) 22:17: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)) 22:17: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)) 22:17: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)) 22:17: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)) 22:17: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)) 22:17: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)) 22:17: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)) 22:17:13 INFO - Cleaning up... 22:17:13 INFO - Return code: 0 22:17:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:17: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:17:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:17:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:17:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17: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 0x7f8852812f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e4850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df370>, '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 0x10e28f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2d80>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1471409982.934131-1655940122', '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 22:17: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 22:17: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 22:17:13 INFO - Using env: {'DISPLAY': ':0', 22:17:13 INFO - 'HOME': '/home/cltbld', 22:17:13 INFO - 'LANG': 'en_US.UTF-8', 22:17:13 INFO - 'LANGUAGE': 'en_US:en', 22:17:13 INFO - 'LOGNAME': 'cltbld', 22:17:13 INFO - 'MAIL': '/var/mail/cltbld', 22:17:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:17:13 INFO - 'MOZ_NO_REMOTE': '1', 22:17:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:17:13 INFO - 'NO_EM_RESTART': '1', 22:17:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:17:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:17:13 INFO - 'PWD': '/builds/slave/test', 22:17:13 INFO - 'SHELL': '/bin/bash', 22:17:13 INFO - 'SHLVL': '1', 22:17:13 INFO - 'TERM': 'linux', 22:17:13 INFO - 'TMOUT': '86400', 22:17:13 INFO - 'USER': 'cltbld', 22:17:13 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1471409982.934131-1655940122', 22:17:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:17:13 INFO - '_': '/tools/buildbot/bin/python'} 22:17:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:17:13 INFO - Cleaning up... 22:17:13 INFO - Return code: 0 22:17:13 INFO - Running post-action listener: _resource_record_post_action 22:17:13 INFO - Running post-action listener: _start_resource_monitoring 22:17:13 INFO - Starting resource monitoring. 22:17:13 INFO - [mozharness: 2016-08-17 05:17:13.997796Z] Finished create-virtualenv step (success) 22:17:13 INFO - [mozharness: 2016-08-17 05:17:13.998263Z] Running install step. 22:17:13 INFO - Running pre-action listener: _resource_record_pre_action 22:17:13 INFO - Running main action method: install 22:17:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:17:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:17:14 INFO - Reading from file tmpfile_stdout 22:17:14 INFO - Detecting whether we're running mozinstall >=1.0... 22:17:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:17:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:17:14 INFO - Reading from file tmpfile_stdout 22:17:14 INFO - Output received: 22:17:14 INFO - Usage: mozinstall [options] installer 22:17:14 INFO - Options: 22:17:14 INFO - -h, --help show this help message and exit 22:17:14 INFO - -d DEST, --destination=DEST 22:17:14 INFO - Directory to install application into. [default: 22:17:14 INFO - "/builds/slave/test"] 22:17:14 INFO - --app=APP Application being installed. [default: firefox] 22:17:14 INFO - mkdir: /builds/slave/test/build/application 22:17:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:17:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:17:31 INFO - Reading from file tmpfile_stdout 22:17:31 INFO - Output received: 22:17:31 INFO - /builds/slave/test/build/application/firefox/firefox 22:17:31 INFO - Running post-action listener: _resource_record_post_action 22:17:31 INFO - [mozharness: 2016-08-17 05:17:31.239918Z] Finished install step (success) 22:17:31 INFO - [mozharness: 2016-08-17 05:17:31.240166Z] Running run-tests step. 22:17:31 INFO - Running pre-action listener: _resource_record_pre_action 22:17:31 INFO - Running main action method: run_tests 22:17:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:17:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:17:31 INFO - Python 2.7.3 22:17:31 INFO - Return code: 0 22:17:31 INFO - grabbing minidump binary from tooltool 22:17: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:17: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 0x10df370>, '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 0x10e28f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:17: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 22:17: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 22:17: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 22:17:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:17:31 INFO - Return code: 0 22:17:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:17:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:17:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:17:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:17:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:17:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M1HKGyusS_aZNrKjgFNSaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 22:17:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M1HKGyusS_aZNrKjgFNSaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --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 22:17:31 INFO - Using env: {'DISPLAY': ':0', 22:17:31 INFO - 'HOME': '/home/cltbld', 22:17:31 INFO - 'LANG': 'en_US.UTF-8', 22:17:31 INFO - 'LANGUAGE': 'en_US:en', 22:17:31 INFO - 'LOGNAME': 'cltbld', 22:17:31 INFO - 'MAIL': '/var/mail/cltbld', 22:17:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:17:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:17:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:17:31 INFO - 'MOZ_NO_REMOTE': '1', 22:17:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:17:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:17:31 INFO - 'NO_EM_RESTART': '1', 22:17:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:17:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:17:31 INFO - 'PWD': '/builds/slave/test', 22:17:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:17:31 INFO - 'SHELL': '/bin/bash', 22:17:31 INFO - 'SHLVL': '1', 22:17:31 INFO - 'TERM': 'linux', 22:17:31 INFO - 'TMOUT': '86400', 22:17:31 INFO - 'USER': 'cltbld', 22:17:31 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1471409982.934131-1655940122', 22:17:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:17:31 INFO - '_': '/tools/buildbot/bin/python'} 22:17:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M1HKGyusS_aZNrKjgFNSaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 22:17:31 INFO - mozversion application_buildid: 20160816193058 22:17:31 INFO - mozversion application_changeset: fe895421dfbe1f1f8f1fc6a39bb20774423a6d74 22:17:31 INFO - mozversion application_display_name: Nightly 22:17:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:17:31 INFO - mozversion application_name: Firefox 22:17:31 INFO - mozversion application_remotingname: firefox 22:17:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:17:31 INFO - mozversion application_vendor: Mozilla 22:17:31 INFO - mozversion application_version: 51.0a1 22:17:31 INFO - mozversion platform_buildid: 20160816193058 22:17:31 INFO - mozversion platform_changeset: fe895421dfbe1f1f8f1fc6a39bb20774423a6d74 22:17:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:17:31 INFO - mozversion platform_version: 51.0a1 22:17:31 INFO - using testdate: 1471411051 22:17:31 INFO - actual date: 1471411051 22:17:31 INFO - starting webserver on 'localhost:37420' 22:17:31 INFO - SUITE-START | Running 2 tests 22:17:31 INFO - TEST-START | dromaeo_css 22:17:31 INFO - operating with platform_type : linux_ 22:17:31 INFO - Initialising browser for dromaeo_css test... 22:17:31 INFO - TEST-INFO | started process 1957 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTvBlO8/profile http://localhost:37420/getInfo.html) 22:17:35 INFO - PROCESS | 1957 | __metrics Screen width/height:1600/1200 22:17:35 INFO - PROCESS | 1957 | colorDepth:24 22:17:35 INFO - PROCESS | 1957 | Browser inner width/height: 1024/697 22:17:35 INFO - PROCESS | 1957 | __metrics 22:17:36 INFO - PROCESS | 1957 | 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" 22:17:36 INFO - PROCESS | 1957 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:17:36 INFO - PROCESS | 1957 | console.error: PushService: 22:17:36 INFO - PROCESS | 1957 | stateChangeProcessEnqueue: Error transitioning state 22:17:36 INFO - PROCESS | 1957 | UnknownError 22:17:37 INFO - TEST-INFO | 1957: exit 0 22:17:37 INFO - Browser initialized. 22:17:37 INFO - Running cycle 1/1 for dromaeo_css test... 22:17:37 INFO - TEST-INFO | started process 2039 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTvBlO8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:17:49 INFO - PROCESS | 2039 | RSS: Main: 155607040 22:17:49 INFO - PROCESS | 2039 | 22:18:40 INFO - PROCESS | 2039 | 1471411120824 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] 22:20:50 INFO - PROCESS | 2039 | Cycle 1(1): loaded http://localhost:37420/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37420/tests/dromaeo/cssquery-ext.html) 22:20:51 INFO - PROCESS | 2039 | RSS: Main: 264601600 22:20:51 INFO - PROCESS | 2039 | 22:23:53 INFO - PROCESS | 2039 | Cycle 1(1): loaded http://localhost:37420/tests/dromaeo/cssquery-ext.html (next: http://localhost:37420/tests/dromaeo/cssquery-jquery.html) 22:23:54 INFO - PROCESS | 2039 | RSS: Main: 244768768 22:23:54 INFO - PROCESS | 2039 | 22:26:56 INFO - PROCESS | 2039 | Cycle 1(1): loaded http://localhost:37420/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37420/tests/dromaeo/cssquery-mootools.html) 22:26:56 INFO - PROCESS | 2039 | RSS: Main: 185466880 22:26:56 INFO - PROCESS | 2039 | 22:29:58 INFO - PROCESS | 2039 | Cycle 1(1): loaded http://localhost:37420/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37420/tests/dromaeo/cssquery-prototype.html) 22:29:59 INFO - PROCESS | 2039 | RSS: Main: 221147136 22:29:59 INFO - PROCESS | 2039 | 22:33:02 INFO - PROCESS | 2039 | Cycle 1(1): loaded http://localhost:37420/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37420/tests/dromaeo/cssquery-yui.html) 22:33:02 INFO - PROCESS | 2039 | RSS: Main: 184819712 22:33:02 INFO - PROCESS | 2039 | 22:36:05 INFO - PROCESS | 2039 | Cycle 1(1): loaded http://localhost:37420/tests/dromaeo/cssquery-yui.html (next: http://localhost:37420/tests/dromaeo/cssquery-dojo.html) 22:36:05 INFO - PROCESS | 2039 | RSS: Main: 284717056 22:36:05 INFO - PROCESS | 2039 | 22:36:05 INFO - PROCESS | 2039 | __start_tp_report 22:36:05 INFO - PROCESS | 2039 | _x_x_mozilla_page_load 22:36:05 INFO - PROCESS | 2039 | _x_x_mozilla_page_load_details 22:36:05 INFO - PROCESS | 2039 | |i|pagename|runs| 22:36:05 INFO - PROCESS | 2039 | |0;dojo.html;2985.8208507489553;2994.8352840593757;3009.548567714843;3025.6974302569747;3028.394321135772;5100;5163.870903227421;5173.767180476878;5289.338832645914;5322.0686379883555;5165.8450246492575;5174.223866420039;5206.479352064792;5221.686698798075;5251.527362537371;4718.9292160617615;4751.833685820997;4878.390201224847;4920.778564964585;4950.702957822542;4870.780814863322;4913.066517361708;4919.316623020327;4919.458859525449;4939.333190019337;4620.260758278693;4834.492378300298;4914.70511769295;4915.3855768029;5004.049230646184;4751.524847515256;4760.143174228638;4761.928571071437;4820.566149046603;4886.706797592155;4764.356811830393;4774.212254977924;4798.808047678089;4822.469528351879;4842.467328593852;5003.874903127415;5180.792768289264;5230.398504172031;5234.110201265794;5252.159654455307;5666.5183459406;5672.319321681383;5690.772369105231;5714.257146570961;5726.742296596663;5699.515541178963;5723.284589426322;5738.540916726652;5747.252857128547;5748.741306641211;5012.749362531896;5217.713025783581;5268;5280.9207861882105;5321;5828.88342233153;5829.358770535237;5831;5837.970810146007;5839.503642190376;5585.218069470277;5607.859803504945;5614.466625670555;5619.100943848965;5622.971885140548;5330.92003619946;5506.779728810803;5542.501174894279;5542.5565954723525;5685.147227915763;5548.112302031736;5556.138798486241;5561.193626924073;5562.499375056183;5601.271834661468;5510.91733623996;5561.77752889888;5564.527015203753;5564.860878478071;5569.053260945649;4194.748315101104;4249.660027197817;4278.208531421635;4307.504636966789;4348.804303806336;3825.5026846509777;3833.0800607853917;3838.5201849768778;3867.361885288896;3870.7871067091583;5251.159814429673;5288.81489147878;5295.947040529622;5327.094393953037;5345.625806193607;5364.91952620711;5542.2795036644975;5592.944070559242;5593.049181639131;5616.747246373923;5307.708076055854;5328.254044433782;5329.8934021319355;5335.466453354711;5358.5981051421295;4760.357351757538;4767.427908650915;4769.475357710649;4775.617950563947;4808.110499557593;5595.580331475075;5741.540676745851;5785.595008349459;5817.592768506164;5860.970695146497;5646.322441307069;5646.774129034792;5649.971750141223;5650;5678.943210567842;5817.127430885232;5822.184894114912;5822.970885145547;5824.155497452761;5825.2135961644635;5271.894562108813;5422.267993820784;5439.374471935778;5448.673079615236;5531.834044978657;5507.118860982224;5559.305086864142;5562.443755624405;5565.248691426606;5600.159976003632;5449.836504904859;5455.481729235717;5455.672659640434;5458.61789674719;5494.890102198014;5272.76272567743;5385.488378604026;5441.102218134122;5486.533644640251;5504.256925315031;5487.176923461513;5488.588355873246;5494.203340515683;5499.175123731472;5535.6955367455175;5586.804461843979;5590.748416321357;5632.5212356950115;5643.294588176478;5650.26546548946;5101.438841727333;5130.333056702605;5138.486151384832;5369.3556773187465;5459.099248624091 22:36:05 INFO - PROCESS | 2039 | |1;ext.html;573.2204202284892;581.3053401185583;594.251243433274;599.2000679093413;616.4020899727263;32782.34435311292;44393.55606443935;45403;45556.31665525016;45567.77216113923;46262.306065409044;46734;46850.76574617122;46885.29672054922;46895.765521172434;8140.308073813733;8898.777530561756;9049.638014479413;9049.819003619923;10667.83998240027;10546.630867919625;10953.726156846064;10954.287971281881;10954.507047182857;10971.83542246867;11033.282836615634;11068.889311106906;11084.279521831095;11087.72280692985;11091.944540277287;10965.56137754489;10999.890001100046;11014.06380457662;11028;11036.779264414667;10717.196210284259;10787.784244315148;10793.244472886901;10796.190285728524;10812.513436895359;43549.78225108886;43780.12439751219;43891.12217755627;43983.78008109939;44009;3631.1466805300734;3644.7266455015715;3690.560681334282;3758.68051215647;3792.374258247386;32746;32811.343773124645;33637.486313115965;33749.156271093176;34388.14029649254;4409.669274804402;4438.4451943507065;4555.263721859781;4587.151376995266;4683.344331793552;367085;367447;367725;367878;369292;35233.82383088068;57282.713586432634;57542.7122864383;57575.424245757844;57607;34763.826180868935;36184;36557.26885462329;36657.63342366542;36669;14314.212718300594;14458;14458.204798736171;14469.855301447062;14549.490767823076;10800.567977280978;11632.476538555786;11748.412579370997;11750.118741094451;11773.117016223647;8490.787730306669;8527.317814574819;8594.87107693385;8596.742097737078;8647;3118.469860123784;3179.761517886168;3215.3569286142865;3224.0972527692284;3243.659415761358;947.209080417845;975.687779910436;1044.368157264859;1113.8663360396642;1145.1640302579165;31717;32311.51532727011;32633.18417039593;32720.509192362133;32763.06863478138;1046.4976811130548;1130.9943450282697;1141.646089712192;1191.6722901202065;1254.617341710787;16172.433964811411;16375.672486550202;16421.343146274256;16589.25812789664;16754.497365079067;542456;543077;551530;552479;773531;60563.39436605578;61537.38462615406;61553.38446615566;61627.69186154041;61870.69064654648;1227.7421741434398;1318.8878945289566;1345.488714288564;1362.9386677599532;1387.188494730594;30946.381072377975;33266.501002485464;33342.33315333631;33428.331433371684;33455.66544334526;50397;50720.49279507158;50887;50970.49029509658;51051;425381;428063;429261;429453;430808;29368.559471607514;29453.263668407602;29644.256918892872;29873.10380688583;29885.850570747007;46308.7684561575;46725.2991205139;46972;47259;47595.04809903852;40604;41146.794266028475;41245.1750964973;41693.37459938164;42854.35718464163;39865.202695945336;40335.79832100821;41519.169616606894;41558.37662435006;41641.58358416498;39950.400743988284;40532.59467405406;40573;40775.59224407718;40792.79603601963;34617;36613.63386366102;37387.43918841165;37582.8120859394;37638;26696;27399.86300068487;27494.587581186697;27683.307917302227;27723 22:36:05 INFO - PROCESS | 2039 | |2;jquery.html;377.9678727308179;390.44166841416796;403.7173978215249;405.61061381074177;425.12636531926876;14123.293835308232;18603.720944185832;19576.21695132193;19942.900285498552;20029.799702002994;12483.31341776202;12677.302748348837;12692.30192339421;12812.487500499969;12839.16545424549;3980.363141897297;5281.023010743015;5431.809886653968;5441.619086663935;5443.237946687447;5717.142428635696;5917.408259174092;5984.551158663117;6070.908936365958;6081.391860813927;5844.912326315109;5906.793262235823;5956.37458066901;6072.848178795522;6085.361037091108;5982.8803423931495;6032.547558933097;6033.456988871001;6035.547333949971;6043.4560889519935;5727.140928860663;5769.567282453832;5795.246617939683;5801.829846248991;5808.273965754281;14348;14444.494442694455;14567.635809104751;21200.575988480145;23394.7660523396;2207.404000919759;2456.287676573809;2950.837703926283;2997.7901546891726;3118.0200572636313;10348.120409765179;10351;10892.237543371966;10902.945485272523;11062.944685276603;1918.5779128591687;1983.7123617075588;1997.4107638246753;2008.4476768888526;2044.0290861840656;83551.99999999939;85189;86789;87324.56337718334;91060;10922.836157457645;11032.889671103347;11163.665090047312;11400.600978965696;11519.48162332697;15753.13357765311;15785.131817749905;15800.130992795277;15802.68394632124;15810.525684229491;7756.844863102707;7984.481008734414;7988.640511177011;8265.421420500506;8281.29608983243;7613.771586852293;7645.19725428833;7844.568548729874;7869.3311068559815;7873.409494287951;4833.154198015333;4875.853724388274;4902.3872015998;4916.5575098240615;4987.750612469362;1931.806819318057;2005.9799402006086;2020.1818263603263;2022.1203776357038;2039.2149022626395;939.3800091939424;999.1806718490768;1003.4882210072915;1027.8304079826744;1052.9631462898915;19825.10787014588;20051.799482005285;20159.294424695065;20244;20553.48616284605;974.6832279509188;981.6318880419842;990.6334656177261;1012.8987101289812;1041.520900385831;10685.412302323446;10974.725631859268;11119.843219959655;11152.553897843994;11306.660800176009;458047;458062;497356.56608585076;506732;510792;92315.53842230747;93283.66790830148;94275.52862235782;94334;99690.5015474918;990.7523119220195;1003.1222680154865;1010.3079390617597;1017.6896046705677;1019.6889948565758;16941.491755247363;17137.314507420062;17868.374606888698;18086.90956545209;18388.908055459637;43856.34215486707;44042.779786100866;44439.55560444354;44440.33339499975;44477.33284000807;56615.43384566101;56713;56900.430995689516;62167.06749398853;64031.6798416005;7148.999140120283;8638.438501497383;8775.605097770744;9024.142706442877;9095.49974751395;9690.660826871026;13152.21086734799;13342;13865.584032479042;14171.220582868042;11974.401279936143;12109.212901161396;12166.330851803235;12228.571999979958;12482.812757808822;5889.499392551681;10900.528428662346;10961.287516311415;11855.407229638657;12058.638240852788;6648.5346025777735;8087.1104178539135;12006.519739210684;12223;12602.621921342374;8788.384813063025;8816.51509167002;8820.766032304658;8886.5112418815;9185.127412895765;9344.626214951326;11664.416779161178;11853.466594003117;12037.939810300892;12283.263004219776 22:36:05 INFO - PROCESS | 2039 | |3;mootools.html;1342.2215564377202;1459.0589070049818;1497.4384605772834;1596.9680606387872;1745.048948323163;8030.839383212332;8407.957960210199;8431.66273349066;8625.309975201984;8628.48229106254;8455.53494557799;8564.828703425943;8565.100664430238;8586.742397728063;8604.354673399488;2330;2354.6468029795583;2355.49356888269;2356.0575769692173;2357.3988632898586;2323.186884590397;2356.6818479505305;2362.9721071334025;2363.444590521226;2368.2066507719846;2329.988350058256;2332.591796435617;2341.9648705269433;2375.9168429104984;2393.8324317297797;2287.0737351372723;2308.9307320780404;2311.6879221305076;2312.4796920692793;2316.4324740438615;2303.1133013789645;2310.6418505131733;2311.3643747969277;2319;2327.685762422085;8428.283595894356;8479.788005299855;8509.702160424355;8534.61594228255;8544.74365769028;4965.280034395028;5158.200478925773;5174.922376164361;5175.094358487249;5187.766550505236;3246.821424821634;3375.864965401381;3397.1167496450853;3416.41136871356;3428.297199074184;1191.7676053169635;1197.1918954705625;1240.9937950310282;1249.181785930217;1261.2369516442604;11703.239289446245;11741.94129029358;11786.35175065371;11801.29192248468;11805.468753906094;4154.833806647761;4344.782760861945;4452.109578084396;4458.08609235106;4461.13007963444;8982.640694372283;9017.954910225539;9023.097690230925;9024.684136055206;9024.954875225712;5002.699838009731;5032.79868805251;5038.823641172541;5039.44566097729;5041.773120209599;4076.898077548026;4465.620422264079;4532.909341813145;4603.17142914272;4735.692180008288;3566.7324950628285;3578.4632305154437;3654.7258955577904;3655.4334078217917;3724.1992971510713;1116.0792346314324;1137.590467431724;1138.3511398502774;1149.7872893514727;1154.7979103656994;975.7365511312048;976.8534719792088;982.9973427104313;984.3355734878928;1002.5688953749811;5825.271841019872;5851.590388672752;5876;5931.288245410578;6084.8783024340155;481.6604293972741;489.8040783686554;490.5815270339113;492.33534728116757;495.97520123993655;4039.6768258539832;4076.449679293317;4102.466679331727;4115.670746340285;4124.443200167999;10387.480625968672;10872.891271087346;10879.292845964987;10884.782304353868;10932.726681833017;10808.297460665031;10841;10842.241043127064;10855.294405863593;10864.837027444595;7540.622968851536;7817.335526480199;7844.294013538694;8006.759797206209;8009.559474228973;5837.153612726216;6051.273847138372;6129.203203583684;6154.215277569455;6157.476614487639;9800.411975281506;9892;9897.35667181631;9919.305648604528;10009.899901001188;9479.857802132836;9811.215102791903;9837.950810245902;9960.651377201762;10028.548715307683;6788.049673045679;6967.09427774386;6977.197622273504;7644.541327520366;7808.258215469521;7575.659095340613;8159.79600509992;8252.133525979685;8375.790605234917;8564.143585641386;7295.489315747846;7573.2805383488485;7751.689932402866;7753.340966017726;7869.173736757787;7437;7453.590052546945;7503.88744168827;7675.731349402744;7740.26467485588;6936.375726184668;7001.334873187039;7020.473464490286;7021.508494405342;7033.156021277479;4893.6085113191575;5103.8468845934685;5137.845864623918;5150.841060761299;5164.483551644806;5056.57019153376;5077.7715002824225;5104.132297509358;5119.539241468286;5276.15581506957 22:36:05 INFO - PROCESS | 2039 | |4;prototype.html;332.95192822381443;340.1920438957476;343.28939096071133;345.42314335060445;347.1737265308565;5285.207218917164;5292.036459582637;5305.495977882099;5310.15037593985;5347.331583552056;4951.801927922878;5091.261767043777;5106.77019534121;5109.642325037249;5289.259503669489;4004.439378487014;4079.4288799568158;4088.3867419887106;4118.341065429532;4160.958390416087;4121.340585506319;4150.21935303346;4150.937735933963;4162.937555936664;4165.916681666365;4075.5379020096784;4124.97937510312;4143.129942712034;4150.584941505856;4155;3941.152652179781;4047.7571345719352;4089.7750623715683;4100.2414553307735;4101.2979613460375;3649.6532829381167;3656.1042544576485;3665;3676.5036720042986;3691.8523259069607;5071.2139618359215;5097.4962386096195;5104.336436263299;5107.846764597068;5113.386393632788;4614.515475875052;4690.530946905316;4719.693219940693;4722.574968252839;4732.621390288768;5417.51242388187;5438.640339915021;5442.455754424526;5444.428335024805;5445.1832225166145;4052.8176232069627;4053.513578370585;4055.2092341993325;4055.9391609125887;4058.3303754880408;5532.3914369419335;5540.750666220029;5631.352394474647;5638.577106716972;5676.211993222122;4131.855385061508;4133.379993001074;4137.089840235143;4137.379393091001;4138.461999939988;4173.52004519478;4182;4183.686223533247;4195.496540415109;4201.789910504463;4454.910901781946;4682.789274482589;4687.554682305175;4698.624110071254;4714.88212794676;5532;5535.363433205152;5551.666899986014;5555.8888822223325;5563.916541251884;1409.4503143773936;1409.9154050756988;1412.4844431782326;1412.837523684769;1414.5402744108;857.7769779857282;906.3429013964823;914.9542522873829;924.3806649544821;926.4256161179977;4719.772859056601;4729.834455794031;4741.217699079613;4778.753985626749;4791.6645834791925;4934.925976110361;4981.975090124526;5010.972750586121;5043.663429191267;5044.511868998581;4712.410948631421;4713.78787954536;4725.621950243973;4767.713937163781;5148.330717006766;2940.6471223453323;2972.316367235548;2981.5527670849547;2987.746041586446;2987.850607469618;5851.473367396955;5863.560232982458;5872.354041055481;5880.8235752927485;5883.2935250791725;5512.889742205133;5725.685087320154;5744.788256521269;5758.395368486249;5759.2512973313205;5807.738651760596;5818.214541036906;5836.533077353802;5839.416058394127;5841.211436456109;5372.5433338166695;5626.606137570331;5631.4368563145;5635.295588051494;5644.548436125182;5537.889242215214;5571.9721401392735;5576.247206627054;5581.693006884498;5610.410906854721;5854.209681693087;5857.47282744555;5861.472467477947;5874.911876321773;5879.7060146993335;3967.1272320089533;4029.4761680981283;4036.7981600919247;4075;4093.713440059167;5614.354349249726;5616.578756593353;5617.539439745614;5633.295838020247;5635.830925072254;5447.727613619224;5497.422770609029;5545.7781688732;5556.361018482765;5563.749631266522;5226.660267082628;5462.317210348707;5464.207689885024;5521.779128834802;5532.1425179097305;5364.678119312697;5386.784528618811;5412.512873841373;5422.945770542244;5424.945750542444;5257.89484210306;5334.413214546319;5485.807996720096;5519.558435325244;5528.253685752372;5373.704446255493;5374.811881584282;5385.892282154413;5406.675599464044;5416.485433883775 22:36:05 INFO - PROCESS | 2039 | |5;yui.html;773.2267732267733;777.8249893773898;813.3290035720528;836.5482639374738;859.2996707683237;15804.367825286989;17552.473425797216;17687.204075816586;17745.20146593403;17764.911175444136;15509.612259693513;15730.213489325517;15750.369985200607;15761.842381576182;15761.921190394032;657.6054367379581;789.8420315936806;789.9052113746344;812.5490352854164;817.3992115794886;807.1081454992237;810.3517186251005;812.6464987730357;813.8575749243888;814.0882211922625;873.5239294584435;874.1258741258741;876.1851478125341;877.9824403511958;878.1964502480223;697.4072038767058;842.0653075086649;866.5927014303298;867.6225841758824;868.4832524647825;625.4652272307158;632.4687262699355;634.0679201573679;634.3402861024529;634.346622978333;16161.919190403973;16206.837931620768;16214.675706485805;16218.189090545544;16223.26995285215;15028.624284392869;15143.924280378638;15147.469838555708;15296.311665974947;15319.923400382926;13402.798958015637;13549.932250338783;13645.249511276876;13834.308284585832;13980.370883310276;4377.124575084996;4449.599536041739;4482.5069242383315;4526.818927242939;4533.954660453419;87345;89316;89762.10237897602;91037.54481227617;91130;12178.147529672839;12217.144799864102;12260.38698065111;12262;12317.322547259808;22576.435589110402;22585.661215081785;22590;22710.205142819923;22721.659175112385;8717.433366831136;8725.869111963326;8903.688370906988;9115;9196.770080748034;4940.7035577865445;4992.345467920541;5030.974845125824;5103.336566246364;5190.429052804188;3345.531625572422;3471.3057388522398;3475.94786078209;3483.059573915029;3491.5635545556806;597.8953683105439;598.4165438697236;614.9538784591174;618.4434009391583;627.645380360095;603.1585937617;628.4281304013326;661.7022339947043;665.6704931059156;667.2393471442559;9633.951830240803;9652.75868103303;9894.950525247328;9976.251781116445;10080.14318782897;638.2532437048571;658.6706646676662;659.8185498987817;664.3489380407228;728.3153835394712;4780.808767649255;4872.731999740048;4923.950760492421;4927.975360123177;4944.826931057468;95034.52482737681;135431;136101;137267;138920.52698682612;113193;113398.3300834955;115840.42079789547;116918;119515;99085;99644;101476.98523014823;102627;105037.47481262544;8799.780005499913;9513.286503512403;9517.821159625604;9671.17794987434;9681.806363872824;55598.72200639133;55615.72192139013;55922.44077559172;56871;57258.42741572531;72262.63868680834;82802;83409.58295208485;84101;84304.57847710722;12435.253884766942;12784.808227876776;12961;13024.869751302365;13113.934430327787;13608;13619.931900340434;13641.795373069213;13840.653983650489;13879.306034698428;12135.514579417078;12139.332336721565;12254.264744115382;12442.191257568229;12494;14193.858061419667;14334.569962901129;14350.712985740436;14531.418743250151;14825.33286002111;13696.86303136956;14395.272567291991;14437.566872993826;14462.27688615586;14836.480723174636;11803.861991764406;12094.334811585448;12260.203086799329;13435.529756458476;13460.461581536629;11448.313101213955;11661.76676466483;11768.293902365544;11897.762044759229;11909.702257443632 22:36:05 INFO - PROCESS | 2039 | __end_tp_report 22:36:05 INFO - PROCESS | 2039 | __start_cc_report 22:36:05 INFO - PROCESS | 2039 | _x_x_mozilla_cycle_collect,1010 22:36:05 INFO - PROCESS | 2039 | __end_cc_report 22:36:05 INFO - PROCESS | 2039 | __startTimestamp1471412165984__endTimestamp 22:36:05 INFO - PROCESS | 2039 | 22:36:05 INFO - PROCESS | 2039 | ------- Summary: start ------- 22:36:05 INFO - PROCESS | 2039 | Number of tests: 6 22:36:05 INFO - PROCESS | 2039 | 22:36:05 INFO - PROCESS | 2039 | [#0] dojo.html Cycles:165 Average:5214.55 Median:5369.36 stddev:592.52 (11.0%) stddev-sans-first:567.95 22:36:05 INFO - PROCESS | 2039 | Values: 2985.8 2994.8 3009.5 3025.7 3028.4 5100.0 5163.9 5173.8 5289.3 5322.1 5165.8 5174.2 5206.5 5221.7 5251.5 4718.9 4751.8 4878.4 4920.8 4950.7 4870.8 4913.1 4919.3 4919.5 4939.3 4620.3 4834.5 4914.7 4915.4 5004.0 4751.5 4760.1 4761.9 4820.6 4886.7 4764.4 4774.2 4798.8 4822.5 4842.5 5003.9 5180.8 5230.4 5234.1 5252.2 5666.5 5672.3 5690.8 5714.3 5726.7 5699.5 5723.3 5738.5 5747.3 5748.7 5012.7 5217.7 5268.0 5280.9 5321.0 5828.9 5829.4 5831.0 5838.0 5839.5 5585.2 5607.9 5614.5 5619.1 5623.0 5330.9 5506.8 5542.5 5542.6 5685.1 5548.1 5556.1 5561.2 5562.5 5601.3 5510.9 5561.8 5564.5 5564.9 5569.1 4194.7 4249.7 4278.2 4307.5 4348.8 3825.5 3833.1 3838.5 3867.4 3870.8 5251.2 5288.8 5295.9 5327.1 5345.6 5364.9 5542.3 5592.9 5593.0 5616.7 5307.7 5328.3 5329.9 5335.5 5358.6 4760.4 4767.4 4769.5 4775.6 4808.1 5595.6 5741.5 5785.6 5817.6 5861.0 5646.3 5646.8 5650.0 5650.0 5678.9 5817.1 5822.2 5823.0 5824.2 5825.2 5271.9 5422.3 5439.4 5448.7 5531.8 5507.1 5559.3 5562.4 5565.2 5600.2 5449.8 5455.5 5455.7 5458.6 5494.9 5272.8 5385.5 5441.1 5486.5 5504.3 5487.2 5488.6 5494.2 5499.2 5535.7 5586.8 5590.7 5632.5 5643.3 5650.3 5101.4 5130.3 5138.5 5369.4 5459.1 22:36:05 INFO - PROCESS | 2039 | 22:36:05 INFO - PROCESS | 2039 | [#1] ext.html Cycles:180 Average:61275.49 Median:367266.00 stddev:126685.56 (34.5%) stddev-sans-first:126958.96 22:36:05 INFO - PROCESS | 2039 | Values: 573.2 581.3 594.3 599.2 616.4 32782.3 44393.6 45403.0 45556.3 45567.8 46262.3 46734.0 46850.8 46885.3 46895.8 8140.3 8898.8 9049.6 9049.8 10667.8 10546.6 10953.7 10954.3 10954.5 10971.8 11033.3 11068.9 11084.3 11087.7 11091.9 10965.6 10999.9 11014.1 11028.0 11036.8 10717.2 10787.8 10793.2 10796.2 10812.5 43549.8 43780.1 43891.1 43983.8 44009.0 3631.1 3644.7 3690.6 3758.7 3792.4 32746.0 32811.3 33637.5 33749.2 34388.1 4409.7 4438.4 4555.3 4587.2 4683.3 367085.0 367447.0 367725.0 367878.0 369292.0 35233.8 57282.7 57542.7 57575.4 57607.0 34763.8 36184.0 36557.3 36657.6 36669.0 14314.2 14458.0 14458.2 14469.9 14549.5 10800.6 11632.5 11748.4 11750.1 11773.1 8490.8 8527.3 8594.9 8596.7 8647.0 3118.5 3179.8 3215.4 3224.1 3243.7 947.2 975.7 1044.4 1113.9 1145.2 31717.0 32311.5 32633.2 32720.5 32763.1 1046.5 1131.0 1141.6 1191.7 1254.6 16172.4 16375.7 16421.3 16589.3 16754.5 542456.0 543077.0 551530.0 552479.0 773531.0 60563.4 61537.4 61553.4 61627.7 61870.7 1227.7 1318.9 1345.5 1362.9 1387.2 30946.4 33266.5 33342.3 33428.3 33455.7 50397.0 50720.5 50887.0 50970.5 51051.0 425381.0 428063.0 429261.0 429453.0 430808.0 29368.6 29453.3 29644.3 29873.1 29885.9 46308.8 46725.3 46972.0 47259.0 47595.0 40604.0 41146.8 41245.2 41693.4 42854.4 39865.2 40335.8 41519.2 41558.4 41641.6 39950.4 40532.6 40573.0 40775.6 40792.8 34617.0 36613.6 37387.4 37582.8 37638.0 26696.0 27399.9 27494.6 27683.3 27723.0 22:36:05 INFO - PROCESS | 2039 | 22:36:05 INFO - PROCESS | 2039 | [#2] jquery.html Cycles:180 Average:28915.01 Median:2185.40 stddev:80530.90 (3684.9%) stddev-sans-first:80728.30 22:36:05 INFO - PROCESS | 2039 | Values: 378.0 390.4 403.7 405.6 425.1 14123.3 18603.7 19576.2 19942.9 20029.8 12483.3 12677.3 12692.3 12812.5 12839.2 3980.4 5281.0 5431.8 5441.6 5443.2 5717.1 5917.4 5984.6 6070.9 6081.4 5844.9 5906.8 5956.4 6072.8 6085.4 5982.9 6032.5 6033.5 6035.5 6043.5 5727.1 5769.6 5795.2 5801.8 5808.3 14348.0 14444.5 14567.6 21200.6 23394.8 2207.4 2456.3 2950.8 2997.8 3118.0 10348.1 10351.0 10892.2 10902.9 11062.9 1918.6 1983.7 1997.4 2008.4 2044.0 83552.0 85189.0 86789.0 87324.6 91060.0 10922.8 11032.9 11163.7 11400.6 11519.5 15753.1 15785.1 15800.1 15802.7 15810.5 7756.8 7984.5 7988.6 8265.4 8281.3 7613.8 7645.2 7844.6 7869.3 7873.4 4833.2 4875.9 4902.4 4916.6 4987.8 1931.8 2006.0 2020.2 2022.1 2039.2 939.4 999.2 1003.5 1027.8 1053.0 19825.1 20051.8 20159.3 20244.0 20553.5 974.7 981.6 990.6 1012.9 1041.5 10685.4 10974.7 11119.8 11152.6 11306.7 458047.0 458062.0 497356.6 506732.0 510792.0 92315.5 93283.7 94275.5 94334.0 99690.5 990.8 1003.1 1010.3 1017.7 1019.7 16941.5 17137.3 17868.4 18086.9 18388.9 43856.3 44042.8 44439.6 44440.3 44477.3 56615.4 56713.0 56900.4 62167.1 64031.7 7149.0 8638.4 8775.6 9024.1 9095.5 9690.7 13152.2 13342.0 13865.6 14171.2 11974.4 12109.2 12166.3 12228.6 12482.8 5889.5 10900.5 10961.3 11855.4 12058.6 6648.5 8087.1 12006.5 12223.0 12602.6 8788.4 8816.5 8820.8 8886.5 9185.1 9344.6 11664.4 11853.5 12037.9 12283.3 22:36:05 INFO - PROCESS | 2039 | 22:36:05 INFO - PROCESS | 2039 | [#3] mootools.html Cycles:180 Average:5624.24 Median:5017.75 stddev:3180.30 (63.4%) stddev-sans-first:3172.94 22:36:05 INFO - PROCESS | 2039 | Values: 1342.2 1459.1 1497.4 1597.0 1745.0 8030.8 8408.0 8431.7 8625.3 8628.5 8455.5 8564.8 8565.1 8586.7 8604.4 2330.0 2354.6 2355.5 2356.1 2357.4 2323.2 2356.7 2363.0 2363.4 2368.2 2330.0 2332.6 2342.0 2375.9 2393.8 2287.1 2308.9 2311.7 2312.5 2316.4 2303.1 2310.6 2311.4 2319.0 2327.7 8428.3 8479.8 8509.7 8534.6 8544.7 4965.3 5158.2 5174.9 5175.1 5187.8 3246.8 3375.9 3397.1 3416.4 3428.3 1191.8 1197.2 1241.0 1249.2 1261.2 11703.2 11741.9 11786.4 11801.3 11805.5 4154.8 4344.8 4452.1 4458.1 4461.1 8982.6 9018.0 9023.1 9024.7 9025.0 5002.7 5032.8 5038.8 5039.4 5041.8 4076.9 4465.6 4532.9 4603.2 4735.7 3566.7 3578.5 3654.7 3655.4 3724.2 1116.1 1137.6 1138.4 1149.8 1154.8 975.7 976.9 983.0 984.3 1002.6 5825.3 5851.6 5876.0 5931.3 6084.9 481.7 489.8 490.6 492.3 496.0 4039.7 4076.4 4102.5 4115.7 4124.4 10387.5 10872.9 10879.3 10884.8 10932.7 10808.3 10841.0 10842.2 10855.3 10864.8 7540.6 7817.3 7844.3 8006.8 8009.6 5837.2 6051.3 6129.2 6154.2 6157.5 9800.4 9892.0 9897.4 9919.3 10009.9 9479.9 9811.2 9838.0 9960.7 10028.5 6788.0 6967.1 6977.2 7644.5 7808.3 7575.7 8159.8 8252.1 8375.8 8564.1 7295.5 7573.3 7751.7 7753.3 7869.2 7437.0 7453.6 7503.9 7675.7 7740.3 6936.4 7001.3 7020.5 7021.5 7033.2 4893.6 5103.8 5137.8 5150.8 5164.5 5056.6 5077.8 5104.1 5119.5 5276.2 22:36:05 INFO - PROCESS | 2039 | 22:36:05 INFO - PROCESS | 2039 | [#4] prototype.html Cycles:180 Average:4594.27 Median:5108.74 stddev:1335.12 (26.1%) stddev-sans-first:1299.99 22:36:05 INFO - PROCESS | 2039 | Values: 333.0 340.2 343.3 345.4 347.2 5285.2 5292.0 5305.5 5310.2 5347.3 4951.8 5091.3 5106.8 5109.6 5289.3 4004.4 4079.4 4088.4 4118.3 4161.0 4121.3 4150.2 4150.9 4162.9 4165.9 4075.5 4125.0 4143.1 4150.6 4155.0 3941.2 4047.8 4089.8 4100.2 4101.3 3649.7 3656.1 3665.0 3676.5 3691.9 5071.2 5097.5 5104.3 5107.8 5113.4 4614.5 4690.5 4719.7 4722.6 4732.6 5417.5 5438.6 5442.5 5444.4 5445.2 4052.8 4053.5 4055.2 4055.9 4058.3 5532.4 5540.8 5631.4 5638.6 5676.2 4131.9 4133.4 4137.1 4137.4 4138.5 4173.5 4182.0 4183.7 4195.5 4201.8 4454.9 4682.8 4687.6 4698.6 4714.9 5532.0 5535.4 5551.7 5555.9 5563.9 1409.5 1409.9 1412.5 1412.8 1414.5 857.8 906.3 915.0 924.4 926.4 4719.8 4729.8 4741.2 4778.8 4791.7 4934.9 4982.0 5011.0 5043.7 5044.5 4712.4 4713.8 4725.6 4767.7 5148.3 2940.6 2972.3 2981.6 2987.7 2987.9 5851.5 5863.6 5872.4 5880.8 5883.3 5512.9 5725.7 5744.8 5758.4 5759.3 5807.7 5818.2 5836.5 5839.4 5841.2 5372.5 5626.6 5631.4 5635.3 5644.5 5537.9 5572.0 5576.2 5581.7 5610.4 5854.2 5857.5 5861.5 5874.9 5879.7 3967.1 4029.5 4036.8 4075.0 4093.7 5614.4 5616.6 5617.5 5633.3 5635.8 5447.7 5497.4 5545.8 5556.4 5563.7 5226.7 5462.3 5464.2 5521.8 5532.1 5364.7 5386.8 5412.5 5422.9 5424.9 5257.9 5334.4 5485.8 5519.6 5528.3 5373.7 5374.8 5385.9 5406.7 5416.5 22:36:05 INFO - PROCESS | 2039 | 22:36:05 INFO - PROCESS | 2039 | [#5] yui.html Cycles:180 Average:23083.30 Median:4504.66 stddev:34525.93 (766.4%) stddev-sans-first:34582.14 22:36:06 INFO - PROCESS | 2039 | Values: 773.2 777.8 813.3 836.5 859.3 15804.4 17552.5 17687.2 17745.2 17764.9 15509.6 15730.2 15750.4 15761.8 15761.9 657.6 789.8 789.9 812.5 817.4 807.1 810.4 812.6 813.9 814.1 873.5 874.1 876.2 878.0 878.2 697.4 842.1 866.6 867.6 868.5 625.5 632.5 634.1 634.3 634.3 16161.9 16206.8 16214.7 16218.2 16223.3 15028.6 15143.9 15147.5 15296.3 15319.9 13402.8 13549.9 13645.2 13834.3 13980.4 4377.1 4449.6 4482.5 4526.8 4534.0 87345.0 89316.0 89762.1 91037.5 91130.0 12178.1 12217.1 12260.4 12262.0 12317.3 22576.4 22585.7 22590.0 22710.2 22721.7 8717.4 8725.9 8903.7 9115.0 9196.8 4940.7 4992.3 5031.0 5103.3 5190.4 3345.5 3471.3 3475.9 3483.1 3491.6 597.9 598.4 615.0 618.4 627.6 603.2 628.4 661.7 665.7 667.2 9634.0 9652.8 9895.0 9976.3 10080.1 638.3 658.7 659.8 664.3 728.3 4780.8 4872.7 4924.0 4928.0 4944.8 95034.5 135431.0 136101.0 137267.0 138920.5 113193.0 113398.3 115840.4 116918.0 119515.0 99085.0 99644.0 101477.0 102627.0 105037.5 8799.8 9513.3 9517.8 9671.2 9681.8 55598.7 55615.7 55922.4 56871.0 57258.4 72262.6 82802.0 83409.6 84101.0 84304.6 12435.3 12784.8 12961.0 13024.9 13113.9 13608.0 13619.9 13641.8 13840.7 13879.3 12135.5 12139.3 12254.3 12442.2 12494.0 14193.9 14334.6 14350.7 14531.4 14825.3 13696.9 14395.3 14437.6 14462.3 14836.5 11803.9 12094.3 12260.2 13435.5 13460.5 11448.3 11661.8 11768.3 11897.8 11909.7 22:36:06 INFO - PROCESS | 2039 | -------- Summary: end -------- 22:36:06 INFO - PROCESS | 2039 | 22:36:06 INFO - TEST-INFO | 2039: exit 0 22:36:06 INFO - TEST-OK | dromaeo_css | took 1115268ms 22:36:06 INFO - TEST-START | kraken 22:36:06 INFO - operating with platform_type : linux_ 22:36:06 INFO - Initialising browser for kraken test... 22:36:06 INFO - TEST-INFO | started process 2340 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD2ZIeS/profile http://localhost:37420/getInfo.html) 22:36:10 INFO - PROCESS | 2340 | __metrics Screen width/height:1600/1200 22:36:10 INFO - PROCESS | 2340 | colorDepth:24 22:36:10 INFO - PROCESS | 2340 | Browser inner width/height: 1024/697 22:36:10 INFO - PROCESS | 2340 | __metrics 22:36:11 INFO - PROCESS | 2340 | 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" 22:36:11 INFO - PROCESS | 2340 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:36:12 INFO - PROCESS | 2340 | console.error: PushService: 22:36:12 INFO - PROCESS | 2340 | stateChangeProcessEnqueue: Error transitioning state 22:36:12 INFO - PROCESS | 2340 | UnknownError 22:36:12 INFO - TEST-INFO | 2340: exit 0 22:36:12 INFO - Browser initialized. 22:36:12 INFO - Running cycle 1/1 for kraken test... 22:36:12 INFO - TEST-INFO | started process 2493 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD2ZIeS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:36:24 INFO - PROCESS | 2493 | RSS: Main: 154939392 22:36:24 INFO - PROCESS | 2493 | 22:36:27 INFO - PROCESS | 2493 | Cycle 1(1): loaded http://localhost:37420/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37420/tests/kraken/driver.html?testName=audio-beat-detection) 22:36:27 INFO - PROCESS | 2493 | RSS: Main: 203350016 22:36:27 INFO - PROCESS | 2493 | 22:36:30 INFO - PROCESS | 2493 | Cycle 1(1): loaded http://localhost:37420/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37420/tests/kraken/driver.html?testName=audio-dft) 22:36:31 INFO - PROCESS | 2493 | RSS: Main: 190636032 22:36:31 INFO - PROCESS | 2493 | 22:36:34 INFO - PROCESS | 2493 | Cycle 1(1): loaded http://localhost:37420/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37420/tests/kraken/driver.html?testName=audio-fft) 22:36:34 INFO - PROCESS | 2493 | RSS: Main: 275681280 22:36:34 INFO - PROCESS | 2493 | 22:36:36 INFO - PROCESS | 2493 | Cycle 1(1): loaded http://localhost:37420/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37420/tests/kraken/driver.html?testName=audio-oscillator) 22:36:37 INFO - PROCESS | 2493 | RSS: Main: 185737216 22:36:37 INFO - PROCESS | 2493 | 22:36:39 INFO - PROCESS | 2493 | Cycle 1(1): loaded http://localhost:37420/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37420/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:36:40 INFO - PROCESS | 2493 | RSS: Main: 189681664 22:36:40 INFO - PROCESS | 2493 | 22:36:43 INFO - PROCESS | 2493 | Cycle 1(1): loaded http://localhost:37420/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37420/tests/kraken/driver.html?testName=imaging-darkroom) 22:36:43 INFO - PROCESS | 2493 | RSS: Main: 225533952 22:36:43 INFO - PROCESS | 2493 | 22:36:47 INFO - PROCESS | 2493 | Cycle 1(1): loaded http://localhost:37420/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37420/tests/kraken/driver.html?testName=imaging-desaturate) 22:36:47 INFO - PROCESS | 2493 | RSS: Main: 225988608 22:36:47 INFO - PROCESS | 2493 | 22:36:50 INFO - PROCESS | 2493 | Cycle 1(1): loaded http://localhost:37420/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37420/tests/kraken/driver.html?testName=json-parse-financial) 22:36:51 INFO - PROCESS | 2493 | RSS: Main: 226201600 22:36:51 INFO - PROCESS | 2493 | 22:36:52 INFO - PROCESS | 2493 | Cycle 1(1): loaded http://localhost:37420/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37420/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:36:53 INFO - PROCESS | 2493 | RSS: Main: 188436480 22:36:53 INFO - PROCESS | 2493 | 22:36:55 INFO - PROCESS | 2493 | Cycle 1(1): loaded http://localhost:37420/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37420/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:36:55 INFO - PROCESS | 2493 | RSS: Main: 194834432 22:36:55 INFO - PROCESS | 2493 | 22:36:57 INFO - PROCESS | 2493 | Cycle 1(1): loaded http://localhost:37420/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37420/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:36:58 INFO - PROCESS | 2493 | RSS: Main: 192495616 22:36:58 INFO - PROCESS | 2493 | 22:37:01 INFO - PROCESS | 2493 | Cycle 1(1): loaded http://localhost:37420/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37420/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:37:01 INFO - PROCESS | 2493 | RSS: Main: 187940864 22:37:01 INFO - PROCESS | 2493 | 22:37:04 INFO - PROCESS | 2493 | Cycle 1(1): loaded http://localhost:37420/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37420/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:37:05 INFO - PROCESS | 2493 | RSS: Main: 191782912 22:37:05 INFO - PROCESS | 2493 | 22:37:06 INFO - PROCESS | 2493 | Cycle 1(1): loaded http://localhost:37420/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37420/tests/kraken/driver.html?testName=ai-astar) 22:37:06 INFO - PROCESS | 2493 | RSS: Main: 242319360 22:37:06 INFO - PROCESS | 2493 | 22:37:06 INFO - PROCESS | 2493 | __start_tp_report 22:37:06 INFO - PROCESS | 2493 | _x_x_mozilla_page_load 22:37:06 INFO - PROCESS | 2493 | _x_x_mozilla_page_load_details 22:37:06 INFO - PROCESS | 2493 | |i|pagename|runs| 22:37:06 INFO - PROCESS | 2493 | |0;ai-astar;106;114;112;113;110;114;112;112;113;112 22:37:06 INFO - PROCESS | 2493 | |1;audio-beat-detection;152;123;123;197;119;118;144;116;152;118 22:37:06 INFO - PROCESS | 2493 | |2;audio-dft;161;161;161;160;160;164;160;162;161;160 22:37:06 INFO - PROCESS | 2493 | |3;audio-fft;76;74;76;105;74;76;73;74;99;76 22:37:06 INFO - PROCESS | 2493 | |4;audio-oscillator;84;84;122;84;85;85;121;84;85;137 22:37:06 INFO - PROCESS | 2493 | |5;imaging-gaussian-blur;117;117;116;117;117;118;116;117;117;117 22:37:06 INFO - PROCESS | 2493 | |6;imaging-darkroom;147;145;146;145;147;146;147;147;147;146 22:37:06 INFO - PROCESS | 2493 | |7;imaging-desaturate;94;95;95;95;94;95;95;95;95;95 22:37:06 INFO - PROCESS | 2493 | |8;json-parse-financial;52;50;52;51;50;52;51;51;52;50 22:37:06 INFO - PROCESS | 2493 | |9;json-stringify-tinderbox;61;61;62;62;62;62;62;66;61;63 22:37:06 INFO - PROCESS | 2493 | |10;stanford-crypto-aes;79;86;78;83;78;78;78;78;78;79 22:37:06 INFO - PROCESS | 2493 | |11;stanford-crypto-ccm;127;144;120;125;136;136;130;134;140;125 22:37:06 INFO - PROCESS | 2493 | |12;stanford-crypto-pbkdf2;159;161;164;171;165;164;161;162;160;164 22:37:06 INFO - PROCESS | 2493 | |13;stanford-crypto-sha256-iterative;64;63;64;63;64;64;64;63;64;61 22:37:06 INFO - PROCESS | 2493 | __end_tp_report 22:37:06 INFO - PROCESS | 2493 | __start_cc_report 22:37:06 INFO - PROCESS | 2493 | _x_x_mozilla_cycle_collect,1656 22:37:06 INFO - PROCESS | 2493 | __end_cc_report 22:37:06 INFO - PROCESS | 2493 | __startTimestamp1471412226966__endTimestamp 22:37:06 INFO - PROCESS | 2493 | 22:37:06 INFO - PROCESS | 2493 | ------- Summary: start ------- 22:37:06 INFO - PROCESS | 2493 | Number of tests: 14 22:37:06 INFO - PROCESS | 2493 | 22:37:06 INFO - PROCESS | 2493 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.50 stddev:2.35 (2.1%) stddev-sans-first:1.24 22:37:06 INFO - PROCESS | 2493 | Values: 106.0 114.0 112.0 113.0 110.0 114.0 112.0 112.0 113.0 112.0 22:37:06 INFO - PROCESS | 2493 | 22:37:06 INFO - PROCESS | 2493 | [#1] audio-beat-detection Cycles:10 Average:136.20 Median:133.50 stddev:25.76 (19.3%) stddev-sans-first:26.68 22:37:06 INFO - PROCESS | 2493 | Values: 152.0 123.0 123.0 197.0 119.0 118.0 144.0 116.0 152.0 118.0 22:37:06 INFO - PROCESS | 2493 | 22:37:06 INFO - PROCESS | 2493 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.25 (0.8%) stddev-sans-first:1.32 22:37:06 INFO - PROCESS | 2493 | Values: 161.0 161.0 161.0 160.0 160.0 164.0 160.0 162.0 161.0 160.0 22:37:06 INFO - PROCESS | 2493 | 22:37:06 INFO - PROCESS | 2493 | [#3] audio-fft Cycles:10 Average:80.30 Median:76.00 stddev:11.58 (15.2%) stddev-sans-first:12.17 22:37:06 INFO - PROCESS | 2493 | Values: 76.0 74.0 76.0 105.0 74.0 76.0 73.0 74.0 99.0 76.0 22:37:06 INFO - PROCESS | 2493 | 22:37:06 INFO - PROCESS | 2493 | [#4] audio-oscillator Cycles:10 Average:97.10 Median:84.00 stddev:20.84 (24.8%) stddev-sans-first:21.56 22:37:06 INFO - PROCESS | 2493 | Values: 84.0 84.0 122.0 84.0 85.0 85.0 121.0 84.0 85.0 137.0 22:37:06 INFO - PROCESS | 2493 | 22:37:06 INFO - PROCESS | 2493 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 22:37:06 INFO - PROCESS | 2493 | Values: 117.0 117.0 116.0 117.0 117.0 118.0 116.0 117.0 117.0 117.0 22:37:06 INFO - PROCESS | 2493 | 22:37:06 INFO - PROCESS | 2493 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 22:37:06 INFO - PROCESS | 2493 | Values: 147.0 145.0 146.0 145.0 147.0 146.0 147.0 147.0 147.0 146.0 22:37:06 INFO - PROCESS | 2493 | 22:37:06 INFO - PROCESS | 2493 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 22:37:06 INFO - PROCESS | 2493 | Values: 94.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 22:37:06 INFO - PROCESS | 2493 | 22:37:06 INFO - PROCESS | 2493 | [#8] json-parse-financial Cycles:10 Average:51.10 Median:51.50 stddev:0.88 (1.7%) stddev-sans-first:0.87 22:37:06 INFO - PROCESS | 2493 | Values: 52.0 50.0 52.0 51.0 50.0 52.0 51.0 51.0 52.0 50.0 22:37:06 INFO - PROCESS | 2493 | 22:37:06 INFO - PROCESS | 2493 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:1.48 (2.4%) stddev-sans-first:1.50 22:37:06 INFO - PROCESS | 2493 | Values: 61.0 61.0 62.0 62.0 62.0 62.0 62.0 66.0 61.0 63.0 22:37:06 INFO - PROCESS | 2493 | 22:37:06 INFO - PROCESS | 2493 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:78.50 stddev:2.76 (3.5%) stddev-sans-first:2.92 22:37:06 INFO - PROCESS | 2493 | Values: 79.0 86.0 78.0 83.0 78.0 78.0 78.0 78.0 78.0 79.0 22:37:06 INFO - PROCESS | 2493 | 22:37:06 INFO - PROCESS | 2493 | [#11] stanford-crypto-ccm Cycles:10 Average:131.70 Median:135.00 stddev:7.56 (5.6%) stddev-sans-first:7.82 22:37:06 INFO - PROCESS | 2493 | Values: 127.0 144.0 120.0 125.0 136.0 136.0 130.0 134.0 140.0 125.0 22:37:06 INFO - PROCESS | 2493 | 22:37:06 INFO - PROCESS | 2493 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.10 Median:164.00 stddev:3.41 (2.1%) stddev-sans-first:3.28 22:37:06 INFO - PROCESS | 2493 | Values: 159.0 161.0 164.0 171.0 165.0 164.0 161.0 162.0 160.0 164.0 22:37:06 INFO - PROCESS | 2493 | 22:37:06 INFO - PROCESS | 2493 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:64.00 stddev:0.97 (1.5%) stddev-sans-first:1.00 22:37:06 INFO - PROCESS | 2493 | Values: 64.0 63.0 64.0 63.0 64.0 64.0 64.0 63.0 64.0 61.0 22:37:06 INFO - PROCESS | 2493 | -------- Summary: end -------- 22:37:06 INFO - PROCESS | 2493 | 22:37:07 INFO - TEST-INFO | 2493: exit 0 22:37:08 INFO - TEST-OK | kraken | took 61222ms 22:37:08 INFO - SUITE-END | took 1176s 22:37:08 INFO - Completed test suite (00:19:36) 22:37:08 INFO - javascript benchmark 22:37:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2985.8208507489553, 2994.8352840593757, 3009.548567714843, 3025.6974302569747, 3028.394321135772, 5100.0, 5163.870903227421, 5173.767180476878, 5289.338832645914, 5322.0686379883555, 5165.8450246492575, 5174.223866420039, 5206.479352064792, 5221.686698798075, 5251.527362537371, 4718.9292160617615, 4751.833685820997, 4878.390201224847, 4920.778564964585, 4950.702957822542, 4870.780814863322, 4913.066517361708, 4919.316623020327, 4919.458859525449, 4939.333190019337, 4620.260758278693, 4834.492378300298, 4914.70511769295, 4915.3855768029, 5004.049230646184, 4751.524847515256, 4760.143174228638, 4761.928571071437, 4820.566149046603, 4886.706797592155, 4764.356811830393, 4774.212254977924, 4798.808047678089, 4822.469528351879, 4842.467328593852, 5003.874903127415, 5180.792768289264, 5230.398504172031, 5234.110201265794, 5252.159654455307, 5666.5183459406, 5672.319321681383, 5690.772369105231, 5714.257146570961, 5726.742296596663, 5699.515541178963, 5723.284589426322, 5738.540916726652, 5747.252857128547, 5748.741306641211, 5012.749362531896, 5217.713025783581, 5268.0, 5280.9207861882105, 5321.0, 5828.88342233153, 5829.358770535237, 5831.0, 5837.970810146007, 5839.503642190376, 5585.218069470277, 5607.859803504945, 5614.466625670555, 5619.100943848965, 5622.971885140548, 5330.92003619946, 5506.779728810803, 5542.501174894279, 5542.5565954723525, 5685.147227915763, 5548.112302031736, 5556.138798486241, 5561.193626924073, 5562.499375056183, 5601.271834661468, 5510.91733623996, 5561.77752889888, 5564.527015203753, 5564.860878478071, 5569.053260945649, 4194.748315101104, 4249.660027197817, 4278.208531421635, 4307.504636966789, 4348.804303806336, 3825.5026846509777, 3833.0800607853917, 3838.5201849768778, 3867.361885288896, 3870.7871067091583, 5251.159814429673, 5288.81489147878, 5295.947040529622, 5327.094393953037, 5345.625806193607, 5364.91952620711, 5542.2795036644975, 5592.944070559242, 5593.049181639131, 5616.747246373923, 5307.708076055854, 5328.254044433782, 5329.8934021319355, 5335.466453354711, 5358.5981051421295, 4760.357351757538, 4767.427908650915, 4769.475357710649, 4775.617950563947, 4808.110499557593, 5595.580331475075, 5741.540676745851, 5785.595008349459, 5817.592768506164, 5860.970695146497, 5646.322441307069, 5646.774129034792, 5649.971750141223, 5650.0, 5678.943210567842, 5817.127430885232, 5822.184894114912, 5822.970885145547, 5824.155497452761, 5825.2135961644635, 5271.894562108813, 5422.267993820784, 5439.374471935778, 5448.673079615236, 5531.834044978657, 5507.118860982224, 5559.305086864142, 5562.443755624405, 5565.248691426606, 5600.159976003632, 5449.836504904859, 5455.481729235717, 5455.672659640434, 5458.61789674719, 5494.890102198014, 5272.76272567743, 5385.488378604026, 5441.102218134122, 5486.533644640251, 5504.256925315031, 5487.176923461513, 5488.588355873246, 5494.203340515683, 5499.175123731472, 5535.6955367455175, 5586.804461843979, 5590.748416321357, 5632.5212356950115, 5643.294588176478, 5650.26546548946, 5101.438841727333, 5130.333056702605, 5138.486151384832, 5369.3556773187465, 5459.099248624091], "value": 5174.501478076879, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.2204202284892, 581.3053401185583, 594.251243433274, 599.2000679093413, 616.4020899727263, 32782.34435311292, 44393.55606443935, 45403.0, 45556.31665525016, 45567.77216113923, 46262.306065409044, 46734.0, 46850.76574617122, 46885.29672054922, 46895.765521172434, 8140.308073813733, 8898.777530561756, 9049.638014479413, 9049.819003619923, 10667.83998240027, 10546.630867919625, 10953.726156846064, 10954.287971281881, 10954.507047182857, 10971.83542246867, 11033.282836615634, 11068.889311106906, 11084.279521831095, 11087.72280692985, 11091.944540277287, 10965.56137754489, 10999.890001100046, 11014.06380457662, 11028.0, 11036.779264414667, 10717.196210284259, 10787.784244315148, 10793.244472886901, 10796.190285728524, 10812.513436895359, 43549.78225108886, 43780.12439751219, 43891.12217755627, 43983.78008109939, 44009.0, 3631.1466805300734, 3644.7266455015715, 3690.560681334282, 3758.68051215647, 3792.374258247386, 32746.0, 32811.343773124645, 33637.486313115965, 33749.156271093176, 34388.14029649254, 4409.669274804402, 4438.4451943507065, 4555.263721859781, 4587.151376995266, 4683.344331793552, 367085.0, 367447.0, 367725.0, 367878.0, 369292.0, 35233.82383088068, 57282.713586432634, 57542.7122864383, 57575.424245757844, 57607.0, 34763.826180868935, 36184.0, 36557.26885462329, 36657.63342366542, 36669.0, 14314.212718300594, 14458.0, 14458.204798736171, 14469.855301447062, 14549.490767823076, 10800.567977280978, 11632.476538555786, 11748.412579370997, 11750.118741094451, 11773.117016223647, 8490.787730306669, 8527.317814574819, 8594.87107693385, 8596.742097737078, 8647.0, 3118.469860123784, 3179.761517886168, 3215.3569286142865, 3224.0972527692284, 3243.659415761358, 947.209080417845, 975.687779910436, 1044.368157264859, 1113.8663360396642, 1145.1640302579165, 31717.0, 32311.51532727011, 32633.18417039593, 32720.509192362133, 32763.06863478138, 1046.4976811130548, 1130.9943450282697, 1141.646089712192, 1191.6722901202065, 1254.617341710787, 16172.433964811411, 16375.672486550202, 16421.343146274256, 16589.25812789664, 16754.497365079067, 542456.0, 543077.0, 551530.0, 552479.0, 773531.0, 60563.39436605578, 61537.38462615406, 61553.38446615566, 61627.69186154041, 61870.69064654648, 1227.7421741434398, 1318.8878945289566, 1345.488714288564, 1362.9386677599532, 1387.188494730594, 30946.381072377975, 33266.501002485464, 33342.33315333631, 33428.331433371684, 33455.66544334526, 50397.0, 50720.49279507158, 50887.0, 50970.49029509658, 51051.0, 425381.0, 428063.0, 429261.0, 429453.0, 430808.0, 29368.559471607514, 29453.263668407602, 29644.256918892872, 29873.10380688583, 29885.850570747007, 46308.7684561575, 46725.2991205139, 46972.0, 47259.0, 47595.04809903852, 40604.0, 41146.794266028475, 41245.1750964973, 41693.37459938164, 42854.35718464163, 39865.202695945336, 40335.79832100821, 41519.169616606894, 41558.37662435006, 41641.58358416498, 39950.400743988284, 40532.59467405406, 40573.0, 40775.59224407718, 40792.79603601963, 34617.0, 36613.63386366102, 37387.43918841165, 37582.8120859394, 37638.0, 26696.0, 27399.86300068487, 27494.587581186697, 27683.307917302227, 27723.0], "value": 19481.081084665882, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.9678727308179, 390.44166841416796, 403.7173978215249, 405.61061381074177, 425.12636531926876, 14123.293835308232, 18603.720944185832, 19576.21695132193, 19942.900285498552, 20029.799702002994, 12483.31341776202, 12677.302748348837, 12692.30192339421, 12812.487500499969, 12839.16545424549, 3980.363141897297, 5281.023010743015, 5431.809886653968, 5441.619086663935, 5443.237946687447, 5717.142428635696, 5917.408259174092, 5984.551158663117, 6070.908936365958, 6081.391860813927, 5844.912326315109, 5906.793262235823, 5956.37458066901, 6072.848178795522, 6085.361037091108, 5982.8803423931495, 6032.547558933097, 6033.456988871001, 6035.547333949971, 6043.4560889519935, 5727.140928860663, 5769.567282453832, 5795.246617939683, 5801.829846248991, 5808.273965754281, 14348.0, 14444.494442694455, 14567.635809104751, 21200.575988480145, 23394.7660523396, 2207.404000919759, 2456.287676573809, 2950.837703926283, 2997.7901546891726, 3118.0200572636313, 10348.120409765179, 10351.0, 10892.237543371966, 10902.945485272523, 11062.944685276603, 1918.5779128591687, 1983.7123617075588, 1997.4107638246753, 2008.4476768888526, 2044.0290861840656, 83551.99999999939, 85189.0, 86789.0, 87324.56337718334, 91060.0, 10922.836157457645, 11032.889671103347, 11163.665090047312, 11400.600978965696, 11519.48162332697, 15753.13357765311, 15785.131817749905, 15800.130992795277, 15802.68394632124, 15810.525684229491, 7756.844863102707, 7984.481008734414, 7988.640511177011, 8265.421420500506, 8281.29608983243, 7613.771586852293, 7645.19725428833, 7844.568548729874, 7869.3311068559815, 7873.409494287951, 4833.154198015333, 4875.853724388274, 4902.3872015998, 4916.5575098240615, 4987.750612469362, 1931.806819318057, 2005.9799402006086, 2020.1818263603263, 2022.1203776357038, 2039.2149022626395, 939.3800091939424, 999.1806718490768, 1003.4882210072915, 1027.8304079826744, 1052.9631462898915, 19825.10787014588, 20051.799482005285, 20159.294424695065, 20244.0, 20553.48616284605, 974.6832279509188, 981.6318880419842, 990.6334656177261, 1012.8987101289812, 1041.520900385831, 10685.412302323446, 10974.725631859268, 11119.843219959655, 11152.553897843994, 11306.660800176009, 458047.0, 458062.0, 497356.56608585076, 506732.0, 510792.0, 92315.53842230747, 93283.66790830148, 94275.52862235782, 94334.0, 99690.5015474918, 990.7523119220195, 1003.1222680154865, 1010.3079390617597, 1017.6896046705677, 1019.6889948565758, 16941.491755247363, 17137.314507420062, 17868.374606888698, 18086.90956545209, 18388.908055459637, 43856.34215486707, 44042.779786100866, 44439.55560444354, 44440.33339499975, 44477.33284000807, 56615.43384566101, 56713.0, 56900.430995689516, 62167.06749398853, 64031.6798416005, 7148.999140120283, 8638.438501497383, 8775.605097770744, 9024.142706442877, 9095.49974751395, 9690.660826871026, 13152.21086734799, 13342.0, 13865.584032479042, 14171.220582868042, 11974.401279936143, 12109.212901161396, 12166.330851803235, 12228.571999979958, 12482.812757808822, 5889.499392551681, 10900.528428662346, 10961.287516311415, 11855.407229638657, 12058.638240852788, 6648.5346025777735, 8087.1104178539135, 12006.519739210684, 12223.0, 12602.621921342374, 8788.384813063025, 8816.51509167002, 8820.766032304658, 8886.5112418815, 9185.127412895765, 9344.626214951326, 11664.416779161178, 11853.466594003117, 12037.939810300892, 12283.263004219776], "value": 9149.265962918184, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1342.2215564377202, 1459.0589070049818, 1497.4384605772834, 1596.9680606387872, 1745.048948323163, 8030.839383212332, 8407.957960210199, 8431.66273349066, 8625.309975201984, 8628.48229106254, 8455.53494557799, 8564.828703425943, 8565.100664430238, 8586.742397728063, 8604.354673399488, 2330.0, 2354.6468029795583, 2355.49356888269, 2356.0575769692173, 2357.3988632898586, 2323.186884590397, 2356.6818479505305, 2362.9721071334025, 2363.444590521226, 2368.2066507719846, 2329.988350058256, 2332.591796435617, 2341.9648705269433, 2375.9168429104984, 2393.8324317297797, 2287.0737351372723, 2308.9307320780404, 2311.6879221305076, 2312.4796920692793, 2316.4324740438615, 2303.1133013789645, 2310.6418505131733, 2311.3643747969277, 2319.0, 2327.685762422085, 8428.283595894356, 8479.788005299855, 8509.702160424355, 8534.61594228255, 8544.74365769028, 4965.280034395028, 5158.200478925773, 5174.922376164361, 5175.094358487249, 5187.766550505236, 3246.821424821634, 3375.864965401381, 3397.1167496450853, 3416.41136871356, 3428.297199074184, 1191.7676053169635, 1197.1918954705625, 1240.9937950310282, 1249.181785930217, 1261.2369516442604, 11703.239289446245, 11741.94129029358, 11786.35175065371, 11801.29192248468, 11805.468753906094, 4154.833806647761, 4344.782760861945, 4452.109578084396, 4458.08609235106, 4461.13007963444, 8982.640694372283, 9017.954910225539, 9023.097690230925, 9024.684136055206, 9024.954875225712, 5002.699838009731, 5032.79868805251, 5038.823641172541, 5039.44566097729, 5041.773120209599, 4076.898077548026, 4465.620422264079, 4532.909341813145, 4603.17142914272, 4735.692180008288, 3566.7324950628285, 3578.4632305154437, 3654.7258955577904, 3655.4334078217917, 3724.1992971510713, 1116.0792346314324, 1137.590467431724, 1138.3511398502774, 1149.7872893514727, 1154.7979103656994, 975.7365511312048, 976.8534719792088, 982.9973427104313, 984.3355734878928, 1002.5688953749811, 5825.271841019872, 5851.590388672752, 5876.0, 5931.288245410578, 6084.8783024340155, 481.6604293972741, 489.8040783686554, 490.5815270339113, 492.33534728116757, 495.97520123993655, 4039.6768258539832, 4076.449679293317, 4102.466679331727, 4115.670746340285, 4124.443200167999, 10387.480625968672, 10872.891271087346, 10879.292845964987, 10884.782304353868, 10932.726681833017, 10808.297460665031, 10841.0, 10842.241043127064, 10855.294405863593, 10864.837027444595, 7540.622968851536, 7817.335526480199, 7844.294013538694, 8006.759797206209, 8009.559474228973, 5837.153612726216, 6051.273847138372, 6129.203203583684, 6154.215277569455, 6157.476614487639, 9800.411975281506, 9892.0, 9897.35667181631, 9919.305648604528, 10009.899901001188, 9479.857802132836, 9811.215102791903, 9837.950810245902, 9960.651377201762, 10028.548715307683, 6788.049673045679, 6967.09427774386, 6977.197622273504, 7644.541327520366, 7808.258215469521, 7575.659095340613, 8159.79600509992, 8252.133525979685, 8375.790605234917, 8564.143585641386, 7295.489315747846, 7573.2805383488485, 7751.689932402866, 7753.340966017726, 7869.173736757787, 7437.0, 7453.590052546945, 7503.88744168827, 7675.731349402744, 7740.26467485588, 6936.375726184668, 7001.334873187039, 7020.473464490286, 7021.508494405342, 7033.156021277479, 4893.6085113191575, 5103.8468845934685, 5137.845864623918, 5150.841060761299, 5164.483551644806, 5056.57019153376, 5077.7715002824225, 5104.132297509358, 5119.539241468286, 5276.15581506957], "value": 4460.481783122651, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.95192822381443, 340.1920438957476, 343.28939096071133, 345.42314335060445, 347.1737265308565, 5285.207218917164, 5292.036459582637, 5305.495977882099, 5310.15037593985, 5347.331583552056, 4951.801927922878, 5091.261767043777, 5106.77019534121, 5109.642325037249, 5289.259503669489, 4004.439378487014, 4079.4288799568158, 4088.3867419887106, 4118.341065429532, 4160.958390416087, 4121.340585506319, 4150.21935303346, 4150.937735933963, 4162.937555936664, 4165.916681666365, 4075.5379020096784, 4124.97937510312, 4143.129942712034, 4150.584941505856, 4155.0, 3941.152652179781, 4047.7571345719352, 4089.7750623715683, 4100.2414553307735, 4101.2979613460375, 3649.6532829381167, 3656.1042544576485, 3665.0, 3676.5036720042986, 3691.8523259069607, 5071.2139618359215, 5097.4962386096195, 5104.336436263299, 5107.846764597068, 5113.386393632788, 4614.515475875052, 4690.530946905316, 4719.693219940693, 4722.574968252839, 4732.621390288768, 5417.51242388187, 5438.640339915021, 5442.455754424526, 5444.428335024805, 5445.1832225166145, 4052.8176232069627, 4053.513578370585, 4055.2092341993325, 4055.9391609125887, 4058.3303754880408, 5532.3914369419335, 5540.750666220029, 5631.352394474647, 5638.577106716972, 5676.211993222122, 4131.855385061508, 4133.379993001074, 4137.089840235143, 4137.379393091001, 4138.461999939988, 4173.52004519478, 4182.0, 4183.686223533247, 4195.496540415109, 4201.789910504463, 4454.910901781946, 4682.789274482589, 4687.554682305175, 4698.624110071254, 4714.88212794676, 5532.0, 5535.363433205152, 5551.666899986014, 5555.8888822223325, 5563.916541251884, 1409.4503143773936, 1409.9154050756988, 1412.4844431782326, 1412.837523684769, 1414.5402744108, 857.7769779857282, 906.3429013964823, 914.9542522873829, 924.3806649544821, 926.4256161179977, 4719.772859056601, 4729.834455794031, 4741.217699079613, 4778.753985626749, 4791.6645834791925, 4934.925976110361, 4981.975090124526, 5010.972750586121, 5043.663429191267, 5044.511868998581, 4712.410948631421, 4713.78787954536, 4725.621950243973, 4767.713937163781, 5148.330717006766, 2940.6471223453323, 2972.316367235548, 2981.5527670849547, 2987.746041586446, 2987.850607469618, 5851.473367396955, 5863.560232982458, 5872.354041055481, 5880.8235752927485, 5883.2935250791725, 5512.889742205133, 5725.685087320154, 5744.788256521269, 5758.395368486249, 5759.2512973313205, 5807.738651760596, 5818.214541036906, 5836.533077353802, 5839.416058394127, 5841.211436456109, 5372.5433338166695, 5626.606137570331, 5631.4368563145, 5635.295588051494, 5644.548436125182, 5537.889242215214, 5571.9721401392735, 5576.247206627054, 5581.693006884498, 5610.410906854721, 5854.209681693087, 5857.47282744555, 5861.472467477947, 5874.911876321773, 5879.7060146993335, 3967.1272320089533, 4029.4761680981283, 4036.7981600919247, 4075.0, 4093.713440059167, 5614.354349249726, 5616.578756593353, 5617.539439745614, 5633.295838020247, 5635.830925072254, 5447.727613619224, 5497.422770609029, 5545.7781688732, 5556.361018482765, 5563.749631266522, 5226.660267082628, 5462.317210348707, 5464.207689885024, 5521.779128834802, 5532.1425179097305, 5364.678119312697, 5386.784528618811, 5412.512873841373, 5422.945770542244, 5424.945750542444, 5257.89484210306, 5334.413214546319, 5485.807996720096, 5519.558435325244, 5528.253685752372, 5373.704446255493, 5374.811881584282, 5385.892282154413, 5406.675599464044, 5416.485433883775], "value": 4171.621555826724, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [773.2267732267733, 777.8249893773898, 813.3290035720528, 836.5482639374738, 859.2996707683237, 15804.367825286989, 17552.473425797216, 17687.204075816586, 17745.20146593403, 17764.911175444136, 15509.612259693513, 15730.213489325517, 15750.369985200607, 15761.842381576182, 15761.921190394032, 657.6054367379581, 789.8420315936806, 789.9052113746344, 812.5490352854164, 817.3992115794886, 807.1081454992237, 810.3517186251005, 812.6464987730357, 813.8575749243888, 814.0882211922625, 873.5239294584435, 874.1258741258741, 876.1851478125341, 877.9824403511958, 878.1964502480223, 697.4072038767058, 842.0653075086649, 866.5927014303298, 867.6225841758824, 868.4832524647825, 625.4652272307158, 632.4687262699355, 634.0679201573679, 634.3402861024529, 634.346622978333, 16161.919190403973, 16206.837931620768, 16214.675706485805, 16218.189090545544, 16223.26995285215, 15028.624284392869, 15143.924280378638, 15147.469838555708, 15296.311665974947, 15319.923400382926, 13402.798958015637, 13549.932250338783, 13645.249511276876, 13834.308284585832, 13980.370883310276, 4377.124575084996, 4449.599536041739, 4482.5069242383315, 4526.818927242939, 4533.954660453419, 87345.0, 89316.0, 89762.10237897602, 91037.54481227617, 91130.0, 12178.147529672839, 12217.144799864102, 12260.38698065111, 12262.0, 12317.322547259808, 22576.435589110402, 22585.661215081785, 22590.0, 22710.205142819923, 22721.659175112385, 8717.433366831136, 8725.869111963326, 8903.688370906988, 9115.0, 9196.770080748034, 4940.7035577865445, 4992.345467920541, 5030.974845125824, 5103.336566246364, 5190.429052804188, 3345.531625572422, 3471.3057388522398, 3475.94786078209, 3483.059573915029, 3491.5635545556806, 597.8953683105439, 598.4165438697236, 614.9538784591174, 618.4434009391583, 627.645380360095, 603.1585937617, 628.4281304013326, 661.7022339947043, 665.6704931059156, 667.2393471442559, 9633.951830240803, 9652.75868103303, 9894.950525247328, 9976.251781116445, 10080.14318782897, 638.2532437048571, 658.6706646676662, 659.8185498987817, 664.3489380407228, 728.3153835394712, 4780.808767649255, 4872.731999740048, 4923.950760492421, 4927.975360123177, 4944.826931057468, 95034.52482737681, 135431.0, 136101.0, 137267.0, 138920.52698682612, 113193.0, 113398.3300834955, 115840.42079789547, 116918.0, 119515.0, 99085.0, 99644.0, 101476.98523014823, 102627.0, 105037.47481262544, 8799.780005499913, 9513.286503512403, 9517.821159625604, 9671.17794987434, 9681.806363872824, 55598.72200639133, 55615.72192139013, 55922.44077559172, 56871.0, 57258.42741572531, 72262.63868680834, 82802.0, 83409.58295208485, 84101.0, 84304.57847710722, 12435.253884766942, 12784.808227876776, 12961.0, 13024.869751302365, 13113.934430327787, 13608.0, 13619.931900340434, 13641.795373069213, 13840.653983650489, 13879.306034698428, 12135.514579417078, 12139.332336721565, 12254.264744115382, 12442.191257568229, 12494.0, 14193.858061419667, 14334.569962901129, 14350.712985740436, 14531.418743250151, 14825.33286002111, 13696.86303136956, 14395.272567291991, 14437.566872993826, 14462.27688615586, 14836.480723174636, 11803.861991764406, 12094.334811585448, 12260.203086799329, 13435.529756458476, 13460.461581536629, 11448.313101213955, 11661.76676466483, 11768.293902365544, 11897.762044759229, 11909.702257443632], "value": 7901.409671013984, "unit": "score"}], "name": "dromaeo_css", "value": 7167.773525312455, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 112.0, 113.0, 110.0, 114.0, 112.0, 112.0, 113.0, 112.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 123.0, 123.0, 197.0, 119.0, 118.0, 144.0, 116.0, 152.0, 118.0], "value": 136.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 160.0, 160.0, 164.0, 160.0, 162.0, 161.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 76.0, 105.0, 74.0, 76.0, 73.0, 74.0, 99.0, 76.0], "value": 80.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 122.0, 84.0, 85.0, 85.0, 121.0, 84.0, 85.0, 137.0], "value": 97.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 118.0, 116.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 146.0, 145.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 52.0, 51.0, 50.0, 52.0, 51.0, 51.0, 52.0, 50.0], "value": 51.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 62.0, 62.0, 62.0, 62.0, 66.0, 61.0, 63.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 86.0, 78.0, 83.0, 78.0, 78.0, 78.0, 78.0, 78.0, 79.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 144.0, 120.0, 125.0, 136.0, 136.0, 130.0, 134.0, 140.0, 125.0], "value": 131.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 164.0, 171.0, 165.0, 164.0, 161.0, 162.0, 160.0, 164.0], "value": 163.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 63.0, 64.0, 64.0, 64.0, 63.0, 64.0, 61.0], "value": 63.4, "unit": "score"}], "name": "kraken", "value": 1495.3999999999999, "alertThreshold": 2.0}]} 22:37:08 INFO - Return code: 0 22:37:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:37:08 INFO - # TBPL SUCCESS # 22:37:08 INFO - Running post-action listener: _resource_record_post_action 22:37:08 INFO - [mozharness: 2016-08-17 05:37:08.290485Z] Finished run-tests step (success) 22:37:08 INFO - Running post-run listener: _resource_record_post_run 22:37:08 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 407515136; Read time: 12; Write time: 436968 22:37:08 INFO - TinderboxPrint: CPU usage
13.0% 22:37:08 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 22:37:08 INFO - TinderboxPrint: I/O write bytes / time
407,515,136 / 436,968 22:37:08 INFO - TinderboxPrint: CPU idle
8,287.8 (86.9%) 22:37:08 INFO - TinderboxPrint: CPU user
1,194.8 (12.5%) 22:37:08 INFO - TinderboxPrint: Swap in / out
0 / 0 22:37:08 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 118210560; Read time: 0; Write time: 145280 22:37:08 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 288972800; Read time: 0; Write time: 291688 22:37:08 INFO - Running post-run listener: _upload_blobber_files 22:37:08 INFO - Blob upload gear active. 22:37:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:37:08 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 22:37:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:37:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:37:09 INFO - (blobuploader) - INFO - Open directory for files ... 22:37:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:37:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:37:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:37:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:37:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:37:10 INFO - (blobuploader) - INFO - Done attempting. 22:37:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:37:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:37:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:37:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:37:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:37:13 INFO - (blobuploader) - INFO - Done attempting. 22:37:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:37:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:37:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:37:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:37:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:37:14 INFO - (blobuploader) - INFO - Done attempting. 22:37:14 INFO - (blobuploader) - INFO - Iteration through files over. 22:37:14 INFO - Return code: 0 22:37:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:37:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:37:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/233605e67ad1cc86dfbb7666b3659d0b4df1fe0552b47b7aa751ecd57de2e94b02bec8083c4ab10ba8c67162ddd4e24138cd43bf69b526a57751df95dfaca087", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb1a364c31d38040398ff4cfa0bca04cedca7c73d90d28ada5fea13b1adb00b732ff1167822fbf896d3d9b539d01fa4547018da4d602e116056a1d7b7e0b6571", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de72a3eb557b98d353d18c22cbea04e7842071df1a9486997b64897f675b8f78a05a627a112b2723305050ef73bbafafb31282c45d6f1787e4cd28cafbe6e0f5"} 22:37:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:37:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:37:14 INFO - Contents: 22:37:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/233605e67ad1cc86dfbb7666b3659d0b4df1fe0552b47b7aa751ecd57de2e94b02bec8083c4ab10ba8c67162ddd4e24138cd43bf69b526a57751df95dfaca087", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb1a364c31d38040398ff4cfa0bca04cedca7c73d90d28ada5fea13b1adb00b732ff1167822fbf896d3d9b539d01fa4547018da4d602e116056a1d7b7e0b6571", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de72a3eb557b98d353d18c22cbea04e7842071df1a9486997b64897f675b8f78a05a627a112b2723305050ef73bbafafb31282c45d6f1787e4cd28cafbe6e0f5"} 22:37:14 INFO - Running post-run listener: copy_logs_to_upload_dir 22:37:14 INFO - Copying logs to upload dir... 22:37:14 INFO - mkdir: /builds/slave/test/build/upload/logs 22:37:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.865320 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-16 22:37:14.763409) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 22:37:14.768572) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1471409982.934131-1655940122 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/233605e67ad1cc86dfbb7666b3659d0b4df1fe0552b47b7aa751ecd57de2e94b02bec8083c4ab10ba8c67162ddd4e24138cd43bf69b526a57751df95dfaca087", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb1a364c31d38040398ff4cfa0bca04cedca7c73d90d28ada5fea13b1adb00b732ff1167822fbf896d3d9b539d01fa4547018da4d602e116056a1d7b7e0b6571", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de72a3eb557b98d353d18c22cbea04e7842071df1a9486997b64897f675b8f78a05a627a112b2723305050ef73bbafafb31282c45d6f1787e4cd28cafbe6e0f5"} build_url:https://queue.taskcluster.net/v1/task/M1HKGyusS_aZNrKjgFNSaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011370 build_url: 'https://queue.taskcluster.net/v1/task/M1HKGyusS_aZNrKjgFNSaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/233605e67ad1cc86dfbb7666b3659d0b4df1fe0552b47b7aa751ecd57de2e94b02bec8083c4ab10ba8c67162ddd4e24138cd43bf69b526a57751df95dfaca087", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb1a364c31d38040398ff4cfa0bca04cedca7c73d90d28ada5fea13b1adb00b732ff1167822fbf896d3d9b539d01fa4547018da4d602e116056a1d7b7e0b6571", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de72a3eb557b98d353d18c22cbea04e7842071df1a9486997b64897f675b8f78a05a627a112b2723305050ef73bbafafb31282c45d6f1787e4cd28cafbe6e0f5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 22:37:14.794109) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 22:37:14.794478) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1471409982.934131-1655940122 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004507 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 22:37:14.876141) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 22:37:14.876461) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 22:37:14.876740) ========= ========= Total master_lag: 0.17 =========