builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-064 starttime: 1479960206.29 results: success (0) buildid: 20161123171736 builduid: 14d0c88e66214f2eb46e4946f265d08e revision: ef9b2a0ba51b16e65d42728d8aacd265b926bb9f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 20:03:26.294872) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 20:03:26.295360) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 20:03:26.295646) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 20:03:26.316252) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 20:03:26.316655) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1479959691.129873-195329299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-23 20:03:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 216M=0s 2016-11-23 20:03:26 (216 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.119316 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 20:03:26.449923) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 20:03:26.453365) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1479959691.129873-195329299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021266 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 20:03:26.505233) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 20:03:26.505764) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ef9b2a0ba51b16e65d42728d8aacd265b926bb9f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ef9b2a0ba51b16e65d42728d8aacd265b926bb9f --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=a12cd81e0ef515edd9e0d800000001bb-1479959691.129873-195329299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-23 20:03:26,828 truncating revision to first 12 chars 2016-11-23 20:03:26,828 Setting DEBUG logging. 2016-11-23 20:03:26,828 attempt 1/10 2016-11-23 20:03:26,828 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ef9b2a0ba51b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-23 20:03:27,128 unpacking tar archive at: mozilla-aurora-ef9b2a0ba51b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.600454 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 20:03:27.119481) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 20:03:27.119789) ========= script_repo_revision: ef9b2a0ba51b16e65d42728d8aacd265b926bb9f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 20:03:27.120178) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 20:03:27.120459) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 20:03:27.130018) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-11-23 20:03:27.130470) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1479959691.129873-195329299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:03:27 INFO - MultiFileLogger online at 20161123 20:03:27 in /builds/slave/test 20:03:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 20:03:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:03:27 INFO - {'append_to_log': False, 20:03:27 INFO - 'base_work_dir': '/builds/slave/test', 20:03:27 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 20:03:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:03:27 INFO - 'branch': 'Mozilla-Aurora', 20:03:27 INFO - 'buildbot_json_path': 'buildprops.json', 20:03:27 INFO - 'config_files': ('talos/linux_config.py',), 20:03:27 INFO - 'default_actions': ('clobber', 20:03:27 INFO - 'read-buildbot-config', 20:03:27 INFO - 'download-and-extract', 20:03:27 INFO - 'populate-webroot', 20:03:27 INFO - 'create-virtualenv', 20:03:27 INFO - 'install', 20:03:27 INFO - 'run-tests'), 20:03:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:03:27 INFO - 'download_minidump_stackwalk': True, 20:03:27 INFO - 'download_symbols': 'ondemand', 20:03:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:03:27 INFO - 'tooltool.py': '/tools/tooltool.py', 20:03:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:03:27 INFO - '/tools/misc-python/virtualenv.py')}, 20:03:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:03:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:03:27 INFO - 'installer_path': 'installer.exe', 20:03:27 INFO - 'log_level': 'info', 20:03:27 INFO - 'log_name': 'talos', 20:03:27 INFO - 'log_to_console': True, 20:03:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:03:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:03:27 INFO - 'opt_config_files': (), 20:03:27 INFO - 'pip_index': False, 20:03:27 INFO - 'sps_profile': False, 20:03:27 INFO - 'sps_profile_interval': 0, 20:03:27 INFO - 'suite': 'dromaeojs', 20:03:27 INFO - 'system_bits': '32', 20:03:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:03:27 INFO - 'title': 'talos-linux64-ix-064', 20:03:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:03:27 INFO - 'use_talos_json': True, 20:03:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:03:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:03:27 INFO - 'work_dir': 'build'} 20:03:27 INFO - [mozharness: 2016-11-24 04:03:27.555807Z] Running clobber step. 20:03:27 INFO - Running pre-action listener: _resource_record_pre_action 20:03:27 INFO - Running main action method: clobber 20:03:27 INFO - rmtree: /builds/slave/test/build 20:03:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:03:28 INFO - Running post-action listener: _resource_record_post_action 20:03:28 INFO - [mozharness: 2016-11-24 04:03:28.541528Z] Finished clobber step (success) 20:03:28 INFO - [mozharness: 2016-11-24 04:03:28.541626Z] Running read-buildbot-config step. 20:03:28 INFO - Running pre-action listener: _resource_record_pre_action 20:03:28 INFO - Running main action method: read_buildbot_config 20:03:28 INFO - Using buildbot properties: 20:03:28 INFO - { 20:03:28 INFO - "project": "", 20:03:28 INFO - "product": "firefox", 20:03:28 INFO - "script_repo_revision": "production", 20:03:28 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 20:03:28 INFO - "repository": "", 20:03:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 20:03:28 INFO - "buildid": "20161123171736", 20:03:28 INFO - "pgo_build": "True", 20:03:28 INFO - "basedir": "/builds/slave/test", 20:03:28 INFO - "buildnumber": 639, 20:03:28 INFO - "slavename": "talos-linux64-ix-064", 20:03:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:03:28 INFO - "platform": "ubuntu64_hw", 20:03:28 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 20:03:28 INFO - "branch": "mozilla-aurora", 20:03:28 INFO - "repo_path": "releases/mozilla-aurora", 20:03:28 INFO - "revision": "ef9b2a0ba51b16e65d42728d8aacd265b926bb9f", 20:03:28 INFO - "stage_platform": "linux64-pgo", 20:03:28 INFO - "builduid": "14d0c88e66214f2eb46e4946f265d08e", 20:03:28 INFO - "slavebuilddir": "test" 20:03:28 INFO - } 20:03:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/UAHI9e7SQWqDRhpa46G2vQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 20:03:28 INFO - Running post-action listener: _resource_record_post_action 20:03:28 INFO - [mozharness: 2016-11-24 04:03:28.544152Z] Finished read-buildbot-config step (success) 20:03:28 INFO - [mozharness: 2016-11-24 04:03:28.544241Z] Running download-and-extract step. 20:03:28 INFO - Running pre-action listener: _resource_record_pre_action 20:03:28 INFO - Running main action method: download_and_extract 20:03:28 INFO - mkdir: /builds/slave/test/build/tests 20:03:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:03:28 INFO - trying https://queue.taskcluster.net/v1/task/UAHI9e7SQWqDRhpa46G2vQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 20:03:28 INFO - Downloading https://queue.taskcluster.net/v1/task/UAHI9e7SQWqDRhpa46G2vQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 20:03:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UAHI9e7SQWqDRhpa46G2vQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:03:29 INFO - Downloaded 1361 bytes. 20:03:29 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 20:03:29 INFO - Using the following test package requirements: 20:03:29 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 20:03:29 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 20:03:29 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 20:03:29 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 20:03:29 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 20:03:29 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 20:03:29 INFO - u'jsshell-linux-x86_64.zip'], 20:03:29 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 20:03:29 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 20:03:29 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 20:03:29 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 20:03:29 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 20:03:29 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 20:03:29 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 20:03:29 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 20:03:29 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 20:03:29 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 20:03:29 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 20:03:29 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:03:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UAHI9e7SQWqDRhpa46G2vQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 20:03:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UAHI9e7SQWqDRhpa46G2vQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:03:29 INFO - Fetch https://queue.taskcluster.net/v1/task/UAHI9e7SQWqDRhpa46G2vQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 20:03:29 INFO - Http code: 200 20:03:29 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 20:03:29 INFO - x-amz-cf-id: Ehh1e-GmP3FFuwdM-4SPu2pwSRLygIUfGyT-OP2LVbBFGVwOT3oV4w== 20:03:29 INFO - x-amz-version-id: 48mD6C3Q6Xd1IzTg9LM50iNhm2ak04L. 20:03:29 INFO - Expected file size: 21950077 20:03:29 INFO - Obtained file size: 21950077 20:03:34 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:03:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UAHI9e7SQWqDRhpa46G2vQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 20:03:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UAHI9e7SQWqDRhpa46G2vQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:03:34 INFO - Fetch https://queue.taskcluster.net/v1/task/UAHI9e7SQWqDRhpa46G2vQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 20:03:34 INFO - Http code: 200 20:03:34 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 20:03:34 INFO - x-amz-cf-id: 632lu7haSq6lYj41vK2UOYs3Sl5FqzkH6cOCRcd_uKYcKSrFHvaDAw== 20:03:34 INFO - x-amz-version-id: 48mD6C3Q6Xd1IzTg9LM50iNhm2ak04L. 20:03:34 INFO - Expected file size: 21950077 20:03:34 INFO - Obtained file size: 21950077 20:03:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UAHI9e7SQWqDRhpa46G2vQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 20:03:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UAHI9e7SQWqDRhpa46G2vQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:03:39 INFO - Fetch https://queue.taskcluster.net/v1/task/UAHI9e7SQWqDRhpa46G2vQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 20:03:39 INFO - Http code: 200 20:03:39 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 20:03:39 INFO - x-amz-cf-id: TC-KL0kdsV80haN3qYOjGKIbfi2lKKjzACZX3JB0n_b8rStlOD9vjA== 20:03:39 INFO - x-amz-version-id: 9zCgQhG0J826_zJsTs04rlz_q2MG_SCY 20:03:39 INFO - Expected file size: 14409038 20:03:39 INFO - Obtained file size: 14409038 20:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:03:40 INFO - trying https://queue.taskcluster.net/v1/task/UAHI9e7SQWqDRhpa46G2vQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 20:03:40 INFO - Downloading https://queue.taskcluster.net/v1/task/UAHI9e7SQWqDRhpa46G2vQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 20:03:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UAHI9e7SQWqDRhpa46G2vQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:03:41 INFO - Downloaded 63882263 bytes. 20:03:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UAHI9e7SQWqDRhpa46G2vQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 20:03:41 INFO - mkdir: /builds/slave/test/properties 20:03:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:03:41 INFO - Writing to file /builds/slave/test/properties/build_url 20:03:41 INFO - Contents: 20:03:41 INFO - build_url:https://queue.taskcluster.net/v1/task/UAHI9e7SQWqDRhpa46G2vQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 20:03:42 INFO - Running post-action listener: _resource_record_post_action 20:03:42 INFO - Running post-action listener: set_extra_try_arguments 20:03:42 INFO - [mozharness: 2016-11-24 04:03:42.050588Z] Finished download-and-extract step (success) 20:03:42 INFO - [mozharness: 2016-11-24 04:03:42.050818Z] Running populate-webroot step. 20:03:42 INFO - Running pre-action listener: _resource_record_pre_action 20:03:42 INFO - Running main action method: populate_webroot 20:03:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:03:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:03:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:03:42 INFO - '--tppagecycles', 20:03:42 INFO - '7'], 20:03:42 INFO - 'tests': ['tsvgm']}}, 20:03:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:03:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:03:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:03:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:03:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:03:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:03:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:42 INFO - 'talos_options': ['--disable-e10s'], 20:03:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:03:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:03:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:42 INFO - 'talos_options': ['--disable-e10s'], 20:03:42 INFO - 'tests': ['damp', 'tps']}, 20:03:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:42 INFO - 'tests': ['damp', 'tps']}, 20:03:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:03:42 INFO - 'tests': ['dromaeo_dom']}, 20:03:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:03:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:03:42 INFO - 'tests': ['basic_compositor_video']}, 20:03:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:03:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:03:42 INFO - 'tests': ['a11yr', 20:03:42 INFO - 'ts_paint', 20:03:42 INFO - 'tpaint', 20:03:42 INFO - 'sessionrestore', 20:03:42 INFO - 'sessionrestore_no_auto_restore', 20:03:42 INFO - 'tabpaint']}, 20:03:42 INFO - 'other-e10s': {'tests': ['a11yr', 20:03:42 INFO - 'ts_paint', 20:03:42 INFO - 'tpaint', 20:03:42 INFO - 'sessionrestore', 20:03:42 INFO - 'sessionrestore_no_auto_restore', 20:03:42 INFO - 'tabpaint']}, 20:03:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:03:42 INFO - 'ts_paint', 20:03:42 INFO - 'tpaint', 20:03:42 INFO - 'sessionrestore', 20:03:42 INFO - 'sessionrestore_no_auto_restore', 20:03:42 INFO - 'tabpaint']}, 20:03:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:03:42 INFO - 'ts_paint', 20:03:42 INFO - 'tpaint', 20:03:42 INFO - 'sessionrestore', 20:03:42 INFO - 'sessionrestore_no_auto_restore', 20:03:42 INFO - 'tabpaint']}, 20:03:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:03:42 INFO - 'tests': ['a11yr', 20:03:42 INFO - 'ts_paint', 20:03:42 INFO - 'tpaint', 20:03:42 INFO - 'sessionrestore', 20:03:42 INFO - 'sessionrestore_no_auto_restore', 20:03:42 INFO - 'tabpaint']}, 20:03:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:03:42 INFO - 'tests': ['a11yr', 20:03:42 INFO - 'ts_paint', 20:03:42 INFO - 'tpaint', 20:03:42 INFO - 'sessionrestore', 20:03:42 INFO - 'sessionrestore_no_auto_restore', 20:03:42 INFO - 'tabpaint']}, 20:03:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:03:42 INFO - 'tests': ['tsvgx', 20:03:42 INFO - 'tsvgr_opacity', 20:03:42 INFO - 'tart', 20:03:42 INFO - 'tscrollx', 20:03:42 INFO - 'cart']}, 20:03:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:03:42 INFO - 'tsvgr_opacity', 20:03:42 INFO - 'tart', 20:03:42 INFO - 'tscrollx', 20:03:42 INFO - 'cart']}, 20:03:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:42 INFO - 'talos_options': ['--disable-e10s'], 20:03:42 INFO - 'tests': ['tp5o']}, 20:03:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:42 INFO - 'tests': ['tp5o']}, 20:03:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:42 INFO - 'talos_options': ['--disable-e10s', 20:03:42 INFO - '--xperf_path', 20:03:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:03:42 INFO - 'tests': ['tp5n']}, 20:03:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:42 INFO - 'talos_options': ['--xperf_path', 20:03:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:03:42 INFO - 'tests': ['tp5n']}}, 20:03:42 INFO - 'talos.zip': {'path': '', 20:03:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:03:42 INFO - Running post-action listener: _resource_record_post_action 20:03:42 INFO - [mozharness: 2016-11-24 04:03:42.068872Z] Finished populate-webroot step (success) 20:03:42 INFO - [mozharness: 2016-11-24 04:03:42.068959Z] Running create-virtualenv step. 20:03:42 INFO - Running pre-action listener: _resource_record_pre_action 20:03:42 INFO - Running main action method: create_virtualenv 20:03:42 INFO - Creating virtualenv /builds/slave/test/build/venv 20:03:42 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 20:03:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:03:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:03:42 INFO - Using real prefix '/usr' 20:03:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:03:42 INFO - Installing distribute.............................................................................................................................................................................................done. 20:03:44 INFO - Installing pip.................done. 20:03:44 INFO - Return code: 0 20:03:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:03:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:03:44 INFO - Reading from file tmpfile_stdout 20:03:44 INFO - Output received: 20:03:44 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) 20:03:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:03:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:03:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:44 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 0x7fdce32def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c56ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c53f60>, '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 0x2c54d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c551d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1479959691.129873-195329299', '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 20:03:44 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 20:03:44 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 20:03:44 INFO - Using env: {'DISPLAY': ':0', 20:03:44 INFO - 'HOME': '/home/cltbld', 20:03:44 INFO - 'LANG': 'en_US.UTF-8', 20:03:44 INFO - 'LANGUAGE': 'en_US:en', 20:03:44 INFO - 'LOGNAME': 'cltbld', 20:03:44 INFO - 'MAIL': '/var/mail/cltbld', 20:03:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:44 INFO - 'MOZ_NO_REMOTE': '1', 20:03:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:44 INFO - 'NO_EM_RESTART': '1', 20:03:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:44 INFO - 'PWD': '/builds/slave/test', 20:03:44 INFO - 'SHELL': '/bin/bash', 20:03:44 INFO - 'SHLVL': '1', 20:03:44 INFO - 'TERM': 'linux', 20:03:44 INFO - 'TMOUT': '86400', 20:03:44 INFO - 'USER': 'cltbld', 20:03:44 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1479959691.129873-195329299', 20:03:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:44 INFO - '_': '/tools/buildbot/bin/python'} 20:03:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:45 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 20:03:45 INFO - Cleaning up... 20:03:45 INFO - Return code: 0 20:03:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:03:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdce32def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c56ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c53f60>, '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 0x2c54d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c551d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1479959691.129873-195329299', '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 20:03:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:03:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:03:45 INFO - Using env: {'DISPLAY': ':0', 20:03:45 INFO - 'HOME': '/home/cltbld', 20:03:45 INFO - 'LANG': 'en_US.UTF-8', 20:03:45 INFO - 'LANGUAGE': 'en_US:en', 20:03:45 INFO - 'LOGNAME': 'cltbld', 20:03:45 INFO - 'MAIL': '/var/mail/cltbld', 20:03:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:45 INFO - 'MOZ_NO_REMOTE': '1', 20:03:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:45 INFO - 'NO_EM_RESTART': '1', 20:03:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:45 INFO - 'PWD': '/builds/slave/test', 20:03:45 INFO - 'SHELL': '/bin/bash', 20:03:45 INFO - 'SHLVL': '1', 20:03:45 INFO - 'TERM': 'linux', 20:03:45 INFO - 'TMOUT': '86400', 20:03:45 INFO - 'USER': 'cltbld', 20:03:45 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1479959691.129873-195329299', 20:03:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:45 INFO - '_': '/tools/buildbot/bin/python'} 20:03:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:45 INFO - Downloading/unpacking psutil>=3.1.1 20:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:03:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:03:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:03:47 INFO - Installing collected packages: psutil 20:03:47 INFO - Running setup.py install for psutil 20:03:47 INFO - building 'psutil._psutil_linux' extension 20:03:47 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 20:03:47 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 20:03:47 INFO - building 'psutil._psutil_posix' extension 20:03:47 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 20:03:47 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 20:03:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:03:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:03:47 INFO - Successfully installed psutil 20:03:47 INFO - Cleaning up... 20:03:47 INFO - Return code: 0 20:03:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:03:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:47 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 0x7fdce32def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c56ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c53f60>, '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 0x2c54d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c551d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1479959691.129873-195329299', '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 20:03:47 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 20:03:47 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 20:03:47 INFO - Using env: {'DISPLAY': ':0', 20:03:47 INFO - 'HOME': '/home/cltbld', 20:03:47 INFO - 'LANG': 'en_US.UTF-8', 20:03:47 INFO - 'LANGUAGE': 'en_US:en', 20:03:47 INFO - 'LOGNAME': 'cltbld', 20:03:47 INFO - 'MAIL': '/var/mail/cltbld', 20:03:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:47 INFO - 'MOZ_NO_REMOTE': '1', 20:03:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:47 INFO - 'NO_EM_RESTART': '1', 20:03:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:47 INFO - 'PWD': '/builds/slave/test', 20:03:47 INFO - 'SHELL': '/bin/bash', 20:03:47 INFO - 'SHLVL': '1', 20:03:47 INFO - 'TERM': 'linux', 20:03:47 INFO - 'TMOUT': '86400', 20:03:47 INFO - 'USER': 'cltbld', 20:03:47 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1479959691.129873-195329299', 20:03:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:47 INFO - '_': '/tools/buildbot/bin/python'} 20:03:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:03:48 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 20:03:48 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 20:03:48 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 20:03:48 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 20:03:48 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 20:03:48 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 20:03:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:03:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:03:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:03:50 INFO - Installing collected packages: mozsystemmonitor 20:03:50 INFO - Running setup.py install for mozsystemmonitor 20:03:50 INFO - Successfully installed mozsystemmonitor 20:03:50 INFO - Cleaning up... 20:03:50 INFO - Return code: 0 20:03:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:03:50 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')]} 20:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:50 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')]} 20:03:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:50 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 0x7fdce32def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c56ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c53f60>, '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 0x2c54d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c551d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1479959691.129873-195329299', '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 20:03:50 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 20:03:50 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 20:03:50 INFO - Using env: {'DISPLAY': ':0', 20:03:50 INFO - 'HOME': '/home/cltbld', 20:03:50 INFO - 'LANG': 'en_US.UTF-8', 20:03:50 INFO - 'LANGUAGE': 'en_US:en', 20:03:50 INFO - 'LOGNAME': 'cltbld', 20:03:50 INFO - 'MAIL': '/var/mail/cltbld', 20:03:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:50 INFO - 'MOZ_NO_REMOTE': '1', 20:03:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:50 INFO - 'NO_EM_RESTART': '1', 20:03:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:50 INFO - 'PWD': '/builds/slave/test', 20:03:50 INFO - 'SHELL': '/bin/bash', 20:03:50 INFO - 'SHLVL': '1', 20:03:50 INFO - 'TERM': 'linux', 20:03:50 INFO - 'TMOUT': '86400', 20:03:50 INFO - 'USER': 'cltbld', 20:03:50 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1479959691.129873-195329299', 20:03:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:50 INFO - '_': '/tools/buildbot/bin/python'} 20:03:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:50 INFO - Downloading/unpacking jsonschema==2.5.1 20:03:50 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 20:03:50 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 20:03:50 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 20:03:50 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 20:03:50 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 20:03:50 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 20:03:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:03:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:03:52 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 20:03:52 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 20:03:52 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 20:03:52 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 20:03:52 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 20:03:52 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 20:03:52 INFO - Downloading functools32-3.2.3-2.tar.gz 20:03:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:03:52 INFO - warning: no files found matching '*.txt' 20:03:52 INFO - no previously-included directories found matching 'build' 20:03:52 INFO - no previously-included directories found matching 'dist' 20:03:52 INFO - no previously-included directories found matching '.git*' 20:03:52 INFO - Installing collected packages: jsonschema, functools32 20:03:52 INFO - Running setup.py install for functools32 20:03:52 INFO - warning: no files found matching '*.txt' 20:03:52 INFO - no previously-included directories found matching 'build' 20:03:52 INFO - no previously-included directories found matching 'dist' 20:03:52 INFO - no previously-included directories found matching '.git*' 20:03:52 INFO - Successfully installed jsonschema functools32 20:03:52 INFO - Cleaning up... 20:03:52 INFO - Return code: 0 20:03:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:03: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')]} 20:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03: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')]} 20:03:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:52 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 0x7fdce32def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c56ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c53f60>, '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 0x2c54d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c551d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1479959691.129873-195329299', '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 20:03:52 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 20:03:52 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 20:03:52 INFO - Using env: {'DISPLAY': ':0', 20:03:52 INFO - 'HOME': '/home/cltbld', 20:03:52 INFO - 'LANG': 'en_US.UTF-8', 20:03:52 INFO - 'LANGUAGE': 'en_US:en', 20:03:52 INFO - 'LOGNAME': 'cltbld', 20:03:52 INFO - 'MAIL': '/var/mail/cltbld', 20:03:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:52 INFO - 'MOZ_NO_REMOTE': '1', 20:03:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:52 INFO - 'NO_EM_RESTART': '1', 20:03:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:52 INFO - 'PWD': '/builds/slave/test', 20:03:52 INFO - 'SHELL': '/bin/bash', 20:03:52 INFO - 'SHLVL': '1', 20:03:52 INFO - 'TERM': 'linux', 20:03:52 INFO - 'TMOUT': '86400', 20:03:52 INFO - 'USER': 'cltbld', 20:03:52 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1479959691.129873-195329299', 20:03:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:52 INFO - '_': '/tools/buildbot/bin/python'} 20:03:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:03:53 INFO - Cleaning up... 20:03:53 INFO - Return code: 0 20:03:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:03:53 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')]} 20:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:53 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')]} 20:03:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:53 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 0x7fdce32def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c56ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c53f60>, '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 0x2c54d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c551d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1479959691.129873-195329299', '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 20:03:53 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 20:03:53 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 20:03:53 INFO - Using env: {'DISPLAY': ':0', 20:03:53 INFO - 'HOME': '/home/cltbld', 20:03:53 INFO - 'LANG': 'en_US.UTF-8', 20:03:53 INFO - 'LANGUAGE': 'en_US:en', 20:03:53 INFO - 'LOGNAME': 'cltbld', 20:03:53 INFO - 'MAIL': '/var/mail/cltbld', 20:03:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:53 INFO - 'MOZ_NO_REMOTE': '1', 20:03:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:53 INFO - 'NO_EM_RESTART': '1', 20:03:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:53 INFO - 'PWD': '/builds/slave/test', 20:03:53 INFO - 'SHELL': '/bin/bash', 20:03:53 INFO - 'SHLVL': '1', 20:03:53 INFO - 'TERM': 'linux', 20:03:53 INFO - 'TMOUT': '86400', 20:03:53 INFO - 'USER': 'cltbld', 20:03:53 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1479959691.129873-195329299', 20:03:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:53 INFO - '_': '/tools/buildbot/bin/python'} 20:03:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:53 INFO - Downloading/unpacking blobuploader==1.2.4 20:03:53 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 20:03:53 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 20:03:53 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 20:03:53 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 20:03:53 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 20:03:53 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 20:03:55 INFO - Downloading blobuploader-1.2.4.tar.gz 20:03:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:03:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:03:55 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 20:03:55 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 20:03:55 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 20:03:55 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 20:03:55 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 20:03:55 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 20:03:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:03:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:03:55 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 20:03:55 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 20:03:55 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 20:03:55 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 20:03:55 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 20:03:55 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 20:03:56 INFO - Downloading docopt-0.6.1.tar.gz 20:03:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:03:56 INFO - Installing collected packages: blobuploader, requests, docopt 20:03:56 INFO - Running setup.py install for blobuploader 20:03:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:03:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:03:56 INFO - Running setup.py install for requests 20:03:56 INFO - Running setup.py install for docopt 20:03:56 INFO - Successfully installed blobuploader requests docopt 20:03:56 INFO - Cleaning up... 20:03:56 INFO - Return code: 0 20:03:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:03:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:56 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 0x7fdce32def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c56ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c53f60>, '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 0x2c54d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c551d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1479959691.129873-195329299', '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 20:03:56 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 20:03:56 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 20:03:56 INFO - Using env: {'DISPLAY': ':0', 20:03:56 INFO - 'HOME': '/home/cltbld', 20:03:56 INFO - 'LANG': 'en_US.UTF-8', 20:03:56 INFO - 'LANGUAGE': 'en_US:en', 20:03:56 INFO - 'LOGNAME': 'cltbld', 20:03:56 INFO - 'MAIL': '/var/mail/cltbld', 20:03:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:56 INFO - 'MOZ_NO_REMOTE': '1', 20:03:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:56 INFO - 'NO_EM_RESTART': '1', 20:03:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:56 INFO - 'PWD': '/builds/slave/test', 20:03:56 INFO - 'SHELL': '/bin/bash', 20:03:56 INFO - 'SHLVL': '1', 20:03:56 INFO - 'TERM': 'linux', 20:03:56 INFO - 'TMOUT': '86400', 20:03:56 INFO - 'USER': 'cltbld', 20:03:56 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1479959691.129873-195329299', 20:03:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:56 INFO - '_': '/tools/buildbot/bin/python'} 20:03:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:03:57 INFO - Running setup.py (path:/tmp/pip-eih9U6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:03:57 INFO - Running setup.py (path:/tmp/pip-ZtBXVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:03:57 INFO - Running setup.py (path:/tmp/pip-_ZgB_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:03:57 INFO - Running setup.py (path:/tmp/pip-m78xi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:03:57 INFO - Running setup.py (path:/tmp/pip-KhuHWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:03:57 INFO - Running setup.py (path:/tmp/pip-Jw6eb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:03:57 INFO - Running setup.py (path:/tmp/pip-_Lr_p2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:03:57 INFO - Running setup.py (path:/tmp/pip-9xqbgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:03:57 INFO - Running setup.py (path:/tmp/pip-7ukKVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:03:57 INFO - Running setup.py (path:/tmp/pip-rb1X4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:03:57 INFO - Running setup.py (path:/tmp/pip-sfxZ_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:03:57 INFO - Running setup.py (path:/tmp/pip-N0LI3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:03:57 INFO - Running setup.py (path:/tmp/pip-zs9gZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:03:58 INFO - Running setup.py (path:/tmp/pip-JmdT5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:03:58 INFO - Running setup.py (path:/tmp/pip-jvuUIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:03:58 INFO - Running setup.py (path:/tmp/pip-r2kVTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:03:58 INFO - Running setup.py (path:/tmp/pip-MPgKuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:03:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:03:58 INFO - Running setup.py install for manifestparser 20:03:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:03:58 INFO - Running setup.py install for mozcrash 20:03:58 INFO - Running setup.py install for mozdebug 20:03:58 INFO - Running setup.py install for mozdevice 20:03:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:03:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:03:58 INFO - Running setup.py install for mozfile 20:03:58 INFO - Running setup.py install for mozhttpd 20:03:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:03:58 INFO - Running setup.py install for mozinfo 20:03:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:03:59 INFO - Running setup.py install for mozInstall 20:03:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:03:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:03:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:03:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:03:59 INFO - Running setup.py install for mozleak 20:03:59 INFO - Running setup.py install for mozlog 20:03:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:03:59 INFO - Running setup.py install for moznetwork 20:03:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:03:59 INFO - Running setup.py install for mozprocess 20:03:59 INFO - Running setup.py install for mozprofile 20:03:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:03:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:03:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:03:59 INFO - Running setup.py install for mozrunner 20:03:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:03:59 INFO - Running setup.py install for mozscreenshot 20:03:59 INFO - Running setup.py install for moztest 20:04:00 INFO - Running setup.py install for mozversion 20:04:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:04:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:04:00 INFO - Cleaning up... 20:04:00 INFO - Return code: 0 20:04:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:04: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')]} 20:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04: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')]} 20:04:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:00 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 0x7fdce32def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c56ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c53f60>, '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 0x2c54d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c551d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1479959691.129873-195329299', '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 20:04:00 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 20:04:00 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 20:04:00 INFO - Using env: {'DISPLAY': ':0', 20:04:00 INFO - 'HOME': '/home/cltbld', 20:04:00 INFO - 'LANG': 'en_US.UTF-8', 20:04:00 INFO - 'LANGUAGE': 'en_US:en', 20:04:00 INFO - 'LOGNAME': 'cltbld', 20:04:00 INFO - 'MAIL': '/var/mail/cltbld', 20:04:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:00 INFO - 'MOZ_NO_REMOTE': '1', 20:04:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:04:00 INFO - 'NO_EM_RESTART': '1', 20:04:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:04:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:00 INFO - 'PWD': '/builds/slave/test', 20:04:00 INFO - 'SHELL': '/bin/bash', 20:04:00 INFO - 'SHLVL': '1', 20:04:00 INFO - 'TERM': 'linux', 20:04:00 INFO - 'TMOUT': '86400', 20:04:00 INFO - 'USER': 'cltbld', 20:04:00 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1479959691.129873-195329299', 20:04:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:00 INFO - '_': '/tools/buildbot/bin/python'} 20:04:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:04:00 INFO - Running setup.py (path:/tmp/pip-vAzZaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:04:00 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)) 20:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:04:00 INFO - Running setup.py (path:/tmp/pip-0u8HPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:04:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:04:00 INFO - Running setup.py (path:/tmp/pip-_Xx8uT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:04:00 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)) 20:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:04:00 INFO - Running setup.py (path:/tmp/pip-ucpf5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:04:00 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)) 20:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:04:00 INFO - Running setup.py (path:/tmp/pip-pElbEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:04:00 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)) 20:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:04:00 INFO - Running setup.py (path:/tmp/pip-Y4w5rn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:04:00 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)) 20:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:04:00 INFO - Running setup.py (path:/tmp/pip-rv20Dg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:04:00 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)) 20:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:04:00 INFO - Running setup.py (path:/tmp/pip-q3XC6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:04:00 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)) 20:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:04:00 INFO - Running setup.py (path:/tmp/pip-7lxyz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:04:01 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)) 20:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:04:01 INFO - Running setup.py (path:/tmp/pip-KYzYUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:04:01 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)) 20:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:04:01 INFO - Running setup.py (path:/tmp/pip-jwMKJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:04:01 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)) 20:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:04:01 INFO - Running setup.py (path:/tmp/pip-f0I9Is-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:04:01 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)) 20:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:04:01 INFO - Running setup.py (path:/tmp/pip-pETVN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:04:01 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)) 20:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:04:01 INFO - Running setup.py (path:/tmp/pip-mYl7Am-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:04:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:04:01 INFO - Running setup.py (path:/tmp/pip-VirUHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:04:01 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)) 20:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:04:01 INFO - Running setup.py (path:/tmp/pip-hiN8EM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:04:01 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)) 20:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:04:01 INFO - Running setup.py (path:/tmp/pip-GcWRVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:04:01 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)) 20:04:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:04:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:04:01 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)) 20:04:01 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)) 20:04:01 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)) 20:04:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:04:01 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 20:04:01 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 20:04:01 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 20:04:01 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 20:04:01 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 20:04:01 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 20:04:03 INFO - Downloading blessings-1.6.tar.gz 20:04:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:04:03 INFO - Installing collected packages: blessings 20:04:03 INFO - Running setup.py install for blessings 20:04:03 INFO - Successfully installed blessings 20:04:03 INFO - Cleaning up... 20:04:03 INFO - Return code: 0 20:04:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:04:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:04:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:04:04 INFO - Reading from file tmpfile_stdout 20:04:04 INFO - Current package versions: 20:04:04 INFO - argparse == 1.2.1 20:04:04 INFO - blessings == 1.6 20:04:04 INFO - blobuploader == 1.2.4 20:04:04 INFO - docopt == 0.6.1 20:04:04 INFO - functools32 == 3.2.3-2 20:04:04 INFO - jsonschema == 2.5.1 20:04:04 INFO - manifestparser == 1.1 20:04:04 INFO - mozInstall == 1.12 20:04:04 INFO - mozcrash == 1.0 20:04:04 INFO - mozdebug == 0.1 20:04:04 INFO - mozdevice == 0.48 20:04:04 INFO - mozfile == 1.2 20:04:04 INFO - mozhttpd == 0.7 20:04:04 INFO - mozinfo == 0.9 20:04:04 INFO - mozleak == 0.1 20:04:04 INFO - mozlog == 3.4 20:04:04 INFO - moznetwork == 0.27 20:04:04 INFO - mozprocess == 0.23 20:04:04 INFO - mozprofile == 0.28 20:04:04 INFO - mozrunner == 6.13 20:04:04 INFO - mozscreenshot == 0.1 20:04:04 INFO - mozsystemmonitor == 0.3 20:04:04 INFO - moztest == 0.7 20:04:04 INFO - mozversion == 1.4 20:04:04 INFO - psutil == 3.1.1 20:04:04 INFO - requests == 1.2.3 20:04:04 INFO - wsgiref == 0.1.2 20:04:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:04:04 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')]} 20:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:04 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')]} 20:04:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:04 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 0x7fdce32def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c56ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c53f60>, '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 0x2c54d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c551d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1479959691.129873-195329299', '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 20:04:04 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 20:04:04 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 20:04:04 INFO - Using env: {'DISPLAY': ':0', 20:04:04 INFO - 'HOME': '/home/cltbld', 20:04:04 INFO - 'LANG': 'en_US.UTF-8', 20:04:04 INFO - 'LANGUAGE': 'en_US:en', 20:04:04 INFO - 'LOGNAME': 'cltbld', 20:04:04 INFO - 'MAIL': '/var/mail/cltbld', 20:04:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:04 INFO - 'MOZ_NO_REMOTE': '1', 20:04:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:04:04 INFO - 'NO_EM_RESTART': '1', 20:04:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:04:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:04 INFO - 'PWD': '/builds/slave/test', 20:04:04 INFO - 'SHELL': '/bin/bash', 20:04:04 INFO - 'SHLVL': '1', 20:04:04 INFO - 'TERM': 'linux', 20:04:04 INFO - 'TMOUT': '86400', 20:04:04 INFO - 'USER': 'cltbld', 20:04:04 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1479959691.129873-195329299', 20:04:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:04 INFO - '_': '/tools/buildbot/bin/python'} 20:04:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:04 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)) 20:04:04 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)) 20:04:04 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)) 20:04:04 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)) 20:04:04 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)) 20:04:04 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)) 20:04:04 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)) 20:04:04 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)) 20:04:04 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)) 20:04:04 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)) 20:04:04 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)) 20:04:04 INFO - Cleaning up... 20:04:04 INFO - Return code: 0 20:04:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:04:04 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')]} 20:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:04 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')]} 20:04:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:04 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 0x7fdce32def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c56ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c53f60>, '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 0x2c54d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c551d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1479959691.129873-195329299', '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 20:04:04 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 20:04:04 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 20:04:04 INFO - Using env: {'DISPLAY': ':0', 20:04:04 INFO - 'HOME': '/home/cltbld', 20:04:04 INFO - 'LANG': 'en_US.UTF-8', 20:04:04 INFO - 'LANGUAGE': 'en_US:en', 20:04:04 INFO - 'LOGNAME': 'cltbld', 20:04:04 INFO - 'MAIL': '/var/mail/cltbld', 20:04:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:04 INFO - 'MOZ_NO_REMOTE': '1', 20:04:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:04:04 INFO - 'NO_EM_RESTART': '1', 20:04:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:04:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:04 INFO - 'PWD': '/builds/slave/test', 20:04:04 INFO - 'SHELL': '/bin/bash', 20:04:04 INFO - 'SHLVL': '1', 20:04:04 INFO - 'TERM': 'linux', 20:04:04 INFO - 'TMOUT': '86400', 20:04:04 INFO - 'USER': 'cltbld', 20:04:04 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1479959691.129873-195329299', 20:04:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:04 INFO - '_': '/tools/buildbot/bin/python'} 20:04:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:04:04 INFO - Cleaning up... 20:04:04 INFO - Return code: 0 20:04:04 INFO - Running post-action listener: _resource_record_post_action 20:04:04 INFO - Running post-action listener: _start_resource_monitoring 20:04:04 INFO - Starting resource monitoring. 20:04:04 INFO - [mozharness: 2016-11-24 04:04:04.561042Z] Finished create-virtualenv step (success) 20:04:04 INFO - [mozharness: 2016-11-24 04:04:04.561535Z] Running install step. 20:04:04 INFO - Running pre-action listener: _resource_record_pre_action 20:04:04 INFO - Running main action method: install 20:04:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:04:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:04:04 INFO - Reading from file tmpfile_stdout 20:04:04 INFO - Detecting whether we're running mozinstall >=1.0... 20:04:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:04:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:04:04 INFO - Reading from file tmpfile_stdout 20:04:04 INFO - Output received: 20:04:04 INFO - Usage: mozinstall [options] installer 20:04:04 INFO - Options: 20:04:04 INFO - -h, --help show this help message and exit 20:04:04 INFO - -d DEST, --destination=DEST 20:04:04 INFO - Directory to install application into. [default: 20:04:04 INFO - "/builds/slave/test"] 20:04:04 INFO - --app=APP Application being installed. [default: firefox] 20:04:04 INFO - mkdir: /builds/slave/test/build/application 20:04:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:04:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:04:20 INFO - Reading from file tmpfile_stdout 20:04:20 INFO - Output received: 20:04:20 INFO - /builds/slave/test/build/application/firefox/firefox 20:04:20 INFO - Running post-action listener: _resource_record_post_action 20:04:20 INFO - [mozharness: 2016-11-24 04:04:20.773143Z] Finished install step (success) 20:04:20 INFO - [mozharness: 2016-11-24 04:04:20.773386Z] Running run-tests step. 20:04:20 INFO - Running pre-action listener: _resource_record_pre_action 20:04:20 INFO - Running main action method: run_tests 20:04:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:04:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:04:20 INFO - Python 2.7.3 20:04:20 INFO - Return code: 0 20:04:20 INFO - grabbing minidump binary from tooltool 20:04:20 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')]} 20:04:20 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 0x2c53f60>, '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 0x2c54d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c551d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:04:20 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 20:04:20 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 20:04:20 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 20:04:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:04:20 INFO - Return code: 0 20:04:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:04:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:04:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:04:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:04:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:04:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UAHI9e7SQWqDRhpa46G2vQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 20:04:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UAHI9e7SQWqDRhpa46G2vQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 20:04:20 INFO - Using env: {'DISPLAY': ':0', 20:04:20 INFO - 'HOME': '/home/cltbld', 20:04:20 INFO - 'LANG': 'en_US.UTF-8', 20:04:20 INFO - 'LANGUAGE': 'en_US:en', 20:04:20 INFO - 'LOGNAME': 'cltbld', 20:04:20 INFO - 'MAIL': '/var/mail/cltbld', 20:04:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:04:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:04:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:20 INFO - 'MOZ_NO_REMOTE': '1', 20:04:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:04:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:04:20 INFO - 'NO_EM_RESTART': '1', 20:04:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:04:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:20 INFO - 'PWD': '/builds/slave/test', 20:04:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:04:20 INFO - 'SHELL': '/bin/bash', 20:04:20 INFO - 'SHLVL': '1', 20:04:20 INFO - 'TERM': 'linux', 20:04:20 INFO - 'TMOUT': '86400', 20:04:20 INFO - 'USER': 'cltbld', 20:04:20 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1479959691.129873-195329299', 20:04:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:20 INFO - '_': '/tools/buildbot/bin/python'} 20:04:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UAHI9e7SQWqDRhpa46G2vQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 20:04:21 INFO - mozversion application_buildid: 20161123171736 20:04:21 INFO - mozversion application_changeset: ef9b2a0ba51b16e65d42728d8aacd265b926bb9f 20:04:21 INFO - mozversion application_display_name: FirefoxDeveloperEdition 20:04:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:04:21 INFO - mozversion application_name: Firefox 20:04:21 INFO - mozversion application_remotingname: firefox-dev 20:04:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:04:21 INFO - mozversion application_vendor: Mozilla 20:04:21 INFO - mozversion application_version: 52.0a2 20:04:21 INFO - mozversion platform_buildid: 20161123171736 20:04:21 INFO - mozversion platform_changeset: ef9b2a0ba51b16e65d42728d8aacd265b926bb9f 20:04:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:04:21 INFO - mozversion platform_version: 52.0a2 20:04:21 INFO - using testdate: 1479960261 20:04:21 INFO - actual date: 1479960261 20:04:21 INFO - starting webserver on 'localhost:39340' 20:04:21 INFO - SUITE-START | Running 2 tests 20:04:21 INFO - TEST-START | dromaeo_css 20:04:21 INFO - operating with platform_type : linux_ 20:04:21 INFO - Initialising browser for dromaeo_css test... 20:04:21 INFO - TEST-INFO | started process 18006 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_Kjc4n/profile http://localhost:39340/getInfo.html) 20:04:24 ERROR - PROCESS | 18006 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5373: TypeError: parent.firstChild is null 20:04:25 INFO - PROCESS | 18006 | __metrics Screen width/height:1600/1200 20:04:25 INFO - PROCESS | 18006 | colorDepth:24 20:04:25 INFO - PROCESS | 18006 | Browser inner width/height: 1024/697 20:04:25 INFO - PROCESS | 18006 | __metrics 20:04:25 INFO - PROCESS | 18006 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:04:25 INFO - PROCESS | 18006 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:04:26 INFO - PROCESS | 18006 | console.error: PushService: 20:04:26 INFO - PROCESS | 18006 | stateChangeProcessEnqueue: Error transitioning state 20:04:26 INFO - PROCESS | 18006 | UnknownError 20:04:26 INFO - TEST-INFO | 18006: exit 0 20:04:26 INFO - Browser initialized. 20:04:26 INFO - Running cycle 1/1 for dromaeo_css test... 20:04:26 INFO - TEST-INFO | started process 18097 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_Kjc4n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:04:38 INFO - PROCESS | 18097 | RSS: Main: 148037632 20:04:38 INFO - PROCESS | 18097 | 20:05:30 INFO - PROCESS | 18097 | 1479960330322 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] 20:07:40 INFO - PROCESS | 18097 | Cycle 1(1): loaded http://localhost:39340/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39340/tests/dromaeo/cssquery-ext.html) 20:07:41 INFO - PROCESS | 18097 | RSS: Main: 239509504 20:07:41 INFO - PROCESS | 18097 | 20:10:44 INFO - PROCESS | 18097 | Cycle 1(1): loaded http://localhost:39340/tests/dromaeo/cssquery-ext.html (next: http://localhost:39340/tests/dromaeo/cssquery-jquery.html) 20:10:44 INFO - PROCESS | 18097 | RSS: Main: 232046592 20:10:44 INFO - PROCESS | 18097 | 20:13:46 INFO - PROCESS | 18097 | Cycle 1(1): loaded http://localhost:39340/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39340/tests/dromaeo/cssquery-mootools.html) 20:13:47 INFO - PROCESS | 18097 | RSS: Main: 176697344 20:13:47 INFO - PROCESS | 18097 | 20:16:49 INFO - PROCESS | 18097 | Cycle 1(1): loaded http://localhost:39340/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39340/tests/dromaeo/cssquery-prototype.html) 20:16:49 INFO - PROCESS | 18097 | RSS: Main: 216989696 20:16:49 INFO - PROCESS | 18097 | 20:19:52 INFO - PROCESS | 18097 | Cycle 1(1): loaded http://localhost:39340/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39340/tests/dromaeo/cssquery-yui.html) 20:19:53 INFO - PROCESS | 18097 | RSS: Main: 179519488 20:19:53 INFO - PROCESS | 18097 | 20:22:55 INFO - PROCESS | 18097 | Cycle 1(1): loaded http://localhost:39340/tests/dromaeo/cssquery-yui.html (next: http://localhost:39340/tests/dromaeo/cssquery-dojo.html) 20:22:55 INFO - PROCESS | 18097 | RSS: Main: 267337728 20:22:55 INFO - PROCESS | 18097 | 20:22:55 INFO - PROCESS | 18097 | __start_tp_report 20:22:55 INFO - PROCESS | 18097 | _x_x_mozilla_page_load 20:22:55 INFO - PROCESS | 18097 | _x_x_mozilla_page_load_details 20:22:55 INFO - PROCESS | 18097 | |i|pagename|runs| 20:22:55 INFO - PROCESS | 18097 | |0;dojo.html;3214.5338925855754;3226.5321528378386;3243.3189030303633;3261.5596894419245;3281.245313577877;5433.945660543398;5484.204790305404;5492.121260598305;5500.80747173849;5509.421510741375;5558.249636299099;5613.494785469307;5616.5787565932615;5631.324241091075;5651.2370829937945;5039.168537191359;5054.469280725517;5061.772220250097;5132.101882170624;5151.278820965068;4999.550040496355;5000.699958002513;5112;5131.897362052775;5146.459621739719;5021.874453138683;5032.723200223986;5071.137906555876;5085.084684756743;5132.332796736419;5155.561777248939;5164.8708782280555;5223.13818219997;5225.817096401645;5246.947530524722;4715.976420117911;5084.644074914758;5090.363704536933;5161.7161056141895;5176.327077479941;5298.523132918017;5357.357117145929;5440.401555828856;5462.808801691922;5544.306961629796;5887.411258874121;5887.5584331174905;5915.526757859361;5983.91024134634;6008.729607167645;6041.426064523863;6043.305019922721;6047.455728984369;6057.030875059969;6072.332043475214;5433.1850222466555;5483.287172667608;5556.833295001156;5631.943680563224;5634.549236061105;6123.755049797958;6158.753649854045;6164.568480206342;6177.135201071854;6191.876162476815;5940.732667029994;5951.047832346891;5965.463108320272;5972.701364931736;5973.701314934323;5760.53915686744;5854.151148083504;5928.170056192136;5943.10853371989;6002.039673652194;5973.79091731796;5997.370276121032;6005.909911351333;6043.3050199227655;6055.636661800306;5979.073243647242;6023.66869822164;6041;6043.637381757108;6046.244219472566;4453.866384008485;4486.75322857246;4490.101979604092;4577.542245775396;4638.420197475316;4126.938095928564;4140.68944829139;4154.875353739392;4183.91632167355;4208.537060923296;5675.829725108253;5721.914171287434;5740.712964351766;5741.5119714824705;5754.971225143848;5833;5908.291005079332;6045.486133678599;6046.576739628272;6059.303180134253;5540.030494663418;5618.381977982419;5620.353659329229;5654.264945557134;5688.146777983336;5161.587073034223;5161.66449180802;5163.0190263849745;5166.509181627739;5196.636235463481;5936.8812623748145;6131.325554189036;6158.753649854045;6196.0705894116245;6202.658853763086;5783.450572195635;5788.334341550775;5855.2973643163095;5860.589758716849;5937.168796368425;6047.455728984237;6057.242844644419;6062.272527296753;6068.78759243442;6071.574989750675;5798.188253644577;5817.9127313091185;5819.738111784895;5844.47399734009;5850.297964244318;5834.824955251349;5863.648181109147;5883;5896.587238893237;5898.793542226002;5790.276215473066;5830.970845145747;5833.154192642128;5842.941570584239;5854.795082172103;5911.231539899785;5935.792247271324;5938.287405511366;5944.9405505946115;5946.07835785454;5662.377138514842;5680.11958146488;5761.798337058183;5816;5889.617174883619;5884.235049443545;5908.084246941731;5925.259342582177;5938.584299099194;5958.970205148947;5580.525655319343;5759.740811663569;5785.6817875015595;5789.102689083199;5796.913046304393 20:22:55 INFO - PROCESS | 18097 | |1;ext.html;571.894199573079;574.9741261643226;586.0769288370815;607.307669257047;629.5718911140424;33676.83161584195;46084.308735368955;46987.530124698744;47078.293825592555;47149.999999999956;47344.10623575053;47433.52566474334;47816.28275575869;47897.7605111974;48005.27992080113;8257.42198046137;8464.449810762311;8859.601317940693;9085.091490850928;9085.727428177132;10574.154067674568;10876.129909607253;10895.237333386665;11141.164412669043;11155.832662510069;10939.45302734864;11017.669469915916;11018.11855051594;11020.283681560673;11028.062614677761;10877.510512026938;10910.345379277269;10937.4531273436;10946.835797463005;10947.124230061616;10801.297915635458;10805.729856753565;10841.67474975752;10863.67408977732;10868.45657717119;44318.77840610808;44763.328550071776;44789.776051119865;44818.32772508415;44833;3768.698504119664;3795.1460921292764;3825.1202223488476;3889.4749208857006;3946.3883098119836;31907;33918;33945.83027084873;34048.82975585131;34184;4568.954310456919;4653.674242803005;4664.813407463697;4676.532346765331;4702.294655801623;388165;395325;397230;397988.9999999971;398154;67921.58509696854;68992.3100768996;69071;69075.65462172657;69120.6543967277;40937.18125637471;42385.78807105945;42462.78768606137;71637.2836271641;72274.2772572278;15400;15508.767368489482;15515.069095854285;15529.534113976599;15577.376904923904;10485.580576776843;10568.947155264175;11948.940255298668;11980.700482488008;12174.208676436003;22078.33764987053;22091.779082209294;22262.888685556467;22313;22340.441488962904;7898.565578893216;7991.72028978983;8134.959325203336;8135.471194372347;8371.665133394596;1097.2648325621853;1101.542859713226;1120.2214460949724;1189.3161432176532;1193.093249130667;32745.345093098003;33510.49734253988;34261.65738342635;34296.82851585726;34489.482657760156;1102.6030628973724;1104.2270410712372;1118.703543560957;1185.7035741064733;1205.8794120588047;16672.916635416746;17517.649647006987;17526.561835953948;17545.56136096608;17654;567110;569006;569060;569248;572548;63538.68230658909;64114.6794266035;64358.356416435236;64409.03386449207;64442;1291.3994992328423;1306.4708792938875;1395.6092294157652;1403.5578792680274;1449.7462943984972;32637;34512.82743586266;34781.826090869385;34834;35040.12399690028;53744.193837093255;54250.186247207115;54369.72815135899;54423.367298981095;54558;406303;409226;410556;410586;410751;31020.22449438782;31431.685683142874;33356.666433335355;33374.833125834215;33465.49801753024;50955;51109;51174.23238651349;51255.2311715332;51565.19521816869;41912.58087419087;42499;42895;43774.34338484862;43992.56007439885;43662;44311.33532996943;44808.551914480435;45497.545024549334;45583.77208113938;42726.57273427226;43020.56979430166;44435;44863.55136448594;44873;36044.81977590095;38237.235255295294;38444.61555384522;39094.2181156381;39356.606433935296;28906.855465722536;29037.419251615273;29061;29114.70885291205;29234.122976310744 20:22:55 INFO - PROCESS | 18097 | |2;jquery.html;400.5393797133298;414.33706070287525;426.58194968930445;426.8036703116566;451.9118771839493;14961.700765984673;18199.636007279845;18657.4402767917;19565.510862228417;19806.504837379074;19047.52381190471;20164.77128129384;20216.292429764962;20520.589588208266;20670;5748.770049198038;6016.368281330463;6032.819015429544;6039.909401358983;6040.909386359208;5658.151277308396;5946.554008449362;5981.0729336952845;5983.431574000463;5989.760409583611;5783.537317014629;5956.672383018932;5956.821295361125;5961.344252132262;5961.403859614047;5856.47291743743;5879.735411906475;5882.911756323637;5910.734016969203;5928.762849485994;5269.762860671279;5269.841904742864;5333.120035194188;5336.973315133399;5339.41266460689;23962.880185599133;23999.64000539993;24142.275731728078;24209.87895060531;24273.514529709308;2329.650552417134;2395.0419832067137;2435.281591930367;3079.9230019249476;3178.4278829810623;10832.483452316683;10867.347959122399;10975.890241097566;11050.723731906686;11390.25963312382;1957.6198779860165;1993.5016245938516;2006.9582504970178;2014.2345908554655;2041.2853203309292;84814.57592712059;85740.57129714312;87547.12452875453;88182.55908720479;90115;10122.493875306205;10922.508487118099;11094.55621775136;11128.554857805597;11293.830592541119;14513.274336283144;14740.484083057041;15409.229538523028;15415.61460963485;15807.209639517978;7498.175200727916;7849.960750196213;7925.365970722443;7935.523868567904;8030.277275045274;7549;7700.730474433368;7716.035495563055;7812.453128280966;7835.960820195976;4694.460137084211;4715.363425937523;4725.432948046187;4816.229403295456;4934.506549345108;1930.5270208798654;2013.7409379162964;2037.276766747783;2047.8566500344832;2077.968830467544;891.362675686887;988.8912219655832;1024.109025148126;1053.5206481051102;1083.4041277297613;19480;19788.70316945247;20202.595948080954;20262.290819821235;20384.28654997068;973.5278389980854;976.067855198284;985.8718366612438;1003.844404117363;1026.3790406803926;9242.491662958468;10904.836427453594;11088.061663659137;11127.721806954729;11206.103511719206;455666;456650;457002;459268;459367;61579.69210153921;63675;93385.5330723342;96212.03787962171;98142;1032.339302846179;1041.6406339812904;1057.645688694296;1076.5586109694987;1080.9730755782039;17562.82437175612;17712.734308985633;17956.191971361583;18175.727364089285;18550.44348669542;42458;42658.78670606627;42761.35857962071;42807.14385712331;42987.78506107449;55320;61207.69396153169;62741.05888411586;62909.68545157245;63396.04905926323;7840.490368126054;8311.875321870297;8698.652053917773;9077.546122693971;9224.631014759603;13832.792508112587;14020.158790472604;14199.64500887486;14256.643583910485;14325.355359008661;11627.825582616437;11868.465919033491;11995.940020299842;12020.03839692805;12246.693832654255;11904.345261010727;11981.801819817949;12053.035757139583;12196.329201893981;12462.501499940263;11641.767164656829;11673.533058677558;12006.39968001579;12082.939585302018;12099.57651482194;8238.546879921661;8264.669413223404;8499.95750021246;8537.274331681876;8583.35624828128;11950.641480755592;12110.939445302716;12163.331016794162;12318.81521777192;12378.133530652767 20:22:55 INFO - PROCESS | 18097 | |3;mootools.html;1341.3494455189225;1454.9781753273703;1501.1443477217983;1633.5834362237629;1813.0300289345196;7591.127020392656;8186.099529051799;8425.07324194338;8435.32517398609;8652;8594.785130371743;8644.092370301121;8658.437201581908;8660.523671198098;8674.95662521688;2464.0513402340093;2492.5762620354585;2493.0775613023116;2496;2498.7376325485743;2420.225527831086;2498.2005758157306;2500.0124950644486;2503.4242124311418;2503.5243303772227;2435.975640243593;2486.813488988324;2516.660250866137;2516.7105782834933;2519.3197836584113;2430.222328854767;2432.3067925641285;2469.5431345201105;2478.3556275368355;2481.987590062038;2431.2463136427764;2454.1655837015323;2475.8638274894874;2477;2482.8758562071826;8363.289120424772;8465.32277417805;8526.74419767408;8543.273821725099;8574.099719529484;5338.973305133488;5530.446955304477;5544.306961629796;5544.390117087117;5547.33431988164;3416.5558477398026;3492.8777492787885;3579.2125732338845;3662.432322989941;3664.780113193217;1111.6053800900725;1135.9545618175264;1142.6457798082622;1161.1117495116243;1179.0685358566807;11893.464794084288;11924.821127683092;11958.40207989597;12014.339211343373;12023.93988030063;4440.267355886307;4591.012932219522;4693.624510039189;4698.906021879543;4710.29345598163;9387.436753794795;9403.247740180768;9445.811083778286;9482.146606805421;9484.90515094854;5371.892562148735;5375.032494151091;5375.946240537544;5378.381486129067;5379.408265090837;4233.5131459882505;4407.6914615976575;4519.435070616173;4525.954740452619;4927.088488629615;3914.236723838824;3931.9213615727526;4073.9796301018305;4076.0828813517314;4087.97956010224;1257.044646068994;1260.40985774233;1268.3658170914543;1276.6808297925518;1289.065427565008;866.7529754020075;956.1299217711988;965.5027660754716;977.3500622086233;982.3172894838019;5673.319511403109;5758.395368486333;5810.21562089121;5953.047512398082;6124.265088189357;476.3355119608127;481.41748484334346;488.09702051205693;498.9600831933437;506.88848453340205;4020.8994775130273;4066.573009833984;4087.1621317629815;4093.85671501496;4096.610821971908;10365.481725913674;10827.729306767236;10937.4531273436;10942.398168100832;11054.060404865677;10947.671569852917;10964.17768667353;10964.945175274073;10968.561257549609;10995.230333876712;7707.421943354271;7837.412194085467;7882.881756773653;7951.602419878983;7967.482113662593;5901.380355062828;5935.732892019783;5953.613015154001;6073.392660734068;6098.993666045053;10030.699079027641;10035.69892903214;10056.798864022825;10085.193184545366;10136.645217417356;8964.641414343354;8981.685641002534;10053;10203.540840662039;10362.430066346424;7122.5726456412785;7679.19368466303;7741.651625676971;7798.454108212371;7942.285194332538;8492.830143396974;8505.532195729294;8552.059273479788;8553.95723021381;8562.229399354088;7548.282913123245;7612.200718924433;7682.923170768221;7733.535987840747;7769.572673503011;7501.062367204099;7554.093508778982;7603.581803000888;7753.379729621504;7805.33654639362;6760.729570817309;6866.690998904961;6876.793696189123;6878.209005964378;6881.483888708267;5164.7934082636275;5253.343332083489;5254.238135470259;5254.710990895537;5446.1558458439;5107.336046313955;5121.74391280442;5145.305383773292;5171.456997015259;5186.351706036746 20:22:55 INFO - PROCESS | 18097 | |4;prototype.html;333.3666034534384;333.8480991149024;333.87646570768817;340.94374428219345;348.5242643791224;5246.7901283948595;5373.194020896867;5452.500562345357;5476.698781567012;5486.177073438987;5206.661566998143;5293.497117773815;5357;5405.621606487547;5418.647787893784;4231.407602935591;4232.470941132358;4258.552851950547;4274.957250427503;4290.4422425084695;4172.582741725818;4230.238557059728;4238.618524332809;4243.448351714273;4276.615104640582;4203.97898010511;4213.178430206111;4223.458437670259;4230.280852255109;4232.619064284214;4168.562300958416;4176.916461670765;4197.7271477354025;4207.158568286355;4212.220739163234;3764.416515440111;3773.4339849022867;3774.471573979645;3778.8663400979594;3807.895710244026;5078.365204349457;5291.656042357235;5297.867553311198;5309.946900530984;5329.747509335303;4797.712137271775;4809.254565542346;4822.553234029777;4833.782479788418;4839.201531747258;5365.049222927374;5669.0079236133515;5681.687507187103;5687.175359572881;5689.772409103631;4022.6982976276895;4042.70633397313;4043.7573745575064;4054.189162167578;4055.9188816223805;5809.883802323972;5882.382349853289;5883.823485295448;5895.496648354685;5913.822585322448;4066.552679205285;4173.373993900939;4175.457190565267;4183.3515805050265;4184.958150418518;4165.875023749292;4173.686973477002;4186.225548273579;4203.831846726097;4216.536181020086;4727.810887564528;4776.164171270014;4784.545468180518;4787.40157480315;4788.377510923558;5523.972380138073;5679.545636349082;5685.971570142206;5689.151025916593;5694.259746232963;1403.4245959156697;1413.5900588829124;1426.8501807310083;1427.8857691384871;1431.7709166533305;918.903515130915;953.9952300238455;964.3779762053576;971.5482300730054;984.4536282363214;5271.917592550997;5302.522772950453;5305.708186049805;5366.382865970385;5368.194770784336;5624.606277560531;5629.634073785191;5635.6048679311125;5654.116400635706;5659.349174844946;5088.77100530477;5270.393904700932;5324.949894290726;5332.213708407727;5349.652272602269;2963.9110826675233;2966.3325751705693;2969.6042859855834;2978.7468065214266;2986.999355216027;5774.855628609234;5818.738156782955;5823.777006828614;5835.387284335168;5851.824445266649;5431.321084864392;5651.463111004448;5671.943280567224;5676.659400435987;5695.7152142392715;5757.942420575824;5793.942060579425;5805.970970145122;5812.314428815596;5865.941340586625;5339.654481301362;5473.726313684379;5501.614886957875;5550.278463799842;5570;5536.169574563848;5536.972315138399;5547.694876781816;5570.192322113352;5573.804916827891;5700.287464066992;5802.709864506842;5829.183914251923;5833.329167145833;5840.853978650568;3985.880423587297;4016.216837716617;4106.445629840053;4145.0880806222585;4149;5801.012478573453;5822.359540450631;5839.270091238595;5845.736941837543;5856.472917437451;5648.689322087324;5719.48524632785;5770.9711451444155;5783.306003279633;5808.680522571299;5656.773729050957;5668.886622267449;5673.3759286477625;5688.203651488878;5707.743151558107;5642.520385767091;5653.773849045992;5673.8865222694485;5688.40271771458;5734.648793994442;5509.917351239815;5651.350094739158;5686.630369026;5746.224259724883;5798.797042103506;5572.414896435978;5572.888542229214;5586.245856809279;5591.524720398812;5598 20:22:55 INFO - PROCESS | 18097 | |5;yui.html;799.5402643479997;819.1439945257206;820.5856042698437;831.1273163178661;856.6659002988836;13758;15940.840591594095;16356.672866542662;16461.506154815346;16511.339546418145;14997.10017398957;15122.924385378057;15326.540203793904;15905.125218112998;16093.356265749386;710.5381502023674;836.2515548584014;838.4885220015816;839.5214727605268;840.5125027484045;717.6160753996613;828.2669837194067;847.3898792869155;851.3784936995966;851.7402192331336;892.5225004622529;892.9776755581097;894.5795476126243;895.1674942303655;895.1898531828673;735.8785800342937;882.9646814127427;888.9822203555925;889.4485419040171;889.524104604037;544.0913674164156;627.4384425938805;643.5334382572597;644.7807745366551;647.1166857239881;14325;14362.856371436257;14903.478378256817;14912.254387280593;14917.850821491755;14154;14429.85570144306;14507.202103884281;14529.200893950829;14610.342534585969;13150.934245328808;13239;13250.403731832092;13293.468261269634;13549.661258468519;4604.6776725629215;4615.838445654386;4618.861434156981;4651.534846515356;4804.0872234275375;64487.67756161236;65643.71781410958;66171.66914165398;67116.66441667809;67749.3225067753;11753.823692644617;11851.525938962517;11853.525858965544;11945.940270298594;11961.581344652895;21457.356279311647;21493.247736329155;21640.91795410223;21772.782272177075;22141;8297.626606802709;8411.242988131098;8473.915260847436;8485.703000394957;8615.267702245379;4421.977890110593;4437.600615944516;4441.178381999341;4461.286194208976;4604.58558729716;3484.8083355415188;3584.2652256287397;3586.605473397924;3599.8200089995394;3644.8359823807464;694.2328726756962;695.2282965907838;697.8081027717418;700.8002719224996;723.7828651404662;658.6048370977471;710.8222944263935;731.0861423220974;762.6682393158993;778.9766307010799;9425.622975081056;9443.433393996382;9616.807663846825;10052.899471005196;10431.16550675944;722.7795522365624;748.9775306740806;749.8537785131847;758.4463341760546;775.968961241544;4547.15877562652;4946.455889852114;4949.554540091337;4976.502349765067;4983.90032199354;74551.62724186345;75263.62368188234;78690;93236;95252.52373738086;62809.37190628127;71617.64191179114;72188.63905680439;73751.63124184452;73784;66306.33693663002;66408;67702.66148669225;69810.3018969814;70988.64505677542;9656.622562535944;10246.53890574911;10405.323653962469;10469.476526173814;10569.63006294776;45142;45878.770606146754;46562.53437465582;47553.524464756294;47884.521154788;42287.365689515296;43302.78348608237;60864;61415;63458.68270658617;12256.87743122593;12444.626661200178;12502.749945001231;13213.207207567577;13456.730865382833;14287.357068932131;14332.211728355041;14982.925085374503;15016.249187540798;15581.766273506133;14043.719125617636;14144;14362.928185359006;14647.267636617913;14794;13691.520796772065;14012.159270443806;14074.859251407355;14108.929455353069;14338.481197152569;12524.311162886128;12610.558630447891;12790.168639038433;13632.182069075887;14201.360938757987;10659.413732244491;10682.73293167677;10929.83605245906;11870.821937671115;11999.880001199876;11866.169368144492;11894.821577676516;12107.81838272409;12197.390130493617;12308.630741077783 20:22:55 INFO - PROCESS | 18097 | __end_tp_report 20:22:55 INFO - PROCESS | 18097 | __start_cc_report 20:22:55 INFO - PROCESS | 18097 | _x_x_mozilla_cycle_collect,1023 20:22:55 INFO - PROCESS | 18097 | __end_cc_report 20:22:55 INFO - PROCESS | 18097 | __startTimestamp1479961375853__endTimestamp 20:22:55 INFO - PROCESS | 18097 | 20:22:55 INFO - PROCESS | 18097 | ------- Summary: start ------- 20:22:55 INFO - PROCESS | 18097 | Number of tests: 6 20:22:55 INFO - PROCESS | 18097 | 20:22:55 INFO - PROCESS | 18097 | [#0] dojo.html Cycles:165 Average:5544.44 Median:5785.68 stddev:620.79 (10.7%) stddev-sans-first:595.18 20:22:55 INFO - PROCESS | 18097 | Values: 3214.5 3226.5 3243.3 3261.6 3281.2 5433.9 5484.2 5492.1 5500.8 5509.4 5558.2 5613.5 5616.6 5631.3 5651.2 5039.2 5054.5 5061.8 5132.1 5151.3 4999.6 5000.7 5112.0 5131.9 5146.5 5021.9 5032.7 5071.1 5085.1 5132.3 5155.6 5164.9 5223.1 5225.8 5246.9 4716.0 5084.6 5090.4 5161.7 5176.3 5298.5 5357.4 5440.4 5462.8 5544.3 5887.4 5887.6 5915.5 5983.9 6008.7 6041.4 6043.3 6047.5 6057.0 6072.3 5433.2 5483.3 5556.8 5631.9 5634.5 6123.8 6158.8 6164.6 6177.1 6191.9 5940.7 5951.0 5965.5 5972.7 5973.7 5760.5 5854.2 5928.2 5943.1 6002.0 5973.8 5997.4 6005.9 6043.3 6055.6 5979.1 6023.7 6041.0 6043.6 6046.2 4453.9 4486.8 4490.1 4577.5 4638.4 4126.9 4140.7 4154.9 4183.9 4208.5 5675.8 5721.9 5740.7 5741.5 5755.0 5833.0 5908.3 6045.5 6046.6 6059.3 5540.0 5618.4 5620.4 5654.3 5688.1 5161.6 5161.7 5163.0 5166.5 5196.6 5936.9 6131.3 6158.8 6196.1 6202.7 5783.5 5788.3 5855.3 5860.6 5937.2 6047.5 6057.2 6062.3 6068.8 6071.6 5798.2 5817.9 5819.7 5844.5 5850.3 5834.8 5863.6 5883.0 5896.6 5898.8 5790.3 5831.0 5833.2 5842.9 5854.8 5911.2 5935.8 5938.3 5944.9 5946.1 5662.4 5680.1 5761.8 5816.0 5889.6 5884.2 5908.1 5925.3 5938.6 5959.0 5580.5 5759.7 5785.7 5789.1 5796.9 20:22:55 INFO - PROCESS | 18097 | 20:22:55 INFO - PROCESS | 18097 | [#1] ext.html Cycles:180 Average:63237.32 Median:21651.50 stddev:123101.92 (568.6%) stddev-sans-first:123357.34 20:22:55 INFO - PROCESS | 18097 | Values: 571.9 575.0 586.1 607.3 629.6 33676.8 46084.3 46987.5 47078.3 47150.0 47344.1 47433.5 47816.3 47897.8 48005.3 8257.4 8464.4 8859.6 9085.1 9085.7 10574.2 10876.1 10895.2 11141.2 11155.8 10939.5 11017.7 11018.1 11020.3 11028.1 10877.5 10910.3 10937.5 10946.8 10947.1 10801.3 10805.7 10841.7 10863.7 10868.5 44318.8 44763.3 44789.8 44818.3 44833.0 3768.7 3795.1 3825.1 3889.5 3946.4 31907.0 33918.0 33945.8 34048.8 34184.0 4569.0 4653.7 4664.8 4676.5 4702.3 388165.0 395325.0 397230.0 397989.0 398154.0 67921.6 68992.3 69071.0 69075.7 69120.7 40937.2 42385.8 42462.8 71637.3 72274.3 15400.0 15508.8 15515.1 15529.5 15577.4 10485.6 10568.9 11948.9 11980.7 12174.2 22078.3 22091.8 22262.9 22313.0 22340.4 7898.6 7991.7 8135.0 8135.5 8371.7 1097.3 1101.5 1120.2 1189.3 1193.1 32745.3 33510.5 34261.7 34296.8 34489.5 1102.6 1104.2 1118.7 1185.7 1205.9 16672.9 17517.6 17526.6 17545.6 17654.0 567110.0 569006.0 569060.0 569248.0 572548.0 63538.7 64114.7 64358.4 64409.0 64442.0 1291.4 1306.5 1395.6 1403.6 1449.7 32637.0 34512.8 34781.8 34834.0 35040.1 53744.2 54250.2 54369.7 54423.4 54558.0 406303.0 409226.0 410556.0 410586.0 410751.0 31020.2 31431.7 33356.7 33374.8 33465.5 50955.0 51109.0 51174.2 51255.2 51565.2 41912.6 42499.0 42895.0 43774.3 43992.6 43662.0 44311.3 44808.6 45497.5 45583.8 42726.6 43020.6 44435.0 44863.6 44873.0 36044.8 38237.2 38444.6 39094.2 39356.6 28906.9 29037.4 29061.0 29114.7 29234.1 20:22:55 INFO - PROCESS | 18097 | 20:22:55 INFO - PROCESS | 18097 | [#2] jquery.html Cycles:180 Average:28292.54 Median:13354.40 stddev:75625.56 (566.3%) stddev-sans-first:75808.71 20:22:55 INFO - PROCESS | 18097 | Values: 400.5 414.3 426.6 426.8 451.9 14961.7 18199.6 18657.4 19565.5 19806.5 19047.5 20164.8 20216.3 20520.6 20670.0 5748.8 6016.4 6032.8 6039.9 6040.9 5658.2 5946.6 5981.1 5983.4 5989.8 5783.5 5956.7 5956.8 5961.3 5961.4 5856.5 5879.7 5882.9 5910.7 5928.8 5269.8 5269.8 5333.1 5337.0 5339.4 23962.9 23999.6 24142.3 24209.9 24273.5 2329.7 2395.0 2435.3 3079.9 3178.4 10832.5 10867.3 10975.9 11050.7 11390.3 1957.6 1993.5 2007.0 2014.2 2041.3 84814.6 85740.6 87547.1 88182.6 90115.0 10122.5 10922.5 11094.6 11128.6 11293.8 14513.3 14740.5 15409.2 15415.6 15807.2 7498.2 7850.0 7925.4 7935.5 8030.3 7549.0 7700.7 7716.0 7812.5 7836.0 4694.5 4715.4 4725.4 4816.2 4934.5 1930.5 2013.7 2037.3 2047.9 2078.0 891.4 988.9 1024.1 1053.5 1083.4 19480.0 19788.7 20202.6 20262.3 20384.3 973.5 976.1 985.9 1003.8 1026.4 9242.5 10904.8 11088.1 11127.7 11206.1 455666.0 456650.0 457002.0 459268.0 459367.0 61579.7 63675.0 93385.5 96212.0 98142.0 1032.3 1041.6 1057.6 1076.6 1081.0 17562.8 17712.7 17956.2 18175.7 18550.4 42458.0 42658.8 42761.4 42807.1 42987.8 55320.0 61207.7 62741.1 62909.7 63396.0 7840.5 8311.9 8698.7 9077.5 9224.6 13832.8 14020.2 14199.6 14256.6 14325.4 11627.8 11868.5 11995.9 12020.0 12246.7 11904.3 11981.8 12053.0 12196.3 12462.5 11641.8 11673.5 12006.4 12082.9 12099.6 8238.5 8264.7 8500.0 8537.3 8583.4 11950.6 12110.9 12163.3 12318.8 12378.1 20:22:55 INFO - PROCESS | 18097 | 20:22:55 INFO - PROCESS | 18097 | [#3] mootools.html Cycles:180 Average:5732.16 Median:2713.02 stddev:3190.19 (117.6%) stddev-sans-first:3182.07 20:22:55 INFO - PROCESS | 18097 | Values: 1341.3 1455.0 1501.1 1633.6 1813.0 7591.1 8186.1 8425.1 8435.3 8652.0 8594.8 8644.1 8658.4 8660.5 8675.0 2464.1 2492.6 2493.1 2496.0 2498.7 2420.2 2498.2 2500.0 2503.4 2503.5 2436.0 2486.8 2516.7 2516.7 2519.3 2430.2 2432.3 2469.5 2478.4 2482.0 2431.2 2454.2 2475.9 2477.0 2482.9 8363.3 8465.3 8526.7 8543.3 8574.1 5339.0 5530.4 5544.3 5544.4 5547.3 3416.6 3492.9 3579.2 3662.4 3664.8 1111.6 1136.0 1142.6 1161.1 1179.1 11893.5 11924.8 11958.4 12014.3 12023.9 4440.3 4591.0 4693.6 4698.9 4710.3 9387.4 9403.2 9445.8 9482.1 9484.9 5371.9 5375.0 5375.9 5378.4 5379.4 4233.5 4407.7 4519.4 4526.0 4927.1 3914.2 3931.9 4074.0 4076.1 4088.0 1257.0 1260.4 1268.4 1276.7 1289.1 866.8 956.1 965.5 977.4 982.3 5673.3 5758.4 5810.2 5953.0 6124.3 476.3 481.4 488.1 499.0 506.9 4020.9 4066.6 4087.2 4093.9 4096.6 10365.5 10827.7 10937.5 10942.4 11054.1 10947.7 10964.2 10964.9 10968.6 10995.2 7707.4 7837.4 7882.9 7951.6 7967.5 5901.4 5935.7 5953.6 6073.4 6099.0 10030.7 10035.7 10056.8 10085.2 10136.6 8964.6 8981.7 10053.0 10203.5 10362.4 7122.6 7679.2 7741.7 7798.5 7942.3 8492.8 8505.5 8552.1 8554.0 8562.2 7548.3 7612.2 7682.9 7733.5 7769.6 7501.1 7554.1 7603.6 7753.4 7805.3 6760.7 6866.7 6876.8 6878.2 6881.5 5164.8 5253.3 5254.2 5254.7 5446.2 5107.3 5121.7 5145.3 5171.5 5186.4 20:22:55 INFO - PROCESS | 18097 | 20:22:55 INFO - PROCESS | 18097 | [#4] prototype.html Cycles:180 Average:4725.65 Median:5370.69 stddev:1376.89 (25.6%) stddev-sans-first:1340.71 20:22:55 INFO - PROCESS | 18097 | Values: 333.4 333.8 333.9 340.9 348.5 5246.8 5373.2 5452.5 5476.7 5486.2 5206.7 5293.5 5357.0 5405.6 5418.6 4231.4 4232.5 4258.6 4275.0 4290.4 4172.6 4230.2 4238.6 4243.4 4276.6 4204.0 4213.2 4223.5 4230.3 4232.6 4168.6 4176.9 4197.7 4207.2 4212.2 3764.4 3773.4 3774.5 3778.9 3807.9 5078.4 5291.7 5297.9 5309.9 5329.7 4797.7 4809.3 4822.6 4833.8 4839.2 5365.0 5669.0 5681.7 5687.2 5689.8 4022.7 4042.7 4043.8 4054.2 4055.9 5809.9 5882.4 5883.8 5895.5 5913.8 4066.6 4173.4 4175.5 4183.4 4185.0 4165.9 4173.7 4186.2 4203.8 4216.5 4727.8 4776.2 4784.5 4787.4 4788.4 5524.0 5679.5 5686.0 5689.2 5694.3 1403.4 1413.6 1426.9 1427.9 1431.8 918.9 954.0 964.4 971.5 984.5 5271.9 5302.5 5305.7 5366.4 5368.2 5624.6 5629.6 5635.6 5654.1 5659.3 5088.8 5270.4 5324.9 5332.2 5349.7 2963.9 2966.3 2969.6 2978.7 2987.0 5774.9 5818.7 5823.8 5835.4 5851.8 5431.3 5651.5 5671.9 5676.7 5695.7 5757.9 5793.9 5806.0 5812.3 5865.9 5339.7 5473.7 5501.6 5550.3 5570.0 5536.2 5537.0 5547.7 5570.2 5573.8 5700.3 5802.7 5829.2 5833.3 5840.9 3985.9 4016.2 4106.4 4145.1 4149.0 5801.0 5822.4 5839.3 5845.7 5856.5 5648.7 5719.5 5771.0 5783.3 5808.7 5656.8 5668.9 5673.4 5688.2 5707.7 5642.5 5653.8 5673.9 5688.4 5734.6 5509.9 5651.4 5686.6 5746.2 5798.8 5572.4 5572.9 5586.2 5591.5 5598.0 20:22:55 INFO - PROCESS | 18097 | 20:22:55 INFO - PROCESS | 18097 | [#5] yui.html Cycles:180 Average:17847.55 Median:4604.63 stddev:22518.35 (489.0%) stddev-sans-first:22545.13 20:22:55 INFO - PROCESS | 18097 | Values: 799.5 819.1 820.6 831.1 856.7 13758.0 15940.8 16356.7 16461.5 16511.3 14997.1 15122.9 15326.5 15905.1 16093.4 710.5 836.3 838.5 839.5 840.5 717.6 828.3 847.4 851.4 851.7 892.5 893.0 894.6 895.2 895.2 735.9 883.0 889.0 889.4 889.5 544.1 627.4 643.5 644.8 647.1 14325.0 14362.9 14903.5 14912.3 14917.9 14154.0 14429.9 14507.2 14529.2 14610.3 13150.9 13239.0 13250.4 13293.5 13549.7 4604.7 4615.8 4618.9 4651.5 4804.1 64487.7 65643.7 66171.7 67116.7 67749.3 11753.8 11851.5 11853.5 11945.9 11961.6 21457.4 21493.2 21640.9 21772.8 22141.0 8297.6 8411.2 8473.9 8485.7 8615.3 4422.0 4437.6 4441.2 4461.3 4604.6 3484.8 3584.3 3586.6 3599.8 3644.8 694.2 695.2 697.8 700.8 723.8 658.6 710.8 731.1 762.7 779.0 9425.6 9443.4 9616.8 10052.9 10431.2 722.8 749.0 749.9 758.4 776.0 4547.2 4946.5 4949.6 4976.5 4983.9 74551.6 75263.6 78690.0 93236.0 95252.5 62809.4 71617.6 72188.6 73751.6 73784.0 66306.3 66408.0 67702.7 69810.3 70988.6 9656.6 10246.5 10405.3 10469.5 10569.6 45142.0 45878.8 46562.5 47553.5 47884.5 42287.4 43302.8 60864.0 61415.0 63458.7 12256.9 12444.6 12502.7 13213.2 13456.7 14287.4 14332.2 14982.9 15016.2 15581.8 14043.7 14144.0 14362.9 14647.3 14794.0 13691.5 14012.2 14074.9 14108.9 14338.5 12524.3 12610.6 12790.2 13632.2 14201.4 10659.4 10682.7 10929.8 11870.8 11999.9 11866.2 11894.8 12107.8 12197.4 12308.6 20:22:55 INFO - PROCESS | 18097 | -------- Summary: end -------- 20:22:55 INFO - PROCESS | 18097 | 20:22:56 INFO - TEST-INFO | 18097: exit 0 20:22:56 INFO - TEST-OK | dromaeo_css | took 1115645ms 20:22:56 INFO - TEST-START | kraken 20:22:56 INFO - operating with platform_type : linux_ 20:22:56 INFO - Initialising browser for kraken test... 20:22:56 INFO - TEST-INFO | started process 18413 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkVgeH8/profile http://localhost:39340/getInfo.html) 20:22:59 ERROR - PROCESS | 18413 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5373: TypeError: parent.firstChild is null 20:23:00 INFO - PROCESS | 18413 | __metrics Screen width/height:1600/1200 20:23:00 INFO - PROCESS | 18413 | colorDepth:24 20:23:00 INFO - PROCESS | 18413 | Browser inner width/height: 1024/697 20:23:00 INFO - PROCESS | 18413 | __metrics 20:23:01 INFO - PROCESS | 18413 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:23:01 INFO - PROCESS | 18413 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:23:02 INFO - PROCESS | 18413 | console.error: PushService: 20:23:02 INFO - PROCESS | 18413 | stateChangeProcessEnqueue: Error transitioning state 20:23:02 INFO - PROCESS | 18413 | UnknownError 20:23:02 INFO - TEST-INFO | 18413: exit 0 20:23:02 INFO - Browser initialized. 20:23:02 INFO - Running cycle 1/1 for kraken test... 20:23:02 INFO - TEST-INFO | started process 18509 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkVgeH8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:23:14 INFO - PROCESS | 18509 | RSS: Main: 148320256 20:23:14 INFO - PROCESS | 18509 | 20:23:16 INFO - PROCESS | 18509 | Cycle 1(1): loaded http://localhost:39340/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39340/tests/kraken/driver.html?testName=audio-beat-detection) 20:23:17 INFO - PROCESS | 18509 | RSS: Main: 189911040 20:23:17 INFO - PROCESS | 18509 | 20:23:20 INFO - PROCESS | 18509 | Cycle 1(1): loaded http://localhost:39340/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39340/tests/kraken/driver.html?testName=audio-dft) 20:23:20 INFO - PROCESS | 18509 | RSS: Main: 179077120 20:23:20 INFO - PROCESS | 18509 | 20:23:23 INFO - PROCESS | 18509 | Cycle 1(1): loaded http://localhost:39340/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39340/tests/kraken/driver.html?testName=audio-fft) 20:23:24 INFO - PROCESS | 18509 | RSS: Main: 270348288 20:23:24 INFO - PROCESS | 18509 | 20:23:26 INFO - PROCESS | 18509 | Cycle 1(1): loaded http://localhost:39340/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39340/tests/kraken/driver.html?testName=audio-oscillator) 20:23:26 INFO - PROCESS | 18509 | RSS: Main: 177070080 20:23:26 INFO - PROCESS | 18509 | 20:23:29 INFO - PROCESS | 18509 | Cycle 1(1): loaded http://localhost:39340/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39340/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:23:29 INFO - PROCESS | 18509 | RSS: Main: 178892800 20:23:29 INFO - PROCESS | 18509 | 20:23:32 INFO - PROCESS | 18509 | Cycle 1(1): loaded http://localhost:39340/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39340/tests/kraken/driver.html?testName=imaging-darkroom) 20:23:33 INFO - PROCESS | 18509 | RSS: Main: 217997312 20:23:33 INFO - PROCESS | 18509 | 20:23:36 INFO - PROCESS | 18509 | Cycle 1(1): loaded http://localhost:39340/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39340/tests/kraken/driver.html?testName=imaging-desaturate) 20:23:37 INFO - PROCESS | 18509 | RSS: Main: 217219072 20:23:37 INFO - PROCESS | 18509 | 20:23:39 INFO - PROCESS | 18509 | Cycle 1(1): loaded http://localhost:39340/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39340/tests/kraken/driver.html?testName=json-parse-financial) 20:23:40 INFO - PROCESS | 18509 | RSS: Main: 215015424 20:23:40 INFO - PROCESS | 18509 | 20:23:41 INFO - PROCESS | 18509 | Cycle 1(1): loaded http://localhost:39340/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39340/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:23:42 INFO - PROCESS | 18509 | RSS: Main: 176898048 20:23:42 INFO - PROCESS | 18509 | 20:23:44 INFO - PROCESS | 18509 | Cycle 1(1): loaded http://localhost:39340/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39340/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:23:44 INFO - PROCESS | 18509 | RSS: Main: 185028608 20:23:44 INFO - PROCESS | 18509 | 20:23:46 INFO - PROCESS | 18509 | Cycle 1(1): loaded http://localhost:39340/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39340/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:23:47 INFO - PROCESS | 18509 | RSS: Main: 190795776 20:23:47 INFO - PROCESS | 18509 | 20:23:50 INFO - PROCESS | 18509 | Cycle 1(1): loaded http://localhost:39340/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39340/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:23:50 INFO - PROCESS | 18509 | RSS: Main: 199299072 20:23:50 INFO - PROCESS | 18509 | 20:23:53 INFO - PROCESS | 18509 | Cycle 1(1): loaded http://localhost:39340/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39340/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:23:53 INFO - PROCESS | 18509 | RSS: Main: 196775936 20:23:53 INFO - PROCESS | 18509 | 20:23:55 INFO - PROCESS | 18509 | Cycle 1(1): loaded http://localhost:39340/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39340/tests/kraken/driver.html?testName=ai-astar) 20:23:55 INFO - PROCESS | 18509 | RSS: Main: 247816192 20:23:55 INFO - PROCESS | 18509 | 20:23:55 INFO - PROCESS | 18509 | __start_tp_report 20:23:55 INFO - PROCESS | 18509 | _x_x_mozilla_page_load 20:23:55 INFO - PROCESS | 18509 | _x_x_mozilla_page_load_details 20:23:55 INFO - PROCESS | 18509 | |i|pagename|runs| 20:23:55 INFO - PROCESS | 18509 | |0;ai-astar;103;112;113;113;113;112;113;113;113;112 20:23:55 INFO - PROCESS | 18509 | |1;audio-beat-detection;146;120;122;152;123;126;123;120;152;121 20:23:55 INFO - PROCESS | 18509 | |2;audio-dft;160;161;161;161;161;161;160;160;160;161 20:23:55 INFO - PROCESS | 18509 | |3;audio-fft;74;74;75;109;85;76;75;75;104;76 20:23:55 INFO - PROCESS | 18509 | |4;audio-oscillator;82;81;110;82;82;81;98;81;81;115 20:23:55 INFO - PROCESS | 18509 | |5;imaging-gaussian-blur;117;117;117;118;117;116;118;117;117;118 20:23:55 INFO - PROCESS | 18509 | |6;imaging-darkroom;146;146;145;146;146;146;147;147;147;147 20:23:55 INFO - PROCESS | 18509 | |7;imaging-desaturate;85;85;85;85;85;85;85;84;84;85 20:23:55 INFO - PROCESS | 18509 | |8;json-parse-financial;53;49;50;50;51;51;51;50;50;50 20:23:55 INFO - PROCESS | 18509 | |9;json-stringify-tinderbox;58;60;58;59;59;57;58;59;60;59 20:23:55 INFO - PROCESS | 18509 | |10;stanford-crypto-aes;75;76;75;80;77;78;76;76;77;75 20:23:55 INFO - PROCESS | 18509 | |11;stanford-crypto-ccm;153;131;135;128;127;136;144;124;172;130 20:23:55 INFO - PROCESS | 18509 | |12;stanford-crypto-pbkdf2;157;158;158;158;157;158;160;162;159;160 20:23:55 INFO - PROCESS | 18509 | |13;stanford-crypto-sha256-iterative;66;62;62;63;62;61;61;63;61;61 20:23:55 INFO - PROCESS | 18509 | __end_tp_report 20:23:55 INFO - PROCESS | 18509 | __start_cc_report 20:23:55 INFO - PROCESS | 18509 | _x_x_mozilla_cycle_collect,1654 20:23:55 INFO - PROCESS | 18509 | __end_cc_report 20:23:55 INFO - PROCESS | 18509 | __startTimestamp1479961435884__endTimestamp 20:23:55 INFO - PROCESS | 18509 | 20:23:55 INFO - PROCESS | 18509 | ------- Summary: start ------- 20:23:55 INFO - PROCESS | 18509 | Number of tests: 14 20:23:55 INFO - PROCESS | 18509 | 20:23:55 INFO - PROCESS | 18509 | [#0] ai-astar Cycles:10 Average:111.70 Median:113.00 stddev:3.09 (2.7%) stddev-sans-first:0.50 20:23:55 INFO - PROCESS | 18509 | Values: 103.0 112.0 113.0 113.0 113.0 112.0 113.0 113.0 113.0 112.0 20:23:55 INFO - PROCESS | 18509 | 20:23:55 INFO - PROCESS | 18509 | [#1] audio-beat-detection Cycles:10 Average:130.50 Median:124.50 stddev:13.66 (11.0%) stddev-sans-first:13.29 20:23:55 INFO - PROCESS | 18509 | Values: 146.0 120.0 122.0 152.0 123.0 126.0 123.0 120.0 152.0 121.0 20:23:55 INFO - PROCESS | 18509 | 20:23:55 INFO - PROCESS | 18509 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.52 (0.3%) stddev-sans-first:0.50 20:23:55 INFO - PROCESS | 18509 | Values: 160.0 161.0 161.0 161.0 161.0 161.0 160.0 160.0 160.0 161.0 20:23:55 INFO - PROCESS | 18509 | 20:23:55 INFO - PROCESS | 18509 | [#3] audio-fft Cycles:10 Average:82.30 Median:75.00 stddev:13.20 (17.6%) stddev-sans-first:13.65 20:23:55 INFO - PROCESS | 18509 | Values: 74.0 74.0 75.0 109.0 85.0 76.0 75.0 75.0 104.0 76.0 20:23:55 INFO - PROCESS | 18509 | 20:23:55 INFO - PROCESS | 18509 | [#4] audio-oscillator Cycles:10 Average:89.30 Median:81.50 stddev:13.33 (16.4%) stddev-sans-first:13.88 20:23:55 INFO - PROCESS | 18509 | Values: 82.0 81.0 110.0 82.0 82.0 81.0 98.0 81.0 81.0 115.0 20:23:55 INFO - PROCESS | 18509 | 20:23:55 INFO - PROCESS | 18509 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 20:23:55 INFO - PROCESS | 18509 | Values: 117.0 117.0 117.0 118.0 117.0 116.0 118.0 117.0 117.0 118.0 20:23:55 INFO - PROCESS | 18509 | 20:23:55 INFO - PROCESS | 18509 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 20:23:55 INFO - PROCESS | 18509 | Values: 146.0 146.0 145.0 146.0 146.0 146.0 147.0 147.0 147.0 147.0 20:23:55 INFO - PROCESS | 18509 | 20:23:55 INFO - PROCESS | 18509 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 20:23:55 INFO - PROCESS | 18509 | Values: 85.0 85.0 85.0 85.0 85.0 85.0 85.0 84.0 84.0 85.0 20:23:55 INFO - PROCESS | 18509 | 20:23:55 INFO - PROCESS | 18509 | [#8] json-parse-financial Cycles:10 Average:50.50 Median:50.50 stddev:1.08 (2.1%) stddev-sans-first:0.67 20:23:55 INFO - PROCESS | 18509 | Values: 53.0 49.0 50.0 50.0 51.0 51.0 51.0 50.0 50.0 50.0 20:23:55 INFO - PROCESS | 18509 | 20:23:55 INFO - PROCESS | 18509 | [#9] json-stringify-tinderbox Cycles:10 Average:58.70 Median:59.00 stddev:0.95 (1.6%) stddev-sans-first:0.97 20:23:55 INFO - PROCESS | 18509 | Values: 58.0 60.0 58.0 59.0 59.0 57.0 58.0 59.0 60.0 59.0 20:23:55 INFO - PROCESS | 18509 | 20:23:55 INFO - PROCESS | 18509 | [#10] stanford-crypto-aes Cycles:10 Average:76.50 Median:76.50 stddev:1.58 (2.1%) stddev-sans-first:1.58 20:23:55 INFO - PROCESS | 18509 | Values: 75.0 76.0 75.0 80.0 77.0 78.0 76.0 76.0 77.0 75.0 20:23:55 INFO - PROCESS | 18509 | 20:23:55 INFO - PROCESS | 18509 | [#11] stanford-crypto-ccm Cycles:10 Average:138.00 Median:135.50 stddev:14.76 (10.9%) stddev-sans-first:14.62 20:23:55 INFO - PROCESS | 18509 | Values: 153.0 131.0 135.0 128.0 127.0 136.0 144.0 124.0 172.0 130.0 20:23:55 INFO - PROCESS | 18509 | 20:23:55 INFO - PROCESS | 18509 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.70 Median:158.50 stddev:1.57 (1.0%) stddev-sans-first:1.54 20:23:55 INFO - PROCESS | 18509 | Values: 157.0 158.0 158.0 158.0 157.0 158.0 160.0 162.0 159.0 160.0 20:23:55 INFO - PROCESS | 18509 | 20:23:55 INFO - PROCESS | 18509 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:62.00 stddev:1.55 (2.5%) stddev-sans-first:0.83 20:23:55 INFO - PROCESS | 18509 | Values: 66.0 62.0 62.0 63.0 62.0 61.0 61.0 63.0 61.0 61.0 20:23:55 INFO - PROCESS | 18509 | -------- Summary: end -------- 20:23:55 INFO - PROCESS | 18509 | 20:23:56 INFO - TEST-INFO | 18509: exit 0 20:23:56 INFO - TEST-OK | kraken | took 60251ms 20:23:56 INFO - SUITE-END | took 1175s 20:23:57 INFO - Completed test suite (00:19:36) 20:23:57 INFO - javascript benchmark 20:23:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3214.5338925855754, 3226.5321528378386, 3243.3189030303633, 3261.5596894419245, 3281.245313577877, 5433.945660543398, 5484.204790305404, 5492.121260598305, 5500.80747173849, 5509.421510741375, 5558.249636299099, 5613.494785469307, 5616.5787565932615, 5631.324241091075, 5651.2370829937945, 5039.168537191359, 5054.469280725517, 5061.772220250097, 5132.101882170624, 5151.278820965068, 4999.550040496355, 5000.699958002513, 5112.0, 5131.897362052775, 5146.459621739719, 5021.874453138683, 5032.723200223986, 5071.137906555876, 5085.084684756743, 5132.332796736419, 5155.561777248939, 5164.8708782280555, 5223.13818219997, 5225.817096401645, 5246.947530524722, 4715.976420117911, 5084.644074914758, 5090.363704536933, 5161.7161056141895, 5176.327077479941, 5298.523132918017, 5357.357117145929, 5440.401555828856, 5462.808801691922, 5544.306961629796, 5887.411258874121, 5887.5584331174905, 5915.526757859361, 5983.91024134634, 6008.729607167645, 6041.426064523863, 6043.305019922721, 6047.455728984369, 6057.030875059969, 6072.332043475214, 5433.1850222466555, 5483.287172667608, 5556.833295001156, 5631.943680563224, 5634.549236061105, 6123.755049797958, 6158.753649854045, 6164.568480206342, 6177.135201071854, 6191.876162476815, 5940.732667029994, 5951.047832346891, 5965.463108320272, 5972.701364931736, 5973.701314934323, 5760.53915686744, 5854.151148083504, 5928.170056192136, 5943.10853371989, 6002.039673652194, 5973.79091731796, 5997.370276121032, 6005.909911351333, 6043.3050199227655, 6055.636661800306, 5979.073243647242, 6023.66869822164, 6041.0, 6043.637381757108, 6046.244219472566, 4453.866384008485, 4486.75322857246, 4490.101979604092, 4577.542245775396, 4638.420197475316, 4126.938095928564, 4140.68944829139, 4154.875353739392, 4183.91632167355, 4208.537060923296, 5675.829725108253, 5721.914171287434, 5740.712964351766, 5741.5119714824705, 5754.971225143848, 5833.0, 5908.291005079332, 6045.486133678599, 6046.576739628272, 6059.303180134253, 5540.030494663418, 5618.381977982419, 5620.353659329229, 5654.264945557134, 5688.146777983336, 5161.587073034223, 5161.66449180802, 5163.0190263849745, 5166.509181627739, 5196.636235463481, 5936.8812623748145, 6131.325554189036, 6158.753649854045, 6196.0705894116245, 6202.658853763086, 5783.450572195635, 5788.334341550775, 5855.2973643163095, 5860.589758716849, 5937.168796368425, 6047.455728984237, 6057.242844644419, 6062.272527296753, 6068.78759243442, 6071.574989750675, 5798.188253644577, 5817.9127313091185, 5819.738111784895, 5844.47399734009, 5850.297964244318, 5834.824955251349, 5863.648181109147, 5883.0, 5896.587238893237, 5898.793542226002, 5790.276215473066, 5830.970845145747, 5833.154192642128, 5842.941570584239, 5854.795082172103, 5911.231539899785, 5935.792247271324, 5938.287405511366, 5944.9405505946115, 5946.07835785454, 5662.377138514842, 5680.11958146488, 5761.798337058183, 5816.0, 5889.617174883619, 5884.235049443545, 5908.084246941731, 5925.259342582177, 5938.584299099194, 5958.970205148947, 5580.525655319343, 5759.740811663569, 5785.6817875015595, 5789.102689083199, 5796.913046304393], "value": 5503.283550273892, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.894199573079, 574.9741261643226, 586.0769288370815, 607.307669257047, 629.5718911140424, 33676.83161584195, 46084.308735368955, 46987.530124698744, 47078.293825592555, 47149.999999999956, 47344.10623575053, 47433.52566474334, 47816.28275575869, 47897.7605111974, 48005.27992080113, 8257.42198046137, 8464.449810762311, 8859.601317940693, 9085.091490850928, 9085.727428177132, 10574.154067674568, 10876.129909607253, 10895.237333386665, 11141.164412669043, 11155.832662510069, 10939.45302734864, 11017.669469915916, 11018.11855051594, 11020.283681560673, 11028.062614677761, 10877.510512026938, 10910.345379277269, 10937.4531273436, 10946.835797463005, 10947.124230061616, 10801.297915635458, 10805.729856753565, 10841.67474975752, 10863.67408977732, 10868.45657717119, 44318.77840610808, 44763.328550071776, 44789.776051119865, 44818.32772508415, 44833.0, 3768.698504119664, 3795.1460921292764, 3825.1202223488476, 3889.4749208857006, 3946.3883098119836, 31907.0, 33918.0, 33945.83027084873, 34048.82975585131, 34184.0, 4568.954310456919, 4653.674242803005, 4664.813407463697, 4676.532346765331, 4702.294655801623, 388165.0, 395325.0, 397230.0, 397988.9999999971, 398154.0, 67921.58509696854, 68992.3100768996, 69071.0, 69075.65462172657, 69120.6543967277, 40937.18125637471, 42385.78807105945, 42462.78768606137, 71637.2836271641, 72274.2772572278, 15400.0, 15508.767368489482, 15515.069095854285, 15529.534113976599, 15577.376904923904, 10485.580576776843, 10568.947155264175, 11948.940255298668, 11980.700482488008, 12174.208676436003, 22078.33764987053, 22091.779082209294, 22262.888685556467, 22313.0, 22340.441488962904, 7898.565578893216, 7991.72028978983, 8134.959325203336, 8135.471194372347, 8371.665133394596, 1097.2648325621853, 1101.542859713226, 1120.2214460949724, 1189.3161432176532, 1193.093249130667, 32745.345093098003, 33510.49734253988, 34261.65738342635, 34296.82851585726, 34489.482657760156, 1102.6030628973724, 1104.2270410712372, 1118.703543560957, 1185.7035741064733, 1205.8794120588047, 16672.916635416746, 17517.649647006987, 17526.561835953948, 17545.56136096608, 17654.0, 567110.0, 569006.0, 569060.0, 569248.0, 572548.0, 63538.68230658909, 64114.6794266035, 64358.356416435236, 64409.03386449207, 64442.0, 1291.3994992328423, 1306.4708792938875, 1395.6092294157652, 1403.5578792680274, 1449.7462943984972, 32637.0, 34512.82743586266, 34781.826090869385, 34834.0, 35040.12399690028, 53744.193837093255, 54250.186247207115, 54369.72815135899, 54423.367298981095, 54558.0, 406303.0, 409226.0, 410556.0, 410586.0, 410751.0, 31020.22449438782, 31431.685683142874, 33356.666433335355, 33374.833125834215, 33465.49801753024, 50955.0, 51109.0, 51174.23238651349, 51255.2311715332, 51565.19521816869, 41912.58087419087, 42499.0, 42895.0, 43774.34338484862, 43992.56007439885, 43662.0, 44311.33532996943, 44808.551914480435, 45497.545024549334, 45583.77208113938, 42726.57273427226, 43020.56979430166, 44435.0, 44863.55136448594, 44873.0, 36044.81977590095, 38237.235255295294, 38444.61555384522, 39094.2181156381, 39356.606433935296, 28906.855465722536, 29037.419251615273, 29061.0, 29114.70885291205, 29234.122976310744], "value": 21486.28968212862, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.5393797133298, 414.33706070287525, 426.58194968930445, 426.8036703116566, 451.9118771839493, 14961.700765984673, 18199.636007279845, 18657.4402767917, 19565.510862228417, 19806.504837379074, 19047.52381190471, 20164.77128129384, 20216.292429764962, 20520.589588208266, 20670.0, 5748.770049198038, 6016.368281330463, 6032.819015429544, 6039.909401358983, 6040.909386359208, 5658.151277308396, 5946.554008449362, 5981.0729336952845, 5983.431574000463, 5989.760409583611, 5783.537317014629, 5956.672383018932, 5956.821295361125, 5961.344252132262, 5961.403859614047, 5856.47291743743, 5879.735411906475, 5882.911756323637, 5910.734016969203, 5928.762849485994, 5269.762860671279, 5269.841904742864, 5333.120035194188, 5336.973315133399, 5339.41266460689, 23962.880185599133, 23999.64000539993, 24142.275731728078, 24209.87895060531, 24273.514529709308, 2329.650552417134, 2395.0419832067137, 2435.281591930367, 3079.9230019249476, 3178.4278829810623, 10832.483452316683, 10867.347959122399, 10975.890241097566, 11050.723731906686, 11390.25963312382, 1957.6198779860165, 1993.5016245938516, 2006.9582504970178, 2014.2345908554655, 2041.2853203309292, 84814.57592712059, 85740.57129714312, 87547.12452875453, 88182.55908720479, 90115.0, 10122.493875306205, 10922.508487118099, 11094.55621775136, 11128.554857805597, 11293.830592541119, 14513.274336283144, 14740.484083057041, 15409.229538523028, 15415.61460963485, 15807.209639517978, 7498.175200727916, 7849.960750196213, 7925.365970722443, 7935.523868567904, 8030.277275045274, 7549.0, 7700.730474433368, 7716.035495563055, 7812.453128280966, 7835.960820195976, 4694.460137084211, 4715.363425937523, 4725.432948046187, 4816.229403295456, 4934.506549345108, 1930.5270208798654, 2013.7409379162964, 2037.276766747783, 2047.8566500344832, 2077.968830467544, 891.362675686887, 988.8912219655832, 1024.109025148126, 1053.5206481051102, 1083.4041277297613, 19480.0, 19788.70316945247, 20202.595948080954, 20262.290819821235, 20384.28654997068, 973.5278389980854, 976.067855198284, 985.8718366612438, 1003.844404117363, 1026.3790406803926, 9242.491662958468, 10904.836427453594, 11088.061663659137, 11127.721806954729, 11206.103511719206, 455666.0, 456650.0, 457002.0, 459268.0, 459367.0, 61579.69210153921, 63675.0, 93385.5330723342, 96212.03787962171, 98142.0, 1032.339302846179, 1041.6406339812904, 1057.645688694296, 1076.5586109694987, 1080.9730755782039, 17562.82437175612, 17712.734308985633, 17956.191971361583, 18175.727364089285, 18550.44348669542, 42458.0, 42658.78670606627, 42761.35857962071, 42807.14385712331, 42987.78506107449, 55320.0, 61207.69396153169, 62741.05888411586, 62909.68545157245, 63396.04905926323, 7840.490368126054, 8311.875321870297, 8698.652053917773, 9077.546122693971, 9224.631014759603, 13832.792508112587, 14020.158790472604, 14199.64500887486, 14256.643583910485, 14325.355359008661, 11627.825582616437, 11868.465919033491, 11995.940020299842, 12020.03839692805, 12246.693832654255, 11904.345261010727, 11981.801819817949, 12053.035757139583, 12196.329201893981, 12462.501499940263, 11641.767164656829, 11673.533058677558, 12006.39968001579, 12082.939585302018, 12099.57651482194, 8238.546879921661, 8264.669413223404, 8499.95750021246, 8537.274331681876, 8583.35624828128, 11950.641480755592, 12110.939445302716, 12163.331016794162, 12318.81521777192, 12378.133530652767], "value": 9400.109156966084, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.3494455189225, 1454.9781753273703, 1501.1443477217983, 1633.5834362237629, 1813.0300289345196, 7591.127020392656, 8186.099529051799, 8425.07324194338, 8435.32517398609, 8652.0, 8594.785130371743, 8644.092370301121, 8658.437201581908, 8660.523671198098, 8674.95662521688, 2464.0513402340093, 2492.5762620354585, 2493.0775613023116, 2496.0, 2498.7376325485743, 2420.225527831086, 2498.2005758157306, 2500.0124950644486, 2503.4242124311418, 2503.5243303772227, 2435.975640243593, 2486.813488988324, 2516.660250866137, 2516.7105782834933, 2519.3197836584113, 2430.222328854767, 2432.3067925641285, 2469.5431345201105, 2478.3556275368355, 2481.987590062038, 2431.2463136427764, 2454.1655837015323, 2475.8638274894874, 2477.0, 2482.8758562071826, 8363.289120424772, 8465.32277417805, 8526.74419767408, 8543.273821725099, 8574.099719529484, 5338.973305133488, 5530.446955304477, 5544.306961629796, 5544.390117087117, 5547.33431988164, 3416.5558477398026, 3492.8777492787885, 3579.2125732338845, 3662.432322989941, 3664.780113193217, 1111.6053800900725, 1135.9545618175264, 1142.6457798082622, 1161.1117495116243, 1179.0685358566807, 11893.464794084288, 11924.821127683092, 11958.40207989597, 12014.339211343373, 12023.93988030063, 4440.267355886307, 4591.012932219522, 4693.624510039189, 4698.906021879543, 4710.29345598163, 9387.436753794795, 9403.247740180768, 9445.811083778286, 9482.146606805421, 9484.90515094854, 5371.892562148735, 5375.032494151091, 5375.946240537544, 5378.381486129067, 5379.408265090837, 4233.5131459882505, 4407.6914615976575, 4519.435070616173, 4525.954740452619, 4927.088488629615, 3914.236723838824, 3931.9213615727526, 4073.9796301018305, 4076.0828813517314, 4087.97956010224, 1257.044646068994, 1260.40985774233, 1268.3658170914543, 1276.6808297925518, 1289.065427565008, 866.7529754020075, 956.1299217711988, 965.5027660754716, 977.3500622086233, 982.3172894838019, 5673.319511403109, 5758.395368486333, 5810.21562089121, 5953.047512398082, 6124.265088189357, 476.3355119608127, 481.41748484334346, 488.09702051205693, 498.9600831933437, 506.88848453340205, 4020.8994775130273, 4066.573009833984, 4087.1621317629815, 4093.85671501496, 4096.610821971908, 10365.481725913674, 10827.729306767236, 10937.4531273436, 10942.398168100832, 11054.060404865677, 10947.671569852917, 10964.17768667353, 10964.945175274073, 10968.561257549609, 10995.230333876712, 7707.421943354271, 7837.412194085467, 7882.881756773653, 7951.602419878983, 7967.482113662593, 5901.380355062828, 5935.732892019783, 5953.613015154001, 6073.392660734068, 6098.993666045053, 10030.699079027641, 10035.69892903214, 10056.798864022825, 10085.193184545366, 10136.645217417356, 8964.641414343354, 8981.685641002534, 10053.0, 10203.540840662039, 10362.430066346424, 7122.5726456412785, 7679.19368466303, 7741.651625676971, 7798.454108212371, 7942.285194332538, 8492.830143396974, 8505.532195729294, 8552.059273479788, 8553.95723021381, 8562.229399354088, 7548.282913123245, 7612.200718924433, 7682.923170768221, 7733.535987840747, 7769.572673503011, 7501.062367204099, 7554.093508778982, 7603.581803000888, 7753.379729621504, 7805.33654639362, 6760.729570817309, 6866.690998904961, 6876.793696189123, 6878.209005964378, 6881.483888708267, 5164.7934082636275, 5253.343332083489, 5254.238135470259, 5254.710990895537, 5446.1558458439, 5107.336046313955, 5121.74391280442, 5145.305383773292, 5171.456997015259, 5186.351706036746], "value": 4566.751980267126, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.3666034534384, 333.8480991149024, 333.87646570768817, 340.94374428219345, 348.5242643791224, 5246.7901283948595, 5373.194020896867, 5452.500562345357, 5476.698781567012, 5486.177073438987, 5206.661566998143, 5293.497117773815, 5357.0, 5405.621606487547, 5418.647787893784, 4231.407602935591, 4232.470941132358, 4258.552851950547, 4274.957250427503, 4290.4422425084695, 4172.582741725818, 4230.238557059728, 4238.618524332809, 4243.448351714273, 4276.615104640582, 4203.97898010511, 4213.178430206111, 4223.458437670259, 4230.280852255109, 4232.619064284214, 4168.562300958416, 4176.916461670765, 4197.7271477354025, 4207.158568286355, 4212.220739163234, 3764.416515440111, 3773.4339849022867, 3774.471573979645, 3778.8663400979594, 3807.895710244026, 5078.365204349457, 5291.656042357235, 5297.867553311198, 5309.946900530984, 5329.747509335303, 4797.712137271775, 4809.254565542346, 4822.553234029777, 4833.782479788418, 4839.201531747258, 5365.049222927374, 5669.0079236133515, 5681.687507187103, 5687.175359572881, 5689.772409103631, 4022.6982976276895, 4042.70633397313, 4043.7573745575064, 4054.189162167578, 4055.9188816223805, 5809.883802323972, 5882.382349853289, 5883.823485295448, 5895.496648354685, 5913.822585322448, 4066.552679205285, 4173.373993900939, 4175.457190565267, 4183.3515805050265, 4184.958150418518, 4165.875023749292, 4173.686973477002, 4186.225548273579, 4203.831846726097, 4216.536181020086, 4727.810887564528, 4776.164171270014, 4784.545468180518, 4787.40157480315, 4788.377510923558, 5523.972380138073, 5679.545636349082, 5685.971570142206, 5689.151025916593, 5694.259746232963, 1403.4245959156697, 1413.5900588829124, 1426.8501807310083, 1427.8857691384871, 1431.7709166533305, 918.903515130915, 953.9952300238455, 964.3779762053576, 971.5482300730054, 984.4536282363214, 5271.917592550997, 5302.522772950453, 5305.708186049805, 5366.382865970385, 5368.194770784336, 5624.606277560531, 5629.634073785191, 5635.6048679311125, 5654.116400635706, 5659.349174844946, 5088.77100530477, 5270.393904700932, 5324.949894290726, 5332.213708407727, 5349.652272602269, 2963.9110826675233, 2966.3325751705693, 2969.6042859855834, 2978.7468065214266, 2986.999355216027, 5774.855628609234, 5818.738156782955, 5823.777006828614, 5835.387284335168, 5851.824445266649, 5431.321084864392, 5651.463111004448, 5671.943280567224, 5676.659400435987, 5695.7152142392715, 5757.942420575824, 5793.942060579425, 5805.970970145122, 5812.314428815596, 5865.941340586625, 5339.654481301362, 5473.726313684379, 5501.614886957875, 5550.278463799842, 5570.0, 5536.169574563848, 5536.972315138399, 5547.694876781816, 5570.192322113352, 5573.804916827891, 5700.287464066992, 5802.709864506842, 5829.183914251923, 5833.329167145833, 5840.853978650568, 3985.880423587297, 4016.216837716617, 4106.445629840053, 4145.0880806222585, 4149.0, 5801.012478573453, 5822.359540450631, 5839.270091238595, 5845.736941837543, 5856.472917437451, 5648.689322087324, 5719.48524632785, 5770.9711451444155, 5783.306003279633, 5808.680522571299, 5656.773729050957, 5668.886622267449, 5673.3759286477625, 5688.203651488878, 5707.743151558107, 5642.520385767091, 5653.773849045992, 5673.8865222694485, 5688.40271771458, 5734.648793994442, 5509.917351239815, 5651.350094739158, 5686.630369026, 5746.224259724883, 5798.797042103506, 5572.414896435978, 5572.888542229214, 5586.245856809279, 5591.524720398812, 5598.0], "value": 4285.65553301983, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [799.5402643479997, 819.1439945257206, 820.5856042698437, 831.1273163178661, 856.6659002988836, 13758.0, 15940.840591594095, 16356.672866542662, 16461.506154815346, 16511.339546418145, 14997.10017398957, 15122.924385378057, 15326.540203793904, 15905.125218112998, 16093.356265749386, 710.5381502023674, 836.2515548584014, 838.4885220015816, 839.5214727605268, 840.5125027484045, 717.6160753996613, 828.2669837194067, 847.3898792869155, 851.3784936995966, 851.7402192331336, 892.5225004622529, 892.9776755581097, 894.5795476126243, 895.1674942303655, 895.1898531828673, 735.8785800342937, 882.9646814127427, 888.9822203555925, 889.4485419040171, 889.524104604037, 544.0913674164156, 627.4384425938805, 643.5334382572597, 644.7807745366551, 647.1166857239881, 14325.0, 14362.856371436257, 14903.478378256817, 14912.254387280593, 14917.850821491755, 14154.0, 14429.85570144306, 14507.202103884281, 14529.200893950829, 14610.342534585969, 13150.934245328808, 13239.0, 13250.403731832092, 13293.468261269634, 13549.661258468519, 4604.6776725629215, 4615.838445654386, 4618.861434156981, 4651.534846515356, 4804.0872234275375, 64487.67756161236, 65643.71781410958, 66171.66914165398, 67116.66441667809, 67749.3225067753, 11753.823692644617, 11851.525938962517, 11853.525858965544, 11945.940270298594, 11961.581344652895, 21457.356279311647, 21493.247736329155, 21640.91795410223, 21772.782272177075, 22141.0, 8297.626606802709, 8411.242988131098, 8473.915260847436, 8485.703000394957, 8615.267702245379, 4421.977890110593, 4437.600615944516, 4441.178381999341, 4461.286194208976, 4604.58558729716, 3484.8083355415188, 3584.2652256287397, 3586.605473397924, 3599.8200089995394, 3644.8359823807464, 694.2328726756962, 695.2282965907838, 697.8081027717418, 700.8002719224996, 723.7828651404662, 658.6048370977471, 710.8222944263935, 731.0861423220974, 762.6682393158993, 778.9766307010799, 9425.622975081056, 9443.433393996382, 9616.807663846825, 10052.899471005196, 10431.16550675944, 722.7795522365624, 748.9775306740806, 749.8537785131847, 758.4463341760546, 775.968961241544, 4547.15877562652, 4946.455889852114, 4949.554540091337, 4976.502349765067, 4983.90032199354, 74551.62724186345, 75263.62368188234, 78690.0, 93236.0, 95252.52373738086, 62809.37190628127, 71617.64191179114, 72188.63905680439, 73751.63124184452, 73784.0, 66306.33693663002, 66408.0, 67702.66148669225, 69810.3018969814, 70988.64505677542, 9656.622562535944, 10246.53890574911, 10405.323653962469, 10469.476526173814, 10569.63006294776, 45142.0, 45878.770606146754, 46562.53437465582, 47553.524464756294, 47884.521154788, 42287.365689515296, 43302.78348608237, 60864.0, 61415.0, 63458.68270658617, 12256.87743122593, 12444.626661200178, 12502.749945001231, 13213.207207567577, 13456.730865382833, 14287.357068932131, 14332.211728355041, 14982.925085374503, 15016.249187540798, 15581.766273506133, 14043.719125617636, 14144.0, 14362.928185359006, 14647.267636617913, 14794.0, 13691.520796772065, 14012.159270443806, 14074.859251407355, 14108.929455353069, 14338.481197152569, 12524.311162886128, 12610.558630447891, 12790.168639038433, 13632.182069075887, 14201.360938757987, 10659.413732244491, 10682.73293167677, 10929.83605245906, 11870.821937671115, 11999.880001199876, 11866.169368144492, 11894.821577676516, 12107.81838272409, 12197.390130493617, 12308.630741077783], "value": 7457.033494325471, "unit": "score"}], "name": "dromaeo_css", "value": 7385.144963789949, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 113.0, 113.0, 113.0, 112.0, 113.0, 113.0, 113.0, 112.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 120.0, 122.0, 152.0, 123.0, 126.0, 123.0, 120.0, 152.0, 121.0], "value": 130.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 161.0, 161.0, 161.0, 160.0, 160.0, 160.0, 161.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 109.0, 85.0, 76.0, 75.0, 75.0, 104.0, 76.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 110.0, 82.0, 82.0, 81.0, 98.0, 81.0, 81.0, 115.0], "value": 89.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 116.0, 118.0, 117.0, 117.0, 118.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 84.0, 84.0, 85.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 49.0, 50.0, 50.0, 51.0, 51.0, 51.0, 50.0, 50.0, 50.0], "value": 50.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 58.0, 59.0, 59.0, 57.0, 58.0, 59.0, 60.0, 59.0], "value": 58.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 80.0, 77.0, 78.0, 76.0, 76.0, 77.0, 75.0], "value": 76.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 131.0, 135.0, 128.0, 127.0, 136.0, 144.0, 124.0, 172.0, 130.0], "value": 138.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 158.0, 158.0, 158.0, 157.0, 158.0, 160.0, 162.0, 159.0, 160.0], "value": 158.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 62.0, 62.0, 63.0, 62.0, 61.0, 61.0, 63.0, 61.0, 61.0], "value": 62.2, "unit": "score"}], "name": "kraken", "value": 1467.3000000000002, "alertThreshold": 2.0}]} 20:23:57 INFO - Return code: 0 20:23:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:23:57 ERROR - # TBPL SUCCESS # 20:23:57 INFO - Running post-action listener: _resource_record_post_action 20:23:57 INFO - [mozharness: 2016-11-24 04:23:57.216574Z] Finished run-tests step (success) 20:23:57 INFO - Running post-run listener: _resource_record_post_run 20:23:57 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 266240; Write bytes: 370241536; Read time: 28; Write time: 263512 20:23:57 INFO - TinderboxPrint: CPU usage
13.0% 20:23:57 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 28 20:23:57 INFO - TinderboxPrint: I/O write bytes / time
370,241,536 / 263,512 20:23:57 INFO - TinderboxPrint: CPU idle
8,276.4 (87.0%) 20:23:57 INFO - TinderboxPrint: CPU user
1,191.4 (12.5%) 20:23:57 INFO - TinderboxPrint: Swap in / out
0 / 0 20:23:57 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 123490304; Read time: 0; Write time: 87480 20:23:57 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 262144; Write bytes: 246206464; Read time: 12; Write time: 175980 20:23:57 INFO - Running post-run listener: _upload_blobber_files 20:23:57 INFO - Blob upload gear active. 20:23:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:23:57 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 20:23:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:23:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:23:58 INFO - (blobuploader) - INFO - Open directory for files ... 20:23:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:23:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:23:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:23:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:23:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:23:59 INFO - (blobuploader) - INFO - Done attempting. 20:23:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:23:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:23:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:24:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:24:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:24:02 INFO - (blobuploader) - INFO - Done attempting. 20:24:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:24:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:24:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:24:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:24:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:24:03 INFO - (blobuploader) - INFO - Done attempting. 20:24:03 INFO - (blobuploader) - INFO - Iteration through files over. 20:24:03 INFO - Return code: 0 20:24:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:24:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:24:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e5df2be468c609de771151956626d8b007d9b1b5f4901b3f8f68acd7effcdc1ebb41784716851f92a69b3c35254ce6f3acca18bed5a63c4df14c6dc1a82fa5e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b0e03e31d0b812d35b55474cb49debe60ab7ac1dce50d3ba54d8eb99062d5aada581733ab31a04ba61b6581ca251e849344c8fb3079ec506adc3b2cc51f41c0b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/294da5ee3a0625b14dd5e2ae67b671b7849b6ac2ac2a4e25763969b39a33a0b86300fabbb15f090ac0d5b7844233c58477ba6ec235acbe1123fe0114c333a2a0"} 20:24:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:24:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:24:03 INFO - Contents: 20:24:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e5df2be468c609de771151956626d8b007d9b1b5f4901b3f8f68acd7effcdc1ebb41784716851f92a69b3c35254ce6f3acca18bed5a63c4df14c6dc1a82fa5e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b0e03e31d0b812d35b55474cb49debe60ab7ac1dce50d3ba54d8eb99062d5aada581733ab31a04ba61b6581ca251e849344c8fb3079ec506adc3b2cc51f41c0b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/294da5ee3a0625b14dd5e2ae67b671b7849b6ac2ac2a4e25763969b39a33a0b86300fabbb15f090ac0d5b7844233c58477ba6ec235acbe1123fe0114c333a2a0"} 20:24:03 INFO - Running post-run listener: copy_logs_to_upload_dir 20:24:03 INFO - Copying logs to upload dir... 20:24:03 INFO - mkdir: /builds/slave/test/build/upload/logs 20:24:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.759140 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-11-23 20:24:02.881291) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 20:24:02.884869) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1479959691.129873-195329299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e5df2be468c609de771151956626d8b007d9b1b5f4901b3f8f68acd7effcdc1ebb41784716851f92a69b3c35254ce6f3acca18bed5a63c4df14c6dc1a82fa5e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b0e03e31d0b812d35b55474cb49debe60ab7ac1dce50d3ba54d8eb99062d5aada581733ab31a04ba61b6581ca251e849344c8fb3079ec506adc3b2cc51f41c0b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/294da5ee3a0625b14dd5e2ae67b671b7849b6ac2ac2a4e25763969b39a33a0b86300fabbb15f090ac0d5b7844233c58477ba6ec235acbe1123fe0114c333a2a0"} build_url:https://queue.taskcluster.net/v1/task/UAHI9e7SQWqDRhpa46G2vQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011882 build_url: 'https://queue.taskcluster.net/v1/task/UAHI9e7SQWqDRhpa46G2vQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e5df2be468c609de771151956626d8b007d9b1b5f4901b3f8f68acd7effcdc1ebb41784716851f92a69b3c35254ce6f3acca18bed5a63c4df14c6dc1a82fa5e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b0e03e31d0b812d35b55474cb49debe60ab7ac1dce50d3ba54d8eb99062d5aada581733ab31a04ba61b6581ca251e849344c8fb3079ec506adc3b2cc51f41c0b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/294da5ee3a0625b14dd5e2ae67b671b7849b6ac2ac2a4e25763969b39a33a0b86300fabbb15f090ac0d5b7844233c58477ba6ec235acbe1123fe0114c333a2a0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 20:24:02.910656) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 20:24:02.910987) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1479959691.129873-195329299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004520 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 20:24:02.995943) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 20:24:02.996284) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 20:24:02.996588) ========= ========= Total master_lag: 0.14 =========