builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-004 starttime: 1480442586.55 results: success (0) buildid: 20161129071727 builduid: eee61be0e4e24103b937939d31953c22 revision: 75ff11d338b2eb7e236362f5da84fc51d3d84cb1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 10:03:06.551696) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 10:03:06.552166) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 10:03:06.552445) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 10:03:06.567287) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 10:03:06.567669) ========= 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=c6927cf182745ad25b1d38b9000001fe-1480442586.66444-1358428423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-29 10:03:06-- 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% 213M=0s 2016-11-29 10:03:06 (213 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.116499 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 10:03:06.698587) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 10:03:06.698911) ========= 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=c6927cf182745ad25b1d38b9000001fe-1480442586.66444-1358428423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016586 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 10:03:06.750099) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 10:03:06.750621) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 75ff11d338b2eb7e236362f5da84fc51d3d84cb1 --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 75ff11d338b2eb7e236362f5da84fc51d3d84cb1 --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=c6927cf182745ad25b1d38b9000001fe-1480442586.66444-1358428423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-29 10:03:07,018 truncating revision to first 12 chars 2016-11-29 10:03:07,018 Setting DEBUG logging. 2016-11-29 10:03:07,018 attempt 1/10 2016-11-29 10:03:07,018 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/75ff11d338b2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-29 10:03:07,321 unpacking tar archive at: mozilla-aurora-75ff11d338b2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.627685 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 10:03:07.391889) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 10:03:07.392301) ========= script_repo_revision: 75ff11d338b2eb7e236362f5da84fc51d3d84cb1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 10:03:07.392747) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 10:03:07.393016) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 10:03:07.401219) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-11-29 10:03:07.401531) ========= /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=c6927cf182745ad25b1d38b9000001fe-1480442586.66444-1358428423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:03:07 INFO - MultiFileLogger online at 20161129 10:03:07 in /builds/slave/test 10:03:07 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 10:03:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:03:07 INFO - {'append_to_log': False, 10:03:07 INFO - 'base_work_dir': '/builds/slave/test', 10:03:07 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:03:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:03:07 INFO - 'branch': 'Mozilla-Aurora', 10:03:07 INFO - 'buildbot_json_path': 'buildprops.json', 10:03:07 INFO - 'config_files': ('talos/linux_config.py',), 10:03:07 INFO - 'default_actions': ('clobber', 10:03:07 INFO - 'read-buildbot-config', 10:03:07 INFO - 'download-and-extract', 10:03:07 INFO - 'populate-webroot', 10:03:07 INFO - 'create-virtualenv', 10:03:07 INFO - 'install', 10:03:07 INFO - 'run-tests'), 10:03:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:03:07 INFO - 'download_minidump_stackwalk': True, 10:03:07 INFO - 'download_symbols': 'ondemand', 10:03:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:03:07 INFO - 'tooltool.py': '/tools/tooltool.py', 10:03:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:03:07 INFO - '/tools/misc-python/virtualenv.py')}, 10:03:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:03:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:03:07 INFO - 'installer_path': 'installer.exe', 10:03:07 INFO - 'log_level': 'info', 10:03:07 INFO - 'log_name': 'talos', 10:03:07 INFO - 'log_to_console': True, 10:03:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:03:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:03:07 INFO - 'opt_config_files': (), 10:03:07 INFO - 'pip_index': False, 10:03:07 INFO - 'sps_profile': False, 10:03:07 INFO - 'sps_profile_interval': 0, 10:03:07 INFO - 'suite': 'dromaeojs', 10:03:07 INFO - 'system_bits': '32', 10:03:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:03:07 INFO - 'title': 'talos-linux64-ix-004', 10:03:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:03:07 INFO - 'use_talos_json': True, 10:03:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:03:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:03:07 INFO - 'work_dir': 'build'} 10:03:07 INFO - [mozharness: 2016-11-29 18:03:07.774788Z] Running clobber step. 10:03:07 INFO - Running pre-action listener: _resource_record_pre_action 10:03:07 INFO - Running main action method: clobber 10:03:07 INFO - rmtree: /builds/slave/test/build 10:03:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:03:08 INFO - Running post-action listener: _resource_record_post_action 10:03:08 INFO - [mozharness: 2016-11-29 18:03:08.233232Z] Finished clobber step (success) 10:03:08 INFO - [mozharness: 2016-11-29 18:03:08.233342Z] Running read-buildbot-config step. 10:03:08 INFO - Running pre-action listener: _resource_record_pre_action 10:03:08 INFO - Running main action method: read_buildbot_config 10:03:08 INFO - Using buildbot properties: 10:03:08 INFO - { 10:03:08 INFO - "project": "", 10:03:08 INFO - "product": "firefox", 10:03:08 INFO - "script_repo_revision": "production", 10:03:08 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 10:03:08 INFO - "repository": "", 10:03:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 10:03:08 INFO - "buildid": "20161129071727", 10:03:08 INFO - "pgo_build": "True", 10:03:08 INFO - "basedir": "/builds/slave/test", 10:03:08 INFO - "buildnumber": 934, 10:03:08 INFO - "slavename": "talos-linux64-ix-004", 10:03:08 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:03:08 INFO - "platform": "ubuntu64_hw", 10:03:08 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 10:03:08 INFO - "branch": "mozilla-aurora", 10:03:08 INFO - "repo_path": "releases/mozilla-aurora", 10:03:08 INFO - "revision": "75ff11d338b2eb7e236362f5da84fc51d3d84cb1", 10:03:08 INFO - "stage_platform": "linux64-pgo", 10:03:08 INFO - "builduid": "eee61be0e4e24103b937939d31953c22", 10:03:08 INFO - "slavebuilddir": "test" 10:03:08 INFO - } 10:03:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/aCu0sArmTKmVBp6JbRHe5Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 10:03:08 INFO - Running post-action listener: _resource_record_post_action 10:03:08 INFO - [mozharness: 2016-11-29 18:03:08.235829Z] Finished read-buildbot-config step (success) 10:03:08 INFO - [mozharness: 2016-11-29 18:03:08.235918Z] Running download-and-extract step. 10:03:08 INFO - Running pre-action listener: _resource_record_pre_action 10:03:08 INFO - Running main action method: download_and_extract 10:03:08 INFO - mkdir: /builds/slave/test/build/tests 10:03: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')]} 10:03:08 INFO - trying https://queue.taskcluster.net/v1/task/aCu0sArmTKmVBp6JbRHe5Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 10:03:08 INFO - Downloading https://queue.taskcluster.net/v1/task/aCu0sArmTKmVBp6JbRHe5Q/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 10:03:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aCu0sArmTKmVBp6JbRHe5Q/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 10:03:08 INFO - Downloaded 1361 bytes. 10:03:08 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 10:03:08 INFO - Using the following test package requirements: 10:03:08 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 10:03:08 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 10:03:08 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 10:03:08 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 10:03:08 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 10:03:08 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 10:03:08 INFO - u'jsshell-linux-x86_64.zip'], 10:03:08 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 10:03:08 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 10:03:08 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 10:03:08 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 10:03:08 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 10:03:08 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 10:03:08 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 10:03:08 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 10:03:08 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 10:03:08 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 10:03:08 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 10:03:08 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:03:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aCu0sArmTKmVBp6JbRHe5Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 10:03:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aCu0sArmTKmVBp6JbRHe5Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:03:08 INFO - Fetch https://queue.taskcluster.net/v1/task/aCu0sArmTKmVBp6JbRHe5Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 10:03:09 INFO - Http code: 200 10:03:09 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 10:03:09 INFO - x-amz-cf-id: HnuY9uitB1PYYi4ZlYTJxCSZcQ6-JVMqB1Dmf3QBokLp5HPm71n1UA== 10:03:09 INFO - x-amz-version-id: 014ANhmJ.qtx0q3CuGVmBIpJHlfNcFlp 10:03:09 INFO - Expected file size: 21955820 10:03:09 INFO - Obtained file size: 21955820 10:03:13 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 10:03:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aCu0sArmTKmVBp6JbRHe5Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 10:03:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aCu0sArmTKmVBp6JbRHe5Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:03:13 INFO - Fetch https://queue.taskcluster.net/v1/task/aCu0sArmTKmVBp6JbRHe5Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 10:03:14 INFO - Http code: 200 10:03:14 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 10:03:14 INFO - x-amz-cf-id: vvqRvytQvIrh5gzCp1dj58jidwlcx6bw-qjCxzFPvzMDem0NlkqBYA== 10:03:14 INFO - x-amz-version-id: 014ANhmJ.qtx0q3CuGVmBIpJHlfNcFlp 10:03:14 INFO - Expected file size: 21955820 10:03:14 INFO - Obtained file size: 21955820 10:03:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aCu0sArmTKmVBp6JbRHe5Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 10:03:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aCu0sArmTKmVBp6JbRHe5Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:03:18 INFO - Fetch https://queue.taskcluster.net/v1/task/aCu0sArmTKmVBp6JbRHe5Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 10:03:19 INFO - Http code: 200 10:03:19 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 10:03:19 INFO - x-amz-cf-id: 68apw1i814l_N5Saob0s6kh7R9IL1ye2I8o8h2H1F2xCfCfcMfcYdQ== 10:03:19 INFO - x-amz-version-id: S75x_QdkY0fyN2cybGTioab_X81BjWy2 10:03:19 INFO - Expected file size: 14409038 10:03:19 INFO - Obtained file size: 14409038 10:03: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')]} 10:03:19 INFO - trying https://queue.taskcluster.net/v1/task/aCu0sArmTKmVBp6JbRHe5Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 10:03:19 INFO - Downloading https://queue.taskcluster.net/v1/task/aCu0sArmTKmVBp6JbRHe5Q/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 10:03:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aCu0sArmTKmVBp6JbRHe5Q/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 10:03:20 INFO - Downloaded 63964112 bytes. 10:03:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aCu0sArmTKmVBp6JbRHe5Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 10:03:20 INFO - mkdir: /builds/slave/test/properties 10:03:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:03:20 INFO - Writing to file /builds/slave/test/properties/build_url 10:03:20 INFO - Contents: 10:03:20 INFO - build_url:https://queue.taskcluster.net/v1/task/aCu0sArmTKmVBp6JbRHe5Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 10:03:21 INFO - Running post-action listener: _resource_record_post_action 10:03:21 INFO - Running post-action listener: set_extra_try_arguments 10:03:21 INFO - [mozharness: 2016-11-29 18:03:21.663900Z] Finished download-and-extract step (success) 10:03:21 INFO - [mozharness: 2016-11-29 18:03:21.664126Z] Running populate-webroot step. 10:03:21 INFO - Running pre-action listener: _resource_record_pre_action 10:03:21 INFO - Running main action method: populate_webroot 10:03:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:03:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:03:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:03:21 INFO - '--tppagecycles', 10:03:21 INFO - '7'], 10:03:21 INFO - 'tests': ['tsvgm']}}, 10:03:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:03:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:03:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:03:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:03:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:03:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:03:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:21 INFO - 'talos_options': ['--disable-e10s'], 10:03:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:03:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:03:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:21 INFO - 'talos_options': ['--disable-e10s'], 10:03:21 INFO - 'tests': ['damp', 'tps']}, 10:03:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:21 INFO - 'tests': ['damp', 'tps']}, 10:03:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:03:21 INFO - 'tests': ['dromaeo_dom']}, 10:03:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:03:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:03:21 INFO - 'tests': ['basic_compositor_video']}, 10:03:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:03:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:03:21 INFO - 'tests': ['a11yr', 10:03:21 INFO - 'ts_paint', 10:03:21 INFO - 'tpaint', 10:03:21 INFO - 'sessionrestore', 10:03:21 INFO - 'sessionrestore_no_auto_restore', 10:03:21 INFO - 'tabpaint']}, 10:03:21 INFO - 'other-e10s': {'tests': ['a11yr', 10:03:21 INFO - 'ts_paint', 10:03:21 INFO - 'tpaint', 10:03:21 INFO - 'sessionrestore', 10:03:21 INFO - 'sessionrestore_no_auto_restore', 10:03:21 INFO - 'tabpaint']}, 10:03:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:03:21 INFO - 'ts_paint', 10:03:21 INFO - 'tpaint', 10:03:21 INFO - 'sessionrestore', 10:03:21 INFO - 'sessionrestore_no_auto_restore', 10:03:21 INFO - 'tabpaint']}, 10:03:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:03:21 INFO - 'ts_paint', 10:03:21 INFO - 'tpaint', 10:03:21 INFO - 'sessionrestore', 10:03:21 INFO - 'sessionrestore_no_auto_restore', 10:03:21 INFO - 'tabpaint']}, 10:03:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:03:21 INFO - 'tests': ['a11yr', 10:03:21 INFO - 'ts_paint', 10:03:21 INFO - 'tpaint', 10:03:21 INFO - 'sessionrestore', 10:03:21 INFO - 'sessionrestore_no_auto_restore', 10:03:21 INFO - 'tabpaint']}, 10:03:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:03:21 INFO - 'tests': ['a11yr', 10:03:21 INFO - 'ts_paint', 10:03:21 INFO - 'tpaint', 10:03:21 INFO - 'sessionrestore', 10:03:21 INFO - 'sessionrestore_no_auto_restore', 10:03:21 INFO - 'tabpaint']}, 10:03:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:03:21 INFO - 'tests': ['tsvgx', 10:03:21 INFO - 'tsvgr_opacity', 10:03:21 INFO - 'tart', 10:03:21 INFO - 'tscrollx', 10:03:21 INFO - 'cart']}, 10:03:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:03:21 INFO - 'tsvgr_opacity', 10:03:21 INFO - 'tart', 10:03:21 INFO - 'tscrollx', 10:03:21 INFO - 'cart']}, 10:03:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:21 INFO - 'talos_options': ['--disable-e10s'], 10:03:21 INFO - 'tests': ['tp5o']}, 10:03:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:21 INFO - 'tests': ['tp5o']}, 10:03:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:21 INFO - 'talos_options': ['--disable-e10s', 10:03:21 INFO - '--xperf_path', 10:03:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:03:21 INFO - 'tests': ['tp5n']}, 10:03:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:21 INFO - 'talos_options': ['--xperf_path', 10:03:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:03:21 INFO - 'tests': ['tp5n']}}, 10:03:21 INFO - 'talos.zip': {'path': '', 10:03:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:03:21 INFO - Running post-action listener: _resource_record_post_action 10:03:21 INFO - [mozharness: 2016-11-29 18:03:21.680701Z] Finished populate-webroot step (success) 10:03:21 INFO - [mozharness: 2016-11-29 18:03:21.680789Z] Running create-virtualenv step. 10:03:21 INFO - Running pre-action listener: _resource_record_pre_action 10:03:21 INFO - Running main action method: create_virtualenv 10:03:21 INFO - Creating virtualenv /builds/slave/test/build/venv 10:03:21 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 10:03:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:03:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:03:21 INFO - Using real prefix '/usr' 10:03:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:03:22 INFO - Installing distribute.............................................................................................................................................................................................done. 10:03:24 INFO - Installing pip.................done. 10:03:24 INFO - Return code: 0 10:03:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:03:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:03:24 INFO - Reading from file tmpfile_stdout 10:03:24 INFO - Output received: 10:03:24 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) 10:03:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:03:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:03:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:03:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb1c805f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ccf60>, '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 0x13cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ce1d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1480442586.66444-1358428423', '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 10:03:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:03:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:03:24 INFO - Using env: {'DISPLAY': ':0', 10:03:24 INFO - 'HOME': '/home/cltbld', 10:03:24 INFO - 'LANG': 'en_US.UTF-8', 10:03:24 INFO - 'LANGUAGE': 'en_US:en', 10:03:24 INFO - 'LOGNAME': 'cltbld', 10:03:24 INFO - 'MAIL': '/var/mail/cltbld', 10:03:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:24 INFO - 'MOZ_NO_REMOTE': '1', 10:03:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:03:24 INFO - 'NO_EM_RESTART': '1', 10:03:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:03:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:24 INFO - 'PWD': '/builds/slave/test', 10:03:24 INFO - 'SHELL': '/bin/bash', 10:03:24 INFO - 'SHLVL': '1', 10:03:24 INFO - 'TERM': 'linux', 10:03:24 INFO - 'TMOUT': '86400', 10:03:24 INFO - 'USER': 'cltbld', 10:03:24 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1480442586.66444-1358428423', 10:03:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:24 INFO - '_': '/tools/buildbot/bin/python'} 10:03:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:24 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 10:03:24 INFO - Cleaning up... 10:03:24 INFO - Return code: 0 10:03:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:03:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:03:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:03:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffb1c805f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ccf60>, '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 0x13cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ce1d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1480442586.66444-1358428423', '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 10:03:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:03:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:03:24 INFO - Using env: {'DISPLAY': ':0', 10:03:24 INFO - 'HOME': '/home/cltbld', 10:03:24 INFO - 'LANG': 'en_US.UTF-8', 10:03:24 INFO - 'LANGUAGE': 'en_US:en', 10:03:24 INFO - 'LOGNAME': 'cltbld', 10:03:24 INFO - 'MAIL': '/var/mail/cltbld', 10:03:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:24 INFO - 'MOZ_NO_REMOTE': '1', 10:03:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:03:24 INFO - 'NO_EM_RESTART': '1', 10:03:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:03:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:24 INFO - 'PWD': '/builds/slave/test', 10:03:24 INFO - 'SHELL': '/bin/bash', 10:03:24 INFO - 'SHLVL': '1', 10:03:24 INFO - 'TERM': 'linux', 10:03:24 INFO - 'TMOUT': '86400', 10:03:24 INFO - 'USER': 'cltbld', 10:03:24 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1480442586.66444-1358428423', 10:03:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:24 INFO - '_': '/tools/buildbot/bin/python'} 10:03:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:24 INFO - Downloading/unpacking psutil>=3.1.1 10:03:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:03:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:03:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:03:28 INFO - Installing collected packages: psutil 10:03:28 INFO - Running setup.py install for psutil 10:03:28 INFO - building 'psutil._psutil_linux' extension 10:03:28 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 10:03:28 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 10:03:28 INFO - building 'psutil._psutil_posix' extension 10:03:28 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 10:03:28 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 10:03:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:03:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:03:28 INFO - Successfully installed psutil 10:03:28 INFO - Cleaning up... 10:03:28 INFO - Return code: 0 10:03:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:03:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:03:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:28 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 0x7ffb1c805f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ccf60>, '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 0x13cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ce1d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1480442586.66444-1358428423', '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 10:03:28 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 10:03:28 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 10:03:28 INFO - Using env: {'DISPLAY': ':0', 10:03:28 INFO - 'HOME': '/home/cltbld', 10:03:28 INFO - 'LANG': 'en_US.UTF-8', 10:03:28 INFO - 'LANGUAGE': 'en_US:en', 10:03:28 INFO - 'LOGNAME': 'cltbld', 10:03:28 INFO - 'MAIL': '/var/mail/cltbld', 10:03:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:28 INFO - 'MOZ_NO_REMOTE': '1', 10:03:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:03:28 INFO - 'NO_EM_RESTART': '1', 10:03:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:03:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:28 INFO - 'PWD': '/builds/slave/test', 10:03:28 INFO - 'SHELL': '/bin/bash', 10:03:28 INFO - 'SHLVL': '1', 10:03:28 INFO - 'TERM': 'linux', 10:03:28 INFO - 'TMOUT': '86400', 10:03:28 INFO - 'USER': 'cltbld', 10:03:28 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1480442586.66444-1358428423', 10:03:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:28 INFO - '_': '/tools/buildbot/bin/python'} 10:03:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:03:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:03:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:03:30 INFO - Installing collected packages: mozsystemmonitor 10:03:30 INFO - Running setup.py install for mozsystemmonitor 10:03:30 INFO - Successfully installed mozsystemmonitor 10:03:30 INFO - Cleaning up... 10:03:31 INFO - Return code: 0 10:03:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:03:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:03:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:03:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:31 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 0x7ffb1c805f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ccf60>, '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 0x13cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ce1d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1480442586.66444-1358428423', '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 10:03:31 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 10:03:31 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 10:03:31 INFO - Using env: {'DISPLAY': ':0', 10:03:31 INFO - 'HOME': '/home/cltbld', 10:03:31 INFO - 'LANG': 'en_US.UTF-8', 10:03:31 INFO - 'LANGUAGE': 'en_US:en', 10:03:31 INFO - 'LOGNAME': 'cltbld', 10:03:31 INFO - 'MAIL': '/var/mail/cltbld', 10:03:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:31 INFO - 'MOZ_NO_REMOTE': '1', 10:03:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:03:31 INFO - 'NO_EM_RESTART': '1', 10:03:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:03:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:31 INFO - 'PWD': '/builds/slave/test', 10:03:31 INFO - 'SHELL': '/bin/bash', 10:03:31 INFO - 'SHLVL': '1', 10:03:31 INFO - 'TERM': 'linux', 10:03:31 INFO - 'TMOUT': '86400', 10:03:31 INFO - 'USER': 'cltbld', 10:03:31 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1480442586.66444-1358428423', 10:03:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:31 INFO - '_': '/tools/buildbot/bin/python'} 10:03:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:31 INFO - Downloading/unpacking jsonschema==2.5.1 10:03: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 10:03: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 10:03: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 10:03: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 10:03: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 10:03: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 10:03:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:03:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:03:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:33 INFO - Downloading functools32-3.2.3-2.tar.gz 10:03:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:03:33 INFO - warning: no files found matching '*.txt' 10:03:33 INFO - no previously-included directories found matching 'build' 10:03:33 INFO - no previously-included directories found matching 'dist' 10:03:33 INFO - no previously-included directories found matching '.git*' 10:03:33 INFO - Installing collected packages: jsonschema, functools32 10:03:33 INFO - Running setup.py install for functools32 10:03:33 INFO - warning: no files found matching '*.txt' 10:03:33 INFO - no previously-included directories found matching 'build' 10:03:33 INFO - no previously-included directories found matching 'dist' 10:03:33 INFO - no previously-included directories found matching '.git*' 10:03:33 INFO - Successfully installed jsonschema functools32 10:03:33 INFO - Cleaning up... 10:03:33 INFO - Return code: 0 10:03:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:03: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')]} 10:03:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03: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')]} 10:03:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:33 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 0x7ffb1c805f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ccf60>, '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 0x13cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ce1d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1480442586.66444-1358428423', '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 10:03:33 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 10:03:33 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 10:03:33 INFO - Using env: {'DISPLAY': ':0', 10:03:33 INFO - 'HOME': '/home/cltbld', 10:03:33 INFO - 'LANG': 'en_US.UTF-8', 10:03:33 INFO - 'LANGUAGE': 'en_US:en', 10:03:33 INFO - 'LOGNAME': 'cltbld', 10:03:33 INFO - 'MAIL': '/var/mail/cltbld', 10:03:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:33 INFO - 'MOZ_NO_REMOTE': '1', 10:03:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:03:33 INFO - 'NO_EM_RESTART': '1', 10:03:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:03:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:33 INFO - 'PWD': '/builds/slave/test', 10:03:33 INFO - 'SHELL': '/bin/bash', 10:03:33 INFO - 'SHLVL': '1', 10:03:33 INFO - 'TERM': 'linux', 10:03:33 INFO - 'TMOUT': '86400', 10:03:33 INFO - 'USER': 'cltbld', 10:03:33 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1480442586.66444-1358428423', 10:03:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:33 INFO - '_': '/tools/buildbot/bin/python'} 10:03:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:03:33 INFO - Cleaning up... 10:03:33 INFO - Return code: 0 10:03:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:03: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')]} 10:03:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03: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')]} 10:03:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:33 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 0x7ffb1c805f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ccf60>, '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 0x13cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ce1d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1480442586.66444-1358428423', '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 10:03:33 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 10:03:33 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 10:03:33 INFO - Using env: {'DISPLAY': ':0', 10:03:33 INFO - 'HOME': '/home/cltbld', 10:03:33 INFO - 'LANG': 'en_US.UTF-8', 10:03:33 INFO - 'LANGUAGE': 'en_US:en', 10:03:33 INFO - 'LOGNAME': 'cltbld', 10:03:33 INFO - 'MAIL': '/var/mail/cltbld', 10:03:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:33 INFO - 'MOZ_NO_REMOTE': '1', 10:03:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:03:33 INFO - 'NO_EM_RESTART': '1', 10:03:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:03:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:33 INFO - 'PWD': '/builds/slave/test', 10:03:33 INFO - 'SHELL': '/bin/bash', 10:03:33 INFO - 'SHLVL': '1', 10:03:33 INFO - 'TERM': 'linux', 10:03:33 INFO - 'TMOUT': '86400', 10:03:33 INFO - 'USER': 'cltbld', 10:03:33 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1480442586.66444-1358428423', 10:03:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:33 INFO - '_': '/tools/buildbot/bin/python'} 10:03:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:34 INFO - Downloading/unpacking blobuploader==1.2.4 10:03:34 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 10:03:34 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 10:03:34 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 10:03:34 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 10:03:34 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 10:03:34 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 10:03:36 INFO - Downloading blobuploader-1.2.4.tar.gz 10:03:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:03:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:03:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:03:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:03:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:36 INFO - Downloading docopt-0.6.1.tar.gz 10:03:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:03:36 INFO - Installing collected packages: blobuploader, requests, docopt 10:03:36 INFO - Running setup.py install for blobuploader 10:03:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:03:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:03:37 INFO - Running setup.py install for requests 10:03:37 INFO - Running setup.py install for docopt 10:03:37 INFO - Successfully installed blobuploader requests docopt 10:03:37 INFO - Cleaning up... 10:03:37 INFO - Return code: 0 10:03:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:03:37 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')]} 10:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:37 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')]} 10:03:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:37 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 0x7ffb1c805f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ccf60>, '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 0x13cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ce1d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1480442586.66444-1358428423', '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 10:03:37 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 10:03:37 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 10:03:37 INFO - Using env: {'DISPLAY': ':0', 10:03:37 INFO - 'HOME': '/home/cltbld', 10:03:37 INFO - 'LANG': 'en_US.UTF-8', 10:03:37 INFO - 'LANGUAGE': 'en_US:en', 10:03:37 INFO - 'LOGNAME': 'cltbld', 10:03:37 INFO - 'MAIL': '/var/mail/cltbld', 10:03:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:37 INFO - 'MOZ_NO_REMOTE': '1', 10:03:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:03:37 INFO - 'NO_EM_RESTART': '1', 10:03:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:03:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:37 INFO - 'PWD': '/builds/slave/test', 10:03:37 INFO - 'SHELL': '/bin/bash', 10:03:37 INFO - 'SHLVL': '1', 10:03:37 INFO - 'TERM': 'linux', 10:03:37 INFO - 'TMOUT': '86400', 10:03:37 INFO - 'USER': 'cltbld', 10:03:37 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1480442586.66444-1358428423', 10:03:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:37 INFO - '_': '/tools/buildbot/bin/python'} 10:03:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:03:37 INFO - Running setup.py (path:/tmp/pip-1HFIGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:03:37 INFO - Running setup.py (path:/tmp/pip-0JBHAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:03:37 INFO - Running setup.py (path:/tmp/pip-XE_KAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:03:37 INFO - Running setup.py (path:/tmp/pip-4fyGDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:03:38 INFO - Running setup.py (path:/tmp/pip-ElDljq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:03:38 INFO - Running setup.py (path:/tmp/pip-D4aqV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:03:38 INFO - Running setup.py (path:/tmp/pip-Rc691e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:03:38 INFO - Running setup.py (path:/tmp/pip-uGyod_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:03:38 INFO - Running setup.py (path:/tmp/pip-TDGAmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:03:38 INFO - Running setup.py (path:/tmp/pip-MU2xGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:03:38 INFO - Running setup.py (path:/tmp/pip-WyFpIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:03:38 INFO - Running setup.py (path:/tmp/pip-3A56so-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:03:38 INFO - Running setup.py (path:/tmp/pip-NP4Pb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:03:38 INFO - Running setup.py (path:/tmp/pip-VUJ2dr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:03:38 INFO - Running setup.py (path:/tmp/pip-woGB1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:03:38 INFO - Running setup.py (path:/tmp/pip-gbbMJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:03:38 INFO - Running setup.py (path:/tmp/pip-wuk_Hs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:03:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:03:38 INFO - Running setup.py install for manifestparser 10:03:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:03:39 INFO - Running setup.py install for mozcrash 10:03:39 INFO - Running setup.py install for mozdebug 10:03:39 INFO - Running setup.py install for mozdevice 10:03:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:03:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:03:39 INFO - Running setup.py install for mozfile 10:03:39 INFO - Running setup.py install for mozhttpd 10:03:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:03:39 INFO - Running setup.py install for mozinfo 10:03:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:03:39 INFO - Running setup.py install for mozInstall 10:03:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:03:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:03:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:03:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:03:39 INFO - Running setup.py install for mozleak 10:03:39 INFO - Running setup.py install for mozlog 10:03:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:03:40 INFO - Running setup.py install for moznetwork 10:03:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:03:40 INFO - Running setup.py install for mozprocess 10:03:40 INFO - Running setup.py install for mozprofile 10:03:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:03:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:03:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:03:40 INFO - Running setup.py install for mozrunner 10:03:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:03:40 INFO - Running setup.py install for mozscreenshot 10:03:40 INFO - Running setup.py install for moztest 10:03:40 INFO - Running setup.py install for mozversion 10:03:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:03:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:03:40 INFO - Cleaning up... 10:03:40 INFO - Return code: 0 10:03:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:03:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:40 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 0x7ffb1c805f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ccf60>, '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 0x13cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ce1d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1480442586.66444-1358428423', '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 10:03:40 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 10:03:40 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 10:03:40 INFO - Using env: {'DISPLAY': ':0', 10:03:40 INFO - 'HOME': '/home/cltbld', 10:03:40 INFO - 'LANG': 'en_US.UTF-8', 10:03:40 INFO - 'LANGUAGE': 'en_US:en', 10:03:40 INFO - 'LOGNAME': 'cltbld', 10:03:40 INFO - 'MAIL': '/var/mail/cltbld', 10:03:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:40 INFO - 'MOZ_NO_REMOTE': '1', 10:03:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:03:40 INFO - 'NO_EM_RESTART': '1', 10:03:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:03:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:40 INFO - 'PWD': '/builds/slave/test', 10:03:40 INFO - 'SHELL': '/bin/bash', 10:03:40 INFO - 'SHLVL': '1', 10:03:40 INFO - 'TERM': 'linux', 10:03:40 INFO - 'TMOUT': '86400', 10:03:40 INFO - 'USER': 'cltbld', 10:03:40 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1480442586.66444-1358428423', 10:03:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:40 INFO - '_': '/tools/buildbot/bin/python'} 10:03:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:03:41 INFO - Running setup.py (path:/tmp/pip-j9eqH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:03:41 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)) 10:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:03:41 INFO - Running setup.py (path:/tmp/pip-F_v9mX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:03:41 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)) 10:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:03:41 INFO - Running setup.py (path:/tmp/pip-0IBajQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:03:41 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)) 10:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:03:41 INFO - Running setup.py (path:/tmp/pip-Nhmpiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:03:41 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)) 10:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:03:41 INFO - Running setup.py (path:/tmp/pip-hSAovo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:03:41 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)) 10:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:03:41 INFO - Running setup.py (path:/tmp/pip-knj13s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:03:41 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)) 10:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:03:41 INFO - Running setup.py (path:/tmp/pip-d0ks6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:03:41 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)) 10:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:03:41 INFO - Running setup.py (path:/tmp/pip-aNHimw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:03:41 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)) 10:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:03:41 INFO - Running setup.py (path:/tmp/pip-pAgZ5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:03:41 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)) 10:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:03:41 INFO - Running setup.py (path:/tmp/pip-ey_IDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:03:41 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)) 10:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:03:41 INFO - Running setup.py (path:/tmp/pip-aVesox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:03:41 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)) 10:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:03:41 INFO - Running setup.py (path:/tmp/pip-so8LNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:03:41 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)) 10:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:03:41 INFO - Running setup.py (path:/tmp/pip-lT7pvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:03:41 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)) 10:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:03:41 INFO - Running setup.py (path:/tmp/pip-NE_9e1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:03:42 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)) 10:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:03:42 INFO - Running setup.py (path:/tmp/pip-Z8pttX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:03:42 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)) 10:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:03:42 INFO - Running setup.py (path:/tmp/pip-bki5be-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:03:42 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)) 10:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:03:42 INFO - Running setup.py (path:/tmp/pip-qKB3W4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:03:42 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)) 10:03:42 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)) 10:03:42 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)) 10:03:42 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)) 10:03:42 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)) 10:03:42 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)) 10:03:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:03:42 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 10:03:42 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 10:03:42 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 10:03:42 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 10:03:42 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 10:03:42 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 10:03:44 INFO - Downloading blessings-1.6.tar.gz 10:03:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:03:44 INFO - Installing collected packages: blessings 10:03:44 INFO - Running setup.py install for blessings 10:03:44 INFO - Successfully installed blessings 10:03:44 INFO - Cleaning up... 10:03:44 INFO - Return code: 0 10:03:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:03:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:03:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:03:44 INFO - Reading from file tmpfile_stdout 10:03:44 INFO - Current package versions: 10:03:44 INFO - argparse == 1.2.1 10:03:44 INFO - blessings == 1.6 10:03:44 INFO - blobuploader == 1.2.4 10:03:44 INFO - docopt == 0.6.1 10:03:44 INFO - functools32 == 3.2.3-2 10:03:44 INFO - jsonschema == 2.5.1 10:03:44 INFO - manifestparser == 1.1 10:03:44 INFO - mozInstall == 1.12 10:03:44 INFO - mozcrash == 1.0 10:03:44 INFO - mozdebug == 0.1 10:03:44 INFO - mozdevice == 0.48 10:03:44 INFO - mozfile == 1.2 10:03:44 INFO - mozhttpd == 0.7 10:03:44 INFO - mozinfo == 0.9 10:03:44 INFO - mozleak == 0.1 10:03:44 INFO - mozlog == 3.4 10:03:44 INFO - moznetwork == 0.27 10:03:44 INFO - mozprocess == 0.23 10:03:44 INFO - mozprofile == 0.28 10:03:44 INFO - mozrunner == 6.13 10:03:44 INFO - mozscreenshot == 0.1 10:03:44 INFO - mozsystemmonitor == 0.3 10:03:44 INFO - moztest == 0.7 10:03:44 INFO - mozversion == 1.4 10:03:44 INFO - psutil == 3.1.1 10:03:44 INFO - requests == 1.2.3 10:03:44 INFO - wsgiref == 0.1.2 10:03:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:03:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:03:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:44 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 0x7ffb1c805f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ccf60>, '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 0x13cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ce1d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1480442586.66444-1358428423', '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 10:03:44 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 10:03:44 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 10:03:44 INFO - Using env: {'DISPLAY': ':0', 10:03:44 INFO - 'HOME': '/home/cltbld', 10:03:44 INFO - 'LANG': 'en_US.UTF-8', 10:03:44 INFO - 'LANGUAGE': 'en_US:en', 10:03:44 INFO - 'LOGNAME': 'cltbld', 10:03:44 INFO - 'MAIL': '/var/mail/cltbld', 10:03:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:44 INFO - 'MOZ_NO_REMOTE': '1', 10:03:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:03:44 INFO - 'NO_EM_RESTART': '1', 10:03:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:03:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:44 INFO - 'PWD': '/builds/slave/test', 10:03:44 INFO - 'SHELL': '/bin/bash', 10:03:44 INFO - 'SHLVL': '1', 10:03:44 INFO - 'TERM': 'linux', 10:03:44 INFO - 'TMOUT': '86400', 10:03:44 INFO - 'USER': 'cltbld', 10:03:44 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1480442586.66444-1358428423', 10:03:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:44 INFO - '_': '/tools/buildbot/bin/python'} 10:03:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:44 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)) 10:03:44 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)) 10:03:44 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)) 10:03:44 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)) 10:03:44 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)) 10:03:44 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)) 10:03:44 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)) 10:03:44 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)) 10:03:44 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)) 10:03:44 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)) 10:03:44 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)) 10:03:44 INFO - Cleaning up... 10:03:44 INFO - Return code: 0 10:03:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:03:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:03:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb1c805f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ccf60>, '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 0x13cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ce1d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1480442586.66444-1358428423', '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 10:03:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:03:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:03:44 INFO - Using env: {'DISPLAY': ':0', 10:03:44 INFO - 'HOME': '/home/cltbld', 10:03:44 INFO - 'LANG': 'en_US.UTF-8', 10:03:44 INFO - 'LANGUAGE': 'en_US:en', 10:03:44 INFO - 'LOGNAME': 'cltbld', 10:03:44 INFO - 'MAIL': '/var/mail/cltbld', 10:03:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:44 INFO - 'MOZ_NO_REMOTE': '1', 10:03:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:03:44 INFO - 'NO_EM_RESTART': '1', 10:03:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:03:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:44 INFO - 'PWD': '/builds/slave/test', 10:03:44 INFO - 'SHELL': '/bin/bash', 10:03:44 INFO - 'SHLVL': '1', 10:03:44 INFO - 'TERM': 'linux', 10:03:44 INFO - 'TMOUT': '86400', 10:03:44 INFO - 'USER': 'cltbld', 10:03:44 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1480442586.66444-1358428423', 10:03:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:44 INFO - '_': '/tools/buildbot/bin/python'} 10:03:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:03:45 INFO - Cleaning up... 10:03:45 INFO - Return code: 0 10:03:45 INFO - Running post-action listener: _resource_record_post_action 10:03:45 INFO - Running post-action listener: _start_resource_monitoring 10:03:45 INFO - Starting resource monitoring. 10:03:45 INFO - [mozharness: 2016-11-29 18:03:45.208860Z] Finished create-virtualenv step (success) 10:03:45 INFO - [mozharness: 2016-11-29 18:03:45.209458Z] Running install step. 10:03:45 INFO - Running pre-action listener: _resource_record_pre_action 10:03:45 INFO - Running main action method: install 10:03:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:03:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:03:45 INFO - Reading from file tmpfile_stdout 10:03:45 INFO - Detecting whether we're running mozinstall >=1.0... 10:03:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:03:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:03:45 INFO - Reading from file tmpfile_stdout 10:03:45 INFO - Output received: 10:03:45 INFO - Usage: mozinstall [options] installer 10:03:45 INFO - Options: 10:03:45 INFO - -h, --help show this help message and exit 10:03:45 INFO - -d DEST, --destination=DEST 10:03:45 INFO - Directory to install application into. [default: 10:03:45 INFO - "/builds/slave/test"] 10:03:45 INFO - --app=APP Application being installed. [default: firefox] 10:03:45 INFO - mkdir: /builds/slave/test/build/application 10:03:45 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'] 10:03:45 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 10:04:01 INFO - Reading from file tmpfile_stdout 10:04:01 INFO - Output received: 10:04:01 INFO - /builds/slave/test/build/application/firefox/firefox 10:04:01 INFO - Running post-action listener: _resource_record_post_action 10:04:01 INFO - [mozharness: 2016-11-29 18:04:01.407612Z] Finished install step (success) 10:04:01 INFO - [mozharness: 2016-11-29 18:04:01.407855Z] Running run-tests step. 10:04:01 INFO - Running pre-action listener: _resource_record_pre_action 10:04:01 INFO - Running main action method: run_tests 10:04:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:04:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:04:01 INFO - Python 2.7.3 10:04:01 INFO - Return code: 0 10:04:01 INFO - grabbing minidump binary from tooltool 10:04:01 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')]} 10:04:01 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 0x13ccf60>, '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 0x13cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ce1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:04:01 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 10:04:01 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 10:04:01 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 10:04:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:04:01 INFO - Return code: 0 10:04:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:04:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:04:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:04:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:04:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:04:01 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/aCu0sArmTKmVBp6JbRHe5Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 10:04:01 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/aCu0sArmTKmVBp6JbRHe5Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --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 10:04:01 INFO - Using env: {'DISPLAY': ':0', 10:04:01 INFO - 'HOME': '/home/cltbld', 10:04:01 INFO - 'LANG': 'en_US.UTF-8', 10:04:01 INFO - 'LANGUAGE': 'en_US:en', 10:04:01 INFO - 'LOGNAME': 'cltbld', 10:04:01 INFO - 'MAIL': '/var/mail/cltbld', 10:04:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:04:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:04:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:01 INFO - 'MOZ_NO_REMOTE': '1', 10:04:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:04:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:01 INFO - 'NO_EM_RESTART': '1', 10:04:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:01 INFO - 'PWD': '/builds/slave/test', 10:04:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:04:01 INFO - 'SHELL': '/bin/bash', 10:04:01 INFO - 'SHLVL': '1', 10:04:01 INFO - 'TERM': 'linux', 10:04:01 INFO - 'TMOUT': '86400', 10:04:01 INFO - 'USER': 'cltbld', 10:04:01 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1480442586.66444-1358428423', 10:04:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:01 INFO - '_': '/tools/buildbot/bin/python'} 10:04:01 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/aCu0sArmTKmVBp6JbRHe5Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 10:04:01 INFO - mozversion application_buildid: 20161129071727 10:04:01 INFO - mozversion application_changeset: 75ff11d338b2eb7e236362f5da84fc51d3d84cb1 10:04:01 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:04:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:04:01 INFO - mozversion application_name: Firefox 10:04:01 INFO - mozversion application_remotingname: firefox-dev 10:04:01 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:04:01 INFO - mozversion application_vendor: Mozilla 10:04:01 INFO - mozversion application_version: 52.0a2 10:04:01 INFO - mozversion platform_buildid: 20161129071727 10:04:01 INFO - mozversion platform_changeset: 75ff11d338b2eb7e236362f5da84fc51d3d84cb1 10:04:01 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:04:01 INFO - mozversion platform_version: 52.0a2 10:04:01 INFO - using testdate: 1480442641 10:04:01 INFO - actual date: 1480442641 10:04:01 INFO - starting webserver on 'localhost:33314' 10:04:01 INFO - SUITE-START | Running 2 tests 10:04:01 INFO - TEST-START | dromaeo_css 10:04:01 INFO - operating with platform_type : linux_ 10:04:01 INFO - Initialising browser for dromaeo_css test... 10:04:01 INFO - TEST-INFO | started process 16939 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpapWgaB/profile http://localhost:33314/getInfo.html) 10:04:05 INFO - PROCESS | 16939 | __metrics Screen width/height:1600/1200 10:04:05 INFO - PROCESS | 16939 | colorDepth:24 10:04:05 INFO - PROCESS | 16939 | Browser inner width/height: 1024/697 10:04:05 INFO - PROCESS | 16939 | __metrics 10:04:06 INFO - PROCESS | 16939 | 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" 10:04:06 INFO - PROCESS | 16939 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:04:06 INFO - PROCESS | 16939 | console.error: PushService: 10:04:06 INFO - PROCESS | 16939 | stateChangeProcessEnqueue: Error transitioning state 10:04:06 INFO - PROCESS | 16939 | UnknownError 10:04:07 INFO - TEST-INFO | 16939: exit 0 10:04:07 INFO - Browser initialized. 10:04:07 INFO - Running cycle 1/1 for dromaeo_css test... 10:04:07 INFO - TEST-INFO | started process 17032 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpapWgaB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:04:19 INFO - PROCESS | 17032 | RSS: Main: 145616896 10:04:19 INFO - PROCESS | 17032 | 10:05:11 INFO - PROCESS | 17032 | 1480442711038 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] 10:07:21 INFO - PROCESS | 17032 | Cycle 1(1): loaded http://localhost:33314/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33314/tests/dromaeo/cssquery-ext.html) 10:07:22 INFO - PROCESS | 17032 | RSS: Main: 237576192 10:07:22 INFO - PROCESS | 17032 | 10:10:24 INFO - PROCESS | 17032 | Cycle 1(1): loaded http://localhost:33314/tests/dromaeo/cssquery-ext.html (next: http://localhost:33314/tests/dromaeo/cssquery-jquery.html) 10:10:25 INFO - PROCESS | 17032 | RSS: Main: 228454400 10:10:25 INFO - PROCESS | 17032 | 10:13:27 INFO - PROCESS | 17032 | Cycle 1(1): loaded http://localhost:33314/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33314/tests/dromaeo/cssquery-mootools.html) 10:13:27 INFO - PROCESS | 17032 | RSS: Main: 208785408 10:13:27 INFO - PROCESS | 17032 | 10:16:29 INFO - PROCESS | 17032 | Cycle 1(1): loaded http://localhost:33314/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33314/tests/dromaeo/cssquery-prototype.html) 10:16:30 INFO - PROCESS | 17032 | RSS: Main: 219070464 10:16:30 INFO - PROCESS | 17032 | 10:19:33 INFO - PROCESS | 17032 | Cycle 1(1): loaded http://localhost:33314/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33314/tests/dromaeo/cssquery-yui.html) 10:19:33 INFO - PROCESS | 17032 | RSS: Main: 176041984 10:19:33 INFO - PROCESS | 17032 | 10:22:36 INFO - PROCESS | 17032 | Cycle 1(1): loaded http://localhost:33314/tests/dromaeo/cssquery-yui.html (next: http://localhost:33314/tests/dromaeo/cssquery-dojo.html) 10:22:36 INFO - PROCESS | 17032 | RSS: Main: 266711040 10:22:36 INFO - PROCESS | 17032 | 10:22:36 INFO - PROCESS | 17032 | __start_tp_report 10:22:36 INFO - PROCESS | 17032 | _x_x_mozilla_page_load 10:22:36 INFO - PROCESS | 17032 | _x_x_mozilla_page_load_details 10:22:36 INFO - PROCESS | 17032 | |i|pagename|runs| 10:22:36 INFO - PROCESS | 17032 | |0;dojo.html;3215.099772063822;3257.1857035741064;3264.379767844108;3274.1814546363407;3305.256317328601;5584.86037849054;5606.719664016803;5611.7474713637885;5624.606277560572;5632.746526406321;5625.353084395296;5691.231683722696;5699.287589051369;5708.828735137942;5720.570957178207;5125.564327032207;5145.022445735298;5169.896602067956;5172.198309262051;5213.348331458567;4934.555889969902;4953.306537084811;5233.73831308435;5239.030779305841;5262.8684282892855;5004.574611158056;5022.573081288095;5022.748862556876;5027.195648696209;5107.897842043157;5137.845864624067;5145.614078944094;5148.176291793295;5220;5221.765020574083;5056.924146137811;5125.00062487815;5161.5870730341485;5184;5202.97398513005;5431.83704488862;5452.6183167178315;5486.61593688442;5497;5517.034518959166;5928.229330187091;5961.493273071794;5999.190109335227;6024.066269728155;6036.3360030396625;6099.786507472261;6099.9085013724825;6111.54163437744;6116.847078823021;6118.785842495536;5423.538999185074;5487.917681234785;5519.503244707916;5555.8888822223325;5566.916496252559;6164.8767024659255;6166.753329866845;6171.043488259327;6197.690115494297;6228.22147231596;5889.204957330791;5899.852503687443;5913.542200825402;5927.73325200367;5951.285845698544;5851.180834683148;5899.439553242435;5904.409559044061;5922.674252916045;5988.341282458926;5942.494887934487;5942.524598032147;5964.940350596438;5969.820905372846;5976.103584462366;5905.76376944926;5940.970295148497;5967.6121052131475;5976.491998180203;5987.311459182162;4514.525974772667;4529.5243999380245;4551.226291530448;4614.792334344963;4616.215243408628;4056.2495938250927;4096.549379568245;4096.754194748325;4099.733517321364;4106.1582375612925;5670.404607516234;5673.375928647845;5675.744591493392;5691.288588926384;5718.228039214736;5851.063829787214;5891.234139561915;5953.940460595339;5968.492678122321;5984.910226346608;5644.238027866268;5691.630044047124;5692.430756924275;5699.658020518782;5768.307803063659;5185.22221666753;5219.660722053054;5221.738913054408;5222.321098257202;5226.947730522722;6217.720202590804;6243.843903902439;6246.3753624637175;6269.623822570569;6274.905876411766;5861.208736820475;5913.113033045078;5958.344582096052;5962.016267315845;5994.130851026664;6275.874482510416;6287.842803929939;6292.937070629235;6294.3076261612105;6316.368363163647;5920.348761636131;5922.674252916131;5924.940750592439;5941.257342832146;5970.5223582114195;5822.970885145547;5902.940970590411;5953.464188223081;5973.283206015306;6065.090236464565;5893.233879595625;5894.557908156819;5902.61632993854;5904.822855314347;5911.940880591139;5862.413758624103;5876;5898.793542226002;5899.351071382059;5917.467427931507;5656.88686226265;5710.685912274865;5778.364379918122;5791.82624521265;5839.182514448065;5875.41245875409;5943.108533719977;5943.197668314895;5973.313068997121;5973.402659733992;5741.942580574141;5779;5787.508061814793;5788.131780232999;5811.070228763547 10:22:36 INFO - PROCESS | 17032 | |1;ext.html;570.686122632552;606.9423404776546;619.1826788638996;657.2802780954855;660.6861740673178;34341.31317373651;34889.12777180572;37332.8800135996;45226.77386613062;45795.31307030389;45691.08617827641;46106.538934610646;46110.30834537485;46191.30713039307;46272.53727462724;8742.82514349711;8890.644374225023;8898.199162075412;8930.910690893106;8942.061083586228;8590.527520986343;8782.824343513126;8785.64857405703;10515.737106572358;10744.247902646817;10768.138548916068;10839.078678312353;10842.295250808711;10844.457777111153;10846.891531084706;10619.840702389432;10664.680059598224;10673.412962287071;10678.626248081358;10685.572577096907;10616.469176541143;10639.734006649818;10665.786684266272;10685.83971240432;10701.090407315387;43231.13537729228;43457.78271108656;43659.563404366185;43681.34477982833;43710.56289437097;3585.0678823505814;3622.6196249393697;3628.872989445383;3750.13746838226;3777.471154038437;32489.350212995843;32503;32774.50838237428;32791.344173116406;32955;4198.874033778991;4250.086231460251;4280;4320.675949303814;4330.545292744248;328809;329062;332006;334257;335631;59222;59391.703041484514;59654;59656.10515842266;59677.40322596805;38996;39654.60345396567;64683.353166468674;64867.675661622336;64869.35130648633;16152.111633860015;16533.33866645345;16536.586585335222;16561.50315490537;16595.50213493573;11295.435228238719;11324.773504530029;11340.773184536429;11344;11951.581694640647;18446;19492.87082887495;20714.896425517774;20770;20840.270590529257;7182.497225194291;7197.280271972761;7229.819254518679;7364.3003914628025;7375.262473752582;960.7694153403272;986.6891929042329;995.233670074039;995.5121990224883;1074.2211896375065;33581.832090839875;33620.831895840856;33627.66372336245;33676.15809604731;33821;1122.5911481091177;1139.2537887683582;1142.2118738070706;1195.1753290229713;1232.7534493101416;17629.854059486093;17651.82348176502;17660.646787064445;17795.19921603531;17839.375621853174;541972;545839;546324;546702.5329746731;548035.818746342;58281.70859145762;58985;58987.705061474415;59160.7041964796;59195;1261.9558315458914;1294.1070661243712;1366.1120271823395;1378.3659516622265;1392.4291040673274;29547.40905181927;31064.068077957698;31855;32100.678993209767;32309.192270193435;50650;51302.486975129774;51331.48668513267;51352.48647513477;51363.48636513737;393682;396409;397693;397757;680902;44521.55478445174;44596.55403445924;44625;44671.77664111659;45486;48053.51946480491;48620.513794861596;48962.26556601725;49175.262371065175;49202.26196606982;41507.37738933858;41541;42014;43156.78421607872;43652.34521482244;40838.1832363357;42092;42247.788761056;43329.350059748496;43503.78248108866;42602;43344.56655433405;43654.34518482162;43854.78072609616;44013.779931100136;34711.82644086763;37348.25303493861;37778.055548611504;37893.24213515769;38124;29009.41981160407;29071;29222.41555168842;29652.258693532833;29653 10:22:36 INFO - PROCESS | 17032 | |2;jquery.html;385.9980700096499;402.65774092021786;414.32258257748583;419.4107279272622;432.2867269006139;15101.697966040672;19079.427617171506;19092;19235.42293731187;19249.037548122575;18360.35738749144;18699.3455229067;19233.807661923376;19676.901615491937;19888.90055549724;4974.328465657144;5625.071863142576;5757.136429535562;5793;6449.6775161241985;6486;6557.901631475508;6572.769953051644;6579.276279609239;6579.967100164493;5545.417731138233;5783.103618939072;5788.0739081746715;5869.413058694117;6517.511186660996;5717.857053573653;5881.735321910524;5908.793192238251;5915.526757859361;5918.023526118207;5700.2589663343915;5731.283589551306;5733.971330143364;5742.712864356766;5742.913856292159;14221.14673119616;14344.497942572065;22078.88960555203;22581.322560323217;22923.541529169324;2554.2848002559313;2612.4644447888136;2639.1027050802627;2815.338395477061;2968.7773416993596;10176.847347289797;10210.948945255226;10505.212109091772;10516.263861529696;10776;1866.2908094923841;2000.6398848207316;2013.4463022668738;2039.3372154049994;2054.8356131509595;80393;80429.19570804275;82879.17120828835;83478.58260708718;84069.57965210135;11046.33721976684;11286.839684888244;11477.770444591062;11506.884931150582;11506.942465287788;16201.432949846934;16214.918925405298;16238.67522649564;16246.268917898722;16254.106024168785;7746.1339304457715;7763.883541746878;7939.801504962306;8280.668773249123;8336.916630833735;7549.50928189666;7565.848683026419;7566.394688425023;7737;7743.457957943003;4837.371141751621;4874.171390863562;4932.728699921467;4944.208926571731;5070.138076527;1953.45303315072;1998.4803950972562;2072.305777564533;2074.8132668059948;2075.304772901065;879.4811061473761;941.9105185007413;1016.217512515359;1021.1728499915092;1075.8063548561177;19667.508312292022;19842.70235946462;20024.299149529696;20247.291344803154;20497.077631506618;1009.1825621246667;1010.141379827141;1021.5862575656871;1027.2347101409348;1044.3472829481575;9747;11177.49701263445;11293;11467.827982580267;11475;476574;489557;490237;497497;499150;57178;58075.12887306694;87769;88283.55858220796;90803.54598226967;970.7961328121173;979.911807937289;1004.4977511244377;1005.3816902604991;1007.2546315726456;17291.654166916844;17628;17798.932064076198;17968.371107011193;18396.448106556825;40186;40335.39496907607;41339.379909301984;41800.79099604482;41827.37258941179;58035;58090;59543.40456595552;61495.385046148964;63143.368566315585;7618.276263754934;7734.071911370672;7897.328727058035;7955.2840244378285;8260.545669988209;12706.36468176606;12865.485380584672;12982.415791289226;13065.477380905038;13087.149335293176;10491.632792852213;11404.828927565926;11523.423828808358;11539.942300288445;12248.571300004458;11171.776564468502;11584.420778961186;11758.529658813552;11815.527378904748;12523.248605083723;12051.819222711842;12083.57707480234;12262.4481898313;12326.630201093982;12702.68243293888;8435.536045517556;8724.302055835646;8746.606402711766;8797.692080777142;8864.601092950703;11708.70728231801;12360;12391.75216495683;12546.12177147591;12573.63274825813 10:22:36 INFO - PROCESS | 17032 | |3;mootools.html;1188.1801556925723;1238.417943566524;1328.4420543371782;1387.9028468007243;1749.8075211726716;7601.391888648908;8293.875591866119;8544.27373673237;8563.400561960665;8777;8549.743507694764;8645.69740059098;8648.783780405493;8650.653973841054;8654.22112009919;2480.8139389545768;2506.1980166346775;2506.523760485502;2509.6862892138483;2513.5852584323566;2445.9143929962456;2534.1637259704344;2535.011345575227;2537.8857951392138;2539.4032402385424;2457.3856535866034;2463.1132792194794;2476.2447453526665;2482.143660437146;2495.3262619092834;2420.3102115896972;2423.418379588895;2448.192096608115;2466.3587467258462;2486.055298986392;2400.819938504602;2409.8795060246916;2434.42790944128;2435.3181109289426;2443.9389015274583;8310.293625041879;8353.707620233323;8490.363222758257;8519.48883067018;8589.656413743505;5379;5489.204065410493;5503.257060296849;5513.255710479074;5515.586331025149;3420.504026916108;3459.7924124552605;3509.385857474957;3528.4883691864793;3599.4420864766003;1155.8266260060975;1176.0532771119247;1182.213827804509;1205.5358686905518;1248.5692436109528;12006.51973921051;12119.212251203644;12163.331016794073;12179.817302740466;12185.207961482476;4456.487503937024;4652.116097941448;4699.036697477009;4718.363020992191;4722.645801564897;9512.952435237918;9514.952425237969;9519.762005949906;9524.523773811281;9527.333086684004;5380.219868119101;5384.78460861569;5386.811461598825;5387.973060134675;5389.541888939406;4348.478182618106;4499.482559505699;4637;5112.258722485293;5141.71720555373;3864.574896761354;3913.9608603914166;3986.820593073319;4013.9197216055513;4020.638142567183;1216.1851559455185;1234.740704452075;1245.40843099527;1251.4868903749418;1254.7427777305631;959.8656188133667;962.821877952581;989.2580564576567;998.32612986234;1000.4697510319543;5937.584369094122;6001.129836173817;6013.338532761392;6089;6268.247810262797;949.662869681267;986.7977064701719;988.1699372527112;1007.6322142417964;1044.8693913260843;4210.5157906840495;4248.893777655583;4277.615014648696;4279.957200427956;4390.692651514363;10411.427371494488;10639.361638301727;10692.946535267429;10723.410212438392;10802;10606.575736970435;10623.468826558641;10636.361818290927;10647.467626618638;10679.145668346513;7717.22827717235;7971.800704982305;8224.930759001292;8404.621792019374;8409.075001749803;5933.199018132669;6088.512918966383;6093.390660933871;6135.141080248858;6175.814725558241;9859.950700246452;9896.802063958536;9926.106650401498;9938.900610994087;10076.143527800219;8860.86708699357;9127.817443650956;9493.0981556752;9835.16401105914;10028.498575071071;7602.543847368955;7717.729879454192;7750.147483776667;7751.302382785577;7928.246816552418;8568.657253709782;8589.65641374363;8634.56827158652;8650.524221167896;8655.740327790176;7476.140243871807;7638.579878106535;7696.615169241403;7784.805379865548;7822.804429889071;7536.585487798005;7555.622218889143;7594.354479869052;7689.8462030757955;7724.150343462327;7014.579125252501;7119.611675723184;7126;7132.500724949204;7135.143782746104;5158.148905430562;5206.817761378334;5265.868353291198;5269.262303277621;5544.889102218014;5296.920546191733;5386.461353864583;5440.510354068153;5500.9174862377895;5651.915221271766 10:22:36 INFO - PROCESS | 17032 | |4;prototype.html;341.60373966199217;351.13445357194513;352.1934769378124;354.85382215444116;356.17723059732015;5262.684238945666;5413.215083812845;5435.8369248922545;5441.809536666217;5447.836564903049;5210.4008039075425;5300.151975683892;5308.787648494055;5314.654547454413;5328.364323038952;4227.513835908864;4230;4240.406343111967;4253.744775313491;4292.184484947866;4203.159368126387;4248.661671573444;4257.914841703164;4276.957230427703;4296.720713153651;4198.320671731301;4216.346466297713;4218.767967761772;4227.85202517912;4229.70392072555;4171.207470580595;4195.244855925932;4214.599613036757;4222.472190976128;4245.702800803945;3571.14292569784;3699.926001479955;3707.870224542128;3714.4799728038097;3777.8677746279022;5119.411267704188;5144.897102057976;5153.458886816868;5162.716050617215;5169.948300517022;4767.760382300592;4775.713457192544;4785.593224575915;4788.233882578771;4861.451140667297;5405;5531.419200983879;5561.972190139064;5572.888542229173;5619;4045.4740883685226;4061.2892743770017;4066.1867626474823;4067.1458993611377;4072.226277007359;5755.971220143872;5777.653340799608;5781.335146458169;5781.739821707991;5791.797287094932;3976.4035394691027;4132.8140233689555;4134.37984302357;4147.3986271991;4174.5616710245595;4185.476815398075;4211.347241177622;4213.91572168561;4224.197402493578;4231.4710661167355;4794.496577859344;4801.399825021872;4803.519648035169;4804.399450068741;4822.324874517571;5410.323709536308;5583.553315734732;5622.91565626516;5659.3208814941645;5685.668875760918;1324.6092402741215;1350.4395675794435;1359.1709057474932;1377.455904917552;1385.8544852790312;925.3060204846365;938.3525367496405;940.8024314893812;953.1612181280428;971.5960437168224;5213.843584692389;5222.686638801684;5245.632805703564;5277.604179686539;5291;5464.754086066137;5531.115021596525;5542.168674698827;5548.446434998207;5567.582431317667;5164.837911469965;5169.71566563835;5175.689458632494;5215.452377500384;5484.478974497496;2934.19309689837;2959.8816047357864;2961.0524632117945;2968.287610973394;2968.376640905391;5751.01589951466;5777.62445441045;5777.913331300034;5778.739956701958;5788.218590490314;5511.421300763443;5597.216389705444;5661.631993920382;5668.327843286241;5677.971610141923;5694.743736531866;5720.68536230503;5738.024535828836;5747.5114615257335;5794.304683438015;5307.469253074816;5510.685512084854;5545.556355491471;5569.303837020372;5613.550915926634;5450.828071964546;5454.318210223722;5471.905618876321;5504.614676972574;5516.91724624139;5703.885922281448;5718.51392631631;5731.223320770575;5762.884742305214;5770.307563092288;3919.7452165609143;3982.8008599569325;4018.794361691422;4019.6985226108745;4022.8994275143355;5505.504504594445;5533.529649979797;5541.340156724876;5563.800814531742;5568.387477377404;5487.807926722546;5548.583856210881;5644.435556444323;5652.63257888236;5664.150377443251;5636.605437619327;5652.406497317723;5662.716864156858;5665;5682.687452190004;5372.629979355395;5544.750486228048;5577.912307100077;5588.072115120277;5593.636413633101;5652.85867853307;5666.773329066791;5667.178259152317;5668.95124401987;5670.149477578231;5451.318585176853;5544.085225937675;5554.666719996813;5557.388687244481;5567 10:22:36 INFO - PROCESS | 17032 | |5;yui.html;751.222484728306;782.808211988063;832.8542505061614;856.1353033436228;876.1545108969844;14794.186319752424;15685.764713529306;15713.371465141408;15722.606934826621;15808;14598.489052883151;15053;15453.92273038636;15468.845311546882;16135.031898086123;727.9235680253577;742.3986570877579;812.9430939834214;831.193742070191;849.5200211880299;838.4885220015816;850.5619605902934;851.2041241439274;863.5854789700948;866.1814585216972;904.7511934218077;904.7602385367883;907.8683590879318;907.9319051071163;907.9500627465487;763.008089483669;765.3226894198674;901.4681338010572;902.6975963052386;903.2954295649371;632.5951391109647;637.7990932856136;638.1257676982564;655.3741177175785;656.8128083496181;15012.324445399874;15048.172350520717;15061;15070.849291507055;15084;13706.657333566642;14522.564323070219;14746.778798318033;14757.18835464049;14762.926185369111;13104.886084682814;13109.803352949713;13118.934405328007;13240.735185296337;13512.527061552799;4505.227689410852;4594.19601569724;4618.2610782275015;4697.154512187805;4700.2479603263655;61257.08114378288;62275.99999999955;63071.684641576496;63834;64288.67855660739;10679.412632305297;10681;10705.197110216764;10944.781104378028;11004.614838480775;20525.692114618294;20530;20538.973051347373;20542;20543.253823425177;7542.358899493494;7780.18308077655;7986.161453047463;8036.879446808302;8128.39037072222;4194.203101410722;4292.82828686849;4388.755179515185;4421.7789110544345;4645.744484053342;3522.084258092863;3620.0406892173596;3620.4388319810473;3624.1120925373452;3625.3655610268097;587.2629849538802;660.5706290910946;664.8304682305981;666.2704338749159;666.2737615998487;582.8601135727395;668.211510417702;675.7769935921233;697.8868704416448;703.1421665567999;8902.198802107841;8964.596593153325;9124.954375228213;9138;9458.148766611039;585.5374254339024;587.9970600146972;675.4630069095081;710.6695386645234;715.6171448275148;4444.422423275474;4660.766961651904;4713.29300604912;4775.808967641256;4806.668943770422;85160;86331;86900;92419.53790231005;92865.5356723212;69546.9567956481;80602.5969870147;81637.18362816414;83124;86751.56624216838;71063.6446817773;72292.27707722856;72649;73133.2686673137;73793.6310318445;9274.907250927674;9323.72028839136;9349.111834375723;9372.578233979624;9373.953130234306;47535.28697069616;48430.757846210545;48661.75669121632;50100.49899501104;51101;61247.38752612595;63939.36060639334;64956.35043649503;66838;66982;10976.945115274373;11062.115030797357;11271.323720576791;11481.425928703364;11977.101717371406;12667.93666031664;12838.614841554769;12841.293728845003;12842.550510732453;12952.222866628032;11402.315861048364;11529.423528823692;11701.473433695333;12184.451699673358;12247.816282755944;11360.204785664924;11413.315201087962;11508.48211830453;11759.529618815151;12107.47329894705;11063.944680276869;11155;11168.385738784445;11198.664040078811;11444.02725768319;9785.85321220168;10186.541605627617;10275.897241027495;10299.639512617023;10319.845202322122;9764.951175244363;9849.45827979468;10028;10149.746256343355;10201.642942496977 10:22:36 INFO - PROCESS | 17032 | __end_tp_report 10:22:36 INFO - PROCESS | 17032 | __start_cc_report 10:22:36 INFO - PROCESS | 17032 | _x_x_mozilla_cycle_collect,946 10:22:36 INFO - PROCESS | 17032 | __end_cc_report 10:22:36 INFO - PROCESS | 17032 | __startTimestamp1480443756449__endTimestamp 10:22:36 INFO - PROCESS | 17032 | 10:22:36 INFO - PROCESS | 17032 | ------- Summary: start ------- 10:22:36 INFO - PROCESS | 17032 | Number of tests: 6 10:22:36 INFO - PROCESS | 17032 | 10:22:36 INFO - PROCESS | 17032 | [#0] dojo.html Cycles:165 Average:5577.20 Median:5791.83 stddev:631.59 (10.9%) stddev-sans-first:605.73 10:22:36 INFO - PROCESS | 17032 | Values: 3215.1 3257.2 3264.4 3274.2 3305.3 5584.9 5606.7 5611.7 5624.6 5632.7 5625.4 5691.2 5699.3 5708.8 5720.6 5125.6 5145.0 5169.9 5172.2 5213.3 4934.6 4953.3 5233.7 5239.0 5262.9 5004.6 5022.6 5022.7 5027.2 5107.9 5137.8 5145.6 5148.2 5220.0 5221.8 5056.9 5125.0 5161.6 5184.0 5203.0 5431.8 5452.6 5486.6 5497.0 5517.0 5928.2 5961.5 5999.2 6024.1 6036.3 6099.8 6099.9 6111.5 6116.8 6118.8 5423.5 5487.9 5519.5 5555.9 5566.9 6164.9 6166.8 6171.0 6197.7 6228.2 5889.2 5899.9 5913.5 5927.7 5951.3 5851.2 5899.4 5904.4 5922.7 5988.3 5942.5 5942.5 5964.9 5969.8 5976.1 5905.8 5941.0 5967.6 5976.5 5987.3 4514.5 4529.5 4551.2 4614.8 4616.2 4056.2 4096.5 4096.8 4099.7 4106.2 5670.4 5673.4 5675.7 5691.3 5718.2 5851.1 5891.2 5953.9 5968.5 5984.9 5644.2 5691.6 5692.4 5699.7 5768.3 5185.2 5219.7 5221.7 5222.3 5226.9 6217.7 6243.8 6246.4 6269.6 6274.9 5861.2 5913.1 5958.3 5962.0 5994.1 6275.9 6287.8 6292.9 6294.3 6316.4 5920.3 5922.7 5924.9 5941.3 5970.5 5823.0 5902.9 5953.5 5973.3 6065.1 5893.2 5894.6 5902.6 5904.8 5911.9 5862.4 5876.0 5898.8 5899.4 5917.5 5656.9 5710.7 5778.4 5791.8 5839.2 5875.4 5943.1 5943.2 5973.3 5973.4 5741.9 5779.0 5787.5 5788.1 5811.1 10:22:36 INFO - PROCESS | 17032 | 10:22:36 INFO - PROCESS | 17032 | [#1] ext.html Cycles:180 Average:61279.59 Median:397725.00 stddev:121296.75 (30.5%) stddev-sans-first:121551.38 10:22:36 INFO - PROCESS | 17032 | Values: 570.7 606.9 619.2 657.3 660.7 34341.3 34889.1 37332.9 45226.8 45795.3 45691.1 46106.5 46110.3 46191.3 46272.5 8742.8 8890.6 8898.2 8930.9 8942.1 8590.5 8782.8 8785.6 10515.7 10744.2 10768.1 10839.1 10842.3 10844.5 10846.9 10619.8 10664.7 10673.4 10678.6 10685.6 10616.5 10639.7 10665.8 10685.8 10701.1 43231.1 43457.8 43659.6 43681.3 43710.6 3585.1 3622.6 3628.9 3750.1 3777.5 32489.4 32503.0 32774.5 32791.3 32955.0 4198.9 4250.1 4280.0 4320.7 4330.5 328809.0 329062.0 332006.0 334257.0 335631.0 59222.0 59391.7 59654.0 59656.1 59677.4 38996.0 39654.6 64683.4 64867.7 64869.4 16152.1 16533.3 16536.6 16561.5 16595.5 11295.4 11324.8 11340.8 11344.0 11951.6 18446.0 19492.9 20714.9 20770.0 20840.3 7182.5 7197.3 7229.8 7364.3 7375.3 960.8 986.7 995.2 995.5 1074.2 33581.8 33620.8 33627.7 33676.2 33821.0 1122.6 1139.3 1142.2 1195.2 1232.8 17629.9 17651.8 17660.6 17795.2 17839.4 541972.0 545839.0 546324.0 546702.5 548035.8 58281.7 58985.0 58987.7 59160.7 59195.0 1262.0 1294.1 1366.1 1378.4 1392.4 29547.4 31064.1 31855.0 32100.7 32309.2 50650.0 51302.5 51331.5 51352.5 51363.5 393682.0 396409.0 397693.0 397757.0 680902.0 44521.6 44596.6 44625.0 44671.8 45486.0 48053.5 48620.5 48962.3 49175.3 49202.3 41507.4 41541.0 42014.0 43156.8 43652.3 40838.2 42092.0 42247.8 43329.4 43503.8 42602.0 43344.6 43654.3 43854.8 44013.8 34711.8 37348.3 37778.1 37893.2 38124.0 29009.4 29071.0 29222.4 29652.3 29653.0 10:22:36 INFO - PROCESS | 17032 | 10:22:36 INFO - PROCESS | 17032 | [#2] jquery.html Cycles:180 Average:28666.68 Median:2583.37 stddev:80670.31 (3122.7%) stddev-sans-first:80868.66 10:22:36 INFO - PROCESS | 17032 | Values: 386.0 402.7 414.3 419.4 432.3 15101.7 19079.4 19092.0 19235.4 19249.0 18360.4 18699.3 19233.8 19676.9 19888.9 4974.3 5625.1 5757.1 5793.0 6449.7 6486.0 6557.9 6572.8 6579.3 6580.0 5545.4 5783.1 5788.1 5869.4 6517.5 5717.9 5881.7 5908.8 5915.5 5918.0 5700.3 5731.3 5734.0 5742.7 5742.9 14221.1 14344.5 22078.9 22581.3 22923.5 2554.3 2612.5 2639.1 2815.3 2968.8 10176.8 10210.9 10505.2 10516.3 10776.0 1866.3 2000.6 2013.4 2039.3 2054.8 80393.0 80429.2 82879.2 83478.6 84069.6 11046.3 11286.8 11477.8 11506.9 11506.9 16201.4 16214.9 16238.7 16246.3 16254.1 7746.1 7763.9 7939.8 8280.7 8336.9 7549.5 7565.8 7566.4 7737.0 7743.5 4837.4 4874.2 4932.7 4944.2 5070.1 1953.5 1998.5 2072.3 2074.8 2075.3 879.5 941.9 1016.2 1021.2 1075.8 19667.5 19842.7 20024.3 20247.3 20497.1 1009.2 1010.1 1021.6 1027.2 1044.3 9747.0 11177.5 11293.0 11467.8 11475.0 476574.0 489557.0 490237.0 497497.0 499150.0 57178.0 58075.1 87769.0 88283.6 90803.5 970.8 979.9 1004.5 1005.4 1007.3 17291.7 17628.0 17798.9 17968.4 18396.4 40186.0 40335.4 41339.4 41800.8 41827.4 58035.0 58090.0 59543.4 61495.4 63143.4 7618.3 7734.1 7897.3 7955.3 8260.5 12706.4 12865.5 12982.4 13065.5 13087.1 10491.6 11404.8 11523.4 11539.9 12248.6 11171.8 11584.4 11758.5 11815.5 12523.2 12051.8 12083.6 12262.4 12326.6 12702.7 8435.5 8724.3 8746.6 8797.7 8864.6 11708.7 12360.0 12391.8 12546.1 12573.6 10:22:36 INFO - PROCESS | 17032 | 10:22:36 INFO - PROCESS | 17032 | [#3] mootools.html Cycles:180 Average:5771.55 Median:5379.61 stddev:3157.62 (58.7%) stddev-sans-first:3147.68 10:22:36 INFO - PROCESS | 17032 | Values: 1188.2 1238.4 1328.4 1387.9 1749.8 7601.4 8293.9 8544.3 8563.4 8777.0 8549.7 8645.7 8648.8 8650.7 8654.2 2480.8 2506.2 2506.5 2509.7 2513.6 2445.9 2534.2 2535.0 2537.9 2539.4 2457.4 2463.1 2476.2 2482.1 2495.3 2420.3 2423.4 2448.2 2466.4 2486.1 2400.8 2409.9 2434.4 2435.3 2443.9 8310.3 8353.7 8490.4 8519.5 8589.7 5379.0 5489.2 5503.3 5513.3 5515.6 3420.5 3459.8 3509.4 3528.5 3599.4 1155.8 1176.1 1182.2 1205.5 1248.6 12006.5 12119.2 12163.3 12179.8 12185.2 4456.5 4652.1 4699.0 4718.4 4722.6 9513.0 9515.0 9519.8 9524.5 9527.3 5380.2 5384.8 5386.8 5388.0 5389.5 4348.5 4499.5 4637.0 5112.3 5141.7 3864.6 3914.0 3986.8 4013.9 4020.6 1216.2 1234.7 1245.4 1251.5 1254.7 959.9 962.8 989.3 998.3 1000.5 5937.6 6001.1 6013.3 6089.0 6268.2 949.7 986.8 988.2 1007.6 1044.9 4210.5 4248.9 4277.6 4280.0 4390.7 10411.4 10639.4 10692.9 10723.4 10802.0 10606.6 10623.5 10636.4 10647.5 10679.1 7717.2 7971.8 8224.9 8404.6 8409.1 5933.2 6088.5 6093.4 6135.1 6175.8 9860.0 9896.8 9926.1 9938.9 10076.1 8860.9 9127.8 9493.1 9835.2 10028.5 7602.5 7717.7 7750.1 7751.3 7928.2 8568.7 8589.7 8634.6 8650.5 8655.7 7476.1 7638.6 7696.6 7784.8 7822.8 7536.6 7555.6 7594.4 7689.8 7724.2 7014.6 7119.6 7126.0 7132.5 7135.1 5158.1 5206.8 5265.9 5269.3 5544.9 5296.9 5386.5 5440.5 5500.9 5651.9 10:22:36 INFO - PROCESS | 17032 | 10:22:36 INFO - PROCESS | 17032 | [#4] prototype.html Cycles:180 Average:4677.78 Median:5350.50 stddev:1356.17 (25.3%) stddev-sans-first:1320.34 10:22:36 INFO - PROCESS | 17032 | Values: 341.6 351.1 352.2 354.9 356.2 5262.7 5413.2 5435.8 5441.8 5447.8 5210.4 5300.2 5308.8 5314.7 5328.4 4227.5 4230.0 4240.4 4253.7 4292.2 4203.2 4248.7 4257.9 4277.0 4296.7 4198.3 4216.3 4218.8 4227.9 4229.7 4171.2 4195.2 4214.6 4222.5 4245.7 3571.1 3699.9 3707.9 3714.5 3777.9 5119.4 5144.9 5153.5 5162.7 5169.9 4767.8 4775.7 4785.6 4788.2 4861.5 5405.0 5531.4 5562.0 5572.9 5619.0 4045.5 4061.3 4066.2 4067.1 4072.2 5756.0 5777.7 5781.3 5781.7 5791.8 3976.4 4132.8 4134.4 4147.4 4174.6 4185.5 4211.3 4213.9 4224.2 4231.5 4794.5 4801.4 4803.5 4804.4 4822.3 5410.3 5583.6 5622.9 5659.3 5685.7 1324.6 1350.4 1359.2 1377.5 1385.9 925.3 938.4 940.8 953.2 971.6 5213.8 5222.7 5245.6 5277.6 5291.0 5464.8 5531.1 5542.2 5548.4 5567.6 5164.8 5169.7 5175.7 5215.5 5484.5 2934.2 2959.9 2961.1 2968.3 2968.4 5751.0 5777.6 5777.9 5778.7 5788.2 5511.4 5597.2 5661.6 5668.3 5678.0 5694.7 5720.7 5738.0 5747.5 5794.3 5307.5 5510.7 5545.6 5569.3 5613.6 5450.8 5454.3 5471.9 5504.6 5516.9 5703.9 5718.5 5731.2 5762.9 5770.3 3919.7 3982.8 4018.8 4019.7 4022.9 5505.5 5533.5 5541.3 5563.8 5568.4 5487.8 5548.6 5644.4 5652.6 5664.2 5636.6 5652.4 5662.7 5665.0 5682.7 5372.6 5544.8 5577.9 5588.1 5593.6 5652.9 5666.8 5667.2 5669.0 5670.1 5451.3 5544.1 5554.7 5557.4 5567.0 10:22:36 INFO - PROCESS | 17032 | 10:22:36 INFO - PROCESS | 17032 | [#5] yui.html Cycles:180 Average:18139.97 Median:50600.75 stddev:24345.31 (48.1%) stddev-sans-first:24378.59 10:22:36 INFO - PROCESS | 17032 | Values: 751.2 782.8 832.9 856.1 876.2 14794.2 15685.8 15713.4 15722.6 15808.0 14598.5 15053.0 15453.9 15468.8 16135.0 727.9 742.4 812.9 831.2 849.5 838.5 850.6 851.2 863.6 866.2 904.8 904.8 907.9 907.9 908.0 763.0 765.3 901.5 902.7 903.3 632.6 637.8 638.1 655.4 656.8 15012.3 15048.2 15061.0 15070.8 15084.0 13706.7 14522.6 14746.8 14757.2 14762.9 13104.9 13109.8 13118.9 13240.7 13512.5 4505.2 4594.2 4618.3 4697.2 4700.2 61257.1 62276.0 63071.7 63834.0 64288.7 10679.4 10681.0 10705.2 10944.8 11004.6 20525.7 20530.0 20539.0 20542.0 20543.3 7542.4 7780.2 7986.2 8036.9 8128.4 4194.2 4292.8 4388.8 4421.8 4645.7 3522.1 3620.0 3620.4 3624.1 3625.4 587.3 660.6 664.8 666.3 666.3 582.9 668.2 675.8 697.9 703.1 8902.2 8964.6 9125.0 9138.0 9458.1 585.5 588.0 675.5 710.7 715.6 4444.4 4660.8 4713.3 4775.8 4806.7 85160.0 86331.0 86900.0 92419.5 92865.5 69547.0 80602.6 81637.2 83124.0 86751.6 71063.6 72292.3 72649.0 73133.3 73793.6 9274.9 9323.7 9349.1 9372.6 9374.0 47535.3 48430.8 48661.8 50100.5 51101.0 61247.4 63939.4 64956.4 66838.0 66982.0 10976.9 11062.1 11271.3 11481.4 11977.1 12667.9 12838.6 12841.3 12842.6 12952.2 11402.3 11529.4 11701.5 12184.5 12247.8 11360.2 11413.3 11508.5 11759.5 12107.5 11063.9 11155.0 11168.4 11198.7 11444.0 9785.9 10186.5 10275.9 10299.6 10319.8 9765.0 9849.5 10028.0 10149.7 10201.6 10:22:36 INFO - PROCESS | 17032 | -------- Summary: end -------- 10:22:36 INFO - PROCESS | 17032 | 10:22:37 INFO - TEST-INFO | 17032: exit 0 10:22:37 INFO - TEST-OK | dromaeo_css | took 1115458ms 10:22:37 INFO - TEST-START | kraken 10:22:37 INFO - operating with platform_type : linux_ 10:22:37 INFO - Initialising browser for kraken test... 10:22:37 INFO - TEST-INFO | started process 17350 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5v63Wp/profile http://localhost:33314/getInfo.html) 10:22:41 INFO - PROCESS | 17350 | __metrics Screen width/height:1600/1200 10:22:41 INFO - PROCESS | 17350 | colorDepth:24 10:22:41 INFO - PROCESS | 17350 | Browser inner width/height: 1024/697 10:22:41 INFO - PROCESS | 17350 | __metrics 10:22:41 INFO - PROCESS | 17350 | 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" 10:22:41 INFO - PROCESS | 17350 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:22:42 INFO - PROCESS | 17350 | console.error: PushService: 10:22:42 INFO - PROCESS | 17350 | stateChangeProcessEnqueue: Error transitioning state 10:22:42 INFO - PROCESS | 17350 | UnknownError 10:22:42 INFO - TEST-INFO | 17350: exit 0 10:22:42 INFO - Browser initialized. 10:22:42 INFO - Running cycle 1/1 for kraken test... 10:22:42 INFO - TEST-INFO | started process 17440 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5v63Wp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:22:54 INFO - PROCESS | 17440 | RSS: Main: 145321984 10:22:54 INFO - PROCESS | 17440 | 10:22:57 INFO - PROCESS | 17440 | Cycle 1(1): loaded http://localhost:33314/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33314/tests/kraken/driver.html?testName=audio-beat-detection) 10:22:57 INFO - PROCESS | 17440 | RSS: Main: 186454016 10:22:57 INFO - PROCESS | 17440 | 10:23:00 INFO - PROCESS | 17440 | Cycle 1(1): loaded http://localhost:33314/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33314/tests/kraken/driver.html?testName=audio-dft) 10:23:01 INFO - PROCESS | 17440 | RSS: Main: 176046080 10:23:01 INFO - PROCESS | 17440 | 10:23:03 INFO - PROCESS | 17440 | Cycle 1(1): loaded http://localhost:33314/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33314/tests/kraken/driver.html?testName=audio-fft) 10:23:04 INFO - PROCESS | 17440 | RSS: Main: 267493376 10:23:04 INFO - PROCESS | 17440 | 10:23:06 INFO - PROCESS | 17440 | Cycle 1(1): loaded http://localhost:33314/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33314/tests/kraken/driver.html?testName=audio-oscillator) 10:23:07 INFO - PROCESS | 17440 | RSS: Main: 173465600 10:23:07 INFO - PROCESS | 17440 | 10:23:09 INFO - PROCESS | 17440 | Cycle 1(1): loaded http://localhost:33314/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33314/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:23:09 INFO - PROCESS | 17440 | RSS: Main: 176164864 10:23:09 INFO - PROCESS | 17440 | 10:23:12 INFO - PROCESS | 17440 | Cycle 1(1): loaded http://localhost:33314/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33314/tests/kraken/driver.html?testName=imaging-darkroom) 10:23:13 INFO - PROCESS | 17440 | RSS: Main: 214659072 10:23:13 INFO - PROCESS | 17440 | 10:23:16 INFO - PROCESS | 17440 | Cycle 1(1): loaded http://localhost:33314/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33314/tests/kraken/driver.html?testName=imaging-desaturate) 10:23:17 INFO - PROCESS | 17440 | RSS: Main: 213774336 10:23:17 INFO - PROCESS | 17440 | 10:23:20 INFO - PROCESS | 17440 | Cycle 1(1): loaded http://localhost:33314/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33314/tests/kraken/driver.html?testName=json-parse-financial) 10:23:20 INFO - PROCESS | 17440 | RSS: Main: 212516864 10:23:20 INFO - PROCESS | 17440 | 10:23:22 INFO - PROCESS | 17440 | Cycle 1(1): loaded http://localhost:33314/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33314/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:23:22 INFO - PROCESS | 17440 | RSS: Main: 174526464 10:23:22 INFO - PROCESS | 17440 | 10:23:24 INFO - PROCESS | 17440 | Cycle 1(1): loaded http://localhost:33314/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33314/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:23:25 INFO - PROCESS | 17440 | RSS: Main: 181932032 10:23:25 INFO - PROCESS | 17440 | 10:23:26 INFO - PROCESS | 17440 | Cycle 1(1): loaded http://localhost:33314/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33314/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:23:27 INFO - PROCESS | 17440 | RSS: Main: 191016960 10:23:27 INFO - PROCESS | 17440 | 10:23:30 INFO - PROCESS | 17440 | Cycle 1(1): loaded http://localhost:33314/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33314/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:23:30 INFO - PROCESS | 17440 | RSS: Main: 199819264 10:23:30 INFO - PROCESS | 17440 | 10:23:33 INFO - PROCESS | 17440 | Cycle 1(1): loaded http://localhost:33314/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33314/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:23:34 INFO - PROCESS | 17440 | RSS: Main: 195891200 10:23:34 INFO - PROCESS | 17440 | 10:23:35 INFO - PROCESS | 17440 | Cycle 1(1): loaded http://localhost:33314/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33314/tests/kraken/driver.html?testName=ai-astar) 10:23:35 INFO - PROCESS | 17440 | RSS: Main: 247029760 10:23:35 INFO - PROCESS | 17440 | 10:23:35 INFO - PROCESS | 17440 | __start_tp_report 10:23:35 INFO - PROCESS | 17440 | _x_x_mozilla_page_load 10:23:35 INFO - PROCESS | 17440 | _x_x_mozilla_page_load_details 10:23:35 INFO - PROCESS | 17440 | |i|pagename|runs| 10:23:35 INFO - PROCESS | 17440 | |0;ai-astar;100;110;111;110;109;112;110;109;113;110 10:23:35 INFO - PROCESS | 17440 | |1;audio-beat-detection;149;120;120;153;126;123;118;123;152;126 10:23:35 INFO - PROCESS | 17440 | |2;audio-dft;161;160;162;161;162;164;163;162;161;161 10:23:35 INFO - PROCESS | 17440 | |3;audio-fft;75;76;77;114;76;77;75;76;97;75 10:23:35 INFO - PROCESS | 17440 | |4;audio-oscillator;83;81;110;82;82;81;98;81;82;117 10:23:35 INFO - PROCESS | 17440 | |5;imaging-gaussian-blur;117;117;117;117;118;117;118;118;119;117 10:23:35 INFO - PROCESS | 17440 | |6;imaging-darkroom;148;146;145;146;146;146;146;147;145;146 10:23:35 INFO - PROCESS | 17440 | |7;imaging-desaturate;85;85;85;84;85;85;84;84;84;85 10:23:35 INFO - PROCESS | 17440 | |8;json-parse-financial;55;51;50;49;51;50;51;50;50;50 10:23:35 INFO - PROCESS | 17440 | |9;json-stringify-tinderbox;58;59;58;58;58;59;58;58;59;59 10:23:35 INFO - PROCESS | 17440 | |10;stanford-crypto-aes;75;75;75;76;76;75;75;76;75;74 10:23:35 INFO - PROCESS | 17440 | |11;stanford-crypto-ccm;127;134;126;140;126;126;124;130;167;127 10:23:36 INFO - PROCESS | 17440 | |12;stanford-crypto-pbkdf2;157;154;154;156;154;157;155;154;158;156 10:23:36 INFO - PROCESS | 17440 | |13;stanford-crypto-sha256-iterative;62;62;61;63;62;62;61;63;59;61 10:23:36 INFO - PROCESS | 17440 | __end_tp_report 10:23:36 INFO - PROCESS | 17440 | __start_cc_report 10:23:36 INFO - PROCESS | 17440 | _x_x_mozilla_cycle_collect,1624 10:23:36 INFO - PROCESS | 17440 | __end_cc_report 10:23:36 INFO - PROCESS | 17440 | __startTimestamp1480443815991__endTimestamp 10:23:36 INFO - PROCESS | 17440 | 10:23:36 INFO - PROCESS | 17440 | ------- Summary: start ------- 10:23:36 INFO - PROCESS | 17440 | Number of tests: 14 10:23:36 INFO - PROCESS | 17440 | 10:23:36 INFO - PROCESS | 17440 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:3.53 (3.2%) stddev-sans-first:1.33 10:23:36 INFO - PROCESS | 17440 | Values: 100.0 110.0 111.0 110.0 109.0 112.0 110.0 109.0 113.0 110.0 10:23:36 INFO - PROCESS | 17440 | 10:23:36 INFO - PROCESS | 17440 | [#1] audio-beat-detection Cycles:10 Average:131.00 Median:126.00 stddev:14.29 (11.3%) stddev-sans-first:13.59 10:23:36 INFO - PROCESS | 17440 | Values: 149.0 120.0 120.0 153.0 126.0 123.0 118.0 123.0 152.0 126.0 10:23:36 INFO - PROCESS | 17440 | 10:23:36 INFO - PROCESS | 17440 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.16 (0.7%) stddev-sans-first:1.20 10:23:36 INFO - PROCESS | 17440 | Values: 161.0 160.0 162.0 161.0 162.0 164.0 163.0 162.0 161.0 161.0 10:23:36 INFO - PROCESS | 17440 | 10:23:36 INFO - PROCESS | 17440 | [#3] audio-fft Cycles:10 Average:81.80 Median:76.00 stddev:13.14 (17.3%) stddev-sans-first:13.70 10:23:36 INFO - PROCESS | 17440 | Values: 75.0 76.0 77.0 114.0 76.0 77.0 75.0 76.0 97.0 75.0 10:23:36 INFO - PROCESS | 17440 | 10:23:36 INFO - PROCESS | 17440 | [#4] audio-oscillator Cycles:10 Average:89.70 Median:82.00 stddev:13.65 (16.6%) stddev-sans-first:14.26 10:23:36 INFO - PROCESS | 17440 | Values: 83.0 81.0 110.0 82.0 82.0 81.0 98.0 81.0 82.0 117.0 10:23:36 INFO - PROCESS | 17440 | 10:23:36 INFO - PROCESS | 17440 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 10:23:36 INFO - PROCESS | 17440 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 118.0 118.0 119.0 117.0 10:23:36 INFO - PROCESS | 17440 | 10:23:36 INFO - PROCESS | 17440 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.88 (0.6%) stddev-sans-first:0.60 10:23:36 INFO - PROCESS | 17440 | Values: 148.0 146.0 145.0 146.0 146.0 146.0 146.0 147.0 145.0 146.0 10:23:36 INFO - PROCESS | 17440 | 10:23:36 INFO - PROCESS | 17440 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:0.52 (0.6%) stddev-sans-first:0.53 10:23:36 INFO - PROCESS | 17440 | Values: 85.0 85.0 85.0 84.0 85.0 85.0 84.0 84.0 84.0 85.0 10:23:36 INFO - PROCESS | 17440 | 10:23:36 INFO - PROCESS | 17440 | [#8] json-parse-financial Cycles:10 Average:50.70 Median:50.50 stddev:1.64 (3.2%) stddev-sans-first:0.67 10:23:36 INFO - PROCESS | 17440 | Values: 55.0 51.0 50.0 49.0 51.0 50.0 51.0 50.0 50.0 50.0 10:23:36 INFO - PROCESS | 17440 | 10:23:36 INFO - PROCESS | 17440 | [#9] json-stringify-tinderbox Cycles:10 Average:58.40 Median:58.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 10:23:36 INFO - PROCESS | 17440 | Values: 58.0 59.0 58.0 58.0 58.0 59.0 58.0 58.0 59.0 59.0 10:23:36 INFO - PROCESS | 17440 | 10:23:36 INFO - PROCESS | 17440 | [#10] stanford-crypto-aes Cycles:10 Average:75.20 Median:75.00 stddev:0.63 (0.8%) stddev-sans-first:0.67 10:23:36 INFO - PROCESS | 17440 | Values: 75.0 75.0 75.0 76.0 76.0 75.0 75.0 76.0 75.0 74.0 10:23:36 INFO - PROCESS | 17440 | 10:23:36 INFO - PROCESS | 17440 | [#11] stanford-crypto-ccm Cycles:10 Average:132.70 Median:128.50 stddev:12.97 (10.1%) stddev-sans-first:13.59 10:23:36 INFO - PROCESS | 17440 | Values: 127.0 134.0 126.0 140.0 126.0 126.0 124.0 130.0 167.0 127.0 10:23:36 INFO - PROCESS | 17440 | 10:23:36 INFO - PROCESS | 17440 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.50 Median:156.00 stddev:1.51 (1.0%) stddev-sans-first:1.50 10:23:36 INFO - PROCESS | 17440 | Values: 157.0 154.0 154.0 156.0 154.0 157.0 155.0 154.0 158.0 156.0 10:23:36 INFO - PROCESS | 17440 | 10:23:36 INFO - PROCESS | 17440 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.60 Median:62.00 stddev:1.17 (1.9%) stddev-sans-first:1.24 10:23:36 INFO - PROCESS | 17440 | Values: 62.0 62.0 61.0 63.0 62.0 62.0 61.0 63.0 59.0 61.0 10:23:36 INFO - PROCESS | 17440 | -------- Summary: end -------- 10:23:36 INFO - PROCESS | 17440 | 10:23:37 INFO - TEST-INFO | 17440: exit 0 10:23:37 INFO - TEST-OK | kraken | took 59901ms 10:23:37 INFO - SUITE-END | took 1175s 10:23:37 INFO - Completed test suite (00:19:35) 10:23:37 INFO - javascript benchmark 10:23:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3215.099772063822, 3257.1857035741064, 3264.379767844108, 3274.1814546363407, 3305.256317328601, 5584.86037849054, 5606.719664016803, 5611.7474713637885, 5624.606277560572, 5632.746526406321, 5625.353084395296, 5691.231683722696, 5699.287589051369, 5708.828735137942, 5720.570957178207, 5125.564327032207, 5145.022445735298, 5169.896602067956, 5172.198309262051, 5213.348331458567, 4934.555889969902, 4953.306537084811, 5233.73831308435, 5239.030779305841, 5262.8684282892855, 5004.574611158056, 5022.573081288095, 5022.748862556876, 5027.195648696209, 5107.897842043157, 5137.845864624067, 5145.614078944094, 5148.176291793295, 5220.0, 5221.765020574083, 5056.924146137811, 5125.00062487815, 5161.5870730341485, 5184.0, 5202.97398513005, 5431.83704488862, 5452.6183167178315, 5486.61593688442, 5497.0, 5517.034518959166, 5928.229330187091, 5961.493273071794, 5999.190109335227, 6024.066269728155, 6036.3360030396625, 6099.786507472261, 6099.9085013724825, 6111.54163437744, 6116.847078823021, 6118.785842495536, 5423.538999185074, 5487.917681234785, 5519.503244707916, 5555.8888822223325, 5566.916496252559, 6164.8767024659255, 6166.753329866845, 6171.043488259327, 6197.690115494297, 6228.22147231596, 5889.204957330791, 5899.852503687443, 5913.542200825402, 5927.73325200367, 5951.285845698544, 5851.180834683148, 5899.439553242435, 5904.409559044061, 5922.674252916045, 5988.341282458926, 5942.494887934487, 5942.524598032147, 5964.940350596438, 5969.820905372846, 5976.103584462366, 5905.76376944926, 5940.970295148497, 5967.6121052131475, 5976.491998180203, 5987.311459182162, 4514.525974772667, 4529.5243999380245, 4551.226291530448, 4614.792334344963, 4616.215243408628, 4056.2495938250927, 4096.549379568245, 4096.754194748325, 4099.733517321364, 4106.1582375612925, 5670.404607516234, 5673.375928647845, 5675.744591493392, 5691.288588926384, 5718.228039214736, 5851.063829787214, 5891.234139561915, 5953.940460595339, 5968.492678122321, 5984.910226346608, 5644.238027866268, 5691.630044047124, 5692.430756924275, 5699.658020518782, 5768.307803063659, 5185.22221666753, 5219.660722053054, 5221.738913054408, 5222.321098257202, 5226.947730522722, 6217.720202590804, 6243.843903902439, 6246.3753624637175, 6269.623822570569, 6274.905876411766, 5861.208736820475, 5913.113033045078, 5958.344582096052, 5962.016267315845, 5994.130851026664, 6275.874482510416, 6287.842803929939, 6292.937070629235, 6294.3076261612105, 6316.368363163647, 5920.348761636131, 5922.674252916131, 5924.940750592439, 5941.257342832146, 5970.5223582114195, 5822.970885145547, 5902.940970590411, 5953.464188223081, 5973.283206015306, 6065.090236464565, 5893.233879595625, 5894.557908156819, 5902.61632993854, 5904.822855314347, 5911.940880591139, 5862.413758624103, 5876.0, 5898.793542226002, 5899.351071382059, 5917.467427931507, 5656.88686226265, 5710.685912274865, 5778.364379918122, 5791.82624521265, 5839.182514448065, 5875.41245875409, 5943.108533719977, 5943.197668314895, 5973.313068997121, 5973.402659733992, 5741.942580574141, 5779.0, 5787.508061814793, 5788.131780232999, 5811.070228763547], "value": 5534.671980969146, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.686122632552, 606.9423404776546, 619.1826788638996, 657.2802780954855, 660.6861740673178, 34341.31317373651, 34889.12777180572, 37332.8800135996, 45226.77386613062, 45795.31307030389, 45691.08617827641, 46106.538934610646, 46110.30834537485, 46191.30713039307, 46272.53727462724, 8742.82514349711, 8890.644374225023, 8898.199162075412, 8930.910690893106, 8942.061083586228, 8590.527520986343, 8782.824343513126, 8785.64857405703, 10515.737106572358, 10744.247902646817, 10768.138548916068, 10839.078678312353, 10842.295250808711, 10844.457777111153, 10846.891531084706, 10619.840702389432, 10664.680059598224, 10673.412962287071, 10678.626248081358, 10685.572577096907, 10616.469176541143, 10639.734006649818, 10665.786684266272, 10685.83971240432, 10701.090407315387, 43231.13537729228, 43457.78271108656, 43659.563404366185, 43681.34477982833, 43710.56289437097, 3585.0678823505814, 3622.6196249393697, 3628.872989445383, 3750.13746838226, 3777.471154038437, 32489.350212995843, 32503.0, 32774.50838237428, 32791.344173116406, 32955.0, 4198.874033778991, 4250.086231460251, 4280.0, 4320.675949303814, 4330.545292744248, 328809.0, 329062.0, 332006.0, 334257.0, 335631.0, 59222.0, 59391.703041484514, 59654.0, 59656.10515842266, 59677.40322596805, 38996.0, 39654.60345396567, 64683.353166468674, 64867.675661622336, 64869.35130648633, 16152.111633860015, 16533.33866645345, 16536.586585335222, 16561.50315490537, 16595.50213493573, 11295.435228238719, 11324.773504530029, 11340.773184536429, 11344.0, 11951.581694640647, 18446.0, 19492.87082887495, 20714.896425517774, 20770.0, 20840.270590529257, 7182.497225194291, 7197.280271972761, 7229.819254518679, 7364.3003914628025, 7375.262473752582, 960.7694153403272, 986.6891929042329, 995.233670074039, 995.5121990224883, 1074.2211896375065, 33581.832090839875, 33620.831895840856, 33627.66372336245, 33676.15809604731, 33821.0, 1122.5911481091177, 1139.2537887683582, 1142.2118738070706, 1195.1753290229713, 1232.7534493101416, 17629.854059486093, 17651.82348176502, 17660.646787064445, 17795.19921603531, 17839.375621853174, 541972.0, 545839.0, 546324.0, 546702.5329746731, 548035.818746342, 58281.70859145762, 58985.0, 58987.705061474415, 59160.7041964796, 59195.0, 1261.9558315458914, 1294.1070661243712, 1366.1120271823395, 1378.3659516622265, 1392.4291040673274, 29547.40905181927, 31064.068077957698, 31855.0, 32100.678993209767, 32309.192270193435, 50650.0, 51302.486975129774, 51331.48668513267, 51352.48647513477, 51363.48636513737, 393682.0, 396409.0, 397693.0, 397757.0, 680902.0, 44521.55478445174, 44596.55403445924, 44625.0, 44671.77664111659, 45486.0, 48053.51946480491, 48620.513794861596, 48962.26556601725, 49175.262371065175, 49202.26196606982, 41507.37738933858, 41541.0, 42014.0, 43156.78421607872, 43652.34521482244, 40838.1832363357, 42092.0, 42247.788761056, 43329.350059748496, 43503.78248108866, 42602.0, 43344.56655433405, 43654.34518482162, 43854.78072609616, 44013.779931100136, 34711.82644086763, 37348.25303493861, 37778.055548611504, 37893.24213515769, 38124.0, 29009.41981160407, 29071.0, 29222.41555168842, 29652.258693532833, 29653.0], "value": 20871.384408641294, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.9980700096499, 402.65774092021786, 414.32258257748583, 419.4107279272622, 432.2867269006139, 15101.697966040672, 19079.427617171506, 19092.0, 19235.42293731187, 19249.037548122575, 18360.35738749144, 18699.3455229067, 19233.807661923376, 19676.901615491937, 19888.90055549724, 4974.328465657144, 5625.071863142576, 5757.136429535562, 5793.0, 6449.6775161241985, 6486.0, 6557.901631475508, 6572.769953051644, 6579.276279609239, 6579.967100164493, 5545.417731138233, 5783.103618939072, 5788.0739081746715, 5869.413058694117, 6517.511186660996, 5717.857053573653, 5881.735321910524, 5908.793192238251, 5915.526757859361, 5918.023526118207, 5700.2589663343915, 5731.283589551306, 5733.971330143364, 5742.712864356766, 5742.913856292159, 14221.14673119616, 14344.497942572065, 22078.88960555203, 22581.322560323217, 22923.541529169324, 2554.2848002559313, 2612.4644447888136, 2639.1027050802627, 2815.338395477061, 2968.7773416993596, 10176.847347289797, 10210.948945255226, 10505.212109091772, 10516.263861529696, 10776.0, 1866.2908094923841, 2000.6398848207316, 2013.4463022668738, 2039.3372154049994, 2054.8356131509595, 80393.0, 80429.19570804275, 82879.17120828835, 83478.58260708718, 84069.57965210135, 11046.33721976684, 11286.839684888244, 11477.770444591062, 11506.884931150582, 11506.942465287788, 16201.432949846934, 16214.918925405298, 16238.67522649564, 16246.268917898722, 16254.106024168785, 7746.1339304457715, 7763.883541746878, 7939.801504962306, 8280.668773249123, 8336.916630833735, 7549.50928189666, 7565.848683026419, 7566.394688425023, 7737.0, 7743.457957943003, 4837.371141751621, 4874.171390863562, 4932.728699921467, 4944.208926571731, 5070.138076527, 1953.45303315072, 1998.4803950972562, 2072.305777564533, 2074.8132668059948, 2075.304772901065, 879.4811061473761, 941.9105185007413, 1016.217512515359, 1021.1728499915092, 1075.8063548561177, 19667.508312292022, 19842.70235946462, 20024.299149529696, 20247.291344803154, 20497.077631506618, 1009.1825621246667, 1010.141379827141, 1021.5862575656871, 1027.2347101409348, 1044.3472829481575, 9747.0, 11177.49701263445, 11293.0, 11467.827982580267, 11475.0, 476574.0, 489557.0, 490237.0, 497497.0, 499150.0, 57178.0, 58075.12887306694, 87769.0, 88283.55858220796, 90803.54598226967, 970.7961328121173, 979.911807937289, 1004.4977511244377, 1005.3816902604991, 1007.2546315726456, 17291.654166916844, 17628.0, 17798.932064076198, 17968.371107011193, 18396.448106556825, 40186.0, 40335.39496907607, 41339.379909301984, 41800.79099604482, 41827.37258941179, 58035.0, 58090.0, 59543.40456595552, 61495.385046148964, 63143.368566315585, 7618.276263754934, 7734.071911370672, 7897.328727058035, 7955.2840244378285, 8260.545669988209, 12706.36468176606, 12865.485380584672, 12982.415791289226, 13065.477380905038, 13087.149335293176, 10491.632792852213, 11404.828927565926, 11523.423828808358, 11539.942300288445, 12248.571300004458, 11171.776564468502, 11584.420778961186, 11758.529658813552, 11815.527378904748, 12523.248605083723, 12051.819222711842, 12083.57707480234, 12262.4481898313, 12326.630201093982, 12702.68243293888, 8435.536045517556, 8724.302055835646, 8746.606402711766, 8797.692080777142, 8864.601092950703, 11708.70728231801, 12360.0, 12391.75216495683, 12546.12177147591, 12573.63274825813], "value": 9297.800845473, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1188.1801556925723, 1238.417943566524, 1328.4420543371782, 1387.9028468007243, 1749.8075211726716, 7601.391888648908, 8293.875591866119, 8544.27373673237, 8563.400561960665, 8777.0, 8549.743507694764, 8645.69740059098, 8648.783780405493, 8650.653973841054, 8654.22112009919, 2480.8139389545768, 2506.1980166346775, 2506.523760485502, 2509.6862892138483, 2513.5852584323566, 2445.9143929962456, 2534.1637259704344, 2535.011345575227, 2537.8857951392138, 2539.4032402385424, 2457.3856535866034, 2463.1132792194794, 2476.2447453526665, 2482.143660437146, 2495.3262619092834, 2420.3102115896972, 2423.418379588895, 2448.192096608115, 2466.3587467258462, 2486.055298986392, 2400.819938504602, 2409.8795060246916, 2434.42790944128, 2435.3181109289426, 2443.9389015274583, 8310.293625041879, 8353.707620233323, 8490.363222758257, 8519.48883067018, 8589.656413743505, 5379.0, 5489.204065410493, 5503.257060296849, 5513.255710479074, 5515.586331025149, 3420.504026916108, 3459.7924124552605, 3509.385857474957, 3528.4883691864793, 3599.4420864766003, 1155.8266260060975, 1176.0532771119247, 1182.213827804509, 1205.5358686905518, 1248.5692436109528, 12006.51973921051, 12119.212251203644, 12163.331016794073, 12179.817302740466, 12185.207961482476, 4456.487503937024, 4652.116097941448, 4699.036697477009, 4718.363020992191, 4722.645801564897, 9512.952435237918, 9514.952425237969, 9519.762005949906, 9524.523773811281, 9527.333086684004, 5380.219868119101, 5384.78460861569, 5386.811461598825, 5387.973060134675, 5389.541888939406, 4348.478182618106, 4499.482559505699, 4637.0, 5112.258722485293, 5141.71720555373, 3864.574896761354, 3913.9608603914166, 3986.820593073319, 4013.9197216055513, 4020.638142567183, 1216.1851559455185, 1234.740704452075, 1245.40843099527, 1251.4868903749418, 1254.7427777305631, 959.8656188133667, 962.821877952581, 989.2580564576567, 998.32612986234, 1000.4697510319543, 5937.584369094122, 6001.129836173817, 6013.338532761392, 6089.0, 6268.247810262797, 949.662869681267, 986.7977064701719, 988.1699372527112, 1007.6322142417964, 1044.8693913260843, 4210.5157906840495, 4248.893777655583, 4277.615014648696, 4279.957200427956, 4390.692651514363, 10411.427371494488, 10639.361638301727, 10692.946535267429, 10723.410212438392, 10802.0, 10606.575736970435, 10623.468826558641, 10636.361818290927, 10647.467626618638, 10679.145668346513, 7717.22827717235, 7971.800704982305, 8224.930759001292, 8404.621792019374, 8409.075001749803, 5933.199018132669, 6088.512918966383, 6093.390660933871, 6135.141080248858, 6175.814725558241, 9859.950700246452, 9896.802063958536, 9926.106650401498, 9938.900610994087, 10076.143527800219, 8860.86708699357, 9127.817443650956, 9493.0981556752, 9835.16401105914, 10028.498575071071, 7602.543847368955, 7717.729879454192, 7750.147483776667, 7751.302382785577, 7928.246816552418, 8568.657253709782, 8589.65641374363, 8634.56827158652, 8650.524221167896, 8655.740327790176, 7476.140243871807, 7638.579878106535, 7696.615169241403, 7784.805379865548, 7822.804429889071, 7536.585487798005, 7555.622218889143, 7594.354479869052, 7689.8462030757955, 7724.150343462327, 7014.579125252501, 7119.611675723184, 7126.0, 7132.500724949204, 7135.143782746104, 5158.148905430562, 5206.817761378334, 5265.868353291198, 5269.262303277621, 5544.889102218014, 5296.920546191733, 5386.461353864583, 5440.510354068153, 5500.9174862377895, 5651.915221271766], "value": 4675.3734175445325, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.60373966199217, 351.13445357194513, 352.1934769378124, 354.85382215444116, 356.17723059732015, 5262.684238945666, 5413.215083812845, 5435.8369248922545, 5441.809536666217, 5447.836564903049, 5210.4008039075425, 5300.151975683892, 5308.787648494055, 5314.654547454413, 5328.364323038952, 4227.513835908864, 4230.0, 4240.406343111967, 4253.744775313491, 4292.184484947866, 4203.159368126387, 4248.661671573444, 4257.914841703164, 4276.957230427703, 4296.720713153651, 4198.320671731301, 4216.346466297713, 4218.767967761772, 4227.85202517912, 4229.70392072555, 4171.207470580595, 4195.244855925932, 4214.599613036757, 4222.472190976128, 4245.702800803945, 3571.14292569784, 3699.926001479955, 3707.870224542128, 3714.4799728038097, 3777.8677746279022, 5119.411267704188, 5144.897102057976, 5153.458886816868, 5162.716050617215, 5169.948300517022, 4767.760382300592, 4775.713457192544, 4785.593224575915, 4788.233882578771, 4861.451140667297, 5405.0, 5531.419200983879, 5561.972190139064, 5572.888542229173, 5619.0, 4045.4740883685226, 4061.2892743770017, 4066.1867626474823, 4067.1458993611377, 4072.226277007359, 5755.971220143872, 5777.653340799608, 5781.335146458169, 5781.739821707991, 5791.797287094932, 3976.4035394691027, 4132.8140233689555, 4134.37984302357, 4147.3986271991, 4174.5616710245595, 4185.476815398075, 4211.347241177622, 4213.91572168561, 4224.197402493578, 4231.4710661167355, 4794.496577859344, 4801.399825021872, 4803.519648035169, 4804.399450068741, 4822.324874517571, 5410.323709536308, 5583.553315734732, 5622.91565626516, 5659.3208814941645, 5685.668875760918, 1324.6092402741215, 1350.4395675794435, 1359.1709057474932, 1377.455904917552, 1385.8544852790312, 925.3060204846365, 938.3525367496405, 940.8024314893812, 953.1612181280428, 971.5960437168224, 5213.843584692389, 5222.686638801684, 5245.632805703564, 5277.604179686539, 5291.0, 5464.754086066137, 5531.115021596525, 5542.168674698827, 5548.446434998207, 5567.582431317667, 5164.837911469965, 5169.71566563835, 5175.689458632494, 5215.452377500384, 5484.478974497496, 2934.19309689837, 2959.8816047357864, 2961.0524632117945, 2968.287610973394, 2968.376640905391, 5751.01589951466, 5777.62445441045, 5777.913331300034, 5778.739956701958, 5788.218590490314, 5511.421300763443, 5597.216389705444, 5661.631993920382, 5668.327843286241, 5677.971610141923, 5694.743736531866, 5720.68536230503, 5738.024535828836, 5747.5114615257335, 5794.304683438015, 5307.469253074816, 5510.685512084854, 5545.556355491471, 5569.303837020372, 5613.550915926634, 5450.828071964546, 5454.318210223722, 5471.905618876321, 5504.614676972574, 5516.91724624139, 5703.885922281448, 5718.51392631631, 5731.223320770575, 5762.884742305214, 5770.307563092288, 3919.7452165609143, 3982.8008599569325, 4018.794361691422, 4019.6985226108745, 4022.8994275143355, 5505.504504594445, 5533.529649979797, 5541.340156724876, 5563.800814531742, 5568.387477377404, 5487.807926722546, 5548.583856210881, 5644.435556444323, 5652.63257888236, 5664.150377443251, 5636.605437619327, 5652.406497317723, 5662.716864156858, 5665.0, 5682.687452190004, 5372.629979355395, 5544.750486228048, 5577.912307100077, 5588.072115120277, 5593.636413633101, 5652.85867853307, 5666.773329066791, 5667.178259152317, 5668.95124401987, 5670.149477578231, 5451.318585176853, 5544.085225937675, 5554.666719996813, 5557.388687244481, 5567.0], "value": 4246.430507742152, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [751.222484728306, 782.808211988063, 832.8542505061614, 856.1353033436228, 876.1545108969844, 14794.186319752424, 15685.764713529306, 15713.371465141408, 15722.606934826621, 15808.0, 14598.489052883151, 15053.0, 15453.92273038636, 15468.845311546882, 16135.031898086123, 727.9235680253577, 742.3986570877579, 812.9430939834214, 831.193742070191, 849.5200211880299, 838.4885220015816, 850.5619605902934, 851.2041241439274, 863.5854789700948, 866.1814585216972, 904.7511934218077, 904.7602385367883, 907.8683590879318, 907.9319051071163, 907.9500627465487, 763.008089483669, 765.3226894198674, 901.4681338010572, 902.6975963052386, 903.2954295649371, 632.5951391109647, 637.7990932856136, 638.1257676982564, 655.3741177175785, 656.8128083496181, 15012.324445399874, 15048.172350520717, 15061.0, 15070.849291507055, 15084.0, 13706.657333566642, 14522.564323070219, 14746.778798318033, 14757.18835464049, 14762.926185369111, 13104.886084682814, 13109.803352949713, 13118.934405328007, 13240.735185296337, 13512.527061552799, 4505.227689410852, 4594.19601569724, 4618.2610782275015, 4697.154512187805, 4700.2479603263655, 61257.08114378288, 62275.99999999955, 63071.684641576496, 63834.0, 64288.67855660739, 10679.412632305297, 10681.0, 10705.197110216764, 10944.781104378028, 11004.614838480775, 20525.692114618294, 20530.0, 20538.973051347373, 20542.0, 20543.253823425177, 7542.358899493494, 7780.18308077655, 7986.161453047463, 8036.879446808302, 8128.39037072222, 4194.203101410722, 4292.82828686849, 4388.755179515185, 4421.7789110544345, 4645.744484053342, 3522.084258092863, 3620.0406892173596, 3620.4388319810473, 3624.1120925373452, 3625.3655610268097, 587.2629849538802, 660.5706290910946, 664.8304682305981, 666.2704338749159, 666.2737615998487, 582.8601135727395, 668.211510417702, 675.7769935921233, 697.8868704416448, 703.1421665567999, 8902.198802107841, 8964.596593153325, 9124.954375228213, 9138.0, 9458.148766611039, 585.5374254339024, 587.9970600146972, 675.4630069095081, 710.6695386645234, 715.6171448275148, 4444.422423275474, 4660.766961651904, 4713.29300604912, 4775.808967641256, 4806.668943770422, 85160.0, 86331.0, 86900.0, 92419.53790231005, 92865.5356723212, 69546.9567956481, 80602.5969870147, 81637.18362816414, 83124.0, 86751.56624216838, 71063.6446817773, 72292.27707722856, 72649.0, 73133.2686673137, 73793.6310318445, 9274.907250927674, 9323.72028839136, 9349.111834375723, 9372.578233979624, 9373.953130234306, 47535.28697069616, 48430.757846210545, 48661.75669121632, 50100.49899501104, 51101.0, 61247.38752612595, 63939.36060639334, 64956.35043649503, 66838.0, 66982.0, 10976.945115274373, 11062.115030797357, 11271.323720576791, 11481.425928703364, 11977.101717371406, 12667.93666031664, 12838.614841554769, 12841.293728845003, 12842.550510732453, 12952.222866628032, 11402.315861048364, 11529.423528823692, 11701.473433695333, 12184.451699673358, 12247.816282755944, 11360.204785664924, 11413.315201087962, 11508.48211830453, 11759.529618815151, 12107.47329894705, 11063.944680276869, 11155.0, 11168.385738784445, 11198.664040078811, 11444.02725768319, 9785.85321220168, 10186.541605627617, 10275.897241027495, 10299.639512617023, 10319.845202322122, 9764.951175244363, 9849.45827979468, 10028.0, 10149.746256343355, 10201.642942496977], "value": 7177.052663328878, "unit": "score"}], "name": "dromaeo_css", "value": 7313.7908125644535, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 110.0, 111.0, 110.0, 109.0, 112.0, 110.0, 109.0, 113.0, 110.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 120.0, 120.0, 153.0, 126.0, 123.0, 118.0, 123.0, 152.0, 126.0], "value": 131.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 161.0, 162.0, 164.0, 163.0, 162.0, 161.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 114.0, 76.0, 77.0, 75.0, 76.0, 97.0, 75.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 110.0, 82.0, 82.0, 81.0, 98.0, 81.0, 82.0, 117.0], "value": 89.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 119.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 147.0, 145.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 84.0, 85.0, 85.0, 84.0, 84.0, 84.0, 85.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 51.0, 50.0, 49.0, 51.0, 50.0, 51.0, 50.0, 50.0, 50.0], "value": 50.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 58.0, 58.0, 59.0, 58.0, 58.0, 59.0, 59.0], "value": 58.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 76.0, 76.0, 75.0, 75.0, 76.0, 75.0, 74.0], "value": 75.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 134.0, 126.0, 140.0, 126.0, 126.0, 124.0, 130.0, 167.0, 127.0], "value": 132.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 154.0, 154.0, 156.0, 154.0, 157.0, 155.0, 154.0, 158.0, 156.0], "value": 155.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 63.0, 62.0, 62.0, 61.0, 63.0, 59.0, 61.0], "value": 61.6, "unit": "score"}], "name": "kraken", "value": 1455.9, "alertThreshold": 2.0}]} 10:23:37 INFO - Return code: 0 10:23:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:23:37 INFO - # TBPL SUCCESS # 10:23:37 INFO - Running post-action listener: _resource_record_post_action 10:23:37 INFO - [mozharness: 2016-11-29 18:23:37.309775Z] Finished run-tests step (success) 10:23:37 INFO - Running post-run listener: _resource_record_post_run 10:23:37 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 347246592; Read time: 0; Write time: 241192 10:23:37 INFO - TinderboxPrint: CPU usage
13.0% 10:23:37 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 10:23:37 INFO - TinderboxPrint: I/O write bytes / time
347,246,592 / 241,192 10:23:37 INFO - TinderboxPrint: CPU idle
8,276.3 (87.0%) 10:23:37 INFO - TinderboxPrint: CPU user
1,192.9 (12.5%) 10:23:37 INFO - TinderboxPrint: Swap in / out
0 / 0 10:23:37 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107413504; Read time: 0; Write time: 94024 10:23:37 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 239362048; Read time: 0; Write time: 147168 10:23:37 INFO - Running post-run listener: _upload_blobber_files 10:23:37 INFO - Blob upload gear active. 10:23:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:23:37 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 10:23:37 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'] 10:23:37 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 10:23:38 INFO - (blobuploader) - INFO - Open directory for files ... 10:23:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:23:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:23:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:23:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:23:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:23:39 INFO - (blobuploader) - INFO - Done attempting. 10:23:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:23:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:23:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:23:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:23:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:23:40 INFO - (blobuploader) - INFO - Done attempting. 10:23:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:23:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:23:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:23:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:23:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:23:44 INFO - (blobuploader) - INFO - Done attempting. 10:23:44 INFO - (blobuploader) - INFO - Iteration through files over. 10:23:44 INFO - Return code: 0 10:23:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:23:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:23:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a9d08e94e8f519726b03342c3a65b9b3241cfa3280d8c9e748f6c2739b781efda2a45bf5bca6f5d88fa4b2027269dafcceb4794a753927e1bddf1b8339d3b1ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/654a8f85fbec00cbfa1e7ced36c61944e96f1625091a9c1d3e56835c446c4ae0fe8a00b5846e7105acc195c2ff3044b5e1db84e785c39caf7ef0648fc58c9a13", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c30fd3a6465db26fdb8bc09409f134963db59a5503abbd61c0931a8e3d64b4a20c12c58ccf737a465677238f7520b145e3251f15fb6a3d4529a7af638a6e64d"} 10:23:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:23:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:23:44 INFO - Contents: 10:23:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a9d08e94e8f519726b03342c3a65b9b3241cfa3280d8c9e748f6c2739b781efda2a45bf5bca6f5d88fa4b2027269dafcceb4794a753927e1bddf1b8339d3b1ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/654a8f85fbec00cbfa1e7ced36c61944e96f1625091a9c1d3e56835c446c4ae0fe8a00b5846e7105acc195c2ff3044b5e1db84e785c39caf7ef0648fc58c9a13", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c30fd3a6465db26fdb8bc09409f134963db59a5503abbd61c0931a8e3d64b4a20c12c58ccf737a465677238f7520b145e3251f15fb6a3d4529a7af638a6e64d"} 10:23:44 INFO - Running post-run listener: copy_logs_to_upload_dir 10:23:44 INFO - Copying logs to upload dir... 10:23:44 INFO - mkdir: /builds/slave/test/build/upload/logs 10:23:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.866086 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-11-29 10:23:44.288829) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 10:23:44.292075) ========= 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=c6927cf182745ad25b1d38b9000001fe-1480442586.66444-1358428423 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/a9d08e94e8f519726b03342c3a65b9b3241cfa3280d8c9e748f6c2739b781efda2a45bf5bca6f5d88fa4b2027269dafcceb4794a753927e1bddf1b8339d3b1ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/654a8f85fbec00cbfa1e7ced36c61944e96f1625091a9c1d3e56835c446c4ae0fe8a00b5846e7105acc195c2ff3044b5e1db84e785c39caf7ef0648fc58c9a13", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c30fd3a6465db26fdb8bc09409f134963db59a5503abbd61c0931a8e3d64b4a20c12c58ccf737a465677238f7520b145e3251f15fb6a3d4529a7af638a6e64d"} build_url:https://queue.taskcluster.net/v1/task/aCu0sArmTKmVBp6JbRHe5Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011462 build_url: 'https://queue.taskcluster.net/v1/task/aCu0sArmTKmVBp6JbRHe5Q/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/a9d08e94e8f519726b03342c3a65b9b3241cfa3280d8c9e748f6c2739b781efda2a45bf5bca6f5d88fa4b2027269dafcceb4794a753927e1bddf1b8339d3b1ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/654a8f85fbec00cbfa1e7ced36c61944e96f1625091a9c1d3e56835c446c4ae0fe8a00b5846e7105acc195c2ff3044b5e1db84e785c39caf7ef0648fc58c9a13", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c30fd3a6465db26fdb8bc09409f134963db59a5503abbd61c0931a8e3d64b4a20c12c58ccf737a465677238f7520b145e3251f15fb6a3d4529a7af638a6e64d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 10:23:44.318022) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 10:23:44.318403) ========= 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=c6927cf182745ad25b1d38b9000001fe-1480442586.66444-1358428423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004453 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 10:23:44.403050) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 10:23:44.403403) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 10:23:44.403764) ========= ========= Total master_lag: 0.18 =========