builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-042 starttime: 1476351114.55 results: success (0) buildid: 20161013010023 builduid: da99d9e7431945b2891d0599805bacd0 revision: 6cb3fe45e73128a9683523c21849716fdbfbf4b5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 02:31:54.547392) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 02:31:54.547850) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 02:31:54.548170) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 02:31:54.574044) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 02:31:54.574347) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1476351113.879051-1713229139 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-13 02:31:54-- 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% 43.2M=0s 2016-10-13 02:31:54 (43.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.081474 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 02:31:54.669597) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 02:31:54.669910) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1476351113.879051-1713229139 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013678 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 02:31:54.718759) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 02:31:54.719081) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 6cb3fe45e73128a9683523c21849716fdbfbf4b5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 6cb3fe45e73128a9683523c21849716fdbfbf4b5 --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=74d6aec007b0fa31a864ebd7000001f8-1476351113.879051-1713229139 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-13 02:31:54,852 truncating revision to first 12 chars 2016-10-13 02:31:54,852 Setting DEBUG logging. 2016-10-13 02:31:54,852 attempt 1/10 2016-10-13 02:31:54,852 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/6cb3fe45e731?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-13 02:31:55,195 unpacking tar archive at: autoland-6cb3fe45e731/testing/mozharness/ program finished with exit code 0 elapsedTime=0.663534 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 02:31:55.396243) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 02:31:55.396592) ========= script_repo_revision: 6cb3fe45e73128a9683523c21849716fdbfbf4b5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 02:31:55.397038) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 02:31:55.397367) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 02:31:55.410406) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-10-13 02:31:55.410789) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] 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=74d6aec007b0fa31a864ebd7000001f8-1476351113.879051-1713229139 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:31:55 INFO - MultiFileLogger online at 20161013 02:31:55 in /builds/slave/test 02:31:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 02:31:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:31:55 INFO - {'append_to_log': False, 02:31:55 INFO - 'base_work_dir': '/builds/slave/test', 02:31:55 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 02:31:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:31:55 INFO - 'branch': 'Autoland-Non-PGO', 02:31:55 INFO - 'buildbot_json_path': 'buildprops.json', 02:31:55 INFO - 'config_files': ('talos/linux_config.py',), 02:31:55 INFO - 'default_actions': ('clobber', 02:31:55 INFO - 'read-buildbot-config', 02:31:55 INFO - 'download-and-extract', 02:31:55 INFO - 'populate-webroot', 02:31:55 INFO - 'create-virtualenv', 02:31:55 INFO - 'install', 02:31:55 INFO - 'run-tests'), 02:31:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:31:55 INFO - 'download_minidump_stackwalk': True, 02:31:55 INFO - 'download_symbols': 'ondemand', 02:31:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:31:55 INFO - 'tooltool.py': '/tools/tooltool.py', 02:31:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:31:55 INFO - '/tools/misc-python/virtualenv.py')}, 02:31:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:31:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:31:55 INFO - 'installer_path': 'installer.exe', 02:31:55 INFO - 'log_level': 'info', 02:31:55 INFO - 'log_name': 'talos', 02:31:55 INFO - 'log_to_console': True, 02:31:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:31:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:31:55 INFO - 'opt_config_files': (), 02:31:55 INFO - 'pip_index': False, 02:31:55 INFO - 'sps_profile': False, 02:31:55 INFO - 'sps_profile_interval': 0, 02:31:55 INFO - 'suite': 'dromaeojs', 02:31:55 INFO - 'system_bits': '32', 02:31:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:31:55 INFO - 'title': 'talos-linux64-ix-042', 02:31:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:31:55 INFO - 'use_talos_json': True, 02:31:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:31:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:31:55 INFO - 'work_dir': 'build'} 02:31:55 INFO - [mozharness: 2016-10-13 09:31:55.637853Z] Running clobber step. 02:31:55 INFO - Running pre-action listener: _resource_record_pre_action 02:31:55 INFO - Running main action method: clobber 02:31:55 INFO - rmtree: /builds/slave/test/build 02:31:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:31:56 INFO - Running post-action listener: _resource_record_post_action 02:31:56 INFO - [mozharness: 2016-10-13 09:31:56.127231Z] Finished clobber step (success) 02:31:56 INFO - [mozharness: 2016-10-13 09:31:56.127331Z] Running read-buildbot-config step. 02:31:56 INFO - Running pre-action listener: _resource_record_pre_action 02:31:56 INFO - Running main action method: read_buildbot_config 02:31:56 INFO - Using buildbot properties: 02:31:56 INFO - { 02:31:56 INFO - "project": "", 02:31:56 INFO - "product": "firefox", 02:31:56 INFO - "script_repo_revision": "production", 02:31:56 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 02:31:56 INFO - "repository": "", 02:31:56 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 02:31:56 INFO - "buildid": "20161013010023", 02:31:56 INFO - "pgo_build": "False", 02:31:56 INFO - "basedir": "/builds/slave/test", 02:31:56 INFO - "buildnumber": 714, 02:31:56 INFO - "slavename": "talos-linux64-ix-042", 02:31:56 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:31:56 INFO - "platform": "ubuntu64_hw", 02:31:56 INFO - "scheduler": "tests-autoland-linux64-talos", 02:31:56 INFO - "branch": "autoland", 02:31:56 INFO - "repo_path": "integration/autoland", 02:31:56 INFO - "revision": "6cb3fe45e73128a9683523c21849716fdbfbf4b5", 02:31:56 INFO - "stage_platform": "linux64", 02:31:56 INFO - "builduid": "da99d9e7431945b2891d0599805bacd0", 02:31:56 INFO - "slavebuilddir": "test" 02:31:56 INFO - } 02:31:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/DwyAgT8-RjmwDoHdRS0XeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 02:31:56 INFO - Running post-action listener: _resource_record_post_action 02:31:56 INFO - [mozharness: 2016-10-13 09:31:56.129756Z] Finished read-buildbot-config step (success) 02:31:56 INFO - [mozharness: 2016-10-13 09:31:56.129842Z] Running download-and-extract step. 02:31:56 INFO - Running pre-action listener: _resource_record_pre_action 02:31:56 INFO - Running main action method: download_and_extract 02:31:56 INFO - mkdir: /builds/slave/test/build/tests 02:31:56 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')]} 02:31:56 INFO - trying https://queue.taskcluster.net/v1/task/DwyAgT8-RjmwDoHdRS0XeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 02:31:56 INFO - Downloading https://queue.taskcluster.net/v1/task/DwyAgT8-RjmwDoHdRS0XeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 02:31:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DwyAgT8-RjmwDoHdRS0XeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:31:56 INFO - Downloaded 1361 bytes. 02:31:56 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 02:31:56 INFO - Using the following test package requirements: 02:31:56 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 02:31:56 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:31:56 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:31:56 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:31:56 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:31:56 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:31:56 INFO - u'jsshell-linux-x86_64.zip'], 02:31:56 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:31:56 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:31:56 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 02:31:56 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:31:56 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:31:56 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:31:56 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:31:56 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:31:56 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:31:56 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:31:56 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:31:56 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:31:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DwyAgT8-RjmwDoHdRS0XeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 02:31:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DwyAgT8-RjmwDoHdRS0XeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:31:56 INFO - Fetch https://queue.taskcluster.net/v1/task/DwyAgT8-RjmwDoHdRS0XeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 02:31:57 INFO - Http code: 200 02:31:57 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 02:31:57 INFO - x-amz-cf-id: s1-KkEzL-V86h6TrgXX09JAYERYve8WpQo-pLzr-UdxH7RFdVYGdrA== 02:31:57 INFO - x-amz-version-id: arQ.FeX5RKnwd2QsPmHRK1hcoWYCbcov 02:31:58 INFO - Expected file size: 20548348 02:31:58 INFO - Obtained file size: 20548348 02:32:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:32:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DwyAgT8-RjmwDoHdRS0XeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 02:32:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DwyAgT8-RjmwDoHdRS0XeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:32:02 INFO - Fetch https://queue.taskcluster.net/v1/task/DwyAgT8-RjmwDoHdRS0XeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 02:32:02 INFO - Http code: 200 02:32:02 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 02:32:02 INFO - x-amz-cf-id: doSEetNTeIgzsPG1weEvlYAY78ZSRd4GsYO9ZEuAWD_lhoB1RoujEQ== 02:32:02 INFO - x-amz-version-id: arQ.FeX5RKnwd2QsPmHRK1hcoWYCbcov 02:32:03 INFO - Expected file size: 20548348 02:32:03 INFO - Obtained file size: 20548348 02:32:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DwyAgT8-RjmwDoHdRS0XeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 02:32:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DwyAgT8-RjmwDoHdRS0XeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:32:07 INFO - Fetch https://queue.taskcluster.net/v1/task/DwyAgT8-RjmwDoHdRS0XeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 02:32:08 INFO - Http code: 200 02:32:08 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 02:32:08 INFO - x-amz-cf-id: Zir4Qs7sDgDPuoVeTNTMDk8x5eJdOEN-_NUlk0kW5Db233J7YCvjPg== 02:32:08 INFO - x-amz-version-id: 5EHe7Zab7bD8.GNuWf.Upm.6OshYljc3 02:32:10 INFO - Expected file size: 14409006 02:32:10 INFO - Obtained file size: 14409006 02:32:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:10 INFO - trying https://queue.taskcluster.net/v1/task/DwyAgT8-RjmwDoHdRS0XeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 02:32:10 INFO - Downloading https://queue.taskcluster.net/v1/task/DwyAgT8-RjmwDoHdRS0XeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 02:32:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DwyAgT8-RjmwDoHdRS0XeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:32:13 INFO - Downloaded 55930509 bytes. 02:32:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DwyAgT8-RjmwDoHdRS0XeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 02:32:13 INFO - mkdir: /builds/slave/test/properties 02:32:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:32:13 INFO - Writing to file /builds/slave/test/properties/build_url 02:32:13 INFO - Contents: 02:32:13 INFO - build_url:https://queue.taskcluster.net/v1/task/DwyAgT8-RjmwDoHdRS0XeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 02:32:13 INFO - Running post-action listener: _resource_record_post_action 02:32:13 INFO - Running post-action listener: set_extra_try_arguments 02:32:13 INFO - [mozharness: 2016-10-13 09:32:13.799349Z] Finished download-and-extract step (success) 02:32:13 INFO - [mozharness: 2016-10-13 09:32:13.799573Z] Running populate-webroot step. 02:32:13 INFO - Running pre-action listener: _resource_record_pre_action 02:32:13 INFO - Running main action method: populate_webroot 02:32:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:32:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:32:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:32:13 INFO - '--tppagecycles', 02:32:13 INFO - '7'], 02:32:13 INFO - 'tests': ['tsvgm']}}, 02:32:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:32:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:32:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:32:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:32:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:32:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:32:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:13 INFO - 'talos_options': ['--disable-e10s'], 02:32:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:32:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:32:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:13 INFO - 'talos_options': ['--disable-e10s'], 02:32:13 INFO - 'tests': ['damp', 'tps']}, 02:32:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:13 INFO - 'tests': ['damp', 'tps']}, 02:32:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:32:13 INFO - 'tests': ['dromaeo_dom']}, 02:32:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:32:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:32:13 INFO - 'tests': ['basic_compositor_video']}, 02:32:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:32:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:32:13 INFO - 'tests': ['a11yr', 02:32:13 INFO - 'ts_paint', 02:32:13 INFO - 'tpaint', 02:32:13 INFO - 'sessionrestore', 02:32:13 INFO - 'sessionrestore_no_auto_restore', 02:32:13 INFO - 'tabpaint']}, 02:32:13 INFO - 'other-e10s': {'tests': ['a11yr', 02:32:13 INFO - 'ts_paint', 02:32:13 INFO - 'tpaint', 02:32:13 INFO - 'sessionrestore', 02:32:13 INFO - 'sessionrestore_no_auto_restore', 02:32:13 INFO - 'tabpaint']}, 02:32:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:32:13 INFO - 'ts_paint', 02:32:13 INFO - 'tpaint', 02:32:13 INFO - 'sessionrestore', 02:32:13 INFO - 'sessionrestore_no_auto_restore', 02:32:13 INFO - 'tabpaint']}, 02:32:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:32:13 INFO - 'ts_paint', 02:32:13 INFO - 'tpaint', 02:32:13 INFO - 'sessionrestore', 02:32:13 INFO - 'sessionrestore_no_auto_restore', 02:32:13 INFO - 'tabpaint']}, 02:32:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:32:13 INFO - 'tests': ['a11yr', 02:32:13 INFO - 'ts_paint', 02:32:13 INFO - 'tpaint', 02:32:13 INFO - 'sessionrestore', 02:32:13 INFO - 'sessionrestore_no_auto_restore', 02:32:13 INFO - 'tabpaint']}, 02:32:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:32:13 INFO - 'tests': ['a11yr', 02:32:13 INFO - 'ts_paint', 02:32:13 INFO - 'tpaint', 02:32:13 INFO - 'sessionrestore', 02:32:13 INFO - 'sessionrestore_no_auto_restore', 02:32:13 INFO - 'tabpaint']}, 02:32:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:32:13 INFO - 'tests': ['tsvgx', 02:32:13 INFO - 'tsvgr_opacity', 02:32:13 INFO - 'tart', 02:32:13 INFO - 'tscrollx', 02:32:13 INFO - 'cart']}, 02:32:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:32:13 INFO - 'tsvgr_opacity', 02:32:13 INFO - 'tart', 02:32:13 INFO - 'tscrollx', 02:32:13 INFO - 'cart']}, 02:32:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:13 INFO - 'talos_options': ['--disable-e10s'], 02:32:13 INFO - 'tests': ['tp5o']}, 02:32:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:13 INFO - 'tests': ['tp5o']}, 02:32:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:13 INFO - 'talos_options': ['--disable-e10s', 02:32:13 INFO - '--xperf_path', 02:32:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:32:13 INFO - 'tests': ['tp5n']}, 02:32:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:13 INFO - 'talos_options': ['--xperf_path', 02:32:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:32:13 INFO - 'tests': ['tp5n']}}, 02:32:13 INFO - 'talos.zip': {'path': '', 02:32:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:32:13 INFO - Running post-action listener: _resource_record_post_action 02:32:13 INFO - [mozharness: 2016-10-13 09:32:13.821476Z] Finished populate-webroot step (success) 02:32:13 INFO - [mozharness: 2016-10-13 09:32:13.821563Z] Running create-virtualenv step. 02:32:13 INFO - Running pre-action listener: _resource_record_pre_action 02:32:13 INFO - Running main action method: create_virtualenv 02:32:13 INFO - Creating virtualenv /builds/slave/test/build/venv 02:32:13 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 02:32:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:32:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:32:13 INFO - Using real prefix '/usr' 02:32:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:32:14 INFO - Installing distribute.............................................................................................................................................................................................done. 02:32:16 INFO - Installing pip.................done. 02:32:16 INFO - Return code: 0 02:32:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:32:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:32:16 INFO - Reading from file tmpfile_stdout 02:32:16 INFO - Output received: 02:32:16 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) 02:32:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:32:16 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')]} 02:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:16 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')]} 02:32:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:16 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 0x7fb8153f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa4f60>, '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 0x1fa5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa61d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1476351113.879051-1713229139', '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 02:32:16 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 02:32:16 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 02:32:16 INFO - Using env: {'DISPLAY': ':0', 02:32:16 INFO - 'HOME': '/home/cltbld', 02:32:16 INFO - 'LANG': 'en_US.UTF-8', 02:32:16 INFO - 'LANGUAGE': 'en_US:en', 02:32:16 INFO - 'LOGNAME': 'cltbld', 02:32:16 INFO - 'MAIL': '/var/mail/cltbld', 02:32:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:16 INFO - 'MOZ_NO_REMOTE': '1', 02:32:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:16 INFO - 'NO_EM_RESTART': '1', 02:32:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:16 INFO - 'PWD': '/builds/slave/test', 02:32:16 INFO - 'SHELL': '/bin/bash', 02:32:16 INFO - 'SHLVL': '1', 02:32:16 INFO - 'TERM': 'linux', 02:32:16 INFO - 'TMOUT': '86400', 02:32:16 INFO - 'USER': 'cltbld', 02:32:16 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476351113.879051-1713229139', 02:32:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:16 INFO - '_': '/tools/buildbot/bin/python'} 02:32:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:16 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 02:32:16 INFO - Cleaning up... 02:32:16 INFO - Return code: 0 02:32:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:32:16 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')]} 02:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:16 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')]} 02:32:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:16 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 0x7fb8153f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa4f60>, '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 0x1fa5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa61d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1476351113.879051-1713229139', '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 02:32:16 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 02:32:16 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 02:32:16 INFO - Using env: {'DISPLAY': ':0', 02:32:16 INFO - 'HOME': '/home/cltbld', 02:32:16 INFO - 'LANG': 'en_US.UTF-8', 02:32:16 INFO - 'LANGUAGE': 'en_US:en', 02:32:16 INFO - 'LOGNAME': 'cltbld', 02:32:16 INFO - 'MAIL': '/var/mail/cltbld', 02:32:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:16 INFO - 'MOZ_NO_REMOTE': '1', 02:32:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:16 INFO - 'NO_EM_RESTART': '1', 02:32:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:16 INFO - 'PWD': '/builds/slave/test', 02:32:16 INFO - 'SHELL': '/bin/bash', 02:32:16 INFO - 'SHLVL': '1', 02:32:16 INFO - 'TERM': 'linux', 02:32:16 INFO - 'TMOUT': '86400', 02:32:16 INFO - 'USER': 'cltbld', 02:32:16 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476351113.879051-1713229139', 02:32:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:16 INFO - '_': '/tools/buildbot/bin/python'} 02:32:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:17 INFO - Downloading/unpacking psutil>=3.1.1 02:32:17 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 02:32:17 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 02:32:17 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 02:32:17 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 02:32:17 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 02:32:17 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 02:32:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:32:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:32:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:32:19 INFO - Installing collected packages: psutil 02:32:19 INFO - Running setup.py install for psutil 02:32:19 INFO - building 'psutil._psutil_linux' extension 02:32:19 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 02:32:19 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 02:32:19 INFO - building 'psutil._psutil_posix' extension 02:32:19 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 02:32:19 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 02:32:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:32:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:32:19 INFO - Successfully installed psutil 02:32:19 INFO - Cleaning up... 02:32:19 INFO - Return code: 0 02:32:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:32:19 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')]} 02:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:19 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')]} 02:32:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:19 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 0x7fb8153f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa4f60>, '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 0x1fa5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa61d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1476351113.879051-1713229139', '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 02:32:19 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 02:32:19 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 02:32:19 INFO - Using env: {'DISPLAY': ':0', 02:32:19 INFO - 'HOME': '/home/cltbld', 02:32:19 INFO - 'LANG': 'en_US.UTF-8', 02:32:19 INFO - 'LANGUAGE': 'en_US:en', 02:32:19 INFO - 'LOGNAME': 'cltbld', 02:32:19 INFO - 'MAIL': '/var/mail/cltbld', 02:32:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:19 INFO - 'MOZ_NO_REMOTE': '1', 02:32:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:19 INFO - 'NO_EM_RESTART': '1', 02:32:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:19 INFO - 'PWD': '/builds/slave/test', 02:32:19 INFO - 'SHELL': '/bin/bash', 02:32:19 INFO - 'SHLVL': '1', 02:32:19 INFO - 'TERM': 'linux', 02:32:19 INFO - 'TMOUT': '86400', 02:32:19 INFO - 'USER': 'cltbld', 02:32:19 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476351113.879051-1713229139', 02:32:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:19 INFO - '_': '/tools/buildbot/bin/python'} 02:32:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:32:19 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 02:32:19 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 02:32:19 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 02:32:19 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 02:32:19 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 02:32:19 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 02:32:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:32:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:32:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:32:21 INFO - Installing collected packages: mozsystemmonitor 02:32:21 INFO - Running setup.py install for mozsystemmonitor 02:32:21 INFO - Successfully installed mozsystemmonitor 02:32:21 INFO - Cleaning up... 02:32:22 INFO - Return code: 0 02:32:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:32: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')]} 02:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32: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')]} 02:32:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32: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', '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 0x7fb8153f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa4f60>, '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 0x1fa5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa61d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1476351113.879051-1713229139', '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 02:32: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:32: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 jsonschema==2.5.1 02:32:22 INFO - Using env: {'DISPLAY': ':0', 02:32:22 INFO - 'HOME': '/home/cltbld', 02:32:22 INFO - 'LANG': 'en_US.UTF-8', 02:32:22 INFO - 'LANGUAGE': 'en_US:en', 02:32:22 INFO - 'LOGNAME': 'cltbld', 02:32:22 INFO - 'MAIL': '/var/mail/cltbld', 02:32:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:22 INFO - 'MOZ_NO_REMOTE': '1', 02:32:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:22 INFO - 'NO_EM_RESTART': '1', 02:32:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:22 INFO - 'PWD': '/builds/slave/test', 02:32:22 INFO - 'SHELL': '/bin/bash', 02:32:22 INFO - 'SHLVL': '1', 02:32:22 INFO - 'TERM': 'linux', 02:32:22 INFO - 'TMOUT': '86400', 02:32:22 INFO - 'USER': 'cltbld', 02:32:22 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476351113.879051-1713229139', 02:32:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:22 INFO - '_': '/tools/buildbot/bin/python'} 02:32:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:22 INFO - Downloading/unpacking jsonschema==2.5.1 02:32: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 02:32: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 02:32: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 02:32: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 02:32: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 02:32: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 02:32:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:32:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:32:24 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 02:32:24 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 02:32:24 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 02:32:24 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 02:32:24 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 02:32:24 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 02:32:24 INFO - Downloading functools32-3.2.3-2.tar.gz 02:32:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:32:24 INFO - warning: no files found matching '*.txt' 02:32:24 INFO - no previously-included directories found matching 'build' 02:32:24 INFO - no previously-included directories found matching 'dist' 02:32:24 INFO - no previously-included directories found matching '.git*' 02:32:24 INFO - Installing collected packages: jsonschema, functools32 02:32:24 INFO - Running setup.py install for functools32 02:32:24 INFO - warning: no files found matching '*.txt' 02:32:24 INFO - no previously-included directories found matching 'build' 02:32:24 INFO - no previously-included directories found matching 'dist' 02:32:24 INFO - no previously-included directories found matching '.git*' 02:32:24 INFO - Successfully installed jsonschema functools32 02:32:24 INFO - Cleaning up... 02:32:24 INFO - Return code: 0 02:32:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:32:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:24 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 0x7fb8153f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa4f60>, '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 0x1fa5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa61d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1476351113.879051-1713229139', '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 02:32:24 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 02:32:24 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 02:32:24 INFO - Using env: {'DISPLAY': ':0', 02:32:24 INFO - 'HOME': '/home/cltbld', 02:32:24 INFO - 'LANG': 'en_US.UTF-8', 02:32:24 INFO - 'LANGUAGE': 'en_US:en', 02:32:24 INFO - 'LOGNAME': 'cltbld', 02:32:24 INFO - 'MAIL': '/var/mail/cltbld', 02:32:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:24 INFO - 'MOZ_NO_REMOTE': '1', 02:32:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:24 INFO - 'NO_EM_RESTART': '1', 02:32:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:24 INFO - 'PWD': '/builds/slave/test', 02:32:24 INFO - 'SHELL': '/bin/bash', 02:32:24 INFO - 'SHLVL': '1', 02:32:24 INFO - 'TERM': 'linux', 02:32:24 INFO - 'TMOUT': '86400', 02:32:24 INFO - 'USER': 'cltbld', 02:32:24 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476351113.879051-1713229139', 02:32:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:24 INFO - '_': '/tools/buildbot/bin/python'} 02:32:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:32:24 INFO - Cleaning up... 02:32:24 INFO - Return code: 0 02:32:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:32:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:24 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 0x7fb8153f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa4f60>, '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 0x1fa5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa61d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1476351113.879051-1713229139', '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 02:32:24 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 02:32:24 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 02:32:24 INFO - Using env: {'DISPLAY': ':0', 02:32:24 INFO - 'HOME': '/home/cltbld', 02:32:24 INFO - 'LANG': 'en_US.UTF-8', 02:32:24 INFO - 'LANGUAGE': 'en_US:en', 02:32:24 INFO - 'LOGNAME': 'cltbld', 02:32:24 INFO - 'MAIL': '/var/mail/cltbld', 02:32:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:24 INFO - 'MOZ_NO_REMOTE': '1', 02:32:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:24 INFO - 'NO_EM_RESTART': '1', 02:32:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:24 INFO - 'PWD': '/builds/slave/test', 02:32:24 INFO - 'SHELL': '/bin/bash', 02:32:24 INFO - 'SHLVL': '1', 02:32:24 INFO - 'TERM': 'linux', 02:32:24 INFO - 'TMOUT': '86400', 02:32:24 INFO - 'USER': 'cltbld', 02:32:24 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476351113.879051-1713229139', 02:32:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:24 INFO - '_': '/tools/buildbot/bin/python'} 02:32:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:25 INFO - Downloading/unpacking blobuploader==1.2.4 02:32: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 02:32: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 02:32: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 02:32: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 02:32: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 02:32: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 02:32:26 INFO - Downloading blobuploader-1.2.4.tar.gz 02:32:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:32:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:32:27 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 02:32:27 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 02:32:27 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 02:32:27 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 02:32:27 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 02:32:27 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 02:32:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:32:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:32:27 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 02:32:27 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 02:32:27 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 02:32:27 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 02:32:27 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 02:32:27 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 02:32:27 INFO - Downloading docopt-0.6.1.tar.gz 02:32:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:32:27 INFO - Installing collected packages: blobuploader, requests, docopt 02:32:27 INFO - Running setup.py install for blobuploader 02:32:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:32:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:32:27 INFO - Running setup.py install for requests 02:32:28 INFO - Running setup.py install for docopt 02:32:28 INFO - Successfully installed blobuploader requests docopt 02:32:28 INFO - Cleaning up... 02:32:28 INFO - Return code: 0 02:32:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:32:28 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')]} 02:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:28 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')]} 02:32:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:28 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 0x7fb8153f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa4f60>, '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 0x1fa5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa61d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1476351113.879051-1713229139', '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 02:32:28 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 02:32:28 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 02:32:28 INFO - Using env: {'DISPLAY': ':0', 02:32:28 INFO - 'HOME': '/home/cltbld', 02:32:28 INFO - 'LANG': 'en_US.UTF-8', 02:32:28 INFO - 'LANGUAGE': 'en_US:en', 02:32:28 INFO - 'LOGNAME': 'cltbld', 02:32:28 INFO - 'MAIL': '/var/mail/cltbld', 02:32:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:28 INFO - 'MOZ_NO_REMOTE': '1', 02:32:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:28 INFO - 'NO_EM_RESTART': '1', 02:32:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:28 INFO - 'PWD': '/builds/slave/test', 02:32:28 INFO - 'SHELL': '/bin/bash', 02:32:28 INFO - 'SHLVL': '1', 02:32:28 INFO - 'TERM': 'linux', 02:32:28 INFO - 'TMOUT': '86400', 02:32:28 INFO - 'USER': 'cltbld', 02:32:28 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476351113.879051-1713229139', 02:32:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:28 INFO - '_': '/tools/buildbot/bin/python'} 02:32:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:32:28 INFO - Running setup.py (path:/tmp/pip-BBHFQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:32:28 INFO - Running setup.py (path:/tmp/pip-UbKAr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:32:28 INFO - Running setup.py (path:/tmp/pip-82mSY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:32:28 INFO - Running setup.py (path:/tmp/pip-0EZqhf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:32:28 INFO - Running setup.py (path:/tmp/pip-lGr_4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:32:28 INFO - Running setup.py (path:/tmp/pip-5S8JTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:32:29 INFO - Running setup.py (path:/tmp/pip-3aeipX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:32:29 INFO - Running setup.py (path:/tmp/pip-oZjoy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:32:29 INFO - Running setup.py (path:/tmp/pip-PpsRIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:32:29 INFO - Running setup.py (path:/tmp/pip-vZZhR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:32:29 INFO - Running setup.py (path:/tmp/pip-RJmR17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:32:29 INFO - Running setup.py (path:/tmp/pip-5f09Ro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:32:29 INFO - Running setup.py (path:/tmp/pip-ssLaPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:32:29 INFO - Running setup.py (path:/tmp/pip-8y1Vee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:32:29 INFO - Running setup.py (path:/tmp/pip-e102kl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:32:29 INFO - Running setup.py (path:/tmp/pip-15jiAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:32:29 INFO - Running setup.py (path:/tmp/pip-GIGV1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:32:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:32:29 INFO - Running setup.py install for manifestparser 02:32:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:32:29 INFO - Running setup.py install for mozcrash 02:32:30 INFO - Running setup.py install for mozdebug 02:32:30 INFO - Running setup.py install for mozdevice 02:32:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:32:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:32:30 INFO - Running setup.py install for mozfile 02:32:30 INFO - Running setup.py install for mozhttpd 02:32:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:32:30 INFO - Running setup.py install for mozinfo 02:32:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:32:30 INFO - Running setup.py install for mozInstall 02:32:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:32:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:32:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:32:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:32:30 INFO - Running setup.py install for mozleak 02:32:30 INFO - Running setup.py install for mozlog 02:32:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:32:30 INFO - Running setup.py install for moznetwork 02:32:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:32:30 INFO - Running setup.py install for mozprocess 02:32:31 INFO - Running setup.py install for mozprofile 02:32:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:32:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:32:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:32:31 INFO - Running setup.py install for mozrunner 02:32:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:32:31 INFO - Running setup.py install for mozscreenshot 02:32:31 INFO - Running setup.py install for moztest 02:32:31 INFO - Running setup.py install for mozversion 02:32:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:32:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:32:31 INFO - Cleaning up... 02:32:31 INFO - Return code: 0 02:32:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:32:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:31 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 0x7fb8153f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa4f60>, '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 0x1fa5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa61d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1476351113.879051-1713229139', '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 02:32:31 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 02:32:31 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 02:32:31 INFO - Using env: {'DISPLAY': ':0', 02:32:31 INFO - 'HOME': '/home/cltbld', 02:32:31 INFO - 'LANG': 'en_US.UTF-8', 02:32:31 INFO - 'LANGUAGE': 'en_US:en', 02:32:31 INFO - 'LOGNAME': 'cltbld', 02:32:31 INFO - 'MAIL': '/var/mail/cltbld', 02:32:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:31 INFO - 'MOZ_NO_REMOTE': '1', 02:32:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:31 INFO - 'NO_EM_RESTART': '1', 02:32:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:31 INFO - 'PWD': '/builds/slave/test', 02:32:31 INFO - 'SHELL': '/bin/bash', 02:32:31 INFO - 'SHLVL': '1', 02:32:31 INFO - 'TERM': 'linux', 02:32:31 INFO - 'TMOUT': '86400', 02:32:31 INFO - 'USER': 'cltbld', 02:32:31 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476351113.879051-1713229139', 02:32:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:31 INFO - '_': '/tools/buildbot/bin/python'} 02:32:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:32:31 INFO - Running setup.py (path:/tmp/pip-ZFBH5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:32:31 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)) 02:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:32:31 INFO - Running setup.py (path:/tmp/pip-69xDgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:32:32 INFO - Running setup.py (path:/tmp/pip-Zy26a7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:32:32 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)) 02:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:32:32 INFO - Running setup.py (path:/tmp/pip-OFJhhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:32:32 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)) 02:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:32:32 INFO - Running setup.py (path:/tmp/pip-NLe7iQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:32:32 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)) 02:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:32:32 INFO - Running setup.py (path:/tmp/pip-dsjWtq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:32:32 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)) 02:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:32:32 INFO - Running setup.py (path:/tmp/pip-d6yCm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:32:32 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)) 02:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:32:32 INFO - Running setup.py (path:/tmp/pip-6U6pem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:32:32 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)) 02:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:32:32 INFO - Running setup.py (path:/tmp/pip-Mg1hYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:32:32 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)) 02:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:32:32 INFO - Running setup.py (path:/tmp/pip-qapg0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:32:32 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)) 02:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:32:32 INFO - Running setup.py (path:/tmp/pip-f4Mgb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:32:32 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)) 02:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:32:32 INFO - Running setup.py (path:/tmp/pip-o7lCeu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:32:32 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)) 02:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:32:32 INFO - Running setup.py (path:/tmp/pip-jTzPmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:32:32 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)) 02:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:32:32 INFO - Running setup.py (path:/tmp/pip-vfvUMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:32:32 INFO - Running setup.py (path:/tmp/pip-DaQzZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:32:32 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)) 02:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:32:32 INFO - Running setup.py (path:/tmp/pip-F2WmkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:32:33 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)) 02:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:32:33 INFO - Running setup.py (path:/tmp/pip-bqZP7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:32:33 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)) 02:32:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:32:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:32:33 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)) 02:32:33 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)) 02:32:33 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)) 02:32:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:32: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 02:32: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 02:32: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 02:32: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 02:32: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 02:32: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 02:32:35 INFO - Downloading blessings-1.6.tar.gz 02:32:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:32:35 INFO - Installing collected packages: blessings 02:32:35 INFO - Running setup.py install for blessings 02:32:35 INFO - Successfully installed blessings 02:32:35 INFO - Cleaning up... 02:32:35 INFO - Return code: 0 02:32:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:32:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:32:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:32:35 INFO - Reading from file tmpfile_stdout 02:32:35 INFO - Current package versions: 02:32:35 INFO - argparse == 1.2.1 02:32:35 INFO - blessings == 1.6 02:32:35 INFO - blobuploader == 1.2.4 02:32:35 INFO - docopt == 0.6.1 02:32:35 INFO - functools32 == 3.2.3-2 02:32:35 INFO - jsonschema == 2.5.1 02:32:35 INFO - manifestparser == 1.1 02:32:35 INFO - mozInstall == 1.12 02:32:35 INFO - mozcrash == 0.17 02:32:35 INFO - mozdebug == 0.1 02:32:35 INFO - mozdevice == 0.48 02:32:35 INFO - mozfile == 1.2 02:32:35 INFO - mozhttpd == 0.7 02:32:35 INFO - mozinfo == 0.9 02:32:35 INFO - mozleak == 0.1 02:32:35 INFO - mozlog == 3.4 02:32:35 INFO - moznetwork == 0.27 02:32:35 INFO - mozprocess == 0.23 02:32:35 INFO - mozprofile == 0.28 02:32:35 INFO - mozrunner == 6.12 02:32:35 INFO - mozscreenshot == 0.1 02:32:35 INFO - mozsystemmonitor == 0.3 02:32:35 INFO - moztest == 0.7 02:32:35 INFO - mozversion == 1.4 02:32:35 INFO - psutil == 3.1.1 02:32:35 INFO - requests == 1.2.3 02:32:35 INFO - wsgiref == 0.1.2 02:32:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:32:35 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')]} 02:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:35 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')]} 02:32:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:35 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 0x7fb8153f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa4f60>, '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 0x1fa5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa61d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1476351113.879051-1713229139', '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 02:32:35 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 02:32:35 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 02:32:35 INFO - Using env: {'DISPLAY': ':0', 02:32:35 INFO - 'HOME': '/home/cltbld', 02:32:35 INFO - 'LANG': 'en_US.UTF-8', 02:32:35 INFO - 'LANGUAGE': 'en_US:en', 02:32:35 INFO - 'LOGNAME': 'cltbld', 02:32:35 INFO - 'MAIL': '/var/mail/cltbld', 02:32:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:35 INFO - 'MOZ_NO_REMOTE': '1', 02:32:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:35 INFO - 'NO_EM_RESTART': '1', 02:32:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:35 INFO - 'PWD': '/builds/slave/test', 02:32:35 INFO - 'SHELL': '/bin/bash', 02:32:35 INFO - 'SHLVL': '1', 02:32:35 INFO - 'TERM': 'linux', 02:32:35 INFO - 'TMOUT': '86400', 02:32:35 INFO - 'USER': 'cltbld', 02:32:35 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476351113.879051-1713229139', 02:32:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:35 INFO - '_': '/tools/buildbot/bin/python'} 02:32:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:35 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)) 02:32:35 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)) 02:32:35 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)) 02:32:35 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)) 02:32:35 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)) 02:32:35 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)) 02:32:35 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)) 02:32:35 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)) 02:32:35 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)) 02:32:35 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)) 02:32:35 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)) 02:32:35 INFO - Cleaning up... 02:32:35 INFO - Return code: 0 02:32:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:32:35 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')]} 02:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:35 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')]} 02:32:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:35 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 0x7fb8153f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa4f60>, '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 0x1fa5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa61d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1476351113.879051-1713229139', '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 02:32:35 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 02:32:35 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 02:32:35 INFO - Using env: {'DISPLAY': ':0', 02:32:35 INFO - 'HOME': '/home/cltbld', 02:32:35 INFO - 'LANG': 'en_US.UTF-8', 02:32:35 INFO - 'LANGUAGE': 'en_US:en', 02:32:35 INFO - 'LOGNAME': 'cltbld', 02:32:35 INFO - 'MAIL': '/var/mail/cltbld', 02:32:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:35 INFO - 'MOZ_NO_REMOTE': '1', 02:32:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:35 INFO - 'NO_EM_RESTART': '1', 02:32:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:35 INFO - 'PWD': '/builds/slave/test', 02:32:35 INFO - 'SHELL': '/bin/bash', 02:32:35 INFO - 'SHLVL': '1', 02:32:35 INFO - 'TERM': 'linux', 02:32:35 INFO - 'TMOUT': '86400', 02:32:35 INFO - 'USER': 'cltbld', 02:32:35 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476351113.879051-1713229139', 02:32:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:35 INFO - '_': '/tools/buildbot/bin/python'} 02:32:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:32:35 INFO - Cleaning up... 02:32:35 INFO - Return code: 0 02:32:35 INFO - Running post-action listener: _resource_record_post_action 02:32:35 INFO - Running post-action listener: _start_resource_monitoring 02:32:36 INFO - Starting resource monitoring. 02:32:36 INFO - [mozharness: 2016-10-13 09:32:36.017473Z] Finished create-virtualenv step (success) 02:32:36 INFO - [mozharness: 2016-10-13 09:32:36.017985Z] Running install step. 02:32:36 INFO - Running pre-action listener: _resource_record_pre_action 02:32:36 INFO - Running main action method: install 02:32:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:32:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:32:36 INFO - Reading from file tmpfile_stdout 02:32:36 INFO - Detecting whether we're running mozinstall >=1.0... 02:32:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:32:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:32:36 INFO - Reading from file tmpfile_stdout 02:32:36 INFO - Output received: 02:32:36 INFO - Usage: mozinstall [options] installer 02:32:36 INFO - Options: 02:32:36 INFO - -h, --help show this help message and exit 02:32:36 INFO - -d DEST, --destination=DEST 02:32:36 INFO - Directory to install application into. [default: 02:32:36 INFO - "/builds/slave/test"] 02:32:36 INFO - --app=APP Application being installed. [default: firefox] 02:32:36 INFO - mkdir: /builds/slave/test/build/application 02:32:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:32:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:32:52 INFO - Reading from file tmpfile_stdout 02:32:52 INFO - Output received: 02:32:52 INFO - /builds/slave/test/build/application/firefox/firefox 02:32:52 INFO - Running post-action listener: _resource_record_post_action 02:32:52 INFO - [mozharness: 2016-10-13 09:32:52.475961Z] Finished install step (success) 02:32:52 INFO - [mozharness: 2016-10-13 09:32:52.476205Z] Running run-tests step. 02:32:52 INFO - Running pre-action listener: _resource_record_pre_action 02:32:52 INFO - Running main action method: run_tests 02:32:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:32:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:32:52 INFO - Python 2.7.3 02:32:52 INFO - Return code: 0 02:32:52 INFO - grabbing minidump binary from tooltool 02:32:52 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')]} 02:32:52 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 0x1fa4f60>, '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 0x1fa5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa61d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:32:52 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 02:32:52 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 02:32:52 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 02:32:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:32:52 INFO - Return code: 0 02:32:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:32:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:32:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:32:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:32:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:32:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DwyAgT8-RjmwDoHdRS0XeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:32:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DwyAgT8-RjmwDoHdRS0XeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:32:52 INFO - Using env: {'DISPLAY': ':0', 02:32:52 INFO - 'HOME': '/home/cltbld', 02:32:52 INFO - 'LANG': 'en_US.UTF-8', 02:32:52 INFO - 'LANGUAGE': 'en_US:en', 02:32:52 INFO - 'LOGNAME': 'cltbld', 02:32:52 INFO - 'MAIL': '/var/mail/cltbld', 02:32:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:32:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:32:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:52 INFO - 'MOZ_NO_REMOTE': '1', 02:32:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:32:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:52 INFO - 'NO_EM_RESTART': '1', 02:32:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:52 INFO - 'PWD': '/builds/slave/test', 02:32:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:32:52 INFO - 'SHELL': '/bin/bash', 02:32:52 INFO - 'SHLVL': '1', 02:32:52 INFO - 'TERM': 'linux', 02:32:52 INFO - 'TMOUT': '86400', 02:32:52 INFO - 'USER': 'cltbld', 02:32:52 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476351113.879051-1713229139', 02:32:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:52 INFO - '_': '/tools/buildbot/bin/python'} 02:32:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DwyAgT8-RjmwDoHdRS0XeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:32:52 INFO - mozversion application_buildid: 20161013010023 02:32:52 INFO - mozversion application_changeset: 6cb3fe45e73128a9683523c21849716fdbfbf4b5 02:32:52 INFO - mozversion application_display_name: Nightly 02:32:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:32:52 INFO - mozversion application_name: Firefox 02:32:52 INFO - mozversion application_remotingname: firefox 02:32:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 02:32:52 INFO - mozversion application_vendor: Mozilla 02:32:52 INFO - mozversion application_version: 52.0a1 02:32:52 INFO - mozversion platform_buildid: 20161013010023 02:32:52 INFO - mozversion platform_changeset: 6cb3fe45e73128a9683523c21849716fdbfbf4b5 02:32:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 02:32:52 INFO - mozversion platform_version: 52.0a1 02:32:52 INFO - using testdate: 1476351172 02:32:52 INFO - actual date: 1476351172 02:32:52 INFO - starting webserver on 'localhost:42832' 02:32:52 INFO - SUITE-START | Running 2 tests 02:32:52 INFO - TEST-START | dromaeo_css 02:32:52 INFO - operating with platform_type : linux_ 02:32:52 INFO - Initialising browser for dromaeo_css test... 02:32:52 INFO - TEST-INFO | started process 8043 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxq3YyL/profile http://localhost:42832/getInfo.html) 02:32:57 INFO - PROCESS | 8043 | __metrics Screen width/height:1600/1200 02:32:57 INFO - PROCESS | 8043 | colorDepth:24 02:32:57 INFO - PROCESS | 8043 | Browser inner width/height: 1024/697 02:32:57 INFO - PROCESS | 8043 | __metrics 02:32:57 INFO - PROCESS | 8043 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:32:57 INFO - PROCESS | 8043 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:32:59 INFO - TEST-INFO | 8043: exit 0 02:32:59 INFO - Browser initialized. 02:32:59 INFO - Running cycle 1/1 for dromaeo_css test... 02:32:59 INFO - TEST-INFO | started process 8126 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxq3YyL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:33:11 INFO - PROCESS | 8126 | RSS: Main: 174780416 02:33:11 INFO - PROCESS | 8126 | 02:34:02 INFO - PROCESS | 8126 | 1476351242435 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] 02:36:17 INFO - PROCESS | 8126 | Cycle 1(1): loaded http://localhost:42832/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42832/tests/dromaeo/cssquery-ext.html) 02:36:18 INFO - PROCESS | 8126 | RSS: Main: 287866880 02:36:18 INFO - PROCESS | 8126 | 02:39:21 INFO - PROCESS | 8126 | Cycle 1(1): loaded http://localhost:42832/tests/dromaeo/cssquery-ext.html (next: http://localhost:42832/tests/dromaeo/cssquery-jquery.html) 02:39:21 INFO - PROCESS | 8126 | RSS: Main: 275574784 02:39:21 INFO - PROCESS | 8126 | 02:42:24 INFO - PROCESS | 8126 | Cycle 1(1): loaded http://localhost:42832/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42832/tests/dromaeo/cssquery-mootools.html) 02:42:24 INFO - PROCESS | 8126 | RSS: Main: 256581632 02:42:24 INFO - PROCESS | 8126 | 02:45:26 INFO - PROCESS | 8126 | Cycle 1(1): loaded http://localhost:42832/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42832/tests/dromaeo/cssquery-prototype.html) 02:45:27 INFO - PROCESS | 8126 | RSS: Main: 218955776 02:45:27 INFO - PROCESS | 8126 | 02:48:30 INFO - PROCESS | 8126 | Cycle 1(1): loaded http://localhost:42832/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42832/tests/dromaeo/cssquery-yui.html) 02:48:31 INFO - PROCESS | 8126 | RSS: Main: 219856896 02:48:31 INFO - PROCESS | 8126 | 02:51:34 INFO - PROCESS | 8126 | Cycle 1(1): loaded http://localhost:42832/tests/dromaeo/cssquery-yui.html (next: http://localhost:42832/tests/dromaeo/cssquery-dojo.html) 02:51:34 INFO - PROCESS | 8126 | RSS: Main: 307572736 02:51:34 INFO - PROCESS | 8126 | 02:51:34 INFO - PROCESS | 8126 | __start_tp_report 02:51:34 INFO - PROCESS | 8126 | _x_x_mozilla_page_load 02:51:34 INFO - PROCESS | 8126 | _x_x_mozilla_page_load_details 02:51:34 INFO - PROCESS | 8126 | |i|pagename|runs| 02:51:34 INFO - PROCESS | 8126 | |0;dojo.html;2602.492513959778;2618.869056547172;2651.310659228601;2665.13383150476;2671.532481815683;4617.515160908107;4652.981620722596;4703.200455922492;4725.3148293497425;4776.80892764289;4680.859574212771;4706.599939005188;4742.264948932921;4743.051389722061;4789.18583840747;4217.493900731916;4221.535631080578;4265.338872474771;4274.529801721824;4290.377895205193;4009.3384591542363;4421.801018954155;4453.554644535553;4497.775111244425;4544.97727511362;4281.721688090295;4438.068005718771;4441.200583894898;4504.954950450503;4548.863534093966;4337.457817772778;4355.128974205171;4375.518692943773;4391.231534481485;4410.669199810027;4348.826046958149;4349.26062569364;4357.063231405232;4401.823927042915;4415.028693687384;4751;4758.500357462452;4764.952350476486;4786.234202527614;4806.375171227753;4950.183219768734;5014.774335154927;5023.874403139951;5079.111155547765;5109.310243117169;5116.053530096944;5119.25770763241;5136.024155410498;5161.66449180802;5178.922316165261;4771.952280477186;4793.448753393404;4800.879978000508;4820.807167713322;4873.829415970424;5077.39071311445;5129.9230511542355;5253.737313134328;5255.658382205221;5265.657732247391;4990.3762029746285;5017.874553136201;5033.194688849767;5041.672291301127;5103.387593488805;5127.307813445212;5127.897442051138;5131.640785145004;5189.481051894781;5192.584593232532;5044.717024303347;5054.393472783289;5062.924056139161;5154.587632989352;5159.922601160911;4848.272759086095;4893.363862697826;4931.9753401232765;5064.34163558735;5076.111680455905;4158.750474971512;4162.375643653416;4168.520620128664;4171.124063946605;4213;3662.1577037281572;3665.780053196763;3674.9448758268645;3701.4262789267705;3710.07248187953;4297.183535128315;4397.736135831797;4404.4494438195225;4406.383106365111;4438.955610443854;4935.457099719028;4950.603951683856;4991.850244492671;5008.524190201925;5025.396952365666;4465.285554311295;4475.977620111878;4483.798229079699;4523.638108951276;4526.728396296233;4598.931016034762;4608.470025947059;4614.676972611885;4619.2378257587125;4669.696469729457;4727.503612120678;4789.616830653609;4826.444958829779;4864.075825593126;4908.361912951294;5137.897242055213;5153.639245252796;5163.8192663258105;5199.116150254541;5201.349831271091;4823.3729615149805;4883.047805678001;4884.755762211804;4885.047415754036;4940.530649588283;4879.902401952012;4925.6305777066145;5020;5084.586605514574;5088.033273677989;5106;5165.715885626327;5169.7673604687125;5169.948300517097;5227.372715274039;5020.648554601143;5021.171506701354;5021.748912554431;5030.144875371268;5091.541761241506;4827.275908613736;4883.731394773322;5008.824691135793;5027.296178535081;5074.923876141787;4834.105690447279;4838.637102217418;4883.340748998839;4903.803847846046;4961.7271050092595;4986.326845875906;4993.201087825931;4999.300097986212;4999.375078115236;5063.3417655704525;4737.810487580458;4807.807687692453;4827.42070951488;4835.58897493717;4879.024195161053 02:51:34 INFO - PROCESS | 8126 | |1;ext.html;540.4460428061237;546.0553242889803;552.748499432758;553.2641586689703;554.8917960997604;27391.589126163097;29947.101586952373;30120.246993825167;30144.397112057744;38090.428643570296;36908;40638.18723625526;40665.59334406663;40673.796631016805;40692.796536017355;7468.701251949929;7607.80980475487;7612.010438642968;7613.581253031081;7618.162002179756;7537.585432801194;7620.618969051553;7625.504342217766;7626.923730762677;7627;7632.5038872473115;7676;7681.3086822186;7682.308592226698;7686.077670679526;7611.733589324374;7645.808854778619;7649.655765490511;7658.119316278616;7658.693652253904;7513;7555.54666719993;7555.811104722426;7566.167721550625;7572.659230334593;38156.42765358522;38520;38520.614793851986;38545.80727096375;38614.80692596547;3138.1840721412595;3163.9050828475183;3189.7926634768664;3286.5070239464035;3523.2248905241063;28237.15288541347;28349.716502834915;28827.85586072077;29101.854490727623;29291.560626590617;3410.334984677964;3467.4105402081705;3496.5454490916272;3557.94663080054;3565.982170089159;250447;251026;251399;252164.99999999817;252225;28443.146705598865;29219.269518262212;29460.410791784045;49510;49925.75037124791;31374.686253137632;31397;31434.84282578618;31447.52828707571;31469.8426507866;13069.673258168621;13183.604491865259;13229.801552976713;13242.668933276553;13250.403731831899;11432.085433165326;11498.77002459963;11551.133664974992;11551.653450396501;11567.652970410902;7712.383009359238;7720.575368354682;7808.609569521501;7816.7264145754625;7821.843563128819;3082.2756652186717;3086.8147911125407;3089.6910308968922;3151.2752067024253;3166.6358368787883;794.2454668065361;832.8292699996487;897.7890195804111;910.2159766856902;915.8168366326761;25999;26816.32959175997;27292.181234562995;27428.862855685595;27581.172564823086;914.5107367558325;917.1058218237299;937.9671711490201;967.8596603492454;1002.3284399452384;13779.555111222195;14271.78592321116;14395.640108997359;14438.639034024234;15283.847161528241;355642;355860;356301;356618;357119;47723;47960.5203947963;48125.518744812805;48238;48279;1055.229682331902;1115.8995690387742;1118.0440723181562;1189.8334233207358;1217.3852204636778;26020.21939341823;27970.696043370037;30501.23746906345;30780.230494236926;30782.538261926537;45168.32247516224;45742.313865291384;45778.77110614559;45859.54140458553;45918.09696175862;326312;327620;330273;330942;333156;24108.87945560261;24447.633285500375;24532;25607.103751368613;25609.23172304834;40020.39969400403;40310.596894031856;40511.594884050784;40700;41520.792396037825;33448.49827252642;34645.826770866996;34752.826235869674;34752.957411277705;35610.46584301186;34092.31815363629;34503;34841.825790870884;35003.47494787631;35015;33763.83118084394;34073;34371.828140859136;34636.480452792726;34787.478187826695;28958;31362.372752545278;31390.52914206243;31469.52795708112;31556.684433156293;24500.877495612407;24589.38526536851;24723.134690285755;24752.628710568995;24917.750822492268 02:51:34 INFO - PROCESS | 8126 | |2;jquery.html;348.19566800690393;364.45513956634835;376.22873110124243;377.2116276981109;386.1581751781118;12226.38868056597;12598;12950.474657441802;13140.605781826536;17272.654546909056;16528.66942661146;16601.584960375996;17320.653586928252;17474.47576572705;17475.300987960498;4816.735079570613;4830.251311046776;5052.444231134572;5079.873003174932;5143.871403214931;5365.624406291561;5403;5407.432219616942;5407.891842163174;5409.107497262967;3383.8308084595797;3597.0647631615707;3635.000374896898;5662.150677398382;5724.9427505724825;5726.971365143189;5733.226014488033;5737.627054241482;5739.282589676291;5743.138529220609;4976.377952755905;5176.844694659167;5196.480351964811;5202.661826981234;5203.531682148587;12289;12515.937420312932;12524.874751252462;17591.472255832345;19852.404427867186;1822.8723989320754;1889.3859495663964;1966.3019628031986;2091.1008266445424;2209.4255493571627;8998;9117.361784675075;9140.360174787767;9690.90309096907;9694.17599504043;1672.5818545363659;1704.5653358393654;1718.3470281293153;1781.153951872863;1792.7848658160974;68997.65501172462;69049.65475172643;69169.65415172992;69663;70947.64526177388;9793.510324483746;9919.355241909398;10024.699259022242;10273.229507786946;10276.177905767521;14139.717205655828;14162.575122746333;14179.716405671828;14185.361658725382;14185.574432767033;6530.542861999709;6791.456683465311;6913.2049814270995;6925.688344024531;7142.821429464201;6439.903401448982;6473.996530537775;6657.633830139292;6658.500612454085;6661.4004739573675;4271.807768650356;4297.419848320499;4329.285667864767;4329.805158767863;4445.955540444619;1785.839064855199;1813.718873574598;1839.3194518028415;1893.6686079936233;1905.2759951218725;739.5673530984327;815.604431850552;861.8060936289285;861.9870701939476;901.5852707754375;16337.509874703777;16773.077480738433;17186.570335741457;17686.204120814593;17788.199531021135;842.2756429470651;846.094678693804;850.9659613615386;858.9742307730778;898.1736802142045;9280.443173409481;9565.569549370295;9863.457509836884;9866.358686685342;9989.900100999042;345138;348863;349947;352514;353458;74756;75495.5223880597;75565.24434755692;77223;77428.61285693536;876.8684697295457;880.1086553895416;896.9192772650363;897.4121950122681;900.7567956651667;14875.47935822241;15040.254447867917;15356.38574457054;15613.453529126426;15751.606209844846;36003.81998089993;36004.27991440209;37251;37411.81294093621;38161.6183838158;45284.54715452803;46865.76567117142;47234.76382618065;49024.26463602977;49110;7203.495755297288;7692.574240271648;7876.684932602631;7952.244536768998;8011;8373.455725377831;10693.679189624323;11903.82144267854;12069.456874440846;12215.26708397499;10074.345167564084;10480.371177729361;10510.737231569272;10599.841002384816;10621.203409744145;9885.703428897144;10178.592856285666;10254.846177307198;10294.433806140734;10463.633772818219;10260.435676037889;10346.741331466774;10361.63734269297;10442.269041167045;10861.782764344827;7656.272654097852;7725.806854828675;7766.650500727368;7839.176886426843;8119.066307374727;9396;9847.60609575609;9948.154406875206;10215.642452514126;10387.53256103462 02:51:34 INFO - PROCESS | 8126 | |3;mootools.html;1236.289133748094;1346.6229455752386;1398.2100113435908;1442.689821688337;1643.7945256842888;6731.596104233749;7702.383809295257;7903.6048197590035;7922.128565857758;8175.46859454135;8009.959950200241;8071.394645401589;8080.555569443678;8088.433809633313;8094;2230.542738738559;2257.8532395394327;2260.276711452336;2263.649134384173;2264.479169790949;2157.7626461089267;2205.2391924785925;2230.10795681727;2230.1748353109374;2232.073689418889;2178.2485042660255;2219.8002179803893;2225.788550087739;2228.487447886987;2251.8536295140843;2160.611090003799;2182.127149140341;2182.4871155278497;2183.3340831046526;2185.5082606413507;2135.4020874155262;2139.411661793004;2140.9464763380884;2142.432255452291;2143.3677065265783;7964.203579642048;7990.4007199460275;8037.959810200911;8041.075276343178;8073.717419890276;4693.460252071021;4726.692764970266;4858.344123543312;4867.7079375237245;4883.99878025004;3013.5027720426106;3066.4633689104317;3113.9844300778577;3119.859606317721;3122.8438578071004;909.7270818754347;915.890093188815;928.1321963963716;953.3374304858127;965.4303960663242;10850.186236032328;10903.945480272627;10916.617918372818;10917.508712107974;10947.616833410872;4121.877233224892;4164.271252530795;4216.852410165629;4227.87316380509;4287.12114016632;8598.699045533376;8636.136386361439;8639.524826134497;8646.135386461303;8653.048164701877;4755.619550435957;4758.881027974259;4768.427788665383;4773.11697335994;4773.260144677581;3597.766145200606;3794.6964242860504;3858.5176852893387;3894.279558281727;4389.4513185851765;2996.8501574921165;3404.4042292599192;3414.4536874100027;3446.965530344715;3457.930841383158;1014.1886490807325;1054.3937236089125;1071.7856428714288;1073.7261998190568;1090.6946055104584;690.5545922879814;748.827769612992;824.6041899888087;828.5194587139445;858.5406807358033;5431.321084864392;5509.00837849183;5539.667619942817;5565.860853478695;5654.9151762723595;426.24767285740694;432.75981830084606;434.1729006243112;437.1846506265855;438.3753151758731;3719.814009299578;3795.9430608540893;3800.4869342638945;3842.6733727633464;3871.2257548490416;9605.087516685904;9885.851712224323;9956.950215248877;9967.053129952643;9987.400755954666;8716.08481109487;9132.360734748636;9163.49600771964;9894.80210395788;9955.402675839472;7015.719371225094;7181.174164970991;7192.208857025723;7193.2447093055525;7197.532160409557;5570.359408668055;5575.135853942646;5682.6306290091015;5758.2514273144225;5811.186433899173;9139.131782480654;9178.311626627896;9188.127127922837;9209.539523023956;9268.860967085364;8831.823363532565;9235.630574776933;9278.304127190622;9433.52832358393;9433.52832358393;6056.636601803906;6239.438450539473;6670;6796.456283497408;6848.8972665409065;7783.688652453839;7818.140004599376;7824.5305281681;7831.569263690551;7858.764237072897;6787.490938179755;6869.828254293682;6953.130858642669;6982.860342793014;7106.751263705745;6817.897731533932;6843.349881761224;6867.416269617139;6896.965515172392;6921.792346229621;6360.4911607072245;6490.091387205889;6554.80335589933;6562.606243625398;6602.471802255712;4548.772561371852;4553.795079221377;4641.489436161952;4673;4798.976005119952;4754.881127971828;4755.1916174251155;4842.297866809364;4846.248831431134;4855.101806165871 02:51:34 INFO - PROCESS | 8126 | |4;prototype.html;300.8991987684126;301.5296138024682;307.2334525359229;308.14028859482045;309.72434533265414;4730.19586670266;4751.738654374008;4771.570558649721;4781.306710526971;4819.469858315591;4721.3390125382475;4750.16872047392;4751.477337492873;4754;4760.166970780108;3554.377983852835;3625.963740362602;3663.7069034477313;3697.5932647408763;3730.6642402183797;3728.9254214915823;3731.3097077040834;3733.253349330131;3733.328000959826;3739.7008239340926;3700.2414505026404;3714.1828797664607;3714.3685573452576;3731.589525152231;3742.307673080475;3522.823858807062;3599.2981368633127;3668.468072129553;3724.2737666155112;3736.7010639148803;3309.3381323735107;3310.2386451116136;3310.7682462227654;3311.784733992283;3313.4698448248164;4595.747233902134;4601.240795268776;4608.539146085398;4613.215753321943;4617.584417402416;4001.919961600781;4185;4240.109576988805;4242.53332133465;4243.681723870722;4908.509149085063;4919.409670839486;4919.975400123012;4923.18767403378;4927.852164435073;3512.7189824813954;3520.507129001942;3534.204803919123;3542.5040494330815;3572;4999.850004499871;5152.227165925104;5187.818426355059;5211;5211.63849317192;3575.713942884563;3587.695045921126;3598.3702852000797;3600.4059330210744;3606.4770608261656;3637.2361804021452;3639.7816131032223;3642.7996460194413;3652.433872749728;3658.5061016762397;4166.854160104382;4173.787892417024;4180;4184.267753143188;4184.476940382452;4640.489546149921;4943.233798761198;4947.975260123676;4948.257761335756;4985.651004429655;1263.829383033297;1281.8461784585909;1282.1473719976111;1284.8072789081712;1285.8778416050461;767.1944458318743;801.2828518475932;808.7129069180473;809.1301850510724;811.7929927868356;4271.1671224111;4301.913961720748;4420.845270415584;4463.598276155161;4465.575770301816;5083.669561478566;5088;5107.719075450812;5119.820806271762;5131.8966422218655;4473.3066374711325;4485.753283569435;4489.9775501122285;4504.459464864237;4507.346434767006;2621;2696.177665811946;2718.1573712149298;2722.8366298022183;2725.9863700681767;4816.892114813612;4818.10864989978;4821.951780482221;4830.478399304208;4831.4202295724735;5033.974830125826;5154.170269554329;5211.326015159304;5217.373915130132;5229.189475631283;4778.761061946958;4806.44725856524;4836.396884321133;4844.297576851407;4869.488703686133;5036.219385995177;5045.520675535819;5054.3176671150395;5054.393472783289;5056.17977528097;4767.761611919321;4899.118158731462;4913.263010548446;4925.45819959797;4928.85213443583;4765.8570242892765;4785.425748910153;4785.569298763128;4798.136335459651;4810.182269014206;3573.6426357365094;3577.783553591687;3586.3006713691625;3592.7485076045473;3593.3531964246686;5025.974870125626;5052.267421223975;5072.188449848154;5074.289599456005;5090.574639101058;4751.928721069117;4882.60939124862;4889.168841297059;4893.266010098514;4919.139150648551;4866.659333846738;4885.706857588556;4899.681520701143;4900.583450406612;4906.337644417958;4829.613630909589;4835.371401717754;4840.854774356775;4848.151573474698;4867.780949857194;4691.460482044608;4701.271302948048;4810.807567697253;4879.4876537963;4918.975405122951;4693.225617773166;4824.565789079;4827.61379089679;4832.975835120802;4839.612830973584 02:51:34 INFO - PROCESS | 8126 | |5;yui.html;600.2526854066687;690.6408667492904;693.0470602920982;699.7410957945558;725.6190499987503;13124.278164700938;13769;13939.512117075905;13960.930195349021;14002.019858609901;12991.610251692464;13388.062835601511;13507.324633768321;13510.392032358543;13570.117942333742;758.067576880436;773.6673230510878;781.0510230070491;781.1173374087274;781.7811012916364;622.7353374815708;628.6982248520712;762.2910693055456;776.926192011758;789.1871372486348;830.6801881275723;831.2352635575255;832.1262674192104;832.8459235041506;832.9125441828612;822.5023860564362;825.0965193113591;825.3809642767924;825.4469505431375;825.7522743177083;483.05080516784335;489.01219536536354;581.9243498345188;593.6497466494745;607.2439812433548;12535.24788512692;12541.623751287476;12542.937285313606;12561.685957851036;12628.179168354027;11520.423978801027;12083.57707480234;12112.939435302855;12212.450439730233;12743.36283185837;9772.364796288219;9828.508574571315;11464.65606031812;11748.353840538766;11799.764004719858;3988.660963818079;4068.1863627274665;4091.284025295561;4142.979285103585;4254.1279037797485;50979;53038.20442693324;53085.46914530844;58906.41093589095;59315.70342148305;9989.200863930868;10235.692929212135;10252.23108266868;10287.485625718684;10384.11735002518;18323.450296491126;18478.07609619514;18505.81494185068;18546;18654.720179197324;6804.08144900442;6811.659417029129;6860.907423235961;6946.6179360134665;7125.786226413215;3679.5584529856587;3721.7394782364972;3735.084904198489;3802.16352402471;3826.2730081284467;3019.6829332920165;3119.1890108571934;3141.3246152076954;3141.8429078545983;3147.5750773645723;522.7020598258956;527.8759491519489;535.130413078747;535.4725595288637;541.2287490326348;517.76700484782;547.5045084198806;558.6843433460164;579.2990481517411;611.2695329081794;7902.841943161219;8357.414980951275;8420.53687047206;8428.957855210685;8646.870296945552;522.647213131135;539.2369796737572;571.2958432791193;608.0241212853396;630.3066626710673;4013.6115518566335;4189.601987811153;4200.5799420058365;4238.173556156582;4346.6522678185665;73271;76138.23861761311;76160.23839761532;89312;89987.10012899787;65968.6701566489;67713;75263.62368188234;78585.60707196542;78610.6069469649;59848.40151598428;62961.68519157375;67423.3257667417;68868;69232;8243.25810677018;9010;9051.230645395215;9110.498922559324;9233.861492077489;30324.84837575798;31481.685183147874;36466.08834779152;40043.79978100091;43115;35276.29447411089;43410;55945.44054559402;56556;58019.41980580309;11162.665120046411;11269;11340.376279304717;11616.535338586362;11643.88356116462;12680.6829829255;13132.474701012236;13431.395587198404;13681.863181368059;14152.575422737335;11782.469788859351;12278.631641050782;12451;12688.74622507563;12811.807822882478;9280.489573073546;11703.590374336858;12142.453589588666;12411.813822792485;12586.370681466073;11253.437328133397;11808.527658893892;12345.197562158432;12439;12497.125201235825;9616.9038309616;9789.412635241908;9985.505073224313;10026.197904167795;10264.332818366782;8922.643094276156;9086.727398178065;9701.708948731268;10030.498475076363;10309.814371347391 02:51:34 INFO - PROCESS | 8126 | __end_tp_report 02:51:34 INFO - PROCESS | 8126 | __start_cc_report 02:51:34 INFO - PROCESS | 8126 | _x_x_mozilla_cycle_collect,1087 02:51:34 INFO - PROCESS | 8126 | __end_cc_report 02:51:34 INFO - PROCESS | 8126 | __startTimestamp1476352294488__endTimestamp 02:51:34 INFO - PROCESS | 8126 | 02:51:34 INFO - PROCESS | 8126 | ------- Summary: start ------- 02:51:34 INFO - PROCESS | 8126 | Number of tests: 6 02:51:34 INFO - PROCESS | 8126 | 02:51:34 INFO - PROCESS | 8126 | [#0] dojo.html Cycles:165 Average:4703.40 Median:4834.11 stddev:508.56 (10.5%) stddev-sans-first:482.67 02:51:34 INFO - PROCESS | 8126 | Values: 2602.5 2618.9 2651.3 2665.1 2671.5 4617.5 4653.0 4703.2 4725.3 4776.8 4680.9 4706.6 4742.3 4743.1 4789.2 4217.5 4221.5 4265.3 4274.5 4290.4 4009.3 4421.8 4453.6 4497.8 4545.0 4281.7 4438.1 4441.2 4505.0 4548.9 4337.5 4355.1 4375.5 4391.2 4410.7 4348.8 4349.3 4357.1 4401.8 4415.0 4751.0 4758.5 4765.0 4786.2 4806.4 4950.2 5014.8 5023.9 5079.1 5109.3 5116.1 5119.3 5136.0 5161.7 5178.9 4772.0 4793.4 4800.9 4820.8 4873.8 5077.4 5129.9 5253.7 5255.7 5265.7 4990.4 5017.9 5033.2 5041.7 5103.4 5127.3 5127.9 5131.6 5189.5 5192.6 5044.7 5054.4 5062.9 5154.6 5159.9 4848.3 4893.4 4932.0 5064.3 5076.1 4158.8 4162.4 4168.5 4171.1 4213.0 3662.2 3665.8 3674.9 3701.4 3710.1 4297.2 4397.7 4404.4 4406.4 4439.0 4935.5 4950.6 4991.9 5008.5 5025.4 4465.3 4476.0 4483.8 4523.6 4526.7 4598.9 4608.5 4614.7 4619.2 4669.7 4727.5 4789.6 4826.4 4864.1 4908.4 5137.9 5153.6 5163.8 5199.1 5201.3 4823.4 4883.0 4884.8 4885.0 4940.5 4879.9 4925.6 5020.0 5084.6 5088.0 5106.0 5165.7 5169.8 5169.9 5227.4 5020.6 5021.2 5021.7 5030.1 5091.5 4827.3 4883.7 5008.8 5027.3 5074.9 4834.1 4838.6 4883.3 4903.8 4961.7 4986.3 4993.2 4999.3 4999.4 5063.3 4737.8 4807.8 4827.4 4835.6 4879.0 02:51:34 INFO - PROCESS | 8126 | 02:51:34 INFO - PROCESS | 8126 | [#1] ext.html Cycles:180 Average:44932.89 Median:19056.62 stddev:83207.13 (436.6%) stddev-sans-first:83373.79 02:51:34 INFO - PROCESS | 8126 | Values: 540.4 546.1 552.7 553.3 554.9 27391.6 29947.1 30120.2 30144.4 38090.4 36908.0 40638.2 40665.6 40673.8 40692.8 7468.7 7607.8 7612.0 7613.6 7618.2 7537.6 7620.6 7625.5 7626.9 7627.0 7632.5 7676.0 7681.3 7682.3 7686.1 7611.7 7645.8 7649.7 7658.1 7658.7 7513.0 7555.5 7555.8 7566.2 7572.7 38156.4 38520.0 38520.6 38545.8 38614.8 3138.2 3163.9 3189.8 3286.5 3523.2 28237.2 28349.7 28827.9 29101.9 29291.6 3410.3 3467.4 3496.5 3557.9 3566.0 250447.0 251026.0 251399.0 252165.0 252225.0 28443.1 29219.3 29460.4 49510.0 49925.8 31374.7 31397.0 31434.8 31447.5 31469.8 13069.7 13183.6 13229.8 13242.7 13250.4 11432.1 11498.8 11551.1 11551.7 11567.7 7712.4 7720.6 7808.6 7816.7 7821.8 3082.3 3086.8 3089.7 3151.3 3166.6 794.2 832.8 897.8 910.2 915.8 25999.0 26816.3 27292.2 27428.9 27581.2 914.5 917.1 938.0 967.9 1002.3 13779.6 14271.8 14395.6 14438.6 15283.8 355642.0 355860.0 356301.0 356618.0 357119.0 47723.0 47960.5 48125.5 48238.0 48279.0 1055.2 1115.9 1118.0 1189.8 1217.4 26020.2 27970.7 30501.2 30780.2 30782.5 45168.3 45742.3 45778.8 45859.5 45918.1 326312.0 327620.0 330273.0 330942.0 333156.0 24108.9 24447.6 24532.0 25607.1 25609.2 40020.4 40310.6 40511.6 40700.0 41520.8 33448.5 34645.8 34752.8 34753.0 35610.5 34092.3 34503.0 34841.8 35003.5 35015.0 33763.8 34073.0 34371.8 34636.5 34787.5 28958.0 31362.4 31390.5 31469.5 31556.7 24500.9 24589.4 24723.1 24752.6 24917.8 02:51:34 INFO - PROCESS | 8126 | 02:51:34 INFO - PROCESS | 8126 | [#2] jquery.html Cycles:180 Average:22811.71 Median:24865.25 stddev:58058.20 (233.5%) stddev-sans-first:58196.57 02:51:34 INFO - PROCESS | 8126 | Values: 348.2 364.5 376.2 377.2 386.2 12226.4 12598.0 12950.5 13140.6 17272.7 16528.7 16601.6 17320.7 17474.5 17475.3 4816.7 4830.3 5052.4 5079.9 5143.9 5365.6 5403.0 5407.4 5407.9 5409.1 3383.8 3597.1 3635.0 5662.2 5724.9 5727.0 5733.2 5737.6 5739.3 5743.1 4976.4 5176.8 5196.5 5202.7 5203.5 12289.0 12515.9 12524.9 17591.5 19852.4 1822.9 1889.4 1966.3 2091.1 2209.4 8998.0 9117.4 9140.4 9690.9 9694.2 1672.6 1704.6 1718.3 1781.2 1792.8 68997.7 69049.7 69169.7 69663.0 70947.6 9793.5 9919.4 10024.7 10273.2 10276.2 14139.7 14162.6 14179.7 14185.4 14185.6 6530.5 6791.5 6913.2 6925.7 7142.8 6439.9 6474.0 6657.6 6658.5 6661.4 4271.8 4297.4 4329.3 4329.8 4446.0 1785.8 1813.7 1839.3 1893.7 1905.3 739.6 815.6 861.8 862.0 901.6 16337.5 16773.1 17186.6 17686.2 17788.2 842.3 846.1 851.0 859.0 898.2 9280.4 9565.6 9863.5 9866.4 9989.9 345138.0 348863.0 349947.0 352514.0 353458.0 74756.0 75495.5 75565.2 77223.0 77428.6 876.9 880.1 896.9 897.4 900.8 14875.5 15040.3 15356.4 15613.5 15751.6 36003.8 36004.3 37251.0 37411.8 38161.6 45284.5 46865.8 47234.8 49024.3 49110.0 7203.5 7692.6 7876.7 7952.2 8011.0 8373.5 10693.7 11903.8 12069.5 12215.3 10074.3 10480.4 10510.7 10599.8 10621.2 9885.7 10178.6 10254.8 10294.4 10463.6 10260.4 10346.7 10361.6 10442.3 10861.8 7656.3 7725.8 7766.7 7839.2 8119.1 9396.0 9847.6 9948.2 10215.6 10387.5 02:51:34 INFO - PROCESS | 8126 | 02:51:34 INFO - PROCESS | 8126 | [#3] mootools.html Cycles:180 Average:5196.38 Median:5470.16 stddev:2941.14 (53.8%) stddev-sans-first:2934.33 02:51:34 INFO - PROCESS | 8126 | Values: 1236.3 1346.6 1398.2 1442.7 1643.8 6731.6 7702.4 7903.6 7922.1 8175.5 8010.0 8071.4 8080.6 8088.4 8094.0 2230.5 2257.9 2260.3 2263.6 2264.5 2157.8 2205.2 2230.1 2230.2 2232.1 2178.2 2219.8 2225.8 2228.5 2251.9 2160.6 2182.1 2182.5 2183.3 2185.5 2135.4 2139.4 2140.9 2142.4 2143.4 7964.2 7990.4 8038.0 8041.1 8073.7 4693.5 4726.7 4858.3 4867.7 4884.0 3013.5 3066.5 3114.0 3119.9 3122.8 909.7 915.9 928.1 953.3 965.4 10850.2 10903.9 10916.6 10917.5 10947.6 4121.9 4164.3 4216.9 4227.9 4287.1 8598.7 8636.1 8639.5 8646.1 8653.0 4755.6 4758.9 4768.4 4773.1 4773.3 3597.8 3794.7 3858.5 3894.3 4389.5 2996.9 3404.4 3414.5 3447.0 3457.9 1014.2 1054.4 1071.8 1073.7 1090.7 690.6 748.8 824.6 828.5 858.5 5431.3 5509.0 5539.7 5565.9 5654.9 426.2 432.8 434.2 437.2 438.4 3719.8 3795.9 3800.5 3842.7 3871.2 9605.1 9885.9 9957.0 9967.1 9987.4 8716.1 9132.4 9163.5 9894.8 9955.4 7015.7 7181.2 7192.2 7193.2 7197.5 5570.4 5575.1 5682.6 5758.3 5811.2 9139.1 9178.3 9188.1 9209.5 9268.9 8831.8 9235.6 9278.3 9433.5 9433.5 6056.6 6239.4 6670.0 6796.5 6848.9 7783.7 7818.1 7824.5 7831.6 7858.8 6787.5 6869.8 6953.1 6982.9 7106.8 6817.9 6843.3 6867.4 6897.0 6921.8 6360.5 6490.1 6554.8 6562.6 6602.5 4548.8 4553.8 4641.5 4673.0 4799.0 4754.9 4755.2 4842.3 4846.2 4855.1 02:51:34 INFO - PROCESS | 8126 | 02:51:34 INFO - PROCESS | 8126 | [#4] prototype.html Cycles:180 Average:4104.52 Median:4740.18 stddev:1185.43 (25.0%) stddev-sans-first:1153.86 02:51:34 INFO - PROCESS | 8126 | Values: 300.9 301.5 307.2 308.1 309.7 4730.2 4751.7 4771.6 4781.3 4819.5 4721.3 4750.2 4751.5 4754.0 4760.2 3554.4 3626.0 3663.7 3697.6 3730.7 3728.9 3731.3 3733.3 3733.3 3739.7 3700.2 3714.2 3714.4 3731.6 3742.3 3522.8 3599.3 3668.5 3724.3 3736.7 3309.3 3310.2 3310.8 3311.8 3313.5 4595.7 4601.2 4608.5 4613.2 4617.6 4001.9 4185.0 4240.1 4242.5 4243.7 4908.5 4919.4 4920.0 4923.2 4927.9 3512.7 3520.5 3534.2 3542.5 3572.0 4999.9 5152.2 5187.8 5211.0 5211.6 3575.7 3587.7 3598.4 3600.4 3606.5 3637.2 3639.8 3642.8 3652.4 3658.5 4166.9 4173.8 4180.0 4184.3 4184.5 4640.5 4943.2 4948.0 4948.3 4985.7 1263.8 1281.8 1282.1 1284.8 1285.9 767.2 801.3 808.7 809.1 811.8 4271.2 4301.9 4420.8 4463.6 4465.6 5083.7 5088.0 5107.7 5119.8 5131.9 4473.3 4485.8 4490.0 4504.5 4507.3 2621.0 2696.2 2718.2 2722.8 2726.0 4816.9 4818.1 4822.0 4830.5 4831.4 5034.0 5154.2 5211.3 5217.4 5229.2 4778.8 4806.4 4836.4 4844.3 4869.5 5036.2 5045.5 5054.3 5054.4 5056.2 4767.8 4899.1 4913.3 4925.5 4928.9 4765.9 4785.4 4785.6 4798.1 4810.2 3573.6 3577.8 3586.3 3592.7 3593.4 5026.0 5052.3 5072.2 5074.3 5090.6 4751.9 4882.6 4889.2 4893.3 4919.1 4866.7 4885.7 4899.7 4900.6 4906.3 4829.6 4835.4 4840.9 4848.2 4867.8 4691.5 4701.3 4810.8 4879.5 4919.0 4693.2 4824.6 4827.6 4833.0 4839.6 02:51:34 INFO - PROCESS | 8126 | 02:51:34 INFO - PROCESS | 8126 | [#5] yui.html Cycles:180 Average:16067.91 Median:520.21 stddev:21415.62 (4116.7%) stddev-sans-first:21444.21 02:51:34 INFO - PROCESS | 8126 | Values: 600.3 690.6 693.0 699.7 725.6 13124.3 13769.0 13939.5 13960.9 14002.0 12991.6 13388.1 13507.3 13510.4 13570.1 758.1 773.7 781.1 781.1 781.8 622.7 628.7 762.3 776.9 789.2 830.7 831.2 832.1 832.8 832.9 822.5 825.1 825.4 825.4 825.8 483.1 489.0 581.9 593.6 607.2 12535.2 12541.6 12542.9 12561.7 12628.2 11520.4 12083.6 12112.9 12212.5 12743.4 9772.4 9828.5 11464.7 11748.4 11799.8 3988.7 4068.2 4091.3 4143.0 4254.1 50979.0 53038.2 53085.5 58906.4 59315.7 9989.2 10235.7 10252.2 10287.5 10384.1 18323.5 18478.1 18505.8 18546.0 18654.7 6804.1 6811.7 6860.9 6946.6 7125.8 3679.6 3721.7 3735.1 3802.2 3826.3 3019.7 3119.2 3141.3 3141.8 3147.6 522.7 527.9 535.1 535.5 541.2 517.8 547.5 558.7 579.3 611.3 7902.8 8357.4 8420.5 8429.0 8646.9 522.6 539.2 571.3 608.0 630.3 4013.6 4189.6 4200.6 4238.2 4346.7 73271.0 76138.2 76160.2 89312.0 89987.1 65968.7 67713.0 75263.6 78585.6 78610.6 59848.4 62961.7 67423.3 68868.0 69232.0 8243.3 9010.0 9051.2 9110.5 9233.9 30324.8 31481.7 36466.1 40043.8 43115.0 35276.3 43410.0 55945.4 56556.0 58019.4 11162.7 11269.0 11340.4 11616.5 11643.9 12680.7 13132.5 13431.4 13681.9 14152.6 11782.5 12278.6 12451.0 12688.7 12811.8 9280.5 11703.6 12142.5 12411.8 12586.4 11253.4 11808.5 12345.2 12439.0 12497.1 9616.9 9789.4 9985.5 10026.2 10264.3 8922.6 9086.7 9701.7 10030.5 10309.8 02:51:34 INFO - PROCESS | 8126 | -------- Summary: end -------- 02:51:34 INFO - PROCESS | 8126 | 02:51:35 INFO - TEST-INFO | 8126: exit 0 02:51:35 INFO - TEST-OK | dromaeo_css | took 1122748ms 02:51:35 INFO - TEST-START | kraken 02:51:35 INFO - operating with platform_type : linux_ 02:51:35 INFO - Initialising browser for kraken test... 02:51:35 INFO - TEST-INFO | started process 8432 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZOK6B0/profile http://localhost:42832/getInfo.html) 02:51:39 INFO - PROCESS | 8432 | __metrics Screen width/height:1600/1200 02:51:39 INFO - PROCESS | 8432 | colorDepth:24 02:51:39 INFO - PROCESS | 8432 | Browser inner width/height: 1024/697 02:51:39 INFO - PROCESS | 8432 | __metrics 02:51:40 INFO - PROCESS | 8432 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:51:40 INFO - PROCESS | 8432 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:51:41 INFO - PROCESS | 8432 | console.error: PushService: 02:51:41 INFO - PROCESS | 8432 | stateChangeProcessEnqueue: Error transitioning state 02:51:41 INFO - PROCESS | 8432 | UnknownError 02:51:41 INFO - TEST-INFO | 8432: exit 0 02:51:41 INFO - Browser initialized. 02:51:41 INFO - Running cycle 1/1 for kraken test... 02:51:41 INFO - TEST-INFO | started process 8514 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZOK6B0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:51:54 INFO - PROCESS | 8514 | RSS: Main: 174399488 02:51:54 INFO - PROCESS | 8514 | 02:51:57 INFO - PROCESS | 8514 | Cycle 1(1): loaded http://localhost:42832/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42832/tests/kraken/driver.html?testName=audio-beat-detection) 02:51:58 INFO - PROCESS | 8514 | RSS: Main: 233668608 02:51:58 INFO - PROCESS | 8514 | 02:52:00 INFO - PROCESS | 8514 | Cycle 1(1): loaded http://localhost:42832/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42832/tests/kraken/driver.html?testName=audio-dft) 02:52:01 INFO - PROCESS | 8514 | RSS: Main: 218566656 02:52:01 INFO - PROCESS | 8514 | 02:52:04 INFO - PROCESS | 8514 | Cycle 1(1): loaded http://localhost:42832/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42832/tests/kraken/driver.html?testName=audio-fft) 02:52:05 INFO - PROCESS | 8514 | RSS: Main: 300294144 02:52:05 INFO - PROCESS | 8514 | 02:52:07 INFO - PROCESS | 8514 | Cycle 1(1): loaded http://localhost:42832/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42832/tests/kraken/driver.html?testName=audio-oscillator) 02:52:08 INFO - PROCESS | 8514 | RSS: Main: 210784256 02:52:08 INFO - PROCESS | 8514 | 02:52:10 INFO - PROCESS | 8514 | Cycle 1(1): loaded http://localhost:42832/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42832/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:52:10 INFO - PROCESS | 8514 | RSS: Main: 213786624 02:52:10 INFO - PROCESS | 8514 | 02:52:14 INFO - PROCESS | 8514 | Cycle 1(1): loaded http://localhost:42832/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42832/tests/kraken/driver.html?testName=imaging-darkroom) 02:52:14 INFO - PROCESS | 8514 | RSS: Main: 250417152 02:52:14 INFO - PROCESS | 8514 | 02:52:18 INFO - PROCESS | 8514 | Cycle 1(1): loaded http://localhost:42832/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42832/tests/kraken/driver.html?testName=imaging-desaturate) 02:52:18 INFO - PROCESS | 8514 | RSS: Main: 248619008 02:52:18 INFO - PROCESS | 8514 | 02:52:21 INFO - PROCESS | 8514 | Cycle 1(1): loaded http://localhost:42832/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42832/tests/kraken/driver.html?testName=json-parse-financial) 02:52:22 INFO - PROCESS | 8514 | RSS: Main: 249126912 02:52:22 INFO - PROCESS | 8514 | 02:52:24 INFO - PROCESS | 8514 | Cycle 1(1): loaded http://localhost:42832/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42832/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:52:24 INFO - PROCESS | 8514 | RSS: Main: 210948096 02:52:24 INFO - PROCESS | 8514 | 02:52:26 INFO - PROCESS | 8514 | Cycle 1(1): loaded http://localhost:42832/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42832/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:52:27 INFO - PROCESS | 8514 | RSS: Main: 218894336 02:52:27 INFO - PROCESS | 8514 | 02:52:29 INFO - PROCESS | 8514 | Cycle 1(1): loaded http://localhost:42832/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42832/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:52:30 INFO - PROCESS | 8514 | RSS: Main: 227360768 02:52:30 INFO - PROCESS | 8514 | 02:52:32 INFO - PROCESS | 8514 | Cycle 1(1): loaded http://localhost:42832/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42832/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:52:33 INFO - PROCESS | 8514 | RSS: Main: 235757568 02:52:33 INFO - PROCESS | 8514 | 02:52:36 INFO - PROCESS | 8514 | Cycle 1(1): loaded http://localhost:42832/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42832/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:52:37 INFO - PROCESS | 8514 | RSS: Main: 232316928 02:52:37 INFO - PROCESS | 8514 | 02:52:39 INFO - PROCESS | 8514 | Cycle 1(1): loaded http://localhost:42832/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42832/tests/kraken/driver.html?testName=ai-astar) 02:52:39 INFO - PROCESS | 8514 | RSS: Main: 283672576 02:52:39 INFO - PROCESS | 8514 | 02:52:39 INFO - PROCESS | 8514 | __start_tp_report 02:52:39 INFO - PROCESS | 8514 | _x_x_mozilla_page_load 02:52:39 INFO - PROCESS | 8514 | _x_x_mozilla_page_load_details 02:52:39 INFO - PROCESS | 8514 | |i|pagename|runs| 02:52:39 INFO - PROCESS | 8514 | |0;ai-astar;113;115;113;114;114;113;114;114;115;113 02:52:39 INFO - PROCESS | 8514 | |1;audio-beat-detection;163;126;130;174;133;138;131;131;175;135 02:52:39 INFO - PROCESS | 8514 | |2;audio-dft;161;164;163;162;160;160;160;163;162;163 02:52:39 INFO - PROCESS | 8514 | |3;audio-fft;74;75;76;114;76;78;76;76;118;77 02:52:39 INFO - PROCESS | 8514 | |4;audio-oscillator;84;83;120;83;84;84;117;83;83;114 02:52:39 INFO - PROCESS | 8514 | |5;imaging-gaussian-blur;118;117;117;117;117;117;117;117;118;117 02:52:39 INFO - PROCESS | 8514 | |6;imaging-darkroom;146;145;146;146;146;147;146;146;146;146 02:52:39 INFO - PROCESS | 8514 | |7;imaging-desaturate;96;96;96;97;96;96;95;96;96;95 02:52:39 INFO - PROCESS | 8514 | |8;json-parse-financial;63;64;66;64;65;67;66;65;66;66 02:52:39 INFO - PROCESS | 8514 | |9;json-stringify-tinderbox;65;66;66;65;68;65;66;66;66;67 02:52:39 INFO - PROCESS | 8514 | |10;stanford-crypto-aes;83;84;84;84;83;89;83;83;82;90 02:52:39 INFO - PROCESS | 8514 | |11;stanford-crypto-ccm;142;139;138;138;161;140;143;139;177;139 02:52:39 INFO - PROCESS | 8514 | |12;stanford-crypto-pbkdf2;178;177;184;179;177;177;176;174;176;185 02:52:39 INFO - PROCESS | 8514 | |13;stanford-crypto-sha256-iterative;73;74;70;72;70;71;71;73;71;70 02:52:39 INFO - PROCESS | 8514 | __end_tp_report 02:52:39 INFO - PROCESS | 8514 | __start_cc_report 02:52:39 INFO - PROCESS | 8514 | _x_x_mozilla_cycle_collect,2027 02:52:39 INFO - PROCESS | 8514 | __end_cc_report 02:52:39 INFO - PROCESS | 8514 | __startTimestamp1476352359346__endTimestamp 02:52:39 INFO - PROCESS | 8514 | 02:52:39 INFO - PROCESS | 8514 | ------- Summary: start ------- 02:52:39 INFO - PROCESS | 8514 | Number of tests: 14 02:52:39 INFO - PROCESS | 8514 | 02:52:39 INFO - PROCESS | 8514 | [#0] ai-astar Cycles:10 Average:113.80 Median:114.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 02:52:39 INFO - PROCESS | 8514 | Values: 113.0 115.0 113.0 114.0 114.0 113.0 114.0 114.0 115.0 113.0 02:52:39 INFO - PROCESS | 8514 | 02:52:39 INFO - PROCESS | 8514 | [#1] audio-beat-detection Cycles:10 Average:143.60 Median:136.50 stddev:19.20 (14.1%) stddev-sans-first:19.03 02:52:39 INFO - PROCESS | 8514 | Values: 163.0 126.0 130.0 174.0 133.0 138.0 131.0 131.0 175.0 135.0 02:52:39 INFO - PROCESS | 8514 | 02:52:39 INFO - PROCESS | 8514 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.50 stddev:1.48 (0.9%) stddev-sans-first:1.54 02:52:39 INFO - PROCESS | 8514 | Values: 161.0 164.0 163.0 162.0 160.0 160.0 160.0 163.0 162.0 163.0 02:52:39 INFO - PROCESS | 8514 | 02:52:39 INFO - PROCESS | 8514 | [#3] audio-fft Cycles:10 Average:84.00 Median:76.00 stddev:16.92 (22.3%) stddev-sans-first:17.56 02:52:39 INFO - PROCESS | 8514 | Values: 74.0 75.0 76.0 114.0 76.0 78.0 76.0 76.0 118.0 77.0 02:52:39 INFO - PROCESS | 8514 | 02:52:39 INFO - PROCESS | 8514 | [#4] audio-oscillator Cycles:10 Average:93.50 Median:83.00 stddev:16.28 (19.6%) stddev-sans-first:16.90 02:52:39 INFO - PROCESS | 8514 | Values: 84.0 83.0 120.0 83.0 84.0 84.0 117.0 83.0 83.0 114.0 02:52:39 INFO - PROCESS | 8514 | 02:52:39 INFO - PROCESS | 8514 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 02:52:39 INFO - PROCESS | 8514 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 02:52:39 INFO - PROCESS | 8514 | 02:52:39 INFO - PROCESS | 8514 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 02:52:39 INFO - PROCESS | 8514 | Values: 146.0 145.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 02:52:39 INFO - PROCESS | 8514 | 02:52:39 INFO - PROCESS | 8514 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 02:52:39 INFO - PROCESS | 8514 | Values: 96.0 96.0 96.0 97.0 96.0 96.0 95.0 96.0 96.0 95.0 02:52:39 INFO - PROCESS | 8514 | 02:52:39 INFO - PROCESS | 8514 | [#8] json-parse-financial Cycles:10 Average:65.20 Median:66.00 stddev:1.23 (1.9%) stddev-sans-first:1.01 02:52:39 INFO - PROCESS | 8514 | Values: 63.0 64.0 66.0 64.0 65.0 67.0 66.0 65.0 66.0 66.0 02:52:39 INFO - PROCESS | 8514 | 02:52:39 INFO - PROCESS | 8514 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.94 (1.4%) stddev-sans-first:0.93 02:52:39 INFO - PROCESS | 8514 | Values: 65.0 66.0 66.0 65.0 68.0 65.0 66.0 66.0 66.0 67.0 02:52:39 INFO - PROCESS | 8514 | 02:52:39 INFO - PROCESS | 8514 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:84.00 stddev:2.72 (3.2%) stddev-sans-first:2.83 02:52:39 INFO - PROCESS | 8514 | Values: 83.0 84.0 84.0 84.0 83.0 89.0 83.0 83.0 82.0 90.0 02:52:39 INFO - PROCESS | 8514 | 02:52:39 INFO - PROCESS | 8514 | [#11] stanford-crypto-ccm Cycles:10 Average:145.60 Median:141.00 stddev:13.00 (9.2%) stddev-sans-first:13.72 02:52:39 INFO - PROCESS | 8514 | Values: 142.0 139.0 138.0 138.0 161.0 140.0 143.0 139.0 177.0 139.0 02:52:39 INFO - PROCESS | 8514 | 02:52:39 INFO - PROCESS | 8514 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.30 Median:177.50 stddev:3.53 (2.0%) stddev-sans-first:3.74 02:52:39 INFO - PROCESS | 8514 | Values: 178.0 177.0 184.0 179.0 177.0 177.0 176.0 174.0 176.0 185.0 02:52:39 INFO - PROCESS | 8514 | 02:52:39 INFO - PROCESS | 8514 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:71.50 stddev:1.43 (2.0%) stddev-sans-first:1.41 02:52:39 INFO - PROCESS | 8514 | Values: 73.0 74.0 70.0 72.0 70.0 71.0 71.0 73.0 71.0 70.0 02:52:39 INFO - PROCESS | 8514 | -------- Summary: end -------- 02:52:39 INFO - PROCESS | 8514 | 02:52:40 INFO - TEST-INFO | 8514: exit 0 02:52:40 INFO - TEST-OK | kraken | took 65181ms 02:52:40 INFO - SUITE-END | took 1187s 02:52:40 INFO - Completed test suite (00:19:48) 02:52:41 INFO - javascript benchmark 02:52:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2602.492513959778, 2618.869056547172, 2651.310659228601, 2665.13383150476, 2671.532481815683, 4617.515160908107, 4652.981620722596, 4703.200455922492, 4725.3148293497425, 4776.80892764289, 4680.859574212771, 4706.599939005188, 4742.264948932921, 4743.051389722061, 4789.18583840747, 4217.493900731916, 4221.535631080578, 4265.338872474771, 4274.529801721824, 4290.377895205193, 4009.3384591542363, 4421.801018954155, 4453.554644535553, 4497.775111244425, 4544.97727511362, 4281.721688090295, 4438.068005718771, 4441.200583894898, 4504.954950450503, 4548.863534093966, 4337.457817772778, 4355.128974205171, 4375.518692943773, 4391.231534481485, 4410.669199810027, 4348.826046958149, 4349.26062569364, 4357.063231405232, 4401.823927042915, 4415.028693687384, 4751.0, 4758.500357462452, 4764.952350476486, 4786.234202527614, 4806.375171227753, 4950.183219768734, 5014.774335154927, 5023.874403139951, 5079.111155547765, 5109.310243117169, 5116.053530096944, 5119.25770763241, 5136.024155410498, 5161.66449180802, 5178.922316165261, 4771.952280477186, 4793.448753393404, 4800.879978000508, 4820.807167713322, 4873.829415970424, 5077.39071311445, 5129.9230511542355, 5253.737313134328, 5255.658382205221, 5265.657732247391, 4990.3762029746285, 5017.874553136201, 5033.194688849767, 5041.672291301127, 5103.387593488805, 5127.307813445212, 5127.897442051138, 5131.640785145004, 5189.481051894781, 5192.584593232532, 5044.717024303347, 5054.393472783289, 5062.924056139161, 5154.587632989352, 5159.922601160911, 4848.272759086095, 4893.363862697826, 4931.9753401232765, 5064.34163558735, 5076.111680455905, 4158.750474971512, 4162.375643653416, 4168.520620128664, 4171.124063946605, 4213.0, 3662.1577037281572, 3665.780053196763, 3674.9448758268645, 3701.4262789267705, 3710.07248187953, 4297.183535128315, 4397.736135831797, 4404.4494438195225, 4406.383106365111, 4438.955610443854, 4935.457099719028, 4950.603951683856, 4991.850244492671, 5008.524190201925, 5025.396952365666, 4465.285554311295, 4475.977620111878, 4483.798229079699, 4523.638108951276, 4526.728396296233, 4598.931016034762, 4608.470025947059, 4614.676972611885, 4619.2378257587125, 4669.696469729457, 4727.503612120678, 4789.616830653609, 4826.444958829779, 4864.075825593126, 4908.361912951294, 5137.897242055213, 5153.639245252796, 5163.8192663258105, 5199.116150254541, 5201.349831271091, 4823.3729615149805, 4883.047805678001, 4884.755762211804, 4885.047415754036, 4940.530649588283, 4879.902401952012, 4925.6305777066145, 5020.0, 5084.586605514574, 5088.033273677989, 5106.0, 5165.715885626327, 5169.7673604687125, 5169.948300517097, 5227.372715274039, 5020.648554601143, 5021.171506701354, 5021.748912554431, 5030.144875371268, 5091.541761241506, 4827.275908613736, 4883.731394773322, 5008.824691135793, 5027.296178535081, 5074.923876141787, 4834.105690447279, 4838.637102217418, 4883.340748998839, 4903.803847846046, 4961.7271050092595, 4986.326845875906, 4993.201087825931, 4999.300097986212, 4999.375078115236, 5063.3417655704525, 4737.810487580458, 4807.807687692453, 4827.42070951488, 4835.58897493717, 4879.024195161053], "value": 4670.076831515264, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [540.4460428061237, 546.0553242889803, 552.748499432758, 553.2641586689703, 554.8917960997604, 27391.589126163097, 29947.101586952373, 30120.246993825167, 30144.397112057744, 38090.428643570296, 36908.0, 40638.18723625526, 40665.59334406663, 40673.796631016805, 40692.796536017355, 7468.701251949929, 7607.80980475487, 7612.010438642968, 7613.581253031081, 7618.162002179756, 7537.585432801194, 7620.618969051553, 7625.504342217766, 7626.923730762677, 7627.0, 7632.5038872473115, 7676.0, 7681.3086822186, 7682.308592226698, 7686.077670679526, 7611.733589324374, 7645.808854778619, 7649.655765490511, 7658.119316278616, 7658.693652253904, 7513.0, 7555.54666719993, 7555.811104722426, 7566.167721550625, 7572.659230334593, 38156.42765358522, 38520.0, 38520.614793851986, 38545.80727096375, 38614.80692596547, 3138.1840721412595, 3163.9050828475183, 3189.7926634768664, 3286.5070239464035, 3523.2248905241063, 28237.15288541347, 28349.716502834915, 28827.85586072077, 29101.854490727623, 29291.560626590617, 3410.334984677964, 3467.4105402081705, 3496.5454490916272, 3557.94663080054, 3565.982170089159, 250447.0, 251026.0, 251399.0, 252164.99999999817, 252225.0, 28443.146705598865, 29219.269518262212, 29460.410791784045, 49510.0, 49925.75037124791, 31374.686253137632, 31397.0, 31434.84282578618, 31447.52828707571, 31469.8426507866, 13069.673258168621, 13183.604491865259, 13229.801552976713, 13242.668933276553, 13250.403731831899, 11432.085433165326, 11498.77002459963, 11551.133664974992, 11551.653450396501, 11567.652970410902, 7712.383009359238, 7720.575368354682, 7808.609569521501, 7816.7264145754625, 7821.843563128819, 3082.2756652186717, 3086.8147911125407, 3089.6910308968922, 3151.2752067024253, 3166.6358368787883, 794.2454668065361, 832.8292699996487, 897.7890195804111, 910.2159766856902, 915.8168366326761, 25999.0, 26816.32959175997, 27292.181234562995, 27428.862855685595, 27581.172564823086, 914.5107367558325, 917.1058218237299, 937.9671711490201, 967.8596603492454, 1002.3284399452384, 13779.555111222195, 14271.78592321116, 14395.640108997359, 14438.639034024234, 15283.847161528241, 355642.0, 355860.0, 356301.0, 356618.0, 357119.0, 47723.0, 47960.5203947963, 48125.518744812805, 48238.0, 48279.0, 1055.229682331902, 1115.8995690387742, 1118.0440723181562, 1189.8334233207358, 1217.3852204636778, 26020.21939341823, 27970.696043370037, 30501.23746906345, 30780.230494236926, 30782.538261926537, 45168.32247516224, 45742.313865291384, 45778.77110614559, 45859.54140458553, 45918.09696175862, 326312.0, 327620.0, 330273.0, 330942.0, 333156.0, 24108.87945560261, 24447.633285500375, 24532.0, 25607.103751368613, 25609.23172304834, 40020.39969400403, 40310.596894031856, 40511.594884050784, 40700.0, 41520.792396037825, 33448.49827252642, 34645.826770866996, 34752.826235869674, 34752.957411277705, 35610.46584301186, 34092.31815363629, 34503.0, 34841.825790870884, 35003.47494787631, 35015.0, 33763.83118084394, 34073.0, 34371.828140859136, 34636.480452792726, 34787.478187826695, 28958.0, 31362.372752545278, 31390.52914206243, 31469.52795708112, 31556.684433156293, 24500.877495612407, 24589.38526536851, 24723.134690285755, 24752.628710568995, 24917.750822492268], "value": 15976.393132618676, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.19566800690393, 364.45513956634835, 376.22873110124243, 377.2116276981109, 386.1581751781118, 12226.38868056597, 12598.0, 12950.474657441802, 13140.605781826536, 17272.654546909056, 16528.66942661146, 16601.584960375996, 17320.653586928252, 17474.47576572705, 17475.300987960498, 4816.735079570613, 4830.251311046776, 5052.444231134572, 5079.873003174932, 5143.871403214931, 5365.624406291561, 5403.0, 5407.432219616942, 5407.891842163174, 5409.107497262967, 3383.8308084595797, 3597.0647631615707, 3635.000374896898, 5662.150677398382, 5724.9427505724825, 5726.971365143189, 5733.226014488033, 5737.627054241482, 5739.282589676291, 5743.138529220609, 4976.377952755905, 5176.844694659167, 5196.480351964811, 5202.661826981234, 5203.531682148587, 12289.0, 12515.937420312932, 12524.874751252462, 17591.472255832345, 19852.404427867186, 1822.8723989320754, 1889.3859495663964, 1966.3019628031986, 2091.1008266445424, 2209.4255493571627, 8998.0, 9117.361784675075, 9140.360174787767, 9690.90309096907, 9694.17599504043, 1672.5818545363659, 1704.5653358393654, 1718.3470281293153, 1781.153951872863, 1792.7848658160974, 68997.65501172462, 69049.65475172643, 69169.65415172992, 69663.0, 70947.64526177388, 9793.510324483746, 9919.355241909398, 10024.699259022242, 10273.229507786946, 10276.177905767521, 14139.717205655828, 14162.575122746333, 14179.716405671828, 14185.361658725382, 14185.574432767033, 6530.542861999709, 6791.456683465311, 6913.2049814270995, 6925.688344024531, 7142.821429464201, 6439.903401448982, 6473.996530537775, 6657.633830139292, 6658.500612454085, 6661.4004739573675, 4271.807768650356, 4297.419848320499, 4329.285667864767, 4329.805158767863, 4445.955540444619, 1785.839064855199, 1813.718873574598, 1839.3194518028415, 1893.6686079936233, 1905.2759951218725, 739.5673530984327, 815.604431850552, 861.8060936289285, 861.9870701939476, 901.5852707754375, 16337.509874703777, 16773.077480738433, 17186.570335741457, 17686.204120814593, 17788.199531021135, 842.2756429470651, 846.094678693804, 850.9659613615386, 858.9742307730778, 898.1736802142045, 9280.443173409481, 9565.569549370295, 9863.457509836884, 9866.358686685342, 9989.900100999042, 345138.0, 348863.0, 349947.0, 352514.0, 353458.0, 74756.0, 75495.5223880597, 75565.24434755692, 77223.0, 77428.61285693536, 876.8684697295457, 880.1086553895416, 896.9192772650363, 897.4121950122681, 900.7567956651667, 14875.47935822241, 15040.254447867917, 15356.38574457054, 15613.453529126426, 15751.606209844846, 36003.81998089993, 36004.27991440209, 37251.0, 37411.81294093621, 38161.6183838158, 45284.54715452803, 46865.76567117142, 47234.76382618065, 49024.26463602977, 49110.0, 7203.495755297288, 7692.574240271648, 7876.684932602631, 7952.244536768998, 8011.0, 8373.455725377831, 10693.679189624323, 11903.82144267854, 12069.456874440846, 12215.26708397499, 10074.345167564084, 10480.371177729361, 10510.737231569272, 10599.841002384816, 10621.203409744145, 9885.703428897144, 10178.592856285666, 10254.846177307198, 10294.433806140734, 10463.633772818219, 10260.435676037889, 10346.741331466774, 10361.63734269297, 10442.269041167045, 10861.782764344827, 7656.272654097852, 7725.806854828675, 7766.650500727368, 7839.176886426843, 8119.066307374727, 9396.0, 9847.60609575609, 9948.154406875206, 10215.642452514126, 10387.53256103462], "value": 7981.916656205372, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1236.289133748094, 1346.6229455752386, 1398.2100113435908, 1442.689821688337, 1643.7945256842888, 6731.596104233749, 7702.383809295257, 7903.6048197590035, 7922.128565857758, 8175.46859454135, 8009.959950200241, 8071.394645401589, 8080.555569443678, 8088.433809633313, 8094.0, 2230.542738738559, 2257.8532395394327, 2260.276711452336, 2263.649134384173, 2264.479169790949, 2157.7626461089267, 2205.2391924785925, 2230.10795681727, 2230.1748353109374, 2232.073689418889, 2178.2485042660255, 2219.8002179803893, 2225.788550087739, 2228.487447886987, 2251.8536295140843, 2160.611090003799, 2182.127149140341, 2182.4871155278497, 2183.3340831046526, 2185.5082606413507, 2135.4020874155262, 2139.411661793004, 2140.9464763380884, 2142.432255452291, 2143.3677065265783, 7964.203579642048, 7990.4007199460275, 8037.959810200911, 8041.075276343178, 8073.717419890276, 4693.460252071021, 4726.692764970266, 4858.344123543312, 4867.7079375237245, 4883.99878025004, 3013.5027720426106, 3066.4633689104317, 3113.9844300778577, 3119.859606317721, 3122.8438578071004, 909.7270818754347, 915.890093188815, 928.1321963963716, 953.3374304858127, 965.4303960663242, 10850.186236032328, 10903.945480272627, 10916.617918372818, 10917.508712107974, 10947.616833410872, 4121.877233224892, 4164.271252530795, 4216.852410165629, 4227.87316380509, 4287.12114016632, 8598.699045533376, 8636.136386361439, 8639.524826134497, 8646.135386461303, 8653.048164701877, 4755.619550435957, 4758.881027974259, 4768.427788665383, 4773.11697335994, 4773.260144677581, 3597.766145200606, 3794.6964242860504, 3858.5176852893387, 3894.279558281727, 4389.4513185851765, 2996.8501574921165, 3404.4042292599192, 3414.4536874100027, 3446.965530344715, 3457.930841383158, 1014.1886490807325, 1054.3937236089125, 1071.7856428714288, 1073.7261998190568, 1090.6946055104584, 690.5545922879814, 748.827769612992, 824.6041899888087, 828.5194587139445, 858.5406807358033, 5431.321084864392, 5509.00837849183, 5539.667619942817, 5565.860853478695, 5654.9151762723595, 426.24767285740694, 432.75981830084606, 434.1729006243112, 437.1846506265855, 438.3753151758731, 3719.814009299578, 3795.9430608540893, 3800.4869342638945, 3842.6733727633464, 3871.2257548490416, 9605.087516685904, 9885.851712224323, 9956.950215248877, 9967.053129952643, 9987.400755954666, 8716.08481109487, 9132.360734748636, 9163.49600771964, 9894.80210395788, 9955.402675839472, 7015.719371225094, 7181.174164970991, 7192.208857025723, 7193.2447093055525, 7197.532160409557, 5570.359408668055, 5575.135853942646, 5682.6306290091015, 5758.2514273144225, 5811.186433899173, 9139.131782480654, 9178.311626627896, 9188.127127922837, 9209.539523023956, 9268.860967085364, 8831.823363532565, 9235.630574776933, 9278.304127190622, 9433.52832358393, 9433.52832358393, 6056.636601803906, 6239.438450539473, 6670.0, 6796.456283497408, 6848.8972665409065, 7783.688652453839, 7818.140004599376, 7824.5305281681, 7831.569263690551, 7858.764237072897, 6787.490938179755, 6869.828254293682, 6953.130858642669, 6982.860342793014, 7106.751263705745, 6817.897731533932, 6843.349881761224, 6867.416269617139, 6896.965515172392, 6921.792346229621, 6360.4911607072245, 6490.091387205889, 6554.80335589933, 6562.606243625398, 6602.471802255712, 4548.772561371852, 4553.795079221377, 4641.489436161952, 4673.0, 4798.976005119952, 4754.881127971828, 4755.1916174251155, 4842.297866809364, 4846.248831431134, 4855.101806165871], "value": 4093.249337616219, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.8991987684126, 301.5296138024682, 307.2334525359229, 308.14028859482045, 309.72434533265414, 4730.19586670266, 4751.738654374008, 4771.570558649721, 4781.306710526971, 4819.469858315591, 4721.3390125382475, 4750.16872047392, 4751.477337492873, 4754.0, 4760.166970780108, 3554.377983852835, 3625.963740362602, 3663.7069034477313, 3697.5932647408763, 3730.6642402183797, 3728.9254214915823, 3731.3097077040834, 3733.253349330131, 3733.328000959826, 3739.7008239340926, 3700.2414505026404, 3714.1828797664607, 3714.3685573452576, 3731.589525152231, 3742.307673080475, 3522.823858807062, 3599.2981368633127, 3668.468072129553, 3724.2737666155112, 3736.7010639148803, 3309.3381323735107, 3310.2386451116136, 3310.7682462227654, 3311.784733992283, 3313.4698448248164, 4595.747233902134, 4601.240795268776, 4608.539146085398, 4613.215753321943, 4617.584417402416, 4001.919961600781, 4185.0, 4240.109576988805, 4242.53332133465, 4243.681723870722, 4908.509149085063, 4919.409670839486, 4919.975400123012, 4923.18767403378, 4927.852164435073, 3512.7189824813954, 3520.507129001942, 3534.204803919123, 3542.5040494330815, 3572.0, 4999.850004499871, 5152.227165925104, 5187.818426355059, 5211.0, 5211.63849317192, 3575.713942884563, 3587.695045921126, 3598.3702852000797, 3600.4059330210744, 3606.4770608261656, 3637.2361804021452, 3639.7816131032223, 3642.7996460194413, 3652.433872749728, 3658.5061016762397, 4166.854160104382, 4173.787892417024, 4180.0, 4184.267753143188, 4184.476940382452, 4640.489546149921, 4943.233798761198, 4947.975260123676, 4948.257761335756, 4985.651004429655, 1263.829383033297, 1281.8461784585909, 1282.1473719976111, 1284.8072789081712, 1285.8778416050461, 767.1944458318743, 801.2828518475932, 808.7129069180473, 809.1301850510724, 811.7929927868356, 4271.1671224111, 4301.913961720748, 4420.845270415584, 4463.598276155161, 4465.575770301816, 5083.669561478566, 5088.0, 5107.719075450812, 5119.820806271762, 5131.8966422218655, 4473.3066374711325, 4485.753283569435, 4489.9775501122285, 4504.459464864237, 4507.346434767006, 2621.0, 2696.177665811946, 2718.1573712149298, 2722.8366298022183, 2725.9863700681767, 4816.892114813612, 4818.10864989978, 4821.951780482221, 4830.478399304208, 4831.4202295724735, 5033.974830125826, 5154.170269554329, 5211.326015159304, 5217.373915130132, 5229.189475631283, 4778.761061946958, 4806.44725856524, 4836.396884321133, 4844.297576851407, 4869.488703686133, 5036.219385995177, 5045.520675535819, 5054.3176671150395, 5054.393472783289, 5056.17977528097, 4767.761611919321, 4899.118158731462, 4913.263010548446, 4925.45819959797, 4928.85213443583, 4765.8570242892765, 4785.425748910153, 4785.569298763128, 4798.136335459651, 4810.182269014206, 3573.6426357365094, 3577.783553591687, 3586.3006713691625, 3592.7485076045473, 3593.3531964246686, 5025.974870125626, 5052.267421223975, 5072.188449848154, 5074.289599456005, 5090.574639101058, 4751.928721069117, 4882.60939124862, 4889.168841297059, 4893.266010098514, 4919.139150648551, 4866.659333846738, 4885.706857588556, 4899.681520701143, 4900.583450406612, 4906.337644417958, 4829.613630909589, 4835.371401717754, 4840.854774356775, 4848.151573474698, 4867.780949857194, 4691.460482044608, 4701.271302948048, 4810.807567697253, 4879.4876537963, 4918.975405122951, 4693.225617773166, 4824.565789079, 4827.61379089679, 4832.975835120802, 4839.612830973584], "value": 3728.3822562773257, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.2526854066687, 690.6408667492904, 693.0470602920982, 699.7410957945558, 725.6190499987503, 13124.278164700938, 13769.0, 13939.512117075905, 13960.930195349021, 14002.019858609901, 12991.610251692464, 13388.062835601511, 13507.324633768321, 13510.392032358543, 13570.117942333742, 758.067576880436, 773.6673230510878, 781.0510230070491, 781.1173374087274, 781.7811012916364, 622.7353374815708, 628.6982248520712, 762.2910693055456, 776.926192011758, 789.1871372486348, 830.6801881275723, 831.2352635575255, 832.1262674192104, 832.8459235041506, 832.9125441828612, 822.5023860564362, 825.0965193113591, 825.3809642767924, 825.4469505431375, 825.7522743177083, 483.05080516784335, 489.01219536536354, 581.9243498345188, 593.6497466494745, 607.2439812433548, 12535.24788512692, 12541.623751287476, 12542.937285313606, 12561.685957851036, 12628.179168354027, 11520.423978801027, 12083.57707480234, 12112.939435302855, 12212.450439730233, 12743.36283185837, 9772.364796288219, 9828.508574571315, 11464.65606031812, 11748.353840538766, 11799.764004719858, 3988.660963818079, 4068.1863627274665, 4091.284025295561, 4142.979285103585, 4254.1279037797485, 50979.0, 53038.20442693324, 53085.46914530844, 58906.41093589095, 59315.70342148305, 9989.200863930868, 10235.692929212135, 10252.23108266868, 10287.485625718684, 10384.11735002518, 18323.450296491126, 18478.07609619514, 18505.81494185068, 18546.0, 18654.720179197324, 6804.08144900442, 6811.659417029129, 6860.907423235961, 6946.6179360134665, 7125.786226413215, 3679.5584529856587, 3721.7394782364972, 3735.084904198489, 3802.16352402471, 3826.2730081284467, 3019.6829332920165, 3119.1890108571934, 3141.3246152076954, 3141.8429078545983, 3147.5750773645723, 522.7020598258956, 527.8759491519489, 535.130413078747, 535.4725595288637, 541.2287490326348, 517.76700484782, 547.5045084198806, 558.6843433460164, 579.2990481517411, 611.2695329081794, 7902.841943161219, 8357.414980951275, 8420.53687047206, 8428.957855210685, 8646.870296945552, 522.647213131135, 539.2369796737572, 571.2958432791193, 608.0241212853396, 630.3066626710673, 4013.6115518566335, 4189.601987811153, 4200.5799420058365, 4238.173556156582, 4346.6522678185665, 73271.0, 76138.23861761311, 76160.23839761532, 89312.0, 89987.10012899787, 65968.6701566489, 67713.0, 75263.62368188234, 78585.60707196542, 78610.6069469649, 59848.40151598428, 62961.68519157375, 67423.3257667417, 68868.0, 69232.0, 8243.25810677018, 9010.0, 9051.230645395215, 9110.498922559324, 9233.861492077489, 30324.84837575798, 31481.685183147874, 36466.08834779152, 40043.79978100091, 43115.0, 35276.29447411089, 43410.0, 55945.44054559402, 56556.0, 58019.41980580309, 11162.665120046411, 11269.0, 11340.376279304717, 11616.535338586362, 11643.88356116462, 12680.6829829255, 13132.474701012236, 13431.395587198404, 13681.863181368059, 14152.575422737335, 11782.469788859351, 12278.631641050782, 12451.0, 12688.74622507563, 12811.807822882478, 9280.489573073546, 11703.590374336858, 12142.453589588666, 12411.813822792485, 12586.370681466073, 11253.437328133397, 11808.527658893892, 12345.197562158432, 12439.0, 12497.125201235825, 9616.9038309616, 9789.412635241908, 9985.505073224313, 10026.197904167795, 10264.332818366782, 8922.643094276156, 9086.727398178065, 9701.708948731268, 10030.498475076363, 10309.814371347391], "value": 6460.894572749899, "unit": "score"}], "name": "dromaeo_css", "value": 6234.566720170356, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 113.0, 114.0, 114.0, 113.0, 114.0, 114.0, 115.0, 113.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 126.0, 130.0, 174.0, 133.0, 138.0, 131.0, 131.0, 175.0, 135.0], "value": 143.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 163.0, 162.0, 160.0, 160.0, 160.0, 163.0, 162.0, 163.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 114.0, 76.0, 78.0, 76.0, 76.0, 118.0, 77.0], "value": 84.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 120.0, 83.0, 84.0, 84.0, 117.0, 83.0, 83.0, 114.0], "value": 93.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 66.0, 64.0, 65.0, 67.0, 66.0, 65.0, 66.0, 66.0], "value": 65.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 65.0, 68.0, 65.0, 66.0, 66.0, 66.0, 67.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 84.0, 84.0, 83.0, 89.0, 83.0, 83.0, 82.0, 90.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 139.0, 138.0, 138.0, 161.0, 140.0, 143.0, 139.0, 177.0, 139.0], "value": 145.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 177.0, 184.0, 179.0, 177.0, 177.0, 176.0, 174.0, 176.0, 185.0], "value": 178.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 70.0, 72.0, 70.0, 71.0, 71.0, 73.0, 71.0, 70.0], "value": 71.5, "unit": "score"}], "name": "kraken", "value": 1566.8999999999999, "alertThreshold": 2.0}]} 02:52:41 INFO - Return code: 0 02:52:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:52:41 INFO - # TBPL SUCCESS # 02:52:41 INFO - Running post-action listener: _resource_record_post_action 02:52:41 INFO - [mozharness: 2016-10-13 09:52:41.175320Z] Finished run-tests step (success) 02:52:41 INFO - Running post-run listener: _resource_record_post_run 02:52:41 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 196608; Write bytes: 393068544; Read time: 52; Write time: 333528 02:52:41 INFO - TinderboxPrint: CPU usage
13.0% 02:52:41 INFO - TinderboxPrint: I/O read bytes / time
196,608 / 52 02:52:41 INFO - TinderboxPrint: I/O write bytes / time
393,068,544 / 333,528 02:52:41 INFO - TinderboxPrint: CPU idle
8,361.0 (87.0%) 02:52:41 INFO - TinderboxPrint: CPU user
1,205.0 (12.5%) 02:52:41 INFO - TinderboxPrint: Swap in / out
0 / 0 02:52:41 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 101937152; Read time: 0; Write time: 112936 02:52:41 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 192512; Write bytes: 291131392; Read time: 40; Write time: 220592 02:52:41 INFO - Running post-run listener: _upload_blobber_files 02:52:41 INFO - Blob upload gear active. 02:52:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:52:41 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 02:52:41 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:52:41 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:52:42 INFO - (blobuploader) - INFO - Open directory for files ... 02:52:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:52:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:52:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:52:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:52:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:52:42 INFO - (blobuploader) - INFO - Done attempting. 02:52:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:52:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:52:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:52:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:52:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:52:43 INFO - (blobuploader) - INFO - Done attempting. 02:52:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:52:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:52:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:52:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:52:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:52:47 INFO - (blobuploader) - INFO - Done attempting. 02:52:47 INFO - (blobuploader) - INFO - Iteration through files over. 02:52:47 INFO - Return code: 0 02:52:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:52:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:52:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6a18ff0d117c57d114ebaec1da517384ce6cb6e5376953a5cf27f4bfe2b1889c0b4ca67a885f6a4b4be599f4930c4c56ce7d630e4fd3040e035aebd6c2eed058", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/557dc0e7e9a45636b37b30e97107a6f9847566f086fe6a6a8388c5ea161930653e9e7566bb9c120f6f93839c886ddafcc3ae00a07101a9f16bfb0a44700fbb16", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/90971ffa1be9d4f84fd19580995d1a91fa7070f31bd2153a1fdc96071b6e10221fba73827b0abf39e7eca9473d33953e81ba357fcb4da755acfa67c7e5d557d1"} 02:52:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:52:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:52:47 INFO - Contents: 02:52:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6a18ff0d117c57d114ebaec1da517384ce6cb6e5376953a5cf27f4bfe2b1889c0b4ca67a885f6a4b4be599f4930c4c56ce7d630e4fd3040e035aebd6c2eed058", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/557dc0e7e9a45636b37b30e97107a6f9847566f086fe6a6a8388c5ea161930653e9e7566bb9c120f6f93839c886ddafcc3ae00a07101a9f16bfb0a44700fbb16", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/90971ffa1be9d4f84fd19580995d1a91fa7070f31bd2153a1fdc96071b6e10221fba73827b0abf39e7eca9473d33953e81ba357fcb4da755acfa67c7e5d557d1"} 02:52:47 INFO - Running post-run listener: copy_logs_to_upload_dir 02:52:47 INFO - Copying logs to upload dir... 02:52:47 INFO - mkdir: /builds/slave/test/build/upload/logs 02:52:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.770438 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-10-13 02:52:47.193430) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 02:52:47.196527) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1476351113.879051-1713229139 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6a18ff0d117c57d114ebaec1da517384ce6cb6e5376953a5cf27f4bfe2b1889c0b4ca67a885f6a4b4be599f4930c4c56ce7d630e4fd3040e035aebd6c2eed058", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/557dc0e7e9a45636b37b30e97107a6f9847566f086fe6a6a8388c5ea161930653e9e7566bb9c120f6f93839c886ddafcc3ae00a07101a9f16bfb0a44700fbb16", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/90971ffa1be9d4f84fd19580995d1a91fa7070f31bd2153a1fdc96071b6e10221fba73827b0abf39e7eca9473d33953e81ba357fcb4da755acfa67c7e5d557d1"} build_url:https://queue.taskcluster.net/v1/task/DwyAgT8-RjmwDoHdRS0XeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011404 build_url: 'https://queue.taskcluster.net/v1/task/DwyAgT8-RjmwDoHdRS0XeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6a18ff0d117c57d114ebaec1da517384ce6cb6e5376953a5cf27f4bfe2b1889c0b4ca67a885f6a4b4be599f4930c4c56ce7d630e4fd3040e035aebd6c2eed058", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/557dc0e7e9a45636b37b30e97107a6f9847566f086fe6a6a8388c5ea161930653e9e7566bb9c120f6f93839c886ddafcc3ae00a07101a9f16bfb0a44700fbb16", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/90971ffa1be9d4f84fd19580995d1a91fa7070f31bd2153a1fdc96071b6e10221fba73827b0abf39e7eca9473d33953e81ba357fcb4da755acfa67c7e5d557d1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 02:52:47.221014) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 02:52:47.221315) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1476351113.879051-1713229139 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 02:52:47.303812) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 02:52:47.304118) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 02:52:47.304392) ========= ========= Total master_lag: 0.17 =========