builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-021 starttime: 1477515358.6 results: success (0) buildid: 20161026103002 builduid: 78c5e69d605846f58a6f15026853634c revision: d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 13:55:58.596150) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 13:55:58.596609) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 13:55:58.596895) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 13:55:58.611476) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:55:58.611765) ========= 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=df17445c3590ff7897617a0e00000225-1477515358.39564-769620550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-26 13:55:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-10-26 13:55:58 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.096610 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:55:58.722073) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:55:58.722415) ========= 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=df17445c3590ff7897617a0e00000225-1477515358.39564-769620550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016035 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:55:58.772439) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:55:58.772799) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 --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=df17445c3590ff7897617a0e00000225-1477515358.39564-769620550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-26 13:55:58,936 truncating revision to first 12 chars 2016-10-26 13:55:58,936 Setting DEBUG logging. 2016-10-26 13:55:58,936 attempt 1/10 2016-10-26 13:55:58,936 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d26ac63f1b81?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-26 13:55:59,572 unpacking tar archive at: mozilla-central-d26ac63f1b81/testing/mozharness/ program finished with exit code 0 elapsedTime=0.948563 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:55:59.733875) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 13:55:59.734210) ========= script_repo_revision: d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 13:55:59.734625) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 13:55:59.734903) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 13:55:59.742108) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-10-26 13:55:59.742403) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=df17445c3590ff7897617a0e00000225-1477515358.39564-769620550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:55:59 INFO - MultiFileLogger online at 20161026 13:55:59 in /builds/slave/test 13:55:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 13:55:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:55:59 INFO - {'append_to_log': False, 13:55:59 INFO - 'base_work_dir': '/builds/slave/test', 13:55:59 INFO - 'blob_upload_branch': 'Firefox', 13:55:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:55:59 INFO - 'branch': 'Firefox', 13:55:59 INFO - 'buildbot_json_path': 'buildprops.json', 13:55:59 INFO - 'config_files': ('talos/linux_config.py',), 13:55:59 INFO - 'default_actions': ('clobber', 13:55:59 INFO - 'read-buildbot-config', 13:55:59 INFO - 'download-and-extract', 13:55:59 INFO - 'populate-webroot', 13:55:59 INFO - 'create-virtualenv', 13:55:59 INFO - 'install', 13:55:59 INFO - 'run-tests'), 13:55:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:55:59 INFO - 'download_minidump_stackwalk': True, 13:55:59 INFO - 'download_symbols': 'ondemand', 13:55:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:55:59 INFO - 'tooltool.py': '/tools/tooltool.py', 13:55:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:55:59 INFO - '/tools/misc-python/virtualenv.py')}, 13:55:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:55:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:55:59 INFO - 'installer_path': 'installer.exe', 13:55:59 INFO - 'log_level': 'info', 13:55:59 INFO - 'log_name': 'talos', 13:55:59 INFO - 'log_to_console': True, 13:55:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:55:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:55:59 INFO - 'opt_config_files': (), 13:55:59 INFO - 'pip_index': False, 13:55:59 INFO - 'sps_profile': False, 13:55:59 INFO - 'sps_profile_interval': 0, 13:55:59 INFO - 'suite': 'dromaeojs', 13:55:59 INFO - 'system_bits': '32', 13:55:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:55:59 INFO - 'title': 'talos-linux64-ix-021', 13:55:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:55:59 INFO - 'use_talos_json': True, 13:55:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:55:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:55:59 INFO - 'work_dir': 'build'} 13:55:59 INFO - [mozharness: 2016-10-26 20:55:59.999757Z] Running clobber step. 13:55:59 INFO - Running pre-action listener: _resource_record_pre_action 13:55:59 INFO - Running main action method: clobber 13:56:00 INFO - rmtree: /builds/slave/test/build 13:56:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:56:00 INFO - Running post-action listener: _resource_record_post_action 13:56:00 INFO - [mozharness: 2016-10-26 20:56:00.461611Z] Finished clobber step (success) 13:56:00 INFO - [mozharness: 2016-10-26 20:56:00.461712Z] Running read-buildbot-config step. 13:56:00 INFO - Running pre-action listener: _resource_record_pre_action 13:56:00 INFO - Running main action method: read_buildbot_config 13:56:00 INFO - Using buildbot properties: 13:56:00 INFO - { 13:56:00 INFO - "project": "", 13:56:00 INFO - "product": "firefox", 13:56:00 INFO - "script_repo_revision": "production", 13:56:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 13:56:00 INFO - "repository": "", 13:56:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 13:56:00 INFO - "buildid": "20161026103002", 13:56:00 INFO - "pgo_build": "True", 13:56:00 INFO - "basedir": "/builds/slave/test", 13:56:00 INFO - "buildnumber": 47, 13:56:00 INFO - "slavename": "talos-linux64-ix-021", 13:56:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:56:00 INFO - "platform": "ubuntu64_hw", 13:56:00 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 13:56:00 INFO - "branch": "mozilla-central", 13:56:00 INFO - "repo_path": "mozilla-central", 13:56:00 INFO - "revision": "d26ac63f1b81c3fce35448a7c502e95e0b5c56c0", 13:56:00 INFO - "stage_platform": "linux64-pgo", 13:56:00 INFO - "builduid": "78c5e69d605846f58a6f15026853634c", 13:56:00 INFO - "slavebuilddir": "test" 13:56:00 INFO - } 13:56:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 13:56:00 INFO - Running post-action listener: _resource_record_post_action 13:56:00 INFO - [mozharness: 2016-10-26 20:56:00.464163Z] Finished read-buildbot-config step (success) 13:56:00 INFO - [mozharness: 2016-10-26 20:56:00.464252Z] Running download-and-extract step. 13:56:00 INFO - Running pre-action listener: _resource_record_pre_action 13:56:00 INFO - Running main action method: download_and_extract 13:56:00 INFO - mkdir: /builds/slave/test/build/tests 13:56: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')]} 13:56:00 INFO - trying https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:56:00 INFO - Downloading https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:56:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:56:01 INFO - Downloaded 1361 bytes. 13:56:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:56:01 INFO - Using the following test package requirements: 13:56:01 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 13:56:01 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:56:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:56:01 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:56:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:56:01 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:56:01 INFO - u'jsshell-linux-x86_64.zip'], 13:56:01 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:56:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:56:01 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 13:56:01 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:56:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:56:01 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:56:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:56:01 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:56:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:56:01 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:56:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:56:01 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:56:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 13:56:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:56:01 INFO - Fetch https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:56:03 INFO - Http code: 200 13:56:03 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 13:56:03 INFO - x-amz-cf-id: LS2zdQLBpMqClCCaLSkhOeu_pwmjOqqqlXG0PvMd57Bmyoikr8vyew== 13:56:03 INFO - x-amz-version-id: U_0UZo97Kb630CjesuvHyECqWqofhPXQ 13:56:04 INFO - Expected file size: 22058358 13:56:04 INFO - Obtained file size: 22058358 13:56:08 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:56:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 13:56:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:56:08 INFO - Fetch https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:56:09 INFO - Http code: 200 13:56:09 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 13:56:09 INFO - x-amz-cf-id: V1JExzt5tiVN9jBryp-NQBtGkZYqROiZjh2Smf5UlWJS59AtPCVf0A== 13:56:09 INFO - x-amz-version-id: U_0UZo97Kb630CjesuvHyECqWqofhPXQ 13:56:09 INFO - Expected file size: 22058358 13:56:09 INFO - Obtained file size: 22058358 13:56:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 13:56:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:56:13 INFO - Fetch https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 13:56:14 INFO - Http code: 200 13:56:14 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 13:56:14 INFO - x-amz-cf-id: 1SUj3pV-YezHl--D38fc7sPBW2cmRN3vf2mihso6eb_ZqsHL67Qtbg== 13:56:14 INFO - x-amz-version-id: iIrxpwrloyib8J5uGYqi6PsPGVxDmjCd 13:56:14 INFO - Expected file size: 14409028 13:56:14 INFO - Obtained file size: 14409028 13:56:14 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')]} 13:56:14 INFO - trying https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:56:14 INFO - Downloading https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:56:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:56:16 INFO - Downloaded 59462255 bytes. 13:56:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:56:16 INFO - mkdir: /builds/slave/test/properties 13:56:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:56:16 INFO - Writing to file /builds/slave/test/properties/build_url 13:56:16 INFO - Contents: 13:56:16 INFO - build_url:https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:56:16 INFO - Running post-action listener: _resource_record_post_action 13:56:16 INFO - Running post-action listener: set_extra_try_arguments 13:56:16 INFO - [mozharness: 2016-10-26 20:56:16.802653Z] Finished download-and-extract step (success) 13:56:16 INFO - [mozharness: 2016-10-26 20:56:16.802881Z] Running populate-webroot step. 13:56:16 INFO - Running pre-action listener: _resource_record_pre_action 13:56:16 INFO - Running main action method: populate_webroot 13:56:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:56:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:56:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:56:16 INFO - '--tppagecycles', 13:56:16 INFO - '7'], 13:56:16 INFO - 'tests': ['tsvgm']}}, 13:56:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:56:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:56:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:56:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:56:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:56:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:56:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:56:16 INFO - 'talos_options': ['--disable-e10s'], 13:56:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:56:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:56:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:56:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:56:16 INFO - 'talos_options': ['--disable-e10s'], 13:56:16 INFO - 'tests': ['damp', 'tps']}, 13:56:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:56:16 INFO - 'tests': ['damp', 'tps']}, 13:56:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:56:16 INFO - 'tests': ['dromaeo_dom']}, 13:56:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:56:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:56:16 INFO - 'tests': ['basic_compositor_video']}, 13:56:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:56:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:56:16 INFO - 'tests': ['a11yr', 13:56:16 INFO - 'ts_paint', 13:56:16 INFO - 'tpaint', 13:56:16 INFO - 'sessionrestore', 13:56:16 INFO - 'sessionrestore_no_auto_restore', 13:56:16 INFO - 'tabpaint']}, 13:56:16 INFO - 'other-e10s': {'tests': ['a11yr', 13:56:16 INFO - 'ts_paint', 13:56:16 INFO - 'tpaint', 13:56:16 INFO - 'sessionrestore', 13:56:16 INFO - 'sessionrestore_no_auto_restore', 13:56:16 INFO - 'tabpaint']}, 13:56:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:56:16 INFO - 'ts_paint', 13:56:16 INFO - 'tpaint', 13:56:16 INFO - 'sessionrestore', 13:56:16 INFO - 'sessionrestore_no_auto_restore', 13:56:16 INFO - 'tabpaint']}, 13:56:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:56:16 INFO - 'ts_paint', 13:56:16 INFO - 'tpaint', 13:56:16 INFO - 'sessionrestore', 13:56:16 INFO - 'sessionrestore_no_auto_restore', 13:56:16 INFO - 'tabpaint']}, 13:56:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:56:16 INFO - 'tests': ['a11yr', 13:56:16 INFO - 'ts_paint', 13:56:16 INFO - 'tpaint', 13:56:16 INFO - 'sessionrestore', 13:56:16 INFO - 'sessionrestore_no_auto_restore', 13:56:16 INFO - 'tabpaint']}, 13:56:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:56:16 INFO - 'tests': ['a11yr', 13:56:16 INFO - 'ts_paint', 13:56:16 INFO - 'tpaint', 13:56:16 INFO - 'sessionrestore', 13:56:16 INFO - 'sessionrestore_no_auto_restore', 13:56:16 INFO - 'tabpaint']}, 13:56:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:56:16 INFO - 'tests': ['tsvgx', 13:56:16 INFO - 'tsvgr_opacity', 13:56:16 INFO - 'tart', 13:56:16 INFO - 'tscrollx', 13:56:16 INFO - 'cart']}, 13:56:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:56:16 INFO - 'tsvgr_opacity', 13:56:16 INFO - 'tart', 13:56:16 INFO - 'tscrollx', 13:56:16 INFO - 'cart']}, 13:56:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:56:16 INFO - 'talos_options': ['--disable-e10s'], 13:56:16 INFO - 'tests': ['tp5o']}, 13:56:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:56:16 INFO - 'tests': ['tp5o']}, 13:56:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:56:16 INFO - 'talos_options': ['--disable-e10s', 13:56:16 INFO - '--xperf_path', 13:56:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:56:16 INFO - 'tests': ['tp5n']}, 13:56:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:56:16 INFO - 'talos_options': ['--xperf_path', 13:56:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:56:16 INFO - 'tests': ['tp5n']}}, 13:56:16 INFO - 'talos.zip': {'path': '', 13:56:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:56:16 INFO - Running post-action listener: _resource_record_post_action 13:56:16 INFO - [mozharness: 2016-10-26 20:56:16.819283Z] Finished populate-webroot step (success) 13:56:16 INFO - [mozharness: 2016-10-26 20:56:16.819370Z] Running create-virtualenv step. 13:56:16 INFO - Running pre-action listener: _resource_record_pre_action 13:56:16 INFO - Running main action method: create_virtualenv 13:56:16 INFO - Creating virtualenv /builds/slave/test/build/venv 13:56:16 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 13:56:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:56:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:56:16 INFO - Using real prefix '/usr' 13:56:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:56:17 INFO - Installing distribute.............................................................................................................................................................................................done. 13:56:19 INFO - Installing pip.................done. 13:56:19 INFO - Return code: 0 13:56:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:56:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:56:19 INFO - Reading from file tmpfile_stdout 13:56:19 INFO - Output received: 13:56:19 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) 13:56:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:56:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:56:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:56:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3c8a526f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bf7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274e790>, '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 0x274f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274fb20>, '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': 'df17445c3590ff7897617a0e00000225-1477515358.39564-769620550', '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 13:56:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:56:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:56:19 INFO - Using env: {'DISPLAY': ':0', 13:56:19 INFO - 'HOME': '/home/cltbld', 13:56:19 INFO - 'LANG': 'en_US.UTF-8', 13:56:19 INFO - 'LANGUAGE': 'en_US:en', 13:56:19 INFO - 'LOGNAME': 'cltbld', 13:56:19 INFO - 'MAIL': '/var/mail/cltbld', 13:56:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:19 INFO - 'MOZ_NO_REMOTE': '1', 13:56:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:56:19 INFO - 'NO_EM_RESTART': '1', 13:56:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:56:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:19 INFO - 'PWD': '/builds/slave/test', 13:56:19 INFO - 'SHELL': '/bin/bash', 13:56:19 INFO - 'SHLVL': '1', 13:56:19 INFO - 'TERM': 'linux', 13:56:19 INFO - 'TMOUT': '86400', 13:56:19 INFO - 'USER': 'cltbld', 13:56:19 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1477515358.39564-769620550', 13:56:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:19 INFO - '_': '/tools/buildbot/bin/python'} 13:56:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:19 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 13:56:19 INFO - Cleaning up... 13:56:19 INFO - Return code: 0 13:56:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:56:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:56:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:56:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3c8a526f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bf7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274e790>, '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 0x274f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274fb20>, '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': 'df17445c3590ff7897617a0e00000225-1477515358.39564-769620550', '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 13:56:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:56:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:56:19 INFO - Using env: {'DISPLAY': ':0', 13:56:19 INFO - 'HOME': '/home/cltbld', 13:56:19 INFO - 'LANG': 'en_US.UTF-8', 13:56:19 INFO - 'LANGUAGE': 'en_US:en', 13:56:19 INFO - 'LOGNAME': 'cltbld', 13:56:19 INFO - 'MAIL': '/var/mail/cltbld', 13:56:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:19 INFO - 'MOZ_NO_REMOTE': '1', 13:56:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:56:19 INFO - 'NO_EM_RESTART': '1', 13:56:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:56:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:19 INFO - 'PWD': '/builds/slave/test', 13:56:19 INFO - 'SHELL': '/bin/bash', 13:56:19 INFO - 'SHLVL': '1', 13:56:19 INFO - 'TERM': 'linux', 13:56:19 INFO - 'TMOUT': '86400', 13:56:19 INFO - 'USER': 'cltbld', 13:56:19 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1477515358.39564-769620550', 13:56:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:19 INFO - '_': '/tools/buildbot/bin/python'} 13:56:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:20 INFO - Downloading/unpacking psutil>=3.1.1 13:56:20 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 13:56:20 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 13:56:20 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 13:56:20 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 13:56:20 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 13:56:20 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 13:56:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:56:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:56:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:56:22 INFO - Installing collected packages: psutil 13:56:22 INFO - Running setup.py install for psutil 13:56:22 INFO - building 'psutil._psutil_linux' extension 13:56:22 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 13:56:22 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 13:56:22 INFO - building 'psutil._psutil_posix' extension 13:56:22 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 13:56:22 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 13:56:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:56:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:56:22 INFO - Successfully installed psutil 13:56:22 INFO - Cleaning up... 13:56:22 INFO - Return code: 0 13:56:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:56:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:56:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:56:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3c8a526f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bf7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274e790>, '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 0x274f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274fb20>, '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': 'df17445c3590ff7897617a0e00000225-1477515358.39564-769620550', '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 13:56:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:56:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:56:22 INFO - Using env: {'DISPLAY': ':0', 13:56:22 INFO - 'HOME': '/home/cltbld', 13:56:22 INFO - 'LANG': 'en_US.UTF-8', 13:56:22 INFO - 'LANGUAGE': 'en_US:en', 13:56:22 INFO - 'LOGNAME': 'cltbld', 13:56:22 INFO - 'MAIL': '/var/mail/cltbld', 13:56:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:22 INFO - 'MOZ_NO_REMOTE': '1', 13:56:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:56:22 INFO - 'NO_EM_RESTART': '1', 13:56:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:56:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:22 INFO - 'PWD': '/builds/slave/test', 13:56:22 INFO - 'SHELL': '/bin/bash', 13:56:22 INFO - 'SHLVL': '1', 13:56:22 INFO - 'TERM': 'linux', 13:56:22 INFO - 'TMOUT': '86400', 13:56:22 INFO - 'USER': 'cltbld', 13:56:22 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1477515358.39564-769620550', 13:56:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:22 INFO - '_': '/tools/buildbot/bin/python'} 13:56:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:56:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:56:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:56:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:56:24 INFO - Installing collected packages: mozsystemmonitor 13:56:24 INFO - Running setup.py install for mozsystemmonitor 13:56:24 INFO - Successfully installed mozsystemmonitor 13:56:24 INFO - Cleaning up... 13:56:24 INFO - Return code: 0 13:56:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:56:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:56:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3c8a526f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bf7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274e790>, '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 0x274f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274fb20>, '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': 'df17445c3590ff7897617a0e00000225-1477515358.39564-769620550', '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 13:56:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:56:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:56:24 INFO - Using env: {'DISPLAY': ':0', 13:56:24 INFO - 'HOME': '/home/cltbld', 13:56:24 INFO - 'LANG': 'en_US.UTF-8', 13:56:24 INFO - 'LANGUAGE': 'en_US:en', 13:56:24 INFO - 'LOGNAME': 'cltbld', 13:56:24 INFO - 'MAIL': '/var/mail/cltbld', 13:56:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:24 INFO - 'MOZ_NO_REMOTE': '1', 13:56:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:56:24 INFO - 'NO_EM_RESTART': '1', 13:56:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:56:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:24 INFO - 'PWD': '/builds/slave/test', 13:56:24 INFO - 'SHELL': '/bin/bash', 13:56:24 INFO - 'SHLVL': '1', 13:56:24 INFO - 'TERM': 'linux', 13:56:24 INFO - 'TMOUT': '86400', 13:56:24 INFO - 'USER': 'cltbld', 13:56:24 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1477515358.39564-769620550', 13:56:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:24 INFO - '_': '/tools/buildbot/bin/python'} 13:56:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:25 INFO - Downloading/unpacking jsonschema==2.5.1 13:56:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:56:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:27 INFO - Downloading functools32-3.2.3-2.tar.gz 13:56:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:56:27 INFO - warning: no files found matching '*.txt' 13:56:27 INFO - no previously-included directories found matching 'build' 13:56:27 INFO - no previously-included directories found matching 'dist' 13:56:27 INFO - no previously-included directories found matching '.git*' 13:56:27 INFO - Installing collected packages: jsonschema, functools32 13:56:27 INFO - Running setup.py install for functools32 13:56:27 INFO - warning: no files found matching '*.txt' 13:56:27 INFO - no previously-included directories found matching 'build' 13:56:27 INFO - no previously-included directories found matching 'dist' 13:56:27 INFO - no previously-included directories found matching '.git*' 13:56:27 INFO - Successfully installed jsonschema functools32 13:56:27 INFO - Cleaning up... 13:56:27 INFO - Return code: 0 13:56:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:56:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:56:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:27 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 0x7f3c8a526f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bf7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274e790>, '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 0x274f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274fb20>, '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': 'df17445c3590ff7897617a0e00000225-1477515358.39564-769620550', '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 13:56:27 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 13:56:27 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 13:56:27 INFO - Using env: {'DISPLAY': ':0', 13:56:27 INFO - 'HOME': '/home/cltbld', 13:56:27 INFO - 'LANG': 'en_US.UTF-8', 13:56:27 INFO - 'LANGUAGE': 'en_US:en', 13:56:27 INFO - 'LOGNAME': 'cltbld', 13:56:27 INFO - 'MAIL': '/var/mail/cltbld', 13:56:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:27 INFO - 'MOZ_NO_REMOTE': '1', 13:56:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:56:27 INFO - 'NO_EM_RESTART': '1', 13:56:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:56:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:27 INFO - 'PWD': '/builds/slave/test', 13:56:27 INFO - 'SHELL': '/bin/bash', 13:56:27 INFO - 'SHLVL': '1', 13:56:27 INFO - 'TERM': 'linux', 13:56:27 INFO - 'TMOUT': '86400', 13:56:27 INFO - 'USER': 'cltbld', 13:56:27 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1477515358.39564-769620550', 13:56:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:27 INFO - '_': '/tools/buildbot/bin/python'} 13:56:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:56:27 INFO - Cleaning up... 13:56:27 INFO - Return code: 0 13:56:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:56:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:56:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:27 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 0x7f3c8a526f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bf7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274e790>, '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 0x274f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274fb20>, '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': 'df17445c3590ff7897617a0e00000225-1477515358.39564-769620550', '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 13:56:27 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 13:56:27 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 13:56:27 INFO - Using env: {'DISPLAY': ':0', 13:56:27 INFO - 'HOME': '/home/cltbld', 13:56:27 INFO - 'LANG': 'en_US.UTF-8', 13:56:27 INFO - 'LANGUAGE': 'en_US:en', 13:56:27 INFO - 'LOGNAME': 'cltbld', 13:56:27 INFO - 'MAIL': '/var/mail/cltbld', 13:56:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:27 INFO - 'MOZ_NO_REMOTE': '1', 13:56:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:56:27 INFO - 'NO_EM_RESTART': '1', 13:56:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:56:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:27 INFO - 'PWD': '/builds/slave/test', 13:56:27 INFO - 'SHELL': '/bin/bash', 13:56:27 INFO - 'SHLVL': '1', 13:56:27 INFO - 'TERM': 'linux', 13:56:27 INFO - 'TMOUT': '86400', 13:56:27 INFO - 'USER': 'cltbld', 13:56:27 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1477515358.39564-769620550', 13:56:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:27 INFO - '_': '/tools/buildbot/bin/python'} 13:56:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:28 INFO - Downloading/unpacking blobuploader==1.2.4 13:56:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:29 INFO - Downloading blobuploader-1.2.4.tar.gz 13:56:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:56:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:56:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:56:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:56:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:30 INFO - Downloading docopt-0.6.1.tar.gz 13:56:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:56:30 INFO - Installing collected packages: blobuploader, requests, docopt 13:56:30 INFO - Running setup.py install for blobuploader 13:56:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:56:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:56:30 INFO - Running setup.py install for requests 13:56:31 INFO - Running setup.py install for docopt 13:56:31 INFO - Successfully installed blobuploader requests docopt 13:56:31 INFO - Cleaning up... 13:56:31 INFO - Return code: 0 13:56:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:56:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:56:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:56:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:31 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 0x7f3c8a526f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bf7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274e790>, '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 0x274f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274fb20>, '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': 'df17445c3590ff7897617a0e00000225-1477515358.39564-769620550', '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 13:56:31 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 13:56:31 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 13:56:31 INFO - Using env: {'DISPLAY': ':0', 13:56:31 INFO - 'HOME': '/home/cltbld', 13:56:31 INFO - 'LANG': 'en_US.UTF-8', 13:56:31 INFO - 'LANGUAGE': 'en_US:en', 13:56:31 INFO - 'LOGNAME': 'cltbld', 13:56:31 INFO - 'MAIL': '/var/mail/cltbld', 13:56:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:31 INFO - 'MOZ_NO_REMOTE': '1', 13:56:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:56:31 INFO - 'NO_EM_RESTART': '1', 13:56:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:56:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:31 INFO - 'PWD': '/builds/slave/test', 13:56:31 INFO - 'SHELL': '/bin/bash', 13:56:31 INFO - 'SHLVL': '1', 13:56:31 INFO - 'TERM': 'linux', 13:56:31 INFO - 'TMOUT': '86400', 13:56:31 INFO - 'USER': 'cltbld', 13:56:31 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1477515358.39564-769620550', 13:56:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:31 INFO - '_': '/tools/buildbot/bin/python'} 13:56:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:56:31 INFO - Running setup.py (path:/tmp/pip-iEqzww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:56:31 INFO - Running setup.py (path:/tmp/pip-T8gZuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:56:31 INFO - Running setup.py (path:/tmp/pip-4qKkB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:56:31 INFO - Running setup.py (path:/tmp/pip-iBqg54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:56:31 INFO - Running setup.py (path:/tmp/pip-CftSlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:56:31 INFO - Running setup.py (path:/tmp/pip-a6EFrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:56:32 INFO - Running setup.py (path:/tmp/pip-DiU2NN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:56:32 INFO - Running setup.py (path:/tmp/pip-AMXRAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:56:32 INFO - Running setup.py (path:/tmp/pip-G_IiWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:56:32 INFO - Running setup.py (path:/tmp/pip-Z8bGX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:56:32 INFO - Running setup.py (path:/tmp/pip-g82VQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:56:32 INFO - Running setup.py (path:/tmp/pip-85X1Xy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:56:32 INFO - Running setup.py (path:/tmp/pip-wvDXAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:56:32 INFO - Running setup.py (path:/tmp/pip-dyDQF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:56:32 INFO - Running setup.py (path:/tmp/pip-ZKnq8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:56:32 INFO - Running setup.py (path:/tmp/pip-bz3qBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:56:32 INFO - Running setup.py (path:/tmp/pip-wqK2fQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:56:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:56:32 INFO - Running setup.py install for manifestparser 13:56:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:56:32 INFO - Running setup.py install for mozcrash 13:56:33 INFO - Running setup.py install for mozdebug 13:56:33 INFO - Running setup.py install for mozdevice 13:56:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:56:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:56:33 INFO - Running setup.py install for mozfile 13:56:33 INFO - Running setup.py install for mozhttpd 13:56:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:56:33 INFO - Running setup.py install for mozinfo 13:56:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:56:33 INFO - Running setup.py install for mozInstall 13:56:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:56:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:56:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:56:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:56:33 INFO - Running setup.py install for mozleak 13:56:33 INFO - Running setup.py install for mozlog 13:56:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:56:33 INFO - Running setup.py install for moznetwork 13:56:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:56:33 INFO - Running setup.py install for mozprocess 13:56:34 INFO - Running setup.py install for mozprofile 13:56:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:56:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:56:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:56:34 INFO - Running setup.py install for mozrunner 13:56:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:56:34 INFO - Running setup.py install for mozscreenshot 13:56:34 INFO - Running setup.py install for moztest 13:56:34 INFO - Running setup.py install for mozversion 13:56:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:56:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:56:34 INFO - Cleaning up... 13:56:34 INFO - Return code: 0 13:56:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:56:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:56:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:56:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:34 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 0x7f3c8a526f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bf7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274e790>, '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 0x274f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274fb20>, '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': 'df17445c3590ff7897617a0e00000225-1477515358.39564-769620550', '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 13:56:34 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 13:56:34 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 13:56:34 INFO - Using env: {'DISPLAY': ':0', 13:56:34 INFO - 'HOME': '/home/cltbld', 13:56:34 INFO - 'LANG': 'en_US.UTF-8', 13:56:34 INFO - 'LANGUAGE': 'en_US:en', 13:56:34 INFO - 'LOGNAME': 'cltbld', 13:56:34 INFO - 'MAIL': '/var/mail/cltbld', 13:56:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:34 INFO - 'MOZ_NO_REMOTE': '1', 13:56:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:56:34 INFO - 'NO_EM_RESTART': '1', 13:56:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:56:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:34 INFO - 'PWD': '/builds/slave/test', 13:56:34 INFO - 'SHELL': '/bin/bash', 13:56:34 INFO - 'SHLVL': '1', 13:56:34 INFO - 'TERM': 'linux', 13:56:34 INFO - 'TMOUT': '86400', 13:56:34 INFO - 'USER': 'cltbld', 13:56:34 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1477515358.39564-769620550', 13:56:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:34 INFO - '_': '/tools/buildbot/bin/python'} 13:56:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:56:34 INFO - Running setup.py (path:/tmp/pip-zHFn83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:56:34 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)) 13:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:56:34 INFO - Running setup.py (path:/tmp/pip-5e1OIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:56:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:56:35 INFO - Running setup.py (path:/tmp/pip-nWwqvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:56:35 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)) 13:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:56:35 INFO - Running setup.py (path:/tmp/pip-Pbwn8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:56:35 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)) 13:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:56:35 INFO - Running setup.py (path:/tmp/pip-O6sSRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:56:35 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)) 13:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:56:35 INFO - Running setup.py (path:/tmp/pip-dJnMII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:56:35 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)) 13:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:56:35 INFO - Running setup.py (path:/tmp/pip-zqE00f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:56:35 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)) 13:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:56:35 INFO - Running setup.py (path:/tmp/pip-Z5ryUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:56:35 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)) 13:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:56:35 INFO - Running setup.py (path:/tmp/pip-rFipPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:56:35 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)) 13:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:56:35 INFO - Running setup.py (path:/tmp/pip-QhZD6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:56:35 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)) 13:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:56:35 INFO - Running setup.py (path:/tmp/pip-DP6Pfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:56:35 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)) 13:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:56:35 INFO - Running setup.py (path:/tmp/pip-Om2aY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:56:35 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)) 13:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:56:35 INFO - Running setup.py (path:/tmp/pip-Be6Xzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:56:35 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)) 13:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:56:35 INFO - Running setup.py (path:/tmp/pip-AjXIKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:56:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:56:35 INFO - Running setup.py (path:/tmp/pip-_1AghT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:56:35 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)) 13:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:56:35 INFO - Running setup.py (path:/tmp/pip-QGGNbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:56:36 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)) 13:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:56:36 INFO - Running setup.py (path:/tmp/pip-DI1kup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:56:36 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)) 13:56:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:56:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:56:36 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)) 13:56:36 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)) 13:56:36 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)) 13:56:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:38 INFO - Downloading blessings-1.6.tar.gz 13:56:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:56:38 INFO - Installing collected packages: blessings 13:56:38 INFO - Running setup.py install for blessings 13:56:38 INFO - Successfully installed blessings 13:56:38 INFO - Cleaning up... 13:56:38 INFO - Return code: 0 13:56:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:56:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:56:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:56:38 INFO - Reading from file tmpfile_stdout 13:56:38 INFO - Current package versions: 13:56:38 INFO - argparse == 1.2.1 13:56:38 INFO - blessings == 1.6 13:56:38 INFO - blobuploader == 1.2.4 13:56:38 INFO - docopt == 0.6.1 13:56:38 INFO - functools32 == 3.2.3-2 13:56:38 INFO - jsonschema == 2.5.1 13:56:38 INFO - manifestparser == 1.1 13:56:38 INFO - mozInstall == 1.12 13:56:38 INFO - mozcrash == 0.17 13:56:38 INFO - mozdebug == 0.1 13:56:38 INFO - mozdevice == 0.48 13:56:38 INFO - mozfile == 1.2 13:56:38 INFO - mozhttpd == 0.7 13:56:38 INFO - mozinfo == 0.9 13:56:38 INFO - mozleak == 0.1 13:56:38 INFO - mozlog == 3.4 13:56:38 INFO - moznetwork == 0.27 13:56:38 INFO - mozprocess == 0.23 13:56:38 INFO - mozprofile == 0.28 13:56:38 INFO - mozrunner == 6.12 13:56:38 INFO - mozscreenshot == 0.1 13:56:38 INFO - mozsystemmonitor == 0.3 13:56:38 INFO - moztest == 0.7 13:56:38 INFO - mozversion == 1.4 13:56:38 INFO - psutil == 3.1.1 13:56:38 INFO - requests == 1.2.3 13:56:38 INFO - wsgiref == 0.1.2 13:56:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:56:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:38 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 0x7f3c8a526f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bf7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274e790>, '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 0x274f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274fb20>, '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': 'df17445c3590ff7897617a0e00000225-1477515358.39564-769620550', '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 13:56:38 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 13:56:38 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 13:56:38 INFO - Using env: {'DISPLAY': ':0', 13:56:38 INFO - 'HOME': '/home/cltbld', 13:56:38 INFO - 'LANG': 'en_US.UTF-8', 13:56:38 INFO - 'LANGUAGE': 'en_US:en', 13:56:38 INFO - 'LOGNAME': 'cltbld', 13:56:38 INFO - 'MAIL': '/var/mail/cltbld', 13:56:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:38 INFO - 'MOZ_NO_REMOTE': '1', 13:56:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:56:38 INFO - 'NO_EM_RESTART': '1', 13:56:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:56:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:38 INFO - 'PWD': '/builds/slave/test', 13:56:38 INFO - 'SHELL': '/bin/bash', 13:56:38 INFO - 'SHLVL': '1', 13:56:38 INFO - 'TERM': 'linux', 13:56:38 INFO - 'TMOUT': '86400', 13:56:38 INFO - 'USER': 'cltbld', 13:56:38 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1477515358.39564-769620550', 13:56:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:38 INFO - '_': '/tools/buildbot/bin/python'} 13:56:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:38 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)) 13:56:38 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)) 13:56:38 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)) 13:56:38 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)) 13:56:38 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)) 13:56:38 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)) 13:56:38 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)) 13:56:38 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)) 13:56:38 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)) 13:56:38 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)) 13:56:38 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)) 13:56:38 INFO - Cleaning up... 13:56:38 INFO - Return code: 0 13:56:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:56:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:38 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 0x7f3c8a526f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bf7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274e790>, '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 0x274f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274fb20>, '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': 'df17445c3590ff7897617a0e00000225-1477515358.39564-769620550', '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 13:56:38 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 13:56:38 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 13:56:38 INFO - Using env: {'DISPLAY': ':0', 13:56:38 INFO - 'HOME': '/home/cltbld', 13:56:38 INFO - 'LANG': 'en_US.UTF-8', 13:56:38 INFO - 'LANGUAGE': 'en_US:en', 13:56:38 INFO - 'LOGNAME': 'cltbld', 13:56:38 INFO - 'MAIL': '/var/mail/cltbld', 13:56:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:38 INFO - 'MOZ_NO_REMOTE': '1', 13:56:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:56:38 INFO - 'NO_EM_RESTART': '1', 13:56:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:56:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:38 INFO - 'PWD': '/builds/slave/test', 13:56:38 INFO - 'SHELL': '/bin/bash', 13:56:38 INFO - 'SHLVL': '1', 13:56:38 INFO - 'TERM': 'linux', 13:56:38 INFO - 'TMOUT': '86400', 13:56:38 INFO - 'USER': 'cltbld', 13:56:38 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1477515358.39564-769620550', 13:56:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:38 INFO - '_': '/tools/buildbot/bin/python'} 13:56:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:56:38 INFO - Cleaning up... 13:56:38 INFO - Return code: 0 13:56:38 INFO - Running post-action listener: _resource_record_post_action 13:56:38 INFO - Running post-action listener: _start_resource_monitoring 13:56:38 INFO - Starting resource monitoring. 13:56:38 INFO - [mozharness: 2016-10-26 20:56:38.986315Z] Finished create-virtualenv step (success) 13:56:38 INFO - [mozharness: 2016-10-26 20:56:38.986817Z] Running install step. 13:56:38 INFO - Running pre-action listener: _resource_record_pre_action 13:56:38 INFO - Running main action method: install 13:56:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:56:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:56:39 INFO - Reading from file tmpfile_stdout 13:56:39 INFO - Detecting whether we're running mozinstall >=1.0... 13:56:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:56:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:56:39 INFO - Reading from file tmpfile_stdout 13:56:39 INFO - Output received: 13:56:39 INFO - Usage: mozinstall [options] installer 13:56:39 INFO - Options: 13:56:39 INFO - -h, --help show this help message and exit 13:56:39 INFO - -d DEST, --destination=DEST 13:56:39 INFO - Directory to install application into. [default: 13:56:39 INFO - "/builds/slave/test"] 13:56:39 INFO - --app=APP Application being installed. [default: firefox] 13:56:39 INFO - mkdir: /builds/slave/test/build/application 13:56:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:56:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:56:56 INFO - Reading from file tmpfile_stdout 13:56:56 INFO - Output received: 13:56:56 INFO - /builds/slave/test/build/application/firefox/firefox 13:56:56 INFO - Running post-action listener: _resource_record_post_action 13:56:56 INFO - [mozharness: 2016-10-26 20:56:56.217638Z] Finished install step (success) 13:56:56 INFO - [mozharness: 2016-10-26 20:56:56.217973Z] Running run-tests step. 13:56:56 INFO - Running pre-action listener: _resource_record_pre_action 13:56:56 INFO - Running main action method: run_tests 13:56:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:56:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:56:56 INFO - Python 2.7.3 13:56:56 INFO - Return code: 0 13:56:56 INFO - grabbing minidump binary from tooltool 13:56: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')]} 13:56:56 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 0x274e790>, '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 0x274f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:56:56 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 13:56:56 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 13:56:56 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 13:56:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:56:56 INFO - Return code: 0 13:56:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:56:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:56:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:56:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:56:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:56:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 13:56:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 13:56:56 INFO - Using env: {'DISPLAY': ':0', 13:56:56 INFO - 'HOME': '/home/cltbld', 13:56:56 INFO - 'LANG': 'en_US.UTF-8', 13:56:56 INFO - 'LANGUAGE': 'en_US:en', 13:56:56 INFO - 'LOGNAME': 'cltbld', 13:56:56 INFO - 'MAIL': '/var/mail/cltbld', 13:56:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:56:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:56:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:56 INFO - 'MOZ_NO_REMOTE': '1', 13:56:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:56:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:56:56 INFO - 'NO_EM_RESTART': '1', 13:56:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:56:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:56 INFO - 'PWD': '/builds/slave/test', 13:56:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:56:56 INFO - 'SHELL': '/bin/bash', 13:56:56 INFO - 'SHLVL': '1', 13:56:56 INFO - 'TERM': 'linux', 13:56:56 INFO - 'TMOUT': '86400', 13:56:56 INFO - 'USER': 'cltbld', 13:56:56 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1477515358.39564-769620550', 13:56:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:56 INFO - '_': '/tools/buildbot/bin/python'} 13:56:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 13:56:56 INFO - mozversion application_buildid: 20161026103002 13:56:56 INFO - mozversion application_changeset: d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 13:56:56 INFO - mozversion application_display_name: Nightly 13:56:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:56:56 INFO - mozversion application_name: Firefox 13:56:56 INFO - mozversion application_remotingname: firefox 13:56:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:56:56 INFO - mozversion application_vendor: Mozilla 13:56:56 INFO - mozversion application_version: 52.0a1 13:56:56 INFO - mozversion platform_buildid: 20161026103002 13:56:56 INFO - mozversion platform_changeset: d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 13:56:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:56:56 INFO - mozversion platform_version: 52.0a1 13:56:56 INFO - using testdate: 1477515416 13:56:56 INFO - actual date: 1477515416 13:56:56 INFO - starting webserver on 'localhost:45355' 13:56:56 INFO - SUITE-START | Running 2 tests 13:56:56 INFO - TEST-START | dromaeo_css 13:56:56 INFO - operating with platform_type : linux_ 13:56:56 INFO - Initialising browser for dromaeo_css test... 13:56:56 INFO - TEST-INFO | started process 2864 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ9q86s/profile http://localhost:45355/getInfo.html) 13:57:01 INFO - PROCESS | 2864 | __metrics Screen width/height:1600/1200 13:57:01 INFO - PROCESS | 2864 | colorDepth:24 13:57:01 INFO - PROCESS | 2864 | Browser inner width/height: 1024/697 13:57:01 INFO - PROCESS | 2864 | __metrics 13:57:01 INFO - PROCESS | 2864 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:57:01 INFO - PROCESS | 2864 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:57:02 INFO - PROCESS | 2864 | console.error: PushService: 13:57:02 INFO - PROCESS | 2864 | stateChangeProcessEnqueue: Error transitioning state 13:57:02 INFO - PROCESS | 2864 | UnknownError 13:57:03 INFO - TEST-INFO | 2864: exit 0 13:57:03 INFO - Browser initialized. 13:57:03 INFO - Running cycle 1/1 for dromaeo_css test... 13:57:03 INFO - TEST-INFO | started process 2969 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ9q86s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:57:15 INFO - PROCESS | 2969 | RSS: Main: 171745280 13:57:15 INFO - PROCESS | 2969 | 13:58:06 INFO - PROCESS | 2969 | 1477515486922 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] 14:00:18 INFO - PROCESS | 2969 | Cycle 1(1): loaded http://localhost:45355/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45355/tests/dromaeo/cssquery-ext.html) 14:00:19 INFO - PROCESS | 2969 | RSS: Main: 315248640 14:00:19 INFO - PROCESS | 2969 | 14:03:22 INFO - PROCESS | 2969 | Cycle 1(1): loaded http://localhost:45355/tests/dromaeo/cssquery-ext.html (next: http://localhost:45355/tests/dromaeo/cssquery-jquery.html) 14:03:23 INFO - PROCESS | 2969 | RSS: Main: 285077504 14:03:23 INFO - PROCESS | 2969 | 14:06:25 INFO - PROCESS | 2969 | Cycle 1(1): loaded http://localhost:45355/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45355/tests/dromaeo/cssquery-mootools.html) 14:06:25 INFO - PROCESS | 2969 | RSS: Main: 252116992 14:06:25 INFO - PROCESS | 2969 | 14:09:27 INFO - PROCESS | 2969 | Cycle 1(1): loaded http://localhost:45355/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45355/tests/dromaeo/cssquery-prototype.html) 14:09:28 INFO - PROCESS | 2969 | RSS: Main: 284635136 14:09:28 INFO - PROCESS | 2969 | 14:12:31 INFO - PROCESS | 2969 | Cycle 1(1): loaded http://localhost:45355/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45355/tests/dromaeo/cssquery-yui.html) 14:12:31 INFO - PROCESS | 2969 | RSS: Main: 215564288 14:12:31 INFO - PROCESS | 2969 | 14:15:34 INFO - PROCESS | 2969 | Cycle 1(1): loaded http://localhost:45355/tests/dromaeo/cssquery-yui.html (next: http://localhost:45355/tests/dromaeo/cssquery-dojo.html) 14:15:34 INFO - PROCESS | 2969 | RSS: Main: 309248000 14:15:34 INFO - PROCESS | 2969 | 14:15:34 INFO - PROCESS | 2969 | __start_tp_report 14:15:34 INFO - PROCESS | 2969 | _x_x_mozilla_page_load 14:15:34 INFO - PROCESS | 2969 | _x_x_mozilla_page_load_details 14:15:34 INFO - PROCESS | 2969 | |i|pagename|runs| 14:15:34 INFO - PROCESS | 2969 | |0;dojo.html;3040.1335619348483;3070.2631368471575;3080.0913730449515;3101.410731960929;3125.9531107033386;5278.9208161877605;5297.178937264721;5341.679499230049;5372.865678358043;5409.783608655654;5262.973685131569;5310.230016647583;5325.733713314338;5374.677519348842;5409.107497262947;4873.098476781798;4883.072216278913;4884.902301953959;4900.0689868924965;4967.627427942901;4382.510841895716;4912.48418916014;4933.703977761345;4968.503149685039;4973.975130124344;4939.3578834751615;4958.231474121499;4961.3798275215595;4996.950030499703;5020.949790502084;4792.664513484057;4845.27320901864;4848.0788650156355;4900.877478063041;4986.5761410280165;4789.090072886141;4807.855764327076;4834.613230941552;4880.902381952341;4891.290762839404;5241.213817927303;5317.042932272189;5319.414864364917;5333.893322133575;5372.946270537283;5690.772369105231;5699.857503562403;5704.942950570483;5705.800296989585;5767.942320576783;5618.269624948772;5653.1520271959125;5668.546516278688;5737.512311453532;5745.798897038625;5339.572834173296;5351.732413379315;5352.785888564453;5354.892902141974;5355.062863998784;5757.050086735641;5828.067509198508;5828.941710582924;5831.533477321804;5831.562632802556;5554.472325129187;5588.888222235614;5602.551795856321;5604.775808967595;5605.243292155506;5667.6316039458125;5680.715964201856;5681.0910254359105;5685.772569097273;5686.772529098873;5674.460926212003;5687.146927960756;5691.004074286983;5692.345380281238;5693.259876216065;5684.857878552986;5690.061139911951;5711.485966263056;5719.142128680731;5736.426357364314;4256.7445953242905;4309.159713855768;4310.288802347577;4314.288142456459;4357.063231405263;3835.36716441784;3861.613838616172;3890.6498415142205;3933.7443066200603;3944.585818489075;5403.972980135074;5459.972700136554;5473.480019398151;5477.178423236546;5481.890362192814;5784.132380143013;5791.652500849962;5801.419858014165;5807.361190269152;5816.592838501264;5272.710000949908;5334.493223143795;5461.0716178249795;5470.234167216593;5471.562275017989;4806.086843499794;4846.127697014571;4861.149298872683;4862.854114376574;4903.166461701519;5872;5872.060470324727;5876.853078672982;5913.940860591425;5945.881082378328;5735.7705691773535;5746.741396637245;5749.885002299847;5751.338596061507;5752.942470575241;5735.254416925773;5818.73815678304;5861.1501332305725;5878.647281163144;5885.588008839341;5615.213870058276;5629.211910332639;5637.098064309691;5653.095504719389;5689.34572524165;5666.744996475086;5671.943280567307;5672.7730890763905;5699.572532060195;5730.398308177748;5370.3287089113865;5490.121580547093;5522.641028333145;5527;5537.861553461195;5507.284053073236;5623.044082506066;5624.943750562442;5630.690312032713;5688.886222275614;5592.972035139798;5608.158776183605;5614.63504872182;5615.803446879339;5620.044592419216;5539.944600554104;5626.35296940857;5636.746346414339;5638.351589567253;5638.379778224474;5463.207834863843;5474.124140137559;5483.725813709379;5488.368837583729;5539.861503462445 14:15:34 INFO - PROCESS | 2969 | |1;ext.html;552.9167100959417;595.7378753348527;612.868233329834;636.3827087724906;640.9647469389182;31821.68178318216;43565.34651980219;44424.8911375192;44469.332960005624;44488.77755611222;44911;45262.77368613161;45340.54659453405;45358.09283814322;45412.772936135356;7986.2013798620255;8184.508929464251;8829.779255518599;8982.236509896667;8996.8650470243;10423.27037107399;10692.839607405895;10694.037536621703;11086;11096.167787415936;10816.134709223243;10890.61882834101;10899.073578745816;10905.400202988832;10908.50911708975;10686.091682207021;10718.196135289885;10735;10740.570377184904;10751.354918704903;10604.151667866552;10642.09542188915;10661.093807026335;10675.572977080907;10682.73293167677;42506;42657.36013959793;42872.78563607193;42879.785601071795;42917;3284.310294838087;3480.1647604574973;3525.4359302511475;3536.6286539913194;3778.735488515805;31567.210819729462;32300.83849580737;32741.6725832741;32949.50575741342;33810.32379352399;4236.449261596003;4247.511536173318;4414.735115893057;4421.867343979686;4511.300748384006;321292;322268;322683;323264;325048;33977.83011084978;57875.71062144746;58359;58382.70808645929;58422.41577584255;34941.825290873385;36724.44913326302;36729.08177295589;36730.44904326437;36731.26537469289;12942.417591208417;13065.412056457291;13077.280749558866;13151.934240328737;13167.868321316855;9355.4386736796;9568.521573921276;9658.3722058066;9869.851952220723;10597.099246563974;8107.756767296873;8134.877976830352;8194.139615340422;8243.752687419386;8293.502389856629;2945.1900727300163;3090.258337998909;3093.9845300773354;3239.3845169417737;3253.6746325367276;944.504135328944;951.538503825644;1015.6902144845745;1027.2706378471219;1027.5889644142403;32074.35851283008;32090.518642220384;32383;32400.67599324024;32857.50713739296;1084.5715942202785;1100.708312297242;1101.9063379612824;1110.4614262082882;1112.9443527823576;15633.218339083;16898;16939.237734301987;16941.407050753165;16985.830141698672;448305;451184;453346;453528;453530;58837.41162588405;59180.40819591835;59316;59371;59390.10914836281;1211.2974474804591;1240.7456471423336;1288.9935550322189;1336.9799453008213;1344.3345543956;31056.68943310538;32399.352012959138;33091.172720681214;33141.91550983663;33690.83154584211;50136;50514.49485505098;50690.493095068574;50700.49299506958;50728;384714;385942;386738;386776;465474;40065.1986960265;42390;42776;43088;43552.78223608862;46095.76952115218;46198.30702539532;46855.53144468512;46909.76545117389;48423;39746.2050758989;41007;41117;41457.58542414658;42857;39664.80167599144;40072.59927400688;41533;41889;41941.161176776906;40891.59108408997;41407.171856563305;42188.367174491796;42399.5760042408;42601.14797703967;31751.682483175795;35544.46683299804;36430.63569364379;38742.61257387503;39411.802940985115;27510.587341189497;27951;28063.438731224855;28260.293492662848;28271.43457130887 14:15:34 INFO - PROCESS | 2969 | |2;jquery.html;371.392772816445;378.77841462744294;386.3856468215537;395.70124555960246;416.56468989905545;14120.293985300732;15750.606234844134;18586.34947776828;19171.61656766864;19193;18457.446276611725;18490.260389584433;18604.813951860477;18740.156692948814;18744.43766686998;4142.772147531885;5472.5074743273;5687.601867869251;5688.63023903447;5694.117411801178;4220.894477638069;6025.758969641209;6191.04038873973;6317.305096439388;6440.903386449184;6147.47746441553;6261.46777523911;6274.341194174614;6388.488920886318;6397.808065758035;6260.7808726694575;6288.371162883721;6289.559730818844;6290.056491526262;6290.685465726719;5305.602079844027;5525.198846167324;5537.418571050022;5567.944320556783;5569.693666848321;18159.909200453912;18257.360992365204;21322.68015979746;22560;22841.31476055721;2269.6368581026954;2279.6124658808044;2486.639437281584;3044.558539011853;3072.1705139612404;13011.86988130116;14310.928445357811;14607.853921460755;14671.119732816065;14813.925930370388;1875.5123667846458;1890.3478299986482;1932.6134773045446;1958.3341663834221;1974.99012504938;78782.60608696977;80724.59637701833;82207.58896205481;82786;83279;10015;10226.693199204035;10281.485925703684;10633.680989570325;10772.461376931122;14724.116553006854;14856.182909940057;14864.628384290263;14921.776173357408;14925.70148597022;7164.785056448315;7180.461465390116;7287.089113860768;7373;7444.367228785505;6764.154480689914;6817.659117044128;6947.930520694829;6961.129858767654;6965.79102626922;6214.8135555933395;6401.871962560723;6411.294757576663;6491.253505846794;6553.279139294674;1844.981550184481;1854.9519521470327;1862.990685046566;1913.894735789545;1961.9705704414446;929.7402020262582;963.3208587945481;992.4491906991544;1046.3146638951498;1050.9632162874416;18472.353467628567;19380.515487112654;19395.8060419394;19452.124654390587;19816.20735170606;988.6786794291884;1012.7012531303283;1050.3172937590627;1052.768390953989;1058.523664351045;9965.453891928615;10357.171426285879;10980.780384392267;10988.945055274673;11162.107031437465;437701;452324;464185;465848;467670;82698.17301826905;82833.17166828255;83319;83591.5820420894;84657.57671211605;966.1449617088787;975.8341082016075;989.4762066417636;989.8465737810651;1008.621766837436;16315.347386104897;16531.504054878373;17065.317387304367;17104.230309636347;17329.913350433166;36833.63166368302;38559;38946.6105338943;40554.1889162221;42092.15815683608;50881.49118508916;52797.472025279254;52927;56229.43770562242;56424.43575564192;8113.797155070934;8168.897198878075;8516.574171291535;8556.18716221958;8683.131686831266;11258.38078905668;12504.437300321326;12728.427220774902;12793.424295906892;13040.934795325962;10476.323788193853;10727.839082413613;10758.085562726943;11138.331700097697;11154.274972126786;10575.524101415609;10772.360771611005;10919.890801092206;11012.834807477733;11298.60454884108;10263.076323130954;10420.68737937863;10653.627123050655;10744.946275268574;11007.119430445386;8240.464369815943;8242.134575869448;8251.95874020626;8271.586420679063;8640.839790052487;7989.161138080651;9965.35225210359;10147.847782283125;10235.948820255851;10266 14:15:34 INFO - PROCESS | 2969 | |3;mootools.html;1328.136711137761;1423.1390009044528;1499.1379956525;1562.9996802046692;1738.4697667211497;7511.62441877906;8128.67485300588;8374.995000599929;8442.240198382144;8446.028706698717;8237.794055148624;8365.874511882326;8367.205115514016;8589.355798315135;8633.179847914455;2287.325239054483;2324.8605083694947;2326.8254880884;2330.778576035274;2333.3000099970027;2246.7303923529116;2294.0823670531754;2347.929562113131;2350.659154422616;2352.047420794581;2236.3514580771557;2257.0858802185057;2275.8293128015384;2277.2940388479624;2277.635578307471;2241.977580224201;2267;2297.5290065536524;2298.643710224918;2301.1255722825385;2241.7758224177614;2251.5046689728233;2256.8533045352;2264.6603009548535;2265.9433514162115;8510.191531804468;8561.785955351104;8563.828723425559;8566.657333706644;8569.528675922822;4921.876953076166;5051.570616497602;5081.288619593223;5149.330587023663;5149.9485005149845;3187.7449804015623;3317.784344017631;3422.4524076147695;3476.7392445566684;3480.843362048714;1088.5264909764278;1100.6367898593444;2077.958440831175;2116.714243577113;2140.0953151695003;11588.304701717923;11688.240264382788;11777.882221177764;11781;11789.941050294694;4401.801918913657;4505.121501307213;4561.589456948891;4577.176108300538;4630.166570017362;10196.592136314614;10198.337108088099;10203.642872499428;10206;10207.132393746615;5181.0415073210825;5182.689038657617;5182.948170518322;5189.6886186828915;5190.24741412493;4067.6949228807957;4186.35111557709;4525.343825145335;4581.816727330936;4600.470945841271;3752.4746535485056;3911.5697273299916;3924.764514129104;3956.248312820555;4000.5399379071196;1274.4328773695802;1288.606974872673;1306.392527474729;1319.64369620202;1323.6426164935413;738.9963050184822;811.5171472973572;896.3456676626099;943.1558754914313;963.7397902566267;5589.636673616202;5607.43925607436;5799.4780469757925;5868.823935281948;6028.819135425944;913.1097180249336;924.8589515272123;950.2587981374539;988.0584651160505;1005.4218824176128;3604.6034936157002;3811.5235595550557;3843.5003449551377;3952.7628342299554;3998.540167880731;10477.580896764197;10622.840657390145;10745;10850.53517775106;10856.2400631955;10089.394636321844;10353.896461035443;10518.73703157412;10770.730731731614;10776.461176941122;7920.32677222431;7956.2441568050945;8058.959705201437;8122.147174546588;8144.83710325802;5479.589030822624;5574.108142697149;5593.384727679871;5737.684427356368;5747.856303592276;9711.66009189675;9729.756756081155;9775.608975640895;9854.359466634645;9871.457069860939;9628.855567166638;9971.40171589707;10126.341787783771;10133.290669653054;10140;7022.43820494349;7198.280171982759;7434.368078713153;7668.501547399401;7833;8055.3152981994845;8465.153484651486;8466.322694184573;8469.110743372104;8482.957585212034;7310.6710198040155;7337.486375953846;7440.144383395762;7622.961885190539;7820;7457.589832559044;7515.361194298327;7530.472866899265;7578.43161762881;7768.84462310762;6393.488520918222;6485.77299794505;6488.124103246001;6488.221413430419;6488.318726533646;4681.250999840009;4708.340832283551;4751.453582837879;4766.45185803637;4847.2729090636685;4857.344258525195;4939.481354457874;4978.352814134139;5046.21783623539;5071.644984851025 14:15:34 INFO - PROCESS | 2969 | |4;prototype.html;294.75829819547965;312.30823725448136;319.640404544887;319.6579659764052;325.16270603196773;4738.597219236361;5082.822101226458;5169.948300516999;5249.370075590925;5256.211568264762;5115.309433226514;5210.609204309673;5226.947730522694;5230.712310822903;5231.424543300234;4103.4460347852955;4104.932717493458;4112.506499220083;4112.547619761839;4118.6499147572495;3893.5717071122294;4098.385242213662;4116.279651061067;4118.732282401635;4120.072983578686;3817.6945844332527;3982.780947047911;4012.498437695288;4018.9397159042637;4027.536833264183;3974.423708562242;3999.6201310547813;4001.8599349022643;4011.899702507417;4016.1766837798327;3530.570119101768;3532.9293414131575;3533.3993221152464;3548;3552.7335449841366;4859.975700121512;4992.525710057539;5060;5062.417821950486;5070.630929649011;4549.181147393468;4585.954140458586;4604.608608268301;4613.723176609415;4622.583967442913;5354.866128346784;5391.865203369908;5415.458454154593;5419.187121931703;5455.290812194429;3650.1604630934767;3823.9426408603613;3868.303705333039;3873.5545412277384;3941.113249518864;5391.838244852661;5522.337319521683;5637.041702910474;5667.271482197928;5675.801346952878;3821.5796262411113;3918.2555314490155;3919.490466239428;3923.058465968147;3925.430812532167;3957.683385329167;3971.9801400993388;3976.6023397660583;3989.880303590897;4000.879973600797;4585.656075794329;4592.311153327028;4594.839180628662;4605;4613.677042606985;5286.233496143038;5461.617686761889;5465.829818705141;5522.337319521683;5532.253145825262;1377.8484366719854;1394.588596364075;1395.155930661935;1395.3441882315296;1398.8181536400202;833.4082801211086;876.6805957034622;877.2280393253895;879.859222524393;885.2386947225381;4705.741184234831;4712.69367491112;4719.976400117977;4726.747411935839;4727.7163370197895;4917.459079501252;4936.950630493649;4936.975315123402;4968.8757781055765;4968.999955036158;4413.823447062082;4711.453447423253;4736.668433209711;4738.620910327166;4739.597134243559;2637.230907547068;2643.7442214947746;2646.5897785843226;2654.2170059832397;2667.479841430941;4998.625103117281;5058.280184737134;5072.847814565569;5088.389393272757;5101.69389836611;4843.467218605951;5049.722265275372;5052.469490703496;5057.898842023139;5090.643654944119;4982.039513071185;4989.201727723546;5005.696240481265;5007.974960125176;5033.622478314068;4922.360093187863;4923.803047878188;4943.530364615356;4962.851114466572;4976.900461990812;4461.412380819182;4799.520047995173;4877.170880950176;4883.487233840396;4910.656254062182;4987.680728461283;5000.299958005955;5509.944900550943;5605.467480589337;5701.543876489954;3955.2089582084272;3973.523177218752;3984.1234928315725;3985.6811455084103;3994.121293315466;5633.676086119676;5651.321841378896;5665.66006039639;5665.801696940587;5689.8862022758485;5300.469953004668;5358.223057656696;5401.351837779492;5428.891422171613;5528.419515950767;5388.407275199804;5388.649737767033;5390.250972004228;5405.891792182514;5444.537214336826;5472.480114389126;5482.917756233739;5483.095289277225;5483.2049352844415;5483.533899618577;5279.604029697711;5548.778048878;5558.277423934863;5586.720663966867;5588.38527761954;5459.754311055933;5468.593818719751;5471.781128754806;5483.424240454854;5490.313710786152 14:15:34 INFO - PROCESS | 2969 | |5;yui.html;698.1831257428807;698.6017969757237;751.3313151295348;793.6785601831259;805.9435839491234;13552.457901683933;14336.211508367061;14535.709285814277;14540.418383264656;14559.12645241285;13341.733165336711;14203.78694319586;14494.927525362385;14790.852091479082;15296.770548441782;797.9800504987393;817.5380909785981;817.7546735979212;818.4598165210962;818.5661599352353;670.9731610735565;687.9140107486564;809.951402915824;813.3452570680599;813.6094674556217;716.8637958787814;719.1442183801286;719.2843121094492;824.1840577827967;854.4915775113828;842.1452225990624;845.3701992015988;846.2045677063602;846.3736834742247;846.4921047371589;615.8552740106071;617.9165812615284;618.11300783376;618.2889676871589;618.3198481670172;10659.413732244724;10927.071198948099;14357.712845743026;14452.855471445257;14512;13169.670758231025;13844.30778461073;13869.37587808551;14134;14192.787108193384;10930.344179349264;11044.668659940215;11212.663620091329;11395.829062564067;11503.641753440525;3675.4119340905595;3721.5906250312446;3723.553173619183;3781.773093614392;3824.5028146341074;65356.673216633615;66698.3330166697;67251.66374168146;67445.66277168583;67955.32044679589;9499.667511637059;9625;9647.421154730739;10208;10366.326188797704;17146.485605431855;17191.398301059653;17287.39494117725;18781.24875005012;18844.623107537773;7254.455915806336;7363.337299643058;7470.887936680954;7474.85050298991;7729.265719756614;4313.9137217255475;4415.6909016368545;4476.35092911526;4538.682292239578;4588.059447813191;3536.2750636119536;3658.32321020612;3663.5603727552866;3664.5419322584676;3664.59689434162;533.2720836058752;543.7471575717232;559.194759546252;559.8404454730382;565.9575531835129;680.3944489404435;684.4626967830229;719.9496035277481;729.4128226777389;737.2332773915175;8568.400211985101;8759.2992560595;8848.778780530409;9170.403923744936;9209.401388909699;541.6452223793422;598.509222437597;619.9925121677275;686.361683634225;719.3202423709545;4200.726952748123;4421.46942366918;4425.579569940851;4441.20058389493;4460.487043989918;63036.68481657654;90894;91044;91885;91895.54052229696;73250;73409;74221;74597.62701186459;75428.62285688537;67479;68089.65955170193;68541.65729171323;71285;72029.63985179935;8417.579121044046;8656.264217541328;8814.471131732116;8870.86693699582;8886.333524985781;47410.28884566803;47449.52550474589;48465.75767121283;48565.5143448561;49926.25110623271;60865.08702369557;62153;63305.68347158235;64727.352726472134;65135;10970.890291096986;11180.496877640364;11198.720031998939;11629.360385178896;11737.354445505238;11547.97168703869;11926.165168438127;11959.222650527689;12387.62837114888;12536.310502922426;11260.324380537195;11979.520819167135;12030.75938481243;12214.694632634255;12433.191842530206;11283.66149015531;11284.7743045137;11585.274976402072;11605.941970290432;12137.332446715516;11425.143114266297;11433.485493152662;11708.70728231801;11864.466099025392;12526.686832828887;9634.71095867125;9705.320627556286;9721.513924303898;9842.163416109424;10084;9574.856377154487;10062.345947513388;10208.489575521342;10372.377657340583;10376.429296388771 14:15:34 INFO - PROCESS | 2969 | __end_tp_report 14:15:34 INFO - PROCESS | 2969 | __start_cc_report 14:15:34 INFO - PROCESS | 2969 | _x_x_mozilla_cycle_collect,1323 14:15:34 INFO - PROCESS | 2969 | __end_cc_report 14:15:34 INFO - PROCESS | 2969 | __startTimestamp1477516534818__endTimestamp 14:15:34 INFO - PROCESS | 2969 | 14:15:34 INFO - PROCESS | 2969 | ------- Summary: start ------- 14:15:34 INFO - PROCESS | 2969 | Number of tests: 6 14:15:34 INFO - PROCESS | 2969 | 14:15:34 INFO - PROCESS | 2969 | [#0] dojo.html Cycles:165 Average:5305.74 Median:5522.64 stddev:603.41 (10.9%) stddev-sans-first:578.50 14:15:34 INFO - PROCESS | 2969 | Values: 3040.1 3070.3 3080.1 3101.4 3126.0 5278.9 5297.2 5341.7 5372.9 5409.8 5263.0 5310.2 5325.7 5374.7 5409.1 4873.1 4883.1 4884.9 4900.1 4967.6 4382.5 4912.5 4933.7 4968.5 4974.0 4939.4 4958.2 4961.4 4997.0 5020.9 4792.7 4845.3 4848.1 4900.9 4986.6 4789.1 4807.9 4834.6 4880.9 4891.3 5241.2 5317.0 5319.4 5333.9 5372.9 5690.8 5699.9 5704.9 5705.8 5767.9 5618.3 5653.2 5668.5 5737.5 5745.8 5339.6 5351.7 5352.8 5354.9 5355.1 5757.1 5828.1 5828.9 5831.5 5831.6 5554.5 5588.9 5602.6 5604.8 5605.2 5667.6 5680.7 5681.1 5685.8 5686.8 5674.5 5687.1 5691.0 5692.3 5693.3 5684.9 5690.1 5711.5 5719.1 5736.4 4256.7 4309.2 4310.3 4314.3 4357.1 3835.4 3861.6 3890.6 3933.7 3944.6 5404.0 5460.0 5473.5 5477.2 5481.9 5784.1 5791.7 5801.4 5807.4 5816.6 5272.7 5334.5 5461.1 5470.2 5471.6 4806.1 4846.1 4861.1 4862.9 4903.2 5872.0 5872.1 5876.9 5913.9 5945.9 5735.8 5746.7 5749.9 5751.3 5752.9 5735.3 5818.7 5861.2 5878.6 5885.6 5615.2 5629.2 5637.1 5653.1 5689.3 5666.7 5671.9 5672.8 5699.6 5730.4 5370.3 5490.1 5522.6 5527.0 5537.9 5507.3 5623.0 5624.9 5630.7 5688.9 5593.0 5608.2 5614.6 5615.8 5620.0 5539.9 5626.4 5636.7 5638.4 5638.4 5463.2 5474.1 5483.7 5488.4 5539.9 14:15:34 INFO - PROCESS | 2969 | 14:15:34 INFO - PROCESS | 2969 | [#1] ext.html Cycles:180 Average:55446.96 Median:386340.00 stddev:104647.99 (27.1%) stddev-sans-first:104860.39 14:15:34 INFO - PROCESS | 2969 | Values: 552.9 595.7 612.9 636.4 641.0 31821.7 43565.3 44424.9 44469.3 44488.8 44911.0 45262.8 45340.5 45358.1 45412.8 7986.2 8184.5 8829.8 8982.2 8996.9 10423.3 10692.8 10694.0 11086.0 11096.2 10816.1 10890.6 10899.1 10905.4 10908.5 10686.1 10718.2 10735.0 10740.6 10751.4 10604.2 10642.1 10661.1 10675.6 10682.7 42506.0 42657.4 42872.8 42879.8 42917.0 3284.3 3480.2 3525.4 3536.6 3778.7 31567.2 32300.8 32741.7 32949.5 33810.3 4236.4 4247.5 4414.7 4421.9 4511.3 321292.0 322268.0 322683.0 323264.0 325048.0 33977.8 57875.7 58359.0 58382.7 58422.4 34941.8 36724.4 36729.1 36730.4 36731.3 12942.4 13065.4 13077.3 13151.9 13167.9 9355.4 9568.5 9658.4 9869.9 10597.1 8107.8 8134.9 8194.1 8243.8 8293.5 2945.2 3090.3 3094.0 3239.4 3253.7 944.5 951.5 1015.7 1027.3 1027.6 32074.4 32090.5 32383.0 32400.7 32857.5 1084.6 1100.7 1101.9 1110.5 1112.9 15633.2 16898.0 16939.2 16941.4 16985.8 448305.0 451184.0 453346.0 453528.0 453530.0 58837.4 59180.4 59316.0 59371.0 59390.1 1211.3 1240.7 1289.0 1337.0 1344.3 31056.7 32399.4 33091.2 33141.9 33690.8 50136.0 50514.5 50690.5 50700.5 50728.0 384714.0 385942.0 386738.0 386776.0 465474.0 40065.2 42390.0 42776.0 43088.0 43552.8 46095.8 46198.3 46855.5 46909.8 48423.0 39746.2 41007.0 41117.0 41457.6 42857.0 39664.8 40072.6 41533.0 41889.0 41941.2 40891.6 41407.2 42188.4 42399.6 42601.1 31751.7 35544.5 36430.6 38742.6 39411.8 27510.6 27951.0 28063.4 28260.3 28271.4 14:15:34 INFO - PROCESS | 2969 | 14:15:34 INFO - PROCESS | 2969 | [#2] jquery.html Cycles:180 Average:27493.61 Median:375.09 stddev:75449.60 (20115.3%) stddev-sans-first:75633.77 14:15:34 INFO - PROCESS | 2969 | Values: 371.4 378.8 386.4 395.7 416.6 14120.3 15750.6 18586.3 19171.6 19193.0 18457.4 18490.3 18604.8 18740.2 18744.4 4142.8 5472.5 5687.6 5688.6 5694.1 4220.9 6025.8 6191.0 6317.3 6440.9 6147.5 6261.5 6274.3 6388.5 6397.8 6260.8 6288.4 6289.6 6290.1 6290.7 5305.6 5525.2 5537.4 5567.9 5569.7 18159.9 18257.4 21322.7 22560.0 22841.3 2269.6 2279.6 2486.6 3044.6 3072.2 13011.9 14310.9 14607.9 14671.1 14813.9 1875.5 1890.3 1932.6 1958.3 1975.0 78782.6 80724.6 82207.6 82786.0 83279.0 10015.0 10226.7 10281.5 10633.7 10772.5 14724.1 14856.2 14864.6 14921.8 14925.7 7164.8 7180.5 7287.1 7373.0 7444.4 6764.2 6817.7 6947.9 6961.1 6965.8 6214.8 6401.9 6411.3 6491.3 6553.3 1845.0 1855.0 1863.0 1913.9 1962.0 929.7 963.3 992.4 1046.3 1051.0 18472.4 19380.5 19395.8 19452.1 19816.2 988.7 1012.7 1050.3 1052.8 1058.5 9965.5 10357.2 10980.8 10988.9 11162.1 437701.0 452324.0 464185.0 465848.0 467670.0 82698.2 82833.2 83319.0 83591.6 84657.6 966.1 975.8 989.5 989.8 1008.6 16315.3 16531.5 17065.3 17104.2 17329.9 36833.6 38559.0 38946.6 40554.2 42092.2 50881.5 52797.5 52927.0 56229.4 56424.4 8113.8 8168.9 8516.6 8556.2 8683.1 11258.4 12504.4 12728.4 12793.4 13040.9 10476.3 10727.8 10758.1 11138.3 11154.3 10575.5 10772.4 10919.9 11012.8 11298.6 10263.1 10420.7 10653.6 10744.9 11007.1 8240.5 8242.1 8252.0 8271.6 8640.8 7989.2 9965.4 10147.8 10235.9 10266.0 14:15:34 INFO - PROCESS | 2969 | 14:15:34 INFO - PROCESS | 2969 | [#3] mootools.html Cycles:180 Average:5631.66 Median:4729.90 stddev:3169.36 (67.0%) stddev-sans-first:3161.75 14:15:34 INFO - PROCESS | 2969 | Values: 1328.1 1423.1 1499.1 1563.0 1738.5 7511.6 8128.7 8375.0 8442.2 8446.0 8237.8 8365.9 8367.2 8589.4 8633.2 2287.3 2324.9 2326.8 2330.8 2333.3 2246.7 2294.1 2347.9 2350.7 2352.0 2236.4 2257.1 2275.8 2277.3 2277.6 2242.0 2267.0 2297.5 2298.6 2301.1 2241.8 2251.5 2256.9 2264.7 2265.9 8510.2 8561.8 8563.8 8566.7 8569.5 4921.9 5051.6 5081.3 5149.3 5149.9 3187.7 3317.8 3422.5 3476.7 3480.8 1088.5 1100.6 2078.0 2116.7 2140.1 11588.3 11688.2 11777.9 11781.0 11789.9 4401.8 4505.1 4561.6 4577.2 4630.2 10196.6 10198.3 10203.6 10206.0 10207.1 5181.0 5182.7 5182.9 5189.7 5190.2 4067.7 4186.4 4525.3 4581.8 4600.5 3752.5 3911.6 3924.8 3956.2 4000.5 1274.4 1288.6 1306.4 1319.6 1323.6 739.0 811.5 896.3 943.2 963.7 5589.6 5607.4 5799.5 5868.8 6028.8 913.1 924.9 950.3 988.1 1005.4 3604.6 3811.5 3843.5 3952.8 3998.5 10477.6 10622.8 10745.0 10850.5 10856.2 10089.4 10353.9 10518.7 10770.7 10776.5 7920.3 7956.2 8059.0 8122.1 8144.8 5479.6 5574.1 5593.4 5737.7 5747.9 9711.7 9729.8 9775.6 9854.4 9871.5 9628.9 9971.4 10126.3 10133.3 10140.0 7022.4 7198.3 7434.4 7668.5 7833.0 8055.3 8465.2 8466.3 8469.1 8483.0 7310.7 7337.5 7440.1 7623.0 7820.0 7457.6 7515.4 7530.5 7578.4 7768.8 6393.5 6485.8 6488.1 6488.2 6488.3 4681.3 4708.3 4751.5 4766.5 4847.3 4857.3 4939.5 4978.4 5046.2 5071.6 14:15:34 INFO - PROCESS | 2969 | 14:15:34 INFO - PROCESS | 2969 | [#4] prototype.html Cycles:180 Average:4416.77 Median:4930.38 stddev:1283.83 (26.0%) stddev-sans-first:1249.60 14:15:34 INFO - PROCESS | 2969 | Values: 294.8 312.3 319.6 319.7 325.2 4738.6 5082.8 5169.9 5249.4 5256.2 5115.3 5210.6 5226.9 5230.7 5231.4 4103.4 4104.9 4112.5 4112.5 4118.6 3893.6 4098.4 4116.3 4118.7 4120.1 3817.7 3982.8 4012.5 4018.9 4027.5 3974.4 3999.6 4001.9 4011.9 4016.2 3530.6 3532.9 3533.4 3548.0 3552.7 4860.0 4992.5 5060.0 5062.4 5070.6 4549.2 4586.0 4604.6 4613.7 4622.6 5354.9 5391.9 5415.5 5419.2 5455.3 3650.2 3823.9 3868.3 3873.6 3941.1 5391.8 5522.3 5637.0 5667.3 5675.8 3821.6 3918.3 3919.5 3923.1 3925.4 3957.7 3972.0 3976.6 3989.9 4000.9 4585.7 4592.3 4594.8 4605.0 4613.7 5286.2 5461.6 5465.8 5522.3 5532.3 1377.8 1394.6 1395.2 1395.3 1398.8 833.4 876.7 877.2 879.9 885.2 4705.7 4712.7 4720.0 4726.7 4727.7 4917.5 4937.0 4937.0 4968.9 4969.0 4413.8 4711.5 4736.7 4738.6 4739.6 2637.2 2643.7 2646.6 2654.2 2667.5 4998.6 5058.3 5072.8 5088.4 5101.7 4843.5 5049.7 5052.5 5057.9 5090.6 4982.0 4989.2 5005.7 5008.0 5033.6 4922.4 4923.8 4943.5 4962.9 4976.9 4461.4 4799.5 4877.2 4883.5 4910.7 4987.7 5000.3 5509.9 5605.5 5701.5 3955.2 3973.5 3984.1 3985.7 3994.1 5633.7 5651.3 5665.7 5665.8 5689.9 5300.5 5358.2 5401.4 5428.9 5528.4 5388.4 5388.6 5390.3 5405.9 5444.5 5472.5 5482.9 5483.1 5483.2 5483.5 5279.6 5548.8 5558.3 5586.7 5588.4 5459.8 5468.6 5471.8 5483.4 5490.3 14:15:34 INFO - PROCESS | 2969 | 14:15:34 INFO - PROCESS | 2969 | [#5] yui.html Cycles:180 Average:17470.09 Median:559.52 stddev:23721.83 (4239.7%) stddev-sans-first:23754.94 14:15:34 INFO - PROCESS | 2969 | Values: 698.2 698.6 751.3 793.7 805.9 13552.5 14336.2 14535.7 14540.4 14559.1 13341.7 14203.8 14494.9 14790.9 15296.8 798.0 817.5 817.8 818.5 818.6 671.0 687.9 810.0 813.3 813.6 716.9 719.1 719.3 824.2 854.5 842.1 845.4 846.2 846.4 846.5 615.9 617.9 618.1 618.3 618.3 10659.4 10927.1 14357.7 14452.9 14512.0 13169.7 13844.3 13869.4 14134.0 14192.8 10930.3 11044.7 11212.7 11395.8 11503.6 3675.4 3721.6 3723.6 3781.8 3824.5 65356.7 66698.3 67251.7 67445.7 67955.3 9499.7 9625.0 9647.4 10208.0 10366.3 17146.5 17191.4 17287.4 18781.2 18844.6 7254.5 7363.3 7470.9 7474.9 7729.3 4313.9 4415.7 4476.4 4538.7 4588.1 3536.3 3658.3 3663.6 3664.5 3664.6 533.3 543.7 559.2 559.8 566.0 680.4 684.5 719.9 729.4 737.2 8568.4 8759.3 8848.8 9170.4 9209.4 541.6 598.5 620.0 686.4 719.3 4200.7 4421.5 4425.6 4441.2 4460.5 63036.7 90894.0 91044.0 91885.0 91895.5 73250.0 73409.0 74221.0 74597.6 75428.6 67479.0 68089.7 68541.7 71285.0 72029.6 8417.6 8656.3 8814.5 8870.9 8886.3 47410.3 47449.5 48465.8 48565.5 49926.3 60865.1 62153.0 63305.7 64727.4 65135.0 10970.9 11180.5 11198.7 11629.4 11737.4 11548.0 11926.2 11959.2 12387.6 12536.3 11260.3 11979.5 12030.8 12214.7 12433.2 11283.7 11284.8 11585.3 11605.9 12137.3 11425.1 11433.5 11708.7 11864.5 12526.7 9634.7 9705.3 9721.5 9842.2 10084.0 9574.9 10062.3 10208.5 10372.4 10376.4 14:15:34 INFO - PROCESS | 2969 | -------- Summary: end -------- 14:15:34 INFO - PROCESS | 2969 | 14:15:35 INFO - TEST-INFO | 2969: exit 0 14:15:35 INFO - TEST-OK | dromaeo_css | took 1119230ms 14:15:35 INFO - TEST-START | kraken 14:15:35 INFO - operating with platform_type : linux_ 14:15:35 INFO - Initialising browser for kraken test... 14:15:35 INFO - TEST-INFO | started process 3278 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCdaI89/profile http://localhost:45355/getInfo.html) 14:15:40 INFO - PROCESS | 3278 | __metrics Screen width/height:1600/1200 14:15:40 INFO - PROCESS | 3278 | colorDepth:24 14:15:40 INFO - PROCESS | 3278 | Browser inner width/height: 1024/697 14:15:40 INFO - PROCESS | 3278 | __metrics 14:15:40 INFO - PROCESS | 3278 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:15:40 INFO - PROCESS | 3278 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:15:41 INFO - PROCESS | 3278 | console.error: PushService: 14:15:41 INFO - PROCESS | 3278 | stateChangeProcessEnqueue: Error transitioning state 14:15:41 INFO - PROCESS | 3278 | UnknownError 14:15:42 INFO - TEST-INFO | 3278: exit 0 14:15:42 INFO - Browser initialized. 14:15:42 INFO - Running cycle 1/1 for kraken test... 14:15:42 INFO - TEST-INFO | started process 3359 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCdaI89/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:15:54 INFO - PROCESS | 3359 | RSS: Main: 171888640 14:15:54 INFO - PROCESS | 3359 | 14:15:56 INFO - PROCESS | 3359 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45355/tests/kraken/driver.html?testName=audio-beat-detection) 14:15:57 INFO - PROCESS | 3359 | RSS: Main: 229429248 14:15:57 INFO - PROCESS | 3359 | 14:16:00 INFO - PROCESS | 3359 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45355/tests/kraken/driver.html?testName=audio-dft) 14:16:01 INFO - PROCESS | 3359 | RSS: Main: 215203840 14:16:01 INFO - PROCESS | 3359 | 14:16:04 INFO - PROCESS | 3359 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45355/tests/kraken/driver.html?testName=audio-fft) 14:16:04 INFO - PROCESS | 3359 | RSS: Main: 297676800 14:16:04 INFO - PROCESS | 3359 | 14:16:06 INFO - PROCESS | 3359 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45355/tests/kraken/driver.html?testName=audio-oscillator) 14:16:07 INFO - PROCESS | 3359 | RSS: Main: 206749696 14:16:07 INFO - PROCESS | 3359 | 14:16:09 INFO - PROCESS | 3359 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45355/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:16:10 INFO - PROCESS | 3359 | RSS: Main: 211435520 14:16:10 INFO - PROCESS | 3359 | 14:16:13 INFO - PROCESS | 3359 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45355/tests/kraken/driver.html?testName=imaging-darkroom) 14:16:13 INFO - PROCESS | 3359 | RSS: Main: 248066048 14:16:13 INFO - PROCESS | 3359 | 14:16:17 INFO - PROCESS | 3359 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45355/tests/kraken/driver.html?testName=imaging-desaturate) 14:16:17 INFO - PROCESS | 3359 | RSS: Main: 246796288 14:16:17 INFO - PROCESS | 3359 | 14:16:20 INFO - PROCESS | 3359 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45355/tests/kraken/driver.html?testName=json-parse-financial) 14:16:20 INFO - PROCESS | 3359 | RSS: Main: 245665792 14:16:20 INFO - PROCESS | 3359 | 14:16:22 INFO - PROCESS | 3359 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45355/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:16:23 INFO - PROCESS | 3359 | RSS: Main: 208556032 14:16:23 INFO - PROCESS | 3359 | 14:16:24 INFO - PROCESS | 3359 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45355/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:16:25 INFO - PROCESS | 3359 | RSS: Main: 216879104 14:16:25 INFO - PROCESS | 3359 | 14:16:27 INFO - PROCESS | 3359 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45355/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:16:28 INFO - PROCESS | 3359 | RSS: Main: 225964032 14:16:28 INFO - PROCESS | 3359 | 14:16:30 INFO - PROCESS | 3359 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45355/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:16:31 INFO - PROCESS | 3359 | RSS: Main: 234283008 14:16:31 INFO - PROCESS | 3359 | 14:16:34 INFO - PROCESS | 3359 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45355/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:16:34 INFO - PROCESS | 3359 | RSS: Main: 231415808 14:16:34 INFO - PROCESS | 3359 | 14:16:36 INFO - PROCESS | 3359 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45355/tests/kraken/driver.html?testName=ai-astar) 14:16:36 INFO - PROCESS | 3359 | RSS: Main: 282353664 14:16:36 INFO - PROCESS | 3359 | 14:16:36 INFO - PROCESS | 3359 | __start_tp_report 14:16:36 INFO - PROCESS | 3359 | _x_x_mozilla_page_load 14:16:36 INFO - PROCESS | 3359 | _x_x_mozilla_page_load_details 14:16:36 INFO - PROCESS | 3359 | |i|pagename|runs| 14:16:36 INFO - PROCESS | 3359 | |0;ai-astar;103;111;111;111;111;110;111;110;111;111 14:16:36 INFO - PROCESS | 3359 | |1;audio-beat-detection;147;131;125;158;123;123;122;127;150;123 14:16:36 INFO - PROCESS | 3359 | |2;audio-dft;160;163;159;161;161;159;160;162;161;161 14:16:36 INFO - PROCESS | 3359 | |3;audio-fft;74;76;77;106;77;77;76;75;103;76 14:16:36 INFO - PROCESS | 3359 | |4;audio-oscillator;84;82;108;82;82;82;100;82;81;121 14:16:36 INFO - PROCESS | 3359 | |5;imaging-gaussian-blur;118;116;117;117;117;117;117;116;117;117 14:16:36 INFO - PROCESS | 3359 | |6;imaging-darkroom;145;148;145;145;145;146;146;146;146;146 14:16:36 INFO - PROCESS | 3359 | |7;imaging-desaturate;84;84;84;84;84;84;85;84;84;85 14:16:36 INFO - PROCESS | 3359 | |8;json-parse-financial;52;51;53;52;55;52;53;53;53;54 14:16:36 INFO - PROCESS | 3359 | |9;json-stringify-tinderbox;60;61;60;60;61;60;61;61;60;60 14:16:36 INFO - PROCESS | 3359 | |10;stanford-crypto-aes;79;79;79;79;82;79;79;79;87;81 14:16:36 INFO - PROCESS | 3359 | |11;stanford-crypto-ccm;142;127;130;138;133;130;132;134;173;132 14:16:36 INFO - PROCESS | 3359 | |12;stanford-crypto-pbkdf2;167;163;167;163;168;169;166;163;162;163 14:16:36 INFO - PROCESS | 3359 | |13;stanford-crypto-sha256-iterative;65;65;66;65;65;65;64;64;67;63 14:16:36 INFO - PROCESS | 3359 | __end_tp_report 14:16:36 INFO - PROCESS | 3359 | __start_cc_report 14:16:36 INFO - PROCESS | 3359 | _x_x_mozilla_cycle_collect,1660 14:16:36 INFO - PROCESS | 3359 | __end_cc_report 14:16:36 INFO - PROCESS | 3359 | __startTimestamp1477516596699__endTimestamp 14:16:36 INFO - PROCESS | 3359 | 14:16:36 INFO - PROCESS | 3359 | ------- Summary: start ------- 14:16:36 INFO - PROCESS | 3359 | Number of tests: 14 14:16:36 INFO - PROCESS | 3359 | 14:16:36 INFO - PROCESS | 3359 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:2.49 (2.2%) stddev-sans-first:0.44 14:16:36 INFO - PROCESS | 3359 | Values: 103.0 111.0 111.0 111.0 111.0 110.0 111.0 110.0 111.0 111.0 14:16:36 INFO - PROCESS | 3359 | 14:16:36 INFO - PROCESS | 3359 | [#1] audio-beat-detection Cycles:10 Average:132.90 Median:129.00 stddev:13.48 (10.4%) stddev-sans-first:13.29 14:16:36 INFO - PROCESS | 3359 | Values: 147.0 131.0 125.0 158.0 123.0 123.0 122.0 127.0 150.0 123.0 14:16:36 INFO - PROCESS | 3359 | 14:16:36 INFO - PROCESS | 3359 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.25 (0.8%) stddev-sans-first:1.30 14:16:36 INFO - PROCESS | 3359 | Values: 160.0 163.0 159.0 161.0 161.0 159.0 160.0 162.0 161.0 161.0 14:16:36 INFO - PROCESS | 3359 | 14:16:36 INFO - PROCESS | 3359 | [#3] audio-fft Cycles:10 Average:81.70 Median:76.00 stddev:12.07 (15.9%) stddev-sans-first:12.48 14:16:36 INFO - PROCESS | 3359 | Values: 74.0 76.0 77.0 106.0 77.0 77.0 76.0 75.0 103.0 76.0 14:16:36 INFO - PROCESS | 3359 | 14:16:36 INFO - PROCESS | 3359 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:82.00 stddev:14.22 (17.3%) stddev-sans-first:14.90 14:16:36 INFO - PROCESS | 3359 | Values: 84.0 82.0 108.0 82.0 82.0 82.0 100.0 82.0 81.0 121.0 14:16:36 INFO - PROCESS | 3359 | 14:16:36 INFO - PROCESS | 3359 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 14:16:36 INFO - PROCESS | 3359 | Values: 118.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 14:16:36 INFO - PROCESS | 3359 | 14:16:36 INFO - PROCESS | 3359 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 14:16:36 INFO - PROCESS | 3359 | Values: 145.0 148.0 145.0 145.0 145.0 146.0 146.0 146.0 146.0 146.0 14:16:36 INFO - PROCESS | 3359 | 14:16:36 INFO - PROCESS | 3359 | [#7] imaging-desaturate Cycles:10 Average:84.20 Median:84.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 14:16:36 INFO - PROCESS | 3359 | Values: 84.0 84.0 84.0 84.0 84.0 84.0 85.0 84.0 84.0 85.0 14:16:36 INFO - PROCESS | 3359 | 14:16:36 INFO - PROCESS | 3359 | [#8] json-parse-financial Cycles:10 Average:52.80 Median:53.00 stddev:1.14 (2.1%) stddev-sans-first:1.17 14:16:36 INFO - PROCESS | 3359 | Values: 52.0 51.0 53.0 52.0 55.0 52.0 53.0 53.0 53.0 54.0 14:16:36 INFO - PROCESS | 3359 | 14:16:36 INFO - PROCESS | 3359 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:60.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 14:16:36 INFO - PROCESS | 3359 | Values: 60.0 61.0 60.0 60.0 61.0 60.0 61.0 61.0 60.0 60.0 14:16:36 INFO - PROCESS | 3359 | 14:16:36 INFO - PROCESS | 3359 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:79.00 stddev:2.58 (3.3%) stddev-sans-first:2.70 14:16:36 INFO - PROCESS | 3359 | Values: 79.0 79.0 79.0 79.0 82.0 79.0 79.0 79.0 87.0 81.0 14:16:36 INFO - PROCESS | 3359 | 14:16:36 INFO - PROCESS | 3359 | [#11] stanford-crypto-ccm Cycles:10 Average:137.10 Median:133.50 stddev:13.31 (10.0%) stddev-sans-first:14.00 14:16:36 INFO - PROCESS | 3359 | Values: 142.0 127.0 130.0 138.0 133.0 130.0 132.0 134.0 173.0 132.0 14:16:36 INFO - PROCESS | 3359 | 14:16:36 INFO - PROCESS | 3359 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.10 Median:166.50 stddev:2.56 (1.5%) stddev-sans-first:2.62 14:16:36 INFO - PROCESS | 3359 | Values: 167.0 163.0 167.0 163.0 168.0 169.0 166.0 163.0 162.0 163.0 14:16:36 INFO - PROCESS | 3359 | 14:16:36 INFO - PROCESS | 3359 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:1.10 (1.7%) stddev-sans-first:1.17 14:16:36 INFO - PROCESS | 3359 | Values: 65.0 65.0 66.0 65.0 65.0 65.0 64.0 64.0 67.0 63.0 14:16:36 INFO - PROCESS | 3359 | -------- Summary: end -------- 14:16:36 INFO - PROCESS | 3359 | 14:16:37 INFO - TEST-INFO | 3359: exit 0 14:16:37 INFO - TEST-OK | kraken | took 62135ms 14:16:37 INFO - SUITE-END | took 1181s 14:16:38 INFO - Completed test suite (00:19:41) 14:16:38 INFO - javascript benchmark 14:16:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3040.1335619348483, 3070.2631368471575, 3080.0913730449515, 3101.410731960929, 3125.9531107033386, 5278.9208161877605, 5297.178937264721, 5341.679499230049, 5372.865678358043, 5409.783608655654, 5262.973685131569, 5310.230016647583, 5325.733713314338, 5374.677519348842, 5409.107497262947, 4873.098476781798, 4883.072216278913, 4884.902301953959, 4900.0689868924965, 4967.627427942901, 4382.510841895716, 4912.48418916014, 4933.703977761345, 4968.503149685039, 4973.975130124344, 4939.3578834751615, 4958.231474121499, 4961.3798275215595, 4996.950030499703, 5020.949790502084, 4792.664513484057, 4845.27320901864, 4848.0788650156355, 4900.877478063041, 4986.5761410280165, 4789.090072886141, 4807.855764327076, 4834.613230941552, 4880.902381952341, 4891.290762839404, 5241.213817927303, 5317.042932272189, 5319.414864364917, 5333.893322133575, 5372.946270537283, 5690.772369105231, 5699.857503562403, 5704.942950570483, 5705.800296989585, 5767.942320576783, 5618.269624948772, 5653.1520271959125, 5668.546516278688, 5737.512311453532, 5745.798897038625, 5339.572834173296, 5351.732413379315, 5352.785888564453, 5354.892902141974, 5355.062863998784, 5757.050086735641, 5828.067509198508, 5828.941710582924, 5831.533477321804, 5831.562632802556, 5554.472325129187, 5588.888222235614, 5602.551795856321, 5604.775808967595, 5605.243292155506, 5667.6316039458125, 5680.715964201856, 5681.0910254359105, 5685.772569097273, 5686.772529098873, 5674.460926212003, 5687.146927960756, 5691.004074286983, 5692.345380281238, 5693.259876216065, 5684.857878552986, 5690.061139911951, 5711.485966263056, 5719.142128680731, 5736.426357364314, 4256.7445953242905, 4309.159713855768, 4310.288802347577, 4314.288142456459, 4357.063231405263, 3835.36716441784, 3861.613838616172, 3890.6498415142205, 3933.7443066200603, 3944.585818489075, 5403.972980135074, 5459.972700136554, 5473.480019398151, 5477.178423236546, 5481.890362192814, 5784.132380143013, 5791.652500849962, 5801.419858014165, 5807.361190269152, 5816.592838501264, 5272.710000949908, 5334.493223143795, 5461.0716178249795, 5470.234167216593, 5471.562275017989, 4806.086843499794, 4846.127697014571, 4861.149298872683, 4862.854114376574, 4903.166461701519, 5872.0, 5872.060470324727, 5876.853078672982, 5913.940860591425, 5945.881082378328, 5735.7705691773535, 5746.741396637245, 5749.885002299847, 5751.338596061507, 5752.942470575241, 5735.254416925773, 5818.73815678304, 5861.1501332305725, 5878.647281163144, 5885.588008839341, 5615.213870058276, 5629.211910332639, 5637.098064309691, 5653.095504719389, 5689.34572524165, 5666.744996475086, 5671.943280567307, 5672.7730890763905, 5699.572532060195, 5730.398308177748, 5370.3287089113865, 5490.121580547093, 5522.641028333145, 5527.0, 5537.861553461195, 5507.284053073236, 5623.044082506066, 5624.943750562442, 5630.690312032713, 5688.886222275614, 5592.972035139798, 5608.158776183605, 5614.63504872182, 5615.803446879339, 5620.044592419216, 5539.944600554104, 5626.35296940857, 5636.746346414339, 5638.351589567253, 5638.379778224474, 5463.207834863843, 5474.124140137559, 5483.725813709379, 5488.368837583729, 5539.861503462445], "value": 5264.816220960217, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.9167100959417, 595.7378753348527, 612.868233329834, 636.3827087724906, 640.9647469389182, 31821.68178318216, 43565.34651980219, 44424.8911375192, 44469.332960005624, 44488.77755611222, 44911.0, 45262.77368613161, 45340.54659453405, 45358.09283814322, 45412.772936135356, 7986.2013798620255, 8184.508929464251, 8829.779255518599, 8982.236509896667, 8996.8650470243, 10423.27037107399, 10692.839607405895, 10694.037536621703, 11086.0, 11096.167787415936, 10816.134709223243, 10890.61882834101, 10899.073578745816, 10905.400202988832, 10908.50911708975, 10686.091682207021, 10718.196135289885, 10735.0, 10740.570377184904, 10751.354918704903, 10604.151667866552, 10642.09542188915, 10661.093807026335, 10675.572977080907, 10682.73293167677, 42506.0, 42657.36013959793, 42872.78563607193, 42879.785601071795, 42917.0, 3284.310294838087, 3480.1647604574973, 3525.4359302511475, 3536.6286539913194, 3778.735488515805, 31567.210819729462, 32300.83849580737, 32741.6725832741, 32949.50575741342, 33810.32379352399, 4236.449261596003, 4247.511536173318, 4414.735115893057, 4421.867343979686, 4511.300748384006, 321292.0, 322268.0, 322683.0, 323264.0, 325048.0, 33977.83011084978, 57875.71062144746, 58359.0, 58382.70808645929, 58422.41577584255, 34941.825290873385, 36724.44913326302, 36729.08177295589, 36730.44904326437, 36731.26537469289, 12942.417591208417, 13065.412056457291, 13077.280749558866, 13151.934240328737, 13167.868321316855, 9355.4386736796, 9568.521573921276, 9658.3722058066, 9869.851952220723, 10597.099246563974, 8107.756767296873, 8134.877976830352, 8194.139615340422, 8243.752687419386, 8293.502389856629, 2945.1900727300163, 3090.258337998909, 3093.9845300773354, 3239.3845169417737, 3253.6746325367276, 944.504135328944, 951.538503825644, 1015.6902144845745, 1027.2706378471219, 1027.5889644142403, 32074.35851283008, 32090.518642220384, 32383.0, 32400.67599324024, 32857.50713739296, 1084.5715942202785, 1100.708312297242, 1101.9063379612824, 1110.4614262082882, 1112.9443527823576, 15633.218339083, 16898.0, 16939.237734301987, 16941.407050753165, 16985.830141698672, 448305.0, 451184.0, 453346.0, 453528.0, 453530.0, 58837.41162588405, 59180.40819591835, 59316.0, 59371.0, 59390.10914836281, 1211.2974474804591, 1240.7456471423336, 1288.9935550322189, 1336.9799453008213, 1344.3345543956, 31056.68943310538, 32399.352012959138, 33091.172720681214, 33141.91550983663, 33690.83154584211, 50136.0, 50514.49485505098, 50690.493095068574, 50700.49299506958, 50728.0, 384714.0, 385942.0, 386738.0, 386776.0, 465474.0, 40065.1986960265, 42390.0, 42776.0, 43088.0, 43552.78223608862, 46095.76952115218, 46198.30702539532, 46855.53144468512, 46909.76545117389, 48423.0, 39746.2050758989, 41007.0, 41117.0, 41457.58542414658, 42857.0, 39664.80167599144, 40072.59927400688, 41533.0, 41889.0, 41941.161176776906, 40891.59108408997, 41407.171856563305, 42188.367174491796, 42399.5760042408, 42601.14797703967, 31751.682483175795, 35544.46683299804, 36430.63569364379, 38742.61257387503, 39411.802940985115, 27510.587341189497, 27951.0, 28063.438731224855, 28260.293492662848, 28271.43457130887], "value": 19027.12529774516, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.392772816445, 378.77841462744294, 386.3856468215537, 395.70124555960246, 416.56468989905545, 14120.293985300732, 15750.606234844134, 18586.34947776828, 19171.61656766864, 19193.0, 18457.446276611725, 18490.260389584433, 18604.813951860477, 18740.156692948814, 18744.43766686998, 4142.772147531885, 5472.5074743273, 5687.601867869251, 5688.63023903447, 5694.117411801178, 4220.894477638069, 6025.758969641209, 6191.04038873973, 6317.305096439388, 6440.903386449184, 6147.47746441553, 6261.46777523911, 6274.341194174614, 6388.488920886318, 6397.808065758035, 6260.7808726694575, 6288.371162883721, 6289.559730818844, 6290.056491526262, 6290.685465726719, 5305.602079844027, 5525.198846167324, 5537.418571050022, 5567.944320556783, 5569.693666848321, 18159.909200453912, 18257.360992365204, 21322.68015979746, 22560.0, 22841.31476055721, 2269.6368581026954, 2279.6124658808044, 2486.639437281584, 3044.558539011853, 3072.1705139612404, 13011.86988130116, 14310.928445357811, 14607.853921460755, 14671.119732816065, 14813.925930370388, 1875.5123667846458, 1890.3478299986482, 1932.6134773045446, 1958.3341663834221, 1974.99012504938, 78782.60608696977, 80724.59637701833, 82207.58896205481, 82786.0, 83279.0, 10015.0, 10226.693199204035, 10281.485925703684, 10633.680989570325, 10772.461376931122, 14724.116553006854, 14856.182909940057, 14864.628384290263, 14921.776173357408, 14925.70148597022, 7164.785056448315, 7180.461465390116, 7287.089113860768, 7373.0, 7444.367228785505, 6764.154480689914, 6817.659117044128, 6947.930520694829, 6961.129858767654, 6965.79102626922, 6214.8135555933395, 6401.871962560723, 6411.294757576663, 6491.253505846794, 6553.279139294674, 1844.981550184481, 1854.9519521470327, 1862.990685046566, 1913.894735789545, 1961.9705704414446, 929.7402020262582, 963.3208587945481, 992.4491906991544, 1046.3146638951498, 1050.9632162874416, 18472.353467628567, 19380.515487112654, 19395.8060419394, 19452.124654390587, 19816.20735170606, 988.6786794291884, 1012.7012531303283, 1050.3172937590627, 1052.768390953989, 1058.523664351045, 9965.453891928615, 10357.171426285879, 10980.780384392267, 10988.945055274673, 11162.107031437465, 437701.0, 452324.0, 464185.0, 465848.0, 467670.0, 82698.17301826905, 82833.17166828255, 83319.0, 83591.5820420894, 84657.57671211605, 966.1449617088787, 975.8341082016075, 989.4762066417636, 989.8465737810651, 1008.621766837436, 16315.347386104897, 16531.504054878373, 17065.317387304367, 17104.230309636347, 17329.913350433166, 36833.63166368302, 38559.0, 38946.6105338943, 40554.1889162221, 42092.15815683608, 50881.49118508916, 52797.472025279254, 52927.0, 56229.43770562242, 56424.43575564192, 8113.797155070934, 8168.897198878075, 8516.574171291535, 8556.18716221958, 8683.131686831266, 11258.38078905668, 12504.437300321326, 12728.427220774902, 12793.424295906892, 13040.934795325962, 10476.323788193853, 10727.839082413613, 10758.085562726943, 11138.331700097697, 11154.274972126786, 10575.524101415609, 10772.360771611005, 10919.890801092206, 11012.834807477733, 11298.60454884108, 10263.076323130954, 10420.68737937863, 10653.627123050655, 10744.946275268574, 11007.119430445386, 8240.464369815943, 8242.134575869448, 8251.95874020626, 8271.586420679063, 8640.839790052487, 7989.161138080651, 9965.35225210359, 10147.847782283125, 10235.948820255851, 10266.0], "value": 9071.60287429473, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1328.136711137761, 1423.1390009044528, 1499.1379956525, 1562.9996802046692, 1738.4697667211497, 7511.62441877906, 8128.67485300588, 8374.995000599929, 8442.240198382144, 8446.028706698717, 8237.794055148624, 8365.874511882326, 8367.205115514016, 8589.355798315135, 8633.179847914455, 2287.325239054483, 2324.8605083694947, 2326.8254880884, 2330.778576035274, 2333.3000099970027, 2246.7303923529116, 2294.0823670531754, 2347.929562113131, 2350.659154422616, 2352.047420794581, 2236.3514580771557, 2257.0858802185057, 2275.8293128015384, 2277.2940388479624, 2277.635578307471, 2241.977580224201, 2267.0, 2297.5290065536524, 2298.643710224918, 2301.1255722825385, 2241.7758224177614, 2251.5046689728233, 2256.8533045352, 2264.6603009548535, 2265.9433514162115, 8510.191531804468, 8561.785955351104, 8563.828723425559, 8566.657333706644, 8569.528675922822, 4921.876953076166, 5051.570616497602, 5081.288619593223, 5149.330587023663, 5149.9485005149845, 3187.7449804015623, 3317.784344017631, 3422.4524076147695, 3476.7392445566684, 3480.843362048714, 1088.5264909764278, 1100.6367898593444, 2077.958440831175, 2116.714243577113, 2140.0953151695003, 11588.304701717923, 11688.240264382788, 11777.882221177764, 11781.0, 11789.941050294694, 4401.801918913657, 4505.121501307213, 4561.589456948891, 4577.176108300538, 4630.166570017362, 10196.592136314614, 10198.337108088099, 10203.642872499428, 10206.0, 10207.132393746615, 5181.0415073210825, 5182.689038657617, 5182.948170518322, 5189.6886186828915, 5190.24741412493, 4067.6949228807957, 4186.35111557709, 4525.343825145335, 4581.816727330936, 4600.470945841271, 3752.4746535485056, 3911.5697273299916, 3924.764514129104, 3956.248312820555, 4000.5399379071196, 1274.4328773695802, 1288.606974872673, 1306.392527474729, 1319.64369620202, 1323.6426164935413, 738.9963050184822, 811.5171472973572, 896.3456676626099, 943.1558754914313, 963.7397902566267, 5589.636673616202, 5607.43925607436, 5799.4780469757925, 5868.823935281948, 6028.819135425944, 913.1097180249336, 924.8589515272123, 950.2587981374539, 988.0584651160505, 1005.4218824176128, 3604.6034936157002, 3811.5235595550557, 3843.5003449551377, 3952.7628342299554, 3998.540167880731, 10477.580896764197, 10622.840657390145, 10745.0, 10850.53517775106, 10856.2400631955, 10089.394636321844, 10353.896461035443, 10518.73703157412, 10770.730731731614, 10776.461176941122, 7920.32677222431, 7956.2441568050945, 8058.959705201437, 8122.147174546588, 8144.83710325802, 5479.589030822624, 5574.108142697149, 5593.384727679871, 5737.684427356368, 5747.856303592276, 9711.66009189675, 9729.756756081155, 9775.608975640895, 9854.359466634645, 9871.457069860939, 9628.855567166638, 9971.40171589707, 10126.341787783771, 10133.290669653054, 10140.0, 7022.43820494349, 7198.280171982759, 7434.368078713153, 7668.501547399401, 7833.0, 8055.3152981994845, 8465.153484651486, 8466.322694184573, 8469.110743372104, 8482.957585212034, 7310.6710198040155, 7337.486375953846, 7440.144383395762, 7622.961885190539, 7820.0, 7457.589832559044, 7515.361194298327, 7530.472866899265, 7578.43161762881, 7768.84462310762, 6393.488520918222, 6485.77299794505, 6488.124103246001, 6488.221413430419, 6488.318726533646, 4681.250999840009, 4708.340832283551, 4751.453582837879, 4766.45185803637, 4847.2729090636685, 4857.344258525195, 4939.481354457874, 4978.352814134139, 5046.21783623539, 5071.644984851025], "value": 4556.599450730836, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.75829819547965, 312.30823725448136, 319.640404544887, 319.6579659764052, 325.16270603196773, 4738.597219236361, 5082.822101226458, 5169.948300516999, 5249.370075590925, 5256.211568264762, 5115.309433226514, 5210.609204309673, 5226.947730522694, 5230.712310822903, 5231.424543300234, 4103.4460347852955, 4104.932717493458, 4112.506499220083, 4112.547619761839, 4118.6499147572495, 3893.5717071122294, 4098.385242213662, 4116.279651061067, 4118.732282401635, 4120.072983578686, 3817.6945844332527, 3982.780947047911, 4012.498437695288, 4018.9397159042637, 4027.536833264183, 3974.423708562242, 3999.6201310547813, 4001.8599349022643, 4011.899702507417, 4016.1766837798327, 3530.570119101768, 3532.9293414131575, 3533.3993221152464, 3548.0, 3552.7335449841366, 4859.975700121512, 4992.525710057539, 5060.0, 5062.417821950486, 5070.630929649011, 4549.181147393468, 4585.954140458586, 4604.608608268301, 4613.723176609415, 4622.583967442913, 5354.866128346784, 5391.865203369908, 5415.458454154593, 5419.187121931703, 5455.290812194429, 3650.1604630934767, 3823.9426408603613, 3868.303705333039, 3873.5545412277384, 3941.113249518864, 5391.838244852661, 5522.337319521683, 5637.041702910474, 5667.271482197928, 5675.801346952878, 3821.5796262411113, 3918.2555314490155, 3919.490466239428, 3923.058465968147, 3925.430812532167, 3957.683385329167, 3971.9801400993388, 3976.6023397660583, 3989.880303590897, 4000.879973600797, 4585.656075794329, 4592.311153327028, 4594.839180628662, 4605.0, 4613.677042606985, 5286.233496143038, 5461.617686761889, 5465.829818705141, 5522.337319521683, 5532.253145825262, 1377.8484366719854, 1394.588596364075, 1395.155930661935, 1395.3441882315296, 1398.8181536400202, 833.4082801211086, 876.6805957034622, 877.2280393253895, 879.859222524393, 885.2386947225381, 4705.741184234831, 4712.69367491112, 4719.976400117977, 4726.747411935839, 4727.7163370197895, 4917.459079501252, 4936.950630493649, 4936.975315123402, 4968.8757781055765, 4968.999955036158, 4413.823447062082, 4711.453447423253, 4736.668433209711, 4738.620910327166, 4739.597134243559, 2637.230907547068, 2643.7442214947746, 2646.5897785843226, 2654.2170059832397, 2667.479841430941, 4998.625103117281, 5058.280184737134, 5072.847814565569, 5088.389393272757, 5101.69389836611, 4843.467218605951, 5049.722265275372, 5052.469490703496, 5057.898842023139, 5090.643654944119, 4982.039513071185, 4989.201727723546, 5005.696240481265, 5007.974960125176, 5033.622478314068, 4922.360093187863, 4923.803047878188, 4943.530364615356, 4962.851114466572, 4976.900461990812, 4461.412380819182, 4799.520047995173, 4877.170880950176, 4883.487233840396, 4910.656254062182, 4987.680728461283, 5000.299958005955, 5509.944900550943, 5605.467480589337, 5701.543876489954, 3955.2089582084272, 3973.523177218752, 3984.1234928315725, 3985.6811455084103, 3994.121293315466, 5633.676086119676, 5651.321841378896, 5665.66006039639, 5665.801696940587, 5689.8862022758485, 5300.469953004668, 5358.223057656696, 5401.351837779492, 5428.891422171613, 5528.419515950767, 5388.407275199804, 5388.649737767033, 5390.250972004228, 5405.891792182514, 5444.537214336826, 5472.480114389126, 5482.917756233739, 5483.095289277225, 5483.2049352844415, 5483.533899618577, 5279.604029697711, 5548.778048878, 5558.277423934863, 5586.720663966867, 5588.38527761954, 5459.754311055933, 5468.593818719751, 5471.781128754806, 5483.424240454854, 5490.313710786152], "value": 4006.5349119877787, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.1831257428807, 698.6017969757237, 751.3313151295348, 793.6785601831259, 805.9435839491234, 13552.457901683933, 14336.211508367061, 14535.709285814277, 14540.418383264656, 14559.12645241285, 13341.733165336711, 14203.78694319586, 14494.927525362385, 14790.852091479082, 15296.770548441782, 797.9800504987393, 817.5380909785981, 817.7546735979212, 818.4598165210962, 818.5661599352353, 670.9731610735565, 687.9140107486564, 809.951402915824, 813.3452570680599, 813.6094674556217, 716.8637958787814, 719.1442183801286, 719.2843121094492, 824.1840577827967, 854.4915775113828, 842.1452225990624, 845.3701992015988, 846.2045677063602, 846.3736834742247, 846.4921047371589, 615.8552740106071, 617.9165812615284, 618.11300783376, 618.2889676871589, 618.3198481670172, 10659.413732244724, 10927.071198948099, 14357.712845743026, 14452.855471445257, 14512.0, 13169.670758231025, 13844.30778461073, 13869.37587808551, 14134.0, 14192.787108193384, 10930.344179349264, 11044.668659940215, 11212.663620091329, 11395.829062564067, 11503.641753440525, 3675.4119340905595, 3721.5906250312446, 3723.553173619183, 3781.773093614392, 3824.5028146341074, 65356.673216633615, 66698.3330166697, 67251.66374168146, 67445.66277168583, 67955.32044679589, 9499.667511637059, 9625.0, 9647.421154730739, 10208.0, 10366.326188797704, 17146.485605431855, 17191.398301059653, 17287.39494117725, 18781.24875005012, 18844.623107537773, 7254.455915806336, 7363.337299643058, 7470.887936680954, 7474.85050298991, 7729.265719756614, 4313.9137217255475, 4415.6909016368545, 4476.35092911526, 4538.682292239578, 4588.059447813191, 3536.2750636119536, 3658.32321020612, 3663.5603727552866, 3664.5419322584676, 3664.59689434162, 533.2720836058752, 543.7471575717232, 559.194759546252, 559.8404454730382, 565.9575531835129, 680.3944489404435, 684.4626967830229, 719.9496035277481, 729.4128226777389, 737.2332773915175, 8568.400211985101, 8759.2992560595, 8848.778780530409, 9170.403923744936, 9209.401388909699, 541.6452223793422, 598.509222437597, 619.9925121677275, 686.361683634225, 719.3202423709545, 4200.726952748123, 4421.46942366918, 4425.579569940851, 4441.20058389493, 4460.487043989918, 63036.68481657654, 90894.0, 91044.0, 91885.0, 91895.54052229696, 73250.0, 73409.0, 74221.0, 74597.62701186459, 75428.62285688537, 67479.0, 68089.65955170193, 68541.65729171323, 71285.0, 72029.63985179935, 8417.579121044046, 8656.264217541328, 8814.471131732116, 8870.86693699582, 8886.333524985781, 47410.28884566803, 47449.52550474589, 48465.75767121283, 48565.5143448561, 49926.25110623271, 60865.08702369557, 62153.0, 63305.68347158235, 64727.352726472134, 65135.0, 10970.890291096986, 11180.496877640364, 11198.720031998939, 11629.360385178896, 11737.354445505238, 11547.97168703869, 11926.165168438127, 11959.222650527689, 12387.62837114888, 12536.310502922426, 11260.324380537195, 11979.520819167135, 12030.75938481243, 12214.694632634255, 12433.191842530206, 11283.66149015531, 11284.7743045137, 11585.274976402072, 11605.941970290432, 12137.332446715516, 11425.143114266297, 11433.485493152662, 11708.70728231801, 11864.466099025392, 12526.686832828887, 9634.71095867125, 9705.320627556286, 9721.513924303898, 9842.163416109424, 10084.0, 9574.856377154487, 10062.345947513388, 10208.489575521342, 10372.377657340583, 10376.429296388771], "value": 6824.404403987272, "unit": "score"}], "name": "dromaeo_css", "value": 6955.4752309294945, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 111.0, 111.0, 111.0, 110.0, 111.0, 110.0, 111.0, 111.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 131.0, 125.0, 158.0, 123.0, 123.0, 122.0, 127.0, 150.0, 123.0], "value": 132.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 159.0, 161.0, 161.0, 159.0, 160.0, 162.0, 161.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 77.0, 106.0, 77.0, 77.0, 76.0, 75.0, 103.0, 76.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 108.0, 82.0, 82.0, 82.0, 100.0, 82.0, 81.0, 121.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 148.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 84.0, 84.0, 84.0, 85.0, 84.0, 84.0, 85.0], "value": 84.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 53.0, 52.0, 55.0, 52.0, 53.0, 53.0, 53.0, 54.0], "value": 52.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 60.0, 61.0, 60.0, 61.0, 61.0, 60.0, 60.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 79.0, 82.0, 79.0, 79.0, 79.0, 87.0, 81.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 127.0, 130.0, 138.0, 133.0, 130.0, 132.0, 134.0, 173.0, 132.0], "value": 137.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 163.0, 167.0, 163.0, 168.0, 169.0, 166.0, 163.0, 162.0, 163.0], "value": 165.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 64.0, 64.0, 67.0, 63.0], "value": 64.9, "unit": "score"}], "name": "kraken", "value": 1483.2, "alertThreshold": 2.0}]} 14:16:38 INFO - Return code: 0 14:16:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:16:38 INFO - # TBPL SUCCESS # 14:16:38 INFO - Running post-action listener: _resource_record_post_action 14:16:38 INFO - [mozharness: 2016-10-26 21:16:38.522559Z] Finished run-tests step (success) 14:16:38 INFO - Running post-run listener: _resource_record_post_run 14:16:38 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 396238848; Read time: 12; Write time: 545676 14:16:38 INFO - TinderboxPrint: CPU usage
13.1% 14:16:38 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 14:16:38 INFO - TinderboxPrint: I/O write bytes / time
396,238,848 / 545,676 14:16:38 INFO - TinderboxPrint: CPU idle
8,309.0 (86.8%) 14:16:38 INFO - TinderboxPrint: CPU user
1,203.2 (12.6%) 14:16:38 INFO - TinderboxPrint: Swap in / out
0 / 0 14:16:38 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 107253760; Read time: 0; Write time: 235900 14:16:38 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 288555008; Read time: 0; Write time: 309776 14:16:39 INFO - Running post-run listener: _upload_blobber_files 14:16:39 INFO - Blob upload gear active. 14:16:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:16:39 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 14:16:39 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:16:39 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:16:39 INFO - (blobuploader) - INFO - Open directory for files ... 14:16:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:16:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:16:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:16:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:16:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:16:42 INFO - (blobuploader) - INFO - Done attempting. 14:16:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:16:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:16:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:16:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:16:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:16:43 INFO - (blobuploader) - INFO - Done attempting. 14:16:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:16:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:16:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:16:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:16:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:16:44 INFO - (blobuploader) - INFO - Done attempting. 14:16:44 INFO - (blobuploader) - INFO - Iteration through files over. 14:16:44 INFO - Return code: 0 14:16:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:16:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:16:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b282e1af3a9b9ec43bc8d4af80ea0a8297f5b79f6d7c05207892221dda99992dde7b8e04032932f602eebf7c53bab053262f6d552ce09698449dbceecebfb0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d9adb7eba0e4adc5521e98d31d18034bf644ea2d1878bd02d08d2fbc1d609891e292cb4e453fafe6e1db5aa968eea86d22d77561e6adf8ea3e90c7ab5339c0c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd2f5a4efd0f1a160f2900e1d29700fa4e808dd8dcd4fb99bba6f56c168af8d438ebff6108b9f11fd758dae7270ab46b2b9d8fb2353f11055bc3388c13292351"} 14:16:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:16:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:16:44 INFO - Contents: 14:16:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b282e1af3a9b9ec43bc8d4af80ea0a8297f5b79f6d7c05207892221dda99992dde7b8e04032932f602eebf7c53bab053262f6d552ce09698449dbceecebfb0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d9adb7eba0e4adc5521e98d31d18034bf644ea2d1878bd02d08d2fbc1d609891e292cb4e453fafe6e1db5aa968eea86d22d77561e6adf8ea3e90c7ab5339c0c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd2f5a4efd0f1a160f2900e1d29700fa4e808dd8dcd4fb99bba6f56c168af8d438ebff6108b9f11fd758dae7270ab46b2b9d8fb2353f11055bc3388c13292351"} 14:16:44 INFO - Running post-run listener: copy_logs_to_upload_dir 14:16:44 INFO - Copying logs to upload dir... 14:16:44 INFO - mkdir: /builds/slave/test/build/upload/logs 14:16:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.739265 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-10-26 14:16:44.514552) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 14:16:44.517708) ========= 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=df17445c3590ff7897617a0e00000225-1477515358.39564-769620550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b282e1af3a9b9ec43bc8d4af80ea0a8297f5b79f6d7c05207892221dda99992dde7b8e04032932f602eebf7c53bab053262f6d552ce09698449dbceecebfb0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d9adb7eba0e4adc5521e98d31d18034bf644ea2d1878bd02d08d2fbc1d609891e292cb4e453fafe6e1db5aa968eea86d22d77561e6adf8ea3e90c7ab5339c0c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd2f5a4efd0f1a160f2900e1d29700fa4e808dd8dcd4fb99bba6f56c168af8d438ebff6108b9f11fd758dae7270ab46b2b9d8fb2353f11055bc3388c13292351"} build_url:https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011311 build_url: 'https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b282e1af3a9b9ec43bc8d4af80ea0a8297f5b79f6d7c05207892221dda99992dde7b8e04032932f602eebf7c53bab053262f6d552ce09698449dbceecebfb0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d9adb7eba0e4adc5521e98d31d18034bf644ea2d1878bd02d08d2fbc1d609891e292cb4e453fafe6e1db5aa968eea86d22d77561e6adf8ea3e90c7ab5339c0c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd2f5a4efd0f1a160f2900e1d29700fa4e808dd8dcd4fb99bba6f56c168af8d438ebff6108b9f11fd758dae7270ab46b2b9d8fb2353f11055bc3388c13292351"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 14:16:44.542786) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:16:44.543100) ========= 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=df17445c3590ff7897617a0e00000225-1477515358.39564-769620550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004488 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:16:44.628085) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 14:16:44.628409) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 14:16:44.628697) ========= ========= Total master_lag: 0.19 =========