builder: larch_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-015 starttime: 1478899964.71 results: success (0) buildid: 20161111113020 builduid: f4c1ab79ad424b8a8feba60fac305c46 revision: 1edd75c67df0fb5e03f4746ae238603f03129807 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-11 13:32:44.708724) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-11 13:32:44.709296) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-11 13:32:44.709573) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-11 13:32:44.724028) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 13:32:44.724380) ========= 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=20e666a3d4cfbb71505a330e000001b4-1478899964.651136-216517208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-11 13:32:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.4M=0s 2016-11-11 13:32:45 (88.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.110585 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 13:32:44.848742) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 13:32:44.849084) ========= 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=20e666a3d4cfbb71505a330e000001b4-1478899964.651136-216517208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016555 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 13:32:44.899047) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 13:32:44.899451) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev 1edd75c67df0fb5e03f4746ae238603f03129807 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 1edd75c67df0fb5e03f4746ae238603f03129807 --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=20e666a3d4cfbb71505a330e000001b4-1478899964.651136-216517208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-11 13:32:45,538 truncating revision to first 12 chars 2016-11-11 13:32:45,538 Setting DEBUG logging. 2016-11-11 13:32:45,538 attempt 1/10 2016-11-11 13:32:45,538 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/1edd75c67df0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-11 13:32:45,844 unpacking tar archive at: larch-1edd75c67df0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.611141 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 13:32:45.524094) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-11 13:32:45.524421) ========= script_repo_revision: 1edd75c67df0fb5e03f4746ae238603f03129807 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-11 13:32:45.524799) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-11 13:32:45.525078) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-11 13:32:45.538502) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-11-11 13:32:45.538832) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-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', 'Larch-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch-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=20e666a3d4cfbb71505a330e000001b4-1478899964.651136-216517208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:32:46 INFO - MultiFileLogger online at 20161111 13:32:46 in /builds/slave/test 13:32:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO 13:32:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:32:46 INFO - {'append_to_log': False, 13:32:46 INFO - 'base_work_dir': '/builds/slave/test', 13:32:46 INFO - 'blob_upload_branch': 'Larch-Non-PGO', 13:32:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:32:46 INFO - 'branch': 'Larch-Non-PGO', 13:32:46 INFO - 'buildbot_json_path': 'buildprops.json', 13:32:46 INFO - 'config_files': ('talos/linux_config.py',), 13:32:46 INFO - 'default_actions': ('clobber', 13:32:46 INFO - 'read-buildbot-config', 13:32:46 INFO - 'download-and-extract', 13:32:46 INFO - 'populate-webroot', 13:32:46 INFO - 'create-virtualenv', 13:32:46 INFO - 'install', 13:32:46 INFO - 'run-tests'), 13:32:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:32:46 INFO - 'download_minidump_stackwalk': True, 13:32:46 INFO - 'download_symbols': 'ondemand', 13:32:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:32:46 INFO - 'tooltool.py': '/tools/tooltool.py', 13:32:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:32:46 INFO - '/tools/misc-python/virtualenv.py')}, 13:32:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:32:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:32:46 INFO - 'installer_path': 'installer.exe', 13:32:46 INFO - 'log_level': 'info', 13:32:46 INFO - 'log_name': 'talos', 13:32:46 INFO - 'log_to_console': True, 13:32:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:32:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:32:46 INFO - 'opt_config_files': (), 13:32:46 INFO - 'pip_index': False, 13:32:46 INFO - 'sps_profile': False, 13:32:46 INFO - 'sps_profile_interval': 0, 13:32:46 INFO - 'suite': 'dromaeojs', 13:32:46 INFO - 'system_bits': '32', 13:32:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:32:46 INFO - 'title': 'talos-linux64-ix-015', 13:32:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:32:46 INFO - 'use_talos_json': True, 13:32:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:32:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:32:46 INFO - 'work_dir': 'build'} 13:32:46 INFO - [mozharness: 2016-11-11 21:32:46.286813Z] Running clobber step. 13:32:46 INFO - Running pre-action listener: _resource_record_pre_action 13:32:46 INFO - Running main action method: clobber 13:32:46 INFO - rmtree: /builds/slave/test/build 13:32:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:32:46 INFO - Running post-action listener: _resource_record_post_action 13:32:46 INFO - [mozharness: 2016-11-11 21:32:46.748646Z] Finished clobber step (success) 13:32:46 INFO - [mozharness: 2016-11-11 21:32:46.748747Z] Running read-buildbot-config step. 13:32:46 INFO - Running pre-action listener: _resource_record_pre_action 13:32:46 INFO - Running main action method: read_buildbot_config 13:32:46 INFO - Using buildbot properties: 13:32:46 INFO - { 13:32:46 INFO - "project": "", 13:32:46 INFO - "product": "firefox", 13:32:46 INFO - "script_repo_revision": "production", 13:32:46 INFO - "builddir": "larch_ubuntu64_hw_test-dromaeojs", 13:32:46 INFO - "repository": "", 13:32:46 INFO - "buildername": "Ubuntu HW 12.04 x64 larch talos dromaeojs", 13:32:46 INFO - "buildid": "20161111113020", 13:32:46 INFO - "pgo_build": "False", 13:32:46 INFO - "basedir": "/builds/slave/test", 13:32:46 INFO - "buildnumber": 11, 13:32:46 INFO - "slavename": "talos-linux64-ix-015", 13:32:46 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:32:46 INFO - "platform": "ubuntu64_hw", 13:32:46 INFO - "scheduler": "tests-larch-linux64-talos", 13:32:46 INFO - "branch": "larch", 13:32:46 INFO - "repo_path": "projects/larch", 13:32:46 INFO - "revision": "1edd75c67df0fb5e03f4746ae238603f03129807", 13:32:46 INFO - "stage_platform": "linux64", 13:32:46 INFO - "builduid": "f4c1ab79ad424b8a8feba60fac305c46", 13:32:46 INFO - "slavebuilddir": "test" 13:32:46 INFO - } 13:32:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/P6g5w_AbSoiQv2t87mNMpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 13:32:46 INFO - Running post-action listener: _resource_record_post_action 13:32:46 INFO - [mozharness: 2016-11-11 21:32:46.751196Z] Finished read-buildbot-config step (success) 13:32:46 INFO - [mozharness: 2016-11-11 21:32:46.751284Z] Running download-and-extract step. 13:32:46 INFO - Running pre-action listener: _resource_record_pre_action 13:32:46 INFO - Running main action method: download_and_extract 13:32:46 INFO - mkdir: /builds/slave/test/build/tests 13:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:46 INFO - trying https://queue.taskcluster.net/v1/task/P6g5w_AbSoiQv2t87mNMpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:32:46 INFO - Downloading https://queue.taskcluster.net/v1/task/P6g5w_AbSoiQv2t87mNMpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:32:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P6g5w_AbSoiQv2t87mNMpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:32:47 INFO - Downloaded 1361 bytes. 13:32:47 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:32:47 INFO - Using the following test package requirements: 13:32:47 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 13:32:47 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:32:47 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:32:47 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:47 INFO - u'jsshell-linux-x86_64.zip'], 13:32:47 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:32:47 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 13:32:47 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:32:47 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:32:47 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:32:47 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:32:47 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:32:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P6g5w_AbSoiQv2t87mNMpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 13:32:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P6g5w_AbSoiQv2t87mNMpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:32:47 INFO - Fetch https://queue.taskcluster.net/v1/task/P6g5w_AbSoiQv2t87mNMpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:32:47 INFO - Http code: 200 13:32:47 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 13:32:47 INFO - x-amz-cf-id: -m26wjINIQ43zVEnfultP_qgl9X2dIpCh7WfG-BzyYuUurPorYqwiA== 13:32:47 INFO - x-amz-version-id: yXanH9uv_LMsO3_rCaMi_HLHSJ2P3sS1 13:32:48 INFO - Expected file size: 20414097 13:32:48 INFO - Obtained file size: 20414097 13:32:52 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:32:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P6g5w_AbSoiQv2t87mNMpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 13:32:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P6g5w_AbSoiQv2t87mNMpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:32:52 INFO - Fetch https://queue.taskcluster.net/v1/task/P6g5w_AbSoiQv2t87mNMpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:32:52 INFO - Http code: 200 13:32:52 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 13:32:52 INFO - x-amz-cf-id: 3aWJFmTkzNzKaRuaP_lDk_ngWI2j81b0rOjfv8v2GRDi4rgv6E43mQ== 13:32:52 INFO - x-amz-version-id: yXanH9uv_LMsO3_rCaMi_HLHSJ2P3sS1 13:32:52 INFO - Expected file size: 20414097 13:32:52 INFO - Obtained file size: 20414097 13:32:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P6g5w_AbSoiQv2t87mNMpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 13:32:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P6g5w_AbSoiQv2t87mNMpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:32:57 INFO - Fetch https://queue.taskcluster.net/v1/task/P6g5w_AbSoiQv2t87mNMpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 13:32:57 INFO - Http code: 200 13:32:57 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 13:32:57 INFO - x-amz-cf-id: z22xjDVcDBACY2veo9oBbdwcs1wFxTl5AaQCa4w7xjIj-47oEFAzEw== 13:32:57 INFO - x-amz-version-id: OPbL.7RSv8vFG9vyJKBt.aMxbN8vIgmN 13:32:58 INFO - Expected file size: 14409038 13:32:58 INFO - Obtained file size: 14409038 13:32:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:58 INFO - trying https://queue.taskcluster.net/v1/task/P6g5w_AbSoiQv2t87mNMpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:32:58 INFO - Downloading https://queue.taskcluster.net/v1/task/P6g5w_AbSoiQv2t87mNMpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:32:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P6g5w_AbSoiQv2t87mNMpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:32:59 INFO - Downloaded 55756500 bytes. 13:32:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P6g5w_AbSoiQv2t87mNMpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:32:59 INFO - mkdir: /builds/slave/test/properties 13:32:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:32:59 INFO - Writing to file /builds/slave/test/properties/build_url 13:32:59 INFO - Contents: 13:32:59 INFO - build_url:https://queue.taskcluster.net/v1/task/P6g5w_AbSoiQv2t87mNMpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:33:00 INFO - Running post-action listener: _resource_record_post_action 13:33:00 INFO - Running post-action listener: set_extra_try_arguments 13:33:00 INFO - [mozharness: 2016-11-11 21:33:00.173959Z] Finished download-and-extract step (success) 13:33:00 INFO - [mozharness: 2016-11-11 21:33:00.174058Z] Running populate-webroot step. 13:33:00 INFO - Running pre-action listener: _resource_record_pre_action 13:33:00 INFO - Running main action method: populate_webroot 13:33:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:33:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:33:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:33:00 INFO - '--tppagecycles', 13:33:00 INFO - '7'], 13:33:00 INFO - 'tests': ['tsvgm']}}, 13:33:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:33:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:33:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:33:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:33:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:33:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:33:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:00 INFO - 'talos_options': ['--disable-e10s'], 13:33:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:33:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:33:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:00 INFO - 'talos_options': ['--disable-e10s'], 13:33:00 INFO - 'tests': ['damp', 'tps']}, 13:33:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:00 INFO - 'tests': ['damp', 'tps']}, 13:33:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:33:00 INFO - 'tests': ['dromaeo_dom']}, 13:33:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:33:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:33:00 INFO - 'tests': ['basic_compositor_video']}, 13:33:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:33:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:33:00 INFO - 'tests': ['a11yr', 13:33:00 INFO - 'ts_paint', 13:33:00 INFO - 'tpaint', 13:33:00 INFO - 'sessionrestore', 13:33:00 INFO - 'sessionrestore_no_auto_restore', 13:33:00 INFO - 'tabpaint']}, 13:33:00 INFO - 'other-e10s': {'tests': ['a11yr', 13:33:00 INFO - 'ts_paint', 13:33:00 INFO - 'tpaint', 13:33:00 INFO - 'sessionrestore', 13:33:00 INFO - 'sessionrestore_no_auto_restore', 13:33:00 INFO - 'tabpaint']}, 13:33:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:33:00 INFO - 'ts_paint', 13:33:00 INFO - 'tpaint', 13:33:00 INFO - 'sessionrestore', 13:33:00 INFO - 'sessionrestore_no_auto_restore', 13:33:00 INFO - 'tabpaint']}, 13:33:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:33:00 INFO - 'ts_paint', 13:33:00 INFO - 'tpaint', 13:33:00 INFO - 'sessionrestore', 13:33:00 INFO - 'sessionrestore_no_auto_restore', 13:33:00 INFO - 'tabpaint']}, 13:33:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:33:00 INFO - 'tests': ['a11yr', 13:33:00 INFO - 'ts_paint', 13:33:00 INFO - 'tpaint', 13:33:00 INFO - 'sessionrestore', 13:33:00 INFO - 'sessionrestore_no_auto_restore', 13:33:00 INFO - 'tabpaint']}, 13:33:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:33:00 INFO - 'tests': ['a11yr', 13:33:00 INFO - 'ts_paint', 13:33:00 INFO - 'tpaint', 13:33:00 INFO - 'sessionrestore', 13:33:00 INFO - 'sessionrestore_no_auto_restore', 13:33:00 INFO - 'tabpaint']}, 13:33:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:33:00 INFO - 'tests': ['tsvgx', 13:33:00 INFO - 'tsvgr_opacity', 13:33:00 INFO - 'tart', 13:33:00 INFO - 'tscrollx', 13:33:00 INFO - 'cart']}, 13:33:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:33:00 INFO - 'tsvgr_opacity', 13:33:00 INFO - 'tart', 13:33:00 INFO - 'tscrollx', 13:33:00 INFO - 'cart']}, 13:33:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:00 INFO - 'talos_options': ['--disable-e10s'], 13:33:00 INFO - 'tests': ['tp5o']}, 13:33:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:00 INFO - 'tests': ['tp5o']}, 13:33:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:00 INFO - 'talos_options': ['--disable-e10s', 13:33:00 INFO - '--xperf_path', 13:33:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:33:00 INFO - 'tests': ['tp5n']}, 13:33:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:00 INFO - 'talos_options': ['--xperf_path', 13:33:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:33:00 INFO - 'tests': ['tp5n']}}, 13:33:00 INFO - 'talos.zip': {'path': '', 13:33:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:33:00 INFO - Running post-action listener: _resource_record_post_action 13:33:00 INFO - [mozharness: 2016-11-11 21:33:00.194984Z] Finished populate-webroot step (success) 13:33:00 INFO - [mozharness: 2016-11-11 21:33:00.195072Z] Running create-virtualenv step. 13:33:00 INFO - Running pre-action listener: _resource_record_pre_action 13:33:00 INFO - Running main action method: create_virtualenv 13:33:00 INFO - Creating virtualenv /builds/slave/test/build/venv 13:33:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:33:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:33:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:33:00 INFO - Using real prefix '/usr' 13:33:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:33:00 INFO - Installing distribute.............................................................................................................................................................................................done. 13:33:02 INFO - Installing pip.................done. 13:33:02 INFO - Return code: 0 13:33:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:33:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:33:03 INFO - Reading from file tmpfile_stdout 13:33:03 INFO - Output received: 13:33:03 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 13:33:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:33: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')]} 13:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33: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')]} 13:33:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f26fda7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd83ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd80f60>, '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 0xd81d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd821d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1478899964.651136-216517208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:33: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', 'pip>=1.5'] in /builds/slave/test/build 13:33: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 pip>=1.5 13:33:03 INFO - Using env: {'DISPLAY': ':0', 13:33:03 INFO - 'HOME': '/home/cltbld', 13:33:03 INFO - 'LANG': 'en_US.UTF-8', 13:33:03 INFO - 'LANGUAGE': 'en_US:en', 13:33:03 INFO - 'LOGNAME': 'cltbld', 13:33:03 INFO - 'MAIL': '/var/mail/cltbld', 13:33:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:03 INFO - 'MOZ_NO_REMOTE': '1', 13:33:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:03 INFO - 'NO_EM_RESTART': '1', 13:33:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:03 INFO - 'PWD': '/builds/slave/test', 13:33:03 INFO - 'SHELL': '/bin/bash', 13:33:03 INFO - 'SHLVL': '1', 13:33:03 INFO - 'TERM': 'linux', 13:33:03 INFO - 'TMOUT': '86400', 13:33:03 INFO - 'USER': 'cltbld', 13:33:03 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478899964.651136-216517208', 13:33:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:03 INFO - '_': '/tools/buildbot/bin/python'} 13:33:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:03 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:33:03 INFO - Cleaning up... 13:33:03 INFO - Return code: 0 13:33:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:33: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')]} 13:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33: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')]} 13:33:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33: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', '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 0x7f26fda7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd83ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd80f60>, '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 0xd81d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd821d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1478899964.651136-216517208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:33: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', 'psutil>=3.1.1'] in /builds/slave/test/build 13:33: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 psutil>=3.1.1 13:33:03 INFO - Using env: {'DISPLAY': ':0', 13:33:03 INFO - 'HOME': '/home/cltbld', 13:33:03 INFO - 'LANG': 'en_US.UTF-8', 13:33:03 INFO - 'LANGUAGE': 'en_US:en', 13:33:03 INFO - 'LOGNAME': 'cltbld', 13:33:03 INFO - 'MAIL': '/var/mail/cltbld', 13:33:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:03 INFO - 'MOZ_NO_REMOTE': '1', 13:33:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:03 INFO - 'NO_EM_RESTART': '1', 13:33:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:03 INFO - 'PWD': '/builds/slave/test', 13:33:03 INFO - 'SHELL': '/bin/bash', 13:33:03 INFO - 'SHLVL': '1', 13:33:03 INFO - 'TERM': 'linux', 13:33:03 INFO - 'TMOUT': '86400', 13:33:03 INFO - 'USER': 'cltbld', 13:33:03 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478899964.651136-216517208', 13:33:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:03 INFO - '_': '/tools/buildbot/bin/python'} 13:33:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:03 INFO - Downloading/unpacking psutil>=3.1.1 13:33: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 13:33: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 13:33: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 13:33: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 13:33: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 13:33: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 13:33:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:33:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:33:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:33:05 INFO - Installing collected packages: psutil 13:33:05 INFO - Running setup.py install for psutil 13:33:05 INFO - building 'psutil._psutil_linux' extension 13:33:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:33:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:33:05 INFO - building 'psutil._psutil_posix' extension 13:33:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 13:33:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 13:33:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:33:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:33:06 INFO - Successfully installed psutil 13:33:06 INFO - Cleaning up... 13:33:06 INFO - Return code: 0 13:33:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:33:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:06 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 0x7f26fda7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd83ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd80f60>, '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 0xd81d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd821d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1478899964.651136-216517208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:33:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:33:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:33:06 INFO - Using env: {'DISPLAY': ':0', 13:33:06 INFO - 'HOME': '/home/cltbld', 13:33:06 INFO - 'LANG': 'en_US.UTF-8', 13:33:06 INFO - 'LANGUAGE': 'en_US:en', 13:33:06 INFO - 'LOGNAME': 'cltbld', 13:33:06 INFO - 'MAIL': '/var/mail/cltbld', 13:33:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:06 INFO - 'MOZ_NO_REMOTE': '1', 13:33:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:06 INFO - 'NO_EM_RESTART': '1', 13:33:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:06 INFO - 'PWD': '/builds/slave/test', 13:33:06 INFO - 'SHELL': '/bin/bash', 13:33:06 INFO - 'SHLVL': '1', 13:33:06 INFO - 'TERM': 'linux', 13:33:06 INFO - 'TMOUT': '86400', 13:33:06 INFO - 'USER': 'cltbld', 13:33:06 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478899964.651136-216517208', 13:33:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:06 INFO - '_': '/tools/buildbot/bin/python'} 13:33:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:33:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:33:08 INFO - Installing collected packages: mozsystemmonitor 13:33:08 INFO - Running setup.py install for mozsystemmonitor 13:33:08 INFO - Successfully installed mozsystemmonitor 13:33:08 INFO - Cleaning up... 13:33:08 INFO - Return code: 0 13:33:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:33: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')]} 13:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33: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')]} 13:33:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33: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', '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 0x7f26fda7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd83ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd80f60>, '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 0xd81d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd821d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1478899964.651136-216517208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:33: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:33: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 jsonschema==2.5.1 13:33:08 INFO - Using env: {'DISPLAY': ':0', 13:33:08 INFO - 'HOME': '/home/cltbld', 13:33:08 INFO - 'LANG': 'en_US.UTF-8', 13:33:08 INFO - 'LANGUAGE': 'en_US:en', 13:33:08 INFO - 'LOGNAME': 'cltbld', 13:33:08 INFO - 'MAIL': '/var/mail/cltbld', 13:33:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:08 INFO - 'MOZ_NO_REMOTE': '1', 13:33:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:08 INFO - 'NO_EM_RESTART': '1', 13:33:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:08 INFO - 'PWD': '/builds/slave/test', 13:33:08 INFO - 'SHELL': '/bin/bash', 13:33:08 INFO - 'SHLVL': '1', 13:33:08 INFO - 'TERM': 'linux', 13:33:08 INFO - 'TMOUT': '86400', 13:33:08 INFO - 'USER': 'cltbld', 13:33:08 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478899964.651136-216517208', 13:33:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:08 INFO - '_': '/tools/buildbot/bin/python'} 13:33:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:08 INFO - Downloading/unpacking jsonschema==2.5.1 13:33: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 13:33: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 13:33: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 13:33: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 13:33: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 13:33: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 13:33:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:33:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:33: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 13:33: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 13:33: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 13:33: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 13:33: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 13:33: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 13:33:10 INFO - Downloading functools32-3.2.3-2.tar.gz 13:33:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:33:10 INFO - warning: no files found matching '*.txt' 13:33:10 INFO - no previously-included directories found matching 'build' 13:33:10 INFO - no previously-included directories found matching 'dist' 13:33:10 INFO - no previously-included directories found matching '.git*' 13:33:10 INFO - Installing collected packages: jsonschema, functools32 13:33:10 INFO - Running setup.py install for functools32 13:33:10 INFO - warning: no files found matching '*.txt' 13:33:10 INFO - no previously-included directories found matching 'build' 13:33:10 INFO - no previously-included directories found matching 'dist' 13:33:10 INFO - no previously-included directories found matching '.git*' 13:33:10 INFO - Successfully installed jsonschema functools32 13:33:10 INFO - Cleaning up... 13:33:11 INFO - Return code: 0 13:33:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:33:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:11 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 0x7f26fda7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd83ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd80f60>, '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 0xd81d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd821d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1478899964.651136-216517208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:33:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:33:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:33:11 INFO - Using env: {'DISPLAY': ':0', 13:33:11 INFO - 'HOME': '/home/cltbld', 13:33:11 INFO - 'LANG': 'en_US.UTF-8', 13:33:11 INFO - 'LANGUAGE': 'en_US:en', 13:33:11 INFO - 'LOGNAME': 'cltbld', 13:33:11 INFO - 'MAIL': '/var/mail/cltbld', 13:33:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:11 INFO - 'MOZ_NO_REMOTE': '1', 13:33:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:11 INFO - 'NO_EM_RESTART': '1', 13:33:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:11 INFO - 'PWD': '/builds/slave/test', 13:33:11 INFO - 'SHELL': '/bin/bash', 13:33:11 INFO - 'SHLVL': '1', 13:33:11 INFO - 'TERM': 'linux', 13:33:11 INFO - 'TMOUT': '86400', 13:33:11 INFO - 'USER': 'cltbld', 13:33:11 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478899964.651136-216517208', 13:33:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:11 INFO - '_': '/tools/buildbot/bin/python'} 13:33:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:33:11 INFO - Cleaning up... 13:33:11 INFO - Return code: 0 13:33:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:33:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:11 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 0x7f26fda7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd83ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd80f60>, '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 0xd81d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd821d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1478899964.651136-216517208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:33:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:33:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:33:11 INFO - Using env: {'DISPLAY': ':0', 13:33:11 INFO - 'HOME': '/home/cltbld', 13:33:11 INFO - 'LANG': 'en_US.UTF-8', 13:33:11 INFO - 'LANGUAGE': 'en_US:en', 13:33:11 INFO - 'LOGNAME': 'cltbld', 13:33:11 INFO - 'MAIL': '/var/mail/cltbld', 13:33:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:11 INFO - 'MOZ_NO_REMOTE': '1', 13:33:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:11 INFO - 'NO_EM_RESTART': '1', 13:33:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:11 INFO - 'PWD': '/builds/slave/test', 13:33:11 INFO - 'SHELL': '/bin/bash', 13:33:11 INFO - 'SHLVL': '1', 13:33:11 INFO - 'TERM': 'linux', 13:33:11 INFO - 'TMOUT': '86400', 13:33:11 INFO - 'USER': 'cltbld', 13:33:11 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478899964.651136-216517208', 13:33:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:11 INFO - '_': '/tools/buildbot/bin/python'} 13:33:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:11 INFO - Downloading/unpacking blobuploader==1.2.4 13:33: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 13:33: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 13:33: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 13:33: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 13:33: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 13:33: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 13:33:13 INFO - Downloading blobuploader-1.2.4.tar.gz 13:33:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:33:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:33:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:14 INFO - Downloading docopt-0.6.1.tar.gz 13:33:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:33:14 INFO - Installing collected packages: blobuploader, requests, docopt 13:33:14 INFO - Running setup.py install for blobuploader 13:33:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:33:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:33:14 INFO - Running setup.py install for requests 13:33:14 INFO - Running setup.py install for docopt 13:33:14 INFO - Successfully installed blobuploader requests docopt 13:33:14 INFO - Cleaning up... 13:33:14 INFO - Return code: 0 13:33:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:33:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:14 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 0x7f26fda7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd83ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd80f60>, '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 0xd81d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd821d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1478899964.651136-216517208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:33:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:33:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:33:14 INFO - Using env: {'DISPLAY': ':0', 13:33:14 INFO - 'HOME': '/home/cltbld', 13:33:14 INFO - 'LANG': 'en_US.UTF-8', 13:33:14 INFO - 'LANGUAGE': 'en_US:en', 13:33:14 INFO - 'LOGNAME': 'cltbld', 13:33:14 INFO - 'MAIL': '/var/mail/cltbld', 13:33:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:14 INFO - 'MOZ_NO_REMOTE': '1', 13:33:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:14 INFO - 'NO_EM_RESTART': '1', 13:33:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:14 INFO - 'PWD': '/builds/slave/test', 13:33:14 INFO - 'SHELL': '/bin/bash', 13:33:14 INFO - 'SHLVL': '1', 13:33:14 INFO - 'TERM': 'linux', 13:33:14 INFO - 'TMOUT': '86400', 13:33:14 INFO - 'USER': 'cltbld', 13:33:14 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478899964.651136-216517208', 13:33:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:14 INFO - '_': '/tools/buildbot/bin/python'} 13:33:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:33:15 INFO - Running setup.py (path:/tmp/pip-ZEdAau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:33:15 INFO - Running setup.py (path:/tmp/pip-MqNE7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:33:15 INFO - Running setup.py (path:/tmp/pip-1l6PG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:33:15 INFO - Running setup.py (path:/tmp/pip-IiYClw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:33:15 INFO - Running setup.py (path:/tmp/pip-1GGCco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:33:15 INFO - Running setup.py (path:/tmp/pip-YX9Xms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:33:15 INFO - Running setup.py (path:/tmp/pip-9K51uX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:33:15 INFO - Running setup.py (path:/tmp/pip-XjcAoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:33:15 INFO - Running setup.py (path:/tmp/pip-HWmfNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:33:15 INFO - Running setup.py (path:/tmp/pip-c50WJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:33:15 INFO - Running setup.py (path:/tmp/pip-O5eZjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:33:15 INFO - Running setup.py (path:/tmp/pip-u5Crwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:33:15 INFO - Running setup.py (path:/tmp/pip-XU724j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:33:15 INFO - Running setup.py (path:/tmp/pip-EnoIfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:33:16 INFO - Running setup.py (path:/tmp/pip-Gsx8Aa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:33:16 INFO - Running setup.py (path:/tmp/pip-mNX7Zu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:33:16 INFO - Running setup.py (path:/tmp/pip-qbKHun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:33:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:33:16 INFO - Running setup.py install for manifestparser 13:33:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:33:16 INFO - Running setup.py install for mozcrash 13:33:16 INFO - Running setup.py install for mozdebug 13:33:16 INFO - Running setup.py install for mozdevice 13:33:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:33:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:33:16 INFO - Running setup.py install for mozfile 13:33:16 INFO - Running setup.py install for mozhttpd 13:33:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:33:16 INFO - Running setup.py install for mozinfo 13:33:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:33:16 INFO - Running setup.py install for mozInstall 13:33:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:33:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:33:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:33:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:33:17 INFO - Running setup.py install for mozleak 13:33:17 INFO - Running setup.py install for mozlog 13:33:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:33:17 INFO - Running setup.py install for moznetwork 13:33:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:33:17 INFO - Running setup.py install for mozprocess 13:33:17 INFO - Running setup.py install for mozprofile 13:33:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:33:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:33:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:33:17 INFO - Running setup.py install for mozrunner 13:33:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:33:17 INFO - Running setup.py install for mozscreenshot 13:33:17 INFO - Running setup.py install for moztest 13:33:17 INFO - Running setup.py install for mozversion 13:33:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:33:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:33:18 INFO - Cleaning up... 13:33:18 INFO - Return code: 0 13:33:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:33:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:18 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 0x7f26fda7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd83ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd80f60>, '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 0xd81d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd821d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1478899964.651136-216517208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:33:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:33:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:33:18 INFO - Using env: {'DISPLAY': ':0', 13:33:18 INFO - 'HOME': '/home/cltbld', 13:33:18 INFO - 'LANG': 'en_US.UTF-8', 13:33:18 INFO - 'LANGUAGE': 'en_US:en', 13:33:18 INFO - 'LOGNAME': 'cltbld', 13:33:18 INFO - 'MAIL': '/var/mail/cltbld', 13:33:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:18 INFO - 'MOZ_NO_REMOTE': '1', 13:33:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:18 INFO - 'NO_EM_RESTART': '1', 13:33:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:18 INFO - 'PWD': '/builds/slave/test', 13:33:18 INFO - 'SHELL': '/bin/bash', 13:33:18 INFO - 'SHLVL': '1', 13:33:18 INFO - 'TERM': 'linux', 13:33:18 INFO - 'TMOUT': '86400', 13:33:18 INFO - 'USER': 'cltbld', 13:33:18 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478899964.651136-216517208', 13:33:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:18 INFO - '_': '/tools/buildbot/bin/python'} 13:33:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:33:18 INFO - Running setup.py (path:/tmp/pip-VBl2Ev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:33:18 INFO - Running setup.py (path:/tmp/pip-OomnnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:33:18 INFO - Running setup.py (path:/tmp/pip-SJDudJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:33:18 INFO - Running setup.py (path:/tmp/pip-bIzI3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:33:18 INFO - Running setup.py (path:/tmp/pip-49p9By-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:33:18 INFO - Running setup.py (path:/tmp/pip-uEdk6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:33:18 INFO - Running setup.py (path:/tmp/pip-4HT_o_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:33:18 INFO - Running setup.py (path:/tmp/pip-IjddT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:33:18 INFO - Running setup.py (path:/tmp/pip-RIZm2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:33:18 INFO - Running setup.py (path:/tmp/pip-p1p0OT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:33:19 INFO - Running setup.py (path:/tmp/pip-vUTQx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:33:19 INFO - Running setup.py (path:/tmp/pip-lcPfxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:33:19 INFO - Running setup.py (path:/tmp/pip-mDAstP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:33:19 INFO - Running setup.py (path:/tmp/pip-Sjc1jX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:33:19 INFO - Running setup.py (path:/tmp/pip-K6B0zs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:33:19 INFO - Running setup.py (path:/tmp/pip-hPH8pj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:33:19 INFO - Running setup.py (path:/tmp/pip-y_MnVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:33:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:21 INFO - Downloading blessings-1.6.tar.gz 13:33:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:33:21 INFO - Installing collected packages: blessings 13:33:21 INFO - Running setup.py install for blessings 13:33:21 INFO - Successfully installed blessings 13:33:21 INFO - Cleaning up... 13:33:21 INFO - Return code: 0 13:33:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:33:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:33:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:33:21 INFO - Reading from file tmpfile_stdout 13:33:21 INFO - Current package versions: 13:33:21 INFO - argparse == 1.2.1 13:33:21 INFO - blessings == 1.6 13:33:21 INFO - blobuploader == 1.2.4 13:33:21 INFO - docopt == 0.6.1 13:33:21 INFO - functools32 == 3.2.3-2 13:33:21 INFO - jsonschema == 2.5.1 13:33:21 INFO - manifestparser == 1.1 13:33:21 INFO - mozInstall == 1.12 13:33:21 INFO - mozcrash == 1.0 13:33:21 INFO - mozdebug == 0.1 13:33:21 INFO - mozdevice == 0.48 13:33:21 INFO - mozfile == 1.2 13:33:21 INFO - mozhttpd == 0.7 13:33:21 INFO - mozinfo == 0.9 13:33:21 INFO - mozleak == 0.1 13:33:21 INFO - mozlog == 3.4 13:33:21 INFO - moznetwork == 0.27 13:33:21 INFO - mozprocess == 0.23 13:33:21 INFO - mozprofile == 0.28 13:33:21 INFO - mozrunner == 6.13 13:33:21 INFO - mozscreenshot == 0.1 13:33:21 INFO - mozsystemmonitor == 0.3 13:33:21 INFO - moztest == 0.7 13:33:21 INFO - mozversion == 1.4 13:33:21 INFO - psutil == 3.1.1 13:33:21 INFO - requests == 1.2.3 13:33:21 INFO - wsgiref == 0.1.2 13:33:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:33:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:21 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 0x7f26fda7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd83ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd80f60>, '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 0xd81d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd821d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1478899964.651136-216517208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:33:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:33:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:33:21 INFO - Using env: {'DISPLAY': ':0', 13:33:21 INFO - 'HOME': '/home/cltbld', 13:33:21 INFO - 'LANG': 'en_US.UTF-8', 13:33:21 INFO - 'LANGUAGE': 'en_US:en', 13:33:21 INFO - 'LOGNAME': 'cltbld', 13:33:21 INFO - 'MAIL': '/var/mail/cltbld', 13:33:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:21 INFO - 'MOZ_NO_REMOTE': '1', 13:33:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:21 INFO - 'NO_EM_RESTART': '1', 13:33:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:21 INFO - 'PWD': '/builds/slave/test', 13:33:21 INFO - 'SHELL': '/bin/bash', 13:33:21 INFO - 'SHLVL': '1', 13:33:21 INFO - 'TERM': 'linux', 13:33:21 INFO - 'TMOUT': '86400', 13:33:21 INFO - 'USER': 'cltbld', 13:33:21 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478899964.651136-216517208', 13:33:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:21 INFO - '_': '/tools/buildbot/bin/python'} 13:33:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:33:22 INFO - Cleaning up... 13:33:22 INFO - Return code: 0 13:33:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:33:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f26fda7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd83ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd80f60>, '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 0xd81d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd821d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1478899964.651136-216517208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:33:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:33:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:33:22 INFO - Using env: {'DISPLAY': ':0', 13:33:22 INFO - 'HOME': '/home/cltbld', 13:33:22 INFO - 'LANG': 'en_US.UTF-8', 13:33:22 INFO - 'LANGUAGE': 'en_US:en', 13:33:22 INFO - 'LOGNAME': 'cltbld', 13:33:22 INFO - 'MAIL': '/var/mail/cltbld', 13:33:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:22 INFO - 'MOZ_NO_REMOTE': '1', 13:33:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:22 INFO - 'NO_EM_RESTART': '1', 13:33:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:22 INFO - 'PWD': '/builds/slave/test', 13:33:22 INFO - 'SHELL': '/bin/bash', 13:33:22 INFO - 'SHLVL': '1', 13:33:22 INFO - 'TERM': 'linux', 13:33:22 INFO - 'TMOUT': '86400', 13:33:22 INFO - 'USER': 'cltbld', 13:33:22 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478899964.651136-216517208', 13:33:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:22 INFO - '_': '/tools/buildbot/bin/python'} 13:33:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:33:22 INFO - Cleaning up... 13:33:22 INFO - Return code: 0 13:33:22 INFO - Running post-action listener: _resource_record_post_action 13:33:22 INFO - Running post-action listener: _start_resource_monitoring 13:33:22 INFO - Starting resource monitoring. 13:33:22 INFO - [mozharness: 2016-11-11 21:33:22.461944Z] Finished create-virtualenv step (success) 13:33:22 INFO - [mozharness: 2016-11-11 21:33:22.462403Z] Running install step. 13:33:22 INFO - Running pre-action listener: _resource_record_pre_action 13:33:22 INFO - Running main action method: install 13:33:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:33:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:33:22 INFO - Reading from file tmpfile_stdout 13:33:22 INFO - Detecting whether we're running mozinstall >=1.0... 13:33:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:33:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:33:22 INFO - Reading from file tmpfile_stdout 13:33:22 INFO - Output received: 13:33:22 INFO - Usage: mozinstall [options] installer 13:33:22 INFO - Options: 13:33:22 INFO - -h, --help show this help message and exit 13:33:22 INFO - -d DEST, --destination=DEST 13:33:22 INFO - Directory to install application into. [default: 13:33:22 INFO - "/builds/slave/test"] 13:33:22 INFO - --app=APP Application being installed. [default: firefox] 13:33:22 INFO - mkdir: /builds/slave/test/build/application 13:33:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:33:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:33:38 INFO - Reading from file tmpfile_stdout 13:33:38 INFO - Output received: 13:33:38 INFO - /builds/slave/test/build/application/firefox/firefox 13:33:38 INFO - Running post-action listener: _resource_record_post_action 13:33:38 INFO - [mozharness: 2016-11-11 21:33:38.801187Z] Finished install step (success) 13:33:38 INFO - [mozharness: 2016-11-11 21:33:38.801523Z] Running run-tests step. 13:33:38 INFO - Running pre-action listener: _resource_record_pre_action 13:33:38 INFO - Running main action method: run_tests 13:33:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:33:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:33:38 INFO - Python 2.7.3 13:33:38 INFO - Return code: 0 13:33:38 INFO - grabbing minidump binary from tooltool 13:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:38 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 0xd80f60>, '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 0xd81d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd821d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:33:38 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:33:38 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:33:38 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:33:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:33:38 INFO - Return code: 0 13:33:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:33:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:33:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:33:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:33:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:33:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P6g5w_AbSoiQv2t87mNMpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:33:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/P6g5w_AbSoiQv2t87mNMpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:33:38 INFO - Using env: {'DISPLAY': ':0', 13:33:38 INFO - 'HOME': '/home/cltbld', 13:33:38 INFO - 'LANG': 'en_US.UTF-8', 13:33:38 INFO - 'LANGUAGE': 'en_US:en', 13:33:38 INFO - 'LOGNAME': 'cltbld', 13:33:38 INFO - 'MAIL': '/var/mail/cltbld', 13:33:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:33:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:33:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:38 INFO - 'MOZ_NO_REMOTE': '1', 13:33:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:33:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:38 INFO - 'NO_EM_RESTART': '1', 13:33:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:38 INFO - 'PWD': '/builds/slave/test', 13:33:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:33:38 INFO - 'SHELL': '/bin/bash', 13:33:38 INFO - 'SHLVL': '1', 13:33:38 INFO - 'TERM': 'linux', 13:33:38 INFO - 'TMOUT': '86400', 13:33:38 INFO - 'USER': 'cltbld', 13:33:38 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478899964.651136-216517208', 13:33:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:38 INFO - '_': '/tools/buildbot/bin/python'} 13:33:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P6g5w_AbSoiQv2t87mNMpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:33:39 INFO - mozversion application_buildid: 20161111113020 13:33:39 INFO - mozversion application_changeset: 1edd75c67df0fb5e03f4746ae238603f03129807 13:33:39 INFO - mozversion application_display_name: Nightly 13:33:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:33:39 INFO - mozversion application_name: Firefox 13:33:39 INFO - mozversion application_remotingname: firefox 13:33:39 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 13:33:39 INFO - mozversion application_vendor: Mozilla 13:33:39 INFO - mozversion application_version: 52.0a1 13:33:39 INFO - mozversion platform_buildid: 20161111113020 13:33:39 INFO - mozversion platform_changeset: 1edd75c67df0fb5e03f4746ae238603f03129807 13:33:39 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 13:33:39 INFO - mozversion platform_version: 52.0a1 13:33:39 INFO - using testdate: 1478900019 13:33:39 INFO - actual date: 1478900019 13:33:39 INFO - starting webserver on 'localhost:36299' 13:33:39 INFO - SUITE-START | Running 2 tests 13:33:39 INFO - TEST-START | dromaeo_css 13:33:39 INFO - operating with platform_type : linux_ 13:33:39 INFO - Initialising browser for dromaeo_css test... 13:33:39 INFO - TEST-INFO | started process 31268 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfaWzKN/profile http://localhost:36299/getInfo.html) 13:33:43 INFO - PROCESS | 31268 | __metrics Screen width/height:1600/1200 13:33:43 INFO - PROCESS | 31268 | colorDepth:24 13:33:43 INFO - PROCESS | 31268 | Browser inner width/height: 1024/697 13:33:43 INFO - PROCESS | 31268 | __metrics 13:33:43 INFO - PROCESS | 31268 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:33:43 INFO - PROCESS | 31268 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:33:44 INFO - PROCESS | 31268 | console.error: PushService: 13:33:44 INFO - PROCESS | 31268 | stateChangeProcessEnqueue: Error transitioning state 13:33:44 INFO - PROCESS | 31268 | UnknownError 13:33:45 INFO - TEST-INFO | 31268: exit 0 13:33:45 INFO - Browser initialized. 13:33:45 INFO - Running cycle 1/1 for dromaeo_css test... 13:33:45 INFO - TEST-INFO | started process 31350 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfaWzKN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:33:57 INFO - PROCESS | 31350 | RSS: Main: 176340992 13:33:57 INFO - PROCESS | 31350 | 13:34:48 INFO - PROCESS | 31350 | 1478900088268 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] 13:37:01 INFO - PROCESS | 31350 | Cycle 1(1): loaded http://localhost:36299/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36299/tests/dromaeo/cssquery-ext.html) 13:37:04 INFO - PROCESS | 31350 | RSS: Main: 404197376 13:37:04 INFO - PROCESS | 31350 | 13:40:07 INFO - PROCESS | 31350 | Cycle 1(1): loaded http://localhost:36299/tests/dromaeo/cssquery-ext.html (next: http://localhost:36299/tests/dromaeo/cssquery-jquery.html) 13:40:08 INFO - PROCESS | 31350 | RSS: Main: 284946432 13:40:08 INFO - PROCESS | 31350 | 13:43:10 INFO - PROCESS | 31350 | Cycle 1(1): loaded http://localhost:36299/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36299/tests/dromaeo/cssquery-mootools.html) 13:43:10 INFO - PROCESS | 31350 | RSS: Main: 220672000 13:43:10 INFO - PROCESS | 31350 | 13:46:13 INFO - PROCESS | 31350 | Cycle 1(1): loaded http://localhost:36299/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36299/tests/dromaeo/cssquery-prototype.html) 13:46:13 INFO - PROCESS | 31350 | RSS: Main: 222519296 13:46:13 INFO - PROCESS | 31350 | 13:49:16 INFO - PROCESS | 31350 | Cycle 1(1): loaded http://localhost:36299/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36299/tests/dromaeo/cssquery-yui.html) 13:49:17 INFO - PROCESS | 31350 | RSS: Main: 222674944 13:49:17 INFO - PROCESS | 31350 | 13:52:20 INFO - PROCESS | 31350 | Cycle 1(1): loaded http://localhost:36299/tests/dromaeo/cssquery-yui.html (next: http://localhost:36299/tests/dromaeo/cssquery-dojo.html) 13:52:21 INFO - PROCESS | 31350 | RSS: Main: 306540544 13:52:21 INFO - PROCESS | 31350 | 13:52:21 INFO - PROCESS | 31350 | __start_tp_report 13:52:21 INFO - PROCESS | 31350 | _x_x_mozilla_page_load 13:52:21 INFO - PROCESS | 31350 | _x_x_mozilla_page_load_details 13:52:21 INFO - PROCESS | 31350 | |i|pagename|runs| 13:52:21 INFO - PROCESS | 31350 | |0;dojo.html;2580.34201278674;2598.9220323390305;2621.6853977522696;2624.8950041998323;2639.564471862143;4662.766861656921;4706.458757242918;4740.4548476925165;4779.665423420362;4795.736234507101;4736.71579705217;4756.5243475652505;4795.640326975474;4826.3725715657;4846.539578740014;4309.978450107745;4327.718698284617;4366.0831225442535;4366.519682834885;4386.1008493258805;4406.449193850769;4415.624671902876;4416.138852923681;4442.555744425547;4480.932786008212;4291.356296555542;4413.602775750198;4416.072624748806;4428.6678499112695;4520.434945631796;4307.181635489247;4317.913641727179;4362.149380870732;4362.280223763075;4373.343998400233;4332.631726303268;4340.175366680321;4359.149965756678;4389.429374181336;4395.7142785718825;4718.339432479455;4722.338872557844;4742.075295317414;4744.501827308118;4747.810087596492;4953.4798846121;5008.073506401327;5009.624278179152;5060.2662613920775;5074.162763144077;5148.2535032420465;5169.4572069932865;5175.197844334134;5203.557697595709;5219.112750832368;4805.087033463631;4822.373091498082;4822.758862056883;4824.34871292378;4869.488703686133;5043.041822053871;5095.210242412432;5268.4994925482015;5272.578193744491;5273.683578985273;4873.074115918035;4913.0173965207105;4914.65597408178;4957.752112394366;4976.328195693535;5000.89998200034;5003.399592048978;5007;5008.373953255843;5060.1903695408555;4928.408590969107;4950.603951683856;4967.726775027409;4968.6025117990475;4970.72661003641;4885.877853053631;4940.431850337257;4940.654154209243;4980.427250866197;4980.701157930535;4282.164977829293;4296.076343586144;4321.416608757841;4406.383106365111;4408.470983482002;3783.50814394127;3794.886153415402;3796.52543432071;3826.1199924017633;3831.7317787755146;4433.556644335541;4438.201123797683;4443.688941774045;4444.222261104358;4481.103779244164;4994.850154495371;5051.06555287273;5056.089903817348;5131.820386286462;5190.377154741455;4441.156180325728;4443.244648409778;4464.955350446519;4489.169503641837;4493.7977790999485;4536.637069034469;4583.954160458353;4597.287420449836;4604.493505714368;4649.814007439732;4580.88547786308;4686.765661716969;4696.412948381452;4768.904621907612;4769.35613692161;5040.873978150576;5054.16606259963;5056.544910958031;5057.797688092435;5058.291839142449;4721.055788842176;4731.668783185144;4732.19552676039;4760;4767.904641907212;4998.225275082368;5000.524950129732;5002.174641184164;5002.574781143643;5004.224345226496;5031.371078615173;5062.987402519584;5076.035553244872;5080.339555857862;5082.618803589671;4896.290037944549;4915.1644220481885;4915.557599816034;4919.114559379346;4919.311296418433;4914.36113305268;4937.21004639256;4976.8755781105765;4984.825531106394;5012.8496145115705;4924.064427758714;4931.901361972812;4934.777934992862;4937.802487900587;4979.775910083982;4847.95152048475;5023.748812559431;5038.193888977746;5042.319286896369;5083.92374114396;4794.904101917872;4891.31521586971;4928.950710492993;4933.038057578738;4995.300657907968 13:52:21 INFO - PROCESS | 31350 | |1;ext.html;559.8908212898484;562.7945799783081;574.5202755698991;578.5920925747348;593.4273426143776;27758.583621245696;30320.696793032064;30333.241668958286;30354.696453035434;38374.616253837456;35457.46813797795;38974.415383769265;39036.41445378322;39055.41416878742;39078.41382379267;7571.583562904052;7709.807254818618;7714.922850771504;7718.53688778675;7718.8456230875345;7348.5958272295;7551.320381165694;7572.97764801753;7574.128975167871;7613.809654758647;9604.3757155785;9838.360506567085;9843.557039933221;10103.545340459697;10110.140638045776;9719.805603887919;9783.070608292237;9798.510074496318;9803.705888823346;9805.558749856273;9689.51552422383;9737.853932191023;9742.805143897152;9758.170555502791;9760.316777825556;36287.81856090729;36561.634383656354;36564.451533227024;36578.451323230176;36753;2850.6721727001245;2850.985745071282;2855.9428811423863;2866.312085099561;2921.1528656689534;26900.327491812666;27415.314617134532;27450.176494704992;27695.723042769518;27963.012891565053;3412.1640198151363;3450.879219227315;3494.633063528344;3561.0919215600115;3572.8928132155816;171016;171021;171177;171473;171493;50062.749686251336;50546.49453505492;50564.74717626462;50597.49402506001;50639.746801265755;27020.324491887466;27563.173104806887;27618.309542261602;27752.167434976982;27769.16692499228;14995.875309351843;15093.39626414953;15153;15158.696826063417;15171.393144274105;11535.480903359368;11645.825312620318;11651.417429128509;11651.825222621668;11659.18385712992;14749.631259218391;15341.156236407105;16693.081880496688;17264.74102888458;17565.297388104587;6669.333066693292;6890.31096890317;6912.101426814482;6955.582665040114;7080.504364694422;722.1695050691746;727.6434547072002;791.6279348706099;892.0722448653457;894.3962825093037;24090.27729168128;25506.74493255044;25588.232353029438;25724.099656512306;25729.09948151843;887.4409122252939;893.3210759822582;915.0986278515657;962.3215632978873;992.5533509920565;12693.873061269454;13437.932810335886;13722.382492787849;13726;13730.794038089436;336100;337351;338106;338618;339019;45183.09633807305;45481.54518454773;45633;45642;45663.771681141385;1031.8916513766096;1042.1923009667569;1045.0542259255235;1157.6121999130216;1191.4042978510745;25381.619275711248;27078;27094.72905271001;29284.707152928197;29986.25034374158;43982.56017439913;44605.55394446014;44685.776571116934;44708.55291447044;44723.77638111789;301968;303964;303978;304165;304659;23144.884275578515;23369;23704.762952370256;23782.762172378054;24129.155479558834;32673.34653306873;40767.796161019;43156.78421607872;44451.11097778091;45237.54762452334;32466.18834529061;33493.497597536545;34228.14429639279;34344.82827585846;37745.62254377531;33227.335453291285;33329.83335083406;33838;33876.49185262273;34008.65991340055;33292.667073329925;33878;33898.49152262669;33941;34455;29221.269468263465;30872;30987.84506077455;31162;31286.245650522083;23860.42093685961;24211.75788242095;24533.754662453146;24565.38586535351;24606.630900536147 13:52:21 INFO - PROCESS | 31350 | |2;jquery.html;325.18054502653297;332.6108453109861;334.87944340037575;338.5750882642284;342.77034386960736;15496.845031549667;15528.999999999985;16715.331386744514;16967.15164241786;17067.231974561142;16457.341706331732;16772.748408773878;16830.579235519086;17140.314387424518;17147.342161964916;4777.378940737699;4822.252550854606;4966.404031516223;4988.875278118058;4990.426100998396;4887.242477415988;4961.156603377434;4967;4978.327925730035;4981;4725.598324142435;4862.756862156895;4909.50904909508;4921.163402221613;4933.161362568354;4896.43690975537;4910.140725373063;4950.059488697136;4953.232249001392;4957.752112394366;4235;4302.096559722462;4314.892127696801;4327.718698284633;4361.934570981438;16486.917565412215;16505.917470412573;17987.910060449743;19437.514062148417;19744.30894918671;1806.4400035988754;1824.4526642007345;2015.6371853066441;2432.2338463383976;2470.17249221511;12377.93811030948;12449.564265250672;12770.297633630147;13071.281079540622;13150.408231629599;1584.3583348743662;1643.4740882917472;1679.8152203257632;1690.704126777809;1725.7066298729246;57824;69221;69801;71216;71653.28346716466;9116.49859257734;9131.908680913106;9333.533323333806;10397.232470480036;10489.527971241312;13594.660133496742;13598.32008399576;13610.659733506742;13615.31923403826;13619.114757540729;7030.578165309996;7372.299631534996;7439.404847612286;7562.205968373351;7567.545947243183;6931.133608298963;6956.686949087303;6959.130108736408;7332.376747976482;7394.5932973685885;4119.938200926988;4200.075983283673;4283.485981682155;4362;4370.077166046929;1731.89608623483;1814.23802003159;1827.1047186878334;1833.9633207335778;1855.2578968412472;643.954923155384;779.5283853268804;796.0964305513169;816.4611356504679;888.6667499687617;16027.358905643878;16108.19459027044;16367.836321636869;16597.095508286002;17288;774.4501404003108;820.1101804542019;823.97940051498;865.6321063547967;866.1122349591593;9193.218576420946;9273.72178834636;9481.146696797321;9546.18857397115;9552.14030737223;290855;297521;298517.5222371666;364609;366463;80187;84644.57677711573;85704.57147714346;85931;86699.13300867037;896.7040876510736;897.5467388968659;935.0742764663071;944.8488241881266;952.4523399045577;15406.152661603272;15444.613884652974;16119.194040298173;16394.09832459226;16432.917835410746;37268.254634907695;37272.81363593165;37401;37951.430728538544;38488.80755596204;53348.46651533435;53696.1945570809;54196.45803542072;55085.449145508035;56131;7261.201267860425;7324.450666200163;7419.627368936764;7548.131964823896;7619.733309334147;7711.575863327571;9606.375585586915;11475.483603237708;12100.636980890587;12549.686257843261;9973.351732137387;10412.739681507719;10446.582136714447;10522.579096836347;10598.2581219317;10094.596216151273;10406.687799366031;10504.947475262576;10509.474526273809;10674.62638807638;5511.834644960658;10144.289899707244;10324.535395907353;10449.111825494918;10645.89354106449;7240.936333145029;7368.852622947618;7374.483786134919;7384.298491643285;7390.334869861738;8776.780580485283;10087.596496140366;10149.137323327304;10504.527296271533;10559 13:52:21 INFO - PROCESS | 31350 | |3;mootools.html;1297.844258688957;1358.5245164192531;1382.536850155198;1616.644338245587;1635.8609518190947;6445.4843612511;6827.52207345486;6832.2826103259185;6838.487113466491;6846.794596162111;5990.8801823963495;6169.969150154243;6695.129633147684;6699.028640847074;6894.44844412447;2029.8883561404116;2049.047193055229;2053.969190462144;2063.47381417739;2063.7007633893077;2004.589059242859;2033.8271246944028;2035.9694604580943;2064.143380497092;2070;1746.2316580704448;1821.6720990221754;1990.5222746540799;2002.5594369238745;2062.06176189834;2022.8988550572412;2036.4806974221478;2039.4289598912328;2043.7956204379443;2044.6932960055963;1988.0358026357205;2047.488127968008;2088.6658134698528;2091.550316681921;2115.153938424627;6760.222574403908;6820.829479263009;6831.521793474459;6851.9657401713175;6901.896471552931;4156.293430116857;4270.957290427118;4273.67947403946;4282.143571285724;4283.271843786564;2742.149933520615;2876.8417737024456;2932;2981.4037192561573;2997.430488207234;838.6058552480324;887.0641473245723;888.0808363343973;888.595688961521;888.7822483491522;9009.144131307516;9080.863787043265;9089.545522723838;9114.954425227832;9119.996800351955;3540.858365665396;3568.7323450741296;3619.2399596084592;3626.8549258029384;3674.475092836443;7918.2477664621765;7918.881216781753;7921.881171782428;7923.16806735296;7925.8811117833275;4212.578742125763;4213.410122582841;4215;4215.009472773896;4221.345691417835;3716.1452865841006;3795.8481660733814;3811.4092315691114;3840.1551658635613;3841.1741475582885;3187.187267246837;3307.9007629770663;3402;3443.0875817908272;3451.482277658321;1055.9788804223872;1082.658962426833;1086.239632257423;1086.8043752124536;1086.9347839129678;613.4325748682451;821.5440430561096;823.7364043506141;825.8307047055339;848.9235968762841;4877.561019508261;4940.542539950723;4948.05986862495;5022.397312322471;5140.588752899834;395.7210166832376;395.79814294709905;396.8412634945987;397.2234281978782;413.33246806407436;3264.281857991238;3336.366090442808;3371.8482668279985;3374.8818791342187;3455.2225749206227;7951.244631759973;8175.63209655567;8307.08622051574;8307.709230176915;8308.792280192923;7957.124716281204;8255.133211012877;8276.503409795432;8279.379046571532;8284.46151000183;6385.106085148083;6526.6084034959;6531.477481801445;6532.967335163294;6535.738570457223;4893.535114164149;4973.328600638867;5115.2071428928575;5128.256402821645;5156.56169225605;7582.317591416799;7749.302562769378;7805.531668099932;7806.41451891099;7835.725749598737;7708.229177082247;7851.568163751049;7901.644426000728;7907.2488113629115;7933.1670174630835;6095.847603809941;6236.781712640036;6237.376262373727;6239.0953311770445;6244.0321750128805;6706.731730730911;6708.19501659804;6717;6763.5941843489545;6797.89803152963;6203.255609326729;6208;6213.65824879636;6232.376762323913;6256.687165641609;5946.613470124428;6000.549958753024;6024.277086749618;6032.819015429544;6145.66198859067;5571.832845014656;5724.084146536534;5726.112452569859;5770.2498675171955;5798.420157984167;4059.817308221196;4123.6701063914215;4164.292070347988;4208.284591619371;4309.353596960481;4146.606072423115;4155.293600087932;4163.687723420695;4174.728642638219;4302.548232435549 13:52:21 INFO - PROCESS | 31350 | |4;prototype.html;260.7301443006488;261.8808442158818;267.49977541996464;268.3961087553006;289.9489351102253;4638.884027899304;4798.976005119974;4852.708837469754;4895.192293271606;4969.701817890929;4700.835470758524;4831.154547954103;4841.927371089437;4853.708777473354;4858.198397264456;3772.3775577029824;3774.075351538877;3789.4126410406293;3802.676772474343;3812.3137835189655;3798.791066491342;3804.565078349858;3805.219929914375;3808.1241314497684;3823.98664353945;3557.573091229056;3739.5699494558066;3740.7007439404783;3766.6045065268163;3771.358868992264;3723.720720945926;3740.8877733668032;3744.831482583263;3753.84984600617;3757.229767897574;3239.676032396765;3267.281198136406;3271.9509207361907;3274.5579346788354;3290.128116049249;4721.95278047222;4758.78585463655;4764.97553026101;4771.260454629503;4782.952170478286;4069.877903662895;4245.257080010986;4252.2345977724;4261.808218630169;4283.614474697261;5026.84919452417;5045.495450454961;5047.520485553867;5079.288899554065;5089.57491902268;3542.8759993400363;3543.486194501783;3547.255076433952;3547.290541891632;3566.144125409883;5017.84946451607;5317.41508434072;5320.042392369372;5342.385625653022;5370.677759334413;3554.147004718849;3566.270358875943;3569.6787289144104;3606.3508568457405;3613.7831730096277;3641.198936234024;3642.21692336149;3650.5071815304595;3653.50677658518;3660.4875317455576;3992.3612222044335;4090.734102283342;4094.7747873867224;4230.936535951963;4243.193793179286;4825.710457372569;4859.805607775649;5014.473480284591;5037.19404895215;5113.437521872591;1180.321315243721;1200.8619008813923;1211.6062279759115;1220.3227208899145;1222.7860124478182;789.3093543149744;810.6959890041235;833.7873842170208;836.6277006732067;847.1951645936385;4351.36905148758;4356.564343565618;4363.52001279859;4369.541198174146;4380.912381752347;4982.950170498321;5062.063518249136;5077.339945807095;5078.289039534468;5118.206677964921;4360.084382279757;4364.607185353333;4379.605835474823;4382.912341753211;4405.163019026375;2587.9223623290954;2725.4004119093765;2732.904348347798;2745.643066401355;2780.8887644493993;4831.613470922388;4843.297721830315;4854.708717476963;4874.268859671007;4887.902241955141;5030.84907452777;5210.895782084337;5252.448492908266;5325.074306266688;5361.651492652965;4911.533404326583;4936.580390666833;4938.135826230324;4940.555350018516;4944.728039957837;5253.789848406021;5263.947360526346;5270.947290527046;5340.279062326536;5347.572194224531;4933.703977761345;5131.717755523333;5176.818811341585;5204.661696989683;5242.554382877498;4936.58039066669;4955.876103097307;4958.826441074545;4972.911377221648;5013.373328333958;3512.9824350878084;3521.295740851891;3541.7520773545602;3562.4300111981956;3578.373784587635;4832.540908613676;5029;5329.333833270841;5334.266363431978;5345.278387417804;5065.924011139909;5074.543291103819;5084.449417771149;5097.286379906742;5125.8718532037;5072.644914855925;5076.82231121909;5091.796328146833;5130.948690513047;5170.276161337491;4820.9517904821905;4974.825881094144;4980.377452818398;5012.398512178562;5022.799088036584;5080.669756465818;5092.159793634157;5100.413452452867;5105.33630628016;5123.590112791042;4981.576565991786;4988.825391111293;4989.650724449254;5047.772850221675;5061.974690126526 13:52:21 INFO - PROCESS | 31350 | |5;yui.html;625.784104483953;641.9293877673455;647.3332467558416;706.0010085728694;739.1352118021914;12420.130590858644;13008.804867926965;13204.933975330134;13217.074804763659;13610.251436171007;13498.595042148727;13636.522721704743;13647.93176034121;13648.112872663294;13661.316934153303;617.7405489694316;756.1719916691228;779.672537534237;782.5539442517767;783.2246076384367;632.5698525002996;748.2031636307315;770.1797585571377;775.255754475704;781.0042196199834;816.6447595296036;820.2986446588171;821.4126899267023;822.4284122534841;824.4105464592815;638.7604648256904;815.9306458950966;816.0819078536616;816.2531283875247;816.9183081691842;482.7875734676766;569.6183557016767;589.1516216648013;594.9167116603679;595.961262517935;13000.609981700563;13045.217286962812;13052.28212448315;13057.542985995444;13072.019598530149;10580.57677692899;10600.575976960912;10679.092277156451;10794.892051079467;11119.221654484189;9451.243900487945;9517.476538790364;10827.296225745302;11080.667579972614;11121.777564448746;3173.5239714042846;3252.788568743048;3267.967320326814;3330.28107333386;3355.6644335566248;46792.7660361696;48740.75629621865;48822;48941.658751187606;49008.264876026886;9214.170724634814;9399.295052871063;9563.521823908915;9744.269179811543;9875.259355548362;16695.16524173811;16702.749458758128;16784.832151678325;16857.15714214309;16989.150542472828;6080.665563393967;6149.200603921461;6170.7223174957235;6176.536759743038;6177.1969643945995;3215.437298472758;3278.5737854078816;3300.6204286506877;3337.132345590164;3469.681521022046;2730.5494593392264;2802.215379693689;2814.043225303407;2820.1539538138477;2823.7035111313426;458.94263217097864;523.9973800130975;541.2773946781012;553.4023254884714;559.6446256627071;539.4794023767083;594.2927915780208;604.6674329118968;606.9817905462843;612.2897438970862;7134.964325178341;7385.70626995511;8376.539290338967;8460.492370457792;8542.829143417097;582.3797655496883;600.8107446154447;606.3663471672113;606.7391021860642;624.572168064877;3592.892213233607;3635.5092062571744;3706.0179052551093;3823.655870971626;3872.0900588361715;39904;59995;60030.39969600248;61815;62759.6862015687;54425.455745442036;55037.174442383395;55537.72231138899;56268.718656407276;57321.71339143278;49818.750906245965;49838.50161498411;50707.23939140916;53575.19637205445;53653;7948.324392426477;8211.137830527947;8212.712555060783;8248.381371397048;8494.74515764528;36378;36632.81683591565;37069.44395834119;37258.44112338263;37582;46689.76655116703;46758;47243.763781180875;48041;51169.48830511647;10475.924522280362;10641.361518308926;10668.946655266674;10681.145508359157;10875;11625.941870290595;11807.527698891949;11865.228760130563;12440.97537723629;12467.812982805084;10636.202284828514;10650;10763.246572739834;11611.6516504505;12209.633710988684;10443.840805442538;10887.618933337295;11316.717082073013;11495.310281383145;12051.397430128283;11288.717782055513;11921.403929803302;12053.216540925163;12112.697182570506;12147.939260303641;9085.818283634158;9331.55665161795;9512.381695190068;9540.379875308083;9865.609803637313;9319.6272149116;9547.713568592953;9637.662681806103;9649.9035009649;9691.9030809691 13:52:21 INFO - PROCESS | 31350 | __end_tp_report 13:52:21 INFO - PROCESS | 31350 | __start_cc_report 13:52:21 INFO - PROCESS | 31350 | _x_x_mozilla_cycle_collect,2749 13:52:21 INFO - PROCESS | 31350 | __end_cc_report 13:52:21 INFO - PROCESS | 31350 | __startTimestamp1478901141077__endTimestamp 13:52:21 INFO - PROCESS | 31350 | 13:52:21 INFO - PROCESS | 31350 | ------- Summary: start ------- 13:52:21 INFO - PROCESS | 31350 | Number of tests: 6 13:52:21 INFO - PROCESS | 31350 | 13:52:21 INFO - PROCESS | 31350 | [#0] dojo.html Cycles:165 Average:4693.84 Median:4824.35 stddev:483.77 (10.0%) stddev-sans-first:455.95 13:52:21 INFO - PROCESS | 31350 | Values: 2580.3 2598.9 2621.7 2624.9 2639.6 4662.8 4706.5 4740.5 4779.7 4795.7 4736.7 4756.5 4795.6 4826.4 4846.5 4310.0 4327.7 4366.1 4366.5 4386.1 4406.4 4415.6 4416.1 4442.6 4480.9 4291.4 4413.6 4416.1 4428.7 4520.4 4307.2 4317.9 4362.1 4362.3 4373.3 4332.6 4340.2 4359.1 4389.4 4395.7 4718.3 4722.3 4742.1 4744.5 4747.8 4953.5 5008.1 5009.6 5060.3 5074.2 5148.3 5169.5 5175.2 5203.6 5219.1 4805.1 4822.4 4822.8 4824.3 4869.5 5043.0 5095.2 5268.5 5272.6 5273.7 4873.1 4913.0 4914.7 4957.8 4976.3 5000.9 5003.4 5007.0 5008.4 5060.2 4928.4 4950.6 4967.7 4968.6 4970.7 4885.9 4940.4 4940.7 4980.4 4980.7 4282.2 4296.1 4321.4 4406.4 4408.5 3783.5 3794.9 3796.5 3826.1 3831.7 4433.6 4438.2 4443.7 4444.2 4481.1 4994.9 5051.1 5056.1 5131.8 5190.4 4441.2 4443.2 4465.0 4489.2 4493.8 4536.6 4584.0 4597.3 4604.5 4649.8 4580.9 4686.8 4696.4 4768.9 4769.4 5040.9 5054.2 5056.5 5057.8 5058.3 4721.1 4731.7 4732.2 4760.0 4767.9 4998.2 5000.5 5002.2 5002.6 5004.2 5031.4 5063.0 5076.0 5080.3 5082.6 4896.3 4915.2 4915.6 4919.1 4919.3 4914.4 4937.2 4976.9 4984.8 5012.8 4924.1 4931.9 4934.8 4937.8 4979.8 4848.0 5023.7 5038.2 5042.3 5083.9 4794.9 4891.3 4929.0 4933.0 4995.3 13:52:21 INFO - PROCESS | 31350 | 13:52:21 INFO - PROCESS | 31350 | [#1] ext.html Cycles:180 Average:41877.07 Median:186228.00 stddev:73710.14 (39.6%) stddev-sans-first:73851.64 13:52:21 INFO - PROCESS | 31350 | Values: 559.9 562.8 574.5 578.6 593.4 27758.6 30320.7 30333.2 30354.7 38374.6 35457.5 38974.4 39036.4 39055.4 39078.4 7571.6 7709.8 7714.9 7718.5 7718.8 7348.6 7551.3 7573.0 7574.1 7613.8 9604.4 9838.4 9843.6 10103.5 10110.1 9719.8 9783.1 9798.5 9803.7 9805.6 9689.5 9737.9 9742.8 9758.2 9760.3 36287.8 36561.6 36564.5 36578.5 36753.0 2850.7 2851.0 2855.9 2866.3 2921.2 26900.3 27415.3 27450.2 27695.7 27963.0 3412.2 3450.9 3494.6 3561.1 3572.9 171016.0 171021.0 171177.0 171473.0 171493.0 50062.7 50546.5 50564.7 50597.5 50639.7 27020.3 27563.2 27618.3 27752.2 27769.2 14995.9 15093.4 15153.0 15158.7 15171.4 11535.5 11645.8 11651.4 11651.8 11659.2 14749.6 15341.2 16693.1 17264.7 17565.3 6669.3 6890.3 6912.1 6955.6 7080.5 722.2 727.6 791.6 892.1 894.4 24090.3 25506.7 25588.2 25724.1 25729.1 887.4 893.3 915.1 962.3 992.6 12693.9 13437.9 13722.4 13726.0 13730.8 336100.0 337351.0 338106.0 338618.0 339019.0 45183.1 45481.5 45633.0 45642.0 45663.8 1031.9 1042.2 1045.1 1157.6 1191.4 25381.6 27078.0 27094.7 29284.7 29986.3 43982.6 44605.6 44685.8 44708.6 44723.8 301968.0 303964.0 303978.0 304165.0 304659.0 23144.9 23369.0 23704.8 23782.8 24129.2 32673.3 40767.8 43156.8 44451.1 45237.5 32466.2 33493.5 34228.1 34344.8 37745.6 33227.3 33329.8 33838.0 33876.5 34008.7 33292.7 33878.0 33898.5 33941.0 34455.0 29221.3 30872.0 30987.8 31162.0 31286.2 23860.4 24211.8 24533.8 24565.4 24606.6 13:52:21 INFO - PROCESS | 31350 | 13:52:21 INFO - PROCESS | 31350 | [#2] jquery.html Cycles:180 Average:22623.77 Median:4292.79 stddev:54540.66 (1270.5%) stddev-sans-first:54667.96 13:52:21 INFO - PROCESS | 31350 | Values: 325.2 332.6 334.9 338.6 342.8 15496.8 15529.0 16715.3 16967.2 17067.2 16457.3 16772.7 16830.6 17140.3 17147.3 4777.4 4822.3 4966.4 4988.9 4990.4 4887.2 4961.2 4967.0 4978.3 4981.0 4725.6 4862.8 4909.5 4921.2 4933.2 4896.4 4910.1 4950.1 4953.2 4957.8 4235.0 4302.1 4314.9 4327.7 4361.9 16486.9 16505.9 17987.9 19437.5 19744.3 1806.4 1824.5 2015.6 2432.2 2470.2 12377.9 12449.6 12770.3 13071.3 13150.4 1584.4 1643.5 1679.8 1690.7 1725.7 57824.0 69221.0 69801.0 71216.0 71653.3 9116.5 9131.9 9333.5 10397.2 10489.5 13594.7 13598.3 13610.7 13615.3 13619.1 7030.6 7372.3 7439.4 7562.2 7567.5 6931.1 6956.7 6959.1 7332.4 7394.6 4119.9 4200.1 4283.5 4362.0 4370.1 1731.9 1814.2 1827.1 1834.0 1855.3 644.0 779.5 796.1 816.5 888.7 16027.4 16108.2 16367.8 16597.1 17288.0 774.5 820.1 824.0 865.6 866.1 9193.2 9273.7 9481.1 9546.2 9552.1 290855.0 297521.0 298517.5 364609.0 366463.0 80187.0 84644.6 85704.6 85931.0 86699.1 896.7 897.5 935.1 944.8 952.5 15406.2 15444.6 16119.2 16394.1 16432.9 37268.3 37272.8 37401.0 37951.4 38488.8 53348.5 53696.2 54196.5 55085.4 56131.0 7261.2 7324.5 7419.6 7548.1 7619.7 7711.6 9606.4 11475.5 12100.6 12549.7 9973.4 10412.7 10446.6 10522.6 10598.3 10094.6 10406.7 10504.9 10509.5 10674.6 5511.8 10144.3 10324.5 10449.1 10645.9 7240.9 7368.9 7374.5 7384.3 7390.3 8776.8 10087.6 10149.1 10504.5 10559.0 13:52:21 INFO - PROCESS | 31350 | 13:52:21 INFO - PROCESS | 31350 | [#3] mootools.html Cycles:180 Average:4588.09 Median:5068.80 stddev:2468.02 (48.7%) stddev-sans-first:2462.56 13:52:21 INFO - PROCESS | 31350 | Values: 1297.8 1358.5 1382.5 1616.6 1635.9 6445.5 6827.5 6832.3 6838.5 6846.8 5990.9 6170.0 6695.1 6699.0 6894.4 2029.9 2049.0 2054.0 2063.5 2063.7 2004.6 2033.8 2036.0 2064.1 2070.0 1746.2 1821.7 1990.5 2002.6 2062.1 2022.9 2036.5 2039.4 2043.8 2044.7 1988.0 2047.5 2088.7 2091.6 2115.2 6760.2 6820.8 6831.5 6852.0 6901.9 4156.3 4271.0 4273.7 4282.1 4283.3 2742.1 2876.8 2932.0 2981.4 2997.4 838.6 887.1 888.1 888.6 888.8 9009.1 9080.9 9089.5 9115.0 9120.0 3540.9 3568.7 3619.2 3626.9 3674.5 7918.2 7918.9 7921.9 7923.2 7925.9 4212.6 4213.4 4215.0 4215.0 4221.3 3716.1 3795.8 3811.4 3840.2 3841.2 3187.2 3307.9 3402.0 3443.1 3451.5 1056.0 1082.7 1086.2 1086.8 1086.9 613.4 821.5 823.7 825.8 848.9 4877.6 4940.5 4948.1 5022.4 5140.6 395.7 395.8 396.8 397.2 413.3 3264.3 3336.4 3371.8 3374.9 3455.2 7951.2 8175.6 8307.1 8307.7 8308.8 7957.1 8255.1 8276.5 8279.4 8284.5 6385.1 6526.6 6531.5 6533.0 6535.7 4893.5 4973.3 5115.2 5128.3 5156.6 7582.3 7749.3 7805.5 7806.4 7835.7 7708.2 7851.6 7901.6 7907.2 7933.2 6095.8 6236.8 6237.4 6239.1 6244.0 6706.7 6708.2 6717.0 6763.6 6797.9 6203.3 6208.0 6213.7 6232.4 6256.7 5946.6 6000.5 6024.3 6032.8 6145.7 5571.8 5724.1 5726.1 5770.2 5798.4 4059.8 4123.7 4164.3 4208.3 4309.4 4146.6 4155.3 4163.7 4174.7 4302.5 13:52:21 INFO - PROCESS | 31350 | 13:52:21 INFO - PROCESS | 31350 | [#4] prototype.html Cycles:180 Average:4178.15 Median:4831.38 stddev:1239.94 (25.7%) stddev-sans-first:1208.05 13:52:21 INFO - PROCESS | 31350 | Values: 260.7 261.9 267.5 268.4 289.9 4638.9 4799.0 4852.7 4895.2 4969.7 4700.8 4831.2 4841.9 4853.7 4858.2 3772.4 3774.1 3789.4 3802.7 3812.3 3798.8 3804.6 3805.2 3808.1 3824.0 3557.6 3739.6 3740.7 3766.6 3771.4 3723.7 3740.9 3744.8 3753.8 3757.2 3239.7 3267.3 3272.0 3274.6 3290.1 4722.0 4758.8 4765.0 4771.3 4783.0 4069.9 4245.3 4252.2 4261.8 4283.6 5026.8 5045.5 5047.5 5079.3 5089.6 3542.9 3543.5 3547.3 3547.3 3566.1 5017.8 5317.4 5320.0 5342.4 5370.7 3554.1 3566.3 3569.7 3606.4 3613.8 3641.2 3642.2 3650.5 3653.5 3660.5 3992.4 4090.7 4094.8 4230.9 4243.2 4825.7 4859.8 5014.5 5037.2 5113.4 1180.3 1200.9 1211.6 1220.3 1222.8 789.3 810.7 833.8 836.6 847.2 4351.4 4356.6 4363.5 4369.5 4380.9 4983.0 5062.1 5077.3 5078.3 5118.2 4360.1 4364.6 4379.6 4382.9 4405.2 2587.9 2725.4 2732.9 2745.6 2780.9 4831.6 4843.3 4854.7 4874.3 4887.9 5030.8 5210.9 5252.4 5325.1 5361.7 4911.5 4936.6 4938.1 4940.6 4944.7 5253.8 5263.9 5270.9 5340.3 5347.6 4933.7 5131.7 5176.8 5204.7 5242.6 4936.6 4955.9 4958.8 4972.9 5013.4 3513.0 3521.3 3541.8 3562.4 3578.4 4832.5 5029.0 5329.3 5334.3 5345.3 5065.9 5074.5 5084.4 5097.3 5125.9 5072.6 5076.8 5091.8 5130.9 5170.3 4821.0 4974.8 4980.4 5012.4 5022.8 5080.7 5092.2 5100.4 5105.3 5123.6 4981.6 4988.8 4989.7 5047.8 5062.0 13:52:21 INFO - PROCESS | 31350 | 13:52:21 INFO - PROCESS | 31350 | [#5] yui.html Cycles:180 Average:13956.30 Median:49828.63 stddev:16929.42 (34.0%) stddev-sans-first:16947.32 13:52:21 INFO - PROCESS | 31350 | Values: 625.8 641.9 647.3 706.0 739.1 12420.1 13008.8 13204.9 13217.1 13610.3 13498.6 13636.5 13647.9 13648.1 13661.3 617.7 756.2 779.7 782.6 783.2 632.6 748.2 770.2 775.3 781.0 816.6 820.3 821.4 822.4 824.4 638.8 815.9 816.1 816.3 816.9 482.8 569.6 589.2 594.9 596.0 13000.6 13045.2 13052.3 13057.5 13072.0 10580.6 10600.6 10679.1 10794.9 11119.2 9451.2 9517.5 10827.3 11080.7 11121.8 3173.5 3252.8 3268.0 3330.3 3355.7 46792.8 48740.8 48822.0 48941.7 49008.3 9214.2 9399.3 9563.5 9744.3 9875.3 16695.2 16702.7 16784.8 16857.2 16989.2 6080.7 6149.2 6170.7 6176.5 6177.2 3215.4 3278.6 3300.6 3337.1 3469.7 2730.5 2802.2 2814.0 2820.2 2823.7 458.9 524.0 541.3 553.4 559.6 539.5 594.3 604.7 607.0 612.3 7135.0 7385.7 8376.5 8460.5 8542.8 582.4 600.8 606.4 606.7 624.6 3592.9 3635.5 3706.0 3823.7 3872.1 39904.0 59995.0 60030.4 61815.0 62759.7 54425.5 55037.2 55537.7 56268.7 57321.7 49818.8 49838.5 50707.2 53575.2 53653.0 7948.3 8211.1 8212.7 8248.4 8494.7 36378.0 36632.8 37069.4 37258.4 37582.0 46689.8 46758.0 47243.8 48041.0 51169.5 10475.9 10641.4 10668.9 10681.1 10875.0 11625.9 11807.5 11865.2 12441.0 12467.8 10636.2 10650.0 10763.2 11611.7 12209.6 10443.8 10887.6 11316.7 11495.3 12051.4 11288.7 11921.4 12053.2 12112.7 12147.9 9085.8 9331.6 9512.4 9540.4 9865.6 9319.6 9547.7 9637.7 9649.9 9691.9 13:52:21 INFO - PROCESS | 31350 | -------- Summary: end -------- 13:52:21 INFO - PROCESS | 31350 | 13:52:22 INFO - TEST-INFO | 31350: exit 0 13:52:22 INFO - TEST-OK | dromaeo_css | took 1123008ms 13:52:22 INFO - TEST-START | kraken 13:52:22 INFO - operating with platform_type : linux_ 13:52:22 INFO - Initialising browser for kraken test... 13:52:22 INFO - TEST-INFO | started process 31654 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPgnN5n/profile http://localhost:36299/getInfo.html) 13:52:26 INFO - PROCESS | 31654 | __metrics Screen width/height:1600/1200 13:52:26 INFO - PROCESS | 31654 | colorDepth:24 13:52:26 INFO - PROCESS | 31654 | Browser inner width/height: 1024/697 13:52:26 INFO - PROCESS | 31654 | __metrics 13:52:26 INFO - PROCESS | 31654 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:52:26 INFO - PROCESS | 31654 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:52:27 INFO - PROCESS | 31654 | console.error: PushService: 13:52:27 INFO - PROCESS | 31654 | stateChangeProcessEnqueue: Error transitioning state 13:52:27 INFO - PROCESS | 31654 | UnknownError 13:52:28 INFO - TEST-INFO | 31654: exit 0 13:52:28 INFO - Browser initialized. 13:52:28 INFO - Running cycle 1/1 for kraken test... 13:52:28 INFO - TEST-INFO | started process 31738 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPgnN5n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:52:40 INFO - PROCESS | 31738 | RSS: Main: 176332800 13:52:40 INFO - PROCESS | 31738 | 13:52:43 INFO - PROCESS | 31738 | Cycle 1(1): loaded http://localhost:36299/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36299/tests/kraken/driver.html?testName=audio-beat-detection) 13:52:44 INFO - PROCESS | 31738 | RSS: Main: 241721344 13:52:44 INFO - PROCESS | 31738 | 13:52:46 INFO - PROCESS | 31738 | Cycle 1(1): loaded http://localhost:36299/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36299/tests/kraken/driver.html?testName=audio-dft) 13:52:47 INFO - PROCESS | 31738 | RSS: Main: 219660288 13:52:47 INFO - PROCESS | 31738 | 13:52:50 INFO - PROCESS | 31738 | Cycle 1(1): loaded http://localhost:36299/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36299/tests/kraken/driver.html?testName=audio-fft) 13:52:51 INFO - PROCESS | 31738 | RSS: Main: 300630016 13:52:51 INFO - PROCESS | 31738 | 13:52:53 INFO - PROCESS | 31738 | Cycle 1(1): loaded http://localhost:36299/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36299/tests/kraken/driver.html?testName=audio-oscillator) 13:52:54 INFO - PROCESS | 31738 | RSS: Main: 209428480 13:52:54 INFO - PROCESS | 31738 | 13:52:56 INFO - PROCESS | 31738 | Cycle 1(1): loaded http://localhost:36299/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36299/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:52:57 INFO - PROCESS | 31738 | RSS: Main: 215252992 13:52:57 INFO - PROCESS | 31738 | 13:53:00 INFO - PROCESS | 31738 | Cycle 1(1): loaded http://localhost:36299/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36299/tests/kraken/driver.html?testName=imaging-darkroom) 13:53:00 INFO - PROCESS | 31738 | RSS: Main: 250753024 13:53:00 INFO - PROCESS | 31738 | 13:53:04 INFO - PROCESS | 31738 | Cycle 1(1): loaded http://localhost:36299/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36299/tests/kraken/driver.html?testName=imaging-desaturate) 13:53:04 INFO - PROCESS | 31738 | RSS: Main: 250490880 13:53:04 INFO - PROCESS | 31738 | 13:53:07 INFO - PROCESS | 31738 | Cycle 1(1): loaded http://localhost:36299/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36299/tests/kraken/driver.html?testName=json-parse-financial) 13:53:08 INFO - PROCESS | 31738 | RSS: Main: 249688064 13:53:08 INFO - PROCESS | 31738 | 13:53:09 INFO - PROCESS | 31738 | Cycle 1(1): loaded http://localhost:36299/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36299/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:53:10 INFO - PROCESS | 31738 | RSS: Main: 212119552 13:53:10 INFO - PROCESS | 31738 | 13:53:12 INFO - PROCESS | 31738 | Cycle 1(1): loaded http://localhost:36299/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36299/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:53:13 INFO - PROCESS | 31738 | RSS: Main: 219258880 13:53:13 INFO - PROCESS | 31738 | 13:53:15 INFO - PROCESS | 31738 | Cycle 1(1): loaded http://localhost:36299/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36299/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:53:15 INFO - PROCESS | 31738 | RSS: Main: 227659776 13:53:15 INFO - PROCESS | 31738 | 13:53:18 INFO - PROCESS | 31738 | Cycle 1(1): loaded http://localhost:36299/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36299/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:53:19 INFO - PROCESS | 31738 | RSS: Main: 236527616 13:53:19 INFO - PROCESS | 31738 | 13:53:22 INFO - PROCESS | 31738 | Cycle 1(1): loaded http://localhost:36299/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36299/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:53:23 INFO - PROCESS | 31738 | RSS: Main: 232857600 13:53:23 INFO - PROCESS | 31738 | 13:53:24 INFO - PROCESS | 31738 | Cycle 1(1): loaded http://localhost:36299/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36299/tests/kraken/driver.html?testName=ai-astar) 13:53:25 INFO - PROCESS | 31738 | RSS: Main: 283967488 13:53:25 INFO - PROCESS | 31738 | 13:53:25 INFO - PROCESS | 31738 | __start_tp_report 13:53:25 INFO - PROCESS | 31738 | _x_x_mozilla_page_load 13:53:25 INFO - PROCESS | 31738 | _x_x_mozilla_page_load_details 13:53:25 INFO - PROCESS | 31738 | |i|pagename|runs| 13:53:25 INFO - PROCESS | 31738 | |0;ai-astar;108;116;115;115;115;117;116;116;116;115 13:53:25 INFO - PROCESS | 31738 | |1;audio-beat-detection;163;137;131;176;131;131;130;128;160;133 13:53:25 INFO - PROCESS | 31738 | |2;audio-dft;162;161;161;162;160;160;162;161;160;162 13:53:25 INFO - PROCESS | 31738 | |3;audio-fft;77;77;78;102;78;78;77;77;102;77 13:53:25 INFO - PROCESS | 31738 | |4;audio-oscillator;84;84;126;83;83;84;104;84;84;116 13:53:25 INFO - PROCESS | 31738 | |5;imaging-gaussian-blur;118;117;118;118;117;117;117;117;117;117 13:53:25 INFO - PROCESS | 31738 | |6;imaging-darkroom;147;148;146;147;147;147;147;147;147;147 13:53:25 INFO - PROCESS | 31738 | |7;imaging-desaturate;85;84;84;84;84;84;84;85;85;85 13:53:25 INFO - PROCESS | 31738 | |8;json-parse-financial;64;62;64;63;64;64;64;65;64;65 13:53:25 INFO - PROCESS | 31738 | |9;json-stringify-tinderbox;66;66;67;66;67;67;67;66;67;68 13:53:25 INFO - PROCESS | 31738 | |10;stanford-crypto-aes;85;84;83;84;93;83;84;84;84;82 13:53:25 INFO - PROCESS | 31738 | |11;stanford-crypto-ccm;148;143;145;159;142;144;140;140;191;141 13:53:25 INFO - PROCESS | 31738 | |12;stanford-crypto-pbkdf2;180;177;183;178;176;177;176;177;179;183 13:53:25 INFO - PROCESS | 31738 | |13;stanford-crypto-sha256-iterative;70;70;73;69;70;70;69;68;73;69 13:53:25 INFO - PROCESS | 31738 | __end_tp_report 13:53:25 INFO - PROCESS | 31738 | __start_cc_report 13:53:25 INFO - PROCESS | 31738 | _x_x_mozilla_cycle_collect,1988 13:53:25 INFO - PROCESS | 31738 | __end_cc_report 13:53:25 INFO - PROCESS | 31738 | __startTimestamp1478901205222__endTimestamp 13:53:25 INFO - PROCESS | 31738 | 13:53:25 INFO - PROCESS | 31738 | ------- Summary: start ------- 13:53:25 INFO - PROCESS | 31738 | Number of tests: 14 13:53:25 INFO - PROCESS | 31738 | 13:53:25 INFO - PROCESS | 31738 | [#0] ai-astar Cycles:10 Average:114.90 Median:116.00 stddev:2.51 (2.2%) stddev-sans-first:0.71 13:53:25 INFO - PROCESS | 31738 | Values: 108.0 116.0 115.0 115.0 115.0 117.0 116.0 116.0 116.0 115.0 13:53:25 INFO - PROCESS | 31738 | 13:53:25 INFO - PROCESS | 31738 | [#1] audio-beat-detection Cycles:10 Average:142.00 Median:135.00 stddev:17.42 (12.9%) stddev-sans-first:16.73 13:53:25 INFO - PROCESS | 31738 | Values: 163.0 137.0 131.0 176.0 131.0 131.0 130.0 128.0 160.0 133.0 13:53:25 INFO - PROCESS | 31738 | 13:53:25 INFO - PROCESS | 31738 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:0.88 (0.5%) stddev-sans-first:0.87 13:53:25 INFO - PROCESS | 31738 | Values: 162.0 161.0 161.0 162.0 160.0 160.0 162.0 161.0 160.0 162.0 13:53:25 INFO - PROCESS | 31738 | 13:53:25 INFO - PROCESS | 31738 | [#3] audio-fft Cycles:10 Average:82.30 Median:77.00 stddev:10.39 (13.5%) stddev-sans-first:10.84 13:53:25 INFO - PROCESS | 31738 | Values: 77.0 77.0 78.0 102.0 78.0 78.0 77.0 77.0 102.0 77.0 13:53:25 INFO - PROCESS | 31738 | 13:53:25 INFO - PROCESS | 31738 | [#4] audio-oscillator Cycles:10 Average:93.20 Median:84.00 stddev:16.14 (19.2%) stddev-sans-first:16.77 13:53:25 INFO - PROCESS | 31738 | Values: 84.0 84.0 126.0 83.0 83.0 84.0 104.0 84.0 84.0 116.0 13:53:25 INFO - PROCESS | 31738 | 13:53:25 INFO - PROCESS | 31738 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 13:53:25 INFO - PROCESS | 31738 | Values: 118.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 13:53:25 INFO - PROCESS | 31738 | 13:53:25 INFO - PROCESS | 31738 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 13:53:25 INFO - PROCESS | 31738 | Values: 147.0 148.0 146.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 13:53:25 INFO - PROCESS | 31738 | 13:53:25 INFO - PROCESS | 31738 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.50 13:53:25 INFO - PROCESS | 31738 | Values: 85.0 84.0 84.0 84.0 84.0 84.0 84.0 85.0 85.0 85.0 13:53:25 INFO - PROCESS | 31738 | 13:53:25 INFO - PROCESS | 31738 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:64.00 stddev:0.88 (1.4%) stddev-sans-first:0.93 13:53:25 INFO - PROCESS | 31738 | Values: 64.0 62.0 64.0 63.0 64.0 64.0 64.0 65.0 64.0 65.0 13:53:25 INFO - PROCESS | 31738 | 13:53:25 INFO - PROCESS | 31738 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 13:53:25 INFO - PROCESS | 31738 | Values: 66.0 66.0 67.0 66.0 67.0 67.0 67.0 66.0 67.0 68.0 13:53:25 INFO - PROCESS | 31738 | 13:53:25 INFO - PROCESS | 31738 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:84.00 stddev:3.06 (3.6%) stddev-sans-first:3.24 13:53:25 INFO - PROCESS | 31738 | Values: 85.0 84.0 83.0 84.0 93.0 83.0 84.0 84.0 84.0 82.0 13:53:25 INFO - PROCESS | 31738 | 13:53:25 INFO - PROCESS | 31738 | [#11] stanford-crypto-ccm Cycles:10 Average:149.30 Median:144.50 stddev:15.69 (10.9%) stddev-sans-first:16.64 13:53:25 INFO - PROCESS | 31738 | Values: 148.0 143.0 145.0 159.0 142.0 144.0 140.0 140.0 191.0 141.0 13:53:25 INFO - PROCESS | 31738 | 13:53:25 INFO - PROCESS | 31738 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.60 Median:178.50 stddev:2.63 (1.5%) stddev-sans-first:2.74 13:53:25 INFO - PROCESS | 31738 | Values: 180.0 177.0 183.0 178.0 176.0 177.0 176.0 177.0 179.0 183.0 13:53:25 INFO - PROCESS | 31738 | 13:53:25 INFO - PROCESS | 31738 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.00 stddev:1.66 (2.4%) stddev-sans-first:1.76 13:53:25 INFO - PROCESS | 31738 | Values: 70.0 70.0 73.0 69.0 70.0 70.0 69.0 68.0 73.0 69.0 13:53:25 INFO - PROCESS | 31738 | -------- Summary: end -------- 13:53:25 INFO - PROCESS | 31738 | 13:53:26 INFO - TEST-INFO | 31738: exit 0 13:53:26 INFO - TEST-OK | kraken | took 64472ms 13:53:26 INFO - SUITE-END | took 1187s 13:53:26 INFO - Completed test suite (00:19:47) 13:53:26 INFO - javascript benchmark 13:53:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2580.34201278674, 2598.9220323390305, 2621.6853977522696, 2624.8950041998323, 2639.564471862143, 4662.766861656921, 4706.458757242918, 4740.4548476925165, 4779.665423420362, 4795.736234507101, 4736.71579705217, 4756.5243475652505, 4795.640326975474, 4826.3725715657, 4846.539578740014, 4309.978450107745, 4327.718698284617, 4366.0831225442535, 4366.519682834885, 4386.1008493258805, 4406.449193850769, 4415.624671902876, 4416.138852923681, 4442.555744425547, 4480.932786008212, 4291.356296555542, 4413.602775750198, 4416.072624748806, 4428.6678499112695, 4520.434945631796, 4307.181635489247, 4317.913641727179, 4362.149380870732, 4362.280223763075, 4373.343998400233, 4332.631726303268, 4340.175366680321, 4359.149965756678, 4389.429374181336, 4395.7142785718825, 4718.339432479455, 4722.338872557844, 4742.075295317414, 4744.501827308118, 4747.810087596492, 4953.4798846121, 5008.073506401327, 5009.624278179152, 5060.2662613920775, 5074.162763144077, 5148.2535032420465, 5169.4572069932865, 5175.197844334134, 5203.557697595709, 5219.112750832368, 4805.087033463631, 4822.373091498082, 4822.758862056883, 4824.34871292378, 4869.488703686133, 5043.041822053871, 5095.210242412432, 5268.4994925482015, 5272.578193744491, 5273.683578985273, 4873.074115918035, 4913.0173965207105, 4914.65597408178, 4957.752112394366, 4976.328195693535, 5000.89998200034, 5003.399592048978, 5007.0, 5008.373953255843, 5060.1903695408555, 4928.408590969107, 4950.603951683856, 4967.726775027409, 4968.6025117990475, 4970.72661003641, 4885.877853053631, 4940.431850337257, 4940.654154209243, 4980.427250866197, 4980.701157930535, 4282.164977829293, 4296.076343586144, 4321.416608757841, 4406.383106365111, 4408.470983482002, 3783.50814394127, 3794.886153415402, 3796.52543432071, 3826.1199924017633, 3831.7317787755146, 4433.556644335541, 4438.201123797683, 4443.688941774045, 4444.222261104358, 4481.103779244164, 4994.850154495371, 5051.06555287273, 5056.089903817348, 5131.820386286462, 5190.377154741455, 4441.156180325728, 4443.244648409778, 4464.955350446519, 4489.169503641837, 4493.7977790999485, 4536.637069034469, 4583.954160458353, 4597.287420449836, 4604.493505714368, 4649.814007439732, 4580.88547786308, 4686.765661716969, 4696.412948381452, 4768.904621907612, 4769.35613692161, 5040.873978150576, 5054.16606259963, 5056.544910958031, 5057.797688092435, 5058.291839142449, 4721.055788842176, 4731.668783185144, 4732.19552676039, 4760.0, 4767.904641907212, 4998.225275082368, 5000.524950129732, 5002.174641184164, 5002.574781143643, 5004.224345226496, 5031.371078615173, 5062.987402519584, 5076.035553244872, 5080.339555857862, 5082.618803589671, 4896.290037944549, 4915.1644220481885, 4915.557599816034, 4919.114559379346, 4919.311296418433, 4914.36113305268, 4937.21004639256, 4976.8755781105765, 4984.825531106394, 5012.8496145115705, 4924.064427758714, 4931.901361972812, 4934.777934992862, 4937.802487900587, 4979.775910083982, 4847.95152048475, 5023.748812559431, 5038.193888977746, 5042.319286896369, 5083.92374114396, 4794.904101917872, 4891.31521586971, 4928.950710492993, 4933.038057578738, 4995.300657907968], "value": 4662.860281379615, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.8908212898484, 562.7945799783081, 574.5202755698991, 578.5920925747348, 593.4273426143776, 27758.583621245696, 30320.696793032064, 30333.241668958286, 30354.696453035434, 38374.616253837456, 35457.46813797795, 38974.415383769265, 39036.41445378322, 39055.41416878742, 39078.41382379267, 7571.583562904052, 7709.807254818618, 7714.922850771504, 7718.53688778675, 7718.8456230875345, 7348.5958272295, 7551.320381165694, 7572.97764801753, 7574.128975167871, 7613.809654758647, 9604.3757155785, 9838.360506567085, 9843.557039933221, 10103.545340459697, 10110.140638045776, 9719.805603887919, 9783.070608292237, 9798.510074496318, 9803.705888823346, 9805.558749856273, 9689.51552422383, 9737.853932191023, 9742.805143897152, 9758.170555502791, 9760.316777825556, 36287.81856090729, 36561.634383656354, 36564.451533227024, 36578.451323230176, 36753.0, 2850.6721727001245, 2850.985745071282, 2855.9428811423863, 2866.312085099561, 2921.1528656689534, 26900.327491812666, 27415.314617134532, 27450.176494704992, 27695.723042769518, 27963.012891565053, 3412.1640198151363, 3450.879219227315, 3494.633063528344, 3561.0919215600115, 3572.8928132155816, 171016.0, 171021.0, 171177.0, 171473.0, 171493.0, 50062.749686251336, 50546.49453505492, 50564.74717626462, 50597.49402506001, 50639.746801265755, 27020.324491887466, 27563.173104806887, 27618.309542261602, 27752.167434976982, 27769.16692499228, 14995.875309351843, 15093.39626414953, 15153.0, 15158.696826063417, 15171.393144274105, 11535.480903359368, 11645.825312620318, 11651.417429128509, 11651.825222621668, 11659.18385712992, 14749.631259218391, 15341.156236407105, 16693.081880496688, 17264.74102888458, 17565.297388104587, 6669.333066693292, 6890.31096890317, 6912.101426814482, 6955.582665040114, 7080.504364694422, 722.1695050691746, 727.6434547072002, 791.6279348706099, 892.0722448653457, 894.3962825093037, 24090.27729168128, 25506.74493255044, 25588.232353029438, 25724.099656512306, 25729.09948151843, 887.4409122252939, 893.3210759822582, 915.0986278515657, 962.3215632978873, 992.5533509920565, 12693.873061269454, 13437.932810335886, 13722.382492787849, 13726.0, 13730.794038089436, 336100.0, 337351.0, 338106.0, 338618.0, 339019.0, 45183.09633807305, 45481.54518454773, 45633.0, 45642.0, 45663.771681141385, 1031.8916513766096, 1042.1923009667569, 1045.0542259255235, 1157.6121999130216, 1191.4042978510745, 25381.619275711248, 27078.0, 27094.72905271001, 29284.707152928197, 29986.25034374158, 43982.56017439913, 44605.55394446014, 44685.776571116934, 44708.55291447044, 44723.77638111789, 301968.0, 303964.0, 303978.0, 304165.0, 304659.0, 23144.884275578515, 23369.0, 23704.762952370256, 23782.762172378054, 24129.155479558834, 32673.34653306873, 40767.796161019, 43156.78421607872, 44451.11097778091, 45237.54762452334, 32466.18834529061, 33493.497597536545, 34228.14429639279, 34344.82827585846, 37745.62254377531, 33227.335453291285, 33329.83335083406, 33838.0, 33876.49185262273, 34008.65991340055, 33292.667073329925, 33878.0, 33898.49152262669, 33941.0, 34455.0, 29221.269468263465, 30872.0, 30987.84506077455, 31162.0, 31286.245650522083, 23860.42093685961, 24211.75788242095, 24533.754662453146, 24565.38586535351, 24606.630900536147], "value": 16596.91001547311, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.18054502653297, 332.6108453109861, 334.87944340037575, 338.5750882642284, 342.77034386960736, 15496.845031549667, 15528.999999999985, 16715.331386744514, 16967.15164241786, 17067.231974561142, 16457.341706331732, 16772.748408773878, 16830.579235519086, 17140.314387424518, 17147.342161964916, 4777.378940737699, 4822.252550854606, 4966.404031516223, 4988.875278118058, 4990.426100998396, 4887.242477415988, 4961.156603377434, 4967.0, 4978.327925730035, 4981.0, 4725.598324142435, 4862.756862156895, 4909.50904909508, 4921.163402221613, 4933.161362568354, 4896.43690975537, 4910.140725373063, 4950.059488697136, 4953.232249001392, 4957.752112394366, 4235.0, 4302.096559722462, 4314.892127696801, 4327.718698284633, 4361.934570981438, 16486.917565412215, 16505.917470412573, 17987.910060449743, 19437.514062148417, 19744.30894918671, 1806.4400035988754, 1824.4526642007345, 2015.6371853066441, 2432.2338463383976, 2470.17249221511, 12377.93811030948, 12449.564265250672, 12770.297633630147, 13071.281079540622, 13150.408231629599, 1584.3583348743662, 1643.4740882917472, 1679.8152203257632, 1690.704126777809, 1725.7066298729246, 57824.0, 69221.0, 69801.0, 71216.0, 71653.28346716466, 9116.49859257734, 9131.908680913106, 9333.533323333806, 10397.232470480036, 10489.527971241312, 13594.660133496742, 13598.32008399576, 13610.659733506742, 13615.31923403826, 13619.114757540729, 7030.578165309996, 7372.299631534996, 7439.404847612286, 7562.205968373351, 7567.545947243183, 6931.133608298963, 6956.686949087303, 6959.130108736408, 7332.376747976482, 7394.5932973685885, 4119.938200926988, 4200.075983283673, 4283.485981682155, 4362.0, 4370.077166046929, 1731.89608623483, 1814.23802003159, 1827.1047186878334, 1833.9633207335778, 1855.2578968412472, 643.954923155384, 779.5283853268804, 796.0964305513169, 816.4611356504679, 888.6667499687617, 16027.358905643878, 16108.19459027044, 16367.836321636869, 16597.095508286002, 17288.0, 774.4501404003108, 820.1101804542019, 823.97940051498, 865.6321063547967, 866.1122349591593, 9193.218576420946, 9273.72178834636, 9481.146696797321, 9546.18857397115, 9552.14030737223, 290855.0, 297521.0, 298517.5222371666, 364609.0, 366463.0, 80187.0, 84644.57677711573, 85704.57147714346, 85931.0, 86699.13300867037, 896.7040876510736, 897.5467388968659, 935.0742764663071, 944.8488241881266, 952.4523399045577, 15406.152661603272, 15444.613884652974, 16119.194040298173, 16394.09832459226, 16432.917835410746, 37268.254634907695, 37272.81363593165, 37401.0, 37951.430728538544, 38488.80755596204, 53348.46651533435, 53696.1945570809, 54196.45803542072, 55085.449145508035, 56131.0, 7261.201267860425, 7324.450666200163, 7419.627368936764, 7548.131964823896, 7619.733309334147, 7711.575863327571, 9606.375585586915, 11475.483603237708, 12100.636980890587, 12549.686257843261, 9973.351732137387, 10412.739681507719, 10446.582136714447, 10522.579096836347, 10598.2581219317, 10094.596216151273, 10406.687799366031, 10504.947475262576, 10509.474526273809, 10674.62638807638, 5511.834644960658, 10144.289899707244, 10324.535395907353, 10449.111825494918, 10645.89354106449, 7240.936333145029, 7368.852622947618, 7374.483786134919, 7384.298491643285, 7390.334869861738, 8776.780580485283, 10087.596496140366, 10149.137323327304, 10504.527296271533, 10559.0], "value": 8014.251893428931, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1297.844258688957, 1358.5245164192531, 1382.536850155198, 1616.644338245587, 1635.8609518190947, 6445.4843612511, 6827.52207345486, 6832.2826103259185, 6838.487113466491, 6846.794596162111, 5990.8801823963495, 6169.969150154243, 6695.129633147684, 6699.028640847074, 6894.44844412447, 2029.8883561404116, 2049.047193055229, 2053.969190462144, 2063.47381417739, 2063.7007633893077, 2004.589059242859, 2033.8271246944028, 2035.9694604580943, 2064.143380497092, 2070.0, 1746.2316580704448, 1821.6720990221754, 1990.5222746540799, 2002.5594369238745, 2062.06176189834, 2022.8988550572412, 2036.4806974221478, 2039.4289598912328, 2043.7956204379443, 2044.6932960055963, 1988.0358026357205, 2047.488127968008, 2088.6658134698528, 2091.550316681921, 2115.153938424627, 6760.222574403908, 6820.829479263009, 6831.521793474459, 6851.9657401713175, 6901.896471552931, 4156.293430116857, 4270.957290427118, 4273.67947403946, 4282.143571285724, 4283.271843786564, 2742.149933520615, 2876.8417737024456, 2932.0, 2981.4037192561573, 2997.430488207234, 838.6058552480324, 887.0641473245723, 888.0808363343973, 888.595688961521, 888.7822483491522, 9009.144131307516, 9080.863787043265, 9089.545522723838, 9114.954425227832, 9119.996800351955, 3540.858365665396, 3568.7323450741296, 3619.2399596084592, 3626.8549258029384, 3674.475092836443, 7918.2477664621765, 7918.881216781753, 7921.881171782428, 7923.16806735296, 7925.8811117833275, 4212.578742125763, 4213.410122582841, 4215.0, 4215.009472773896, 4221.345691417835, 3716.1452865841006, 3795.8481660733814, 3811.4092315691114, 3840.1551658635613, 3841.1741475582885, 3187.187267246837, 3307.9007629770663, 3402.0, 3443.0875817908272, 3451.482277658321, 1055.9788804223872, 1082.658962426833, 1086.239632257423, 1086.8043752124536, 1086.9347839129678, 613.4325748682451, 821.5440430561096, 823.7364043506141, 825.8307047055339, 848.9235968762841, 4877.561019508261, 4940.542539950723, 4948.05986862495, 5022.397312322471, 5140.588752899834, 395.7210166832376, 395.79814294709905, 396.8412634945987, 397.2234281978782, 413.33246806407436, 3264.281857991238, 3336.366090442808, 3371.8482668279985, 3374.8818791342187, 3455.2225749206227, 7951.244631759973, 8175.63209655567, 8307.08622051574, 8307.709230176915, 8308.792280192923, 7957.124716281204, 8255.133211012877, 8276.503409795432, 8279.379046571532, 8284.46151000183, 6385.106085148083, 6526.6084034959, 6531.477481801445, 6532.967335163294, 6535.738570457223, 4893.535114164149, 4973.328600638867, 5115.2071428928575, 5128.256402821645, 5156.56169225605, 7582.317591416799, 7749.302562769378, 7805.531668099932, 7806.41451891099, 7835.725749598737, 7708.229177082247, 7851.568163751049, 7901.644426000728, 7907.2488113629115, 7933.1670174630835, 6095.847603809941, 6236.781712640036, 6237.376262373727, 6239.0953311770445, 6244.0321750128805, 6706.731730730911, 6708.19501659804, 6717.0, 6763.5941843489545, 6797.89803152963, 6203.255609326729, 6208.0, 6213.65824879636, 6232.376762323913, 6256.687165641609, 5946.613470124428, 6000.549958753024, 6024.277086749618, 6032.819015429544, 6145.66198859067, 5571.832845014656, 5724.084146536534, 5726.112452569859, 5770.2498675171955, 5798.420157984167, 4059.817308221196, 4123.6701063914215, 4164.292070347988, 4208.284591619371, 4309.353596960481, 4146.606072423115, 4155.293600087932, 4163.687723420695, 4174.728642638219, 4302.548232435549], "value": 3695.211177084323, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [260.7301443006488, 261.8808442158818, 267.49977541996464, 268.3961087553006, 289.9489351102253, 4638.884027899304, 4798.976005119974, 4852.708837469754, 4895.192293271606, 4969.701817890929, 4700.835470758524, 4831.154547954103, 4841.927371089437, 4853.708777473354, 4858.198397264456, 3772.3775577029824, 3774.075351538877, 3789.4126410406293, 3802.676772474343, 3812.3137835189655, 3798.791066491342, 3804.565078349858, 3805.219929914375, 3808.1241314497684, 3823.98664353945, 3557.573091229056, 3739.5699494558066, 3740.7007439404783, 3766.6045065268163, 3771.358868992264, 3723.720720945926, 3740.8877733668032, 3744.831482583263, 3753.84984600617, 3757.229767897574, 3239.676032396765, 3267.281198136406, 3271.9509207361907, 3274.5579346788354, 3290.128116049249, 4721.95278047222, 4758.78585463655, 4764.97553026101, 4771.260454629503, 4782.952170478286, 4069.877903662895, 4245.257080010986, 4252.2345977724, 4261.808218630169, 4283.614474697261, 5026.84919452417, 5045.495450454961, 5047.520485553867, 5079.288899554065, 5089.57491902268, 3542.8759993400363, 3543.486194501783, 3547.255076433952, 3547.290541891632, 3566.144125409883, 5017.84946451607, 5317.41508434072, 5320.042392369372, 5342.385625653022, 5370.677759334413, 3554.147004718849, 3566.270358875943, 3569.6787289144104, 3606.3508568457405, 3613.7831730096277, 3641.198936234024, 3642.21692336149, 3650.5071815304595, 3653.50677658518, 3660.4875317455576, 3992.3612222044335, 4090.734102283342, 4094.7747873867224, 4230.936535951963, 4243.193793179286, 4825.710457372569, 4859.805607775649, 5014.473480284591, 5037.19404895215, 5113.437521872591, 1180.321315243721, 1200.8619008813923, 1211.6062279759115, 1220.3227208899145, 1222.7860124478182, 789.3093543149744, 810.6959890041235, 833.7873842170208, 836.6277006732067, 847.1951645936385, 4351.36905148758, 4356.564343565618, 4363.52001279859, 4369.541198174146, 4380.912381752347, 4982.950170498321, 5062.063518249136, 5077.339945807095, 5078.289039534468, 5118.206677964921, 4360.084382279757, 4364.607185353333, 4379.605835474823, 4382.912341753211, 4405.163019026375, 2587.9223623290954, 2725.4004119093765, 2732.904348347798, 2745.643066401355, 2780.8887644493993, 4831.613470922388, 4843.297721830315, 4854.708717476963, 4874.268859671007, 4887.902241955141, 5030.84907452777, 5210.895782084337, 5252.448492908266, 5325.074306266688, 5361.651492652965, 4911.533404326583, 4936.580390666833, 4938.135826230324, 4940.555350018516, 4944.728039957837, 5253.789848406021, 5263.947360526346, 5270.947290527046, 5340.279062326536, 5347.572194224531, 4933.703977761345, 5131.717755523333, 5176.818811341585, 5204.661696989683, 5242.554382877498, 4936.58039066669, 4955.876103097307, 4958.826441074545, 4972.911377221648, 5013.373328333958, 3512.9824350878084, 3521.295740851891, 3541.7520773545602, 3562.4300111981956, 3578.373784587635, 4832.540908613676, 5029.0, 5329.333833270841, 5334.266363431978, 5345.278387417804, 5065.924011139909, 5074.543291103819, 5084.449417771149, 5097.286379906742, 5125.8718532037, 5072.644914855925, 5076.82231121909, 5091.796328146833, 5130.948690513047, 5170.276161337491, 4820.9517904821905, 4974.825881094144, 4980.377452818398, 5012.398512178562, 5022.799088036584, 5080.669756465818, 5092.159793634157, 5100.413452452867, 5105.33630628016, 5123.590112791042, 4981.576565991786, 4988.825391111293, 4989.650724449254, 5047.772850221675, 5061.974690126526], "value": 3771.0546902454375, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [625.784104483953, 641.9293877673455, 647.3332467558416, 706.0010085728694, 739.1352118021914, 12420.130590858644, 13008.804867926965, 13204.933975330134, 13217.074804763659, 13610.251436171007, 13498.595042148727, 13636.522721704743, 13647.93176034121, 13648.112872663294, 13661.316934153303, 617.7405489694316, 756.1719916691228, 779.672537534237, 782.5539442517767, 783.2246076384367, 632.5698525002996, 748.2031636307315, 770.1797585571377, 775.255754475704, 781.0042196199834, 816.6447595296036, 820.2986446588171, 821.4126899267023, 822.4284122534841, 824.4105464592815, 638.7604648256904, 815.9306458950966, 816.0819078536616, 816.2531283875247, 816.9183081691842, 482.7875734676766, 569.6183557016767, 589.1516216648013, 594.9167116603679, 595.961262517935, 13000.609981700563, 13045.217286962812, 13052.28212448315, 13057.542985995444, 13072.019598530149, 10580.57677692899, 10600.575976960912, 10679.092277156451, 10794.892051079467, 11119.221654484189, 9451.243900487945, 9517.476538790364, 10827.296225745302, 11080.667579972614, 11121.777564448746, 3173.5239714042846, 3252.788568743048, 3267.967320326814, 3330.28107333386, 3355.6644335566248, 46792.7660361696, 48740.75629621865, 48822.0, 48941.658751187606, 49008.264876026886, 9214.170724634814, 9399.295052871063, 9563.521823908915, 9744.269179811543, 9875.259355548362, 16695.16524173811, 16702.749458758128, 16784.832151678325, 16857.15714214309, 16989.150542472828, 6080.665563393967, 6149.200603921461, 6170.7223174957235, 6176.536759743038, 6177.1969643945995, 3215.437298472758, 3278.5737854078816, 3300.6204286506877, 3337.132345590164, 3469.681521022046, 2730.5494593392264, 2802.215379693689, 2814.043225303407, 2820.1539538138477, 2823.7035111313426, 458.94263217097864, 523.9973800130975, 541.2773946781012, 553.4023254884714, 559.6446256627071, 539.4794023767083, 594.2927915780208, 604.6674329118968, 606.9817905462843, 612.2897438970862, 7134.964325178341, 7385.70626995511, 8376.539290338967, 8460.492370457792, 8542.829143417097, 582.3797655496883, 600.8107446154447, 606.3663471672113, 606.7391021860642, 624.572168064877, 3592.892213233607, 3635.5092062571744, 3706.0179052551093, 3823.655870971626, 3872.0900588361715, 39904.0, 59995.0, 60030.39969600248, 61815.0, 62759.6862015687, 54425.455745442036, 55037.174442383395, 55537.72231138899, 56268.718656407276, 57321.71339143278, 49818.750906245965, 49838.50161498411, 50707.23939140916, 53575.19637205445, 53653.0, 7948.324392426477, 8211.137830527947, 8212.712555060783, 8248.381371397048, 8494.74515764528, 36378.0, 36632.81683591565, 37069.44395834119, 37258.44112338263, 37582.0, 46689.76655116703, 46758.0, 47243.763781180875, 48041.0, 51169.48830511647, 10475.924522280362, 10641.361518308926, 10668.946655266674, 10681.145508359157, 10875.0, 11625.941870290595, 11807.527698891949, 11865.228760130563, 12440.97537723629, 12467.812982805084, 10636.202284828514, 10650.0, 10763.246572739834, 11611.6516504505, 12209.633710988684, 10443.840805442538, 10887.618933337295, 11316.717082073013, 11495.310281383145, 12051.397430128283, 11288.717782055513, 11921.403929803302, 12053.216540925163, 12112.697182570506, 12147.939260303641, 9085.818283634158, 9331.55665161795, 9512.381695190068, 9540.379875308083, 9865.609803637313, 9319.6272149116, 9547.713568592953, 9637.662681806103, 9649.9035009649, 9691.9030809691], "value": 6025.159492846872, "unit": "score"}], "name": "dromaeo_css", "value": 6110.9798701064165, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 116.0, 115.0, 115.0, 115.0, 117.0, 116.0, 116.0, 116.0, 115.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 137.0, 131.0, 176.0, 131.0, 131.0, 130.0, 128.0, 160.0, 133.0], "value": 142.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 162.0, 160.0, 160.0, 162.0, 161.0, 160.0, 162.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 78.0, 102.0, 78.0, 78.0, 77.0, 77.0, 102.0, 77.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 126.0, 83.0, 83.0, 84.0, 104.0, 84.0, 84.0, 116.0], "value": 93.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 84.0, 84.0, 84.0, 84.0, 85.0, 85.0, 85.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 64.0, 63.0, 64.0, 64.0, 64.0, 65.0, 64.0, 65.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 66.0, 67.0, 67.0, 67.0, 66.0, 67.0, 68.0], "value": 66.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 83.0, 84.0, 93.0, 83.0, 84.0, 84.0, 84.0, 82.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 143.0, 145.0, 159.0, 142.0, 144.0, 140.0, 140.0, 191.0, 141.0], "value": 149.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 177.0, 183.0, 178.0, 176.0, 177.0, 176.0, 177.0, 179.0, 183.0], "value": 178.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 73.0, 69.0, 70.0, 70.0, 69.0, 68.0, 73.0, 69.0], "value": 70.1, "unit": "score"}], "name": "kraken", "value": 1555.3999999999996, "alertThreshold": 2.0}]} 13:53:26 INFO - Return code: 0 13:53:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:53:27 INFO - # TBPL SUCCESS # 13:53:27 INFO - Running post-action listener: _resource_record_post_action 13:53:27 INFO - [mozharness: 2016-11-11 21:53:27.005694Z] Finished run-tests step (success) 13:53:27 INFO - Running post-run listener: _resource_record_post_run 13:53:27 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 391626752; Read time: 16; Write time: 267632 13:53:27 INFO - TinderboxPrint: CPU usage
13.1% 13:53:27 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 13:53:27 INFO - TinderboxPrint: I/O write bytes / time
391,626,752 / 267,632 13:53:27 INFO - TinderboxPrint: CPU idle
8,350.6 (86.9%) 13:53:27 INFO - TinderboxPrint: CPU user
1,209.2 (12.6%) 13:53:27 INFO - TinderboxPrint: Swap in / out
0 / 0 13:53:27 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 100818944; Read time: 0; Write time: 65696 13:53:27 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 290807808; Read time: 0; Write time: 201936 13:53:27 INFO - Running post-run listener: _upload_blobber_files 13:53:27 INFO - Blob upload gear active. 13:53:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:53:27 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:53:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Larch-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:53:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Larch-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:53:28 INFO - (blobuploader) - INFO - Open directory for files ... 13:53:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:53:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:53:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:53:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:53:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:53:31 INFO - (blobuploader) - INFO - Done attempting. 13:53:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:53:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:53:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:53:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:53:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:53:32 INFO - (blobuploader) - INFO - Done attempting. 13:53:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:53:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:53:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:53:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:53:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:53:32 INFO - (blobuploader) - INFO - Done attempting. 13:53:32 INFO - (blobuploader) - INFO - Iteration through files over. 13:53:32 INFO - Return code: 0 13:53:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:53:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:53:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/590fb33fb50e7936cdcb29249edc70ba406ee214e102abb503387aeddc86b38c9c91a4749972a426acf18f64ce46de30cce60ba65e70c0302edabe4116d0a56d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/663c3e1dbdc2648b55ba472d3feb294f53e109d616a8896b0ef414b045fb0966230cb855c004c7cb13b32d5cfcc5a5aaf96ff44092bb2671f249cc36f46dbd67", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/48311b84c823275fc0a781d6bd87e220a8848cefe933c8f354df8ee33e90d03879f631129cdc09f5492de068e300e711f9edb760a7e159c06cda4ac2f290ed99"} 13:53:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:53:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:53:32 INFO - Contents: 13:53:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/590fb33fb50e7936cdcb29249edc70ba406ee214e102abb503387aeddc86b38c9c91a4749972a426acf18f64ce46de30cce60ba65e70c0302edabe4116d0a56d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/663c3e1dbdc2648b55ba472d3feb294f53e109d616a8896b0ef414b045fb0966230cb855c004c7cb13b32d5cfcc5a5aaf96ff44092bb2671f249cc36f46dbd67", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/48311b84c823275fc0a781d6bd87e220a8848cefe933c8f354df8ee33e90d03879f631129cdc09f5492de068e300e711f9edb760a7e159c06cda4ac2f290ed99"} 13:53:32 INFO - Running post-run listener: copy_logs_to_upload_dir 13:53:32 INFO - Copying logs to upload dir... 13:53:32 INFO - mkdir: /builds/slave/test/build/upload/logs 13:53:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.735902 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-11-11 13:53:32.295011) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-11 13:53:32.298518) ========= 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=20e666a3d4cfbb71505a330e000001b4-1478899964.651136-216517208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/590fb33fb50e7936cdcb29249edc70ba406ee214e102abb503387aeddc86b38c9c91a4749972a426acf18f64ce46de30cce60ba65e70c0302edabe4116d0a56d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/663c3e1dbdc2648b55ba472d3feb294f53e109d616a8896b0ef414b045fb0966230cb855c004c7cb13b32d5cfcc5a5aaf96ff44092bb2671f249cc36f46dbd67", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/48311b84c823275fc0a781d6bd87e220a8848cefe933c8f354df8ee33e90d03879f631129cdc09f5492de068e300e711f9edb760a7e159c06cda4ac2f290ed99"} build_url:https://queue.taskcluster.net/v1/task/P6g5w_AbSoiQv2t87mNMpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011470 build_url: 'https://queue.taskcluster.net/v1/task/P6g5w_AbSoiQv2t87mNMpg/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/Larch-Non-PGO/sha512/590fb33fb50e7936cdcb29249edc70ba406ee214e102abb503387aeddc86b38c9c91a4749972a426acf18f64ce46de30cce60ba65e70c0302edabe4116d0a56d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/663c3e1dbdc2648b55ba472d3feb294f53e109d616a8896b0ef414b045fb0966230cb855c004c7cb13b32d5cfcc5a5aaf96ff44092bb2671f249cc36f46dbd67", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/48311b84c823275fc0a781d6bd87e220a8848cefe933c8f354df8ee33e90d03879f631129cdc09f5492de068e300e711f9edb760a7e159c06cda4ac2f290ed99"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-11 13:53:32.324250) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 13:53:32.324578) ========= 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=20e666a3d4cfbb71505a330e000001b4-1478899964.651136-216517208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004526 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 13:53:32.408949) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-11 13:53:32.409297) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-11 13:53:32.409629) ========= ========= Total master_lag: 0.18 =========