builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-044 starttime: 1482327937.43 results: success (0) buildid: 20161221040853 builduid: 2c1493cdf51e45c397e84a271b21b857 revision: e6ec59a1128a587af3d45b9d529105cee4e1205d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 05:45:37.429359) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 05:45:37.429812) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 05:45:37.430107) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 05:45:37.444778) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 05:45:37.445143) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1482326981.243818-1268270434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-21 05:45:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2016-12-21 05:45:38 (219 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.113284 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 05:45:37.572009) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 05:45:37.572296) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1482326981.243818-1268270434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013319 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 05:45:37.621419) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 05:45:37.621745) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e6ec59a1128a587af3d45b9d529105cee4e1205d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e6ec59a1128a587af3d45b9d529105cee4e1205d --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=88e9d754c8c9af9f7805d7f3000001bd-1482326981.243818-1268270434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-21 05:45:38,533 truncating revision to first 12 chars 2016-12-21 05:45:38,533 Setting DEBUG logging. 2016-12-21 05:45:38,533 attempt 1/10 2016-12-21 05:45:38,533 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/e6ec59a1128a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-21 05:45:38,832 unpacking tar archive at: mozilla-aurora-e6ec59a1128a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.614012 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 05:45:38.249560) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 05:45:38.249976) ========= script_repo_revision: e6ec59a1128a587af3d45b9d529105cee4e1205d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 05:45:38.250414) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 05:45:38.250912) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 05:45:38.282532) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-12-21 05:45:38.283098) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=88e9d754c8c9af9f7805d7f3000001bd-1482326981.243818-1268270434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:45:39 INFO - MultiFileLogger online at 20161221 05:45:39 in /builds/slave/test 05:45:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 05:45:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:45:39 INFO - {'append_to_log': False, 05:45:39 INFO - 'base_work_dir': '/builds/slave/test', 05:45:39 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:45:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:45:39 INFO - 'branch': 'Mozilla-Aurora', 05:45:39 INFO - 'buildbot_json_path': 'buildprops.json', 05:45:39 INFO - 'config_files': ('talos/linux_config.py',), 05:45:39 INFO - 'default_actions': ('clobber', 05:45:39 INFO - 'read-buildbot-config', 05:45:39 INFO - 'download-and-extract', 05:45:39 INFO - 'populate-webroot', 05:45:39 INFO - 'create-virtualenv', 05:45:39 INFO - 'install', 05:45:39 INFO - 'run-tests'), 05:45:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:45:39 INFO - 'download_minidump_stackwalk': True, 05:45:39 INFO - 'download_symbols': 'ondemand', 05:45:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:45:39 INFO - 'tooltool.py': '/tools/tooltool.py', 05:45:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:45:39 INFO - '/tools/misc-python/virtualenv.py')}, 05:45:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:45:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:45:39 INFO - 'installer_path': 'installer.exe', 05:45:39 INFO - 'log_level': 'info', 05:45:39 INFO - 'log_name': 'talos', 05:45:39 INFO - 'log_to_console': True, 05:45:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:45:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:45:39 INFO - 'opt_config_files': (), 05:45:39 INFO - 'pip_index': False, 05:45:39 INFO - 'sps_profile': False, 05:45:39 INFO - 'sps_profile_interval': 0, 05:45:39 INFO - 'suite': 'dromaeojs', 05:45:39 INFO - 'system_bits': '32', 05:45:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:45:39 INFO - 'title': 'talos-linux64-ix-044', 05:45:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:45:39 INFO - 'use_talos_json': True, 05:45:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:45:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:45:39 INFO - 'work_dir': 'build'} 05:45:39 INFO - [mozharness: 2016-12-21 13:45:39.296825Z] Running clobber step. 05:45:39 INFO - Running pre-action listener: _resource_record_pre_action 05:45:39 INFO - Running main action method: clobber 05:45:39 INFO - rmtree: /builds/slave/test/build 05:45:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:45:39 INFO - Running post-action listener: _resource_record_post_action 05:45:39 INFO - [mozharness: 2016-12-21 13:45:39.752268Z] Finished clobber step (success) 05:45:39 INFO - [mozharness: 2016-12-21 13:45:39.752369Z] Running read-buildbot-config step. 05:45:39 INFO - Running pre-action listener: _resource_record_pre_action 05:45:39 INFO - Running main action method: read_buildbot_config 05:45:39 INFO - Using buildbot properties: 05:45:39 INFO - { 05:45:39 INFO - "project": "", 05:45:39 INFO - "product": "firefox", 05:45:39 INFO - "script_repo_revision": "production", 05:45:39 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 05:45:39 INFO - "repository": "", 05:45:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 05:45:39 INFO - "buildid": "20161221040853", 05:45:39 INFO - "pgo_build": "True", 05:45:39 INFO - "basedir": "/builds/slave/test", 05:45:39 INFO - "buildnumber": 970, 05:45:39 INFO - "slavename": "talos-linux64-ix-044", 05:45:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:45:39 INFO - "platform": "ubuntu64_hw", 05:45:39 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 05:45:39 INFO - "branch": "mozilla-aurora", 05:45:39 INFO - "repo_path": "releases/mozilla-aurora", 05:45:39 INFO - "revision": "e6ec59a1128a587af3d45b9d529105cee4e1205d", 05:45:39 INFO - "stage_platform": "linux64-pgo", 05:45:39 INFO - "builduid": "2c1493cdf51e45c397e84a271b21b857", 05:45:39 INFO - "slavebuilddir": "test" 05:45:39 INFO - } 05:45:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/dCt6jV22QwCr1bywOlfViQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 05:45:39 INFO - Running post-action listener: _resource_record_post_action 05:45:39 INFO - [mozharness: 2016-12-21 13:45:39.754824Z] Finished read-buildbot-config step (success) 05:45:39 INFO - [mozharness: 2016-12-21 13:45:39.754912Z] Running download-and-extract step. 05:45:39 INFO - Running pre-action listener: _resource_record_pre_action 05:45:39 INFO - Running main action method: download_and_extract 05:45:39 INFO - mkdir: /builds/slave/test/build/tests 05:45:39 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')]} 05:45:39 INFO - trying https://queue.taskcluster.net/v1/task/dCt6jV22QwCr1bywOlfViQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 05:45:39 INFO - Downloading https://queue.taskcluster.net/v1/task/dCt6jV22QwCr1bywOlfViQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 05:45:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dCt6jV22QwCr1bywOlfViQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:45:40 INFO - Downloaded 1361 bytes. 05:45:40 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 05:45:40 INFO - Using the following test package requirements: 05:45:40 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 05:45:40 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 05:45:40 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 05:45:40 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 05:45:40 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 05:45:40 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 05:45:40 INFO - u'jsshell-linux-x86_64.zip'], 05:45:40 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 05:45:40 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 05:45:40 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 05:45:40 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 05:45:40 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 05:45:40 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 05:45:40 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 05:45:40 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 05:45:40 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 05:45:40 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 05:45:40 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 05:45:40 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:45:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dCt6jV22QwCr1bywOlfViQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 05:45:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dCt6jV22QwCr1bywOlfViQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:45:40 INFO - Fetch https://queue.taskcluster.net/v1/task/dCt6jV22QwCr1bywOlfViQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 05:45:40 INFO - Http code: 200 05:45:40 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 05:45:40 INFO - x-amz-cf-id: Vil9dGaG0Oh0lCoEUX07eOduAto-V39nf2LMpHy3o88R9Jdw2fQ-UQ== 05:45:40 INFO - x-amz-version-id: 9G8Njv547y3uZzG3GsSq1VLhmeO4fCdx 05:45:41 INFO - Expected file size: 21940560 05:45:41 INFO - Obtained file size: 21940560 05:45:45 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:45:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dCt6jV22QwCr1bywOlfViQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 05:45:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dCt6jV22QwCr1bywOlfViQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:45:45 INFO - Fetch https://queue.taskcluster.net/v1/task/dCt6jV22QwCr1bywOlfViQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 05:45:46 INFO - Http code: 200 05:45:46 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 05:45:46 INFO - x-amz-cf-id: 6SwrZD-dPvn8C-xvWIsaYstZZxHAcKIfIFYb610ztecRJtw2bXmS_g== 05:45:46 INFO - x-amz-version-id: 9G8Njv547y3uZzG3GsSq1VLhmeO4fCdx 05:45:46 INFO - Expected file size: 21940560 05:45:46 INFO - Obtained file size: 21940560 05:45:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dCt6jV22QwCr1bywOlfViQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 05:45:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dCt6jV22QwCr1bywOlfViQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:45:51 INFO - Fetch https://queue.taskcluster.net/v1/task/dCt6jV22QwCr1bywOlfViQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 05:45:51 INFO - Http code: 200 05:45:51 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 05:45:51 INFO - x-amz-cf-id: jzTWdrtRM09QDu8fwdK9HnZfsNSK_vzLquiIuQ7M5KVRskzFHysNlw== 05:45:51 INFO - x-amz-version-id: HhqQbtbGfeHGwZmKx4HIJ0IL8QifOARS 05:45:52 INFO - Expected file size: 14409038 05:45:52 INFO - Obtained file size: 14409038 05:45:52 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')]} 05:45:52 INFO - trying https://queue.taskcluster.net/v1/task/dCt6jV22QwCr1bywOlfViQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 05:45:52 INFO - Downloading https://queue.taskcluster.net/v1/task/dCt6jV22QwCr1bywOlfViQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 05:45:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dCt6jV22QwCr1bywOlfViQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:45:55 INFO - Downloaded 63960454 bytes. 05:45:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dCt6jV22QwCr1bywOlfViQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 05:45:55 INFO - mkdir: /builds/slave/test/properties 05:45:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:45:55 INFO - Writing to file /builds/slave/test/properties/build_url 05:45:55 INFO - Contents: 05:45:55 INFO - build_url:https://queue.taskcluster.net/v1/task/dCt6jV22QwCr1bywOlfViQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 05:45:56 INFO - Running post-action listener: _resource_record_post_action 05:45:56 INFO - Running post-action listener: set_extra_try_arguments 05:45:56 INFO - [mozharness: 2016-12-21 13:45:56.396955Z] Finished download-and-extract step (success) 05:45:56 INFO - [mozharness: 2016-12-21 13:45:56.397183Z] Running populate-webroot step. 05:45:56 INFO - Running pre-action listener: _resource_record_pre_action 05:45:56 INFO - Running main action method: populate_webroot 05:45:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:45:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:45:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:45:56 INFO - '--tppagecycles', 05:45:56 INFO - '7'], 05:45:56 INFO - 'tests': ['tsvgm']}}, 05:45:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:45:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:45:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:45:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:45:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:45:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:45:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:56 INFO - 'talos_options': ['--disable-e10s'], 05:45:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:45:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:45:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:56 INFO - 'talos_options': ['--disable-e10s'], 05:45:56 INFO - 'tests': ['damp', 'tps']}, 05:45:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:56 INFO - 'tests': ['damp', 'tps']}, 05:45:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:45:56 INFO - 'tests': ['dromaeo_dom']}, 05:45:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:45:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:45:56 INFO - 'tests': ['basic_compositor_video']}, 05:45:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:45:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:45:56 INFO - 'tests': ['a11yr', 05:45:56 INFO - 'ts_paint', 05:45:56 INFO - 'tpaint', 05:45:56 INFO - 'sessionrestore', 05:45:56 INFO - 'sessionrestore_no_auto_restore', 05:45:56 INFO - 'tabpaint']}, 05:45:56 INFO - 'other-e10s': {'tests': ['a11yr', 05:45:56 INFO - 'ts_paint', 05:45:56 INFO - 'tpaint', 05:45:56 INFO - 'sessionrestore', 05:45:56 INFO - 'sessionrestore_no_auto_restore', 05:45:56 INFO - 'tabpaint']}, 05:45:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:45:56 INFO - 'ts_paint', 05:45:56 INFO - 'tpaint', 05:45:56 INFO - 'sessionrestore', 05:45:56 INFO - 'sessionrestore_no_auto_restore', 05:45:56 INFO - 'tabpaint']}, 05:45:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:45:56 INFO - 'ts_paint', 05:45:56 INFO - 'tpaint', 05:45:56 INFO - 'sessionrestore', 05:45:56 INFO - 'sessionrestore_no_auto_restore', 05:45:56 INFO - 'tabpaint']}, 05:45:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:45:56 INFO - 'tests': ['a11yr', 05:45:56 INFO - 'ts_paint', 05:45:56 INFO - 'tpaint', 05:45:56 INFO - 'sessionrestore', 05:45:56 INFO - 'sessionrestore_no_auto_restore', 05:45:56 INFO - 'tabpaint']}, 05:45:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:45:56 INFO - 'tests': ['a11yr', 05:45:56 INFO - 'ts_paint', 05:45:56 INFO - 'tpaint', 05:45:56 INFO - 'sessionrestore', 05:45:56 INFO - 'sessionrestore_no_auto_restore', 05:45:56 INFO - 'tabpaint']}, 05:45:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:45:56 INFO - 'tests': ['tsvgx', 05:45:56 INFO - 'tsvgr_opacity', 05:45:56 INFO - 'tart', 05:45:56 INFO - 'tscrollx', 05:45:56 INFO - 'cart']}, 05:45:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:45:56 INFO - 'tsvgr_opacity', 05:45:56 INFO - 'tart', 05:45:56 INFO - 'tscrollx', 05:45:56 INFO - 'cart']}, 05:45:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:56 INFO - 'talos_options': ['--disable-e10s'], 05:45:56 INFO - 'tests': ['tp5o']}, 05:45:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:56 INFO - 'tests': ['tp5o']}, 05:45:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:56 INFO - 'talos_options': ['--disable-e10s', 05:45:56 INFO - '--xperf_path', 05:45:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:45:56 INFO - 'tests': ['tp5n']}, 05:45:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:56 INFO - 'talos_options': ['--xperf_path', 05:45:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:45:56 INFO - 'tests': ['tp5n']}}, 05:45:56 INFO - 'talos.zip': {'path': '', 05:45:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:45:56 INFO - Running post-action listener: _resource_record_post_action 05:45:56 INFO - [mozharness: 2016-12-21 13:45:56.414022Z] Finished populate-webroot step (success) 05:45:56 INFO - [mozharness: 2016-12-21 13:45:56.414110Z] Running create-virtualenv step. 05:45:56 INFO - Running pre-action listener: _resource_record_pre_action 05:45:56 INFO - Running main action method: create_virtualenv 05:45:56 INFO - Creating virtualenv /builds/slave/test/build/venv 05:45:56 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 05:45:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:45:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:45:56 INFO - Using real prefix '/usr' 05:45:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:45:57 INFO - Installing distribute.............................................................................................................................................................................................done. 05:45:58 INFO - Installing pip.................done. 05:45:59 INFO - Return code: 0 05:45:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:45:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:45:59 INFO - Reading from file tmpfile_stdout 05:45:59 INFO - Output received: 05:45:59 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) 05:45:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:45:59 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')]} 05:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:59 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')]} 05:45:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:59 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 0x7f7f5b727f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1972ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196ff60>, '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 0x1970d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19711d0>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1482326981.243818-1268270434', '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 05:45:59 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 05:45:59 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 05:45:59 INFO - Using env: {'DISPLAY': ':0', 05:45:59 INFO - 'HOME': '/home/cltbld', 05:45:59 INFO - 'LANG': 'en_US.UTF-8', 05:45:59 INFO - 'LANGUAGE': 'en_US:en', 05:45:59 INFO - 'LOGNAME': 'cltbld', 05:45:59 INFO - 'MAIL': '/var/mail/cltbld', 05:45:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:59 INFO - 'MOZ_NO_REMOTE': '1', 05:45:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:59 INFO - 'NO_EM_RESTART': '1', 05:45:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:59 INFO - 'PWD': '/builds/slave/test', 05:45:59 INFO - 'SHELL': '/bin/bash', 05:45:59 INFO - 'SHLVL': '1', 05:45:59 INFO - 'TERM': 'linux', 05:45:59 INFO - 'TMOUT': '86400', 05:45:59 INFO - 'USER': 'cltbld', 05:45:59 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1482326981.243818-1268270434', 05:45:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:59 INFO - '_': '/tools/buildbot/bin/python'} 05:45:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:59 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 05:45:59 INFO - Cleaning up... 05:45:59 INFO - Return code: 0 05:45:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:45:59 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')]} 05:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:59 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')]} 05:45:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:59 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 0x7f7f5b727f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1972ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196ff60>, '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 0x1970d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19711d0>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1482326981.243818-1268270434', '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 05:45:59 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 05:45:59 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 05:45:59 INFO - Using env: {'DISPLAY': ':0', 05:45:59 INFO - 'HOME': '/home/cltbld', 05:45:59 INFO - 'LANG': 'en_US.UTF-8', 05:45:59 INFO - 'LANGUAGE': 'en_US:en', 05:45:59 INFO - 'LOGNAME': 'cltbld', 05:45:59 INFO - 'MAIL': '/var/mail/cltbld', 05:45:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:59 INFO - 'MOZ_NO_REMOTE': '1', 05:45:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:59 INFO - 'NO_EM_RESTART': '1', 05:45:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:59 INFO - 'PWD': '/builds/slave/test', 05:45:59 INFO - 'SHELL': '/bin/bash', 05:45:59 INFO - 'SHLVL': '1', 05:45:59 INFO - 'TERM': 'linux', 05:45:59 INFO - 'TMOUT': '86400', 05:45:59 INFO - 'USER': 'cltbld', 05:45:59 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1482326981.243818-1268270434', 05:45:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:59 INFO - '_': '/tools/buildbot/bin/python'} 05:45:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:59 INFO - Downloading/unpacking psutil>=3.1.1 05:45:59 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 05:45:59 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 05:45:59 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 05:45:59 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 05:45:59 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 05:45:59 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 05:46:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:46:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:46:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:46:01 INFO - Installing collected packages: psutil 05:46:01 INFO - Running setup.py install for psutil 05:46:01 INFO - building 'psutil._psutil_linux' extension 05:46:01 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 05:46:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:46:02 INFO - building 'psutil._psutil_posix' extension 05:46:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:46:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:46:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:46:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:46:02 INFO - Successfully installed psutil 05:46:02 INFO - Cleaning up... 05:46:02 INFO - Return code: 0 05:46:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:46:02 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')]} 05:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:02 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')]} 05:46:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:02 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 0x7f7f5b727f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1972ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196ff60>, '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 0x1970d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19711d0>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1482326981.243818-1268270434', '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 05:46:02 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 05:46:02 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 05:46:02 INFO - Using env: {'DISPLAY': ':0', 05:46:02 INFO - 'HOME': '/home/cltbld', 05:46:02 INFO - 'LANG': 'en_US.UTF-8', 05:46:02 INFO - 'LANGUAGE': 'en_US:en', 05:46:02 INFO - 'LOGNAME': 'cltbld', 05:46:02 INFO - 'MAIL': '/var/mail/cltbld', 05:46:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:02 INFO - 'MOZ_NO_REMOTE': '1', 05:46:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:02 INFO - 'NO_EM_RESTART': '1', 05:46:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:02 INFO - 'PWD': '/builds/slave/test', 05:46:02 INFO - 'SHELL': '/bin/bash', 05:46:02 INFO - 'SHLVL': '1', 05:46:02 INFO - 'TERM': 'linux', 05:46:02 INFO - 'TMOUT': '86400', 05:46:02 INFO - 'USER': 'cltbld', 05:46:02 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1482326981.243818-1268270434', 05:46:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:02 INFO - '_': '/tools/buildbot/bin/python'} 05:46:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:46:02 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 05:46:02 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 05:46:02 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 05:46:02 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 05:46:02 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 05:46:02 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 05:46:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:46:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:46:04 INFO - Installing collected packages: mozsystemmonitor 05:46:04 INFO - Running setup.py install for mozsystemmonitor 05:46:04 INFO - Successfully installed mozsystemmonitor 05:46:04 INFO - Cleaning up... 05:46:04 INFO - Return code: 0 05:46:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:46:04 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')]} 05:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:04 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')]} 05:46:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:04 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 0x7f7f5b727f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1972ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196ff60>, '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 0x1970d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19711d0>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1482326981.243818-1268270434', '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 05:46:04 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 05:46:04 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 05:46:04 INFO - Using env: {'DISPLAY': ':0', 05:46:04 INFO - 'HOME': '/home/cltbld', 05:46:04 INFO - 'LANG': 'en_US.UTF-8', 05:46:04 INFO - 'LANGUAGE': 'en_US:en', 05:46:04 INFO - 'LOGNAME': 'cltbld', 05:46:04 INFO - 'MAIL': '/var/mail/cltbld', 05:46:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:04 INFO - 'MOZ_NO_REMOTE': '1', 05:46:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:04 INFO - 'NO_EM_RESTART': '1', 05:46:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:04 INFO - 'PWD': '/builds/slave/test', 05:46:04 INFO - 'SHELL': '/bin/bash', 05:46:04 INFO - 'SHLVL': '1', 05:46:04 INFO - 'TERM': 'linux', 05:46:04 INFO - 'TMOUT': '86400', 05:46:04 INFO - 'USER': 'cltbld', 05:46:04 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1482326981.243818-1268270434', 05:46:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:04 INFO - '_': '/tools/buildbot/bin/python'} 05:46:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:04 INFO - Downloading/unpacking jsonschema==2.5.1 05:46:04 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 05:46:04 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 05:46:04 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 05:46:04 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 05:46:04 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 05:46:04 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 05:46:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:46:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:07 INFO - Downloading functools32-3.2.3-2.tar.gz 05:46:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:46:07 INFO - warning: no files found matching '*.txt' 05:46:07 INFO - no previously-included directories found matching 'build' 05:46:07 INFO - no previously-included directories found matching 'dist' 05:46:07 INFO - no previously-included directories found matching '.git*' 05:46:07 INFO - Installing collected packages: jsonschema, functools32 05:46:07 INFO - Running setup.py install for functools32 05:46:07 INFO - warning: no files found matching '*.txt' 05:46:07 INFO - no previously-included directories found matching 'build' 05:46:07 INFO - no previously-included directories found matching 'dist' 05:46:07 INFO - no previously-included directories found matching '.git*' 05:46:07 INFO - Successfully installed jsonschema functools32 05:46:07 INFO - Cleaning up... 05:46:07 INFO - Return code: 0 05:46:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:46:07 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')]} 05:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:07 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')]} 05:46:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:07 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 0x7f7f5b727f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1972ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196ff60>, '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 0x1970d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19711d0>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1482326981.243818-1268270434', '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 05:46:07 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 05:46:07 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 05:46:07 INFO - Using env: {'DISPLAY': ':0', 05:46:07 INFO - 'HOME': '/home/cltbld', 05:46:07 INFO - 'LANG': 'en_US.UTF-8', 05:46:07 INFO - 'LANGUAGE': 'en_US:en', 05:46:07 INFO - 'LOGNAME': 'cltbld', 05:46:07 INFO - 'MAIL': '/var/mail/cltbld', 05:46:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:07 INFO - 'MOZ_NO_REMOTE': '1', 05:46:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:07 INFO - 'NO_EM_RESTART': '1', 05:46:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:07 INFO - 'PWD': '/builds/slave/test', 05:46:07 INFO - 'SHELL': '/bin/bash', 05:46:07 INFO - 'SHLVL': '1', 05:46:07 INFO - 'TERM': 'linux', 05:46:07 INFO - 'TMOUT': '86400', 05:46:07 INFO - 'USER': 'cltbld', 05:46:07 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1482326981.243818-1268270434', 05:46:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:07 INFO - '_': '/tools/buildbot/bin/python'} 05:46:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:46:07 INFO - Cleaning up... 05:46:07 INFO - Return code: 0 05:46:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:46:07 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')]} 05:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:07 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')]} 05:46:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:07 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 0x7f7f5b727f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1972ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196ff60>, '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 0x1970d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19711d0>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1482326981.243818-1268270434', '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 05:46:07 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 05:46:07 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 05:46:07 INFO - Using env: {'DISPLAY': ':0', 05:46:07 INFO - 'HOME': '/home/cltbld', 05:46:07 INFO - 'LANG': 'en_US.UTF-8', 05:46:07 INFO - 'LANGUAGE': 'en_US:en', 05:46:07 INFO - 'LOGNAME': 'cltbld', 05:46:07 INFO - 'MAIL': '/var/mail/cltbld', 05:46:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:07 INFO - 'MOZ_NO_REMOTE': '1', 05:46:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:07 INFO - 'NO_EM_RESTART': '1', 05:46:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:07 INFO - 'PWD': '/builds/slave/test', 05:46:07 INFO - 'SHELL': '/bin/bash', 05:46:07 INFO - 'SHLVL': '1', 05:46:07 INFO - 'TERM': 'linux', 05:46:07 INFO - 'TMOUT': '86400', 05:46:07 INFO - 'USER': 'cltbld', 05:46:07 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1482326981.243818-1268270434', 05:46:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:07 INFO - '_': '/tools/buildbot/bin/python'} 05:46:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:07 INFO - Downloading/unpacking blobuploader==1.2.4 05:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:09 INFO - Downloading blobuploader-1.2.4.tar.gz 05:46:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:46:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:46: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 05:46: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 05:46: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 05:46: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 05:46: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 05:46: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 05:46:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:46:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:46: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 05:46: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 05:46: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 05:46: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 05:46: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 05:46: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 05:46:10 INFO - Downloading docopt-0.6.1.tar.gz 05:46:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:46:10 INFO - Installing collected packages: blobuploader, requests, docopt 05:46:10 INFO - Running setup.py install for blobuploader 05:46:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:46:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:46:10 INFO - Running setup.py install for requests 05:46:11 INFO - Running setup.py install for docopt 05:46:11 INFO - Successfully installed blobuploader requests docopt 05:46:11 INFO - Cleaning up... 05:46:11 INFO - Return code: 0 05:46:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:46: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')]} 05:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46: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')]} 05:46:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:11 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 0x7f7f5b727f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1972ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196ff60>, '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 0x1970d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19711d0>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1482326981.243818-1268270434', '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 05:46:11 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 05:46:11 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 05:46:11 INFO - Using env: {'DISPLAY': ':0', 05:46:11 INFO - 'HOME': '/home/cltbld', 05:46:11 INFO - 'LANG': 'en_US.UTF-8', 05:46:11 INFO - 'LANGUAGE': 'en_US:en', 05:46:11 INFO - 'LOGNAME': 'cltbld', 05:46:11 INFO - 'MAIL': '/var/mail/cltbld', 05:46:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:11 INFO - 'MOZ_NO_REMOTE': '1', 05:46:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:11 INFO - 'NO_EM_RESTART': '1', 05:46:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:11 INFO - 'PWD': '/builds/slave/test', 05:46:11 INFO - 'SHELL': '/bin/bash', 05:46:11 INFO - 'SHLVL': '1', 05:46:11 INFO - 'TERM': 'linux', 05:46:11 INFO - 'TMOUT': '86400', 05:46:11 INFO - 'USER': 'cltbld', 05:46:11 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1482326981.243818-1268270434', 05:46:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:11 INFO - '_': '/tools/buildbot/bin/python'} 05:46:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:46:11 INFO - Running setup.py (path:/tmp/pip-dJLbwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:46:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:46:11 INFO - Running setup.py (path:/tmp/pip-8r48Je-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:46:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:46:11 INFO - Running setup.py (path:/tmp/pip-EvV7aP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:46:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:46:11 INFO - Running setup.py (path:/tmp/pip-UJnV77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:46:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:46:11 INFO - Running setup.py (path:/tmp/pip-yTceoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:46:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:46:11 INFO - Running setup.py (path:/tmp/pip-IyEIrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:46:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:46:11 INFO - Running setup.py (path:/tmp/pip-K3GxnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:46:12 INFO - Running setup.py (path:/tmp/pip-nvg_r_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:46:12 INFO - Running setup.py (path:/tmp/pip-xBLQmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:46:12 INFO - Running setup.py (path:/tmp/pip-bio5XC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:46:12 INFO - Running setup.py (path:/tmp/pip-J5MRgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:46:12 INFO - Running setup.py (path:/tmp/pip-Hsa2YF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:46:12 INFO - Running setup.py (path:/tmp/pip-8tsri0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:46:12 INFO - Running setup.py (path:/tmp/pip-z43rtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:12 INFO - Running setup.py (path:/tmp/pip-mfEqtb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:46:12 INFO - Running setup.py (path:/tmp/pip-VmMfsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:46:12 INFO - Running setup.py (path:/tmp/pip-UaVEte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:46:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:46:12 INFO - Running setup.py install for manifestparser 05:46:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:46:12 INFO - Running setup.py install for mozcrash 05:46:12 INFO - Running setup.py install for mozdebug 05:46:13 INFO - Running setup.py install for mozdevice 05:46:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:46:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:46:13 INFO - Running setup.py install for mozfile 05:46:13 INFO - Running setup.py install for mozhttpd 05:46:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:46:13 INFO - Running setup.py install for mozinfo 05:46:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:46:13 INFO - Running setup.py install for mozInstall 05:46:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:46:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:46:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:46:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:46:13 INFO - Running setup.py install for mozleak 05:46:13 INFO - Running setup.py install for mozlog 05:46:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:46:13 INFO - Running setup.py install for moznetwork 05:46:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:46:13 INFO - Running setup.py install for mozprocess 05:46:14 INFO - Running setup.py install for mozprofile 05:46:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:46:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:46:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:46:14 INFO - Running setup.py install for mozrunner 05:46:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:46:14 INFO - Running setup.py install for mozscreenshot 05:46:14 INFO - Running setup.py install for moztest 05:46:14 INFO - Running setup.py install for mozversion 05:46:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:46:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:46:14 INFO - Cleaning up... 05:46:14 INFO - Return code: 0 05:46:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:46: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')]} 05:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46: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')]} 05:46:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:14 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 0x7f7f5b727f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1972ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196ff60>, '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 0x1970d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19711d0>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1482326981.243818-1268270434', '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 05:46:14 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 05:46:14 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 05:46:14 INFO - Using env: {'DISPLAY': ':0', 05:46:14 INFO - 'HOME': '/home/cltbld', 05:46:14 INFO - 'LANG': 'en_US.UTF-8', 05:46:14 INFO - 'LANGUAGE': 'en_US:en', 05:46:14 INFO - 'LOGNAME': 'cltbld', 05:46:14 INFO - 'MAIL': '/var/mail/cltbld', 05:46:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:14 INFO - 'MOZ_NO_REMOTE': '1', 05:46:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:14 INFO - 'NO_EM_RESTART': '1', 05:46:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:14 INFO - 'PWD': '/builds/slave/test', 05:46:14 INFO - 'SHELL': '/bin/bash', 05:46:14 INFO - 'SHLVL': '1', 05:46:14 INFO - 'TERM': 'linux', 05:46:14 INFO - 'TMOUT': '86400', 05:46:14 INFO - 'USER': 'cltbld', 05:46:14 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1482326981.243818-1268270434', 05:46:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:14 INFO - '_': '/tools/buildbot/bin/python'} 05:46:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:46:14 INFO - Running setup.py (path:/tmp/pip-h_g6SZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:46:14 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)) 05:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:46:14 INFO - Running setup.py (path:/tmp/pip-YP3JEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:46:14 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)) 05:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:46:14 INFO - Running setup.py (path:/tmp/pip-8W8att-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:46:15 INFO - Running setup.py (path:/tmp/pip-gM0Uwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:46:15 INFO - Running setup.py (path:/tmp/pip-evbItW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:46:15 INFO - Running setup.py (path:/tmp/pip-Jd5AqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:46:15 INFO - Running setup.py (path:/tmp/pip-yQ_TO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:46:15 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)) 05:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:46:15 INFO - Running setup.py (path:/tmp/pip-V0DGbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:46:15 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)) 05:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:46:15 INFO - Running setup.py (path:/tmp/pip-89g3Ov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:46:15 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)) 05:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:46:15 INFO - Running setup.py (path:/tmp/pip-heEv7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:46:15 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)) 05:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:46:15 INFO - Running setup.py (path:/tmp/pip-sIxzLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:46:15 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)) 05:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:46:15 INFO - Running setup.py (path:/tmp/pip-zhLXjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:46:15 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)) 05:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:46:15 INFO - Running setup.py (path:/tmp/pip-JMj_nJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:46:15 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)) 05:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:46:15 INFO - Running setup.py (path:/tmp/pip-OmR62R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:46:15 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)) 05:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:15 INFO - Running setup.py (path:/tmp/pip-v2gWL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:15 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)) 05:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:46:15 INFO - Running setup.py (path:/tmp/pip-8i58Ef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:46:15 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)) 05:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:46:15 INFO - Running setup.py (path:/tmp/pip-ZHWT95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:46:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:18 INFO - Downloading blessings-1.6.tar.gz 05:46:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:46:18 INFO - Installing collected packages: blessings 05:46:18 INFO - Running setup.py install for blessings 05:46:18 INFO - Successfully installed blessings 05:46:18 INFO - Cleaning up... 05:46:18 INFO - Return code: 0 05:46:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:46:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:46:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:46:18 INFO - Reading from file tmpfile_stdout 05:46:18 INFO - Current package versions: 05:46:18 INFO - argparse == 1.2.1 05:46:18 INFO - blessings == 1.6 05:46:18 INFO - blobuploader == 1.2.4 05:46:18 INFO - docopt == 0.6.1 05:46:18 INFO - functools32 == 3.2.3-2 05:46:18 INFO - jsonschema == 2.5.1 05:46:18 INFO - manifestparser == 1.1 05:46:18 INFO - mozInstall == 1.12 05:46:18 INFO - mozcrash == 1.0 05:46:18 INFO - mozdebug == 0.1 05:46:18 INFO - mozdevice == 0.48 05:46:18 INFO - mozfile == 1.2 05:46:18 INFO - mozhttpd == 0.7 05:46:18 INFO - mozinfo == 0.9 05:46:18 INFO - mozleak == 0.1 05:46:18 INFO - mozlog == 3.4 05:46:18 INFO - moznetwork == 0.27 05:46:18 INFO - mozprocess == 0.23 05:46:18 INFO - mozprofile == 0.28 05:46:18 INFO - mozrunner == 6.13 05:46:18 INFO - mozscreenshot == 0.1 05:46:18 INFO - mozsystemmonitor == 0.3 05:46:18 INFO - moztest == 0.7 05:46:18 INFO - mozversion == 1.4 05:46:18 INFO - psutil == 3.1.1 05:46:18 INFO - requests == 1.2.3 05:46:18 INFO - wsgiref == 0.1.2 05:46:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:46: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')]} 05:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46: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')]} 05:46:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:18 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 0x7f7f5b727f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1972ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196ff60>, '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 0x1970d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19711d0>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1482326981.243818-1268270434', '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 05:46:18 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 05:46:18 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 05:46:18 INFO - Using env: {'DISPLAY': ':0', 05:46:18 INFO - 'HOME': '/home/cltbld', 05:46:18 INFO - 'LANG': 'en_US.UTF-8', 05:46:18 INFO - 'LANGUAGE': 'en_US:en', 05:46:18 INFO - 'LOGNAME': 'cltbld', 05:46:18 INFO - 'MAIL': '/var/mail/cltbld', 05:46:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:18 INFO - 'MOZ_NO_REMOTE': '1', 05:46:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:18 INFO - 'NO_EM_RESTART': '1', 05:46:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:18 INFO - 'PWD': '/builds/slave/test', 05:46:18 INFO - 'SHELL': '/bin/bash', 05:46:18 INFO - 'SHLVL': '1', 05:46:18 INFO - 'TERM': 'linux', 05:46:18 INFO - 'TMOUT': '86400', 05:46:18 INFO - 'USER': 'cltbld', 05:46:18 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1482326981.243818-1268270434', 05:46:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:18 INFO - '_': '/tools/buildbot/bin/python'} 05:46:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:18 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)) 05:46:18 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)) 05:46:18 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)) 05:46:18 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)) 05:46:18 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)) 05:46:18 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)) 05:46:18 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)) 05:46:18 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)) 05:46:18 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)) 05:46:18 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)) 05:46:18 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)) 05:46:18 INFO - Cleaning up... 05:46:18 INFO - Return code: 0 05:46:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:46: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')]} 05:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46: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')]} 05:46:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:18 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 0x7f7f5b727f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1972ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196ff60>, '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 0x1970d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19711d0>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1482326981.243818-1268270434', '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 05:46:18 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 05:46:18 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 05:46:18 INFO - Using env: {'DISPLAY': ':0', 05:46:18 INFO - 'HOME': '/home/cltbld', 05:46:18 INFO - 'LANG': 'en_US.UTF-8', 05:46:18 INFO - 'LANGUAGE': 'en_US:en', 05:46:18 INFO - 'LOGNAME': 'cltbld', 05:46:18 INFO - 'MAIL': '/var/mail/cltbld', 05:46:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:18 INFO - 'MOZ_NO_REMOTE': '1', 05:46:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:18 INFO - 'NO_EM_RESTART': '1', 05:46:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:18 INFO - 'PWD': '/builds/slave/test', 05:46:18 INFO - 'SHELL': '/bin/bash', 05:46:18 INFO - 'SHLVL': '1', 05:46:18 INFO - 'TERM': 'linux', 05:46:18 INFO - 'TMOUT': '86400', 05:46:18 INFO - 'USER': 'cltbld', 05:46:18 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1482326981.243818-1268270434', 05:46:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:18 INFO - '_': '/tools/buildbot/bin/python'} 05:46:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:46:18 INFO - Cleaning up... 05:46:18 INFO - Return code: 0 05:46:18 INFO - Running post-action listener: _resource_record_post_action 05:46:18 INFO - Running post-action listener: _start_resource_monitoring 05:46:19 INFO - Starting resource monitoring. 05:46:19 INFO - [mozharness: 2016-12-21 13:46:19.016401Z] Finished create-virtualenv step (success) 05:46:19 INFO - [mozharness: 2016-12-21 13:46:19.016859Z] Running install step. 05:46:19 INFO - Running pre-action listener: _resource_record_pre_action 05:46:19 INFO - Running main action method: install 05:46:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:46:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:46:19 INFO - Reading from file tmpfile_stdout 05:46:19 INFO - Detecting whether we're running mozinstall >=1.0... 05:46:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:46:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:46:19 INFO - Reading from file tmpfile_stdout 05:46:19 INFO - Output received: 05:46:19 INFO - Usage: mozinstall [options] installer 05:46:19 INFO - Options: 05:46:19 INFO - -h, --help show this help message and exit 05:46:19 INFO - -d DEST, --destination=DEST 05:46:19 INFO - Directory to install application into. [default: 05:46:19 INFO - "/builds/slave/test"] 05:46:19 INFO - --app=APP Application being installed. [default: firefox] 05:46:19 INFO - mkdir: /builds/slave/test/build/application 05:46:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:46:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:46:35 INFO - Reading from file tmpfile_stdout 05:46:35 INFO - Output received: 05:46:35 INFO - /builds/slave/test/build/application/firefox/firefox 05:46:35 INFO - Running post-action listener: _resource_record_post_action 05:46:35 INFO - [mozharness: 2016-12-21 13:46:35.220903Z] Finished install step (success) 05:46:35 INFO - [mozharness: 2016-12-21 13:46:35.221148Z] Running run-tests step. 05:46:35 INFO - Running pre-action listener: _resource_record_pre_action 05:46:35 INFO - Running main action method: run_tests 05:46:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:46:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:46:35 INFO - Python 2.7.3 05:46:35 INFO - Return code: 0 05:46:35 INFO - grabbing minidump binary from tooltool 05:46:35 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')]} 05:46:35 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 0x196ff60>, '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 0x1970d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19711d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:46:35 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 05:46:35 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 05:46:35 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 05:46:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:46:35 INFO - Return code: 0 05:46:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:46:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:46:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:46:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:46:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:46:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dCt6jV22QwCr1bywOlfViQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 05:46:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dCt6jV22QwCr1bywOlfViQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --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 05:46:35 INFO - Using env: {'DISPLAY': ':0', 05:46:35 INFO - 'HOME': '/home/cltbld', 05:46:35 INFO - 'LANG': 'en_US.UTF-8', 05:46:35 INFO - 'LANGUAGE': 'en_US:en', 05:46:35 INFO - 'LOGNAME': 'cltbld', 05:46:35 INFO - 'MAIL': '/var/mail/cltbld', 05:46:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:46:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:46:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:35 INFO - 'MOZ_NO_REMOTE': '1', 05:46:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:46:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:35 INFO - 'NO_EM_RESTART': '1', 05:46:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:35 INFO - 'PWD': '/builds/slave/test', 05:46:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:46:35 INFO - 'SHELL': '/bin/bash', 05:46:35 INFO - 'SHLVL': '1', 05:46:35 INFO - 'TERM': 'linux', 05:46:35 INFO - 'TMOUT': '86400', 05:46:35 INFO - 'USER': 'cltbld', 05:46:35 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1482326981.243818-1268270434', 05:46:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:35 INFO - '_': '/tools/buildbot/bin/python'} 05:46:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dCt6jV22QwCr1bywOlfViQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 05:46:35 INFO - mozversion application_buildid: 20161221040853 05:46:35 INFO - mozversion application_changeset: e6ec59a1128a587af3d45b9d529105cee4e1205d 05:46:35 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:46:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:46:35 INFO - mozversion application_name: Firefox 05:46:35 INFO - mozversion application_remotingname: firefox-dev 05:46:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:46:35 INFO - mozversion application_vendor: Mozilla 05:46:35 INFO - mozversion application_version: 52.0a2 05:46:35 INFO - mozversion platform_buildid: 20161221040853 05:46:35 INFO - mozversion platform_changeset: e6ec59a1128a587af3d45b9d529105cee4e1205d 05:46:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:46:35 INFO - mozversion platform_version: 52.0a2 05:46:35 INFO - using testdate: 1482327995 05:46:35 INFO - actual date: 1482327995 05:46:35 INFO - starting webserver on 'localhost:47640' 05:46:35 INFO - SUITE-START | Running 2 tests 05:46:35 INFO - TEST-START | dromaeo_css 05:46:35 INFO - operating with platform_type : linux_ 05:46:35 INFO - Initialising browser for dromaeo_css test... 05:46:35 INFO - TEST-INFO | started process 21781 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuZQh6o/profile http://localhost:47640/getInfo.html) 05:46:39 INFO - PROCESS | 21781 | __metrics Screen width/height:1600/1200 05:46:39 INFO - PROCESS | 21781 | colorDepth:24 05:46:39 INFO - PROCESS | 21781 | Browser inner width/height: 1024/697 05:46:39 INFO - PROCESS | 21781 | __metrics 05:46:39 INFO - PROCESS | 21781 | 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" 05:46:39 INFO - PROCESS | 21781 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:46:40 INFO - PROCESS | 21781 | console.error: PushService: 05:46:40 INFO - PROCESS | 21781 | stateChangeProcessEnqueue: Error transitioning state 05:46:40 INFO - PROCESS | 21781 | UnknownError 05:46:40 INFO - TEST-INFO | 21781: exit 0 05:46:40 INFO - Browser initialized. 05:46:40 INFO - Running cycle 1/1 for dromaeo_css test... 05:46:40 INFO - TEST-INFO | started process 21869 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuZQh6o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:46:52 INFO - PROCESS | 21869 | RSS: Main: 144367616 05:46:52 INFO - PROCESS | 21869 | 05:47:44 INFO - PROCESS | 21869 | 1482328064431 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] 05:49:54 INFO - PROCESS | 21869 | Cycle 1(1): loaded http://localhost:47640/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47640/tests/dromaeo/cssquery-ext.html) 05:49:56 INFO - PROCESS | 21869 | RSS: Main: 294936576 05:49:56 INFO - PROCESS | 21869 | 05:52:58 INFO - PROCESS | 21869 | Cycle 1(1): loaded http://localhost:47640/tests/dromaeo/cssquery-ext.html (next: http://localhost:47640/tests/dromaeo/cssquery-jquery.html) 05:52:59 INFO - PROCESS | 21869 | RSS: Main: 233418752 05:52:59 INFO - PROCESS | 21869 | 05:56:01 INFO - PROCESS | 21869 | Cycle 1(1): loaded http://localhost:47640/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47640/tests/dromaeo/cssquery-mootools.html) 05:56:01 INFO - PROCESS | 21869 | RSS: Main: 174202880 05:56:01 INFO - PROCESS | 21869 | 05:59:03 INFO - PROCESS | 21869 | Cycle 1(1): loaded http://localhost:47640/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47640/tests/dromaeo/cssquery-prototype.html) 05:59:04 INFO - PROCESS | 21869 | RSS: Main: 225124352 05:59:04 INFO - PROCESS | 21869 | 06:02:07 INFO - PROCESS | 21869 | Cycle 1(1): loaded http://localhost:47640/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47640/tests/dromaeo/cssquery-yui.html) 06:02:07 INFO - PROCESS | 21869 | RSS: Main: 174010368 06:02:07 INFO - PROCESS | 21869 | 06:05:10 INFO - PROCESS | 21869 | Cycle 1(1): loaded http://localhost:47640/tests/dromaeo/cssquery-yui.html (next: http://localhost:47640/tests/dromaeo/cssquery-dojo.html) 06:05:10 INFO - PROCESS | 21869 | RSS: Main: 264171520 06:05:10 INFO - PROCESS | 21869 | 06:05:10 INFO - PROCESS | 21869 | __start_tp_report 06:05:10 INFO - PROCESS | 21869 | _x_x_mozilla_page_load 06:05:10 INFO - PROCESS | 21869 | _x_x_mozilla_page_load_details 06:05:10 INFO - PROCESS | 21869 | |i|pagename|runs| 06:05:10 INFO - PROCESS | 21869 | |0;dojo.html;3233.3371658809947;3248.139243100578;3276.459384201607;3302.4055669979425;3322.8172450515212;5544.556435485161;5586.162075688649;5631.774729010845;5634.436556344363;5651.8021869234635;5573.136163894593;5663.9433605663935;5664.858378540539;5668.234788303578;5699.800506982246;5111;5126.384833819947;5133.922991155136;5166.870828229286;5197.272381866523;5000.549950504454;5011.473795251501;5235.528802407783;5239.345081864767;5243.86890327741;5105.923411148836;5110.437851836314;5133.768980395891;5154.484551544834;5158.484151584849;5189.091908915943;5206.921896171561;5250.65870718402;5267.446918073624;5291.973540132313;5003.174476211457;5104.25988231708;5179.352580927384;5215.687058776448;5235.136202526579;5510.779568817243;5513.724313784295;5519.503244707996;5543.36251331094;5543.77824887004;5940.61386009908;5941.19793827832;5946.226990491252;6013.6993150342305;6023.69881505923;6050.183225264577;6066.636001839904;6080.0271956487195;6088.634681919099;6103.725332360054;5449.863753406157;5476.096444086761;5483.287172667528;5619.578531610146;5662.122371032497;6218.409251121137;6253.499720022387;6262.5929314594405;6263.311035786151;6266.592671476339;5996.850078748066;6006.819795406145;6007.879842403215;6017.252051676225;6052.12244224585;5871.794487192928;5936.079907614327;5943.989521781307;6003.159557661931;6088.786892458743;6010.308814486302;6026;6031.366706495843;6044.727987240584;6050.848728781728;5965.671888046112;5982.970085149634;6023.668698221552;6025.698715064229;6047.879042419127;4530.954690453053;4559.977200113978;4610.884727881829;4676.929846052312;4683.578477937002;4115.97942010294;4137.97931010343;4139.317012692872;4169.583041695867;4178.331466965271;5728.598998070179;5729.742161602738;5731.111677689964;5735.627184233012;5755.194272801811;5875.853103672357;5930.258717660293;6018.247719035121;6028.246469191351;6031.60794548353;5675.574331925122;5696.174054762119;5728.656280623092;5737.426257374229;5794.797182098607;5120.8719782005;5160.535551800356;5162.432132465426;5172.094883395466;5186.481351864859;6251.062340648939;6316.9368306317265;6322.272938612026;6333.176687030748;6341.334159913327;5824.650520968586;5869.06095024794;5981.611195272293;6003.42967418112;6115.816525504242;6313.96843015782;6345.936540634534;6351.491880649629;6354.618722876642;6364.554481186273;6004.0693692477735;6005.789797357246;6007.459328660441;6008.969955150196;6017.699115044143;5853.151293062568;5936.495397891227;5995.46040856325;6063.090536419572;6123.4488895999575;5873.618214816023;5936.257967754031;5944.851378715393;5953.880922381615;5968.313643931004;5929.110633405024;5942.970285148546;5945.078512830518;5946.316173640087;5946.494547963472;5860.853478663067;5907.793227237026;5911.763529458945;5919.7040147991565;5926.940730592639;5739.110437882135;5765.798197063083;5820.126980952721;5880.294364676266;5887.941120588739;5753.942460575508;5797.623154494944;5802.187693722966;5810.041343178328;5817.825465236049 06:05:10 INFO - PROCESS | 21869 | |1;ext.html;568.8122919436586;614.5882258886545;641.3938827807721;661.6327937994412;673.3737624009669;32752.836235818817;44707;45452.77273613636;45497.31754023688;48813.51186488143;44868;45286.0942781145;45327.77336113323;45366.319505207364;45911.77044114783;8286.627101780434;8773.912260877389;8908.242799362062;8912.24245939096;8917.95541022294;8227.712030078948;10411.635592754255;10653.627123050655;10659.733506662318;10979.396133212671;10824.079953203987;10872.565097396095;10880.12958963285;10898.782024359509;10907.672769816878;10557.366558006544;10612.893871061306;10638.734031649194;10679.305845120081;10696.732581685443;10527.263091583593;10589.417582032986;10643.095336896373;10662.253642245047;10670.093042091432;41571;41755.1648967019;41899;41931.79034104841;41943.1611367771;3511.6488351164935;3552.6802587767224;3575.5530558680166;3585.2112535242204;3702.4816525686424;31836.20409489758;32136.517952230733;32215.19462013445;32371.676283237102;32871.67128328734;4127.731697439687;4162.354835000579;4178.289690752579;4189.790510474464;4275.5724427557;360404;360964;361087;362899;364244;37682.24635507275;62360;62838.68580657068;62869.428264292845;62904;38064.809675952;40340.39489407661;40406.39390409087;40452.79773601172;40500;16311.184440777914;16415.753763693556;16418.507444776675;16433.09617971023;16444.588885277964;12028.63914082579;12147.878521214852;13442.731145377038;13738.900887928941;13804.102733322503;9310.906890931139;9343.34596578233;9458.57436415363;9551.90448095524;9563.426194428357;3520.4015317396106;3578.5526809148855;3586.067622418138;3608.0619039050034;3620.7646502977223;1012.8784545854545;1029.7785976015193;1106.6071544601712;1114.1755101225035;1131.179894576442;33248.501272480935;33290.167745806546;33327.018754299694;33349;33633.831830841176;1128.8250321200228;1170.8302296167178;1176.3823992403886;1178.269472926791;1182.8166634171716;16863.91568042152;17710;17720.556986075193;17969.281228750966;17991.280348786164;510323;515291;515331;516484;516622;61014.389856101756;61572;61596.07605885915;61736.69131654313;61780.69109654513;1291.0897817038965;1340.6581321762887;1343.2813444807177;1419.1626940105386;1436.4756863744658;28823.85588072046;34559;34794.65205347914;37417.812910935274;37475.81262093672;57530.712346438;57641.42358576528;58072.41927580839;58213.70893145507;58314.7084264576;446582;448907;450030.24833634467;450570;451389;29775.70224297729;30971.69028309688;31246.68753312438;37795.62204377921;38230;45109.548904511845;47783.5221647793;47808.04383912233;51324.74337628288;52809.47190528046;42370;42913;43477.56522434735;43869.34195986999;43965.36207827541;42278.365824513276;43486.56513434825;43497.13005739804;43813.34279985739;44339;42545.36181957335;43426.782866085465;43488;43550.34674479822;43707.12585748331;35969.28061438704;38107.42838857364;38113.80943095267;38870.22259554736;39077.6092239074;28830.135095947157;29057.418851622428;29248.41503169967;29523.261918452212;29530.852345738134 06:05:10 INFO - PROCESS | 21869 | |2;jquery.html;407.6820080337337;414.53364964415033;418.21793246628806;419.98740037798876;425.29401194017936;18868.245270189193;19645.50886227845;20038.49903752407;20206.59586808263;20254.29109981151;19891.80108198921;20365.28721494748;20519.487012824688;20643;20748.273810416602;5783.566232532556;5966.582339236255;5978.611390259641;5978.850528736794;5982.910256346158;5703.629264097841;5812.128180772876;5909.556783241274;5974.044152935531;6003.759849606033;5839.270091238595;5844.473997340238;5846.23998880145;5852.473277405033;5909.586328956974;5671.177679236487;5835.562332825055;5877.118432235156;5902.704864756766;5903;5244.239585260154;5296.417394086648;5308.575313974911;5312.893742125136;5313.07021271276;22991.655125173136;23000.884995574914;23178.420539486648;23273.88363058191;23601.645975310385;2348.2250857217077;2356.952860942789;2493.7755601995727;2575.703794063669;2623.081921327539;14448.71102577953;15032.699346013127;15146.153230966096;15295.235238238043;15822.683546329125;1822.1162736072995;1835.2016872660301;1849.4913898677837;1897.5066482714456;1934.8742331748533;81929.77105343365;82318.58840705758;82763.58618206931;83790;84604;10789.24475286738;10940.070094041936;11139.888601114048;11318.943405283086;11396.544138234543;15467.613309667124;15487.922560387125;15522.223888805514;15588.454404095803;15616.219189040503;8611.655533778703;8638.654453821902;8757.693480728143;8769.816074829816;8982.191602755784;8565.657373705106;8602.096779838026;8736.06773338864;8810.559472026373;8850.64597416109;6856;6872;6902.551334163263;6904.240533541307;6994.860102797916;1932.4878907089633;1971.714101455281;1995.3914056212996;2006.9899650501945;2044.2027609232412;1000.3197825478599;1004.6684594083935;1010.802893435773;1019.5564929255797;1049.1868801678606;19516.414507564798;20380.898095509725;20509.89745051295;20609;20645.896770516352;1051.9737006574896;1052.8736551613702;1065.8561094252332;1082.3938594387012;1089.411717672448;10872.007950499235;11737.941310293394;11986.580469683693;11995.100367472474;12058.698532536582;438199;450506;450841;452611;454527;72149.39253037432;72652.27347726561;97237;98779.50610247046;100814;1005.7385079879137;1035.3322107240938;1083.182197440927;1084.3006260961636;1089.1341383600056;17471.82528174702;17720.113994299976;18036;18131.818681813013;18477.260909563465;42290.57709422989;43488;44260.77869610631;44712.55287447214;44960.550394495636;54523;58495.70752146212;59676.70161649164;59892.40107598868;61283;8152.755417337489;8177.713780017671;8271.379646526655;8273.46222495536;8476.194761497647;11485.942570287096;12534;12585.370731463574;12613.68465788326;13193.076484645982;5936;6250;10882.40146791934;11085.22403431752;11101.722456938642;11237.101031917591;11280.041196498389;11344.432778361213;11474;11684.357360345262;11125.944370278097;11519.596814111466;11750;11960.10299227544;12103.515859365527;8172.795680107807;8188.672453101809;8281.503109813431;8551.700690475804;8637.222649961534;8896.610601045386;11264.66206013821;11494.137939654727;11811.645650630495;11826.881731182579 06:05:10 INFO - PROCESS | 21869 | |3;mootools.html;1482.5181815909832;1493.0295308049767;1634.9509514714555;1779.3416435918705;1782.7236778299368;8321.958390208049;8782.429142105759;8797.516136612483;8804.64781408743;8806.603702833372;7469.701211951529;7657.9617101914555;8309.83380332393;8547.358948078889;8729.65081396745;2454.5827209374406;2478.4547399572157;2478.834947574637;2497.6628155198996;2500.749925007494;2324.5583339165587;2403.3150552092657;2415.4806716555936;2418.069043418288;2422.9878850605724;2440.8169387295934;2441.951160976779;2466.519028789387;2469.3209367423924;2469.777720005199;2328.953420931572;2340.414896275931;2357.622780355135;2361.4332560185517;2362.70466191726;2405.0379848060743;2426.0295881647307;2427.830051896368;2428.9312702410884;2432.221689059502;8509.149085091503;8599.82800343996;8672.783180420476;8677.479351238882;8686.86969695455;5310.601704872111;5431.293931788881;5434.130539113762;5439.401665816757;5448.128299472105;3458.87893923714;3537.4340105582983;3614.27714457107;3709.51776269086;3743.625637436262;1232.3653318540958;1268.7018550640685;1280.3470230182581;1295.66960425091;1318.7098838255567;12095.395230238453;12131.93934030333;12151.453184606626;12179.208351457128;12179.269243845398;4773;4838.080764654775;4892.706437613754;4897.2898929655;4949.752512374367;10237.692869213935;10250.026247506476;10258.12805911491;10259.538320775433;10260.435676037889;5513.862153446196;5527.50252477279;5529.060059789846;5530.834074977757;5532.170174473861;4488.5960263576435;4755.500672429414;4988.301637770715;4997.350344455198;5044.798208071636;4144.854930077433;4200.6429453496185;4231.7672528010635;4258.61672449481;4287.57124287575;1350.8176396186586;1353.1745635162542;1359.2931675528669;1383.5434306678771;1395.141987677571;989.8069876374182;992.1963209799941;997.1075887081167;1000.5497526113278;1027.5170669785189;5960.7019649017375;6006.789762358384;6043.274807023097;6085.087236914498;6286.622802631857;479.3648415849014;485.58239913674214;487.4978771864985;487.8341363936208;496.85094471658357;4014.157027024299;4063.593640635913;4212.873613791591;4367.71609845359;4466.4640243171025;10596.629117980834;10658.520366583522;10786.083182929382;10787.946060269649;10802.891971080346;10666.78666426667;10733.409662468639;10734.677959661223;10737.35575865435;10741.462926853626;7893.368530517545;8150.4294699370475;8157.306628936607;8199.549024803573;8365.916340836635;5849.444302791228;5949.613275137102;5977.641341519523;5985.191999080243;6029.939700602938;9817.803643926938;9883.85174222373;9951.552180152055;9959.551820168255;9964.202863770735;9755.170810481188;9861.211103111591;9881.160101391462;10062.49687515636;10070.690810194628;6857.5199736018;7064.081669382947;7072.257412971564;7568.167501574932;7784.84430311402;7649.349805266392;7718.266764657348;8173.18268173178;8284.337253019623;8359;7536.434767392358;7553.886691699739;7567.886481702889;7818.804529886798;7865.370770338473;7386.704531818667;7622.9237707622215;7636.541807491568;7709.9614501927135;7714.6914123434435;7015.964920175571;7128.108986376703;7146.606936618536;7149.82125446868;7150;5249.370075590953;5276.472352764693;5365.839024829262;5501.202325662676;5547.944520554905;5119.155339369111;5195.636305458733;5218.712970786643;5289.867753306198;5416.431274716256 06:05:10 INFO - PROCESS | 21869 | |4;prototype.html;346.6117947898354;360.047673902528;362.7352033015898;364.7556137387948;371.81223482141525;5369.9463005369935;5417.566594672427;5426.647267927582;5426.728663566821;5448.700321482317;5129.179331306992;5159.71621560814;5200.921986170201;5248.81901572146;5362.329708786402;4217.304144816117;4222.247767176618;4222.577742225783;4231.873043808675;4242.681798865082;4225;4225.6830737694645;4230.57694230576;4239.7668128252935;4274.401583778274;3983.1436241208135;4000.8199631016673;4235.301175306071;4237.364395340693;4237.555056719047;4217.746935183899;4234.068504928941;4235.475228917588;4239.448871646666;4243.533211346749;3806.8286927088348;3810.8856734298015;3812.580616132251;3819.732618716691;3825.7704537727827;5086.3896332440345;5176.171812510018;5227.66020208689;5252.1071417858675;5278.815241466568;4847.175980083359;4848.200046992242;4855.247436647325;4857.077155340474;4863.586595139417;5567.972160139214;5581.888362232733;5599.776008959637;5604.99110160171;5610.69141197234;3924.4309575111733;4106.295887206836;4112.979435102835;4210.873673789792;4218.8523401680795;5772.971135144339;5801.767929282823;5812.564057695689;5836.540864783804;5878.2064421303;4238.87283381499;4255.340422234559;4256.872293831128;4258.659307255412;4264.658827293809;4212.178625168124;4244.766537840448;4299.54854740254;4314.309710446313;4323.870283891489;4847.146518517787;4849.515048495122;4856.247281671346;4865.513448655106;4879.658423910292;5689.317281926113;5690.260266165455;5700.971495142498;5702.31572211329;5709.65742055478;1399.3842709207916;1438.8129543159323;1447.1027962663215;1449.7970284160226;1460.5175746617192;951.1724799424406;965.666844938495;981.2836629260537;1004.5529739266102;1016.1159790981893;5334.252859777218;5347.438518955531;5362;5371.704556249366;5383.246345511631;5464.535514481234;5488.9725551371985;5536.889262214814;5603.6077474577205;5628.352739434936;5071.847844564669;5222.981518603911;5252.842414727565;5278.577713782888;5295.4439783822145;2921.4224318868;2936.897208597689;2938.1185644306624;2946.3500439753807;2951.409718056397;5508.394076651565;5687.971560142173;5699.603597118649;5703.401142879938;5761.423857614205;5612.747426365823;5621.747021384048;5625.212470254168;5634.549236061105;5648.576356773258;5702.486776190163;5722.227499287543;5729.828105156852;5771.68255745938;5774.855628609318;5221.451747566451;5415.160650099241;5433;5461.863453413696;5511.255980442749;5404.5406140476925;5408.405075441777;5452.945470545244;5453.7545810439415;5490.588205884655;5362.490563396471;5721.596929289792;5729.28383952006;5730.452777750067;5748.712564371681;4061.7969101545395;4086.3257562501853;4090.5500394955934;4091.3453847384276;4107.753534787803;5520.365158006881;5554.333479982428;5557.194206840067;5573.498385145356;5583.246261754611;5332.33345831771;5452.91820622683;5460.890782184413;5463.350275116644;5469.835904922858;5680.403557626555;5685.20407142992;5686.829395118153;5690.2887139107615;5695.800646977336;5412.269343638716;5531.806386776443;5669.7165141741925;5679.659220446786;5702.800401985911;5507.862303442446;5693.658380497183;5696.487316141402;5714.228579141929;5719.542436604978;5508.20131080999;5529.30883639545;5532.723363831873;5535.308086489189;5569.19246709233 06:05:10 INFO - PROCESS | 21869 | |5;yui.html;812.601825105698;815.991840081599;843.548701444727;850.7192626433276;892.1435421994885;16305.51083467495;16771.24529396177;16909.492715218534;16911;16937.3225070997;16137.596560086004;16139.273732682028;16189.83810161901;16207.108609026498;16468.176591170424;716.6739133694183;847.8601030829906;869.3827382558391;871.3813192633238;873.3406278259937;731.784123683512;835.9456635318716;850.5662112322728;863.9222469977701;864.6109250837117;901.1529162587148;911.699139284038;911.7948461596154;911.7994041310934;911.8085202107566;741.8442127153304;893.7452825944574;895.2479916869828;896.5069211933411;897.2642433204775;564.1058921609255;641.3298103481826;658.6673729766437;660.9173853268342;663.8605892762478;15209.163496007715;15218.923905380403;15230.771538426932;15249.542513724495;15250.923745381202;14019.859801401957;14108.858911410856;14389.424423023067;14467.638309042253;14473.78289325661;13087.280199589019;13124.868751312555;13295.468181272738;13367.997400194927;14000.929995349958;4489.887752806173;4519.638428925678;4539;4552.635789136861;4578.5650363215445;65950.3404965949;66561.66719166373;66567;66795.66602166957;66853.99999999952;11180.944095279472;11669.183157179086;11713.531458741554;12071.215371000857;12156.939215304044;20990.160393584392;21375.46561335979;21389.893050534647;21407.785922140578;21418;8584.570771461402;8617.741467755977;8825.867611985825;8916.777080573038;9138.451692898314;4472.608988853185;4563.498015218323;4600.953990460052;4621.399218101626;4791.712497250106;3552.786832790041;3618.9819050904575;3645.3620616392027;3658.835352409148;3673.7428380013143;658.8239991614944;660.4155322539491;661.890788019981;663.5255792108666;663.7444583835162;663.1180529895228;734.772220611612;740.2227660955974;798.3014861995754;811.4725428471422;9757.658481953098;9768.36505627132;10006.79986400268;10373.425382167008;10617.416042117758;668.0747165176169;699.1260923845193;711.9537230080028;729.6643543969833;815.7389635316641;4592.812887236679;4859.975700121548;5054.631263756956;5107.948920510822;5124.084984824174;45973.54026459759;50605.74697126491;52157.47842521526;52530.737346313785;52570.47429525732;69859.65070174719;71753.6412317935;72424.63787681134;72847.63576182086;73371.26628733751;62416.68791656013;64836.351636483974;65057.67471162614;65248.34751652517;67825;9461.290403219924;9689.563969621244;9695.951520242354;9706.660266890625;9755.122039016522;42749;43428.78285608552;43558.56441435545;44464;44675.10649786921;55076.72461637826;55943.440565593824;60971;61214.69392653008;63293.36706633059;11777.941110294394;11954.641360759191;12263;12690.682732931751;12709.428075736429;14118.223497707724;14365.353559090076;14562.344694488986;15277.694446111238;15801;11713.648590542298;13944.651383715489;14304.356303966555;14445.205513696848;14760.778588320969;12552.748945020865;13786;13853.376598053314;14153.858461415253;14392.496262630757;13771.862281377058;14044.157350558999;14155.858441415867;14331.277057359068;14666.560003199495;10621.946890265499;10725.517351719036;11733.237339572901;12162.087843411957;12333.62999110028;11661.883381166079;11709.473073711533;11734.882651173379;11884.881151188378;11945.82081268799 06:05:10 INFO - PROCESS | 21869 | __end_tp_report 06:05:10 INFO - PROCESS | 21869 | __start_cc_report 06:05:10 INFO - PROCESS | 21869 | _x_x_mozilla_cycle_collect,1593 06:05:10 INFO - PROCESS | 21869 | __end_cc_report 06:05:10 INFO - PROCESS | 21869 | __startTimestamp1482329110886__endTimestamp 06:05:10 INFO - PROCESS | 21869 | 06:05:10 INFO - PROCESS | 21869 | ------- Summary: start ------- 06:05:10 INFO - PROCESS | 21869 | Number of tests: 6 06:05:10 INFO - PROCESS | 21869 | 06:05:10 INFO - PROCESS | 21869 | [#0] dojo.html Cycles:165 Average:5609.98 Median:5820.13 stddev:636.46 (10.9%) stddev-sans-first:610.50 06:05:10 INFO - PROCESS | 21869 | Values: 3233.3 3248.1 3276.5 3302.4 3322.8 5544.6 5586.2 5631.8 5634.4 5651.8 5573.1 5663.9 5664.9 5668.2 5699.8 5111.0 5126.4 5133.9 5166.9 5197.3 5000.5 5011.5 5235.5 5239.3 5243.9 5105.9 5110.4 5133.8 5154.5 5158.5 5189.1 5206.9 5250.7 5267.4 5292.0 5003.2 5104.3 5179.4 5215.7 5235.1 5510.8 5513.7 5519.5 5543.4 5543.8 5940.6 5941.2 5946.2 6013.7 6023.7 6050.2 6066.6 6080.0 6088.6 6103.7 5449.9 5476.1 5483.3 5619.6 5662.1 6218.4 6253.5 6262.6 6263.3 6266.6 5996.9 6006.8 6007.9 6017.3 6052.1 5871.8 5936.1 5944.0 6003.2 6088.8 6010.3 6026.0 6031.4 6044.7 6050.8 5965.7 5983.0 6023.7 6025.7 6047.9 4531.0 4560.0 4610.9 4676.9 4683.6 4116.0 4138.0 4139.3 4169.6 4178.3 5728.6 5729.7 5731.1 5735.6 5755.2 5875.9 5930.3 6018.2 6028.2 6031.6 5675.6 5696.2 5728.7 5737.4 5794.8 5120.9 5160.5 5162.4 5172.1 5186.5 6251.1 6316.9 6322.3 6333.2 6341.3 5824.7 5869.1 5981.6 6003.4 6115.8 6314.0 6345.9 6351.5 6354.6 6364.6 6004.1 6005.8 6007.5 6009.0 6017.7 5853.2 5936.5 5995.5 6063.1 6123.4 5873.6 5936.3 5944.9 5953.9 5968.3 5929.1 5943.0 5945.1 5946.3 5946.5 5860.9 5907.8 5911.8 5919.7 5926.9 5739.1 5765.8 5820.1 5880.3 5887.9 5753.9 5797.6 5802.2 5810.0 5817.8 06:05:10 INFO - PROCESS | 21869 | 06:05:10 INFO - PROCESS | 21869 | [#1] ext.html Cycles:180 Average:60485.67 Median:37930.22 stddev:118243.80 (311.7%) stddev-sans-first:118489.93 06:05:10 INFO - PROCESS | 21869 | Values: 568.8 614.6 641.4 661.6 673.4 32752.8 44707.0 45452.8 45497.3 48813.5 44868.0 45286.1 45327.8 45366.3 45911.8 8286.6 8773.9 8908.2 8912.2 8918.0 8227.7 10411.6 10653.6 10659.7 10979.4 10824.1 10872.6 10880.1 10898.8 10907.7 10557.4 10612.9 10638.7 10679.3 10696.7 10527.3 10589.4 10643.1 10662.3 10670.1 41571.0 41755.2 41899.0 41931.8 41943.2 3511.6 3552.7 3575.6 3585.2 3702.5 31836.2 32136.5 32215.2 32371.7 32871.7 4127.7 4162.4 4178.3 4189.8 4275.6 360404.0 360964.0 361087.0 362899.0 364244.0 37682.2 62360.0 62838.7 62869.4 62904.0 38064.8 40340.4 40406.4 40452.8 40500.0 16311.2 16415.8 16418.5 16433.1 16444.6 12028.6 12147.9 13442.7 13738.9 13804.1 9310.9 9343.3 9458.6 9551.9 9563.4 3520.4 3578.6 3586.1 3608.1 3620.8 1012.9 1029.8 1106.6 1114.2 1131.2 33248.5 33290.2 33327.0 33349.0 33633.8 1128.8 1170.8 1176.4 1178.3 1182.8 16863.9 17710.0 17720.6 17969.3 17991.3 510323.0 515291.0 515331.0 516484.0 516622.0 61014.4 61572.0 61596.1 61736.7 61780.7 1291.1 1340.7 1343.3 1419.2 1436.5 28823.9 34559.0 34794.7 37417.8 37475.8 57530.7 57641.4 58072.4 58213.7 58314.7 446582.0 448907.0 450030.2 450570.0 451389.0 29775.7 30971.7 31246.7 37795.6 38230.0 45109.5 47783.5 47808.0 51324.7 52809.5 42370.0 42913.0 43477.6 43869.3 43965.4 42278.4 43486.6 43497.1 43813.3 44339.0 42545.4 43426.8 43488.0 43550.3 43707.1 35969.3 38107.4 38113.8 38870.2 39077.6 28830.1 29057.4 29248.4 29523.3 29530.9 06:05:10 INFO - PROCESS | 21869 | 06:05:10 INFO - PROCESS | 21869 | [#2] jquery.html Cycles:180 Average:28170.68 Median:23226.15 stddev:74295.32 (319.9%) stddev-sans-first:74474.49 06:05:10 INFO - PROCESS | 21869 | Values: 407.7 414.5 418.2 420.0 425.3 18868.2 19645.5 20038.5 20206.6 20254.3 19891.8 20365.3 20519.5 20643.0 20748.3 5783.6 5966.6 5978.6 5978.9 5982.9 5703.6 5812.1 5909.6 5974.0 6003.8 5839.3 5844.5 5846.2 5852.5 5909.6 5671.2 5835.6 5877.1 5902.7 5903.0 5244.2 5296.4 5308.6 5312.9 5313.1 22991.7 23000.9 23178.4 23273.9 23601.6 2348.2 2357.0 2493.8 2575.7 2623.1 14448.7 15032.7 15146.2 15295.2 15822.7 1822.1 1835.2 1849.5 1897.5 1934.9 81929.8 82318.6 82763.6 83790.0 84604.0 10789.2 10940.1 11139.9 11318.9 11396.5 15467.6 15487.9 15522.2 15588.5 15616.2 8611.7 8638.7 8757.7 8769.8 8982.2 8565.7 8602.1 8736.1 8810.6 8850.6 6856.0 6872.0 6902.6 6904.2 6994.9 1932.5 1971.7 1995.4 2007.0 2044.2 1000.3 1004.7 1010.8 1019.6 1049.2 19516.4 20380.9 20509.9 20609.0 20645.9 1052.0 1052.9 1065.9 1082.4 1089.4 10872.0 11737.9 11986.6 11995.1 12058.7 438199.0 450506.0 450841.0 452611.0 454527.0 72149.4 72652.3 97237.0 98779.5 100814.0 1005.7 1035.3 1083.2 1084.3 1089.1 17471.8 17720.1 18036.0 18131.8 18477.3 42290.6 43488.0 44260.8 44712.6 44960.6 54523.0 58495.7 59676.7 59892.4 61283.0 8152.8 8177.7 8271.4 8273.5 8476.2 11485.9 12534.0 12585.4 12613.7 13193.1 5936.0 6250.0 10882.4 11085.2 11101.7 11237.1 11280.0 11344.4 11474.0 11684.4 11125.9 11519.6 11750.0 11960.1 12103.5 8172.8 8188.7 8281.5 8551.7 8637.2 8896.6 11264.7 11494.1 11811.6 11826.9 06:05:10 INFO - PROCESS | 21869 | 06:05:10 INFO - PROCESS | 21869 | [#3] mootools.html Cycles:180 Average:5786.28 Median:2742.58 stddev:3190.84 (116.3%) stddev-sans-first:3183.40 06:05:10 INFO - PROCESS | 21869 | Values: 1482.5 1493.0 1635.0 1779.3 1782.7 8322.0 8782.4 8797.5 8804.6 8806.6 7469.7 7658.0 8309.8 8547.4 8729.7 2454.6 2478.5 2478.8 2497.7 2500.7 2324.6 2403.3 2415.5 2418.1 2423.0 2440.8 2442.0 2466.5 2469.3 2469.8 2329.0 2340.4 2357.6 2361.4 2362.7 2405.0 2426.0 2427.8 2428.9 2432.2 8509.1 8599.8 8672.8 8677.5 8686.9 5310.6 5431.3 5434.1 5439.4 5448.1 3458.9 3537.4 3614.3 3709.5 3743.6 1232.4 1268.7 1280.3 1295.7 1318.7 12095.4 12131.9 12151.5 12179.2 12179.3 4773.0 4838.1 4892.7 4897.3 4949.8 10237.7 10250.0 10258.1 10259.5 10260.4 5513.9 5527.5 5529.1 5530.8 5532.2 4488.6 4755.5 4988.3 4997.4 5044.8 4144.9 4200.6 4231.8 4258.6 4287.6 1350.8 1353.2 1359.3 1383.5 1395.1 989.8 992.2 997.1 1000.5 1027.5 5960.7 6006.8 6043.3 6085.1 6286.6 479.4 485.6 487.5 487.8 496.9 4014.2 4063.6 4212.9 4367.7 4466.5 10596.6 10658.5 10786.1 10787.9 10802.9 10666.8 10733.4 10734.7 10737.4 10741.5 7893.4 8150.4 8157.3 8199.5 8365.9 5849.4 5949.6 5977.6 5985.2 6029.9 9817.8 9883.9 9951.6 9959.6 9964.2 9755.2 9861.2 9881.2 10062.5 10070.7 6857.5 7064.1 7072.3 7568.2 7784.8 7649.3 7718.3 8173.2 8284.3 8359.0 7536.4 7553.9 7567.9 7818.8 7865.4 7386.7 7622.9 7636.5 7710.0 7714.7 7016.0 7128.1 7146.6 7149.8 7150.0 5249.4 5276.5 5365.8 5501.2 5547.9 5119.2 5195.6 5218.7 5289.9 5416.4 06:05:10 INFO - PROCESS | 21869 | 06:05:10 INFO - PROCESS | 21869 | [#4] prototype.html Cycles:180 Average:4692.84 Median:5362.16 stddev:1341.70 (25.0%) stddev-sans-first:1305.21 06:05:10 INFO - PROCESS | 21869 | Values: 346.6 360.0 362.7 364.8 371.8 5369.9 5417.6 5426.6 5426.7 5448.7 5129.2 5159.7 5200.9 5248.8 5362.3 4217.3 4222.2 4222.6 4231.9 4242.7 4225.0 4225.7 4230.6 4239.8 4274.4 3983.1 4000.8 4235.3 4237.4 4237.6 4217.7 4234.1 4235.5 4239.4 4243.5 3806.8 3810.9 3812.6 3819.7 3825.8 5086.4 5176.2 5227.7 5252.1 5278.8 4847.2 4848.2 4855.2 4857.1 4863.6 5568.0 5581.9 5599.8 5605.0 5610.7 3924.4 4106.3 4113.0 4210.9 4218.9 5773.0 5801.8 5812.6 5836.5 5878.2 4238.9 4255.3 4256.9 4258.7 4264.7 4212.2 4244.8 4299.5 4314.3 4323.9 4847.1 4849.5 4856.2 4865.5 4879.7 5689.3 5690.3 5701.0 5702.3 5709.7 1399.4 1438.8 1447.1 1449.8 1460.5 951.2 965.7 981.3 1004.6 1016.1 5334.3 5347.4 5362.0 5371.7 5383.2 5464.5 5489.0 5536.9 5603.6 5628.4 5071.8 5223.0 5252.8 5278.6 5295.4 2921.4 2936.9 2938.1 2946.4 2951.4 5508.4 5688.0 5699.6 5703.4 5761.4 5612.7 5621.7 5625.2 5634.5 5648.6 5702.5 5722.2 5729.8 5771.7 5774.9 5221.5 5415.2 5433.0 5461.9 5511.3 5404.5 5408.4 5452.9 5453.8 5490.6 5362.5 5721.6 5729.3 5730.5 5748.7 4061.8 4086.3 4090.6 4091.3 4107.8 5520.4 5554.3 5557.2 5573.5 5583.2 5332.3 5452.9 5460.9 5463.4 5469.8 5680.4 5685.2 5686.8 5690.3 5695.8 5412.3 5531.8 5669.7 5679.7 5702.8 5507.9 5693.7 5696.5 5714.2 5719.5 5508.2 5529.3 5532.7 5535.3 5569.2 06:05:10 INFO - PROCESS | 21869 | 06:05:10 INFO - PROCESS | 21869 | [#5] yui.html Cycles:180 Average:17000.86 Median:25283.18 stddev:20345.61 (80.5%) stddev-sans-first:20366.37 06:05:10 INFO - PROCESS | 21869 | Values: 812.6 816.0 843.5 850.7 892.1 16305.5 16771.2 16909.5 16911.0 16937.3 16137.6 16139.3 16189.8 16207.1 16468.2 716.7 847.9 869.4 871.4 873.3 731.8 835.9 850.6 863.9 864.6 901.2 911.7 911.8 911.8 911.8 741.8 893.7 895.2 896.5 897.3 564.1 641.3 658.7 660.9 663.9 15209.2 15218.9 15230.8 15249.5 15250.9 14019.9 14108.9 14389.4 14467.6 14473.8 13087.3 13124.9 13295.5 13368.0 14000.9 4489.9 4519.6 4539.0 4552.6 4578.6 65950.3 66561.7 66567.0 66795.7 66854.0 11180.9 11669.2 11713.5 12071.2 12156.9 20990.2 21375.5 21389.9 21407.8 21418.0 8584.6 8617.7 8825.9 8916.8 9138.5 4472.6 4563.5 4601.0 4621.4 4791.7 3552.8 3619.0 3645.4 3658.8 3673.7 658.8 660.4 661.9 663.5 663.7 663.1 734.8 740.2 798.3 811.5 9757.7 9768.4 10006.8 10373.4 10617.4 668.1 699.1 712.0 729.7 815.7 4592.8 4860.0 5054.6 5107.9 5124.1 45973.5 50605.7 52157.5 52530.7 52570.5 69859.7 71753.6 72424.6 72847.6 73371.3 62416.7 64836.4 65057.7 65248.3 67825.0 9461.3 9689.6 9696.0 9706.7 9755.1 42749.0 43428.8 43558.6 44464.0 44675.1 55076.7 55943.4 60971.0 61214.7 63293.4 11777.9 11954.6 12263.0 12690.7 12709.4 14118.2 14365.4 14562.3 15277.7 15801.0 11713.6 13944.7 14304.4 14445.2 14760.8 12552.7 13786.0 13853.4 14153.9 14392.5 13771.9 14044.2 14155.9 14331.3 14666.6 10621.9 10725.5 11733.2 12162.1 12333.6 11661.9 11709.5 11734.9 11884.9 11945.8 06:05:10 INFO - PROCESS | 21869 | -------- Summary: end -------- 06:05:10 INFO - PROCESS | 21869 | 06:05:11 INFO - TEST-INFO | 21869: exit 0 06:05:11 INFO - TEST-OK | dromaeo_css | took 1116140ms 06:05:11 INFO - TEST-START | kraken 06:05:11 INFO - operating with platform_type : linux_ 06:05:11 INFO - Initialising browser for kraken test... 06:05:11 INFO - TEST-INFO | started process 22188 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpirWIhN/profile http://localhost:47640/getInfo.html) 06:05:15 INFO - PROCESS | 22188 | __metrics Screen width/height:1600/1200 06:05:15 INFO - PROCESS | 22188 | colorDepth:24 06:05:15 INFO - PROCESS | 22188 | Browser inner width/height: 1024/697 06:05:15 INFO - PROCESS | 22188 | __metrics 06:05:16 INFO - PROCESS | 22188 | 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" 06:05:16 INFO - PROCESS | 22188 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:05:16 INFO - PROCESS | 22188 | console.error: PushService: 06:05:16 INFO - PROCESS | 22188 | stateChangeProcessEnqueue: Error transitioning state 06:05:16 INFO - PROCESS | 22188 | UnknownError 06:05:17 INFO - TEST-INFO | 22188: exit 0 06:05:17 INFO - Browser initialized. 06:05:17 INFO - Running cycle 1/1 for kraken test... 06:05:17 INFO - TEST-INFO | started process 22284 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpirWIhN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:05:28 INFO - PROCESS | 22284 | RSS: Main: 144674816 06:05:28 INFO - PROCESS | 22284 | 06:05:31 INFO - PROCESS | 22284 | Cycle 1(1): loaded http://localhost:47640/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47640/tests/kraken/driver.html?testName=audio-beat-detection) 06:05:32 INFO - PROCESS | 22284 | RSS: Main: 185589760 06:05:32 INFO - PROCESS | 22284 | 06:05:34 INFO - PROCESS | 22284 | Cycle 1(1): loaded http://localhost:47640/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47640/tests/kraken/driver.html?testName=audio-dft) 06:05:35 INFO - PROCESS | 22284 | RSS: Main: 174899200 06:05:35 INFO - PROCESS | 22284 | 06:05:38 INFO - PROCESS | 22284 | Cycle 1(1): loaded http://localhost:47640/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47640/tests/kraken/driver.html?testName=audio-fft) 06:05:38 INFO - PROCESS | 22284 | RSS: Main: 266641408 06:05:38 INFO - PROCESS | 22284 | 06:05:40 INFO - PROCESS | 22284 | Cycle 1(1): loaded http://localhost:47640/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47640/tests/kraken/driver.html?testName=audio-oscillator) 06:05:41 INFO - PROCESS | 22284 | RSS: Main: 172515328 06:05:41 INFO - PROCESS | 22284 | 06:05:43 INFO - PROCESS | 22284 | Cycle 1(1): loaded http://localhost:47640/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47640/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:05:44 INFO - PROCESS | 22284 | RSS: Main: 175124480 06:05:44 INFO - PROCESS | 22284 | 06:05:47 INFO - PROCESS | 22284 | Cycle 1(1): loaded http://localhost:47640/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47640/tests/kraken/driver.html?testName=imaging-darkroom) 06:05:47 INFO - PROCESS | 22284 | RSS: Main: 214401024 06:05:47 INFO - PROCESS | 22284 | 06:05:51 INFO - PROCESS | 22284 | Cycle 1(1): loaded http://localhost:47640/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47640/tests/kraken/driver.html?testName=imaging-desaturate) 06:05:51 INFO - PROCESS | 22284 | RSS: Main: 212938752 06:05:51 INFO - PROCESS | 22284 | 06:05:54 INFO - PROCESS | 22284 | Cycle 1(1): loaded http://localhost:47640/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47640/tests/kraken/driver.html?testName=json-parse-financial) 06:05:54 INFO - PROCESS | 22284 | RSS: Main: 211419136 06:05:54 INFO - PROCESS | 22284 | 06:05:56 INFO - PROCESS | 22284 | Cycle 1(1): loaded http://localhost:47640/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47640/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:05:56 INFO - PROCESS | 22284 | RSS: Main: 173846528 06:05:56 INFO - PROCESS | 22284 | 06:05:58 INFO - PROCESS | 22284 | Cycle 1(1): loaded http://localhost:47640/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47640/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:05:59 INFO - PROCESS | 22284 | RSS: Main: 181207040 06:05:59 INFO - PROCESS | 22284 | 06:06:01 INFO - PROCESS | 22284 | Cycle 1(1): loaded http://localhost:47640/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47640/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:06:01 INFO - PROCESS | 22284 | RSS: Main: 189808640 06:06:01 INFO - PROCESS | 22284 | 06:06:04 INFO - PROCESS | 22284 | Cycle 1(1): loaded http://localhost:47640/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47640/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:06:05 INFO - PROCESS | 22284 | RSS: Main: 198602752 06:06:05 INFO - PROCESS | 22284 | 06:06:07 INFO - PROCESS | 22284 | Cycle 1(1): loaded http://localhost:47640/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47640/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:06:08 INFO - PROCESS | 22284 | RSS: Main: 195280896 06:06:08 INFO - PROCESS | 22284 | 06:06:10 INFO - PROCESS | 22284 | Cycle 1(1): loaded http://localhost:47640/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47640/tests/kraken/driver.html?testName=ai-astar) 06:06:10 INFO - PROCESS | 22284 | RSS: Main: 246398976 06:06:10 INFO - PROCESS | 22284 | 06:06:10 INFO - PROCESS | 22284 | __start_tp_report 06:06:10 INFO - PROCESS | 22284 | _x_x_mozilla_page_load 06:06:10 INFO - PROCESS | 22284 | _x_x_mozilla_page_load_details 06:06:10 INFO - PROCESS | 22284 | |i|pagename|runs| 06:06:10 INFO - PROCESS | 22284 | |0;ai-astar;102;112;109;112;111;110;113;110;111;110 06:06:10 INFO - PROCESS | 22284 | |1;audio-beat-detection;151;118;122;162;117;117;118;117;156;120 06:06:10 INFO - PROCESS | 22284 | |2;audio-dft;162;161;163;162;159;161;161;161;160;162 06:06:10 INFO - PROCESS | 22284 | |3;audio-fft;74;74;75;109;76;76;85;76;101;75 06:06:10 INFO - PROCESS | 22284 | |4;audio-oscillator;81;81;121;82;81;81;97;81;81;106 06:06:10 INFO - PROCESS | 22284 | |5;imaging-gaussian-blur;118;117;118;117;118;117;117;117;117;117 06:06:10 INFO - PROCESS | 22284 | |6;imaging-darkroom;146;146;147;146;146;145;146;147;146;146 06:06:10 INFO - PROCESS | 22284 | |7;imaging-desaturate;85;84;84;85;85;84;84;84;84;84 06:06:10 INFO - PROCESS | 22284 | |8;json-parse-financial;48;50;49;50;49;49;50;49;51;51 06:06:10 INFO - PROCESS | 22284 | |9;json-stringify-tinderbox;59;59;60;60;60;60;59;60;60;59 06:06:10 INFO - PROCESS | 22284 | |10;stanford-crypto-aes;76;82;74;76;75;76;76;74;80;74 06:06:10 INFO - PROCESS | 22284 | |11;stanford-crypto-ccm;123;136;121;125;123;124;127;117;165;122 06:06:10 INFO - PROCESS | 22284 | |12;stanford-crypto-pbkdf2;154;152;154;154;158;156;158;153;152;159 06:06:10 INFO - PROCESS | 22284 | |13;stanford-crypto-sha256-iterative;63;64;62;69;62;63;62;68;60;62 06:06:10 INFO - PROCESS | 22284 | __end_tp_report 06:06:10 INFO - PROCESS | 22284 | __start_cc_report 06:06:10 INFO - PROCESS | 22284 | _x_x_mozilla_cycle_collect,1621 06:06:10 INFO - PROCESS | 22284 | __end_cc_report 06:06:10 INFO - PROCESS | 22284 | __startTimestamp1482329170279__endTimestamp 06:06:10 INFO - PROCESS | 22284 | 06:06:10 INFO - PROCESS | 22284 | ------- Summary: start ------- 06:06:10 INFO - PROCESS | 22284 | Number of tests: 14 06:06:10 INFO - PROCESS | 22284 | 06:06:10 INFO - PROCESS | 22284 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:3.06 (2.8%) stddev-sans-first:1.27 06:06:10 INFO - PROCESS | 22284 | Values: 102.0 112.0 109.0 112.0 111.0 110.0 113.0 110.0 111.0 110.0 06:06:10 INFO - PROCESS | 22284 | 06:06:10 INFO - PROCESS | 22284 | [#1] audio-beat-detection Cycles:10 Average:129.80 Median:121.00 stddev:18.56 (15.3%) stddev-sans-first:18.03 06:06:10 INFO - PROCESS | 22284 | Values: 151.0 118.0 122.0 162.0 117.0 117.0 118.0 117.0 156.0 120.0 06:06:10 INFO - PROCESS | 22284 | 06:06:10 INFO - PROCESS | 22284 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.14 (0.7%) stddev-sans-first:1.17 06:06:10 INFO - PROCESS | 22284 | Values: 162.0 161.0 163.0 162.0 159.0 161.0 161.0 161.0 160.0 162.0 06:06:10 INFO - PROCESS | 22284 | 06:06:10 INFO - PROCESS | 22284 | [#3] audio-fft Cycles:10 Average:82.10 Median:75.50 stddev:12.62 (16.7%) stddev-sans-first:13.04 06:06:10 INFO - PROCESS | 22284 | Values: 74.0 74.0 75.0 109.0 76.0 76.0 85.0 76.0 101.0 75.0 06:06:10 INFO - PROCESS | 22284 | 06:06:10 INFO - PROCESS | 22284 | [#4] audio-oscillator Cycles:10 Average:89.20 Median:81.00 stddev:14.18 (17.5%) stddev-sans-first:14.73 06:06:10 INFO - PROCESS | 22284 | Values: 81.0 81.0 121.0 82.0 81.0 81.0 97.0 81.0 81.0 106.0 06:06:10 INFO - PROCESS | 22284 | 06:06:10 INFO - PROCESS | 22284 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 06:06:10 INFO - PROCESS | 22284 | Values: 118.0 117.0 118.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 06:06:10 INFO - PROCESS | 22284 | 06:06:10 INFO - PROCESS | 22284 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 06:06:10 INFO - PROCESS | 22284 | Values: 146.0 146.0 147.0 146.0 146.0 145.0 146.0 147.0 146.0 146.0 06:06:10 INFO - PROCESS | 22284 | 06:06:10 INFO - PROCESS | 22284 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.00 stddev:0.48 (0.6%) stddev-sans-first:0.44 06:06:10 INFO - PROCESS | 22284 | Values: 85.0 84.0 84.0 85.0 85.0 84.0 84.0 84.0 84.0 84.0 06:06:10 INFO - PROCESS | 22284 | 06:06:10 INFO - PROCESS | 22284 | [#8] json-parse-financial Cycles:10 Average:49.60 Median:50.00 stddev:0.97 (1.9%) stddev-sans-first:0.83 06:06:10 INFO - PROCESS | 22284 | Values: 48.0 50.0 49.0 50.0 49.0 49.0 50.0 49.0 51.0 51.0 06:06:10 INFO - PROCESS | 22284 | 06:06:10 INFO - PROCESS | 22284 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:60.00 stddev:0.52 (0.9%) stddev-sans-first:0.50 06:06:10 INFO - PROCESS | 22284 | Values: 59.0 59.0 60.0 60.0 60.0 60.0 59.0 60.0 60.0 59.0 06:06:10 INFO - PROCESS | 22284 | 06:06:10 INFO - PROCESS | 22284 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:76.00 stddev:2.67 (3.5%) stddev-sans-first:2.83 06:06:10 INFO - PROCESS | 22284 | Values: 76.0 82.0 74.0 76.0 75.0 76.0 76.0 74.0 80.0 74.0 06:06:10 INFO - PROCESS | 22284 | 06:06:10 INFO - PROCESS | 22284 | [#11] stanford-crypto-ccm Cycles:10 Average:128.30 Median:124.50 stddev:13.80 (11.1%) stddev-sans-first:14.50 06:06:10 INFO - PROCESS | 22284 | Values: 123.0 136.0 121.0 125.0 123.0 124.0 127.0 117.0 165.0 122.0 06:06:10 INFO - PROCESS | 22284 | 06:06:10 INFO - PROCESS | 22284 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.00 Median:155.00 stddev:2.58 (1.7%) stddev-sans-first:2.71 06:06:10 INFO - PROCESS | 22284 | Values: 154.0 152.0 154.0 154.0 158.0 156.0 158.0 153.0 152.0 159.0 06:06:10 INFO - PROCESS | 22284 | 06:06:10 INFO - PROCESS | 22284 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:63.00 stddev:2.84 (4.5%) stddev-sans-first:3.00 06:06:10 INFO - PROCESS | 22284 | Values: 63.0 64.0 62.0 69.0 62.0 63.0 62.0 68.0 60.0 62.0 06:06:10 INFO - PROCESS | 22284 | -------- Summary: end -------- 06:06:10 INFO - PROCESS | 22284 | 06:06:11 INFO - TEST-INFO | 22284: exit 0 06:06:11 INFO - TEST-OK | kraken | took 59851ms 06:06:11 INFO - SUITE-END | took 1175s 06:06:11 INFO - Completed test suite (00:19:36) 06:06:11 INFO - javascript benchmark 06:06:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3233.3371658809947, 3248.139243100578, 3276.459384201607, 3302.4055669979425, 3322.8172450515212, 5544.556435485161, 5586.162075688649, 5631.774729010845, 5634.436556344363, 5651.8021869234635, 5573.136163894593, 5663.9433605663935, 5664.858378540539, 5668.234788303578, 5699.800506982246, 5111.0, 5126.384833819947, 5133.922991155136, 5166.870828229286, 5197.272381866523, 5000.549950504454, 5011.473795251501, 5235.528802407783, 5239.345081864767, 5243.86890327741, 5105.923411148836, 5110.437851836314, 5133.768980395891, 5154.484551544834, 5158.484151584849, 5189.091908915943, 5206.921896171561, 5250.65870718402, 5267.446918073624, 5291.973540132313, 5003.174476211457, 5104.25988231708, 5179.352580927384, 5215.687058776448, 5235.136202526579, 5510.779568817243, 5513.724313784295, 5519.503244707996, 5543.36251331094, 5543.77824887004, 5940.61386009908, 5941.19793827832, 5946.226990491252, 6013.6993150342305, 6023.69881505923, 6050.183225264577, 6066.636001839904, 6080.0271956487195, 6088.634681919099, 6103.725332360054, 5449.863753406157, 5476.096444086761, 5483.287172667528, 5619.578531610146, 5662.122371032497, 6218.409251121137, 6253.499720022387, 6262.5929314594405, 6263.311035786151, 6266.592671476339, 5996.850078748066, 6006.819795406145, 6007.879842403215, 6017.252051676225, 6052.12244224585, 5871.794487192928, 5936.079907614327, 5943.989521781307, 6003.159557661931, 6088.786892458743, 6010.308814486302, 6026.0, 6031.366706495843, 6044.727987240584, 6050.848728781728, 5965.671888046112, 5982.970085149634, 6023.668698221552, 6025.698715064229, 6047.879042419127, 4530.954690453053, 4559.977200113978, 4610.884727881829, 4676.929846052312, 4683.578477937002, 4115.97942010294, 4137.97931010343, 4139.317012692872, 4169.583041695867, 4178.331466965271, 5728.598998070179, 5729.742161602738, 5731.111677689964, 5735.627184233012, 5755.194272801811, 5875.853103672357, 5930.258717660293, 6018.247719035121, 6028.246469191351, 6031.60794548353, 5675.574331925122, 5696.174054762119, 5728.656280623092, 5737.426257374229, 5794.797182098607, 5120.8719782005, 5160.535551800356, 5162.432132465426, 5172.094883395466, 5186.481351864859, 6251.062340648939, 6316.9368306317265, 6322.272938612026, 6333.176687030748, 6341.334159913327, 5824.650520968586, 5869.06095024794, 5981.611195272293, 6003.42967418112, 6115.816525504242, 6313.96843015782, 6345.936540634534, 6351.491880649629, 6354.618722876642, 6364.554481186273, 6004.0693692477735, 6005.789797357246, 6007.459328660441, 6008.969955150196, 6017.699115044143, 5853.151293062568, 5936.495397891227, 5995.46040856325, 6063.090536419572, 6123.4488895999575, 5873.618214816023, 5936.257967754031, 5944.851378715393, 5953.880922381615, 5968.313643931004, 5929.110633405024, 5942.970285148546, 5945.078512830518, 5946.316173640087, 5946.494547963472, 5860.853478663067, 5907.793227237026, 5911.763529458945, 5919.7040147991565, 5926.940730592639, 5739.110437882135, 5765.798197063083, 5820.126980952721, 5880.294364676266, 5887.941120588739, 5753.942460575508, 5797.623154494944, 5802.187693722966, 5810.041343178328, 5817.825465236049], "value": 5567.2035235232925, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.8122919436586, 614.5882258886545, 641.3938827807721, 661.6327937994412, 673.3737624009669, 32752.836235818817, 44707.0, 45452.77273613636, 45497.31754023688, 48813.51186488143, 44868.0, 45286.0942781145, 45327.77336113323, 45366.319505207364, 45911.77044114783, 8286.627101780434, 8773.912260877389, 8908.242799362062, 8912.24245939096, 8917.95541022294, 8227.712030078948, 10411.635592754255, 10653.627123050655, 10659.733506662318, 10979.396133212671, 10824.079953203987, 10872.565097396095, 10880.12958963285, 10898.782024359509, 10907.672769816878, 10557.366558006544, 10612.893871061306, 10638.734031649194, 10679.305845120081, 10696.732581685443, 10527.263091583593, 10589.417582032986, 10643.095336896373, 10662.253642245047, 10670.093042091432, 41571.0, 41755.1648967019, 41899.0, 41931.79034104841, 41943.1611367771, 3511.6488351164935, 3552.6802587767224, 3575.5530558680166, 3585.2112535242204, 3702.4816525686424, 31836.20409489758, 32136.517952230733, 32215.19462013445, 32371.676283237102, 32871.67128328734, 4127.731697439687, 4162.354835000579, 4178.289690752579, 4189.790510474464, 4275.5724427557, 360404.0, 360964.0, 361087.0, 362899.0, 364244.0, 37682.24635507275, 62360.0, 62838.68580657068, 62869.428264292845, 62904.0, 38064.809675952, 40340.39489407661, 40406.39390409087, 40452.79773601172, 40500.0, 16311.184440777914, 16415.753763693556, 16418.507444776675, 16433.09617971023, 16444.588885277964, 12028.63914082579, 12147.878521214852, 13442.731145377038, 13738.900887928941, 13804.102733322503, 9310.906890931139, 9343.34596578233, 9458.57436415363, 9551.90448095524, 9563.426194428357, 3520.4015317396106, 3578.5526809148855, 3586.067622418138, 3608.0619039050034, 3620.7646502977223, 1012.8784545854545, 1029.7785976015193, 1106.6071544601712, 1114.1755101225035, 1131.179894576442, 33248.501272480935, 33290.167745806546, 33327.018754299694, 33349.0, 33633.831830841176, 1128.8250321200228, 1170.8302296167178, 1176.3823992403886, 1178.269472926791, 1182.8166634171716, 16863.91568042152, 17710.0, 17720.556986075193, 17969.281228750966, 17991.280348786164, 510323.0, 515291.0, 515331.0, 516484.0, 516622.0, 61014.389856101756, 61572.0, 61596.07605885915, 61736.69131654313, 61780.69109654513, 1291.0897817038965, 1340.6581321762887, 1343.2813444807177, 1419.1626940105386, 1436.4756863744658, 28823.85588072046, 34559.0, 34794.65205347914, 37417.812910935274, 37475.81262093672, 57530.712346438, 57641.42358576528, 58072.41927580839, 58213.70893145507, 58314.7084264576, 446582.0, 448907.0, 450030.24833634467, 450570.0, 451389.0, 29775.70224297729, 30971.69028309688, 31246.68753312438, 37795.62204377921, 38230.0, 45109.548904511845, 47783.5221647793, 47808.04383912233, 51324.74337628288, 52809.47190528046, 42370.0, 42913.0, 43477.56522434735, 43869.34195986999, 43965.36207827541, 42278.365824513276, 43486.56513434825, 43497.13005739804, 43813.34279985739, 44339.0, 42545.36181957335, 43426.782866085465, 43488.0, 43550.34674479822, 43707.12585748331, 35969.28061438704, 38107.42838857364, 38113.80943095267, 38870.22259554736, 39077.6092239074, 28830.135095947157, 29057.418851622428, 29248.41503169967, 29523.261918452212, 29530.852345738134], "value": 20030.360662905965, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.6820080337337, 414.53364964415033, 418.21793246628806, 419.98740037798876, 425.29401194017936, 18868.245270189193, 19645.50886227845, 20038.49903752407, 20206.59586808263, 20254.29109981151, 19891.80108198921, 20365.28721494748, 20519.487012824688, 20643.0, 20748.273810416602, 5783.566232532556, 5966.582339236255, 5978.611390259641, 5978.850528736794, 5982.910256346158, 5703.629264097841, 5812.128180772876, 5909.556783241274, 5974.044152935531, 6003.759849606033, 5839.270091238595, 5844.473997340238, 5846.23998880145, 5852.473277405033, 5909.586328956974, 5671.177679236487, 5835.562332825055, 5877.118432235156, 5902.704864756766, 5903.0, 5244.239585260154, 5296.417394086648, 5308.575313974911, 5312.893742125136, 5313.07021271276, 22991.655125173136, 23000.884995574914, 23178.420539486648, 23273.88363058191, 23601.645975310385, 2348.2250857217077, 2356.952860942789, 2493.7755601995727, 2575.703794063669, 2623.081921327539, 14448.71102577953, 15032.699346013127, 15146.153230966096, 15295.235238238043, 15822.683546329125, 1822.1162736072995, 1835.2016872660301, 1849.4913898677837, 1897.5066482714456, 1934.8742331748533, 81929.77105343365, 82318.58840705758, 82763.58618206931, 83790.0, 84604.0, 10789.24475286738, 10940.070094041936, 11139.888601114048, 11318.943405283086, 11396.544138234543, 15467.613309667124, 15487.922560387125, 15522.223888805514, 15588.454404095803, 15616.219189040503, 8611.655533778703, 8638.654453821902, 8757.693480728143, 8769.816074829816, 8982.191602755784, 8565.657373705106, 8602.096779838026, 8736.06773338864, 8810.559472026373, 8850.64597416109, 6856.0, 6872.0, 6902.551334163263, 6904.240533541307, 6994.860102797916, 1932.4878907089633, 1971.714101455281, 1995.3914056212996, 2006.9899650501945, 2044.2027609232412, 1000.3197825478599, 1004.6684594083935, 1010.802893435773, 1019.5564929255797, 1049.1868801678606, 19516.414507564798, 20380.898095509725, 20509.89745051295, 20609.0, 20645.896770516352, 1051.9737006574896, 1052.8736551613702, 1065.8561094252332, 1082.3938594387012, 1089.411717672448, 10872.007950499235, 11737.941310293394, 11986.580469683693, 11995.100367472474, 12058.698532536582, 438199.0, 450506.0, 450841.0, 452611.0, 454527.0, 72149.39253037432, 72652.27347726561, 97237.0, 98779.50610247046, 100814.0, 1005.7385079879137, 1035.3322107240938, 1083.182197440927, 1084.3006260961636, 1089.1341383600056, 17471.82528174702, 17720.113994299976, 18036.0, 18131.818681813013, 18477.260909563465, 42290.57709422989, 43488.0, 44260.77869610631, 44712.55287447214, 44960.550394495636, 54523.0, 58495.70752146212, 59676.70161649164, 59892.40107598868, 61283.0, 8152.755417337489, 8177.713780017671, 8271.379646526655, 8273.46222495536, 8476.194761497647, 11485.942570287096, 12534.0, 12585.370731463574, 12613.68465788326, 13193.076484645982, 5936.0, 6250.0, 10882.40146791934, 11085.22403431752, 11101.722456938642, 11237.101031917591, 11280.041196498389, 11344.432778361213, 11474.0, 11684.357360345262, 11125.944370278097, 11519.596814111466, 11750.0, 11960.10299227544, 12103.515859365527, 8172.795680107807, 8188.672453101809, 8281.503109813431, 8551.700690475804, 8637.222649961534, 8896.610601045386, 11264.66206013821, 11494.137939654727, 11811.645650630495, 11826.881731182579], "value": 9492.239608872376, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1482.5181815909832, 1493.0295308049767, 1634.9509514714555, 1779.3416435918705, 1782.7236778299368, 8321.958390208049, 8782.429142105759, 8797.516136612483, 8804.64781408743, 8806.603702833372, 7469.701211951529, 7657.9617101914555, 8309.83380332393, 8547.358948078889, 8729.65081396745, 2454.5827209374406, 2478.4547399572157, 2478.834947574637, 2497.6628155198996, 2500.749925007494, 2324.5583339165587, 2403.3150552092657, 2415.4806716555936, 2418.069043418288, 2422.9878850605724, 2440.8169387295934, 2441.951160976779, 2466.519028789387, 2469.3209367423924, 2469.777720005199, 2328.953420931572, 2340.414896275931, 2357.622780355135, 2361.4332560185517, 2362.70466191726, 2405.0379848060743, 2426.0295881647307, 2427.830051896368, 2428.9312702410884, 2432.221689059502, 8509.149085091503, 8599.82800343996, 8672.783180420476, 8677.479351238882, 8686.86969695455, 5310.601704872111, 5431.293931788881, 5434.130539113762, 5439.401665816757, 5448.128299472105, 3458.87893923714, 3537.4340105582983, 3614.27714457107, 3709.51776269086, 3743.625637436262, 1232.3653318540958, 1268.7018550640685, 1280.3470230182581, 1295.66960425091, 1318.7098838255567, 12095.395230238453, 12131.93934030333, 12151.453184606626, 12179.208351457128, 12179.269243845398, 4773.0, 4838.080764654775, 4892.706437613754, 4897.2898929655, 4949.752512374367, 10237.692869213935, 10250.026247506476, 10258.12805911491, 10259.538320775433, 10260.435676037889, 5513.862153446196, 5527.50252477279, 5529.060059789846, 5530.834074977757, 5532.170174473861, 4488.5960263576435, 4755.500672429414, 4988.301637770715, 4997.350344455198, 5044.798208071636, 4144.854930077433, 4200.6429453496185, 4231.7672528010635, 4258.61672449481, 4287.57124287575, 1350.8176396186586, 1353.1745635162542, 1359.2931675528669, 1383.5434306678771, 1395.141987677571, 989.8069876374182, 992.1963209799941, 997.1075887081167, 1000.5497526113278, 1027.5170669785189, 5960.7019649017375, 6006.789762358384, 6043.274807023097, 6085.087236914498, 6286.622802631857, 479.3648415849014, 485.58239913674214, 487.4978771864985, 487.8341363936208, 496.85094471658357, 4014.157027024299, 4063.593640635913, 4212.873613791591, 4367.71609845359, 4466.4640243171025, 10596.629117980834, 10658.520366583522, 10786.083182929382, 10787.946060269649, 10802.891971080346, 10666.78666426667, 10733.409662468639, 10734.677959661223, 10737.35575865435, 10741.462926853626, 7893.368530517545, 8150.4294699370475, 8157.306628936607, 8199.549024803573, 8365.916340836635, 5849.444302791228, 5949.613275137102, 5977.641341519523, 5985.191999080243, 6029.939700602938, 9817.803643926938, 9883.85174222373, 9951.552180152055, 9959.551820168255, 9964.202863770735, 9755.170810481188, 9861.211103111591, 9881.160101391462, 10062.49687515636, 10070.690810194628, 6857.5199736018, 7064.081669382947, 7072.257412971564, 7568.167501574932, 7784.84430311402, 7649.349805266392, 7718.266764657348, 8173.18268173178, 8284.337253019623, 8359.0, 7536.434767392358, 7553.886691699739, 7567.886481702889, 7818.804529886798, 7865.370770338473, 7386.704531818667, 7622.9237707622215, 7636.541807491568, 7709.9614501927135, 7714.6914123434435, 7015.964920175571, 7128.108986376703, 7146.606936618536, 7149.82125446868, 7150.0, 5249.370075590953, 5276.472352764693, 5365.839024829262, 5501.202325662676, 5547.944520554905, 5119.155339369111, 5195.636305458733, 5218.712970786643, 5289.867753306198, 5416.431274716256], "value": 4632.288508978032, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.6117947898354, 360.047673902528, 362.7352033015898, 364.7556137387948, 371.81223482141525, 5369.9463005369935, 5417.566594672427, 5426.647267927582, 5426.728663566821, 5448.700321482317, 5129.179331306992, 5159.71621560814, 5200.921986170201, 5248.81901572146, 5362.329708786402, 4217.304144816117, 4222.247767176618, 4222.577742225783, 4231.873043808675, 4242.681798865082, 4225.0, 4225.6830737694645, 4230.57694230576, 4239.7668128252935, 4274.401583778274, 3983.1436241208135, 4000.8199631016673, 4235.301175306071, 4237.364395340693, 4237.555056719047, 4217.746935183899, 4234.068504928941, 4235.475228917588, 4239.448871646666, 4243.533211346749, 3806.8286927088348, 3810.8856734298015, 3812.580616132251, 3819.732618716691, 3825.7704537727827, 5086.3896332440345, 5176.171812510018, 5227.66020208689, 5252.1071417858675, 5278.815241466568, 4847.175980083359, 4848.200046992242, 4855.247436647325, 4857.077155340474, 4863.586595139417, 5567.972160139214, 5581.888362232733, 5599.776008959637, 5604.99110160171, 5610.69141197234, 3924.4309575111733, 4106.295887206836, 4112.979435102835, 4210.873673789792, 4218.8523401680795, 5772.971135144339, 5801.767929282823, 5812.564057695689, 5836.540864783804, 5878.2064421303, 4238.87283381499, 4255.340422234559, 4256.872293831128, 4258.659307255412, 4264.658827293809, 4212.178625168124, 4244.766537840448, 4299.54854740254, 4314.309710446313, 4323.870283891489, 4847.146518517787, 4849.515048495122, 4856.247281671346, 4865.513448655106, 4879.658423910292, 5689.317281926113, 5690.260266165455, 5700.971495142498, 5702.31572211329, 5709.65742055478, 1399.3842709207916, 1438.8129543159323, 1447.1027962663215, 1449.7970284160226, 1460.5175746617192, 951.1724799424406, 965.666844938495, 981.2836629260537, 1004.5529739266102, 1016.1159790981893, 5334.252859777218, 5347.438518955531, 5362.0, 5371.704556249366, 5383.246345511631, 5464.535514481234, 5488.9725551371985, 5536.889262214814, 5603.6077474577205, 5628.352739434936, 5071.847844564669, 5222.981518603911, 5252.842414727565, 5278.577713782888, 5295.4439783822145, 2921.4224318868, 2936.897208597689, 2938.1185644306624, 2946.3500439753807, 2951.409718056397, 5508.394076651565, 5687.971560142173, 5699.603597118649, 5703.401142879938, 5761.423857614205, 5612.747426365823, 5621.747021384048, 5625.212470254168, 5634.549236061105, 5648.576356773258, 5702.486776190163, 5722.227499287543, 5729.828105156852, 5771.68255745938, 5774.855628609318, 5221.451747566451, 5415.160650099241, 5433.0, 5461.863453413696, 5511.255980442749, 5404.5406140476925, 5408.405075441777, 5452.945470545244, 5453.7545810439415, 5490.588205884655, 5362.490563396471, 5721.596929289792, 5729.28383952006, 5730.452777750067, 5748.712564371681, 4061.7969101545395, 4086.3257562501853, 4090.5500394955934, 4091.3453847384276, 4107.753534787803, 5520.365158006881, 5554.333479982428, 5557.194206840067, 5573.498385145356, 5583.246261754611, 5332.33345831771, 5452.91820622683, 5460.890782184413, 5463.350275116644, 5469.835904922858, 5680.403557626555, 5685.20407142992, 5686.829395118153, 5690.2887139107615, 5695.800646977336, 5412.269343638716, 5531.806386776443, 5669.7165141741925, 5679.659220446786, 5702.800401985911, 5507.862303442446, 5693.658380497183, 5696.487316141402, 5714.228579141929, 5719.542436604978, 5508.20131080999, 5529.30883639545, 5532.723363831873, 5535.308086489189, 5569.19246709233], "value": 4273.1364447018495, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [812.601825105698, 815.991840081599, 843.548701444727, 850.7192626433276, 892.1435421994885, 16305.51083467495, 16771.24529396177, 16909.492715218534, 16911.0, 16937.3225070997, 16137.596560086004, 16139.273732682028, 16189.83810161901, 16207.108609026498, 16468.176591170424, 716.6739133694183, 847.8601030829906, 869.3827382558391, 871.3813192633238, 873.3406278259937, 731.784123683512, 835.9456635318716, 850.5662112322728, 863.9222469977701, 864.6109250837117, 901.1529162587148, 911.699139284038, 911.7948461596154, 911.7994041310934, 911.8085202107566, 741.8442127153304, 893.7452825944574, 895.2479916869828, 896.5069211933411, 897.2642433204775, 564.1058921609255, 641.3298103481826, 658.6673729766437, 660.9173853268342, 663.8605892762478, 15209.163496007715, 15218.923905380403, 15230.771538426932, 15249.542513724495, 15250.923745381202, 14019.859801401957, 14108.858911410856, 14389.424423023067, 14467.638309042253, 14473.78289325661, 13087.280199589019, 13124.868751312555, 13295.468181272738, 13367.997400194927, 14000.929995349958, 4489.887752806173, 4519.638428925678, 4539.0, 4552.635789136861, 4578.5650363215445, 65950.3404965949, 66561.66719166373, 66567.0, 66795.66602166957, 66853.99999999952, 11180.944095279472, 11669.183157179086, 11713.531458741554, 12071.215371000857, 12156.939215304044, 20990.160393584392, 21375.46561335979, 21389.893050534647, 21407.785922140578, 21418.0, 8584.570771461402, 8617.741467755977, 8825.867611985825, 8916.777080573038, 9138.451692898314, 4472.608988853185, 4563.498015218323, 4600.953990460052, 4621.399218101626, 4791.712497250106, 3552.786832790041, 3618.9819050904575, 3645.3620616392027, 3658.835352409148, 3673.7428380013143, 658.8239991614944, 660.4155322539491, 661.890788019981, 663.5255792108666, 663.7444583835162, 663.1180529895228, 734.772220611612, 740.2227660955974, 798.3014861995754, 811.4725428471422, 9757.658481953098, 9768.36505627132, 10006.79986400268, 10373.425382167008, 10617.416042117758, 668.0747165176169, 699.1260923845193, 711.9537230080028, 729.6643543969833, 815.7389635316641, 4592.812887236679, 4859.975700121548, 5054.631263756956, 5107.948920510822, 5124.084984824174, 45973.54026459759, 50605.74697126491, 52157.47842521526, 52530.737346313785, 52570.47429525732, 69859.65070174719, 71753.6412317935, 72424.63787681134, 72847.63576182086, 73371.26628733751, 62416.68791656013, 64836.351636483974, 65057.67471162614, 65248.34751652517, 67825.0, 9461.290403219924, 9689.563969621244, 9695.951520242354, 9706.660266890625, 9755.122039016522, 42749.0, 43428.78285608552, 43558.56441435545, 44464.0, 44675.10649786921, 55076.72461637826, 55943.440565593824, 60971.0, 61214.69392653008, 63293.36706633059, 11777.941110294394, 11954.641360759191, 12263.0, 12690.682732931751, 12709.428075736429, 14118.223497707724, 14365.353559090076, 14562.344694488986, 15277.694446111238, 15801.0, 11713.648590542298, 13944.651383715489, 14304.356303966555, 14445.205513696848, 14760.778588320969, 12552.748945020865, 13786.0, 13853.376598053314, 14153.858461415253, 14392.496262630757, 13771.862281377058, 14044.157350558999, 14155.858441415867, 14331.277057359068, 14666.560003199495, 10621.946890265499, 10725.517351719036, 11733.237339572901, 12162.087843411957, 12333.62999110028, 11661.883381166079, 11709.473073711533, 11734.882651173379, 11884.881151188378, 11945.82081268799], "value": 7390.63738337622, "unit": "score"}], "name": "dromaeo_css", "value": 7328.140753019844, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 109.0, 112.0, 111.0, 110.0, 113.0, 110.0, 111.0, 110.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 118.0, 122.0, 162.0, 117.0, 117.0, 118.0, 117.0, 156.0, 120.0], "value": 129.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 162.0, 159.0, 161.0, 161.0, 161.0, 160.0, 162.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 109.0, 76.0, 76.0, 85.0, 76.0, 101.0, 75.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 121.0, 82.0, 81.0, 81.0, 97.0, 81.0, 81.0, 106.0], "value": 89.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 118.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": [146.0, 146.0, 147.0, 146.0, 146.0, 145.0, 146.0, 147.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 85.0, 85.0, 84.0, 84.0, 84.0, 84.0, 84.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 50.0, 49.0, 50.0, 49.0, 49.0, 50.0, 49.0, 51.0, 51.0], "value": 49.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 60.0, 60.0, 60.0, 60.0, 59.0, 60.0, 60.0, 59.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 82.0, 74.0, 76.0, 75.0, 76.0, 76.0, 74.0, 80.0, 74.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 136.0, 121.0, 125.0, 123.0, 124.0, 127.0, 117.0, 165.0, 122.0], "value": 128.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 152.0, 154.0, 154.0, 158.0, 156.0, 158.0, 153.0, 152.0, 159.0], "value": 155.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 62.0, 69.0, 62.0, 63.0, 62.0, 68.0, 60.0, 62.0], "value": 63.5, "unit": "score"}], "name": "kraken", "value": 1452.3, "alertThreshold": 2.0}]} 06:06:12 INFO - Return code: 0 06:06:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:06:12 INFO - # TBPL SUCCESS # 06:06:12 INFO - Running post-action listener: _resource_record_post_action 06:06:12 INFO - [mozharness: 2016-12-21 14:06:12.068448Z] Finished run-tests step (success) 06:06:12 INFO - Running post-run listener: _resource_record_post_run 06:06:12 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 262144; Write bytes: 356536320; Read time: 8; Write time: 255736 06:06:12 INFO - TinderboxPrint: CPU usage
13.0% 06:06:12 INFO - TinderboxPrint: I/O read bytes / time
262,144 / 8 06:06:12 INFO - TinderboxPrint: I/O write bytes / time
356,536,320 / 255,736 06:06:12 INFO - TinderboxPrint: CPU idle
8,276.5 (87.0%) 06:06:12 INFO - TinderboxPrint: CPU user
1,193.0 (12.5%) 06:06:12 INFO - TinderboxPrint: Swap in / out
0 / 0 06:06:12 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108171264; Read time: 0; Write time: 113420 06:06:12 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 262144; Write bytes: 248037376; Read time: 8; Write time: 142280 06:06:12 INFO - Running post-run listener: _upload_blobber_files 06:06:12 INFO - Blob upload gear active. 06:06:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:06:12 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 06:06:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:06:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:06:13 INFO - (blobuploader) - INFO - Open directory for files ... 06:06:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:06:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:06:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:13 INFO - (blobuploader) - INFO - Done attempting. 06:06:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:06:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:06:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:14 INFO - (blobuploader) - INFO - Done attempting. 06:06:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:06:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:06:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:17 INFO - (blobuploader) - INFO - Done attempting. 06:06:17 INFO - (blobuploader) - INFO - Iteration through files over. 06:06:17 INFO - Return code: 0 06:06:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:06:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:06:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2b4d4d37cc254c5b9f696d8e587f54a6b497d5d54e71873efcfdabe4379088320469565b2f782eed0f4a16d45b152a61dc869d3f77c25dce68255b2ae5c602a7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0f8def729d0bc43f6c30f04ca4a133c667a94161c0abef8a7795d141e8750730e667800fbdd3efe5e0a5c067ea16c1ce61e5e0064a64352f3b810172e4de9270", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30a542c6eb6d842b3ed1c3f23dce8277af5b146b61d9a6c207cfc197d24f7c2caa853be3d951cb1484bdfd89b14e3e9f13754a774eb5b704a9f93c635134592f"} 06:06:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:06:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:06:17 INFO - Contents: 06:06:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2b4d4d37cc254c5b9f696d8e587f54a6b497d5d54e71873efcfdabe4379088320469565b2f782eed0f4a16d45b152a61dc869d3f77c25dce68255b2ae5c602a7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0f8def729d0bc43f6c30f04ca4a133c667a94161c0abef8a7795d141e8750730e667800fbdd3efe5e0a5c067ea16c1ce61e5e0064a64352f3b810172e4de9270", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30a542c6eb6d842b3ed1c3f23dce8277af5b146b61d9a6c207cfc197d24f7c2caa853be3d951cb1484bdfd89b14e3e9f13754a774eb5b704a9f93c635134592f"} 06:06:17 INFO - Running post-run listener: copy_logs_to_upload_dir 06:06:17 INFO - Copying logs to upload dir... 06:06:17 INFO - mkdir: /builds/slave/test/build/upload/logs 06:06:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.672307 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-12-21 06:06:16.959446) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 06:06:16.963395) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1482326981.243818-1268270434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2b4d4d37cc254c5b9f696d8e587f54a6b497d5d54e71873efcfdabe4379088320469565b2f782eed0f4a16d45b152a61dc869d3f77c25dce68255b2ae5c602a7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0f8def729d0bc43f6c30f04ca4a133c667a94161c0abef8a7795d141e8750730e667800fbdd3efe5e0a5c067ea16c1ce61e5e0064a64352f3b810172e4de9270", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30a542c6eb6d842b3ed1c3f23dce8277af5b146b61d9a6c207cfc197d24f7c2caa853be3d951cb1484bdfd89b14e3e9f13754a774eb5b704a9f93c635134592f"} build_url:https://queue.taskcluster.net/v1/task/dCt6jV22QwCr1bywOlfViQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011582 build_url: 'https://queue.taskcluster.net/v1/task/dCt6jV22QwCr1bywOlfViQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2b4d4d37cc254c5b9f696d8e587f54a6b497d5d54e71873efcfdabe4379088320469565b2f782eed0f4a16d45b152a61dc869d3f77c25dce68255b2ae5c602a7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0f8def729d0bc43f6c30f04ca4a133c667a94161c0abef8a7795d141e8750730e667800fbdd3efe5e0a5c067ea16c1ce61e5e0064a64352f3b810172e4de9270", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30a542c6eb6d842b3ed1c3f23dce8277af5b146b61d9a6c207cfc197d24f7c2caa853be3d951cb1484bdfd89b14e3e9f13754a774eb5b704a9f93c635134592f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 06:06:16.989539) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 06:06:16.989885) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1482326981.243818-1268270434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004396 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 06:06:17.073886) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 06:06:17.074196) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 06:06:17.074505) ========= ========= Total master_lag: 0.16 =========