builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-069 starttime: 1476486100.43 results: success (0) buildid: 20161014144235 builduid: cb463a0add744897a27dd56f40f95750 revision: de5d73a0568d1c3d50da32169026cc68ee09b1ae ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 16:01:40.431161) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 16:01:40.431638) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 16:01:40.431933) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 16:01:40.446815) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 16:01:40.447181) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1476486101.151107-1782428227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-14 16:01:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.1M=0s 2016-10-14 16:01:41 (43.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.103144 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 16:01:40.564073) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 16:01:40.564385) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1476486101.151107-1782428227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017656 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 16:01:40.613727) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 16:01:40.614123) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev de5d73a0568d1c3d50da32169026cc68ee09b1ae --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev de5d73a0568d1c3d50da32169026cc68ee09b1ae --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=05b19d94dfa9f3ce7b6e62cc000001f7-1476486101.151107-1782428227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-14 16:01:42,075 truncating revision to first 12 chars 2016-10-14 16:01:42,075 Setting DEBUG logging. 2016-10-14 16:01:42,075 attempt 1/10 2016-10-14 16:01:42,075 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/de5d73a0568d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-14 16:01:42,382 unpacking tar archive at: mozilla-central-de5d73a0568d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.623150 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 16:01:41.250688) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 16:01:41.251007) ========= script_repo_revision: de5d73a0568d1c3d50da32169026cc68ee09b1ae ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 16:01:41.251401) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 16:01:41.251695) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 16:01:41.262424) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-14 16:01:41.262828) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=05b19d94dfa9f3ce7b6e62cc000001f7-1476486101.151107-1782428227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:01:42 INFO - MultiFileLogger online at 20161014 16:01:42 in /builds/slave/test 16:01:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 16:01:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:01:42 INFO - {'append_to_log': False, 16:01:42 INFO - 'base_work_dir': '/builds/slave/test', 16:01:42 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:01:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:01:42 INFO - 'branch': 'Firefox-Non-PGO', 16:01:42 INFO - 'buildbot_json_path': 'buildprops.json', 16:01:42 INFO - 'config_files': ('talos/linux_config.py',), 16:01:42 INFO - 'default_actions': ('clobber', 16:01:42 INFO - 'read-buildbot-config', 16:01:42 INFO - 'download-and-extract', 16:01:42 INFO - 'populate-webroot', 16:01:42 INFO - 'create-virtualenv', 16:01:42 INFO - 'install', 16:01:42 INFO - 'run-tests'), 16:01:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:01:42 INFO - 'download_minidump_stackwalk': True, 16:01:42 INFO - 'download_symbols': 'ondemand', 16:01:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:01:42 INFO - 'tooltool.py': '/tools/tooltool.py', 16:01:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:01:42 INFO - '/tools/misc-python/virtualenv.py')}, 16:01:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:01:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:01:42 INFO - 'installer_path': 'installer.exe', 16:01:42 INFO - 'log_level': 'info', 16:01:42 INFO - 'log_name': 'talos', 16:01:42 INFO - 'log_to_console': True, 16:01:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:01:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:01:42 INFO - 'opt_config_files': (), 16:01:42 INFO - 'pip_index': False, 16:01:42 INFO - 'sps_profile': False, 16:01:42 INFO - 'sps_profile_interval': 0, 16:01:42 INFO - 'suite': 'dromaeojs', 16:01:42 INFO - 'system_bits': '32', 16:01:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:01:42 INFO - 'title': 'talos-linux64-ix-069', 16:01:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:01:42 INFO - 'use_talos_json': True, 16:01:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:01:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:01:42 INFO - 'work_dir': 'build'} 16:01:42 INFO - [mozharness: 2016-10-14 23:01:42.823210Z] Running clobber step. 16:01:42 INFO - Running pre-action listener: _resource_record_pre_action 16:01:42 INFO - Running main action method: clobber 16:01:42 INFO - rmtree: /builds/slave/test/build 16:01:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:01:43 INFO - Running post-action listener: _resource_record_post_action 16:01:43 INFO - [mozharness: 2016-10-14 23:01:43.344563Z] Finished clobber step (success) 16:01:43 INFO - [mozharness: 2016-10-14 23:01:43.344663Z] Running read-buildbot-config step. 16:01:43 INFO - Running pre-action listener: _resource_record_pre_action 16:01:43 INFO - Running main action method: read_buildbot_config 16:01:43 INFO - Using buildbot properties: 16:01:43 INFO - { 16:01:43 INFO - "project": "", 16:01:43 INFO - "product": "firefox", 16:01:43 INFO - "script_repo_revision": "production", 16:01:43 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 16:01:43 INFO - "repository": "", 16:01:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 16:01:43 INFO - "buildid": "20161014144235", 16:01:43 INFO - "pgo_build": "False", 16:01:43 INFO - "basedir": "/builds/slave/test", 16:01:43 INFO - "buildnumber": 679, 16:01:43 INFO - "slavename": "talos-linux64-ix-069", 16:01:43 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:01:43 INFO - "platform": "ubuntu64_hw", 16:01:43 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 16:01:43 INFO - "branch": "mozilla-central", 16:01:43 INFO - "repo_path": "mozilla-central", 16:01:43 INFO - "revision": "de5d73a0568d1c3d50da32169026cc68ee09b1ae", 16:01:43 INFO - "stage_platform": "linux64", 16:01:43 INFO - "builduid": "cb463a0add744897a27dd56f40f95750", 16:01:43 INFO - "slavebuilddir": "test" 16:01:43 INFO - } 16:01:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/D80shwmXQ8OuQYfozRYGkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 16:01:43 INFO - Running post-action listener: _resource_record_post_action 16:01:43 INFO - [mozharness: 2016-10-14 23:01:43.347101Z] Finished read-buildbot-config step (success) 16:01:43 INFO - [mozharness: 2016-10-14 23:01:43.347190Z] Running download-and-extract step. 16:01:43 INFO - Running pre-action listener: _resource_record_pre_action 16:01:43 INFO - Running main action method: download_and_extract 16:01:43 INFO - mkdir: /builds/slave/test/build/tests 16:01:43 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')]} 16:01:43 INFO - trying https://queue.taskcluster.net/v1/task/D80shwmXQ8OuQYfozRYGkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:01:43 INFO - Downloading https://queue.taskcluster.net/v1/task/D80shwmXQ8OuQYfozRYGkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:01:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D80shwmXQ8OuQYfozRYGkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:01:43 INFO - Downloaded 1361 bytes. 16:01:43 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:01:43 INFO - Using the following test package requirements: 16:01:43 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 16:01:43 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:01:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:01:43 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:01:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:01:43 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:01:43 INFO - u'jsshell-linux-x86_64.zip'], 16:01:43 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:01:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:01:43 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 16:01:43 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:01:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:01:43 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:01:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:01:43 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:01:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:01:43 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:01:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:01:43 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:01:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D80shwmXQ8OuQYfozRYGkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 16:01:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D80shwmXQ8OuQYfozRYGkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:01:43 INFO - Fetch https://queue.taskcluster.net/v1/task/D80shwmXQ8OuQYfozRYGkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:01:44 INFO - Http code: 200 16:01:44 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 16:01:44 INFO - x-amz-cf-id: 0gA9m0uIAWHj_8EAqHJjnKzT0sxWcMQIwuJeTCn3XuLf9IPZhd70tQ== 16:01:44 INFO - x-amz-version-id: 8j6D_8c17x29yX6GO.JaAseoc0JPdoqg 16:01:44 INFO - Expected file size: 20553650 16:01:44 INFO - Obtained file size: 20553650 16:01:48 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:01:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D80shwmXQ8OuQYfozRYGkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 16:01:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D80shwmXQ8OuQYfozRYGkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:01:48 INFO - Fetch https://queue.taskcluster.net/v1/task/D80shwmXQ8OuQYfozRYGkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:01:49 INFO - Http code: 200 16:01:49 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 16:01:49 INFO - x-amz-cf-id: bPLLLgjH51zJIvZKpdZjeqPH1AsDrRW9FviJuUezX5SHO93iXlZjgA== 16:01:49 INFO - x-amz-version-id: 8j6D_8c17x29yX6GO.JaAseoc0JPdoqg 16:01:49 INFO - Expected file size: 20553650 16:01:49 INFO - Obtained file size: 20553650 16:01:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D80shwmXQ8OuQYfozRYGkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 16:01:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D80shwmXQ8OuQYfozRYGkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:01:54 INFO - Fetch https://queue.taskcluster.net/v1/task/D80shwmXQ8OuQYfozRYGkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 16:01:54 INFO - Http code: 200 16:01:54 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 16:01:54 INFO - x-amz-cf-id: 6Jwvf5YzwTqwLNtQXX--2rnPz5D5Dv-Ji9UgqIU-DG_KV-ccfHaIuA== 16:01:54 INFO - x-amz-version-id: CeeQBSSllCCKmCCfs7Dx9a9aSvs_.iBa 16:01:54 INFO - Expected file size: 14409028 16:01:54 INFO - Obtained file size: 14409028 16:01:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:55 INFO - trying https://queue.taskcluster.net/v1/task/D80shwmXQ8OuQYfozRYGkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:01:55 INFO - Downloading https://queue.taskcluster.net/v1/task/D80shwmXQ8OuQYfozRYGkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:01:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D80shwmXQ8OuQYfozRYGkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:01:56 INFO - Downloaded 55681488 bytes. 16:01:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D80shwmXQ8OuQYfozRYGkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:01:56 INFO - mkdir: /builds/slave/test/properties 16:01:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:01:56 INFO - Writing to file /builds/slave/test/properties/build_url 16:01:56 INFO - Contents: 16:01:56 INFO - build_url:https://queue.taskcluster.net/v1/task/D80shwmXQ8OuQYfozRYGkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:01:57 INFO - Running post-action listener: _resource_record_post_action 16:01:57 INFO - Running post-action listener: set_extra_try_arguments 16:01:57 INFO - [mozharness: 2016-10-14 23:01:57.449541Z] Finished download-and-extract step (success) 16:01:57 INFO - [mozharness: 2016-10-14 23:01:57.449767Z] Running populate-webroot step. 16:01:57 INFO - Running pre-action listener: _resource_record_pre_action 16:01:57 INFO - Running main action method: populate_webroot 16:01:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:01:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:01:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:01:57 INFO - '--tppagecycles', 16:01:57 INFO - '7'], 16:01:57 INFO - 'tests': ['tsvgm']}}, 16:01:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:01:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:01:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:01:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:01:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:01:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:01:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:57 INFO - 'talos_options': ['--disable-e10s'], 16:01:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:01:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:01:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:57 INFO - 'talos_options': ['--disable-e10s'], 16:01:57 INFO - 'tests': ['damp', 'tps']}, 16:01:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:57 INFO - 'tests': ['damp', 'tps']}, 16:01:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:01:57 INFO - 'tests': ['dromaeo_dom']}, 16:01:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:01:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:01:57 INFO - 'tests': ['basic_compositor_video']}, 16:01:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:01:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:01:57 INFO - 'tests': ['a11yr', 16:01:57 INFO - 'ts_paint', 16:01:57 INFO - 'tpaint', 16:01:57 INFO - 'sessionrestore', 16:01:57 INFO - 'sessionrestore_no_auto_restore', 16:01:57 INFO - 'tabpaint']}, 16:01:57 INFO - 'other-e10s': {'tests': ['a11yr', 16:01:57 INFO - 'ts_paint', 16:01:57 INFO - 'tpaint', 16:01:57 INFO - 'sessionrestore', 16:01:57 INFO - 'sessionrestore_no_auto_restore', 16:01:57 INFO - 'tabpaint']}, 16:01:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:01:57 INFO - 'ts_paint', 16:01:57 INFO - 'tpaint', 16:01:57 INFO - 'sessionrestore', 16:01:57 INFO - 'sessionrestore_no_auto_restore', 16:01:57 INFO - 'tabpaint']}, 16:01:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:01:57 INFO - 'ts_paint', 16:01:57 INFO - 'tpaint', 16:01:57 INFO - 'sessionrestore', 16:01:57 INFO - 'sessionrestore_no_auto_restore', 16:01:57 INFO - 'tabpaint']}, 16:01:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:01:57 INFO - 'tests': ['a11yr', 16:01:57 INFO - 'ts_paint', 16:01:57 INFO - 'tpaint', 16:01:57 INFO - 'sessionrestore', 16:01:57 INFO - 'sessionrestore_no_auto_restore', 16:01:57 INFO - 'tabpaint']}, 16:01:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:01:57 INFO - 'tests': ['a11yr', 16:01:57 INFO - 'ts_paint', 16:01:57 INFO - 'tpaint', 16:01:57 INFO - 'sessionrestore', 16:01:57 INFO - 'sessionrestore_no_auto_restore', 16:01:57 INFO - 'tabpaint']}, 16:01:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:01:57 INFO - 'tests': ['tsvgx', 16:01:57 INFO - 'tsvgr_opacity', 16:01:57 INFO - 'tart', 16:01:57 INFO - 'tscrollx', 16:01:57 INFO - 'cart']}, 16:01:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:01:57 INFO - 'tsvgr_opacity', 16:01:57 INFO - 'tart', 16:01:57 INFO - 'tscrollx', 16:01:57 INFO - 'cart']}, 16:01:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:57 INFO - 'talos_options': ['--disable-e10s'], 16:01:57 INFO - 'tests': ['tp5o']}, 16:01:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:57 INFO - 'tests': ['tp5o']}, 16:01:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:57 INFO - 'talos_options': ['--disable-e10s', 16:01:57 INFO - '--xperf_path', 16:01:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:01:57 INFO - 'tests': ['tp5n']}, 16:01:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:57 INFO - 'talos_options': ['--xperf_path', 16:01:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:01:57 INFO - 'tests': ['tp5n']}}, 16:01:57 INFO - 'talos.zip': {'path': '', 16:01:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:01:57 INFO - Running post-action listener: _resource_record_post_action 16:01:57 INFO - [mozharness: 2016-10-14 23:01:57.468916Z] Finished populate-webroot step (success) 16:01:57 INFO - [mozharness: 2016-10-14 23:01:57.469004Z] Running create-virtualenv step. 16:01:57 INFO - Running pre-action listener: _resource_record_pre_action 16:01:57 INFO - Running main action method: create_virtualenv 16:01:57 INFO - Creating virtualenv /builds/slave/test/build/venv 16:01:57 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 16:01:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:01:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:01:57 INFO - Using real prefix '/usr' 16:01:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:01:58 INFO - Installing distribute.............................................................................................................................................................................................done. 16:02:00 INFO - Installing pip.................done. 16:02:00 INFO - Return code: 0 16:02:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:02:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:02:00 INFO - Reading from file tmpfile_stdout 16:02:00 INFO - Output received: 16:02:00 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) 16:02:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:02:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff22dc51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f3f60>, '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 0x25f4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f51d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1476486101.151107-1782428227', '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 16:02:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:02:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:02:00 INFO - Using env: {'DISPLAY': ':0', 16:02:00 INFO - 'HOME': '/home/cltbld', 16:02:00 INFO - 'LANG': 'en_US.UTF-8', 16:02:00 INFO - 'LANGUAGE': 'en_US:en', 16:02:00 INFO - 'LOGNAME': 'cltbld', 16:02:00 INFO - 'MAIL': '/var/mail/cltbld', 16:02:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:00 INFO - 'MOZ_NO_REMOTE': '1', 16:02:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:00 INFO - 'NO_EM_RESTART': '1', 16:02:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:00 INFO - 'PWD': '/builds/slave/test', 16:02:00 INFO - 'SHELL': '/bin/bash', 16:02:00 INFO - 'SHLVL': '1', 16:02:00 INFO - 'TERM': 'linux', 16:02:00 INFO - 'TMOUT': '86400', 16:02:00 INFO - 'USER': 'cltbld', 16:02:00 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1476486101.151107-1782428227', 16:02:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:00 INFO - '_': '/tools/buildbot/bin/python'} 16:02:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:00 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 16:02:00 INFO - Cleaning up... 16:02:00 INFO - Return code: 0 16:02:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:02:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff22dc51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f3f60>, '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 0x25f4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f51d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1476486101.151107-1782428227', '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 16:02:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:02:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:02:00 INFO - Using env: {'DISPLAY': ':0', 16:02:00 INFO - 'HOME': '/home/cltbld', 16:02:00 INFO - 'LANG': 'en_US.UTF-8', 16:02:00 INFO - 'LANGUAGE': 'en_US:en', 16:02:00 INFO - 'LOGNAME': 'cltbld', 16:02:00 INFO - 'MAIL': '/var/mail/cltbld', 16:02:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:00 INFO - 'MOZ_NO_REMOTE': '1', 16:02:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:00 INFO - 'NO_EM_RESTART': '1', 16:02:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:00 INFO - 'PWD': '/builds/slave/test', 16:02:00 INFO - 'SHELL': '/bin/bash', 16:02:00 INFO - 'SHLVL': '1', 16:02:00 INFO - 'TERM': 'linux', 16:02:00 INFO - 'TMOUT': '86400', 16:02:00 INFO - 'USER': 'cltbld', 16:02:00 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1476486101.151107-1782428227', 16:02:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:00 INFO - '_': '/tools/buildbot/bin/python'} 16:02:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:00 INFO - Downloading/unpacking psutil>=3.1.1 16:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:02:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:02:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:02:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:02:02 INFO - Installing collected packages: psutil 16:02:02 INFO - Running setup.py install for psutil 16:02:02 INFO - building 'psutil._psutil_linux' extension 16:02:02 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 16:02:02 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 16:02:02 INFO - building 'psutil._psutil_posix' extension 16:02:02 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 16:02:03 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 16:02:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:02:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:02:03 INFO - Successfully installed psutil 16:02:03 INFO - Cleaning up... 16:02:03 INFO - Return code: 0 16:02:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff22dc51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f3f60>, '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 0x25f4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f51d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1476486101.151107-1782428227', '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 16:02:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:02:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:02:03 INFO - Using env: {'DISPLAY': ':0', 16:02:03 INFO - 'HOME': '/home/cltbld', 16:02:03 INFO - 'LANG': 'en_US.UTF-8', 16:02:03 INFO - 'LANGUAGE': 'en_US:en', 16:02:03 INFO - 'LOGNAME': 'cltbld', 16:02:03 INFO - 'MAIL': '/var/mail/cltbld', 16:02:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:03 INFO - 'MOZ_NO_REMOTE': '1', 16:02:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:03 INFO - 'NO_EM_RESTART': '1', 16:02:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:03 INFO - 'PWD': '/builds/slave/test', 16:02:03 INFO - 'SHELL': '/bin/bash', 16:02:03 INFO - 'SHLVL': '1', 16:02:03 INFO - 'TERM': 'linux', 16:02:03 INFO - 'TMOUT': '86400', 16:02:03 INFO - 'USER': 'cltbld', 16:02:03 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1476486101.151107-1782428227', 16:02:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:03 INFO - '_': '/tools/buildbot/bin/python'} 16:02:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:02:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:02:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:02:05 INFO - Installing collected packages: mozsystemmonitor 16:02:05 INFO - Running setup.py install for mozsystemmonitor 16:02:05 INFO - Successfully installed mozsystemmonitor 16:02:05 INFO - Cleaning up... 16:02:05 INFO - Return code: 0 16:02:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff22dc51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f3f60>, '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 0x25f4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f51d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1476486101.151107-1782428227', '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 16:02:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:02:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:02:05 INFO - Using env: {'DISPLAY': ':0', 16:02:05 INFO - 'HOME': '/home/cltbld', 16:02:05 INFO - 'LANG': 'en_US.UTF-8', 16:02:05 INFO - 'LANGUAGE': 'en_US:en', 16:02:05 INFO - 'LOGNAME': 'cltbld', 16:02:05 INFO - 'MAIL': '/var/mail/cltbld', 16:02:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:05 INFO - 'MOZ_NO_REMOTE': '1', 16:02:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:05 INFO - 'NO_EM_RESTART': '1', 16:02:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:05 INFO - 'PWD': '/builds/slave/test', 16:02:05 INFO - 'SHELL': '/bin/bash', 16:02:05 INFO - 'SHLVL': '1', 16:02:05 INFO - 'TERM': 'linux', 16:02:05 INFO - 'TMOUT': '86400', 16:02:05 INFO - 'USER': 'cltbld', 16:02:05 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1476486101.151107-1782428227', 16:02:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:05 INFO - '_': '/tools/buildbot/bin/python'} 16:02:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:05 INFO - Downloading/unpacking jsonschema==2.5.1 16:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:02:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:02:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:02:07 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 16:02:07 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 16:02:07 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 16:02:07 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 16:02:07 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 16:02:07 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 16:02:07 INFO - Downloading functools32-3.2.3-2.tar.gz 16:02:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:02:08 INFO - warning: no files found matching '*.txt' 16:02:08 INFO - no previously-included directories found matching 'build' 16:02:08 INFO - no previously-included directories found matching 'dist' 16:02:08 INFO - no previously-included directories found matching '.git*' 16:02:08 INFO - Installing collected packages: jsonschema, functools32 16:02:08 INFO - Running setup.py install for functools32 16:02:08 INFO - warning: no files found matching '*.txt' 16:02:08 INFO - no previously-included directories found matching 'build' 16:02:08 INFO - no previously-included directories found matching 'dist' 16:02:08 INFO - no previously-included directories found matching '.git*' 16:02:08 INFO - Successfully installed jsonschema functools32 16:02:08 INFO - Cleaning up... 16:02:08 INFO - Return code: 0 16:02:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:02: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')]} 16:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02: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')]} 16:02:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:08 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 0x7ff22dc51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f3f60>, '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 0x25f4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f51d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1476486101.151107-1782428227', '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 16:02:08 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 16:02:08 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 16:02:08 INFO - Using env: {'DISPLAY': ':0', 16:02:08 INFO - 'HOME': '/home/cltbld', 16:02:08 INFO - 'LANG': 'en_US.UTF-8', 16:02:08 INFO - 'LANGUAGE': 'en_US:en', 16:02:08 INFO - 'LOGNAME': 'cltbld', 16:02:08 INFO - 'MAIL': '/var/mail/cltbld', 16:02:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:08 INFO - 'MOZ_NO_REMOTE': '1', 16:02:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:08 INFO - 'NO_EM_RESTART': '1', 16:02:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:08 INFO - 'PWD': '/builds/slave/test', 16:02:08 INFO - 'SHELL': '/bin/bash', 16:02:08 INFO - 'SHLVL': '1', 16:02:08 INFO - 'TERM': 'linux', 16:02:08 INFO - 'TMOUT': '86400', 16:02:08 INFO - 'USER': 'cltbld', 16:02:08 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1476486101.151107-1782428227', 16:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:08 INFO - '_': '/tools/buildbot/bin/python'} 16:02:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:02:08 INFO - Cleaning up... 16:02:08 INFO - Return code: 0 16:02:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:02: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')]} 16:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02: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')]} 16:02:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:08 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 0x7ff22dc51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f3f60>, '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 0x25f4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f51d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1476486101.151107-1782428227', '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 16:02:08 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 16:02:08 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 16:02:08 INFO - Using env: {'DISPLAY': ':0', 16:02:08 INFO - 'HOME': '/home/cltbld', 16:02:08 INFO - 'LANG': 'en_US.UTF-8', 16:02:08 INFO - 'LANGUAGE': 'en_US:en', 16:02:08 INFO - 'LOGNAME': 'cltbld', 16:02:08 INFO - 'MAIL': '/var/mail/cltbld', 16:02:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:08 INFO - 'MOZ_NO_REMOTE': '1', 16:02:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:08 INFO - 'NO_EM_RESTART': '1', 16:02:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:08 INFO - 'PWD': '/builds/slave/test', 16:02:08 INFO - 'SHELL': '/bin/bash', 16:02:08 INFO - 'SHLVL': '1', 16:02:08 INFO - 'TERM': 'linux', 16:02:08 INFO - 'TMOUT': '86400', 16:02:08 INFO - 'USER': 'cltbld', 16:02:08 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1476486101.151107-1782428227', 16:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:08 INFO - '_': '/tools/buildbot/bin/python'} 16:02:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:08 INFO - Downloading/unpacking blobuploader==1.2.4 16:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:02:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:10 INFO - Downloading blobuploader-1.2.4.tar.gz 16:02:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:02:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:02:10 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 16:02:10 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 16:02:10 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 16:02:10 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 16:02:10 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 16:02:10 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 16:02:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:02:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:02:11 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 16:02:11 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 16:02:11 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 16:02:11 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 16:02:11 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 16:02:11 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 16:02:11 INFO - Downloading docopt-0.6.1.tar.gz 16:02:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:02:11 INFO - Installing collected packages: blobuploader, requests, docopt 16:02:11 INFO - Running setup.py install for blobuploader 16:02:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:02:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:02:11 INFO - Running setup.py install for requests 16:02:11 INFO - Running setup.py install for docopt 16:02:11 INFO - Successfully installed blobuploader requests docopt 16:02:11 INFO - Cleaning up... 16:02:12 INFO - Return code: 0 16:02:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:02:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:12 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 0x7ff22dc51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f3f60>, '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 0x25f4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f51d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1476486101.151107-1782428227', '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 16:02:12 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 16:02:12 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 16:02:12 INFO - Using env: {'DISPLAY': ':0', 16:02:12 INFO - 'HOME': '/home/cltbld', 16:02:12 INFO - 'LANG': 'en_US.UTF-8', 16:02:12 INFO - 'LANGUAGE': 'en_US:en', 16:02:12 INFO - 'LOGNAME': 'cltbld', 16:02:12 INFO - 'MAIL': '/var/mail/cltbld', 16:02:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:12 INFO - 'MOZ_NO_REMOTE': '1', 16:02:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:12 INFO - 'NO_EM_RESTART': '1', 16:02:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:12 INFO - 'PWD': '/builds/slave/test', 16:02:12 INFO - 'SHELL': '/bin/bash', 16:02:12 INFO - 'SHLVL': '1', 16:02:12 INFO - 'TERM': 'linux', 16:02:12 INFO - 'TMOUT': '86400', 16:02:12 INFO - 'USER': 'cltbld', 16:02:12 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1476486101.151107-1782428227', 16:02:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:12 INFO - '_': '/tools/buildbot/bin/python'} 16:02:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:02:12 INFO - Running setup.py (path:/tmp/pip-IMwkzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:02:12 INFO - Running setup.py (path:/tmp/pip-nwrqSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:02:12 INFO - Running setup.py (path:/tmp/pip-cdhN7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:02:12 INFO - Running setup.py (path:/tmp/pip-PuZv3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:02:12 INFO - Running setup.py (path:/tmp/pip-tKlMnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:02:12 INFO - Running setup.py (path:/tmp/pip-AH3C4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:02:12 INFO - Running setup.py (path:/tmp/pip-B7mGI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:02:12 INFO - Running setup.py (path:/tmp/pip-2MhTMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:02:12 INFO - Running setup.py (path:/tmp/pip-MLlTSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:02:12 INFO - Running setup.py (path:/tmp/pip-RN8Gm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:02:12 INFO - Running setup.py (path:/tmp/pip-fwQ1gC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:02:13 INFO - Running setup.py (path:/tmp/pip-N1jWX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:02:13 INFO - Running setup.py (path:/tmp/pip-yVT22F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:02:13 INFO - Running setup.py (path:/tmp/pip-mGBBpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:02:13 INFO - Running setup.py (path:/tmp/pip-dEy1ZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:02:13 INFO - Running setup.py (path:/tmp/pip-FGBDSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:02:13 INFO - Running setup.py (path:/tmp/pip-2ujyI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:02:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:02:13 INFO - Running setup.py install for manifestparser 16:02:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:02:13 INFO - Running setup.py install for mozcrash 16:02:13 INFO - Running setup.py install for mozdebug 16:02:13 INFO - Running setup.py install for mozdevice 16:02:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:02:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:02:13 INFO - Running setup.py install for mozfile 16:02:14 INFO - Running setup.py install for mozhttpd 16:02:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:02:14 INFO - Running setup.py install for mozinfo 16:02:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:02:14 INFO - Running setup.py install for mozInstall 16:02:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:02:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:02:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:02:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:02:14 INFO - Running setup.py install for mozleak 16:02:14 INFO - Running setup.py install for mozlog 16:02:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:02:14 INFO - Running setup.py install for moznetwork 16:02:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:02:14 INFO - Running setup.py install for mozprocess 16:02:14 INFO - Running setup.py install for mozprofile 16:02:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:02:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:02:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:02:14 INFO - Running setup.py install for mozrunner 16:02:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:02:14 INFO - Running setup.py install for mozscreenshot 16:02:15 INFO - Running setup.py install for moztest 16:02:15 INFO - Running setup.py install for mozversion 16:02:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:02:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:02:15 INFO - Cleaning up... 16:02:15 INFO - Return code: 0 16:02:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:02:15 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')]} 16:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:15 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')]} 16:02:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:15 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 0x7ff22dc51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f3f60>, '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 0x25f4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f51d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1476486101.151107-1782428227', '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 16:02:15 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 16:02:15 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 16:02:15 INFO - Using env: {'DISPLAY': ':0', 16:02:15 INFO - 'HOME': '/home/cltbld', 16:02:15 INFO - 'LANG': 'en_US.UTF-8', 16:02:15 INFO - 'LANGUAGE': 'en_US:en', 16:02:15 INFO - 'LOGNAME': 'cltbld', 16:02:15 INFO - 'MAIL': '/var/mail/cltbld', 16:02:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:15 INFO - 'MOZ_NO_REMOTE': '1', 16:02:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:15 INFO - 'NO_EM_RESTART': '1', 16:02:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:15 INFO - 'PWD': '/builds/slave/test', 16:02:15 INFO - 'SHELL': '/bin/bash', 16:02:15 INFO - 'SHLVL': '1', 16:02:15 INFO - 'TERM': 'linux', 16:02:15 INFO - 'TMOUT': '86400', 16:02:15 INFO - 'USER': 'cltbld', 16:02:15 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1476486101.151107-1782428227', 16:02:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:15 INFO - '_': '/tools/buildbot/bin/python'} 16:02:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:02:15 INFO - Running setup.py (path:/tmp/pip-0Bk_Qo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:02:15 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)) 16:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:02:15 INFO - Running setup.py (path:/tmp/pip-FWNhkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:02:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:02:15 INFO - Running setup.py (path:/tmp/pip-wLJq6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:02:15 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)) 16:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:02:15 INFO - Running setup.py (path:/tmp/pip-JJ346m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:02:15 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)) 16:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:02:15 INFO - Running setup.py (path:/tmp/pip-P4nJdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:02:15 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)) 16:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:02:15 INFO - Running setup.py (path:/tmp/pip-kDcKfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:02:15 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)) 16:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:02:15 INFO - Running setup.py (path:/tmp/pip-gz406G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:02:16 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)) 16:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:02:16 INFO - Running setup.py (path:/tmp/pip-dPqQbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:02:16 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)) 16:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:02:16 INFO - Running setup.py (path:/tmp/pip-dcEOBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:02:16 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)) 16:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:02:16 INFO - Running setup.py (path:/tmp/pip-E1oeHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:02:16 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)) 16:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:02:16 INFO - Running setup.py (path:/tmp/pip-gKCK7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:02:16 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)) 16:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:02:16 INFO - Running setup.py (path:/tmp/pip-u3bl7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:02:16 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)) 16:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:02:16 INFO - Running setup.py (path:/tmp/pip-f76vEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:02:16 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)) 16:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:02:16 INFO - Running setup.py (path:/tmp/pip-68rvZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:02:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:02:16 INFO - Running setup.py (path:/tmp/pip-zuBMTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:02:16 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)) 16:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:02:16 INFO - Running setup.py (path:/tmp/pip-115Spd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:02:16 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)) 16:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:02:16 INFO - Running setup.py (path:/tmp/pip-q8Vtyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:02:16 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)) 16:02:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:02:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:02:16 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)) 16:02:16 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)) 16:02:16 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)) 16:02:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:02:16 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 16:02:16 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 16:02:16 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 16:02:16 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 16:02:16 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 16:02:16 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 16:02:18 INFO - Downloading blessings-1.6.tar.gz 16:02:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:02:18 INFO - Installing collected packages: blessings 16:02:18 INFO - Running setup.py install for blessings 16:02:18 INFO - Successfully installed blessings 16:02:18 INFO - Cleaning up... 16:02:18 INFO - Return code: 0 16:02:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:02:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:02:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:02:19 INFO - Reading from file tmpfile_stdout 16:02:19 INFO - Current package versions: 16:02:19 INFO - argparse == 1.2.1 16:02:19 INFO - blessings == 1.6 16:02:19 INFO - blobuploader == 1.2.4 16:02:19 INFO - docopt == 0.6.1 16:02:19 INFO - functools32 == 3.2.3-2 16:02:19 INFO - jsonschema == 2.5.1 16:02:19 INFO - manifestparser == 1.1 16:02:19 INFO - mozInstall == 1.12 16:02:19 INFO - mozcrash == 0.17 16:02:19 INFO - mozdebug == 0.1 16:02:19 INFO - mozdevice == 0.48 16:02:19 INFO - mozfile == 1.2 16:02:19 INFO - mozhttpd == 0.7 16:02:19 INFO - mozinfo == 0.9 16:02:19 INFO - mozleak == 0.1 16:02:19 INFO - mozlog == 3.4 16:02:19 INFO - moznetwork == 0.27 16:02:19 INFO - mozprocess == 0.23 16:02:19 INFO - mozprofile == 0.28 16:02:19 INFO - mozrunner == 6.12 16:02:19 INFO - mozscreenshot == 0.1 16:02:19 INFO - mozsystemmonitor == 0.3 16:02:19 INFO - moztest == 0.7 16:02:19 INFO - mozversion == 1.4 16:02:19 INFO - psutil == 3.1.1 16:02:19 INFO - requests == 1.2.3 16:02:19 INFO - wsgiref == 0.1.2 16:02:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:02: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')]} 16:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02: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')]} 16:02:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:19 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 0x7ff22dc51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f3f60>, '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 0x25f4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f51d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1476486101.151107-1782428227', '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 16:02:19 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 16:02:19 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 16:02:19 INFO - Using env: {'DISPLAY': ':0', 16:02:19 INFO - 'HOME': '/home/cltbld', 16:02:19 INFO - 'LANG': 'en_US.UTF-8', 16:02:19 INFO - 'LANGUAGE': 'en_US:en', 16:02:19 INFO - 'LOGNAME': 'cltbld', 16:02:19 INFO - 'MAIL': '/var/mail/cltbld', 16:02:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:19 INFO - 'MOZ_NO_REMOTE': '1', 16:02:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:19 INFO - 'NO_EM_RESTART': '1', 16:02:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:19 INFO - 'PWD': '/builds/slave/test', 16:02:19 INFO - 'SHELL': '/bin/bash', 16:02:19 INFO - 'SHLVL': '1', 16:02:19 INFO - 'TERM': 'linux', 16:02:19 INFO - 'TMOUT': '86400', 16:02:19 INFO - 'USER': 'cltbld', 16:02:19 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1476486101.151107-1782428227', 16:02:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:19 INFO - '_': '/tools/buildbot/bin/python'} 16:02:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:19 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)) 16:02:19 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)) 16:02:19 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)) 16:02:19 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)) 16:02:19 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)) 16:02:19 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)) 16:02:19 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)) 16:02:19 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)) 16:02:19 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)) 16:02:19 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)) 16:02:19 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)) 16:02:19 INFO - Cleaning up... 16:02:19 INFO - Return code: 0 16:02:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:02: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')]} 16:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02: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')]} 16:02:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff22dc51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f3f60>, '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 0x25f4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f51d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1476486101.151107-1782428227', '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 16:02:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:02:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:02:19 INFO - Using env: {'DISPLAY': ':0', 16:02:19 INFO - 'HOME': '/home/cltbld', 16:02:19 INFO - 'LANG': 'en_US.UTF-8', 16:02:19 INFO - 'LANGUAGE': 'en_US:en', 16:02:19 INFO - 'LOGNAME': 'cltbld', 16:02:19 INFO - 'MAIL': '/var/mail/cltbld', 16:02:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:19 INFO - 'MOZ_NO_REMOTE': '1', 16:02:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:19 INFO - 'NO_EM_RESTART': '1', 16:02:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:19 INFO - 'PWD': '/builds/slave/test', 16:02:19 INFO - 'SHELL': '/bin/bash', 16:02:19 INFO - 'SHLVL': '1', 16:02:19 INFO - 'TERM': 'linux', 16:02:19 INFO - 'TMOUT': '86400', 16:02:19 INFO - 'USER': 'cltbld', 16:02:19 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1476486101.151107-1782428227', 16:02:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:19 INFO - '_': '/tools/buildbot/bin/python'} 16:02:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:02:19 INFO - Cleaning up... 16:02:19 INFO - Return code: 0 16:02:19 INFO - Running post-action listener: _resource_record_post_action 16:02:19 INFO - Running post-action listener: _start_resource_monitoring 16:02:19 INFO - Starting resource monitoring. 16:02:19 INFO - [mozharness: 2016-10-14 23:02:19.664378Z] Finished create-virtualenv step (success) 16:02:19 INFO - [mozharness: 2016-10-14 23:02:19.664832Z] Running install step. 16:02:19 INFO - Running pre-action listener: _resource_record_pre_action 16:02:19 INFO - Running main action method: install 16:02:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:02:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:02:19 INFO - Reading from file tmpfile_stdout 16:02:19 INFO - Detecting whether we're running mozinstall >=1.0... 16:02:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:02:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:02:19 INFO - Reading from file tmpfile_stdout 16:02:19 INFO - Output received: 16:02:19 INFO - Usage: mozinstall [options] installer 16:02:19 INFO - Options: 16:02:19 INFO - -h, --help show this help message and exit 16:02:19 INFO - -d DEST, --destination=DEST 16:02:19 INFO - Directory to install application into. [default: 16:02:19 INFO - "/builds/slave/test"] 16:02:19 INFO - --app=APP Application being installed. [default: firefox] 16:02:19 INFO - mkdir: /builds/slave/test/build/application 16:02:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:02:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:02:36 INFO - Reading from file tmpfile_stdout 16:02:36 INFO - Output received: 16:02:36 INFO - /builds/slave/test/build/application/firefox/firefox 16:02:36 INFO - Running post-action listener: _resource_record_post_action 16:02:36 INFO - [mozharness: 2016-10-14 23:02:36.040536Z] Finished install step (success) 16:02:36 INFO - [mozharness: 2016-10-14 23:02:36.040778Z] Running run-tests step. 16:02:36 INFO - Running pre-action listener: _resource_record_pre_action 16:02:36 INFO - Running main action method: run_tests 16:02:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:02:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:02:36 INFO - Python 2.7.3 16:02:36 INFO - Return code: 0 16:02:36 INFO - grabbing minidump binary from tooltool 16:02:36 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')]} 16:02:36 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 0x25f3f60>, '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 0x25f4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f51d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:02:36 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 16:02:36 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 16:02:36 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 16:02:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:02:36 INFO - Return code: 0 16:02:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:02:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:02:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:02:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:02:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:02:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D80shwmXQ8OuQYfozRYGkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 16:02:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/D80shwmXQ8OuQYfozRYGkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --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 16:02:36 INFO - Using env: {'DISPLAY': ':0', 16:02:36 INFO - 'HOME': '/home/cltbld', 16:02:36 INFO - 'LANG': 'en_US.UTF-8', 16:02:36 INFO - 'LANGUAGE': 'en_US:en', 16:02:36 INFO - 'LOGNAME': 'cltbld', 16:02:36 INFO - 'MAIL': '/var/mail/cltbld', 16:02:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:02:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:02:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:36 INFO - 'MOZ_NO_REMOTE': '1', 16:02:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:02:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:36 INFO - 'NO_EM_RESTART': '1', 16:02:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:36 INFO - 'PWD': '/builds/slave/test', 16:02:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:02:36 INFO - 'SHELL': '/bin/bash', 16:02:36 INFO - 'SHLVL': '1', 16:02:36 INFO - 'TERM': 'linux', 16:02:36 INFO - 'TMOUT': '86400', 16:02:36 INFO - 'USER': 'cltbld', 16:02:36 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1476486101.151107-1782428227', 16:02:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:36 INFO - '_': '/tools/buildbot/bin/python'} 16:02:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D80shwmXQ8OuQYfozRYGkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 16:02:36 INFO - mozversion application_buildid: 20161014144235 16:02:36 INFO - mozversion application_changeset: de5d73a0568d1c3d50da32169026cc68ee09b1ae 16:02:36 INFO - mozversion application_display_name: Nightly 16:02:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:02:36 INFO - mozversion application_name: Firefox 16:02:36 INFO - mozversion application_remotingname: firefox 16:02:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:02:36 INFO - mozversion application_vendor: Mozilla 16:02:36 INFO - mozversion application_version: 52.0a1 16:02:36 INFO - mozversion platform_buildid: 20161014144235 16:02:36 INFO - mozversion platform_changeset: de5d73a0568d1c3d50da32169026cc68ee09b1ae 16:02:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:02:36 INFO - mozversion platform_version: 52.0a1 16:02:36 INFO - using testdate: 1476486156 16:02:36 INFO - actual date: 1476486156 16:02:36 INFO - starting webserver on 'localhost:37782' 16:02:36 INFO - SUITE-START | Running 2 tests 16:02:36 INFO - TEST-START | dromaeo_css 16:02:36 INFO - operating with platform_type : linux_ 16:02:36 INFO - Initialising browser for dromaeo_css test... 16:02:36 INFO - TEST-INFO | started process 9501 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWy5Ed3/profile http://localhost:37782/getInfo.html) 16:02:40 INFO - PROCESS | 9501 | __metrics Screen width/height:1600/1200 16:02:40 INFO - PROCESS | 9501 | colorDepth:24 16:02:40 INFO - PROCESS | 9501 | Browser inner width/height: 1024/697 16:02:40 INFO - PROCESS | 9501 | __metrics 16:02:41 INFO - PROCESS | 9501 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:02:41 INFO - PROCESS | 9501 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:02:41 INFO - PROCESS | 9501 | console.error: PushService: 16:02:41 INFO - PROCESS | 9501 | stateChangeProcessEnqueue: Error transitioning state 16:02:41 INFO - PROCESS | 9501 | UnknownError 16:02:42 INFO - TEST-INFO | 9501: exit 0 16:02:42 INFO - Browser initialized. 16:02:42 INFO - Running cycle 1/1 for dromaeo_css test... 16:02:42 INFO - TEST-INFO | started process 9583 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWy5Ed3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:02:54 INFO - PROCESS | 9583 | RSS: Main: 173150208 16:02:54 INFO - PROCESS | 9583 | 16:03:46 INFO - PROCESS | 9583 | 1476486226316 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] 16:05:58 INFO - PROCESS | 9583 | Cycle 1(1): loaded http://localhost:37782/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37782/tests/dromaeo/cssquery-ext.html) 16:06:01 INFO - PROCESS | 9583 | RSS: Main: 271937536 16:06:01 INFO - PROCESS | 9583 | 16:09:03 INFO - PROCESS | 9583 | Cycle 1(1): loaded http://localhost:37782/tests/dromaeo/cssquery-ext.html (next: http://localhost:37782/tests/dromaeo/cssquery-jquery.html) 16:09:04 INFO - PROCESS | 9583 | RSS: Main: 283688960 16:09:04 INFO - PROCESS | 9583 | 16:12:06 INFO - PROCESS | 9583 | Cycle 1(1): loaded http://localhost:37782/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37782/tests/dromaeo/cssquery-mootools.html) 16:12:07 INFO - PROCESS | 9583 | RSS: Main: 258490368 16:12:07 INFO - PROCESS | 9583 | 16:15:09 INFO - PROCESS | 9583 | Cycle 1(1): loaded http://localhost:37782/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37782/tests/dromaeo/cssquery-prototype.html) 16:15:10 INFO - PROCESS | 9583 | RSS: Main: 259051520 16:15:10 INFO - PROCESS | 9583 | 16:18:13 INFO - PROCESS | 9583 | Cycle 1(1): loaded http://localhost:37782/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37782/tests/dromaeo/cssquery-yui.html) 16:18:13 INFO - PROCESS | 9583 | RSS: Main: 220798976 16:18:13 INFO - PROCESS | 9583 | 16:21:16 INFO - PROCESS | 9583 | Cycle 1(1): loaded http://localhost:37782/tests/dromaeo/cssquery-yui.html (next: http://localhost:37782/tests/dromaeo/cssquery-dojo.html) 16:21:17 INFO - PROCESS | 9583 | RSS: Main: 307396608 16:21:17 INFO - PROCESS | 9583 | 16:21:17 INFO - PROCESS | 9583 | __start_tp_report 16:21:17 INFO - PROCESS | 9583 | _x_x_mozilla_page_load 16:21:17 INFO - PROCESS | 9583 | _x_x_mozilla_page_load_details 16:21:17 INFO - PROCESS | 9583 | |i|pagename|runs| 16:21:17 INFO - PROCESS | 9583 | |0;dojo.html;2598.506283806077;2617.6727909011374;2643.920682379528;2644.5900885362776;2664.933376665583;4576.107659006495;4641.25739881619;4757.643176761744;4768.976155119224;4793.13723529765;4670.392848929634;4685.344051832738;4718.57532822046;4760.262159365296;4817.759112044401;4266.36004599311;4271.871843844674;4314.956850431503;4349.108432771274;4364.388985542027;3975.3639417693175;4393.626541743955;4406.933895991563;4440.844570440036;4496.9550304497025;4253.574642535753;4345.717528360647;4388.780560971971;4446.933296000562;4489.932651010221;4286.185624731291;4294.613484786353;4306.289462238727;4327.2643650579475;4360.869173924787;4299.161663475624;4302.333138363559;4305.526392096866;4353.564643535653;4359.411479450266;4691.577758001762;4717.221658426355;4719;4730.550597693214;4738.1708201064675;4883.951160488421;4940.135476291671;4953.380827396575;4965.602751779885;5031.144705400091;5029.798808047673;5062.2406639004075;5064.82273120439;5101.4133374662015;5119.820806271762;4682.41469816273;4683.344331793552;4694.178518759203;4694.671373003891;4754.381930349033;5057.6459647824295;5073.797048118107;5155.355580552431;5160.23577195504;5211.166213405837;4891.608671306287;4932.556069953722;4942.233953737176;4946.035523073038;4949.282354058713;5018.673786203885;5025.221090730943;5025.673331233458;5025.723585202776;5029.547340739351;4933.50664933511;4969.4782047884455;4970.701757894538;4978.103941290602;4980.252962055648;4953.6037117030555;4964.925526117111;4967.180415231446;4967.2549117631925;4972.825951091694;4186.874393768192;4234.25900467417;4235.089455767024;4239.8092085856215;4246.617804397619;3713.424419215026;3739.8878033659034;3779.6598306152578;3806.885793426202;3849.9807500962315;4293.656507479394;4300.98926752213;4301.16127355169;4304.053108316165;4355.346697995326;4913.508649135058;4977.8257760978195;5110.437851836295;5120.283160357479;5181.611379146579;4223.746575205498;4240.98216428055;4241.088166044316;4292.163028209469;4324.437823082979;4520.909581808345;4521.88695282614;4528.864134075983;4530.954690453119;4587.655925805578;4787.664863459664;4788.329633851334;4789.9042019160115;4790.95209047919;4853.223484242504;5001.074801161797;5054.469280725618;5059.038782631288;5140.228965655032;5141.511556402136;4820.228763397839;4839.274108883696;4839.564439200489;4839.612830973443;4842.346283251716;5047.974760126176;5049.495050494921;5050.974745126251;5051.1160546904875;5051.722155281494;4990.900181996267;5030.647854650139;5047.6214283929585;5102.846914592568;5127.4872512748425;4948.331975183448;4951.876203094951;4955.331030311006;4995.25071239317;5008.57427118699;4944.8763780905765;4957.405111386656;4958.42978057528;4962.478939711278;5019.222020586815;4698.177818881613;4746.145693775154;4830.903381932412;4849.612031037579;4909.877253068702;4911.484294149206;4934.185859333314;4951.232558953368;4970.080535101018;5029.723365214948;4855.708657480563;4858.246971719389;4860;4865.513448655106;4918.213085906238 16:21:17 INFO - PROCESS | 9583 | |1;ext.html;547.8630342414397;572.2846441947565;576.8240686590591;580.6951350540962;599.4934280532948;28031;38964.61035389645;40410.19179616406;40456.59543404565;44269.7786511067;40356.19287614246;40867.38698919518;40886.59113408865;40911.18177636446;40948;7554.282343177403;7652.4260680448915;7728.884066739003;7742.612869356538;7752.457327987043;7427.2201418851055;7510.774676759706;7513.060867391576;7517.624118794039;7521.022267105269;7489.176190619028;7522.849543009136;7542.849143017136;7568.129665088531;7568.243175682415;7464.216257292987;7481.551106933602;7485.5508669480005;7494.213107623676;7497.212792656747;7527.736529221451;7538.886916696254;7573.5834529100875;7580.279873412072;7623.123340815821;37877;38225.426618600744;38302.42546361807;38342.42486362707;38377;2953.5569664550276;2956.482615542293;2970.1386597886585;3092.2578581140588;3340.265141668829;28496.572551411744;28696.744966942977;28815.711842881512;29198.41603167946;29932.251693707614;3434.1242983039415;3479.512868198429;3498.8950331490096;3500.4574290984683;3581.4269716845442;241873;241993;243185.78407108027;243953;243957;54111;54312.185317220275;54486;54561;54837.725811370685;31584.36831263362;32585.837070814967;32667.836660817018;34450.13874653103;34478.48282275768;13706.177629342272;13774;13786.517471888435;13786.931065344608;13788.172709637252;10529.157667386591;10596.31123976939;10602.36385816838;10602.469876506144;10609.151267898704;18008.639827203384;18062.63874722498;18111.909440452713;18133.54666133331;18334.81665183358;6694.732210711517;6761.29006454325;6831;6832.145981752281;6865.828354291183;750.9699612015568;897.8159477307137;898.4070513461085;963.325672029582;993.0714781679153;27073.323166920985;27534.76093575794;27603.86198069037;28002.2999425016;28256.43487130246;903.8870141232346;921.8432866412726;926.8007378413673;939.2204470289644;1039.5322105052755;13968;14416.567502974927;14429.206393648241;14866.628334291729;14980.850191498164;332805;335479;335591;335601;335773;49091;49546;49601.50398496041;49688.75155624199;49712;1054.6783231114584;1087.0542627913765;1132.660201939415;1160.1936654025371;1166.393475392791;24421.633675494526;29119.272018199714;29465.55801662934;29653.851730741208;29755.404891902475;36719.26561468702;36957.26085478329;36982;37038.074048149014;37090;275591;276060;276276;276299;276837;23620.8818955911;25053.74946250587;25081.49837003213;25090.874545627154;25120.74879251257;40313.79843100766;40679.38980915229;40845.38731918964;41541.37687934744;42097.36853947255;34632;34656.133596660286;34835.12912177115;34873.47689784604;34935.47596786101;34361;34386.48420273648;34609.480857787654;34808.65191348155;34810;28500.42999140047;29388.706112939453;31665.20836979094;35125.473117902744;35213.82393088018;30683.386332273676;32030.359392811548;32208.19479513031;32497.675023249463;32670.183245418102;24651.3976591521;24725.134620288205;24759;24994.875025624755;25182.244532664048 16:21:17 INFO - PROCESS | 9583 | |2;jquery.html;323.2758620689656;341.330991257136;341.7915071806199;347.2672660685953;360.95307610010695;12232.877671223285;13231.20612763235;16308.02151870887;17223.311067557283;17484.38804641838;14079.718405631882;14293.213873236968;16595.170241487936;17210.96734195949;17386.56533586661;4572.565606267399;4972.080165169446;5192.402873669538;5199.350081239845;5199.6360254782185;5834.533237341024;6124.346426464852;6129.111278864562;6130.632162070267;6138;5880.059190529516;5882.5588080893895;5928.199693041449;6125;6131.448169664729;5886.20536227608;5909.970450147722;5916.615419997686;5918.1418694289305;5923.022701254288;4724.4094488188975;5019.67372120811;5050.318207042039;5091.159958606825;5098.107831129538;12487.687807804878;12601.621951341474;14541.70916581673;19700.704489432526;20100.798992010037;1780.2789870102629;1793.820617938209;1801.9999999999868;1979.1291831594053;1981.3362523554626;8665.306775457948;9331.074767522672;9444.102810233016;9748.171405430547;9763.218942484584;1631.3719218101116;1690.754840548126;1707.8548323392527;1733.6619359224956;1780.8753387262898;64327;68675;69203.65398172977;72544.27455725428;74193;8308.792280193044;8785.956070219609;8789.208971192624;9776.804463910681;10019.599216031276;11756.882431175749;11775.646730598095;11812.763744725058;11819.527218911147;11843.34861582604;6499.317571655003;6691.464682825363;6768.898466523006;6773.762918297836;6926.445884329241;6552.443042341454;6660.9000864987065;6816.897746533806;6823.078884350549;6846.596447728204;4250.808713607895;4350.195213885378;4357.302831546937;4449.221386257456;4460.598546130864;1781.340903865552;1842.95392615183;1845.0682405385194;1883.3784850999136;1902.2961504243242;752.6312107067497;783.8667426537502;792.7859477941039;798.3254150243035;876.3120950054176;16551.34486551335;16649.3340266388;16824.57938551546;16987.660246795243;17427.73858392125;794.3089512124488;851.3614788908319;853.3258725606701;856.0860659812631;863.6113748813059;9506.572204250688;9745.415275083518;9797.853032204523;9822.901770982342;9853.556589953469;352750;367173;374247;374323;374895;72543.27456725365;74743.62628186824;75624;76817.23182768101;77333.22666773373;853.7396094191207;872.6771094695004;873.3973558244791;879.3097418526554;881.8192270584515;15243.618909527351;15271.847281527043;15496.225188740293;15549.533513994598;15848.370609884987;36545.45181822328;36663.63336366709;36837.44743828791;36925.99053077498;38168.2366352677;49815.25277120918;50469.74765126298;50809;50916.74541627268;50923;7361.889571656322;7451.590162540895;7517.548947062975;7618;7740;11224.887751122384;11486.94256528712;11619.302841829518;11736.823947640964;12457;10266.897331026892;10271.383716977005;10429.478526073817;10432.426216558162;10549.103326217051;10206.846897296398;10348.172146228435;10482.423466709404;10600.939906009646;10653.307535010199;10248.436336001592;10547.472626368497;10712.303700259457;10912.836307455553;11097.944510277397;7604.771856844303;7626.995827190769;7643.235676432535;7805.2194780521495;7903.604819758874;9942.552585133832;10162.491875406347;10248.64129755455;10383.896161038596;10803.189760767817 16:21:17 INFO - PROCESS | 9583 | |3;mootools.html;1234.648125284293;1321.9405126769295;1386.1682990205877;1417.461364681421;1675.7989041315036;6435.742570297189;7384.926150738491;7672.117706463759;7673.194314596971;7914.40641951853;7776.066871975357;7829.021372328459;7842.843143137134;7844.764657060283;7853.5680537570415;2100.71640328556;2122.246602456129;2123.437289118377;2131.6269652810774;2133.5306232628795;2060.8248298894614;2091.8535702500753;2106.452322396173;2111.324376199617;2111.567128738605;2099.359695292935;2113.9154433822705;2124.40516655336;2124.75565309989;2126.8404869634837;2052;2056.20835978148;2058.691196320549;2059.258666879922;2063.4222417723063;2019.9192032318836;2021.080408414168;2048.72342233798;2053.5995480881234;2054.5685406064745;7673.50122242058;7700.845983080363;7751.612419379065;7779.416543759184;7880.211978802131;4407.096545208225;4543.205433853609;4567.063751930847;4568.5431456854385;4569.063342014879;2850.5439129739143;2955.866985985636;3012.6686064532882;3020.8489575521357;3027.7880548361622;973.9513024348826;993.3890657245814;1003.0771690045176;1008.7982403519326;1011.4386515483903;10187.981201879827;10207.540660670213;10217.744556386075;10236.078752912274;10239.692809215661;3791.658750712449;4048.2510735514024;4184.2468355696265;4195.958040419618;4197.118605092965;8197.590120493951;8228.794280143044;8255.215754503313;8272.090070092285;8295.253427191461;4380.890477738082;4395.912081758411;4398.120375924827;4398.340248962617;4405.647548196201;3415.487676848443;3631.5279013728045;3719.3119272934596;4062.370332598393;4064.2684316823256;3191.888283910052;3236.6925142111463;3254.2989318865284;3303.884364047247;3330.0675810773023;988.7923536057365;991.8462638291077;993.294760719897;993.3741742702196;1020.0666390252835;772.8647486689807;790.9129995700468;811.4847072109135;818.8198596308803;820.2084987986622;5019.874503137377;5192.870178245498;5260.9736951315;5398.703071331036;5530.529904958124;394.9940750888739;398.30098177697954;413.0726518964943;416.04725179338976;417.8683714629882;3436;3438.570178727659;3594.4272909111955;3685.9078523037138;3737.8878633641034;9150.725478235663;9410;9443.669471568463;9460.195883349992;9476.526173691287;9389.953050234704;9405.623775048922;9409.670661526814;9418.152366287068;9425.38734982224;7138.571685698875;7145.749898753623;7162.176349719744;7163.78508644731;7184.173820010661;5177.974110129576;5282.366116066097;5307.601929855199;5321.707306098202;5385.515303622693;8416.116307787594;8608.956955215184;8721.738347849574;8862.158094980967;8863.556822158995;6766.323367663194;8450.408471406943;8663.6101375437;8706.390552661507;8997.775055623662;5950.672713000827;6328.272248691459;6683.866322673616;6702.128723266139;6709.93290067093;6694.163229596301;6906.827329316808;7048.083749112582;7101.964490177516;7304.306090921354;6440.452561532322;6493.967530162319;6648.235452922976;6657.900131498128;6748.73005079811;6411.96794016027;6444.903326450013;6451.838704032437;6478.70845811949;6503.154589903283;5925.40745925404;5975.492083172979;6001.789937352171;6002.969985150046;6023.6385816851125;4235.767032813224;4246.426732391211;4253.957460425356;4254.87235382939;4367.58507941745;4312.116016216731;4327.069680018811;4404.273294906433;4428.335749637451;4487.887802804956 16:21:17 INFO - PROCESS | 9583 | |4;prototype.html;284.7238178966402;289.3749501077672;297.6309376373298;298.2127184233623;301.45436759465355;4620.168369693454;4757.310190022449;4764.428268607772;4823.927641085386;4830.975845120774;4599.471060828006;4697.718136911788;4703.871070942975;4743.976280118603;4774.976125119379;3794.260119276742;3796.753211041287;3801.980990095046;3807.3908174692056;3820.1213720844294;3465.175881656442;3801.8404386662055;3808.2954653389074;3808.8286027128847;3809.904752381185;3274.4433446314065;3529.523514325559;3716.2939041582013;3750.1749615084636;3758.32350176968;3741.9690051058456;3745.550533935918;3748;3748.550173979126;3751.3997760358347;3311.2384151645015;3316.403047451458;3319.5850518685165;3323.5845519310087;3333.93332133356;4543.273076307808;4661.743604101773;4690.343351930733;4731.266653668687;4745.1695953208055;4291.699581029329;4295.508605009088;4295.591918767744;4302;4306.504751953534;4993.725345106018;5016.849494515134;5024;5032.220005899091;5043.445221025684;3388.6950174484414;3649.6715295623258;3680.245549662313;3685.8341374638208;3698.2973235085515;5203.60972927032;5268.394134674523;5272.868178295535;5283.762230699589;5287.920681189786;3509.5613048368955;3518.595361533405;3523.894283171509;3557.964420355815;3563.518924945151;3601.513795637555;3603.2253065591026;3606.206634540397;3610.422332426799;3610.530631017951;4079.6124368184974;4193.685473589493;4220.6412454941055;4225.9577404226175;4252.744835309892;5024.874378140503;5036.7733451994745;5042.243663450438;5043.394792624908;5062.367204099488;1172.6833754886134;1200.6218041317131;1244.8630650628425;1271.8299164768434;1297.695041665208;832.2218725491684;836.8911192669736;843.7637461510786;852.3266619370752;854.598338780772;4330.112326972963;4342.131573685276;4348.08672195027;4357.4988876279;4395;5152.562032227228;5152.871178220575;5154.587632989352;5171.612129090333;5171.758777893278;4311.8706438806885;4323.897406161472;4333.956660433355;4347.369631403429;4372.650187984954;2352.4118970257437;2408.3617841272076;2430.0158435833514;2441.523902838929;2442.7801497865275;4329.264025115738;4344.891377715582;4351.608355248043;4375.190589740844;4420.469543654782;4593.379893714306;4604.516525764813;4611.76941152941;4630.665920537208;4640.559146881041;4084.9591504085174;4224.4508213931995;4319.719218250803;4373.447426163793;4389.4513185851765;4554.294084416921;4560.908781824412;4562.680612357103;4576.3593096967115;4588.632909367176;4447.466304043406;4477.753723545236;4487.563979526521;4489.8999745062665;4506.616937560213;4156.542780294226;4220.240356735694;4296.720713153635;4343.478782546114;4369.099441742852;3294.9341013180083;3306.8015919044933;3333.983330083334;3338.5326054352895;3341.4796267698625;4623.86128416148;4628.976855115703;4633.907321853611;4648.7443190624845;4654.86035418938;4856.514348565115;4909.656324057281;4967.069429036886;4975.129352363394;4976.253561965734;4613.308003799457;4974.303597496426;4991.775370108427;5017.698938063728;5061.898762024813;4826.517348265286;4939.851804445872;4951.678140920829;4962.354893863775;4964.6524743269065;5021.84934451967;5025.170846810235;5027.64806463544;5049.6465247432325;5069.073751974226;4914.70511769295;4930.950690493192;4944.7033178008;4968.22992436173;5017.974910125426 16:21:17 INFO - PROCESS | 9583 | |5;yui.html;628.5882746800845;678.1590827374055;709.9645017749111;733.5965219129481;737.859806636739;12879;13242.7351452971;13700.451981920723;14054;14123.293835308245;13171.868281317184;13296.401661925212;13308.866911330884;13316.733665326688;13320.40058197381;610.8014895159068;746.6602695773423;766.5515673331108;768.5158350239342;769.7228997560874;651.9543631945766;762.9694812207505;786.9331106855924;795.3319211862034;797.7247849491916;824.6124321568883;826.0335407573153;826.3182874128838;828.4780588229407;833.170994860115;655.2104713819836;823.180934969703;823.7528741377592;823.9876401853977;824.0564553586111;498.20038837665385;581.3895409819714;600.2137200267663;601.4887345756116;602.1178972804862;12222.511099556006;12255.387230638433;12311.56909508163;12311.569095081719;12318.445669944875;12384.62846114618;12733.681657958532;12918.741625167539;13207.86792132076;13473.663158421019;11939.701507462296;11986.880131198664;12027.21823081497;12235;12350.382480876011;4165.958340416587;4195.077083041726;4204.906724251686;4206.85276015338;4327.0913108247305;61893;62615.68692156555;62823.68588157076;64523.354766452205;65892;10230.539625716861;10496.527656255486;10567;10570.841437378445;10998.505067271992;16916.49250522486;17794.733079003825;19584.60830783405;19766.802331976785;19833.30583429573;6719.160104986877;6928.376446119873;6985.930140698528;7002.159740831133;7315.085614298213;3691.1141326081547;3743.0455233915177;3805.7906815125434;3820.751651142667;3882.76703397797;2930.369970456362;3059.5563643271603;3077.1845460952864;3081.1064791210747;3100.6279246490567;513.4018868018791;521.4915457428976;521.8277968270462;524.8819015721432;531.5056996992756;572.4361503918636;583.6031498581006;585.8154681275385;589.7228302697725;593.1843714892024;8056.234657707509;8485.023932758562;8649.264812491008;8704.912950870537;8794;577.9452499188912;598.8023952095798;616.5468380740152;623.1151764494339;630.8044506203091;3831.65515103642;3905.921881562353;3966.167104907944;3967.305721498726;4051.9797401012806;54804.72597636986;54876.45123548793;54929.72535137379;55020.174697379574;55809.162862557096;74201.62899185577;85474;86562.56718716366;87173.56413217893;87372;58185.70907145522;65358.34641653618;68692.3130768686;69853;72079.91880121802;8254.66410939782;8325.85912142915;8747.65009399617;8873.73378798637;8993.595288211915;39866.40200397054;40123.398149027205;40571.59428405678;40997.38503922384;42288.577114229694;53030.73484632552;54646.907061857746;54741.72629136988;61671.383286166565;62851.37148628638;11280.548778048786;11594.420278986187;11719.707007324885;11932.343721095076;12083.456244468844;12813.487460501849;13237.933810330887;13361.66595835112;13480;13584.45662173502;11048.613298534512;11269.211155219384;11822.467988940347;11823.113266504875;11846.763064738829;12009.459574319351;12149.939250304045;12702.30137342455;12872.22766634005;12874.935625322189;10982.199539117473;11225.214235003472;11650.825237621273;12142.210756300812;12160.695982600506;10136.594536218763;10798;10861.511231994422;10923.508442119964;10956.945215273872;9237.506081879506;9271.444426827378;9414.952925235604;10462.21533384984;10464.63373781914 16:21:17 INFO - PROCESS | 9583 | __end_tp_report 16:21:17 INFO - PROCESS | 9583 | __start_cc_report 16:21:17 INFO - PROCESS | 9583 | _x_x_mozilla_cycle_collect,2205 16:21:17 INFO - PROCESS | 9583 | __end_cc_report 16:21:17 INFO - PROCESS | 9583 | __startTimestamp1476487277064__endTimestamp 16:21:17 INFO - PROCESS | 9583 | 16:21:17 INFO - PROCESS | 9583 | ------- Summary: start ------- 16:21:17 INFO - PROCESS | 9583 | Number of tests: 6 16:21:17 INFO - PROCESS | 9583 | 16:21:17 INFO - PROCESS | 9583 | [#0] dojo.html Cycles:165 Average:4660.93 Median:4830.90 stddev:491.44 (10.2%) stddev-sans-first:465.55 16:21:17 INFO - PROCESS | 9583 | Values: 2598.5 2617.7 2643.9 2644.6 2664.9 4576.1 4641.3 4757.6 4769.0 4793.1 4670.4 4685.3 4718.6 4760.3 4817.8 4266.4 4271.9 4315.0 4349.1 4364.4 3975.4 4393.6 4406.9 4440.8 4497.0 4253.6 4345.7 4388.8 4446.9 4489.9 4286.2 4294.6 4306.3 4327.3 4360.9 4299.2 4302.3 4305.5 4353.6 4359.4 4691.6 4717.2 4719.0 4730.6 4738.2 4884.0 4940.1 4953.4 4965.6 5031.1 5029.8 5062.2 5064.8 5101.4 5119.8 4682.4 4683.3 4694.2 4694.7 4754.4 5057.6 5073.8 5155.4 5160.2 5211.2 4891.6 4932.6 4942.2 4946.0 4949.3 5018.7 5025.2 5025.7 5025.7 5029.5 4933.5 4969.5 4970.7 4978.1 4980.3 4953.6 4964.9 4967.2 4967.3 4972.8 4186.9 4234.3 4235.1 4239.8 4246.6 3713.4 3739.9 3779.7 3806.9 3850.0 4293.7 4301.0 4301.2 4304.1 4355.3 4913.5 4977.8 5110.4 5120.3 5181.6 4223.7 4241.0 4241.1 4292.2 4324.4 4520.9 4521.9 4528.9 4531.0 4587.7 4787.7 4788.3 4789.9 4791.0 4853.2 5001.1 5054.5 5059.0 5140.2 5141.5 4820.2 4839.3 4839.6 4839.6 4842.3 5048.0 5049.5 5051.0 5051.1 5051.7 4990.9 5030.6 5047.6 5102.8 5127.5 4948.3 4951.9 4955.3 4995.3 5008.6 4944.9 4957.4 4958.4 4962.5 5019.2 4698.2 4746.1 4830.9 4849.6 4909.9 4911.5 4934.2 4951.2 4970.1 5029.7 4855.7 4858.2 4860.0 4865.5 4918.2 16:21:17 INFO - PROCESS | 9583 | 16:21:17 INFO - PROCESS | 9583 | [#1] ext.html Cycles:180 Average:43523.07 Median:19067.82 stddev:75289.56 (394.9%) stddev-sans-first:75431.63 16:21:17 INFO - PROCESS | 9583 | Values: 547.9 572.3 576.8 580.7 599.5 28031.0 38964.6 40410.2 40456.6 44269.8 40356.2 40867.4 40886.6 40911.2 40948.0 7554.3 7652.4 7728.9 7742.6 7752.5 7427.2 7510.8 7513.1 7517.6 7521.0 7489.2 7522.8 7542.8 7568.1 7568.2 7464.2 7481.6 7485.6 7494.2 7497.2 7527.7 7538.9 7573.6 7580.3 7623.1 37877.0 38225.4 38302.4 38342.4 38377.0 2953.6 2956.5 2970.1 3092.3 3340.3 28496.6 28696.7 28815.7 29198.4 29932.3 3434.1 3479.5 3498.9 3500.5 3581.4 241873.0 241993.0 243185.8 243953.0 243957.0 54111.0 54312.2 54486.0 54561.0 54837.7 31584.4 32585.8 32667.8 34450.1 34478.5 13706.2 13774.0 13786.5 13786.9 13788.2 10529.2 10596.3 10602.4 10602.5 10609.2 18008.6 18062.6 18111.9 18133.5 18334.8 6694.7 6761.3 6831.0 6832.1 6865.8 751.0 897.8 898.4 963.3 993.1 27073.3 27534.8 27603.9 28002.3 28256.4 903.9 921.8 926.8 939.2 1039.5 13968.0 14416.6 14429.2 14866.6 14980.9 332805.0 335479.0 335591.0 335601.0 335773.0 49091.0 49546.0 49601.5 49688.8 49712.0 1054.7 1087.1 1132.7 1160.2 1166.4 24421.6 29119.3 29465.6 29653.9 29755.4 36719.3 36957.3 36982.0 37038.1 37090.0 275591.0 276060.0 276276.0 276299.0 276837.0 23620.9 25053.7 25081.5 25090.9 25120.7 40313.8 40679.4 40845.4 41541.4 42097.4 34632.0 34656.1 34835.1 34873.5 34935.5 34361.0 34386.5 34609.5 34808.7 34810.0 28500.4 29388.7 31665.2 35125.5 35213.8 30683.4 32030.4 32208.2 32497.7 32670.2 24651.4 24725.1 24759.0 24994.9 25182.2 16:21:17 INFO - PROCESS | 9583 | 16:21:17 INFO - PROCESS | 9583 | [#2] jquery.html Cycles:180 Average:23443.89 Median:4648.49 stddev:61036.71 (1313.0%) stddev-sans-first:61183.25 16:21:17 INFO - PROCESS | 9583 | Values: 323.3 341.3 341.8 347.3 361.0 12232.9 13231.2 16308.0 17223.3 17484.4 14079.7 14293.2 16595.2 17211.0 17386.6 4572.6 4972.1 5192.4 5199.4 5199.6 5834.5 6124.3 6129.1 6130.6 6138.0 5880.1 5882.6 5928.2 6125.0 6131.4 5886.2 5910.0 5916.6 5918.1 5923.0 4724.4 5019.7 5050.3 5091.2 5098.1 12487.7 12601.6 14541.7 19700.7 20100.8 1780.3 1793.8 1802.0 1979.1 1981.3 8665.3 9331.1 9444.1 9748.2 9763.2 1631.4 1690.8 1707.9 1733.7 1780.9 64327.0 68675.0 69203.7 72544.3 74193.0 8308.8 8786.0 8789.2 9776.8 10019.6 11756.9 11775.6 11812.8 11819.5 11843.3 6499.3 6691.5 6768.9 6773.8 6926.4 6552.4 6660.9 6816.9 6823.1 6846.6 4250.8 4350.2 4357.3 4449.2 4460.6 1781.3 1843.0 1845.1 1883.4 1902.3 752.6 783.9 792.8 798.3 876.3 16551.3 16649.3 16824.6 16987.7 17427.7 794.3 851.4 853.3 856.1 863.6 9506.6 9745.4 9797.9 9822.9 9853.6 352750.0 367173.0 374247.0 374323.0 374895.0 72543.3 74743.6 75624.0 76817.2 77333.2 853.7 872.7 873.4 879.3 881.8 15243.6 15271.8 15496.2 15549.5 15848.4 36545.5 36663.6 36837.4 36926.0 38168.2 49815.3 50469.7 50809.0 50916.7 50923.0 7361.9 7451.6 7517.5 7618.0 7740.0 11224.9 11486.9 11619.3 11736.8 12457.0 10266.9 10271.4 10429.5 10432.4 10549.1 10206.8 10348.2 10482.4 10600.9 10653.3 10248.4 10547.5 10712.3 10912.8 11097.9 7604.8 7627.0 7643.2 7805.2 7903.6 9942.6 10162.5 10248.6 10383.9 10803.2 16:21:17 INFO - PROCESS | 9583 | 16:21:17 INFO - PROCESS | 9583 | [#3] mootools.html Cycles:180 Average:4940.49 Median:5185.42 stddev:2794.02 (53.9%) stddev-sans-first:2787.98 16:21:17 INFO - PROCESS | 9583 | Values: 1234.6 1321.9 1386.2 1417.5 1675.8 6435.7 7384.9 7672.1 7673.2 7914.4 7776.1 7829.0 7842.8 7844.8 7853.6 2100.7 2122.2 2123.4 2131.6 2133.5 2060.8 2091.9 2106.5 2111.3 2111.6 2099.4 2113.9 2124.4 2124.8 2126.8 2052.0 2056.2 2058.7 2059.3 2063.4 2019.9 2021.1 2048.7 2053.6 2054.6 7673.5 7700.8 7751.6 7779.4 7880.2 4407.1 4543.2 4567.1 4568.5 4569.1 2850.5 2955.9 3012.7 3020.8 3027.8 974.0 993.4 1003.1 1008.8 1011.4 10188.0 10207.5 10217.7 10236.1 10239.7 3791.7 4048.3 4184.2 4196.0 4197.1 8197.6 8228.8 8255.2 8272.1 8295.3 4380.9 4395.9 4398.1 4398.3 4405.6 3415.5 3631.5 3719.3 4062.4 4064.3 3191.9 3236.7 3254.3 3303.9 3330.1 988.8 991.8 993.3 993.4 1020.1 772.9 790.9 811.5 818.8 820.2 5019.9 5192.9 5261.0 5398.7 5530.5 395.0 398.3 413.1 416.0 417.9 3436.0 3438.6 3594.4 3685.9 3737.9 9150.7 9410.0 9443.7 9460.2 9476.5 9390.0 9405.6 9409.7 9418.2 9425.4 7138.6 7145.7 7162.2 7163.8 7184.2 5178.0 5282.4 5307.6 5321.7 5385.5 8416.1 8609.0 8721.7 8862.2 8863.6 6766.3 8450.4 8663.6 8706.4 8997.8 5950.7 6328.3 6683.9 6702.1 6709.9 6694.2 6906.8 7048.1 7102.0 7304.3 6440.5 6494.0 6648.2 6657.9 6748.7 6412.0 6444.9 6451.8 6478.7 6503.2 5925.4 5975.5 6001.8 6003.0 6023.6 4235.8 4246.4 4254.0 4254.9 4367.6 4312.1 4327.1 4404.3 4428.3 4487.9 16:21:17 INFO - PROCESS | 9583 | 16:21:17 INFO - PROCESS | 9583 | [#4] prototype.html Cycles:180 Average:4025.54 Median:4374.32 stddev:1168.91 (26.7%) stddev-sans-first:1137.97 16:21:17 INFO - PROCESS | 9583 | Values: 284.7 289.4 297.6 298.2 301.5 4620.2 4757.3 4764.4 4823.9 4831.0 4599.5 4697.7 4703.9 4744.0 4775.0 3794.3 3796.8 3802.0 3807.4 3820.1 3465.2 3801.8 3808.3 3808.8 3809.9 3274.4 3529.5 3716.3 3750.2 3758.3 3742.0 3745.6 3748.0 3748.6 3751.4 3311.2 3316.4 3319.6 3323.6 3333.9 4543.3 4661.7 4690.3 4731.3 4745.2 4291.7 4295.5 4295.6 4302.0 4306.5 4993.7 5016.8 5024.0 5032.2 5043.4 3388.7 3649.7 3680.2 3685.8 3698.3 5203.6 5268.4 5272.9 5283.8 5287.9 3509.6 3518.6 3523.9 3558.0 3563.5 3601.5 3603.2 3606.2 3610.4 3610.5 4079.6 4193.7 4220.6 4226.0 4252.7 5024.9 5036.8 5042.2 5043.4 5062.4 1172.7 1200.6 1244.9 1271.8 1297.7 832.2 836.9 843.8 852.3 854.6 4330.1 4342.1 4348.1 4357.5 4395.0 5152.6 5152.9 5154.6 5171.6 5171.8 4311.9 4323.9 4334.0 4347.4 4372.7 2352.4 2408.4 2430.0 2441.5 2442.8 4329.3 4344.9 4351.6 4375.2 4420.5 4593.4 4604.5 4611.8 4630.7 4640.6 4085.0 4224.5 4319.7 4373.4 4389.5 4554.3 4560.9 4562.7 4576.4 4588.6 4447.5 4477.8 4487.6 4489.9 4506.6 4156.5 4220.2 4296.7 4343.5 4369.1 3294.9 3306.8 3334.0 3338.5 3341.5 4623.9 4629.0 4633.9 4648.7 4654.9 4856.5 4909.7 4967.1 4975.1 4976.3 4613.3 4974.3 4991.8 5017.7 5061.9 4826.5 4939.9 4951.7 4962.4 4964.7 5021.8 5025.2 5027.6 5049.6 5069.1 4914.7 4931.0 4944.7 4968.2 5018.0 16:21:17 INFO - PROCESS | 9583 | 16:21:17 INFO - PROCESS | 9583 | [#5] yui.html Cycles:180 Average:16329.61 Median:23307.83 stddev:21500.03 (92.2%) stddev-sans-first:21528.01 16:21:17 INFO - PROCESS | 9583 | Values: 628.6 678.2 710.0 733.6 737.9 12879.0 13242.7 13700.5 14054.0 14123.3 13171.9 13296.4 13308.9 13316.7 13320.4 610.8 746.7 766.6 768.5 769.7 652.0 763.0 786.9 795.3 797.7 824.6 826.0 826.3 828.5 833.2 655.2 823.2 823.8 824.0 824.1 498.2 581.4 600.2 601.5 602.1 12222.5 12255.4 12311.6 12311.6 12318.4 12384.6 12733.7 12918.7 13207.9 13473.7 11939.7 11986.9 12027.2 12235.0 12350.4 4166.0 4195.1 4204.9 4206.9 4327.1 61893.0 62615.7 62823.7 64523.4 65892.0 10230.5 10496.5 10567.0 10570.8 10998.5 16916.5 17794.7 19584.6 19766.8 19833.3 6719.2 6928.4 6985.9 7002.2 7315.1 3691.1 3743.0 3805.8 3820.8 3882.8 2930.4 3059.6 3077.2 3081.1 3100.6 513.4 521.5 521.8 524.9 531.5 572.4 583.6 585.8 589.7 593.2 8056.2 8485.0 8649.3 8704.9 8794.0 577.9 598.8 616.5 623.1 630.8 3831.7 3905.9 3966.2 3967.3 4052.0 54804.7 54876.5 54929.7 55020.2 55809.2 74201.6 85474.0 86562.6 87173.6 87372.0 58185.7 65358.3 68692.3 69853.0 72079.9 8254.7 8325.9 8747.7 8873.7 8993.6 39866.4 40123.4 40571.6 40997.4 42288.6 53030.7 54646.9 54741.7 61671.4 62851.4 11280.5 11594.4 11719.7 11932.3 12083.5 12813.5 13237.9 13361.7 13480.0 13584.5 11048.6 11269.2 11822.5 11823.1 11846.8 12009.5 12149.9 12702.3 12872.2 12874.9 10982.2 11225.2 11650.8 12142.2 12160.7 10136.6 10798.0 10861.5 10923.5 10956.9 9237.5 9271.4 9415.0 10462.2 10464.6 16:21:17 INFO - PROCESS | 9583 | -------- Summary: end -------- 16:21:17 INFO - PROCESS | 9583 | 16:21:18 INFO - TEST-INFO | 9583: exit 0 16:21:18 INFO - TEST-OK | dromaeo_css | took 1121801ms 16:21:18 INFO - TEST-START | kraken 16:21:18 INFO - operating with platform_type : linux_ 16:21:18 INFO - Initialising browser for kraken test... 16:21:18 INFO - TEST-INFO | started process 9899 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUINODz/profile http://localhost:37782/getInfo.html) 16:21:22 INFO - PROCESS | 9899 | __metrics Screen width/height:1600/1200 16:21:22 INFO - PROCESS | 9899 | colorDepth:24 16:21:22 INFO - PROCESS | 9899 | Browser inner width/height: 1024/697 16:21:22 INFO - PROCESS | 9899 | __metrics 16:21:22 INFO - PROCESS | 9899 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:21:22 INFO - PROCESS | 9899 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:21:23 INFO - PROCESS | 9899 | console.error: PushService: 16:21:23 INFO - PROCESS | 9899 | stateChangeProcessEnqueue: Error transitioning state 16:21:23 INFO - PROCESS | 9899 | UnknownError 16:21:24 INFO - TEST-INFO | 9899: exit 0 16:21:24 INFO - Browser initialized. 16:21:24 INFO - Running cycle 1/1 for kraken test... 16:21:24 INFO - TEST-INFO | started process 9981 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUINODz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:21:36 INFO - PROCESS | 9981 | RSS: Main: 173408256 16:21:36 INFO - PROCESS | 9981 | 16:21:39 INFO - PROCESS | 9981 | Cycle 1(1): loaded http://localhost:37782/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37782/tests/kraken/driver.html?testName=audio-beat-detection) 16:21:40 INFO - PROCESS | 9981 | RSS: Main: 239353856 16:21:40 INFO - PROCESS | 9981 | 16:21:43 INFO - PROCESS | 9981 | Cycle 1(1): loaded http://localhost:37782/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37782/tests/kraken/driver.html?testName=audio-dft) 16:21:43 INFO - PROCESS | 9981 | RSS: Main: 216801280 16:21:43 INFO - PROCESS | 9981 | 16:21:46 INFO - PROCESS | 9981 | Cycle 1(1): loaded http://localhost:37782/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37782/tests/kraken/driver.html?testName=audio-fft) 16:21:47 INFO - PROCESS | 9981 | RSS: Main: 299016192 16:21:47 INFO - PROCESS | 9981 | 16:21:49 INFO - PROCESS | 9981 | Cycle 1(1): loaded http://localhost:37782/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37782/tests/kraken/driver.html?testName=audio-oscillator) 16:21:50 INFO - PROCESS | 9981 | RSS: Main: 209842176 16:21:50 INFO - PROCESS | 9981 | 16:21:52 INFO - PROCESS | 9981 | Cycle 1(1): loaded http://localhost:37782/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37782/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:21:53 INFO - PROCESS | 9981 | RSS: Main: 212578304 16:21:53 INFO - PROCESS | 9981 | 16:21:56 INFO - PROCESS | 9981 | Cycle 1(1): loaded http://localhost:37782/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37782/tests/kraken/driver.html?testName=imaging-darkroom) 16:21:56 INFO - PROCESS | 9981 | RSS: Main: 249151488 16:21:56 INFO - PROCESS | 9981 | 16:22:00 INFO - PROCESS | 9981 | Cycle 1(1): loaded http://localhost:37782/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37782/tests/kraken/driver.html?testName=imaging-desaturate) 16:22:01 INFO - PROCESS | 9981 | RSS: Main: 242601984 16:22:01 INFO - PROCESS | 9981 | 16:22:03 INFO - PROCESS | 9981 | Cycle 1(1): loaded http://localhost:37782/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37782/tests/kraken/driver.html?testName=json-parse-financial) 16:22:04 INFO - PROCESS | 9981 | RSS: Main: 245448704 16:22:04 INFO - PROCESS | 9981 | 16:22:06 INFO - PROCESS | 9981 | Cycle 1(1): loaded http://localhost:37782/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37782/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:22:06 INFO - PROCESS | 9981 | RSS: Main: 209088512 16:22:06 INFO - PROCESS | 9981 | 16:22:08 INFO - PROCESS | 9981 | Cycle 1(1): loaded http://localhost:37782/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37782/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:22:09 INFO - PROCESS | 9981 | RSS: Main: 216268800 16:22:09 INFO - PROCESS | 9981 | 16:22:11 INFO - PROCESS | 9981 | Cycle 1(1): loaded http://localhost:37782/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37782/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:22:11 INFO - PROCESS | 9981 | RSS: Main: 225230848 16:22:11 INFO - PROCESS | 9981 | 16:22:14 INFO - PROCESS | 9981 | Cycle 1(1): loaded http://localhost:37782/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37782/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:22:15 INFO - PROCESS | 9981 | RSS: Main: 234713088 16:22:15 INFO - PROCESS | 9981 | 16:22:18 INFO - PROCESS | 9981 | Cycle 1(1): loaded http://localhost:37782/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37782/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:22:19 INFO - PROCESS | 9981 | RSS: Main: 231153664 16:22:19 INFO - PROCESS | 9981 | 16:22:21 INFO - PROCESS | 9981 | Cycle 1(1): loaded http://localhost:37782/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37782/tests/kraken/driver.html?testName=ai-astar) 16:22:21 INFO - PROCESS | 9981 | RSS: Main: 280522752 16:22:21 INFO - PROCESS | 9981 | 16:22:21 INFO - PROCESS | 9981 | __start_tp_report 16:22:21 INFO - PROCESS | 9981 | _x_x_mozilla_page_load 16:22:21 INFO - PROCESS | 9981 | _x_x_mozilla_page_load_details 16:22:21 INFO - PROCESS | 9981 | |i|pagename|runs| 16:22:21 INFO - PROCESS | 9981 | |0;ai-astar;108;114;114;115;115;114;112;114;113;114 16:22:21 INFO - PROCESS | 9981 | |1;audio-beat-detection;153;128;133;176;135;137;130;126;157;132 16:22:21 INFO - PROCESS | 9981 | |2;audio-dft;161;162;161;161;161;161;161;162;161;161 16:22:21 INFO - PROCESS | 9981 | |3;audio-fft;77;76;76;112;78;79;78;78;103;76 16:22:21 INFO - PROCESS | 9981 | |4;audio-oscillator;84;84;116;84;83;83;116;82;83;108 16:22:21 INFO - PROCESS | 9981 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;118;117 16:22:21 INFO - PROCESS | 9981 | |6;imaging-darkroom;148;147;148;148;147;147;148;147;147;148 16:22:21 INFO - PROCESS | 9981 | |7;imaging-desaturate;84;84;86;84;84;85;85;84;84;84 16:22:21 INFO - PROCESS | 9981 | |8;json-parse-financial;66;65;65;64;75;66;67;66;65;66 16:22:21 INFO - PROCESS | 9981 | |9;json-stringify-tinderbox;67;68;68;67;68;67;68;67;67;68 16:22:21 INFO - PROCESS | 9981 | |10;stanford-crypto-aes;94;84;92;84;83;93;83;83;82;82 16:22:21 INFO - PROCESS | 9981 | |11;stanford-crypto-ccm;140;142;142;149;143;141;141;138;187;140 16:22:21 INFO - PROCESS | 9981 | |12;stanford-crypto-pbkdf2;179;179;181;182;178;183;176;186;178;178 16:22:21 INFO - PROCESS | 9981 | |13;stanford-crypto-sha256-iterative;73;71;70;70;70;74;74;70;70;69 16:22:21 INFO - PROCESS | 9981 | __end_tp_report 16:22:21 INFO - PROCESS | 9981 | __start_cc_report 16:22:21 INFO - PROCESS | 9981 | _x_x_mozilla_cycle_collect,1957 16:22:21 INFO - PROCESS | 9981 | __end_cc_report 16:22:21 INFO - PROCESS | 9981 | __startTimestamp1476487341260__endTimestamp 16:22:21 INFO - PROCESS | 9981 | 16:22:21 INFO - PROCESS | 9981 | ------- Summary: start ------- 16:22:21 INFO - PROCESS | 9981 | Number of tests: 14 16:22:21 INFO - PROCESS | 9981 | 16:22:21 INFO - PROCESS | 9981 | [#0] ai-astar Cycles:10 Average:113.30 Median:114.00 stddev:2.06 (1.8%) stddev-sans-first:0.93 16:22:21 INFO - PROCESS | 9981 | Values: 108.0 114.0 114.0 115.0 115.0 114.0 112.0 114.0 113.0 114.0 16:22:21 INFO - PROCESS | 9981 | 16:22:21 INFO - PROCESS | 9981 | [#1] audio-beat-detection Cycles:10 Average:140.70 Median:136.00 stddev:16.11 (11.8%) stddev-sans-first:16.46 16:22:21 INFO - PROCESS | 9981 | Values: 153.0 128.0 133.0 176.0 135.0 137.0 130.0 126.0 157.0 132.0 16:22:21 INFO - PROCESS | 9981 | 16:22:21 INFO - PROCESS | 9981 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 16:22:21 INFO - PROCESS | 9981 | Values: 161.0 162.0 161.0 161.0 161.0 161.0 161.0 162.0 161.0 161.0 16:22:21 INFO - PROCESS | 9981 | 16:22:21 INFO - PROCESS | 9981 | [#3] audio-fft Cycles:10 Average:83.30 Median:77.50 stddev:12.97 (16.7%) stddev-sans-first:13.56 16:22:21 INFO - PROCESS | 9981 | Values: 77.0 76.0 76.0 112.0 78.0 79.0 78.0 78.0 103.0 76.0 16:22:21 INFO - PROCESS | 9981 | 16:22:21 INFO - PROCESS | 9981 | [#4] audio-oscillator Cycles:10 Average:92.30 Median:83.00 stddev:14.69 (17.7%) stddev-sans-first:15.27 16:22:21 INFO - PROCESS | 9981 | Values: 84.0 84.0 116.0 84.0 83.0 83.0 116.0 82.0 83.0 108.0 16:22:21 INFO - PROCESS | 9981 | 16:22:21 INFO - PROCESS | 9981 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 16:22:21 INFO - PROCESS | 9981 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 16:22:21 INFO - PROCESS | 9981 | 16:22:21 INFO - PROCESS | 9981 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 16:22:21 INFO - PROCESS | 9981 | Values: 148.0 147.0 148.0 148.0 147.0 147.0 148.0 147.0 147.0 148.0 16:22:21 INFO - PROCESS | 9981 | 16:22:21 INFO - PROCESS | 9981 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.00 stddev:0.70 (0.8%) stddev-sans-first:0.73 16:22:21 INFO - PROCESS | 9981 | Values: 84.0 84.0 86.0 84.0 84.0 85.0 85.0 84.0 84.0 84.0 16:22:21 INFO - PROCESS | 9981 | 16:22:21 INFO - PROCESS | 9981 | [#8] json-parse-financial Cycles:10 Average:66.50 Median:66.00 stddev:3.10 (4.7%) stddev-sans-first:3.28 16:22:21 INFO - PROCESS | 9981 | Values: 66.0 65.0 65.0 64.0 75.0 66.0 67.0 66.0 65.0 66.0 16:22:21 INFO - PROCESS | 9981 | 16:22:21 INFO - PROCESS | 9981 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:68.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 16:22:21 INFO - PROCESS | 9981 | Values: 67.0 68.0 68.0 67.0 68.0 67.0 68.0 67.0 67.0 68.0 16:22:21 INFO - PROCESS | 9981 | 16:22:21 INFO - PROCESS | 9981 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:84.00 stddev:4.90 (5.8%) stddev-sans-first:4.26 16:22:21 INFO - PROCESS | 9981 | Values: 94.0 84.0 92.0 84.0 83.0 93.0 83.0 83.0 82.0 82.0 16:22:21 INFO - PROCESS | 9981 | 16:22:21 INFO - PROCESS | 9981 | [#11] stanford-crypto-ccm Cycles:10 Average:146.30 Median:142.00 stddev:14.59 (10.3%) stddev-sans-first:15.30 16:22:21 INFO - PROCESS | 9981 | Values: 140.0 142.0 142.0 149.0 143.0 141.0 141.0 138.0 187.0 140.0 16:22:21 INFO - PROCESS | 9981 | 16:22:21 INFO - PROCESS | 9981 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.00 Median:180.00 stddev:2.98 (1.7%) stddev-sans-first:3.14 16:22:21 INFO - PROCESS | 9981 | Values: 179.0 179.0 181.0 182.0 178.0 183.0 176.0 186.0 178.0 178.0 16:22:21 INFO - PROCESS | 9981 | 16:22:21 INFO - PROCESS | 9981 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:70.50 stddev:1.85 (2.6%) stddev-sans-first:1.83 16:22:21 INFO - PROCESS | 9981 | Values: 73.0 71.0 70.0 70.0 70.0 74.0 74.0 70.0 70.0 69.0 16:22:21 INFO - PROCESS | 9981 | -------- Summary: end -------- 16:22:21 INFO - PROCESS | 9981 | 16:22:22 INFO - TEST-INFO | 9981: exit 0 16:22:22 INFO - TEST-OK | kraken | took 64463ms 16:22:22 INFO - SUITE-END | took 1186s 16:22:22 INFO - Completed test suite (00:19:46) 16:22:22 INFO - javascript benchmark 16:22:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2598.506283806077, 2617.6727909011374, 2643.920682379528, 2644.5900885362776, 2664.933376665583, 4576.107659006495, 4641.25739881619, 4757.643176761744, 4768.976155119224, 4793.13723529765, 4670.392848929634, 4685.344051832738, 4718.57532822046, 4760.262159365296, 4817.759112044401, 4266.36004599311, 4271.871843844674, 4314.956850431503, 4349.108432771274, 4364.388985542027, 3975.3639417693175, 4393.626541743955, 4406.933895991563, 4440.844570440036, 4496.9550304497025, 4253.574642535753, 4345.717528360647, 4388.780560971971, 4446.933296000562, 4489.932651010221, 4286.185624731291, 4294.613484786353, 4306.289462238727, 4327.2643650579475, 4360.869173924787, 4299.161663475624, 4302.333138363559, 4305.526392096866, 4353.564643535653, 4359.411479450266, 4691.577758001762, 4717.221658426355, 4719.0, 4730.550597693214, 4738.1708201064675, 4883.951160488421, 4940.135476291671, 4953.380827396575, 4965.602751779885, 5031.144705400091, 5029.798808047673, 5062.2406639004075, 5064.82273120439, 5101.4133374662015, 5119.820806271762, 4682.41469816273, 4683.344331793552, 4694.178518759203, 4694.671373003891, 4754.381930349033, 5057.6459647824295, 5073.797048118107, 5155.355580552431, 5160.23577195504, 5211.166213405837, 4891.608671306287, 4932.556069953722, 4942.233953737176, 4946.035523073038, 4949.282354058713, 5018.673786203885, 5025.221090730943, 5025.673331233458, 5025.723585202776, 5029.547340739351, 4933.50664933511, 4969.4782047884455, 4970.701757894538, 4978.103941290602, 4980.252962055648, 4953.6037117030555, 4964.925526117111, 4967.180415231446, 4967.2549117631925, 4972.825951091694, 4186.874393768192, 4234.25900467417, 4235.089455767024, 4239.8092085856215, 4246.617804397619, 3713.424419215026, 3739.8878033659034, 3779.6598306152578, 3806.885793426202, 3849.9807500962315, 4293.656507479394, 4300.98926752213, 4301.16127355169, 4304.053108316165, 4355.346697995326, 4913.508649135058, 4977.8257760978195, 5110.437851836295, 5120.283160357479, 5181.611379146579, 4223.746575205498, 4240.98216428055, 4241.088166044316, 4292.163028209469, 4324.437823082979, 4520.909581808345, 4521.88695282614, 4528.864134075983, 4530.954690453119, 4587.655925805578, 4787.664863459664, 4788.329633851334, 4789.9042019160115, 4790.95209047919, 4853.223484242504, 5001.074801161797, 5054.469280725618, 5059.038782631288, 5140.228965655032, 5141.511556402136, 4820.228763397839, 4839.274108883696, 4839.564439200489, 4839.612830973443, 4842.346283251716, 5047.974760126176, 5049.495050494921, 5050.974745126251, 5051.1160546904875, 5051.722155281494, 4990.900181996267, 5030.647854650139, 5047.6214283929585, 5102.846914592568, 5127.4872512748425, 4948.331975183448, 4951.876203094951, 4955.331030311006, 4995.25071239317, 5008.57427118699, 4944.8763780905765, 4957.405111386656, 4958.42978057528, 4962.478939711278, 5019.222020586815, 4698.177818881613, 4746.145693775154, 4830.903381932412, 4849.612031037579, 4909.877253068702, 4911.484294149206, 4934.185859333314, 4951.232558953368, 4970.080535101018, 5029.723365214948, 4855.708657480563, 4858.246971719389, 4860.0, 4865.513448655106, 4918.213085906238], "value": 4629.5179097328855, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.8630342414397, 572.2846441947565, 576.8240686590591, 580.6951350540962, 599.4934280532948, 28031.0, 38964.61035389645, 40410.19179616406, 40456.59543404565, 44269.7786511067, 40356.19287614246, 40867.38698919518, 40886.59113408865, 40911.18177636446, 40948.0, 7554.282343177403, 7652.4260680448915, 7728.884066739003, 7742.612869356538, 7752.457327987043, 7427.2201418851055, 7510.774676759706, 7513.060867391576, 7517.624118794039, 7521.022267105269, 7489.176190619028, 7522.849543009136, 7542.849143017136, 7568.129665088531, 7568.243175682415, 7464.216257292987, 7481.551106933602, 7485.5508669480005, 7494.213107623676, 7497.212792656747, 7527.736529221451, 7538.886916696254, 7573.5834529100875, 7580.279873412072, 7623.123340815821, 37877.0, 38225.426618600744, 38302.42546361807, 38342.42486362707, 38377.0, 2953.5569664550276, 2956.482615542293, 2970.1386597886585, 3092.2578581140588, 3340.265141668829, 28496.572551411744, 28696.744966942977, 28815.711842881512, 29198.41603167946, 29932.251693707614, 3434.1242983039415, 3479.512868198429, 3498.8950331490096, 3500.4574290984683, 3581.4269716845442, 241873.0, 241993.0, 243185.78407108027, 243953.0, 243957.0, 54111.0, 54312.185317220275, 54486.0, 54561.0, 54837.725811370685, 31584.36831263362, 32585.837070814967, 32667.836660817018, 34450.13874653103, 34478.48282275768, 13706.177629342272, 13774.0, 13786.517471888435, 13786.931065344608, 13788.172709637252, 10529.157667386591, 10596.31123976939, 10602.36385816838, 10602.469876506144, 10609.151267898704, 18008.639827203384, 18062.63874722498, 18111.909440452713, 18133.54666133331, 18334.81665183358, 6694.732210711517, 6761.29006454325, 6831.0, 6832.145981752281, 6865.828354291183, 750.9699612015568, 897.8159477307137, 898.4070513461085, 963.325672029582, 993.0714781679153, 27073.323166920985, 27534.76093575794, 27603.86198069037, 28002.2999425016, 28256.43487130246, 903.8870141232346, 921.8432866412726, 926.8007378413673, 939.2204470289644, 1039.5322105052755, 13968.0, 14416.567502974927, 14429.206393648241, 14866.628334291729, 14980.850191498164, 332805.0, 335479.0, 335591.0, 335601.0, 335773.0, 49091.0, 49546.0, 49601.50398496041, 49688.75155624199, 49712.0, 1054.6783231114584, 1087.0542627913765, 1132.660201939415, 1160.1936654025371, 1166.393475392791, 24421.633675494526, 29119.272018199714, 29465.55801662934, 29653.851730741208, 29755.404891902475, 36719.26561468702, 36957.26085478329, 36982.0, 37038.074048149014, 37090.0, 275591.0, 276060.0, 276276.0, 276299.0, 276837.0, 23620.8818955911, 25053.74946250587, 25081.49837003213, 25090.874545627154, 25120.74879251257, 40313.79843100766, 40679.38980915229, 40845.38731918964, 41541.37687934744, 42097.36853947255, 34632.0, 34656.133596660286, 34835.12912177115, 34873.47689784604, 34935.47596786101, 34361.0, 34386.48420273648, 34609.480857787654, 34808.65191348155, 34810.0, 28500.42999140047, 29388.706112939453, 31665.20836979094, 35125.473117902744, 35213.82393088018, 30683.386332273676, 32030.359392811548, 32208.19479513031, 32497.675023249463, 32670.183245418102, 24651.3976591521, 24725.134620288205, 24759.0, 24994.875025624755, 25182.244532664048], "value": 16769.47714321709, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.2758620689656, 341.330991257136, 341.7915071806199, 347.2672660685953, 360.95307610010695, 12232.877671223285, 13231.20612763235, 16308.02151870887, 17223.311067557283, 17484.38804641838, 14079.718405631882, 14293.213873236968, 16595.170241487936, 17210.96734195949, 17386.56533586661, 4572.565606267399, 4972.080165169446, 5192.402873669538, 5199.350081239845, 5199.6360254782185, 5834.533237341024, 6124.346426464852, 6129.111278864562, 6130.632162070267, 6138.0, 5880.059190529516, 5882.5588080893895, 5928.199693041449, 6125.0, 6131.448169664729, 5886.20536227608, 5909.970450147722, 5916.615419997686, 5918.1418694289305, 5923.022701254288, 4724.4094488188975, 5019.67372120811, 5050.318207042039, 5091.159958606825, 5098.107831129538, 12487.687807804878, 12601.621951341474, 14541.70916581673, 19700.704489432526, 20100.798992010037, 1780.2789870102629, 1793.820617938209, 1801.9999999999868, 1979.1291831594053, 1981.3362523554626, 8665.306775457948, 9331.074767522672, 9444.102810233016, 9748.171405430547, 9763.218942484584, 1631.3719218101116, 1690.754840548126, 1707.8548323392527, 1733.6619359224956, 1780.8753387262898, 64327.0, 68675.0, 69203.65398172977, 72544.27455725428, 74193.0, 8308.792280193044, 8785.956070219609, 8789.208971192624, 9776.804463910681, 10019.599216031276, 11756.882431175749, 11775.646730598095, 11812.763744725058, 11819.527218911147, 11843.34861582604, 6499.317571655003, 6691.464682825363, 6768.898466523006, 6773.762918297836, 6926.445884329241, 6552.443042341454, 6660.9000864987065, 6816.897746533806, 6823.078884350549, 6846.596447728204, 4250.808713607895, 4350.195213885378, 4357.302831546937, 4449.221386257456, 4460.598546130864, 1781.340903865552, 1842.95392615183, 1845.0682405385194, 1883.3784850999136, 1902.2961504243242, 752.6312107067497, 783.8667426537502, 792.7859477941039, 798.3254150243035, 876.3120950054176, 16551.34486551335, 16649.3340266388, 16824.57938551546, 16987.660246795243, 17427.73858392125, 794.3089512124488, 851.3614788908319, 853.3258725606701, 856.0860659812631, 863.6113748813059, 9506.572204250688, 9745.415275083518, 9797.853032204523, 9822.901770982342, 9853.556589953469, 352750.0, 367173.0, 374247.0, 374323.0, 374895.0, 72543.27456725365, 74743.62628186824, 75624.0, 76817.23182768101, 77333.22666773373, 853.7396094191207, 872.6771094695004, 873.3973558244791, 879.3097418526554, 881.8192270584515, 15243.618909527351, 15271.847281527043, 15496.225188740293, 15549.533513994598, 15848.370609884987, 36545.45181822328, 36663.63336366709, 36837.44743828791, 36925.99053077498, 38168.2366352677, 49815.25277120918, 50469.74765126298, 50809.0, 50916.74541627268, 50923.0, 7361.889571656322, 7451.590162540895, 7517.548947062975, 7618.0, 7740.0, 11224.887751122384, 11486.94256528712, 11619.302841829518, 11736.823947640964, 12457.0, 10266.897331026892, 10271.383716977005, 10429.478526073817, 10432.426216558162, 10549.103326217051, 10206.846897296398, 10348.172146228435, 10482.423466709404, 10600.939906009646, 10653.307535010199, 10248.436336001592, 10547.472626368497, 10712.303700259457, 10912.836307455553, 11097.944510277397, 7604.771856844303, 7626.995827190769, 7643.235676432535, 7805.2194780521495, 7903.604819758874, 9942.552585133832, 10162.491875406347, 10248.64129755455, 10383.896161038596, 10803.189760767817], "value": 8035.750477173837, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1234.648125284293, 1321.9405126769295, 1386.1682990205877, 1417.461364681421, 1675.7989041315036, 6435.742570297189, 7384.926150738491, 7672.117706463759, 7673.194314596971, 7914.40641951853, 7776.066871975357, 7829.021372328459, 7842.843143137134, 7844.764657060283, 7853.5680537570415, 2100.71640328556, 2122.246602456129, 2123.437289118377, 2131.6269652810774, 2133.5306232628795, 2060.8248298894614, 2091.8535702500753, 2106.452322396173, 2111.324376199617, 2111.567128738605, 2099.359695292935, 2113.9154433822705, 2124.40516655336, 2124.75565309989, 2126.8404869634837, 2052.0, 2056.20835978148, 2058.691196320549, 2059.258666879922, 2063.4222417723063, 2019.9192032318836, 2021.080408414168, 2048.72342233798, 2053.5995480881234, 2054.5685406064745, 7673.50122242058, 7700.845983080363, 7751.612419379065, 7779.416543759184, 7880.211978802131, 4407.096545208225, 4543.205433853609, 4567.063751930847, 4568.5431456854385, 4569.063342014879, 2850.5439129739143, 2955.866985985636, 3012.6686064532882, 3020.8489575521357, 3027.7880548361622, 973.9513024348826, 993.3890657245814, 1003.0771690045176, 1008.7982403519326, 1011.4386515483903, 10187.981201879827, 10207.540660670213, 10217.744556386075, 10236.078752912274, 10239.692809215661, 3791.658750712449, 4048.2510735514024, 4184.2468355696265, 4195.958040419618, 4197.118605092965, 8197.590120493951, 8228.794280143044, 8255.215754503313, 8272.090070092285, 8295.253427191461, 4380.890477738082, 4395.912081758411, 4398.120375924827, 4398.340248962617, 4405.647548196201, 3415.487676848443, 3631.5279013728045, 3719.3119272934596, 4062.370332598393, 4064.2684316823256, 3191.888283910052, 3236.6925142111463, 3254.2989318865284, 3303.884364047247, 3330.0675810773023, 988.7923536057365, 991.8462638291077, 993.294760719897, 993.3741742702196, 1020.0666390252835, 772.8647486689807, 790.9129995700468, 811.4847072109135, 818.8198596308803, 820.2084987986622, 5019.874503137377, 5192.870178245498, 5260.9736951315, 5398.703071331036, 5530.529904958124, 394.9940750888739, 398.30098177697954, 413.0726518964943, 416.04725179338976, 417.8683714629882, 3436.0, 3438.570178727659, 3594.4272909111955, 3685.9078523037138, 3737.8878633641034, 9150.725478235663, 9410.0, 9443.669471568463, 9460.195883349992, 9476.526173691287, 9389.953050234704, 9405.623775048922, 9409.670661526814, 9418.152366287068, 9425.38734982224, 7138.571685698875, 7145.749898753623, 7162.176349719744, 7163.78508644731, 7184.173820010661, 5177.974110129576, 5282.366116066097, 5307.601929855199, 5321.707306098202, 5385.515303622693, 8416.116307787594, 8608.956955215184, 8721.738347849574, 8862.158094980967, 8863.556822158995, 6766.323367663194, 8450.408471406943, 8663.6101375437, 8706.390552661507, 8997.775055623662, 5950.672713000827, 6328.272248691459, 6683.866322673616, 6702.128723266139, 6709.93290067093, 6694.163229596301, 6906.827329316808, 7048.083749112582, 7101.964490177516, 7304.306090921354, 6440.452561532322, 6493.967530162319, 6648.235452922976, 6657.900131498128, 6748.73005079811, 6411.96794016027, 6444.903326450013, 6451.838704032437, 6478.70845811949, 6503.154589903283, 5925.40745925404, 5975.492083172979, 6001.789937352171, 6002.969985150046, 6023.6385816851125, 4235.767032813224, 4246.426732391211, 4253.957460425356, 4254.87235382939, 4367.58507941745, 4312.116016216731, 4327.069680018811, 4404.273294906433, 4428.335749637451, 4487.887802804956], "value": 3908.440318342539, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.7238178966402, 289.3749501077672, 297.6309376373298, 298.2127184233623, 301.45436759465355, 4620.168369693454, 4757.310190022449, 4764.428268607772, 4823.927641085386, 4830.975845120774, 4599.471060828006, 4697.718136911788, 4703.871070942975, 4743.976280118603, 4774.976125119379, 3794.260119276742, 3796.753211041287, 3801.980990095046, 3807.3908174692056, 3820.1213720844294, 3465.175881656442, 3801.8404386662055, 3808.2954653389074, 3808.8286027128847, 3809.904752381185, 3274.4433446314065, 3529.523514325559, 3716.2939041582013, 3750.1749615084636, 3758.32350176968, 3741.9690051058456, 3745.550533935918, 3748.0, 3748.550173979126, 3751.3997760358347, 3311.2384151645015, 3316.403047451458, 3319.5850518685165, 3323.5845519310087, 3333.93332133356, 4543.273076307808, 4661.743604101773, 4690.343351930733, 4731.266653668687, 4745.1695953208055, 4291.699581029329, 4295.508605009088, 4295.591918767744, 4302.0, 4306.504751953534, 4993.725345106018, 5016.849494515134, 5024.0, 5032.220005899091, 5043.445221025684, 3388.6950174484414, 3649.6715295623258, 3680.245549662313, 3685.8341374638208, 3698.2973235085515, 5203.60972927032, 5268.394134674523, 5272.868178295535, 5283.762230699589, 5287.920681189786, 3509.5613048368955, 3518.595361533405, 3523.894283171509, 3557.964420355815, 3563.518924945151, 3601.513795637555, 3603.2253065591026, 3606.206634540397, 3610.422332426799, 3610.530631017951, 4079.6124368184974, 4193.685473589493, 4220.6412454941055, 4225.9577404226175, 4252.744835309892, 5024.874378140503, 5036.7733451994745, 5042.243663450438, 5043.394792624908, 5062.367204099488, 1172.6833754886134, 1200.6218041317131, 1244.8630650628425, 1271.8299164768434, 1297.695041665208, 832.2218725491684, 836.8911192669736, 843.7637461510786, 852.3266619370752, 854.598338780772, 4330.112326972963, 4342.131573685276, 4348.08672195027, 4357.4988876279, 4395.0, 5152.562032227228, 5152.871178220575, 5154.587632989352, 5171.612129090333, 5171.758777893278, 4311.8706438806885, 4323.897406161472, 4333.956660433355, 4347.369631403429, 4372.650187984954, 2352.4118970257437, 2408.3617841272076, 2430.0158435833514, 2441.523902838929, 2442.7801497865275, 4329.264025115738, 4344.891377715582, 4351.608355248043, 4375.190589740844, 4420.469543654782, 4593.379893714306, 4604.516525764813, 4611.76941152941, 4630.665920537208, 4640.559146881041, 4084.9591504085174, 4224.4508213931995, 4319.719218250803, 4373.447426163793, 4389.4513185851765, 4554.294084416921, 4560.908781824412, 4562.680612357103, 4576.3593096967115, 4588.632909367176, 4447.466304043406, 4477.753723545236, 4487.563979526521, 4489.8999745062665, 4506.616937560213, 4156.542780294226, 4220.240356735694, 4296.720713153635, 4343.478782546114, 4369.099441742852, 3294.9341013180083, 3306.8015919044933, 3333.983330083334, 3338.5326054352895, 3341.4796267698625, 4623.86128416148, 4628.976855115703, 4633.907321853611, 4648.7443190624845, 4654.86035418938, 4856.514348565115, 4909.656324057281, 4967.069429036886, 4975.129352363394, 4976.253561965734, 4613.308003799457, 4974.303597496426, 4991.775370108427, 5017.698938063728, 5061.898762024813, 4826.517348265286, 4939.851804445872, 4951.678140920829, 4962.354893863775, 4964.6524743269065, 5021.84934451967, 5025.170846810235, 5027.64806463544, 5049.6465247432325, 5069.073751974226, 4914.70511769295, 4930.950690493192, 4944.7033178008, 4968.22992436173, 5017.974910125426], "value": 3657.1019068167693, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [628.5882746800845, 678.1590827374055, 709.9645017749111, 733.5965219129481, 737.859806636739, 12879.0, 13242.7351452971, 13700.451981920723, 14054.0, 14123.293835308245, 13171.868281317184, 13296.401661925212, 13308.866911330884, 13316.733665326688, 13320.40058197381, 610.8014895159068, 746.6602695773423, 766.5515673331108, 768.5158350239342, 769.7228997560874, 651.9543631945766, 762.9694812207505, 786.9331106855924, 795.3319211862034, 797.7247849491916, 824.6124321568883, 826.0335407573153, 826.3182874128838, 828.4780588229407, 833.170994860115, 655.2104713819836, 823.180934969703, 823.7528741377592, 823.9876401853977, 824.0564553586111, 498.20038837665385, 581.3895409819714, 600.2137200267663, 601.4887345756116, 602.1178972804862, 12222.511099556006, 12255.387230638433, 12311.56909508163, 12311.569095081719, 12318.445669944875, 12384.62846114618, 12733.681657958532, 12918.741625167539, 13207.86792132076, 13473.663158421019, 11939.701507462296, 11986.880131198664, 12027.21823081497, 12235.0, 12350.382480876011, 4165.958340416587, 4195.077083041726, 4204.906724251686, 4206.85276015338, 4327.0913108247305, 61893.0, 62615.68692156555, 62823.68588157076, 64523.354766452205, 65892.0, 10230.539625716861, 10496.527656255486, 10567.0, 10570.841437378445, 10998.505067271992, 16916.49250522486, 17794.733079003825, 19584.60830783405, 19766.802331976785, 19833.30583429573, 6719.160104986877, 6928.376446119873, 6985.930140698528, 7002.159740831133, 7315.085614298213, 3691.1141326081547, 3743.0455233915177, 3805.7906815125434, 3820.751651142667, 3882.76703397797, 2930.369970456362, 3059.5563643271603, 3077.1845460952864, 3081.1064791210747, 3100.6279246490567, 513.4018868018791, 521.4915457428976, 521.8277968270462, 524.8819015721432, 531.5056996992756, 572.4361503918636, 583.6031498581006, 585.8154681275385, 589.7228302697725, 593.1843714892024, 8056.234657707509, 8485.023932758562, 8649.264812491008, 8704.912950870537, 8794.0, 577.9452499188912, 598.8023952095798, 616.5468380740152, 623.1151764494339, 630.8044506203091, 3831.65515103642, 3905.921881562353, 3966.167104907944, 3967.305721498726, 4051.9797401012806, 54804.72597636986, 54876.45123548793, 54929.72535137379, 55020.174697379574, 55809.162862557096, 74201.62899185577, 85474.0, 86562.56718716366, 87173.56413217893, 87372.0, 58185.70907145522, 65358.34641653618, 68692.3130768686, 69853.0, 72079.91880121802, 8254.66410939782, 8325.85912142915, 8747.65009399617, 8873.73378798637, 8993.595288211915, 39866.40200397054, 40123.398149027205, 40571.59428405678, 40997.38503922384, 42288.577114229694, 53030.73484632552, 54646.907061857746, 54741.72629136988, 61671.383286166565, 62851.37148628638, 11280.548778048786, 11594.420278986187, 11719.707007324885, 11932.343721095076, 12083.456244468844, 12813.487460501849, 13237.933810330887, 13361.66595835112, 13480.0, 13584.45662173502, 11048.613298534512, 11269.211155219384, 11822.467988940347, 11823.113266504875, 11846.763064738829, 12009.459574319351, 12149.939250304045, 12702.30137342455, 12872.22766634005, 12874.935625322189, 10982.199539117473, 11225.214235003472, 11650.825237621273, 12142.210756300812, 12160.695982600506, 10136.594536218763, 10798.0, 10861.511231994422, 10923.508442119964, 10956.945215273872, 9237.506081879506, 9271.444426827378, 9414.952925235604, 10462.21533384984, 10464.63373781914], "value": 6547.5182715479505, "unit": "score"}], "name": "dromaeo_css", "value": 6228.618965162919, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 114.0, 114.0, 115.0, 115.0, 114.0, 112.0, 114.0, 113.0, 114.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 128.0, 133.0, 176.0, 135.0, 137.0, 130.0, 126.0, 157.0, 132.0], "value": 140.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 161.0, 161.0, 161.0, 161.0, 162.0, 161.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 112.0, 78.0, 79.0, 78.0, 78.0, 103.0, 76.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 116.0, 84.0, 83.0, 83.0, 116.0, 82.0, 83.0, 108.0], "value": 92.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 148.0, 147.0, 147.0, 148.0, 147.0, 147.0, 148.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 86.0, 84.0, 84.0, 85.0, 85.0, 84.0, 84.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 64.0, 75.0, 66.0, 67.0, 66.0, 65.0, 66.0], "value": 66.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 67.0, 68.0, 67.0, 68.0, 67.0, 67.0, 68.0], "value": 67.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 84.0, 92.0, 84.0, 83.0, 93.0, 83.0, 83.0, 82.0, 82.0], "value": 86.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 142.0, 142.0, 149.0, 143.0, 141.0, 141.0, 138.0, 187.0, 140.0], "value": 146.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 179.0, 181.0, 182.0, 178.0, 183.0, 176.0, 186.0, 178.0, 178.0], "value": 180.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 71.0, 70.0, 70.0, 70.0, 74.0, 74.0, 70.0, 70.0, 69.0], "value": 71.1, "unit": "score"}], "name": "kraken", "value": 1557.0999999999997, "alertThreshold": 2.0}]} 16:22:22 INFO - Return code: 0 16:22:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:22:23 INFO - # TBPL SUCCESS # 16:22:23 INFO - Running post-action listener: _resource_record_post_action 16:22:23 INFO - [mozharness: 2016-10-14 23:22:23.047236Z] Finished run-tests step (success) 16:22:23 INFO - Running post-run listener: _resource_record_post_run 16:22:23 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 0; Write bytes: 398999552; Read time: 0; Write time: 495208 16:22:23 INFO - TinderboxPrint: CPU usage
13.1% 16:22:23 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 16:22:23 INFO - TinderboxPrint: I/O write bytes / time
398,999,552 / 495,208 16:22:23 INFO - TinderboxPrint: CPU idle
8,339.6 (86.9%) 16:22:23 INFO - TinderboxPrint: CPU user
1,207.8 (12.6%) 16:22:23 INFO - TinderboxPrint: Swap in / out
0 / 0 16:22:23 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 106815488; Read time: 0; Write time: 134324 16:22:23 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 292184064; Read time: 0; Write time: 360884 16:22:23 INFO - Running post-run listener: _upload_blobber_files 16:22:23 INFO - Blob upload gear active. 16:22:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:22:23 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 16:22:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:22:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:22:24 INFO - (blobuploader) - INFO - Open directory for files ... 16:22:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:22:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:22:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:22:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:22:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:22:24 INFO - (blobuploader) - INFO - Done attempting. 16:22:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:22:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:22:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:22:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:22:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:22:30 INFO - (blobuploader) - INFO - Done attempting. 16:22:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:22:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:22:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:22:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:22:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:22:31 INFO - (blobuploader) - INFO - Done attempting. 16:22:31 INFO - (blobuploader) - INFO - Iteration through files over. 16:22:31 INFO - Return code: 0 16:22:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:22:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:22:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bd24d081edba2dc2bb37c3ae78a49bd29e90efcd0de1c17ef8b78e60188bc8b3b80482483a44c9ec977e0aee1b86e41337802d9c6cbb4e8cead791bd0b2d62c6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a1fe3a335224617ff23cb5a66acbcf1de8f3f577ab8cf7da43d5c6226f730a06a9b0b358488aabdbf226347ec260abed4b1560d336c82a5132929bf584c19990", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c0718b4e7833381c2161d35d01093d3fce9ab5602c3742f130bf5ea0e93379872cfdac22ebe5225a2d66baa9a1d7f58dc3041c971856b015639787b68d96de58"} 16:22:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:22:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:22:31 INFO - Contents: 16:22:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bd24d081edba2dc2bb37c3ae78a49bd29e90efcd0de1c17ef8b78e60188bc8b3b80482483a44c9ec977e0aee1b86e41337802d9c6cbb4e8cead791bd0b2d62c6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a1fe3a335224617ff23cb5a66acbcf1de8f3f577ab8cf7da43d5c6226f730a06a9b0b358488aabdbf226347ec260abed4b1560d336c82a5132929bf584c19990", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c0718b4e7833381c2161d35d01093d3fce9ab5602c3742f130bf5ea0e93379872cfdac22ebe5225a2d66baa9a1d7f58dc3041c971856b015639787b68d96de58"} 16:22:31 INFO - Running post-run listener: copy_logs_to_upload_dir 16:22:31 INFO - Copying logs to upload dir... 16:22:31 INFO - mkdir: /builds/slave/test/build/upload/logs 16:22:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.615643 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-14 16:22:29.868866) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 16:22:29.872058) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1476486101.151107-1782428227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bd24d081edba2dc2bb37c3ae78a49bd29e90efcd0de1c17ef8b78e60188bc8b3b80482483a44c9ec977e0aee1b86e41337802d9c6cbb4e8cead791bd0b2d62c6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a1fe3a335224617ff23cb5a66acbcf1de8f3f577ab8cf7da43d5c6226f730a06a9b0b358488aabdbf226347ec260abed4b1560d336c82a5132929bf584c19990", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c0718b4e7833381c2161d35d01093d3fce9ab5602c3742f130bf5ea0e93379872cfdac22ebe5225a2d66baa9a1d7f58dc3041c971856b015639787b68d96de58"} build_url:https://queue.taskcluster.net/v1/task/D80shwmXQ8OuQYfozRYGkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011369 build_url: 'https://queue.taskcluster.net/v1/task/D80shwmXQ8OuQYfozRYGkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bd24d081edba2dc2bb37c3ae78a49bd29e90efcd0de1c17ef8b78e60188bc8b3b80482483a44c9ec977e0aee1b86e41337802d9c6cbb4e8cead791bd0b2d62c6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a1fe3a335224617ff23cb5a66acbcf1de8f3f577ab8cf7da43d5c6226f730a06a9b0b358488aabdbf226347ec260abed4b1560d336c82a5132929bf584c19990", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c0718b4e7833381c2161d35d01093d3fce9ab5602c3742f130bf5ea0e93379872cfdac22ebe5225a2d66baa9a1d7f58dc3041c971856b015639787b68d96de58"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 16:22:29.897387) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 16:22:29.897714) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1476486101.151107-1782428227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 16:22:29.982570) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 16:22:29.982884) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 16:22:29.983177) ========= ========= Total master_lag: 0.14 =========