builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-007 starttime: 1482213721.21 results: success (0) buildid: 20161219202253 builduid: ddce2ca76a1d460dac2d69122129be1d revision: 171be6aaa16ee1d241ffa4bcdabc95b28372c28b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-19 22:02:01.210372) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-19 22:02:01.210827) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-19 22:02:01.211108) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-19 22:02:01.225846) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 22:02:01.226203) ========= 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=923d835db2ba3686ebe126b700000192-1482213487.340237-899975824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-19 22:02:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 31.4M=0s 2016-12-19 22:02:02 (31.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.403083 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 22:02:01.643151) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 22:02:01.643471) ========= 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=923d835db2ba3686ebe126b700000192-1482213487.340237-899975824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013983 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 22:02:01.693763) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 22:02:01.694115) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 171be6aaa16ee1d241ffa4bcdabc95b28372c28b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 171be6aaa16ee1d241ffa4bcdabc95b28372c28b --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=923d835db2ba3686ebe126b700000192-1482213487.340237-899975824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-19 22:02:02,328 truncating revision to first 12 chars 2016-12-19 22:02:02,328 Setting DEBUG logging. 2016-12-19 22:02:02,328 attempt 1/10 2016-12-19 22:02:02,328 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/171be6aaa16e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-19 22:02:02,649 unpacking tar archive at: mozilla-aurora-171be6aaa16e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.630789 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 22:02:02.339431) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-19 22:02:02.339833) ========= script_repo_revision: 171be6aaa16ee1d241ffa4bcdabc95b28372c28b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-19 22:02:02.340275) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-19 22:02:02.340632) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-19 22:02:02.352639) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-12-19 22:02:02.353003) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=923d835db2ba3686ebe126b700000192-1482213487.340237-899975824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:02:03 INFO - MultiFileLogger online at 20161219 22:02:03 in /builds/slave/test 22:02:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 22:02:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:02:03 INFO - {'append_to_log': False, 22:02:03 INFO - 'base_work_dir': '/builds/slave/test', 22:02:03 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 22:02:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:02:03 INFO - 'branch': 'Mozilla-Aurora', 22:02:03 INFO - 'buildbot_json_path': 'buildprops.json', 22:02:03 INFO - 'config_files': ('talos/linux_config.py',), 22:02:03 INFO - 'default_actions': ('clobber', 22:02:03 INFO - 'read-buildbot-config', 22:02:03 INFO - 'download-and-extract', 22:02:03 INFO - 'populate-webroot', 22:02:03 INFO - 'create-virtualenv', 22:02:03 INFO - 'install', 22:02:03 INFO - 'run-tests'), 22:02:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:02:03 INFO - 'download_minidump_stackwalk': True, 22:02:03 INFO - 'download_symbols': 'ondemand', 22:02:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:02:03 INFO - 'tooltool.py': '/tools/tooltool.py', 22:02:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:02:03 INFO - '/tools/misc-python/virtualenv.py')}, 22:02:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:02:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:02:03 INFO - 'installer_path': 'installer.exe', 22:02:03 INFO - 'log_level': 'info', 22:02:03 INFO - 'log_name': 'talos', 22:02:03 INFO - 'log_to_console': True, 22:02:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:02:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:02:03 INFO - 'opt_config_files': (), 22:02:03 INFO - 'pip_index': False, 22:02:03 INFO - 'sps_profile': False, 22:02:03 INFO - 'sps_profile_interval': 0, 22:02:03 INFO - 'suite': 'dromaeojs-e10s', 22:02:03 INFO - 'system_bits': '32', 22:02:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:02:03 INFO - 'title': 'talos-linux64-ix-007', 22:02:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:02:03 INFO - 'use_talos_json': True, 22:02:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:02:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:02:03 INFO - 'work_dir': 'build'} 22:02:03 INFO - [mozharness: 2016-12-20 06:02:03.081852Z] Running clobber step. 22:02:03 INFO - Running pre-action listener: _resource_record_pre_action 22:02:03 INFO - Running main action method: clobber 22:02:03 INFO - rmtree: /builds/slave/test/build 22:02:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:02:03 INFO - Running post-action listener: _resource_record_post_action 22:02:03 INFO - [mozharness: 2016-12-20 06:02:03.553193Z] Finished clobber step (success) 22:02:03 INFO - [mozharness: 2016-12-20 06:02:03.553292Z] Running read-buildbot-config step. 22:02:03 INFO - Running pre-action listener: _resource_record_pre_action 22:02:03 INFO - Running main action method: read_buildbot_config 22:02:03 INFO - Using buildbot properties: 22:02:03 INFO - { 22:02:03 INFO - "project": "", 22:02:03 INFO - "product": "firefox", 22:02:03 INFO - "script_repo_revision": "production", 22:02:03 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 22:02:03 INFO - "repository": "", 22:02:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 22:02:03 INFO - "buildid": "20161219202253", 22:02:03 INFO - "pgo_build": "True", 22:02:03 INFO - "basedir": "/builds/slave/test", 22:02:03 INFO - "buildnumber": 719, 22:02:03 INFO - "slavename": "talos-linux64-ix-007", 22:02:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:02:03 INFO - "platform": "ubuntu64_hw", 22:02:03 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 22:02:03 INFO - "branch": "mozilla-aurora", 22:02:03 INFO - "repo_path": "releases/mozilla-aurora", 22:02:03 INFO - "revision": "171be6aaa16ee1d241ffa4bcdabc95b28372c28b", 22:02:03 INFO - "stage_platform": "linux64-pgo", 22:02:03 INFO - "builduid": "ddce2ca76a1d460dac2d69122129be1d", 22:02:03 INFO - "slavebuilddir": "test" 22:02:03 INFO - } 22:02:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/eHzeF_F7QtqJx1Jdri-D4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 22:02:03 INFO - Running post-action listener: _resource_record_post_action 22:02:03 INFO - [mozharness: 2016-12-20 06:02:03.555839Z] Finished read-buildbot-config step (success) 22:02:03 INFO - [mozharness: 2016-12-20 06:02:03.555925Z] Running download-and-extract step. 22:02:03 INFO - Running pre-action listener: _resource_record_pre_action 22:02:03 INFO - Running main action method: download_and_extract 22:02:03 INFO - mkdir: /builds/slave/test/build/tests 22:02: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')]} 22:02:03 INFO - trying https://queue.taskcluster.net/v1/task/eHzeF_F7QtqJx1Jdri-D4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 22:02:03 INFO - Downloading https://queue.taskcluster.net/v1/task/eHzeF_F7QtqJx1Jdri-D4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 22:02:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eHzeF_F7QtqJx1Jdri-D4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:02:04 INFO - Downloaded 1361 bytes. 22:02:04 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 22:02:04 INFO - Using the following test package requirements: 22:02:04 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 22:02:04 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 22:02:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 22:02:04 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 22:02:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 22:02:04 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 22:02:04 INFO - u'jsshell-linux-x86_64.zip'], 22:02:04 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 22:02:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 22:02:04 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 22:02:04 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 22:02:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 22:02:04 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 22:02:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 22:02:04 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 22:02:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 22:02:04 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 22:02:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 22:02:04 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:02:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eHzeF_F7QtqJx1Jdri-D4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 22:02:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eHzeF_F7QtqJx1Jdri-D4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:02:04 INFO - Fetch https://queue.taskcluster.net/v1/task/eHzeF_F7QtqJx1Jdri-D4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 22:02:04 INFO - Http code: 200 22:02:04 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 22:02:04 INFO - x-amz-cf-id: YyVuNNUl6jypwgArL4vZunQkkIyPVcv2fdNiMnubvqQEvhzcqfyaLg== 22:02:04 INFO - x-amz-version-id: cI27WYliMsyIssiW30XONLZoUXG1UdSD 22:02:04 INFO - Expected file size: 21940786 22:02:04 INFO - Obtained file size: 21940786 22:02:08 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:02:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eHzeF_F7QtqJx1Jdri-D4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 22:02:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eHzeF_F7QtqJx1Jdri-D4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:02:08 INFO - Fetch https://queue.taskcluster.net/v1/task/eHzeF_F7QtqJx1Jdri-D4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 22:02:09 INFO - Http code: 200 22:02:09 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 22:02:09 INFO - x-amz-cf-id: h_nOERm99UfDWDu9jk_qR2IWRTFqtJwp2yg-fOsmiVKfu0BwaJTpUg== 22:02:09 INFO - x-amz-version-id: cI27WYliMsyIssiW30XONLZoUXG1UdSD 22:02:10 INFO - Expected file size: 21940786 22:02:10 INFO - Obtained file size: 21940786 22:02:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eHzeF_F7QtqJx1Jdri-D4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 22:02:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eHzeF_F7QtqJx1Jdri-D4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:02:14 INFO - Fetch https://queue.taskcluster.net/v1/task/eHzeF_F7QtqJx1Jdri-D4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 22:02:14 INFO - Http code: 200 22:02:14 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 22:02:14 INFO - x-amz-cf-id: 6PGWBrrdGqbITAtpd4cyqLK7x7TGYWgtZt4eAz5aswuGyKNeObX64g== 22:02:14 INFO - x-amz-version-id: t2wR8W8BfwPNfnoNqHTHmsiECpAa5N.Y 22:02:15 INFO - Expected file size: 14409038 22:02:15 INFO - Obtained file size: 14409038 22:02:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:02:15 INFO - trying https://queue.taskcluster.net/v1/task/eHzeF_F7QtqJx1Jdri-D4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 22:02:15 INFO - Downloading https://queue.taskcluster.net/v1/task/eHzeF_F7QtqJx1Jdri-D4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 22:02:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eHzeF_F7QtqJx1Jdri-D4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:02:18 INFO - Downloaded 63942889 bytes. 22:02:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eHzeF_F7QtqJx1Jdri-D4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 22:02:18 INFO - mkdir: /builds/slave/test/properties 22:02:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:02:18 INFO - Writing to file /builds/slave/test/properties/build_url 22:02:18 INFO - Contents: 22:02:18 INFO - build_url:https://queue.taskcluster.net/v1/task/eHzeF_F7QtqJx1Jdri-D4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 22:02:19 INFO - Running post-action listener: _resource_record_post_action 22:02:19 INFO - Running post-action listener: set_extra_try_arguments 22:02:19 INFO - [mozharness: 2016-12-20 06:02:19.669823Z] Finished download-and-extract step (success) 22:02:19 INFO - [mozharness: 2016-12-20 06:02:19.670047Z] Running populate-webroot step. 22:02:19 INFO - Running pre-action listener: _resource_record_pre_action 22:02:19 INFO - Running main action method: populate_webroot 22:02:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:02:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:02:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:02:19 INFO - '--tppagecycles', 22:02:19 INFO - '7'], 22:02:19 INFO - 'tests': ['tsvgm']}}, 22:02:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:02:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:02:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:02:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:02:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:02:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:02:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:02:19 INFO - 'talos_options': ['--disable-e10s'], 22:02:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:02:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:02:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:02:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:02:19 INFO - 'talos_options': ['--disable-e10s'], 22:02:19 INFO - 'tests': ['damp', 'tps']}, 22:02:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:02:19 INFO - 'tests': ['damp', 'tps']}, 22:02:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:02:19 INFO - 'tests': ['dromaeo_dom']}, 22:02:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:02:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:02:19 INFO - 'tests': ['basic_compositor_video']}, 22:02:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:02:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:02:19 INFO - 'tests': ['a11yr', 22:02:19 INFO - 'ts_paint', 22:02:19 INFO - 'tpaint', 22:02:19 INFO - 'sessionrestore', 22:02:19 INFO - 'sessionrestore_no_auto_restore', 22:02:19 INFO - 'tabpaint']}, 22:02:19 INFO - 'other-e10s': {'tests': ['a11yr', 22:02:19 INFO - 'ts_paint', 22:02:19 INFO - 'tpaint', 22:02:19 INFO - 'sessionrestore', 22:02:19 INFO - 'sessionrestore_no_auto_restore', 22:02:19 INFO - 'tabpaint']}, 22:02:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:02:19 INFO - 'ts_paint', 22:02:19 INFO - 'tpaint', 22:02:19 INFO - 'sessionrestore', 22:02:19 INFO - 'sessionrestore_no_auto_restore', 22:02:19 INFO - 'tabpaint']}, 22:02:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:02:19 INFO - 'ts_paint', 22:02:19 INFO - 'tpaint', 22:02:19 INFO - 'sessionrestore', 22:02:19 INFO - 'sessionrestore_no_auto_restore', 22:02:19 INFO - 'tabpaint']}, 22:02:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:02:19 INFO - 'tests': ['a11yr', 22:02:19 INFO - 'ts_paint', 22:02:19 INFO - 'tpaint', 22:02:19 INFO - 'sessionrestore', 22:02:19 INFO - 'sessionrestore_no_auto_restore', 22:02:19 INFO - 'tabpaint']}, 22:02:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:02:19 INFO - 'tests': ['a11yr', 22:02:19 INFO - 'ts_paint', 22:02:19 INFO - 'tpaint', 22:02:19 INFO - 'sessionrestore', 22:02:19 INFO - 'sessionrestore_no_auto_restore', 22:02:19 INFO - 'tabpaint']}, 22:02:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:02:19 INFO - 'tests': ['tsvgx', 22:02:19 INFO - 'tsvgr_opacity', 22:02:19 INFO - 'tart', 22:02:19 INFO - 'tscrollx', 22:02:19 INFO - 'cart']}, 22:02:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:02:19 INFO - 'tsvgr_opacity', 22:02:19 INFO - 'tart', 22:02:19 INFO - 'tscrollx', 22:02:19 INFO - 'cart']}, 22:02:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:02:19 INFO - 'talos_options': ['--disable-e10s'], 22:02:19 INFO - 'tests': ['tp5o']}, 22:02:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:02:19 INFO - 'tests': ['tp5o']}, 22:02:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:02:19 INFO - 'talos_options': ['--disable-e10s', 22:02:19 INFO - '--xperf_path', 22:02:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:02:19 INFO - 'tests': ['tp5n']}, 22:02:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:02:19 INFO - 'talos_options': ['--xperf_path', 22:02:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:02:19 INFO - 'tests': ['tp5n']}}, 22:02:19 INFO - 'talos.zip': {'path': '', 22:02:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:02:19 INFO - Running post-action listener: _resource_record_post_action 22:02:19 INFO - [mozharness: 2016-12-20 06:02:19.686208Z] Finished populate-webroot step (success) 22:02:19 INFO - [mozharness: 2016-12-20 06:02:19.686295Z] Running create-virtualenv step. 22:02:19 INFO - Running pre-action listener: _resource_record_pre_action 22:02:19 INFO - Running main action method: create_virtualenv 22:02:19 INFO - Creating virtualenv /builds/slave/test/build/venv 22:02:19 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 22:02:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:02:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:02:19 INFO - Using real prefix '/usr' 22:02:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:02:20 INFO - Installing distribute.............................................................................................................................................................................................done. 22:02:22 INFO - Installing pip.................done. 22:02:22 INFO - Return code: 0 22:02:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:02:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:02:22 INFO - Reading from file tmpfile_stdout 22:02:22 INFO - Output received: 22:02:22 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) 22:02:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:02:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:02:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:22 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 0x7f5ab260ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229af60>, '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 0x229bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229c1d0>, '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': '923d835db2ba3686ebe126b700000192-1482213487.340237-899975824', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:02:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:02:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:02:22 INFO - Using env: {'DISPLAY': ':0', 22:02:22 INFO - 'HOME': '/home/cltbld', 22:02:22 INFO - 'LANG': 'en_US.UTF-8', 22:02:22 INFO - 'LANGUAGE': 'en_US:en', 22:02:22 INFO - 'LOGNAME': 'cltbld', 22:02:22 INFO - 'MAIL': '/var/mail/cltbld', 22:02:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:22 INFO - 'MOZ_NO_REMOTE': '1', 22:02:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:22 INFO - 'NO_EM_RESTART': '1', 22:02:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:02:22 INFO - 'PWD': '/builds/slave/test', 22:02:22 INFO - 'SHELL': '/bin/bash', 22:02:22 INFO - 'SHLVL': '1', 22:02:22 INFO - 'TERM': 'linux', 22:02:22 INFO - 'TMOUT': '86400', 22:02:22 INFO - 'USER': 'cltbld', 22:02:22 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1482213487.340237-899975824', 22:02:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:22 INFO - '_': '/tools/buildbot/bin/python'} 22:02:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:22 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:02:22 INFO - Cleaning up... 22:02:22 INFO - Return code: 0 22:02:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:02:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:02:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:22 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 0x7f5ab260ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229af60>, '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 0x229bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229c1d0>, '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': '923d835db2ba3686ebe126b700000192-1482213487.340237-899975824', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:02:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 22:02:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:02:22 INFO - Using env: {'DISPLAY': ':0', 22:02:22 INFO - 'HOME': '/home/cltbld', 22:02:22 INFO - 'LANG': 'en_US.UTF-8', 22:02:22 INFO - 'LANGUAGE': 'en_US:en', 22:02:22 INFO - 'LOGNAME': 'cltbld', 22:02:22 INFO - 'MAIL': '/var/mail/cltbld', 22:02:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:22 INFO - 'MOZ_NO_REMOTE': '1', 22:02:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:22 INFO - 'NO_EM_RESTART': '1', 22:02:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:02:22 INFO - 'PWD': '/builds/slave/test', 22:02:22 INFO - 'SHELL': '/bin/bash', 22:02:22 INFO - 'SHLVL': '1', 22:02:22 INFO - 'TERM': 'linux', 22:02:22 INFO - 'TMOUT': '86400', 22:02:22 INFO - 'USER': 'cltbld', 22:02:22 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1482213487.340237-899975824', 22:02:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:22 INFO - '_': '/tools/buildbot/bin/python'} 22:02:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:22 INFO - Downloading/unpacking psutil>=3.1.1 22:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:02:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:02:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:02:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:02:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:02:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:02:25 INFO - Installing collected packages: psutil 22:02:25 INFO - Running setup.py install for psutil 22:02:25 INFO - building 'psutil._psutil_linux' extension 22:02:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:02:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:02:25 INFO - building 'psutil._psutil_posix' extension 22:02:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:02:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:02:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:02:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:02:25 INFO - Successfully installed psutil 22:02:25 INFO - Cleaning up... 22:02:25 INFO - Return code: 0 22:02:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:02:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:02:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:25 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 0x7f5ab260ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229af60>, '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 0x229bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229c1d0>, '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': '923d835db2ba3686ebe126b700000192-1482213487.340237-899975824', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:02:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:02:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 22:02:25 INFO - Using env: {'DISPLAY': ':0', 22:02:25 INFO - 'HOME': '/home/cltbld', 22:02:25 INFO - 'LANG': 'en_US.UTF-8', 22:02:25 INFO - 'LANGUAGE': 'en_US:en', 22:02:25 INFO - 'LOGNAME': 'cltbld', 22:02:25 INFO - 'MAIL': '/var/mail/cltbld', 22:02:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:25 INFO - 'MOZ_NO_REMOTE': '1', 22:02:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:25 INFO - 'NO_EM_RESTART': '1', 22:02:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:02:25 INFO - 'PWD': '/builds/slave/test', 22:02:25 INFO - 'SHELL': '/bin/bash', 22:02:25 INFO - 'SHLVL': '1', 22:02:25 INFO - 'TERM': 'linux', 22:02:25 INFO - 'TMOUT': '86400', 22:02:25 INFO - 'USER': 'cltbld', 22:02:25 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1482213487.340237-899975824', 22:02:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:25 INFO - '_': '/tools/buildbot/bin/python'} 22:02:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:02:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:02:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:02:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:02:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:02:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:02:27 INFO - Installing collected packages: mozsystemmonitor 22:02:27 INFO - Running setup.py install for mozsystemmonitor 22:02:27 INFO - Successfully installed mozsystemmonitor 22:02:27 INFO - Cleaning up... 22:02:27 INFO - Return code: 0 22:02:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:02:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:02:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:28 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 0x7f5ab260ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229af60>, '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 0x229bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229c1d0>, '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': '923d835db2ba3686ebe126b700000192-1482213487.340237-899975824', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:02:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 22:02:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 22:02:28 INFO - Using env: {'DISPLAY': ':0', 22:02:28 INFO - 'HOME': '/home/cltbld', 22:02:28 INFO - 'LANG': 'en_US.UTF-8', 22:02:28 INFO - 'LANGUAGE': 'en_US:en', 22:02:28 INFO - 'LOGNAME': 'cltbld', 22:02:28 INFO - 'MAIL': '/var/mail/cltbld', 22:02:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:28 INFO - 'MOZ_NO_REMOTE': '1', 22:02:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:28 INFO - 'NO_EM_RESTART': '1', 22:02:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:02:28 INFO - 'PWD': '/builds/slave/test', 22:02:28 INFO - 'SHELL': '/bin/bash', 22:02:28 INFO - 'SHLVL': '1', 22:02:28 INFO - 'TERM': 'linux', 22:02:28 INFO - 'TMOUT': '86400', 22:02:28 INFO - 'USER': 'cltbld', 22:02:28 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1482213487.340237-899975824', 22:02:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:28 INFO - '_': '/tools/buildbot/bin/python'} 22:02:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:28 INFO - Downloading/unpacking jsonschema==2.5.1 22:02:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:02:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:02:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:02:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:02:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:02:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:02:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:02:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:02:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:30 INFO - Downloading functools32-3.2.3-2.tar.gz 22:02:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:02:30 INFO - warning: no files found matching '*.txt' 22:02:30 INFO - no previously-included directories found matching 'build' 22:02:30 INFO - no previously-included directories found matching 'dist' 22:02:30 INFO - no previously-included directories found matching '.git*' 22:02:30 INFO - Installing collected packages: jsonschema, functools32 22:02:30 INFO - Running setup.py install for functools32 22:02:30 INFO - warning: no files found matching '*.txt' 22:02:30 INFO - no previously-included directories found matching 'build' 22:02:30 INFO - no previously-included directories found matching 'dist' 22:02:30 INFO - no previously-included directories found matching '.git*' 22:02:30 INFO - Successfully installed jsonschema functools32 22:02:30 INFO - Cleaning up... 22:02:30 INFO - Return code: 0 22:02:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:02:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:30 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 0x7f5ab260ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229af60>, '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 0x229bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229c1d0>, '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': '923d835db2ba3686ebe126b700000192-1482213487.340237-899975824', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:02:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 22:02:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 22:02:30 INFO - Using env: {'DISPLAY': ':0', 22:02:30 INFO - 'HOME': '/home/cltbld', 22:02:30 INFO - 'LANG': 'en_US.UTF-8', 22:02:30 INFO - 'LANGUAGE': 'en_US:en', 22:02:30 INFO - 'LOGNAME': 'cltbld', 22:02:30 INFO - 'MAIL': '/var/mail/cltbld', 22:02:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:30 INFO - 'MOZ_NO_REMOTE': '1', 22:02:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:30 INFO - 'NO_EM_RESTART': '1', 22:02:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:02:30 INFO - 'PWD': '/builds/slave/test', 22:02:30 INFO - 'SHELL': '/bin/bash', 22:02:30 INFO - 'SHLVL': '1', 22:02:30 INFO - 'TERM': 'linux', 22:02:30 INFO - 'TMOUT': '86400', 22:02:30 INFO - 'USER': 'cltbld', 22:02:30 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1482213487.340237-899975824', 22:02:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:30 INFO - '_': '/tools/buildbot/bin/python'} 22:02:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:02:30 INFO - Cleaning up... 22:02:30 INFO - Return code: 0 22:02:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:02:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:30 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 0x7f5ab260ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229af60>, '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 0x229bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229c1d0>, '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': '923d835db2ba3686ebe126b700000192-1482213487.340237-899975824', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:02:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:02:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:02:30 INFO - Using env: {'DISPLAY': ':0', 22:02:30 INFO - 'HOME': '/home/cltbld', 22:02:30 INFO - 'LANG': 'en_US.UTF-8', 22:02:30 INFO - 'LANGUAGE': 'en_US:en', 22:02:30 INFO - 'LOGNAME': 'cltbld', 22:02:30 INFO - 'MAIL': '/var/mail/cltbld', 22:02:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:30 INFO - 'MOZ_NO_REMOTE': '1', 22:02:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:30 INFO - 'NO_EM_RESTART': '1', 22:02:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:02:30 INFO - 'PWD': '/builds/slave/test', 22:02:30 INFO - 'SHELL': '/bin/bash', 22:02:30 INFO - 'SHLVL': '1', 22:02:30 INFO - 'TERM': 'linux', 22:02:30 INFO - 'TMOUT': '86400', 22:02:30 INFO - 'USER': 'cltbld', 22:02:30 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1482213487.340237-899975824', 22:02:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:30 INFO - '_': '/tools/buildbot/bin/python'} 22:02:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:31 INFO - Downloading/unpacking blobuploader==1.2.4 22:02: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 22:02: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 22:02: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 22:02: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 22:02: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 22:02: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 22:02:33 INFO - Downloading blobuploader-1.2.4.tar.gz 22:02:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:02:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:02: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 22:02: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 22:02: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 22:02: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 22:02: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 22:02: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 22:02:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:02:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:02: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 22:02: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 22:02: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 22:02: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 22:02: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 22:02: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 22:02:33 INFO - Downloading docopt-0.6.1.tar.gz 22:02:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:02:33 INFO - Installing collected packages: blobuploader, requests, docopt 22:02:33 INFO - Running setup.py install for blobuploader 22:02:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:02:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:02:33 INFO - Running setup.py install for requests 22:02:34 INFO - Running setup.py install for docopt 22:02:34 INFO - Successfully installed blobuploader requests docopt 22:02:34 INFO - Cleaning up... 22:02:34 INFO - Return code: 0 22:02:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:02: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')]} 22:02:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02: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')]} 22:02:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:34 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 0x7f5ab260ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229af60>, '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 0x229bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229c1d0>, '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': '923d835db2ba3686ebe126b700000192-1482213487.340237-899975824', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:02:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:02:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:02:34 INFO - Using env: {'DISPLAY': ':0', 22:02:34 INFO - 'HOME': '/home/cltbld', 22:02:34 INFO - 'LANG': 'en_US.UTF-8', 22:02:34 INFO - 'LANGUAGE': 'en_US:en', 22:02:34 INFO - 'LOGNAME': 'cltbld', 22:02:34 INFO - 'MAIL': '/var/mail/cltbld', 22:02:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:34 INFO - 'MOZ_NO_REMOTE': '1', 22:02:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:34 INFO - 'NO_EM_RESTART': '1', 22:02:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:02:34 INFO - 'PWD': '/builds/slave/test', 22:02:34 INFO - 'SHELL': '/bin/bash', 22:02:34 INFO - 'SHLVL': '1', 22:02:34 INFO - 'TERM': 'linux', 22:02:34 INFO - 'TMOUT': '86400', 22:02:34 INFO - 'USER': 'cltbld', 22:02:34 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1482213487.340237-899975824', 22:02:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:34 INFO - '_': '/tools/buildbot/bin/python'} 22:02:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:02:34 INFO - Running setup.py (path:/tmp/pip-tm0grW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:02:34 INFO - Running setup.py (path:/tmp/pip-2oriCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:02:34 INFO - Running setup.py (path:/tmp/pip-tI9MTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:02:34 INFO - Running setup.py (path:/tmp/pip-NLjq5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:02:35 INFO - Running setup.py (path:/tmp/pip-PRi85y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:02:35 INFO - Running setup.py (path:/tmp/pip-lEhkIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:02:35 INFO - Running setup.py (path:/tmp/pip-4CeyOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:02:35 INFO - Running setup.py (path:/tmp/pip-8HDkGh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:02:35 INFO - Running setup.py (path:/tmp/pip-wHyTWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:02:35 INFO - Running setup.py (path:/tmp/pip-1Kmq2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:02:35 INFO - Running setup.py (path:/tmp/pip-Eu9vty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:02:35 INFO - Running setup.py (path:/tmp/pip-OSIulj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:02:35 INFO - Running setup.py (path:/tmp/pip-t5hBhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:02:35 INFO - Running setup.py (path:/tmp/pip-AZtux_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:02:35 INFO - Running setup.py (path:/tmp/pip-6phxdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:02:35 INFO - Running setup.py (path:/tmp/pip-JBz_8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:02:35 INFO - Running setup.py (path:/tmp/pip-624qF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:02:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:02:35 INFO - Running setup.py install for manifestparser 22:02:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:02:36 INFO - Running setup.py install for mozcrash 22:02:36 INFO - Running setup.py install for mozdebug 22:02:36 INFO - Running setup.py install for mozdevice 22:02:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:02:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:02:36 INFO - Running setup.py install for mozfile 22:02:36 INFO - Running setup.py install for mozhttpd 22:02:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:02:36 INFO - Running setup.py install for mozinfo 22:02:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:02:36 INFO - Running setup.py install for mozInstall 22:02:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:02:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:02:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:02:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:02:36 INFO - Running setup.py install for mozleak 22:02:36 INFO - Running setup.py install for mozlog 22:02:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:02:37 INFO - Running setup.py install for moznetwork 22:02:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:02:37 INFO - Running setup.py install for mozprocess 22:02:37 INFO - Running setup.py install for mozprofile 22:02:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:02:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:02:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:02:37 INFO - Running setup.py install for mozrunner 22:02:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:02:37 INFO - Running setup.py install for mozscreenshot 22:02:37 INFO - Running setup.py install for moztest 22:02:37 INFO - Running setup.py install for mozversion 22:02:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:02:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:02:37 INFO - Cleaning up... 22:02:37 INFO - Return code: 0 22:02:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:02:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:02:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:02:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:37 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 0x7f5ab260ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229af60>, '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 0x229bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229c1d0>, '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': '923d835db2ba3686ebe126b700000192-1482213487.340237-899975824', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:02:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:02:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:02:37 INFO - Using env: {'DISPLAY': ':0', 22:02:37 INFO - 'HOME': '/home/cltbld', 22:02:37 INFO - 'LANG': 'en_US.UTF-8', 22:02:37 INFO - 'LANGUAGE': 'en_US:en', 22:02:37 INFO - 'LOGNAME': 'cltbld', 22:02:37 INFO - 'MAIL': '/var/mail/cltbld', 22:02:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:37 INFO - 'MOZ_NO_REMOTE': '1', 22:02:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:37 INFO - 'NO_EM_RESTART': '1', 22:02:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:02:37 INFO - 'PWD': '/builds/slave/test', 22:02:37 INFO - 'SHELL': '/bin/bash', 22:02:37 INFO - 'SHLVL': '1', 22:02:37 INFO - 'TERM': 'linux', 22:02:37 INFO - 'TMOUT': '86400', 22:02:37 INFO - 'USER': 'cltbld', 22:02:37 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1482213487.340237-899975824', 22:02:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:37 INFO - '_': '/tools/buildbot/bin/python'} 22:02:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:02:37 INFO - Running setup.py (path:/tmp/pip-7sYJwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 22:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:02:38 INFO - Running setup.py (path:/tmp/pip-qW_hmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:02:38 INFO - Running setup.py (path:/tmp/pip-0t3xe7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:02:38 INFO - Running setup.py (path:/tmp/pip-5zdggr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:02:38 INFO - Running setup.py (path:/tmp/pip-c5tyHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 22:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:02:38 INFO - Running setup.py (path:/tmp/pip-NNItDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 22:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:02:38 INFO - Running setup.py (path:/tmp/pip-eWdF_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 22:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:02:38 INFO - Running setup.py (path:/tmp/pip-06_LMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 22:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:02:38 INFO - Running setup.py (path:/tmp/pip-OL9wfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 22:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:02:38 INFO - Running setup.py (path:/tmp/pip-KzKqEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:02:38 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)) 22:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:02:38 INFO - Running setup.py (path:/tmp/pip-x16IPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 22:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:02:38 INFO - Running setup.py (path:/tmp/pip-j9o599-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 22:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:02:38 INFO - Running setup.py (path:/tmp/pip-dno9jm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 22:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:02:38 INFO - Running setup.py (path:/tmp/pip-n92bK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:02:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:02:39 INFO - Running setup.py (path:/tmp/pip-HoWpyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:02:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 22:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:02:39 INFO - Running setup.py (path:/tmp/pip-0je5aL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:02:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 22:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:02:39 INFO - Running setup.py (path:/tmp/pip-ozDw3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:02:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 22:02:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:02:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:02:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:02:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:02:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:02:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:02:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:02:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:02:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:02:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:02:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:41 INFO - Downloading blessings-1.6.tar.gz 22:02:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:02:41 INFO - Installing collected packages: blessings 22:02:41 INFO - Running setup.py install for blessings 22:02:41 INFO - Successfully installed blessings 22:02:41 INFO - Cleaning up... 22:02:41 INFO - Return code: 0 22:02:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:02:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:02:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:02:41 INFO - Reading from file tmpfile_stdout 22:02:41 INFO - Current package versions: 22:02:41 INFO - argparse == 1.2.1 22:02:41 INFO - blessings == 1.6 22:02:41 INFO - blobuploader == 1.2.4 22:02:41 INFO - docopt == 0.6.1 22:02:41 INFO - functools32 == 3.2.3-2 22:02:41 INFO - jsonschema == 2.5.1 22:02:41 INFO - manifestparser == 1.1 22:02:41 INFO - mozInstall == 1.12 22:02:41 INFO - mozcrash == 1.0 22:02:41 INFO - mozdebug == 0.1 22:02:41 INFO - mozdevice == 0.48 22:02:41 INFO - mozfile == 1.2 22:02:41 INFO - mozhttpd == 0.7 22:02:41 INFO - mozinfo == 0.9 22:02:41 INFO - mozleak == 0.1 22:02:41 INFO - mozlog == 3.4 22:02:41 INFO - moznetwork == 0.27 22:02:41 INFO - mozprocess == 0.23 22:02:41 INFO - mozprofile == 0.28 22:02:41 INFO - mozrunner == 6.13 22:02:41 INFO - mozscreenshot == 0.1 22:02:41 INFO - mozsystemmonitor == 0.3 22:02:41 INFO - moztest == 0.7 22:02:41 INFO - mozversion == 1.4 22:02:41 INFO - psutil == 3.1.1 22:02:41 INFO - requests == 1.2.3 22:02:41 INFO - wsgiref == 0.1.2 22:02:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:02: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')]} 22:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02: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')]} 22:02:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:41 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 0x7f5ab260ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229af60>, '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 0x229bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229c1d0>, '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': '923d835db2ba3686ebe126b700000192-1482213487.340237-899975824', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:02:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 22:02:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:02:41 INFO - Using env: {'DISPLAY': ':0', 22:02:41 INFO - 'HOME': '/home/cltbld', 22:02:41 INFO - 'LANG': 'en_US.UTF-8', 22:02:41 INFO - 'LANGUAGE': 'en_US:en', 22:02:41 INFO - 'LOGNAME': 'cltbld', 22:02:41 INFO - 'MAIL': '/var/mail/cltbld', 22:02:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:41 INFO - 'MOZ_NO_REMOTE': '1', 22:02:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:41 INFO - 'NO_EM_RESTART': '1', 22:02:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:02:41 INFO - 'PWD': '/builds/slave/test', 22:02:41 INFO - 'SHELL': '/bin/bash', 22:02:41 INFO - 'SHLVL': '1', 22:02:41 INFO - 'TERM': 'linux', 22:02:41 INFO - 'TMOUT': '86400', 22:02:41 INFO - 'USER': 'cltbld', 22:02:41 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1482213487.340237-899975824', 22:02:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:41 INFO - '_': '/tools/buildbot/bin/python'} 22:02:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 22:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 22:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 22:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 22:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 22:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 22:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 22:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:02:41 INFO - Cleaning up... 22:02:41 INFO - Return code: 0 22:02:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:02: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')]} 22:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02: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')]} 22:02:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:41 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 0x7f5ab260ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229af60>, '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 0x229bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229c1d0>, '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': '923d835db2ba3686ebe126b700000192-1482213487.340237-899975824', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:02:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:02:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:02:41 INFO - Using env: {'DISPLAY': ':0', 22:02:41 INFO - 'HOME': '/home/cltbld', 22:02:41 INFO - 'LANG': 'en_US.UTF-8', 22:02:41 INFO - 'LANGUAGE': 'en_US:en', 22:02:41 INFO - 'LOGNAME': 'cltbld', 22:02:41 INFO - 'MAIL': '/var/mail/cltbld', 22:02:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:41 INFO - 'MOZ_NO_REMOTE': '1', 22:02:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:41 INFO - 'NO_EM_RESTART': '1', 22:02:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:02:41 INFO - 'PWD': '/builds/slave/test', 22:02:41 INFO - 'SHELL': '/bin/bash', 22:02:41 INFO - 'SHLVL': '1', 22:02:41 INFO - 'TERM': 'linux', 22:02:41 INFO - 'TMOUT': '86400', 22:02:41 INFO - 'USER': 'cltbld', 22:02:41 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1482213487.340237-899975824', 22:02:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:41 INFO - '_': '/tools/buildbot/bin/python'} 22:02:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:02:42 INFO - Cleaning up... 22:02:42 INFO - Return code: 0 22:02:42 INFO - Running post-action listener: _resource_record_post_action 22:02:42 INFO - Running post-action listener: _start_resource_monitoring 22:02:42 INFO - Starting resource monitoring. 22:02:42 INFO - [mozharness: 2016-12-20 06:02:42.187561Z] Finished create-virtualenv step (success) 22:02:42 INFO - [mozharness: 2016-12-20 06:02:42.188066Z] Running install step. 22:02:42 INFO - Running pre-action listener: _resource_record_pre_action 22:02:42 INFO - Running main action method: install 22:02:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:02:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:02:42 INFO - Reading from file tmpfile_stdout 22:02:42 INFO - Detecting whether we're running mozinstall >=1.0... 22:02:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:02:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:02:42 INFO - Reading from file tmpfile_stdout 22:02:42 INFO - Output received: 22:02:42 INFO - Usage: mozinstall [options] installer 22:02:42 INFO - Options: 22:02:42 INFO - -h, --help show this help message and exit 22:02:42 INFO - -d DEST, --destination=DEST 22:02:42 INFO - Directory to install application into. [default: 22:02:42 INFO - "/builds/slave/test"] 22:02:42 INFO - --app=APP Application being installed. [default: firefox] 22:02:42 INFO - mkdir: /builds/slave/test/build/application 22:02:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:02:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:02:58 INFO - Reading from file tmpfile_stdout 22:02:58 INFO - Output received: 22:02:58 INFO - /builds/slave/test/build/application/firefox/firefox 22:02:58 INFO - Running post-action listener: _resource_record_post_action 22:02:58 INFO - [mozharness: 2016-12-20 06:02:58.405238Z] Finished install step (success) 22:02:58 INFO - [mozharness: 2016-12-20 06:02:58.405568Z] Running run-tests step. 22:02:58 INFO - Running pre-action listener: _resource_record_pre_action 22:02:58 INFO - Running main action method: run_tests 22:02:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:02:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:02:58 INFO - Python 2.7.3 22:02:58 INFO - Return code: 0 22:02:58 INFO - grabbing minidump binary from tooltool 22:02:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:02:58 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 0x229af60>, '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 0x229bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229c1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:02:58 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 22:02:58 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:02:58 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 22:02:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:02:58 INFO - Return code: 0 22:02:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:02:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:02:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:02:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:02:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:02:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eHzeF_F7QtqJx1Jdri-D4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 22:02:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eHzeF_F7QtqJx1Jdri-D4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:02:58 INFO - Using env: {'DISPLAY': ':0', 22:02:58 INFO - 'HOME': '/home/cltbld', 22:02:58 INFO - 'LANG': 'en_US.UTF-8', 22:02:58 INFO - 'LANGUAGE': 'en_US:en', 22:02:58 INFO - 'LOGNAME': 'cltbld', 22:02:58 INFO - 'MAIL': '/var/mail/cltbld', 22:02:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:02:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:02:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:58 INFO - 'MOZ_NO_REMOTE': '1', 22:02:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:02:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:58 INFO - 'NO_EM_RESTART': '1', 22:02:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:02:58 INFO - 'PWD': '/builds/slave/test', 22:02:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:02:58 INFO - 'SHELL': '/bin/bash', 22:02:58 INFO - 'SHLVL': '1', 22:02:58 INFO - 'TERM': 'linux', 22:02:58 INFO - 'TMOUT': '86400', 22:02:58 INFO - 'USER': 'cltbld', 22:02:58 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1482213487.340237-899975824', 22:02:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:58 INFO - '_': '/tools/buildbot/bin/python'} 22:02:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eHzeF_F7QtqJx1Jdri-D4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:02:58 INFO - mozversion application_buildid: 20161219202253 22:02:58 INFO - mozversion application_changeset: 171be6aaa16ee1d241ffa4bcdabc95b28372c28b 22:02:58 INFO - mozversion application_display_name: FirefoxDeveloperEdition 22:02:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:02:58 INFO - mozversion application_name: Firefox 22:02:58 INFO - mozversion application_remotingname: firefox-dev 22:02:58 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:02:58 INFO - mozversion application_vendor: Mozilla 22:02:58 INFO - mozversion application_version: 52.0a2 22:02:58 INFO - mozversion platform_buildid: 20161219202253 22:02:58 INFO - mozversion platform_changeset: 171be6aaa16ee1d241ffa4bcdabc95b28372c28b 22:02:58 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:02:58 INFO - mozversion platform_version: 52.0a2 22:02:58 INFO - using testdate: 1482213778 22:02:58 INFO - actual date: 1482213778 22:02:58 INFO - starting webserver on 'localhost:51415' 22:02:58 INFO - SUITE-START | Running 2 tests 22:02:58 INFO - TEST-START | dromaeo_css 22:02:58 INFO - operating with platform_type : linux_ 22:02:58 INFO - Initialising browser for dromaeo_css test... 22:02:58 INFO - TEST-INFO | started process 26614 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXWSSiZ/profile http://localhost:51415/getInfo.html) 22:03:02 INFO - PROCESS | 26614 | __metrics Screen width/height:1600/1200 22:03:02 INFO - PROCESS | 26614 | colorDepth:24 22:03:02 INFO - PROCESS | 26614 | Browser inner width/height: 1024/697 22:03:02 INFO - PROCESS | 26614 | __metrics 22:03:03 ERROR - PROCESS | 26614 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 22:03:04 INFO - TEST-INFO | 26614: exit 0 22:03:04 INFO - Browser initialized. 22:03:04 INFO - Running cycle 1/1 for dromaeo_css test... 22:03:04 INFO - TEST-INFO | started process 26746 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXWSSiZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:03:15 INFO - PROCESS | 26746 | RSS: Main: 151924736 22:03:15 INFO - PROCESS | 26746 | 22:04:05 INFO - PROCESS | 26746 | 1482213845586 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 22:06:15 INFO - PROCESS | 26746 | Cycle 1(1): loaded http://localhost:51415/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51415/tests/dromaeo/cssquery-ext.html) 22:06:17 INFO - PROCESS | 26746 | RSS: Main: 155918336 22:06:17 INFO - PROCESS | 26746 | 22:09:19 INFO - PROCESS | 26746 | Cycle 1(1): loaded http://localhost:51415/tests/dromaeo/cssquery-ext.html (next: http://localhost:51415/tests/dromaeo/cssquery-jquery.html) 22:09:19 INFO - PROCESS | 26746 | RSS: Main: 153288704 22:09:19 INFO - PROCESS | 26746 | 22:12:21 INFO - PROCESS | 26746 | Cycle 1(1): loaded http://localhost:51415/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51415/tests/dromaeo/cssquery-mootools.html) 22:12:22 INFO - PROCESS | 26746 | RSS: Main: 152842240 22:12:22 INFO - PROCESS | 26746 | 22:15:24 INFO - PROCESS | 26746 | Cycle 1(1): loaded http://localhost:51415/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51415/tests/dromaeo/cssquery-prototype.html) 22:15:24 INFO - PROCESS | 26746 | RSS: Main: 151838720 22:15:24 INFO - PROCESS | 26746 | 22:18:27 INFO - PROCESS | 26746 | Cycle 1(1): loaded http://localhost:51415/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51415/tests/dromaeo/cssquery-yui.html) 22:18:27 INFO - PROCESS | 26746 | RSS: Main: 154583040 22:18:27 INFO - PROCESS | 26746 | 22:21:30 INFO - PROCESS | 26746 | Cycle 1(1): loaded http://localhost:51415/tests/dromaeo/cssquery-yui.html (next: http://localhost:51415/tests/dromaeo/cssquery-dojo.html) 22:21:30 INFO - PROCESS | 26746 | RSS: Main: 155037696 22:21:30 INFO - PROCESS | 26746 | 22:21:30 INFO - PROCESS | 26746 | __start_tp_report 22:21:30 INFO - PROCESS | 26746 | _x_x_mozilla_page_load 22:21:30 INFO - PROCESS | 26746 | _x_x_mozilla_page_load_details 22:21:30 INFO - PROCESS | 26746 | |i|pagename|runs| 22:21:30 INFO - PROCESS | 26746 | |0;dojo.html;3248.9512657310142;3261.494468357404;3264.6082470103574;3275.344931013798;3279.983600081999;5454.290942177517;5474.260974768415;5514.862128446785;5524.171374293858;5535.501804837564;5583.664980101197;5600.327960644729;5628.409017053202;5647.8588035299135;5649.378568357477;5055.266986286977;5081.796728130888;5137.820176293831;5168.147255702805;5187.688738675692;5085.262636917645;5145.74271286436;5150.356205474316;5157.767900444489;5168.121419358718;4976.950230497685;4977.178765503688;5147.38231412231;5148.073346797575;5156.871078223037;5051.494850514974;5062.0888240116765;5101.489851014906;5153.149730294497;5198.662086964335;5087.694738315713;5128.794848206067;5142.74286285688;5145.511176438233;5153.871153221162;5405.4324295949145;5599.944000559983;5622.465865742748;5690.9146362804595;5700.7719691212305;5867.823965281048;5868.647881127104;5933.139694744238;5973.850653733648;6078.1186727924205;6062.545309101835;6068;6069.0592958091565;6073.483753880925;6087.3303936566945;5654.5193658538665;5661.094224923992;5673.23411339468;5675.574331925122;5679.914801277984;5894.263217097863;5936.821895343147;6045.697715114315;6098.451139397387;6120.969395153084;5910.202122713465;5964.254468191476;5968.462838344483;5970.104484327298;5984.162217289583;6021.638701677914;6064.06007068905;6068.423499767515;6069.393060693896;6086;5786.652800831879;5850.268716410449;5878.177055212273;5967.5524335675;6030.065339872327;6041.335453100155;6042.546808989343;6057.697115144225;6061.969690151521;6081.331053584102;4689.109069276827;4711.764411779466;4712.575868171881;4719.315699223594;4742.834000810024;4068.959310406858;4094.792036349284;4207.579242075768;4209.6000879916355;4244.681648876347;5682.318121825408;5770.596058275881;5788.884222315614;5849.941500585025;5870.647761134345;6050.909236361458;6089.512838972872;6092.45167934888;6100.633961962297;6107;5606.243157173811;5659.179418984224;5708.914366284509;5763.711814409263;5789.102689083199;5194.636375453758;5195.3246078009615;5209.218617207373;5226.817061402832;5233.476652334736;6214.5960512566535;6216.44052035319;6220.875582488325;6230.252369715663;6241.032639940907;5814.796482123105;5866.677332746569;5905;6086.056661217518;6086.300075491198;6062.242219722535;6126.792505495216;6163.38366163398;6164.630122192682;6178.258608966773;5925.200097986716;5926.940730592812;5943.58394912352;5944.613600115978;5958.136070269873;5821.301443826768;5868.4424979626865;5985.102234664835;6035.094735789667;6043.12374705674;5860.208871802422;5958.1360702697;5972.044472884491;6003.249593800775;6037.667928263988;5927.051671732675;5961.225040744675;5974.880502390015;5982.700864956648;5994.580379373402;5559.944400555943;5922.318933322723;5931.703414829328;5944.791932282523;5951.821445356646;5736.971315143398;5839.270091238595;5928.555358348055;5939.732712027882;6029.306629737636;5824.912626310694;5827.475527202572;5829.7085145743395;5837.766489340549;5861.0915308127305 22:21:30 INFO - PROCESS | 26746 | |1;ext.html;591.2254946020713;609.135028259871;613.4908026338138;650.635644039338;655.9245686746019;41300.793496032515;42239.36640950384;44685.88285292869;44781.10437791242;44793.999999999956;44495;45241.773791130996;45261.32108018374;45273.77363113188;45477;8781.780455488615;10507.21195910306;10816.242862999594;10842.72893177673;11142.108631309517;10680.626178083769;10786.244962852603;10797.190210734187;10800.78398432031;10819.350838949687;10774.40740759258;10827.512761925693;10837.783244335109;10858.891411085906;10876.619318323861;10680.839787403194;10699.304545204575;10756.08573271269;10781.08360789326;10817;10610.734731631694;10618.840717389245;10697.251192416534;10711.250212485129;10713.517891694892;42796;43139;43368.3494747579;43386;43429.13141737148;3761.6614504694435;3854.4796452478836;3883.6310550497656;4073.6130067643526;4343.04453020335;33028;33372.499412508834;33420.83289583561;33448.49827252593;34932.12669683253;4024.3359845625437;4029.3754468057205;4062.939055914164;4064.268431682296;4162.687798415131;353899;355988;358443;358467;358943;66035.66982165155;66331.33668663348;66464.66767666131;66567.33432665709;66867.33132668708;61908.69045654743;61934.38065619376;61988;62163;62190;16896.746548801777;17054.403095891583;17894.10529473521;18566.25734970613;18640.067996600115;13794.37925293344;13994.440222390991;13998.30008499571;14295.78556321656;14393.856061439461;20376.592468150553;20641.690374644393;20743.792562074486;20829.479263018547;20836.791632083787;7539.962300188464;7650.617469126521;7681.731139410093;7684.231576842383;7717;979.7893452907659;1027.3527677563088;1045.6549338718357;1088;1156.502703837358;32093.51859722106;32542.674573254437;32792.50811237833;32816.835915820266;33019.3396132076;1111.8443417921496;1126.6957921361186;1134.5688638317386;1149.9252548584316;1252.5803855708257;17289.308427662752;17460.30158793634;17659;17765.911170444066;17803.19885605125;527658;530571;533894;535476;535872;60653.39346606566;60757.69621151866;60949.39050609526;61102.38897610967;61296.693516532134;1348.2517202952456;1408.6267139208119;1408.7041721238654;1411.56947131126;1412.7174565087023;31356.843215783774;32124.518132227568;32339;33165.83417082899;33197.17007074746;54595.72702136464;56514;58382.708086460996;58758;63860.361396385444;460286;464375;464391;464515;464644;29975;29990.25024374408;30144.69855301419;33079.66920330766;45936.31095533503;48064.251435960476;48746.75626621844;48765.75617121892;49562.25656615226;50395.49604504055;41355.379669305585;42517.14965700607;43066;43489.56510434855;43683.56316436795;43171.13657726891;43205.351919721856;43689.78155109204;44133.11733765371;44225;41214.79392603018;41843.37234941539;42058.78970605128;42576.5742342585;44903.775481122386;34243.4863477053;37182;37591.24817503689;37604.24791504209;38235.61764382321;29412.11763647094;29550.261243469085;29770.255743605718;30179.09462716122;30206.244843879078 22:21:30 INFO - PROCESS | 26746 | |2;jquery.html;419.45470887845795;419.9433076534667;426.6565414841053;429.79799494237716;435.2796122417398;18766.4370068898;19211.51971200719;20166.19335226591;20402.693959590582;20551.897240513816;17941.28234870607;19380.612387752237;19881;20389.898050509728;20483.795162048376;5695.373508914026;5954.612950158247;5963.3738457462;5965.46310832025;5986.670733109677;5755.913661295084;5767.769289228447;5804.129380592924;5874.970625146868;5929.703514824241;5923.792667256647;5944.346121926585;5945.137954996523;5945.286565612133;5964.522838172958;5709.885802283972;5932.9406705932815;5934.762609495615;5966.463018328372;6015.127806468037;5857.26784151981;5885.440883116097;5890.057590785454;5893.6463812171405;5902.32123305821;14892;14996.625084372869;15250.23748812566;15269.770953435707;15291.388344466208;2303.3205204464725;2474.319562120413;2482.491089326684;2724.9182524524294;2926.2391778137626;11156.888431115665;11252.38111903845;11296.604618838383;12291.323977181251;15841.366345346172;1939.156466936873;1998.120826836202;2019.6061767955255;2038.898055097254;2074.875507469557;84535.5773221136;86495.99999999937;88284.55857720734;88905;90040.52953258628;11653;11785.941070294764;11960.461779219955;12043.397830108459;12184.147109702235;17044.31822727077;17075;17088.316467341414;17118.572035699206;17122.229499672543;8587.441816281922;8734.519601421856;8830.072842351588;8833.469991800512;8848.247898928534;8629.956850215709;8635.827283454295;8681.348898832613;8760.824783504422;8836.602352894006;5180.818671346485;5194.636375453758;5196.376434827845;5230.372355317386;5253.553447956967;2110.715053467793;2140.4006878074165;2164.433046272364;2200.8789516576744;2234.273860995183;925.1997022575424;1034.6533911139702;1034.9223808214415;1049.239301506417;1049.7375656085978;19291.131899064574;19330.130144143546;20070.197192112442;20129.09419076145;20221.696674549894;989.7674046599044;1037.5227395398201;1037.5745944162857;1063.3832377221347;1126.9492872820742;10376.273660843819;11057.612983545538;11068;11123.276986995981;11152.776944461066;444087;445880;453508;467003;469961;90324;94389.5280523593;94750.52624736833;100154.4992275034;104122.47938760258;985.9408435493893;1029.45953374479;1030.5002073994108;1056.4717641179411;1068.9518971646294;17076.316947321968;17403.56491087733;17422.21600028027;17484.50929442375;17904;40330.596694033855;42628;42999.57000429956;43419.34870976875;44689.77655111704;52237;61902.38097618966;62034.37965620286;62715.6864215676;63338;8736.56317184151;9010.684626038057;9028.052054534443;9201.079892010745;9308.627654893999;13012.154209976321;13722.245276509888;13730.65673358174;13742.93128534351;14105.506307279196;12034.398280086136;12063.457144428698;12094.274343539415;12211.816822747489;12264.44809983535;11770.764584708086;11946.283223006647;12023.579174728842;12046.277223366626;12203.633890983285;11652.126090543412;11708.70728231801;11782.11634127461;11978.520859165536;12070.818937716116;8665.090165532529;8921.598528066123;8971.551422428984;8998.505082220541;9077.09229077087;10902.890971090505;11965;12108.515659373526;12363.995550079258;12587.559435419716 22:21:30 INFO - PROCESS | 26746 | |3;mootools.html;1463.4585203474712;1524.80177576915;1631.8612917901978;1729.9913500432497;1751.0369296886709;7851.45039847211;8058.315043221319;8504;9078.182963533272;9088.681896133636;8497;8695.21743043126;8710.041895391501;8840.248578870804;8896.154865287803;2435.0990133650575;2502.4119331956977;2504.1485894795765;2504.9749502505015;2505.3987043109705;2466.05057053035;2522.810789190809;2541.1995221505167;2560.911612564662;2563.9359016024564;2470.6170543565777;2473.183849329726;2476.1952365481293;2477.4549599088264;2485.378655336166;2417.613181890898;2427.672264244331;2440.548498527778;2482.962755558668;2489.8630575318352;2427.526632306701;2437.122635851092;2442.2306973303353;2451.093095554656;2477.2444404456633;8749.606267717905;8824.8676269856;8861.512616806072;8878.511681857495;8890.688825891062;5427.185922111676;5499.395066542677;5525.392206857243;5525.944740552583;5545.473180047889;3444.9483257751153;3449.344624521333;3475.0964749165146;3498.4577390504514;3540.4689296605716;1008.1128606825946;1069.4866464097277;1089.4008295437557;1094.9397783121924;1120.5573798349606;12363.258204507669;12418.192817466836;12428.75142497145;12489.18820276679;12539.811902821464;4712.85861424151;4875.804967801319;4900.436449808247;4941.777620007108;4966.925496117561;10482.109020733324;10503.422311772925;10505.894941050645;10519.579216831395;10533.84199237012;5533.142362933751;5559.610827242054;5568.276124103841;5580.1629755537;5621.381648018714;4975.626827987915;4989.800407983713;5093.4651861554;5156.7421628919155;5170.793168273227;3877.8836634901;3917.118648304109;4005.178938317638;4072.592740725963;4099.487564054493;1235.932023738703;1245.63876475821;1254.7804134276648;1255.12768625806;1269.0608949377395;840.369722707969;954.4464210757744;992.5831150916632;1000.314784372707;1001.8346972749415;6059;6061.151438798572;6076.392360763976;6088.726007329681;6160.7535698571555;491.31461611052384;493.1616252370912;499.6627276588288;1016.7458135466134;1091.8689757229024;4243.893902652397;4287.292596721506;4321.135772845443;4337.306031035019;4454.977725111418;10780.29928054674;11073;11088;11117.72205694848;11137.665870023913;10972.780544389068;11071.335719856834;11091.667249982513;11127.276727012719;11131.276467029616;7926.682932682628;8177.182281771894;8273.958630206811;8401.579921003926;8415.915840841635;5962.970185149046;6083.117947897442;6234.563580549318;6299.118123462627;6356.484290303695;9681.564329605044;10236.795264094528;10254.794904102026;10283.794324113325;10341.896581034394;10019;10345.327553708985;10365.63720269787;10402.323848949794;10449.21630877672;7085.658335789542;7840.568768717775;7843.843123137392;7854.41091918097;8017.158198389086;8674.826503469769;8685;8726.563671816511;8744.213020828156;8797.604107815292;7658.961705191661;7690.077190737147;7869.0950540688555;7910.802229944297;7956.9602151988865;7701.537907725555;7758.8448231033935;7794.376449884109;7808;7947.245011723877;7219.061522002106;7229.349358557755;7238.565686058853;7258.383037441877;7321.926780732125;5271.683698978073;5274.841754747364;5294.920576191437;5398.865028374322;5399.784008639767;5275.657082289639;5392.325959255093;5403.621746477709;5435.592330575144;5522.5858060644805 22:21:30 INFO - PROCESS | 26746 | |4;prototype.html;353.08550853289984;358.53390592230096;365.3423837093233;371.58011447064814;372.5529364762286;5481.12302031675;5550.833474995751;5651.8304450866435;5673.943260567393;5740.655560666352;5465.453454654543;5581.609287349887;5583.69289689068;5584.9162262566;5613.887722245553;4357.259265924785;4364.716293440916;4382.904273931517;4392;4424.513303536608;4341.674374421915;4344.587264209895;4372.2130016597;4385.276429389163;4386.692931494781;4348.673654535365;4363.799955012365;4395.274779661352;4411.404460397837;4415.116976604676;4300.892477688051;4337.284348082562;4343.891402714926;4374.190774706658;4374.759388233646;3872.6514613684903;3892.4550562921213;3915;3927.253821773854;3959.5842436544035;5457.61796674229;5483.150111732648;5504.64219825714;5519.144532597414;5525.419830917776;4942.851714448572;5055.848324550233;5061.810474538481;5067.949320506821;5101.591872650179;5845.269341332333;5862.85674293513;5867.442592953706;5879.176915231871;5884.499817515516;4340.370646256275;4351.260285751398;4353.825846966118;4368.148211098837;4397.802098905557;5883.970580147072;6003.279606447254;6022.427869352405;6054.636721796706;6056.303525094627;4248.957510424856;4276.914461710749;4283.378910058024;4306.609831543524;4311.784410779448;4271;4306.870793876189;4313.2883074292395;4322.589354011364;4352;4846.854594362175;4899.6570240083565;4961.4294356148785;4984.950150498448;5025.39695236574;5696.287964004499;5703.925319534682;5767.88464230713;5780.826575202751;5847;1428.707115041414;1435.411481292665;1449.8550144985418;1480.667399340602;1484.829244636859;981.4503877828439;1017.1659239423601;1022.5091955861228;1026.1534234256767;1045.7281106912105;5475.260839786658;5476.2333273341765;5483.369412517532;5527.834164975057;5533.644257157022;5809.419058094157;5814.854628634233;5824.475797178275;5891.617044892068;5909.409059094142;5367.78528858849;5520;5539.750711218005;5564.248826408464;5572.192032155314;3099.4266060778828;3104.3170502489415;3114.112477943775;3115.5326700995033;3123.7969531980802;5753.827385178452;5897.019511829498;5905.940940590539;5920.851978700481;5946.345901950782;6060.2727672678675;6115.052166914135;6116.663583502861;6117.235345581802;6130.693465326805;6166.630002199882;6184.299317687582;6189.195404597373;6193.566450348432;6249.187605611241;5669.34802497718;5952.910706339322;6005.609635373687;6015.819525414245;6085.57400981927;5917.467427931507;5937.7921772737745;5993.400659933972;6038.154658347747;6046.758129674764;5928.318243401892;6100.23747031621;6136.325004249618;6147.84630384244;6254.405831446005;4415.823367065282;4480.865574032784;4490.12442573695;4524.172392254841;4531.501534831232;5838.2702162229725;6144.907826382519;6148.1699970503405;6164.321924588202;6169.50643948474;5797.333306669787;5866.5893387462465;5888.4700376966275;5905.734241959208;5924.851878703067;5846.736896839738;5903.350631430453;5935.762569497172;5936.970315148569;5950.583459157991;5672.801451949162;5805.274340707411;5857.535616095976;5858.7070646468355;5873;5892.911606325994;5909.143174239797;5934.6142500737315;5942.197803296673;5981.312149102909;5686.346070201815;5694.231278777312;5865.3254875689845;5912.556558258234;5914.704264786829 22:21:30 INFO - PROCESS | 26746 | |5;yui.html;802.0095182449674;814.1939479914882;834.9039860416052;852.7441767469766;895.6954635423957;15039.774403383944;15430.228488575582;15656.138912359816;15958.521244362673;16085.678286434279;14456.710865782705;14758.483453079145;14794;14800.481983130592;14806.407743690239;822.6298165825373;840.5587066789953;847.1189962439072;852.3862818770506;852.5012867472536;829.1376967953352;831.6174559702544;832.4630613254448;833.3166803221361;833.4540875726409;865.4158443050947;868.3357231717741;870.4342177584557;873.0309356614154;874.1957399192726;855.8673405622138;859.2481578618708;860.9569521523899;864.8097418567905;867.4881819726392;633.9080833279148;636.6752955992431;640.945519630832;641.6278558436143;641.7433026789322;14789.778153327708;14923.70152596942;15158.31787569551;15158.848411515854;15165;14351.116042422662;14883.032602880778;14937.327820248114;14991.339246938833;15038.172900490468;11505.539778408853;11749.64751057461;12038.879611203864;12137.453814578364;12146.757064858743;3860.6911447084167;3918.7060970427333;3968.3452230381954;4566.360709500673;4617.191991401525;51867.22199167016;57761;60165;60462.09306860401;68546.65726671334;10683.626073087406;10764.300320479144;10909.18181136418;10927.836082458769;10932.508037138348;19142.904285478482;19298.32455864038;19435.12541935616;19511.317103901296;19743.60512789736;8522.829543409098;8816.250618697355;8819;8892.421992570462;8983.281337492985;4845.297431872429;4858.149823780825;4864.246041863516;4940.283658869444;4990.226514890198;3530.5586801649793;3658.304922064799;3678.9080272993388;3680.981595092061;3688.9302102390006;651.1469974333638;665.5740326191242;667.5360624366116;669.0566301514841;699.1226011355716;621.2638023941644;774.3340726974798;780.6643143448372;791.8020494876281;797.6609940775147;9325.720228393158;10087.848682269772;10439.582416703399;10534.051935325704;10568.260221784401;666.6966530228734;729.6971756720901;776.3153955915676;785.7210690204895;793.6309616028575;4889.779959901742;4915.705057696549;4941.1847045237855;4964.230544265644;4996;84144;85668.57165714256;87482.56258718665;88050;89958.55020724854;74015.25984740084;74652;75225;75233.24766752262;75918.24081759222;44191;49122.26316605254;58430.415695843345;58776.41223587795;67613.32386676071;10018.998100190214;10611.4163720993;10650.201234907569;10866.728331791452;10968.890311096788;46059.76970115128;46541;46664.30003549882;46673.53326466692;47669.28496072492;53004.46995529995;53613.731931340095;62158;63205.36794631995;64763;12671.113022088366;13014.089013768946;13041.804372934224;13210.735785284432;13255.469781208643;14498.637534061732;14613.85386146125;15088.471903483765;15245.16151611672;15259.694806104038;14288.214148221947;14524.636884077983;14628.780568291271;14672.77990830117;14758.778618320948;12943.288119153536;13102.868971310165;13192.472301107848;13231;14266.500672476413;13942.930285348508;14151;14454.855451445352;14665.413383464542;15170;11489.138314626603;11722.58970936013;11787.410629468664;12108.21296615717;12458.75082498363;12127.514899403925;12236.265824050586;12383.690407739517;12394.938025310177;12452.875471245172 22:21:30 INFO - PROCESS | 26746 | __end_tp_report 22:21:30 INFO - PROCESS | 26746 | __start_cc_report 22:21:30 INFO - PROCESS | 26746 | _x_x_mozilla_cycle_collect,302 22:21:30 INFO - PROCESS | 26746 | __end_cc_report 22:21:30 INFO - PROCESS | 26746 | __startTimestamp1482214890345__endTimestamp 22:21:30 INFO - PROCESS | 26746 | 22:21:30 INFO - PROCESS | 26746 | ------- Summary: start ------- 22:21:30 INFO - PROCESS | 26746 | Number of tests: 6 22:21:30 INFO - PROCESS | 26746 | 22:21:30 INFO - PROCESS | 26746 | [#0] dojo.html Cycles:165 Average:5596.46 Median:5839.27 stddev:622.49 (10.7%) stddev-sans-first:596.54 22:21:30 INFO - PROCESS | 26746 | Values: 3249.0 3261.5 3264.6 3275.3 3280.0 5454.3 5474.3 5514.9 5524.2 5535.5 5583.7 5600.3 5628.4 5647.9 5649.4 5055.3 5081.8 5137.8 5168.1 5187.7 5085.3 5145.7 5150.4 5157.8 5168.1 4977.0 4977.2 5147.4 5148.1 5156.9 5051.5 5062.1 5101.5 5153.1 5198.7 5087.7 5128.8 5142.7 5145.5 5153.9 5405.4 5599.9 5622.5 5690.9 5700.8 5867.8 5868.6 5933.1 5973.9 6078.1 6062.5 6068.0 6069.1 6073.5 6087.3 5654.5 5661.1 5673.2 5675.6 5679.9 5894.3 5936.8 6045.7 6098.5 6121.0 5910.2 5964.3 5968.5 5970.1 5984.2 6021.6 6064.1 6068.4 6069.4 6086.0 5786.7 5850.3 5878.2 5967.6 6030.1 6041.3 6042.5 6057.7 6062.0 6081.3 4689.1 4711.8 4712.6 4719.3 4742.8 4069.0 4094.8 4207.6 4209.6 4244.7 5682.3 5770.6 5788.9 5849.9 5870.6 6050.9 6089.5 6092.5 6100.6 6107.0 5606.2 5659.2 5708.9 5763.7 5789.1 5194.6 5195.3 5209.2 5226.8 5233.5 6214.6 6216.4 6220.9 6230.3 6241.0 5814.8 5866.7 5905.0 6086.1 6086.3 6062.2 6126.8 6163.4 6164.6 6178.3 5925.2 5926.9 5943.6 5944.6 5958.1 5821.3 5868.4 5985.1 6035.1 6043.1 5860.2 5958.1 5972.0 6003.2 6037.7 5927.1 5961.2 5974.9 5982.7 5994.6 5559.9 5922.3 5931.7 5944.8 5951.8 5737.0 5839.3 5928.6 5939.7 6029.3 5824.9 5827.5 5829.7 5837.8 5861.1 22:21:30 INFO - PROCESS | 26746 | 22:21:30 INFO - PROCESS | 26746 | [#1] ext.html Cycles:180 Average:62620.65 Median:20682.95 stddev:120857.91 (584.3%) stddev-sans-first:121107.21 22:21:30 INFO - PROCESS | 26746 | Values: 591.2 609.1 613.5 650.6 655.9 41300.8 42239.4 44685.9 44781.1 44794.0 44495.0 45241.8 45261.3 45273.8 45477.0 8781.8 10507.2 10816.2 10842.7 11142.1 10680.6 10786.2 10797.2 10800.8 10819.4 10774.4 10827.5 10837.8 10858.9 10876.6 10680.8 10699.3 10756.1 10781.1 10817.0 10610.7 10618.8 10697.3 10711.3 10713.5 42796.0 43139.0 43368.3 43386.0 43429.1 3761.7 3854.5 3883.6 4073.6 4343.0 33028.0 33372.5 33420.8 33448.5 34932.1 4024.3 4029.4 4062.9 4064.3 4162.7 353899.0 355988.0 358443.0 358467.0 358943.0 66035.7 66331.3 66464.7 66567.3 66867.3 61908.7 61934.4 61988.0 62163.0 62190.0 16896.7 17054.4 17894.1 18566.3 18640.1 13794.4 13994.4 13998.3 14295.8 14393.9 20376.6 20641.7 20743.8 20829.5 20836.8 7540.0 7650.6 7681.7 7684.2 7717.0 979.8 1027.4 1045.7 1088.0 1156.5 32093.5 32542.7 32792.5 32816.8 33019.3 1111.8 1126.7 1134.6 1149.9 1252.6 17289.3 17460.3 17659.0 17765.9 17803.2 527658.0 530571.0 533894.0 535476.0 535872.0 60653.4 60757.7 60949.4 61102.4 61296.7 1348.3 1408.6 1408.7 1411.6 1412.7 31356.8 32124.5 32339.0 33165.8 33197.2 54595.7 56514.0 58382.7 58758.0 63860.4 460286.0 464375.0 464391.0 464515.0 464644.0 29975.0 29990.3 30144.7 33079.7 45936.3 48064.3 48746.8 48765.8 49562.3 50395.5 41355.4 42517.1 43066.0 43489.6 43683.6 43171.1 43205.4 43689.8 44133.1 44225.0 41214.8 41843.4 42058.8 42576.6 44903.8 34243.5 37182.0 37591.2 37604.2 38235.6 29412.1 29550.3 29770.3 30179.1 30206.2 22:21:30 INFO - PROCESS | 26746 | 22:21:30 INFO - PROCESS | 26746 | [#2] jquery.html Cycles:180 Average:28610.97 Median:2152.42 stddev:75662.62 (3515.2%) stddev-sans-first:75845.26 22:21:30 INFO - PROCESS | 26746 | Values: 419.5 419.9 426.7 429.8 435.3 18766.4 19211.5 20166.2 20402.7 20551.9 17941.3 19380.6 19881.0 20389.9 20483.8 5695.4 5954.6 5963.4 5965.5 5986.7 5755.9 5767.8 5804.1 5875.0 5929.7 5923.8 5944.3 5945.1 5945.3 5964.5 5709.9 5932.9 5934.8 5966.5 6015.1 5857.3 5885.4 5890.1 5893.6 5902.3 14892.0 14996.6 15250.2 15269.8 15291.4 2303.3 2474.3 2482.5 2724.9 2926.2 11156.9 11252.4 11296.6 12291.3 15841.4 1939.2 1998.1 2019.6 2038.9 2074.9 84535.6 86496.0 88284.6 88905.0 90040.5 11653.0 11785.9 11960.5 12043.4 12184.1 17044.3 17075.0 17088.3 17118.6 17122.2 8587.4 8734.5 8830.1 8833.5 8848.2 8630.0 8635.8 8681.3 8760.8 8836.6 5180.8 5194.6 5196.4 5230.4 5253.6 2110.7 2140.4 2164.4 2200.9 2234.3 925.2 1034.7 1034.9 1049.2 1049.7 19291.1 19330.1 20070.2 20129.1 20221.7 989.8 1037.5 1037.6 1063.4 1126.9 10376.3 11057.6 11068.0 11123.3 11152.8 444087.0 445880.0 453508.0 467003.0 469961.0 90324.0 94389.5 94750.5 100154.5 104122.5 985.9 1029.5 1030.5 1056.5 1069.0 17076.3 17403.6 17422.2 17484.5 17904.0 40330.6 42628.0 42999.6 43419.3 44689.8 52237.0 61902.4 62034.4 62715.7 63338.0 8736.6 9010.7 9028.1 9201.1 9308.6 13012.2 13722.2 13730.7 13742.9 14105.5 12034.4 12063.5 12094.3 12211.8 12264.4 11770.8 11946.3 12023.6 12046.3 12203.6 11652.1 11708.7 11782.1 11978.5 12070.8 8665.1 8921.6 8971.6 8998.5 9077.1 10902.9 11965.0 12108.5 12364.0 12587.6 22:21:30 INFO - PROCESS | 26746 | 22:21:30 INFO - PROCESS | 26746 | [#3] mootools.html Cycles:180 Average:5918.70 Median:2695.88 stddev:3311.97 (122.9%) stddev-sans-first:3304.34 22:21:30 INFO - PROCESS | 26746 | Values: 1463.5 1524.8 1631.9 1730.0 1751.0 7851.5 8058.3 8504.0 9078.2 9088.7 8497.0 8695.2 8710.0 8840.2 8896.2 2435.1 2502.4 2504.1 2505.0 2505.4 2466.1 2522.8 2541.2 2560.9 2563.9 2470.6 2473.2 2476.2 2477.5 2485.4 2417.6 2427.7 2440.5 2483.0 2489.9 2427.5 2437.1 2442.2 2451.1 2477.2 8749.6 8824.9 8861.5 8878.5 8890.7 5427.2 5499.4 5525.4 5525.9 5545.5 3444.9 3449.3 3475.1 3498.5 3540.5 1008.1 1069.5 1089.4 1094.9 1120.6 12363.3 12418.2 12428.8 12489.2 12539.8 4712.9 4875.8 4900.4 4941.8 4966.9 10482.1 10503.4 10505.9 10519.6 10533.8 5533.1 5559.6 5568.3 5580.2 5621.4 4975.6 4989.8 5093.5 5156.7 5170.8 3877.9 3917.1 4005.2 4072.6 4099.5 1235.9 1245.6 1254.8 1255.1 1269.1 840.4 954.4 992.6 1000.3 1001.8 6059.0 6061.2 6076.4 6088.7 6160.8 491.3 493.2 499.7 1016.7 1091.9 4243.9 4287.3 4321.1 4337.3 4455.0 10780.3 11073.0 11088.0 11117.7 11137.7 10972.8 11071.3 11091.7 11127.3 11131.3 7926.7 8177.2 8274.0 8401.6 8415.9 5963.0 6083.1 6234.6 6299.1 6356.5 9681.6 10236.8 10254.8 10283.8 10341.9 10019.0 10345.3 10365.6 10402.3 10449.2 7085.7 7840.6 7843.8 7854.4 8017.2 8674.8 8685.0 8726.6 8744.2 8797.6 7659.0 7690.1 7869.1 7910.8 7957.0 7701.5 7758.8 7794.4 7808.0 7947.2 7219.1 7229.3 7238.6 7258.4 7321.9 5271.7 5274.8 5294.9 5398.9 5399.8 5275.7 5392.3 5403.6 5435.6 5522.6 22:21:30 INFO - PROCESS | 26746 | 22:21:30 INFO - PROCESS | 26746 | [#4] prototype.html Cycles:180 Average:4934.52 Median:5568.22 stddev:1436.98 (25.8%) stddev-sans-first:1399.26 22:21:30 INFO - PROCESS | 26746 | Values: 353.1 358.5 365.3 371.6 372.6 5481.1 5550.8 5651.8 5673.9 5740.7 5465.5 5581.6 5583.7 5584.9 5613.9 4357.3 4364.7 4382.9 4392.0 4424.5 4341.7 4344.6 4372.2 4385.3 4386.7 4348.7 4363.8 4395.3 4411.4 4415.1 4300.9 4337.3 4343.9 4374.2 4374.8 3872.7 3892.5 3915.0 3927.3 3959.6 5457.6 5483.2 5504.6 5519.1 5525.4 4942.9 5055.8 5061.8 5067.9 5101.6 5845.3 5862.9 5867.4 5879.2 5884.5 4340.4 4351.3 4353.8 4368.1 4397.8 5884.0 6003.3 6022.4 6054.6 6056.3 4249.0 4276.9 4283.4 4306.6 4311.8 4271.0 4306.9 4313.3 4322.6 4352.0 4846.9 4899.7 4961.4 4985.0 5025.4 5696.3 5703.9 5767.9 5780.8 5847.0 1428.7 1435.4 1449.9 1480.7 1484.8 981.5 1017.2 1022.5 1026.2 1045.7 5475.3 5476.2 5483.4 5527.8 5533.6 5809.4 5814.9 5824.5 5891.6 5909.4 5367.8 5520.0 5539.8 5564.2 5572.2 3099.4 3104.3 3114.1 3115.5 3123.8 5753.8 5897.0 5905.9 5920.9 5946.3 6060.3 6115.1 6116.7 6117.2 6130.7 6166.6 6184.3 6189.2 6193.6 6249.2 5669.3 5952.9 6005.6 6015.8 6085.6 5917.5 5937.8 5993.4 6038.2 6046.8 5928.3 6100.2 6136.3 6147.8 6254.4 4415.8 4480.9 4490.1 4524.2 4531.5 5838.3 6144.9 6148.2 6164.3 6169.5 5797.3 5866.6 5888.5 5905.7 5924.9 5846.7 5903.4 5935.8 5937.0 5950.6 5672.8 5805.3 5857.5 5858.7 5873.0 5892.9 5909.1 5934.6 5942.2 5981.3 5686.3 5694.2 5865.3 5912.6 5914.7 22:21:30 INFO - PROCESS | 26746 | 22:21:30 INFO - PROCESS | 26746 | [#5] yui.html Cycles:180 Average:17636.55 Median:25579.10 stddev:22245.92 (87.0%) stddev-sans-first:22272.41 22:21:30 INFO - PROCESS | 26746 | Values: 802.0 814.2 834.9 852.7 895.7 15039.8 15430.2 15656.1 15958.5 16085.7 14456.7 14758.5 14794.0 14800.5 14806.4 822.6 840.6 847.1 852.4 852.5 829.1 831.6 832.5 833.3 833.5 865.4 868.3 870.4 873.0 874.2 855.9 859.2 861.0 864.8 867.5 633.9 636.7 640.9 641.6 641.7 14789.8 14923.7 15158.3 15158.8 15165.0 14351.1 14883.0 14937.3 14991.3 15038.2 11505.5 11749.6 12038.9 12137.5 12146.8 3860.7 3918.7 3968.3 4566.4 4617.2 51867.2 57761.0 60165.0 60462.1 68546.7 10683.6 10764.3 10909.2 10927.8 10932.5 19142.9 19298.3 19435.1 19511.3 19743.6 8522.8 8816.3 8819.0 8892.4 8983.3 4845.3 4858.1 4864.2 4940.3 4990.2 3530.6 3658.3 3678.9 3681.0 3688.9 651.1 665.6 667.5 669.1 699.1 621.3 774.3 780.7 791.8 797.7 9325.7 10087.8 10439.6 10534.1 10568.3 666.7 729.7 776.3 785.7 793.6 4889.8 4915.7 4941.2 4964.2 4996.0 84144.0 85668.6 87482.6 88050.0 89958.6 74015.3 74652.0 75225.0 75233.2 75918.2 44191.0 49122.3 58430.4 58776.4 67613.3 10019.0 10611.4 10650.2 10866.7 10968.9 46059.8 46541.0 46664.3 46673.5 47669.3 53004.5 53613.7 62158.0 63205.4 64763.0 12671.1 13014.1 13041.8 13210.7 13255.5 14498.6 14613.9 15088.5 15245.2 15259.7 14288.2 14524.6 14628.8 14672.8 14758.8 12943.3 13102.9 13192.5 13231.0 14266.5 13942.9 14151.0 14454.9 14665.4 15170.0 11489.1 11722.6 11787.4 12108.2 12458.8 12127.5 12236.3 12383.7 12394.9 12452.9 22:21:30 INFO - PROCESS | 26746 | -------- Summary: end -------- 22:21:30 INFO - PROCESS | 26746 | 22:21:31 INFO - TEST-INFO | 26746: exit 0 22:21:31 INFO - TEST-OK | dromaeo_css | took 1112446ms 22:21:31 INFO - TEST-START | kraken 22:21:31 INFO - operating with platform_type : linux_ 22:21:31 INFO - Initialising browser for kraken test... 22:21:31 INFO - TEST-INFO | started process 27121 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpze2tt7/profile http://localhost:51415/getInfo.html) 22:21:35 INFO - PROCESS | 27121 | __metrics Screen width/height:1600/1200 22:21:35 INFO - PROCESS | 27121 | colorDepth:24 22:21:35 INFO - PROCESS | 27121 | Browser inner width/height: 1024/697 22:21:35 INFO - PROCESS | 27121 | __metrics 22:21:35 ERROR - PROCESS | 27121 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 22:21:36 INFO - TEST-INFO | 27121: exit 0 22:21:36 INFO - Browser initialized. 22:21:36 INFO - Running cycle 1/1 for kraken test... 22:21:36 INFO - TEST-INFO | started process 27255 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpze2tt7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:21:48 INFO - PROCESS | 27255 | RSS: Main: 151654400 22:21:48 INFO - PROCESS | 27255 | 22:21:50 INFO - PROCESS | 27255 | Cycle 1(1): loaded http://localhost:51415/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51415/tests/kraken/driver.html?testName=audio-beat-detection) 22:21:51 INFO - PROCESS | 27255 | RSS: Main: 156995584 22:21:51 INFO - PROCESS | 27255 | 22:21:54 INFO - PROCESS | 27255 | Cycle 1(1): loaded http://localhost:51415/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51415/tests/kraken/driver.html?testName=audio-dft) 22:21:54 INFO - PROCESS | 27255 | RSS: Main: 155074560 22:21:54 INFO - PROCESS | 27255 | 22:21:57 INFO - PROCESS | 27255 | Cycle 1(1): loaded http://localhost:51415/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51415/tests/kraken/driver.html?testName=audio-fft) 22:21:58 INFO - PROCESS | 27255 | RSS: Main: 155496448 22:21:58 INFO - PROCESS | 27255 | 22:22:00 INFO - PROCESS | 27255 | Cycle 1(1): loaded http://localhost:51415/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51415/tests/kraken/driver.html?testName=audio-oscillator) 22:22:01 INFO - PROCESS | 27255 | RSS: Main: 155426816 22:22:01 INFO - PROCESS | 27255 | 22:22:03 INFO - PROCESS | 27255 | Cycle 1(1): loaded http://localhost:51415/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51415/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:22:03 INFO - PROCESS | 27255 | RSS: Main: 155217920 22:22:03 INFO - PROCESS | 27255 | 22:22:06 INFO - PROCESS | 27255 | Cycle 1(1): loaded http://localhost:51415/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51415/tests/kraken/driver.html?testName=imaging-darkroom) 22:22:07 INFO - PROCESS | 27255 | RSS: Main: 158765056 22:22:07 INFO - PROCESS | 27255 | 22:22:10 INFO - PROCESS | 27255 | Cycle 1(1): loaded http://localhost:51415/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51415/tests/kraken/driver.html?testName=imaging-desaturate) 22:22:11 INFO - PROCESS | 27255 | RSS: Main: 158990336 22:22:11 INFO - PROCESS | 27255 | 22:22:14 INFO - PROCESS | 27255 | Cycle 1(1): loaded http://localhost:51415/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51415/tests/kraken/driver.html?testName=json-parse-financial) 22:22:14 INFO - PROCESS | 27255 | RSS: Main: 158912512 22:22:14 INFO - PROCESS | 27255 | 22:22:16 INFO - PROCESS | 27255 | Cycle 1(1): loaded http://localhost:51415/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51415/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:22:17 INFO - PROCESS | 27255 | RSS: Main: 157704192 22:22:17 INFO - PROCESS | 27255 | 22:22:18 INFO - PROCESS | 27255 | Cycle 1(1): loaded http://localhost:51415/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51415/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:22:19 INFO - PROCESS | 27255 | RSS: Main: 157274112 22:22:19 INFO - PROCESS | 27255 | 22:22:21 INFO - PROCESS | 27255 | Cycle 1(1): loaded http://localhost:51415/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51415/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:22:22 INFO - PROCESS | 27255 | RSS: Main: 157577216 22:22:22 INFO - PROCESS | 27255 | 22:22:24 INFO - PROCESS | 27255 | Cycle 1(1): loaded http://localhost:51415/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51415/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:22:25 INFO - PROCESS | 27255 | RSS: Main: 157487104 22:22:25 INFO - PROCESS | 27255 | 22:22:28 INFO - PROCESS | 27255 | Cycle 1(1): loaded http://localhost:51415/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51415/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:22:28 INFO - PROCESS | 27255 | RSS: Main: 158068736 22:22:28 INFO - PROCESS | 27255 | 22:22:30 INFO - PROCESS | 27255 | Cycle 1(1): loaded http://localhost:51415/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51415/tests/kraken/driver.html?testName=ai-astar) 22:22:30 INFO - PROCESS | 27255 | RSS: Main: 159240192 22:22:30 INFO - PROCESS | 27255 | 22:22:30 INFO - PROCESS | 27255 | __start_tp_report 22:22:30 INFO - PROCESS | 27255 | _x_x_mozilla_page_load 22:22:30 INFO - PROCESS | 27255 | _x_x_mozilla_page_load_details 22:22:30 INFO - PROCESS | 27255 | |i|pagename|runs| 22:22:30 INFO - PROCESS | 27255 | |0;ai-astar;104;111;111;111;111;111;113;114;112;111 22:22:30 INFO - PROCESS | 27255 | |1;audio-beat-detection;147;123;126;161;124;123;120;125;145;119 22:22:30 INFO - PROCESS | 27255 | |2;audio-dft;163;164;162;162;165;163;163;164;163;161 22:22:30 INFO - PROCESS | 27255 | |3;audio-fft;75;77;76;109;76;76;75;75;115;75 22:22:30 INFO - PROCESS | 27255 | |4;audio-oscillator;81;81;125;82;82;82;99;81;81;102 22:22:30 INFO - PROCESS | 27255 | |5;imaging-gaussian-blur;118;117;117;117;117;117;118;118;118;121 22:22:30 INFO - PROCESS | 27255 | |6;imaging-darkroom;151;150;149;149;151;158;160;149;152;150 22:22:30 INFO - PROCESS | 27255 | |7;imaging-desaturate;87;85;85;87;85;84;85;85;85;86 22:22:30 INFO - PROCESS | 27255 | |8;json-parse-financial;52;51;61;50;51;51;51;52;51;51 22:22:30 INFO - PROCESS | 27255 | |9;json-stringify-tinderbox;61;60;59;59;59;58;58;58;59;59 22:22:30 INFO - PROCESS | 27255 | |10;stanford-crypto-aes;80;73;75;76;83;75;74;75;79;79 22:22:30 INFO - PROCESS | 27255 | |11;stanford-crypto-ccm;121;121;128;122;126;121;125;124;174;122 22:22:30 INFO - PROCESS | 27255 | |12;stanford-crypto-pbkdf2;158;163;164;154;157;154;157;159;156;155 22:22:30 INFO - PROCESS | 27255 | |13;stanford-crypto-sha256-iterative;63;63;65;68;72;64;65;64;62;64 22:22:30 INFO - PROCESS | 27255 | __end_tp_report 22:22:30 INFO - PROCESS | 27255 | __start_cc_report 22:22:30 INFO - PROCESS | 27255 | _x_x_mozilla_cycle_collect,829 22:22:30 INFO - PROCESS | 27255 | __end_cc_report 22:22:30 INFO - PROCESS | 27255 | __startTimestamp1482214950610__endTimestamp 22:22:30 INFO - PROCESS | 27255 | 22:22:30 INFO - PROCESS | 27255 | ------- Summary: start ------- 22:22:30 INFO - PROCESS | 27255 | Number of tests: 14 22:22:30 INFO - PROCESS | 27255 | 22:22:30 INFO - PROCESS | 27255 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.00 stddev:2.64 (2.4%) stddev-sans-first:1.12 22:22:30 INFO - PROCESS | 27255 | Values: 104.0 111.0 111.0 111.0 111.0 111.0 113.0 114.0 112.0 111.0 22:22:30 INFO - PROCESS | 27255 | 22:22:30 INFO - PROCESS | 27255 | [#1] audio-beat-detection Cycles:10 Average:131.30 Median:125.50 stddev:14.35 (11.4%) stddev-sans-first:14.05 22:22:30 INFO - PROCESS | 27255 | Values: 147.0 123.0 126.0 161.0 124.0 123.0 120.0 125.0 145.0 119.0 22:22:30 INFO - PROCESS | 27255 | 22:22:30 INFO - PROCESS | 27255 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:1.15 (0.7%) stddev-sans-first:1.22 22:22:30 INFO - PROCESS | 27255 | Values: 163.0 164.0 162.0 162.0 165.0 163.0 163.0 164.0 163.0 161.0 22:22:30 INFO - PROCESS | 27255 | 22:22:30 INFO - PROCESS | 27255 | [#3] audio-fft Cycles:10 Average:82.90 Median:75.50 stddev:15.42 (20.4%) stddev-sans-first:16.08 22:22:30 INFO - PROCESS | 27255 | Values: 75.0 77.0 76.0 109.0 76.0 76.0 75.0 75.0 115.0 75.0 22:22:30 INFO - PROCESS | 27255 | 22:22:30 INFO - PROCESS | 27255 | [#4] audio-oscillator Cycles:10 Average:89.60 Median:81.50 stddev:14.77 (18.1%) stddev-sans-first:15.34 22:22:30 INFO - PROCESS | 27255 | Values: 81.0 81.0 125.0 82.0 82.0 82.0 99.0 81.0 81.0 102.0 22:22:30 INFO - PROCESS | 27255 | 22:22:30 INFO - PROCESS | 27255 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:1.23 (1.0%) stddev-sans-first:1.30 22:22:30 INFO - PROCESS | 27255 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 118.0 121.0 22:22:30 INFO - PROCESS | 27255 | 22:22:30 INFO - PROCESS | 27255 | [#6] imaging-darkroom Cycles:10 Average:151.90 Median:151.00 stddev:3.90 (2.6%) stddev-sans-first:4.12 22:22:30 INFO - PROCESS | 27255 | Values: 151.0 150.0 149.0 149.0 151.0 158.0 160.0 149.0 152.0 150.0 22:22:30 INFO - PROCESS | 27255 | 22:22:30 INFO - PROCESS | 27255 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:85.00 stddev:0.97 (1.1%) stddev-sans-first:0.83 22:22:30 INFO - PROCESS | 27255 | Values: 87.0 85.0 85.0 87.0 85.0 84.0 85.0 85.0 85.0 86.0 22:22:30 INFO - PROCESS | 27255 | 22:22:30 INFO - PROCESS | 27255 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:51.00 stddev:3.18 (6.2%) stddev-sans-first:3.37 22:22:30 INFO - PROCESS | 27255 | Values: 52.0 51.0 61.0 50.0 51.0 51.0 51.0 52.0 51.0 51.0 22:22:30 INFO - PROCESS | 27255 | 22:22:30 INFO - PROCESS | 27255 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:59.00 stddev:0.94 (1.6%) stddev-sans-first:0.67 22:22:30 INFO - PROCESS | 27255 | Values: 61.0 60.0 59.0 59.0 59.0 58.0 58.0 58.0 59.0 59.0 22:22:30 INFO - PROCESS | 27255 | 22:22:30 INFO - PROCESS | 27255 | [#10] stanford-crypto-aes Cycles:10 Average:76.90 Median:77.50 stddev:3.18 (4.1%) stddev-sans-first:3.17 22:22:30 INFO - PROCESS | 27255 | Values: 80.0 73.0 75.0 76.0 83.0 75.0 74.0 75.0 79.0 79.0 22:22:30 INFO - PROCESS | 27255 | 22:22:30 INFO - PROCESS | 27255 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:124.50 stddev:16.20 (13.0%) stddev-sans-first:16.96 22:22:30 INFO - PROCESS | 27255 | Values: 121.0 121.0 128.0 122.0 126.0 121.0 125.0 124.0 174.0 122.0 22:22:30 INFO - PROCESS | 27255 | 22:22:30 INFO - PROCESS | 27255 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.70 Median:157.50 stddev:3.47 (2.2%) stddev-sans-first:3.67 22:22:30 INFO - PROCESS | 27255 | Values: 158.0 163.0 164.0 154.0 157.0 154.0 157.0 159.0 156.0 155.0 22:22:30 INFO - PROCESS | 27255 | 22:22:30 INFO - PROCESS | 27255 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:64.50 stddev:2.94 (4.6%) stddev-sans-first:3.03 22:22:30 INFO - PROCESS | 27255 | Values: 63.0 63.0 65.0 68.0 72.0 64.0 65.0 64.0 62.0 64.0 22:22:30 INFO - PROCESS | 27255 | -------- Summary: end -------- 22:22:30 INFO - PROCESS | 27255 | 22:22:31 INFO - TEST-INFO | 27255: exit 0 22:22:31 INFO - TEST-OK | kraken | took 60513ms 22:22:31 INFO - SUITE-END | took 1172s 22:22:31 INFO - Completed test suite (00:19:33) 22:22:31 INFO - javascript benchmark 22:22:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7513.674946655311, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3248.9512657310142, 3261.494468357404, 3264.6082470103574, 3275.344931013798, 3279.983600081999, 5454.290942177517, 5474.260974768415, 5514.862128446785, 5524.171374293858, 5535.501804837564, 5583.664980101197, 5600.327960644729, 5628.409017053202, 5647.8588035299135, 5649.378568357477, 5055.266986286977, 5081.796728130888, 5137.820176293831, 5168.147255702805, 5187.688738675692, 5085.262636917645, 5145.74271286436, 5150.356205474316, 5157.767900444489, 5168.121419358718, 4976.950230497685, 4977.178765503688, 5147.38231412231, 5148.073346797575, 5156.871078223037, 5051.494850514974, 5062.0888240116765, 5101.489851014906, 5153.149730294497, 5198.662086964335, 5087.694738315713, 5128.794848206067, 5142.74286285688, 5145.511176438233, 5153.871153221162, 5405.4324295949145, 5599.944000559983, 5622.465865742748, 5690.9146362804595, 5700.7719691212305, 5867.823965281048, 5868.647881127104, 5933.139694744238, 5973.850653733648, 6078.1186727924205, 6062.545309101835, 6068.0, 6069.0592958091565, 6073.483753880925, 6087.3303936566945, 5654.5193658538665, 5661.094224923992, 5673.23411339468, 5675.574331925122, 5679.914801277984, 5894.263217097863, 5936.821895343147, 6045.697715114315, 6098.451139397387, 6120.969395153084, 5910.202122713465, 5964.254468191476, 5968.462838344483, 5970.104484327298, 5984.162217289583, 6021.638701677914, 6064.06007068905, 6068.423499767515, 6069.393060693896, 6086.0, 5786.652800831879, 5850.268716410449, 5878.177055212273, 5967.5524335675, 6030.065339872327, 6041.335453100155, 6042.546808989343, 6057.697115144225, 6061.969690151521, 6081.331053584102, 4689.109069276827, 4711.764411779466, 4712.575868171881, 4719.315699223594, 4742.834000810024, 4068.959310406858, 4094.792036349284, 4207.579242075768, 4209.6000879916355, 4244.681648876347, 5682.318121825408, 5770.596058275881, 5788.884222315614, 5849.941500585025, 5870.647761134345, 6050.909236361458, 6089.512838972872, 6092.45167934888, 6100.633961962297, 6107.0, 5606.243157173811, 5659.179418984224, 5708.914366284509, 5763.711814409263, 5789.102689083199, 5194.636375453758, 5195.3246078009615, 5209.218617207373, 5226.817061402832, 5233.476652334736, 6214.5960512566535, 6216.44052035319, 6220.875582488325, 6230.252369715663, 6241.032639940907, 5814.796482123105, 5866.677332746569, 5905.0, 6086.056661217518, 6086.300075491198, 6062.242219722535, 6126.792505495216, 6163.38366163398, 6164.630122192682, 6178.258608966773, 5925.200097986716, 5926.940730592812, 5943.58394912352, 5944.613600115978, 5958.136070269873, 5821.301443826768, 5868.4424979626865, 5985.102234664835, 6035.094735789667, 6043.12374705674, 5860.208871802422, 5958.1360702697, 5972.044472884491, 6003.249593800775, 6037.667928263988, 5927.051671732675, 5961.225040744675, 5974.880502390015, 5982.700864956648, 5994.580379373402, 5559.944400555943, 5922.318933322723, 5931.703414829328, 5944.791932282523, 5951.821445356646, 5736.971315143398, 5839.270091238595, 5928.555358348055, 5939.732712027882, 6029.306629737636, 5824.912626310694, 5827.475527202572, 5829.7085145743395, 5837.766489340549, 5861.0915308127305], "value": 5555.309552258736, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.2254946020713, 609.135028259871, 613.4908026338138, 650.635644039338, 655.9245686746019, 41300.793496032515, 42239.36640950384, 44685.88285292869, 44781.10437791242, 44793.999999999956, 44495.0, 45241.773791130996, 45261.32108018374, 45273.77363113188, 45477.0, 8781.780455488615, 10507.21195910306, 10816.242862999594, 10842.72893177673, 11142.108631309517, 10680.626178083769, 10786.244962852603, 10797.190210734187, 10800.78398432031, 10819.350838949687, 10774.40740759258, 10827.512761925693, 10837.783244335109, 10858.891411085906, 10876.619318323861, 10680.839787403194, 10699.304545204575, 10756.08573271269, 10781.08360789326, 10817.0, 10610.734731631694, 10618.840717389245, 10697.251192416534, 10711.250212485129, 10713.517891694892, 42796.0, 43139.0, 43368.3494747579, 43386.0, 43429.13141737148, 3761.6614504694435, 3854.4796452478836, 3883.6310550497656, 4073.6130067643526, 4343.04453020335, 33028.0, 33372.499412508834, 33420.83289583561, 33448.49827252593, 34932.12669683253, 4024.3359845625437, 4029.3754468057205, 4062.939055914164, 4064.268431682296, 4162.687798415131, 353899.0, 355988.0, 358443.0, 358467.0, 358943.0, 66035.66982165155, 66331.33668663348, 66464.66767666131, 66567.33432665709, 66867.33132668708, 61908.69045654743, 61934.38065619376, 61988.0, 62163.0, 62190.0, 16896.746548801777, 17054.403095891583, 17894.10529473521, 18566.25734970613, 18640.067996600115, 13794.37925293344, 13994.440222390991, 13998.30008499571, 14295.78556321656, 14393.856061439461, 20376.592468150553, 20641.690374644393, 20743.792562074486, 20829.479263018547, 20836.791632083787, 7539.962300188464, 7650.617469126521, 7681.731139410093, 7684.231576842383, 7717.0, 979.7893452907659, 1027.3527677563088, 1045.6549338718357, 1088.0, 1156.502703837358, 32093.51859722106, 32542.674573254437, 32792.50811237833, 32816.835915820266, 33019.3396132076, 1111.8443417921496, 1126.6957921361186, 1134.5688638317386, 1149.9252548584316, 1252.5803855708257, 17289.308427662752, 17460.30158793634, 17659.0, 17765.911170444066, 17803.19885605125, 527658.0, 530571.0, 533894.0, 535476.0, 535872.0, 60653.39346606566, 60757.69621151866, 60949.39050609526, 61102.38897610967, 61296.693516532134, 1348.2517202952456, 1408.6267139208119, 1408.7041721238654, 1411.56947131126, 1412.7174565087023, 31356.843215783774, 32124.518132227568, 32339.0, 33165.83417082899, 33197.17007074746, 54595.72702136464, 56514.0, 58382.708086460996, 58758.0, 63860.361396385444, 460286.0, 464375.0, 464391.0, 464515.0, 464644.0, 29975.0, 29990.25024374408, 30144.69855301419, 33079.66920330766, 45936.31095533503, 48064.251435960476, 48746.75626621844, 48765.75617121892, 49562.25656615226, 50395.49604504055, 41355.379669305585, 42517.14965700607, 43066.0, 43489.56510434855, 43683.56316436795, 43171.13657726891, 43205.351919721856, 43689.78155109204, 44133.11733765371, 44225.0, 41214.79392603018, 41843.37234941539, 42058.78970605128, 42576.5742342585, 44903.775481122386, 34243.4863477053, 37182.0, 37591.24817503689, 37604.24791504209, 38235.61764382321, 29412.11763647094, 29550.261243469085, 29770.255743605718, 30179.09462716122, 30206.244843879078], "value": 21525.35614352151, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [419.45470887845795, 419.9433076534667, 426.6565414841053, 429.79799494237716, 435.2796122417398, 18766.4370068898, 19211.51971200719, 20166.19335226591, 20402.693959590582, 20551.897240513816, 17941.28234870607, 19380.612387752237, 19881.0, 20389.898050509728, 20483.795162048376, 5695.373508914026, 5954.612950158247, 5963.3738457462, 5965.46310832025, 5986.670733109677, 5755.913661295084, 5767.769289228447, 5804.129380592924, 5874.970625146868, 5929.703514824241, 5923.792667256647, 5944.346121926585, 5945.137954996523, 5945.286565612133, 5964.522838172958, 5709.885802283972, 5932.9406705932815, 5934.762609495615, 5966.463018328372, 6015.127806468037, 5857.26784151981, 5885.440883116097, 5890.057590785454, 5893.6463812171405, 5902.32123305821, 14892.0, 14996.625084372869, 15250.23748812566, 15269.770953435707, 15291.388344466208, 2303.3205204464725, 2474.319562120413, 2482.491089326684, 2724.9182524524294, 2926.2391778137626, 11156.888431115665, 11252.38111903845, 11296.604618838383, 12291.323977181251, 15841.366345346172, 1939.156466936873, 1998.120826836202, 2019.6061767955255, 2038.898055097254, 2074.875507469557, 84535.5773221136, 86495.99999999937, 88284.55857720734, 88905.0, 90040.52953258628, 11653.0, 11785.941070294764, 11960.461779219955, 12043.397830108459, 12184.147109702235, 17044.31822727077, 17075.0, 17088.316467341414, 17118.572035699206, 17122.229499672543, 8587.441816281922, 8734.519601421856, 8830.072842351588, 8833.469991800512, 8848.247898928534, 8629.956850215709, 8635.827283454295, 8681.348898832613, 8760.824783504422, 8836.602352894006, 5180.818671346485, 5194.636375453758, 5196.376434827845, 5230.372355317386, 5253.553447956967, 2110.715053467793, 2140.4006878074165, 2164.433046272364, 2200.8789516576744, 2234.273860995183, 925.1997022575424, 1034.6533911139702, 1034.9223808214415, 1049.239301506417, 1049.7375656085978, 19291.131899064574, 19330.130144143546, 20070.197192112442, 20129.09419076145, 20221.696674549894, 989.7674046599044, 1037.5227395398201, 1037.5745944162857, 1063.3832377221347, 1126.9492872820742, 10376.273660843819, 11057.612983545538, 11068.0, 11123.276986995981, 11152.776944461066, 444087.0, 445880.0, 453508.0, 467003.0, 469961.0, 90324.0, 94389.5280523593, 94750.52624736833, 100154.4992275034, 104122.47938760258, 985.9408435493893, 1029.45953374479, 1030.5002073994108, 1056.4717641179411, 1068.9518971646294, 17076.316947321968, 17403.56491087733, 17422.21600028027, 17484.50929442375, 17904.0, 40330.596694033855, 42628.0, 42999.57000429956, 43419.34870976875, 44689.77655111704, 52237.0, 61902.38097618966, 62034.37965620286, 62715.6864215676, 63338.0, 8736.56317184151, 9010.684626038057, 9028.052054534443, 9201.079892010745, 9308.627654893999, 13012.154209976321, 13722.245276509888, 13730.65673358174, 13742.93128534351, 14105.506307279196, 12034.398280086136, 12063.457144428698, 12094.274343539415, 12211.816822747489, 12264.44809983535, 11770.764584708086, 11946.283223006647, 12023.579174728842, 12046.277223366626, 12203.633890983285, 11652.126090543412, 11708.70728231801, 11782.11634127461, 11978.520859165536, 12070.818937716116, 8665.090165532529, 8921.598528066123, 8971.551422428984, 8998.505082220541, 9077.09229077087, 10902.890971090505, 11965.0, 12108.515659373526, 12363.995550079258, 12587.559435419716], "value": 9556.003482488375, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1463.4585203474712, 1524.80177576915, 1631.8612917901978, 1729.9913500432497, 1751.0369296886709, 7851.45039847211, 8058.315043221319, 8504.0, 9078.182963533272, 9088.681896133636, 8497.0, 8695.21743043126, 8710.041895391501, 8840.248578870804, 8896.154865287803, 2435.0990133650575, 2502.4119331956977, 2504.1485894795765, 2504.9749502505015, 2505.3987043109705, 2466.05057053035, 2522.810789190809, 2541.1995221505167, 2560.911612564662, 2563.9359016024564, 2470.6170543565777, 2473.183849329726, 2476.1952365481293, 2477.4549599088264, 2485.378655336166, 2417.613181890898, 2427.672264244331, 2440.548498527778, 2482.962755558668, 2489.8630575318352, 2427.526632306701, 2437.122635851092, 2442.2306973303353, 2451.093095554656, 2477.2444404456633, 8749.606267717905, 8824.8676269856, 8861.512616806072, 8878.511681857495, 8890.688825891062, 5427.185922111676, 5499.395066542677, 5525.392206857243, 5525.944740552583, 5545.473180047889, 3444.9483257751153, 3449.344624521333, 3475.0964749165146, 3498.4577390504514, 3540.4689296605716, 1008.1128606825946, 1069.4866464097277, 1089.4008295437557, 1094.9397783121924, 1120.5573798349606, 12363.258204507669, 12418.192817466836, 12428.75142497145, 12489.18820276679, 12539.811902821464, 4712.85861424151, 4875.804967801319, 4900.436449808247, 4941.777620007108, 4966.925496117561, 10482.109020733324, 10503.422311772925, 10505.894941050645, 10519.579216831395, 10533.84199237012, 5533.142362933751, 5559.610827242054, 5568.276124103841, 5580.1629755537, 5621.381648018714, 4975.626827987915, 4989.800407983713, 5093.4651861554, 5156.7421628919155, 5170.793168273227, 3877.8836634901, 3917.118648304109, 4005.178938317638, 4072.592740725963, 4099.487564054493, 1235.932023738703, 1245.63876475821, 1254.7804134276648, 1255.12768625806, 1269.0608949377395, 840.369722707969, 954.4464210757744, 992.5831150916632, 1000.314784372707, 1001.8346972749415, 6059.0, 6061.151438798572, 6076.392360763976, 6088.726007329681, 6160.7535698571555, 491.31461611052384, 493.1616252370912, 499.6627276588288, 1016.7458135466134, 1091.8689757229024, 4243.893902652397, 4287.292596721506, 4321.135772845443, 4337.306031035019, 4454.977725111418, 10780.29928054674, 11073.0, 11088.0, 11117.72205694848, 11137.665870023913, 10972.780544389068, 11071.335719856834, 11091.667249982513, 11127.276727012719, 11131.276467029616, 7926.682932682628, 8177.182281771894, 8273.958630206811, 8401.579921003926, 8415.915840841635, 5962.970185149046, 6083.117947897442, 6234.563580549318, 6299.118123462627, 6356.484290303695, 9681.564329605044, 10236.795264094528, 10254.794904102026, 10283.794324113325, 10341.896581034394, 10019.0, 10345.327553708985, 10365.63720269787, 10402.323848949794, 10449.21630877672, 7085.658335789542, 7840.568768717775, 7843.843123137392, 7854.41091918097, 8017.158198389086, 8674.826503469769, 8685.0, 8726.563671816511, 8744.213020828156, 8797.604107815292, 7658.961705191661, 7690.077190737147, 7869.0950540688555, 7910.802229944297, 7956.9602151988865, 7701.537907725555, 7758.8448231033935, 7794.376449884109, 7808.0, 7947.245011723877, 7219.061522002106, 7229.349358557755, 7238.565686058853, 7258.383037441877, 7321.926780732125, 5271.683698978073, 5274.841754747364, 5294.920576191437, 5398.865028374322, 5399.784008639767, 5275.657082289639, 5392.325959255093, 5403.621746477709, 5435.592330575144, 5522.5858060644805], "value": 4725.008326142588, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.08550853289984, 358.53390592230096, 365.3423837093233, 371.58011447064814, 372.5529364762286, 5481.12302031675, 5550.833474995751, 5651.8304450866435, 5673.943260567393, 5740.655560666352, 5465.453454654543, 5581.609287349887, 5583.69289689068, 5584.9162262566, 5613.887722245553, 4357.259265924785, 4364.716293440916, 4382.904273931517, 4392.0, 4424.513303536608, 4341.674374421915, 4344.587264209895, 4372.2130016597, 4385.276429389163, 4386.692931494781, 4348.673654535365, 4363.799955012365, 4395.274779661352, 4411.404460397837, 4415.116976604676, 4300.892477688051, 4337.284348082562, 4343.891402714926, 4374.190774706658, 4374.759388233646, 3872.6514613684903, 3892.4550562921213, 3915.0, 3927.253821773854, 3959.5842436544035, 5457.61796674229, 5483.150111732648, 5504.64219825714, 5519.144532597414, 5525.419830917776, 4942.851714448572, 5055.848324550233, 5061.810474538481, 5067.949320506821, 5101.591872650179, 5845.269341332333, 5862.85674293513, 5867.442592953706, 5879.176915231871, 5884.499817515516, 4340.370646256275, 4351.260285751398, 4353.825846966118, 4368.148211098837, 4397.802098905557, 5883.970580147072, 6003.279606447254, 6022.427869352405, 6054.636721796706, 6056.303525094627, 4248.957510424856, 4276.914461710749, 4283.378910058024, 4306.609831543524, 4311.784410779448, 4271.0, 4306.870793876189, 4313.2883074292395, 4322.589354011364, 4352.0, 4846.854594362175, 4899.6570240083565, 4961.4294356148785, 4984.950150498448, 5025.39695236574, 5696.287964004499, 5703.925319534682, 5767.88464230713, 5780.826575202751, 5847.0, 1428.707115041414, 1435.411481292665, 1449.8550144985418, 1480.667399340602, 1484.829244636859, 981.4503877828439, 1017.1659239423601, 1022.5091955861228, 1026.1534234256767, 1045.7281106912105, 5475.260839786658, 5476.2333273341765, 5483.369412517532, 5527.834164975057, 5533.644257157022, 5809.419058094157, 5814.854628634233, 5824.475797178275, 5891.617044892068, 5909.409059094142, 5367.78528858849, 5520.0, 5539.750711218005, 5564.248826408464, 5572.192032155314, 3099.4266060778828, 3104.3170502489415, 3114.112477943775, 3115.5326700995033, 3123.7969531980802, 5753.827385178452, 5897.019511829498, 5905.940940590539, 5920.851978700481, 5946.345901950782, 6060.2727672678675, 6115.052166914135, 6116.663583502861, 6117.235345581802, 6130.693465326805, 6166.630002199882, 6184.299317687582, 6189.195404597373, 6193.566450348432, 6249.187605611241, 5669.34802497718, 5952.910706339322, 6005.609635373687, 6015.819525414245, 6085.57400981927, 5917.467427931507, 5937.7921772737745, 5993.400659933972, 6038.154658347747, 6046.758129674764, 5928.318243401892, 6100.23747031621, 6136.325004249618, 6147.84630384244, 6254.405831446005, 4415.823367065282, 4480.865574032784, 4490.12442573695, 4524.172392254841, 4531.501534831232, 5838.2702162229725, 6144.907826382519, 6148.1699970503405, 6164.321924588202, 6169.50643948474, 5797.333306669787, 5866.5893387462465, 5888.4700376966275, 5905.734241959208, 5924.851878703067, 5846.736896839738, 5903.350631430453, 5935.762569497172, 5936.970315148569, 5950.583459157991, 5672.801451949162, 5805.274340707411, 5857.535616095976, 5858.7070646468355, 5873.0, 5892.911606325994, 5909.143174239797, 5934.6142500737315, 5942.197803296673, 5981.312149102909, 5686.346070201815, 5694.231278777312, 5865.3254875689845, 5912.556558258234, 5914.704264786829], "value": 4478.900716841179, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [802.0095182449674, 814.1939479914882, 834.9039860416052, 852.7441767469766, 895.6954635423957, 15039.774403383944, 15430.228488575582, 15656.138912359816, 15958.521244362673, 16085.678286434279, 14456.710865782705, 14758.483453079145, 14794.0, 14800.481983130592, 14806.407743690239, 822.6298165825373, 840.5587066789953, 847.1189962439072, 852.3862818770506, 852.5012867472536, 829.1376967953352, 831.6174559702544, 832.4630613254448, 833.3166803221361, 833.4540875726409, 865.4158443050947, 868.3357231717741, 870.4342177584557, 873.0309356614154, 874.1957399192726, 855.8673405622138, 859.2481578618708, 860.9569521523899, 864.8097418567905, 867.4881819726392, 633.9080833279148, 636.6752955992431, 640.945519630832, 641.6278558436143, 641.7433026789322, 14789.778153327708, 14923.70152596942, 15158.31787569551, 15158.848411515854, 15165.0, 14351.116042422662, 14883.032602880778, 14937.327820248114, 14991.339246938833, 15038.172900490468, 11505.539778408853, 11749.64751057461, 12038.879611203864, 12137.453814578364, 12146.757064858743, 3860.6911447084167, 3918.7060970427333, 3968.3452230381954, 4566.360709500673, 4617.191991401525, 51867.22199167016, 57761.0, 60165.0, 60462.09306860401, 68546.65726671334, 10683.626073087406, 10764.300320479144, 10909.18181136418, 10927.836082458769, 10932.508037138348, 19142.904285478482, 19298.32455864038, 19435.12541935616, 19511.317103901296, 19743.60512789736, 8522.829543409098, 8816.250618697355, 8819.0, 8892.421992570462, 8983.281337492985, 4845.297431872429, 4858.149823780825, 4864.246041863516, 4940.283658869444, 4990.226514890198, 3530.5586801649793, 3658.304922064799, 3678.9080272993388, 3680.981595092061, 3688.9302102390006, 651.1469974333638, 665.5740326191242, 667.5360624366116, 669.0566301514841, 699.1226011355716, 621.2638023941644, 774.3340726974798, 780.6643143448372, 791.8020494876281, 797.6609940775147, 9325.720228393158, 10087.848682269772, 10439.582416703399, 10534.051935325704, 10568.260221784401, 666.6966530228734, 729.6971756720901, 776.3153955915676, 785.7210690204895, 793.6309616028575, 4889.779959901742, 4915.705057696549, 4941.1847045237855, 4964.230544265644, 4996.0, 84144.0, 85668.57165714256, 87482.56258718665, 88050.0, 89958.55020724854, 74015.25984740084, 74652.0, 75225.0, 75233.24766752262, 75918.24081759222, 44191.0, 49122.26316605254, 58430.415695843345, 58776.41223587795, 67613.32386676071, 10018.998100190214, 10611.4163720993, 10650.201234907569, 10866.728331791452, 10968.890311096788, 46059.76970115128, 46541.0, 46664.30003549882, 46673.53326466692, 47669.28496072492, 53004.46995529995, 53613.731931340095, 62158.0, 63205.36794631995, 64763.0, 12671.113022088366, 13014.089013768946, 13041.804372934224, 13210.735785284432, 13255.469781208643, 14498.637534061732, 14613.85386146125, 15088.471903483765, 15245.16151611672, 15259.694806104038, 14288.214148221947, 14524.636884077983, 14628.780568291271, 14672.77990830117, 14758.778618320948, 12943.288119153536, 13102.868971310165, 13192.472301107848, 13231.0, 14266.500672476413, 13942.930285348508, 14151.0, 14454.855451445352, 14665.413383464542, 15170.0, 11489.138314626603, 11722.58970936013, 11787.410629468664, 12108.21296615717, 12458.75082498363, 12127.514899403925, 12236.265824050586, 12383.690407739517, 12394.938025310177, 12452.875471245172], "value": 7439.79992757117, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1471.9000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 111.0, 111.0, 111.0, 111.0, 113.0, 114.0, 112.0, 111.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 123.0, 126.0, 161.0, 124.0, 123.0, 120.0, 125.0, 145.0, 119.0], "value": 131.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 162.0, 162.0, 165.0, 163.0, 163.0, 164.0, 163.0, 161.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 109.0, 76.0, 76.0, 75.0, 75.0, 115.0, 75.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 125.0, 82.0, 82.0, 82.0, 99.0, 81.0, 81.0, 102.0], "value": 89.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 121.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 149.0, 149.0, 151.0, 158.0, 160.0, 149.0, 152.0, 150.0], "value": 151.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 85.0, 87.0, 85.0, 84.0, 85.0, 85.0, 85.0, 86.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 61.0, 50.0, 51.0, 51.0, 51.0, 52.0, 51.0, 51.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 59.0, 59.0, 59.0, 58.0, 58.0, 58.0, 59.0, 59.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 73.0, 75.0, 76.0, 83.0, 75.0, 74.0, 75.0, 79.0, 79.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 121.0, 128.0, 122.0, 126.0, 121.0, 125.0, 124.0, 174.0, 122.0], "value": 128.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 163.0, 164.0, 154.0, 157.0, 154.0, 157.0, 159.0, 156.0, 155.0], "value": 157.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 65.0, 68.0, 72.0, 64.0, 65.0, 64.0, 62.0, 64.0], "value": 65.0, "unit": "score"}]}]} 22:22:31 INFO - Return code: 0 22:22:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:22:31 ERROR - # TBPL SUCCESS # 22:22:31 INFO - Running post-action listener: _resource_record_post_action 22:22:31 INFO - [mozharness: 2016-12-20 06:22:31.900773Z] Finished run-tests step (success) 22:22:31 INFO - Running post-run listener: _resource_record_post_run 22:22:31 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 8192; Write bytes: 356962304; Read time: 8; Write time: 214780 22:22:31 INFO - TinderboxPrint: CPU usage
13.3% 22:22:31 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 8 22:22:31 INFO - TinderboxPrint: I/O write bytes / time
356,962,304 / 214,780 22:22:31 INFO - TinderboxPrint: CPU idle
8,223.1 (86.7%) 22:22:31 INFO - TinderboxPrint: CPU user
1,207.3 (12.7%) 22:22:31 INFO - TinderboxPrint: Swap in / out
0 / 0 22:22:31 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108134400; Read time: 0; Write time: 74872 22:22:31 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 248467456; Read time: 4; Write time: 139908 22:22:32 INFO - Running post-run listener: _upload_blobber_files 22:22:32 INFO - Blob upload gear active. 22:22:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:22:32 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:22:32 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:22:32 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:22:32 INFO - (blobuploader) - INFO - Open directory for files ... 22:22:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:22:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:22:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:22:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:22:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:22:33 INFO - (blobuploader) - INFO - Done attempting. 22:22:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:22:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:22:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:22:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:22:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:22:37 INFO - (blobuploader) - INFO - Done attempting. 22:22:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:22:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:22:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:22:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:22:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:22:38 INFO - (blobuploader) - INFO - Done attempting. 22:22:38 INFO - (blobuploader) - INFO - Iteration through files over. 22:22:38 INFO - Return code: 0 22:22:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:22:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:22:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/53ae9d8051d21b85c12def696b6babc247f1e6ebee7ecad9da8a7f79c659bc7671c0c03163b0c9c215dc48f42927d510c5c06529195539085f67c0b6a4290268", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d30c393a6e488e706d3ff44dd4f494ac65ddc6e0bd16b98d69ac6a69c230f42b6c55e9bfedb7551a9fd1dd411baadfd29e517797ce075ae21826937228838054", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/106ba91948c484dd957673e1896e6541c63442e9aaee9803a14baaf34bb2750bdc96552c8ea300e88160f2cfb7aba7c638a7e11acf744b232a3a8604f26676ec"} 22:22:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:22:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:22:38 INFO - Contents: 22:22:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/53ae9d8051d21b85c12def696b6babc247f1e6ebee7ecad9da8a7f79c659bc7671c0c03163b0c9c215dc48f42927d510c5c06529195539085f67c0b6a4290268", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d30c393a6e488e706d3ff44dd4f494ac65ddc6e0bd16b98d69ac6a69c230f42b6c55e9bfedb7551a9fd1dd411baadfd29e517797ce075ae21826937228838054", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/106ba91948c484dd957673e1896e6541c63442e9aaee9803a14baaf34bb2750bdc96552c8ea300e88160f2cfb7aba7c638a7e11acf744b232a3a8604f26676ec"} 22:22:38 INFO - Running post-run listener: copy_logs_to_upload_dir 22:22:38 INFO - Copying logs to upload dir... 22:22:38 INFO - mkdir: /builds/slave/test/build/upload/logs 22:22:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.155690 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-12-19 22:22:37.535800) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-19 22:22:37.538931) ========= 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=923d835db2ba3686ebe126b700000192-1482213487.340237-899975824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/53ae9d8051d21b85c12def696b6babc247f1e6ebee7ecad9da8a7f79c659bc7671c0c03163b0c9c215dc48f42927d510c5c06529195539085f67c0b6a4290268", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d30c393a6e488e706d3ff44dd4f494ac65ddc6e0bd16b98d69ac6a69c230f42b6c55e9bfedb7551a9fd1dd411baadfd29e517797ce075ae21826937228838054", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/106ba91948c484dd957673e1896e6541c63442e9aaee9803a14baaf34bb2750bdc96552c8ea300e88160f2cfb7aba7c638a7e11acf744b232a3a8604f26676ec"} build_url:https://queue.taskcluster.net/v1/task/eHzeF_F7QtqJx1Jdri-D4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011304 build_url: 'https://queue.taskcluster.net/v1/task/eHzeF_F7QtqJx1Jdri-D4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/53ae9d8051d21b85c12def696b6babc247f1e6ebee7ecad9da8a7f79c659bc7671c0c03163b0c9c215dc48f42927d510c5c06529195539085f67c0b6a4290268", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d30c393a6e488e706d3ff44dd4f494ac65ddc6e0bd16b98d69ac6a69c230f42b6c55e9bfedb7551a9fd1dd411baadfd29e517797ce075ae21826937228838054", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/106ba91948c484dd957673e1896e6541c63442e9aaee9803a14baaf34bb2750bdc96552c8ea300e88160f2cfb7aba7c638a7e11acf744b232a3a8604f26676ec"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-19 22:22:37.567280) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 22:22:37.567616) ========= 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=923d835db2ba3686ebe126b700000192-1482213487.340237-899975824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004507 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 22:22:37.647294) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-19 22:22:37.648110) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-19 22:22:37.648405) ========= ========= Total master_lag: 0.18 =========