builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-052 starttime: 1475890268.56 results: success (0) buildid: 20161007153043 builduid: 6c7336606596407d992423ddfa11c842 revision: 66bbe7f0d664f2164fa7371608e3563c54ce8d55 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 18:31:08.564504) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 18:31:08.565017) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 18:31:08.565340) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 18:31:08.621330) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 18:31:08.621625) ========= 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=826874ccc97bd7bf541b4875000001d5-1475882853.774275-693207389 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-07 18:31:08-- 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% 46.6M=0s 2016-10-07 18:31:08 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.074196 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 18:31:08.714546) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 18:31:08.714904) ========= 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=826874ccc97bd7bf541b4875000001d5-1475882853.774275-693207389 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013753 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 18:31:08.764487) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 18:31:08.764898) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 66bbe7f0d664f2164fa7371608e3563c54ce8d55 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 66bbe7f0d664f2164fa7371608e3563c54ce8d55 --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=826874ccc97bd7bf541b4875000001d5-1475882853.774275-693207389 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-07 18:31:09,021 truncating revision to first 12 chars 2016-10-07 18:31:09,021 Setting DEBUG logging. 2016-10-07 18:31:09,021 attempt 1/10 2016-10-07 18:31:09,021 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/66bbe7f0d664?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-07 18:31:09,318 unpacking tar archive at: mozilla-inbound-66bbe7f0d664/testing/mozharness/ program finished with exit code 0 elapsedTime=0.618297 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 18:31:09.396791) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 18:31:09.397136) ========= script_repo_revision: 66bbe7f0d664f2164fa7371608e3563c54ce8d55 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 18:31:09.397582) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 18:31:09.397907) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 18:31:09.407426) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-10-07 18:31:09.407812) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1475882853.774275-693207389 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:31:09 INFO - MultiFileLogger online at 20161007 18:31:09 in /builds/slave/test 18:31:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 18:31:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:31:09 INFO - {'append_to_log': False, 18:31:09 INFO - 'base_work_dir': '/builds/slave/test', 18:31:09 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 18:31:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:31:09 INFO - 'branch': 'Mozilla-Inbound', 18:31:09 INFO - 'buildbot_json_path': 'buildprops.json', 18:31:09 INFO - 'config_files': ('talos/linux_config.py',), 18:31:09 INFO - 'default_actions': ('clobber', 18:31:09 INFO - 'read-buildbot-config', 18:31:09 INFO - 'download-and-extract', 18:31:09 INFO - 'populate-webroot', 18:31:09 INFO - 'create-virtualenv', 18:31:09 INFO - 'install', 18:31:09 INFO - 'run-tests'), 18:31:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:31:09 INFO - 'download_minidump_stackwalk': True, 18:31:09 INFO - 'download_symbols': 'ondemand', 18:31:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:31:09 INFO - 'tooltool.py': '/tools/tooltool.py', 18:31:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:31:09 INFO - '/tools/misc-python/virtualenv.py')}, 18:31:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:31:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:31:09 INFO - 'installer_path': 'installer.exe', 18:31:09 INFO - 'log_level': 'info', 18:31:09 INFO - 'log_name': 'talos', 18:31:09 INFO - 'log_to_console': True, 18:31:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:31:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:31:09 INFO - 'opt_config_files': (), 18:31:09 INFO - 'pip_index': False, 18:31:09 INFO - 'sps_profile': False, 18:31:09 INFO - 'sps_profile_interval': 0, 18:31:09 INFO - 'suite': 'dromaeojs', 18:31:09 INFO - 'system_bits': '32', 18:31:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:31:09 INFO - 'title': 'talos-linux64-ix-052', 18:31:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:31:09 INFO - 'use_talos_json': True, 18:31:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:31:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:31:09 INFO - 'work_dir': 'build'} 18:31:09 INFO - [mozharness: 2016-10-08 01:31:09.759246Z] Running clobber step. 18:31:09 INFO - Running pre-action listener: _resource_record_pre_action 18:31:09 INFO - Running main action method: clobber 18:31:09 INFO - rmtree: /builds/slave/test/build 18:31:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:31:10 INFO - Running post-action listener: _resource_record_post_action 18:31:10 INFO - [mozharness: 2016-10-08 01:31:10.222242Z] Finished clobber step (success) 18:31:10 INFO - [mozharness: 2016-10-08 01:31:10.222342Z] Running read-buildbot-config step. 18:31:10 INFO - Running pre-action listener: _resource_record_pre_action 18:31:10 INFO - Running main action method: read_buildbot_config 18:31:10 INFO - Using buildbot properties: 18:31:10 INFO - { 18:31:10 INFO - "project": "", 18:31:10 INFO - "product": "firefox", 18:31:10 INFO - "script_repo_revision": "production", 18:31:10 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 18:31:10 INFO - "repository": "", 18:31:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 18:31:10 INFO - "buildid": "20161007153043", 18:31:10 INFO - "pgo_build": "True", 18:31:10 INFO - "basedir": "/builds/slave/test", 18:31:10 INFO - "buildnumber": 1799, 18:31:10 INFO - "slavename": "talos-linux64-ix-052", 18:31:10 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:31:10 INFO - "platform": "ubuntu64_hw", 18:31:10 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 18:31:10 INFO - "branch": "mozilla-inbound", 18:31:10 INFO - "repo_path": "integration/mozilla-inbound", 18:31:10 INFO - "revision": "66bbe7f0d664f2164fa7371608e3563c54ce8d55", 18:31:10 INFO - "stage_platform": "linux64-pgo", 18:31:10 INFO - "builduid": "6c7336606596407d992423ddfa11c842", 18:31:10 INFO - "slavebuilddir": "test" 18:31:10 INFO - } 18:31:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/XVRgdMumQdiC5sgjdilezA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 18:31:10 INFO - Running post-action listener: _resource_record_post_action 18:31:10 INFO - [mozharness: 2016-10-08 01:31:10.224806Z] Finished read-buildbot-config step (success) 18:31:10 INFO - [mozharness: 2016-10-08 01:31:10.224894Z] Running download-and-extract step. 18:31:10 INFO - Running pre-action listener: _resource_record_pre_action 18:31:10 INFO - Running main action method: download_and_extract 18:31:10 INFO - mkdir: /builds/slave/test/build/tests 18:31:10 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')]} 18:31:10 INFO - trying https://queue.taskcluster.net/v1/task/XVRgdMumQdiC5sgjdilezA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:31:10 INFO - Downloading https://queue.taskcluster.net/v1/task/XVRgdMumQdiC5sgjdilezA/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 18:31:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XVRgdMumQdiC5sgjdilezA/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 18:31:10 INFO - Downloaded 1361 bytes. 18:31:10 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:31:10 INFO - Using the following test package requirements: 18:31:10 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:31:10 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:31:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:31:10 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:31:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:31:10 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:31:10 INFO - u'jsshell-linux-x86_64.zip'], 18:31:10 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:31:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:31:10 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:31:10 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:31:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:31:10 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:31:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:31:10 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:31:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:31:10 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:31:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:31:10 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:31:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XVRgdMumQdiC5sgjdilezA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:31:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XVRgdMumQdiC5sgjdilezA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:31:10 INFO - Fetch https://queue.taskcluster.net/v1/task/XVRgdMumQdiC5sgjdilezA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:31:11 INFO - Http code: 200 18:31:11 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 18:31:11 INFO - x-amz-cf-id: jxXTMwZfNiXCV1bhD9RRnWrx1vIWCwAk4SLfSAIOcee9cwBv7GPfng== 18:31:11 INFO - x-amz-version-id: rdbMPo2cRX7cS98CJLxt1uFkQ4seuvPA 18:31:11 INFO - Expected file size: 22110664 18:31:11 INFO - Obtained file size: 22110664 18:31:15 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 18:31:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XVRgdMumQdiC5sgjdilezA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:31:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XVRgdMumQdiC5sgjdilezA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:31:15 INFO - Fetch https://queue.taskcluster.net/v1/task/XVRgdMumQdiC5sgjdilezA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:31:16 INFO - Http code: 200 18:31:16 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 18:31:16 INFO - x-amz-cf-id: lY0Jcqr50Y6FIv18OnMUZX_ESm_Dv8Ml99kPLM2rvicsno5xqQdixA== 18:31:16 INFO - x-amz-version-id: rdbMPo2cRX7cS98CJLxt1uFkQ4seuvPA 18:31:16 INFO - Expected file size: 22110664 18:31:16 INFO - Obtained file size: 22110664 18:31:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XVRgdMumQdiC5sgjdilezA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 18:31:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XVRgdMumQdiC5sgjdilezA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:31:20 INFO - Fetch https://queue.taskcluster.net/v1/task/XVRgdMumQdiC5sgjdilezA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 18:31:21 INFO - Http code: 200 18:31:21 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 18:31:21 INFO - x-amz-cf-id: M5DQDPLbzfvnPCpVvP3301YxWvdNg0V8CPduBIKbwoIZWVyRQKJKOQ== 18:31:21 INFO - x-amz-version-id: B8ggiBREOSZ0oW.34hZfj4nS9i98PEc4 18:31:21 INFO - Expected file size: 14409006 18:31:21 INFO - Obtained file size: 14409006 18:31:21 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')]} 18:31:21 INFO - trying https://queue.taskcluster.net/v1/task/XVRgdMumQdiC5sgjdilezA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:31:21 INFO - Downloading https://queue.taskcluster.net/v1/task/XVRgdMumQdiC5sgjdilezA/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 18:31:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XVRgdMumQdiC5sgjdilezA/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 18:31:23 INFO - Downloaded 59707966 bytes. 18:31:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XVRgdMumQdiC5sgjdilezA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:31:23 INFO - mkdir: /builds/slave/test/properties 18:31:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:31:23 INFO - Writing to file /builds/slave/test/properties/build_url 18:31:23 INFO - Contents: 18:31:23 INFO - build_url:https://queue.taskcluster.net/v1/task/XVRgdMumQdiC5sgjdilezA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:31:23 INFO - Running post-action listener: _resource_record_post_action 18:31:23 INFO - Running post-action listener: set_extra_try_arguments 18:31:23 INFO - [mozharness: 2016-10-08 01:31:23.637488Z] Finished download-and-extract step (success) 18:31:23 INFO - [mozharness: 2016-10-08 01:31:23.637713Z] Running populate-webroot step. 18:31:23 INFO - Running pre-action listener: _resource_record_pre_action 18:31:23 INFO - Running main action method: populate_webroot 18:31:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:31:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:31:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:31:23 INFO - '--tppagecycles', 18:31:23 INFO - '7'], 18:31:23 INFO - 'tests': ['tsvgm']}}, 18:31:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:31:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:31:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:31:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:31:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:31:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:31:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:23 INFO - 'talos_options': ['--disable-e10s'], 18:31:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:31:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:31:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:23 INFO - 'talos_options': ['--disable-e10s'], 18:31:23 INFO - 'tests': ['damp', 'tps']}, 18:31:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:23 INFO - 'tests': ['damp', 'tps']}, 18:31:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:31:23 INFO - 'tests': ['dromaeo_dom']}, 18:31:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:31:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:31:23 INFO - 'tests': ['basic_compositor_video']}, 18:31:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:31:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:31:23 INFO - 'tests': ['a11yr', 18:31:23 INFO - 'ts_paint', 18:31:23 INFO - 'tpaint', 18:31:23 INFO - 'sessionrestore', 18:31:23 INFO - 'sessionrestore_no_auto_restore', 18:31:23 INFO - 'tabpaint']}, 18:31:23 INFO - 'other-e10s': {'tests': ['a11yr', 18:31:23 INFO - 'ts_paint', 18:31:23 INFO - 'tpaint', 18:31:23 INFO - 'sessionrestore', 18:31:23 INFO - 'sessionrestore_no_auto_restore', 18:31:23 INFO - 'tabpaint']}, 18:31:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:31:23 INFO - 'ts_paint', 18:31:23 INFO - 'tpaint', 18:31:23 INFO - 'sessionrestore', 18:31:23 INFO - 'sessionrestore_no_auto_restore', 18:31:23 INFO - 'tabpaint']}, 18:31:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:31:23 INFO - 'ts_paint', 18:31:23 INFO - 'tpaint', 18:31:23 INFO - 'sessionrestore', 18:31:23 INFO - 'sessionrestore_no_auto_restore', 18:31:23 INFO - 'tabpaint']}, 18:31:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:31:23 INFO - 'tests': ['a11yr', 18:31:23 INFO - 'ts_paint', 18:31:23 INFO - 'tpaint', 18:31:23 INFO - 'sessionrestore', 18:31:23 INFO - 'sessionrestore_no_auto_restore', 18:31:23 INFO - 'tabpaint']}, 18:31:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:31:23 INFO - 'tests': ['a11yr', 18:31:23 INFO - 'ts_paint', 18:31:23 INFO - 'tpaint', 18:31:23 INFO - 'sessionrestore', 18:31:23 INFO - 'sessionrestore_no_auto_restore', 18:31:23 INFO - 'tabpaint']}, 18:31:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:31:23 INFO - 'tests': ['tsvgx', 18:31:23 INFO - 'tsvgr_opacity', 18:31:23 INFO - 'tart', 18:31:23 INFO - 'tscrollx', 18:31:23 INFO - 'cart']}, 18:31:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:31:23 INFO - 'tsvgr_opacity', 18:31:23 INFO - 'tart', 18:31:23 INFO - 'tscrollx', 18:31:23 INFO - 'cart']}, 18:31:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:23 INFO - 'talos_options': ['--disable-e10s'], 18:31:23 INFO - 'tests': ['tp5o']}, 18:31:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:23 INFO - 'tests': ['tp5o']}, 18:31:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:23 INFO - 'talos_options': ['--disable-e10s', 18:31:23 INFO - '--xperf_path', 18:31:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:31:23 INFO - 'tests': ['tp5n']}, 18:31:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:23 INFO - 'talos_options': ['--xperf_path', 18:31:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:31:23 INFO - 'tests': ['tp5n']}}, 18:31:23 INFO - 'talos.zip': {'path': '', 18:31:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:31:23 INFO - Running post-action listener: _resource_record_post_action 18:31:23 INFO - [mozharness: 2016-10-08 01:31:23.659137Z] Finished populate-webroot step (success) 18:31:23 INFO - [mozharness: 2016-10-08 01:31:23.659225Z] Running create-virtualenv step. 18:31:23 INFO - Running pre-action listener: _resource_record_pre_action 18:31:23 INFO - Running main action method: create_virtualenv 18:31:23 INFO - Creating virtualenv /builds/slave/test/build/venv 18:31:23 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 18:31:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:31:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:31:23 INFO - Using real prefix '/usr' 18:31:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:31:24 INFO - Installing distribute.............................................................................................................................................................................................done. 18:31:26 INFO - Installing pip.................done. 18:31:26 INFO - Return code: 0 18:31:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:31:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:31:26 INFO - Reading from file tmpfile_stdout 18:31:26 INFO - Output received: 18:31:26 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:31:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:31:26 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')]} 18:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:26 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')]} 18:31:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:26 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 0x7fc4161ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b9eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9bf60>, '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 0x2b9cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9d1d0>, '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': '826874ccc97bd7bf541b4875000001d5-1475882853.774275-693207389', '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 18:31:26 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 18:31:26 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 18:31:26 INFO - Using env: {'DISPLAY': ':0', 18:31:26 INFO - 'HOME': '/home/cltbld', 18:31:26 INFO - 'LANG': 'en_US.UTF-8', 18:31:26 INFO - 'LANGUAGE': 'en_US:en', 18:31:26 INFO - 'LOGNAME': 'cltbld', 18:31:26 INFO - 'MAIL': '/var/mail/cltbld', 18:31:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:26 INFO - 'MOZ_NO_REMOTE': '1', 18:31:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:26 INFO - 'NO_EM_RESTART': '1', 18:31:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:26 INFO - 'PWD': '/builds/slave/test', 18:31:26 INFO - 'SHELL': '/bin/bash', 18:31:26 INFO - 'SHLVL': '1', 18:31:26 INFO - 'TERM': 'linux', 18:31:26 INFO - 'TMOUT': '86400', 18:31:26 INFO - 'USER': 'cltbld', 18:31:26 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1475882853.774275-693207389', 18:31:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:26 INFO - '_': '/tools/buildbot/bin/python'} 18:31:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:26 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 18:31:26 INFO - Cleaning up... 18:31:26 INFO - Return code: 0 18:31:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:31:26 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')]} 18:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:26 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')]} 18:31:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:26 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 0x7fc4161ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b9eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9bf60>, '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 0x2b9cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9d1d0>, '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': '826874ccc97bd7bf541b4875000001d5-1475882853.774275-693207389', '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 18:31:26 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 18:31:26 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 18:31:26 INFO - Using env: {'DISPLAY': ':0', 18:31:26 INFO - 'HOME': '/home/cltbld', 18:31:26 INFO - 'LANG': 'en_US.UTF-8', 18:31:26 INFO - 'LANGUAGE': 'en_US:en', 18:31:26 INFO - 'LOGNAME': 'cltbld', 18:31:26 INFO - 'MAIL': '/var/mail/cltbld', 18:31:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:26 INFO - 'MOZ_NO_REMOTE': '1', 18:31:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:26 INFO - 'NO_EM_RESTART': '1', 18:31:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:26 INFO - 'PWD': '/builds/slave/test', 18:31:26 INFO - 'SHELL': '/bin/bash', 18:31:26 INFO - 'SHLVL': '1', 18:31:26 INFO - 'TERM': 'linux', 18:31:26 INFO - 'TMOUT': '86400', 18:31:26 INFO - 'USER': 'cltbld', 18:31:26 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1475882853.774275-693207389', 18:31:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:26 INFO - '_': '/tools/buildbot/bin/python'} 18:31:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:26 INFO - Downloading/unpacking psutil>=3.1.1 18:31:26 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 18:31:26 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 18:31:26 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 18:31:26 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 18:31:26 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 18:31:26 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 18:31:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:31:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:31:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:31:28 INFO - Installing collected packages: psutil 18:31:28 INFO - Running setup.py install for psutil 18:31:28 INFO - building 'psutil._psutil_linux' extension 18:31:28 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 18:31:29 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 18:31:29 INFO - building 'psutil._psutil_posix' extension 18:31:29 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 18:31:29 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 18:31:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:31:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:31:29 INFO - Successfully installed psutil 18:31:29 INFO - Cleaning up... 18:31:29 INFO - Return code: 0 18:31:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:31: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')]} 18:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31: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')]} 18:31:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4161ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b9eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9bf60>, '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 0x2b9cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9d1d0>, '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': '826874ccc97bd7bf541b4875000001d5-1475882853.774275-693207389', '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 18:31: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:31: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 mozsystemmonitor==0.3 18:31:29 INFO - Using env: {'DISPLAY': ':0', 18:31:29 INFO - 'HOME': '/home/cltbld', 18:31:29 INFO - 'LANG': 'en_US.UTF-8', 18:31:29 INFO - 'LANGUAGE': 'en_US:en', 18:31:29 INFO - 'LOGNAME': 'cltbld', 18:31:29 INFO - 'MAIL': '/var/mail/cltbld', 18:31:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:29 INFO - 'MOZ_NO_REMOTE': '1', 18:31:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:29 INFO - 'NO_EM_RESTART': '1', 18:31:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:29 INFO - 'PWD': '/builds/slave/test', 18:31:29 INFO - 'SHELL': '/bin/bash', 18:31:29 INFO - 'SHLVL': '1', 18:31:29 INFO - 'TERM': 'linux', 18:31:29 INFO - 'TMOUT': '86400', 18:31:29 INFO - 'USER': 'cltbld', 18:31:29 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1475882853.774275-693207389', 18:31:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:29 INFO - '_': '/tools/buildbot/bin/python'} 18:31:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:31: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 18:31: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 18:31: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 18:31: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 18:31: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 18:31: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 18:31:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:31:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:31:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:31:31 INFO - Installing collected packages: mozsystemmonitor 18:31:31 INFO - Running setup.py install for mozsystemmonitor 18:31:31 INFO - Successfully installed mozsystemmonitor 18:31:31 INFO - Cleaning up... 18:31:31 INFO - Return code: 0 18:31:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:31:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:31 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 0x7fc4161ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b9eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9bf60>, '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 0x2b9cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9d1d0>, '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': '826874ccc97bd7bf541b4875000001d5-1475882853.774275-693207389', '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 18:31:31 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 18:31:31 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 18:31:31 INFO - Using env: {'DISPLAY': ':0', 18:31:31 INFO - 'HOME': '/home/cltbld', 18:31:31 INFO - 'LANG': 'en_US.UTF-8', 18:31:31 INFO - 'LANGUAGE': 'en_US:en', 18:31:31 INFO - 'LOGNAME': 'cltbld', 18:31:31 INFO - 'MAIL': '/var/mail/cltbld', 18:31:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:31 INFO - 'MOZ_NO_REMOTE': '1', 18:31:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:31 INFO - 'NO_EM_RESTART': '1', 18:31:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:31 INFO - 'PWD': '/builds/slave/test', 18:31:31 INFO - 'SHELL': '/bin/bash', 18:31:31 INFO - 'SHLVL': '1', 18:31:31 INFO - 'TERM': 'linux', 18:31:31 INFO - 'TMOUT': '86400', 18:31:31 INFO - 'USER': 'cltbld', 18:31:31 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1475882853.774275-693207389', 18:31:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:31 INFO - '_': '/tools/buildbot/bin/python'} 18:31:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:31 INFO - Downloading/unpacking jsonschema==2.5.1 18:31:31 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 18:31:31 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 18:31:31 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 18:31:31 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 18:31:31 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 18:31:31 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 18:31:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:31:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:31:33 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 18:31:33 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 18:31:33 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 18:31:33 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 18:31:33 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 18:31:33 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 18:31:34 INFO - Downloading functools32-3.2.3-2.tar.gz 18:31:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:31:34 INFO - warning: no files found matching '*.txt' 18:31:34 INFO - no previously-included directories found matching 'build' 18:31:34 INFO - no previously-included directories found matching 'dist' 18:31:34 INFO - no previously-included directories found matching '.git*' 18:31:34 INFO - Installing collected packages: jsonschema, functools32 18:31:34 INFO - Running setup.py install for functools32 18:31:34 INFO - warning: no files found matching '*.txt' 18:31:34 INFO - no previously-included directories found matching 'build' 18:31:34 INFO - no previously-included directories found matching 'dist' 18:31:34 INFO - no previously-included directories found matching '.git*' 18:31:34 INFO - Successfully installed jsonschema functools32 18:31:34 INFO - Cleaning up... 18:31:34 INFO - Return code: 0 18:31:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:31: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')]} 18:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31: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')]} 18:31:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31: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', '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 0x7fc4161ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b9eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9bf60>, '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 0x2b9cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9d1d0>, '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': '826874ccc97bd7bf541b4875000001d5-1475882853.774275-693207389', '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 18:31: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:31: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 functools32==3.2.3-2 18:31:34 INFO - Using env: {'DISPLAY': ':0', 18:31:34 INFO - 'HOME': '/home/cltbld', 18:31:34 INFO - 'LANG': 'en_US.UTF-8', 18:31:34 INFO - 'LANGUAGE': 'en_US:en', 18:31:34 INFO - 'LOGNAME': 'cltbld', 18:31:34 INFO - 'MAIL': '/var/mail/cltbld', 18:31:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:34 INFO - 'MOZ_NO_REMOTE': '1', 18:31:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:34 INFO - 'NO_EM_RESTART': '1', 18:31:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:34 INFO - 'PWD': '/builds/slave/test', 18:31:34 INFO - 'SHELL': '/bin/bash', 18:31:34 INFO - 'SHLVL': '1', 18:31:34 INFO - 'TERM': 'linux', 18:31:34 INFO - 'TMOUT': '86400', 18:31:34 INFO - 'USER': 'cltbld', 18:31:34 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1475882853.774275-693207389', 18:31:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:34 INFO - '_': '/tools/buildbot/bin/python'} 18:31:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:31:34 INFO - Cleaning up... 18:31:34 INFO - Return code: 0 18:31:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:31: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')]} 18:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31: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')]} 18:31:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31: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', '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 0x7fc4161ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b9eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9bf60>, '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 0x2b9cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9d1d0>, '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': '826874ccc97bd7bf541b4875000001d5-1475882853.774275-693207389', '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 18:31: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:31: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 blobuploader==1.2.4 18:31:34 INFO - Using env: {'DISPLAY': ':0', 18:31:34 INFO - 'HOME': '/home/cltbld', 18:31:34 INFO - 'LANG': 'en_US.UTF-8', 18:31:34 INFO - 'LANGUAGE': 'en_US:en', 18:31:34 INFO - 'LOGNAME': 'cltbld', 18:31:34 INFO - 'MAIL': '/var/mail/cltbld', 18:31:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:34 INFO - 'MOZ_NO_REMOTE': '1', 18:31:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:34 INFO - 'NO_EM_RESTART': '1', 18:31:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:34 INFO - 'PWD': '/builds/slave/test', 18:31:34 INFO - 'SHELL': '/bin/bash', 18:31:34 INFO - 'SHLVL': '1', 18:31:34 INFO - 'TERM': 'linux', 18:31:34 INFO - 'TMOUT': '86400', 18:31:34 INFO - 'USER': 'cltbld', 18:31:34 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1475882853.774275-693207389', 18:31:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:34 INFO - '_': '/tools/buildbot/bin/python'} 18:31:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:34 INFO - Downloading/unpacking blobuploader==1.2.4 18:31: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 18:31: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 18:31: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 18:31: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 18:31: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 18:31: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 18:31:36 INFO - Downloading blobuploader-1.2.4.tar.gz 18:31:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:31:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:31: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 18:31: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 18:31: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 18:31: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 18:31: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 18:31: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 18:31:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:31:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:31: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 18:31: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 18:31: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 18:31: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 18:31: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 18:31: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 18:31:37 INFO - Downloading docopt-0.6.1.tar.gz 18:31:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:31:37 INFO - Installing collected packages: blobuploader, requests, docopt 18:31:37 INFO - Running setup.py install for blobuploader 18:31:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:31:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:31:37 INFO - Running setup.py install for requests 18:31:37 INFO - Running setup.py install for docopt 18:31:38 INFO - Successfully installed blobuploader requests docopt 18:31:38 INFO - Cleaning up... 18:31:38 INFO - Return code: 0 18:31:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:31:38 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')]} 18:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:38 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')]} 18:31:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:38 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 0x7fc4161ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b9eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9bf60>, '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 0x2b9cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9d1d0>, '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': '826874ccc97bd7bf541b4875000001d5-1475882853.774275-693207389', '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 18:31:38 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 18:31:38 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 18:31:38 INFO - Using env: {'DISPLAY': ':0', 18:31:38 INFO - 'HOME': '/home/cltbld', 18:31:38 INFO - 'LANG': 'en_US.UTF-8', 18:31:38 INFO - 'LANGUAGE': 'en_US:en', 18:31:38 INFO - 'LOGNAME': 'cltbld', 18:31:38 INFO - 'MAIL': '/var/mail/cltbld', 18:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:38 INFO - 'MOZ_NO_REMOTE': '1', 18:31:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:38 INFO - 'NO_EM_RESTART': '1', 18:31:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:38 INFO - 'PWD': '/builds/slave/test', 18:31:38 INFO - 'SHELL': '/bin/bash', 18:31:38 INFO - 'SHLVL': '1', 18:31:38 INFO - 'TERM': 'linux', 18:31:38 INFO - 'TMOUT': '86400', 18:31:38 INFO - 'USER': 'cltbld', 18:31:38 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1475882853.774275-693207389', 18:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:38 INFO - '_': '/tools/buildbot/bin/python'} 18:31:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:31:38 INFO - Running setup.py (path:/tmp/pip-XeCkry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:31:38 INFO - Running setup.py (path:/tmp/pip-QSSMX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:31:38 INFO - Running setup.py (path:/tmp/pip-KkpS_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:31:38 INFO - Running setup.py (path:/tmp/pip-df5WpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:31:38 INFO - Running setup.py (path:/tmp/pip-FZL4BH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:31:38 INFO - Running setup.py (path:/tmp/pip-q0KJUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:31:38 INFO - Running setup.py (path:/tmp/pip-6IScrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:31:38 INFO - Running setup.py (path:/tmp/pip-FF9IUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:31:38 INFO - Running setup.py (path:/tmp/pip-fnlk18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:31:39 INFO - Running setup.py (path:/tmp/pip-6lgP_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:31:39 INFO - Running setup.py (path:/tmp/pip-Ee_qRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:31:39 INFO - Running setup.py (path:/tmp/pip-uRscve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:31:39 INFO - Running setup.py (path:/tmp/pip-XxUqbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:31:39 INFO - Running setup.py (path:/tmp/pip-nEcP4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:39 INFO - Running setup.py (path:/tmp/pip-FRr9i_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:31:39 INFO - Running setup.py (path:/tmp/pip-RqqFvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:31:39 INFO - Running setup.py (path:/tmp/pip-qPC1zC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:31:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:31:39 INFO - Running setup.py install for manifestparser 18:31:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:31:39 INFO - Running setup.py install for mozcrash 18:31:39 INFO - Running setup.py install for mozdebug 18:31:39 INFO - Running setup.py install for mozdevice 18:31:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:31:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:31:40 INFO - Running setup.py install for mozfile 18:31:40 INFO - Running setup.py install for mozhttpd 18:31:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:31:40 INFO - Running setup.py install for mozinfo 18:31:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:31:40 INFO - Running setup.py install for mozInstall 18:31:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:31:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:31:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:31:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:31:40 INFO - Running setup.py install for mozleak 18:31:40 INFO - Running setup.py install for mozlog 18:31:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:31:40 INFO - Running setup.py install for moznetwork 18:31:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:31:40 INFO - Running setup.py install for mozprocess 18:31:40 INFO - Running setup.py install for mozprofile 18:31:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:31:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:31:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:31:40 INFO - Running setup.py install for mozrunner 18:31:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:31:41 INFO - Running setup.py install for mozscreenshot 18:31:41 INFO - Running setup.py install for moztest 18:31:41 INFO - Running setup.py install for mozversion 18:31:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:31:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:31:41 INFO - Cleaning up... 18:31:41 INFO - Return code: 0 18:31:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:31:41 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')]} 18:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:41 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')]} 18:31:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:41 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 0x7fc4161ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b9eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9bf60>, '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 0x2b9cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9d1d0>, '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': '826874ccc97bd7bf541b4875000001d5-1475882853.774275-693207389', '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 18:31:41 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 18:31:41 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 18:31:41 INFO - Using env: {'DISPLAY': ':0', 18:31:41 INFO - 'HOME': '/home/cltbld', 18:31:41 INFO - 'LANG': 'en_US.UTF-8', 18:31:41 INFO - 'LANGUAGE': 'en_US:en', 18:31:41 INFO - 'LOGNAME': 'cltbld', 18:31:41 INFO - 'MAIL': '/var/mail/cltbld', 18:31:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:41 INFO - 'MOZ_NO_REMOTE': '1', 18:31:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:41 INFO - 'NO_EM_RESTART': '1', 18:31:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:41 INFO - 'PWD': '/builds/slave/test', 18:31:41 INFO - 'SHELL': '/bin/bash', 18:31:41 INFO - 'SHLVL': '1', 18:31:41 INFO - 'TERM': 'linux', 18:31:41 INFO - 'TMOUT': '86400', 18:31:41 INFO - 'USER': 'cltbld', 18:31:41 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1475882853.774275-693207389', 18:31:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:41 INFO - '_': '/tools/buildbot/bin/python'} 18:31:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:31:41 INFO - Running setup.py (path:/tmp/pip-jH8ZEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:31:41 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)) 18:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:31:41 INFO - Running setup.py (path:/tmp/pip-QAqQhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:31:41 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)) 18:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:31:41 INFO - Running setup.py (path:/tmp/pip-T3OwBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:31:41 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)) 18:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:31:41 INFO - Running setup.py (path:/tmp/pip-mSZOV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:31:41 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)) 18:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:31:41 INFO - Running setup.py (path:/tmp/pip-AZTYPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:31:41 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)) 18:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:31:41 INFO - Running setup.py (path:/tmp/pip-2UqtsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:31:42 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)) 18:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:31:42 INFO - Running setup.py (path:/tmp/pip-RFdA9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:31:42 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)) 18:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:31:42 INFO - Running setup.py (path:/tmp/pip-O3zU1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:31:42 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)) 18:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:31:42 INFO - Running setup.py (path:/tmp/pip-gGjRxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:31:42 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)) 18:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:31:42 INFO - Running setup.py (path:/tmp/pip-RW6knD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:31:42 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)) 18:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:31:42 INFO - Running setup.py (path:/tmp/pip-IKIfmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:31:42 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)) 18:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:31:42 INFO - Running setup.py (path:/tmp/pip-Kl3Wf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:31:42 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)) 18:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:31:42 INFO - Running setup.py (path:/tmp/pip-sWOwfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:31:42 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)) 18:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:31:42 INFO - Running setup.py (path:/tmp/pip-QBZcLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:31:42 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)) 18:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:42 INFO - Running setup.py (path:/tmp/pip-9b9aiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:42 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)) 18:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:31:42 INFO - Running setup.py (path:/tmp/pip-Ak2Hc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:31:42 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)) 18:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:31:42 INFO - Running setup.py (path:/tmp/pip-aQtT3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:31:42 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)) 18:31:42 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)) 18:31:42 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)) 18:31:42 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)) 18:31:42 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)) 18:31:42 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)) 18:31:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:44 INFO - Downloading blessings-1.6.tar.gz 18:31:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:31:44 INFO - Installing collected packages: blessings 18:31:44 INFO - Running setup.py install for blessings 18:31:44 INFO - Successfully installed blessings 18:31:44 INFO - Cleaning up... 18:31:45 INFO - Return code: 0 18:31:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:31:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:31:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:31:45 INFO - Reading from file tmpfile_stdout 18:31:45 INFO - Current package versions: 18:31:45 INFO - argparse == 1.2.1 18:31:45 INFO - blessings == 1.6 18:31:45 INFO - blobuploader == 1.2.4 18:31:45 INFO - docopt == 0.6.1 18:31:45 INFO - functools32 == 3.2.3-2 18:31:45 INFO - jsonschema == 2.5.1 18:31:45 INFO - manifestparser == 1.1 18:31:45 INFO - mozInstall == 1.12 18:31:45 INFO - mozcrash == 0.17 18:31:45 INFO - mozdebug == 0.1 18:31:45 INFO - mozdevice == 0.48 18:31:45 INFO - mozfile == 1.2 18:31:45 INFO - mozhttpd == 0.7 18:31:45 INFO - mozinfo == 0.9 18:31:45 INFO - mozleak == 0.1 18:31:45 INFO - mozlog == 3.4 18:31:45 INFO - moznetwork == 0.27 18:31:45 INFO - mozprocess == 0.23 18:31:45 INFO - mozprofile == 0.28 18:31:45 INFO - mozrunner == 6.12 18:31:45 INFO - mozscreenshot == 0.1 18:31:45 INFO - mozsystemmonitor == 0.3 18:31:45 INFO - moztest == 0.7 18:31:45 INFO - mozversion == 1.4 18:31:45 INFO - psutil == 3.1.1 18:31:45 INFO - requests == 1.2.3 18:31:45 INFO - wsgiref == 0.1.2 18:31:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:31:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:45 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 0x7fc4161ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b9eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9bf60>, '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 0x2b9cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9d1d0>, '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': '826874ccc97bd7bf541b4875000001d5-1475882853.774275-693207389', '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 18:31:45 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 18:31:45 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 18:31:45 INFO - Using env: {'DISPLAY': ':0', 18:31:45 INFO - 'HOME': '/home/cltbld', 18:31:45 INFO - 'LANG': 'en_US.UTF-8', 18:31:45 INFO - 'LANGUAGE': 'en_US:en', 18:31:45 INFO - 'LOGNAME': 'cltbld', 18:31:45 INFO - 'MAIL': '/var/mail/cltbld', 18:31:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:45 INFO - 'MOZ_NO_REMOTE': '1', 18:31:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:45 INFO - 'NO_EM_RESTART': '1', 18:31:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:45 INFO - 'PWD': '/builds/slave/test', 18:31:45 INFO - 'SHELL': '/bin/bash', 18:31:45 INFO - 'SHLVL': '1', 18:31:45 INFO - 'TERM': 'linux', 18:31:45 INFO - 'TMOUT': '86400', 18:31:45 INFO - 'USER': 'cltbld', 18:31:45 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1475882853.774275-693207389', 18:31:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:45 INFO - '_': '/tools/buildbot/bin/python'} 18:31:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:45 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)) 18:31:45 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)) 18:31:45 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)) 18:31:45 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)) 18:31:45 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)) 18:31:45 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)) 18:31:45 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)) 18:31:45 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)) 18:31:45 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)) 18:31:45 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)) 18:31:45 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)) 18:31:45 INFO - Cleaning up... 18:31:45 INFO - Return code: 0 18:31:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:31:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:45 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 0x7fc4161ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b9eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9bf60>, '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 0x2b9cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9d1d0>, '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': '826874ccc97bd7bf541b4875000001d5-1475882853.774275-693207389', '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 18:31:45 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 18:31:45 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 18:31:45 INFO - Using env: {'DISPLAY': ':0', 18:31:45 INFO - 'HOME': '/home/cltbld', 18:31:45 INFO - 'LANG': 'en_US.UTF-8', 18:31:45 INFO - 'LANGUAGE': 'en_US:en', 18:31:45 INFO - 'LOGNAME': 'cltbld', 18:31:45 INFO - 'MAIL': '/var/mail/cltbld', 18:31:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:45 INFO - 'MOZ_NO_REMOTE': '1', 18:31:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:45 INFO - 'NO_EM_RESTART': '1', 18:31:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:45 INFO - 'PWD': '/builds/slave/test', 18:31:45 INFO - 'SHELL': '/bin/bash', 18:31:45 INFO - 'SHLVL': '1', 18:31:45 INFO - 'TERM': 'linux', 18:31:45 INFO - 'TMOUT': '86400', 18:31:45 INFO - 'USER': 'cltbld', 18:31:45 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1475882853.774275-693207389', 18:31:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:45 INFO - '_': '/tools/buildbot/bin/python'} 18:31:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:31:45 INFO - Cleaning up... 18:31:45 INFO - Return code: 0 18:31:45 INFO - Running post-action listener: _resource_record_post_action 18:31:45 INFO - Running post-action listener: _start_resource_monitoring 18:31:45 INFO - Starting resource monitoring. 18:31:45 INFO - [mozharness: 2016-10-08 01:31:45.722351Z] Finished create-virtualenv step (success) 18:31:45 INFO - [mozharness: 2016-10-08 01:31:45.722910Z] Running install step. 18:31:45 INFO - Running pre-action listener: _resource_record_pre_action 18:31:45 INFO - Running main action method: install 18:31:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:31:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:31:45 INFO - Reading from file tmpfile_stdout 18:31:45 INFO - Detecting whether we're running mozinstall >=1.0... 18:31:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:31:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:31:46 INFO - Reading from file tmpfile_stdout 18:31:46 INFO - Output received: 18:31:46 INFO - Usage: mozinstall [options] installer 18:31:46 INFO - Options: 18:31:46 INFO - -h, --help show this help message and exit 18:31:46 INFO - -d DEST, --destination=DEST 18:31:46 INFO - Directory to install application into. [default: 18:31:46 INFO - "/builds/slave/test"] 18:31:46 INFO - --app=APP Application being installed. [default: firefox] 18:31:46 INFO - mkdir: /builds/slave/test/build/application 18:31:46 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'] 18:31:46 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 18:32:03 INFO - Reading from file tmpfile_stdout 18:32:03 INFO - Output received: 18:32:03 INFO - /builds/slave/test/build/application/firefox/firefox 18:32:03 INFO - Running post-action listener: _resource_record_post_action 18:32:03 INFO - [mozharness: 2016-10-08 01:32:03.044890Z] Finished install step (success) 18:32:03 INFO - [mozharness: 2016-10-08 01:32:03.044994Z] Running run-tests step. 18:32:03 INFO - Running pre-action listener: _resource_record_pre_action 18:32:03 INFO - Running main action method: run_tests 18:32:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:32:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:32:03 INFO - Python 2.7.3 18:32:03 INFO - Return code: 0 18:32:03 INFO - grabbing minidump binary from tooltool 18:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:32:03 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 0x2b9bf60>, '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 0x2b9cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9d1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:32:03 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 18:32:03 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 18:32:03 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 18:32:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:32:03 INFO - Return code: 0 18:32:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:32:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:32:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:32:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:32:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:32:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XVRgdMumQdiC5sgjdilezA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 18:32:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XVRgdMumQdiC5sgjdilezA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --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 18:32:03 INFO - Using env: {'DISPLAY': ':0', 18:32:03 INFO - 'HOME': '/home/cltbld', 18:32:03 INFO - 'LANG': 'en_US.UTF-8', 18:32:03 INFO - 'LANGUAGE': 'en_US:en', 18:32:03 INFO - 'LOGNAME': 'cltbld', 18:32:03 INFO - 'MAIL': '/var/mail/cltbld', 18:32:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:32:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:32:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:03 INFO - 'MOZ_NO_REMOTE': '1', 18:32:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:32:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:32:03 INFO - 'NO_EM_RESTART': '1', 18:32:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:32:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:03 INFO - 'PWD': '/builds/slave/test', 18:32:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:32:03 INFO - 'SHELL': '/bin/bash', 18:32:03 INFO - 'SHLVL': '1', 18:32:03 INFO - 'TERM': 'linux', 18:32:03 INFO - 'TMOUT': '86400', 18:32:03 INFO - 'USER': 'cltbld', 18:32:03 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1475882853.774275-693207389', 18:32:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:03 INFO - '_': '/tools/buildbot/bin/python'} 18:32:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XVRgdMumQdiC5sgjdilezA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 18:32:03 INFO - mozversion application_buildid: 20161007153043 18:32:03 INFO - mozversion application_changeset: 66bbe7f0d664f2164fa7371608e3563c54ce8d55 18:32:03 INFO - mozversion application_display_name: Nightly 18:32:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:32:03 INFO - mozversion application_name: Firefox 18:32:03 INFO - mozversion application_remotingname: firefox 18:32:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:32:03 INFO - mozversion application_vendor: Mozilla 18:32:03 INFO - mozversion application_version: 52.0a1 18:32:03 INFO - mozversion platform_buildid: 20161007153043 18:32:03 INFO - mozversion platform_changeset: 66bbe7f0d664f2164fa7371608e3563c54ce8d55 18:32:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:32:03 INFO - mozversion platform_version: 52.0a1 18:32:03 INFO - using testdate: 1475890323 18:32:03 INFO - actual date: 1475890323 18:32:03 INFO - starting webserver on 'localhost:43023' 18:32:03 INFO - SUITE-START | Running 2 tests 18:32:03 INFO - TEST-START | dromaeo_css 18:32:03 INFO - operating with platform_type : linux_ 18:32:03 INFO - Initialising browser for dromaeo_css test... 18:32:03 INFO - TEST-INFO | started process 8284 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMNssZ4/profile http://localhost:43023/getInfo.html) 18:32:07 INFO - PROCESS | 8284 | __metrics Screen width/height:1600/1200 18:32:07 INFO - PROCESS | 8284 | colorDepth:24 18:32:07 INFO - PROCESS | 8284 | Browser inner width/height: 1024/697 18:32:07 INFO - PROCESS | 8284 | __metrics 18:32:08 INFO - PROCESS | 8284 | 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" 18:32:08 INFO - PROCESS | 8284 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:32:08 INFO - PROCESS | 8284 | console.error: PushService: 18:32:08 INFO - PROCESS | 8284 | stateChangeProcessEnqueue: Error transitioning state 18:32:08 INFO - PROCESS | 8284 | UnknownError 18:32:09 INFO - TEST-INFO | 8284: exit 0 18:32:09 INFO - Browser initialized. 18:32:09 INFO - Running cycle 1/1 for dromaeo_css test... 18:32:09 INFO - TEST-INFO | started process 8364 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMNssZ4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:32:21 INFO - PROCESS | 8364 | RSS: Main: 172920832 18:32:21 INFO - PROCESS | 8364 | 18:33:12 INFO - PROCESS | 8364 | 1475890392891 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] 18:35:23 INFO - PROCESS | 8364 | Cycle 1(1): loaded http://localhost:43023/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43023/tests/dromaeo/cssquery-ext.html) 18:35:24 INFO - PROCESS | 8364 | RSS: Main: 290267136 18:35:24 INFO - PROCESS | 8364 | 18:38:26 INFO - PROCESS | 8364 | Cycle 1(1): loaded http://localhost:43023/tests/dromaeo/cssquery-ext.html (next: http://localhost:43023/tests/dromaeo/cssquery-jquery.html) 18:38:27 INFO - PROCESS | 8364 | RSS: Main: 281866240 18:38:27 INFO - PROCESS | 8364 | 18:41:29 INFO - PROCESS | 8364 | Cycle 1(1): loaded http://localhost:43023/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43023/tests/dromaeo/cssquery-mootools.html) 18:41:30 INFO - PROCESS | 8364 | RSS: Main: 252903424 18:41:30 INFO - PROCESS | 8364 | 18:44:32 INFO - PROCESS | 8364 | Cycle 1(1): loaded http://localhost:43023/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43023/tests/dromaeo/cssquery-prototype.html) 18:44:32 INFO - PROCESS | 8364 | RSS: Main: 245288960 18:44:32 INFO - PROCESS | 8364 | 18:47:35 INFO - PROCESS | 8364 | Cycle 1(1): loaded http://localhost:43023/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43023/tests/dromaeo/cssquery-yui.html) 18:47:36 INFO - PROCESS | 8364 | RSS: Main: 216117248 18:47:36 INFO - PROCESS | 8364 | 18:50:38 INFO - PROCESS | 8364 | Cycle 1(1): loaded http://localhost:43023/tests/dromaeo/cssquery-yui.html (next: http://localhost:43023/tests/dromaeo/cssquery-dojo.html) 18:50:39 INFO - PROCESS | 8364 | RSS: Main: 307380224 18:50:39 INFO - PROCESS | 8364 | 18:50:39 INFO - PROCESS | 8364 | __start_tp_report 18:50:39 INFO - PROCESS | 8364 | _x_x_mozilla_page_load 18:50:39 INFO - PROCESS | 8364 | _x_x_mozilla_page_load_details 18:50:39 INFO - PROCESS | 8364 | |i|pagename|runs| 18:50:39 INFO - PROCESS | 8364 | |0;dojo.html;2998.2354499602607;3027;3030.3333266681334;3057.9541306880387;3085.845707714615;5108.208227724699;5164.793408263665;5207.609429292799;5303.204519322098;5313.89372212556;5217.243499692552;5243.3970093439175;5276.076686579842;5327.227552004957;5334.786608535654;4750.073735621555;4789.928151077736;4809.855704328858;4823.0353929214125;4867.707937523742;4933.161362568354;4965.230389289648;4976.054549635558;4978.6514943953935;5000.124978128831;4691.319758635013;4740.45484769249;4744.691595046311;4945.233488809223;4960.950390496121;4743;4789.904201915942;4790.976045119787;4808.807647694088;4819.5180481951875;4709.976450117728;4731.503192164842;4737.50256223095;4738.8341408050555;4782;5282.339707536558;5301.7084060376665;5306.151015837448;5310.8141215057285;5314.256004159421;5493.7802487900435;5532.474414930575;5557.749901254453;5573.359063707685;5642.520385767215;5576.470235327637;5578.330600327987;5590.748416321276;5601.859953501154;5659.264295641581;5194.948050519484;5199.402068762103;5201.895962080737;5253.028189784902;5283.841484755463;5624.409437009137;5657.915131273035;5679.460451257124;5685.118806584986;5750.166225897222;5473.808416705396;5575.888482230333;5578.2748242728185;5579.38626751057;5580.888382232332;5541.722913854291;5579.944200558024;5587.804426845041;5593;5594.412586678422;5571.9442805571425;5572.136318870582;5578.30271216098;5585.860353491195;5629.887402251932;5457.672539647634;5503.449655034465;5508.64193827408;5519.448055194529;5567.526760225345;4304.246756817544;4345.087531618332;4354.847580334736;4355.869323920288;4389.078293558325;3856.9035774105873;3862.6909847212155;3867.4778904847485;3909.100906791454;3911.393733971239;5328.17413300939;5330.173823057432;5333.146696528537;5337.039332920034;5337.039332920034;5431.972840135853;5491.148871924778;5491.423400542885;5590.552755779528;5635.492805647511;5336.62643614951;5336.973315133477;5405.70268635221;5423.132298832247;5439.374471935699;4778.092162489116;4791.808327666854;4818.325434439182;4830.275458681226;4845.9030819383415;5503.11950087984;5643.746031428514;5793.391693872167;5795.88408231833;5798.478136967608;5544.279243698294;5570.303712035996;5582.972085139549;5585.525230355465;5670.461306175906;5717.22817419643;5734.025215713255;5737.225474560881;5738.368779434342;5745.827625171251;5426.403095659395;5517.806876759294;5518.365387980433;5525.861853453695;5528.889422211614;5498.532624726783;5513.696746678971;5558.833235002957;5570.080936645408;5648.689322087324;5489.39616642161;5491.423400542885;5493.478119578634;5495.725213739377;5496.450354964471;5485.6434331768305;5495.697736624524;5495.835124946258;5497.36780270274;5562.026645336969;5380.246765452918;5413.756380962945;5421.5933804964;5446.128619420873;5462.235287059894;5484.808031718871;5521.613487055867;5525.668459892419;5527.364353099445;5570.442955704397;5395.298611180521;5408.675479471244;5410.296661433988;5411.350637923474;5421.434134068084 18:50:39 INFO - PROCESS | 8364 | |1;ext.html;583.2097507876827;604.250729095921;609.7835268479693;615.5444970721667;629.3706293706293;30471.238219044506;31028;41579.37630935534;42570.14859702804;42721.786391068;43865.561344386544;44224.77887610557;44249.7787511062;44287.335689964675;44323.33514997278;8673.176048275403;8832.249258813008;8832.381733278673;8832.646694132227;8834.690785822497;7957.164497727742;8150.062742784567;8652.697155599555;10289.382637041765;10546.367217966947;10648.361098334086;10710.571577136905;10712.25014249003;10715.142788576895;10715.410652414113;10517.631882884063;10566;10588.682339529827;10594.099501542378;10618.734531636694;10337.431441270726;10360.274780765349;10363.637272695494;10363.844542331872;10405.47972601367;41130.79434602838;41266.174676506605;41410.79294603538;41418;41471.58528414708;3468.1849765305133;3562.9109272268142;3594.1194407370363;3613.94579081314;3695.4826324314618;30421;31656.841715791503;31710;31829;31840.681593184236;4234.640055595278;4325.675574331906;4334.241507736165;4506.278995360759;4508.278675411918;329947;331775;332408;333017;334066;54761;54983.72508137434;55167;55503.444965549825;55514.72242638761;57415.52643813724;57900.710496447246;57932;57970.710146449;57971.420285797445;15349.386024558893;15518.534443966699;15547.30037148331;15550.14474203907;15551.611209719622;10546.209034322457;12240.44917978693;12291;12292.139550231577;12297.200681955645;13606.455741770416;15087.094774313577;15591.844081559266;15593.766093508606;16236.51290461288;6123.540734444845;6172.321044685081;6298.307186209513;6417.294097649255;6507.739690412425;934.8270569944582;1022.2417441999748;1024.6516184497307;1079.9632352941107;1086.5436516663021;31470;31495.78128260947;31606.841965790023;31662;31917.84041079826;1070.1813112968584;1097.4238524774557;1119.535392811974;1146.644540192543;1170.151640060949;17058.402955896483;17510.562235943948;17646.91176544109;18161.63676726458;18277.177527011052;218138;491998;503029;505656;716135;49170;49962;52815;54502.72748636311;55583.444165558634;1344.6503908983734;1347.2926713475308;1365.7336819320137;1369.9862102044615;1375.408574313055;29331.853340734015;30620.84689576538;30682.693173068878;30822.69177308288;31023.379532409675;47787.522124778305;48137;48586;48593.5140648589;48603.27095093505;433058;437700;437767;439056;439086;26740;27063;27099.458010840066;27117.779699913157;27118.864405677847;44805.77597111993;46311.76844115893;46342.76828615835;49645;51042.234366485274;38925.61074389333;39274.41088383619;39410.605893940694;40938.795306023276;41141.382879257435;38564.6143538561;38997;39810.601893981846;40015.1996960065;41233.793831030656;38930.6106938927;40322.39516407315;40690.389644155955;41019.384709229984;41041.79479102585;31364.843175783975;35826.462603060456;37728.62271377251;38499.198949180805;38723.806380967915;27425.45149096967;27492.05143074266;27580;27645;27846.86076569604 18:50:39 INFO - PROCESS | 8364 | |2;jquery.html;380.3344147741453;386.9922601547969;386.9980650096751;397.98806035818916;415.8710799652108;13429.33625119678;15390.384384624616;17267.39564115256;19322.420327390202;19779.703304450446;18592.721109183338;18811.717824232648;19061.809381906176;19082.904585477052;19624;5291.788328466857;5599.524040456566;5846.152307915371;5848.41515848416;5851.941480585204;5682.573806964473;5711.485966263035;5739.483446489815;5767.567432442584;5770.163326317682;5602.13166959122;5665.433456654343;5731.512821410185;5734;5746.942530574683;5637.2107904893555;5668.829935101953;5678.744456499468;5711.228984087157;5741.626794258381;4910.803567857281;5067.797288108472;5101.005303965728;5105.774614092628;5115.283860259567;22168.445788855246;22278.777212227833;22578.322650320515;23218.53562928732;23298.301050968497;2325.976740232593;2548.554003049459;2565.7305982871717;2926.88292468301;3092.7989680670685;14284.57146285613;14680.632984175374;14681.559553213421;14712.117272963656;15127.848721512753;1834.2662934826044;1934.1006432009042;1946.1492773708092;1951.5218771401098;1977.2486455147096;81514.59242703808;81733.59133204295;81922.59038704769;82930;83045.16954830434;10547.411875834037;10724.410157441416;10799.730006749895;10816.134709223243;11005;14885.255737213096;14897.77653335201;14906.540420830659;14911.850881491046;14951;7637.274458926393;7769.689212431553;7869.921300786918;7909.169537198626;7947;7456;7559.735409260649;7736.922630773733;7740.961295193488;7770.572618506037;4167.562405947392;4280.657547396263;4295.183915056192;4404.383386325917;4404.4494438195225;1787.767590213264;1820.390169293275;1861.5625328047897;1930.4787707318944;1939.156466936887;864.6541383446672;934.243262957007;961.8076384722943;973.2408721197477;974.3082411487782;18182.09089545544;19557.8044219556;19650.508737281398;19710.310139145062;19715.802841971683;944.2163004706077;957.5547370472764;975.492743773234;1007.7329507680471;1010.5200029985698;10664;11354.3755093469;11609.187356885106;11756.882431175578;11792.587259445878;448280;450033;470603;471382;474408;86520;86943.56528217444;87682;88352.55823720968;88499.55750221337;1016.1058268723476;1023.3348323589727;1054.383185836279;1055.9524821383056;1057.7091299892438;15987.840121598636;17099.230534626222;17710.20304086345;17929.82070179334;18363.449096527125;38760.224795504495;39875.408098473505;39923.00192495211;40311.79844100761;40722;52300.21549676682;55057.724711376184;55169;56048;58046.7097664509;8206.466579672302;8373.665053397795;8399.370047246359;8511.95744021276;8766.517841518778;10862.402567858528;12592.74814503723;12699.619011429671;12748.936255318664;13352.332383380986;10985.725356866142;11139.220254582102;11166.888331116585;11436.485358158736;11688.240264383128;5295.655782374133;9514.620380044993;10945.616903408343;11086.833697494383;11942.462589183333;10800.189985750943;10831.675049748204;10896.455177241265;11047.72380690489;12056.71300308502;8437.240648341678;8519.787005324668;8585.441946273471;8696.347773916856;8874.733757987271;10067.69796906094;10713.35719856811;10744.623938162127;10849.728756781144;11231.101511878867 18:50:39 INFO - PROCESS | 8364 | |3;mootools.html;1364.6315494816406;1490.6422458609934;1515.3408267403681;1668.3576822923171;1796.2994432171456;8028.35773138149;8637.568121593926;9052.683156089539;9060;9246.583903724331;9064.04827493112;9127.726168214947;9145.817083658323;9148.542572871347;9152.222061124812;2304.562133194692;2331.3705299569106;2341.718993720756;2346.694929659142;2353.4234112642425;2332.265336419031;2359.6460530920413;2376.584097782881;2379.9048038078454;2382.106709983756;2294.3117064880553;2333.8366314358;2336.4275752440676;2350.247920665388;2352.635341522067;2245.4610893385634;2255.672927425522;2259.288324177887;2265.139247086097;2292.9541409171807;2238.8917485844613;2240.0703707961175;2242.8766417847014;2244.472548950995;2244.62963611004;8838.734837954871;9013;9047.909520904772;9096.545172741402;9166.358354915159;5157.742112894378;5360.892782144374;5361.946380536184;5362.329708786402;5373.731313434313;3497.055794935379;3531.099569609759;3576.9821150894077;3583.6595523425235;3585.8027808470524;1060.9257351985364;1074.9677509674723;1104.6575561575937;1122.3826895207685;1128.542940109257;12534.310612916286;12542.937285313606;12573.559925402567;12575.308358040304;12589.30758808265;4372.803223854934;4545.0909818036525;4618.745968971739;4634.21218392874;4661.137689527448;10014.699559013241;10035.849462258071;10046.949765251273;10047.698569042794;10053;5419.34967803866;5422.349318081777;5424.430434804368;5430.83707488776;5431.293931788842;4530.161920044802;4671.042436300618;4873.951260487421;4963.5780958618925;5082.644214904921;3754.2866855297407;3873.4189871519498;3918.4710064141545;3919.7060220483577;4074.6943979201087;1178.6287319494504;1193.9044876409866;1193.9820902686467;1198.101423932051;1212.5877201751448;861.8621020636793;862.5256109139948;891.7235656946237;909.3225546967551;925.4077390470104;5668.234788303609;5672.773089076473;5757.366689664133;5846.242625038574;6059.454649081604;931.3759780946782;935.1396715022059;945.0785484152896;955.5938726041404;974.7222041718077;3842.7886466244627;3956.723029387973;3980.661643760313;4041;4051.5745846686264;10666.200034997406;11354.318740875575;11384.886151138548;11433.59982400612;11461.312321260752;11218.326900386002;11269.66191014271;11495.42522873853;11502.367369794742;11525.250858694159;8296.419250652518;8495.575221238912;8522.74431767048;8528.488290702579;8562.828743424972;5676.17695434168;5696.686682232351;5774.82675519735;5782.392848750821;5970.761169553343;10420.531076101443;10517.579296828042;10578.523966421684;10608.098311643596;10759.515821787882;10091.344062635904;10585.364878107339;10589.523471443958;10851.294665846695;10901.34591924487;7265.673044712895;7456.7762967111075;7719.729809456642;8005.7197998072115;8194.42639015287;8515.020772610982;8882.555872206492;8899.421537600036;8904.020557738773;8908;7811.765647030598;7832.5348388762;8036.638351274323;8063.354931605575;8156.755297341089;7805.9609701953395;7856.882146767689;7890.526568405914;7925.762227132965;7934.444588878954;6524.184476940382;6599.439047681001;6602.8349291268105;6603.702833372414;6661.400473957173;5016.473270306566;5073.644844860824;5120.385553733576;5147.073526765218;5325.414204437587;5032.169692000779;5047.343845300087;5108.157154069537;5151.201563757623;5341.465853414627 18:50:39 INFO - PROCESS | 8364 | |4;prototype.html;335.3434035862837;338.4855020369039;346.98959031229055;354.18360678635736;356.5543071161047;5029.924551131736;5090.669106508074;5247.737613119343;5263.1578947368425;5282.841514754558;4984.17761069424;5123.641345105844;5130.769115389807;5150.22746588012;5183.53348198662;4087.9591204087874;4102.671786257092;4113.917721645573;4122.567130451304;4176.164767046603;3986.940195897064;4150.97924510377;4170.833166673329;4191.40133117466;4193.937090943623;4114.218298523286;4141.295979683446;4145.150244199932;4148.357004664267;4156.833726650931;4121.62905338518;4134.297169481196;4149.315362965107;4150.128473020669;4169.6455801256925;3715.6841668458214;3721.683656889141;3722.497462842509;3732.5520937487404;3735.4957080794015;4927.77824997876;4971.304017437562;5044.924326135111;5052.595792336604;5062.012907483042;4667.346571479996;4681.648876334289;4724.692894961817;4725.480197178307;4733.006068725572;5352.598555108382;5375.381831089436;5377.919331210035;5397.78408863645;5398.083680293478;3905.5508616508896;3986.3223252047223;4005.359142537209;4007.6593489553425;4028.2144981728575;5585.944140558624;5602.4957753802355;5603.271574695345;5618.269624948731;5618.494335509783;4110.280700877334;4119.279126152971;4124.587541245912;4133.256013917524;4166.604172603597;4067.8911510418484;4073.816678249486;4135.234981528427;4154.875353739392;4181.623653871166;4565.634749220055;4619.8450387403145;4675.57919787214;4678.555537223959;4689.804099954558;5371.973140134274;5374.4528611116475;5400.378956419983;5406.756446017359;5413.188021796762;1355.8272094638264;1381.5095641047485;1404.9789253161211;1432.9355179016968;1442.4662874736205;984.2322988069318;1007.9193664506822;1024.0936770957755;1027.3579013116803;1032.7314898126542;5176.456472070454;5178.559822415137;5188.403333616682;5207.427183009866;5225.529702326809;5425.419223312673;5436.374816896028;5472.699001554873;5482.5613950884635;5513.145462453326;5032.7735251913755;5141.151709967889;5150.665206761623;5150.742462876841;5312.5484333832055;2927.326714855595;2946.587477753116;2948.5110019440476;2966.8664910079096;2967.866446009935;5712.257406537124;5714.857128571819;5738.340090889517;5742.368339482654;5746.109353050284;5542.889142217133;5639.182318563785;5641.435856414326;5675.460831221028;5696.743646535916;5583.916241256466;5592.217089607459;5597.160425936061;5626.508975121596;5626.7339848534575;5440.483154100354;5530.391656917655;5548.250986116984;5559.4162612926675;5608.887822243614;5408.9459105410015;5472.2338872557075;5487.149491828773;5528.253685752372;5542.8337149885565;5666.348369937345;5684.3747187808485;5710.914336285042;5711.942880571141;5712.02895507773;3965;3977.2840888639166;4005.2590270799997;4010.8997275068355;4048.6356227939627;5174.8965020700125;5508.394076651645;5513.531349835149;5518.19986102021;5523.364813046551;5189.532942035235;5276.5251127398715;5408.72956352173;5432.619716619799;5455.727213639381;5362.276092727432;5425.511703946664;5426.864328391664;5437.32033495813;5440.1023831069015;5276.34045744282;5404.486573775485;5413.269208656939;5427.891442171055;5438.673679579238;5452.427495113115;5462.098753705594;5465.863353416196;5471;5479.986202552541;5239.371275446971;5242.816501422432;5341.599380046589;5367.248585197997;5401.972990135024 18:50:39 INFO - PROCESS | 8364 | |5;yui.html;765.6669348833261;778.1906816910414;809.3606051219535;819.1930948016206;831.1812864328635;14761.48334808282;15572.221388930537;15612.2974466149;15661.921690391546;15718.842811571882;13475.460981560725;13533.932330338359;13547.390367433465;13553.051286409955;13567.660808479794;649.1496140056541;674.8110529051849;771.3906014248737;778.5250996891891;798.8801679748026;804.5213098206558;804.5816175588691;807.3379828540599;810.84999275134;811.6185392865344;847.1782371100023;848.0671261612239;848.9575521223945;849.2484151525882;850.5789634131114;844.1769274956898;844.3540691371076;844.5692696724653;844.8099177685033;845.9957700211521;509.6839959225267;526.4025331249022;592.4312659846553;609.5946195779801;614.3242433323353;14339.713205735827;14448.205348705817;14453.205073720941;14455.27723613815;14458.27708614565;13403.128796628285;14196.574102776933;14246.501372452018;14304.499342523066;14377.849772018213;12549.247045177228;12557.309347985856;12567.434465448985;12747.490100395973;13313.334333283394;4370.541093185201;4442.555744425532;4480.305552639346;4493.887652808673;4530.75080870552;76889.61555192189;76921.23078769197;77182.61408692977;77360.83958740624;80408.79386809262;10386.42874641902;10415.114715249289;10791.6222932197;10815.080718138888;11520.13598980063;21012.26457073995;21300.36098917035;21306;21488.24791132303;21492.78507214908;7846.450748447668;7861.921380786233;7978.720744773905;7984.800379990546;8034.598270086589;4097.631213190827;4130.690198235145;4184.7106269625665;4186.5604111568455;4223.957760422357;3569.8929032129076;3676.540432445944;3680.981595092061;3689.538807649044;3965.1276719121747;710.3500297228081;710.4848984486206;712.8645557344088;720.8738470767595;734.6436978065634;628.4877824572958;662.6686656671665;697.8848489999093;750.2497502497503;759.5670467833393;9516.57782862172;9633.807323853624;9688.951555242178;9708;10245.641402550875;618.170216160162;641.887669657808;667.2903950775004;671.53328436736;673.959562426256;4791.305260737174;4967.801287948514;5002.349694539686;5004.624653151028;5015.3229314042865;63935;93298;115869;116297;121033;56862.7156864213;57118.143227851615;86253;99883;100366;68978.65510672414;90619;91011;92123;93902.53048734849;9120.361574689709;9425.151736343762;9476.810463790824;9549.665761698307;9550.761230969003;55961;56323;56582.15126773184;56804.7159764215;57527.123643816805;75254.24745752472;75836;81767.59116204381;81971;82864;12812.23126612369;12897.226166430044;12938.805917911428;12971.5459958901;13277.136986095873;14080;14941.402343906557;15057.397704092153;15620.531384058497;15807.051576905422;12791.36043197855;12956.222626642431;13623.18260904349;13962;14050;13736.793948090986;13892.583222503341;14057.156570605797;14084.366203521071;14243.430262789787;12464.5014199431;12877.678058048623;13113.40989655487;13194.604161875159;13634.590962271148;11132.443377831238;11494.96545310926;11735.76528469443;11871.821922671339;12059;10360.948195258976;11153.330800152016;11527.942360288145;11540.307581545134;11747.118966077749 18:50:39 INFO - PROCESS | 8364 | __end_tp_report 18:50:39 INFO - PROCESS | 8364 | __start_cc_report 18:50:39 INFO - PROCESS | 8364 | _x_x_mozilla_cycle_collect,1061 18:50:39 INFO - PROCESS | 8364 | __end_cc_report 18:50:39 INFO - PROCESS | 8364 | __startTimestamp1475891439024__endTimestamp 18:50:39 INFO - PROCESS | 8364 | 18:50:39 INFO - PROCESS | 8364 | ------- Summary: start ------- 18:50:39 INFO - PROCESS | 8364 | Number of tests: 6 18:50:39 INFO - PROCESS | 8364 | 18:50:39 INFO - PROCESS | 8364 | [#0] dojo.html Cycles:165 Average:5212.71 Median:5426.40 stddev:568.13 (10.5%) stddev-sans-first:542.66 18:50:39 INFO - PROCESS | 8364 | Values: 2998.2 3027.0 3030.3 3058.0 3085.8 5108.2 5164.8 5207.6 5303.2 5313.9 5217.2 5243.4 5276.1 5327.2 5334.8 4750.1 4789.9 4809.9 4823.0 4867.7 4933.2 4965.2 4976.1 4978.7 5000.1 4691.3 4740.5 4744.7 4945.2 4961.0 4743.0 4789.9 4791.0 4808.8 4819.5 4710.0 4731.5 4737.5 4738.8 4782.0 5282.3 5301.7 5306.2 5310.8 5314.3 5493.8 5532.5 5557.7 5573.4 5642.5 5576.5 5578.3 5590.7 5601.9 5659.3 5194.9 5199.4 5201.9 5253.0 5283.8 5624.4 5657.9 5679.5 5685.1 5750.2 5473.8 5575.9 5578.3 5579.4 5580.9 5541.7 5579.9 5587.8 5593.0 5594.4 5571.9 5572.1 5578.3 5585.9 5629.9 5457.7 5503.4 5508.6 5519.4 5567.5 4304.2 4345.1 4354.8 4355.9 4389.1 3856.9 3862.7 3867.5 3909.1 3911.4 5328.2 5330.2 5333.1 5337.0 5337.0 5432.0 5491.1 5491.4 5590.6 5635.5 5336.6 5337.0 5405.7 5423.1 5439.4 4778.1 4791.8 4818.3 4830.3 4845.9 5503.1 5643.7 5793.4 5795.9 5798.5 5544.3 5570.3 5583.0 5585.5 5670.5 5717.2 5734.0 5737.2 5738.4 5745.8 5426.4 5517.8 5518.4 5525.9 5528.9 5498.5 5513.7 5558.8 5570.1 5648.7 5489.4 5491.4 5493.5 5495.7 5496.5 5485.6 5495.7 5495.8 5497.4 5562.0 5380.2 5413.8 5421.6 5446.1 5462.2 5484.8 5521.6 5525.7 5527.4 5570.4 5395.3 5408.7 5410.3 5411.4 5421.4 18:50:39 INFO - PROCESS | 8364 | 18:50:39 INFO - PROCESS | 8364 | [#1] ext.html Cycles:180 Average:57618.20 Median:20712.05 stddev:115224.98 (556.3%) stddev-sans-first:115468.65 18:50:39 INFO - PROCESS | 8364 | Values: 583.2 604.3 609.8 615.5 629.4 30471.2 31028.0 41579.4 42570.1 42721.8 43865.6 44224.8 44249.8 44287.3 44323.3 8673.2 8832.2 8832.4 8832.6 8834.7 7957.2 8150.1 8652.7 10289.4 10546.4 10648.4 10710.6 10712.3 10715.1 10715.4 10517.6 10566.0 10588.7 10594.1 10618.7 10337.4 10360.3 10363.6 10363.8 10405.5 41130.8 41266.2 41410.8 41418.0 41471.6 3468.2 3562.9 3594.1 3613.9 3695.5 30421.0 31656.8 31710.0 31829.0 31840.7 4234.6 4325.7 4334.2 4506.3 4508.3 329947.0 331775.0 332408.0 333017.0 334066.0 54761.0 54983.7 55167.0 55503.4 55514.7 57415.5 57900.7 57932.0 57970.7 57971.4 15349.4 15518.5 15547.3 15550.1 15551.6 10546.2 12240.4 12291.0 12292.1 12297.2 13606.5 15087.1 15591.8 15593.8 16236.5 6123.5 6172.3 6298.3 6417.3 6507.7 934.8 1022.2 1024.7 1080.0 1086.5 31470.0 31495.8 31606.8 31662.0 31917.8 1070.2 1097.4 1119.5 1146.6 1170.2 17058.4 17510.6 17646.9 18161.6 18277.2 218138.0 491998.0 503029.0 505656.0 716135.0 49170.0 49962.0 52815.0 54502.7 55583.4 1344.7 1347.3 1365.7 1370.0 1375.4 29331.9 30620.8 30682.7 30822.7 31023.4 47787.5 48137.0 48586.0 48593.5 48603.3 433058.0 437700.0 437767.0 439056.0 439086.0 26740.0 27063.0 27099.5 27117.8 27118.9 44805.8 46311.8 46342.8 49645.0 51042.2 38925.6 39274.4 39410.6 40938.8 41141.4 38564.6 38997.0 39810.6 40015.2 41233.8 38930.6 40322.4 40690.4 41019.4 41041.8 31364.8 35826.5 37728.6 38499.2 38723.8 27425.5 27492.1 27580.0 27645.0 27846.9 18:50:39 INFO - PROCESS | 8364 | 18:50:39 INFO - PROCESS | 8364 | [#2] jquery.html Cycles:180 Average:27925.29 Median:383.66 stddev:76422.06 (19919.0%) stddev-sans-first:76608.45 18:50:39 INFO - PROCESS | 8364 | Values: 380.3 387.0 387.0 398.0 415.9 13429.3 15390.4 17267.4 19322.4 19779.7 18592.7 18811.7 19061.8 19082.9 19624.0 5291.8 5599.5 5846.2 5848.4 5851.9 5682.6 5711.5 5739.5 5767.6 5770.2 5602.1 5665.4 5731.5 5734.0 5746.9 5637.2 5668.8 5678.7 5711.2 5741.6 4910.8 5067.8 5101.0 5105.8 5115.3 22168.4 22278.8 22578.3 23218.5 23298.3 2326.0 2548.6 2565.7 2926.9 3092.8 14284.6 14680.6 14681.6 14712.1 15127.8 1834.3 1934.1 1946.1 1951.5 1977.2 81514.6 81733.6 81922.6 82930.0 83045.2 10547.4 10724.4 10799.7 10816.1 11005.0 14885.3 14897.8 14906.5 14911.9 14951.0 7637.3 7769.7 7869.9 7909.2 7947.0 7456.0 7559.7 7736.9 7741.0 7770.6 4167.6 4280.7 4295.2 4404.4 4404.4 1787.8 1820.4 1861.6 1930.5 1939.2 864.7 934.2 961.8 973.2 974.3 18182.1 19557.8 19650.5 19710.3 19715.8 944.2 957.6 975.5 1007.7 1010.5 10664.0 11354.4 11609.2 11756.9 11792.6 448280.0 450033.0 470603.0 471382.0 474408.0 86520.0 86943.6 87682.0 88352.6 88499.6 1016.1 1023.3 1054.4 1056.0 1057.7 15987.8 17099.2 17710.2 17929.8 18363.4 38760.2 39875.4 39923.0 40311.8 40722.0 52300.2 55057.7 55169.0 56048.0 58046.7 8206.5 8373.7 8399.4 8512.0 8766.5 10862.4 12592.7 12699.6 12748.9 13352.3 10985.7 11139.2 11166.9 11436.5 11688.2 5295.7 9514.6 10945.6 11086.8 11942.5 10800.2 10831.7 10896.5 11047.7 12056.7 8437.2 8519.8 8585.4 8696.3 8874.7 10067.7 10713.4 10744.6 10849.7 11231.1 18:50:39 INFO - PROCESS | 8364 | 18:50:39 INFO - PROCESS | 8364 | [#3] mootools.html Cycles:180 Average:5877.08 Median:4666.09 stddev:3413.59 (73.2%) stddev-sans-first:3406.32 18:50:39 INFO - PROCESS | 8364 | Values: 1364.6 1490.6 1515.3 1668.4 1796.3 8028.4 8637.6 9052.7 9060.0 9246.6 9064.0 9127.7 9145.8 9148.5 9152.2 2304.6 2331.4 2341.7 2346.7 2353.4 2332.3 2359.6 2376.6 2379.9 2382.1 2294.3 2333.8 2336.4 2350.2 2352.6 2245.5 2255.7 2259.3 2265.1 2293.0 2238.9 2240.1 2242.9 2244.5 2244.6 8838.7 9013.0 9047.9 9096.5 9166.4 5157.7 5360.9 5361.9 5362.3 5373.7 3497.1 3531.1 3577.0 3583.7 3585.8 1060.9 1075.0 1104.7 1122.4 1128.5 12534.3 12542.9 12573.6 12575.3 12589.3 4372.8 4545.1 4618.7 4634.2 4661.1 10014.7 10035.8 10046.9 10047.7 10053.0 5419.3 5422.3 5424.4 5430.8 5431.3 4530.2 4671.0 4874.0 4963.6 5082.6 3754.3 3873.4 3918.5 3919.7 4074.7 1178.6 1193.9 1194.0 1198.1 1212.6 861.9 862.5 891.7 909.3 925.4 5668.2 5672.8 5757.4 5846.2 6059.5 931.4 935.1 945.1 955.6 974.7 3842.8 3956.7 3980.7 4041.0 4051.6 10666.2 11354.3 11384.9 11433.6 11461.3 11218.3 11269.7 11495.4 11502.4 11525.3 8296.4 8495.6 8522.7 8528.5 8562.8 5676.2 5696.7 5774.8 5782.4 5970.8 10420.5 10517.6 10578.5 10608.1 10759.5 10091.3 10585.4 10589.5 10851.3 10901.3 7265.7 7456.8 7719.7 8005.7 8194.4 8515.0 8882.6 8899.4 8904.0 8908.0 7811.8 7832.5 8036.6 8063.4 8156.8 7806.0 7856.9 7890.5 7925.8 7934.4 6524.2 6599.4 6602.8 6603.7 6661.4 5016.5 5073.6 5120.4 5147.1 5325.4 5032.2 5047.3 5108.2 5151.2 5341.5 18:50:39 INFO - PROCESS | 8364 | 18:50:39 INFO - PROCESS | 8364 | [#4] prototype.html Cycles:180 Average:4588.40 Median:5177.51 stddev:1308.71 (25.3%) stddev-sans-first:1272.85 18:50:39 INFO - PROCESS | 8364 | Values: 335.3 338.5 347.0 354.2 356.6 5029.9 5090.7 5247.7 5263.2 5282.8 4984.2 5123.6 5130.8 5150.2 5183.5 4088.0 4102.7 4113.9 4122.6 4176.2 3986.9 4151.0 4170.8 4191.4 4193.9 4114.2 4141.3 4145.2 4148.4 4156.8 4121.6 4134.3 4149.3 4150.1 4169.6 3715.7 3721.7 3722.5 3732.6 3735.5 4927.8 4971.3 5044.9 5052.6 5062.0 4667.3 4681.6 4724.7 4725.5 4733.0 5352.6 5375.4 5377.9 5397.8 5398.1 3905.6 3986.3 4005.4 4007.7 4028.2 5585.9 5602.5 5603.3 5618.3 5618.5 4110.3 4119.3 4124.6 4133.3 4166.6 4067.9 4073.8 4135.2 4154.9 4181.6 4565.6 4619.8 4675.6 4678.6 4689.8 5372.0 5374.5 5400.4 5406.8 5413.2 1355.8 1381.5 1405.0 1432.9 1442.5 984.2 1007.9 1024.1 1027.4 1032.7 5176.5 5178.6 5188.4 5207.4 5225.5 5425.4 5436.4 5472.7 5482.6 5513.1 5032.8 5141.2 5150.7 5150.7 5312.5 2927.3 2946.6 2948.5 2966.9 2967.9 5712.3 5714.9 5738.3 5742.4 5746.1 5542.9 5639.2 5641.4 5675.5 5696.7 5583.9 5592.2 5597.2 5626.5 5626.7 5440.5 5530.4 5548.3 5559.4 5608.9 5408.9 5472.2 5487.1 5528.3 5542.8 5666.3 5684.4 5710.9 5711.9 5712.0 3965.0 3977.3 4005.3 4010.9 4048.6 5174.9 5508.4 5513.5 5518.2 5523.4 5189.5 5276.5 5408.7 5432.6 5455.7 5362.3 5425.5 5426.9 5437.3 5440.1 5276.3 5404.5 5413.3 5427.9 5438.7 5452.4 5462.1 5465.9 5471.0 5480.0 5239.4 5242.8 5341.6 5367.2 5402.0 18:50:39 INFO - PROCESS | 8364 | 18:50:39 INFO - PROCESS | 8364 | [#5] yui.html Cycles:180 Average:20235.48 Median:4879.55 stddev:28627.21 (586.7%) stddev-sans-first:28670.19 18:50:39 INFO - PROCESS | 8364 | Values: 765.7 778.2 809.4 819.2 831.2 14761.5 15572.2 15612.3 15661.9 15718.8 13475.5 13533.9 13547.4 13553.1 13567.7 649.1 674.8 771.4 778.5 798.9 804.5 804.6 807.3 810.8 811.6 847.2 848.1 849.0 849.2 850.6 844.2 844.4 844.6 844.8 846.0 509.7 526.4 592.4 609.6 614.3 14339.7 14448.2 14453.2 14455.3 14458.3 13403.1 14196.6 14246.5 14304.5 14377.8 12549.2 12557.3 12567.4 12747.5 13313.3 4370.5 4442.6 4480.3 4493.9 4530.8 76889.6 76921.2 77182.6 77360.8 80408.8 10386.4 10415.1 10791.6 10815.1 11520.1 21012.3 21300.4 21306.0 21488.2 21492.8 7846.5 7861.9 7978.7 7984.8 8034.6 4097.6 4130.7 4184.7 4186.6 4224.0 3569.9 3676.5 3681.0 3689.5 3965.1 710.4 710.5 712.9 720.9 734.6 628.5 662.7 697.9 750.2 759.6 9516.6 9633.8 9689.0 9708.0 10245.6 618.2 641.9 667.3 671.5 674.0 4791.3 4967.8 5002.3 5004.6 5015.3 63935.0 93298.0 115869.0 116297.0 121033.0 56862.7 57118.1 86253.0 99883.0 100366.0 68978.7 90619.0 91011.0 92123.0 93902.5 9120.4 9425.2 9476.8 9549.7 9550.8 55961.0 56323.0 56582.2 56804.7 57527.1 75254.2 75836.0 81767.6 81971.0 82864.0 12812.2 12897.2 12938.8 12971.5 13277.1 14080.0 14941.4 15057.4 15620.5 15807.1 12791.4 12956.2 13623.2 13962.0 14050.0 13736.8 13892.6 14057.2 14084.4 14243.4 12464.5 12877.7 13113.4 13194.6 13634.6 11132.4 11495.0 11735.8 11871.8 12059.0 10360.9 11153.3 11527.9 11540.3 11747.1 18:50:39 INFO - PROCESS | 8364 | -------- Summary: end -------- 18:50:39 INFO - PROCESS | 8364 | 18:50:39 INFO - TEST-INFO | 8364: exit 0 18:50:39 INFO - TEST-OK | dromaeo_css | took 1116654ms 18:50:39 INFO - TEST-START | kraken 18:50:39 INFO - operating with platform_type : linux_ 18:50:39 INFO - Initialising browser for kraken test... 18:50:39 INFO - TEST-INFO | started process 8673 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_W7I58/profile http://localhost:43023/getInfo.html) 18:50:44 INFO - PROCESS | 8673 | __metrics Screen width/height:1600/1200 18:50:44 INFO - PROCESS | 8673 | colorDepth:24 18:50:44 INFO - PROCESS | 8673 | Browser inner width/height: 1024/697 18:50:44 INFO - PROCESS | 8673 | __metrics 18:50:44 INFO - PROCESS | 8673 | 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" 18:50:44 INFO - PROCESS | 8673 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:50:45 INFO - PROCESS | 8673 | console.error: PushService: 18:50:45 INFO - PROCESS | 8673 | stateChangeProcessEnqueue: Error transitioning state 18:50:45 INFO - PROCESS | 8673 | UnknownError 18:50:45 INFO - TEST-INFO | 8673: exit 0 18:50:45 INFO - Browser initialized. 18:50:45 INFO - Running cycle 1/1 for kraken test... 18:50:45 INFO - TEST-INFO | started process 8753 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_W7I58/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:50:58 INFO - PROCESS | 8753 | RSS: Main: 173076480 18:50:58 INFO - PROCESS | 8753 | 18:51:00 INFO - PROCESS | 8753 | Cycle 1(1): loaded http://localhost:43023/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43023/tests/kraken/driver.html?testName=audio-beat-detection) 18:51:01 INFO - PROCESS | 8753 | RSS: Main: 231636992 18:51:01 INFO - PROCESS | 8753 | 18:51:04 INFO - PROCESS | 8753 | Cycle 1(1): loaded http://localhost:43023/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43023/tests/kraken/driver.html?testName=audio-dft) 18:51:04 INFO - PROCESS | 8753 | RSS: Main: 216793088 18:51:04 INFO - PROCESS | 8753 | 18:51:07 INFO - PROCESS | 8753 | Cycle 1(1): loaded http://localhost:43023/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43023/tests/kraken/driver.html?testName=audio-fft) 18:51:08 INFO - PROCESS | 8753 | RSS: Main: 297897984 18:51:08 INFO - PROCESS | 8753 | 18:51:10 INFO - PROCESS | 8753 | Cycle 1(1): loaded http://localhost:43023/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43023/tests/kraken/driver.html?testName=audio-oscillator) 18:51:11 INFO - PROCESS | 8753 | RSS: Main: 206905344 18:51:11 INFO - PROCESS | 8753 | 18:51:13 INFO - PROCESS | 8753 | Cycle 1(1): loaded http://localhost:43023/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43023/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:51:13 INFO - PROCESS | 8753 | RSS: Main: 212189184 18:51:13 INFO - PROCESS | 8753 | 18:51:16 INFO - PROCESS | 8753 | Cycle 1(1): loaded http://localhost:43023/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43023/tests/kraken/driver.html?testName=imaging-darkroom) 18:51:17 INFO - PROCESS | 8753 | RSS: Main: 248594432 18:51:17 INFO - PROCESS | 8753 | 18:51:20 INFO - PROCESS | 8753 | Cycle 1(1): loaded http://localhost:43023/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43023/tests/kraken/driver.html?testName=imaging-desaturate) 18:51:21 INFO - PROCESS | 8753 | RSS: Main: 247111680 18:51:21 INFO - PROCESS | 8753 | 18:51:24 INFO - PROCESS | 8753 | Cycle 1(1): loaded http://localhost:43023/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43023/tests/kraken/driver.html?testName=json-parse-financial) 18:51:24 INFO - PROCESS | 8753 | RSS: Main: 247529472 18:51:24 INFO - PROCESS | 8753 | 18:51:26 INFO - PROCESS | 8753 | Cycle 1(1): loaded http://localhost:43023/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43023/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:51:26 INFO - PROCESS | 8753 | RSS: Main: 209805312 18:51:26 INFO - PROCESS | 8753 | 18:51:28 INFO - PROCESS | 8753 | Cycle 1(1): loaded http://localhost:43023/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43023/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:51:29 INFO - PROCESS | 8753 | RSS: Main: 217468928 18:51:29 INFO - PROCESS | 8753 | 18:51:31 INFO - PROCESS | 8753 | Cycle 1(1): loaded http://localhost:43023/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43023/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:51:31 INFO - PROCESS | 8753 | RSS: Main: 226328576 18:51:31 INFO - PROCESS | 8753 | 18:51:34 INFO - PROCESS | 8753 | Cycle 1(1): loaded http://localhost:43023/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43023/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:51:35 INFO - PROCESS | 8753 | RSS: Main: 235675648 18:51:35 INFO - PROCESS | 8753 | 18:51:37 INFO - PROCESS | 8753 | Cycle 1(1): loaded http://localhost:43023/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43023/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:51:38 INFO - PROCESS | 8753 | RSS: Main: 232054784 18:51:38 INFO - PROCESS | 8753 | 18:51:40 INFO - PROCESS | 8753 | Cycle 1(1): loaded http://localhost:43023/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43023/tests/kraken/driver.html?testName=ai-astar) 18:51:40 INFO - PROCESS | 8753 | RSS: Main: 282415104 18:51:40 INFO - PROCESS | 8753 | 18:51:40 INFO - PROCESS | 8753 | __start_tp_report 18:51:40 INFO - PROCESS | 8753 | _x_x_mozilla_page_load 18:51:40 INFO - PROCESS | 8753 | _x_x_mozilla_page_load_details 18:51:40 INFO - PROCESS | 8753 | |i|pagename|runs| 18:51:40 INFO - PROCESS | 8753 | |0;ai-astar;107;110;109;109;111;110;110;108;109;109 18:51:40 INFO - PROCESS | 8753 | |1;audio-beat-detection;146;122;123;168;123;122;121;121;167;122 18:51:40 INFO - PROCESS | 8753 | |2;audio-dft;160;160;162;161;160;161;160;161;160;161 18:51:40 INFO - PROCESS | 8753 | |3;audio-fft;75;78;76;110;75;75;74;75;97;74 18:51:40 INFO - PROCESS | 8753 | |4;audio-oscillator;83;82;110;82;82;82;103;82;83;114 18:51:40 INFO - PROCESS | 8753 | |5;imaging-gaussian-blur;117;117;117;117;117;118;117;118;117;117 18:51:40 INFO - PROCESS | 8753 | |6;imaging-darkroom;145;147;146;145;146;147;147;146;146;147 18:51:40 INFO - PROCESS | 8753 | |7;imaging-desaturate;95;95;95;95;94;95;95;95;95;95 18:51:40 INFO - PROCESS | 8753 | |8;json-parse-financial;54;54;55;52;53;55;56;54;55;53 18:51:40 INFO - PROCESS | 8753 | |9;json-stringify-tinderbox;62;62;62;62;63;61;61;61;61;62 18:51:40 INFO - PROCESS | 8753 | |10;stanford-crypto-aes;83;86;80;81;80;86;79;79;80;80 18:51:40 INFO - PROCESS | 8753 | |11;stanford-crypto-ccm;131;149;136;142;143;141;143;130;169;135 18:51:40 INFO - PROCESS | 8753 | |12;stanford-crypto-pbkdf2;170;166;165;168;169;169;165;164;166;165 18:51:40 INFO - PROCESS | 8753 | |13;stanford-crypto-sha256-iterative;66;67;68;76;65;67;66;67;66;64 18:51:40 INFO - PROCESS | 8753 | __end_tp_report 18:51:40 INFO - PROCESS | 8753 | __start_cc_report 18:51:40 INFO - PROCESS | 8753 | _x_x_mozilla_cycle_collect,1670 18:51:40 INFO - PROCESS | 8753 | __end_cc_report 18:51:40 INFO - PROCESS | 8753 | __startTimestamp1475891500502__endTimestamp 18:51:40 INFO - PROCESS | 8753 | 18:51:40 INFO - PROCESS | 8753 | ------- Summary: start ------- 18:51:40 INFO - PROCESS | 8753 | Number of tests: 14 18:51:40 INFO - PROCESS | 8753 | 18:51:40 INFO - PROCESS | 8753 | [#0] ai-astar Cycles:10 Average:109.20 Median:109.50 stddev:1.14 (1.0%) stddev-sans-first:0.88 18:51:40 INFO - PROCESS | 8753 | Values: 107.0 110.0 109.0 109.0 111.0 110.0 110.0 108.0 109.0 109.0 18:51:40 INFO - PROCESS | 8753 | 18:51:40 INFO - PROCESS | 8753 | [#1] audio-beat-detection Cycles:10 Average:133.50 Median:123.00 stddev:19.43 (15.8%) stddev-sans-first:20.08 18:51:40 INFO - PROCESS | 8753 | Values: 146.0 122.0 123.0 168.0 123.0 122.0 121.0 121.0 167.0 122.0 18:51:40 INFO - PROCESS | 8753 | 18:51:40 INFO - PROCESS | 8753 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 18:51:40 INFO - PROCESS | 8753 | Values: 160.0 160.0 162.0 161.0 160.0 161.0 160.0 161.0 160.0 161.0 18:51:40 INFO - PROCESS | 8753 | 18:51:40 INFO - PROCESS | 8753 | [#3] audio-fft Cycles:10 Average:80.90 Median:75.00 stddev:12.35 (16.5%) stddev-sans-first:12.91 18:51:40 INFO - PROCESS | 8753 | Values: 75.0 78.0 76.0 110.0 75.0 75.0 74.0 75.0 97.0 74.0 18:51:40 INFO - PROCESS | 8753 | 18:51:40 INFO - PROCESS | 8753 | [#4] audio-oscillator Cycles:10 Average:90.30 Median:82.00 stddev:13.17 (16.1%) stddev-sans-first:13.71 18:51:40 INFO - PROCESS | 8753 | Values: 83.0 82.0 110.0 82.0 82.0 82.0 103.0 82.0 83.0 114.0 18:51:40 INFO - PROCESS | 8753 | 18:51:40 INFO - PROCESS | 8753 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 18:51:40 INFO - PROCESS | 8753 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 117.0 118.0 117.0 117.0 18:51:40 INFO - PROCESS | 8753 | 18:51:40 INFO - PROCESS | 8753 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.50 stddev:0.79 (0.5%) stddev-sans-first:0.71 18:51:40 INFO - PROCESS | 8753 | Values: 145.0 147.0 146.0 145.0 146.0 147.0 147.0 146.0 146.0 147.0 18:51:40 INFO - PROCESS | 8753 | 18:51:40 INFO - PROCESS | 8753 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 18:51:40 INFO - PROCESS | 8753 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 18:51:40 INFO - PROCESS | 8753 | 18:51:40 INFO - PROCESS | 8753 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.50 stddev:1.20 (2.2%) stddev-sans-first:1.27 18:51:40 INFO - PROCESS | 8753 | Values: 54.0 54.0 55.0 52.0 53.0 55.0 56.0 54.0 55.0 53.0 18:51:40 INFO - PROCESS | 8753 | 18:51:40 INFO - PROCESS | 8753 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 18:51:40 INFO - PROCESS | 8753 | Values: 62.0 62.0 62.0 62.0 63.0 61.0 61.0 61.0 61.0 62.0 18:51:40 INFO - PROCESS | 8753 | 18:51:40 INFO - PROCESS | 8753 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:80.50 stddev:2.67 (3.3%) stddev-sans-first:2.77 18:51:40 INFO - PROCESS | 8753 | Values: 83.0 86.0 80.0 81.0 80.0 86.0 79.0 79.0 80.0 80.0 18:51:40 INFO - PROCESS | 8753 | 18:51:40 INFO - PROCESS | 8753 | [#11] stanford-crypto-ccm Cycles:10 Average:141.90 Median:142.50 stddev:11.21 (7.9%) stddev-sans-first:11.17 18:51:40 INFO - PROCESS | 8753 | Values: 131.0 149.0 136.0 142.0 143.0 141.0 143.0 130.0 169.0 135.0 18:51:40 INFO - PROCESS | 8753 | 18:51:40 INFO - PROCESS | 8753 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.70 Median:167.00 stddev:2.11 (1.3%) stddev-sans-first:1.87 18:51:40 INFO - PROCESS | 8753 | Values: 170.0 166.0 165.0 168.0 169.0 169.0 165.0 164.0 166.0 165.0 18:51:40 INFO - PROCESS | 8753 | 18:51:40 INFO - PROCESS | 8753 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:3.29 (4.9%) stddev-sans-first:3.46 18:51:40 INFO - PROCESS | 8753 | Values: 66.0 67.0 68.0 76.0 65.0 67.0 66.0 67.0 66.0 64.0 18:51:40 INFO - PROCESS | 8753 | -------- Summary: end -------- 18:51:40 INFO - PROCESS | 8753 | 18:51:41 INFO - TEST-INFO | 8753: exit 0 18:51:41 INFO - TEST-OK | kraken | took 61761ms 18:51:41 INFO - SUITE-END | took 1178s 18:51:42 INFO - Completed test suite (00:19:38) 18:51:42 INFO - javascript benchmark 18:51:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2998.2354499602607, 3027.0, 3030.3333266681334, 3057.9541306880387, 3085.845707714615, 5108.208227724699, 5164.793408263665, 5207.609429292799, 5303.204519322098, 5313.89372212556, 5217.243499692552, 5243.3970093439175, 5276.076686579842, 5327.227552004957, 5334.786608535654, 4750.073735621555, 4789.928151077736, 4809.855704328858, 4823.0353929214125, 4867.707937523742, 4933.161362568354, 4965.230389289648, 4976.054549635558, 4978.6514943953935, 5000.124978128831, 4691.319758635013, 4740.45484769249, 4744.691595046311, 4945.233488809223, 4960.950390496121, 4743.0, 4789.904201915942, 4790.976045119787, 4808.807647694088, 4819.5180481951875, 4709.976450117728, 4731.503192164842, 4737.50256223095, 4738.8341408050555, 4782.0, 5282.339707536558, 5301.7084060376665, 5306.151015837448, 5310.8141215057285, 5314.256004159421, 5493.7802487900435, 5532.474414930575, 5557.749901254453, 5573.359063707685, 5642.520385767215, 5576.470235327637, 5578.330600327987, 5590.748416321276, 5601.859953501154, 5659.264295641581, 5194.948050519484, 5199.402068762103, 5201.895962080737, 5253.028189784902, 5283.841484755463, 5624.409437009137, 5657.915131273035, 5679.460451257124, 5685.118806584986, 5750.166225897222, 5473.808416705396, 5575.888482230333, 5578.2748242728185, 5579.38626751057, 5580.888382232332, 5541.722913854291, 5579.944200558024, 5587.804426845041, 5593.0, 5594.412586678422, 5571.9442805571425, 5572.136318870582, 5578.30271216098, 5585.860353491195, 5629.887402251932, 5457.672539647634, 5503.449655034465, 5508.64193827408, 5519.448055194529, 5567.526760225345, 4304.246756817544, 4345.087531618332, 4354.847580334736, 4355.869323920288, 4389.078293558325, 3856.9035774105873, 3862.6909847212155, 3867.4778904847485, 3909.100906791454, 3911.393733971239, 5328.17413300939, 5330.173823057432, 5333.146696528537, 5337.039332920034, 5337.039332920034, 5431.972840135853, 5491.148871924778, 5491.423400542885, 5590.552755779528, 5635.492805647511, 5336.62643614951, 5336.973315133477, 5405.70268635221, 5423.132298832247, 5439.374471935699, 4778.092162489116, 4791.808327666854, 4818.325434439182, 4830.275458681226, 4845.9030819383415, 5503.11950087984, 5643.746031428514, 5793.391693872167, 5795.88408231833, 5798.478136967608, 5544.279243698294, 5570.303712035996, 5582.972085139549, 5585.525230355465, 5670.461306175906, 5717.22817419643, 5734.025215713255, 5737.225474560881, 5738.368779434342, 5745.827625171251, 5426.403095659395, 5517.806876759294, 5518.365387980433, 5525.861853453695, 5528.889422211614, 5498.532624726783, 5513.696746678971, 5558.833235002957, 5570.080936645408, 5648.689322087324, 5489.39616642161, 5491.423400542885, 5493.478119578634, 5495.725213739377, 5496.450354964471, 5485.6434331768305, 5495.697736624524, 5495.835124946258, 5497.36780270274, 5562.026645336969, 5380.246765452918, 5413.756380962945, 5421.5933804964, 5446.128619420873, 5462.235287059894, 5484.808031718871, 5521.613487055867, 5525.668459892419, 5527.364353099445, 5570.442955704397, 5395.298611180521, 5408.675479471244, 5410.296661433988, 5411.350637923474, 5421.434134068084], "value": 5175.455591099068, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.2097507876827, 604.250729095921, 609.7835268479693, 615.5444970721667, 629.3706293706293, 30471.238219044506, 31028.0, 41579.37630935534, 42570.14859702804, 42721.786391068, 43865.561344386544, 44224.77887610557, 44249.7787511062, 44287.335689964675, 44323.33514997278, 8673.176048275403, 8832.249258813008, 8832.381733278673, 8832.646694132227, 8834.690785822497, 7957.164497727742, 8150.062742784567, 8652.697155599555, 10289.382637041765, 10546.367217966947, 10648.361098334086, 10710.571577136905, 10712.25014249003, 10715.142788576895, 10715.410652414113, 10517.631882884063, 10566.0, 10588.682339529827, 10594.099501542378, 10618.734531636694, 10337.431441270726, 10360.274780765349, 10363.637272695494, 10363.844542331872, 10405.47972601367, 41130.79434602838, 41266.174676506605, 41410.79294603538, 41418.0, 41471.58528414708, 3468.1849765305133, 3562.9109272268142, 3594.1194407370363, 3613.94579081314, 3695.4826324314618, 30421.0, 31656.841715791503, 31710.0, 31829.0, 31840.681593184236, 4234.640055595278, 4325.675574331906, 4334.241507736165, 4506.278995360759, 4508.278675411918, 329947.0, 331775.0, 332408.0, 333017.0, 334066.0, 54761.0, 54983.72508137434, 55167.0, 55503.444965549825, 55514.72242638761, 57415.52643813724, 57900.710496447246, 57932.0, 57970.710146449, 57971.420285797445, 15349.386024558893, 15518.534443966699, 15547.30037148331, 15550.14474203907, 15551.611209719622, 10546.209034322457, 12240.44917978693, 12291.0, 12292.139550231577, 12297.200681955645, 13606.455741770416, 15087.094774313577, 15591.844081559266, 15593.766093508606, 16236.51290461288, 6123.540734444845, 6172.321044685081, 6298.307186209513, 6417.294097649255, 6507.739690412425, 934.8270569944582, 1022.2417441999748, 1024.6516184497307, 1079.9632352941107, 1086.5436516663021, 31470.0, 31495.78128260947, 31606.841965790023, 31662.0, 31917.84041079826, 1070.1813112968584, 1097.4238524774557, 1119.535392811974, 1146.644540192543, 1170.151640060949, 17058.402955896483, 17510.562235943948, 17646.91176544109, 18161.63676726458, 18277.177527011052, 218138.0, 491998.0, 503029.0, 505656.0, 716135.0, 49170.0, 49962.0, 52815.0, 54502.72748636311, 55583.444165558634, 1344.6503908983734, 1347.2926713475308, 1365.7336819320137, 1369.9862102044615, 1375.408574313055, 29331.853340734015, 30620.84689576538, 30682.693173068878, 30822.69177308288, 31023.379532409675, 47787.522124778305, 48137.0, 48586.0, 48593.5140648589, 48603.27095093505, 433058.0, 437700.0, 437767.0, 439056.0, 439086.0, 26740.0, 27063.0, 27099.458010840066, 27117.779699913157, 27118.864405677847, 44805.77597111993, 46311.76844115893, 46342.76828615835, 49645.0, 51042.234366485274, 38925.61074389333, 39274.41088383619, 39410.605893940694, 40938.795306023276, 41141.382879257435, 38564.6143538561, 38997.0, 39810.601893981846, 40015.1996960065, 41233.793831030656, 38930.6106938927, 40322.39516407315, 40690.389644155955, 41019.384709229984, 41041.79479102585, 31364.843175783975, 35826.462603060456, 37728.62271377251, 38499.198949180805, 38723.806380967915, 27425.45149096967, 27492.05143074266, 27580.0, 27645.0, 27846.86076569604], "value": 19758.271598657833, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.3344147741453, 386.9922601547969, 386.9980650096751, 397.98806035818916, 415.8710799652108, 13429.33625119678, 15390.384384624616, 17267.39564115256, 19322.420327390202, 19779.703304450446, 18592.721109183338, 18811.717824232648, 19061.809381906176, 19082.904585477052, 19624.0, 5291.788328466857, 5599.524040456566, 5846.152307915371, 5848.41515848416, 5851.941480585204, 5682.573806964473, 5711.485966263035, 5739.483446489815, 5767.567432442584, 5770.163326317682, 5602.13166959122, 5665.433456654343, 5731.512821410185, 5734.0, 5746.942530574683, 5637.2107904893555, 5668.829935101953, 5678.744456499468, 5711.228984087157, 5741.626794258381, 4910.803567857281, 5067.797288108472, 5101.005303965728, 5105.774614092628, 5115.283860259567, 22168.445788855246, 22278.777212227833, 22578.322650320515, 23218.53562928732, 23298.301050968497, 2325.976740232593, 2548.554003049459, 2565.7305982871717, 2926.88292468301, 3092.7989680670685, 14284.57146285613, 14680.632984175374, 14681.559553213421, 14712.117272963656, 15127.848721512753, 1834.2662934826044, 1934.1006432009042, 1946.1492773708092, 1951.5218771401098, 1977.2486455147096, 81514.59242703808, 81733.59133204295, 81922.59038704769, 82930.0, 83045.16954830434, 10547.411875834037, 10724.410157441416, 10799.730006749895, 10816.134709223243, 11005.0, 14885.255737213096, 14897.77653335201, 14906.540420830659, 14911.850881491046, 14951.0, 7637.274458926393, 7769.689212431553, 7869.921300786918, 7909.169537198626, 7947.0, 7456.0, 7559.735409260649, 7736.922630773733, 7740.961295193488, 7770.572618506037, 4167.562405947392, 4280.657547396263, 4295.183915056192, 4404.383386325917, 4404.4494438195225, 1787.767590213264, 1820.390169293275, 1861.5625328047897, 1930.4787707318944, 1939.156466936887, 864.6541383446672, 934.243262957007, 961.8076384722943, 973.2408721197477, 974.3082411487782, 18182.09089545544, 19557.8044219556, 19650.508737281398, 19710.310139145062, 19715.802841971683, 944.2163004706077, 957.5547370472764, 975.492743773234, 1007.7329507680471, 1010.5200029985698, 10664.0, 11354.3755093469, 11609.187356885106, 11756.882431175578, 11792.587259445878, 448280.0, 450033.0, 470603.0, 471382.0, 474408.0, 86520.0, 86943.56528217444, 87682.0, 88352.55823720968, 88499.55750221337, 1016.1058268723476, 1023.3348323589727, 1054.383185836279, 1055.9524821383056, 1057.7091299892438, 15987.840121598636, 17099.230534626222, 17710.20304086345, 17929.82070179334, 18363.449096527125, 38760.224795504495, 39875.408098473505, 39923.00192495211, 40311.79844100761, 40722.0, 52300.21549676682, 55057.724711376184, 55169.0, 56048.0, 58046.7097664509, 8206.466579672302, 8373.665053397795, 8399.370047246359, 8511.95744021276, 8766.517841518778, 10862.402567858528, 12592.74814503723, 12699.619011429671, 12748.936255318664, 13352.332383380986, 10985.725356866142, 11139.220254582102, 11166.888331116585, 11436.485358158736, 11688.240264383128, 5295.655782374133, 9514.620380044993, 10945.616903408343, 11086.833697494383, 11942.462589183333, 10800.189985750943, 10831.675049748204, 10896.455177241265, 11047.72380690489, 12056.71300308502, 8437.240648341678, 8519.787005324668, 8585.441946273471, 8696.347773916856, 8874.733757987271, 10067.69796906094, 10713.35719856811, 10744.623938162127, 10849.728756781144, 11231.101511878867], "value": 9071.587214609935, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1364.6315494816406, 1490.6422458609934, 1515.3408267403681, 1668.3576822923171, 1796.2994432171456, 8028.35773138149, 8637.568121593926, 9052.683156089539, 9060.0, 9246.583903724331, 9064.04827493112, 9127.726168214947, 9145.817083658323, 9148.542572871347, 9152.222061124812, 2304.562133194692, 2331.3705299569106, 2341.718993720756, 2346.694929659142, 2353.4234112642425, 2332.265336419031, 2359.6460530920413, 2376.584097782881, 2379.9048038078454, 2382.106709983756, 2294.3117064880553, 2333.8366314358, 2336.4275752440676, 2350.247920665388, 2352.635341522067, 2245.4610893385634, 2255.672927425522, 2259.288324177887, 2265.139247086097, 2292.9541409171807, 2238.8917485844613, 2240.0703707961175, 2242.8766417847014, 2244.472548950995, 2244.62963611004, 8838.734837954871, 9013.0, 9047.909520904772, 9096.545172741402, 9166.358354915159, 5157.742112894378, 5360.892782144374, 5361.946380536184, 5362.329708786402, 5373.731313434313, 3497.055794935379, 3531.099569609759, 3576.9821150894077, 3583.6595523425235, 3585.8027808470524, 1060.9257351985364, 1074.9677509674723, 1104.6575561575937, 1122.3826895207685, 1128.542940109257, 12534.310612916286, 12542.937285313606, 12573.559925402567, 12575.308358040304, 12589.30758808265, 4372.803223854934, 4545.0909818036525, 4618.745968971739, 4634.21218392874, 4661.137689527448, 10014.699559013241, 10035.849462258071, 10046.949765251273, 10047.698569042794, 10053.0, 5419.34967803866, 5422.349318081777, 5424.430434804368, 5430.83707488776, 5431.293931788842, 4530.161920044802, 4671.042436300618, 4873.951260487421, 4963.5780958618925, 5082.644214904921, 3754.2866855297407, 3873.4189871519498, 3918.4710064141545, 3919.7060220483577, 4074.6943979201087, 1178.6287319494504, 1193.9044876409866, 1193.9820902686467, 1198.101423932051, 1212.5877201751448, 861.8621020636793, 862.5256109139948, 891.7235656946237, 909.3225546967551, 925.4077390470104, 5668.234788303609, 5672.773089076473, 5757.366689664133, 5846.242625038574, 6059.454649081604, 931.3759780946782, 935.1396715022059, 945.0785484152896, 955.5938726041404, 974.7222041718077, 3842.7886466244627, 3956.723029387973, 3980.661643760313, 4041.0, 4051.5745846686264, 10666.200034997406, 11354.318740875575, 11384.886151138548, 11433.59982400612, 11461.312321260752, 11218.326900386002, 11269.66191014271, 11495.42522873853, 11502.367369794742, 11525.250858694159, 8296.419250652518, 8495.575221238912, 8522.74431767048, 8528.488290702579, 8562.828743424972, 5676.17695434168, 5696.686682232351, 5774.82675519735, 5782.392848750821, 5970.761169553343, 10420.531076101443, 10517.579296828042, 10578.523966421684, 10608.098311643596, 10759.515821787882, 10091.344062635904, 10585.364878107339, 10589.523471443958, 10851.294665846695, 10901.34591924487, 7265.673044712895, 7456.7762967111075, 7719.729809456642, 8005.7197998072115, 8194.42639015287, 8515.020772610982, 8882.555872206492, 8899.421537600036, 8904.020557738773, 8908.0, 7811.765647030598, 7832.5348388762, 8036.638351274323, 8063.354931605575, 8156.755297341089, 7805.9609701953395, 7856.882146767689, 7890.526568405914, 7925.762227132965, 7934.444588878954, 6524.184476940382, 6599.439047681001, 6602.8349291268105, 6603.702833372414, 6661.400473957173, 5016.473270306566, 5073.644844860824, 5120.385553733576, 5147.073526765218, 5325.414204437587, 5032.169692000779, 5047.343845300087, 5108.157154069537, 5151.201563757623, 5341.465853414627], "value": 4656.381557766087, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.3434035862837, 338.4855020369039, 346.98959031229055, 354.18360678635736, 356.5543071161047, 5029.924551131736, 5090.669106508074, 5247.737613119343, 5263.1578947368425, 5282.841514754558, 4984.17761069424, 5123.641345105844, 5130.769115389807, 5150.22746588012, 5183.53348198662, 4087.9591204087874, 4102.671786257092, 4113.917721645573, 4122.567130451304, 4176.164767046603, 3986.940195897064, 4150.97924510377, 4170.833166673329, 4191.40133117466, 4193.937090943623, 4114.218298523286, 4141.295979683446, 4145.150244199932, 4148.357004664267, 4156.833726650931, 4121.62905338518, 4134.297169481196, 4149.315362965107, 4150.128473020669, 4169.6455801256925, 3715.6841668458214, 3721.683656889141, 3722.497462842509, 3732.5520937487404, 3735.4957080794015, 4927.77824997876, 4971.304017437562, 5044.924326135111, 5052.595792336604, 5062.012907483042, 4667.346571479996, 4681.648876334289, 4724.692894961817, 4725.480197178307, 4733.006068725572, 5352.598555108382, 5375.381831089436, 5377.919331210035, 5397.78408863645, 5398.083680293478, 3905.5508616508896, 3986.3223252047223, 4005.359142537209, 4007.6593489553425, 4028.2144981728575, 5585.944140558624, 5602.4957753802355, 5603.271574695345, 5618.269624948731, 5618.494335509783, 4110.280700877334, 4119.279126152971, 4124.587541245912, 4133.256013917524, 4166.604172603597, 4067.8911510418484, 4073.816678249486, 4135.234981528427, 4154.875353739392, 4181.623653871166, 4565.634749220055, 4619.8450387403145, 4675.57919787214, 4678.555537223959, 4689.804099954558, 5371.973140134274, 5374.4528611116475, 5400.378956419983, 5406.756446017359, 5413.188021796762, 1355.8272094638264, 1381.5095641047485, 1404.9789253161211, 1432.9355179016968, 1442.4662874736205, 984.2322988069318, 1007.9193664506822, 1024.0936770957755, 1027.3579013116803, 1032.7314898126542, 5176.456472070454, 5178.559822415137, 5188.403333616682, 5207.427183009866, 5225.529702326809, 5425.419223312673, 5436.374816896028, 5472.699001554873, 5482.5613950884635, 5513.145462453326, 5032.7735251913755, 5141.151709967889, 5150.665206761623, 5150.742462876841, 5312.5484333832055, 2927.326714855595, 2946.587477753116, 2948.5110019440476, 2966.8664910079096, 2967.866446009935, 5712.257406537124, 5714.857128571819, 5738.340090889517, 5742.368339482654, 5746.109353050284, 5542.889142217133, 5639.182318563785, 5641.435856414326, 5675.460831221028, 5696.743646535916, 5583.916241256466, 5592.217089607459, 5597.160425936061, 5626.508975121596, 5626.7339848534575, 5440.483154100354, 5530.391656917655, 5548.250986116984, 5559.4162612926675, 5608.887822243614, 5408.9459105410015, 5472.2338872557075, 5487.149491828773, 5528.253685752372, 5542.8337149885565, 5666.348369937345, 5684.3747187808485, 5710.914336285042, 5711.942880571141, 5712.02895507773, 3965.0, 3977.2840888639166, 4005.2590270799997, 4010.8997275068355, 4048.6356227939627, 5174.8965020700125, 5508.394076651645, 5513.531349835149, 5518.19986102021, 5523.364813046551, 5189.532942035235, 5276.5251127398715, 5408.72956352173, 5432.619716619799, 5455.727213639381, 5362.276092727432, 5425.511703946664, 5426.864328391664, 5437.32033495813, 5440.1023831069015, 5276.34045744282, 5404.486573775485, 5413.269208656939, 5427.891442171055, 5438.673679579238, 5452.427495113115, 5462.098753705594, 5465.863353416196, 5471.0, 5479.986202552541, 5239.371275446971, 5242.816501422432, 5341.599380046589, 5367.248585197997, 5401.972990135024], "value": 4181.165035916575, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [765.6669348833261, 778.1906816910414, 809.3606051219535, 819.1930948016206, 831.1812864328635, 14761.48334808282, 15572.221388930537, 15612.2974466149, 15661.921690391546, 15718.842811571882, 13475.460981560725, 13533.932330338359, 13547.390367433465, 13553.051286409955, 13567.660808479794, 649.1496140056541, 674.8110529051849, 771.3906014248737, 778.5250996891891, 798.8801679748026, 804.5213098206558, 804.5816175588691, 807.3379828540599, 810.84999275134, 811.6185392865344, 847.1782371100023, 848.0671261612239, 848.9575521223945, 849.2484151525882, 850.5789634131114, 844.1769274956898, 844.3540691371076, 844.5692696724653, 844.8099177685033, 845.9957700211521, 509.6839959225267, 526.4025331249022, 592.4312659846553, 609.5946195779801, 614.3242433323353, 14339.713205735827, 14448.205348705817, 14453.205073720941, 14455.27723613815, 14458.27708614565, 13403.128796628285, 14196.574102776933, 14246.501372452018, 14304.499342523066, 14377.849772018213, 12549.247045177228, 12557.309347985856, 12567.434465448985, 12747.490100395973, 13313.334333283394, 4370.541093185201, 4442.555744425532, 4480.305552639346, 4493.887652808673, 4530.75080870552, 76889.61555192189, 76921.23078769197, 77182.61408692977, 77360.83958740624, 80408.79386809262, 10386.42874641902, 10415.114715249289, 10791.6222932197, 10815.080718138888, 11520.13598980063, 21012.26457073995, 21300.36098917035, 21306.0, 21488.24791132303, 21492.78507214908, 7846.450748447668, 7861.921380786233, 7978.720744773905, 7984.800379990546, 8034.598270086589, 4097.631213190827, 4130.690198235145, 4184.7106269625665, 4186.5604111568455, 4223.957760422357, 3569.8929032129076, 3676.540432445944, 3680.981595092061, 3689.538807649044, 3965.1276719121747, 710.3500297228081, 710.4848984486206, 712.8645557344088, 720.8738470767595, 734.6436978065634, 628.4877824572958, 662.6686656671665, 697.8848489999093, 750.2497502497503, 759.5670467833393, 9516.57782862172, 9633.807323853624, 9688.951555242178, 9708.0, 10245.641402550875, 618.170216160162, 641.887669657808, 667.2903950775004, 671.53328436736, 673.959562426256, 4791.305260737174, 4967.801287948514, 5002.349694539686, 5004.624653151028, 5015.3229314042865, 63935.0, 93298.0, 115869.0, 116297.0, 121033.0, 56862.7156864213, 57118.143227851615, 86253.0, 99883.0, 100366.0, 68978.65510672414, 90619.0, 91011.0, 92123.0, 93902.53048734849, 9120.361574689709, 9425.151736343762, 9476.810463790824, 9549.665761698307, 9550.761230969003, 55961.0, 56323.0, 56582.15126773184, 56804.7159764215, 57527.123643816805, 75254.24745752472, 75836.0, 81767.59116204381, 81971.0, 82864.0, 12812.23126612369, 12897.226166430044, 12938.805917911428, 12971.5459958901, 13277.136986095873, 14080.0, 14941.402343906557, 15057.397704092153, 15620.531384058497, 15807.051576905422, 12791.36043197855, 12956.222626642431, 13623.18260904349, 13962.0, 14050.0, 13736.793948090986, 13892.583222503341, 14057.156570605797, 14084.366203521071, 14243.430262789787, 12464.5014199431, 12877.678058048623, 13113.40989655487, 13194.604161875159, 13634.590962271148, 11132.443377831238, 11494.96545310926, 11735.76528469443, 11871.821922671339, 12059.0, 10360.948195258976, 11153.330800152016, 11527.942360288145, 11540.307581545134, 11747.118966077749], "value": 7501.318265878067, "unit": "score"}], "name": "dromaeo_css", "value": 7166.683841811934, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 110.0, 109.0, 109.0, 111.0, 110.0, 110.0, 108.0, 109.0, 109.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 122.0, 123.0, 168.0, 123.0, 122.0, 121.0, 121.0, 167.0, 122.0], "value": 133.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 161.0, 160.0, 161.0, 160.0, 161.0, 160.0, 161.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 76.0, 110.0, 75.0, 75.0, 74.0, 75.0, 97.0, 74.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 110.0, 82.0, 82.0, 82.0, 103.0, 82.0, 83.0, 114.0], "value": 90.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 146.0, 145.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 52.0, 53.0, 55.0, 56.0, 54.0, 55.0, 53.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 63.0, 61.0, 61.0, 61.0, 61.0, 62.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 80.0, 81.0, 80.0, 86.0, 79.0, 79.0, 80.0, 80.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 149.0, 136.0, 142.0, 143.0, 141.0, 143.0, 130.0, 169.0, 135.0], "value": 141.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 166.0, 165.0, 168.0, 169.0, 169.0, 165.0, 164.0, 166.0, 165.0], "value": 166.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 68.0, 76.0, 65.0, 67.0, 66.0, 67.0, 66.0, 64.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1505.8000000000002, "alertThreshold": 2.0}]} 18:51:42 INFO - Return code: 0 18:51:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:51:42 INFO - # TBPL SUCCESS # 18:51:42 INFO - Running post-action listener: _resource_record_post_action 18:51:42 INFO - [mozharness: 2016-10-08 01:51:42.338386Z] Finished run-tests step (success) 18:51:42 INFO - Running post-run listener: _resource_record_post_run 18:51:42 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 204800; Write bytes: 404328448; Read time: 304; Write time: 267732 18:51:42 INFO - TinderboxPrint: CPU usage
13.0% 18:51:42 INFO - TinderboxPrint: I/O read bytes / time
204,800 / 304 18:51:42 INFO - TinderboxPrint: I/O write bytes / time
404,328,448 / 267,732 18:51:42 INFO - TinderboxPrint: CPU idle
8,296.9 (86.9%) 18:51:42 INFO - TinderboxPrint: CPU user
1,197.8 (12.6%) 18:51:42 INFO - TinderboxPrint: Swap in / out
0 / 0 18:51:42 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 114589696; Read time: 96; Write time: 78168 18:51:42 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 196608; Write bytes: 289738752; Read time: 200; Write time: 189564 18:51:42 INFO - Running post-run listener: _upload_blobber_files 18:51:42 INFO - Blob upload gear active. 18:51:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:51:42 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 18:51:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:51:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:51:43 INFO - (blobuploader) - INFO - Open directory for files ... 18:51:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:51:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:51:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:51:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:51:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:51:43 INFO - (blobuploader) - INFO - Done attempting. 18:51:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:51:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:51:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:51:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:51:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:51:47 INFO - (blobuploader) - INFO - Done attempting. 18:51:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:51:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:51:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:51:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:51:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:51:49 INFO - (blobuploader) - INFO - Done attempting. 18:51:49 INFO - (blobuploader) - INFO - Iteration through files over. 18:51:49 INFO - Return code: 0 18:51:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:51:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:51:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3d95b166905bbe779093822b0167f25c21552f1680594658ca192b853d6608cec49bb4c9685d1d0fe9f6383b7779a5992243691fe117a327bd63e03cb177f211", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/007cc169f52854f93201cc25f30cc6c7a086fcc7573b86126751c3103982e786c9725441e60dc1091b2cbdd6a8b0e80475ed2d1599b57f7b01482d5223158c51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/754c6ae5f431f698faab7e5f1988ed0fb084822a236d3fd86b7cd77bd0f549ef48e6cf8da7d33c71ba764a09edabdf803208586173fa2d795649b85f9e3207f7"} 18:51:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:51:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:51:49 INFO - Contents: 18:51:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3d95b166905bbe779093822b0167f25c21552f1680594658ca192b853d6608cec49bb4c9685d1d0fe9f6383b7779a5992243691fe117a327bd63e03cb177f211", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/007cc169f52854f93201cc25f30cc6c7a086fcc7573b86126751c3103982e786c9725441e60dc1091b2cbdd6a8b0e80475ed2d1599b57f7b01482d5223158c51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/754c6ae5f431f698faab7e5f1988ed0fb084822a236d3fd86b7cd77bd0f549ef48e6cf8da7d33c71ba764a09edabdf803208586173fa2d795649b85f9e3207f7"} 18:51:49 INFO - Running post-run listener: copy_logs_to_upload_dir 18:51:49 INFO - Copying logs to upload dir... 18:51:49 INFO - mkdir: /builds/slave/test/build/upload/logs 18:51:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.505116 ========= master_lag: 0.36 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-10-07 18:51:49.269079) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 18:51:49.276161) ========= 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=826874ccc97bd7bf541b4875000001d5-1475882853.774275-693207389 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3d95b166905bbe779093822b0167f25c21552f1680594658ca192b853d6608cec49bb4c9685d1d0fe9f6383b7779a5992243691fe117a327bd63e03cb177f211", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/007cc169f52854f93201cc25f30cc6c7a086fcc7573b86126751c3103982e786c9725441e60dc1091b2cbdd6a8b0e80475ed2d1599b57f7b01482d5223158c51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/754c6ae5f431f698faab7e5f1988ed0fb084822a236d3fd86b7cd77bd0f549ef48e6cf8da7d33c71ba764a09edabdf803208586173fa2d795649b85f9e3207f7"} build_url:https://queue.taskcluster.net/v1/task/XVRgdMumQdiC5sgjdilezA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011380 build_url: 'https://queue.taskcluster.net/v1/task/XVRgdMumQdiC5sgjdilezA/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/Mozilla-Inbound/sha512/3d95b166905bbe779093822b0167f25c21552f1680594658ca192b853d6608cec49bb4c9685d1d0fe9f6383b7779a5992243691fe117a327bd63e03cb177f211", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/007cc169f52854f93201cc25f30cc6c7a086fcc7573b86126751c3103982e786c9725441e60dc1091b2cbdd6a8b0e80475ed2d1599b57f7b01482d5223158c51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/754c6ae5f431f698faab7e5f1988ed0fb084822a236d3fd86b7cd77bd0f549ef48e6cf8da7d33c71ba764a09edabdf803208586173fa2d795649b85f9e3207f7"}' ========= master_lag: 0.63 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 18:51:49.915701) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 18:51:49.916115) ========= 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=826874ccc97bd7bf541b4875000001d5-1475882853.774275-693207389 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004528 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 18:51:49.932941) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 18:51:49.933281) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 18:51:49.933583) ========= ========= Total master_lag: 1.06 =========