builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-054 starttime: 1474553769.47 results: success (0) buildid: 20160922043003 builduid: 0a62f584391c4fe6bd98ddd9a8b027fa revision: f0e6cc6360213ba21fd98c887b55fce5c680df68 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 07:16:09.468964) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 07:16:09.470120) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 07:16:09.470553) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 07:16:09.670028) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 07:16:09.670282) ========= 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=cbe409c6de289db6ac707de3000001d4-1474552741.665845-984883129 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-22 07:16:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 20.1M=0.001s 2016-09-22 07:16:10 (20.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096347 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 07:16:09.796667) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 07:16:09.797103) ========= 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=cbe409c6de289db6ac707de3000001d4-1474552741.665845-984883129 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019674 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 07:16:09.855296) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-22 07:16:09.855614) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f0e6cc6360213ba21fd98c887b55fce5c680df68 --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 f0e6cc6360213ba21fd98c887b55fce5c680df68 --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=cbe409c6de289db6ac707de3000001d4-1474552741.665845-984883129 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-22 07:16:10,330 truncating revision to first 12 chars 2016-09-22 07:16:10,330 Setting DEBUG logging. 2016-09-22 07:16:10,330 attempt 1/10 2016-09-22 07:16:10,331 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f0e6cc636021?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-22 07:16:11,715 unpacking tar archive at: mozilla-central-f0e6cc636021/testing/mozharness/ program finished with exit code 0 elapsedTime=1.702208 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-22 07:16:11.582958) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 07:16:11.583283) ========= script_repo_revision: f0e6cc6360213ba21fd98c887b55fce5c680df68 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 07:16:11.583698) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 07:16:11.583965) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 07:16:11.595469) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-09-22 07:16:11.595932) ========= /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=cbe409c6de289db6ac707de3000001d4-1474552741.665845-984883129 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:16:12 INFO - MultiFileLogger online at 20160922 07:16:12 in /builds/slave/test 07:16:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:16:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:16:12 INFO - {'append_to_log': False, 07:16:12 INFO - 'base_work_dir': '/builds/slave/test', 07:16:12 INFO - 'blob_upload_branch': 'Firefox', 07:16:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:16:12 INFO - 'branch': 'Firefox', 07:16:12 INFO - 'buildbot_json_path': 'buildprops.json', 07:16:12 INFO - 'config_files': ('talos/linux_config.py',), 07:16:12 INFO - 'default_actions': ('clobber', 07:16:12 INFO - 'read-buildbot-config', 07:16:12 INFO - 'download-and-extract', 07:16:12 INFO - 'populate-webroot', 07:16:12 INFO - 'create-virtualenv', 07:16:12 INFO - 'install', 07:16:12 INFO - 'run-tests'), 07:16:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:16:12 INFO - 'download_minidump_stackwalk': True, 07:16:12 INFO - 'download_symbols': 'ondemand', 07:16:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:16:12 INFO - 'tooltool.py': '/tools/tooltool.py', 07:16:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:16:12 INFO - '/tools/misc-python/virtualenv.py')}, 07:16:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:16:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:16:12 INFO - 'installer_path': 'installer.exe', 07:16:12 INFO - 'log_level': 'info', 07:16:12 INFO - 'log_name': 'talos', 07:16:12 INFO - 'log_to_console': True, 07:16:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:16:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:16:12 INFO - 'opt_config_files': (), 07:16:12 INFO - 'pip_index': False, 07:16:12 INFO - 'sps_profile': False, 07:16:12 INFO - 'sps_profile_interval': 0, 07:16:12 INFO - 'suite': 'dromaeojs', 07:16:12 INFO - 'system_bits': '32', 07:16:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:16:12 INFO - 'title': 'talos-linux64-ix-054', 07:16:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:16:12 INFO - 'use_talos_json': True, 07:16:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:16:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:16:12 INFO - 'work_dir': 'build'} 07:16:12 INFO - [mozharness: 2016-09-22 14:16:12.156911Z] Running clobber step. 07:16:12 INFO - Running pre-action listener: _resource_record_pre_action 07:16:12 INFO - Running main action method: clobber 07:16:12 INFO - rmtree: /builds/slave/test/build 07:16:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:16:13 INFO - Running post-action listener: _resource_record_post_action 07:16:13 INFO - [mozharness: 2016-09-22 14:16:13.132755Z] Finished clobber step (success) 07:16:13 INFO - [mozharness: 2016-09-22 14:16:13.132854Z] Running read-buildbot-config step. 07:16:13 INFO - Running pre-action listener: _resource_record_pre_action 07:16:13 INFO - Running main action method: read_buildbot_config 07:16:13 INFO - Using buildbot properties: 07:16:13 INFO - { 07:16:13 INFO - "project": "", 07:16:13 INFO - "product": "firefox", 07:16:13 INFO - "script_repo_revision": "production", 07:16:13 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:16:13 INFO - "repository": "", 07:16:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 07:16:13 INFO - "buildid": "20160922043003", 07:16:13 INFO - "pgo_build": "True", 07:16:13 INFO - "basedir": "/builds/slave/test", 07:16:13 INFO - "buildnumber": 891, 07:16:13 INFO - "slavename": "talos-linux64-ix-054", 07:16:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:16:13 INFO - "platform": "ubuntu64_hw", 07:16:13 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:16:13 INFO - "branch": "mozilla-central", 07:16:13 INFO - "repo_path": "mozilla-central", 07:16:13 INFO - "revision": "f0e6cc6360213ba21fd98c887b55fce5c680df68", 07:16:13 INFO - "stage_platform": "linux64-pgo", 07:16:13 INFO - "builduid": "0a62f584391c4fe6bd98ddd9a8b027fa", 07:16:13 INFO - "slavebuilddir": "test" 07:16:13 INFO - } 07:16:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/DwTwkyYqRRy-bs8snkhd8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 07:16:13 INFO - Running post-action listener: _resource_record_post_action 07:16:13 INFO - [mozharness: 2016-09-22 14:16:13.135290Z] Finished read-buildbot-config step (success) 07:16:13 INFO - [mozharness: 2016-09-22 14:16:13.135380Z] Running download-and-extract step. 07:16:13 INFO - Running pre-action listener: _resource_record_pre_action 07:16:13 INFO - Running main action method: download_and_extract 07:16:13 INFO - mkdir: /builds/slave/test/build/tests 07:16: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')]} 07:16:13 INFO - trying https://queue.taskcluster.net/v1/task/DwTwkyYqRRy-bs8snkhd8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:16:13 INFO - Downloading https://queue.taskcluster.net/v1/task/DwTwkyYqRRy-bs8snkhd8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:16:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DwTwkyYqRRy-bs8snkhd8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:16:13 INFO - Downloaded 1361 bytes. 07:16:13 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:16:13 INFO - Using the following test package requirements: 07:16:13 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 07:16:13 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:16:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:16:13 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:16:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:16:13 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:16:13 INFO - u'jsshell-linux-x86_64.zip'], 07:16:13 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:16:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:16:13 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 07:16:13 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:16:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:16:13 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:16:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:16:13 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:16:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:16:13 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:16:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:16:13 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:16:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DwTwkyYqRRy-bs8snkhd8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 07:16:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DwTwkyYqRRy-bs8snkhd8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:16:13 INFO - Fetch https://queue.taskcluster.net/v1/task/DwTwkyYqRRy-bs8snkhd8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:16:14 INFO - Expected file size: 21944017 07:16:18 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:16:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DwTwkyYqRRy-bs8snkhd8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 07:16:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DwTwkyYqRRy-bs8snkhd8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:16:18 INFO - Fetch https://queue.taskcluster.net/v1/task/DwTwkyYqRRy-bs8snkhd8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:16:19 INFO - Expected file size: 21944017 07:16:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DwTwkyYqRRy-bs8snkhd8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 07:16:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DwTwkyYqRRy-bs8snkhd8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:16:23 INFO - Fetch https://queue.taskcluster.net/v1/task/DwTwkyYqRRy-bs8snkhd8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 07:16:24 INFO - Expected file size: 14414059 07:16:24 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')]} 07:16:24 INFO - trying https://queue.taskcluster.net/v1/task/DwTwkyYqRRy-bs8snkhd8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:16:24 INFO - Downloading https://queue.taskcluster.net/v1/task/DwTwkyYqRRy-bs8snkhd8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:16:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DwTwkyYqRRy-bs8snkhd8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:16:26 INFO - Downloaded 59631721 bytes. 07:16:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DwTwkyYqRRy-bs8snkhd8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:16:26 INFO - mkdir: /builds/slave/test/properties 07:16:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:16:26 INFO - Writing to file /builds/slave/test/properties/build_url 07:16:26 INFO - Contents: 07:16:26 INFO - build_url:https://queue.taskcluster.net/v1/task/DwTwkyYqRRy-bs8snkhd8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:16:26 INFO - Running post-action listener: _resource_record_post_action 07:16:26 INFO - Running post-action listener: set_extra_try_arguments 07:16:26 INFO - [mozharness: 2016-09-22 14:16:26.784353Z] Finished download-and-extract step (success) 07:16:26 INFO - [mozharness: 2016-09-22 14:16:26.784581Z] Running populate-webroot step. 07:16:26 INFO - Running pre-action listener: _resource_record_pre_action 07:16:26 INFO - Running main action method: populate_webroot 07:16:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:16:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:16:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:16:26 INFO - '--tppagecycles', 07:16:26 INFO - '7'], 07:16:26 INFO - 'tests': ['tsvgm']}}, 07:16:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:16:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:16:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:16:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:16:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:16:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:16:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:16:26 INFO - 'talos_options': ['--disable-e10s'], 07:16:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:16:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:16:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:16:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:16:26 INFO - 'talos_options': ['--disable-e10s'], 07:16:26 INFO - 'tests': ['damp', 'tps']}, 07:16:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:16:26 INFO - 'tests': ['damp', 'tps']}, 07:16:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:16:26 INFO - 'tests': ['dromaeo_dom']}, 07:16:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:16:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:16:26 INFO - 'tests': ['basic_compositor_video']}, 07:16:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:16:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:16:26 INFO - 'tests': ['a11yr', 07:16:26 INFO - 'ts_paint', 07:16:26 INFO - 'tpaint', 07:16:26 INFO - 'sessionrestore', 07:16:26 INFO - 'sessionrestore_no_auto_restore', 07:16:26 INFO - 'tabpaint']}, 07:16:26 INFO - 'other-e10s': {'tests': ['a11yr', 07:16:26 INFO - 'ts_paint', 07:16:26 INFO - 'tpaint', 07:16:26 INFO - 'sessionrestore', 07:16:26 INFO - 'sessionrestore_no_auto_restore', 07:16:26 INFO - 'tabpaint']}, 07:16:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:16:26 INFO - 'ts_paint', 07:16:26 INFO - 'tpaint', 07:16:26 INFO - 'sessionrestore', 07:16:26 INFO - 'sessionrestore_no_auto_restore', 07:16:26 INFO - 'tabpaint']}, 07:16:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:16:26 INFO - 'ts_paint', 07:16:26 INFO - 'tpaint', 07:16:26 INFO - 'sessionrestore', 07:16:26 INFO - 'sessionrestore_no_auto_restore', 07:16:26 INFO - 'tabpaint']}, 07:16:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:16:26 INFO - 'tests': ['a11yr', 07:16:26 INFO - 'ts_paint', 07:16:26 INFO - 'tpaint', 07:16:26 INFO - 'sessionrestore', 07:16:26 INFO - 'sessionrestore_no_auto_restore', 07:16:26 INFO - 'tabpaint']}, 07:16:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:16:26 INFO - 'tests': ['a11yr', 07:16:26 INFO - 'ts_paint', 07:16:26 INFO - 'tpaint', 07:16:26 INFO - 'sessionrestore', 07:16:26 INFO - 'sessionrestore_no_auto_restore', 07:16:26 INFO - 'tabpaint']}, 07:16:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:16:26 INFO - 'tests': ['tsvgx', 07:16:26 INFO - 'tsvgr_opacity', 07:16:26 INFO - 'tart', 07:16:26 INFO - 'tscrollx', 07:16:26 INFO - 'cart']}, 07:16:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:16:26 INFO - 'tsvgr_opacity', 07:16:26 INFO - 'tart', 07:16:26 INFO - 'tscrollx', 07:16:26 INFO - 'cart']}, 07:16:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:16:26 INFO - 'talos_options': ['--disable-e10s'], 07:16:26 INFO - 'tests': ['tp5o']}, 07:16:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:16:26 INFO - 'tests': ['tp5o']}, 07:16:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:16:26 INFO - 'talos_options': ['--disable-e10s', 07:16:26 INFO - '--xperf_path', 07:16:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:16:26 INFO - 'tests': ['tp5n']}, 07:16:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:16:26 INFO - 'talos_options': ['--xperf_path', 07:16:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:16:26 INFO - 'tests': ['tp5n']}}, 07:16:26 INFO - 'talos.zip': {'path': '', 07:16:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:16:26 INFO - Running post-action listener: _resource_record_post_action 07:16:26 INFO - [mozharness: 2016-09-22 14:16:26.803636Z] Finished populate-webroot step (success) 07:16:26 INFO - [mozharness: 2016-09-22 14:16:26.803725Z] Running create-virtualenv step. 07:16:26 INFO - Running pre-action listener: _resource_record_pre_action 07:16:26 INFO - Running main action method: create_virtualenv 07:16:26 INFO - Creating virtualenv /builds/slave/test/build/venv 07:16:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:16:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:16:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:16:26 INFO - Using real prefix '/usr' 07:16:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:16:27 INFO - Installing distribute.............................................................................................................................................................................................done. 07:16:29 INFO - Installing pip.................done. 07:16:29 INFO - Return code: 0 07:16:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:16:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:16:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:29 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 0x7f9531291f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1394790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1391930>, '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 0x1392830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1392cc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1474552741.665845-984883129', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:16:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:16:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:16:29 INFO - Using env: {'DISPLAY': ':0', 07:16:29 INFO - 'HOME': '/home/cltbld', 07:16:29 INFO - 'LANG': 'en_US.UTF-8', 07:16:29 INFO - 'LANGUAGE': 'en_US:en', 07:16:29 INFO - 'LOGNAME': 'cltbld', 07:16:29 INFO - 'MAIL': '/var/mail/cltbld', 07:16:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:29 INFO - 'MOZ_NO_REMOTE': '1', 07:16:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:29 INFO - 'NO_EM_RESTART': '1', 07:16:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:29 INFO - 'PWD': '/builds/slave/test', 07:16:29 INFO - 'SHELL': '/bin/bash', 07:16:29 INFO - 'SHLVL': '1', 07:16:29 INFO - 'TERM': 'linux', 07:16:29 INFO - 'TMOUT': '86400', 07:16:29 INFO - 'USER': 'cltbld', 07:16:29 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1474552741.665845-984883129', 07:16:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:29 INFO - '_': '/tools/buildbot/bin/python'} 07:16:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:16:29 INFO - Cleaning up... 07:16:29 INFO - Return code: 0 07:16:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:16:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:16:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:29 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 0x7f9531291f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1394790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1391930>, '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 0x1392830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1392cc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1474552741.665845-984883129', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:16:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:16:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:16:29 INFO - Using env: {'DISPLAY': ':0', 07:16:29 INFO - 'HOME': '/home/cltbld', 07:16:29 INFO - 'LANG': 'en_US.UTF-8', 07:16:29 INFO - 'LANGUAGE': 'en_US:en', 07:16:29 INFO - 'LOGNAME': 'cltbld', 07:16:29 INFO - 'MAIL': '/var/mail/cltbld', 07:16:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:29 INFO - 'MOZ_NO_REMOTE': '1', 07:16:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:29 INFO - 'NO_EM_RESTART': '1', 07:16:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:29 INFO - 'PWD': '/builds/slave/test', 07:16:29 INFO - 'SHELL': '/bin/bash', 07:16:29 INFO - 'SHLVL': '1', 07:16:29 INFO - 'TERM': 'linux', 07:16:29 INFO - 'TMOUT': '86400', 07:16:29 INFO - 'USER': 'cltbld', 07:16:29 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1474552741.665845-984883129', 07:16:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:29 INFO - '_': '/tools/buildbot/bin/python'} 07:16:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:29 INFO - Downloading/unpacking psutil>=3.1.1 07:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:16:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:16:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:16:31 INFO - Installing collected packages: psutil 07:16:31 INFO - Running setup.py install for psutil 07:16:31 INFO - building 'psutil._psutil_linux' extension 07:16:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:16:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:16:32 INFO - building 'psutil._psutil_posix' extension 07:16:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:16:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:16:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:16:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:16:32 INFO - Successfully installed psutil 07:16:32 INFO - Cleaning up... 07:16:32 INFO - Return code: 0 07:16:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:16:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:32 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 0x7f9531291f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1394790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1391930>, '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 0x1392830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1392cc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1474552741.665845-984883129', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:16:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:16:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:16:32 INFO - Using env: {'DISPLAY': ':0', 07:16:32 INFO - 'HOME': '/home/cltbld', 07:16:32 INFO - 'LANG': 'en_US.UTF-8', 07:16:32 INFO - 'LANGUAGE': 'en_US:en', 07:16:32 INFO - 'LOGNAME': 'cltbld', 07:16:32 INFO - 'MAIL': '/var/mail/cltbld', 07:16:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:32 INFO - 'MOZ_NO_REMOTE': '1', 07:16:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:32 INFO - 'NO_EM_RESTART': '1', 07:16:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:32 INFO - 'PWD': '/builds/slave/test', 07:16:32 INFO - 'SHELL': '/bin/bash', 07:16:32 INFO - 'SHLVL': '1', 07:16:32 INFO - 'TERM': 'linux', 07:16:32 INFO - 'TMOUT': '86400', 07:16:32 INFO - 'USER': 'cltbld', 07:16:32 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1474552741.665845-984883129', 07:16:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:32 INFO - '_': '/tools/buildbot/bin/python'} 07:16:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:16:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:16:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:16:34 INFO - Installing collected packages: mozsystemmonitor 07:16:34 INFO - Running setup.py install for mozsystemmonitor 07:16:34 INFO - Successfully installed mozsystemmonitor 07:16:34 INFO - Cleaning up... 07:16:34 INFO - Return code: 0 07:16:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:16:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:16:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:34 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 0x7f9531291f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1394790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1391930>, '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 0x1392830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1392cc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1474552741.665845-984883129', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:16:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:16:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:16:34 INFO - Using env: {'DISPLAY': ':0', 07:16:34 INFO - 'HOME': '/home/cltbld', 07:16:34 INFO - 'LANG': 'en_US.UTF-8', 07:16:34 INFO - 'LANGUAGE': 'en_US:en', 07:16:34 INFO - 'LOGNAME': 'cltbld', 07:16:34 INFO - 'MAIL': '/var/mail/cltbld', 07:16:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:34 INFO - 'MOZ_NO_REMOTE': '1', 07:16:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:34 INFO - 'NO_EM_RESTART': '1', 07:16:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:34 INFO - 'PWD': '/builds/slave/test', 07:16:34 INFO - 'SHELL': '/bin/bash', 07:16:34 INFO - 'SHLVL': '1', 07:16:34 INFO - 'TERM': 'linux', 07:16:34 INFO - 'TMOUT': '86400', 07:16:34 INFO - 'USER': 'cltbld', 07:16:34 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1474552741.665845-984883129', 07:16:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:34 INFO - '_': '/tools/buildbot/bin/python'} 07:16:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:34 INFO - Downloading/unpacking jsonschema==2.5.1 07:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:16:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:36 INFO - Downloading functools32-3.2.3-2.tar.gz 07:16:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:16:37 INFO - warning: no files found matching '*.txt' 07:16:37 INFO - no previously-included directories found matching 'build' 07:16:37 INFO - no previously-included directories found matching 'dist' 07:16:37 INFO - no previously-included directories found matching '.git*' 07:16:37 INFO - Installing collected packages: jsonschema, functools32 07:16:37 INFO - Running setup.py install for functools32 07:16:37 INFO - warning: no files found matching '*.txt' 07:16:37 INFO - no previously-included directories found matching 'build' 07:16:37 INFO - no previously-included directories found matching 'dist' 07:16:37 INFO - no previously-included directories found matching '.git*' 07:16:37 INFO - Successfully installed jsonschema functools32 07:16:37 INFO - Cleaning up... 07:16:37 INFO - Return code: 0 07:16:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:16:37 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')]} 07:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:37 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')]} 07:16:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:37 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 0x7f9531291f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1394790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1391930>, '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 0x1392830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1392cc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1474552741.665845-984883129', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:16:37 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 07:16:37 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 07:16:37 INFO - Using env: {'DISPLAY': ':0', 07:16:37 INFO - 'HOME': '/home/cltbld', 07:16:37 INFO - 'LANG': 'en_US.UTF-8', 07:16:37 INFO - 'LANGUAGE': 'en_US:en', 07:16:37 INFO - 'LOGNAME': 'cltbld', 07:16:37 INFO - 'MAIL': '/var/mail/cltbld', 07:16:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:37 INFO - 'MOZ_NO_REMOTE': '1', 07:16:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:37 INFO - 'NO_EM_RESTART': '1', 07:16:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:37 INFO - 'PWD': '/builds/slave/test', 07:16:37 INFO - 'SHELL': '/bin/bash', 07:16:37 INFO - 'SHLVL': '1', 07:16:37 INFO - 'TERM': 'linux', 07:16:37 INFO - 'TMOUT': '86400', 07:16:37 INFO - 'USER': 'cltbld', 07:16:37 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1474552741.665845-984883129', 07:16:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:37 INFO - '_': '/tools/buildbot/bin/python'} 07:16:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:16:37 INFO - Cleaning up... 07:16:37 INFO - Return code: 0 07:16:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:16:37 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')]} 07:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:37 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')]} 07:16:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:37 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 0x7f9531291f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1394790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1391930>, '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 0x1392830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1392cc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1474552741.665845-984883129', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:16:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:16:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:16:37 INFO - Using env: {'DISPLAY': ':0', 07:16:37 INFO - 'HOME': '/home/cltbld', 07:16:37 INFO - 'LANG': 'en_US.UTF-8', 07:16:37 INFO - 'LANGUAGE': 'en_US:en', 07:16:37 INFO - 'LOGNAME': 'cltbld', 07:16:37 INFO - 'MAIL': '/var/mail/cltbld', 07:16:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:37 INFO - 'MOZ_NO_REMOTE': '1', 07:16:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:37 INFO - 'NO_EM_RESTART': '1', 07:16:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:37 INFO - 'PWD': '/builds/slave/test', 07:16:37 INFO - 'SHELL': '/bin/bash', 07:16:37 INFO - 'SHLVL': '1', 07:16:37 INFO - 'TERM': 'linux', 07:16:37 INFO - 'TMOUT': '86400', 07:16:37 INFO - 'USER': 'cltbld', 07:16:37 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1474552741.665845-984883129', 07:16:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:37 INFO - '_': '/tools/buildbot/bin/python'} 07:16:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:37 INFO - Downloading/unpacking blobuploader==1.2.4 07:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:39 INFO - Downloading blobuploader-1.2.4.tar.gz 07:16:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:16:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:16:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:40 INFO - Downloading docopt-0.6.1.tar.gz 07:16:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:16:40 INFO - Installing collected packages: blobuploader, requests, docopt 07:16:40 INFO - Running setup.py install for blobuploader 07:16:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:16:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:16:40 INFO - Running setup.py install for requests 07:16:40 INFO - Running setup.py install for docopt 07:16:40 INFO - Successfully installed blobuploader requests docopt 07:16:40 INFO - Cleaning up... 07:16:40 INFO - Return code: 0 07:16:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:16:40 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')]} 07:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:40 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')]} 07:16:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:40 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 0x7f9531291f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1394790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1391930>, '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 0x1392830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1392cc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1474552741.665845-984883129', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:16:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:16:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:16:40 INFO - Using env: {'DISPLAY': ':0', 07:16:40 INFO - 'HOME': '/home/cltbld', 07:16:40 INFO - 'LANG': 'en_US.UTF-8', 07:16:40 INFO - 'LANGUAGE': 'en_US:en', 07:16:40 INFO - 'LOGNAME': 'cltbld', 07:16:40 INFO - 'MAIL': '/var/mail/cltbld', 07:16:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:40 INFO - 'MOZ_NO_REMOTE': '1', 07:16:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:40 INFO - 'NO_EM_RESTART': '1', 07:16:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:40 INFO - 'PWD': '/builds/slave/test', 07:16:40 INFO - 'SHELL': '/bin/bash', 07:16:40 INFO - 'SHLVL': '1', 07:16:40 INFO - 'TERM': 'linux', 07:16:40 INFO - 'TMOUT': '86400', 07:16:40 INFO - 'USER': 'cltbld', 07:16:40 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1474552741.665845-984883129', 07:16:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:40 INFO - '_': '/tools/buildbot/bin/python'} 07:16:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:16:41 INFO - Running setup.py (path:/tmp/pip-B0Y3DM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:16:41 INFO - Running setup.py (path:/tmp/pip-YKSkUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:16:41 INFO - Running setup.py (path:/tmp/pip-AAXkGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:16:41 INFO - Running setup.py (path:/tmp/pip-dO9GE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:16:41 INFO - Running setup.py (path:/tmp/pip-ekNydb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:16:41 INFO - Running setup.py (path:/tmp/pip-T04pGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:16:41 INFO - Running setup.py (path:/tmp/pip-RPOOa5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:16:41 INFO - Running setup.py (path:/tmp/pip-0xkD4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:16:41 INFO - Running setup.py (path:/tmp/pip-2AwqiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:16:41 INFO - Running setup.py (path:/tmp/pip-WeYCkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:16:41 INFO - Running setup.py (path:/tmp/pip-08Z0_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:16:41 INFO - Running setup.py (path:/tmp/pip-28RxXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:16:42 INFO - Running setup.py (path:/tmp/pip-2FfXZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:16:42 INFO - Running setup.py (path:/tmp/pip-cbpAmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:16:42 INFO - Running setup.py (path:/tmp/pip-h4BrRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:16:42 INFO - Running setup.py (path:/tmp/pip-8tw5tt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:16:42 INFO - Running setup.py (path:/tmp/pip-eoqxkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:16:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:16:42 INFO - Running setup.py install for manifestparser 07:16:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:16:42 INFO - Running setup.py install for mozcrash 07:16:42 INFO - Running setup.py install for mozdebug 07:16:42 INFO - Running setup.py install for mozdevice 07:16:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:16:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:16:42 INFO - Running setup.py install for mozfile 07:16:42 INFO - Running setup.py install for mozhttpd 07:16:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:16:42 INFO - Running setup.py install for mozinfo 07:16:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:16:43 INFO - Running setup.py install for mozInstall 07:16:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:16:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:16:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:16:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:16:43 INFO - Running setup.py install for mozleak 07:16:43 INFO - Running setup.py install for mozlog 07:16:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:16:43 INFO - Running setup.py install for moznetwork 07:16:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:16:43 INFO - Running setup.py install for mozprocess 07:16:43 INFO - Running setup.py install for mozprofile 07:16:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:16:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:16:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:16:43 INFO - Running setup.py install for mozrunner 07:16:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:16:43 INFO - Running setup.py install for mozscreenshot 07:16:43 INFO - Running setup.py install for moztest 07:16:44 INFO - Running setup.py install for mozversion 07:16:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:16:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:16:44 INFO - Cleaning up... 07:16:44 INFO - Return code: 0 07:16:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:16:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:16:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:44 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 0x7f9531291f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1394790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1391930>, '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 0x1392830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1392cc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1474552741.665845-984883129', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:16:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:16:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:16:44 INFO - Using env: {'DISPLAY': ':0', 07:16:44 INFO - 'HOME': '/home/cltbld', 07:16:44 INFO - 'LANG': 'en_US.UTF-8', 07:16:44 INFO - 'LANGUAGE': 'en_US:en', 07:16:44 INFO - 'LOGNAME': 'cltbld', 07:16:44 INFO - 'MAIL': '/var/mail/cltbld', 07:16:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:44 INFO - 'MOZ_NO_REMOTE': '1', 07:16:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:44 INFO - 'NO_EM_RESTART': '1', 07:16:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:44 INFO - 'PWD': '/builds/slave/test', 07:16:44 INFO - 'SHELL': '/bin/bash', 07:16:44 INFO - 'SHLVL': '1', 07:16:44 INFO - 'TERM': 'linux', 07:16:44 INFO - 'TMOUT': '86400', 07:16:44 INFO - 'USER': 'cltbld', 07:16:44 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1474552741.665845-984883129', 07:16:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:44 INFO - '_': '/tools/buildbot/bin/python'} 07:16:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:16:44 INFO - Running setup.py (path:/tmp/pip-Sl5EnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:16:44 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:16:44 INFO - Running setup.py (path:/tmp/pip-jItb46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:16:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:16:44 INFO - Running setup.py (path:/tmp/pip-7fZBCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:16:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:16:44 INFO - Running setup.py (path:/tmp/pip-EH2sio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:16:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:16:44 INFO - Running setup.py (path:/tmp/pip-Ksg8Xc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:16:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:16:44 INFO - Running setup.py (path:/tmp/pip-vgLycD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:16:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:16:44 INFO - Running setup.py (path:/tmp/pip-IDiwfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:16:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:16:44 INFO - Running setup.py (path:/tmp/pip-kFWNnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:16:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:16:44 INFO - Running setup.py (path:/tmp/pip-_ru3eI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:16:45 INFO - Running setup.py (path:/tmp/pip-Yc_Xvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:16:45 INFO - Running setup.py (path:/tmp/pip-qqaFqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:16:45 INFO - Running setup.py (path:/tmp/pip-qPEPYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:16:45 INFO - Running setup.py (path:/tmp/pip-gB1dM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:16:45 INFO - Running setup.py (path:/tmp/pip-dZqAPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:16:45 INFO - Running setup.py (path:/tmp/pip-XtG7OK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:16:45 INFO - Running setup.py (path:/tmp/pip-QySOld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:16:45 INFO - Running setup.py (path:/tmp/pip-7k8sdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:16:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:47 INFO - Downloading blessings-1.6.tar.gz 07:16:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:16:47 INFO - Installing collected packages: blessings 07:16:47 INFO - Running setup.py install for blessings 07:16:47 INFO - Successfully installed blessings 07:16:47 INFO - Cleaning up... 07:16:47 INFO - Return code: 0 07:16:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:16:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:16:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:16:47 INFO - Reading from file tmpfile_stdout 07:16:47 INFO - Current package versions: 07:16:47 INFO - argparse == 1.2.1 07:16:47 INFO - blessings == 1.6 07:16:47 INFO - blobuploader == 1.2.4 07:16:47 INFO - docopt == 0.6.1 07:16:47 INFO - functools32 == 3.2.3-2 07:16:47 INFO - jsonschema == 2.5.1 07:16:47 INFO - manifestparser == 1.1 07:16:47 INFO - mozInstall == 1.12 07:16:47 INFO - mozcrash == 0.17 07:16:47 INFO - mozdebug == 0.1 07:16:47 INFO - mozdevice == 0.48 07:16:47 INFO - mozfile == 1.2 07:16:47 INFO - mozhttpd == 0.7 07:16:47 INFO - mozinfo == 0.9 07:16:47 INFO - mozleak == 0.1 07:16:47 INFO - mozlog == 3.4 07:16:47 INFO - moznetwork == 0.27 07:16:47 INFO - mozprocess == 0.23 07:16:47 INFO - mozprofile == 0.28 07:16:47 INFO - mozrunner == 6.12 07:16:47 INFO - mozscreenshot == 0.1 07:16:47 INFO - mozsystemmonitor == 0.3 07:16:47 INFO - moztest == 0.7 07:16:47 INFO - mozversion == 1.4 07:16:47 INFO - psutil == 3.1.1 07:16:47 INFO - requests == 1.2.3 07:16:47 INFO - wsgiref == 0.1.2 07:16:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07: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')]} 07:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07: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')]} 07:16:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:47 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 0x7f9531291f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1394790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1391930>, '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 0x1392830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1392cc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1474552741.665845-984883129', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:16:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:16:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:16:47 INFO - Using env: {'DISPLAY': ':0', 07:16:47 INFO - 'HOME': '/home/cltbld', 07:16:47 INFO - 'LANG': 'en_US.UTF-8', 07:16:47 INFO - 'LANGUAGE': 'en_US:en', 07:16:47 INFO - 'LOGNAME': 'cltbld', 07:16:47 INFO - 'MAIL': '/var/mail/cltbld', 07:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:47 INFO - 'MOZ_NO_REMOTE': '1', 07:16:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:47 INFO - 'NO_EM_RESTART': '1', 07:16:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:47 INFO - 'PWD': '/builds/slave/test', 07:16:47 INFO - 'SHELL': '/bin/bash', 07:16:47 INFO - 'SHLVL': '1', 07:16:48 INFO - 'TERM': 'linux', 07:16:48 INFO - 'TMOUT': '86400', 07:16:48 INFO - 'USER': 'cltbld', 07:16:48 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1474552741.665845-984883129', 07:16:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:48 INFO - '_': '/tools/buildbot/bin/python'} 07:16:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:16:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:16:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:16:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:16:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:16:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:16:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:16:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:16:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:16:48 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:16:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:16:48 INFO - Cleaning up... 07:16:48 INFO - Return code: 0 07:16:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:16:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:16:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:48 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 0x7f9531291f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1394790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1391930>, '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 0x1392830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1392cc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1474552741.665845-984883129', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:16:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:16:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:16:48 INFO - Using env: {'DISPLAY': ':0', 07:16:48 INFO - 'HOME': '/home/cltbld', 07:16:48 INFO - 'LANG': 'en_US.UTF-8', 07:16:48 INFO - 'LANGUAGE': 'en_US:en', 07:16:48 INFO - 'LOGNAME': 'cltbld', 07:16:48 INFO - 'MAIL': '/var/mail/cltbld', 07:16:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:48 INFO - 'MOZ_NO_REMOTE': '1', 07:16:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:48 INFO - 'NO_EM_RESTART': '1', 07:16:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:48 INFO - 'PWD': '/builds/slave/test', 07:16:48 INFO - 'SHELL': '/bin/bash', 07:16:48 INFO - 'SHLVL': '1', 07:16:48 INFO - 'TERM': 'linux', 07:16:48 INFO - 'TMOUT': '86400', 07:16:48 INFO - 'USER': 'cltbld', 07:16:48 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1474552741.665845-984883129', 07:16:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:48 INFO - '_': '/tools/buildbot/bin/python'} 07:16:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:16:48 INFO - Cleaning up... 07:16:48 INFO - Return code: 0 07:16:48 INFO - Running post-action listener: _resource_record_post_action 07:16:48 INFO - Running post-action listener: _start_resource_monitoring 07:16:48 INFO - Starting resource monitoring. 07:16:48 INFO - [mozharness: 2016-09-22 14:16:48.456389Z] Finished create-virtualenv step (success) 07:16:48 INFO - [mozharness: 2016-09-22 14:16:48.456853Z] Running install step. 07:16:48 INFO - Running pre-action listener: _resource_record_pre_action 07:16:48 INFO - Running main action method: install 07:16:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:16:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:16:48 INFO - Reading from file tmpfile_stdout 07:16:48 INFO - Detecting whether we're running mozinstall >=1.0... 07:16:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:16:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:16:48 INFO - Reading from file tmpfile_stdout 07:16:48 INFO - Output received: 07:16:48 INFO - Usage: mozinstall [options] installer 07:16:48 INFO - Options: 07:16:48 INFO - -h, --help show this help message and exit 07:16:48 INFO - -d DEST, --destination=DEST 07:16:48 INFO - Directory to install application into. [default: 07:16:48 INFO - "/builds/slave/test"] 07:16:48 INFO - --app=APP Application being installed. [default: firefox] 07:16:48 INFO - mkdir: /builds/slave/test/build/application 07:16:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:16:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:17:05 INFO - Reading from file tmpfile_stdout 07:17:05 INFO - Output received: 07:17:05 INFO - /builds/slave/test/build/application/firefox/firefox 07:17:05 INFO - Running post-action listener: _resource_record_post_action 07:17:05 INFO - [mozharness: 2016-09-22 14:17:05.734882Z] Finished install step (success) 07:17:05 INFO - [mozharness: 2016-09-22 14:17:05.735127Z] Running run-tests step. 07:17:05 INFO - Running pre-action listener: _resource_record_pre_action 07:17:05 INFO - Running main action method: run_tests 07:17:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:17:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:17:05 INFO - Python 2.7.3 07:17:05 INFO - Return code: 0 07:17:05 INFO - grabbing minidump binary from tooltool 07:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:05 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 0x1391930>, '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 0x1392830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1392cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:17:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:17:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:17:05 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:17:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:17:05 INFO - Return code: 0 07:17:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:17:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:17:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:17:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:17:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:17:05 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/DwTwkyYqRRy-bs8snkhd8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:17:05 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/DwTwkyYqRRy-bs8snkhd8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:17:05 INFO - Using env: {'DISPLAY': ':0', 07:17:05 INFO - 'HOME': '/home/cltbld', 07:17:05 INFO - 'LANG': 'en_US.UTF-8', 07:17:05 INFO - 'LANGUAGE': 'en_US:en', 07:17:05 INFO - 'LOGNAME': 'cltbld', 07:17:05 INFO - 'MAIL': '/var/mail/cltbld', 07:17:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:17:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:05 INFO - 'MOZ_NO_REMOTE': '1', 07:17:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:17:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:05 INFO - 'NO_EM_RESTART': '1', 07:17:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:05 INFO - 'PWD': '/builds/slave/test', 07:17:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:17:05 INFO - 'SHELL': '/bin/bash', 07:17:05 INFO - 'SHLVL': '1', 07:17:05 INFO - 'TERM': 'linux', 07:17:05 INFO - 'TMOUT': '86400', 07:17:05 INFO - 'USER': 'cltbld', 07:17:05 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1474552741.665845-984883129', 07:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:05 INFO - '_': '/tools/buildbot/bin/python'} 07:17:05 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/DwTwkyYqRRy-bs8snkhd8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:17:06 INFO - mozversion application_buildid: 20160922043003 07:17:06 INFO - mozversion application_changeset: f0e6cc6360213ba21fd98c887b55fce5c680df68 07:17:06 INFO - mozversion application_display_name: Nightly 07:17:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:17:06 INFO - mozversion application_name: Firefox 07:17:06 INFO - mozversion application_remotingname: firefox 07:17:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:17:06 INFO - mozversion application_vendor: Mozilla 07:17:06 INFO - mozversion application_version: 52.0a1 07:17:06 INFO - mozversion platform_buildid: 20160922043003 07:17:06 INFO - mozversion platform_changeset: f0e6cc6360213ba21fd98c887b55fce5c680df68 07:17:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:17:06 INFO - mozversion platform_version: 52.0a1 07:17:06 INFO - using testdate: 1474553826 07:17:06 INFO - actual date: 1474553826 07:17:06 INFO - starting webserver on 'localhost:55333' 07:17:06 INFO - SUITE-START | Running 2 tests 07:17:06 INFO - TEST-START | dromaeo_css 07:17:06 INFO - operating with platform_type : linux_ 07:17:06 INFO - Initialising browser for dromaeo_css test... 07:17:06 INFO - TEST-INFO | started process 25159 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr_cl1_/profile http://localhost:55333/getInfo.html) 07:17:10 INFO - PROCESS | 25159 | __metrics Screen width/height:1600/1200 07:17:10 INFO - PROCESS | 25159 | colorDepth:24 07:17:10 INFO - PROCESS | 25159 | Browser inner width/height: 1024/697 07:17:10 INFO - PROCESS | 25159 | __metrics 07:17:11 INFO - PROCESS | 25159 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:17:11 INFO - PROCESS | 25159 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:17:11 INFO - PROCESS | 25159 | console.error: PushService: 07:17:11 INFO - PROCESS | 25159 | stateChangeProcessEnqueue: Error transitioning state 07:17:11 INFO - PROCESS | 25159 | UnknownError 07:17:12 INFO - TEST-INFO | 25159: exit 0 07:17:12 INFO - Browser initialized. 07:17:12 INFO - Running cycle 1/1 for dromaeo_css test... 07:17:12 INFO - TEST-INFO | started process 25242 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr_cl1_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:17:24 INFO - PROCESS | 25242 | RSS: Main: 173621248 07:17:24 INFO - PROCESS | 25242 | 07:18:16 INFO - PROCESS | 25242 | 1474553896027 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:20:25 INFO - PROCESS | 25242 | Cycle 1(1): loaded http://localhost:55333/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55333/tests/dromaeo/cssquery-ext.html) 07:20:26 INFO - PROCESS | 25242 | RSS: Main: 299823104 07:20:26 INFO - PROCESS | 25242 | 07:23:28 INFO - PROCESS | 25242 | Cycle 1(1): loaded http://localhost:55333/tests/dromaeo/cssquery-ext.html (next: http://localhost:55333/tests/dromaeo/cssquery-jquery.html) 07:23:29 INFO - PROCESS | 25242 | RSS: Main: 271294464 07:23:29 INFO - PROCESS | 25242 | 07:26:31 INFO - PROCESS | 25242 | Cycle 1(1): loaded http://localhost:55333/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55333/tests/dromaeo/cssquery-mootools.html) 07:26:32 INFO - PROCESS | 25242 | RSS: Main: 250642432 07:26:32 INFO - PROCESS | 25242 | 07:29:34 INFO - PROCESS | 25242 | Cycle 1(1): loaded http://localhost:55333/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55333/tests/dromaeo/cssquery-prototype.html) 07:29:34 INFO - PROCESS | 25242 | RSS: Main: 251711488 07:29:34 INFO - PROCESS | 25242 | 07:32:37 INFO - PROCESS | 25242 | Cycle 1(1): loaded http://localhost:55333/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55333/tests/dromaeo/cssquery-yui.html) 07:32:38 INFO - PROCESS | 25242 | RSS: Main: 220872704 07:32:38 INFO - PROCESS | 25242 | 07:35:40 INFO - PROCESS | 25242 | Cycle 1(1): loaded http://localhost:55333/tests/dromaeo/cssquery-yui.html (next: http://localhost:55333/tests/dromaeo/cssquery-dojo.html) 07:35:41 INFO - PROCESS | 25242 | RSS: Main: 310685696 07:35:41 INFO - PROCESS | 25242 | 07:35:41 INFO - PROCESS | 25242 | __start_tp_report 07:35:41 INFO - PROCESS | 25242 | _x_x_mozilla_page_load 07:35:41 INFO - PROCESS | 25242 | _x_x_mozilla_page_load_details 07:35:41 INFO - PROCESS | 25242 | |i|pagename|runs| 07:35:41 INFO - PROCESS | 25242 | |0;dojo.html;3014.623172103487;3064.6935306469354;3066.110827859922;3076.9846150769245;3092.4279008383437;5170.1986192140275;5226.5034821691925;5297.973510132453;5344.038073146832;5355.330583677035;5300.151975683892;5304.389995150559;5342.679439233649;5368.033753924292;5369.301990741208;4779.426468823746;4846.5880400166025;4856.830010949618;4870.732109733964;4962.627802914796;4909.533594308535;4927.211646136619;4933.925991110136;4983.6760610560195;5013.298138260647;4750.429948406196;4758.095961767253;4796.544328288807;4831.565159135695;4859.34398856157;4871.220604703266;4871.853844384674;4884.877878053077;4895.9510404895855;4903;4813.494583068762;4845.370101886768;4850.175470170079;4859.659823812334;4863.781129849165;5146.202338637517;5200.115980283361;5237.266782650432;5314.92027619586;5352.545033672142;5588.385277619459;5609.49514543693;5616.634918730269;5627.268455100811;5690.345610254791;5682.801101961411;5691.601587888849;5697.230873832021;5698.088305871041;5698.316202055738;5171.741412929301;5244.475552444801;5251.159814429673;5280.260763493114;5302.496262855023;5817.272840894888;5826.475617194473;5828.154917536934;5829.15477255804;5835.153902684087;5540.279763630702;5542.307211598551;5589.608727389043;5595.608307418442;5602.747876345574;5719.056355701346;5776.913346299809;5785.363610002896;5791.507721843691;5792.420757924258;5641.802536911188;5700.116481945305;5703.657780533182;5706;5709.058005429058;5508.614396992252;5588.0779671354585;5697;5712.257406537124;5712.942870571241;4360.454943132108;4406.625436837905;4406.823727050882;4411.338299255138;4460.063386688832;3917.7061720371084;3924.803759812055;3926.254011737818;3964.1675248197625;3975.4235635832642;5307.893842123136;5398.865028374244;5402.37872644643;5403.621746477787;5406.702631355234;5594.0769772987815;5628.915566266509;5652.604317697722;5700.287464066992;5756.827295181151;5337.572994160458;5349.919751203657;5361.249425080492;5363.892722145535;5367.570594352521;4931.506849315111;4938.234573641092;4948.653594248368;4949.82675606352;5000.649954503223;5739.253896993448;5796.3913789052385;5838.299404071538;5896.557758168069;5912.940870591239;5770.076787713946;5771.278590176228;5771.509421699203;5775.104858746901;5826.679532625746;5920.644761314335;5927.762889484545;5930.05119180929;5931.228940237742;5933.3769954154195;5398.163284690879;5471.72641367938;5483.369412517612;5511.063119269654;5642.915356269741;5663.490285874291;5664.461876121762;5677.403872593318;5705.885882282414;5731.627444216113;5514.724263786715;5517.503424691797;5524.033294173584;5525.171224316224;5526.309211348582;5427.267318911896;5482.643628164156;5486.533644640251;5518.668879867221;5589.301337332833;5200.843974680765;5436.320459942507;5443.482869127427;5498.505134537911;5506.972465137648;5529.253550770755;5531.8893622126525;5564.638298510584;5566.165075238747;5568.916466252928;5342.305500284938;5388.811391601275;5415.918761218506;5472.20653005304;5539.667619942817 07:35:41 INFO - PROCESS | 25242 | |1;ext.html;557.5133323777843;591.8638713095988;596.7463827873155;609.3084349263585;611.004063376696;31142.68857311429;31867.36265274696;34185.65814341862;34218.65781342189;41313.79343103288;39887.800560997224;44105.11789764211;44137.77931110348;44149.55850441495;44295;8962.775930601721;9127.315451341143;9140.680076197334;9143.03998080202;9146.31402644801;8900.910990890105;8989.101089891024;8994.235489983359;8998.955005224965;9002.504862232574;9055.59249833759;9104;9108.089191080871;9114.635414583441;9123.08769123089;8998.100189981014;9020.8646870297;9041.321900857396;9045.909540904573;9050.502222377767;8857.911420885774;8934.151255630704;8945.910540894572;8953.462792232487;8955.552222388855;40046.59953400458;40337.193256135004;40431;40434.39348409776;40693.593064069275;3396.4735466002808;3534.2224710563637;3791.545014598266;3979.781112038837;4025.3961905714086;30844.69155308463;31319.843400783077;31434.685653143406;31891.362172756413;32440.513392299134;4436.64506839452;4526.841560545365;4531;4534.161180181677;4537.500874903758;341174;343221.2838935814;343538;343703;343707;47405.5259447408;48803;54624;55234.171487427724;55644.16533751997;55784.442155578734;56939.14591281134;56958.14562781562;61425.38574614197;61471.385286146564;16376.918115409586;16691.666166676598;16692.916535417487;16698.24857881374;16702.58243543921;12513.874861251454;12571.622851314476;12622.431990560446;12634.81047784284;12637.93681031589;14230.928845355915;14497.158253062948;15331;15735.606609834846;15944.920275398548;5626.381098079208;5798.88402231953;5837.182794408786;5838.854028649318;5893.6463812171405;896.3994123936978;985.9556319965619;990.1089019882164;1005.2109094360892;1041.557338131291;30065.549016764766;31204.531932021036;31381;31960.680393196235;32663.83668081692;1033.7777377863795;1058.9682309530572;1120.1486869978712;1142.731458107344;1149.8850114988434;15689.293981770848;16375.344986200656;16418.67162656764;16560.420385286456;16599.50201493957;535935;537075;539349;539592;540300;55491.72254138784;55564.72217638886;55653.72173139108;55679.71042750932;55715.721421392635;1302.1340808362334;1327.8937684985178;1337.5452346202144;1375.0099928051786;1381.599336192493;28848.567271491363;30174.698253017188;30228.69771302259;30499.390012200074;30856;48374.51625483841;48812.75593622151;48894.51105489042;48930;48967;342426;343092;343291;344127;344324;24448.51102977966;25077.74922250827;25083;27216.591751124146;27548.58677119885;37756.62243377531;39288.6426814392;40453.79773101116;47208.29187562121;49641;38244.23511529698;38685.80657096697;38756;40542.39186412147;40901.1819763609;39489.40765888571;39656.801715991234;40422.79788601038;41309.58690413057;41316.586834132475;39293.41059884047;39565.40651890282;39760.80119599384;39824;40140.78521755174;33666;35971.82014089913;36429.08927276839;36928;36989;27308.726912730617;27665.308367290978;27678;27808.721912781424;27990.860045699643 07:35:41 INFO - PROCESS | 25242 | |2;jquery.html;370.1191165027235;400.3334448143842;404.3066141567212;407.96532294754945;418.48735299258414;13201.405936732846;14924.626884327898;19568.90215548924;19569.41291761246;20405.183792648277;18414;18801.43595692128;18815.05924703763;18910.243590256407;18950.62098758024;4540.136901057872;5550.333959924815;5757.856053598652;5758.568107391941;5762.308522977249;4128.236276288896;4324.286492728712;5707.1153971134545;5710.571707121982;5743.224664670279;6093.146959425684;6355.523335749815;6363.586366886161;6442.48460123189;6480.060391243267;6201.90697139541;6235.688215589225;6334.081558174039;6347.460465860408;6456.031595260702;5621.353544342372;5624.3250809903075;5630.493255606974;5630.549556035548;5631.831045068655;22129;22654.546909061726;22711;22786.98686289014;22787;2238.160689741347;2288.622377307742;2361.6457531370434;2468.6543883856275;2847.0604700449007;14007.929960350235;14384.208868512227;14682.751966082897;15046.645801877883;15060.246987650573;1864.822841830024;1875.1280654495724;1890.8770929889652;1928.9421317360361;1961.2449207055245;80731.19268807354;83158;83775.5811220946;83983;85899;10284.125849302893;10333.896661033294;10483.790324193626;10688.893111068945;10697.358158510515;15053.548393548212;15056.698866022618;15060.849391506164;15069.17119558413;15070.698586028218;7723.150453450116;7759.107702614158;8083.353331733447;8208.794780130545;8218.589070546448;7722.498037627536;7755.7324227905265;7758.7672369829;7786.532808031537;7945.523268603903;6190.226221722285;6291.476773007131;6327.810165695037;6407.583507072025;6446.774362897276;1702.5913780692545;1803.9610837462653;1896.7818700849302;1912.4645099372199;1943.2906988948932;821.5850995247362;895.9820803583892;941.2611100286242;949.781550243434;956.0582825916466;18958.24167033303;19451;19538.218471261276;19576.587795765878;19765.802341976683;969.1519920069939;982.4400091947664;1025.600015993763;1038.0709265207597;1062.5059347403494;9533.952330238304;11065.557377704801;11078.169137314733;11150.219484635998;11168.162387820947;439209;449536;475930;476099;477877;49728.25407618889;50472.747636261585;51283.74358128185;60528.39471605315;86909.52902300154;905.2622112977901;945.3288165402641;1044.6709286574705;1059.327327147267;1065.8081545321916;15661.37354505807;16529.83470165331;17571.648567028842;17863.553411164823;17897.910510447364;40743;41464;41797.79101104475;42112.789436052626;42443.7877810609;52263.47736522738;52324.21513677374;54048.18927716166;56307.71846140743;58048;8249.83500329978;8288.50268983863;8450.450720703135;8512.446690965067;8880.245179159843;13062.150960187557;13083.41124649412;13181.275029873448;13218.405171767487;13294.867051329364;8804.962452504571;10131;11104.111671066134;11513.712157195801;11518.654440366803;6742.359475849787;11122.277051991594;11211.383373914186;11645.88354116482;11721.12091593151;11312.94343528277;11620.244684095507;12089.81865272004;12378.938105309417;12525.624231273076;8181.5500147490075;8373.455725377831;8438.704645337384;8607.063410732535;8773.29813614922;10788.676339709822;10992.560297588007;11181.273217240854;11185.217034807485;11249.21255512139 07:35:41 INFO - PROCESS | 25242 | |3;mootools.html;1448.3337664674252;1492.3284521965115;1608.3245037084423;1742.5120966129489;1758.1472985601981;8225.58872056397;8849.424787388814;8852.822943541125;8856.247218986395;8861.46831190129;7714.190010048948;7998.600069996506;8217.424780265368;8487.618057187427;8723.084076172006;2283.977160228393;2308.4344335637707;2310.976890231093;2311.641695537186;2320.1299512682745;2193.024104273599;2216.3240211735415;2224.855384400017;2244.6969659095976;2259.830512711545;2226.815980329458;2243.4839986803045;2247.7077979862597;2322.4658328584437;2325.2791634593245;2200.7799220078023;2205.757366689671;2206.2278202629113;2210.4142402263415;2213.756486786444;2201.2075652764993;2220.544788318391;2231.9330420087263;2259.2770313499686;2265.173211777689;8722.607482663296;8763.649454021832;8765.517896515752;8778.429402088845;8778.56107194644;5075.5939524838295;5190.039842629126;5206.24509446132;5207.817726379596;5212.348456442945;3322;3376.7805092668896;3475.1078791753143;3488.8953331399844;3499.7550171488006;1076.4133547216786;1096.780643871221;1097.9890201098046;1111.4831603304501;1143.2511704833348;12044.096692747991;12151.513939442411;12152.57465988686;12159.696007599792;12163.20939138962;4398.780060996937;4503.864884053483;4629.166749984967;4713.3872596562915;4741.051789642085;10198.031187037219;10202.38785672862;10218.335808172445;10222.693319200436;10224.948875255575;5241.580673546107;5283.550898173698;5283.682979021271;5283.920741188886;5285.814996475182;4180.707350485437;4328.935065974013;4654.488006319302;4755.072760811678;4842.5157484251295;3850.3828392075397;3875.8255878485534;3959.3269144245546;3967.26605577969;3979.243943650697;1281.3529167770216;1281.4617860498613;1285.6271681212531;1292.424870932445;1305.3603734170188;958;971.5288085278776;972.9513524323755;976.7069879036261;996.3324572536418;5776.42235776419;5890.617109887844;5960.791372302036;5967.492763115097;6047.998882586798;439.1524357989048;447.9776011199427;452.53389009320455;457.9519150489217;461.9422572178478;4089.652379547772;4128.896777580585;4143.482064741907;4147.398627199039;4183.832646694159;10442.164626829835;10647.733806654896;10730.785384292427;10769.83845242322;10801.729956751144;10683.572657093784;10692.518836652369;10694.679159625224;10699.411532365639;10710.785784284271;7527.623618819037;7887.84224315499;7892.802679932933;8011.919880801117;8099.433039687166;5916.001956693175;5916.467517923235;6052.818415447544;6120.908186377119;6176.629402235881;9861.654842080492;9886.752831179278;9905.653302134391;9907.801843962936;10011.649592264235;9916.702498925044;9986.650467233612;9999.100080992746;10136.18910487174;10198.082172604205;6843.897341539781;7049.647517624201;7238.0952380952385;7559.848803024019;7743.45795794289;8192.18078192176;8441.409101362846;8459.788505287417;8467.364947629076;8474.491530508189;7224.711011559479;7256.818579535343;7331.963340183265;7367.115946086504;7586.696532138652;7119.5372300802355;7133.072700548895;7135.500514963903;7306.050213472215;7328.2305357938785;6661.800145995628;6682.9331706682315;6714;6718.462522998051;6722.495812814156;4963.255511673134;5170.48295170495;5218.765155567932;5249.186376111708;5287.52412282881;4866.221404575251;4871.244957031666;4877.3903262092235;4951.9752401237765;5085.110105731408 07:35:41 INFO - PROCESS | 25242 | |4;prototype.html;332.4381794766844;334.12959241176736;340.5708806903301;344.3663658867684;349.82159098859574;5188.688678679282;5310.07073762092;5349.5720342372615;5398.48714372135;5425.864353391163;5130.410002849673;5218.921716174261;5249.4750524947585;5267.630416091815;5284.260203571494;4184.665226781865;4194.433751443562;4205.5794420558;4218.59923307286;4226.654206915161;3918.9804050979847;4153.8161623937185;4209.768462734548;4212.747235165884;4227.365895115742;4096.73371230869;4104.651104656108;4113.4858142732155;4122.196171746511;4138.1103062841485;4071.1705364771497;4079.938800917989;4093.9795301023305;4113.938290925638;4116.670666346685;3678.558572971234;3678.70570354371;3679.8344074516713;3696.796676182809;3705.40713485841;5068.898622027539;5093.1850903855575;5101.82143624975;5119.3088932994315;5167.6641018333685;4682.836100736458;4705.482396936334;4726.810927562893;4737;4748.145333839908;5314.51172000057;5417.8103766367985;5459.235707001023;5483.506484416422;5540.36285827131;3850.5764365919727;3867.7872717000555;3881.126746482047;3890.9027274318087;3893.4743809585625;5725.914111288334;5764.394738552475;5767.942320576824;5782.884342313172;5786.623869448515;4134.462519872457;4139.586041395896;4155.958440415558;4173.916521669549;4181.91636167281;3931.744436611611;4150.481189851269;4153.937690934638;4171.770552619635;4207.431996680409;4716.457607375127;4727.716337019721;4728.834490792806;4731.124741922756;4760.785764640599;5576.581756368289;5584.4921871094575;5604.859878502988;5635.464630860144;5651.519620832193;1310.3382791690135;1338.9129706569042;1368.6988862450246;1386.3137746815391;1387.126110550367;886.3308202307346;896.8878890138733;897.8922529296395;907.5643691028343;907.8774365460711;4750.8337208197545;4755.408302475159;4756.262779269219;4793.688410253322;4808.158572249842;5003.874903127451;5025.537486631524;5026.868954485211;5045.823396181189;5049.8737531562;4472.674209411153;4675.275332323496;4715;4720.669553131248;4734.384530011076;2608.491344187903;2636.709961904189;2638.643783089297;2657.4153686189006;2672.2116975492277;5075.8984820303385;5117.437081920985;5127.07712611726;5132.508216208621;5162.199859021783;4838.153323168432;4970.2793095001025;5057.797688092435;5074.847754567369;5075.771590278447;5128.3845938486875;5128.410232823273;5136.845894623242;5146.511081447256;5155.664881782672;4946.653734238569;4955.306257124078;4964.180910149785;4994.9500504994485;5017.623678224075;4711.81152753886;4949.604031677529;4949.871555231285;4951.425258865442;4962.702237865739;5123.5388815005335;5140.228965655182;5168.793248270027;5169.974150129376;5172.431032586337;3725.5097960814805;3741.428599987957;3746.3443897318407;3748.34403979308;3750.868719594801;4673.906521869611;4938.654294199371;4969.751512424436;5016.974915125547;5019.949800502094;4861.562459378673;4866.9269960949905;4868.878278043077;4883.487233840396;4885.65800393969;4793.688410253322;4843.443004054438;4848.806047758191;4851.781669824937;4854.247591623304;4443.555644435531;4742.928856067231;4801.879953001203;4815.627546149331;4866.197077482176;4854.78153483087;4860.857698440935;4880.316755654282;4884.633652476007;4906.386701662293;4756.738379389167;4784.512053732109;4789.568938795525;4790.257510085942;4793.976030119967 07:35:41 INFO - PROCESS | 25242 | |5;yui.html;725.2529894208964;727.2545640718263;767.6737386610689;780.7501599488164;789.6209819286743;13866.514671986482;14900.180490073042;14927.92536037321;14940.850591494082;14950.327235274412;13136.408861601227;13137.67155821105;13187.208767473958;13207.207567545955;13256.403461844217;644.0693198328394;660.1319265166314;771.463832636318;778.1246098139593;798.1459837973342;799.360511590728;800.4276941986478;800.9759707208764;803.3733687723585;809.1625167951172;839.1692224697535;839.7396806989822;839.9916000840005;840.1094839470151;840.277361469136;662.9303923088103;834.3241974001048;834.8872902158191;834.9582520873932;835.4277320035765;509.85469141294925;593.2110293309887;607.6384551192034;612.0513204533;613.9662318572476;12988.090833641649;13002.089853710244;13020.544280950122;13021.934890325489;13028.348582570834;12891.806622900664;13037.41331640069;13812.723745525032;14002.719945601031;14160.672242023116;12500.874991250063;12596.68508287291;12649;12700.237985720887;12827.358632068452;4418.924351231033;4426.490953540352;4451.109778044404;4491;4567.086582683477;81236;81317.78023329595;84508;85125.99999999937;87217.56391218067;9957.601695932082;10103.292769506064;10151.7462063449;10160.288779785493;10350.275480716427;20733.792662073487;20776.376708698765;20850.791492085187;20876.47808804792;20884;7761.5731134787;7908.802279942933;8152.6331315090965;8391.916080839235;8655.78360540979;4349.521552629209;4551.431071116111;4585.578470674035;4632.5135860734135;4660.161170989187;3383.323335332894;3518.4722291655944;3521.102118959649;3521.4013617685055;3525.629808870083;606.8513214262446;608.5162295974711;614.5513774944226;627.159606127791;636.1062706896818;634.8476365672205;638.1958731997623;660.5475249454139;698.434268242725;707.5860621536356;8650.6972255972;8983.416077955042;9152.581008022846;9288.628454861864;9396.342256042148;672.4317951331118;672.8788818012805;679.4700133895569;683.282553319013;702.2626242445411;4512.323151527297;4559.817607295671;4569.95430045702;4576.153411618861;4688.859334219979;123836.52043494563;126283;126709.36645316899;126965.36517317539;129996;111854;112093.43953280181;112197.43901280442;113349;117530.41234793772;73569.63215183996;75336.24663753292;94490;97688;98907;9347.719568412958;9556.713298601053;9691.466969316756;9881.802363952824;10214.336068155546;37468.81265593655;40746;49764.502354975986;50689;52048.47951520588;63296;75002.9998800042;75826.24173758192;78490.26420376525;80241.59879200567;12981.480740770641;13313.866861331262;13315.26766027839;13461.932690336485;13741.519046833313;14833.406663733329;14853;14957.850421495647;15003.174825384709;15133.167675777939;11759.235649682743;11946.522139114339;13501.662458438617;13563.86436135626;14027.36876840565;14059.367328470447;14075.788863167265;14200.857991419953;14367.497137600134;14504.492342767953;13219.471221151047;13697.863021369658;14158.929205353907;14419.639509012359;14585.635359115682;10874.401907895142;11462.828057578976;11789.174757766874;12000.456555290182;12112.515499380279;9558.28312876551;10819.621313253998;11442;11817.763644727229;12314.50741970347 07:35:41 INFO - PROCESS | 25242 | __end_tp_report 07:35:41 INFO - PROCESS | 25242 | __start_cc_report 07:35:41 INFO - PROCESS | 25242 | _x_x_mozilla_cycle_collect,992 07:35:41 INFO - PROCESS | 25242 | __end_cc_report 07:35:41 INFO - PROCESS | 25242 | __startTimestamp1474554941236__endTimestamp 07:35:41 INFO - PROCESS | 25242 | 07:35:41 INFO - PROCESS | 25242 | ------- Summary: start ------- 07:35:41 INFO - PROCESS | 25242 | Number of tests: 6 07:35:41 INFO - PROCESS | 25242 | 07:35:41 INFO - PROCESS | 25242 | [#0] dojo.html Cycles:165 Average:5279.70 Median:5443.48 stddev:587.28 (10.8%) stddev-sans-first:561.56 07:35:41 INFO - PROCESS | 25242 | Values: 3014.6 3064.7 3066.1 3077.0 3092.4 5170.2 5226.5 5298.0 5344.0 5355.3 5300.2 5304.4 5342.7 5368.0 5369.3 4779.4 4846.6 4856.8 4870.7 4962.6 4909.5 4927.2 4933.9 4983.7 5013.3 4750.4 4758.1 4796.5 4831.6 4859.3 4871.2 4871.9 4884.9 4896.0 4903.0 4813.5 4845.4 4850.2 4859.7 4863.8 5146.2 5200.1 5237.3 5314.9 5352.5 5588.4 5609.5 5616.6 5627.3 5690.3 5682.8 5691.6 5697.2 5698.1 5698.3 5171.7 5244.5 5251.2 5280.3 5302.5 5817.3 5826.5 5828.2 5829.2 5835.2 5540.3 5542.3 5589.6 5595.6 5602.7 5719.1 5776.9 5785.4 5791.5 5792.4 5641.8 5700.1 5703.7 5706.0 5709.1 5508.6 5588.1 5697.0 5712.3 5712.9 4360.5 4406.6 4406.8 4411.3 4460.1 3917.7 3924.8 3926.3 3964.2 3975.4 5307.9 5398.9 5402.4 5403.6 5406.7 5594.1 5628.9 5652.6 5700.3 5756.8 5337.6 5349.9 5361.2 5363.9 5367.6 4931.5 4938.2 4948.7 4949.8 5000.6 5739.3 5796.4 5838.3 5896.6 5912.9 5770.1 5771.3 5771.5 5775.1 5826.7 5920.6 5927.8 5930.1 5931.2 5933.4 5398.2 5471.7 5483.4 5511.1 5642.9 5663.5 5664.5 5677.4 5705.9 5731.6 5514.7 5517.5 5524.0 5525.2 5526.3 5427.3 5482.6 5486.5 5518.7 5589.3 5200.8 5436.3 5443.5 5498.5 5507.0 5529.3 5531.9 5564.6 5566.2 5568.9 5342.3 5388.8 5415.9 5472.2 5539.7 07:35:41 INFO - PROCESS | 25242 | 07:35:41 INFO - PROCESS | 25242 | [#1] ext.html Cycles:180 Average:56322.22 Median:39855.90 stddev:111043.12 (278.6%) stddev-sans-first:111275.69 07:35:41 INFO - PROCESS | 25242 | Values: 557.5 591.9 596.7 609.3 611.0 31142.7 31867.4 34185.7 34218.7 41313.8 39887.8 44105.1 44137.8 44149.6 44295.0 8962.8 9127.3 9140.7 9143.0 9146.3 8900.9 8989.1 8994.2 8999.0 9002.5 9055.6 9104.0 9108.1 9114.6 9123.1 8998.1 9020.9 9041.3 9045.9 9050.5 8857.9 8934.2 8945.9 8953.5 8955.6 40046.6 40337.2 40431.0 40434.4 40693.6 3396.5 3534.2 3791.5 3979.8 4025.4 30844.7 31319.8 31434.7 31891.4 32440.5 4436.6 4526.8 4531.0 4534.2 4537.5 341174.0 343221.3 343538.0 343703.0 343707.0 47405.5 48803.0 54624.0 55234.2 55644.2 55784.4 56939.1 56958.1 61425.4 61471.4 16376.9 16691.7 16692.9 16698.2 16702.6 12513.9 12571.6 12622.4 12634.8 12637.9 14230.9 14497.2 15331.0 15735.6 15944.9 5626.4 5798.9 5837.2 5838.9 5893.6 896.4 986.0 990.1 1005.2 1041.6 30065.5 31204.5 31381.0 31960.7 32663.8 1033.8 1059.0 1120.1 1142.7 1149.9 15689.3 16375.3 16418.7 16560.4 16599.5 535935.0 537075.0 539349.0 539592.0 540300.0 55491.7 55564.7 55653.7 55679.7 55715.7 1302.1 1327.9 1337.5 1375.0 1381.6 28848.6 30174.7 30228.7 30499.4 30856.0 48374.5 48812.8 48894.5 48930.0 48967.0 342426.0 343092.0 343291.0 344127.0 344324.0 24448.5 25077.7 25083.0 27216.6 27548.6 37756.6 39288.6 40453.8 47208.3 49641.0 38244.2 38685.8 38756.0 40542.4 40901.2 39489.4 39656.8 40422.8 41309.6 41316.6 39293.4 39565.4 39760.8 39824.0 40140.8 33666.0 35971.8 36429.1 36928.0 36989.0 27308.7 27665.3 27678.0 27808.7 27990.9 07:35:41 INFO - PROCESS | 25242 | 07:35:41 INFO - PROCESS | 25242 | [#2] jquery.html Cycles:180 Average:27351.30 Median:406.14 stddev:76138.13 (18747.0%) stddev-sans-first:76324.77 07:35:41 INFO - PROCESS | 25242 | Values: 370.1 400.3 404.3 408.0 418.5 13201.4 14924.6 19568.9 19569.4 20405.2 18414.0 18801.4 18815.1 18910.2 18950.6 4540.1 5550.3 5757.9 5758.6 5762.3 4128.2 4324.3 5707.1 5710.6 5743.2 6093.1 6355.5 6363.6 6442.5 6480.1 6201.9 6235.7 6334.1 6347.5 6456.0 5621.4 5624.3 5630.5 5630.5 5631.8 22129.0 22654.5 22711.0 22787.0 22787.0 2238.2 2288.6 2361.6 2468.7 2847.1 14007.9 14384.2 14682.8 15046.6 15060.2 1864.8 1875.1 1890.9 1928.9 1961.2 80731.2 83158.0 83775.6 83983.0 85899.0 10284.1 10333.9 10483.8 10688.9 10697.4 15053.5 15056.7 15060.8 15069.2 15070.7 7723.2 7759.1 8083.4 8208.8 8218.6 7722.5 7755.7 7758.8 7786.5 7945.5 6190.2 6291.5 6327.8 6407.6 6446.8 1702.6 1804.0 1896.8 1912.5 1943.3 821.6 896.0 941.3 949.8 956.1 18958.2 19451.0 19538.2 19576.6 19765.8 969.2 982.4 1025.6 1038.1 1062.5 9534.0 11065.6 11078.2 11150.2 11168.2 439209.0 449536.0 475930.0 476099.0 477877.0 49728.3 50472.7 51283.7 60528.4 86909.5 905.3 945.3 1044.7 1059.3 1065.8 15661.4 16529.8 17571.6 17863.6 17897.9 40743.0 41464.0 41797.8 42112.8 42443.8 52263.5 52324.2 54048.2 56307.7 58048.0 8249.8 8288.5 8450.5 8512.4 8880.2 13062.2 13083.4 13181.3 13218.4 13294.9 8805.0 10131.0 11104.1 11513.7 11518.7 6742.4 11122.3 11211.4 11645.9 11721.1 11312.9 11620.2 12089.8 12378.9 12525.6 8181.6 8373.5 8438.7 8607.1 8773.3 10788.7 10992.6 11181.3 11185.2 11249.2 07:35:41 INFO - PROCESS | 25242 | 07:35:41 INFO - PROCESS | 25242 | [#3] mootools.html Cycles:180 Average:5669.34 Median:4748.06 stddev:3239.39 (68.2%) stddev-sans-first:3232.95 07:35:41 INFO - PROCESS | 25242 | Values: 1448.3 1492.3 1608.3 1742.5 1758.1 8225.6 8849.4 8852.8 8856.2 8861.5 7714.2 7998.6 8217.4 8487.6 8723.1 2284.0 2308.4 2311.0 2311.6 2320.1 2193.0 2216.3 2224.9 2244.7 2259.8 2226.8 2243.5 2247.7 2322.5 2325.3 2200.8 2205.8 2206.2 2210.4 2213.8 2201.2 2220.5 2231.9 2259.3 2265.2 8722.6 8763.6 8765.5 8778.4 8778.6 5075.6 5190.0 5206.2 5207.8 5212.3 3322.0 3376.8 3475.1 3488.9 3499.8 1076.4 1096.8 1098.0 1111.5 1143.3 12044.1 12151.5 12152.6 12159.7 12163.2 4398.8 4503.9 4629.2 4713.4 4741.1 10198.0 10202.4 10218.3 10222.7 10224.9 5241.6 5283.6 5283.7 5283.9 5285.8 4180.7 4328.9 4654.5 4755.1 4842.5 3850.4 3875.8 3959.3 3967.3 3979.2 1281.4 1281.5 1285.6 1292.4 1305.4 958.0 971.5 973.0 976.7 996.3 5776.4 5890.6 5960.8 5967.5 6048.0 439.2 448.0 452.5 458.0 461.9 4089.7 4128.9 4143.5 4147.4 4183.8 10442.2 10647.7 10730.8 10769.8 10801.7 10683.6 10692.5 10694.7 10699.4 10710.8 7527.6 7887.8 7892.8 8011.9 8099.4 5916.0 5916.5 6052.8 6120.9 6176.6 9861.7 9886.8 9905.7 9907.8 10011.6 9916.7 9986.7 9999.1 10136.2 10198.1 6843.9 7049.6 7238.1 7559.8 7743.5 8192.2 8441.4 8459.8 8467.4 8474.5 7224.7 7256.8 7332.0 7367.1 7586.7 7119.5 7133.1 7135.5 7306.1 7328.2 6661.8 6682.9 6714.0 6718.5 6722.5 4963.3 5170.5 5218.8 5249.2 5287.5 4866.2 4871.2 4877.4 4952.0 5085.1 07:35:41 INFO - PROCESS | 25242 | 07:35:41 INFO - PROCESS | 25242 | [#4] prototype.html Cycles:180 Average:4364.83 Median:4811.89 stddev:1226.38 (25.5%) stddev-sans-first:1191.89 07:35:41 INFO - PROCESS | 25242 | Values: 332.4 334.1 340.6 344.4 349.8 5188.7 5310.1 5349.6 5398.5 5425.9 5130.4 5218.9 5249.5 5267.6 5284.3 4184.7 4194.4 4205.6 4218.6 4226.7 3919.0 4153.8 4209.8 4212.7 4227.4 4096.7 4104.7 4113.5 4122.2 4138.1 4071.2 4079.9 4094.0 4113.9 4116.7 3678.6 3678.7 3679.8 3696.8 3705.4 5068.9 5093.2 5101.8 5119.3 5167.7 4682.8 4705.5 4726.8 4737.0 4748.1 5314.5 5417.8 5459.2 5483.5 5540.4 3850.6 3867.8 3881.1 3890.9 3893.5 5725.9 5764.4 5767.9 5782.9 5786.6 4134.5 4139.6 4156.0 4173.9 4181.9 3931.7 4150.5 4153.9 4171.8 4207.4 4716.5 4727.7 4728.8 4731.1 4760.8 5576.6 5584.5 5604.9 5635.5 5651.5 1310.3 1338.9 1368.7 1386.3 1387.1 886.3 896.9 897.9 907.6 907.9 4750.8 4755.4 4756.3 4793.7 4808.2 5003.9 5025.5 5026.9 5045.8 5049.9 4472.7 4675.3 4715.0 4720.7 4734.4 2608.5 2636.7 2638.6 2657.4 2672.2 5075.9 5117.4 5127.1 5132.5 5162.2 4838.2 4970.3 5057.8 5074.8 5075.8 5128.4 5128.4 5136.8 5146.5 5155.7 4946.7 4955.3 4964.2 4995.0 5017.6 4711.8 4949.6 4949.9 4951.4 4962.7 5123.5 5140.2 5168.8 5170.0 5172.4 3725.5 3741.4 3746.3 3748.3 3750.9 4673.9 4938.7 4969.8 5017.0 5019.9 4861.6 4866.9 4868.9 4883.5 4885.7 4793.7 4843.4 4848.8 4851.8 4854.2 4443.6 4742.9 4801.9 4815.6 4866.2 4854.8 4860.9 4880.3 4884.6 4906.4 4756.7 4784.5 4789.6 4790.3 4794.0 07:35:41 INFO - PROCESS | 25242 | 07:35:41 INFO - PROCESS | 25242 | [#5] yui.html Cycles:180 Average:21495.76 Median:4501.66 stddev:32566.80 (723.4%) stddev-sans-first:32620.82 07:35:41 INFO - PROCESS | 25242 | Values: 725.3 727.3 767.7 780.8 789.6 13866.5 14900.2 14927.9 14940.9 14950.3 13136.4 13137.7 13187.2 13207.2 13256.4 644.1 660.1 771.5 778.1 798.1 799.4 800.4 801.0 803.4 809.2 839.2 839.7 840.0 840.1 840.3 662.9 834.3 834.9 835.0 835.4 509.9 593.2 607.6 612.1 614.0 12988.1 13002.1 13020.5 13021.9 13028.3 12891.8 13037.4 13812.7 14002.7 14160.7 12500.9 12596.7 12649.0 12700.2 12827.4 4418.9 4426.5 4451.1 4491.0 4567.1 81236.0 81317.8 84508.0 85126.0 87217.6 9957.6 10103.3 10151.7 10160.3 10350.3 20733.8 20776.4 20850.8 20876.5 20884.0 7761.6 7908.8 8152.6 8391.9 8655.8 4349.5 4551.4 4585.6 4632.5 4660.2 3383.3 3518.5 3521.1 3521.4 3525.6 606.9 608.5 614.6 627.2 636.1 634.8 638.2 660.5 698.4 707.6 8650.7 8983.4 9152.6 9288.6 9396.3 672.4 672.9 679.5 683.3 702.3 4512.3 4559.8 4570.0 4576.2 4688.9 123836.5 126283.0 126709.4 126965.4 129996.0 111854.0 112093.4 112197.4 113349.0 117530.4 73569.6 75336.2 94490.0 97688.0 98907.0 9347.7 9556.7 9691.5 9881.8 10214.3 37468.8 40746.0 49764.5 50689.0 52048.5 63296.0 75003.0 75826.2 78490.3 80241.6 12981.5 13313.9 13315.3 13461.9 13741.5 14833.4 14853.0 14957.9 15003.2 15133.2 11759.2 11946.5 13501.7 13563.9 14027.4 14059.4 14075.8 14200.9 14367.5 14504.5 13219.5 13697.9 14158.9 14419.6 14585.6 10874.4 11462.8 11789.2 12000.5 12112.5 9558.3 10819.6 11442.0 11817.8 12314.5 07:35:41 INFO - PROCESS | 25242 | -------- Summary: end -------- 07:35:41 INFO - PROCESS | 25242 | 07:35:42 INFO - TEST-INFO | 25242: exit 0 07:35:42 INFO - TEST-OK | dromaeo_css | took 1116151ms 07:35:42 INFO - TEST-START | kraken 07:35:42 INFO - operating with platform_type : linux_ 07:35:42 INFO - Initialising browser for kraken test... 07:35:42 INFO - TEST-INFO | started process 25591 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4Xy2dI/profile http://localhost:55333/getInfo.html) 07:35:46 INFO - PROCESS | 25591 | __metrics Screen width/height:1600/1200 07:35:46 INFO - PROCESS | 25591 | colorDepth:24 07:35:46 INFO - PROCESS | 25591 | Browser inner width/height: 1024/697 07:35:46 INFO - PROCESS | 25591 | __metrics 07:35:47 INFO - PROCESS | 25591 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:35:47 INFO - PROCESS | 25591 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:35:47 INFO - PROCESS | 25591 | console.error: PushService: 07:35:47 INFO - PROCESS | 25591 | stateChangeProcessEnqueue: Error transitioning state 07:35:47 INFO - PROCESS | 25591 | UnknownError 07:35:48 INFO - TEST-INFO | 25591: exit 0 07:35:48 INFO - Browser initialized. 07:35:48 INFO - Running cycle 1/1 for kraken test... 07:35:48 INFO - TEST-INFO | started process 25674 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4Xy2dI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:36:00 INFO - PROCESS | 25674 | RSS: Main: 173764608 07:36:00 INFO - PROCESS | 25674 | 07:36:03 INFO - PROCESS | 25674 | Cycle 1(1): loaded http://localhost:55333/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55333/tests/kraken/driver.html?testName=audio-beat-detection) 07:36:03 INFO - PROCESS | 25674 | RSS: Main: 236376064 07:36:03 INFO - PROCESS | 25674 | 07:36:06 INFO - PROCESS | 25674 | Cycle 1(1): loaded http://localhost:55333/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55333/tests/kraken/driver.html?testName=audio-dft) 07:36:07 INFO - PROCESS | 25674 | RSS: Main: 217198592 07:36:07 INFO - PROCESS | 25674 | 07:36:10 INFO - PROCESS | 25674 | Cycle 1(1): loaded http://localhost:55333/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55333/tests/kraken/driver.html?testName=audio-fft) 07:36:10 INFO - PROCESS | 25674 | RSS: Main: 298770432 07:36:10 INFO - PROCESS | 25674 | 07:36:13 INFO - PROCESS | 25674 | Cycle 1(1): loaded http://localhost:55333/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55333/tests/kraken/driver.html?testName=audio-oscillator) 07:36:13 INFO - PROCESS | 25674 | RSS: Main: 207433728 07:36:13 INFO - PROCESS | 25674 | 07:36:15 INFO - PROCESS | 25674 | Cycle 1(1): loaded http://localhost:55333/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55333/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:36:16 INFO - PROCESS | 25674 | RSS: Main: 212733952 07:36:16 INFO - PROCESS | 25674 | 07:36:19 INFO - PROCESS | 25674 | Cycle 1(1): loaded http://localhost:55333/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55333/tests/kraken/driver.html?testName=imaging-darkroom) 07:36:20 INFO - PROCESS | 25674 | RSS: Main: 249065472 07:36:20 INFO - PROCESS | 25674 | 07:36:23 INFO - PROCESS | 25674 | Cycle 1(1): loaded http://localhost:55333/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55333/tests/kraken/driver.html?testName=imaging-desaturate) 07:36:24 INFO - PROCESS | 25674 | RSS: Main: 248717312 07:36:24 INFO - PROCESS | 25674 | 07:36:26 INFO - PROCESS | 25674 | Cycle 1(1): loaded http://localhost:55333/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55333/tests/kraken/driver.html?testName=json-parse-financial) 07:36:27 INFO - PROCESS | 25674 | RSS: Main: 248311808 07:36:27 INFO - PROCESS | 25674 | 07:36:29 INFO - PROCESS | 25674 | Cycle 1(1): loaded http://localhost:55333/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55333/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:36:29 INFO - PROCESS | 25674 | RSS: Main: 210444288 07:36:29 INFO - PROCESS | 25674 | 07:36:31 INFO - PROCESS | 25674 | Cycle 1(1): loaded http://localhost:55333/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55333/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:36:31 INFO - PROCESS | 25674 | RSS: Main: 217612288 07:36:31 INFO - PROCESS | 25674 | 07:36:34 INFO - PROCESS | 25674 | Cycle 1(1): loaded http://localhost:55333/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55333/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:36:34 INFO - PROCESS | 25674 | RSS: Main: 222760960 07:36:34 INFO - PROCESS | 25674 | 07:36:37 INFO - PROCESS | 25674 | Cycle 1(1): loaded http://localhost:55333/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55333/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:36:37 INFO - PROCESS | 25674 | RSS: Main: 223723520 07:36:37 INFO - PROCESS | 25674 | 07:36:40 INFO - PROCESS | 25674 | Cycle 1(1): loaded http://localhost:55333/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55333/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:36:41 INFO - PROCESS | 25674 | RSS: Main: 221396992 07:36:41 INFO - PROCESS | 25674 | 07:36:43 INFO - PROCESS | 25674 | Cycle 1(1): loaded http://localhost:55333/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55333/tests/kraken/driver.html?testName=ai-astar) 07:36:43 INFO - PROCESS | 25674 | RSS: Main: 272392192 07:36:43 INFO - PROCESS | 25674 | 07:36:43 INFO - PROCESS | 25674 | __start_tp_report 07:36:43 INFO - PROCESS | 25674 | _x_x_mozilla_page_load 07:36:43 INFO - PROCESS | 25674 | _x_x_mozilla_page_load_details 07:36:43 INFO - PROCESS | 25674 | |i|pagename|runs| 07:36:43 INFO - PROCESS | 25674 | |0;ai-astar;110;110;109;110;112;112;111;113;110;112 07:36:43 INFO - PROCESS | 25674 | |1;audio-beat-detection;141;117;122;160;119;123;125;123;159;120 07:36:43 INFO - PROCESS | 25674 | |2;audio-dft;162;162;163;163;163;161;162;162;160;161 07:36:43 INFO - PROCESS | 25674 | |3;audio-fft;75;75;76;107;75;76;77;75;101;77 07:36:43 INFO - PROCESS | 25674 | |4;audio-oscillator;84;83;126;83;83;82;113;82;83;118 07:36:43 INFO - PROCESS | 25674 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;117;118 07:36:43 INFO - PROCESS | 25674 | |6;imaging-darkroom;146;146;145;145;146;145;146;146;145;144 07:36:43 INFO - PROCESS | 25674 | |7;imaging-desaturate;95;95;95;95;95;96;95;95;95;95 07:36:43 INFO - PROCESS | 25674 | |8;json-parse-financial;52;51;50;52;51;52;51;52;51;52 07:36:43 INFO - PROCESS | 25674 | |9;json-stringify-tinderbox;61;60;59;61;61;60;59;60;59;60 07:36:43 INFO - PROCESS | 25674 | |10;stanford-crypto-aes;78;82;80;82;88;79;80;78;77;78 07:36:43 INFO - PROCESS | 25674 | |11;stanford-crypto-ccm;128;135;126;125;125;128;124;140;169;124 07:36:43 INFO - PROCESS | 25674 | |12;stanford-crypto-pbkdf2;172;169;162;166;161;165;163;161;160;165 07:36:43 INFO - PROCESS | 25674 | |13;stanford-crypto-sha256-iterative;66;66;64;64;65;65;65;63;63;64 07:36:43 INFO - PROCESS | 25674 | __end_tp_report 07:36:43 INFO - PROCESS | 25674 | __start_cc_report 07:36:43 INFO - PROCESS | 25674 | _x_x_mozilla_cycle_collect,1629 07:36:43 INFO - PROCESS | 25674 | __end_cc_report 07:36:43 INFO - PROCESS | 25674 | __startTimestamp1474555003278__endTimestamp 07:36:43 INFO - PROCESS | 25674 | 07:36:43 INFO - PROCESS | 25674 | ------- Summary: start ------- 07:36:43 INFO - PROCESS | 25674 | Number of tests: 14 07:36:43 INFO - PROCESS | 25674 | 07:36:43 INFO - PROCESS | 25674 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.50 stddev:1.29 (1.2%) stddev-sans-first:1.32 07:36:43 INFO - PROCESS | 25674 | Values: 110.0 110.0 109.0 110.0 112.0 112.0 111.0 113.0 110.0 112.0 07:36:43 INFO - PROCESS | 25674 | 07:36:43 INFO - PROCESS | 25674 | [#1] audio-beat-detection Cycles:10 Average:130.90 Median:124.00 stddev:16.43 (13.3%) stddev-sans-first:17.02 07:36:43 INFO - PROCESS | 25674 | Values: 141.0 117.0 122.0 160.0 119.0 123.0 125.0 123.0 159.0 120.0 07:36:43 INFO - PROCESS | 25674 | 07:36:43 INFO - PROCESS | 25674 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 07:36:43 INFO - PROCESS | 25674 | Values: 162.0 162.0 163.0 163.0 163.0 161.0 162.0 162.0 160.0 161.0 07:36:43 INFO - PROCESS | 25674 | 07:36:43 INFO - PROCESS | 25674 | [#3] audio-fft Cycles:10 Average:81.40 Median:75.50 stddev:12.02 (15.9%) stddev-sans-first:12.52 07:36:43 INFO - PROCESS | 25674 | Values: 75.0 75.0 76.0 107.0 75.0 76.0 77.0 75.0 101.0 77.0 07:36:43 INFO - PROCESS | 25674 | 07:36:43 INFO - PROCESS | 25674 | [#4] audio-oscillator Cycles:10 Average:93.70 Median:83.00 stddev:17.74 (21.4%) stddev-sans-first:18.46 07:36:43 INFO - PROCESS | 25674 | Values: 84.0 83.0 126.0 83.0 83.0 82.0 113.0 82.0 83.0 118.0 07:36:43 INFO - PROCESS | 25674 | 07:36:43 INFO - PROCESS | 25674 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 07:36:43 INFO - PROCESS | 25674 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 118.0 07:36:43 INFO - PROCESS | 25674 | 07:36:43 INFO - PROCESS | 25674 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 07:36:43 INFO - PROCESS | 25674 | Values: 146.0 146.0 145.0 145.0 146.0 145.0 146.0 146.0 145.0 144.0 07:36:43 INFO - PROCESS | 25674 | 07:36:43 INFO - PROCESS | 25674 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:36:43 INFO - PROCESS | 25674 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 07:36:43 INFO - PROCESS | 25674 | 07:36:43 INFO - PROCESS | 25674 | [#8] json-parse-financial Cycles:10 Average:51.40 Median:52.00 stddev:0.70 (1.3%) stddev-sans-first:0.71 07:36:43 INFO - PROCESS | 25674 | Values: 52.0 51.0 50.0 52.0 51.0 52.0 51.0 52.0 51.0 52.0 07:36:43 INFO - PROCESS | 25674 | 07:36:43 INFO - PROCESS | 25674 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:0.82 (1.4%) stddev-sans-first:0.78 07:36:43 INFO - PROCESS | 25674 | Values: 61.0 60.0 59.0 61.0 61.0 60.0 59.0 60.0 59.0 60.0 07:36:43 INFO - PROCESS | 25674 | 07:36:43 INFO - PROCESS | 25674 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:80.00 stddev:3.22 (4.0%) stddev-sans-first:3.32 07:36:43 INFO - PROCESS | 25674 | Values: 78.0 82.0 80.0 82.0 88.0 79.0 80.0 78.0 77.0 78.0 07:36:43 INFO - PROCESS | 25674 | 07:36:43 INFO - PROCESS | 25674 | [#11] stanford-crypto-ccm Cycles:10 Average:132.40 Median:128.00 stddev:13.88 (10.8%) stddev-sans-first:14.63 07:36:43 INFO - PROCESS | 25674 | Values: 128.0 135.0 126.0 125.0 125.0 128.0 124.0 140.0 169.0 124.0 07:36:43 INFO - PROCESS | 25674 | 07:36:43 INFO - PROCESS | 25674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.40 Median:165.00 stddev:3.84 (2.3%) stddev-sans-first:2.92 07:36:43 INFO - PROCESS | 25674 | Values: 172.0 169.0 162.0 166.0 161.0 165.0 163.0 161.0 160.0 165.0 07:36:43 INFO - PROCESS | 25674 | 07:36:43 INFO - PROCESS | 25674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:65.00 stddev:1.08 (1.7%) stddev-sans-first:1.00 07:36:43 INFO - PROCESS | 25674 | Values: 66.0 66.0 64.0 64.0 65.0 65.0 65.0 63.0 63.0 64.0 07:36:43 INFO - PROCESS | 25674 | -------- Summary: end -------- 07:36:43 INFO - PROCESS | 25674 | 07:36:44 INFO - TEST-INFO | 25674: exit 0 07:36:44 INFO - TEST-OK | kraken | took 62353ms 07:36:44 INFO - SUITE-END | took 1178s 07:36:44 INFO - Completed test suite (00:19:38) 07:36:44 INFO - javascript benchmark 07:36:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3014.623172103487, 3064.6935306469354, 3066.110827859922, 3076.9846150769245, 3092.4279008383437, 5170.1986192140275, 5226.5034821691925, 5297.973510132453, 5344.038073146832, 5355.330583677035, 5300.151975683892, 5304.389995150559, 5342.679439233649, 5368.033753924292, 5369.301990741208, 4779.426468823746, 4846.5880400166025, 4856.830010949618, 4870.732109733964, 4962.627802914796, 4909.533594308535, 4927.211646136619, 4933.925991110136, 4983.6760610560195, 5013.298138260647, 4750.429948406196, 4758.095961767253, 4796.544328288807, 4831.565159135695, 4859.34398856157, 4871.220604703266, 4871.853844384674, 4884.877878053077, 4895.9510404895855, 4903.0, 4813.494583068762, 4845.370101886768, 4850.175470170079, 4859.659823812334, 4863.781129849165, 5146.202338637517, 5200.115980283361, 5237.266782650432, 5314.92027619586, 5352.545033672142, 5588.385277619459, 5609.49514543693, 5616.634918730269, 5627.268455100811, 5690.345610254791, 5682.801101961411, 5691.601587888849, 5697.230873832021, 5698.088305871041, 5698.316202055738, 5171.741412929301, 5244.475552444801, 5251.159814429673, 5280.260763493114, 5302.496262855023, 5817.272840894888, 5826.475617194473, 5828.154917536934, 5829.15477255804, 5835.153902684087, 5540.279763630702, 5542.307211598551, 5589.608727389043, 5595.608307418442, 5602.747876345574, 5719.056355701346, 5776.913346299809, 5785.363610002896, 5791.507721843691, 5792.420757924258, 5641.802536911188, 5700.116481945305, 5703.657780533182, 5706.0, 5709.058005429058, 5508.614396992252, 5588.0779671354585, 5697.0, 5712.257406537124, 5712.942870571241, 4360.454943132108, 4406.625436837905, 4406.823727050882, 4411.338299255138, 4460.063386688832, 3917.7061720371084, 3924.803759812055, 3926.254011737818, 3964.1675248197625, 3975.4235635832642, 5307.893842123136, 5398.865028374244, 5402.37872644643, 5403.621746477787, 5406.702631355234, 5594.0769772987815, 5628.915566266509, 5652.604317697722, 5700.287464066992, 5756.827295181151, 5337.572994160458, 5349.919751203657, 5361.249425080492, 5363.892722145535, 5367.570594352521, 4931.506849315111, 4938.234573641092, 4948.653594248368, 4949.82675606352, 5000.649954503223, 5739.253896993448, 5796.3913789052385, 5838.299404071538, 5896.557758168069, 5912.940870591239, 5770.076787713946, 5771.278590176228, 5771.509421699203, 5775.104858746901, 5826.679532625746, 5920.644761314335, 5927.762889484545, 5930.05119180929, 5931.228940237742, 5933.3769954154195, 5398.163284690879, 5471.72641367938, 5483.369412517612, 5511.063119269654, 5642.915356269741, 5663.490285874291, 5664.461876121762, 5677.403872593318, 5705.885882282414, 5731.627444216113, 5514.724263786715, 5517.503424691797, 5524.033294173584, 5525.171224316224, 5526.309211348582, 5427.267318911896, 5482.643628164156, 5486.533644640251, 5518.668879867221, 5589.301337332833, 5200.843974680765, 5436.320459942507, 5443.482869127427, 5498.505134537911, 5506.972465137648, 5529.253550770755, 5531.8893622126525, 5564.638298510584, 5566.165075238747, 5568.916466252928, 5342.305500284938, 5388.811391601275, 5415.918761218506, 5472.20653005304, 5539.667619942817], "value": 5240.690324945657, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.5133323777843, 591.8638713095988, 596.7463827873155, 609.3084349263585, 611.004063376696, 31142.68857311429, 31867.36265274696, 34185.65814341862, 34218.65781342189, 41313.79343103288, 39887.800560997224, 44105.11789764211, 44137.77931110348, 44149.55850441495, 44295.0, 8962.775930601721, 9127.315451341143, 9140.680076197334, 9143.03998080202, 9146.31402644801, 8900.910990890105, 8989.101089891024, 8994.235489983359, 8998.955005224965, 9002.504862232574, 9055.59249833759, 9104.0, 9108.089191080871, 9114.635414583441, 9123.08769123089, 8998.100189981014, 9020.8646870297, 9041.321900857396, 9045.909540904573, 9050.502222377767, 8857.911420885774, 8934.151255630704, 8945.910540894572, 8953.462792232487, 8955.552222388855, 40046.59953400458, 40337.193256135004, 40431.0, 40434.39348409776, 40693.593064069275, 3396.4735466002808, 3534.2224710563637, 3791.545014598266, 3979.781112038837, 4025.3961905714086, 30844.69155308463, 31319.843400783077, 31434.685653143406, 31891.362172756413, 32440.513392299134, 4436.64506839452, 4526.841560545365, 4531.0, 4534.161180181677, 4537.500874903758, 341174.0, 343221.2838935814, 343538.0, 343703.0, 343707.0, 47405.5259447408, 48803.0, 54624.0, 55234.171487427724, 55644.16533751997, 55784.442155578734, 56939.14591281134, 56958.14562781562, 61425.38574614197, 61471.385286146564, 16376.918115409586, 16691.666166676598, 16692.916535417487, 16698.24857881374, 16702.58243543921, 12513.874861251454, 12571.622851314476, 12622.431990560446, 12634.81047784284, 12637.93681031589, 14230.928845355915, 14497.158253062948, 15331.0, 15735.606609834846, 15944.920275398548, 5626.381098079208, 5798.88402231953, 5837.182794408786, 5838.854028649318, 5893.6463812171405, 896.3994123936978, 985.9556319965619, 990.1089019882164, 1005.2109094360892, 1041.557338131291, 30065.549016764766, 31204.531932021036, 31381.0, 31960.680393196235, 32663.83668081692, 1033.7777377863795, 1058.9682309530572, 1120.1486869978712, 1142.731458107344, 1149.8850114988434, 15689.293981770848, 16375.344986200656, 16418.67162656764, 16560.420385286456, 16599.50201493957, 535935.0, 537075.0, 539349.0, 539592.0, 540300.0, 55491.72254138784, 55564.72217638886, 55653.72173139108, 55679.71042750932, 55715.721421392635, 1302.1340808362334, 1327.8937684985178, 1337.5452346202144, 1375.0099928051786, 1381.599336192493, 28848.567271491363, 30174.698253017188, 30228.69771302259, 30499.390012200074, 30856.0, 48374.51625483841, 48812.75593622151, 48894.51105489042, 48930.0, 48967.0, 342426.0, 343092.0, 343291.0, 344127.0, 344324.0, 24448.51102977966, 25077.74922250827, 25083.0, 27216.591751124146, 27548.58677119885, 37756.62243377531, 39288.6426814392, 40453.79773101116, 47208.29187562121, 49641.0, 38244.23511529698, 38685.80657096697, 38756.0, 40542.39186412147, 40901.1819763609, 39489.40765888571, 39656.801715991234, 40422.79788601038, 41309.58690413057, 41316.586834132475, 39293.41059884047, 39565.40651890282, 39760.80119599384, 39824.0, 40140.78521755174, 33666.0, 35971.82014089913, 36429.08927276839, 36928.0, 36989.0, 27308.726912730617, 27665.308367290978, 27678.0, 27808.721912781424, 27990.860045699643], "value": 19259.431994784383, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.1191165027235, 400.3334448143842, 404.3066141567212, 407.96532294754945, 418.48735299258414, 13201.405936732846, 14924.626884327898, 19568.90215548924, 19569.41291761246, 20405.183792648277, 18414.0, 18801.43595692128, 18815.05924703763, 18910.243590256407, 18950.62098758024, 4540.136901057872, 5550.333959924815, 5757.856053598652, 5758.568107391941, 5762.308522977249, 4128.236276288896, 4324.286492728712, 5707.1153971134545, 5710.571707121982, 5743.224664670279, 6093.146959425684, 6355.523335749815, 6363.586366886161, 6442.48460123189, 6480.060391243267, 6201.90697139541, 6235.688215589225, 6334.081558174039, 6347.460465860408, 6456.031595260702, 5621.353544342372, 5624.3250809903075, 5630.493255606974, 5630.549556035548, 5631.831045068655, 22129.0, 22654.546909061726, 22711.0, 22786.98686289014, 22787.0, 2238.160689741347, 2288.622377307742, 2361.6457531370434, 2468.6543883856275, 2847.0604700449007, 14007.929960350235, 14384.208868512227, 14682.751966082897, 15046.645801877883, 15060.246987650573, 1864.822841830024, 1875.1280654495724, 1890.8770929889652, 1928.9421317360361, 1961.2449207055245, 80731.19268807354, 83158.0, 83775.5811220946, 83983.0, 85899.0, 10284.125849302893, 10333.896661033294, 10483.790324193626, 10688.893111068945, 10697.358158510515, 15053.548393548212, 15056.698866022618, 15060.849391506164, 15069.17119558413, 15070.698586028218, 7723.150453450116, 7759.107702614158, 8083.353331733447, 8208.794780130545, 8218.589070546448, 7722.498037627536, 7755.7324227905265, 7758.7672369829, 7786.532808031537, 7945.523268603903, 6190.226221722285, 6291.476773007131, 6327.810165695037, 6407.583507072025, 6446.774362897276, 1702.5913780692545, 1803.9610837462653, 1896.7818700849302, 1912.4645099372199, 1943.2906988948932, 821.5850995247362, 895.9820803583892, 941.2611100286242, 949.781550243434, 956.0582825916466, 18958.24167033303, 19451.0, 19538.218471261276, 19576.587795765878, 19765.802341976683, 969.1519920069939, 982.4400091947664, 1025.600015993763, 1038.0709265207597, 1062.5059347403494, 9533.952330238304, 11065.557377704801, 11078.169137314733, 11150.219484635998, 11168.162387820947, 439209.0, 449536.0, 475930.0, 476099.0, 477877.0, 49728.25407618889, 50472.747636261585, 51283.74358128185, 60528.39471605315, 86909.52902300154, 905.2622112977901, 945.3288165402641, 1044.6709286574705, 1059.327327147267, 1065.8081545321916, 15661.37354505807, 16529.83470165331, 17571.648567028842, 17863.553411164823, 17897.910510447364, 40743.0, 41464.0, 41797.79101104475, 42112.789436052626, 42443.7877810609, 52263.47736522738, 52324.21513677374, 54048.18927716166, 56307.71846140743, 58048.0, 8249.83500329978, 8288.50268983863, 8450.450720703135, 8512.446690965067, 8880.245179159843, 13062.150960187557, 13083.41124649412, 13181.275029873448, 13218.405171767487, 13294.867051329364, 8804.962452504571, 10131.0, 11104.111671066134, 11513.712157195801, 11518.654440366803, 6742.359475849787, 11122.277051991594, 11211.383373914186, 11645.88354116482, 11721.12091593151, 11312.94343528277, 11620.244684095507, 12089.81865272004, 12378.938105309417, 12525.624231273076, 8181.5500147490075, 8373.455725377831, 8438.704645337384, 8607.063410732535, 8773.29813614922, 10788.676339709822, 10992.560297588007, 11181.273217240854, 11185.217034807485, 11249.21255512139], "value": 9123.370534891752, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1448.3337664674252, 1492.3284521965115, 1608.3245037084423, 1742.5120966129489, 1758.1472985601981, 8225.58872056397, 8849.424787388814, 8852.822943541125, 8856.247218986395, 8861.46831190129, 7714.190010048948, 7998.600069996506, 8217.424780265368, 8487.618057187427, 8723.084076172006, 2283.977160228393, 2308.4344335637707, 2310.976890231093, 2311.641695537186, 2320.1299512682745, 2193.024104273599, 2216.3240211735415, 2224.855384400017, 2244.6969659095976, 2259.830512711545, 2226.815980329458, 2243.4839986803045, 2247.7077979862597, 2322.4658328584437, 2325.2791634593245, 2200.7799220078023, 2205.757366689671, 2206.2278202629113, 2210.4142402263415, 2213.756486786444, 2201.2075652764993, 2220.544788318391, 2231.9330420087263, 2259.2770313499686, 2265.173211777689, 8722.607482663296, 8763.649454021832, 8765.517896515752, 8778.429402088845, 8778.56107194644, 5075.5939524838295, 5190.039842629126, 5206.24509446132, 5207.817726379596, 5212.348456442945, 3322.0, 3376.7805092668896, 3475.1078791753143, 3488.8953331399844, 3499.7550171488006, 1076.4133547216786, 1096.780643871221, 1097.9890201098046, 1111.4831603304501, 1143.2511704833348, 12044.096692747991, 12151.513939442411, 12152.57465988686, 12159.696007599792, 12163.20939138962, 4398.780060996937, 4503.864884053483, 4629.166749984967, 4713.3872596562915, 4741.051789642085, 10198.031187037219, 10202.38785672862, 10218.335808172445, 10222.693319200436, 10224.948875255575, 5241.580673546107, 5283.550898173698, 5283.682979021271, 5283.920741188886, 5285.814996475182, 4180.707350485437, 4328.935065974013, 4654.488006319302, 4755.072760811678, 4842.5157484251295, 3850.3828392075397, 3875.8255878485534, 3959.3269144245546, 3967.26605577969, 3979.243943650697, 1281.3529167770216, 1281.4617860498613, 1285.6271681212531, 1292.424870932445, 1305.3603734170188, 958.0, 971.5288085278776, 972.9513524323755, 976.7069879036261, 996.3324572536418, 5776.42235776419, 5890.617109887844, 5960.791372302036, 5967.492763115097, 6047.998882586798, 439.1524357989048, 447.9776011199427, 452.53389009320455, 457.9519150489217, 461.9422572178478, 4089.652379547772, 4128.896777580585, 4143.482064741907, 4147.398627199039, 4183.832646694159, 10442.164626829835, 10647.733806654896, 10730.785384292427, 10769.83845242322, 10801.729956751144, 10683.572657093784, 10692.518836652369, 10694.679159625224, 10699.411532365639, 10710.785784284271, 7527.623618819037, 7887.84224315499, 7892.802679932933, 8011.919880801117, 8099.433039687166, 5916.001956693175, 5916.467517923235, 6052.818415447544, 6120.908186377119, 6176.629402235881, 9861.654842080492, 9886.752831179278, 9905.653302134391, 9907.801843962936, 10011.649592264235, 9916.702498925044, 9986.650467233612, 9999.100080992746, 10136.18910487174, 10198.082172604205, 6843.897341539781, 7049.647517624201, 7238.0952380952385, 7559.848803024019, 7743.45795794289, 8192.18078192176, 8441.409101362846, 8459.788505287417, 8467.364947629076, 8474.491530508189, 7224.711011559479, 7256.818579535343, 7331.963340183265, 7367.115946086504, 7586.696532138652, 7119.5372300802355, 7133.072700548895, 7135.500514963903, 7306.050213472215, 7328.2305357938785, 6661.800145995628, 6682.9331706682315, 6714.0, 6718.462522998051, 6722.495812814156, 4963.255511673134, 5170.48295170495, 5218.765155567932, 5249.186376111708, 5287.52412282881, 4866.221404575251, 4871.244957031666, 4877.3903262092235, 4951.9752401237765, 5085.110105731408], "value": 4470.782209579989, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.4381794766844, 334.12959241176736, 340.5708806903301, 344.3663658867684, 349.82159098859574, 5188.688678679282, 5310.07073762092, 5349.5720342372615, 5398.48714372135, 5425.864353391163, 5130.410002849673, 5218.921716174261, 5249.4750524947585, 5267.630416091815, 5284.260203571494, 4184.665226781865, 4194.433751443562, 4205.5794420558, 4218.59923307286, 4226.654206915161, 3918.9804050979847, 4153.8161623937185, 4209.768462734548, 4212.747235165884, 4227.365895115742, 4096.73371230869, 4104.651104656108, 4113.4858142732155, 4122.196171746511, 4138.1103062841485, 4071.1705364771497, 4079.938800917989, 4093.9795301023305, 4113.938290925638, 4116.670666346685, 3678.558572971234, 3678.70570354371, 3679.8344074516713, 3696.796676182809, 3705.40713485841, 5068.898622027539, 5093.1850903855575, 5101.82143624975, 5119.3088932994315, 5167.6641018333685, 4682.836100736458, 4705.482396936334, 4726.810927562893, 4737.0, 4748.145333839908, 5314.51172000057, 5417.8103766367985, 5459.235707001023, 5483.506484416422, 5540.36285827131, 3850.5764365919727, 3867.7872717000555, 3881.126746482047, 3890.9027274318087, 3893.4743809585625, 5725.914111288334, 5764.394738552475, 5767.942320576824, 5782.884342313172, 5786.623869448515, 4134.462519872457, 4139.586041395896, 4155.958440415558, 4173.916521669549, 4181.91636167281, 3931.744436611611, 4150.481189851269, 4153.937690934638, 4171.770552619635, 4207.431996680409, 4716.457607375127, 4727.716337019721, 4728.834490792806, 4731.124741922756, 4760.785764640599, 5576.581756368289, 5584.4921871094575, 5604.859878502988, 5635.464630860144, 5651.519620832193, 1310.3382791690135, 1338.9129706569042, 1368.6988862450246, 1386.3137746815391, 1387.126110550367, 886.3308202307346, 896.8878890138733, 897.8922529296395, 907.5643691028343, 907.8774365460711, 4750.8337208197545, 4755.408302475159, 4756.262779269219, 4793.688410253322, 4808.158572249842, 5003.874903127451, 5025.537486631524, 5026.868954485211, 5045.823396181189, 5049.8737531562, 4472.674209411153, 4675.275332323496, 4715.0, 4720.669553131248, 4734.384530011076, 2608.491344187903, 2636.709961904189, 2638.643783089297, 2657.4153686189006, 2672.2116975492277, 5075.8984820303385, 5117.437081920985, 5127.07712611726, 5132.508216208621, 5162.199859021783, 4838.153323168432, 4970.2793095001025, 5057.797688092435, 5074.847754567369, 5075.771590278447, 5128.3845938486875, 5128.410232823273, 5136.845894623242, 5146.511081447256, 5155.664881782672, 4946.653734238569, 4955.306257124078, 4964.180910149785, 4994.9500504994485, 5017.623678224075, 4711.81152753886, 4949.604031677529, 4949.871555231285, 4951.425258865442, 4962.702237865739, 5123.5388815005335, 5140.228965655182, 5168.793248270027, 5169.974150129376, 5172.431032586337, 3725.5097960814805, 3741.428599987957, 3746.3443897318407, 3748.34403979308, 3750.868719594801, 4673.906521869611, 4938.654294199371, 4969.751512424436, 5016.974915125547, 5019.949800502094, 4861.562459378673, 4866.9269960949905, 4868.878278043077, 4883.487233840396, 4885.65800393969, 4793.688410253322, 4843.443004054438, 4848.806047758191, 4851.781669824937, 4854.247591623304, 4443.555644435531, 4742.928856067231, 4801.879953001203, 4815.627546149331, 4866.197077482176, 4854.78153483087, 4860.857698440935, 4880.316755654282, 4884.633652476007, 4906.386701662293, 4756.738379389167, 4784.512053732109, 4789.568938795525, 4790.257510085942, 4793.976030119967], "value": 3980.4970419491665, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.2529894208964, 727.2545640718263, 767.6737386610689, 780.7501599488164, 789.6209819286743, 13866.514671986482, 14900.180490073042, 14927.92536037321, 14940.850591494082, 14950.327235274412, 13136.408861601227, 13137.67155821105, 13187.208767473958, 13207.207567545955, 13256.403461844217, 644.0693198328394, 660.1319265166314, 771.463832636318, 778.1246098139593, 798.1459837973342, 799.360511590728, 800.4276941986478, 800.9759707208764, 803.3733687723585, 809.1625167951172, 839.1692224697535, 839.7396806989822, 839.9916000840005, 840.1094839470151, 840.277361469136, 662.9303923088103, 834.3241974001048, 834.8872902158191, 834.9582520873932, 835.4277320035765, 509.85469141294925, 593.2110293309887, 607.6384551192034, 612.0513204533, 613.9662318572476, 12988.090833641649, 13002.089853710244, 13020.544280950122, 13021.934890325489, 13028.348582570834, 12891.806622900664, 13037.41331640069, 13812.723745525032, 14002.719945601031, 14160.672242023116, 12500.874991250063, 12596.68508287291, 12649.0, 12700.237985720887, 12827.358632068452, 4418.924351231033, 4426.490953540352, 4451.109778044404, 4491.0, 4567.086582683477, 81236.0, 81317.78023329595, 84508.0, 85125.99999999937, 87217.56391218067, 9957.601695932082, 10103.292769506064, 10151.7462063449, 10160.288779785493, 10350.275480716427, 20733.792662073487, 20776.376708698765, 20850.791492085187, 20876.47808804792, 20884.0, 7761.5731134787, 7908.802279942933, 8152.6331315090965, 8391.916080839235, 8655.78360540979, 4349.521552629209, 4551.431071116111, 4585.578470674035, 4632.5135860734135, 4660.161170989187, 3383.323335332894, 3518.4722291655944, 3521.102118959649, 3521.4013617685055, 3525.629808870083, 606.8513214262446, 608.5162295974711, 614.5513774944226, 627.159606127791, 636.1062706896818, 634.8476365672205, 638.1958731997623, 660.5475249454139, 698.434268242725, 707.5860621536356, 8650.6972255972, 8983.416077955042, 9152.581008022846, 9288.628454861864, 9396.342256042148, 672.4317951331118, 672.8788818012805, 679.4700133895569, 683.282553319013, 702.2626242445411, 4512.323151527297, 4559.817607295671, 4569.95430045702, 4576.153411618861, 4688.859334219979, 123836.52043494563, 126283.0, 126709.36645316899, 126965.36517317539, 129996.0, 111854.0, 112093.43953280181, 112197.43901280442, 113349.0, 117530.41234793772, 73569.63215183996, 75336.24663753292, 94490.0, 97688.0, 98907.0, 9347.719568412958, 9556.713298601053, 9691.466969316756, 9881.802363952824, 10214.336068155546, 37468.81265593655, 40746.0, 49764.502354975986, 50689.0, 52048.47951520588, 63296.0, 75002.9998800042, 75826.24173758192, 78490.26420376525, 80241.59879200567, 12981.480740770641, 13313.866861331262, 13315.26766027839, 13461.932690336485, 13741.519046833313, 14833.406663733329, 14853.0, 14957.850421495647, 15003.174825384709, 15133.167675777939, 11759.235649682743, 11946.522139114339, 13501.662458438617, 13563.86436135626, 14027.36876840565, 14059.367328470447, 14075.788863167265, 14200.857991419953, 14367.497137600134, 14504.492342767953, 13219.471221151047, 13697.863021369658, 14158.929205353907, 14419.639509012359, 14585.635359115682, 10874.401907895142, 11462.828057578976, 11789.174757766874, 12000.456555290182, 12112.515499380279, 9558.28312876551, 10819.621313253998, 11442.0, 11817.763644727229, 12314.50741970347], "value": 7463.045054620566, "unit": "score"}], "name": "dromaeo_css", "value": 7045.502305613153, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 109.0, 110.0, 112.0, 112.0, 111.0, 113.0, 110.0, 112.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 117.0, 122.0, 160.0, 119.0, 123.0, 125.0, 123.0, 159.0, 120.0], "value": 130.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 163.0, 163.0, 161.0, 162.0, 162.0, 160.0, 161.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 107.0, 75.0, 76.0, 77.0, 75.0, 101.0, 77.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 126.0, 83.0, 83.0, 82.0, 113.0, 82.0, 83.0, 118.0], "value": 93.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 144.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 50.0, 52.0, 51.0, 52.0, 51.0, 52.0, 51.0, 52.0], "value": 51.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 59.0, 61.0, 61.0, 60.0, 59.0, 60.0, 59.0, 60.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 82.0, 80.0, 82.0, 88.0, 79.0, 80.0, 78.0, 77.0, 78.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 135.0, 126.0, 125.0, 125.0, 128.0, 124.0, 140.0, 169.0, 124.0], "value": 132.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 169.0, 162.0, 166.0, 161.0, 165.0, 163.0, 161.0, 160.0, 165.0], "value": 164.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 64.0, 64.0, 65.0, 65.0, 65.0, 63.0, 63.0, 64.0], "value": 64.5, "unit": "score"}], "name": "kraken", "value": 1489.2000000000003, "alertThreshold": 2.0}]} 07:36:44 INFO - Return code: 0 07:36:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:36:45 INFO - # TBPL SUCCESS # 07:36:45 INFO - Running post-action listener: _resource_record_post_action 07:36:45 INFO - [mozharness: 2016-09-22 14:36:45.075373Z] Finished run-tests step (success) 07:36:45 INFO - Running post-run listener: _resource_record_post_run 07:36:45 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 2740224; Write bytes: 409972736; Read time: 520; Write time: 274632 07:36:45 INFO - TinderboxPrint: CPU usage
13.1% 07:36:45 INFO - TinderboxPrint: I/O read bytes / time
2,740,224 / 520 07:36:45 INFO - TinderboxPrint: I/O write bytes / time
409,972,736 / 274,632 07:36:45 INFO - TinderboxPrint: CPU idle
8,286.7 (86.8%) 07:36:45 INFO - TinderboxPrint: CPU user
1,201.6 (12.6%) 07:36:45 INFO - TinderboxPrint: Swap in / out
0 / 0 07:36:45 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 120774656; Read time: 0; Write time: 100792 07:36:45 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 2736128; Write bytes: 289198080; Read time: 504; Write time: 173840 07:36:45 INFO - Running post-run listener: _upload_blobber_files 07:36:45 INFO - Blob upload gear active. 07:36:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:36:45 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:36:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:36:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:36:46 INFO - (blobuploader) - INFO - Open directory for files ... 07:36:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:36:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:36:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:36:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:36:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:36:46 INFO - (blobuploader) - INFO - Done attempting. 07:36:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:36:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:36:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:36:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:36:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:36:50 INFO - (blobuploader) - INFO - Done attempting. 07:36:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:36:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:36:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:36:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:36:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:36:51 INFO - (blobuploader) - INFO - Done attempting. 07:36:51 INFO - (blobuploader) - INFO - Iteration through files over. 07:36:51 INFO - Return code: 0 07:36:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:36:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:36:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74ab7584dd5511cc7962a1fc7c7db1bfa7689237da933b901bda673d6a8bb81a60a5b8f66aa522e94aa9233f7bd5b3770a2b008691ae9fe0e2dd358dad4daefd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d8d0ad4c6891dcc0b06b238d28495695077c4883f29a2ca4af73ea32dc8a0378f78fdafc6e983395004839ec4f42ce0dc74a926640b3928215402065a9c2658", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43fc5092bed6e41e2e02515842daf45bb6a33ae0ff0eaa559bc17a0b775f1031c999d3e606f970f845443530bf210c2fb55ddea0c9557ff88ae494a4c3ebe3d1"} 07:36:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:36:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:36:51 INFO - Contents: 07:36:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74ab7584dd5511cc7962a1fc7c7db1bfa7689237da933b901bda673d6a8bb81a60a5b8f66aa522e94aa9233f7bd5b3770a2b008691ae9fe0e2dd358dad4daefd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d8d0ad4c6891dcc0b06b238d28495695077c4883f29a2ca4af73ea32dc8a0378f78fdafc6e983395004839ec4f42ce0dc74a926640b3928215402065a9c2658", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43fc5092bed6e41e2e02515842daf45bb6a33ae0ff0eaa559bc17a0b775f1031c999d3e606f970f845443530bf210c2fb55ddea0c9557ff88ae494a4c3ebe3d1"} 07:36:51 INFO - Running post-run listener: copy_logs_to_upload_dir 07:36:51 INFO - Copying logs to upload dir... 07:36:51 INFO - mkdir: /builds/slave/test/build/upload/logs 07:36:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.493278 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-09-22 07:36:51.110028) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 07:36:51.113071) ========= 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=cbe409c6de289db6ac707de3000001d4-1474552741.665845-984883129 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/74ab7584dd5511cc7962a1fc7c7db1bfa7689237da933b901bda673d6a8bb81a60a5b8f66aa522e94aa9233f7bd5b3770a2b008691ae9fe0e2dd358dad4daefd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d8d0ad4c6891dcc0b06b238d28495695077c4883f29a2ca4af73ea32dc8a0378f78fdafc6e983395004839ec4f42ce0dc74a926640b3928215402065a9c2658", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43fc5092bed6e41e2e02515842daf45bb6a33ae0ff0eaa559bc17a0b775f1031c999d3e606f970f845443530bf210c2fb55ddea0c9557ff88ae494a4c3ebe3d1"} build_url:https://queue.taskcluster.net/v1/task/DwTwkyYqRRy-bs8snkhd8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011322 build_url: 'https://queue.taskcluster.net/v1/task/DwTwkyYqRRy-bs8snkhd8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74ab7584dd5511cc7962a1fc7c7db1bfa7689237da933b901bda673d6a8bb81a60a5b8f66aa522e94aa9233f7bd5b3770a2b008691ae9fe0e2dd358dad4daefd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d8d0ad4c6891dcc0b06b238d28495695077c4883f29a2ca4af73ea32dc8a0378f78fdafc6e983395004839ec4f42ce0dc74a926640b3928215402065a9c2658", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43fc5092bed6e41e2e02515842daf45bb6a33ae0ff0eaa559bc17a0b775f1031c999d3e606f970f845443530bf210c2fb55ddea0c9557ff88ae494a4c3ebe3d1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 07:36:51.142604) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 07:36:51.143349) ========= 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=cbe409c6de289db6ac707de3000001d4-1474552741.665845-984883129 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004485 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 07:36:51.226774) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 07:36:51.227520) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 07:36:51.228227) ========= ========= Total master_lag: 0.21 =========