builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-045 starttime: 1481452793.28 results: success (0) buildid: 20161211004007 builduid: c98077941a7e4b099c3b48189609c656 revision: 2ec25b58608c6e815b1b6b2901561adb0d24e9d3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-11 02:39:53.279579) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-11 02:39:53.280029) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-11 02:39:53.280303) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-11 02:39:53.298038) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-11 02:39:53.298303) ========= 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=4300f881736b422476174874000001bc-1481452692.256544-55095987 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-11 02:39:53-- 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% 139M=0s 2016-12-11 02:39:53 (139 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.137640 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-11 02:39:53.449864) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-11 02:39:53.450215) ========= 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=4300f881736b422476174874000001bc-1481452692.256544-55095987 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013845 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-11 02:39:53.503992) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-11 02:39:53.504367) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2ec25b58608c6e815b1b6b2901561adb0d24e9d3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2ec25b58608c6e815b1b6b2901561adb0d24e9d3 --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=4300f881736b422476174874000001bc-1481452692.256544-55095987 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-11 02:39:53,691 truncating revision to first 12 chars 2016-12-11 02:39:53,691 Setting DEBUG logging. 2016-12-11 02:39:53,691 attempt 1/10 2016-12-11 02:39:53,691 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2ec25b58608c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-11 02:39:53,991 unpacking tar archive at: mozilla-aurora-2ec25b58608c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.639801 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-11 02:39:54.157962) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-11 02:39:54.158318) ========= script_repo_revision: 2ec25b58608c6e815b1b6b2901561adb0d24e9d3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-11 02:39:54.158781) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-11 02:39:54.159105) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-11 02:39:54.169633) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-12-11 02:39:54.169956) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4300f881736b422476174874000001bc-1481452692.256544-55095987 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:39:54 INFO - MultiFileLogger online at 20161211 02:39:54 in /builds/slave/test 02:39:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:39:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:39:54 INFO - {'append_to_log': False, 02:39:54 INFO - 'base_work_dir': '/builds/slave/test', 02:39:54 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:39:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:39:54 INFO - 'branch': 'Mozilla-Aurora', 02:39:54 INFO - 'buildbot_json_path': 'buildprops.json', 02:39:54 INFO - 'config_files': ('talos/linux_config.py',), 02:39:54 INFO - 'default_actions': ('clobber', 02:39:54 INFO - 'read-buildbot-config', 02:39:54 INFO - 'download-and-extract', 02:39:54 INFO - 'populate-webroot', 02:39:54 INFO - 'create-virtualenv', 02:39:54 INFO - 'install', 02:39:54 INFO - 'run-tests'), 02:39:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:39:54 INFO - 'download_minidump_stackwalk': True, 02:39:54 INFO - 'download_symbols': 'ondemand', 02:39:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:39:54 INFO - 'tooltool.py': '/tools/tooltool.py', 02:39:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:39:54 INFO - '/tools/misc-python/virtualenv.py')}, 02:39:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:39:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:39:54 INFO - 'installer_path': 'installer.exe', 02:39:54 INFO - 'log_level': 'info', 02:39:54 INFO - 'log_name': 'talos', 02:39:54 INFO - 'log_to_console': True, 02:39:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:39:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:39:54 INFO - 'opt_config_files': (), 02:39:54 INFO - 'pip_index': False, 02:39:54 INFO - 'sps_profile': False, 02:39:54 INFO - 'sps_profile_interval': 0, 02:39:54 INFO - 'suite': 'dromaeojs', 02:39:54 INFO - 'system_bits': '32', 02:39:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:39:54 INFO - 'title': 'talos-linux64-ix-045', 02:39:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:39:54 INFO - 'use_talos_json': True, 02:39:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:39:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:39:54 INFO - 'work_dir': 'build'} 02:39:54 INFO - [mozharness: 2016-12-11 10:39:54.454444Z] Running clobber step. 02:39:54 INFO - Running pre-action listener: _resource_record_pre_action 02:39:54 INFO - Running main action method: clobber 02:39:54 INFO - rmtree: /builds/slave/test/build 02:39:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:39:55 INFO - Running post-action listener: _resource_record_post_action 02:39:55 INFO - [mozharness: 2016-12-11 10:39:55.427582Z] Finished clobber step (success) 02:39:55 INFO - [mozharness: 2016-12-11 10:39:55.427681Z] Running read-buildbot-config step. 02:39:55 INFO - Running pre-action listener: _resource_record_pre_action 02:39:55 INFO - Running main action method: read_buildbot_config 02:39:55 INFO - Using buildbot properties: 02:39:55 INFO - { 02:39:55 INFO - "project": "", 02:39:55 INFO - "product": "firefox", 02:39:55 INFO - "script_repo_revision": "production", 02:39:55 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 02:39:55 INFO - "repository": "", 02:39:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 02:39:55 INFO - "buildid": "20161211004007", 02:39:55 INFO - "stage_platform": "linux64-pgo", 02:39:55 INFO - "basedir": "/builds/slave/test", 02:39:55 INFO - "nightly_build": "True", 02:39:55 INFO - "buildnumber": 957, 02:39:55 INFO - "slavename": "talos-linux64-ix-045", 02:39:55 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:39:55 INFO - "platform": "ubuntu64_hw", 02:39:55 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 02:39:55 INFO - "branch": "mozilla-aurora", 02:39:55 INFO - "repo_path": "releases/mozilla-aurora", 02:39:55 INFO - "revision": "2ec25b58608c6e815b1b6b2901561adb0d24e9d3", 02:39:55 INFO - "pgo_build": "True", 02:39:55 INFO - "builduid": "c98077941a7e4b099c3b48189609c656", 02:39:55 INFO - "slavebuilddir": "test" 02:39:55 INFO - } 02:39:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/HLKeAgElR0CEQbRzcz-PFw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 02:39:55 INFO - Running post-action listener: _resource_record_post_action 02:39:55 INFO - [mozharness: 2016-12-11 10:39:55.430192Z] Finished read-buildbot-config step (success) 02:39:55 INFO - [mozharness: 2016-12-11 10:39:55.430280Z] Running download-and-extract step. 02:39:55 INFO - Running pre-action listener: _resource_record_pre_action 02:39:55 INFO - Running main action method: download_and_extract 02:39:55 INFO - mkdir: /builds/slave/test/build/tests 02:39:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:55 INFO - trying https://queue.taskcluster.net/v1/task/HLKeAgElR0CEQbRzcz-PFw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:39:55 INFO - Downloading https://queue.taskcluster.net/v1/task/HLKeAgElR0CEQbRzcz-PFw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:39:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HLKeAgElR0CEQbRzcz-PFw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:39:55 INFO - Downloaded 1361 bytes. 02:39:55 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:39:55 INFO - Using the following test package requirements: 02:39:55 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 02:39:55 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:39:55 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 02:39:55 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:39:55 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 02:39:55 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:39:55 INFO - u'jsshell-linux-x86_64.zip'], 02:39:55 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:39:55 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 02:39:55 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 02:39:55 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:39:55 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 02:39:55 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:39:55 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 02:39:55 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:39:55 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 02:39:55 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:39:55 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 02:39:55 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:39:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HLKeAgElR0CEQbRzcz-PFw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 02:39:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HLKeAgElR0CEQbRzcz-PFw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:39:55 INFO - Fetch https://queue.taskcluster.net/v1/task/HLKeAgElR0CEQbRzcz-PFw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 02:39:56 INFO - Http code: 200 02:39:56 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 02:39:56 INFO - x-amz-cf-id: oOSblsnlj8EVLpjYI13nge5Oc-6lGT-P13tXTJGogwlNUw-FJ5W1eA== 02:39:56 INFO - x-amz-version-id: A9RM0o1COGZcAwMSvmMoy08cWlUEL436 02:39:57 INFO - Expected file size: 21953835 02:39:57 INFO - Obtained file size: 21953835 02:40:01 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:40:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HLKeAgElR0CEQbRzcz-PFw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 02:40:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HLKeAgElR0CEQbRzcz-PFw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:40:01 INFO - Fetch https://queue.taskcluster.net/v1/task/HLKeAgElR0CEQbRzcz-PFw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 02:40:01 INFO - Http code: 200 02:40:01 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 02:40:01 INFO - x-amz-cf-id: te_VhifTqa_6NKSEc3IYRFU6hZ8TwYmwqtbyqWkVx4nN85oB_tPsoA== 02:40:01 INFO - x-amz-version-id: A9RM0o1COGZcAwMSvmMoy08cWlUEL436 02:40:02 INFO - Expected file size: 21953835 02:40:02 INFO - Obtained file size: 21953835 02:40:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HLKeAgElR0CEQbRzcz-PFw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 02:40:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HLKeAgElR0CEQbRzcz-PFw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:40:06 INFO - Fetch https://queue.taskcluster.net/v1/task/HLKeAgElR0CEQbRzcz-PFw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 02:40:07 INFO - Http code: 200 02:40:07 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 02:40:07 INFO - x-amz-cf-id: ZFh9yNrhxoaPFaSL9G5uQ9-dNXbJab1MjE6A0MSptFw2HjNJmkpO9Q== 02:40:07 INFO - x-amz-version-id: _hJ4zOrQEeIrSyBg91xjJV8LIckhiUaL 02:40:07 INFO - Expected file size: 14409038 02:40:07 INFO - Obtained file size: 14409038 02:40:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:40:08 INFO - trying https://queue.taskcluster.net/v1/task/HLKeAgElR0CEQbRzcz-PFw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:40:08 INFO - Downloading https://queue.taskcluster.net/v1/task/HLKeAgElR0CEQbRzcz-PFw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:40:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HLKeAgElR0CEQbRzcz-PFw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:40:10 INFO - Downloaded 63983620 bytes. 02:40:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HLKeAgElR0CEQbRzcz-PFw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:40:10 INFO - mkdir: /builds/slave/test/properties 02:40:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:40:10 INFO - Writing to file /builds/slave/test/properties/build_url 02:40:10 INFO - Contents: 02:40:10 INFO - build_url:https://queue.taskcluster.net/v1/task/HLKeAgElR0CEQbRzcz-PFw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:40:11 INFO - Running post-action listener: _resource_record_post_action 02:40:11 INFO - Running post-action listener: set_extra_try_arguments 02:40:11 INFO - [mozharness: 2016-12-11 10:40:11.599198Z] Finished download-and-extract step (success) 02:40:11 INFO - [mozharness: 2016-12-11 10:40:11.599424Z] Running populate-webroot step. 02:40:11 INFO - Running pre-action listener: _resource_record_pre_action 02:40:11 INFO - Running main action method: populate_webroot 02:40:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:40:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:40:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:40:11 INFO - '--tppagecycles', 02:40:11 INFO - '7'], 02:40:11 INFO - 'tests': ['tsvgm']}}, 02:40:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:40:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:40:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:40:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:40:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:40:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:40:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:40:11 INFO - 'talos_options': ['--disable-e10s'], 02:40:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:40:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:40:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:40:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:40:11 INFO - 'talos_options': ['--disable-e10s'], 02:40:11 INFO - 'tests': ['damp', 'tps']}, 02:40:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:40:11 INFO - 'tests': ['damp', 'tps']}, 02:40:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:40:11 INFO - 'tests': ['dromaeo_dom']}, 02:40:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:40:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:40:11 INFO - 'tests': ['basic_compositor_video']}, 02:40:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:40:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:40:11 INFO - 'tests': ['a11yr', 02:40:11 INFO - 'ts_paint', 02:40:11 INFO - 'tpaint', 02:40:11 INFO - 'sessionrestore', 02:40:11 INFO - 'sessionrestore_no_auto_restore', 02:40:11 INFO - 'tabpaint']}, 02:40:11 INFO - 'other-e10s': {'tests': ['a11yr', 02:40:11 INFO - 'ts_paint', 02:40:11 INFO - 'tpaint', 02:40:11 INFO - 'sessionrestore', 02:40:11 INFO - 'sessionrestore_no_auto_restore', 02:40:11 INFO - 'tabpaint']}, 02:40:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:40:11 INFO - 'ts_paint', 02:40:11 INFO - 'tpaint', 02:40:11 INFO - 'sessionrestore', 02:40:11 INFO - 'sessionrestore_no_auto_restore', 02:40:11 INFO - 'tabpaint']}, 02:40:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:40:11 INFO - 'ts_paint', 02:40:11 INFO - 'tpaint', 02:40:11 INFO - 'sessionrestore', 02:40:11 INFO - 'sessionrestore_no_auto_restore', 02:40:11 INFO - 'tabpaint']}, 02:40:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:40:11 INFO - 'tests': ['a11yr', 02:40:11 INFO - 'ts_paint', 02:40:11 INFO - 'tpaint', 02:40:11 INFO - 'sessionrestore', 02:40:11 INFO - 'sessionrestore_no_auto_restore', 02:40:11 INFO - 'tabpaint']}, 02:40:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:40:11 INFO - 'tests': ['a11yr', 02:40:11 INFO - 'ts_paint', 02:40:11 INFO - 'tpaint', 02:40:11 INFO - 'sessionrestore', 02:40:11 INFO - 'sessionrestore_no_auto_restore', 02:40:11 INFO - 'tabpaint']}, 02:40:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:40:11 INFO - 'tests': ['tsvgx', 02:40:11 INFO - 'tsvgr_opacity', 02:40:11 INFO - 'tart', 02:40:11 INFO - 'tscrollx', 02:40:11 INFO - 'cart']}, 02:40:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:40:11 INFO - 'tsvgr_opacity', 02:40:11 INFO - 'tart', 02:40:11 INFO - 'tscrollx', 02:40:11 INFO - 'cart']}, 02:40:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:40:11 INFO - 'talos_options': ['--disable-e10s'], 02:40:11 INFO - 'tests': ['tp5o']}, 02:40:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:40:11 INFO - 'tests': ['tp5o']}, 02:40:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:40:11 INFO - 'talos_options': ['--disable-e10s', 02:40:11 INFO - '--xperf_path', 02:40:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:40:11 INFO - 'tests': ['tp5n']}, 02:40:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:40:11 INFO - 'talos_options': ['--xperf_path', 02:40:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:40:11 INFO - 'tests': ['tp5n']}}, 02:40:11 INFO - 'talos.zip': {'path': '', 02:40:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:40:11 INFO - Running post-action listener: _resource_record_post_action 02:40:11 INFO - [mozharness: 2016-12-11 10:40:11.619046Z] Finished populate-webroot step (success) 02:40:11 INFO - [mozharness: 2016-12-11 10:40:11.619135Z] Running create-virtualenv step. 02:40:11 INFO - Running pre-action listener: _resource_record_pre_action 02:40:11 INFO - Running main action method: create_virtualenv 02:40:11 INFO - Creating virtualenv /builds/slave/test/build/venv 02:40:11 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:40:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:40:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:40:11 INFO - Using real prefix '/usr' 02:40:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:40:12 INFO - Installing distribute.............................................................................................................................................................................................done. 02:40:14 INFO - Installing pip.................done. 02:40:14 INFO - Return code: 0 02:40:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:40:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:40:14 INFO - Reading from file tmpfile_stdout 02:40:14 INFO - Output received: 02:40:14 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:40:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:40: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')]} 02:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40: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')]} 02:40:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:14 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 0x7f3b9ebc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee1f60>, '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 0xee2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee31d0>, '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': '4300f881736b422476174874000001bc-1481452692.256544-55095987', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:40:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:40:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:40:14 INFO - Using env: {'DISPLAY': ':0', 02:40:14 INFO - 'HOME': '/home/cltbld', 02:40:14 INFO - 'LANG': 'en_US.UTF-8', 02:40:14 INFO - 'LANGUAGE': 'en_US:en', 02:40:14 INFO - 'LOGNAME': 'cltbld', 02:40:14 INFO - 'MAIL': '/var/mail/cltbld', 02:40:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:14 INFO - 'MOZ_NO_REMOTE': '1', 02:40:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:14 INFO - 'NO_EM_RESTART': '1', 02:40:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:14 INFO - 'PWD': '/builds/slave/test', 02:40:14 INFO - 'SHELL': '/bin/bash', 02:40:14 INFO - 'SHLVL': '1', 02:40:14 INFO - 'TERM': 'linux', 02:40:14 INFO - 'TMOUT': '86400', 02:40:14 INFO - 'USER': 'cltbld', 02:40:14 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1481452692.256544-55095987', 02:40:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:14 INFO - '_': '/tools/buildbot/bin/python'} 02:40:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:14 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:40:14 INFO - Cleaning up... 02:40:14 INFO - Return code: 0 02:40:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:40: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')]} 02:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40: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')]} 02:40:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:14 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 0x7f3b9ebc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee1f60>, '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 0xee2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee31d0>, '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': '4300f881736b422476174874000001bc-1481452692.256544-55095987', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:40:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:40:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:40:14 INFO - Using env: {'DISPLAY': ':0', 02:40:14 INFO - 'HOME': '/home/cltbld', 02:40:14 INFO - 'LANG': 'en_US.UTF-8', 02:40:14 INFO - 'LANGUAGE': 'en_US:en', 02:40:14 INFO - 'LOGNAME': 'cltbld', 02:40:14 INFO - 'MAIL': '/var/mail/cltbld', 02:40:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:14 INFO - 'MOZ_NO_REMOTE': '1', 02:40:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:14 INFO - 'NO_EM_RESTART': '1', 02:40:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:14 INFO - 'PWD': '/builds/slave/test', 02:40:14 INFO - 'SHELL': '/bin/bash', 02:40:14 INFO - 'SHLVL': '1', 02:40:14 INFO - 'TERM': 'linux', 02:40:14 INFO - 'TMOUT': '86400', 02:40:14 INFO - 'USER': 'cltbld', 02:40:14 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1481452692.256544-55095987', 02:40:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:14 INFO - '_': '/tools/buildbot/bin/python'} 02:40:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:14 INFO - Downloading/unpacking psutil>=3.1.1 02:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:40:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:40:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:40:16 INFO - Installing collected packages: psutil 02:40:16 INFO - Running setup.py install for psutil 02:40:17 INFO - building 'psutil._psutil_linux' extension 02:40:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:40:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:40:17 INFO - building 'psutil._psutil_posix' extension 02:40:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:40:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:40:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:40:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:40:17 INFO - Successfully installed psutil 02:40:17 INFO - Cleaning up... 02:40:17 INFO - Return code: 0 02:40:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:40:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:40:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:17 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 0x7f3b9ebc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee1f60>, '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 0xee2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee31d0>, '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': '4300f881736b422476174874000001bc-1481452692.256544-55095987', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:40:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:40:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:40:17 INFO - Using env: {'DISPLAY': ':0', 02:40:17 INFO - 'HOME': '/home/cltbld', 02:40:17 INFO - 'LANG': 'en_US.UTF-8', 02:40:17 INFO - 'LANGUAGE': 'en_US:en', 02:40:17 INFO - 'LOGNAME': 'cltbld', 02:40:17 INFO - 'MAIL': '/var/mail/cltbld', 02:40:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:17 INFO - 'MOZ_NO_REMOTE': '1', 02:40:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:17 INFO - 'NO_EM_RESTART': '1', 02:40:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:17 INFO - 'PWD': '/builds/slave/test', 02:40:17 INFO - 'SHELL': '/bin/bash', 02:40:17 INFO - 'SHLVL': '1', 02:40:17 INFO - 'TERM': 'linux', 02:40:17 INFO - 'TMOUT': '86400', 02:40:17 INFO - 'USER': 'cltbld', 02:40:17 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1481452692.256544-55095987', 02:40:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:17 INFO - '_': '/tools/buildbot/bin/python'} 02:40:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:40:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:40:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:40:19 INFO - Installing collected packages: mozsystemmonitor 02:40:19 INFO - Running setup.py install for mozsystemmonitor 02:40:19 INFO - Successfully installed mozsystemmonitor 02:40:19 INFO - Cleaning up... 02:40:19 INFO - Return code: 0 02:40:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:40:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:40:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:40:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40: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', '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 0x7f3b9ebc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee1f60>, '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 0xee2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee31d0>, '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': '4300f881736b422476174874000001bc-1481452692.256544-55095987', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:40: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:40: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 jsonschema==2.5.1 02:40:19 INFO - Using env: {'DISPLAY': ':0', 02:40:19 INFO - 'HOME': '/home/cltbld', 02:40:19 INFO - 'LANG': 'en_US.UTF-8', 02:40:19 INFO - 'LANGUAGE': 'en_US:en', 02:40:19 INFO - 'LOGNAME': 'cltbld', 02:40:19 INFO - 'MAIL': '/var/mail/cltbld', 02:40:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:19 INFO - 'MOZ_NO_REMOTE': '1', 02:40:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:19 INFO - 'NO_EM_RESTART': '1', 02:40:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:19 INFO - 'PWD': '/builds/slave/test', 02:40:19 INFO - 'SHELL': '/bin/bash', 02:40:19 INFO - 'SHLVL': '1', 02:40:19 INFO - 'TERM': 'linux', 02:40:19 INFO - 'TMOUT': '86400', 02:40:19 INFO - 'USER': 'cltbld', 02:40:19 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1481452692.256544-55095987', 02:40:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:19 INFO - '_': '/tools/buildbot/bin/python'} 02:40:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:20 INFO - Downloading/unpacking jsonschema==2.5.1 02:40: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 02:40: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 02:40: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 02:40: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 02:40: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 02:40: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 02:40:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:40:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:22 INFO - Downloading functools32-3.2.3-2.tar.gz 02:40:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:40:22 INFO - warning: no files found matching '*.txt' 02:40:22 INFO - no previously-included directories found matching 'build' 02:40:22 INFO - no previously-included directories found matching 'dist' 02:40:22 INFO - no previously-included directories found matching '.git*' 02:40:22 INFO - Installing collected packages: jsonschema, functools32 02:40:22 INFO - Running setup.py install for functools32 02:40:22 INFO - warning: no files found matching '*.txt' 02:40:22 INFO - no previously-included directories found matching 'build' 02:40:22 INFO - no previously-included directories found matching 'dist' 02:40:22 INFO - no previously-included directories found matching '.git*' 02:40:22 INFO - Successfully installed jsonschema functools32 02:40:22 INFO - Cleaning up... 02:40:22 INFO - Return code: 0 02:40:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:40:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:40:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40: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', '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 0x7f3b9ebc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee1f60>, '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 0xee2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee31d0>, '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': '4300f881736b422476174874000001bc-1481452692.256544-55095987', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:40: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:40: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 functools32==3.2.3-2 02:40:22 INFO - Using env: {'DISPLAY': ':0', 02:40:22 INFO - 'HOME': '/home/cltbld', 02:40:22 INFO - 'LANG': 'en_US.UTF-8', 02:40:22 INFO - 'LANGUAGE': 'en_US:en', 02:40:22 INFO - 'LOGNAME': 'cltbld', 02:40:22 INFO - 'MAIL': '/var/mail/cltbld', 02:40:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:22 INFO - 'MOZ_NO_REMOTE': '1', 02:40:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:22 INFO - 'NO_EM_RESTART': '1', 02:40:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:22 INFO - 'PWD': '/builds/slave/test', 02:40:22 INFO - 'SHELL': '/bin/bash', 02:40:22 INFO - 'SHLVL': '1', 02:40:22 INFO - 'TERM': 'linux', 02:40:22 INFO - 'TMOUT': '86400', 02:40:22 INFO - 'USER': 'cltbld', 02:40:22 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1481452692.256544-55095987', 02:40:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:22 INFO - '_': '/tools/buildbot/bin/python'} 02:40:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:40:22 INFO - Cleaning up... 02:40:23 INFO - Return code: 0 02:40:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:40:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:40:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:40:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:23 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 0x7f3b9ebc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee1f60>, '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 0xee2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee31d0>, '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': '4300f881736b422476174874000001bc-1481452692.256544-55095987', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:40:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:40:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:40:23 INFO - Using env: {'DISPLAY': ':0', 02:40:23 INFO - 'HOME': '/home/cltbld', 02:40:23 INFO - 'LANG': 'en_US.UTF-8', 02:40:23 INFO - 'LANGUAGE': 'en_US:en', 02:40:23 INFO - 'LOGNAME': 'cltbld', 02:40:23 INFO - 'MAIL': '/var/mail/cltbld', 02:40:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:23 INFO - 'MOZ_NO_REMOTE': '1', 02:40:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:23 INFO - 'NO_EM_RESTART': '1', 02:40:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:23 INFO - 'PWD': '/builds/slave/test', 02:40:23 INFO - 'SHELL': '/bin/bash', 02:40:23 INFO - 'SHLVL': '1', 02:40:23 INFO - 'TERM': 'linux', 02:40:23 INFO - 'TMOUT': '86400', 02:40:23 INFO - 'USER': 'cltbld', 02:40:23 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1481452692.256544-55095987', 02:40:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:23 INFO - '_': '/tools/buildbot/bin/python'} 02:40:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:23 INFO - Downloading/unpacking blobuploader==1.2.4 02:40:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:25 INFO - Downloading blobuploader-1.2.4.tar.gz 02:40:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:40:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:40:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:25 INFO - Downloading docopt-0.6.1.tar.gz 02:40:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:40:25 INFO - Installing collected packages: blobuploader, requests, docopt 02:40:25 INFO - Running setup.py install for blobuploader 02:40:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:40:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:40:26 INFO - Running setup.py install for requests 02:40:26 INFO - Running setup.py install for docopt 02:40:26 INFO - Successfully installed blobuploader requests docopt 02:40:26 INFO - Cleaning up... 02:40:26 INFO - Return code: 0 02:40:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:40:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:40:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:40:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:26 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 0x7f3b9ebc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee1f60>, '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 0xee2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee31d0>, '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': '4300f881736b422476174874000001bc-1481452692.256544-55095987', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:40:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:40:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:40:26 INFO - Using env: {'DISPLAY': ':0', 02:40:26 INFO - 'HOME': '/home/cltbld', 02:40:26 INFO - 'LANG': 'en_US.UTF-8', 02:40:26 INFO - 'LANGUAGE': 'en_US:en', 02:40:26 INFO - 'LOGNAME': 'cltbld', 02:40:26 INFO - 'MAIL': '/var/mail/cltbld', 02:40:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:26 INFO - 'MOZ_NO_REMOTE': '1', 02:40:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:26 INFO - 'NO_EM_RESTART': '1', 02:40:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:26 INFO - 'PWD': '/builds/slave/test', 02:40:26 INFO - 'SHELL': '/bin/bash', 02:40:26 INFO - 'SHLVL': '1', 02:40:26 INFO - 'TERM': 'linux', 02:40:26 INFO - 'TMOUT': '86400', 02:40:26 INFO - 'USER': 'cltbld', 02:40:26 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1481452692.256544-55095987', 02:40:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:26 INFO - '_': '/tools/buildbot/bin/python'} 02:40:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:40:26 INFO - Running setup.py (path:/tmp/pip-lYN0kE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:40:26 INFO - Running setup.py (path:/tmp/pip-fYHrKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:40:26 INFO - Running setup.py (path:/tmp/pip-3JzN0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:40:27 INFO - Running setup.py (path:/tmp/pip-yPyuHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:40:27 INFO - Running setup.py (path:/tmp/pip-7iGBJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:40:27 INFO - Running setup.py (path:/tmp/pip-aSa2Db-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:40:27 INFO - Running setup.py (path:/tmp/pip-lpo003-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:40:27 INFO - Running setup.py (path:/tmp/pip-9l33PG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:40:27 INFO - Running setup.py (path:/tmp/pip-80a3SZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:40:27 INFO - Running setup.py (path:/tmp/pip-jH0qja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:40:27 INFO - Running setup.py (path:/tmp/pip-45udFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:40:27 INFO - Running setup.py (path:/tmp/pip-wk4mU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:40:27 INFO - Running setup.py (path:/tmp/pip-RkKSce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:40:27 INFO - Running setup.py (path:/tmp/pip-xnZgKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:40:27 INFO - Running setup.py (path:/tmp/pip-eCQsb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:40:27 INFO - Running setup.py (path:/tmp/pip-epuWB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:40:27 INFO - Running setup.py (path:/tmp/pip-3cJQyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:40:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:40:28 INFO - Running setup.py install for manifestparser 02:40:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:40:28 INFO - Running setup.py install for mozcrash 02:40:28 INFO - Running setup.py install for mozdebug 02:40:28 INFO - Running setup.py install for mozdevice 02:40:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:40:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:40:28 INFO - Running setup.py install for mozfile 02:40:28 INFO - Running setup.py install for mozhttpd 02:40:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:40:28 INFO - Running setup.py install for mozinfo 02:40:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:40:28 INFO - Running setup.py install for mozInstall 02:40:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:40:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:40:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:40:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:40:28 INFO - Running setup.py install for mozleak 02:40:28 INFO - Running setup.py install for mozlog 02:40:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:40:29 INFO - Running setup.py install for moznetwork 02:40:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:40:29 INFO - Running setup.py install for mozprocess 02:40:29 INFO - Running setup.py install for mozprofile 02:40:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:40:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:40:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:40:29 INFO - Running setup.py install for mozrunner 02:40:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:40:29 INFO - Running setup.py install for mozscreenshot 02:40:29 INFO - Running setup.py install for moztest 02:40:29 INFO - Running setup.py install for mozversion 02:40:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:40:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:40:29 INFO - Cleaning up... 02:40:29 INFO - Return code: 0 02:40:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:40:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:40:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:40:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:29 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 0x7f3b9ebc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee1f60>, '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 0xee2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee31d0>, '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': '4300f881736b422476174874000001bc-1481452692.256544-55095987', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:40:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:40:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:40:29 INFO - Using env: {'DISPLAY': ':0', 02:40:29 INFO - 'HOME': '/home/cltbld', 02:40:29 INFO - 'LANG': 'en_US.UTF-8', 02:40:29 INFO - 'LANGUAGE': 'en_US:en', 02:40:29 INFO - 'LOGNAME': 'cltbld', 02:40:29 INFO - 'MAIL': '/var/mail/cltbld', 02:40:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:29 INFO - 'MOZ_NO_REMOTE': '1', 02:40:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:29 INFO - 'NO_EM_RESTART': '1', 02:40:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:29 INFO - 'PWD': '/builds/slave/test', 02:40:29 INFO - 'SHELL': '/bin/bash', 02:40:29 INFO - 'SHLVL': '1', 02:40:29 INFO - 'TERM': 'linux', 02:40:29 INFO - 'TMOUT': '86400', 02:40:29 INFO - 'USER': 'cltbld', 02:40:29 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1481452692.256544-55095987', 02:40:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:29 INFO - '_': '/tools/buildbot/bin/python'} 02:40:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:40:30 INFO - Running setup.py (path:/tmp/pip-8fO79e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:40:30 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:40:30 INFO - Running setup.py (path:/tmp/pip-4apk8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:40:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:40:30 INFO - Running setup.py (path:/tmp/pip-CoaPdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:40:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:40:30 INFO - Running setup.py (path:/tmp/pip-lmaBp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:40:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:40:30 INFO - Running setup.py (path:/tmp/pip-ZaiPY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:40:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:40:30 INFO - Running setup.py (path:/tmp/pip-4H7HEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:40:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:40:30 INFO - Running setup.py (path:/tmp/pip-kf_RLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:40:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:40:30 INFO - Running setup.py (path:/tmp/pip-nZzneo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:40:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:40:30 INFO - Running setup.py (path:/tmp/pip-yj0krv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:40:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:40:30 INFO - Running setup.py (path:/tmp/pip-2acuKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:40:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:40:30 INFO - Running setup.py (path:/tmp/pip-Id7BKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:40:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:40:30 INFO - Running setup.py (path:/tmp/pip-AaKTEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:40:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:40:30 INFO - Running setup.py (path:/tmp/pip-g6nUsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:40:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:40:31 INFO - Running setup.py (path:/tmp/pip-kxIgbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:40:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:40:31 INFO - Running setup.py (path:/tmp/pip-vfbYY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:40:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:40:31 INFO - Running setup.py (path:/tmp/pip-V15QuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:40:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:40:31 INFO - Running setup.py (path:/tmp/pip-a2n9EE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:40:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:40:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:40:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:40:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:40:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:40:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:40:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:33 INFO - Downloading blessings-1.6.tar.gz 02:40:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:40:33 INFO - Installing collected packages: blessings 02:40:33 INFO - Running setup.py install for blessings 02:40:33 INFO - Successfully installed blessings 02:40:33 INFO - Cleaning up... 02:40:33 INFO - Return code: 0 02:40:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:40:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:40:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:40:33 INFO - Reading from file tmpfile_stdout 02:40:33 INFO - Current package versions: 02:40:33 INFO - argparse == 1.2.1 02:40:33 INFO - blessings == 1.6 02:40:33 INFO - blobuploader == 1.2.4 02:40:33 INFO - docopt == 0.6.1 02:40:33 INFO - functools32 == 3.2.3-2 02:40:33 INFO - jsonschema == 2.5.1 02:40:33 INFO - manifestparser == 1.1 02:40:33 INFO - mozInstall == 1.12 02:40:33 INFO - mozcrash == 1.0 02:40:33 INFO - mozdebug == 0.1 02:40:33 INFO - mozdevice == 0.48 02:40:33 INFO - mozfile == 1.2 02:40:33 INFO - mozhttpd == 0.7 02:40:33 INFO - mozinfo == 0.9 02:40:33 INFO - mozleak == 0.1 02:40:33 INFO - mozlog == 3.4 02:40:33 INFO - moznetwork == 0.27 02:40:33 INFO - mozprocess == 0.23 02:40:33 INFO - mozprofile == 0.28 02:40:33 INFO - mozrunner == 6.13 02:40:33 INFO - mozscreenshot == 0.1 02:40:33 INFO - mozsystemmonitor == 0.3 02:40:33 INFO - moztest == 0.7 02:40:33 INFO - mozversion == 1.4 02:40:33 INFO - psutil == 3.1.1 02:40:33 INFO - requests == 1.2.3 02:40:33 INFO - wsgiref == 0.1.2 02:40:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:40:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:33 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 0x7f3b9ebc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee1f60>, '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 0xee2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee31d0>, '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': '4300f881736b422476174874000001bc-1481452692.256544-55095987', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:40:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:40:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:40:33 INFO - Using env: {'DISPLAY': ':0', 02:40:33 INFO - 'HOME': '/home/cltbld', 02:40:33 INFO - 'LANG': 'en_US.UTF-8', 02:40:33 INFO - 'LANGUAGE': 'en_US:en', 02:40:33 INFO - 'LOGNAME': 'cltbld', 02:40:33 INFO - 'MAIL': '/var/mail/cltbld', 02:40:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:33 INFO - 'MOZ_NO_REMOTE': '1', 02:40:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:33 INFO - 'NO_EM_RESTART': '1', 02:40:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:33 INFO - 'PWD': '/builds/slave/test', 02:40:33 INFO - 'SHELL': '/bin/bash', 02:40:33 INFO - 'SHLVL': '1', 02:40:33 INFO - 'TERM': 'linux', 02:40:33 INFO - 'TMOUT': '86400', 02:40:33 INFO - 'USER': 'cltbld', 02:40:33 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1481452692.256544-55095987', 02:40:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:33 INFO - '_': '/tools/buildbot/bin/python'} 02:40:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:40:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:40:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:40:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:40:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:40:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:40:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:40:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:40:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:40:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:40:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:40:34 INFO - Cleaning up... 02:40:34 INFO - Return code: 0 02:40:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:40: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')]} 02:40:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40: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')]} 02:40:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:34 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 0x7f3b9ebc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee1f60>, '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 0xee2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee31d0>, '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': '4300f881736b422476174874000001bc-1481452692.256544-55095987', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:40:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:40:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:40:34 INFO - Using env: {'DISPLAY': ':0', 02:40:34 INFO - 'HOME': '/home/cltbld', 02:40:34 INFO - 'LANG': 'en_US.UTF-8', 02:40:34 INFO - 'LANGUAGE': 'en_US:en', 02:40:34 INFO - 'LOGNAME': 'cltbld', 02:40:34 INFO - 'MAIL': '/var/mail/cltbld', 02:40:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:34 INFO - 'MOZ_NO_REMOTE': '1', 02:40:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:34 INFO - 'NO_EM_RESTART': '1', 02:40:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:34 INFO - 'PWD': '/builds/slave/test', 02:40:34 INFO - 'SHELL': '/bin/bash', 02:40:34 INFO - 'SHLVL': '1', 02:40:34 INFO - 'TERM': 'linux', 02:40:34 INFO - 'TMOUT': '86400', 02:40:34 INFO - 'USER': 'cltbld', 02:40:34 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1481452692.256544-55095987', 02:40:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:34 INFO - '_': '/tools/buildbot/bin/python'} 02:40:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:40:34 INFO - Cleaning up... 02:40:34 INFO - Return code: 0 02:40:34 INFO - Running post-action listener: _resource_record_post_action 02:40:34 INFO - Running post-action listener: _start_resource_monitoring 02:40:34 INFO - Starting resource monitoring. 02:40:34 INFO - [mozharness: 2016-12-11 10:40:34.319171Z] Finished create-virtualenv step (success) 02:40:34 INFO - [mozharness: 2016-12-11 10:40:34.319673Z] Running install step. 02:40:34 INFO - Running pre-action listener: _resource_record_pre_action 02:40:34 INFO - Running main action method: install 02:40:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:40:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:40:34 INFO - Reading from file tmpfile_stdout 02:40:34 INFO - Detecting whether we're running mozinstall >=1.0... 02:40:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:40:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:40:34 INFO - Reading from file tmpfile_stdout 02:40:34 INFO - Output received: 02:40:34 INFO - Usage: mozinstall [options] installer 02:40:34 INFO - Options: 02:40:34 INFO - -h, --help show this help message and exit 02:40:34 INFO - -d DEST, --destination=DEST 02:40:34 INFO - Directory to install application into. [default: 02:40:34 INFO - "/builds/slave/test"] 02:40:34 INFO - --app=APP Application being installed. [default: firefox] 02:40:34 INFO - mkdir: /builds/slave/test/build/application 02:40:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:40:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:40:50 INFO - Reading from file tmpfile_stdout 02:40:50 INFO - Output received: 02:40:50 INFO - /builds/slave/test/build/application/firefox/firefox 02:40:50 INFO - Running post-action listener: _resource_record_post_action 02:40:50 INFO - [mozharness: 2016-12-11 10:40:50.537921Z] Finished install step (success) 02:40:50 INFO - [mozharness: 2016-12-11 10:40:50.538163Z] Running run-tests step. 02:40:50 INFO - Running pre-action listener: _resource_record_pre_action 02:40:50 INFO - Running main action method: run_tests 02:40:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:40:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:40:50 INFO - Python 2.7.3 02:40:50 INFO - Return code: 0 02:40:50 INFO - grabbing minidump binary from tooltool 02:40:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:40:50 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 0xee1f60>, '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 0xee2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee31d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:40:50 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:40:50 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:40:50 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:40:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:40:50 INFO - Return code: 0 02:40:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:40:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:40:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:40:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:40:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:40:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HLKeAgElR0CEQbRzcz-PFw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:40:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HLKeAgElR0CEQbRzcz-PFw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:40:50 INFO - Using env: {'DISPLAY': ':0', 02:40:50 INFO - 'HOME': '/home/cltbld', 02:40:50 INFO - 'LANG': 'en_US.UTF-8', 02:40:50 INFO - 'LANGUAGE': 'en_US:en', 02:40:50 INFO - 'LOGNAME': 'cltbld', 02:40:50 INFO - 'MAIL': '/var/mail/cltbld', 02:40:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:40:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:40:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:50 INFO - 'MOZ_NO_REMOTE': '1', 02:40:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:40:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:50 INFO - 'NO_EM_RESTART': '1', 02:40:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:50 INFO - 'PWD': '/builds/slave/test', 02:40:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:40:50 INFO - 'SHELL': '/bin/bash', 02:40:50 INFO - 'SHLVL': '1', 02:40:50 INFO - 'TERM': 'linux', 02:40:50 INFO - 'TMOUT': '86400', 02:40:50 INFO - 'USER': 'cltbld', 02:40:50 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1481452692.256544-55095987', 02:40:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:50 INFO - '_': '/tools/buildbot/bin/python'} 02:40:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HLKeAgElR0CEQbRzcz-PFw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:40:50 INFO - mozversion application_buildid: 20161211004007 02:40:50 INFO - mozversion application_changeset: 2ec25b58608c6e815b1b6b2901561adb0d24e9d3 02:40:50 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:40:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:40:50 INFO - mozversion application_name: Firefox 02:40:50 INFO - mozversion application_remotingname: firefox-dev 02:40:50 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:40:50 INFO - mozversion application_vendor: Mozilla 02:40:50 INFO - mozversion application_version: 52.0a2 02:40:50 INFO - mozversion platform_buildid: 20161211004007 02:40:50 INFO - mozversion platform_changeset: 2ec25b58608c6e815b1b6b2901561adb0d24e9d3 02:40:50 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:40:50 INFO - mozversion platform_version: 52.0a2 02:40:50 INFO - using testdate: 1481452850 02:40:50 INFO - actual date: 1481452850 02:40:50 INFO - starting webserver on 'localhost:46765' 02:40:50 INFO - SUITE-START | Running 2 tests 02:40:50 INFO - TEST-START | dromaeo_css 02:40:50 INFO - operating with platform_type : linux_ 02:40:50 INFO - Initialising browser for dromaeo_css test... 02:40:50 INFO - TEST-INFO | started process 28416 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4jvnEW/profile http://localhost:46765/getInfo.html) 02:40:55 INFO - PROCESS | 28416 | __metrics Screen width/height:1600/1200 02:40:55 INFO - PROCESS | 28416 | colorDepth:24 02:40:55 INFO - PROCESS | 28416 | Browser inner width/height: 1024/697 02:40:55 INFO - PROCESS | 28416 | __metrics 02:40:55 INFO - PROCESS | 28416 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:40:55 INFO - PROCESS | 28416 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:40:56 INFO - PROCESS | 28416 | console.error: PushService: 02:40:56 INFO - PROCESS | 28416 | stateChangeProcessEnqueue: Error transitioning state 02:40:56 INFO - PROCESS | 28416 | UnknownError 02:40:56 INFO - TEST-INFO | 28416: exit 0 02:40:56 INFO - Browser initialized. 02:40:56 INFO - Running cycle 1/1 for dromaeo_css test... 02:40:56 INFO - TEST-INFO | started process 28507 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4jvnEW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:41:08 INFO - PROCESS | 28507 | RSS: Main: 144572416 02:41:08 INFO - PROCESS | 28507 | 02:42:00 INFO - PROCESS | 28507 | 1481452920102 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:44:10 INFO - PROCESS | 28507 | Cycle 1(1): loaded http://localhost:46765/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46765/tests/dromaeo/cssquery-ext.html) 02:44:11 INFO - PROCESS | 28507 | RSS: Main: 291262464 02:44:11 INFO - PROCESS | 28507 | 02:47:14 INFO - PROCESS | 28507 | Cycle 1(1): loaded http://localhost:46765/tests/dromaeo/cssquery-ext.html (next: http://localhost:46765/tests/dromaeo/cssquery-jquery.html) 02:47:14 INFO - PROCESS | 28507 | RSS: Main: 232108032 02:47:14 INFO - PROCESS | 28507 | 02:50:16 INFO - PROCESS | 28507 | Cycle 1(1): loaded http://localhost:46765/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46765/tests/dromaeo/cssquery-mootools.html) 02:50:17 INFO - PROCESS | 28507 | RSS: Main: 218255360 02:50:17 INFO - PROCESS | 28507 | 02:53:19 INFO - PROCESS | 28507 | Cycle 1(1): loaded http://localhost:46765/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46765/tests/dromaeo/cssquery-prototype.html) 02:53:19 INFO - PROCESS | 28507 | RSS: Main: 183427072 02:53:19 INFO - PROCESS | 28507 | 02:56:22 INFO - PROCESS | 28507 | Cycle 1(1): loaded http://localhost:46765/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46765/tests/dromaeo/cssquery-yui.html) 02:56:22 INFO - PROCESS | 28507 | RSS: Main: 176185344 02:56:22 INFO - PROCESS | 28507 | 02:59:25 INFO - PROCESS | 28507 | Cycle 1(1): loaded http://localhost:46765/tests/dromaeo/cssquery-yui.html (next: http://localhost:46765/tests/dromaeo/cssquery-dojo.html) 02:59:25 INFO - PROCESS | 28507 | RSS: Main: 273170432 02:59:25 INFO - PROCESS | 28507 | 02:59:25 INFO - PROCESS | 28507 | __start_tp_report 02:59:25 INFO - PROCESS | 28507 | _x_x_mozilla_page_load 02:59:25 INFO - PROCESS | 28507 | _x_x_mozilla_page_load_details 02:59:25 INFO - PROCESS | 28507 | |i|pagename|runs| 02:59:25 INFO - PROCESS | 28507 | |0;dojo.html;3181.1569933967494;3215.1801290670883;3223.0492004858565;3242.0922141800306;3250.593675790526;5490.615656904019;5569.053260945639;5578.944210557893;5607.4112218217115;5611.3266408030995;5469.671819690821;5509.283793106891;5521.861953451165;5525.309336332948;5558.388577256498;4963.627727920411;4979.526944940225;5008.549230569248;5024.045431368028;5074.492550744914;4922.630802689812;4991.875203119915;5066.138756411419;5069.847904562869;5076.238564215379;4911.140550403683;4972.627052971024;4982.252662100677;5003.724795136284;5031.949680503203;4960.702357858522;5051.292819005343;5052.166392545244;5121.820736274212;5150.562202212779;4963.826266080706;5023.547880690755;5076.720780357079;5089.4147173074825;5096.719680417576;5291.788328466857;5333.973330133364;5390.4879036491475;5426.8371948841595;5495.422980587061;5786.594938354317;5795.710214489259;5807.651540907559;5882.617629854046;5921.585489015771;5945.643261404286;5950.821475355746;5959.314678811948;5965.4929331006915;5966.67183304918;5348.491893270133;5398.703071331075;5399.352077750616;5526.253955715927;5541.362743284493;6056.36408177135;6101.633901965807;6105.45050945417;6106.542009349317;6108.72510737009;5841.299044114733;5844.88310233793;5853.0635098384055;5856.385079566669;5878.823635290948;5720.456556627114;5770.42295770428;5894.528437725057;5935.465808077208;5977.820665380045;5932.436418540232;5939.22790037301;5939.673317967467;5960.0761881908375;5974.3428222895445;5872.765089396462;5916.940830591725;5929.05135178378;5929.703514824241;5932.822015339547;4385.144896745168;4396.516383197845;4496.842610508682;4534.977325113353;4588.151192029485;4078.632923036941;4079.204555111725;4086.0397806515443;4098.344264917599;4124.773137477468;5649.576281778883;5651.519620832193;5651.886962260814;5652.491275785199;5656.095024796013;5711.029125048752;5772.451617096369;5775.422457754191;5908.113782932594;5921.230240068763;5499.285092937973;5548.112302031655;5555.30558680165;5579.414161513064;5644.6330988485615;5096.0827051131155;5105.132127538327;5110.591152707774;5111.412187598474;5116.616253780907;6034.577579569564;6035.155078289043;6066.969665151646;6079.118527813443;6083.391660833881;5608.130739735348;5631.0427227372265;5950.613210141327;6040.879182416239;6054.39456054391;6215.595986260879;6228.03465462854;6252.280987686292;6256.749730010749;6260.780872669435;5889.234399528034;5891.734871930687;5895.67573783446;5899.882002359843;5930.525557955267;5727.083666613322;5773.740181691918;5815.011448053757;5953.523718102628;6038.5772995889865;5677.858053548694;5756.913646295226;5779.104238842986;5788.160716696139;5802.82591522255;5758.62568933018;5770.538356931352;5774.307083149881;5777.046787280052;5778.075507918713;5541.5843811715085;5666.178404131296;5715.057015592547;5718.142278658234;5726.656400615976;5668.574856885833;5780.306363236438;5794;5797.159411885169;5942.019566771434;5748.741306641295;5759.107338362561;5759.683217423082;5770.682612456355;5799.188113664006 02:59:25 INFO - PROCESS | 28507 | |1;ext.html;570.5920267009087;601.3715667127851;629.7890206780728;661.814691886272;673.3502170405558;34194.48708269375;44600.553994460046;45302.32046519296;45392.31911521321;45509.999999999956;46427;46787.298190527166;46788;46814.59556213319;46846.53153468464;8341.290990265805;8832.470051796881;9009.234215091725;9018.188363047324;9034.27725781939;8332.958335208346;10344.327618704798;10584.994425529563;10597.788044239149;10942.507587158558;10793.136549076055;10875.728106797354;10875.891241087567;10876.347419154836;10877.83683244752;10708.625198118067;10775.946120269427;10784.191185661028;10794.784104317949;10806.51370688313;10545.578176872916;10601.946990265;10606.893931060667;10616.893831061669;10621.097206737437;42076;42373.15253694909;42428.363574546405;42450.57549424497;42581;3716.089558058266;3859.4403811447182;3873.709471789627;3963.663088637469;4386.71486353386;31802.522962155585;32337.51493727596;32500;32908.17729556756;33976.49035264473;4079.5308539518037;4157.542670306264;4161.9375709364385;4168.7707176105305;4300.440942677463;269035;269171;269267.6536617324;269665;269675;37064.81467592645;38196.42705359422;62126;62563.37436625666;62613.686931565964;40213.195736085116;40423.393649095284;40584;40586.39120413196;40608.79695601503;16629;16799.83200168007;16802.915985419993;16812;16821.91589042047;12649.05132115095;12809.807852882213;13831.446742130403;13934.651633709238;14060.296985150702;9050.140236677506;9209.907900920905;9279.422498175327;9297.535123243946;9309.30180236485;3432.8626854926024;3488.4418493040994;3490.4938783876196;3547.3082748863726;3547.6629720176543;1028.665683652816;1079.2822772855964;1090.4166271045112;1136.2216881436243;1199.130630293048;34210.82894585511;34261.657383425845;34471.65528344735;34568.30863382718;34588.82705586506;1025.887152413234;1140.2474366917795;1165.1086918507349;1169.4386694386742;1183.2900259844025;16194.433194838124;18005.909970450324;18030.729539056923;18847.528811779543;18924.148413321433;569688;606129;608499;609620;866021;60017.09974350388;60373.39626603766;60671;60882.39117608767;60888;1436.4685066525453;1441.7188648213498;1445.8337291211644;1451.361400983564;1460.890433217513;32300.83849580737;35083.29833403369;35299.82350088233;35356.70399712275;35510.28979420449;54885;55639.44360556343;55709.164362535405;55747.442525574224;55781.163282551606;392248;393912;394334;395064;396497;27279.45441091207;28058.579121313604;30507.2373190672;30697.693023069485;31234;48283.75858120687;49107.01785964189;49966.25050624171;51776.48223517867;52112.21831672604;41366.793166033975;41915.37126943159;41988.1602367957;43007.139857202055;43136.568634313255;41396.586034139276;41697.37453938254;41791;43240.56759432366;43265.783671081444;41606;42109;42712.78643606762;42892.35661465143;43072.35391469068;34195.82902085573;36699;37396.81301593475;37668.84607186593;37749.4337584931;28779.42441151207;28870.71129288764;29112.56331154992;29218.123456296344;29298.853505732335 02:59:25 INFO - PROCESS | 28507 | |2;jquery.html;420.7538589924894;423.18114448542053;425.79349015727365;428.402378681739;447.97312161270327;18853.151608177646;18954.52613684657;20356;20448.182072717093;20509.692354614694;19668.803311966876;19905.900470497665;20563.28028519002;20641.793582064176;20765.584688306226;5733.569982251327;6066.120412540201;6069.241344831896;6077.665728384937;6081.331053584102;5833.533317334603;5841.503472204868;5882.441168089024;5969.552283578727;5989;5929.347771745104;5939.643621382709;5942.197803296564;5945.108233764927;5947.048472244442;5720.942790572103;5933.4659880610525;5934.198883150762;5972.6715030673295;5980.43185897339;5377.919331210035;5386.48828361305;5386.811461598825;5393.19102134679;5393.9730301348245;23476.413089672897;23917.402064948343;24232.51534969291;24337.269881903572;24587.262382128385;2373.8219633527383;2384.499255156419;2402.903883844644;2418.056957786465;2427;14663.41346346145;15146.545603631908;15280.694386112216;15378.461753838674;15973.520794376187;1784.5538615346163;1854.619802940394;1878.924843006278;1897.4781934967993;1934.1103092577432;80065.59967200184;80546;82252;82975.58512207461;83815.580922095;10999;11202;11275.097992160607;11519.76960460803;11554.94222528882;16283.104429256267;16331.755023674654;16344.346226150821;16348.75476867848;16360.34558617642;8747.343949203836;8793.120687931156;8823.69117080899;8937.910620893708;9100.681476148304;8662.220400164015;8667.739967800977;8703.129687031245;8850.20348168655;8889.19997200255;6892.931070689329;6994.720127230667;7011.333923277382;7016.5790052597;7157.24848890859;2018.8687735297453;2021.5451523407116;2029.1781828359537;2076.6677331626865;2091.6130515854616;764.3464837563914;982.8771403574553;1028.7736697926443;1060.9734756631146;1065.536491626145;19263.4220973371;19929.800701992794;20689;21253.574928501344;21794.128234870746;1025.348903446302;1027.6197806811379;1037.3568387599737;1064.324154162097;1084.9186311026704;10789.46052697362;11512.94243528777;11555.595554155565;11622.88377116218;11741.17811753169;531464;544026;546185;546556;555138;97016;97595.51202244086;99565;101098.494507527;101393.49303253584;1027.984580231297;1082.658962426833;1085.7231405991422;1088.1566785741113;1093.4532733633184;17630.55923601869;18003.2798688051;18398.816011840245;18799;18894.811051889305;45440;45724.54275457203;46176;46991.295130572384;48028.27957580709;63754;64454.355456444835;65362;66080.33919660741;66082.66958665175;8795.516246606498;9028.90971090307;9125.224355929555;9164.633414663338;9390.154886060287;12893;13284.402201900744;13350.599482015556;13521.459141634225;13907.791383129059;11697.06423486102;12087.214331068453;12095.334756588472;12097.57658481949;12327.445264963277;11653.671732039265;11852.940735296268;11931.164818462625;12008.219465734699;12044.277343359427;11664.825027624762;11748.530058797553;12168.2699038058;12359.75280494403;12397.504099836266;8778.166074222938;8846.115388461103;9129.315301352291;9239.630414783333;9455.952720236355;9011.909880901107;10967.396793176133;11308.886911130783;11395.031422329195;11897.453331066907 02:59:25 INFO - PROCESS | 28507 | |3;mootools.html;1475.3066058952293;1489.4712377106127;1641.1548052752828;1747;1810.3120814090653;7709.653065612047;8151.062627797805;8161.22468365505;8171.795705107375;8186.467879587837;7128.786136415903;7358.117025956879;7524.736634217804;7706.460547761645;7720.61396930154;2316.5019520803025;2353.1646265575732;2355.2580937004873;2356.799672027871;2372.9406764830933;2315.918942837001;2341.239097293378;2344.753800850912;2345.2495201535517;2363.822713296501;2031.9796802031938;2091.027672132458;2268.444231163359;2348.3189874936334;2350.7296660884044;2332.731735850382;2334.5097529518735;2335.883205839701;2339.6958395408487;2344.167820423759;2325.5813953488364;2341.8594884306995;2345.9648105278266;2346.601077816775;2347.1550241912896;8020.3984701147065;8063.233992770677;8068.233517815798;8079.676812927534;8082.878756818653;4955.083309587738;5100.336956195708;5104.3619547556555;5104.61715371345;5106;2952.129121909042;2982.358792859524;3171.809691418522;3198.280386912926;3201.08769000836;955.073578628729;959.2853324273461;980.3578655980344;1002.2733518199248;1017.6082208349765;10827.07969822566;10885.619003334845;10899.673009809718;10910.963458471353;10933.18001149909;4328.177646247203;4564.2012647786505;4582.793774280165;4583.175028494837;4596.17268891596;9401.576929038072;9401.858972115424;9414.29392795543;9416.482093484925;9419.623215071457;5091.618128640367;5154.768035438415;5159.355080614923;5174.844754657366;5175.870603234949;4644.5123262056995;4759.928601070987;4765.594924431392;4812.903741925142;4822.252550854623;3659.524261845943;3775.320442320409;3785.564660064073;3812.8284227209842;3868.3037053330672;1175.9941200293945;1296.1315918334737;1299.909006369564;1305.575687901436;1311.3377744239099;828.98342033159;852.3224036890687;950.9429434233969;959.6919408821794;986.3145114145743;5545.556355491551;5625.606207565431;5686.601937864392;5707.857303567444;5750.079987202112;962.37926537383;984.1732944326657;1006.3961623026125;1031.3966329697212;1057.2018126314583;3684.1158122050515;3688.5942546319884;3696.5194524711615;3704.148045949447;3716.925661486755;9510.09654082861;9933.155681766986;9937.850932236022;9953.054459826304;9955.900440995641;9881.505924703735;9884.11043006133;9904.108630223314;9906.702798916043;9917.702468925943;7660.693572257047;7792.493487923381;7804.609769511501;7813.531188128731;7816.49192802466;5527.917081243865;5559.916601250903;5685.459881311269;5705.144228365778;5812.7674893003805;9020.458772473672;9095.045020272775;9102.954485227532;9124.49815260167;9126.680566180152;8667.956660216658;8949.686760963335;8964.238039766693;9186.08139186076;9195.540222988957;7007.404370628554;7137.643117843983;7159.427245820426;7162.785116446515;7166.749163779451;7748.806279843049;7753.37972962173;7827.4129440293345;7831.921680783347;7836.960815195887;7079.610621415872;7232.312930271826;7235.602041887536;7330.926690733025;7429.219931907288;6975.162980442379;7033.331833475811;7034.507584469038;7109.075820143348;7267.927320726725;6302.149209856794;6405.455536279468;6407.967960160169;6420.229572451336;6435.549511534147;4555.908881822411;4564.612007979226;4625.537446255482;4704;4708.4349878014855;4570.4972453030805;4747.572718455355;4761;4859.757012149449;5116.386033675983 02:59:25 INFO - PROCESS | 28507 | |4;prototype.html;340.15810868101454;349.25608453992993;352.68963312285183;354.3780664933045;358.2333805655897;5096.3374761281075;5252.185911183763;5269.446708095652;5284.550813180879;5316.149416093426;5103.540681338679;5182.792688292464;5224.21636754487;5224.817131400402;5243.947560524393;4194.8112334945;4210.915781684364;4217.093324935138;4219.810108545123;4230.788460576974;4084.14233011068;4158.480189976253;4219.493660760713;4226.239276930151;4230.3865939438765;4129.4012368206595;4131.256373852705;4148.211839750453;4174.20690068886;4185;4107.301758701028;4125.752454852718;4157.459530261077;4158.4178215049915;4171.1438409907605;3711.628837116267;3724.348239058154;3730.7201959852846;3735.2529494101286;3736.2901048800913;5070.594352451832;5141.203113517411;5156.561692256163;5167.741612919339;5169.767360468788;4725.078609671115;4778.378810754614;4780.354652121954;4783.808647654089;4802.735849528274;5399.730013499309;5500.202470641774;5505.889882202334;5513.476219759116;5542.418046105141;4048.838046478137;4050.2102090092444;4052.5542190359038;4059.6549293310104;4090.3864420337186;5642.871425714873;5673.546116310686;5691.459311365414;5711.857203569903;5720.342160651495;4129.29801933672;4147.917041659211;4155.729877557949;4174.4364510791265;4192.7065105442325;4108.322126849096;4194.224068547329;4194.958050419517;4205.411242426063;4226;4713.528647135259;4715.457722361973;4725.905481890343;4729.69933268354;4735.810567577328;5512.614117011771;5518.365387980353;5531.861703457445;5540.252065971123;5554.2779438672715;1316.7885545298348;1318.6110097521255;1386.81278027467;1414.5402744108205;1415.9946438029115;959.6833045095102;972.7762614598682;979.5640939781729;991.9336713033374;1000.2048371544639;5151.2530683050745;5161.81933632321;5205.531502164823;5253.290805741252;5279.736013199325;5378.757955891994;5401.864953376197;5427.45725427462;5449.700266485302;5461.1808228766;5156.948430515722;5165;5166.767495462713;5187.559057480081;5429.4027656957705;2912.8689208985647;2913.67949525552;2928.707129287054;2939.5002849515636;2951.985240073786;5689.175069614966;5693;5721.656700597978;5781.768729250783;5810.489272789106;5437.483439073281;5564.833055008276;5606;5624.865723693082;5654.180143879197;5665.433456654301;5675.687837168913;5694.515966142924;5697.259356283656;5727;5345.6525325855255;5506.5870059746485;5549.889002220014;5560.471755183251;5631.493165615114;5386.5560912246765;5397.436217796515;5417.729113544386;5419;5440.564754819684;5671.865626874559;5678;5690.317161940594;5736.885262294814;5774;3844.6732027777953;3986.943459983049;4008.498937632796;4014.8193331299576;4073.877783666495;5488.588355873246;5535.920495503499;5536.667799932017;5552.52803511706;5567.8285468666445;5423.701696406735;5470.370907345547;5502.669839809464;5589;5621.35354434229;5528.838943821843;5536.975659503005;5542.667439953616;5556.860843526986;5564.165375193753;5301.204819276985;5452.154915988028;5454.563634909118;5499.560035197094;5507.697076660822;5555.694436806015;5558.138488534284;5563;5563.833085007456;5570.442955704397;5411.485908838654;5428.891422171613;5454.209139674805;5466.289382380265;5472.808451704172 02:59:25 INFO - PROCESS | 28507 | |5;yui.html;746.1158527145329;761.8285885675724;779.1118125337113;819.9713010044647;851.4337965253105;14635.560933171995;14638.634034149152;15217.086974781494;15608.219589020546;15618.765718514218;14399.496017639385;14971;15155.090694558306;15169.241537923115;15180.392784288642;850.5789634131114;866.9263112635433;874.6064271078009;874.8556488179443;875.2123089219722;865.212656482601;866.6663334616187;867.9609417576193;867.9913200867974;868.6481974800216;921.1847514949251;921.6774129054844;922.1792604581894;922.8200500902327;923.4920793563547;919.3656377099779;920.3557509743207;920.3603495570582;920.6087412849512;921.387277460488;669.6718607882151;670.2325836916751;671.5366397185926;671.9160104986877;672.0289182131821;13778.862211377858;13805.17168969865;13813.102148360324;14825.481108161162;15466.690666186612;14296.356663950148;14400.855991440056;14805.333759980718;14812.70374592513;14982.62543436412;11839.526418943318;11897.583584574584;12010.399480025964;12119.93940030303;12424.37878106091;3781.716371272138;3872;3874.9806250968563;3920.2551515212017;3922.3920292354733;64336;64531.03203451952;65034.349656503306;65507.3449265506;67472;11163.386013769159;11309.604163854226;11315.377654228932;11429.085673146128;11657.18399712029;20582.897085514476;20742.066607002722;20874;21168.682469762967;21208.78791212099;8224.917750822415;8330.541820199947;8401.831963360699;8441.282490988211;8721.956390218009;4450.3991961085485;4528.41130653013;4590.288505281686;4667.043256132485;4841.201201801734;3507.7895326280504;3627.238279961238;3630.364686179908;3631.055925459347;3632.20091579852;621.4003486635419;632.1118828046602;640.270092095012;641.1856941684035;644.5198327246231;727.5670975769409;751.2224847283036;754.4756394306014;765.2921048030549;777.3159619534773;9374.578143983537;10023.398596084258;10100.393976361442;10110.848337274947;10272.280940334105;640.2668944059026;704.8519810839679;709.7835160276062;715.3418854653731;724.1816747075876;4425.22558552252;4641.512641172628;4745.976270118627;4775.71345719258;4857.2228443449585;70185.64907175432;95385.5230723842;96772;97989;100481.49759251157;84465;84812.57593711992;85558;86163.56918215369;88615.11384886198;73347.63326183335;73978.26021739822;74058;75434.24565754383;75825.62087189528;9111.95444022802;9238;9265.166135047879;9527.57125929321;9532.666356677482;50748.49251507438;52617.210741838135;52732;52895.47104529059;52974;68531.31468685449;70484.64757676178;70832;71866.28133718805;72178.63910680624;13435.664108397368;13497.595072147458;13501.864981350061;13950;14566.19885906243;14325;14886.925565372103;14956.775648365066;15329.38682452734;16193.03162997618;13938.442462301395;14335.784963225351;14423.92788036053;14787.482438114614;15043.172625505702;13512.864871351161;13680.247586382446;13729.382177801823;14206.934479913842;14340;12212.145149839425;12358.876411236131;12501.56244531437;13553.390097445441;13577.253251071286;10973.912440501676;11301.660950171508;11564.132690048113;11941.283522988648;12718.618441446772;12248.387580620754;12610.243385396905;12644.178128421623;12651.430685618985;12701.301428421526 02:59:25 INFO - PROCESS | 28507 | __end_tp_report 02:59:25 INFO - PROCESS | 28507 | __start_cc_report 02:59:25 INFO - PROCESS | 28507 | _x_x_mozilla_cycle_collect,1540 02:59:25 INFO - PROCESS | 28507 | __end_cc_report 02:59:25 INFO - PROCESS | 28507 | __startTimestamp1481453965615__endTimestamp 02:59:25 INFO - PROCESS | 28507 | 02:59:25 INFO - PROCESS | 28507 | ------- Summary: start ------- 02:59:25 INFO - PROCESS | 28507 | Number of tests: 6 02:59:25 INFO - PROCESS | 28507 | 02:59:25 INFO - PROCESS | 28507 | [#0] dojo.html Cycles:165 Average:5489.58 Median:5715.06 stddev:621.79 (10.9%) stddev-sans-first:596.74 02:59:25 INFO - PROCESS | 28507 | Values: 3181.2 3215.2 3223.0 3242.1 3250.6 5490.6 5569.1 5578.9 5607.4 5611.3 5469.7 5509.3 5521.9 5525.3 5558.4 4963.6 4979.5 5008.5 5024.0 5074.5 4922.6 4991.9 5066.1 5069.8 5076.2 4911.1 4972.6 4982.3 5003.7 5031.9 4960.7 5051.3 5052.2 5121.8 5150.6 4963.8 5023.5 5076.7 5089.4 5096.7 5291.8 5334.0 5390.5 5426.8 5495.4 5786.6 5795.7 5807.7 5882.6 5921.6 5945.6 5950.8 5959.3 5965.5 5966.7 5348.5 5398.7 5399.4 5526.3 5541.4 6056.4 6101.6 6105.5 6106.5 6108.7 5841.3 5844.9 5853.1 5856.4 5878.8 5720.5 5770.4 5894.5 5935.5 5977.8 5932.4 5939.2 5939.7 5960.1 5974.3 5872.8 5916.9 5929.1 5929.7 5932.8 4385.1 4396.5 4496.8 4535.0 4588.2 4078.6 4079.2 4086.0 4098.3 4124.8 5649.6 5651.5 5651.9 5652.5 5656.1 5711.0 5772.5 5775.4 5908.1 5921.2 5499.3 5548.1 5555.3 5579.4 5644.6 5096.1 5105.1 5110.6 5111.4 5116.6 6034.6 6035.2 6067.0 6079.1 6083.4 5608.1 5631.0 5950.6 6040.9 6054.4 6215.6 6228.0 6252.3 6256.7 6260.8 5889.2 5891.7 5895.7 5899.9 5930.5 5727.1 5773.7 5815.0 5953.5 6038.6 5677.9 5756.9 5779.1 5788.2 5802.8 5758.6 5770.5 5774.3 5777.0 5778.1 5541.6 5666.2 5715.1 5718.1 5726.7 5668.6 5780.3 5794.0 5797.2 5942.0 5748.7 5759.1 5759.7 5770.7 5799.2 02:59:25 INFO - PROCESS | 28507 | 02:59:25 INFO - PROCESS | 28507 | [#1] ext.html Cycles:180 Average:59892.36 Median:37709.14 stddev:126047.74 (334.3%) stddev-sans-first:126322.65 02:59:25 INFO - PROCESS | 28507 | Values: 570.6 601.4 629.8 661.8 673.4 34194.5 44600.6 45302.3 45392.3 45510.0 46427.0 46787.3 46788.0 46814.6 46846.5 8341.3 8832.5 9009.2 9018.2 9034.3 8333.0 10344.3 10585.0 10597.8 10942.5 10793.1 10875.7 10875.9 10876.3 10877.8 10708.6 10775.9 10784.2 10794.8 10806.5 10545.6 10601.9 10606.9 10616.9 10621.1 42076.0 42373.2 42428.4 42450.6 42581.0 3716.1 3859.4 3873.7 3963.7 4386.7 31802.5 32337.5 32500.0 32908.2 33976.5 4079.5 4157.5 4161.9 4168.8 4300.4 269035.0 269171.0 269267.7 269665.0 269675.0 37064.8 38196.4 62126.0 62563.4 62613.7 40213.2 40423.4 40584.0 40586.4 40608.8 16629.0 16799.8 16802.9 16812.0 16821.9 12649.1 12809.8 13831.4 13934.7 14060.3 9050.1 9209.9 9279.4 9297.5 9309.3 3432.9 3488.4 3490.5 3547.3 3547.7 1028.7 1079.3 1090.4 1136.2 1199.1 34210.8 34261.7 34471.7 34568.3 34588.8 1025.9 1140.2 1165.1 1169.4 1183.3 16194.4 18005.9 18030.7 18847.5 18924.1 569688.0 606129.0 608499.0 609620.0 866021.0 60017.1 60373.4 60671.0 60882.4 60888.0 1436.5 1441.7 1445.8 1451.4 1460.9 32300.8 35083.3 35299.8 35356.7 35510.3 54885.0 55639.4 55709.2 55747.4 55781.2 392248.0 393912.0 394334.0 395064.0 396497.0 27279.5 28058.6 30507.2 30697.7 31234.0 48283.8 49107.0 49966.3 51776.5 52112.2 41366.8 41915.4 41988.2 43007.1 43136.6 41396.6 41697.4 41791.0 43240.6 43265.8 41606.0 42109.0 42712.8 42892.4 43072.4 34195.8 36699.0 37396.8 37668.8 37749.4 28779.4 28870.7 29112.6 29218.1 29298.9 02:59:25 INFO - PROCESS | 28507 | 02:59:25 INFO - PROCESS | 28507 | [#2] jquery.html Cycles:180 Average:31591.14 Median:2379.16 stddev:89690.45 (3769.8%) stddev-sans-first:89911.52 02:59:25 INFO - PROCESS | 28507 | Values: 420.8 423.2 425.8 428.4 448.0 18853.2 18954.5 20356.0 20448.2 20509.7 19668.8 19905.9 20563.3 20641.8 20765.6 5733.6 6066.1 6069.2 6077.7 6081.3 5833.5 5841.5 5882.4 5969.6 5989.0 5929.3 5939.6 5942.2 5945.1 5947.0 5720.9 5933.5 5934.2 5972.7 5980.4 5377.9 5386.5 5386.8 5393.2 5394.0 23476.4 23917.4 24232.5 24337.3 24587.3 2373.8 2384.5 2402.9 2418.1 2427.0 14663.4 15146.5 15280.7 15378.5 15973.5 1784.6 1854.6 1878.9 1897.5 1934.1 80065.6 80546.0 82252.0 82975.6 83815.6 10999.0 11202.0 11275.1 11519.8 11554.9 16283.1 16331.8 16344.3 16348.8 16360.3 8747.3 8793.1 8823.7 8937.9 9100.7 8662.2 8667.7 8703.1 8850.2 8889.2 6892.9 6994.7 7011.3 7016.6 7157.2 2018.9 2021.5 2029.2 2076.7 2091.6 764.3 982.9 1028.8 1061.0 1065.5 19263.4 19929.8 20689.0 21253.6 21794.1 1025.3 1027.6 1037.4 1064.3 1084.9 10789.5 11512.9 11555.6 11622.9 11741.2 531464.0 544026.0 546185.0 546556.0 555138.0 97016.0 97595.5 99565.0 101098.5 101393.5 1028.0 1082.7 1085.7 1088.2 1093.5 17630.6 18003.3 18398.8 18799.0 18894.8 45440.0 45724.5 46176.0 46991.3 48028.3 63754.0 64454.4 65362.0 66080.3 66082.7 8795.5 9028.9 9125.2 9164.6 9390.2 12893.0 13284.4 13350.6 13521.5 13907.8 11697.1 12087.2 12095.3 12097.6 12327.4 11653.7 11852.9 11931.2 12008.2 12044.3 11664.8 11748.5 12168.3 12359.8 12397.5 8778.2 8846.1 9129.3 9239.6 9456.0 9011.9 10967.4 11308.9 11395.0 11897.5 02:59:25 INFO - PROCESS | 28507 | 02:59:25 INFO - PROCESS | 28507 | [#3] mootools.html Cycles:180 Average:5374.57 Median:5536.74 stddev:2915.51 (52.7%) stddev-sans-first:2908.96 02:59:25 INFO - PROCESS | 28507 | Values: 1475.3 1489.5 1641.2 1747.0 1810.3 7709.7 8151.1 8161.2 8171.8 8186.5 7128.8 7358.1 7524.7 7706.5 7720.6 2316.5 2353.2 2355.3 2356.8 2372.9 2315.9 2341.2 2344.8 2345.2 2363.8 2032.0 2091.0 2268.4 2348.3 2350.7 2332.7 2334.5 2335.9 2339.7 2344.2 2325.6 2341.9 2346.0 2346.6 2347.2 8020.4 8063.2 8068.2 8079.7 8082.9 4955.1 5100.3 5104.4 5104.6 5106.0 2952.1 2982.4 3171.8 3198.3 3201.1 955.1 959.3 980.4 1002.3 1017.6 10827.1 10885.6 10899.7 10911.0 10933.2 4328.2 4564.2 4582.8 4583.2 4596.2 9401.6 9401.9 9414.3 9416.5 9419.6 5091.6 5154.8 5159.4 5174.8 5175.9 4644.5 4759.9 4765.6 4812.9 4822.3 3659.5 3775.3 3785.6 3812.8 3868.3 1176.0 1296.1 1299.9 1305.6 1311.3 829.0 852.3 950.9 959.7 986.3 5545.6 5625.6 5686.6 5707.9 5750.1 962.4 984.2 1006.4 1031.4 1057.2 3684.1 3688.6 3696.5 3704.1 3716.9 9510.1 9933.2 9937.9 9953.1 9955.9 9881.5 9884.1 9904.1 9906.7 9917.7 7660.7 7792.5 7804.6 7813.5 7816.5 5527.9 5559.9 5685.5 5705.1 5812.8 9020.5 9095.0 9103.0 9124.5 9126.7 8668.0 8949.7 8964.2 9186.1 9195.5 7007.4 7137.6 7159.4 7162.8 7166.7 7748.8 7753.4 7827.4 7831.9 7837.0 7079.6 7232.3 7235.6 7330.9 7429.2 6975.2 7033.3 7034.5 7109.1 7267.9 6302.1 6405.5 6408.0 6420.2 6435.5 4555.9 4564.6 4625.5 4704.0 4708.4 4570.5 4747.6 4761.0 4859.8 5116.4 02:59:25 INFO - PROCESS | 28507 | 02:59:25 INFO - PROCESS | 28507 | [#4] prototype.html Cycles:180 Average:4633.30 Median:5261.37 stddev:1331.62 (25.3%) stddev-sans-first:1295.78 02:59:25 INFO - PROCESS | 28507 | Values: 340.2 349.3 352.7 354.4 358.2 5096.3 5252.2 5269.4 5284.6 5316.1 5103.5 5182.8 5224.2 5224.8 5243.9 4194.8 4210.9 4217.1 4219.8 4230.8 4084.1 4158.5 4219.5 4226.2 4230.4 4129.4 4131.3 4148.2 4174.2 4185.0 4107.3 4125.8 4157.5 4158.4 4171.1 3711.6 3724.3 3730.7 3735.3 3736.3 5070.6 5141.2 5156.6 5167.7 5169.8 4725.1 4778.4 4780.4 4783.8 4802.7 5399.7 5500.2 5505.9 5513.5 5542.4 4048.8 4050.2 4052.6 4059.7 4090.4 5642.9 5673.5 5691.5 5711.9 5720.3 4129.3 4147.9 4155.7 4174.4 4192.7 4108.3 4194.2 4195.0 4205.4 4226.0 4713.5 4715.5 4725.9 4729.7 4735.8 5512.6 5518.4 5531.9 5540.3 5554.3 1316.8 1318.6 1386.8 1414.5 1416.0 959.7 972.8 979.6 991.9 1000.2 5151.3 5161.8 5205.5 5253.3 5279.7 5378.8 5401.9 5427.5 5449.7 5461.2 5156.9 5165.0 5166.8 5187.6 5429.4 2912.9 2913.7 2928.7 2939.5 2952.0 5689.2 5693.0 5721.7 5781.8 5810.5 5437.5 5564.8 5606.0 5624.9 5654.2 5665.4 5675.7 5694.5 5697.3 5727.0 5345.7 5506.6 5549.9 5560.5 5631.5 5386.6 5397.4 5417.7 5419.0 5440.6 5671.9 5678.0 5690.3 5736.9 5774.0 3844.7 3986.9 4008.5 4014.8 4073.9 5488.6 5535.9 5536.7 5552.5 5567.8 5423.7 5470.4 5502.7 5589.0 5621.4 5528.8 5537.0 5542.7 5556.9 5564.2 5301.2 5452.2 5454.6 5499.6 5507.7 5555.7 5558.1 5563.0 5563.8 5570.4 5411.5 5428.9 5454.2 5466.3 5472.8 02:59:25 INFO - PROCESS | 28507 | 02:59:25 INFO - PROCESS | 28507 | [#5] yui.html Cycles:180 Average:19186.62 Median:4706.51 stddev:25644.72 (544.9%) stddev-sans-first:25679.27 02:59:25 INFO - PROCESS | 28507 | Values: 746.1 761.8 779.1 820.0 851.4 14635.6 14638.6 15217.1 15608.2 15618.8 14399.5 14971.0 15155.1 15169.2 15180.4 850.6 866.9 874.6 874.9 875.2 865.2 866.7 868.0 868.0 868.6 921.2 921.7 922.2 922.8 923.5 919.4 920.4 920.4 920.6 921.4 669.7 670.2 671.5 671.9 672.0 13778.9 13805.2 13813.1 14825.5 15466.7 14296.4 14400.9 14805.3 14812.7 14982.6 11839.5 11897.6 12010.4 12119.9 12424.4 3781.7 3872.0 3875.0 3920.3 3922.4 64336.0 64531.0 65034.3 65507.3 67472.0 11163.4 11309.6 11315.4 11429.1 11657.2 20582.9 20742.1 20874.0 21168.7 21208.8 8224.9 8330.5 8401.8 8441.3 8722.0 4450.4 4528.4 4590.3 4667.0 4841.2 3507.8 3627.2 3630.4 3631.1 3632.2 621.4 632.1 640.3 641.2 644.5 727.6 751.2 754.5 765.3 777.3 9374.6 10023.4 10100.4 10110.8 10272.3 640.3 704.9 709.8 715.3 724.2 4425.2 4641.5 4746.0 4775.7 4857.2 70185.6 95385.5 96772.0 97989.0 100481.5 84465.0 84812.6 85558.0 86163.6 88615.1 73347.6 73978.3 74058.0 75434.2 75825.6 9112.0 9238.0 9265.2 9527.6 9532.7 50748.5 52617.2 52732.0 52895.5 52974.0 68531.3 70484.6 70832.0 71866.3 72178.6 13435.7 13497.6 13501.9 13950.0 14566.2 14325.0 14886.9 14956.8 15329.4 16193.0 13938.4 14335.8 14423.9 14787.5 15043.2 13512.9 13680.2 13729.4 14206.9 14340.0 12212.1 12358.9 12501.6 13553.4 13577.3 10973.9 11301.7 11564.1 11941.3 12718.6 12248.4 12610.2 12644.2 12651.4 12701.3 02:59:25 INFO - PROCESS | 28507 | -------- Summary: end -------- 02:59:25 INFO - PROCESS | 28507 | 02:59:26 INFO - TEST-INFO | 28507: exit 0 02:59:26 INFO - TEST-OK | dromaeo_css | took 1115621ms 02:59:26 INFO - TEST-START | kraken 02:59:26 INFO - operating with platform_type : linux_ 02:59:26 INFO - Initialising browser for kraken test... 02:59:26 INFO - TEST-INFO | started process 28824 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8oDZpN/profile http://localhost:46765/getInfo.html) 02:59:30 INFO - PROCESS | 28824 | __metrics Screen width/height:1600/1200 02:59:30 INFO - PROCESS | 28824 | colorDepth:24 02:59:30 INFO - PROCESS | 28824 | Browser inner width/height: 1024/697 02:59:30 INFO - PROCESS | 28824 | __metrics 02:59:31 INFO - PROCESS | 28824 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:59:31 INFO - PROCESS | 28824 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:59:31 INFO - PROCESS | 28824 | console.error: PushService: 02:59:31 INFO - PROCESS | 28824 | stateChangeProcessEnqueue: Error transitioning state 02:59:31 INFO - PROCESS | 28824 | UnknownError 02:59:32 INFO - TEST-INFO | 28824: exit 0 02:59:32 INFO - Browser initialized. 02:59:32 INFO - Running cycle 1/1 for kraken test... 02:59:32 INFO - TEST-INFO | started process 28919 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8oDZpN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:59:44 INFO - PROCESS | 28919 | RSS: Main: 145182720 02:59:44 INFO - PROCESS | 28919 | 02:59:46 INFO - PROCESS | 28919 | Cycle 1(1): loaded http://localhost:46765/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46765/tests/kraken/driver.html?testName=audio-beat-detection) 02:59:47 INFO - PROCESS | 28919 | RSS: Main: 185925632 02:59:47 INFO - PROCESS | 28919 | 02:59:50 INFO - PROCESS | 28919 | Cycle 1(1): loaded http://localhost:46765/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46765/tests/kraken/driver.html?testName=audio-dft) 02:59:50 INFO - PROCESS | 28919 | RSS: Main: 174956544 02:59:50 INFO - PROCESS | 28919 | 02:59:53 INFO - PROCESS | 28919 | Cycle 1(1): loaded http://localhost:46765/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46765/tests/kraken/driver.html?testName=audio-fft) 02:59:54 INFO - PROCESS | 28919 | RSS: Main: 266498048 02:59:54 INFO - PROCESS | 28919 | 02:59:56 INFO - PROCESS | 28919 | Cycle 1(1): loaded http://localhost:46765/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46765/tests/kraken/driver.html?testName=audio-oscillator) 02:59:56 INFO - PROCESS | 28919 | RSS: Main: 173166592 02:59:56 INFO - PROCESS | 28919 | 02:59:58 INFO - PROCESS | 28919 | Cycle 1(1): loaded http://localhost:46765/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46765/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:59:59 INFO - PROCESS | 28919 | RSS: Main: 175357952 02:59:59 INFO - PROCESS | 28919 | 03:00:02 INFO - PROCESS | 28919 | Cycle 1(1): loaded http://localhost:46765/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46765/tests/kraken/driver.html?testName=imaging-darkroom) 03:00:02 INFO - PROCESS | 28919 | RSS: Main: 213622784 03:00:02 INFO - PROCESS | 28919 | 03:00:06 INFO - PROCESS | 28919 | Cycle 1(1): loaded http://localhost:46765/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46765/tests/kraken/driver.html?testName=imaging-desaturate) 03:00:06 INFO - PROCESS | 28919 | RSS: Main: 213155840 03:00:06 INFO - PROCESS | 28919 | 03:00:09 INFO - PROCESS | 28919 | Cycle 1(1): loaded http://localhost:46765/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46765/tests/kraken/driver.html?testName=json-parse-financial) 03:00:10 INFO - PROCESS | 28919 | RSS: Main: 211083264 03:00:10 INFO - PROCESS | 28919 | 03:00:11 INFO - PROCESS | 28919 | Cycle 1(1): loaded http://localhost:46765/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46765/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:00:12 INFO - PROCESS | 28919 | RSS: Main: 173649920 03:00:12 INFO - PROCESS | 28919 | 03:00:13 INFO - PROCESS | 28919 | Cycle 1(1): loaded http://localhost:46765/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46765/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:00:14 INFO - PROCESS | 28919 | RSS: Main: 181002240 03:00:14 INFO - PROCESS | 28919 | 03:00:16 INFO - PROCESS | 28919 | Cycle 1(1): loaded http://localhost:46765/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46765/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:00:17 INFO - PROCESS | 28919 | RSS: Main: 189816832 03:00:17 INFO - PROCESS | 28919 | 03:00:19 INFO - PROCESS | 28919 | Cycle 1(1): loaded http://localhost:46765/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46765/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:00:20 INFO - PROCESS | 28919 | RSS: Main: 198471680 03:00:20 INFO - PROCESS | 28919 | 03:00:23 INFO - PROCESS | 28919 | Cycle 1(1): loaded http://localhost:46765/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46765/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:00:23 INFO - PROCESS | 28919 | RSS: Main: 195002368 03:00:23 INFO - PROCESS | 28919 | 03:00:25 INFO - PROCESS | 28919 | Cycle 1(1): loaded http://localhost:46765/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46765/tests/kraken/driver.html?testName=ai-astar) 03:00:25 INFO - PROCESS | 28919 | RSS: Main: 246530048 03:00:25 INFO - PROCESS | 28919 | 03:00:25 INFO - PROCESS | 28919 | __start_tp_report 03:00:25 INFO - PROCESS | 28919 | _x_x_mozilla_page_load 03:00:25 INFO - PROCESS | 28919 | _x_x_mozilla_page_load_details 03:00:25 INFO - PROCESS | 28919 | |i|pagename|runs| 03:00:25 INFO - PROCESS | 28919 | |0;ai-astar;102;111;112;111;112;111;110;112;111;110 03:00:25 INFO - PROCESS | 28919 | |1;audio-beat-detection;150;123;122;156;122;121;123;126;158;127 03:00:25 INFO - PROCESS | 28919 | |2;audio-dft;161;162;164;163;163;163;162;163;160;162 03:00:25 INFO - PROCESS | 28919 | |3;audio-fft;75;74;74;113;75;74;75;74;97;75 03:00:25 INFO - PROCESS | 28919 | |4;audio-oscillator;81;81;113;81;82;81;107;81;81;115 03:00:25 INFO - PROCESS | 28919 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;119 03:00:25 INFO - PROCESS | 28919 | |6;imaging-darkroom;145;146;146;146;147;146;146;146;147;146 03:00:25 INFO - PROCESS | 28919 | |7;imaging-desaturate;84;84;84;85;84;84;84;85;84;84 03:00:25 INFO - PROCESS | 28919 | |8;json-parse-financial;50;52;53;51;51;51;52;51;51;51 03:00:25 INFO - PROCESS | 28919 | |9;json-stringify-tinderbox;60;61;60;59;60;59;59;59;59;60 03:00:25 INFO - PROCESS | 28919 | |10;stanford-crypto-aes;75;78;82;75;82;77;75;75;78;76 03:00:25 INFO - PROCESS | 28919 | |11;stanford-crypto-ccm;138;130;129;129;129;139;124;124;170;130 03:00:25 INFO - PROCESS | 28919 | |12;stanford-crypto-pbkdf2;155;155;166;156;159;155;156;153;153;159 03:00:25 INFO - PROCESS | 28919 | |13;stanford-crypto-sha256-iterative;62;63;64;63;67;61;64;62;62;62 03:00:25 INFO - PROCESS | 28919 | __end_tp_report 03:00:25 INFO - PROCESS | 28919 | __start_cc_report 03:00:25 INFO - PROCESS | 28919 | _x_x_mozilla_cycle_collect,1635 03:00:25 INFO - PROCESS | 28919 | __end_cc_report 03:00:25 INFO - PROCESS | 28919 | __startTimestamp1481454025516__endTimestamp 03:00:25 INFO - PROCESS | 28919 | 03:00:25 INFO - PROCESS | 28919 | ------- Summary: start ------- 03:00:25 INFO - PROCESS | 28919 | Number of tests: 14 03:00:25 INFO - PROCESS | 28919 | 03:00:25 INFO - PROCESS | 28919 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:2.97 (2.7%) stddev-sans-first:0.78 03:00:25 INFO - PROCESS | 28919 | Values: 102.0 111.0 112.0 111.0 112.0 111.0 110.0 112.0 111.0 110.0 03:00:25 INFO - PROCESS | 28919 | 03:00:25 INFO - PROCESS | 28919 | [#1] audio-beat-detection Cycles:10 Average:132.80 Median:126.50 stddev:15.32 (12.1%) stddev-sans-first:14.94 03:00:25 INFO - PROCESS | 28919 | Values: 150.0 123.0 122.0 156.0 122.0 121.0 123.0 126.0 158.0 127.0 03:00:25 INFO - PROCESS | 28919 | 03:00:25 INFO - PROCESS | 28919 | [#2] audio-dft Cycles:10 Average:162.30 Median:163.00 stddev:1.16 (0.7%) stddev-sans-first:1.13 03:00:25 INFO - PROCESS | 28919 | Values: 161.0 162.0 164.0 163.0 163.0 163.0 162.0 163.0 160.0 162.0 03:00:25 INFO - PROCESS | 28919 | 03:00:25 INFO - PROCESS | 28919 | [#3] audio-fft Cycles:10 Average:80.60 Median:75.00 stddev:13.41 (17.9%) stddev-sans-first:14.07 03:00:25 INFO - PROCESS | 28919 | Values: 75.0 74.0 74.0 113.0 75.0 74.0 75.0 74.0 97.0 75.0 03:00:25 INFO - PROCESS | 28919 | 03:00:25 INFO - PROCESS | 28919 | [#4] audio-oscillator Cycles:10 Average:90.30 Median:81.00 stddev:14.88 (18.4%) stddev-sans-first:15.39 03:00:25 INFO - PROCESS | 28919 | Values: 81.0 81.0 113.0 81.0 82.0 81.0 107.0 81.0 81.0 115.0 03:00:25 INFO - PROCESS | 28919 | 03:00:25 INFO - PROCESS | 28919 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 03:00:25 INFO - PROCESS | 28919 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 119.0 03:00:25 INFO - PROCESS | 28919 | 03:00:25 INFO - PROCESS | 28919 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.44 03:00:25 INFO - PROCESS | 28919 | Values: 145.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 147.0 146.0 03:00:25 INFO - PROCESS | 28919 | 03:00:25 INFO - PROCESS | 28919 | [#7] imaging-desaturate Cycles:10 Average:84.20 Median:84.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 03:00:25 INFO - PROCESS | 28919 | Values: 84.0 84.0 84.0 85.0 84.0 84.0 84.0 85.0 84.0 84.0 03:00:25 INFO - PROCESS | 28919 | 03:00:25 INFO - PROCESS | 28919 | [#8] json-parse-financial Cycles:10 Average:51.30 Median:51.00 stddev:0.82 (1.6%) stddev-sans-first:0.73 03:00:25 INFO - PROCESS | 28919 | Values: 50.0 52.0 53.0 51.0 51.0 51.0 52.0 51.0 51.0 51.0 03:00:25 INFO - PROCESS | 28919 | 03:00:25 INFO - PROCESS | 28919 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:60.00 stddev:0.70 (1.2%) stddev-sans-first:0.73 03:00:25 INFO - PROCESS | 28919 | Values: 60.0 61.0 60.0 59.0 60.0 59.0 59.0 59.0 59.0 60.0 03:00:25 INFO - PROCESS | 28919 | 03:00:25 INFO - PROCESS | 28919 | [#10] stanford-crypto-aes Cycles:10 Average:77.30 Median:77.50 stddev:2.75 (3.5%) stddev-sans-first:2.79 03:00:25 INFO - PROCESS | 28919 | Values: 75.0 78.0 82.0 75.0 82.0 77.0 75.0 75.0 78.0 76.0 03:00:25 INFO - PROCESS | 28919 | 03:00:25 INFO - PROCESS | 28919 | [#11] stanford-crypto-ccm Cycles:10 Average:134.20 Median:130.00 stddev:13.51 (10.4%) stddev-sans-first:14.26 03:00:25 INFO - PROCESS | 28919 | Values: 138.0 130.0 129.0 129.0 129.0 139.0 124.0 124.0 170.0 130.0 03:00:25 INFO - PROCESS | 28919 | 03:00:25 INFO - PROCESS | 28919 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.70 Median:156.00 stddev:3.86 (2.5%) stddev-sans-first:4.04 03:00:25 INFO - PROCESS | 28919 | Values: 155.0 155.0 166.0 156.0 159.0 155.0 156.0 153.0 153.0 159.0 03:00:25 INFO - PROCESS | 28919 | 03:00:25 INFO - PROCESS | 28919 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:1.70 (2.7%) stddev-sans-first:1.76 03:00:25 INFO - PROCESS | 28919 | Values: 62.0 63.0 64.0 63.0 67.0 61.0 64.0 62.0 62.0 62.0 03:00:25 INFO - PROCESS | 28919 | -------- Summary: end -------- 03:00:25 INFO - PROCESS | 28919 | 03:00:26 INFO - TEST-INFO | 28919: exit 0 03:00:26 INFO - TEST-OK | kraken | took 60200ms 03:00:26 INFO - SUITE-END | took 1175s 03:00:26 INFO - Completed test suite (00:19:35) 03:00:26 INFO - javascript benchmark 03:00:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3181.1569933967494, 3215.1801290670883, 3223.0492004858565, 3242.0922141800306, 3250.593675790526, 5490.615656904019, 5569.053260945639, 5578.944210557893, 5607.4112218217115, 5611.3266408030995, 5469.671819690821, 5509.283793106891, 5521.861953451165, 5525.309336332948, 5558.388577256498, 4963.627727920411, 4979.526944940225, 5008.549230569248, 5024.045431368028, 5074.492550744914, 4922.630802689812, 4991.875203119915, 5066.138756411419, 5069.847904562869, 5076.238564215379, 4911.140550403683, 4972.627052971024, 4982.252662100677, 5003.724795136284, 5031.949680503203, 4960.702357858522, 5051.292819005343, 5052.166392545244, 5121.820736274212, 5150.562202212779, 4963.826266080706, 5023.547880690755, 5076.720780357079, 5089.4147173074825, 5096.719680417576, 5291.788328466857, 5333.973330133364, 5390.4879036491475, 5426.8371948841595, 5495.422980587061, 5786.594938354317, 5795.710214489259, 5807.651540907559, 5882.617629854046, 5921.585489015771, 5945.643261404286, 5950.821475355746, 5959.314678811948, 5965.4929331006915, 5966.67183304918, 5348.491893270133, 5398.703071331075, 5399.352077750616, 5526.253955715927, 5541.362743284493, 6056.36408177135, 6101.633901965807, 6105.45050945417, 6106.542009349317, 6108.72510737009, 5841.299044114733, 5844.88310233793, 5853.0635098384055, 5856.385079566669, 5878.823635290948, 5720.456556627114, 5770.42295770428, 5894.528437725057, 5935.465808077208, 5977.820665380045, 5932.436418540232, 5939.22790037301, 5939.673317967467, 5960.0761881908375, 5974.3428222895445, 5872.765089396462, 5916.940830591725, 5929.05135178378, 5929.703514824241, 5932.822015339547, 4385.144896745168, 4396.516383197845, 4496.842610508682, 4534.977325113353, 4588.151192029485, 4078.632923036941, 4079.204555111725, 4086.0397806515443, 4098.344264917599, 4124.773137477468, 5649.576281778883, 5651.519620832193, 5651.886962260814, 5652.491275785199, 5656.095024796013, 5711.029125048752, 5772.451617096369, 5775.422457754191, 5908.113782932594, 5921.230240068763, 5499.285092937973, 5548.112302031655, 5555.30558680165, 5579.414161513064, 5644.6330988485615, 5096.0827051131155, 5105.132127538327, 5110.591152707774, 5111.412187598474, 5116.616253780907, 6034.577579569564, 6035.155078289043, 6066.969665151646, 6079.118527813443, 6083.391660833881, 5608.130739735348, 5631.0427227372265, 5950.613210141327, 6040.879182416239, 6054.39456054391, 6215.595986260879, 6228.03465462854, 6252.280987686292, 6256.749730010749, 6260.780872669435, 5889.234399528034, 5891.734871930687, 5895.67573783446, 5899.882002359843, 5930.525557955267, 5727.083666613322, 5773.740181691918, 5815.011448053757, 5953.523718102628, 6038.5772995889865, 5677.858053548694, 5756.913646295226, 5779.104238842986, 5788.160716696139, 5802.82591522255, 5758.62568933018, 5770.538356931352, 5774.307083149881, 5777.046787280052, 5778.075507918713, 5541.5843811715085, 5666.178404131296, 5715.057015592547, 5718.142278658234, 5726.656400615976, 5668.574856885833, 5780.306363236438, 5794.0, 5797.159411885169, 5942.019566771434, 5748.741306641295, 5759.107338362561, 5759.683217423082, 5770.682612456355, 5799.188113664006], "value": 5448.123411730932, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.5920267009087, 601.3715667127851, 629.7890206780728, 661.814691886272, 673.3502170405558, 34194.48708269375, 44600.553994460046, 45302.32046519296, 45392.31911521321, 45509.999999999956, 46427.0, 46787.298190527166, 46788.0, 46814.59556213319, 46846.53153468464, 8341.290990265805, 8832.470051796881, 9009.234215091725, 9018.188363047324, 9034.27725781939, 8332.958335208346, 10344.327618704798, 10584.994425529563, 10597.788044239149, 10942.507587158558, 10793.136549076055, 10875.728106797354, 10875.891241087567, 10876.347419154836, 10877.83683244752, 10708.625198118067, 10775.946120269427, 10784.191185661028, 10794.784104317949, 10806.51370688313, 10545.578176872916, 10601.946990265, 10606.893931060667, 10616.893831061669, 10621.097206737437, 42076.0, 42373.15253694909, 42428.363574546405, 42450.57549424497, 42581.0, 3716.089558058266, 3859.4403811447182, 3873.709471789627, 3963.663088637469, 4386.71486353386, 31802.522962155585, 32337.51493727596, 32500.0, 32908.17729556756, 33976.49035264473, 4079.5308539518037, 4157.542670306264, 4161.9375709364385, 4168.7707176105305, 4300.440942677463, 269035.0, 269171.0, 269267.6536617324, 269665.0, 269675.0, 37064.81467592645, 38196.42705359422, 62126.0, 62563.37436625666, 62613.686931565964, 40213.195736085116, 40423.393649095284, 40584.0, 40586.39120413196, 40608.79695601503, 16629.0, 16799.83200168007, 16802.915985419993, 16812.0, 16821.91589042047, 12649.05132115095, 12809.807852882213, 13831.446742130403, 13934.651633709238, 14060.296985150702, 9050.140236677506, 9209.907900920905, 9279.422498175327, 9297.535123243946, 9309.30180236485, 3432.8626854926024, 3488.4418493040994, 3490.4938783876196, 3547.3082748863726, 3547.6629720176543, 1028.665683652816, 1079.2822772855964, 1090.4166271045112, 1136.2216881436243, 1199.130630293048, 34210.82894585511, 34261.657383425845, 34471.65528344735, 34568.30863382718, 34588.82705586506, 1025.887152413234, 1140.2474366917795, 1165.1086918507349, 1169.4386694386742, 1183.2900259844025, 16194.433194838124, 18005.909970450324, 18030.729539056923, 18847.528811779543, 18924.148413321433, 569688.0, 606129.0, 608499.0, 609620.0, 866021.0, 60017.09974350388, 60373.39626603766, 60671.0, 60882.39117608767, 60888.0, 1436.4685066525453, 1441.7188648213498, 1445.8337291211644, 1451.361400983564, 1460.890433217513, 32300.83849580737, 35083.29833403369, 35299.82350088233, 35356.70399712275, 35510.28979420449, 54885.0, 55639.44360556343, 55709.164362535405, 55747.442525574224, 55781.163282551606, 392248.0, 393912.0, 394334.0, 395064.0, 396497.0, 27279.45441091207, 28058.579121313604, 30507.2373190672, 30697.693023069485, 31234.0, 48283.75858120687, 49107.01785964189, 49966.25050624171, 51776.48223517867, 52112.21831672604, 41366.793166033975, 41915.37126943159, 41988.1602367957, 43007.139857202055, 43136.568634313255, 41396.586034139276, 41697.37453938254, 41791.0, 43240.56759432366, 43265.783671081444, 41606.0, 42109.0, 42712.78643606762, 42892.35661465143, 43072.35391469068, 34195.82902085573, 36699.0, 37396.81301593475, 37668.84607186593, 37749.4337584931, 28779.42441151207, 28870.71129288764, 29112.56331154992, 29218.123456296344, 29298.853505732335], "value": 19877.51489627278, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [420.7538589924894, 423.18114448542053, 425.79349015727365, 428.402378681739, 447.97312161270327, 18853.151608177646, 18954.52613684657, 20356.0, 20448.182072717093, 20509.692354614694, 19668.803311966876, 19905.900470497665, 20563.28028519002, 20641.793582064176, 20765.584688306226, 5733.569982251327, 6066.120412540201, 6069.241344831896, 6077.665728384937, 6081.331053584102, 5833.533317334603, 5841.503472204868, 5882.441168089024, 5969.552283578727, 5989.0, 5929.347771745104, 5939.643621382709, 5942.197803296564, 5945.108233764927, 5947.048472244442, 5720.942790572103, 5933.4659880610525, 5934.198883150762, 5972.6715030673295, 5980.43185897339, 5377.919331210035, 5386.48828361305, 5386.811461598825, 5393.19102134679, 5393.9730301348245, 23476.413089672897, 23917.402064948343, 24232.51534969291, 24337.269881903572, 24587.262382128385, 2373.8219633527383, 2384.499255156419, 2402.903883844644, 2418.056957786465, 2427.0, 14663.41346346145, 15146.545603631908, 15280.694386112216, 15378.461753838674, 15973.520794376187, 1784.5538615346163, 1854.619802940394, 1878.924843006278, 1897.4781934967993, 1934.1103092577432, 80065.59967200184, 80546.0, 82252.0, 82975.58512207461, 83815.580922095, 10999.0, 11202.0, 11275.097992160607, 11519.76960460803, 11554.94222528882, 16283.104429256267, 16331.755023674654, 16344.346226150821, 16348.75476867848, 16360.34558617642, 8747.343949203836, 8793.120687931156, 8823.69117080899, 8937.910620893708, 9100.681476148304, 8662.220400164015, 8667.739967800977, 8703.129687031245, 8850.20348168655, 8889.19997200255, 6892.931070689329, 6994.720127230667, 7011.333923277382, 7016.5790052597, 7157.24848890859, 2018.8687735297453, 2021.5451523407116, 2029.1781828359537, 2076.6677331626865, 2091.6130515854616, 764.3464837563914, 982.8771403574553, 1028.7736697926443, 1060.9734756631146, 1065.536491626145, 19263.4220973371, 19929.800701992794, 20689.0, 21253.574928501344, 21794.128234870746, 1025.348903446302, 1027.6197806811379, 1037.3568387599737, 1064.324154162097, 1084.9186311026704, 10789.46052697362, 11512.94243528777, 11555.595554155565, 11622.88377116218, 11741.17811753169, 531464.0, 544026.0, 546185.0, 546556.0, 555138.0, 97016.0, 97595.51202244086, 99565.0, 101098.494507527, 101393.49303253584, 1027.984580231297, 1082.658962426833, 1085.7231405991422, 1088.1566785741113, 1093.4532733633184, 17630.55923601869, 18003.2798688051, 18398.816011840245, 18799.0, 18894.811051889305, 45440.0, 45724.54275457203, 46176.0, 46991.295130572384, 48028.27957580709, 63754.0, 64454.355456444835, 65362.0, 66080.33919660741, 66082.66958665175, 8795.516246606498, 9028.90971090307, 9125.224355929555, 9164.633414663338, 9390.154886060287, 12893.0, 13284.402201900744, 13350.599482015556, 13521.459141634225, 13907.791383129059, 11697.06423486102, 12087.214331068453, 12095.334756588472, 12097.57658481949, 12327.445264963277, 11653.671732039265, 11852.940735296268, 11931.164818462625, 12008.219465734699, 12044.277343359427, 11664.825027624762, 11748.530058797553, 12168.2699038058, 12359.75280494403, 12397.504099836266, 8778.166074222938, 8846.115388461103, 9129.315301352291, 9239.630414783333, 9455.952720236355, 9011.909880901107, 10967.396793176133, 11308.886911130783, 11395.031422329195, 11897.453331066907], "value": 9827.208883072812, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1475.3066058952293, 1489.4712377106127, 1641.1548052752828, 1747.0, 1810.3120814090653, 7709.653065612047, 8151.062627797805, 8161.22468365505, 8171.795705107375, 8186.467879587837, 7128.786136415903, 7358.117025956879, 7524.736634217804, 7706.460547761645, 7720.61396930154, 2316.5019520803025, 2353.1646265575732, 2355.2580937004873, 2356.799672027871, 2372.9406764830933, 2315.918942837001, 2341.239097293378, 2344.753800850912, 2345.2495201535517, 2363.822713296501, 2031.9796802031938, 2091.027672132458, 2268.444231163359, 2348.3189874936334, 2350.7296660884044, 2332.731735850382, 2334.5097529518735, 2335.883205839701, 2339.6958395408487, 2344.167820423759, 2325.5813953488364, 2341.8594884306995, 2345.9648105278266, 2346.601077816775, 2347.1550241912896, 8020.3984701147065, 8063.233992770677, 8068.233517815798, 8079.676812927534, 8082.878756818653, 4955.083309587738, 5100.336956195708, 5104.3619547556555, 5104.61715371345, 5106.0, 2952.129121909042, 2982.358792859524, 3171.809691418522, 3198.280386912926, 3201.08769000836, 955.073578628729, 959.2853324273461, 980.3578655980344, 1002.2733518199248, 1017.6082208349765, 10827.07969822566, 10885.619003334845, 10899.673009809718, 10910.963458471353, 10933.18001149909, 4328.177646247203, 4564.2012647786505, 4582.793774280165, 4583.175028494837, 4596.17268891596, 9401.576929038072, 9401.858972115424, 9414.29392795543, 9416.482093484925, 9419.623215071457, 5091.618128640367, 5154.768035438415, 5159.355080614923, 5174.844754657366, 5175.870603234949, 4644.5123262056995, 4759.928601070987, 4765.594924431392, 4812.903741925142, 4822.252550854623, 3659.524261845943, 3775.320442320409, 3785.564660064073, 3812.8284227209842, 3868.3037053330672, 1175.9941200293945, 1296.1315918334737, 1299.909006369564, 1305.575687901436, 1311.3377744239099, 828.98342033159, 852.3224036890687, 950.9429434233969, 959.6919408821794, 986.3145114145743, 5545.556355491551, 5625.606207565431, 5686.601937864392, 5707.857303567444, 5750.079987202112, 962.37926537383, 984.1732944326657, 1006.3961623026125, 1031.3966329697212, 1057.2018126314583, 3684.1158122050515, 3688.5942546319884, 3696.5194524711615, 3704.148045949447, 3716.925661486755, 9510.09654082861, 9933.155681766986, 9937.850932236022, 9953.054459826304, 9955.900440995641, 9881.505924703735, 9884.11043006133, 9904.108630223314, 9906.702798916043, 9917.702468925943, 7660.693572257047, 7792.493487923381, 7804.609769511501, 7813.531188128731, 7816.49192802466, 5527.917081243865, 5559.916601250903, 5685.459881311269, 5705.144228365778, 5812.7674893003805, 9020.458772473672, 9095.045020272775, 9102.954485227532, 9124.49815260167, 9126.680566180152, 8667.956660216658, 8949.686760963335, 8964.238039766693, 9186.08139186076, 9195.540222988957, 7007.404370628554, 7137.643117843983, 7159.427245820426, 7162.785116446515, 7166.749163779451, 7748.806279843049, 7753.37972962173, 7827.4129440293345, 7831.921680783347, 7836.960815195887, 7079.610621415872, 7232.312930271826, 7235.602041887536, 7330.926690733025, 7429.219931907288, 6975.162980442379, 7033.331833475811, 7034.507584469038, 7109.075820143348, 7267.927320726725, 6302.149209856794, 6405.455536279468, 6407.967960160169, 6420.229572451336, 6435.549511534147, 4555.908881822411, 4564.612007979226, 4625.537446255482, 4704.0, 4708.4349878014855, 4570.4972453030805, 4747.572718455355, 4761.0, 4859.757012149449, 5116.386033675983], "value": 4381.665272518311, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.15810868101454, 349.25608453992993, 352.68963312285183, 354.3780664933045, 358.2333805655897, 5096.3374761281075, 5252.185911183763, 5269.446708095652, 5284.550813180879, 5316.149416093426, 5103.540681338679, 5182.792688292464, 5224.21636754487, 5224.817131400402, 5243.947560524393, 4194.8112334945, 4210.915781684364, 4217.093324935138, 4219.810108545123, 4230.788460576974, 4084.14233011068, 4158.480189976253, 4219.493660760713, 4226.239276930151, 4230.3865939438765, 4129.4012368206595, 4131.256373852705, 4148.211839750453, 4174.20690068886, 4185.0, 4107.301758701028, 4125.752454852718, 4157.459530261077, 4158.4178215049915, 4171.1438409907605, 3711.628837116267, 3724.348239058154, 3730.7201959852846, 3735.2529494101286, 3736.2901048800913, 5070.594352451832, 5141.203113517411, 5156.561692256163, 5167.741612919339, 5169.767360468788, 4725.078609671115, 4778.378810754614, 4780.354652121954, 4783.808647654089, 4802.735849528274, 5399.730013499309, 5500.202470641774, 5505.889882202334, 5513.476219759116, 5542.418046105141, 4048.838046478137, 4050.2102090092444, 4052.5542190359038, 4059.6549293310104, 4090.3864420337186, 5642.871425714873, 5673.546116310686, 5691.459311365414, 5711.857203569903, 5720.342160651495, 4129.29801933672, 4147.917041659211, 4155.729877557949, 4174.4364510791265, 4192.7065105442325, 4108.322126849096, 4194.224068547329, 4194.958050419517, 4205.411242426063, 4226.0, 4713.528647135259, 4715.457722361973, 4725.905481890343, 4729.69933268354, 4735.810567577328, 5512.614117011771, 5518.365387980353, 5531.861703457445, 5540.252065971123, 5554.2779438672715, 1316.7885545298348, 1318.6110097521255, 1386.81278027467, 1414.5402744108205, 1415.9946438029115, 959.6833045095102, 972.7762614598682, 979.5640939781729, 991.9336713033374, 1000.2048371544639, 5151.2530683050745, 5161.81933632321, 5205.531502164823, 5253.290805741252, 5279.736013199325, 5378.757955891994, 5401.864953376197, 5427.45725427462, 5449.700266485302, 5461.1808228766, 5156.948430515722, 5165.0, 5166.767495462713, 5187.559057480081, 5429.4027656957705, 2912.8689208985647, 2913.67949525552, 2928.707129287054, 2939.5002849515636, 2951.985240073786, 5689.175069614966, 5693.0, 5721.656700597978, 5781.768729250783, 5810.489272789106, 5437.483439073281, 5564.833055008276, 5606.0, 5624.865723693082, 5654.180143879197, 5665.433456654301, 5675.687837168913, 5694.515966142924, 5697.259356283656, 5727.0, 5345.6525325855255, 5506.5870059746485, 5549.889002220014, 5560.471755183251, 5631.493165615114, 5386.5560912246765, 5397.436217796515, 5417.729113544386, 5419.0, 5440.564754819684, 5671.865626874559, 5678.0, 5690.317161940594, 5736.885262294814, 5774.0, 3844.6732027777953, 3986.943459983049, 4008.498937632796, 4014.8193331299576, 4073.877783666495, 5488.588355873246, 5535.920495503499, 5536.667799932017, 5552.52803511706, 5567.8285468666445, 5423.701696406735, 5470.370907345547, 5502.669839809464, 5589.0, 5621.35354434229, 5528.838943821843, 5536.975659503005, 5542.667439953616, 5556.860843526986, 5564.165375193753, 5301.204819276985, 5452.154915988028, 5454.563634909118, 5499.560035197094, 5507.697076660822, 5555.694436806015, 5558.138488534284, 5563.0, 5563.833085007456, 5570.442955704397, 5411.485908838654, 5428.891422171613, 5454.209139674805, 5466.289382380265, 5472.808451704172], "value": 4214.337601341039, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [746.1158527145329, 761.8285885675724, 779.1118125337113, 819.9713010044647, 851.4337965253105, 14635.560933171995, 14638.634034149152, 15217.086974781494, 15608.219589020546, 15618.765718514218, 14399.496017639385, 14971.0, 15155.090694558306, 15169.241537923115, 15180.392784288642, 850.5789634131114, 866.9263112635433, 874.6064271078009, 874.8556488179443, 875.2123089219722, 865.212656482601, 866.6663334616187, 867.9609417576193, 867.9913200867974, 868.6481974800216, 921.1847514949251, 921.6774129054844, 922.1792604581894, 922.8200500902327, 923.4920793563547, 919.3656377099779, 920.3557509743207, 920.3603495570582, 920.6087412849512, 921.387277460488, 669.6718607882151, 670.2325836916751, 671.5366397185926, 671.9160104986877, 672.0289182131821, 13778.862211377858, 13805.17168969865, 13813.102148360324, 14825.481108161162, 15466.690666186612, 14296.356663950148, 14400.855991440056, 14805.333759980718, 14812.70374592513, 14982.62543436412, 11839.526418943318, 11897.583584574584, 12010.399480025964, 12119.93940030303, 12424.37878106091, 3781.716371272138, 3872.0, 3874.9806250968563, 3920.2551515212017, 3922.3920292354733, 64336.0, 64531.03203451952, 65034.349656503306, 65507.3449265506, 67472.0, 11163.386013769159, 11309.604163854226, 11315.377654228932, 11429.085673146128, 11657.18399712029, 20582.897085514476, 20742.066607002722, 20874.0, 21168.682469762967, 21208.78791212099, 8224.917750822415, 8330.541820199947, 8401.831963360699, 8441.282490988211, 8721.956390218009, 4450.3991961085485, 4528.41130653013, 4590.288505281686, 4667.043256132485, 4841.201201801734, 3507.7895326280504, 3627.238279961238, 3630.364686179908, 3631.055925459347, 3632.20091579852, 621.4003486635419, 632.1118828046602, 640.270092095012, 641.1856941684035, 644.5198327246231, 727.5670975769409, 751.2224847283036, 754.4756394306014, 765.2921048030549, 777.3159619534773, 9374.578143983537, 10023.398596084258, 10100.393976361442, 10110.848337274947, 10272.280940334105, 640.2668944059026, 704.8519810839679, 709.7835160276062, 715.3418854653731, 724.1816747075876, 4425.22558552252, 4641.512641172628, 4745.976270118627, 4775.71345719258, 4857.2228443449585, 70185.64907175432, 95385.5230723842, 96772.0, 97989.0, 100481.49759251157, 84465.0, 84812.57593711992, 85558.0, 86163.56918215369, 88615.11384886198, 73347.63326183335, 73978.26021739822, 74058.0, 75434.24565754383, 75825.62087189528, 9111.95444022802, 9238.0, 9265.166135047879, 9527.57125929321, 9532.666356677482, 50748.49251507438, 52617.210741838135, 52732.0, 52895.47104529059, 52974.0, 68531.31468685449, 70484.64757676178, 70832.0, 71866.28133718805, 72178.63910680624, 13435.664108397368, 13497.595072147458, 13501.864981350061, 13950.0, 14566.19885906243, 14325.0, 14886.925565372103, 14956.775648365066, 15329.38682452734, 16193.03162997618, 13938.442462301395, 14335.784963225351, 14423.92788036053, 14787.482438114614, 15043.172625505702, 13512.864871351161, 13680.247586382446, 13729.382177801823, 14206.934479913842, 14340.0, 12212.145149839425, 12358.876411236131, 12501.56244531437, 13553.390097445441, 13577.253251071286, 10973.912440501676, 11301.660950171508, 11564.132690048113, 11941.283522988648, 12718.618441446772, 12248.387580620754, 12610.243385396905, 12644.178128421623, 12651.430685618985, 12701.301428421526], "value": 7560.418360861374, "unit": "score"}], "name": "dromaeo_css", "value": 7277.8004796828045, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 112.0, 111.0, 112.0, 111.0, 110.0, 112.0, 111.0, 110.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 123.0, 122.0, 156.0, 122.0, 121.0, 123.0, 126.0, 158.0, 127.0], "value": 132.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 164.0, 163.0, 163.0, 163.0, 162.0, 163.0, 160.0, 162.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 113.0, 75.0, 74.0, 75.0, 74.0, 97.0, 75.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 113.0, 81.0, 82.0, 81.0, 107.0, 81.0, 81.0, 115.0], "value": 90.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 119.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 85.0, 84.0, 84.0, 84.0, 85.0, 84.0, 84.0], "value": 84.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 52.0, 53.0, 51.0, 51.0, 51.0, 52.0, 51.0, 51.0, 51.0], "value": 51.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 59.0, 60.0, 59.0, 59.0, 59.0, 59.0, 60.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 82.0, 75.0, 82.0, 77.0, 75.0, 75.0, 78.0, 76.0], "value": 77.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 130.0, 129.0, 129.0, 129.0, 139.0, 124.0, 124.0, 170.0, 130.0], "value": 134.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 155.0, 166.0, 156.0, 159.0, 155.0, 156.0, 153.0, 153.0, 159.0], "value": 156.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 64.0, 63.0, 67.0, 61.0, 64.0, 62.0, 62.0, 62.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1465.8, "alertThreshold": 2.0}]} 03:00:26 INFO - Return code: 0 03:00:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:00:26 INFO - # TBPL SUCCESS # 03:00:26 INFO - Running post-action listener: _resource_record_post_action 03:00:26 INFO - [mozharness: 2016-12-11 11:00:26.840009Z] Finished run-tests step (success) 03:00:26 INFO - Running post-run listener: _resource_record_post_run 03:00:26 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 266240; Write bytes: 354451456; Read time: 28; Write time: 310980 03:00:26 INFO - TinderboxPrint: CPU usage
13.0% 03:00:26 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 28 03:00:26 INFO - TinderboxPrint: I/O write bytes / time
354,451,456 / 310,980 03:00:26 INFO - TinderboxPrint: CPU idle
8,276.0 (87.0%) 03:00:26 INFO - TinderboxPrint: CPU user
1,192.5 (12.5%) 03:00:26 INFO - TinderboxPrint: Swap in / out
0 / 0 03:00:26 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108187648; Read time: 0; Write time: 126824 03:00:26 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 262144; Write bytes: 245915648; Read time: 8; Write time: 184152 03:00:27 INFO - Running post-run listener: _upload_blobber_files 03:00:27 INFO - Blob upload gear active. 03:00:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:00:27 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 03:00:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:00:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:00:27 INFO - (blobuploader) - INFO - Open directory for files ... 03:00:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:00:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:00:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:00:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:00:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:00:28 INFO - (blobuploader) - INFO - Done attempting. 03:00:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:00:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:00:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:00:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:00:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:00:31 INFO - (blobuploader) - INFO - Done attempting. 03:00:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:00:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:00:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:00:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:00:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:00:33 INFO - (blobuploader) - INFO - Done attempting. 03:00:33 INFO - (blobuploader) - INFO - Iteration through files over. 03:00:33 INFO - Return code: 0 03:00:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:00:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:00:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67e1c12401ee70d3394a9cc7bfd833deb25834f7d36f4364be881a9a3298080d18bafc2a63c139e01ebda84c83325d132afb8698a94ca496538e163479b96920", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c54d7bcd3aef85182418eca46bae6d2052075c3b3464d16481b7e362695dfa4b53c3f8271125e9da4c54426098a27c4a14a21f7021554f8adcd0379b8e10d89", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf82495fc962d6fc5a352026625d3db5d9f4afacb2d62e7308ac2d327d5d3104907833eac9ee2b2105225c3cf84f6b9514cf896db18a2fa74a8e9801075464c2"} 03:00:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:00:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:00:33 INFO - Contents: 03:00:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67e1c12401ee70d3394a9cc7bfd833deb25834f7d36f4364be881a9a3298080d18bafc2a63c139e01ebda84c83325d132afb8698a94ca496538e163479b96920", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c54d7bcd3aef85182418eca46bae6d2052075c3b3464d16481b7e362695dfa4b53c3f8271125e9da4c54426098a27c4a14a21f7021554f8adcd0379b8e10d89", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf82495fc962d6fc5a352026625d3db5d9f4afacb2d62e7308ac2d327d5d3104907833eac9ee2b2105225c3cf84f6b9514cf896db18a2fa74a8e9801075464c2"} 03:00:33 INFO - Running post-run listener: copy_logs_to_upload_dir 03:00:33 INFO - Copying logs to upload dir... 03:00:33 INFO - mkdir: /builds/slave/test/build/upload/logs 03:00:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.365675 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-12-11 03:00:33.549960) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-11 03:00:33.553336) ========= 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=4300f881736b422476174874000001bc-1481452692.256544-55095987 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67e1c12401ee70d3394a9cc7bfd833deb25834f7d36f4364be881a9a3298080d18bafc2a63c139e01ebda84c83325d132afb8698a94ca496538e163479b96920", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c54d7bcd3aef85182418eca46bae6d2052075c3b3464d16481b7e362695dfa4b53c3f8271125e9da4c54426098a27c4a14a21f7021554f8adcd0379b8e10d89", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf82495fc962d6fc5a352026625d3db5d9f4afacb2d62e7308ac2d327d5d3104907833eac9ee2b2105225c3cf84f6b9514cf896db18a2fa74a8e9801075464c2"} build_url:https://queue.taskcluster.net/v1/task/HLKeAgElR0CEQbRzcz-PFw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011401 build_url: 'https://queue.taskcluster.net/v1/task/HLKeAgElR0CEQbRzcz-PFw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67e1c12401ee70d3394a9cc7bfd833deb25834f7d36f4364be881a9a3298080d18bafc2a63c139e01ebda84c83325d132afb8698a94ca496538e163479b96920", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c54d7bcd3aef85182418eca46bae6d2052075c3b3464d16481b7e362695dfa4b53c3f8271125e9da4c54426098a27c4a14a21f7021554f8adcd0379b8e10d89", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf82495fc962d6fc5a352026625d3db5d9f4afacb2d62e7308ac2d327d5d3104907833eac9ee2b2105225c3cf84f6b9514cf896db18a2fa74a8e9801075464c2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-11 03:00:33.579075) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-11 03:00:33.579403) ========= 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=4300f881736b422476174874000001bc-1481452692.256544-55095987 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-11 03:00:33.661692) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-11 03:00:33.662009) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-11 03:00:33.662300) ========= ========= Total master_lag: 0.17 =========