builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-036 starttime: 1475890007.1 results: success (0) buildid: 20161007153015 builduid: 6771b61defc04947841d604811a09d75 revision: efa3b654aa77bcb9b3dd7fc5a52efb6b5afc34d6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 18:26:47.100182) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 18:26:47.100818) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 18:26:47.101093) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 18:26:47.145449) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 18:26:47.145696) ========= 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=14ef55db36f7623abb31b9cf000001d5-1475888958.767880-192553756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-07 18:26:47-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 32.1M=0s 2016-10-07 18:26:47 (32.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086572 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 18:26:47.259223) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 18:26:47.259505) ========= 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=14ef55db36f7623abb31b9cf000001d5-1475888958.767880-192553756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022843 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 18:26:47.311743) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 18:26:47.312558) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev efa3b654aa77bcb9b3dd7fc5a52efb6b5afc34d6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev efa3b654aa77bcb9b3dd7fc5a52efb6b5afc34d6 --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=14ef55db36f7623abb31b9cf000001d5-1475888958.767880-192553756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-07 18:26:47,391 truncating revision to first 12 chars 2016-10-07 18:26:47,391 Setting DEBUG logging. 2016-10-07 18:26:47,391 attempt 1/10 2016-10-07 18:26:47,391 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/efa3b654aa77?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-07 18:26:47,714 unpacking tar archive at: fx-team-efa3b654aa77/testing/mozharness/ program finished with exit code 0 elapsedTime=0.634275 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 18:26:47.963802) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 18:26:47.964115) ========= script_repo_revision: efa3b654aa77bcb9b3dd7fc5a52efb6b5afc34d6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 18:26:47.964560) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 18:26:47.964869) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 18:26:47.973853) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-07 18:26:47.974175) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=14ef55db36f7623abb31b9cf000001d5-1475888958.767880-192553756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:26:48 INFO - MultiFileLogger online at 20161007 18:26:48 in /builds/slave/test 18:26:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 18:26:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:26:48 INFO - {'append_to_log': False, 18:26:48 INFO - 'base_work_dir': '/builds/slave/test', 18:26:48 INFO - 'blob_upload_branch': 'Fx-Team', 18:26:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:26:48 INFO - 'branch': 'Fx-Team', 18:26:48 INFO - 'buildbot_json_path': 'buildprops.json', 18:26:48 INFO - 'config_files': ('talos/linux_config.py',), 18:26:48 INFO - 'default_actions': ('clobber', 18:26:48 INFO - 'read-buildbot-config', 18:26:48 INFO - 'download-and-extract', 18:26:48 INFO - 'populate-webroot', 18:26:48 INFO - 'create-virtualenv', 18:26:48 INFO - 'install', 18:26:48 INFO - 'run-tests'), 18:26:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:26:48 INFO - 'download_minidump_stackwalk': True, 18:26:48 INFO - 'download_symbols': 'ondemand', 18:26:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:26:48 INFO - 'tooltool.py': '/tools/tooltool.py', 18:26:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:26:48 INFO - '/tools/misc-python/virtualenv.py')}, 18:26:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:26:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:26:48 INFO - 'installer_path': 'installer.exe', 18:26:48 INFO - 'log_level': 'info', 18:26:48 INFO - 'log_name': 'talos', 18:26:48 INFO - 'log_to_console': True, 18:26:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:26:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:26:48 INFO - 'opt_config_files': (), 18:26:48 INFO - 'pip_index': False, 18:26:48 INFO - 'sps_profile': False, 18:26:48 INFO - 'sps_profile_interval': 0, 18:26:48 INFO - 'suite': 'dromaeojs', 18:26:48 INFO - 'system_bits': '32', 18:26:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:26:48 INFO - 'title': 'talos-linux64-ix-036', 18:26:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:26:48 INFO - 'use_talos_json': True, 18:26:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:26:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:26:48 INFO - 'work_dir': 'build'} 18:26:48 INFO - [mozharness: 2016-10-08 01:26:48.141871Z] Running clobber step. 18:26:48 INFO - Running pre-action listener: _resource_record_pre_action 18:26:48 INFO - Running main action method: clobber 18:26:48 INFO - rmtree: /builds/slave/test/build 18:26:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:26:49 INFO - Running post-action listener: _resource_record_post_action 18:26:49 INFO - [mozharness: 2016-10-08 01:26:49.105193Z] Finished clobber step (success) 18:26:49 INFO - [mozharness: 2016-10-08 01:26:49.105293Z] Running read-buildbot-config step. 18:26:49 INFO - Running pre-action listener: _resource_record_pre_action 18:26:49 INFO - Running main action method: read_buildbot_config 18:26:49 INFO - Using buildbot properties: 18:26:49 INFO - { 18:26:49 INFO - "project": "", 18:26:49 INFO - "product": "firefox", 18:26:49 INFO - "script_repo_revision": "production", 18:26:49 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 18:26:49 INFO - "repository": "", 18:26:49 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 18:26:49 INFO - "buildid": "20161007153015", 18:26:49 INFO - "pgo_build": "True", 18:26:49 INFO - "basedir": "/builds/slave/test", 18:26:49 INFO - "buildnumber": 518, 18:26:49 INFO - "slavename": "talos-linux64-ix-036", 18:26:49 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:26:49 INFO - "platform": "ubuntu64_hw", 18:26:49 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 18:26:49 INFO - "branch": "fx-team", 18:26:49 INFO - "repo_path": "integration/fx-team", 18:26:49 INFO - "revision": "efa3b654aa77bcb9b3dd7fc5a52efb6b5afc34d6", 18:26:49 INFO - "stage_platform": "linux64-pgo", 18:26:49 INFO - "builduid": "6771b61defc04947841d604811a09d75", 18:26:49 INFO - "slavebuilddir": "test" 18:26:49 INFO - } 18:26:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z2BLx0myRnygCH5IkqhV6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 18:26:49 INFO - Running post-action listener: _resource_record_post_action 18:26:49 INFO - [mozharness: 2016-10-08 01:26:49.107755Z] Finished read-buildbot-config step (success) 18:26:49 INFO - [mozharness: 2016-10-08 01:26:49.107843Z] Running download-and-extract step. 18:26:49 INFO - Running pre-action listener: _resource_record_pre_action 18:26:49 INFO - Running main action method: download_and_extract 18:26:49 INFO - mkdir: /builds/slave/test/build/tests 18:26:49 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')]} 18:26:49 INFO - trying https://queue.taskcluster.net/v1/task/Z2BLx0myRnygCH5IkqhV6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:26:49 INFO - Downloading https://queue.taskcluster.net/v1/task/Z2BLx0myRnygCH5IkqhV6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:26:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z2BLx0myRnygCH5IkqhV6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:26:49 INFO - Downloaded 1361 bytes. 18:26:49 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:26:49 INFO - Using the following test package requirements: 18:26:49 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:26:49 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:26:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:26:49 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:26:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:26:49 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:26:49 INFO - u'jsshell-linux-x86_64.zip'], 18:26:49 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:26:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:26:49 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:26:49 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:26:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:26:49 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:26:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:26:49 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:26:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:26:49 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:26:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:26:49 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:26:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z2BLx0myRnygCH5IkqhV6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:26:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z2BLx0myRnygCH5IkqhV6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:26:49 INFO - Fetch https://queue.taskcluster.net/v1/task/Z2BLx0myRnygCH5IkqhV6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:26:50 INFO - Http code: 200 18:26:50 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 18:26:50 INFO - x-amz-cf-id: CdSiGG4Tze1ICsk-muFcSMd5PyQGSUcQVbvGv6eG4TvyrN_1WLpgsg== 18:26:50 INFO - x-amz-version-id: uvNFm5lIuv1ZeooxB7sILvJ6ujBAlR9g 18:26:50 INFO - Expected file size: 22038471 18:26:50 INFO - Obtained file size: 22038471 18:26:54 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:26:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z2BLx0myRnygCH5IkqhV6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:26:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z2BLx0myRnygCH5IkqhV6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:26:54 INFO - Fetch https://queue.taskcluster.net/v1/task/Z2BLx0myRnygCH5IkqhV6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:26:55 INFO - Http code: 200 18:26:55 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 18:26:55 INFO - x-amz-cf-id: XxbIBSp4hSyjGjnRiGcaXCQfErkVjrp6RcBQu0fKbyPIPijdNFiEtg== 18:26:55 INFO - x-amz-version-id: uvNFm5lIuv1ZeooxB7sILvJ6ujBAlR9g 18:26:55 INFO - Expected file size: 22038471 18:26:55 INFO - Obtained file size: 22038471 18:26:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z2BLx0myRnygCH5IkqhV6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 18:26:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z2BLx0myRnygCH5IkqhV6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:26:59 INFO - Fetch https://queue.taskcluster.net/v1/task/Z2BLx0myRnygCH5IkqhV6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 18:27:00 INFO - Http code: 200 18:27:00 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 18:27:00 INFO - x-amz-cf-id: FFwLqHeS3qggag6l45rXp31JEzBkGerpAiK2EfSIn-8YejAZzNI8Mg== 18:27:00 INFO - x-amz-version-id: aaPISng._jcKf3DS.9HchRT_6wB3A1JF 18:27:00 INFO - Expected file size: 14409006 18:27:00 INFO - Obtained file size: 14409006 18:27:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:27:00 INFO - trying https://queue.taskcluster.net/v1/task/Z2BLx0myRnygCH5IkqhV6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:27:00 INFO - Downloading https://queue.taskcluster.net/v1/task/Z2BLx0myRnygCH5IkqhV6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:27:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z2BLx0myRnygCH5IkqhV6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:27:02 INFO - Downloaded 59708157 bytes. 18:27:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z2BLx0myRnygCH5IkqhV6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:27:02 INFO - mkdir: /builds/slave/test/properties 18:27:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:27:02 INFO - Writing to file /builds/slave/test/properties/build_url 18:27:02 INFO - Contents: 18:27:02 INFO - build_url:https://queue.taskcluster.net/v1/task/Z2BLx0myRnygCH5IkqhV6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:27:02 INFO - Running post-action listener: _resource_record_post_action 18:27:02 INFO - Running post-action listener: set_extra_try_arguments 18:27:02 INFO - [mozharness: 2016-10-08 01:27:02.721324Z] Finished download-and-extract step (success) 18:27:02 INFO - [mozharness: 2016-10-08 01:27:02.721722Z] Running populate-webroot step. 18:27:02 INFO - Running pre-action listener: _resource_record_pre_action 18:27:02 INFO - Running main action method: populate_webroot 18:27:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:27:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:27:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:27:02 INFO - '--tppagecycles', 18:27:02 INFO - '7'], 18:27:02 INFO - 'tests': ['tsvgm']}}, 18:27:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:27:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:27:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:27:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:27:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:27:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:27:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:27:02 INFO - 'talos_options': ['--disable-e10s'], 18:27:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:27:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:27:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:27:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:27:02 INFO - 'talos_options': ['--disable-e10s'], 18:27:02 INFO - 'tests': ['damp', 'tps']}, 18:27:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:27:02 INFO - 'tests': ['damp', 'tps']}, 18:27:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:27:02 INFO - 'tests': ['dromaeo_dom']}, 18:27:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:27:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:27:02 INFO - 'tests': ['basic_compositor_video']}, 18:27:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:27:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:27:02 INFO - 'tests': ['a11yr', 18:27:02 INFO - 'ts_paint', 18:27:02 INFO - 'tpaint', 18:27:02 INFO - 'sessionrestore', 18:27:02 INFO - 'sessionrestore_no_auto_restore', 18:27:02 INFO - 'tabpaint']}, 18:27:02 INFO - 'other-e10s': {'tests': ['a11yr', 18:27:02 INFO - 'ts_paint', 18:27:02 INFO - 'tpaint', 18:27:02 INFO - 'sessionrestore', 18:27:02 INFO - 'sessionrestore_no_auto_restore', 18:27:02 INFO - 'tabpaint']}, 18:27:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:27:02 INFO - 'ts_paint', 18:27:02 INFO - 'tpaint', 18:27:02 INFO - 'sessionrestore', 18:27:02 INFO - 'sessionrestore_no_auto_restore', 18:27:02 INFO - 'tabpaint']}, 18:27:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:27:02 INFO - 'ts_paint', 18:27:02 INFO - 'tpaint', 18:27:02 INFO - 'sessionrestore', 18:27:02 INFO - 'sessionrestore_no_auto_restore', 18:27:02 INFO - 'tabpaint']}, 18:27:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:27:02 INFO - 'tests': ['a11yr', 18:27:02 INFO - 'ts_paint', 18:27:02 INFO - 'tpaint', 18:27:02 INFO - 'sessionrestore', 18:27:02 INFO - 'sessionrestore_no_auto_restore', 18:27:02 INFO - 'tabpaint']}, 18:27:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:27:02 INFO - 'tests': ['a11yr', 18:27:02 INFO - 'ts_paint', 18:27:02 INFO - 'tpaint', 18:27:02 INFO - 'sessionrestore', 18:27:02 INFO - 'sessionrestore_no_auto_restore', 18:27:02 INFO - 'tabpaint']}, 18:27:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:27:02 INFO - 'tests': ['tsvgx', 18:27:02 INFO - 'tsvgr_opacity', 18:27:02 INFO - 'tart', 18:27:02 INFO - 'tscrollx', 18:27:02 INFO - 'cart']}, 18:27:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:27:02 INFO - 'tsvgr_opacity', 18:27:02 INFO - 'tart', 18:27:02 INFO - 'tscrollx', 18:27:02 INFO - 'cart']}, 18:27:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:27:02 INFO - 'talos_options': ['--disable-e10s'], 18:27:02 INFO - 'tests': ['tp5o']}, 18:27:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:27:02 INFO - 'tests': ['tp5o']}, 18:27:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:27:02 INFO - 'talos_options': ['--disable-e10s', 18:27:02 INFO - '--xperf_path', 18:27:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:27:02 INFO - 'tests': ['tp5n']}, 18:27:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:27:02 INFO - 'talos_options': ['--xperf_path', 18:27:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:27:02 INFO - 'tests': ['tp5n']}}, 18:27:02 INFO - 'talos.zip': {'path': '', 18:27:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:27:02 INFO - Running post-action listener: _resource_record_post_action 18:27:02 INFO - [mozharness: 2016-10-08 01:27:02.744506Z] Finished populate-webroot step (success) 18:27:02 INFO - [mozharness: 2016-10-08 01:27:02.744599Z] Running create-virtualenv step. 18:27:02 INFO - Running pre-action listener: _resource_record_pre_action 18:27:02 INFO - Running main action method: create_virtualenv 18:27:02 INFO - Creating virtualenv /builds/slave/test/build/venv 18:27:02 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 18:27:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:27:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:27:02 INFO - Using real prefix '/usr' 18:27:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:27:03 INFO - Installing distribute.............................................................................................................................................................................................done. 18:27:05 INFO - Installing pip.................done. 18:27:05 INFO - Return code: 0 18:27:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:27:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:27:05 INFO - Reading from file tmpfile_stdout 18:27:05 INFO - Output received: 18:27:05 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) 18:27:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:27:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:27:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6eccbdef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2788790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2785930>, '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 0x2786830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2786cc0>, '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': '14ef55db36f7623abb31b9cf000001d5-1475888958.767880-192553756', '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 18:27:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:27:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:27:05 INFO - Using env: {'DISPLAY': ':0', 18:27:05 INFO - 'HOME': '/home/cltbld', 18:27:05 INFO - 'LANG': 'en_US.UTF-8', 18:27:05 INFO - 'LANGUAGE': 'en_US:en', 18:27:05 INFO - 'LOGNAME': 'cltbld', 18:27:05 INFO - 'MAIL': '/var/mail/cltbld', 18:27:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:05 INFO - 'MOZ_NO_REMOTE': '1', 18:27:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:05 INFO - 'NO_EM_RESTART': '1', 18:27:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:05 INFO - 'PWD': '/builds/slave/test', 18:27:05 INFO - 'SHELL': '/bin/bash', 18:27:05 INFO - 'SHLVL': '1', 18:27:05 INFO - 'TERM': 'linux', 18:27:05 INFO - 'TMOUT': '86400', 18:27:05 INFO - 'USER': 'cltbld', 18:27:05 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475888958.767880-192553756', 18:27:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:05 INFO - '_': '/tools/buildbot/bin/python'} 18:27:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:05 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 18:27:05 INFO - Cleaning up... 18:27:05 INFO - Return code: 0 18:27:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:27:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:27:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6eccbdef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2788790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2785930>, '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 0x2786830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2786cc0>, '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': '14ef55db36f7623abb31b9cf000001d5-1475888958.767880-192553756', '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 18:27:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:27:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:27:05 INFO - Using env: {'DISPLAY': ':0', 18:27:05 INFO - 'HOME': '/home/cltbld', 18:27:05 INFO - 'LANG': 'en_US.UTF-8', 18:27:05 INFO - 'LANGUAGE': 'en_US:en', 18:27:05 INFO - 'LOGNAME': 'cltbld', 18:27:05 INFO - 'MAIL': '/var/mail/cltbld', 18:27:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:05 INFO - 'MOZ_NO_REMOTE': '1', 18:27:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:05 INFO - 'NO_EM_RESTART': '1', 18:27:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:05 INFO - 'PWD': '/builds/slave/test', 18:27:05 INFO - 'SHELL': '/bin/bash', 18:27:05 INFO - 'SHLVL': '1', 18:27:05 INFO - 'TERM': 'linux', 18:27:05 INFO - 'TMOUT': '86400', 18:27:05 INFO - 'USER': 'cltbld', 18:27:05 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475888958.767880-192553756', 18:27:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:05 INFO - '_': '/tools/buildbot/bin/python'} 18:27:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:05 INFO - Downloading/unpacking psutil>=3.1.1 18:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:27:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:27:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:27:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:27:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:27:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:27:07 INFO - Installing collected packages: psutil 18:27:07 INFO - Running setup.py install for psutil 18:27:08 INFO - building 'psutil._psutil_linux' extension 18:27:08 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 18:27:08 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 18:27:08 INFO - building 'psutil._psutil_posix' extension 18:27:08 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 18:27:08 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 18:27:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:27:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:27:08 INFO - Successfully installed psutil 18:27:08 INFO - Cleaning up... 18:27:08 INFO - Return code: 0 18:27:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:27:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6eccbdef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2788790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2785930>, '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 0x2786830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2786cc0>, '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': '14ef55db36f7623abb31b9cf000001d5-1475888958.767880-192553756', '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 18:27:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:27:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:27:08 INFO - Using env: {'DISPLAY': ':0', 18:27:08 INFO - 'HOME': '/home/cltbld', 18:27:08 INFO - 'LANG': 'en_US.UTF-8', 18:27:08 INFO - 'LANGUAGE': 'en_US:en', 18:27:08 INFO - 'LOGNAME': 'cltbld', 18:27:08 INFO - 'MAIL': '/var/mail/cltbld', 18:27:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:08 INFO - 'MOZ_NO_REMOTE': '1', 18:27:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:08 INFO - 'NO_EM_RESTART': '1', 18:27:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:08 INFO - 'PWD': '/builds/slave/test', 18:27:08 INFO - 'SHELL': '/bin/bash', 18:27:08 INFO - 'SHLVL': '1', 18:27:08 INFO - 'TERM': 'linux', 18:27:08 INFO - 'TMOUT': '86400', 18:27:08 INFO - 'USER': 'cltbld', 18:27:08 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475888958.767880-192553756', 18:27:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:08 INFO - '_': '/tools/buildbot/bin/python'} 18:27:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:27:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:27:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:27:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:27:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:27:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:27:10 INFO - Installing collected packages: mozsystemmonitor 18:27:10 INFO - Running setup.py install for mozsystemmonitor 18:27:10 INFO - Successfully installed mozsystemmonitor 18:27:10 INFO - Cleaning up... 18:27:10 INFO - Return code: 0 18:27:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:27:10 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')]} 18:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:10 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')]} 18:27:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:10 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 0x7f6eccbdef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2788790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2785930>, '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 0x2786830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2786cc0>, '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': '14ef55db36f7623abb31b9cf000001d5-1475888958.767880-192553756', '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 18:27:10 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 18:27:10 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 18:27:10 INFO - Using env: {'DISPLAY': ':0', 18:27:10 INFO - 'HOME': '/home/cltbld', 18:27:10 INFO - 'LANG': 'en_US.UTF-8', 18:27:10 INFO - 'LANGUAGE': 'en_US:en', 18:27:10 INFO - 'LOGNAME': 'cltbld', 18:27:10 INFO - 'MAIL': '/var/mail/cltbld', 18:27:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:10 INFO - 'MOZ_NO_REMOTE': '1', 18:27:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:10 INFO - 'NO_EM_RESTART': '1', 18:27:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:10 INFO - 'PWD': '/builds/slave/test', 18:27:10 INFO - 'SHELL': '/bin/bash', 18:27:10 INFO - 'SHLVL': '1', 18:27:10 INFO - 'TERM': 'linux', 18:27:10 INFO - 'TMOUT': '86400', 18:27:10 INFO - 'USER': 'cltbld', 18:27:10 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475888958.767880-192553756', 18:27:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:10 INFO - '_': '/tools/buildbot/bin/python'} 18:27:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:11 INFO - Downloading/unpacking jsonschema==2.5.1 18:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:27:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:27:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:27:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:27:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:27:12 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 18:27:12 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 18:27:12 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 18:27:12 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 18:27:12 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 18:27:12 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 18:27:13 INFO - Downloading functools32-3.2.3-2.tar.gz 18:27:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:27:13 INFO - warning: no files found matching '*.txt' 18:27:13 INFO - no previously-included directories found matching 'build' 18:27:13 INFO - no previously-included directories found matching 'dist' 18:27:13 INFO - no previously-included directories found matching '.git*' 18:27:13 INFO - Installing collected packages: jsonschema, functools32 18:27:13 INFO - Running setup.py install for functools32 18:27:13 INFO - warning: no files found matching '*.txt' 18:27:13 INFO - no previously-included directories found matching 'build' 18:27:13 INFO - no previously-included directories found matching 'dist' 18:27:13 INFO - no previously-included directories found matching '.git*' 18:27:13 INFO - Successfully installed jsonschema functools32 18:27:13 INFO - Cleaning up... 18:27:13 INFO - Return code: 0 18:27:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:27:13 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')]} 18:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:13 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')]} 18:27:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:13 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 0x7f6eccbdef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2788790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2785930>, '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 0x2786830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2786cc0>, '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': '14ef55db36f7623abb31b9cf000001d5-1475888958.767880-192553756', '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 18:27:13 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 18:27:13 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 18:27:13 INFO - Using env: {'DISPLAY': ':0', 18:27:13 INFO - 'HOME': '/home/cltbld', 18:27:13 INFO - 'LANG': 'en_US.UTF-8', 18:27:13 INFO - 'LANGUAGE': 'en_US:en', 18:27:13 INFO - 'LOGNAME': 'cltbld', 18:27:13 INFO - 'MAIL': '/var/mail/cltbld', 18:27:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:13 INFO - 'MOZ_NO_REMOTE': '1', 18:27:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:13 INFO - 'NO_EM_RESTART': '1', 18:27:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:13 INFO - 'PWD': '/builds/slave/test', 18:27:13 INFO - 'SHELL': '/bin/bash', 18:27:13 INFO - 'SHLVL': '1', 18:27:13 INFO - 'TERM': 'linux', 18:27:13 INFO - 'TMOUT': '86400', 18:27:13 INFO - 'USER': 'cltbld', 18:27:13 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475888958.767880-192553756', 18:27:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:13 INFO - '_': '/tools/buildbot/bin/python'} 18:27:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:27:13 INFO - Cleaning up... 18:27:13 INFO - Return code: 0 18:27:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:27:13 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')]} 18:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:13 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')]} 18:27:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:13 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 0x7f6eccbdef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2788790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2785930>, '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 0x2786830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2786cc0>, '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': '14ef55db36f7623abb31b9cf000001d5-1475888958.767880-192553756', '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 18:27:13 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 18:27:13 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 18:27:13 INFO - Using env: {'DISPLAY': ':0', 18:27:13 INFO - 'HOME': '/home/cltbld', 18:27:13 INFO - 'LANG': 'en_US.UTF-8', 18:27:13 INFO - 'LANGUAGE': 'en_US:en', 18:27:13 INFO - 'LOGNAME': 'cltbld', 18:27:13 INFO - 'MAIL': '/var/mail/cltbld', 18:27:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:13 INFO - 'MOZ_NO_REMOTE': '1', 18:27:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:13 INFO - 'NO_EM_RESTART': '1', 18:27:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:13 INFO - 'PWD': '/builds/slave/test', 18:27:13 INFO - 'SHELL': '/bin/bash', 18:27:13 INFO - 'SHLVL': '1', 18:27:13 INFO - 'TERM': 'linux', 18:27:13 INFO - 'TMOUT': '86400', 18:27:13 INFO - 'USER': 'cltbld', 18:27:13 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475888958.767880-192553756', 18:27:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:13 INFO - '_': '/tools/buildbot/bin/python'} 18:27:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:13 INFO - Downloading/unpacking blobuploader==1.2.4 18:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:27:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:27:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:27:15 INFO - Downloading blobuploader-1.2.4.tar.gz 18:27:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:27:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:27:15 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 18:27:15 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 18:27:15 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 18:27:15 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 18:27:15 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 18:27:15 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 18:27:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:27:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:27: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 18:27: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 18:27: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 18:27: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 18:27: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 18:27: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 18:27:16 INFO - Downloading docopt-0.6.1.tar.gz 18:27:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:27:16 INFO - Installing collected packages: blobuploader, requests, docopt 18:27:16 INFO - Running setup.py install for blobuploader 18:27:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:27:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:27:16 INFO - Running setup.py install for requests 18:27:16 INFO - Running setup.py install for docopt 18:27:17 INFO - Successfully installed blobuploader requests docopt 18:27:17 INFO - Cleaning up... 18:27:17 INFO - Return code: 0 18:27:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:27:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:27:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:17 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 0x7f6eccbdef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2788790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2785930>, '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 0x2786830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2786cc0>, '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': '14ef55db36f7623abb31b9cf000001d5-1475888958.767880-192553756', '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 18:27:17 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 18:27:17 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 18:27:17 INFO - Using env: {'DISPLAY': ':0', 18:27:17 INFO - 'HOME': '/home/cltbld', 18:27:17 INFO - 'LANG': 'en_US.UTF-8', 18:27:17 INFO - 'LANGUAGE': 'en_US:en', 18:27:17 INFO - 'LOGNAME': 'cltbld', 18:27:17 INFO - 'MAIL': '/var/mail/cltbld', 18:27:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:17 INFO - 'MOZ_NO_REMOTE': '1', 18:27:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:17 INFO - 'NO_EM_RESTART': '1', 18:27:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:17 INFO - 'PWD': '/builds/slave/test', 18:27:17 INFO - 'SHELL': '/bin/bash', 18:27:17 INFO - 'SHLVL': '1', 18:27:17 INFO - 'TERM': 'linux', 18:27:17 INFO - 'TMOUT': '86400', 18:27:17 INFO - 'USER': 'cltbld', 18:27:17 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475888958.767880-192553756', 18:27:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:17 INFO - '_': '/tools/buildbot/bin/python'} 18:27:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:27:17 INFO - Running setup.py (path:/tmp/pip-CWwIH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:27:17 INFO - Running setup.py (path:/tmp/pip-JsJ5Yc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:27:17 INFO - Running setup.py (path:/tmp/pip-7q69xa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:27:17 INFO - Running setup.py (path:/tmp/pip-1mLrCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:27:17 INFO - Running setup.py (path:/tmp/pip-eymbYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:27:17 INFO - Running setup.py (path:/tmp/pip-DcN_Ha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:27:17 INFO - Running setup.py (path:/tmp/pip-7cr_av-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:27:17 INFO - Running setup.py (path:/tmp/pip-krvuIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:27:17 INFO - Running setup.py (path:/tmp/pip-QlwUbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:27:17 INFO - Running setup.py (path:/tmp/pip-t5CV5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:27:18 INFO - Running setup.py (path:/tmp/pip-Wq2t81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:27:18 INFO - Running setup.py (path:/tmp/pip-6GymxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:27:18 INFO - Running setup.py (path:/tmp/pip-fLaM_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:27:18 INFO - Running setup.py (path:/tmp/pip-uw4gy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:27:18 INFO - Running setup.py (path:/tmp/pip-B3RDuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:27:18 INFO - Running setup.py (path:/tmp/pip-RYf64T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:27:18 INFO - Running setup.py (path:/tmp/pip-xL4RHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:27:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:27:18 INFO - Running setup.py install for manifestparser 18:27:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:27:18 INFO - Running setup.py install for mozcrash 18:27:18 INFO - Running setup.py install for mozdebug 18:27:18 INFO - Running setup.py install for mozdevice 18:27:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:27:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:27:18 INFO - Running setup.py install for mozfile 18:27:19 INFO - Running setup.py install for mozhttpd 18:27:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:27:19 INFO - Running setup.py install for mozinfo 18:27:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:27:19 INFO - Running setup.py install for mozInstall 18:27:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:27:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:27:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:27:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:27:19 INFO - Running setup.py install for mozleak 18:27:19 INFO - Running setup.py install for mozlog 18:27:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:27:19 INFO - Running setup.py install for moznetwork 18:27:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:27:19 INFO - Running setup.py install for mozprocess 18:27:19 INFO - Running setup.py install for mozprofile 18:27:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:27:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:27:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:27:19 INFO - Running setup.py install for mozrunner 18:27:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:27:19 INFO - Running setup.py install for mozscreenshot 18:27:20 INFO - Running setup.py install for moztest 18:27:20 INFO - Running setup.py install for mozversion 18:27:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:27:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:27:20 INFO - Cleaning up... 18:27:20 INFO - Return code: 0 18:27:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:27:20 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')]} 18:27:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:20 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')]} 18:27:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:20 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 0x7f6eccbdef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2788790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2785930>, '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 0x2786830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2786cc0>, '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': '14ef55db36f7623abb31b9cf000001d5-1475888958.767880-192553756', '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 18:27:20 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 18:27:20 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 18:27:20 INFO - Using env: {'DISPLAY': ':0', 18:27:20 INFO - 'HOME': '/home/cltbld', 18:27:20 INFO - 'LANG': 'en_US.UTF-8', 18:27:20 INFO - 'LANGUAGE': 'en_US:en', 18:27:20 INFO - 'LOGNAME': 'cltbld', 18:27:20 INFO - 'MAIL': '/var/mail/cltbld', 18:27:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:20 INFO - 'MOZ_NO_REMOTE': '1', 18:27:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:20 INFO - 'NO_EM_RESTART': '1', 18:27:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:20 INFO - 'PWD': '/builds/slave/test', 18:27:20 INFO - 'SHELL': '/bin/bash', 18:27:20 INFO - 'SHLVL': '1', 18:27:20 INFO - 'TERM': 'linux', 18:27:20 INFO - 'TMOUT': '86400', 18:27:20 INFO - 'USER': 'cltbld', 18:27:20 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475888958.767880-192553756', 18:27:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:20 INFO - '_': '/tools/buildbot/bin/python'} 18:27:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:27:20 INFO - Running setup.py (path:/tmp/pip-WrNnkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:27:20 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)) 18:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:27:20 INFO - Running setup.py (path:/tmp/pip-AQXKhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:27:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:27:20 INFO - Running setup.py (path:/tmp/pip-JUguak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:27:20 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)) 18:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:27:20 INFO - Running setup.py (path:/tmp/pip-1TtrQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:27:20 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)) 18:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:27:20 INFO - Running setup.py (path:/tmp/pip-OMBy6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:27:20 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)) 18:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:27:20 INFO - Running setup.py (path:/tmp/pip-FJ6U4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:27:20 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)) 18:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:27:20 INFO - Running setup.py (path:/tmp/pip-5ptzS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:27:21 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)) 18:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:27:21 INFO - Running setup.py (path:/tmp/pip-fElOWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:27:21 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)) 18:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:27:21 INFO - Running setup.py (path:/tmp/pip-K9lYwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:27:21 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)) 18:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:27:21 INFO - Running setup.py (path:/tmp/pip-7R213P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:27:21 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)) 18:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:27:21 INFO - Running setup.py (path:/tmp/pip-BgeIPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:27:21 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)) 18:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:27:21 INFO - Running setup.py (path:/tmp/pip-cSpm8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:27:21 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)) 18:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:27:21 INFO - Running setup.py (path:/tmp/pip-90w8s_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:27:21 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)) 18:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:27:21 INFO - Running setup.py (path:/tmp/pip-Wux8uK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:27:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:27:21 INFO - Running setup.py (path:/tmp/pip-vK00WI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:27:21 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)) 18:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:27:21 INFO - Running setup.py (path:/tmp/pip-whoX6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:27:21 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)) 18:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:27:21 INFO - Running setup.py (path:/tmp/pip-CnTPo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:27:21 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)) 18:27:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:27:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:27:21 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)) 18:27:21 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)) 18:27:21 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)) 18:27:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:27:21 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 18:27:21 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 18:27:21 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 18:27:21 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 18:27:21 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 18:27:21 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 18:27:23 INFO - Downloading blessings-1.6.tar.gz 18:27:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:27:23 INFO - Installing collected packages: blessings 18:27:23 INFO - Running setup.py install for blessings 18:27:23 INFO - Successfully installed blessings 18:27:23 INFO - Cleaning up... 18:27:23 INFO - Return code: 0 18:27:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:27:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:27:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:27:24 INFO - Reading from file tmpfile_stdout 18:27:24 INFO - Current package versions: 18:27:24 INFO - argparse == 1.2.1 18:27:24 INFO - blessings == 1.6 18:27:24 INFO - blobuploader == 1.2.4 18:27:24 INFO - docopt == 0.6.1 18:27:24 INFO - functools32 == 3.2.3-2 18:27:24 INFO - jsonschema == 2.5.1 18:27:24 INFO - manifestparser == 1.1 18:27:24 INFO - mozInstall == 1.12 18:27:24 INFO - mozcrash == 0.17 18:27:24 INFO - mozdebug == 0.1 18:27:24 INFO - mozdevice == 0.48 18:27:24 INFO - mozfile == 1.2 18:27:24 INFO - mozhttpd == 0.7 18:27:24 INFO - mozinfo == 0.9 18:27:24 INFO - mozleak == 0.1 18:27:24 INFO - mozlog == 3.4 18:27:24 INFO - moznetwork == 0.27 18:27:24 INFO - mozprocess == 0.23 18:27:24 INFO - mozprofile == 0.28 18:27:24 INFO - mozrunner == 6.12 18:27:24 INFO - mozscreenshot == 0.1 18:27:24 INFO - mozsystemmonitor == 0.3 18:27:24 INFO - moztest == 0.7 18:27:24 INFO - mozversion == 1.4 18:27:24 INFO - psutil == 3.1.1 18:27:24 INFO - requests == 1.2.3 18:27:24 INFO - wsgiref == 0.1.2 18:27:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:27:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:27:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:27:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:24 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 0x7f6eccbdef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2788790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2785930>, '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 0x2786830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2786cc0>, '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': '14ef55db36f7623abb31b9cf000001d5-1475888958.767880-192553756', '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 18:27:24 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 18:27:24 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 18:27:24 INFO - Using env: {'DISPLAY': ':0', 18:27:24 INFO - 'HOME': '/home/cltbld', 18:27:24 INFO - 'LANG': 'en_US.UTF-8', 18:27:24 INFO - 'LANGUAGE': 'en_US:en', 18:27:24 INFO - 'LOGNAME': 'cltbld', 18:27:24 INFO - 'MAIL': '/var/mail/cltbld', 18:27:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:24 INFO - 'MOZ_NO_REMOTE': '1', 18:27:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:24 INFO - 'NO_EM_RESTART': '1', 18:27:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:24 INFO - 'PWD': '/builds/slave/test', 18:27:24 INFO - 'SHELL': '/bin/bash', 18:27:24 INFO - 'SHLVL': '1', 18:27:24 INFO - 'TERM': 'linux', 18:27:24 INFO - 'TMOUT': '86400', 18:27:24 INFO - 'USER': 'cltbld', 18:27:24 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475888958.767880-192553756', 18:27:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:24 INFO - '_': '/tools/buildbot/bin/python'} 18:27:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:24 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)) 18:27:24 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)) 18:27:24 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)) 18:27:24 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)) 18:27:24 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)) 18:27:24 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)) 18:27:24 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)) 18:27:24 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)) 18:27:24 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)) 18:27:24 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)) 18:27:24 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)) 18:27:24 INFO - Cleaning up... 18:27:24 INFO - Return code: 0 18:27:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:27:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:27:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:27:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6eccbdef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2788790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2785930>, '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 0x2786830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2786cc0>, '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': '14ef55db36f7623abb31b9cf000001d5-1475888958.767880-192553756', '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 18:27:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:27:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:27:24 INFO - Using env: {'DISPLAY': ':0', 18:27:24 INFO - 'HOME': '/home/cltbld', 18:27:24 INFO - 'LANG': 'en_US.UTF-8', 18:27:24 INFO - 'LANGUAGE': 'en_US:en', 18:27:24 INFO - 'LOGNAME': 'cltbld', 18:27:24 INFO - 'MAIL': '/var/mail/cltbld', 18:27:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:24 INFO - 'MOZ_NO_REMOTE': '1', 18:27:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:24 INFO - 'NO_EM_RESTART': '1', 18:27:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:24 INFO - 'PWD': '/builds/slave/test', 18:27:24 INFO - 'SHELL': '/bin/bash', 18:27:24 INFO - 'SHLVL': '1', 18:27:24 INFO - 'TERM': 'linux', 18:27:24 INFO - 'TMOUT': '86400', 18:27:24 INFO - 'USER': 'cltbld', 18:27:24 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475888958.767880-192553756', 18:27:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:24 INFO - '_': '/tools/buildbot/bin/python'} 18:27:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:27:24 INFO - Cleaning up... 18:27:24 INFO - Return code: 0 18:27:24 INFO - Running post-action listener: _resource_record_post_action 18:27:24 INFO - Running post-action listener: _start_resource_monitoring 18:27:24 INFO - Starting resource monitoring. 18:27:24 INFO - [mozharness: 2016-10-08 01:27:24.624670Z] Finished create-virtualenv step (success) 18:27:24 INFO - [mozharness: 2016-10-08 01:27:24.625183Z] Running install step. 18:27:24 INFO - Running pre-action listener: _resource_record_pre_action 18:27:24 INFO - Running main action method: install 18:27:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:27:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:27:24 INFO - Reading from file tmpfile_stdout 18:27:24 INFO - Detecting whether we're running mozinstall >=1.0... 18:27:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:27:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:27:24 INFO - Reading from file tmpfile_stdout 18:27:24 INFO - Output received: 18:27:24 INFO - Usage: mozinstall [options] installer 18:27:24 INFO - Options: 18:27:24 INFO - -h, --help show this help message and exit 18:27:24 INFO - -d DEST, --destination=DEST 18:27:24 INFO - Directory to install application into. [default: 18:27:24 INFO - "/builds/slave/test"] 18:27:24 INFO - --app=APP Application being installed. [default: firefox] 18:27:24 INFO - mkdir: /builds/slave/test/build/application 18:27:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:27:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:27:41 INFO - Reading from file tmpfile_stdout 18:27:41 INFO - Output received: 18:27:41 INFO - /builds/slave/test/build/application/firefox/firefox 18:27:41 INFO - Running post-action listener: _resource_record_post_action 18:27:41 INFO - [mozharness: 2016-10-08 01:27:41.935548Z] Finished install step (success) 18:27:41 INFO - [mozharness: 2016-10-08 01:27:41.935793Z] Running run-tests step. 18:27:41 INFO - Running pre-action listener: _resource_record_pre_action 18:27:41 INFO - Running main action method: run_tests 18:27:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:27:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:27:41 INFO - Python 2.7.3 18:27:41 INFO - Return code: 0 18:27:41 INFO - grabbing minidump binary from tooltool 18:27:41 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')]} 18:27:41 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 0x2785930>, '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 0x2786830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2786cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:27:41 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 18:27:41 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 18:27:41 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 18:27:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:27:42 INFO - Return code: 0 18:27:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:27:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:27:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:27:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:27:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:27:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z2BLx0myRnygCH5IkqhV6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 18:27:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Z2BLx0myRnygCH5IkqhV6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 18:27:42 INFO - Using env: {'DISPLAY': ':0', 18:27:42 INFO - 'HOME': '/home/cltbld', 18:27:42 INFO - 'LANG': 'en_US.UTF-8', 18:27:42 INFO - 'LANGUAGE': 'en_US:en', 18:27:42 INFO - 'LOGNAME': 'cltbld', 18:27:42 INFO - 'MAIL': '/var/mail/cltbld', 18:27:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:27:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:27:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:42 INFO - 'MOZ_NO_REMOTE': '1', 18:27:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:27:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:42 INFO - 'NO_EM_RESTART': '1', 18:27:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:42 INFO - 'PWD': '/builds/slave/test', 18:27:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:27:42 INFO - 'SHELL': '/bin/bash', 18:27:42 INFO - 'SHLVL': '1', 18:27:42 INFO - 'TERM': 'linux', 18:27:42 INFO - 'TMOUT': '86400', 18:27:42 INFO - 'USER': 'cltbld', 18:27:42 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475888958.767880-192553756', 18:27:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:42 INFO - '_': '/tools/buildbot/bin/python'} 18:27:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z2BLx0myRnygCH5IkqhV6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 18:27:42 INFO - mozversion application_buildid: 20161007153015 18:27:42 INFO - mozversion application_changeset: efa3b654aa77bcb9b3dd7fc5a52efb6b5afc34d6 18:27:42 INFO - mozversion application_display_name: Nightly 18:27:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:27:42 INFO - mozversion application_name: Firefox 18:27:42 INFO - mozversion application_remotingname: firefox 18:27:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:27:42 INFO - mozversion application_vendor: Mozilla 18:27:42 INFO - mozversion application_version: 52.0a1 18:27:42 INFO - mozversion platform_buildid: 20161007153015 18:27:42 INFO - mozversion platform_changeset: efa3b654aa77bcb9b3dd7fc5a52efb6b5afc34d6 18:27:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:27:42 INFO - mozversion platform_version: 52.0a1 18:27:42 INFO - using testdate: 1475890062 18:27:42 INFO - actual date: 1475890062 18:27:42 INFO - starting webserver on 'localhost:49482' 18:27:42 INFO - SUITE-START | Running 2 tests 18:27:42 INFO - TEST-START | dromaeo_css 18:27:42 INFO - operating with platform_type : linux_ 18:27:42 INFO - Initialising browser for dromaeo_css test... 18:27:42 INFO - TEST-INFO | started process 14917 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplpBW3U/profile http://localhost:49482/getInfo.html) 18:27:46 INFO - PROCESS | 14917 | __metrics Screen width/height:1600/1200 18:27:46 INFO - PROCESS | 14917 | colorDepth:24 18:27:46 INFO - PROCESS | 14917 | Browser inner width/height: 1024/697 18:27:46 INFO - PROCESS | 14917 | __metrics 18:27:46 INFO - PROCESS | 14917 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:27:46 INFO - PROCESS | 14917 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:27:47 INFO - PROCESS | 14917 | console.error: PushService: 18:27:47 INFO - PROCESS | 14917 | stateChangeProcessEnqueue: Error transitioning state 18:27:47 INFO - PROCESS | 14917 | UnknownError 18:27:48 INFO - TEST-INFO | 14917: exit 0 18:27:48 INFO - Browser initialized. 18:27:48 INFO - Running cycle 1/1 for dromaeo_css test... 18:27:48 INFO - TEST-INFO | started process 14997 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplpBW3U/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:28:00 INFO - PROCESS | 14997 | RSS: Main: 172793856 18:28:00 INFO - PROCESS | 14997 | 18:28:52 INFO - PROCESS | 14997 | 1475890131995 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] 18:31:02 INFO - PROCESS | 14997 | Cycle 1(1): loaded http://localhost:49482/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49482/tests/dromaeo/cssquery-ext.html) 18:31:03 INFO - PROCESS | 14997 | RSS: Main: 333930496 18:31:03 INFO - PROCESS | 14997 | 18:34:06 INFO - PROCESS | 14997 | Cycle 1(1): loaded http://localhost:49482/tests/dromaeo/cssquery-ext.html (next: http://localhost:49482/tests/dromaeo/cssquery-jquery.html) 18:34:07 INFO - PROCESS | 14997 | RSS: Main: 282726400 18:34:07 INFO - PROCESS | 14997 | 18:37:09 INFO - PROCESS | 14997 | Cycle 1(1): loaded http://localhost:49482/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49482/tests/dromaeo/cssquery-mootools.html) 18:37:09 INFO - PROCESS | 14997 | RSS: Main: 272842752 18:37:09 INFO - PROCESS | 14997 | 18:40:11 INFO - PROCESS | 14997 | Cycle 1(1): loaded http://localhost:49482/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49482/tests/dromaeo/cssquery-prototype.html) 18:40:12 INFO - PROCESS | 14997 | RSS: Main: 233517056 18:40:12 INFO - PROCESS | 14997 | 18:43:15 INFO - PROCESS | 14997 | Cycle 1(1): loaded http://localhost:49482/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49482/tests/dromaeo/cssquery-yui.html) 18:43:15 INFO - PROCESS | 14997 | RSS: Main: 215625728 18:43:15 INFO - PROCESS | 14997 | 18:46:18 INFO - PROCESS | 14997 | Cycle 1(1): loaded http://localhost:49482/tests/dromaeo/cssquery-yui.html (next: http://localhost:49482/tests/dromaeo/cssquery-dojo.html) 18:46:18 INFO - PROCESS | 14997 | RSS: Main: 309215232 18:46:18 INFO - PROCESS | 14997 | 18:46:18 INFO - PROCESS | 14997 | __start_tp_report 18:46:18 INFO - PROCESS | 14997 | _x_x_mozilla_page_load 18:46:18 INFO - PROCESS | 14997 | _x_x_mozilla_page_load_details 18:46:18 INFO - PROCESS | 14997 | |i|pagename|runs| 18:46:18 INFO - PROCESS | 14997 | |0;dojo.html;2959.46729588674;2984.567237750526;2991.970080299195;3016.1705530978993;3044.771642126841;5045.217991211368;5138.845834624967;5146.176611742122;5221.556167725743;5269.077911365515;5150.356205474316;5172.069027575035;5173.249878767586;5214.165733482643;5246.344206974129;4689.2966055091665;4727.66906316558;4770.904581908359;4777.546133117357;4813.590844778198;4744.051189762062;4806.206975848981;4861.902761944759;4878.438979517366;4893.29047288143;4821;4877.341558889558;4882.2432522958825;4885.047415753929;4949.604031677475;4674.649401294916;4706.7646617669325;4713.316569097496;4749.073930583538;4872.293517439987;4719.669623126382;4734.289856521515;4744.810207591692;4787.018661174451;4820.349252850855;5148.974255128738;5186.222066689989;5188.429272779991;5192.896142077175;5204.9479505204845;5354.277172581729;5396.271503347037;5440.211169380457;5530.032244357221;5537.390887002426;5528.115501519737;5534.501894829445;5546.69493177875;5622.634528755618;5625.268715067015;5151.484851514819;5153.072446959583;5155.458676838915;5155.7679904404395;5218.791248350023;5472.808451704172;5525.309336332958;5643.238162847963;5653.745581448845;5654.293213348332;5378.838634840961;5404.351477822608;5408.161734931092;5413.675179489164;5472.069748142825;5452.890942181134;5488.396276409591;5493.423190565013;5501.257330260363;5502.147167189092;5450.018996580654;5491.395946445888;5502.5597952164535;5503.257060296889;5574.526165275997;5325.573954083664;5394.460553944653;5395.595330350239;5429.67421954684;5472.343318801769;4280.6789490788315;4281.443412356373;4324.8486302979245;4333.804978775963;4341.630961368256;3820.2741479118877;3826.4069069294305;3833.386658134685;3868.845246190177;3893.065664240562;5163.09645811989;5200.8959820803375;5203.635745497854;5260.71066091361;5273.182656688219;5499.615026948075;5543.113101903757;5561.221428999943;5562.527185189223;5566.137248726453;5202.375714914235;5255.290535777621;5259.658122222043;5265.947340526623;5277.868053298622;4830.4444988826735;4850.6119510439785;4852.80588776445;4853.174960256694;4857.319975203474;5724.82641058582;5736.942630573724;5737.885242295214;5743.684097374601;5757.568182386338;5551.91737611162;5569.025420551468;5570.359408668055;5570.61005729595;5572.972135139298;5684.090545512863;5721.8569535761935;5823.7379317929945;5829.970850145892;5837.503812176013;5423.3491980962535;5428.430014848384;5431.6740995540395;5435.048866448435;5437.293151890229;5389.164679474688;5531.004419204582;5533.529649979797;5541.5289700375915;5602.935442265956;5317.920231196458;5327.920081198863;5405.918816236847;5408.350997880122;5485.341758988788;5400.810971615974;5418.322709661293;5421.593380496557;5422.132458806572;5422.48486393792;5372.758225879923;5402.135658294654;5402.405735369185;5406.648567843235;5467.043267428105;5276.604254680991;5327.334083239595;5334.8933021340135;5397.244385785914;5407.080796264566;5159.561437277874;5277.076511610376;5281.788728450819;5282.366116066097;5289.841304760864 18:46:18 INFO - PROCESS | 14997 | |1;ext.html;551.7540359329815;593.3473179502548;598.353777919846;602.4126476685233;611.5596770325366;32361.029169124933;32960.17599560012;42616.573834261646;43034;43363.78318108405;40355.798221008925;45379.319310210376;45387.319190212176;45425;45428.77285613567;8100.432969692124;8888.911110888905;9068.682596109138;9076.546172691373;9078.228350590207;8055.113937466874;10581.470926453685;10842.078423334026;10852.511636976355;11219.831702524469;10988;11004.724881877937;11008.174386920973;11035.172362072837;11060.944695276512;10798.67603971882;10857.837132443019;10864;10904.182186336056;10915;10698.732531686692;10758.515866786014;10788.838167427495;10793.78412431747;10794.352338859693;43291;43556.56443435588;43558.12883742339;43694.344584831255;43698.34452483215;3476.617572067071;3476.8261586920553;3613.1689711366535;3637.1816341323256;3832.6550610445192;30821.229469263224;31349.529757053664;32101.51847722286;32123.678763212538;32178.195545111324;4293.3989241506215;4366.868993930156;4416.24923762961;4539.251023581105;4656.95343046572;327299;327345;328486;328827;328982;59462.40537594655;60210;60223;60632.69683651553;60688.69655651694;33894.32211355759;34012.31975360528;34024.14939626529;64618.35381646217;64621.67689161524;14297.428102875976;14341.64145896361;14426.278686065654;14447;14465.421383144556;8715.215630593277;8754;9969.700908972742;11173.608923687632;11253.887461125447;18790;18993.43019709411;19034.524136896413;19104.33134840302;19404.611907761766;7205.063341765537;7230.240824713434;7233.529820561752;7318.194998550155;7339.70641174347;934.1592566689898;1076.6339444588878;1080.5515710980012;1080.7352198711367;1126.0934947367284;32402.67597324044;32636.184095397806;32687.182820429203;32808.67191328104;33327.166820829676;1119.9440027998567;1138.692553010699;1172.1267655596635;1194.3073017649742;1238.1580525242741;16830.579235518966;17247.74128388075;17263.913680431517;17337.479875603753;17382.91308543449;544056;548060.5969701499;550975.3927068019;551571;553376;59513.70243148757;59924.101138482954;59942;60022;60043.09935350973;1185.1674497949907;1212.1151559361715;1311.0887932886742;1316.4339334086435;1321.2138777427415;29362.412751744418;33181.66818331883;33414;33662.49506257457;33684;50650.49349506458;51375.22937155871;51378.48621513737;51409;51411;405366.9731651323;406202;406485;408545;411092;25898.870505647352;25958.610620840325;26392.472150557267;28729;28773;47239.055218896116;47337.52662473331;47521;47578.76210619063;47717.76141119411;39575.60424395719;40351.59648403596;40666.390004150555;41419.378709319986;42552.57447425486;40498.79750601346;40523.18953620852;41563.1687366257;42008;42114.789426053896;40113.59886401215;40359.79820100881;40456.39315410212;40750.75870827133;40758.59241407548;34182;36016.63983360133;36773.60971536842;36863.81568092143;37061.814690926374;27794.305142371602;28161.859190703915;28231;28278.85860570684;28497.572536411557 18:46:18 INFO - PROCESS | 14997 | |2;jquery.html;384.9923001539968;403.4714523973595;405.4101282633768;411.16738604326235;424.17074619119626;13729.519466818663;15580.922095389522;19075.427737167873;19859.503512412197;19953.70069448956;18959.90520047401;19166.904165479154;19443.513912152204;19654.705179422286;19714.30999915003;5110.437851836295;5498.257735205756;5630.859228519289;5905.822825315247;5908.202392676998;5778.393268706788;5794.246747922764;5843.5033022193165;5849.239598852165;5874.265716785402;5601.215829783833;5780.739866705987;5818.825435236929;5833.7083145842535;5834.970825145869;5773.855653608652;5792.4497172768515;5820.301563812349;5820.9708951455395;5823.184754134425;4972.378452693413;5133.512316329943;5168.793248270064;5169.379674439091;5211.817586384458;21745;22548.66177007346;22705;23150.884245578665;23336.416589585227;2383.6175018489407;2489.514544663791;2531.9113831015825;2574.9871250643814;2808.3260017595835;10382.117520010808;10384.480775961247;10498.842517362245;10924.781504369868;10976.835347469794;1810.167323031407;1862.1527205121638;1917.9520511987173;1937.2154277517627;1972.8618996670239;80604;85150.57424712837;85404.57297713534;86494;86975.56512217398;10724.517396717167;10995.450227488594;11128.109751219883;11380.658580242605;11458.760258704333;16169.272382742805;16181.4336498222;16188.43340483101;16217.59456013609;16217.67564648724;7323.450741194431;7468.626568671545;7609.733659321897;7671.769846904602;7729.4202934779;6727.66361681914;6735.865282694416;6801.1158549388265;6932.792016239521;6933.410660093848;4744.383230180124;4751.885410992076;4771.976140119277;4785.521447855187;4820.975895120502;1959.2358979997812;2004.8596598237984;2012.8691635043676;2025.1291944464022;2033.6542787726123;741.7107328142029;890.4212262029732;930.418488444722;998.9500524973868;1056.0062223596037;18756.343527976456;19519.707204391947;19592.11835467379;19616.901915490333;19988.900055499922;956.8229877472689;972.1250874213123;980.9166220871306;998.6854140945579;1051.5846240734868;10259;10495.947520262349;10719.78560428787;10769.084627806567;10834.783304333869;220869;221371;223100;224356;471018;94199;96975.51416259253;100441;101491;103402.48298758458;1000.3197825478744;1019.9490025498695;1053.9051485366508;1070.882202957674;1074.4305518075432;16894.57763555872;16990.57523561921;17292.394766183123;17868.374606889218;18224.088795560434;40867.38698919578;42581;43056;43772;44279.33580996352;60684;61094;61475.692621536604;62318;62815;8241.217084376975;8536.231739143506;8715.912840871764;8720.171583699539;8904.154105359981;12094.39528023613;12308.446119924445;12415.751684966432;12785.61643150707;13129.666605560315;10451.320664156805;10739.516721747385;10802.351858888493;10830.67507974762;11496;10960.068394186264;11113;11238.7752244953;11412.08703303717;12003.81994270104;11121.332720036824;11260.887391125983;11439;11535.884641153816;11632;7576.924230757621;7949.8410031800195;8490.23587877094;8652.437591556529;8797;10698.358098513803;11150.665480035612;11277.210595258253;11362.659120226075;11735.23720958135 18:46:18 INFO - PROCESS | 14997 | |3;mootools.html;1442.7258820824045;1484.7772834074888;1574.5355120239528;1698.2018451327872;1720.320473413002;7475.364594009502;7790.9220907790905;8054;8584.356173287006;8593.839831622738;7994.840103197933;8278.875816862752;8290.83418331633;8452.774347719576;8472.940882389701;2288.336382449088;2319.93040208794;2322.1175953137786;2323.53529294141;2336.7195936487647;2011.8289945354663;2077.802608752174;2278.8860556972168;2309.180241014441;2336.158982766203;2086.351782092153;2113.1019316790303;2198.8131008864266;2274.238130226368;2286.6112760830615;2225.543763528473;2233.140241007208;2241.9551608967813;2247.179779380531;2247.763984781607;2173.9891300543554;2240.171136679423;2240.283109404991;2240.3950933247934;2242.854214476054;8292.958535207346;8430.831383372359;8448.662053517914;8455.027671817757;8458.74623761282;5114.335136432277;5256.448072952323;5261.289725886994;5262.342207224097;5269.367675878881;3258;3401.047706642144;3427.6915077642884;3433.2790114076074;3440.535527703753;1126.8422420861086;1163.2206421697483;1183.3314177489776;1199.322382853685;1212.1696637803134;11510.539578416854;11585.18903676743;11660.300381977024;11671.649850504498;11682.182247242696;4496.617787488035;4663.440387153495;4738;4782.282657601318;4802.231642937113;9894.257930655085;9925;9927.40435573868;9932.553035113437;9937.900620993698;5306.416294207634;5310.628256022119;5315.840524784263;5322.121849894724;5324.733763311819;4772.475027746945;4895.339129217581;4911.705297682151;4911.87720306988;4913.48408417111;3824.2160357126722;3847.7498962567342;3900.9609903901164;3932.1545867638597;3985.9202815943518;1279;1281.8397700287464;1283.9422225999851;1306.288073000217;1309.6922223277522;766.8696321625337;900.684760333891;902.6479672927563;923.8060007398387;968.4286271100085;5562.415946325658;5606.859828504238;5736.1682556029145;5883.529317654663;5892.558058145656;926.9397489163183;935.4106912645126;943.4858002388714;944.9527523623791;999.0558921818956;3841.4045822897497;3967.5687477051088;4000.2199571083943;4042.6159514846045;4163.333866581333;9729.318947673737;10364.429956352473;10404.167666586654;10406.27156099081;10422.062014418738;10093;10344.32761870476;10350.844737328945;10353.06822385989;10356;7761.301482866569;7864;7915.84168316642;7917.049954005441;7917.683292668344;5577.8047768327915;5583.69289689071;5606.187102870143;5641.40765219646;5765.4811067004175;9557.235421166151;9588.520573971413;9646.372985755903;9676.85484717744;9789.216862650828;9162.358634895494;9633.277504187074;9634.181094607036;9734.561944712363;9738.805223895624;7427.44294177928;7602.201768814195;7602.391808655405;7612.58130802789;7619.238076192337;8224.712135075482;8226.876596850932;8232.753017409488;8242.711505097293;8308.584570771558;7291.38023268007;7346.816329591803;7351.117865855917;7428.071491063617;7696;6903.89644155328;7034.085568876013;7060.7881763547175;7377.889331659922;7448.106227252764;6131.032865489547;6356.809295721136;6392.712327945346;6432.678366081771;6530.412262896362;4755.262934245197;4868.269759535956;4874.53691899269;4953.2570114483115;4987.426445958616;4934.851954441372;5062.569681577107;5071.467495912876;5096.974515127401;5206.088934436534 18:46:18 INFO - PROCESS | 14997 | |4;prototype.html;320.43443322535717;333.88981636060095;335.5604158552297;341.5303957059045;348.80466938514417;4982.900341993162;5167.5607573356265;5274.2879711238975;5278.36659600848;5333.2000199970025;4983.152864013117;5183.64144314337;5244.973775131129;5257.158854583267;5260.631755777097;4108.506979162505;4113.547509773923;4126.154138401621;4136.855210067648;4149.356849688304;3911.76529408235;4007.939880901789;4020.477337946063;4105.4252404663375;4125.773082480462;4081.999910022049;4089.672826173899;4092.4884389451317;4095.488063992001;4096.746789265907;4092.6521245694153;4097.959020409788;4098.7130900836955;4104.056067104553;4107.260693075245;3465.896023119285;3616.0959760059986;3630.6006339302658;3633.2551826875692;3639.94540081899;5077.136886729265;5082.872928176826;5096.235564665293;5096.388433388017;5106.361704786902;4681.672282940195;4687.117422784997;4690.530946905316;4694.638554819098;4696.788644511005;5260.263563101169;5411.2965314508865;5436.809711660112;5462.344518657746;5471.781128754845;3957.7823219722904;3961.3067713150085;3973.662238709713;3978.70692025093;3978.76127432355;5624.803131890364;5656.830295091154;5666.631668941547;5712.314522257314;5731.111677689964;3887.552931412867;4026.154507553388;4095.2219078375015;4104.610062044101;4115.176964607091;4092.2224777292813;4093.4678491795876;4105.67154627635;4109.547949725527;4115.650169735606;4413.16149931512;4544.818207271672;4552;4559.452865656142;4559.794809233593;5327.547158491571;5471.316085489314;5484.862878428071;5492.395836457987;5512.283403157644;1412.0892024644047;1422.2888555722138;1423.516004558455;1425.5509514502899;1426.315368623046;902.3007169443733;927.1053433436766;929.2612373163216;929.7030642254152;937.4562753602894;4737.010455608653;4750.358701575312;4753;4759.714417134914;4760.928586071212;4966.15575352191;4968.4101087652325;4968.577670898014;4970.304157417964;4984.451710311862;4550.613197878151;4685.484596694361;4721.929171062437;4725.385699858996;4746.857594272177;2615.856127912983;2617.659704238475;2631.2369412870053;2635;2635.89456421741;5073.34046573943;5082.738181509193;5100.7959681613065;5103.464136265713;5118.283440318284;4796.760161991887;4929.334539837076;4961.751912404366;4966.467101778119;5013.273075404119;5003.174476211457;5052.827284267727;5091.974540127349;5093.821716239914;5100.923486147711;4881.463039065629;4887.731174785421;4914.950850491592;4929.309896614549;4936;4900.730459824601;5186.573692234666;5552.52803511706;5595;5609.214709940693;5862.472377486047;5866.823995280149;5893.381194974638;5897.439743224387;5917.6745279010065;4086.81609327575;4100.507939047334;4104.5690202529495;4127.855525056729;4135.669146468215;5333.4133245343755;5404.918926216032;5532.529734972572;5616.1856530803625;5649.7740090397565;5407.459254074561;5425.864353391197;5462.8907421850545;5468.507834294933;5546.916796247979;5441.29263195782;5481.671099734029;5509.256250406143;5511.889762204813;5521.834344969658;5264.1314183160885;5399.78400863961;5430.891382172255;5445;5471.589630777628;5494.917576236279;5516.310461192351;5532.419095994863;5542.806001789918;5548.334199895877;5282.864184200415;5411.538884501084;5414.35027796667;5417.458254174709;5423.074808443103 18:46:18 INFO - PROCESS | 14997 | |5;yui.html;718.4719231364946;721.931789892955;740.389178927385;758.5524540521092;849.405416208654;13753;14574.198419086946;14600.488982885588;14607.050541714807;14668.559943201695;13232;13304.268265245408;13343.2661203634;13352.866471335285;13457.596272111852;772.5982489105662;784.3215618489994;785.1794874356283;785.83104632504;785.9449838511307;663.4161937495022;683.4771399879096;804.798800299925;808.8584497712906;809.4778867630375;814.8003739083932;839.7396806989822;847.8516259654535;848.0713618587637;850.1158794853345;840.8024114333127;841.9789505262387;842.0274582856811;842.1662554071486;842.338764070205;517.350724840323;529.2537522093868;626.6146320013205;627.9277883043463;628.0924064726472;12426.565070222588;12754.278172446786;12862;13051.086423950328;13064.804027939588;14023.929880350635;14662;14859.108453492825;14862.331195096138;14987.250637468083;11363.829542556869;11376.317420954769;11436.142289328334;11561.595344162997;11606.709832254177;3616.782993020427;3671.4859919611276;3712.2204337089242;3713.6657700806786;3761.0785357587292;76075.61962190154;76203.6189819053;76768;77477.61261193715;84180.73728894132;11559.479823407966;11568.074554035657;11623.535058597561;11810.704732381588;11937.582184623496;23127.190548330727;23159.76840231576;23178.53642927132;23179.768202318097;23180.21837379525;8104.27061564462;8180.345572354197;8346.66613335472;8494.320454363637;8497.36269779769;4295.9663449641175;4338.3709362142945;4340.066885619543;4342.869713908588;4371.125774845043;3344.665533446636;3439.8452069656923;3444.431668774624;3448.706859916885;3451.430513965168;587.9382664820217;597.2146627185238;597.745957967862;617.5121653893464;619.2290598205263;554.5535843645904;556.524171833085;615.602936106209;621.8414304352451;664.2792570061538;9480;9617.23062155026;9885.25860560461;9922.751931201634;10075.899241007643;571.2858926342072;624.1324558863183;679.2358596578849;683.5181197255922;704.1901812915188;4712.787924543404;4872.9512704873205;4873.220284754422;4876.902461950741;4890.486498917562;68121.65939170272;91520.54239728893;95496.52251738835;95760.52119739357;109143;91648.54175729211;92020;93894;94962.52518737363;95616.52191738997;82812;84035.5798221005;87019;87789;89761.55119224363;9791.706248812547;10064.245181611555;10281.948590257001;10328.380297181893;10331.638392656221;47718;48276.5172348272;48987.265191022874;49329.26006109839;50087.74956125196;69507;70831.64584177046;75205;75463;76075.61962190154;12971;12971.221726696429;12982.15615984958;13004.674883127998;13279.86720132825;13831.792523112363;14177.36201870939;14527.78208326897;14847.628809279422;15116.697666046397;13353.79969300442;13697;14278.143311401349;14279.357428915517;14749.631259218606;12573.622791316275;13068.346582671018;13130.868691312964;13273.933630332172;13449.394777235244;12714.173578717353;13066;13120.737585248433;13415.396307166397;13518.324083795575;11210.607628732956;11251.268667536584;11550.884491155317;11594.188406811441;11896.345700986529;10514.894851051391;10769.892301077203;11352.716182095513;11724.88275117238;11822.82265765997 18:46:18 INFO - PROCESS | 14997 | __end_tp_report 18:46:18 INFO - PROCESS | 14997 | __start_cc_report 18:46:18 INFO - PROCESS | 14997 | _x_x_mozilla_cycle_collect,1445 18:46:18 INFO - PROCESS | 14997 | __end_cc_report 18:46:18 INFO - PROCESS | 14997 | __startTimestamp1475891178985__endTimestamp 18:46:18 INFO - PROCESS | 14997 | 18:46:18 INFO - PROCESS | 14997 | ------- Summary: start ------- 18:46:18 INFO - PROCESS | 14997 | Number of tests: 6 18:46:18 INFO - PROCESS | 14997 | 18:46:18 INFO - PROCESS | 14997 | [#0] dojo.html Cycles:165 Average:5151.49 Median:5325.57 stddev:557.91 (10.5%) stddev-sans-first:532.46 18:46:18 INFO - PROCESS | 14997 | Values: 2959.5 2984.6 2992.0 3016.2 3044.8 5045.2 5138.8 5146.2 5221.6 5269.1 5150.4 5172.1 5173.2 5214.2 5246.3 4689.3 4727.7 4770.9 4777.5 4813.6 4744.1 4806.2 4861.9 4878.4 4893.3 4821.0 4877.3 4882.2 4885.0 4949.6 4674.6 4706.8 4713.3 4749.1 4872.3 4719.7 4734.3 4744.8 4787.0 4820.3 5149.0 5186.2 5188.4 5192.9 5204.9 5354.3 5396.3 5440.2 5530.0 5537.4 5528.1 5534.5 5546.7 5622.6 5625.3 5151.5 5153.1 5155.5 5155.8 5218.8 5472.8 5525.3 5643.2 5653.7 5654.3 5378.8 5404.4 5408.2 5413.7 5472.1 5452.9 5488.4 5493.4 5501.3 5502.1 5450.0 5491.4 5502.6 5503.3 5574.5 5325.6 5394.5 5395.6 5429.7 5472.3 4280.7 4281.4 4324.8 4333.8 4341.6 3820.3 3826.4 3833.4 3868.8 3893.1 5163.1 5200.9 5203.6 5260.7 5273.2 5499.6 5543.1 5561.2 5562.5 5566.1 5202.4 5255.3 5259.7 5265.9 5277.9 4830.4 4850.6 4852.8 4853.2 4857.3 5724.8 5736.9 5737.9 5743.7 5757.6 5551.9 5569.0 5570.4 5570.6 5573.0 5684.1 5721.9 5823.7 5830.0 5837.5 5423.3 5428.4 5431.7 5435.0 5437.3 5389.2 5531.0 5533.5 5541.5 5602.9 5317.9 5327.9 5405.9 5408.4 5485.3 5400.8 5418.3 5421.6 5422.1 5422.5 5372.8 5402.1 5402.4 5406.6 5467.0 5276.6 5327.3 5334.9 5397.2 5407.1 5159.6 5277.1 5281.8 5282.4 5289.8 18:46:18 INFO - PROCESS | 14997 | 18:46:18 INFO - PROCESS | 14997 | [#1] ext.html Cycles:180 Average:58903.70 Median:20205.40 stddev:116208.34 (575.1%) stddev-sans-first:116451.74 18:46:18 INFO - PROCESS | 14997 | Values: 551.8 593.3 598.4 602.4 611.6 32361.0 32960.2 42616.6 43034.0 43363.8 40355.8 45379.3 45387.3 45425.0 45428.8 8100.4 8888.9 9068.7 9076.5 9078.2 8055.1 10581.5 10842.1 10852.5 11219.8 10988.0 11004.7 11008.2 11035.2 11060.9 10798.7 10857.8 10864.0 10904.2 10915.0 10698.7 10758.5 10788.8 10793.8 10794.4 43291.0 43556.6 43558.1 43694.3 43698.3 3476.6 3476.8 3613.2 3637.2 3832.7 30821.2 31349.5 32101.5 32123.7 32178.2 4293.4 4366.9 4416.2 4539.3 4657.0 327299.0 327345.0 328486.0 328827.0 328982.0 59462.4 60210.0 60223.0 60632.7 60688.7 33894.3 34012.3 34024.1 64618.4 64621.7 14297.4 14341.6 14426.3 14447.0 14465.4 8715.2 8754.0 9969.7 11173.6 11253.9 18790.0 18993.4 19034.5 19104.3 19404.6 7205.1 7230.2 7233.5 7318.2 7339.7 934.2 1076.6 1080.6 1080.7 1126.1 32402.7 32636.2 32687.2 32808.7 33327.2 1119.9 1138.7 1172.1 1194.3 1238.2 16830.6 17247.7 17263.9 17337.5 17382.9 544056.0 548060.6 550975.4 551571.0 553376.0 59513.7 59924.1 59942.0 60022.0 60043.1 1185.2 1212.1 1311.1 1316.4 1321.2 29362.4 33181.7 33414.0 33662.5 33684.0 50650.5 51375.2 51378.5 51409.0 51411.0 405367.0 406202.0 406485.0 408545.0 411092.0 25898.9 25958.6 26392.5 28729.0 28773.0 47239.1 47337.5 47521.0 47578.8 47717.8 39575.6 40351.6 40666.4 41419.4 42552.6 40498.8 40523.2 41563.2 42008.0 42114.8 40113.6 40359.8 40456.4 40750.8 40758.6 34182.0 36016.6 36773.6 36863.8 37061.8 27794.3 28161.9 28231.0 28278.9 28497.6 18:46:18 INFO - PROCESS | 14997 | 18:46:18 INFO - PROCESS | 14997 | [#2] jquery.html Cycles:180 Average:23268.65 Median:22626.83 stddev:50364.57 (222.6%) stddev-sans-first:50476.55 18:46:18 INFO - PROCESS | 14997 | Values: 385.0 403.5 405.4 411.2 424.2 13729.5 15580.9 19075.4 19859.5 19953.7 18959.9 19166.9 19443.5 19654.7 19714.3 5110.4 5498.3 5630.9 5905.8 5908.2 5778.4 5794.2 5843.5 5849.2 5874.3 5601.2 5780.7 5818.8 5833.7 5835.0 5773.9 5792.4 5820.3 5821.0 5823.2 4972.4 5133.5 5168.8 5169.4 5211.8 21745.0 22548.7 22705.0 23150.9 23336.4 2383.6 2489.5 2531.9 2575.0 2808.3 10382.1 10384.5 10498.8 10924.8 10976.8 1810.2 1862.2 1918.0 1937.2 1972.9 80604.0 85150.6 85404.6 86494.0 86975.6 10724.5 10995.5 11128.1 11380.7 11458.8 16169.3 16181.4 16188.4 16217.6 16217.7 7323.5 7468.6 7609.7 7671.8 7729.4 6727.7 6735.9 6801.1 6932.8 6933.4 4744.4 4751.9 4772.0 4785.5 4821.0 1959.2 2004.9 2012.9 2025.1 2033.7 741.7 890.4 930.4 999.0 1056.0 18756.3 19519.7 19592.1 19616.9 19988.9 956.8 972.1 980.9 998.7 1051.6 10259.0 10495.9 10719.8 10769.1 10834.8 220869.0 221371.0 223100.0 224356.0 471018.0 94199.0 96975.5 100441.0 101491.0 103402.5 1000.3 1019.9 1053.9 1070.9 1074.4 16894.6 16990.6 17292.4 17868.4 18224.1 40867.4 42581.0 43056.0 43772.0 44279.3 60684.0 61094.0 61475.7 62318.0 62815.0 8241.2 8536.2 8715.9 8720.2 8904.2 12094.4 12308.4 12415.8 12785.6 13129.7 10451.3 10739.5 10802.4 10830.7 11496.0 10960.1 11113.0 11238.8 11412.1 12003.8 11121.3 11260.9 11439.0 11535.9 11632.0 7576.9 7949.8 8490.2 8652.4 8797.0 10698.4 11150.7 11277.2 11362.7 11735.2 18:46:18 INFO - PROCESS | 14997 | 18:46:18 INFO - PROCESS | 14997 | [#3] mootools.html Cycles:180 Average:5573.24 Median:5258.87 stddev:3094.52 (58.8%) stddev-sans-first:3087.63 18:46:18 INFO - PROCESS | 14997 | Values: 1442.7 1484.8 1574.5 1698.2 1720.3 7475.4 7790.9 8054.0 8584.4 8593.8 7994.8 8278.9 8290.8 8452.8 8472.9 2288.3 2319.9 2322.1 2323.5 2336.7 2011.8 2077.8 2278.9 2309.2 2336.2 2086.4 2113.1 2198.8 2274.2 2286.6 2225.5 2233.1 2242.0 2247.2 2247.8 2174.0 2240.2 2240.3 2240.4 2242.9 8293.0 8430.8 8448.7 8455.0 8458.7 5114.3 5256.4 5261.3 5262.3 5269.4 3258.0 3401.0 3427.7 3433.3 3440.5 1126.8 1163.2 1183.3 1199.3 1212.2 11510.5 11585.2 11660.3 11671.6 11682.2 4496.6 4663.4 4738.0 4782.3 4802.2 9894.3 9925.0 9927.4 9932.6 9937.9 5306.4 5310.6 5315.8 5322.1 5324.7 4772.5 4895.3 4911.7 4911.9 4913.5 3824.2 3847.7 3901.0 3932.2 3985.9 1279.0 1281.8 1283.9 1306.3 1309.7 766.9 900.7 902.6 923.8 968.4 5562.4 5606.9 5736.2 5883.5 5892.6 926.9 935.4 943.5 945.0 999.1 3841.4 3967.6 4000.2 4042.6 4163.3 9729.3 10364.4 10404.2 10406.3 10422.1 10093.0 10344.3 10350.8 10353.1 10356.0 7761.3 7864.0 7915.8 7917.0 7917.7 5577.8 5583.7 5606.2 5641.4 5765.5 9557.2 9588.5 9646.4 9676.9 9789.2 9162.4 9633.3 9634.2 9734.6 9738.8 7427.4 7602.2 7602.4 7612.6 7619.2 8224.7 8226.9 8232.8 8242.7 8308.6 7291.4 7346.8 7351.1 7428.1 7696.0 6903.9 7034.1 7060.8 7377.9 7448.1 6131.0 6356.8 6392.7 6432.7 6530.4 4755.3 4868.3 4874.5 4953.3 4987.4 4934.9 5062.6 5071.5 5097.0 5206.1 18:46:18 INFO - PROCESS | 14997 | 18:46:18 INFO - PROCESS | 14997 | [#4] prototype.html Cycles:180 Average:4477.54 Median:4967.44 stddev:1290.99 (26.0%) stddev-sans-first:1256.34 18:46:18 INFO - PROCESS | 14997 | Values: 320.4 333.9 335.6 341.5 348.8 4982.9 5167.6 5274.3 5278.4 5333.2 4983.2 5183.6 5245.0 5257.2 5260.6 4108.5 4113.5 4126.2 4136.9 4149.4 3911.8 4007.9 4020.5 4105.4 4125.8 4082.0 4089.7 4092.5 4095.5 4096.7 4092.7 4098.0 4098.7 4104.1 4107.3 3465.9 3616.1 3630.6 3633.3 3639.9 5077.1 5082.9 5096.2 5096.4 5106.4 4681.7 4687.1 4690.5 4694.6 4696.8 5260.3 5411.3 5436.8 5462.3 5471.8 3957.8 3961.3 3973.7 3978.7 3978.8 5624.8 5656.8 5666.6 5712.3 5731.1 3887.6 4026.2 4095.2 4104.6 4115.2 4092.2 4093.5 4105.7 4109.5 4115.7 4413.2 4544.8 4552.0 4559.5 4559.8 5327.5 5471.3 5484.9 5492.4 5512.3 1412.1 1422.3 1423.5 1425.6 1426.3 902.3 927.1 929.3 929.7 937.5 4737.0 4750.4 4753.0 4759.7 4760.9 4966.2 4968.4 4968.6 4970.3 4984.5 4550.6 4685.5 4721.9 4725.4 4746.9 2615.9 2617.7 2631.2 2635.0 2635.9 5073.3 5082.7 5100.8 5103.5 5118.3 4796.8 4929.3 4961.8 4966.5 5013.3 5003.2 5052.8 5092.0 5093.8 5100.9 4881.5 4887.7 4915.0 4929.3 4936.0 4900.7 5186.6 5552.5 5595.0 5609.2 5862.5 5866.8 5893.4 5897.4 5917.7 4086.8 4100.5 4104.6 4127.9 4135.7 5333.4 5404.9 5532.5 5616.2 5649.8 5407.5 5425.9 5462.9 5468.5 5546.9 5441.3 5481.7 5509.3 5511.9 5521.8 5264.1 5399.8 5430.9 5445.0 5471.6 5494.9 5516.3 5532.4 5542.8 5548.3 5282.9 5411.5 5414.4 5417.5 5423.1 18:46:18 INFO - PROCESS | 14997 | 18:46:18 INFO - PROCESS | 14997 | [#5] yui.html Cycles:180 Average:19877.88 Median:4541.96 stddev:27784.70 (611.7%) stddev-sans-first:27825.40 18:46:18 INFO - PROCESS | 14997 | Values: 718.5 721.9 740.4 758.6 849.4 13753.0 14574.2 14600.5 14607.1 14668.6 13232.0 13304.3 13343.3 13352.9 13457.6 772.6 784.3 785.2 785.8 785.9 663.4 683.5 804.8 808.9 809.5 814.8 839.7 847.9 848.1 850.1 840.8 842.0 842.0 842.2 842.3 517.4 529.3 626.6 627.9 628.1 12426.6 12754.3 12862.0 13051.1 13064.8 14023.9 14662.0 14859.1 14862.3 14987.3 11363.8 11376.3 11436.1 11561.6 11606.7 3616.8 3671.5 3712.2 3713.7 3761.1 76075.6 76203.6 76768.0 77477.6 84180.7 11559.5 11568.1 11623.5 11810.7 11937.6 23127.2 23159.8 23178.5 23179.8 23180.2 8104.3 8180.3 8346.7 8494.3 8497.4 4296.0 4338.4 4340.1 4342.9 4371.1 3344.7 3439.8 3444.4 3448.7 3451.4 587.9 597.2 597.7 617.5 619.2 554.6 556.5 615.6 621.8 664.3 9480.0 9617.2 9885.3 9922.8 10075.9 571.3 624.1 679.2 683.5 704.2 4712.8 4873.0 4873.2 4876.9 4890.5 68121.7 91520.5 95496.5 95760.5 109143.0 91648.5 92020.0 93894.0 94962.5 95616.5 82812.0 84035.6 87019.0 87789.0 89761.6 9791.7 10064.2 10281.9 10328.4 10331.6 47718.0 48276.5 48987.3 49329.3 50087.7 69507.0 70831.6 75205.0 75463.0 76075.6 12971.0 12971.2 12982.2 13004.7 13279.9 13831.8 14177.4 14527.8 14847.6 15116.7 13353.8 13697.0 14278.1 14279.4 14749.6 12573.6 13068.3 13130.9 13273.9 13449.4 12714.2 13066.0 13120.7 13415.4 13518.3 11210.6 11251.3 11550.9 11594.2 11896.3 10514.9 10769.9 11352.7 11724.9 11822.8 18:46:18 INFO - PROCESS | 14997 | -------- Summary: end -------- 18:46:18 INFO - PROCESS | 14997 | 18:46:20 INFO - TEST-INFO | 14997: exit 0 18:46:20 INFO - TEST-OK | dromaeo_css | took 1117820ms 18:46:20 INFO - TEST-START | kraken 18:46:20 INFO - operating with platform_type : linux_ 18:46:20 INFO - Initialising browser for kraken test... 18:46:20 INFO - TEST-INFO | started process 15304 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphGry_E/profile http://localhost:49482/getInfo.html) 18:46:24 INFO - PROCESS | 15304 | __metrics Screen width/height:1600/1200 18:46:24 INFO - PROCESS | 15304 | colorDepth:24 18:46:24 INFO - PROCESS | 15304 | Browser inner width/height: 1024/697 18:46:24 INFO - PROCESS | 15304 | __metrics 18:46:24 INFO - PROCESS | 15304 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:46:24 INFO - PROCESS | 15304 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:46:25 INFO - PROCESS | 15304 | console.error: PushService: 18:46:25 INFO - PROCESS | 15304 | stateChangeProcessEnqueue: Error transitioning state 18:46:25 INFO - PROCESS | 15304 | UnknownError 18:46:26 INFO - TEST-INFO | 15304: exit 0 18:46:26 INFO - Browser initialized. 18:46:26 INFO - Running cycle 1/1 for kraken test... 18:46:26 INFO - TEST-INFO | started process 15387 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphGry_E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:46:38 INFO - PROCESS | 15387 | RSS: Main: 172814336 18:46:38 INFO - PROCESS | 15387 | 18:46:40 INFO - PROCESS | 15387 | Cycle 1(1): loaded http://localhost:49482/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49482/tests/kraken/driver.html?testName=audio-beat-detection) 18:46:41 INFO - PROCESS | 15387 | RSS: Main: 231428096 18:46:41 INFO - PROCESS | 15387 | 18:46:44 INFO - PROCESS | 15387 | Cycle 1(1): loaded http://localhost:49482/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49482/tests/kraken/driver.html?testName=audio-dft) 18:46:44 INFO - PROCESS | 15387 | RSS: Main: 216719360 18:46:44 INFO - PROCESS | 15387 | 18:46:48 INFO - PROCESS | 15387 | Cycle 1(1): loaded http://localhost:49482/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49482/tests/kraken/driver.html?testName=audio-fft) 18:46:48 INFO - PROCESS | 15387 | RSS: Main: 298094592 18:46:48 INFO - PROCESS | 15387 | 18:46:50 INFO - PROCESS | 15387 | Cycle 1(1): loaded http://localhost:49482/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49482/tests/kraken/driver.html?testName=audio-oscillator) 18:46:51 INFO - PROCESS | 15387 | RSS: Main: 208982016 18:46:51 INFO - PROCESS | 15387 | 18:46:53 INFO - PROCESS | 15387 | Cycle 1(1): loaded http://localhost:49482/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49482/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:46:54 INFO - PROCESS | 15387 | RSS: Main: 212406272 18:46:54 INFO - PROCESS | 15387 | 18:46:57 INFO - PROCESS | 15387 | Cycle 1(1): loaded http://localhost:49482/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49482/tests/kraken/driver.html?testName=imaging-darkroom) 18:46:57 INFO - PROCESS | 15387 | RSS: Main: 248565760 18:46:57 INFO - PROCESS | 15387 | 18:47:01 INFO - PROCESS | 15387 | Cycle 1(1): loaded http://localhost:49482/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49482/tests/kraken/driver.html?testName=imaging-desaturate) 18:47:01 INFO - PROCESS | 15387 | RSS: Main: 247300096 18:47:01 INFO - PROCESS | 15387 | 18:47:04 INFO - PROCESS | 15387 | Cycle 1(1): loaded http://localhost:49482/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49482/tests/kraken/driver.html?testName=json-parse-financial) 18:47:05 INFO - PROCESS | 15387 | RSS: Main: 247414784 18:47:05 INFO - PROCESS | 15387 | 18:47:06 INFO - PROCESS | 15387 | Cycle 1(1): loaded http://localhost:49482/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49482/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:47:07 INFO - PROCESS | 15387 | RSS: Main: 209203200 18:47:07 INFO - PROCESS | 15387 | 18:47:08 INFO - PROCESS | 15387 | Cycle 1(1): loaded http://localhost:49482/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49482/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:47:09 INFO - PROCESS | 15387 | RSS: Main: 216477696 18:47:09 INFO - PROCESS | 15387 | 18:47:11 INFO - PROCESS | 15387 | Cycle 1(1): loaded http://localhost:49482/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49482/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:47:12 INFO - PROCESS | 15387 | RSS: Main: 225726464 18:47:12 INFO - PROCESS | 15387 | 18:47:14 INFO - PROCESS | 15387 | Cycle 1(1): loaded http://localhost:49482/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49482/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:47:15 INFO - PROCESS | 15387 | RSS: Main: 235020288 18:47:15 INFO - PROCESS | 15387 | 18:47:18 INFO - PROCESS | 15387 | Cycle 1(1): loaded http://localhost:49482/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49482/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:47:18 INFO - PROCESS | 15387 | RSS: Main: 231710720 18:47:18 INFO - PROCESS | 15387 | 18:47:20 INFO - PROCESS | 15387 | Cycle 1(1): loaded http://localhost:49482/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49482/tests/kraken/driver.html?testName=ai-astar) 18:47:20 INFO - PROCESS | 15387 | RSS: Main: 282738688 18:47:20 INFO - PROCESS | 15387 | 18:47:20 INFO - PROCESS | 15387 | __start_tp_report 18:47:20 INFO - PROCESS | 15387 | _x_x_mozilla_page_load 18:47:20 INFO - PROCESS | 15387 | _x_x_mozilla_page_load_details 18:47:20 INFO - PROCESS | 15387 | |i|pagename|runs| 18:47:20 INFO - PROCESS | 15387 | |0;ai-astar;111;112;111;112;114;112;114;111;112;113 18:47:20 INFO - PROCESS | 15387 | |1;audio-beat-detection;149;126;130;160;129;123;122;126;151;122 18:47:20 INFO - PROCESS | 15387 | |2;audio-dft;160;160;170;160;161;162;162;161;161;160 18:47:20 INFO - PROCESS | 15387 | |3;audio-fft;76;76;76;115;78;76;76;76;105;76 18:47:20 INFO - PROCESS | 15387 | |4;audio-oscillator;83;83;115;83;84;83;104;82;82;109 18:47:20 INFO - PROCESS | 15387 | |5;imaging-gaussian-blur;118;118;117;117;118;117;118;118;117;117 18:47:20 INFO - PROCESS | 15387 | |6;imaging-darkroom;146;146;146;147;147;146;146;147;146;145 18:47:20 INFO - PROCESS | 15387 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;95 18:47:20 INFO - PROCESS | 15387 | |8;json-parse-financial;53;52;52;51;52;53;53;52;53;53 18:47:20 INFO - PROCESS | 15387 | |9;json-stringify-tinderbox;63;62;62;62;62;63;62;62;63;64 18:47:20 INFO - PROCESS | 15387 | |10;stanford-crypto-aes;81;80;80;88;80;80;80;81;80;87 18:47:20 INFO - PROCESS | 15387 | |11;stanford-crypto-ccm;132;139;129;127;135;129;140;129;171;133 18:47:20 INFO - PROCESS | 15387 | |12;stanford-crypto-pbkdf2;174;176;165;169;173;168;170;173;168;168 18:47:20 INFO - PROCESS | 15387 | |13;stanford-crypto-sha256-iterative;66;67;69;66;73;66;67;66;65;63 18:47:20 INFO - PROCESS | 15387 | __end_tp_report 18:47:20 INFO - PROCESS | 15387 | __start_cc_report 18:47:20 INFO - PROCESS | 15387 | _x_x_mozilla_cycle_collect,1645 18:47:20 INFO - PROCESS | 15387 | __end_cc_report 18:47:20 INFO - PROCESS | 15387 | __startTimestamp1475891240772__endTimestamp 18:47:20 INFO - PROCESS | 15387 | 18:47:20 INFO - PROCESS | 15387 | ------- Summary: start ------- 18:47:20 INFO - PROCESS | 15387 | Number of tests: 14 18:47:20 INFO - PROCESS | 15387 | 18:47:20 INFO - PROCESS | 15387 | [#0] ai-astar Cycles:10 Average:112.20 Median:112.00 stddev:1.14 (1.0%) stddev-sans-first:1.12 18:47:20 INFO - PROCESS | 15387 | Values: 111.0 112.0 111.0 112.0 114.0 112.0 114.0 111.0 112.0 113.0 18:47:20 INFO - PROCESS | 15387 | 18:47:20 INFO - PROCESS | 15387 | [#1] audio-beat-detection Cycles:10 Average:133.80 Median:129.50 stddev:14.01 (10.8%) stddev-sans-first:13.74 18:47:20 INFO - PROCESS | 15387 | Values: 149.0 126.0 130.0 160.0 129.0 123.0 122.0 126.0 151.0 122.0 18:47:20 INFO - PROCESS | 15387 | 18:47:20 INFO - PROCESS | 15387 | [#2] audio-dft Cycles:10 Average:161.70 Median:161.00 stddev:3.02 (1.9%) stddev-sans-first:3.14 18:47:20 INFO - PROCESS | 15387 | Values: 160.0 160.0 170.0 160.0 161.0 162.0 162.0 161.0 161.0 160.0 18:47:20 INFO - PROCESS | 15387 | 18:47:20 INFO - PROCESS | 15387 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.00 stddev:14.44 (19.0%) stddev-sans-first:15.09 18:47:20 INFO - PROCESS | 15387 | Values: 76.0 76.0 76.0 115.0 78.0 76.0 76.0 76.0 105.0 76.0 18:47:20 INFO - PROCESS | 15387 | 18:47:20 INFO - PROCESS | 15387 | [#4] audio-oscillator Cycles:10 Average:90.80 Median:83.00 stddev:13.06 (15.7%) stddev-sans-first:13.55 18:47:20 INFO - PROCESS | 15387 | Values: 83.0 83.0 115.0 83.0 84.0 83.0 104.0 82.0 82.0 109.0 18:47:20 INFO - PROCESS | 15387 | 18:47:20 INFO - PROCESS | 15387 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 18:47:20 INFO - PROCESS | 15387 | Values: 118.0 118.0 117.0 117.0 118.0 117.0 118.0 118.0 117.0 117.0 18:47:20 INFO - PROCESS | 15387 | 18:47:20 INFO - PROCESS | 15387 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 18:47:20 INFO - PROCESS | 15387 | Values: 146.0 146.0 146.0 147.0 147.0 146.0 146.0 147.0 146.0 145.0 18:47:20 INFO - PROCESS | 15387 | 18:47:20 INFO - PROCESS | 15387 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 18:47:20 INFO - PROCESS | 15387 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 18:47:20 INFO - PROCESS | 15387 | 18:47:20 INFO - PROCESS | 15387 | [#8] json-parse-financial Cycles:10 Average:52.40 Median:53.00 stddev:0.70 (1.3%) stddev-sans-first:0.71 18:47:20 INFO - PROCESS | 15387 | Values: 53.0 52.0 52.0 51.0 52.0 53.0 53.0 52.0 53.0 53.0 18:47:20 INFO - PROCESS | 15387 | 18:47:20 INFO - PROCESS | 15387 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:62.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 18:47:20 INFO - PROCESS | 15387 | Values: 63.0 62.0 62.0 62.0 62.0 63.0 62.0 62.0 63.0 64.0 18:47:20 INFO - PROCESS | 15387 | 18:47:20 INFO - PROCESS | 15387 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:80.50 stddev:3.09 (3.8%) stddev-sans-first:3.27 18:47:20 INFO - PROCESS | 15387 | Values: 81.0 80.0 80.0 88.0 80.0 80.0 80.0 81.0 80.0 87.0 18:47:20 INFO - PROCESS | 15387 | 18:47:20 INFO - PROCESS | 15387 | [#11] stanford-crypto-ccm Cycles:10 Average:136.40 Median:134.00 stddev:12.92 (9.6%) stddev-sans-first:13.61 18:47:20 INFO - PROCESS | 15387 | Values: 132.0 139.0 129.0 127.0 135.0 129.0 140.0 129.0 171.0 133.0 18:47:20 INFO - PROCESS | 15387 | 18:47:20 INFO - PROCESS | 15387 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.40 Median:171.50 stddev:3.44 (2.0%) stddev-sans-first:3.39 18:47:20 INFO - PROCESS | 15387 | Values: 174.0 176.0 165.0 169.0 173.0 168.0 170.0 173.0 168.0 168.0 18:47:20 INFO - PROCESS | 15387 | 18:47:20 INFO - PROCESS | 15387 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:66.50 stddev:2.66 (4.0%) stddev-sans-first:2.80 18:47:20 INFO - PROCESS | 15387 | Values: 66.0 67.0 69.0 66.0 73.0 66.0 67.0 66.0 65.0 63.0 18:47:20 INFO - PROCESS | 15387 | -------- Summary: end -------- 18:47:20 INFO - PROCESS | 15387 | 18:47:21 INFO - TEST-INFO | 15387: exit 0 18:47:21 INFO - TEST-OK | kraken | took 61908ms 18:47:21 INFO - SUITE-END | took 1179s 18:47:21 INFO - Completed test suite (00:19:39) 18:47:21 INFO - javascript benchmark 18:47:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2959.46729588674, 2984.567237750526, 2991.970080299195, 3016.1705530978993, 3044.771642126841, 5045.217991211368, 5138.845834624967, 5146.176611742122, 5221.556167725743, 5269.077911365515, 5150.356205474316, 5172.069027575035, 5173.249878767586, 5214.165733482643, 5246.344206974129, 4689.2966055091665, 4727.66906316558, 4770.904581908359, 4777.546133117357, 4813.590844778198, 4744.051189762062, 4806.206975848981, 4861.902761944759, 4878.438979517366, 4893.29047288143, 4821.0, 4877.341558889558, 4882.2432522958825, 4885.047415753929, 4949.604031677475, 4674.649401294916, 4706.7646617669325, 4713.316569097496, 4749.073930583538, 4872.293517439987, 4719.669623126382, 4734.289856521515, 4744.810207591692, 4787.018661174451, 4820.349252850855, 5148.974255128738, 5186.222066689989, 5188.429272779991, 5192.896142077175, 5204.9479505204845, 5354.277172581729, 5396.271503347037, 5440.211169380457, 5530.032244357221, 5537.390887002426, 5528.115501519737, 5534.501894829445, 5546.69493177875, 5622.634528755618, 5625.268715067015, 5151.484851514819, 5153.072446959583, 5155.458676838915, 5155.7679904404395, 5218.791248350023, 5472.808451704172, 5525.309336332958, 5643.238162847963, 5653.745581448845, 5654.293213348332, 5378.838634840961, 5404.351477822608, 5408.161734931092, 5413.675179489164, 5472.069748142825, 5452.890942181134, 5488.396276409591, 5493.423190565013, 5501.257330260363, 5502.147167189092, 5450.018996580654, 5491.395946445888, 5502.5597952164535, 5503.257060296889, 5574.526165275997, 5325.573954083664, 5394.460553944653, 5395.595330350239, 5429.67421954684, 5472.343318801769, 4280.6789490788315, 4281.443412356373, 4324.8486302979245, 4333.804978775963, 4341.630961368256, 3820.2741479118877, 3826.4069069294305, 3833.386658134685, 3868.845246190177, 3893.065664240562, 5163.09645811989, 5200.8959820803375, 5203.635745497854, 5260.71066091361, 5273.182656688219, 5499.615026948075, 5543.113101903757, 5561.221428999943, 5562.527185189223, 5566.137248726453, 5202.375714914235, 5255.290535777621, 5259.658122222043, 5265.947340526623, 5277.868053298622, 4830.4444988826735, 4850.6119510439785, 4852.80588776445, 4853.174960256694, 4857.319975203474, 5724.82641058582, 5736.942630573724, 5737.885242295214, 5743.684097374601, 5757.568182386338, 5551.91737611162, 5569.025420551468, 5570.359408668055, 5570.61005729595, 5572.972135139298, 5684.090545512863, 5721.8569535761935, 5823.7379317929945, 5829.970850145892, 5837.503812176013, 5423.3491980962535, 5428.430014848384, 5431.6740995540395, 5435.048866448435, 5437.293151890229, 5389.164679474688, 5531.004419204582, 5533.529649979797, 5541.5289700375915, 5602.935442265956, 5317.920231196458, 5327.920081198863, 5405.918816236847, 5408.350997880122, 5485.341758988788, 5400.810971615974, 5418.322709661293, 5421.593380496557, 5422.132458806572, 5422.48486393792, 5372.758225879923, 5402.135658294654, 5402.405735369185, 5406.648567843235, 5467.043267428105, 5276.604254680991, 5327.334083239595, 5334.8933021340135, 5397.244385785914, 5407.080796264566, 5159.561437277874, 5277.076511610376, 5281.788728450819, 5282.366116066097, 5289.841304760864], "value": 5115.146994942533, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.7540359329815, 593.3473179502548, 598.353777919846, 602.4126476685233, 611.5596770325366, 32361.029169124933, 32960.17599560012, 42616.573834261646, 43034.0, 43363.78318108405, 40355.798221008925, 45379.319310210376, 45387.319190212176, 45425.0, 45428.77285613567, 8100.432969692124, 8888.911110888905, 9068.682596109138, 9076.546172691373, 9078.228350590207, 8055.113937466874, 10581.470926453685, 10842.078423334026, 10852.511636976355, 11219.831702524469, 10988.0, 11004.724881877937, 11008.174386920973, 11035.172362072837, 11060.944695276512, 10798.67603971882, 10857.837132443019, 10864.0, 10904.182186336056, 10915.0, 10698.732531686692, 10758.515866786014, 10788.838167427495, 10793.78412431747, 10794.352338859693, 43291.0, 43556.56443435588, 43558.12883742339, 43694.344584831255, 43698.34452483215, 3476.617572067071, 3476.8261586920553, 3613.1689711366535, 3637.1816341323256, 3832.6550610445192, 30821.229469263224, 31349.529757053664, 32101.51847722286, 32123.678763212538, 32178.195545111324, 4293.3989241506215, 4366.868993930156, 4416.24923762961, 4539.251023581105, 4656.95343046572, 327299.0, 327345.0, 328486.0, 328827.0, 328982.0, 59462.40537594655, 60210.0, 60223.0, 60632.69683651553, 60688.69655651694, 33894.32211355759, 34012.31975360528, 34024.14939626529, 64618.35381646217, 64621.67689161524, 14297.428102875976, 14341.64145896361, 14426.278686065654, 14447.0, 14465.421383144556, 8715.215630593277, 8754.0, 9969.700908972742, 11173.608923687632, 11253.887461125447, 18790.0, 18993.43019709411, 19034.524136896413, 19104.33134840302, 19404.611907761766, 7205.063341765537, 7230.240824713434, 7233.529820561752, 7318.194998550155, 7339.70641174347, 934.1592566689898, 1076.6339444588878, 1080.5515710980012, 1080.7352198711367, 1126.0934947367284, 32402.67597324044, 32636.184095397806, 32687.182820429203, 32808.67191328104, 33327.166820829676, 1119.9440027998567, 1138.692553010699, 1172.1267655596635, 1194.3073017649742, 1238.1580525242741, 16830.579235518966, 17247.74128388075, 17263.913680431517, 17337.479875603753, 17382.91308543449, 544056.0, 548060.5969701499, 550975.3927068019, 551571.0, 553376.0, 59513.70243148757, 59924.101138482954, 59942.0, 60022.0, 60043.09935350973, 1185.1674497949907, 1212.1151559361715, 1311.0887932886742, 1316.4339334086435, 1321.2138777427415, 29362.412751744418, 33181.66818331883, 33414.0, 33662.49506257457, 33684.0, 50650.49349506458, 51375.22937155871, 51378.48621513737, 51409.0, 51411.0, 405366.9731651323, 406202.0, 406485.0, 408545.0, 411092.0, 25898.870505647352, 25958.610620840325, 26392.472150557267, 28729.0, 28773.0, 47239.055218896116, 47337.52662473331, 47521.0, 47578.76210619063, 47717.76141119411, 39575.60424395719, 40351.59648403596, 40666.390004150555, 41419.378709319986, 42552.57447425486, 40498.79750601346, 40523.18953620852, 41563.1687366257, 42008.0, 42114.789426053896, 40113.59886401215, 40359.79820100881, 40456.39315410212, 40750.75870827133, 40758.59241407548, 34182.0, 36016.63983360133, 36773.60971536842, 36863.81568092143, 37061.814690926374, 27794.305142371602, 28161.859190703915, 28231.0, 28278.85860570684, 28497.572536411557], "value": 20134.384022710907, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.9923001539968, 403.4714523973595, 405.4101282633768, 411.16738604326235, 424.17074619119626, 13729.519466818663, 15580.922095389522, 19075.427737167873, 19859.503512412197, 19953.70069448956, 18959.90520047401, 19166.904165479154, 19443.513912152204, 19654.705179422286, 19714.30999915003, 5110.437851836295, 5498.257735205756, 5630.859228519289, 5905.822825315247, 5908.202392676998, 5778.393268706788, 5794.246747922764, 5843.5033022193165, 5849.239598852165, 5874.265716785402, 5601.215829783833, 5780.739866705987, 5818.825435236929, 5833.7083145842535, 5834.970825145869, 5773.855653608652, 5792.4497172768515, 5820.301563812349, 5820.9708951455395, 5823.184754134425, 4972.378452693413, 5133.512316329943, 5168.793248270064, 5169.379674439091, 5211.817586384458, 21745.0, 22548.66177007346, 22705.0, 23150.884245578665, 23336.416589585227, 2383.6175018489407, 2489.514544663791, 2531.9113831015825, 2574.9871250643814, 2808.3260017595835, 10382.117520010808, 10384.480775961247, 10498.842517362245, 10924.781504369868, 10976.835347469794, 1810.167323031407, 1862.1527205121638, 1917.9520511987173, 1937.2154277517627, 1972.8618996670239, 80604.0, 85150.57424712837, 85404.57297713534, 86494.0, 86975.56512217398, 10724.517396717167, 10995.450227488594, 11128.109751219883, 11380.658580242605, 11458.760258704333, 16169.272382742805, 16181.4336498222, 16188.43340483101, 16217.59456013609, 16217.67564648724, 7323.450741194431, 7468.626568671545, 7609.733659321897, 7671.769846904602, 7729.4202934779, 6727.66361681914, 6735.865282694416, 6801.1158549388265, 6932.792016239521, 6933.410660093848, 4744.383230180124, 4751.885410992076, 4771.976140119277, 4785.521447855187, 4820.975895120502, 1959.2358979997812, 2004.8596598237984, 2012.8691635043676, 2025.1291944464022, 2033.6542787726123, 741.7107328142029, 890.4212262029732, 930.418488444722, 998.9500524973868, 1056.0062223596037, 18756.343527976456, 19519.707204391947, 19592.11835467379, 19616.901915490333, 19988.900055499922, 956.8229877472689, 972.1250874213123, 980.9166220871306, 998.6854140945579, 1051.5846240734868, 10259.0, 10495.947520262349, 10719.78560428787, 10769.084627806567, 10834.783304333869, 220869.0, 221371.0, 223100.0, 224356.0, 471018.0, 94199.0, 96975.51416259253, 100441.0, 101491.0, 103402.48298758458, 1000.3197825478744, 1019.9490025498695, 1053.9051485366508, 1070.882202957674, 1074.4305518075432, 16894.57763555872, 16990.57523561921, 17292.394766183123, 17868.374606889218, 18224.088795560434, 40867.38698919578, 42581.0, 43056.0, 43772.0, 44279.33580996352, 60684.0, 61094.0, 61475.692621536604, 62318.0, 62815.0, 8241.217084376975, 8536.231739143506, 8715.912840871764, 8720.171583699539, 8904.154105359981, 12094.39528023613, 12308.446119924445, 12415.751684966432, 12785.61643150707, 13129.666605560315, 10451.320664156805, 10739.516721747385, 10802.351858888493, 10830.67507974762, 11496.0, 10960.068394186264, 11113.0, 11238.7752244953, 11412.08703303717, 12003.81994270104, 11121.332720036824, 11260.887391125983, 11439.0, 11535.884641153816, 11632.0, 7576.924230757621, 7949.8410031800195, 8490.23587877094, 8652.437591556529, 8797.0, 10698.358098513803, 11150.665480035612, 11277.210595258253, 11362.659120226075, 11735.23720958135], "value": 9020.355839331916, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1442.7258820824045, 1484.7772834074888, 1574.5355120239528, 1698.2018451327872, 1720.320473413002, 7475.364594009502, 7790.9220907790905, 8054.0, 8584.356173287006, 8593.839831622738, 7994.840103197933, 8278.875816862752, 8290.83418331633, 8452.774347719576, 8472.940882389701, 2288.336382449088, 2319.93040208794, 2322.1175953137786, 2323.53529294141, 2336.7195936487647, 2011.8289945354663, 2077.802608752174, 2278.8860556972168, 2309.180241014441, 2336.158982766203, 2086.351782092153, 2113.1019316790303, 2198.8131008864266, 2274.238130226368, 2286.6112760830615, 2225.543763528473, 2233.140241007208, 2241.9551608967813, 2247.179779380531, 2247.763984781607, 2173.9891300543554, 2240.171136679423, 2240.283109404991, 2240.3950933247934, 2242.854214476054, 8292.958535207346, 8430.831383372359, 8448.662053517914, 8455.027671817757, 8458.74623761282, 5114.335136432277, 5256.448072952323, 5261.289725886994, 5262.342207224097, 5269.367675878881, 3258.0, 3401.047706642144, 3427.6915077642884, 3433.2790114076074, 3440.535527703753, 1126.8422420861086, 1163.2206421697483, 1183.3314177489776, 1199.322382853685, 1212.1696637803134, 11510.539578416854, 11585.18903676743, 11660.300381977024, 11671.649850504498, 11682.182247242696, 4496.617787488035, 4663.440387153495, 4738.0, 4782.282657601318, 4802.231642937113, 9894.257930655085, 9925.0, 9927.40435573868, 9932.553035113437, 9937.900620993698, 5306.416294207634, 5310.628256022119, 5315.840524784263, 5322.121849894724, 5324.733763311819, 4772.475027746945, 4895.339129217581, 4911.705297682151, 4911.87720306988, 4913.48408417111, 3824.2160357126722, 3847.7498962567342, 3900.9609903901164, 3932.1545867638597, 3985.9202815943518, 1279.0, 1281.8397700287464, 1283.9422225999851, 1306.288073000217, 1309.6922223277522, 766.8696321625337, 900.684760333891, 902.6479672927563, 923.8060007398387, 968.4286271100085, 5562.415946325658, 5606.859828504238, 5736.1682556029145, 5883.529317654663, 5892.558058145656, 926.9397489163183, 935.4106912645126, 943.4858002388714, 944.9527523623791, 999.0558921818956, 3841.4045822897497, 3967.5687477051088, 4000.2199571083943, 4042.6159514846045, 4163.333866581333, 9729.318947673737, 10364.429956352473, 10404.167666586654, 10406.27156099081, 10422.062014418738, 10093.0, 10344.32761870476, 10350.844737328945, 10353.06822385989, 10356.0, 7761.301482866569, 7864.0, 7915.84168316642, 7917.049954005441, 7917.683292668344, 5577.8047768327915, 5583.69289689071, 5606.187102870143, 5641.40765219646, 5765.4811067004175, 9557.235421166151, 9588.520573971413, 9646.372985755903, 9676.85484717744, 9789.216862650828, 9162.358634895494, 9633.277504187074, 9634.181094607036, 9734.561944712363, 9738.805223895624, 7427.44294177928, 7602.201768814195, 7602.391808655405, 7612.58130802789, 7619.238076192337, 8224.712135075482, 8226.876596850932, 8232.753017409488, 8242.711505097293, 8308.584570771558, 7291.38023268007, 7346.816329591803, 7351.117865855917, 7428.071491063617, 7696.0, 6903.89644155328, 7034.085568876013, 7060.7881763547175, 7377.889331659922, 7448.106227252764, 6131.032865489547, 6356.809295721136, 6392.712327945346, 6432.678366081771, 6530.412262896362, 4755.262934245197, 4868.269759535956, 4874.53691899269, 4953.2570114483115, 4987.426445958616, 4934.851954441372, 5062.569681577107, 5071.467495912876, 5096.974515127401, 5206.088934436534], "value": 4500.3623261524235, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.43443322535717, 333.88981636060095, 335.5604158552297, 341.5303957059045, 348.80466938514417, 4982.900341993162, 5167.5607573356265, 5274.2879711238975, 5278.36659600848, 5333.2000199970025, 4983.152864013117, 5183.64144314337, 5244.973775131129, 5257.158854583267, 5260.631755777097, 4108.506979162505, 4113.547509773923, 4126.154138401621, 4136.855210067648, 4149.356849688304, 3911.76529408235, 4007.939880901789, 4020.477337946063, 4105.4252404663375, 4125.773082480462, 4081.999910022049, 4089.672826173899, 4092.4884389451317, 4095.488063992001, 4096.746789265907, 4092.6521245694153, 4097.959020409788, 4098.7130900836955, 4104.056067104553, 4107.260693075245, 3465.896023119285, 3616.0959760059986, 3630.6006339302658, 3633.2551826875692, 3639.94540081899, 5077.136886729265, 5082.872928176826, 5096.235564665293, 5096.388433388017, 5106.361704786902, 4681.672282940195, 4687.117422784997, 4690.530946905316, 4694.638554819098, 4696.788644511005, 5260.263563101169, 5411.2965314508865, 5436.809711660112, 5462.344518657746, 5471.781128754845, 3957.7823219722904, 3961.3067713150085, 3973.662238709713, 3978.70692025093, 3978.76127432355, 5624.803131890364, 5656.830295091154, 5666.631668941547, 5712.314522257314, 5731.111677689964, 3887.552931412867, 4026.154507553388, 4095.2219078375015, 4104.610062044101, 4115.176964607091, 4092.2224777292813, 4093.4678491795876, 4105.67154627635, 4109.547949725527, 4115.650169735606, 4413.16149931512, 4544.818207271672, 4552.0, 4559.452865656142, 4559.794809233593, 5327.547158491571, 5471.316085489314, 5484.862878428071, 5492.395836457987, 5512.283403157644, 1412.0892024644047, 1422.2888555722138, 1423.516004558455, 1425.5509514502899, 1426.315368623046, 902.3007169443733, 927.1053433436766, 929.2612373163216, 929.7030642254152, 937.4562753602894, 4737.010455608653, 4750.358701575312, 4753.0, 4759.714417134914, 4760.928586071212, 4966.15575352191, 4968.4101087652325, 4968.577670898014, 4970.304157417964, 4984.451710311862, 4550.613197878151, 4685.484596694361, 4721.929171062437, 4725.385699858996, 4746.857594272177, 2615.856127912983, 2617.659704238475, 2631.2369412870053, 2635.0, 2635.89456421741, 5073.34046573943, 5082.738181509193, 5100.7959681613065, 5103.464136265713, 5118.283440318284, 4796.760161991887, 4929.334539837076, 4961.751912404366, 4966.467101778119, 5013.273075404119, 5003.174476211457, 5052.827284267727, 5091.974540127349, 5093.821716239914, 5100.923486147711, 4881.463039065629, 4887.731174785421, 4914.950850491592, 4929.309896614549, 4936.0, 4900.730459824601, 5186.573692234666, 5552.52803511706, 5595.0, 5609.214709940693, 5862.472377486047, 5866.823995280149, 5893.381194974638, 5897.439743224387, 5917.6745279010065, 4086.81609327575, 4100.507939047334, 4104.5690202529495, 4127.855525056729, 4135.669146468215, 5333.4133245343755, 5404.918926216032, 5532.529734972572, 5616.1856530803625, 5649.7740090397565, 5407.459254074561, 5425.864353391197, 5462.8907421850545, 5468.507834294933, 5546.916796247979, 5441.29263195782, 5481.671099734029, 5509.256250406143, 5511.889762204813, 5521.834344969658, 5264.1314183160885, 5399.78400863961, 5430.891382172255, 5445.0, 5471.589630777628, 5494.917576236279, 5516.310461192351, 5532.419095994863, 5542.806001789918, 5548.334199895877, 5282.864184200415, 5411.538884501084, 5414.35027796667, 5417.458254174709, 5423.074808443103], "value": 4072.702346379775, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.4719231364946, 721.931789892955, 740.389178927385, 758.5524540521092, 849.405416208654, 13753.0, 14574.198419086946, 14600.488982885588, 14607.050541714807, 14668.559943201695, 13232.0, 13304.268265245408, 13343.2661203634, 13352.866471335285, 13457.596272111852, 772.5982489105662, 784.3215618489994, 785.1794874356283, 785.83104632504, 785.9449838511307, 663.4161937495022, 683.4771399879096, 804.798800299925, 808.8584497712906, 809.4778867630375, 814.8003739083932, 839.7396806989822, 847.8516259654535, 848.0713618587637, 850.1158794853345, 840.8024114333127, 841.9789505262387, 842.0274582856811, 842.1662554071486, 842.338764070205, 517.350724840323, 529.2537522093868, 626.6146320013205, 627.9277883043463, 628.0924064726472, 12426.565070222588, 12754.278172446786, 12862.0, 13051.086423950328, 13064.804027939588, 14023.929880350635, 14662.0, 14859.108453492825, 14862.331195096138, 14987.250637468083, 11363.829542556869, 11376.317420954769, 11436.142289328334, 11561.595344162997, 11606.709832254177, 3616.782993020427, 3671.4859919611276, 3712.2204337089242, 3713.6657700806786, 3761.0785357587292, 76075.61962190154, 76203.6189819053, 76768.0, 77477.61261193715, 84180.73728894132, 11559.479823407966, 11568.074554035657, 11623.535058597561, 11810.704732381588, 11937.582184623496, 23127.190548330727, 23159.76840231576, 23178.53642927132, 23179.768202318097, 23180.21837379525, 8104.27061564462, 8180.345572354197, 8346.66613335472, 8494.320454363637, 8497.36269779769, 4295.9663449641175, 4338.3709362142945, 4340.066885619543, 4342.869713908588, 4371.125774845043, 3344.665533446636, 3439.8452069656923, 3444.431668774624, 3448.706859916885, 3451.430513965168, 587.9382664820217, 597.2146627185238, 597.745957967862, 617.5121653893464, 619.2290598205263, 554.5535843645904, 556.524171833085, 615.602936106209, 621.8414304352451, 664.2792570061538, 9480.0, 9617.23062155026, 9885.25860560461, 9922.751931201634, 10075.899241007643, 571.2858926342072, 624.1324558863183, 679.2358596578849, 683.5181197255922, 704.1901812915188, 4712.787924543404, 4872.9512704873205, 4873.220284754422, 4876.902461950741, 4890.486498917562, 68121.65939170272, 91520.54239728893, 95496.52251738835, 95760.52119739357, 109143.0, 91648.54175729211, 92020.0, 93894.0, 94962.52518737363, 95616.52191738997, 82812.0, 84035.5798221005, 87019.0, 87789.0, 89761.55119224363, 9791.706248812547, 10064.245181611555, 10281.948590257001, 10328.380297181893, 10331.638392656221, 47718.0, 48276.5172348272, 48987.265191022874, 49329.26006109839, 50087.74956125196, 69507.0, 70831.64584177046, 75205.0, 75463.0, 76075.61962190154, 12971.0, 12971.221726696429, 12982.15615984958, 13004.674883127998, 13279.86720132825, 13831.792523112363, 14177.36201870939, 14527.78208326897, 14847.628809279422, 15116.697666046397, 13353.79969300442, 13697.0, 14278.143311401349, 14279.357428915517, 14749.631259218606, 12573.622791316275, 13068.346582671018, 13130.868691312964, 13273.933630332172, 13449.394777235244, 12714.173578717353, 13066.0, 13120.737585248433, 13415.396307166397, 13518.324083795575, 11210.607628732956, 11251.268667536584, 11550.884491155317, 11594.188406811441, 11896.345700986529, 10514.894851051391, 10769.892301077203, 11352.716182095513, 11724.88275117238, 11822.82265765997], "value": 7326.154494914475, "unit": "score"}], "name": "dromaeo_css", "value": 7068.801600273381, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 111.0, 112.0, 114.0, 112.0, 114.0, 111.0, 112.0, 113.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 126.0, 130.0, 160.0, 129.0, 123.0, 122.0, 126.0, 151.0, 122.0], "value": 133.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 170.0, 160.0, 161.0, 162.0, 162.0, 161.0, 161.0, 160.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 115.0, 78.0, 76.0, 76.0, 76.0, 105.0, 76.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 115.0, 83.0, 84.0, 83.0, 104.0, 82.0, 82.0, 109.0], "value": 90.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 145.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 52.0, 51.0, 52.0, 53.0, 53.0, 52.0, 53.0, 53.0], "value": 52.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 62.0, 62.0, 63.0, 62.0, 62.0, 63.0, 64.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 80.0, 88.0, 80.0, 80.0, 80.0, 81.0, 80.0, 87.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 139.0, 129.0, 127.0, 135.0, 129.0, 140.0, 129.0, 171.0, 133.0], "value": 136.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 176.0, 165.0, 169.0, 173.0, 168.0, 170.0, 173.0, 168.0, 168.0], "value": 170.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 69.0, 66.0, 73.0, 66.0, 67.0, 66.0, 65.0, 63.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1510.5000000000002, "alertThreshold": 2.0}]} 18:47:22 INFO - Return code: 0 18:47:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:47:22 INFO - # TBPL SUCCESS # 18:47:22 INFO - Running post-action listener: _resource_record_post_action 18:47:22 INFO - [mozharness: 2016-10-08 01:47:22.089522Z] Finished run-tests step (success) 18:47:22 INFO - Running post-run listener: _resource_record_post_run 18:47:22 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 409296896; Read time: 16; Write time: 337416 18:47:22 INFO - TinderboxPrint: CPU usage
13.1% 18:47:22 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 18:47:22 INFO - TinderboxPrint: I/O write bytes / time
409,296,896 / 337,416 18:47:22 INFO - TinderboxPrint: CPU idle
8,298.2 (86.9%) 18:47:22 INFO - TinderboxPrint: CPU user
1,200.7 (12.6%) 18:47:22 INFO - TinderboxPrint: Swap in / out
0 / 0 18:47:22 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 119898112; Read time: 0; Write time: 81976 18:47:22 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 288395264; Read time: 0; Write time: 255408 18:47:22 INFO - Running post-run listener: _upload_blobber_files 18:47:22 INFO - Blob upload gear active. 18:47:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:47:22 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 18:47:22 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:47:22 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:47:23 INFO - (blobuploader) - INFO - Open directory for files ... 18:47:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:47:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:47:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:47:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:47:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:47:23 INFO - (blobuploader) - INFO - Done attempting. 18:47:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:47:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:47:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:47:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:47:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:47:24 INFO - (blobuploader) - INFO - Done attempting. 18:47:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:47:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:47:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:47:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:47:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:47:28 INFO - (blobuploader) - INFO - Done attempting. 18:47:28 INFO - (blobuploader) - INFO - Iteration through files over. 18:47:28 INFO - Return code: 0 18:47:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:47:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:47:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/647b62bf077d43254d645a49a7202fc9ecc6eabb056133efe860e71b3a3f31c5510502417ae85b9037d8731a1c48d9988eb8f2fc557d5642057a90bf5a070133", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c92cbefd48c7c0afc6aaddd05731d5657037a6e2a83d17903a94da0fabb1ca14dd41dfd07f0f07dc5caa6fbc24fa4871aab72e7b2caf6e8422037370af44022", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/92eae8be06cbaa8c99d9108e0a8cd87a42483179b10794101802b9bb17807b385eac5a9a1d5b15f343a5f5a66fb2f429cb90ef4a87c37fd5c1f38345e1d5d2b4"} 18:47:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:47:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:47:28 INFO - Contents: 18:47:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/647b62bf077d43254d645a49a7202fc9ecc6eabb056133efe860e71b3a3f31c5510502417ae85b9037d8731a1c48d9988eb8f2fc557d5642057a90bf5a070133", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c92cbefd48c7c0afc6aaddd05731d5657037a6e2a83d17903a94da0fabb1ca14dd41dfd07f0f07dc5caa6fbc24fa4871aab72e7b2caf6e8422037370af44022", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/92eae8be06cbaa8c99d9108e0a8cd87a42483179b10794101802b9bb17807b385eac5a9a1d5b15f343a5f5a66fb2f429cb90ef4a87c37fd5c1f38345e1d5d2b4"} 18:47:28 INFO - Running post-run listener: copy_logs_to_upload_dir 18:47:28 INFO - Copying logs to upload dir... 18:47:28 INFO - mkdir: /builds/slave/test/build/upload/logs 18:47:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.143202 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-07 18:47:28.143793) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 18:47:28.147586) ========= 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=14ef55db36f7623abb31b9cf000001d5-1475888958.767880-192553756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/647b62bf077d43254d645a49a7202fc9ecc6eabb056133efe860e71b3a3f31c5510502417ae85b9037d8731a1c48d9988eb8f2fc557d5642057a90bf5a070133", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c92cbefd48c7c0afc6aaddd05731d5657037a6e2a83d17903a94da0fabb1ca14dd41dfd07f0f07dc5caa6fbc24fa4871aab72e7b2caf6e8422037370af44022", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/92eae8be06cbaa8c99d9108e0a8cd87a42483179b10794101802b9bb17807b385eac5a9a1d5b15f343a5f5a66fb2f429cb90ef4a87c37fd5c1f38345e1d5d2b4"} build_url:https://queue.taskcluster.net/v1/task/Z2BLx0myRnygCH5IkqhV6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011203 build_url: 'https://queue.taskcluster.net/v1/task/Z2BLx0myRnygCH5IkqhV6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/647b62bf077d43254d645a49a7202fc9ecc6eabb056133efe860e71b3a3f31c5510502417ae85b9037d8731a1c48d9988eb8f2fc557d5642057a90bf5a070133", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c92cbefd48c7c0afc6aaddd05731d5657037a6e2a83d17903a94da0fabb1ca14dd41dfd07f0f07dc5caa6fbc24fa4871aab72e7b2caf6e8422037370af44022", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/92eae8be06cbaa8c99d9108e0a8cd87a42483179b10794101802b9bb17807b385eac5a9a1d5b15f343a5f5a66fb2f429cb90ef4a87c37fd5c1f38345e1d5d2b4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 18:47:28.178624) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 18:47:28.178973) ========= 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=14ef55db36f7623abb31b9cf000001d5-1475888958.767880-192553756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 18:47:28.260721) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 18:47:28.261439) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 18:47:28.262059) ========= ========= Total master_lag: 0.20 =========