builder: autoland_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-039 starttime: 1475792315.96 results: success (0) buildid: 20161006123033 builduid: 87b95f55188d4e6c8ac54af0de8ff24d revision: 299fcfa7652e340de5b5ac2dbea0c8e5dfdeb9f6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 15:18:35.964466) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 15:18:35.965224) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 15:18:35.965710) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 15:18:36.045996) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 15:18:36.046323) ========= 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=5bd038846534b2fdfa68eeae000001e2-1475792103.784364-380280811 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-06 15:18:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.1M=0s 2016-10-06 15:18:36 (70.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125723 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 15:18:36.189037) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 15:18:36.189345) ========= 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=5bd038846534b2fdfa68eeae000001e2-1475792103.784364-380280811 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017040 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 15:18:36.240849) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 15:18:36.241187) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 299fcfa7652e340de5b5ac2dbea0c8e5dfdeb9f6 --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 299fcfa7652e340de5b5ac2dbea0c8e5dfdeb9f6 --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=5bd038846534b2fdfa68eeae000001e2-1475792103.784364-380280811 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-06 15:18:36,611 truncating revision to first 12 chars 2016-10-06 15:18:36,611 Setting DEBUG logging. 2016-10-06 15:18:36,611 attempt 1/10 2016-10-06 15:18:36,611 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/299fcfa7652e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 15:18:37,120 unpacking tar archive at: autoland-299fcfa7652e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.885562 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 15:18:37.140247) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 15:18:37.140556) ========= script_repo_revision: 299fcfa7652e340de5b5ac2dbea0c8e5dfdeb9f6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 15:18:37.141030) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 15:18:37.141332) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 15:18:37.155668) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-10-06 15:18:37.155949) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=5bd038846534b2fdfa68eeae000001e2-1475792103.784364-380280811 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:18:37 INFO - MultiFileLogger online at 20161006 15:18:37 in /builds/slave/test 15:18:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 15:18:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:18:37 INFO - {'append_to_log': False, 15:18:37 INFO - 'base_work_dir': '/builds/slave/test', 15:18:37 INFO - 'blob_upload_branch': 'Autoland', 15:18:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:18:37 INFO - 'branch': 'Autoland', 15:18:37 INFO - 'buildbot_json_path': 'buildprops.json', 15:18:37 INFO - 'config_files': ('talos/linux_config.py',), 15:18:37 INFO - 'default_actions': ('clobber', 15:18:37 INFO - 'read-buildbot-config', 15:18:37 INFO - 'download-and-extract', 15:18:37 INFO - 'populate-webroot', 15:18:37 INFO - 'create-virtualenv', 15:18:37 INFO - 'install', 15:18:37 INFO - 'run-tests'), 15:18:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:18:37 INFO - 'download_minidump_stackwalk': True, 15:18:37 INFO - 'download_symbols': 'ondemand', 15:18:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:18:37 INFO - 'tooltool.py': '/tools/tooltool.py', 15:18:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:18:37 INFO - '/tools/misc-python/virtualenv.py')}, 15:18:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:18:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:18:37 INFO - 'installer_path': 'installer.exe', 15:18:37 INFO - 'log_level': 'info', 15:18:37 INFO - 'log_name': 'talos', 15:18:37 INFO - 'log_to_console': True, 15:18:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:18:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:18:37 INFO - 'opt_config_files': (), 15:18:37 INFO - 'pip_index': False, 15:18:37 INFO - 'sps_profile': False, 15:18:37 INFO - 'sps_profile_interval': 0, 15:18:37 INFO - 'suite': 'dromaeojs', 15:18:37 INFO - 'system_bits': '32', 15:18:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:18:37 INFO - 'title': 'talos-linux64-ix-039', 15:18:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:18:37 INFO - 'use_talos_json': True, 15:18:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:18:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:18:37 INFO - 'work_dir': 'build'} 15:18:37 INFO - [mozharness: 2016-10-06 22:18:37.625296Z] Running clobber step. 15:18:37 INFO - Running pre-action listener: _resource_record_pre_action 15:18:37 INFO - Running main action method: clobber 15:18:37 INFO - rmtree: /builds/slave/test/build 15:18:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:18:38 INFO - Running post-action listener: _resource_record_post_action 15:18:38 INFO - [mozharness: 2016-10-06 22:18:38.083619Z] Finished clobber step (success) 15:18:38 INFO - [mozharness: 2016-10-06 22:18:38.083720Z] Running read-buildbot-config step. 15:18:38 INFO - Running pre-action listener: _resource_record_pre_action 15:18:38 INFO - Running main action method: read_buildbot_config 15:18:38 INFO - Using buildbot properties: 15:18:38 INFO - { 15:18:38 INFO - "project": "", 15:18:38 INFO - "product": "firefox", 15:18:38 INFO - "script_repo_revision": "production", 15:18:38 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 15:18:38 INFO - "repository": "", 15:18:38 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs", 15:18:38 INFO - "buildid": "20161006123033", 15:18:38 INFO - "pgo_build": "True", 15:18:38 INFO - "basedir": "/builds/slave/test", 15:18:38 INFO - "buildnumber": 319, 15:18:38 INFO - "slavename": "talos-linux64-ix-039", 15:18:38 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:18:38 INFO - "platform": "ubuntu64_hw", 15:18:38 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 15:18:38 INFO - "branch": "autoland", 15:18:38 INFO - "repo_path": "integration/autoland", 15:18:38 INFO - "revision": "299fcfa7652e340de5b5ac2dbea0c8e5dfdeb9f6", 15:18:38 INFO - "stage_platform": "linux64-pgo", 15:18:38 INFO - "builduid": "87b95f55188d4e6c8ac54af0de8ff24d", 15:18:38 INFO - "slavebuilddir": "test" 15:18:38 INFO - } 15:18:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/Uk5FJr2lQZa1tkty3UwyNQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 15:18:38 INFO - Running post-action listener: _resource_record_post_action 15:18:38 INFO - [mozharness: 2016-10-06 22:18:38.086164Z] Finished read-buildbot-config step (success) 15:18:38 INFO - [mozharness: 2016-10-06 22:18:38.086253Z] Running download-and-extract step. 15:18:38 INFO - Running pre-action listener: _resource_record_pre_action 15:18:38 INFO - Running main action method: download_and_extract 15:18:38 INFO - mkdir: /builds/slave/test/build/tests 15:18:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:18:38 INFO - trying https://queue.taskcluster.net/v1/task/Uk5FJr2lQZa1tkty3UwyNQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:18:38 INFO - Downloading https://queue.taskcluster.net/v1/task/Uk5FJr2lQZa1tkty3UwyNQ/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 15:18:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Uk5FJr2lQZa1tkty3UwyNQ/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 15:18:38 INFO - Downloaded 1361 bytes. 15:18:38 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:18:38 INFO - Using the following test package requirements: 15:18:38 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:18:38 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:18:38 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:18:38 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:18:38 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:18:38 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:18:38 INFO - u'jsshell-linux-x86_64.zip'], 15:18:38 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:18:38 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:18:38 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:18:38 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:18:38 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:18:38 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:18:38 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:18:38 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:18:38 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:18:38 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:18:38 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:18:38 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:18:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Uk5FJr2lQZa1tkty3UwyNQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:18:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Uk5FJr2lQZa1tkty3UwyNQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:18:38 INFO - Fetch https://queue.taskcluster.net/v1/task/Uk5FJr2lQZa1tkty3UwyNQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:18:39 INFO - Http code: 200 15:18:39 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 15:18:39 INFO - x-amz-cf-id: 8-eoUYeP0NBA_W2cQqUo2a5zWh8HDGGY_7miqPB00YyXwgCVYIdWlA== 15:18:39 INFO - x-amz-version-id: rHvtOD5_Txc.h3YwDdMya1XYw6Ichn9H 15:18:41 INFO - Expected file size: 22017730 15:18:41 INFO - Obtained file size: 22017730 15:18:45 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 15:18:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Uk5FJr2lQZa1tkty3UwyNQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:18:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Uk5FJr2lQZa1tkty3UwyNQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:18:45 INFO - Fetch https://queue.taskcluster.net/v1/task/Uk5FJr2lQZa1tkty3UwyNQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:18:45 INFO - Http code: 200 15:18:45 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 15:18:45 INFO - x-amz-cf-id: x0ttAA0BkvqE9JzN6WEwA3C-TjuIigddU_tV0SN0E5rtc-ePVyYgcQ== 15:18:45 INFO - x-amz-version-id: rHvtOD5_Txc.h3YwDdMya1XYw6Ichn9H 15:18:46 INFO - Expected file size: 22017730 15:18:46 INFO - Obtained file size: 22017730 15:18:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Uk5FJr2lQZa1tkty3UwyNQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 15:18:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Uk5FJr2lQZa1tkty3UwyNQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:18:50 INFO - Fetch https://queue.taskcluster.net/v1/task/Uk5FJr2lQZa1tkty3UwyNQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:18:51 INFO - Http code: 200 15:18:51 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 15:18:51 INFO - x-amz-cf-id: 1HlUZB0ARivOA_w9jBJ33mlFRVQ9-L-OoIVkb3jLcTXiOv_I286wEg== 15:18:51 INFO - x-amz-version-id: JWWdLraT9atkIk0v3pKOvkvvnj7gevSB 15:18:52 INFO - Expected file size: 14409006 15:18:52 INFO - Obtained file size: 14409006 15:18: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')]} 15:18:52 INFO - trying https://queue.taskcluster.net/v1/task/Uk5FJr2lQZa1tkty3UwyNQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:18:52 INFO - Downloading https://queue.taskcluster.net/v1/task/Uk5FJr2lQZa1tkty3UwyNQ/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 15:18:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Uk5FJr2lQZa1tkty3UwyNQ/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 15:18:54 INFO - Downloaded 59698450 bytes. 15:18:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Uk5FJr2lQZa1tkty3UwyNQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:18:54 INFO - mkdir: /builds/slave/test/properties 15:18:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:18:54 INFO - Writing to file /builds/slave/test/properties/build_url 15:18:54 INFO - Contents: 15:18:54 INFO - build_url:https://queue.taskcluster.net/v1/task/Uk5FJr2lQZa1tkty3UwyNQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:18:54 INFO - Running post-action listener: _resource_record_post_action 15:18:54 INFO - Running post-action listener: set_extra_try_arguments 15:18:54 INFO - [mozharness: 2016-10-06 22:18:54.939882Z] Finished download-and-extract step (success) 15:18:54 INFO - [mozharness: 2016-10-06 22:18:54.940110Z] Running populate-webroot step. 15:18:54 INFO - Running pre-action listener: _resource_record_pre_action 15:18:54 INFO - Running main action method: populate_webroot 15:18:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:18:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:18:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:18:54 INFO - '--tppagecycles', 15:18:54 INFO - '7'], 15:18:54 INFO - 'tests': ['tsvgm']}}, 15:18:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:18:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:18:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:18:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:18:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:18:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:18:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:54 INFO - 'talos_options': ['--disable-e10s'], 15:18:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:18:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:18:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:54 INFO - 'talos_options': ['--disable-e10s'], 15:18:54 INFO - 'tests': ['damp', 'tps']}, 15:18:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:54 INFO - 'tests': ['damp', 'tps']}, 15:18:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:18:54 INFO - 'tests': ['dromaeo_dom']}, 15:18:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:18:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:18:54 INFO - 'tests': ['basic_compositor_video']}, 15:18:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:18:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:18:54 INFO - 'tests': ['a11yr', 15:18:54 INFO - 'ts_paint', 15:18:54 INFO - 'tpaint', 15:18:54 INFO - 'sessionrestore', 15:18:54 INFO - 'sessionrestore_no_auto_restore', 15:18:54 INFO - 'tabpaint']}, 15:18:54 INFO - 'other-e10s': {'tests': ['a11yr', 15:18:54 INFO - 'ts_paint', 15:18:54 INFO - 'tpaint', 15:18:54 INFO - 'sessionrestore', 15:18:54 INFO - 'sessionrestore_no_auto_restore', 15:18:54 INFO - 'tabpaint']}, 15:18:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:18:54 INFO - 'ts_paint', 15:18:54 INFO - 'tpaint', 15:18:54 INFO - 'sessionrestore', 15:18:54 INFO - 'sessionrestore_no_auto_restore', 15:18:54 INFO - 'tabpaint']}, 15:18:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:18:54 INFO - 'ts_paint', 15:18:54 INFO - 'tpaint', 15:18:54 INFO - 'sessionrestore', 15:18:54 INFO - 'sessionrestore_no_auto_restore', 15:18:54 INFO - 'tabpaint']}, 15:18:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:18:54 INFO - 'tests': ['a11yr', 15:18:54 INFO - 'ts_paint', 15:18:54 INFO - 'tpaint', 15:18:54 INFO - 'sessionrestore', 15:18:54 INFO - 'sessionrestore_no_auto_restore', 15:18:54 INFO - 'tabpaint']}, 15:18:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:18:54 INFO - 'tests': ['a11yr', 15:18:54 INFO - 'ts_paint', 15:18:54 INFO - 'tpaint', 15:18:54 INFO - 'sessionrestore', 15:18:54 INFO - 'sessionrestore_no_auto_restore', 15:18:54 INFO - 'tabpaint']}, 15:18:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:18:54 INFO - 'tests': ['tsvgx', 15:18:54 INFO - 'tsvgr_opacity', 15:18:54 INFO - 'tart', 15:18:54 INFO - 'tscrollx', 15:18:54 INFO - 'cart']}, 15:18:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:18:54 INFO - 'tsvgr_opacity', 15:18:54 INFO - 'tart', 15:18:54 INFO - 'tscrollx', 15:18:54 INFO - 'cart']}, 15:18:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:54 INFO - 'talos_options': ['--disable-e10s'], 15:18:54 INFO - 'tests': ['tp5o']}, 15:18:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:54 INFO - 'tests': ['tp5o']}, 15:18:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:54 INFO - 'talos_options': ['--disable-e10s', 15:18:54 INFO - '--xperf_path', 15:18:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:18:54 INFO - 'tests': ['tp5n']}, 15:18:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:54 INFO - 'talos_options': ['--xperf_path', 15:18:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:18:54 INFO - 'tests': ['tp5n']}}, 15:18:54 INFO - 'talos.zip': {'path': '', 15:18:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:18:54 INFO - Running post-action listener: _resource_record_post_action 15:18:54 INFO - [mozharness: 2016-10-06 22:18:54.959943Z] Finished populate-webroot step (success) 15:18:54 INFO - [mozharness: 2016-10-06 22:18:54.960032Z] Running create-virtualenv step. 15:18:54 INFO - Running pre-action listener: _resource_record_pre_action 15:18:54 INFO - Running main action method: create_virtualenv 15:18:54 INFO - Creating virtualenv /builds/slave/test/build/venv 15:18:54 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 15:18:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:18:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:18:55 INFO - Using real prefix '/usr' 15:18:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:18:55 INFO - Installing distribute.............................................................................................................................................................................................done. 15:18:57 INFO - Installing pip.................done. 15:18:57 INFO - Return code: 0 15:18:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:18:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:18:57 INFO - Reading from file tmpfile_stdout 15:18:57 INFO - Output received: 15:18:57 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) 15:18:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:18:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:18:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6610338f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a67930>, '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 0x1a68830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a68cc0>, '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': '5bd038846534b2fdfa68eeae000001e2-1475792103.784364-380280811', '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 15:18:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:18:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:18:57 INFO - Using env: {'DISPLAY': ':0', 15:18:57 INFO - 'HOME': '/home/cltbld', 15:18:57 INFO - 'LANG': 'en_US.UTF-8', 15:18:57 INFO - 'LANGUAGE': 'en_US:en', 15:18:57 INFO - 'LOGNAME': 'cltbld', 15:18:57 INFO - 'MAIL': '/var/mail/cltbld', 15:18:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:57 INFO - 'MOZ_NO_REMOTE': '1', 15:18:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:57 INFO - 'NO_EM_RESTART': '1', 15:18:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:57 INFO - 'PWD': '/builds/slave/test', 15:18:57 INFO - 'SHELL': '/bin/bash', 15:18:57 INFO - 'SHLVL': '1', 15:18:57 INFO - 'TERM': 'linux', 15:18:57 INFO - 'TMOUT': '86400', 15:18:57 INFO - 'USER': 'cltbld', 15:18:57 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1475792103.784364-380280811', 15:18:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:57 INFO - '_': '/tools/buildbot/bin/python'} 15:18:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:57 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 15:18:57 INFO - Cleaning up... 15:18:57 INFO - Return code: 0 15:18:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:18:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:18:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6610338f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a67930>, '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 0x1a68830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a68cc0>, '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': '5bd038846534b2fdfa68eeae000001e2-1475792103.784364-380280811', '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 15:18:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:18:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:18:57 INFO - Using env: {'DISPLAY': ':0', 15:18:57 INFO - 'HOME': '/home/cltbld', 15:18:57 INFO - 'LANG': 'en_US.UTF-8', 15:18:57 INFO - 'LANGUAGE': 'en_US:en', 15:18:57 INFO - 'LOGNAME': 'cltbld', 15:18:57 INFO - 'MAIL': '/var/mail/cltbld', 15:18:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:57 INFO - 'MOZ_NO_REMOTE': '1', 15:18:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:57 INFO - 'NO_EM_RESTART': '1', 15:18:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:57 INFO - 'PWD': '/builds/slave/test', 15:18:57 INFO - 'SHELL': '/bin/bash', 15:18:57 INFO - 'SHLVL': '1', 15:18:57 INFO - 'TERM': 'linux', 15:18:57 INFO - 'TMOUT': '86400', 15:18:57 INFO - 'USER': 'cltbld', 15:18:57 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1475792103.784364-380280811', 15:18:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:57 INFO - '_': '/tools/buildbot/bin/python'} 15:18:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:58 INFO - Downloading/unpacking psutil>=3.1.1 15:18:58 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 15:18:58 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 15:18:58 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 15:18:58 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 15:18:58 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 15:18:58 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 15:19:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:19:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:19:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:19:00 INFO - Installing collected packages: psutil 15:19:00 INFO - Running setup.py install for psutil 15:19:00 INFO - building 'psutil._psutil_linux' extension 15:19:00 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 15:19:00 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 15:19:00 INFO - building 'psutil._psutil_posix' extension 15:19:00 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 15:19:00 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 15:19:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:19:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:19:00 INFO - Successfully installed psutil 15:19:00 INFO - Cleaning up... 15:19:00 INFO - Return code: 0 15:19:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:19:00 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')]} 15:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:00 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')]} 15:19:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:00 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 0x7f6610338f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a67930>, '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 0x1a68830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a68cc0>, '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': '5bd038846534b2fdfa68eeae000001e2-1475792103.784364-380280811', '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 15:19:00 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 15:19:00 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 15:19:00 INFO - Using env: {'DISPLAY': ':0', 15:19:00 INFO - 'HOME': '/home/cltbld', 15:19:00 INFO - 'LANG': 'en_US.UTF-8', 15:19:00 INFO - 'LANGUAGE': 'en_US:en', 15:19:00 INFO - 'LOGNAME': 'cltbld', 15:19:00 INFO - 'MAIL': '/var/mail/cltbld', 15:19:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:00 INFO - 'MOZ_NO_REMOTE': '1', 15:19:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:00 INFO - 'NO_EM_RESTART': '1', 15:19:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:00 INFO - 'PWD': '/builds/slave/test', 15:19:00 INFO - 'SHELL': '/bin/bash', 15:19:00 INFO - 'SHLVL': '1', 15:19:00 INFO - 'TERM': 'linux', 15:19:00 INFO - 'TMOUT': '86400', 15:19:00 INFO - 'USER': 'cltbld', 15:19:00 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1475792103.784364-380280811', 15:19:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:00 INFO - '_': '/tools/buildbot/bin/python'} 15:19:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:19:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:19:02 INFO - Installing collected packages: mozsystemmonitor 15:19:02 INFO - Running setup.py install for mozsystemmonitor 15:19:03 INFO - Successfully installed mozsystemmonitor 15:19:03 INFO - Cleaning up... 15:19:03 INFO - Return code: 0 15:19:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:03 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 0x7f6610338f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a67930>, '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 0x1a68830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a68cc0>, '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': '5bd038846534b2fdfa68eeae000001e2-1475792103.784364-380280811', '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 15:19:03 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 15:19:03 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 15:19:03 INFO - Using env: {'DISPLAY': ':0', 15:19:03 INFO - 'HOME': '/home/cltbld', 15:19:03 INFO - 'LANG': 'en_US.UTF-8', 15:19:03 INFO - 'LANGUAGE': 'en_US:en', 15:19:03 INFO - 'LOGNAME': 'cltbld', 15:19:03 INFO - 'MAIL': '/var/mail/cltbld', 15:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:03 INFO - 'MOZ_NO_REMOTE': '1', 15:19:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:03 INFO - 'NO_EM_RESTART': '1', 15:19:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:03 INFO - 'PWD': '/builds/slave/test', 15:19:03 INFO - 'SHELL': '/bin/bash', 15:19:03 INFO - 'SHLVL': '1', 15:19:03 INFO - 'TERM': 'linux', 15:19:03 INFO - 'TMOUT': '86400', 15:19:03 INFO - 'USER': 'cltbld', 15:19:03 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1475792103.784364-380280811', 15:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:03 INFO - '_': '/tools/buildbot/bin/python'} 15:19:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:03 INFO - Downloading/unpacking jsonschema==2.5.1 15:19:03 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 15:19:03 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 15:19:03 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 15:19:03 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 15:19:03 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 15:19:03 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 15:19:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:19:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:05 INFO - Downloading functools32-3.2.3-2.tar.gz 15:19:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:19:05 INFO - warning: no files found matching '*.txt' 15:19:05 INFO - no previously-included directories found matching 'build' 15:19:05 INFO - no previously-included directories found matching 'dist' 15:19:05 INFO - no previously-included directories found matching '.git*' 15:19:05 INFO - Installing collected packages: jsonschema, functools32 15:19:05 INFO - Running setup.py install for functools32 15:19:05 INFO - warning: no files found matching '*.txt' 15:19:05 INFO - no previously-included directories found matching 'build' 15:19:05 INFO - no previously-included directories found matching 'dist' 15:19:05 INFO - no previously-included directories found matching '.git*' 15:19:05 INFO - Successfully installed jsonschema functools32 15:19:05 INFO - Cleaning up... 15:19:05 INFO - Return code: 0 15:19:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:05 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 0x7f6610338f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a67930>, '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 0x1a68830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a68cc0>, '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': '5bd038846534b2fdfa68eeae000001e2-1475792103.784364-380280811', '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 15:19:05 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 15:19:05 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 15:19:05 INFO - Using env: {'DISPLAY': ':0', 15:19:05 INFO - 'HOME': '/home/cltbld', 15:19:05 INFO - 'LANG': 'en_US.UTF-8', 15:19:05 INFO - 'LANGUAGE': 'en_US:en', 15:19:05 INFO - 'LOGNAME': 'cltbld', 15:19:05 INFO - 'MAIL': '/var/mail/cltbld', 15:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:05 INFO - 'MOZ_NO_REMOTE': '1', 15:19:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:05 INFO - 'NO_EM_RESTART': '1', 15:19:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:05 INFO - 'PWD': '/builds/slave/test', 15:19:05 INFO - 'SHELL': '/bin/bash', 15:19:05 INFO - 'SHLVL': '1', 15:19:05 INFO - 'TERM': 'linux', 15:19:05 INFO - 'TMOUT': '86400', 15:19:05 INFO - 'USER': 'cltbld', 15:19:05 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1475792103.784364-380280811', 15:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:05 INFO - '_': '/tools/buildbot/bin/python'} 15:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:19:05 INFO - Cleaning up... 15:19:05 INFO - Return code: 0 15:19:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:05 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 0x7f6610338f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a67930>, '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 0x1a68830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a68cc0>, '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': '5bd038846534b2fdfa68eeae000001e2-1475792103.784364-380280811', '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 15:19:05 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 15:19:05 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 15:19:05 INFO - Using env: {'DISPLAY': ':0', 15:19:05 INFO - 'HOME': '/home/cltbld', 15:19:05 INFO - 'LANG': 'en_US.UTF-8', 15:19:05 INFO - 'LANGUAGE': 'en_US:en', 15:19:05 INFO - 'LOGNAME': 'cltbld', 15:19:05 INFO - 'MAIL': '/var/mail/cltbld', 15:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:05 INFO - 'MOZ_NO_REMOTE': '1', 15:19:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:05 INFO - 'NO_EM_RESTART': '1', 15:19:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:05 INFO - 'PWD': '/builds/slave/test', 15:19:05 INFO - 'SHELL': '/bin/bash', 15:19:05 INFO - 'SHLVL': '1', 15:19:05 INFO - 'TERM': 'linux', 15:19:05 INFO - 'TMOUT': '86400', 15:19:05 INFO - 'USER': 'cltbld', 15:19:05 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1475792103.784364-380280811', 15:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:05 INFO - '_': '/tools/buildbot/bin/python'} 15:19:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:06 INFO - Downloading/unpacking blobuploader==1.2.4 15:19:06 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 15:19:06 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 15:19:06 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 15:19:06 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 15:19:06 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 15:19:06 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 15:19:07 INFO - Downloading blobuploader-1.2.4.tar.gz 15:19:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:19:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:19:08 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 15:19:08 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 15:19:08 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 15:19:08 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 15:19:08 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 15:19:08 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 15:19:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:19:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:19:08 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 15:19:08 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 15:19:08 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 15:19:08 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 15:19:08 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 15:19:08 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 15:19:08 INFO - Downloading docopt-0.6.1.tar.gz 15:19:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:19:08 INFO - Installing collected packages: blobuploader, requests, docopt 15:19:08 INFO - Running setup.py install for blobuploader 15:19:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:19:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:19:08 INFO - Running setup.py install for requests 15:19:09 INFO - Running setup.py install for docopt 15:19:09 INFO - Successfully installed blobuploader requests docopt 15:19:09 INFO - Cleaning up... 15:19:09 INFO - Return code: 0 15:19:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:09 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 0x7f6610338f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a67930>, '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 0x1a68830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a68cc0>, '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': '5bd038846534b2fdfa68eeae000001e2-1475792103.784364-380280811', '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 15:19:09 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 15:19:09 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 15:19:09 INFO - Using env: {'DISPLAY': ':0', 15:19:09 INFO - 'HOME': '/home/cltbld', 15:19:09 INFO - 'LANG': 'en_US.UTF-8', 15:19:09 INFO - 'LANGUAGE': 'en_US:en', 15:19:09 INFO - 'LOGNAME': 'cltbld', 15:19:09 INFO - 'MAIL': '/var/mail/cltbld', 15:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:09 INFO - 'MOZ_NO_REMOTE': '1', 15:19:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:09 INFO - 'NO_EM_RESTART': '1', 15:19:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:09 INFO - 'PWD': '/builds/slave/test', 15:19:09 INFO - 'SHELL': '/bin/bash', 15:19:09 INFO - 'SHLVL': '1', 15:19:09 INFO - 'TERM': 'linux', 15:19:09 INFO - 'TMOUT': '86400', 15:19:09 INFO - 'USER': 'cltbld', 15:19:09 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1475792103.784364-380280811', 15:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:09 INFO - '_': '/tools/buildbot/bin/python'} 15:19:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:19:09 INFO - Running setup.py (path:/tmp/pip-_pNksR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:19:09 INFO - Running setup.py (path:/tmp/pip-M9jl5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:19:09 INFO - Running setup.py (path:/tmp/pip-IZRY4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:19:09 INFO - Running setup.py (path:/tmp/pip-YDYdJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:19:09 INFO - Running setup.py (path:/tmp/pip-hONv8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:19:09 INFO - Running setup.py (path:/tmp/pip-3SmKzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:19:10 INFO - Running setup.py (path:/tmp/pip-V6rCvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:19:10 INFO - Running setup.py (path:/tmp/pip-kdWfCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:19:10 INFO - Running setup.py (path:/tmp/pip-9iWF6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:19:10 INFO - Running setup.py (path:/tmp/pip-SgRt5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:19:10 INFO - Running setup.py (path:/tmp/pip-lY0zuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:19:10 INFO - Running setup.py (path:/tmp/pip-Zor7wZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:19:10 INFO - Running setup.py (path:/tmp/pip-fhGYs5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:19:10 INFO - Running setup.py (path:/tmp/pip-vCtCwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:19:10 INFO - Running setup.py (path:/tmp/pip-82vEcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:19:10 INFO - Running setup.py (path:/tmp/pip-zUTpMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:19:10 INFO - Running setup.py (path:/tmp/pip-JPCbvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:19:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:19:10 INFO - Running setup.py install for manifestparser 15:19:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:19:10 INFO - Running setup.py install for mozcrash 15:19:11 INFO - Running setup.py install for mozdebug 15:19:11 INFO - Running setup.py install for mozdevice 15:19:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:19:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:19:11 INFO - Running setup.py install for mozfile 15:19:11 INFO - Running setup.py install for mozhttpd 15:19:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:19:11 INFO - Running setup.py install for mozinfo 15:19:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:19:11 INFO - Running setup.py install for mozInstall 15:19:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:19:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:19:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:19:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:19:11 INFO - Running setup.py install for mozleak 15:19:11 INFO - Running setup.py install for mozlog 15:19:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:19:11 INFO - Running setup.py install for moznetwork 15:19:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:19:12 INFO - Running setup.py install for mozprocess 15:19:12 INFO - Running setup.py install for mozprofile 15:19:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:19:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:19:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:19:12 INFO - Running setup.py install for mozrunner 15:19:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:19:12 INFO - Running setup.py install for mozscreenshot 15:19:12 INFO - Running setup.py install for moztest 15:19:12 INFO - Running setup.py install for mozversion 15:19:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:19:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:19:12 INFO - Cleaning up... 15:19:12 INFO - Return code: 0 15:19:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:19:12 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')]} 15:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:12 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')]} 15:19:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:12 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 0x7f6610338f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a67930>, '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 0x1a68830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a68cc0>, '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': '5bd038846534b2fdfa68eeae000001e2-1475792103.784364-380280811', '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 15:19:12 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 15:19:12 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 15:19:12 INFO - Using env: {'DISPLAY': ':0', 15:19:12 INFO - 'HOME': '/home/cltbld', 15:19:12 INFO - 'LANG': 'en_US.UTF-8', 15:19:12 INFO - 'LANGUAGE': 'en_US:en', 15:19:12 INFO - 'LOGNAME': 'cltbld', 15:19:12 INFO - 'MAIL': '/var/mail/cltbld', 15:19:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:12 INFO - 'MOZ_NO_REMOTE': '1', 15:19:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:12 INFO - 'NO_EM_RESTART': '1', 15:19:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:12 INFO - 'PWD': '/builds/slave/test', 15:19:12 INFO - 'SHELL': '/bin/bash', 15:19:12 INFO - 'SHLVL': '1', 15:19:12 INFO - 'TERM': 'linux', 15:19:12 INFO - 'TMOUT': '86400', 15:19:12 INFO - 'USER': 'cltbld', 15:19:12 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1475792103.784364-380280811', 15:19:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:12 INFO - '_': '/tools/buildbot/bin/python'} 15:19:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:19:12 INFO - Running setup.py (path:/tmp/pip-sQJ1CM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:19:12 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)) 15:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:19:12 INFO - Running setup.py (path:/tmp/pip-8OnYyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:19:13 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)) 15:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:19:13 INFO - Running setup.py (path:/tmp/pip-2AVy7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:19:13 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)) 15:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:19:13 INFO - Running setup.py (path:/tmp/pip-m4lmMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:19:13 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)) 15:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:19:13 INFO - Running setup.py (path:/tmp/pip-hsUpmp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:19:13 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)) 15:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:19:13 INFO - Running setup.py (path:/tmp/pip-R8T2Yw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:19:13 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)) 15:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:19:13 INFO - Running setup.py (path:/tmp/pip-deUYWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:19:13 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)) 15:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:19:13 INFO - Running setup.py (path:/tmp/pip-4nD8gm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:19:13 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)) 15:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:19:13 INFO - Running setup.py (path:/tmp/pip-IMDFEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:19:13 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)) 15:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:19:13 INFO - Running setup.py (path:/tmp/pip-WrKmtF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:19:13 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)) 15:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:19:13 INFO - Running setup.py (path:/tmp/pip-fBmTUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:19:13 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)) 15:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:19:13 INFO - Running setup.py (path:/tmp/pip-htQTRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:19:13 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)) 15:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:19:13 INFO - Running setup.py (path:/tmp/pip-MOl5VP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:19:13 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)) 15:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:19:13 INFO - Running setup.py (path:/tmp/pip-TWPKf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:19:13 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)) 15:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:19:13 INFO - Running setup.py (path:/tmp/pip-haXLMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:19:13 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)) 15:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:19:13 INFO - Running setup.py (path:/tmp/pip-jiP4Mu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:19:14 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)) 15:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:19:14 INFO - Running setup.py (path:/tmp/pip-8E_DVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:19:14 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)) 15:19:14 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)) 15:19:14 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)) 15:19:14 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)) 15:19:14 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)) 15:19:14 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)) 15:19:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:19:14 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 15:19:14 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 15:19:14 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 15:19:14 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 15:19:14 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 15:19:14 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 15:19:16 INFO - Downloading blessings-1.6.tar.gz 15:19:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:19:16 INFO - Installing collected packages: blessings 15:19:16 INFO - Running setup.py install for blessings 15:19:16 INFO - Successfully installed blessings 15:19:16 INFO - Cleaning up... 15:19:16 INFO - Return code: 0 15:19:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:19:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:19:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:19:16 INFO - Reading from file tmpfile_stdout 15:19:16 INFO - Current package versions: 15:19:16 INFO - argparse == 1.2.1 15:19:16 INFO - blessings == 1.6 15:19:16 INFO - blobuploader == 1.2.4 15:19:16 INFO - docopt == 0.6.1 15:19:16 INFO - functools32 == 3.2.3-2 15:19:16 INFO - jsonschema == 2.5.1 15:19:16 INFO - manifestparser == 1.1 15:19:16 INFO - mozInstall == 1.12 15:19:16 INFO - mozcrash == 0.17 15:19:16 INFO - mozdebug == 0.1 15:19:16 INFO - mozdevice == 0.48 15:19:16 INFO - mozfile == 1.2 15:19:16 INFO - mozhttpd == 0.7 15:19:16 INFO - mozinfo == 0.9 15:19:16 INFO - mozleak == 0.1 15:19:16 INFO - mozlog == 3.4 15:19:16 INFO - moznetwork == 0.27 15:19:16 INFO - mozprocess == 0.23 15:19:16 INFO - mozprofile == 0.28 15:19:16 INFO - mozrunner == 6.12 15:19:16 INFO - mozscreenshot == 0.1 15:19:16 INFO - mozsystemmonitor == 0.3 15:19:16 INFO - moztest == 0.7 15:19:16 INFO - mozversion == 1.4 15:19:16 INFO - psutil == 3.1.1 15:19:16 INFO - requests == 1.2.3 15:19:16 INFO - wsgiref == 0.1.2 15:19:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:19: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')]} 15:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19: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')]} 15:19:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:16 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 0x7f6610338f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a67930>, '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 0x1a68830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a68cc0>, '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': '5bd038846534b2fdfa68eeae000001e2-1475792103.784364-380280811', '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 15:19:16 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 15:19:16 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 15:19:16 INFO - Using env: {'DISPLAY': ':0', 15:19:16 INFO - 'HOME': '/home/cltbld', 15:19:16 INFO - 'LANG': 'en_US.UTF-8', 15:19:16 INFO - 'LANGUAGE': 'en_US:en', 15:19:16 INFO - 'LOGNAME': 'cltbld', 15:19:16 INFO - 'MAIL': '/var/mail/cltbld', 15:19:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:16 INFO - 'MOZ_NO_REMOTE': '1', 15:19:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:16 INFO - 'NO_EM_RESTART': '1', 15:19:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:16 INFO - 'PWD': '/builds/slave/test', 15:19:16 INFO - 'SHELL': '/bin/bash', 15:19:16 INFO - 'SHLVL': '1', 15:19:16 INFO - 'TERM': 'linux', 15:19:16 INFO - 'TMOUT': '86400', 15:19:16 INFO - 'USER': 'cltbld', 15:19:16 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1475792103.784364-380280811', 15:19:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:16 INFO - '_': '/tools/buildbot/bin/python'} 15:19:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:16 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)) 15:19:16 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)) 15:19:16 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)) 15:19:16 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)) 15:19:16 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)) 15:19:16 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)) 15:19:16 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)) 15:19:16 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)) 15:19:16 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)) 15:19:16 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)) 15:19:16 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)) 15:19:16 INFO - Cleaning up... 15:19:16 INFO - Return code: 0 15:19:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:19: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')]} 15:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19: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')]} 15:19:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6610338f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a67930>, '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 0x1a68830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a68cc0>, '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': '5bd038846534b2fdfa68eeae000001e2-1475792103.784364-380280811', '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 15:19: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', 'jsonschema'] in /builds/slave/test/build 15:19: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 jsonschema 15:19:16 INFO - Using env: {'DISPLAY': ':0', 15:19:16 INFO - 'HOME': '/home/cltbld', 15:19:16 INFO - 'LANG': 'en_US.UTF-8', 15:19:16 INFO - 'LANGUAGE': 'en_US:en', 15:19:16 INFO - 'LOGNAME': 'cltbld', 15:19:16 INFO - 'MAIL': '/var/mail/cltbld', 15:19:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:16 INFO - 'MOZ_NO_REMOTE': '1', 15:19:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:16 INFO - 'NO_EM_RESTART': '1', 15:19:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:16 INFO - 'PWD': '/builds/slave/test', 15:19:16 INFO - 'SHELL': '/bin/bash', 15:19:16 INFO - 'SHLVL': '1', 15:19:16 INFO - 'TERM': 'linux', 15:19:16 INFO - 'TMOUT': '86400', 15:19:16 INFO - 'USER': 'cltbld', 15:19:16 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1475792103.784364-380280811', 15:19:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:16 INFO - '_': '/tools/buildbot/bin/python'} 15:19:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:19:16 INFO - Cleaning up... 15:19:16 INFO - Return code: 0 15:19:16 INFO - Running post-action listener: _resource_record_post_action 15:19:16 INFO - Running post-action listener: _start_resource_monitoring 15:19:17 INFO - Starting resource monitoring. 15:19:17 INFO - [mozharness: 2016-10-06 22:19:17.010154Z] Finished create-virtualenv step (success) 15:19:17 INFO - [mozharness: 2016-10-06 22:19:17.010714Z] Running install step. 15:19:17 INFO - Running pre-action listener: _resource_record_pre_action 15:19:17 INFO - Running main action method: install 15:19:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:19:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:19:17 INFO - Reading from file tmpfile_stdout 15:19:17 INFO - Detecting whether we're running mozinstall >=1.0... 15:19:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:19:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:19:17 INFO - Reading from file tmpfile_stdout 15:19:17 INFO - Output received: 15:19:17 INFO - Usage: mozinstall [options] installer 15:19:17 INFO - Options: 15:19:17 INFO - -h, --help show this help message and exit 15:19:17 INFO - -d DEST, --destination=DEST 15:19:17 INFO - Directory to install application into. [default: 15:19:17 INFO - "/builds/slave/test"] 15:19:17 INFO - --app=APP Application being installed. [default: firefox] 15:19:17 INFO - mkdir: /builds/slave/test/build/application 15:19:17 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'] 15:19:17 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 15:19:34 INFO - Reading from file tmpfile_stdout 15:19:34 INFO - Output received: 15:19:34 INFO - /builds/slave/test/build/application/firefox/firefox 15:19:34 INFO - Running post-action listener: _resource_record_post_action 15:19:34 INFO - [mozharness: 2016-10-06 22:19:34.328665Z] Finished install step (success) 15:19:34 INFO - [mozharness: 2016-10-06 22:19:34.328910Z] Running run-tests step. 15:19:34 INFO - Running pre-action listener: _resource_record_pre_action 15:19:34 INFO - Running main action method: run_tests 15:19:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:19:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:19:34 INFO - Python 2.7.3 15:19:34 INFO - Return code: 0 15:19:34 INFO - grabbing minidump binary from tooltool 15:19:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:34 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 0x1a67930>, '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 0x1a68830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a68cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:19:34 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 15:19:34 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 15:19:34 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 15:19:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:19:34 INFO - Return code: 0 15:19:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:19:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:19:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:19:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:19:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:19:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Uk5FJr2lQZa1tkty3UwyNQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 15:19:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Uk5FJr2lQZa1tkty3UwyNQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --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 15:19:34 INFO - Using env: {'DISPLAY': ':0', 15:19:34 INFO - 'HOME': '/home/cltbld', 15:19:34 INFO - 'LANG': 'en_US.UTF-8', 15:19:34 INFO - 'LANGUAGE': 'en_US:en', 15:19:34 INFO - 'LOGNAME': 'cltbld', 15:19:34 INFO - 'MAIL': '/var/mail/cltbld', 15:19:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:19:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:19:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:34 INFO - 'MOZ_NO_REMOTE': '1', 15:19:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:19:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:34 INFO - 'NO_EM_RESTART': '1', 15:19:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:34 INFO - 'PWD': '/builds/slave/test', 15:19:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:19:34 INFO - 'SHELL': '/bin/bash', 15:19:34 INFO - 'SHLVL': '1', 15:19:34 INFO - 'TERM': 'linux', 15:19:34 INFO - 'TMOUT': '86400', 15:19:34 INFO - 'USER': 'cltbld', 15:19:34 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1475792103.784364-380280811', 15:19:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:34 INFO - '_': '/tools/buildbot/bin/python'} 15:19:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Uk5FJr2lQZa1tkty3UwyNQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 15:19:34 INFO - mozversion application_buildid: 20161006123033 15:19:34 INFO - mozversion application_changeset: 299fcfa7652e340de5b5ac2dbea0c8e5dfdeb9f6 15:19:34 INFO - mozversion application_display_name: Nightly 15:19:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:19:34 INFO - mozversion application_name: Firefox 15:19:34 INFO - mozversion application_remotingname: firefox 15:19:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 15:19:34 INFO - mozversion application_vendor: Mozilla 15:19:34 INFO - mozversion application_version: 52.0a1 15:19:34 INFO - mozversion platform_buildid: 20161006123033 15:19:34 INFO - mozversion platform_changeset: 299fcfa7652e340de5b5ac2dbea0c8e5dfdeb9f6 15:19:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 15:19:34 INFO - mozversion platform_version: 52.0a1 15:19:34 INFO - using testdate: 1475792374 15:19:34 INFO - actual date: 1475792374 15:19:34 INFO - starting webserver on 'localhost:33833' 15:19:34 INFO - SUITE-START | Running 2 tests 15:19:34 INFO - TEST-START | dromaeo_css 15:19:34 INFO - operating with platform_type : linux_ 15:19:34 INFO - Initialising browser for dromaeo_css test... 15:19:34 INFO - TEST-INFO | started process 7554 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNb1ahm/profile http://localhost:33833/getInfo.html) 15:19:39 INFO - PROCESS | 7554 | __metrics Screen width/height:1600/1200 15:19:39 INFO - PROCESS | 7554 | colorDepth:24 15:19:39 INFO - PROCESS | 7554 | Browser inner width/height: 1024/697 15:19:39 INFO - PROCESS | 7554 | __metrics 15:19:39 INFO - PROCESS | 7554 | 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" 15:19:39 INFO - PROCESS | 7554 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:19:40 INFO - PROCESS | 7554 | console.error: PushService: 15:19:40 INFO - PROCESS | 7554 | stateChangeProcessEnqueue: Error transitioning state 15:19:40 INFO - PROCESS | 7554 | UnknownError 15:19:40 INFO - TEST-INFO | 7554: exit 0 15:19:40 INFO - Browser initialized. 15:19:40 INFO - Running cycle 1/1 for dromaeo_css test... 15:19:40 INFO - TEST-INFO | started process 7637 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNb1ahm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:19:52 INFO - PROCESS | 7637 | RSS: Main: 173551616 15:19:52 INFO - PROCESS | 7637 | 15:20:43 INFO - PROCESS | 7637 | 1475792443834 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] 15:22:54 INFO - PROCESS | 7637 | Cycle 1(1): loaded http://localhost:33833/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33833/tests/dromaeo/cssquery-ext.html) 15:22:55 INFO - PROCESS | 7637 | RSS: Main: 310345728 15:22:55 INFO - PROCESS | 7637 | 15:25:58 INFO - PROCESS | 7637 | Cycle 1(1): loaded http://localhost:33833/tests/dromaeo/cssquery-ext.html (next: http://localhost:33833/tests/dromaeo/cssquery-jquery.html) 15:25:59 INFO - PROCESS | 7637 | RSS: Main: 280469504 15:25:59 INFO - PROCESS | 7637 | 15:29:01 INFO - PROCESS | 7637 | Cycle 1(1): loaded http://localhost:33833/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33833/tests/dromaeo/cssquery-mootools.html) 15:29:01 INFO - PROCESS | 7637 | RSS: Main: 281010176 15:29:01 INFO - PROCESS | 7637 | 15:32:04 INFO - PROCESS | 7637 | Cycle 1(1): loaded http://localhost:33833/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33833/tests/dromaeo/cssquery-prototype.html) 15:32:04 INFO - PROCESS | 7637 | RSS: Main: 252485632 15:32:04 INFO - PROCESS | 7637 | 15:35:07 INFO - PROCESS | 7637 | Cycle 1(1): loaded http://localhost:33833/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33833/tests/dromaeo/cssquery-yui.html) 15:35:08 INFO - PROCESS | 7637 | RSS: Main: 217808896 15:35:08 INFO - PROCESS | 7637 | 15:38:11 INFO - PROCESS | 7637 | Cycle 1(1): loaded http://localhost:33833/tests/dromaeo/cssquery-yui.html (next: http://localhost:33833/tests/dromaeo/cssquery-dojo.html) 15:38:11 INFO - PROCESS | 7637 | RSS: Main: 303665152 15:38:11 INFO - PROCESS | 7637 | 15:38:11 INFO - PROCESS | 7637 | __start_tp_report 15:38:11 INFO - PROCESS | 7637 | _x_x_mozilla_page_load 15:38:11 INFO - PROCESS | 7637 | _x_x_mozilla_page_load_details 15:38:11 INFO - PROCESS | 7637 | |i|pagename|runs| 15:38:11 INFO - PROCESS | 7637 | |0;dojo.html;2931.443025825093;2978.597889284947;2981.612390389249;2999.7300242978126;3029.378977309652;4978.800847966077;5082.771275292612;5102.872428189293;5189.6886186828815;5206.843794686156;5115.155999260118;5130.846074617758;5189.8183563575285;5229.633925625208;5255.76349064292;4631.513691062441;4667.393238878941;4671.813127474897;4687.156311863863;4733.100710864942;4761.714297142183;4794.9280760788615;4808.110499557575;4838.395200599925;4866.951330486703;4609.67732258742;4649.465311489188;4659.091477161955;4764.475907650156;4837.9274310885185;4687.062587482517;4688.062387522475;4691.272852707836;4691.577758001762;4691.671582989192;4667.299905014241;4680.976595117037;4683.063387322515;4686.507916668769;4690.4605970313505;5094.694318340874;5130.743462826844;5131.820386286499;5141.562967147797;5147.356580427447;5420.970015697005;5438.211459338374;5449.618526703132;5516.420775818521;5521.779128834842;5450.100733378988;5461.563074953994;5522.475364840334;5533.667979921177;5535.335759708821;4990.5508504234795;5128.333316668809;5170.095233334151;5180.145276029413;5239.3712754469325;5429.185622156708;5563.276774019432;5598.608097433141;5643.435656434323;5651.943480565224;5380.542653874386;5410.540104091197;5411.621186516984;5413.648112872651;5416.295881535375;5333.626646134733;5459.317585301837;5488.506034456918;5494.945050549443;5560.110382338888;5362.946370536322;5402.540784033323;5444.156155795858;5450.373207081237;5521.4478552144465;5452.1276595745285;5467.07059799827;5467.480589344006;5468.316460442445;5528.281323427928;4259.850905218303;4263.616274535307;4267;4272.038791271939;4313.61177494027;3761.0409345616695;3796.52543432071;3811.561670407883;3827.8516445066925;3846.1538461538416;5270.998510283034;5272.525472707474;5273.1035723927025;5277.9472205278225;5300.098983172793;5482.835514934558;5496.120620700749;5502.889942201134;5504.504594586427;5513.117901135799;5123.795048198031;5124.154514505065;5182.170852663631;5228.503292187313;5228.764705588258;4753.738544380023;4762.9523704763205;4764.523547645277;4795.568398844121;4817;5686.715664216773;5694.658320500783;5696.971515142481;5705.7432415542235;5769.423057694281;5358.919616205682;5400.108982017923;5402.027635025576;5469.9179512306555;5482.39693633692;5588.385277619377;5598.188262701967;5606.971965140148;5614.943850561442;5625.071863142535;5356.0626890294825;5376.354837419378;5415.756290966837;5416.945830541802;5422.810201642924;5370.650907690988;5413.160960051198;5463.7814487420055;5481.150421684645;5511.807086751945;5227.790888364423;5372;5375.16684913839;5406.864828379322;5458.454154584669;5252.684838909678;5350.277712508761;5366.114591092426;5390.218418329398;5452.482014208644;5376.354837419534;5383.757730902197;5389.137737961907;5394.217838413487;5395.298611180521;5406.107992181246;5418.566514678895;5439.102548079681;5441;5441.374241962225;5117.5905927526455;5173.948260517347;5318.920216196838;5319.281896943863;5330.93381323729 15:38:11 INFO - PROCESS | 7637 | |1;ext.html;549.5047412396262;571.1546910572354;609.0407608017373;617.3240301869452;617.6170774120044;31670.52494212586;41243.58756412435;42182.78908605453;42211.57788422115;42265.366019509696;44632.330515042304;44857;45034;45048.77475612626;45158.54841451585;8133.633986470593;8318.45930014547;8994.595243214055;9166.954165229165;10597.470126493683;10375.636852710119;10755.677329680122;10761.946190269038;10787.460626968621;10789;10785.946070269638;10812.783744325108;10836.620718274862;10838.458077096113;10840.78318433631;8221.465604735673;8425.536595487245;10574.418406987612;10692.572297108145;10840.241183117185;10594.516767652534;10597.470126493645;10665.9466702666;10675.679729608046;10685.626003089932;41490.79254603738;41965;42192.36711449331;42222.57777422217;42318.36522452166;3378.9493157602656;3395.9490607640905;3399.6940275375337;3461.705755010827;3798.0929785123562;31118.844405778054;31175;31354.37291254185;31449.21376965571;31668.841655791803;4249.681273904439;4294.119705460374;4364.410804541378;4407.889802754925;4546.272596384596;250086;250479;250725;251391;252072;55738.44261557332;56184.15723764147;56349.71825140848;56733;56740.43259567351;58250.4174958245;58782;58792.70603646954;58815.41184588185;58835.41164588385;13635.727285454235;13920.095193812369;13934.721305574034;13937.442502299997;13942.093763905314;10462;10833.83749243762;11364.318140911571;11696.415179241005;11706.414679266003;16621.750673739905;16783.412580559623;16811.243494042796;16851.325946962228;16868.746968795476;6025.367336429612;6215.285242197115;6293.496520278367;6322.71547780351;6385.393387628168;894.7405252476839;1024.6823484719762;1050.8598170984567;1067.8291473364225;1111.4498323329842;31120.22199444987;31402;31445.685543144733;32017.359652806812;32071.358572828412;1099.769048499824;1104.6465131157952;1106.9391183484825;1131.7396998690347;1218.3603608105816;15610.687786244438;16421.425250116426;16663.50009499717;16708.41520546775;16942.491725248263;536485;539928;544496;545197;545696;55946;56072.43927560754;56168.15747763787;56221.43778562244;56271.437285627435;1205.5238180918489;1254.5609036837034;1272.376535497618;1314.7304802515462;1321.596912941562;28183.43633127367;31312;32191.195220119684;32597.674023259464;33111.50332744962;46766.76616617031;47265.52734472611;47413.28880066733;47413.525864740914;47416;404156;404769;405086;405452;405780;26438;27103.59344609872;27297.448612333294;28865.278368040967;38851.58948773421;44591.77704111459;45056.324155137045;45310;45958.310625339975;46485.3027204599;36998.44502332414;37650.62349376581;38658;40395;40951;38731.41902871403;38846;38946.80526597349;38988.41517377185;40207.19585608213;39290.410643840936;39793.60206398015;39795;39995.2000959985;40004.1999160021;33161.50257746087;35343.11642208965;35456.290874181854;36117.458238125924;36320.81839590785;27009.45981080328;27198.864005679847;27212;27429.45141097207;27435.86282068657 15:38:11 INFO - PROCESS | 7637 | |2;jquery.html;376.54626175458577;389.5578518381638;393.1919904596055;399.9880003599892;422.08407755171277;13276.734465310688;15231.086134831918;16920.746188807178;19187.808121918777;19658.115384807683;18073.1867065982;18675.71986420205;18713.941466438682;18816;18870;5666.150077488389;5907.409259074079;5907.822765317026;5908.202392676976;5909.320428150753;4868.951310486903;6363.968180159092;6405.775797847076;6524.4454221391;6527.249366322886;6267.185265915425;6454.128692626506;6459.029995851263;6467.417932386084;6483.935160648404;6432.163818703562;6464.967675161641;6468.773592924225;6469.191351081115;6470.644114573696;5579.246801681762;5676.659400435946;5680.829575112712;5701.57238207132;5701.77192912283;21544.461388465257;21774.673379899315;22320.21879234219;22362;22548.66177007346;2594.831335963175;2959.845660192527;3047.420990011891;3048.085574327693;3184.2039490127468;13938.93030534851;14431.567052988426;14437.339705933742;14626.707465850623;14635.121892686473;1876.840468560174;1884.2557189909908;1886.9622607547772;1891.6973284274588;1916.9137388817537;79939;85318;85920.57039714824;86450;87932.56033719855;10792.603698150924;10997.760636974372;11003.779924401468;11007.944960275308;11240.49417776202;15670.9216453917;15683.451079212173;15689.764653530206;15717.764233536505;15723.921380393025;7486.064241969754;7494.437917156235;7673.11759147694;7683.116441609175;7752.844943101107;6959.851624481904;7012.789616311519;7024.262452442522;7171.211166771651;7196.424286057103;4661.580457758818;4750.786214620351;4776.283557466339;4813.7593120343845;4834.564889159922;1916.8658193926292;1970.8423326133875;1994.3318988139135;1995.361484325002;2006.8695534790193;815.6492708135559;876.7808047988003;979.5934687104914;1002.9197664186847;1022.5296363672645;17525.561860953578;18762.155702993125;19135.80864191368;19162.71255931162;19542.804571954384;903.8282726281985;907.6505545365083;911.8677791720163;918.9448633082036;966.367029595616;10170.898291017143;10575.62985295511;10694.73263168427;10779.353238805697;10799.892001080047;325714;327702.3378597292;328466;469654;474221;91443.54278228566;96028.51985740027;96394.51802740942;96635;97642;983.2232536296389;998.3161534348994;1022.4274406332329;1035.1977217656226;1042.0777611813598;16537.91731041337;16630.334786608884;16810.495685129466;17273.65452690914;17926;32383;35816.64183358133;40194;40521.594784051784;41097;56312.43687563236;56599.43400566106;57476.425235747105;57981;59231;8144.185581442045;8440;8451.32389408858;8636.740897773077;8865.379423440298;10124.89875101269;12571.434285456993;12624.87375126237;12894.806577901527;12940.611781646565;11035.558577656804;11146.164037697366;11246.100311975186;11351.659450216506;11551.306921584732;11126.499307531343;11532.770824169245;11580.36308003068;11618.825717614412;11735.706607334885;10896.782064358827;11003.33979961205;11251.887481125084;11371.14716396257;11756.294622322688;8066.153053929253;8181;8296.626651800563;8553.144685531397;8772.868406974028;9626.855597166188;10709.357438553712;11639.418029098342;11806.291622502677;11806.586769463027 15:38:11 INFO - PROCESS | 7637 | |3;mootools.html;1289.6969212235128;1453.7673972164455;1461.7588097963833;1582.762585612158;1761.2602706863115;7736.342410895074;8446.450980686252;8840.557972101386;8862.379633425662;9163.175314221719;8829.911700882989;8900.688475903346;8922.732318030454;8928.866067009;8930.330225233118;2341.0752752662647;2345.413646588353;2364.6334818103137;2368.86971216583;2374.2283757778705;2196.2642514757576;2280.407094155515;2392.5932591459405;2393.2222027840935;2393.9760602393926;2342.6603142544404;2365.7752513511273;2374.0385144016614;2376.0852071952336;2377.7622237776172;2237.876916769577;2256.029907139929;2263.4341414646337;2264.909403623853;2292.5071109711494;2266.252136794854;2267.3878052925616;2271.5235097186796;2273.3180045986137;2274.226762900622;8720.476771393736;8807.77980550485;8862.158094980967;8887.644494220223;8902.065283145306;5180.481951804827;5369.060414427459;5371.973140134313;5427.375851777057;5441.319835020622;3281.1961069538115;3403.897883063512;3468.687818096358;3475.4786781982652;3488.6336934621754;1016.9542370593341;1042.0881728487573;1052.3054783842626;1064.6060957445795;1075.3279200499687;12242.81635775464;12250.632481025583;12305.077119216005;12338.75322493554;12385.690357741038;4324.17840610283;4398.3402489626815;4457.2645513489915;4545.749983750926;4608.216603177468;9722.805543889082;9726.17327527154;9732.951335243279;9739.26955478342;9749.415035097916;5167.483251674803;5177.3269474968765;5181.715005674724;5186.429492755794;5188.377394712583;4254.744715317091;4365.847195348148;4720.12677654635;4747.121782470254;4827.662063655511;3671.7613355132366;3685.355062863988;3777.282316359938;3829.0810205550465;3840.731148819556;1124.668222874254;1129.3675541696512;1137.2664631312757;1153.948072336747;1166.0904494494307;942.6794889737522;948.4025064209642;951.6098399656108;953.5708930981086;963.5471328475605;5929.584929054925;5949.524038076944;5974.61165024272;6086.513078953673;6321.873562528724;427.2395136656756;427.3333599584658;428.81775245520527;429.08604672048335;443.2332065526657;4051.6758659307775;4079.918401631951;4118.855840045584;4122.649574786176;4146.150039241948;10755.516001779939;11080.113590912708;11159.386233757059;11164.888351116548;11192.888071119347;11008.669739907815;11025.17311201647;11039.116870650329;11071.446427678584;11123.16576256784;7793.610319484116;8009.31920786728;8097.473664211808;8102.797430064295;8121.959390203129;6091.208142941389;6094.177286066324;6158.107074474086;6197.03945888388;6243.906341404791;10041.297109202285;10062.345947513388;10110.949445252727;10122.746931326776;10229.181665466893;9778.168855647065;10106.646267380607;10148.086672199537;10285.43430111351;10457.320274182153;6952.826179345557;7214.927850721636;7220.241874603301;7842.098158711821;8011.919880801117;8063.435559510778;8397.790055248668;8464.576771161293;8568.485890846569;8670.479771213748;7287;7387.113546374255;7542.547447153188;7828.256315650005;7922.286994170552;7416.9258307418395;7460.0674915635545;7511.286427789351;7526.774196774106;7821;6908.861822763617;7001.089858318386;7023.719051238098;7031.648417579203;7038.718451261892;5260.421353651172;5360.919586206132;5363.168708850135;5400.081986062457;5602.635828671123;5315.920261196008;5344.198370244494;5411.756470958895;5428.7014214217015;5553.750081246273 15:38:11 INFO - PROCESS | 7637 | |4;prototype.html;329.28485582795116;339.7536785830273;344.90342704042877;345.7787016309564;345.9135216195951;4975.925361119586;5168.560672342851;5214.452482489341;5233.162693968966;5262.421133675292;5105.1831706926805;5226.92159617606;5227.5295223429885;5234.8691282717955;5273.551748101407;4185.937210941838;4186.476690413699;4189.204051230272;4192.350185721218;4206.3690446432975;3867.284552357823;4093.2427500912427;4127.917441651165;4205.5794420558;4229.957700422987;4060.9847538115473;4073.307537718595;4074.857379991701;4076.653484453825;4093.2018256440006;4051.3112770828734;4062.8984275393054;4063.918721625566;4098.959010409888;4106.137711080677;3637.236180402119;3652;3661.3958696814993;3672.06362377592;3675.46705727668;5031.974840125813;5109;5113.488651134894;5140.460251673595;5165.793368265265;4671.902103005791;4674.410700361893;4675.251959686468;4678.461976872669;4703.882402939919;5416.891662166774;5430.402655707869;5450.656217826333;5452.263944367499;5462.289902312674;3829.9808500957315;3945.5462621798574;3960.6435420812263;3971.960280397188;3996.220736956295;5600.719964001783;5613.326400831886;5614.6631202128;5617.21359009739;5619.466150715675;3991.5808840071954;4048.332025215865;4049.4128351388886;4056.959430405658;4071.75569465833;4006.979965100214;4079.8368065277054;4088.8160032798;4115.629593336614;4119.155573107506;4635.010418280258;4639.327297541838;4640.120751095812;4656.580907718321;4665.930011049769;5411.621186516906;5415.268938693304;5470.699111548824;5504.91742623861;5563.443655634404;1295.8272763149364;1339.7387509435762;1379.7309524642799;1380.171896861895;1389.5622878793147;961.6538046303325;965.3146266151111;976.7069879036261;980.7057882635181;981.788915383196;5203.895922081537;5235.319408476874;5239.318888544465;5269.104252277122;5302.151655735064;5547.583931205176;5550.472705093091;5552.91670624941;5565.193047008162;5591.41290164535;5109.770060347293;5330.093884039723;5335.919961200585;5341.3857406398765;5358.973205134027;2967.6735559088484;2972.851357432163;2989.9850500747793;2991.880324786984;2995.4757917364373;5759.395263497357;5776.797812076557;5835.649861008268;5859.619124756877;5887.1757953885635;5638.844036972411;5683.692750667287;5735.5337205001415;5739.311282646109;5755.539556835443;5746.683932383759;5793.188953546507;5801.50687191585;5808.448197421239;5840.386759390203;5410.675359478444;5606.523445507014;5638.097904335286;5682.971585142048;5713.485786279255;5575.163725441216;5578.888422231452;5595.496405323541;5595.63628364155;5598.412166722435;5772.913406298993;5802.738876750472;5804.970975145097;5808.273965754281;5828.300603927386;3836.2711084894895;4010.0375909782024;4036.434899114068;4074.7351422157467;4092.4066010427728;5330.760115794721;5598.608097433304;5606.579506536945;5614.242077319673;5626.184203290418;5352.812651557177;5405.351357837085;5426.294581704353;5441.972790136024;5486.725663716878;5477;5491.395946445968;5493.148561972901;5511.472657499284;5517.172424136412;5249.632525723163;5436.891262174655;5467.507924286833;5503.3120859892515;5533.806316778893;5483.327585086587;5488.368837583729;5506.944930550803;5515.731381782292;5523.502884740393;5404.216388623706;5417.131089774021;5422.8373148805595;5426.294581704353;5458.399576046552 15:38:11 INFO - PROCESS | 7637 | |5;yui.html;703.8803403421418;704.8132244955091;720.2545365546664;764.2892110337384;786.182370334852;14643.121412715245;15531;15534.922325388357;15552.377904883806;15628.765568516466;15094;15171.620709482268;15181.696366072672;15199.772003419957;15202.391904323813;634.0615888485045;651.4983462733692;729.0813574895617;751.6204316819998;757.9962100189491;752.086215248473;752.3980815347727;753.0361137743697;753.175273075981;760.5170716594974;808.514891065359;809.9392545559107;810.84999275134;811.0956283743612;811.3914564076942;650.8991106378519;664.8138521214067;778.0546635837428;804.9557274349909;806.592670701295;589.0163427076792;592.4549414538635;593.1014513012789;593.3532449629881;593.5904226083989;15099.773503397459;15104.320305586165;15137.091774493565;15143.394264229417;15155.318010689545;13642.181469111785;13956.441742330295;13961.277550877583;14303.499377521737;14762.557123286319;13074.673133171651;13097.41061652228;13140.737185256241;13339.533116340881;13512.729745405135;4304.289792184317;4325.5025672047805;4367.847125350598;4389.912201755979;4549.590536851666;77929;78796.21203787946;79382.60308698477;81603.5919820403;81721.59139204325;10734.141268698486;10734.463276836283;10867;10869.945650271698;11085.72285692848;19762.20951161966;19775.802241977683;19785;19800.60398792016;19967.20131194736;7921.564313962672;8451.830963380698;8581.399302048796;8758.430702004476;8763.956180219058;4479.417675702203;4673.766311684402;4675.13510000651;4793.472718001017;4850.7574621269505;3413.1637748751714;3516.7186625070444;3540.8937731868086;3576.0344706929504;3578.3737845876867;591.3642833953431;597.277294473683;604.2597817673403;614.1340709599443;621.8942779727457;635.1489004733587;650.5446187668556;651.91199188109;655.4232275597444;664.7042066280555;8300.294474969694;8730.607122679494;8894.42186257891;8905.110940934353;9092.090790920854;629.1475051305507;638.8211300835774;656.6683824668512;658.7987836034481;665.9533832631669;4265.91468170641;4269.167512335127;4318.568143185719;4370.956290437119;4441.067375851043;68734.65632671805;100228.49885750671;113522;122694.38652806857;131043.3091532631;107596.38605420924;108984;109169;110985;115112;93649;93947;96328.51835740777;96585.517072417;98066.5096674512;8054.758357249058;8062.274395304451;8073.233042860918;8191.549464779494;8285.4200205985;52994.470055300495;53076;53143;53943.954203435685;55608.16587751106;76788.61605691936;81223.37979163807;82810;83012;84035.15964840274;10790.514426850654;11037.834432483358;11078.889211107786;11181.105511559219;11613.6515904523;11450.971016441768;11871.584494542649;11957.880421195676;12330.321832299309;12685.429155687832;10977.28647637901;11474.082073433938;11484.94257528707;11575.652730418102;11583.362915039754;10830.837537437103;11189.72025699364;11305.71735706614;11626;11690.824637630612;11150.442477875911;11160.386178760245;11186.04918581897;11476.770464590494;11504.309741415542;9442.669506567512;9876.802463950824;10007.749806254611;10016.699499015042;10066.496675166067;9124.27005839518;9595.13643772064;9668.178204852666;9752.951235243778;9773.768230290929 15:38:11 INFO - PROCESS | 7637 | __end_tp_report 15:38:11 INFO - PROCESS | 7637 | __start_cc_report 15:38:11 INFO - PROCESS | 7637 | _x_x_mozilla_cycle_collect,1194 15:38:11 INFO - PROCESS | 7637 | __end_cc_report 15:38:11 INFO - PROCESS | 7637 | __startTimestamp1475793491552__endTimestamp 15:38:11 INFO - PROCESS | 7637 | 15:38:11 INFO - PROCESS | 7637 | ------- Summary: start ------- 15:38:11 INFO - PROCESS | 7637 | Number of tests: 6 15:38:11 INFO - PROCESS | 7637 | 15:38:11 INFO - PROCESS | 7637 | [#0] dojo.html Cycles:165 Average:5110.84 Median:5333.63 stddev:559.67 (10.5%) stddev-sans-first:534.63 15:38:11 INFO - PROCESS | 7637 | Values: 2931.4 2978.6 2981.6 2999.7 3029.4 4978.8 5082.8 5102.9 5189.7 5206.8 5115.2 5130.8 5189.8 5229.6 5255.8 4631.5 4667.4 4671.8 4687.2 4733.1 4761.7 4794.9 4808.1 4838.4 4867.0 4609.7 4649.5 4659.1 4764.5 4837.9 4687.1 4688.1 4691.3 4691.6 4691.7 4667.3 4681.0 4683.1 4686.5 4690.5 5094.7 5130.7 5131.8 5141.6 5147.4 5421.0 5438.2 5449.6 5516.4 5521.8 5450.1 5461.6 5522.5 5533.7 5535.3 4990.6 5128.3 5170.1 5180.1 5239.4 5429.2 5563.3 5598.6 5643.4 5651.9 5380.5 5410.5 5411.6 5413.6 5416.3 5333.6 5459.3 5488.5 5494.9 5560.1 5362.9 5402.5 5444.2 5450.4 5521.4 5452.1 5467.1 5467.5 5468.3 5528.3 4259.9 4263.6 4267.0 4272.0 4313.6 3761.0 3796.5 3811.6 3827.9 3846.2 5271.0 5272.5 5273.1 5277.9 5300.1 5482.8 5496.1 5502.9 5504.5 5513.1 5123.8 5124.2 5182.2 5228.5 5228.8 4753.7 4763.0 4764.5 4795.6 4817.0 5686.7 5694.7 5697.0 5705.7 5769.4 5358.9 5400.1 5402.0 5469.9 5482.4 5588.4 5598.2 5607.0 5614.9 5625.1 5356.1 5376.4 5415.8 5416.9 5422.8 5370.7 5413.2 5463.8 5481.2 5511.8 5227.8 5372.0 5375.2 5406.9 5458.5 5252.7 5350.3 5366.1 5390.2 5452.5 5376.4 5383.8 5389.1 5394.2 5395.3 5406.1 5418.6 5439.1 5441.0 5441.4 5117.6 5173.9 5318.9 5319.3 5330.9 15:38:11 INFO - PROCESS | 7637 | 15:38:11 INFO - PROCESS | 7637 | [#1] ext.html Cycles:180 Average:56143.05 Median:36219.14 stddev:110759.14 (305.8%) stddev-sans-first:110991.20 15:38:11 INFO - PROCESS | 7637 | Values: 549.5 571.2 609.0 617.3 617.6 31670.5 41243.6 42182.8 42211.6 42265.4 44632.3 44857.0 45034.0 45048.8 45158.5 8133.6 8318.5 8994.6 9167.0 10597.5 10375.6 10755.7 10761.9 10787.5 10789.0 10785.9 10812.8 10836.6 10838.5 10840.8 8221.5 8425.5 10574.4 10692.6 10840.2 10594.5 10597.5 10665.9 10675.7 10685.6 41490.8 41965.0 42192.4 42222.6 42318.4 3378.9 3395.9 3399.7 3461.7 3798.1 31118.8 31175.0 31354.4 31449.2 31668.8 4249.7 4294.1 4364.4 4407.9 4546.3 250086.0 250479.0 250725.0 251391.0 252072.0 55738.4 56184.2 56349.7 56733.0 56740.4 58250.4 58782.0 58792.7 58815.4 58835.4 13635.7 13920.1 13934.7 13937.4 13942.1 10462.0 10833.8 11364.3 11696.4 11706.4 16621.8 16783.4 16811.2 16851.3 16868.7 6025.4 6215.3 6293.5 6322.7 6385.4 894.7 1024.7 1050.9 1067.8 1111.4 31120.2 31402.0 31445.7 32017.4 32071.4 1099.8 1104.6 1106.9 1131.7 1218.4 15610.7 16421.4 16663.5 16708.4 16942.5 536485.0 539928.0 544496.0 545197.0 545696.0 55946.0 56072.4 56168.2 56221.4 56271.4 1205.5 1254.6 1272.4 1314.7 1321.6 28183.4 31312.0 32191.2 32597.7 33111.5 46766.8 47265.5 47413.3 47413.5 47416.0 404156.0 404769.0 405086.0 405452.0 405780.0 26438.0 27103.6 27297.4 28865.3 38851.6 44591.8 45056.3 45310.0 45958.3 46485.3 36998.4 37650.6 38658.0 40395.0 40951.0 38731.4 38846.0 38946.8 38988.4 40207.2 39290.4 39793.6 39795.0 39995.2 40004.2 33161.5 35343.1 35456.3 36117.5 36320.8 27009.5 27198.9 27212.0 27429.5 27435.9 15:38:11 INFO - PROCESS | 7637 | 15:38:11 INFO - PROCESS | 7637 | [#2] jquery.html Cycles:180 Average:26138.51 Median:326708.17 stddev:65488.53 (20.0%) stddev-sans-first:65643.68 15:38:11 INFO - PROCESS | 7637 | Values: 376.5 389.6 393.2 400.0 422.1 13276.7 15231.1 16920.7 19187.8 19658.1 18073.2 18675.7 18713.9 18816.0 18870.0 5666.2 5907.4 5907.8 5908.2 5909.3 4869.0 6364.0 6405.8 6524.4 6527.2 6267.2 6454.1 6459.0 6467.4 6483.9 6432.2 6465.0 6468.8 6469.2 6470.6 5579.2 5676.7 5680.8 5701.6 5701.8 21544.5 21774.7 22320.2 22362.0 22548.7 2594.8 2959.8 3047.4 3048.1 3184.2 13938.9 14431.6 14437.3 14626.7 14635.1 1876.8 1884.3 1887.0 1891.7 1916.9 79939.0 85318.0 85920.6 86450.0 87932.6 10792.6 10997.8 11003.8 11007.9 11240.5 15670.9 15683.5 15689.8 15717.8 15723.9 7486.1 7494.4 7673.1 7683.1 7752.8 6959.9 7012.8 7024.3 7171.2 7196.4 4661.6 4750.8 4776.3 4813.8 4834.6 1916.9 1970.8 1994.3 1995.4 2006.9 815.6 876.8 979.6 1002.9 1022.5 17525.6 18762.2 19135.8 19162.7 19542.8 903.8 907.7 911.9 918.9 966.4 10170.9 10575.6 10694.7 10779.4 10799.9 325714.0 327702.3 328466.0 469654.0 474221.0 91443.5 96028.5 96394.5 96635.0 97642.0 983.2 998.3 1022.4 1035.2 1042.1 16537.9 16630.3 16810.5 17273.7 17926.0 32383.0 35816.6 40194.0 40521.6 41097.0 56312.4 56599.4 57476.4 57981.0 59231.0 8144.2 8440.0 8451.3 8636.7 8865.4 10124.9 12571.4 12624.9 12894.8 12940.6 11035.6 11146.2 11246.1 11351.7 11551.3 11126.5 11532.8 11580.4 11618.8 11735.7 10896.8 11003.3 11251.9 11371.1 11756.3 8066.2 8181.0 8296.6 8553.1 8772.9 9626.9 10709.4 11639.4 11806.3 11806.6 15:38:11 INFO - PROCESS | 7637 | 15:38:11 INFO - PROCESS | 7637 | [#3] mootools.html Cycles:180 Average:5761.05 Median:4664.17 stddev:3313.97 (71.1%) stddev-sans-first:3306.22 15:38:11 INFO - PROCESS | 7637 | Values: 1289.7 1453.8 1461.8 1582.8 1761.3 7736.3 8446.5 8840.6 8862.4 9163.2 8829.9 8900.7 8922.7 8928.9 8930.3 2341.1 2345.4 2364.6 2368.9 2374.2 2196.3 2280.4 2392.6 2393.2 2394.0 2342.7 2365.8 2374.0 2376.1 2377.8 2237.9 2256.0 2263.4 2264.9 2292.5 2266.3 2267.4 2271.5 2273.3 2274.2 8720.5 8807.8 8862.2 8887.6 8902.1 5180.5 5369.1 5372.0 5427.4 5441.3 3281.2 3403.9 3468.7 3475.5 3488.6 1017.0 1042.1 1052.3 1064.6 1075.3 12242.8 12250.6 12305.1 12338.8 12385.7 4324.2 4398.3 4457.3 4545.7 4608.2 9722.8 9726.2 9733.0 9739.3 9749.4 5167.5 5177.3 5181.7 5186.4 5188.4 4254.7 4365.8 4720.1 4747.1 4827.7 3671.8 3685.4 3777.3 3829.1 3840.7 1124.7 1129.4 1137.3 1153.9 1166.1 942.7 948.4 951.6 953.6 963.5 5929.6 5949.5 5974.6 6086.5 6321.9 427.2 427.3 428.8 429.1 443.2 4051.7 4079.9 4118.9 4122.6 4146.2 10755.5 11080.1 11159.4 11164.9 11192.9 11008.7 11025.2 11039.1 11071.4 11123.2 7793.6 8009.3 8097.5 8102.8 8122.0 6091.2 6094.2 6158.1 6197.0 6243.9 10041.3 10062.3 10110.9 10122.7 10229.2 9778.2 10106.6 10148.1 10285.4 10457.3 6952.8 7214.9 7220.2 7842.1 8011.9 8063.4 8397.8 8464.6 8568.5 8670.5 7287.0 7387.1 7542.5 7828.3 7922.3 7416.9 7460.1 7511.3 7526.8 7821.0 6908.9 7001.1 7023.7 7031.6 7038.7 5260.4 5360.9 5363.2 5400.1 5602.6 5315.9 5344.2 5411.8 5428.7 5553.8 15:38:11 INFO - PROCESS | 7637 | 15:38:11 INFO - PROCESS | 7637 | [#4] prototype.html Cycles:180 Average:4624.42 Median:5287.85 stddev:1349.75 (25.5%) stddev-sans-first:1314.48 15:38:11 INFO - PROCESS | 7637 | Values: 329.3 339.8 344.9 345.8 345.9 4975.9 5168.6 5214.5 5233.2 5262.4 5105.2 5226.9 5227.5 5234.9 5273.6 4185.9 4186.5 4189.2 4192.4 4206.4 3867.3 4093.2 4127.9 4205.6 4230.0 4061.0 4073.3 4074.9 4076.7 4093.2 4051.3 4062.9 4063.9 4099.0 4106.1 3637.2 3652.0 3661.4 3672.1 3675.5 5032.0 5109.0 5113.5 5140.5 5165.8 4671.9 4674.4 4675.3 4678.5 4703.9 5416.9 5430.4 5450.7 5452.3 5462.3 3830.0 3945.5 3960.6 3972.0 3996.2 5600.7 5613.3 5614.7 5617.2 5619.5 3991.6 4048.3 4049.4 4057.0 4071.8 4007.0 4079.8 4088.8 4115.6 4119.2 4635.0 4639.3 4640.1 4656.6 4665.9 5411.6 5415.3 5470.7 5504.9 5563.4 1295.8 1339.7 1379.7 1380.2 1389.6 961.7 965.3 976.7 980.7 981.8 5203.9 5235.3 5239.3 5269.1 5302.2 5547.6 5550.5 5552.9 5565.2 5591.4 5109.8 5330.1 5335.9 5341.4 5359.0 2967.7 2972.9 2990.0 2991.9 2995.5 5759.4 5776.8 5835.6 5859.6 5887.2 5638.8 5683.7 5735.5 5739.3 5755.5 5746.7 5793.2 5801.5 5808.4 5840.4 5410.7 5606.5 5638.1 5683.0 5713.5 5575.2 5578.9 5595.5 5595.6 5598.4 5772.9 5802.7 5805.0 5808.3 5828.3 3836.3 4010.0 4036.4 4074.7 4092.4 5330.8 5598.6 5606.6 5614.2 5626.2 5352.8 5405.4 5426.3 5442.0 5486.7 5477.0 5491.4 5493.1 5511.5 5517.2 5249.6 5436.9 5467.5 5503.3 5533.8 5483.3 5488.4 5506.9 5515.7 5523.5 5404.2 5417.1 5422.8 5426.3 5458.4 15:38:11 INFO - PROCESS | 7637 | 15:38:11 INFO - PROCESS | 7637 | [#5] yui.html Cycles:180 Average:21043.35 Median:4822.12 stddev:31729.68 (658.0%) stddev-sans-first:31781.94 15:38:11 INFO - PROCESS | 7637 | Values: 703.9 704.8 720.3 764.3 786.2 14643.1 15531.0 15534.9 15552.4 15628.8 15094.0 15171.6 15181.7 15199.8 15202.4 634.1 651.5 729.1 751.6 758.0 752.1 752.4 753.0 753.2 760.5 808.5 809.9 810.8 811.1 811.4 650.9 664.8 778.1 805.0 806.6 589.0 592.5 593.1 593.4 593.6 15099.8 15104.3 15137.1 15143.4 15155.3 13642.2 13956.4 13961.3 14303.5 14762.6 13074.7 13097.4 13140.7 13339.5 13512.7 4304.3 4325.5 4367.8 4389.9 4549.6 77929.0 78796.2 79382.6 81603.6 81721.6 10734.1 10734.5 10867.0 10869.9 11085.7 19762.2 19775.8 19785.0 19800.6 19967.2 7921.6 8451.8 8581.4 8758.4 8764.0 4479.4 4673.8 4675.1 4793.5 4850.8 3413.2 3516.7 3540.9 3576.0 3578.4 591.4 597.3 604.3 614.1 621.9 635.1 650.5 651.9 655.4 664.7 8300.3 8730.6 8894.4 8905.1 9092.1 629.1 638.8 656.7 658.8 666.0 4265.9 4269.2 4318.6 4371.0 4441.1 68734.7 100228.5 113522.0 122694.4 131043.3 107596.4 108984.0 109169.0 110985.0 115112.0 93649.0 93947.0 96328.5 96585.5 98066.5 8054.8 8062.3 8073.2 8191.5 8285.4 52994.5 53076.0 53143.0 53944.0 55608.2 76788.6 81223.4 82810.0 83012.0 84035.2 10790.5 11037.8 11078.9 11181.1 11613.7 11451.0 11871.6 11957.9 12330.3 12685.4 10977.3 11474.1 11484.9 11575.7 11583.4 10830.8 11189.7 11305.7 11626.0 11690.8 11150.4 11160.4 11186.0 11476.8 11504.3 9442.7 9876.8 10007.7 10016.7 10066.5 9124.3 9595.1 9668.2 9753.0 9773.8 15:38:11 INFO - PROCESS | 7637 | -------- Summary: end -------- 15:38:11 INFO - PROCESS | 7637 | 15:38:12 INFO - TEST-INFO | 7637: exit 0 15:38:12 INFO - TEST-OK | dromaeo_css | took 1117922ms 15:38:12 INFO - TEST-START | kraken 15:38:12 INFO - operating with platform_type : linux_ 15:38:12 INFO - Initialising browser for kraken test... 15:38:12 INFO - TEST-INFO | started process 7943 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFhdJaJ/profile http://localhost:33833/getInfo.html) 15:38:16 INFO - PROCESS | 7943 | __metrics Screen width/height:1600/1200 15:38:16 INFO - PROCESS | 7943 | colorDepth:24 15:38:16 INFO - PROCESS | 7943 | Browser inner width/height: 1024/697 15:38:16 INFO - PROCESS | 7943 | __metrics 15:38:17 INFO - PROCESS | 7943 | 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" 15:38:17 INFO - PROCESS | 7943 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:38:18 INFO - PROCESS | 7943 | console.error: PushService: 15:38:18 INFO - PROCESS | 7943 | stateChangeProcessEnqueue: Error transitioning state 15:38:18 INFO - PROCESS | 7943 | UnknownError 15:38:18 INFO - TEST-INFO | 7943: exit 0 15:38:18 INFO - Browser initialized. 15:38:18 INFO - Running cycle 1/1 for kraken test... 15:38:18 INFO - TEST-INFO | started process 8024 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFhdJaJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:38:30 INFO - PROCESS | 8024 | RSS: Main: 175767552 15:38:30 INFO - PROCESS | 8024 | 15:38:33 INFO - PROCESS | 8024 | Cycle 1(1): loaded http://localhost:33833/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33833/tests/kraken/driver.html?testName=audio-beat-detection) 15:38:34 INFO - PROCESS | 8024 | RSS: Main: 232300544 15:38:34 INFO - PROCESS | 8024 | 15:38:36 INFO - PROCESS | 8024 | Cycle 1(1): loaded http://localhost:33833/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33833/tests/kraken/driver.html?testName=audio-dft) 15:38:37 INFO - PROCESS | 8024 | RSS: Main: 216829952 15:38:37 INFO - PROCESS | 8024 | 15:38:40 INFO - PROCESS | 8024 | Cycle 1(1): loaded http://localhost:33833/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33833/tests/kraken/driver.html?testName=audio-fft) 15:38:41 INFO - PROCESS | 8024 | RSS: Main: 299384832 15:38:41 INFO - PROCESS | 8024 | 15:38:43 INFO - PROCESS | 8024 | Cycle 1(1): loaded http://localhost:33833/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33833/tests/kraken/driver.html?testName=audio-oscillator) 15:38:44 INFO - PROCESS | 8024 | RSS: Main: 210616320 15:38:44 INFO - PROCESS | 8024 | 15:38:46 INFO - PROCESS | 8024 | Cycle 1(1): loaded http://localhost:33833/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33833/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:38:46 INFO - PROCESS | 8024 | RSS: Main: 213712896 15:38:46 INFO - PROCESS | 8024 | 15:38:49 INFO - PROCESS | 8024 | Cycle 1(1): loaded http://localhost:33833/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33833/tests/kraken/driver.html?testName=imaging-darkroom) 15:38:50 INFO - PROCESS | 8024 | RSS: Main: 249679872 15:38:50 INFO - PROCESS | 8024 | 15:38:53 INFO - PROCESS | 8024 | Cycle 1(1): loaded http://localhost:33833/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33833/tests/kraken/driver.html?testName=imaging-desaturate) 15:38:54 INFO - PROCESS | 8024 | RSS: Main: 248127488 15:38:54 INFO - PROCESS | 8024 | 15:38:57 INFO - PROCESS | 8024 | Cycle 1(1): loaded http://localhost:33833/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33833/tests/kraken/driver.html?testName=json-parse-financial) 15:38:57 INFO - PROCESS | 8024 | RSS: Main: 247922688 15:38:57 INFO - PROCESS | 8024 | 15:38:59 INFO - PROCESS | 8024 | Cycle 1(1): loaded http://localhost:33833/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33833/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:38:59 INFO - PROCESS | 8024 | RSS: Main: 209952768 15:38:59 INFO - PROCESS | 8024 | 15:39:01 INFO - PROCESS | 8024 | Cycle 1(1): loaded http://localhost:33833/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33833/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:39:02 INFO - PROCESS | 8024 | RSS: Main: 217714688 15:39:02 INFO - PROCESS | 8024 | 15:39:04 INFO - PROCESS | 8024 | Cycle 1(1): loaded http://localhost:33833/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33833/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:39:04 INFO - PROCESS | 8024 | RSS: Main: 226754560 15:39:04 INFO - PROCESS | 8024 | 15:39:07 INFO - PROCESS | 8024 | Cycle 1(1): loaded http://localhost:33833/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33833/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:39:08 INFO - PROCESS | 8024 | RSS: Main: 236457984 15:39:08 INFO - PROCESS | 8024 | 15:39:11 INFO - PROCESS | 8024 | Cycle 1(1): loaded http://localhost:33833/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33833/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:39:11 INFO - PROCESS | 8024 | RSS: Main: 232763392 15:39:11 INFO - PROCESS | 8024 | 15:39:13 INFO - PROCESS | 8024 | Cycle 1(1): loaded http://localhost:33833/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33833/tests/kraken/driver.html?testName=ai-astar) 15:39:13 INFO - PROCESS | 8024 | RSS: Main: 284356608 15:39:13 INFO - PROCESS | 8024 | 15:39:13 INFO - PROCESS | 8024 | __start_tp_report 15:39:13 INFO - PROCESS | 8024 | _x_x_mozilla_page_load 15:39:13 INFO - PROCESS | 8024 | _x_x_mozilla_page_load_details 15:39:13 INFO - PROCESS | 8024 | |i|pagename|runs| 15:39:13 INFO - PROCESS | 8024 | |0;ai-astar;109;110;112;110;114;112;111;112;109;110 15:39:13 INFO - PROCESS | 8024 | |1;audio-beat-detection;146;120;124;171;124;128;129;130;157;129 15:39:13 INFO - PROCESS | 8024 | |2;audio-dft;162;162;162;161;161;163;161;162;161;161 15:39:13 INFO - PROCESS | 8024 | |3;audio-fft;76;76;76;115;77;77;77;75;99;76 15:39:13 INFO - PROCESS | 8024 | |4;audio-oscillator;83;82;128;83;83;82;104;81;82;120 15:39:13 INFO - PROCESS | 8024 | |5;imaging-gaussian-blur;117;116;116;117;117;116;118;117;117;117 15:39:13 INFO - PROCESS | 8024 | |6;imaging-darkroom;146;146;145;145;146;146;146;145;145;147 15:39:13 INFO - PROCESS | 8024 | |7;imaging-desaturate;95;96;95;95;95;94;95;95;95;95 15:39:13 INFO - PROCESS | 8024 | |8;json-parse-financial;53;52;52;52;52;52;53;52;54;52 15:39:13 INFO - PROCESS | 8024 | |9;json-stringify-tinderbox;61;61;60;61;62;60;61;61;61;60 15:39:13 INFO - PROCESS | 8024 | |10;stanford-crypto-aes;80;80;80;80;79;81;86;86;80;80 15:39:13 INFO - PROCESS | 8024 | |11;stanford-crypto-ccm;134;131;142;135;138;139;130;129;167;147 15:39:13 INFO - PROCESS | 8024 | |12;stanford-crypto-pbkdf2;170;169;167;166;167;167;168;166;167;172 15:39:13 INFO - PROCESS | 8024 | |13;stanford-crypto-sha256-iterative;69;66;67;66;65;66;69;65;64;63 15:39:13 INFO - PROCESS | 8024 | __end_tp_report 15:39:13 INFO - PROCESS | 8024 | __start_cc_report 15:39:13 INFO - PROCESS | 8024 | _x_x_mozilla_cycle_collect,1689 15:39:13 INFO - PROCESS | 8024 | __end_cc_report 15:39:13 INFO - PROCESS | 8024 | __startTimestamp1475793553608__endTimestamp 15:39:13 INFO - PROCESS | 8024 | 15:39:13 INFO - PROCESS | 8024 | ------- Summary: start ------- 15:39:13 INFO - PROCESS | 8024 | Number of tests: 14 15:39:13 INFO - PROCESS | 8024 | 15:39:13 INFO - PROCESS | 8024 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.50 stddev:1.60 (1.4%) stddev-sans-first:1.54 15:39:13 INFO - PROCESS | 8024 | Values: 109.0 110.0 112.0 110.0 114.0 112.0 111.0 112.0 109.0 110.0 15:39:13 INFO - PROCESS | 8024 | 15:39:13 INFO - PROCESS | 8024 | [#1] audio-beat-detection Cycles:10 Average:135.80 Median:129.50 stddev:16.69 (12.9%) stddev-sans-first:17.29 15:39:13 INFO - PROCESS | 8024 | Values: 146.0 120.0 124.0 171.0 124.0 128.0 129.0 130.0 157.0 129.0 15:39:13 INFO - PROCESS | 8024 | 15:39:13 INFO - PROCESS | 8024 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 15:39:13 INFO - PROCESS | 8024 | Values: 162.0 162.0 162.0 161.0 161.0 163.0 161.0 162.0 161.0 161.0 15:39:13 INFO - PROCESS | 8024 | 15:39:13 INFO - PROCESS | 8024 | [#3] audio-fft Cycles:10 Average:82.40 Median:76.50 stddev:13.52 (17.7%) stddev-sans-first:14.14 15:39:13 INFO - PROCESS | 8024 | Values: 76.0 76.0 76.0 115.0 77.0 77.0 77.0 75.0 99.0 76.0 15:39:13 INFO - PROCESS | 8024 | 15:39:13 INFO - PROCESS | 8024 | [#4] audio-oscillator Cycles:10 Average:92.80 Median:82.00 stddev:17.89 (21.8%) stddev-sans-first:18.62 15:39:13 INFO - PROCESS | 8024 | Values: 83.0 82.0 128.0 83.0 83.0 82.0 104.0 81.0 82.0 120.0 15:39:13 INFO - PROCESS | 8024 | 15:39:13 INFO - PROCESS | 8024 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 15:39:13 INFO - PROCESS | 8024 | Values: 117.0 116.0 116.0 117.0 117.0 116.0 118.0 117.0 117.0 117.0 15:39:13 INFO - PROCESS | 8024 | 15:39:13 INFO - PROCESS | 8024 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 15:39:13 INFO - PROCESS | 8024 | Values: 146.0 146.0 145.0 145.0 146.0 146.0 146.0 145.0 145.0 147.0 15:39:13 INFO - PROCESS | 8024 | 15:39:13 INFO - PROCESS | 8024 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 15:39:13 INFO - PROCESS | 8024 | Values: 95.0 96.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 15:39:13 INFO - PROCESS | 8024 | 15:39:13 INFO - PROCESS | 8024 | [#8] json-parse-financial Cycles:10 Average:52.40 Median:52.00 stddev:0.70 (1.3%) stddev-sans-first:0.71 15:39:13 INFO - PROCESS | 8024 | Values: 53.0 52.0 52.0 52.0 52.0 52.0 53.0 52.0 54.0 52.0 15:39:13 INFO - PROCESS | 8024 | 15:39:13 INFO - PROCESS | 8024 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 15:39:13 INFO - PROCESS | 8024 | Values: 61.0 61.0 60.0 61.0 62.0 60.0 61.0 61.0 61.0 60.0 15:39:13 INFO - PROCESS | 8024 | 15:39:13 INFO - PROCESS | 8024 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:80.00 stddev:2.57 (3.2%) stddev-sans-first:2.69 15:39:13 INFO - PROCESS | 8024 | Values: 80.0 80.0 80.0 80.0 79.0 81.0 86.0 86.0 80.0 80.0 15:39:13 INFO - PROCESS | 8024 | 15:39:13 INFO - PROCESS | 8024 | [#11] stanford-crypto-ccm Cycles:10 Average:139.20 Median:138.50 stddev:11.27 (8.1%) stddev-sans-first:11.80 15:39:13 INFO - PROCESS | 8024 | Values: 134.0 131.0 142.0 135.0 138.0 139.0 130.0 129.0 167.0 147.0 15:39:13 INFO - PROCESS | 8024 | 15:39:13 INFO - PROCESS | 8024 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.90 Median:167.50 stddev:1.91 (1.1%) stddev-sans-first:1.87 15:39:13 INFO - PROCESS | 8024 | Values: 170.0 169.0 167.0 166.0 167.0 167.0 168.0 166.0 167.0 172.0 15:39:13 INFO - PROCESS | 8024 | 15:39:13 INFO - PROCESS | 8024 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:1.94 (2.9%) stddev-sans-first:1.73 15:39:13 INFO - PROCESS | 8024 | Values: 69.0 66.0 67.0 66.0 65.0 66.0 69.0 65.0 64.0 63.0 15:39:13 INFO - PROCESS | 8024 | -------- Summary: end -------- 15:39:13 INFO - PROCESS | 8024 | 15:39:14 INFO - TEST-INFO | 8024: exit 0 15:39:14 INFO - TEST-OK | kraken | took 62328ms 15:39:14 INFO - SUITE-END | took 1180s 15:39:15 INFO - Completed test suite (00:19:40) 15:39:15 INFO - javascript benchmark 15:39:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2931.443025825093, 2978.597889284947, 2981.612390389249, 2999.7300242978126, 3029.378977309652, 4978.800847966077, 5082.771275292612, 5102.872428189293, 5189.6886186828815, 5206.843794686156, 5115.155999260118, 5130.846074617758, 5189.8183563575285, 5229.633925625208, 5255.76349064292, 4631.513691062441, 4667.393238878941, 4671.813127474897, 4687.156311863863, 4733.100710864942, 4761.714297142183, 4794.9280760788615, 4808.110499557575, 4838.395200599925, 4866.951330486703, 4609.67732258742, 4649.465311489188, 4659.091477161955, 4764.475907650156, 4837.9274310885185, 4687.062587482517, 4688.062387522475, 4691.272852707836, 4691.577758001762, 4691.671582989192, 4667.299905014241, 4680.976595117037, 4683.063387322515, 4686.507916668769, 4690.4605970313505, 5094.694318340874, 5130.743462826844, 5131.820386286499, 5141.562967147797, 5147.356580427447, 5420.970015697005, 5438.211459338374, 5449.618526703132, 5516.420775818521, 5521.779128834842, 5450.100733378988, 5461.563074953994, 5522.475364840334, 5533.667979921177, 5535.335759708821, 4990.5508504234795, 5128.333316668809, 5170.095233334151, 5180.145276029413, 5239.3712754469325, 5429.185622156708, 5563.276774019432, 5598.608097433141, 5643.435656434323, 5651.943480565224, 5380.542653874386, 5410.540104091197, 5411.621186516984, 5413.648112872651, 5416.295881535375, 5333.626646134733, 5459.317585301837, 5488.506034456918, 5494.945050549443, 5560.110382338888, 5362.946370536322, 5402.540784033323, 5444.156155795858, 5450.373207081237, 5521.4478552144465, 5452.1276595745285, 5467.07059799827, 5467.480589344006, 5468.316460442445, 5528.281323427928, 4259.850905218303, 4263.616274535307, 4267.0, 4272.038791271939, 4313.61177494027, 3761.0409345616695, 3796.52543432071, 3811.561670407883, 3827.8516445066925, 3846.1538461538416, 5270.998510283034, 5272.525472707474, 5273.1035723927025, 5277.9472205278225, 5300.098983172793, 5482.835514934558, 5496.120620700749, 5502.889942201134, 5504.504594586427, 5513.117901135799, 5123.795048198031, 5124.154514505065, 5182.170852663631, 5228.503292187313, 5228.764705588258, 4753.738544380023, 4762.9523704763205, 4764.523547645277, 4795.568398844121, 4817.0, 5686.715664216773, 5694.658320500783, 5696.971515142481, 5705.7432415542235, 5769.423057694281, 5358.919616205682, 5400.108982017923, 5402.027635025576, 5469.9179512306555, 5482.39693633692, 5588.385277619377, 5598.188262701967, 5606.971965140148, 5614.943850561442, 5625.071863142535, 5356.0626890294825, 5376.354837419378, 5415.756290966837, 5416.945830541802, 5422.810201642924, 5370.650907690988, 5413.160960051198, 5463.7814487420055, 5481.150421684645, 5511.807086751945, 5227.790888364423, 5372.0, 5375.16684913839, 5406.864828379322, 5458.454154584669, 5252.684838909678, 5350.277712508761, 5366.114591092426, 5390.218418329398, 5452.482014208644, 5376.354837419534, 5383.757730902197, 5389.137737961907, 5394.217838413487, 5395.298611180521, 5406.107992181246, 5418.566514678895, 5439.102548079681, 5441.0, 5441.374241962225, 5117.5905927526455, 5173.948260517347, 5318.920216196838, 5319.281896943863, 5330.93381323729], "value": 5074.14946455888, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.5047412396262, 571.1546910572354, 609.0407608017373, 617.3240301869452, 617.6170774120044, 31670.52494212586, 41243.58756412435, 42182.78908605453, 42211.57788422115, 42265.366019509696, 44632.330515042304, 44857.0, 45034.0, 45048.77475612626, 45158.54841451585, 8133.633986470593, 8318.45930014547, 8994.595243214055, 9166.954165229165, 10597.470126493683, 10375.636852710119, 10755.677329680122, 10761.946190269038, 10787.460626968621, 10789.0, 10785.946070269638, 10812.783744325108, 10836.620718274862, 10838.458077096113, 10840.78318433631, 8221.465604735673, 8425.536595487245, 10574.418406987612, 10692.572297108145, 10840.241183117185, 10594.516767652534, 10597.470126493645, 10665.9466702666, 10675.679729608046, 10685.626003089932, 41490.79254603738, 41965.0, 42192.36711449331, 42222.57777422217, 42318.36522452166, 3378.9493157602656, 3395.9490607640905, 3399.6940275375337, 3461.705755010827, 3798.0929785123562, 31118.844405778054, 31175.0, 31354.37291254185, 31449.21376965571, 31668.841655791803, 4249.681273904439, 4294.119705460374, 4364.410804541378, 4407.889802754925, 4546.272596384596, 250086.0, 250479.0, 250725.0, 251391.0, 252072.0, 55738.44261557332, 56184.15723764147, 56349.71825140848, 56733.0, 56740.43259567351, 58250.4174958245, 58782.0, 58792.70603646954, 58815.41184588185, 58835.41164588385, 13635.727285454235, 13920.095193812369, 13934.721305574034, 13937.442502299997, 13942.093763905314, 10462.0, 10833.83749243762, 11364.318140911571, 11696.415179241005, 11706.414679266003, 16621.750673739905, 16783.412580559623, 16811.243494042796, 16851.325946962228, 16868.746968795476, 6025.367336429612, 6215.285242197115, 6293.496520278367, 6322.71547780351, 6385.393387628168, 894.7405252476839, 1024.6823484719762, 1050.8598170984567, 1067.8291473364225, 1111.4498323329842, 31120.22199444987, 31402.0, 31445.685543144733, 32017.359652806812, 32071.358572828412, 1099.769048499824, 1104.6465131157952, 1106.9391183484825, 1131.7396998690347, 1218.3603608105816, 15610.687786244438, 16421.425250116426, 16663.50009499717, 16708.41520546775, 16942.491725248263, 536485.0, 539928.0, 544496.0, 545197.0, 545696.0, 55946.0, 56072.43927560754, 56168.15747763787, 56221.43778562244, 56271.437285627435, 1205.5238180918489, 1254.5609036837034, 1272.376535497618, 1314.7304802515462, 1321.596912941562, 28183.43633127367, 31312.0, 32191.195220119684, 32597.674023259464, 33111.50332744962, 46766.76616617031, 47265.52734472611, 47413.28880066733, 47413.525864740914, 47416.0, 404156.0, 404769.0, 405086.0, 405452.0, 405780.0, 26438.0, 27103.59344609872, 27297.448612333294, 28865.278368040967, 38851.58948773421, 44591.77704111459, 45056.324155137045, 45310.0, 45958.310625339975, 46485.3027204599, 36998.44502332414, 37650.62349376581, 38658.0, 40395.0, 40951.0, 38731.41902871403, 38846.0, 38946.80526597349, 38988.41517377185, 40207.19585608213, 39290.410643840936, 39793.60206398015, 39795.0, 39995.2000959985, 40004.1999160021, 33161.50257746087, 35343.11642208965, 35456.290874181854, 36117.458238125924, 36320.81839590785, 27009.45981080328, 27198.864005679847, 27212.0, 27429.45141097207, 27435.86282068657], "value": 19633.165215406294, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.54626175458577, 389.5578518381638, 393.1919904596055, 399.9880003599892, 422.08407755171277, 13276.734465310688, 15231.086134831918, 16920.746188807178, 19187.808121918777, 19658.115384807683, 18073.1867065982, 18675.71986420205, 18713.941466438682, 18816.0, 18870.0, 5666.150077488389, 5907.409259074079, 5907.822765317026, 5908.202392676976, 5909.320428150753, 4868.951310486903, 6363.968180159092, 6405.775797847076, 6524.4454221391, 6527.249366322886, 6267.185265915425, 6454.128692626506, 6459.029995851263, 6467.417932386084, 6483.935160648404, 6432.163818703562, 6464.967675161641, 6468.773592924225, 6469.191351081115, 6470.644114573696, 5579.246801681762, 5676.659400435946, 5680.829575112712, 5701.57238207132, 5701.77192912283, 21544.461388465257, 21774.673379899315, 22320.21879234219, 22362.0, 22548.66177007346, 2594.831335963175, 2959.845660192527, 3047.420990011891, 3048.085574327693, 3184.2039490127468, 13938.93030534851, 14431.567052988426, 14437.339705933742, 14626.707465850623, 14635.121892686473, 1876.840468560174, 1884.2557189909908, 1886.9622607547772, 1891.6973284274588, 1916.9137388817537, 79939.0, 85318.0, 85920.57039714824, 86450.0, 87932.56033719855, 10792.603698150924, 10997.760636974372, 11003.779924401468, 11007.944960275308, 11240.49417776202, 15670.9216453917, 15683.451079212173, 15689.764653530206, 15717.764233536505, 15723.921380393025, 7486.064241969754, 7494.437917156235, 7673.11759147694, 7683.116441609175, 7752.844943101107, 6959.851624481904, 7012.789616311519, 7024.262452442522, 7171.211166771651, 7196.424286057103, 4661.580457758818, 4750.786214620351, 4776.283557466339, 4813.7593120343845, 4834.564889159922, 1916.8658193926292, 1970.8423326133875, 1994.3318988139135, 1995.361484325002, 2006.8695534790193, 815.6492708135559, 876.7808047988003, 979.5934687104914, 1002.9197664186847, 1022.5296363672645, 17525.561860953578, 18762.155702993125, 19135.80864191368, 19162.71255931162, 19542.804571954384, 903.8282726281985, 907.6505545365083, 911.8677791720163, 918.9448633082036, 966.367029595616, 10170.898291017143, 10575.62985295511, 10694.73263168427, 10779.353238805697, 10799.892001080047, 325714.0, 327702.3378597292, 328466.0, 469654.0, 474221.0, 91443.54278228566, 96028.51985740027, 96394.51802740942, 96635.0, 97642.0, 983.2232536296389, 998.3161534348994, 1022.4274406332329, 1035.1977217656226, 1042.0777611813598, 16537.91731041337, 16630.334786608884, 16810.495685129466, 17273.65452690914, 17926.0, 32383.0, 35816.64183358133, 40194.0, 40521.594784051784, 41097.0, 56312.43687563236, 56599.43400566106, 57476.425235747105, 57981.0, 59231.0, 8144.185581442045, 8440.0, 8451.32389408858, 8636.740897773077, 8865.379423440298, 10124.89875101269, 12571.434285456993, 12624.87375126237, 12894.806577901527, 12940.611781646565, 11035.558577656804, 11146.164037697366, 11246.100311975186, 11351.659450216506, 11551.306921584732, 11126.499307531343, 11532.770824169245, 11580.36308003068, 11618.825717614412, 11735.706607334885, 10896.782064358827, 11003.33979961205, 11251.887481125084, 11371.14716396257, 11756.294622322688, 8066.153053929253, 8181.0, 8296.626651800563, 8553.144685531397, 8772.868406974028, 9626.855597166188, 10709.357438553712, 11639.418029098342, 11806.291622502677, 11806.586769463027], "value": 9192.395384255295, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1289.6969212235128, 1453.7673972164455, 1461.7588097963833, 1582.762585612158, 1761.2602706863115, 7736.342410895074, 8446.450980686252, 8840.557972101386, 8862.379633425662, 9163.175314221719, 8829.911700882989, 8900.688475903346, 8922.732318030454, 8928.866067009, 8930.330225233118, 2341.0752752662647, 2345.413646588353, 2364.6334818103137, 2368.86971216583, 2374.2283757778705, 2196.2642514757576, 2280.407094155515, 2392.5932591459405, 2393.2222027840935, 2393.9760602393926, 2342.6603142544404, 2365.7752513511273, 2374.0385144016614, 2376.0852071952336, 2377.7622237776172, 2237.876916769577, 2256.029907139929, 2263.4341414646337, 2264.909403623853, 2292.5071109711494, 2266.252136794854, 2267.3878052925616, 2271.5235097186796, 2273.3180045986137, 2274.226762900622, 8720.476771393736, 8807.77980550485, 8862.158094980967, 8887.644494220223, 8902.065283145306, 5180.481951804827, 5369.060414427459, 5371.973140134313, 5427.375851777057, 5441.319835020622, 3281.1961069538115, 3403.897883063512, 3468.687818096358, 3475.4786781982652, 3488.6336934621754, 1016.9542370593341, 1042.0881728487573, 1052.3054783842626, 1064.6060957445795, 1075.3279200499687, 12242.81635775464, 12250.632481025583, 12305.077119216005, 12338.75322493554, 12385.690357741038, 4324.17840610283, 4398.3402489626815, 4457.2645513489915, 4545.749983750926, 4608.216603177468, 9722.805543889082, 9726.17327527154, 9732.951335243279, 9739.26955478342, 9749.415035097916, 5167.483251674803, 5177.3269474968765, 5181.715005674724, 5186.429492755794, 5188.377394712583, 4254.744715317091, 4365.847195348148, 4720.12677654635, 4747.121782470254, 4827.662063655511, 3671.7613355132366, 3685.355062863988, 3777.282316359938, 3829.0810205550465, 3840.731148819556, 1124.668222874254, 1129.3675541696512, 1137.2664631312757, 1153.948072336747, 1166.0904494494307, 942.6794889737522, 948.4025064209642, 951.6098399656108, 953.5708930981086, 963.5471328475605, 5929.584929054925, 5949.524038076944, 5974.61165024272, 6086.513078953673, 6321.873562528724, 427.2395136656756, 427.3333599584658, 428.81775245520527, 429.08604672048335, 443.2332065526657, 4051.6758659307775, 4079.918401631951, 4118.855840045584, 4122.649574786176, 4146.150039241948, 10755.516001779939, 11080.113590912708, 11159.386233757059, 11164.888351116548, 11192.888071119347, 11008.669739907815, 11025.17311201647, 11039.116870650329, 11071.446427678584, 11123.16576256784, 7793.610319484116, 8009.31920786728, 8097.473664211808, 8102.797430064295, 8121.959390203129, 6091.208142941389, 6094.177286066324, 6158.107074474086, 6197.03945888388, 6243.906341404791, 10041.297109202285, 10062.345947513388, 10110.949445252727, 10122.746931326776, 10229.181665466893, 9778.168855647065, 10106.646267380607, 10148.086672199537, 10285.43430111351, 10457.320274182153, 6952.826179345557, 7214.927850721636, 7220.241874603301, 7842.098158711821, 8011.919880801117, 8063.435559510778, 8397.790055248668, 8464.576771161293, 8568.485890846569, 8670.479771213748, 7287.0, 7387.113546374255, 7542.547447153188, 7828.256315650005, 7922.286994170552, 7416.9258307418395, 7460.0674915635545, 7511.286427789351, 7526.774196774106, 7821.0, 6908.861822763617, 7001.089858318386, 7023.719051238098, 7031.648417579203, 7038.718451261892, 5260.421353651172, 5360.919586206132, 5363.168708850135, 5400.081986062457, 5602.635828671123, 5315.920261196008, 5344.198370244494, 5411.756470958895, 5428.7014214217015, 5553.750081246273], "value": 4503.20510526858, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.28485582795116, 339.7536785830273, 344.90342704042877, 345.7787016309564, 345.9135216195951, 4975.925361119586, 5168.560672342851, 5214.452482489341, 5233.162693968966, 5262.421133675292, 5105.1831706926805, 5226.92159617606, 5227.5295223429885, 5234.8691282717955, 5273.551748101407, 4185.937210941838, 4186.476690413699, 4189.204051230272, 4192.350185721218, 4206.3690446432975, 3867.284552357823, 4093.2427500912427, 4127.917441651165, 4205.5794420558, 4229.957700422987, 4060.9847538115473, 4073.307537718595, 4074.857379991701, 4076.653484453825, 4093.2018256440006, 4051.3112770828734, 4062.8984275393054, 4063.918721625566, 4098.959010409888, 4106.137711080677, 3637.236180402119, 3652.0, 3661.3958696814993, 3672.06362377592, 3675.46705727668, 5031.974840125813, 5109.0, 5113.488651134894, 5140.460251673595, 5165.793368265265, 4671.902103005791, 4674.410700361893, 4675.251959686468, 4678.461976872669, 4703.882402939919, 5416.891662166774, 5430.402655707869, 5450.656217826333, 5452.263944367499, 5462.289902312674, 3829.9808500957315, 3945.5462621798574, 3960.6435420812263, 3971.960280397188, 3996.220736956295, 5600.719964001783, 5613.326400831886, 5614.6631202128, 5617.21359009739, 5619.466150715675, 3991.5808840071954, 4048.332025215865, 4049.4128351388886, 4056.959430405658, 4071.75569465833, 4006.979965100214, 4079.8368065277054, 4088.8160032798, 4115.629593336614, 4119.155573107506, 4635.010418280258, 4639.327297541838, 4640.120751095812, 4656.580907718321, 4665.930011049769, 5411.621186516906, 5415.268938693304, 5470.699111548824, 5504.91742623861, 5563.443655634404, 1295.8272763149364, 1339.7387509435762, 1379.7309524642799, 1380.171896861895, 1389.5622878793147, 961.6538046303325, 965.3146266151111, 976.7069879036261, 980.7057882635181, 981.788915383196, 5203.895922081537, 5235.319408476874, 5239.318888544465, 5269.104252277122, 5302.151655735064, 5547.583931205176, 5550.472705093091, 5552.91670624941, 5565.193047008162, 5591.41290164535, 5109.770060347293, 5330.093884039723, 5335.919961200585, 5341.3857406398765, 5358.973205134027, 2967.6735559088484, 2972.851357432163, 2989.9850500747793, 2991.880324786984, 2995.4757917364373, 5759.395263497357, 5776.797812076557, 5835.649861008268, 5859.619124756877, 5887.1757953885635, 5638.844036972411, 5683.692750667287, 5735.5337205001415, 5739.311282646109, 5755.539556835443, 5746.683932383759, 5793.188953546507, 5801.50687191585, 5808.448197421239, 5840.386759390203, 5410.675359478444, 5606.523445507014, 5638.097904335286, 5682.971585142048, 5713.485786279255, 5575.163725441216, 5578.888422231452, 5595.496405323541, 5595.63628364155, 5598.412166722435, 5772.913406298993, 5802.738876750472, 5804.970975145097, 5808.273965754281, 5828.300603927386, 3836.2711084894895, 4010.0375909782024, 4036.434899114068, 4074.7351422157467, 4092.4066010427728, 5330.760115794721, 5598.608097433304, 5606.579506536945, 5614.242077319673, 5626.184203290418, 5352.812651557177, 5405.351357837085, 5426.294581704353, 5441.972790136024, 5486.725663716878, 5477.0, 5491.395946445968, 5493.148561972901, 5511.472657499284, 5517.172424136412, 5249.632525723163, 5436.891262174655, 5467.507924286833, 5503.3120859892515, 5533.806316778893, 5483.327585086587, 5488.368837583729, 5506.944930550803, 5515.731381782292, 5523.502884740393, 5404.216388623706, 5417.131089774021, 5422.8373148805595, 5426.294581704353, 5458.399576046552], "value": 4198.110673038589, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.8803403421418, 704.8132244955091, 720.2545365546664, 764.2892110337384, 786.182370334852, 14643.121412715245, 15531.0, 15534.922325388357, 15552.377904883806, 15628.765568516466, 15094.0, 15171.620709482268, 15181.696366072672, 15199.772003419957, 15202.391904323813, 634.0615888485045, 651.4983462733692, 729.0813574895617, 751.6204316819998, 757.9962100189491, 752.086215248473, 752.3980815347727, 753.0361137743697, 753.175273075981, 760.5170716594974, 808.514891065359, 809.9392545559107, 810.84999275134, 811.0956283743612, 811.3914564076942, 650.8991106378519, 664.8138521214067, 778.0546635837428, 804.9557274349909, 806.592670701295, 589.0163427076792, 592.4549414538635, 593.1014513012789, 593.3532449629881, 593.5904226083989, 15099.773503397459, 15104.320305586165, 15137.091774493565, 15143.394264229417, 15155.318010689545, 13642.181469111785, 13956.441742330295, 13961.277550877583, 14303.499377521737, 14762.557123286319, 13074.673133171651, 13097.41061652228, 13140.737185256241, 13339.533116340881, 13512.729745405135, 4304.289792184317, 4325.5025672047805, 4367.847125350598, 4389.912201755979, 4549.590536851666, 77929.0, 78796.21203787946, 79382.60308698477, 81603.5919820403, 81721.59139204325, 10734.141268698486, 10734.463276836283, 10867.0, 10869.945650271698, 11085.72285692848, 19762.20951161966, 19775.802241977683, 19785.0, 19800.60398792016, 19967.20131194736, 7921.564313962672, 8451.830963380698, 8581.399302048796, 8758.430702004476, 8763.956180219058, 4479.417675702203, 4673.766311684402, 4675.13510000651, 4793.472718001017, 4850.7574621269505, 3413.1637748751714, 3516.7186625070444, 3540.8937731868086, 3576.0344706929504, 3578.3737845876867, 591.3642833953431, 597.277294473683, 604.2597817673403, 614.1340709599443, 621.8942779727457, 635.1489004733587, 650.5446187668556, 651.91199188109, 655.4232275597444, 664.7042066280555, 8300.294474969694, 8730.607122679494, 8894.42186257891, 8905.110940934353, 9092.090790920854, 629.1475051305507, 638.8211300835774, 656.6683824668512, 658.7987836034481, 665.9533832631669, 4265.91468170641, 4269.167512335127, 4318.568143185719, 4370.956290437119, 4441.067375851043, 68734.65632671805, 100228.49885750671, 113522.0, 122694.38652806857, 131043.3091532631, 107596.38605420924, 108984.0, 109169.0, 110985.0, 115112.0, 93649.0, 93947.0, 96328.51835740777, 96585.517072417, 98066.5096674512, 8054.758357249058, 8062.274395304451, 8073.233042860918, 8191.549464779494, 8285.4200205985, 52994.470055300495, 53076.0, 53143.0, 53943.954203435685, 55608.16587751106, 76788.61605691936, 81223.37979163807, 82810.0, 83012.0, 84035.15964840274, 10790.514426850654, 11037.834432483358, 11078.889211107786, 11181.105511559219, 11613.6515904523, 11450.971016441768, 11871.584494542649, 11957.880421195676, 12330.321832299309, 12685.429155687832, 10977.28647637901, 11474.082073433938, 11484.94257528707, 11575.652730418102, 11583.362915039754, 10830.837537437103, 11189.72025699364, 11305.71735706614, 11626.0, 11690.824637630612, 11150.442477875911, 11160.386178760245, 11186.04918581897, 11476.770464590494, 11504.309741415542, 9442.669506567512, 9876.802463950824, 10007.749806254611, 10016.699499015042, 10066.496675166067, 9124.27005839518, 9595.13643772064, 9668.178204852666, 9752.951235243778, 9773.768230290929], "value": 7197.340156100963, "unit": "score"}], "name": "dromaeo_css", "value": 7067.4497821489995, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 112.0, 110.0, 114.0, 112.0, 111.0, 112.0, 109.0, 110.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 120.0, 124.0, 171.0, 124.0, 128.0, 129.0, 130.0, 157.0, 129.0], "value": 135.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 161.0, 161.0, 163.0, 161.0, 162.0, 161.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 115.0, 77.0, 77.0, 77.0, 75.0, 99.0, 76.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 128.0, 83.0, 83.0, 82.0, 104.0, 81.0, 82.0, 120.0], "value": 92.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 118.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 147.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 52.0, 52.0, 52.0, 52.0, 53.0, 52.0, 54.0, 52.0], "value": 52.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 61.0, 62.0, 60.0, 61.0, 61.0, 61.0, 60.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 80.0, 80.0, 79.0, 81.0, 86.0, 86.0, 80.0, 80.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 131.0, 142.0, 135.0, 138.0, 139.0, 130.0, 129.0, 167.0, 147.0], "value": 139.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 169.0, 167.0, 166.0, 167.0, 167.0, 168.0, 166.0, 167.0, 172.0], "value": 167.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 67.0, 66.0, 65.0, 66.0, 69.0, 65.0, 64.0, 63.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1508.5000000000002, "alertThreshold": 2.0}]} 15:39:15 INFO - Return code: 0 15:39:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:39:15 INFO - # TBPL SUCCESS # 15:39:15 INFO - Running post-action listener: _resource_record_post_action 15:39:15 INFO - [mozharness: 2016-10-06 22:39:15.432230Z] Finished run-tests step (success) 15:39:15 INFO - Running post-run listener: _resource_record_post_run 15:39:15 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 392216576; Read time: 0; Write time: 422680 15:39:15 INFO - TinderboxPrint: CPU usage
13.0% 15:39:15 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 15:39:15 INFO - TinderboxPrint: I/O write bytes / time
392,216,576 / 422,680 15:39:15 INFO - TinderboxPrint: CPU idle
8,311.8 (87.0%) 15:39:15 INFO - TinderboxPrint: CPU user
1,196.9 (12.5%) 15:39:15 INFO - TinderboxPrint: Swap in / out
0 / 0 15:39:15 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103714816; Read time: 0; Write time: 154388 15:39:15 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 288501760; Read time: 0; Write time: 268292 15:39:16 INFO - Running post-run listener: _upload_blobber_files 15:39:16 INFO - Blob upload gear active. 15:39:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:39:16 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 15:39:16 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:39:16 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:39:16 INFO - (blobuploader) - INFO - Open directory for files ... 15:39:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:39:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:39:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:39:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:39:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:39:21 INFO - (blobuploader) - INFO - Done attempting. 15:39:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:39:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:39:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:39:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:39:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:39:21 INFO - (blobuploader) - INFO - Done attempting. 15:39:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:39:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:39:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:39:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:39:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:39:22 INFO - (blobuploader) - INFO - Done attempting. 15:39:22 INFO - (blobuploader) - INFO - Iteration through files over. 15:39:22 INFO - Return code: 0 15:39:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:39:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:39:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b2040acc97a47eafba9d1f4a9512d3582a7570091a85ac8362f2d0cf9fc860c010ef7aa38ec118f4c33b4c8a35e03bc0cdd91137067806857e93c1f290dc9bc3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d8e50a89ec1ab274f18aa917a6d6bc8481692e3eb1242fcad2c9da9e13e44e8c0c11f0126451e9b7a703d5246f531e8b675a3874a77b1aa76f6070cef9fb730f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/070a0e252160ec3cc18ac119d4f43184532daa56baaf3e0268808153c28a396ea461691efeeae3e92e33a2e1a47640e7ffd1f8f74d075ceffcce6c7d94f67025"} 15:39:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:39:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:39:22 INFO - Contents: 15:39:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b2040acc97a47eafba9d1f4a9512d3582a7570091a85ac8362f2d0cf9fc860c010ef7aa38ec118f4c33b4c8a35e03bc0cdd91137067806857e93c1f290dc9bc3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d8e50a89ec1ab274f18aa917a6d6bc8481692e3eb1242fcad2c9da9e13e44e8c0c11f0126451e9b7a703d5246f531e8b675a3874a77b1aa76f6070cef9fb730f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/070a0e252160ec3cc18ac119d4f43184532daa56baaf3e0268808153c28a396ea461691efeeae3e92e33a2e1a47640e7ffd1f8f74d075ceffcce6c7d94f67025"} 15:39:22 INFO - Running post-run listener: copy_logs_to_upload_dir 15:39:22 INFO - Copying logs to upload dir... 15:39:22 INFO - mkdir: /builds/slave/test/build/upload/logs 15:39:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.405568 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-10-06 15:39:22.568745) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 15:39:22.572576) ========= 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=5bd038846534b2fdfa68eeae000001e2-1475792103.784364-380280811 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/sha512/b2040acc97a47eafba9d1f4a9512d3582a7570091a85ac8362f2d0cf9fc860c010ef7aa38ec118f4c33b4c8a35e03bc0cdd91137067806857e93c1f290dc9bc3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d8e50a89ec1ab274f18aa917a6d6bc8481692e3eb1242fcad2c9da9e13e44e8c0c11f0126451e9b7a703d5246f531e8b675a3874a77b1aa76f6070cef9fb730f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/070a0e252160ec3cc18ac119d4f43184532daa56baaf3e0268808153c28a396ea461691efeeae3e92e33a2e1a47640e7ffd1f8f74d075ceffcce6c7d94f67025"} build_url:https://queue.taskcluster.net/v1/task/Uk5FJr2lQZa1tkty3UwyNQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011597 build_url: 'https://queue.taskcluster.net/v1/task/Uk5FJr2lQZa1tkty3UwyNQ/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/sha512/b2040acc97a47eafba9d1f4a9512d3582a7570091a85ac8362f2d0cf9fc860c010ef7aa38ec118f4c33b4c8a35e03bc0cdd91137067806857e93c1f290dc9bc3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d8e50a89ec1ab274f18aa917a6d6bc8481692e3eb1242fcad2c9da9e13e44e8c0c11f0126451e9b7a703d5246f531e8b675a3874a77b1aa76f6070cef9fb730f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/070a0e252160ec3cc18ac119d4f43184532daa56baaf3e0268808153c28a396ea461691efeeae3e92e33a2e1a47640e7ffd1f8f74d075ceffcce6c7d94f67025"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 15:39:22.598115) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 15:39:22.598450) ========= 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=5bd038846534b2fdfa68eeae000001e2-1475792103.784364-380280811 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004523 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 15:39:22.683217) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 15:39:22.683542) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 15:39:22.683829) ========= ========= Total master_lag: 0.17 =========