builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-001 starttime: 1466543504.6 results: success (0) buildid: 20160621113020 builduid: b37153fbdb3647e69e41a84874564af3 revision: 448ad5bf7e92885c8c73acb0aee5d3e217712f95 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 14:11:44.603271) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 14:11:44.603722) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 14:11:44.604074) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 14:11:44.632972) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 14:11:44.633282) ========= 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=8887e36bb8e381bfd44124ac000001a8-1466540867.982696-1936983635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-21 14:11:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 30.2M=0s 2016-06-21 14:11:45 (30.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103980 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 14:11:44.753085) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 14:11:44.753414) ========= 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=8887e36bb8e381bfd44124ac000001a8-1466540867.982696-1936983635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020386 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 14:11:44.806792) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 14:11:44.807212) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 448ad5bf7e92885c8c73acb0aee5d3e217712f95 --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 448ad5bf7e92885c8c73acb0aee5d3e217712f95 --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=8887e36bb8e381bfd44124ac000001a8-1466540867.982696-1936983635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-21 14:11:45,273 truncating revision to first 12 chars 2016-06-21 14:11:45,273 Setting DEBUG logging. 2016-06-21 14:11:45,273 attempt 1/10 2016-06-21 14:11:45,273 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/448ad5bf7e92?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-21 14:11:45,647 unpacking tar archive at: fx-team-448ad5bf7e92/testing/mozharness/ program finished with exit code 0 elapsedTime=0.747054 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 14:11:45.570511) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 14:11:45.570881) ========= script_repo_revision: 448ad5bf7e92885c8c73acb0aee5d3e217712f95 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 14:11:45.571855) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 14:11:45.572281) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 14:11:45.583573) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-06-21 14:11:45.584052) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=8887e36bb8e381bfd44124ac000001a8-1466540867.982696-1936983635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:11:46 INFO - MultiFileLogger online at 20160621 14:11:46 in /builds/slave/test 14:11:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:11:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:11:46 INFO - {'append_to_log': False, 14:11:46 INFO - 'base_work_dir': '/builds/slave/test', 14:11:46 INFO - 'blob_upload_branch': 'Fx-Team', 14:11:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:11:46 INFO - 'branch': 'Fx-Team', 14:11:46 INFO - 'buildbot_json_path': 'buildprops.json', 14:11:46 INFO - 'config_files': ('talos/linux_config.py',), 14:11:46 INFO - 'default_actions': ('clobber', 14:11:46 INFO - 'read-buildbot-config', 14:11:46 INFO - 'download-and-extract', 14:11:46 INFO - 'populate-webroot', 14:11:46 INFO - 'create-virtualenv', 14:11:46 INFO - 'install', 14:11:46 INFO - 'run-tests'), 14:11:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:11:46 INFO - 'download_minidump_stackwalk': True, 14:11:46 INFO - 'download_symbols': 'ondemand', 14:11:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:11:46 INFO - 'tooltool.py': '/tools/tooltool.py', 14:11:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:11:46 INFO - '/tools/misc-python/virtualenv.py')}, 14:11:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:11:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:11:46 INFO - 'installer_path': 'installer.exe', 14:11:46 INFO - 'log_level': 'info', 14:11:46 INFO - 'log_name': 'talos', 14:11:46 INFO - 'log_to_console': True, 14:11:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:11:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:11:46 INFO - 'opt_config_files': (), 14:11:46 INFO - 'pip_index': False, 14:11:46 INFO - 'sps_profile': False, 14:11:46 INFO - 'sps_profile_interval': 0, 14:11:46 INFO - 'suite': 'dromaeojs-e10s', 14:11:46 INFO - 'system_bits': '32', 14:11:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:11:46 INFO - 'title': 'talos-linux64-ix-001', 14:11:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:11:46 INFO - 'use_talos_json': True, 14:11:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:11:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:11:46 INFO - 'work_dir': 'build'} 14:11:46 INFO - ##### 14:11:46 INFO - ##### Running clobber step. 14:11:46 INFO - ##### 14:11:46 INFO - Running pre-action listener: _resource_record_pre_action 14:11:46 INFO - Running main action method: clobber 14:11:46 INFO - rmtree: /builds/slave/test/build 14:11:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:11:46 INFO - Running post-action listener: _resource_record_post_action 14:11:46 INFO - ##### 14:11:46 INFO - ##### Finished clobber step (success) 14:11:46 INFO - ##### 14:11:46 INFO - ##### 14:11:46 INFO - ##### Running read-buildbot-config step. 14:11:46 INFO - ##### 14:11:46 INFO - Running pre-action listener: _resource_record_pre_action 14:11:46 INFO - Running main action method: read_buildbot_config 14:11:46 INFO - Using buildbot properties: 14:11:46 INFO - { 14:11:46 INFO - "project": "", 14:11:46 INFO - "product": "firefox", 14:11:46 INFO - "script_repo_revision": "production", 14:11:46 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:11:46 INFO - "repository": "", 14:11:46 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 14:11:46 INFO - "buildid": "20160621113020", 14:11:46 INFO - "pgo_build": "True", 14:11:46 INFO - "basedir": "/builds/slave/test", 14:11:46 INFO - "buildnumber": 850, 14:11:46 INFO - "slavename": "talos-linux64-ix-001", 14:11:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:11:46 INFO - "platform": "ubuntu64_hw", 14:11:46 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:11:46 INFO - "branch": "fx-team", 14:11:46 INFO - "repo_path": "integration/fx-team", 14:11:46 INFO - "revision": "448ad5bf7e92885c8c73acb0aee5d3e217712f95", 14:11:46 INFO - "stage_platform": "linux64-pgo", 14:11:46 INFO - "builduid": "b37153fbdb3647e69e41a84874564af3", 14:11:46 INFO - "slavebuilddir": "test" 14:11:46 INFO - } 14:11:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/CbVqcauFTcWuPl-FW-CkVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 14:11:46 INFO - Running post-action listener: _resource_record_post_action 14:11:46 INFO - ##### 14:11:46 INFO - ##### Finished read-buildbot-config step (success) 14:11:46 INFO - ##### 14:11:46 INFO - ##### 14:11:46 INFO - ##### Running download-and-extract step. 14:11:46 INFO - ##### 14:11:46 INFO - Running pre-action listener: _resource_record_pre_action 14:11:46 INFO - Running main action method: download_and_extract 14:11:46 INFO - mkdir: /builds/slave/test/build/tests 14:11:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:46 INFO - https://queue.taskcluster.net/v1/task/CbVqcauFTcWuPl-FW-CkVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:11:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbVqcauFTcWuPl-FW-CkVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:11:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbVqcauFTcWuPl-FW-CkVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:11:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbVqcauFTcWuPl-FW-CkVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:11:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbVqcauFTcWuPl-FW-CkVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:11:48 INFO - Downloaded 1361 bytes. 14:11:48 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:11:48 INFO - Using the following test package requirements: 14:11:48 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:11:48 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:11:48 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:11:48 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:48 INFO - u'jsshell-linux-x86_64.zip'], 14:11:48 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:11:48 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:11:48 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:11:48 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:11:48 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:11:48 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:11:48 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:11:48 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:48 INFO - https://queue.taskcluster.net/v1/task/CbVqcauFTcWuPl-FW-CkVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:11:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbVqcauFTcWuPl-FW-CkVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:11:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbVqcauFTcWuPl-FW-CkVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:11:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbVqcauFTcWuPl-FW-CkVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:11:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbVqcauFTcWuPl-FW-CkVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:11:49 INFO - Downloaded 24225417 bytes. 14:11:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:11:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:11:51 INFO - Return code: 0 14:11:51 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:11:51 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:51 INFO - https://queue.taskcluster.net/v1/task/CbVqcauFTcWuPl-FW-CkVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:11:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbVqcauFTcWuPl-FW-CkVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:11:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbVqcauFTcWuPl-FW-CkVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:11:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbVqcauFTcWuPl-FW-CkVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:11:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbVqcauFTcWuPl-FW-CkVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:12:18 INFO - Downloaded 24225417 bytes. 14:12:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:12:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:12:20 INFO - Return code: 0 14:12: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:20 INFO - https://queue.taskcluster.net/v1/task/CbVqcauFTcWuPl-FW-CkVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:12:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbVqcauFTcWuPl-FW-CkVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:12:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbVqcauFTcWuPl-FW-CkVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:12:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbVqcauFTcWuPl-FW-CkVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:12:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbVqcauFTcWuPl-FW-CkVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:12:34 INFO - Downloaded 14405384 bytes. 14:12:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:12:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:12:34 INFO - Return code: 0 14:12:34 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:34 INFO - https://queue.taskcluster.net/v1/task/CbVqcauFTcWuPl-FW-CkVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:12:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbVqcauFTcWuPl-FW-CkVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:12:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbVqcauFTcWuPl-FW-CkVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:12:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbVqcauFTcWuPl-FW-CkVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:12:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbVqcauFTcWuPl-FW-CkVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:12:36 INFO - Downloaded 60129851 bytes. 14:12:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CbVqcauFTcWuPl-FW-CkVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:12:36 INFO - mkdir: /builds/slave/test/properties 14:12:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:12:36 INFO - Writing to file /builds/slave/test/properties/build_url 14:12:36 INFO - Contents: 14:12:36 INFO - build_url:https://queue.taskcluster.net/v1/task/CbVqcauFTcWuPl-FW-CkVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:12:36 INFO - Running post-action listener: _resource_record_post_action 14:12:36 INFO - Running post-action listener: set_extra_try_arguments 14:12:36 INFO - ##### 14:12:36 INFO - ##### Finished download-and-extract step (success) 14:12:36 INFO - ##### 14:12:36 INFO - ##### 14:12:36 INFO - ##### Running populate-webroot step. 14:12:36 INFO - ##### 14:12:36 INFO - Running pre-action listener: _resource_record_pre_action 14:12:36 INFO - Running main action method: populate_webroot 14:12:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:12:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:12:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:12:36 INFO - '--tppagecycles', 14:12:36 INFO - '7'], 14:12:36 INFO - 'tests': ['tsvgm']}}, 14:12:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:12:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:12:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:12:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:12:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:12:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:12:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:36 INFO - 'talos_options': ['--disable-e10s'], 14:12:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:12:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:12:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:36 INFO - 'talos_options': ['--disable-e10s'], 14:12:36 INFO - 'tests': ['damp', 'tps']}, 14:12:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:36 INFO - 'tests': ['damp', 'tps']}, 14:12:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:12:36 INFO - 'tests': ['dromaeo_dom']}, 14:12:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:12:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:12:36 INFO - 'tests': ['basic_compositor_video']}, 14:12:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:12:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:12:36 INFO - 'tests': ['a11yr', 14:12:36 INFO - 'ts_paint', 14:12:36 INFO - 'tpaint', 14:12:36 INFO - 'sessionrestore', 14:12:36 INFO - 'sessionrestore_no_auto_restore', 14:12:36 INFO - 'tabpaint']}, 14:12:36 INFO - 'other-e10s': {'tests': ['a11yr', 14:12:36 INFO - 'ts_paint', 14:12:36 INFO - 'tpaint', 14:12:36 INFO - 'sessionrestore', 14:12:36 INFO - 'sessionrestore_no_auto_restore', 14:12:36 INFO - 'tabpaint']}, 14:12:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:12:36 INFO - 'ts_paint', 14:12:36 INFO - 'tpaint', 14:12:36 INFO - 'sessionrestore', 14:12:36 INFO - 'sessionrestore_no_auto_restore', 14:12:36 INFO - 'tabpaint']}, 14:12:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:12:36 INFO - 'ts_paint', 14:12:36 INFO - 'tpaint', 14:12:36 INFO - 'sessionrestore', 14:12:36 INFO - 'sessionrestore_no_auto_restore', 14:12:36 INFO - 'tabpaint']}, 14:12:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:12:36 INFO - 'tests': ['a11yr', 14:12:36 INFO - 'ts_paint', 14:12:36 INFO - 'tpaint', 14:12:36 INFO - 'sessionrestore', 14:12:36 INFO - 'sessionrestore_no_auto_restore', 14:12:36 INFO - 'tabpaint']}, 14:12:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:12:36 INFO - 'tests': ['a11yr', 14:12:36 INFO - 'ts_paint', 14:12:36 INFO - 'tpaint', 14:12:36 INFO - 'sessionrestore', 14:12:36 INFO - 'sessionrestore_no_auto_restore', 14:12:36 INFO - 'tabpaint']}, 14:12:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:12:36 INFO - 'tests': ['tsvgx', 14:12:36 INFO - 'tsvgr_opacity', 14:12:36 INFO - 'tart', 14:12:36 INFO - 'tscrollx', 14:12:36 INFO - 'cart']}, 14:12:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:12:36 INFO - 'tsvgr_opacity', 14:12:36 INFO - 'tart', 14:12:36 INFO - 'tscrollx', 14:12:36 INFO - 'cart']}, 14:12:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:36 INFO - 'talos_options': ['--disable-e10s'], 14:12:36 INFO - 'tests': ['tp5o']}, 14:12:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:36 INFO - 'tests': ['tp5o']}, 14:12:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:36 INFO - 'talos_options': ['--disable-e10s', 14:12:36 INFO - '--xperf_path', 14:12:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:12:36 INFO - 'tests': ['tp5n']}, 14:12:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:36 INFO - 'talos_options': ['--xperf_path', 14:12:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:12:36 INFO - 'tests': ['tp5n']}}, 14:12:36 INFO - 'talos.zip': {'path': '', 14:12:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:12:36 INFO - Running post-action listener: _resource_record_post_action 14:12:36 INFO - ##### 14:12:36 INFO - ##### Finished populate-webroot step (success) 14:12:36 INFO - ##### 14:12:36 INFO - ##### 14:12:36 INFO - ##### Running create-virtualenv step. 14:12:36 INFO - ##### 14:12:36 INFO - Running pre-action listener: _resource_record_pre_action 14:12:36 INFO - Running main action method: create_virtualenv 14:12:36 INFO - Creating virtualenv /builds/slave/test/build/venv 14:12:36 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 14:12:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:12:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:12:36 INFO - Using real prefix '/usr' 14:12:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:12:37 INFO - Installing distribute.............................................................................................................................................................................................done. 14:12:39 INFO - Installing pip.................done. 14:12:39 INFO - Return code: 0 14:12:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:39 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 0x7f627e96df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1beb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a1c0>, '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 0x1c7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c7b550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466540867.982696-1936983635', '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 14:12:39 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 14:12:39 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 14:12:39 INFO - Using env: {'DISPLAY': ':0', 14:12:39 INFO - 'HOME': '/home/cltbld', 14:12:39 INFO - 'LANG': 'en_US.UTF-8', 14:12:39 INFO - 'LANGUAGE': 'en_US:en', 14:12:39 INFO - 'LOGNAME': 'cltbld', 14:12:39 INFO - 'MAIL': '/var/mail/cltbld', 14:12:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:39 INFO - 'MOZ_NO_REMOTE': '1', 14:12:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:39 INFO - 'NO_EM_RESTART': '1', 14:12:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:39 INFO - 'PWD': '/builds/slave/test', 14:12:39 INFO - 'SHELL': '/bin/bash', 14:12:39 INFO - 'SHLVL': '1', 14:12:39 INFO - 'TERM': 'linux', 14:12:39 INFO - 'TMOUT': '86400', 14:12:39 INFO - 'USER': 'cltbld', 14:12:39 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466540867.982696-1936983635', 14:12:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:39 INFO - '_': '/tools/buildbot/bin/python'} 14:12:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:39 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 14:12:39 INFO - Cleaning up... 14:12:39 INFO - Return code: 0 14:12:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:39 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 0x7f627e96df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1beb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a1c0>, '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 0x1c7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c7b550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466540867.982696-1936983635', '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 14:12:39 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 14:12:39 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 14:12:39 INFO - Using env: {'DISPLAY': ':0', 14:12:39 INFO - 'HOME': '/home/cltbld', 14:12:39 INFO - 'LANG': 'en_US.UTF-8', 14:12:39 INFO - 'LANGUAGE': 'en_US:en', 14:12:39 INFO - 'LOGNAME': 'cltbld', 14:12:39 INFO - 'MAIL': '/var/mail/cltbld', 14:12:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:39 INFO - 'MOZ_NO_REMOTE': '1', 14:12:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:39 INFO - 'NO_EM_RESTART': '1', 14:12:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:39 INFO - 'PWD': '/builds/slave/test', 14:12:39 INFO - 'SHELL': '/bin/bash', 14:12:39 INFO - 'SHLVL': '1', 14:12:39 INFO - 'TERM': 'linux', 14:12:39 INFO - 'TMOUT': '86400', 14:12:39 INFO - 'USER': 'cltbld', 14:12:39 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466540867.982696-1936983635', 14:12:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:39 INFO - '_': '/tools/buildbot/bin/python'} 14:12:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:39 INFO - Downloading/unpacking psutil>=3.1.1 14:12:39 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 14:12:39 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 14:12:39 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 14:12:39 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 14:12:39 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 14:12:39 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 14:12:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:12:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:12:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:12:41 INFO - Installing collected packages: psutil 14:12:41 INFO - Running setup.py install for psutil 14:12:41 INFO - building 'psutil._psutil_linux' extension 14:12:41 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 14:12:42 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 14:12:42 INFO - building 'psutil._psutil_posix' extension 14:12:42 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 14:12:42 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 14:12:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:12:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:12:42 INFO - Successfully installed psutil 14:12:42 INFO - Cleaning up... 14:12:42 INFO - Return code: 0 14:12:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:12:42 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:42 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:42 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 0x7f627e96df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1beb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a1c0>, '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 0x1c7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c7b550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466540867.982696-1936983635', '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 14:12:42 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 14:12:42 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 14:12:42 INFO - Using env: {'DISPLAY': ':0', 14:12:42 INFO - 'HOME': '/home/cltbld', 14:12:42 INFO - 'LANG': 'en_US.UTF-8', 14:12:42 INFO - 'LANGUAGE': 'en_US:en', 14:12:42 INFO - 'LOGNAME': 'cltbld', 14:12:42 INFO - 'MAIL': '/var/mail/cltbld', 14:12:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:42 INFO - 'MOZ_NO_REMOTE': '1', 14:12:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:42 INFO - 'NO_EM_RESTART': '1', 14:12:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:42 INFO - 'PWD': '/builds/slave/test', 14:12:42 INFO - 'SHELL': '/bin/bash', 14:12:42 INFO - 'SHLVL': '1', 14:12:42 INFO - 'TERM': 'linux', 14:12:42 INFO - 'TMOUT': '86400', 14:12:42 INFO - 'USER': 'cltbld', 14:12:42 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466540867.982696-1936983635', 14:12:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:42 INFO - '_': '/tools/buildbot/bin/python'} 14:12:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:12:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:12:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:12:44 INFO - Installing collected packages: mozsystemmonitor 14:12:44 INFO - Running setup.py install for mozsystemmonitor 14:12:44 INFO - Successfully installed mozsystemmonitor 14:12:44 INFO - Cleaning up... 14:12:44 INFO - Return code: 0 14:12:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:12:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f627e96df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1beb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a1c0>, '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 0x1c7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c7b550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466540867.982696-1936983635', '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 14:12:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:12:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:12:44 INFO - Using env: {'DISPLAY': ':0', 14:12:44 INFO - 'HOME': '/home/cltbld', 14:12:44 INFO - 'LANG': 'en_US.UTF-8', 14:12:44 INFO - 'LANGUAGE': 'en_US:en', 14:12:44 INFO - 'LOGNAME': 'cltbld', 14:12:44 INFO - 'MAIL': '/var/mail/cltbld', 14:12:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:44 INFO - 'MOZ_NO_REMOTE': '1', 14:12:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:44 INFO - 'NO_EM_RESTART': '1', 14:12:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:44 INFO - 'PWD': '/builds/slave/test', 14:12:44 INFO - 'SHELL': '/bin/bash', 14:12:44 INFO - 'SHLVL': '1', 14:12:44 INFO - 'TERM': 'linux', 14:12:44 INFO - 'TMOUT': '86400', 14:12:44 INFO - 'USER': 'cltbld', 14:12:44 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466540867.982696-1936983635', 14:12:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:44 INFO - '_': '/tools/buildbot/bin/python'} 14:12:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:44 INFO - Downloading/unpacking jsonschema==2.5.1 14:12:44 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 14:12:44 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 14:12:44 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 14:12:44 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 14:12:44 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 14:12:44 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 14:12:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:12:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:12:46 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 14:12:46 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 14:12:46 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 14:12:46 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 14:12:46 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 14:12:46 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 14:12:46 INFO - Downloading functools32-3.2.3-2.tar.gz 14:12:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:12:47 INFO - warning: no files found matching '*.txt' 14:12:47 INFO - no previously-included directories found matching 'build' 14:12:47 INFO - no previously-included directories found matching 'dist' 14:12:47 INFO - no previously-included directories found matching '.git*' 14:12:47 INFO - Installing collected packages: jsonschema, functools32 14:12:47 INFO - Running setup.py install for functools32 14:12:47 INFO - warning: no files found matching '*.txt' 14:12:47 INFO - no previously-included directories found matching 'build' 14:12:47 INFO - no previously-included directories found matching 'dist' 14:12:47 INFO - no previously-included directories found matching '.git*' 14:12:47 INFO - Successfully installed jsonschema functools32 14:12:47 INFO - Cleaning up... 14:12:47 INFO - Return code: 0 14:12:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:12:47 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:47 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:47 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 0x7f627e96df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1beb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a1c0>, '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 0x1c7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c7b550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466540867.982696-1936983635', '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 14:12:47 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 14:12:47 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 14:12:47 INFO - Using env: {'DISPLAY': ':0', 14:12:47 INFO - 'HOME': '/home/cltbld', 14:12:47 INFO - 'LANG': 'en_US.UTF-8', 14:12:47 INFO - 'LANGUAGE': 'en_US:en', 14:12:47 INFO - 'LOGNAME': 'cltbld', 14:12:47 INFO - 'MAIL': '/var/mail/cltbld', 14:12:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:47 INFO - 'MOZ_NO_REMOTE': '1', 14:12:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:47 INFO - 'NO_EM_RESTART': '1', 14:12:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:47 INFO - 'PWD': '/builds/slave/test', 14:12:47 INFO - 'SHELL': '/bin/bash', 14:12:47 INFO - 'SHLVL': '1', 14:12:47 INFO - 'TERM': 'linux', 14:12:47 INFO - 'TMOUT': '86400', 14:12:47 INFO - 'USER': 'cltbld', 14:12:47 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466540867.982696-1936983635', 14:12:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:47 INFO - '_': '/tools/buildbot/bin/python'} 14:12:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:47 INFO - Downloading/unpacking blobuploader==1.2.4 14:12:47 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 14:12:47 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 14:12:47 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 14:12:47 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 14:12:47 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 14:12:47 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 14:12:49 INFO - Downloading blobuploader-1.2.4.tar.gz 14:12:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:12:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:12:49 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 14:12:49 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 14:12:49 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 14:12:49 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 14:12:49 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 14:12:49 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 14:12:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:12:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:12:49 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 14:12:49 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 14:12:49 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 14:12:49 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 14:12:49 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 14:12:49 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 14:12:50 INFO - Downloading docopt-0.6.1.tar.gz 14:12:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:12:50 INFO - Installing collected packages: blobuploader, requests, docopt 14:12:50 INFO - Running setup.py install for blobuploader 14:12:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:12:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:12:50 INFO - Running setup.py install for requests 14:12:50 INFO - Running setup.py install for docopt 14:12:50 INFO - Successfully installed blobuploader requests docopt 14:12:51 INFO - Cleaning up... 14:12:51 INFO - Return code: 0 14:12:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:12:51 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:51 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:51 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 0x7f627e96df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1beb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a1c0>, '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 0x1c7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c7b550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466540867.982696-1936983635', '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 14:12:51 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 14:12:51 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 14:12:51 INFO - Using env: {'DISPLAY': ':0', 14:12:51 INFO - 'HOME': '/home/cltbld', 14:12:51 INFO - 'LANG': 'en_US.UTF-8', 14:12:51 INFO - 'LANGUAGE': 'en_US:en', 14:12:51 INFO - 'LOGNAME': 'cltbld', 14:12:51 INFO - 'MAIL': '/var/mail/cltbld', 14:12:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:51 INFO - 'MOZ_NO_REMOTE': '1', 14:12:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:51 INFO - 'NO_EM_RESTART': '1', 14:12:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:51 INFO - 'PWD': '/builds/slave/test', 14:12:51 INFO - 'SHELL': '/bin/bash', 14:12:51 INFO - 'SHLVL': '1', 14:12:51 INFO - 'TERM': 'linux', 14:12:51 INFO - 'TMOUT': '86400', 14:12:51 INFO - 'USER': 'cltbld', 14:12:51 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466540867.982696-1936983635', 14:12:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:51 INFO - '_': '/tools/buildbot/bin/python'} 14:12:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:12:51 INFO - Running setup.py (path:/tmp/pip-W9lDo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:12:51 INFO - Running setup.py (path:/tmp/pip-xXWebs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:12:51 INFO - Running setup.py (path:/tmp/pip-Vji0Lk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:12:51 INFO - Running setup.py (path:/tmp/pip-xpTorX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:12:51 INFO - Running setup.py (path:/tmp/pip-YwDU23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:12:51 INFO - Running setup.py (path:/tmp/pip-HlC94o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:12:51 INFO - Running setup.py (path:/tmp/pip-4n5dX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:12:51 INFO - Running setup.py (path:/tmp/pip-5T9bpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:12:51 INFO - Running setup.py (path:/tmp/pip-_2xSaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:12:52 INFO - Running setup.py (path:/tmp/pip-FVNIOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:12:52 INFO - Running setup.py (path:/tmp/pip-AxbUnY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:12:52 INFO - Running setup.py (path:/tmp/pip-fsX0J3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:12:52 INFO - Running setup.py (path:/tmp/pip-6Jnwfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:12:52 INFO - Running setup.py (path:/tmp/pip-rKC9aq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:12:52 INFO - Running setup.py (path:/tmp/pip-TdslHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:12:52 INFO - Running setup.py (path:/tmp/pip-6N0SAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:12:52 INFO - Running setup.py (path:/tmp/pip-82_urD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:12:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:12:52 INFO - Running setup.py install for manifestparser 14:12:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:12:52 INFO - Running setup.py install for mozcrash 14:12:52 INFO - Running setup.py install for mozdebug 14:12:52 INFO - Running setup.py install for mozdevice 14:12:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:12:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:12:53 INFO - Running setup.py install for mozfile 14:12:53 INFO - Running setup.py install for mozhttpd 14:12:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:12:53 INFO - Running setup.py install for mozinfo 14:12:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:12:53 INFO - Running setup.py install for mozInstall 14:12:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:12:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:12:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:12:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:12:53 INFO - Running setup.py install for mozleak 14:12:53 INFO - Running setup.py install for mozlog 14:12:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:12:53 INFO - Running setup.py install for moznetwork 14:12:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:12:53 INFO - Running setup.py install for mozprocess 14:12:53 INFO - Running setup.py install for mozprofile 14:12:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:12:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:12:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:12:53 INFO - Running setup.py install for mozrunner 14:12:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:12:54 INFO - Running setup.py install for mozscreenshot 14:12:54 INFO - Running setup.py install for moztest 14:12:54 INFO - Running setup.py install for mozversion 14:12:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:12:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:12:54 INFO - Cleaning up... 14:12:54 INFO - Return code: 0 14:12:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:12:54 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:54 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:54 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 0x7f627e96df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1beb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a1c0>, '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 0x1c7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c7b550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466540867.982696-1936983635', '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 14:12:54 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 14:12:54 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 14:12:54 INFO - Using env: {'DISPLAY': ':0', 14:12:54 INFO - 'HOME': '/home/cltbld', 14:12:54 INFO - 'LANG': 'en_US.UTF-8', 14:12:54 INFO - 'LANGUAGE': 'en_US:en', 14:12:54 INFO - 'LOGNAME': 'cltbld', 14:12:54 INFO - 'MAIL': '/var/mail/cltbld', 14:12:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:54 INFO - 'MOZ_NO_REMOTE': '1', 14:12:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:54 INFO - 'NO_EM_RESTART': '1', 14:12:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:54 INFO - 'PWD': '/builds/slave/test', 14:12:54 INFO - 'SHELL': '/bin/bash', 14:12:54 INFO - 'SHLVL': '1', 14:12:54 INFO - 'TERM': 'linux', 14:12:54 INFO - 'TMOUT': '86400', 14:12:54 INFO - 'USER': 'cltbld', 14:12:54 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466540867.982696-1936983635', 14:12:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:54 INFO - '_': '/tools/buildbot/bin/python'} 14:12:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:12:54 INFO - Running setup.py (path:/tmp/pip-BEvvp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:12:54 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)) 14:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:12:54 INFO - Running setup.py (path:/tmp/pip-4I17kJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:12:54 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)) 14:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:12:54 INFO - Running setup.py (path:/tmp/pip-a8e8rj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:12:54 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)) 14:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:12:54 INFO - Running setup.py (path:/tmp/pip-x2NSyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:12:54 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)) 14:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:12:54 INFO - Running setup.py (path:/tmp/pip-QvGaSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:12:54 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)) 14:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:12:54 INFO - Running setup.py (path:/tmp/pip-VYIKv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:12:55 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)) 14:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:12:55 INFO - Running setup.py (path:/tmp/pip-Imv5m5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:12:55 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)) 14:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:12:55 INFO - Running setup.py (path:/tmp/pip-Aq6ZWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:12:55 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)) 14:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:12:55 INFO - Running setup.py (path:/tmp/pip-GKS1u6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:12:55 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)) 14:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:12:55 INFO - Running setup.py (path:/tmp/pip-Adsi3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:12:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 14:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:12:55 INFO - Running setup.py (path:/tmp/pip-D9uMkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:12:55 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)) 14:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:12:55 INFO - Running setup.py (path:/tmp/pip-wxWv0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:12:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 14:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:12:55 INFO - Running setup.py (path:/tmp/pip-xeAPYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:12:55 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)) 14:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:12:55 INFO - Running setup.py (path:/tmp/pip-hfuWYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:12:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 14:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:12:55 INFO - Running setup.py (path:/tmp/pip-ubFppd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:12:55 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)) 14:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:12:55 INFO - Running setup.py (path:/tmp/pip-r7gNge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:12:55 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)) 14:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:12:55 INFO - Running setup.py (path:/tmp/pip-8Brg_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:12:55 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)) 14:12:55 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)) 14:12:55 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)) 14:12:55 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)) 14:12:55 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)) 14:12:55 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)) 14:12:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:12:55 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 14:12:55 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 14:12:55 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 14:12:55 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 14:12:55 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 14:12:55 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 14:12:57 INFO - Downloading blessings-1.6.tar.gz 14:12:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:12:57 INFO - Installing collected packages: blessings 14:12:57 INFO - Running setup.py install for blessings 14:12:57 INFO - Successfully installed blessings 14:12:57 INFO - Cleaning up... 14:12:58 INFO - Return code: 0 14:12:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:12:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:12:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:12:58 INFO - Reading from file tmpfile_stdout 14:12:58 INFO - Current package versions: 14:12:58 INFO - argparse == 1.2.1 14:12:58 INFO - blessings == 1.6 14:12:58 INFO - blobuploader == 1.2.4 14:12:58 INFO - docopt == 0.6.1 14:12:58 INFO - functools32 == 3.2.3-2 14:12:58 INFO - jsonschema == 2.5.1 14:12:58 INFO - manifestparser == 1.1 14:12:58 INFO - mozInstall == 1.12 14:12:58 INFO - mozcrash == 0.17 14:12:58 INFO - mozdebug == 0.1 14:12:58 INFO - mozdevice == 0.48 14:12:58 INFO - mozfile == 1.2 14:12:58 INFO - mozhttpd == 0.7 14:12:58 INFO - mozinfo == 0.9 14:12:58 INFO - mozleak == 0.1 14:12:58 INFO - mozlog == 3.2 14:12:58 INFO - moznetwork == 0.27 14:12:58 INFO - mozprocess == 0.22 14:12:58 INFO - mozprofile == 0.28 14:12:58 INFO - mozrunner == 6.11 14:12:58 INFO - mozscreenshot == 0.1 14:12:58 INFO - mozsystemmonitor == 0.3 14:12:58 INFO - moztest == 0.7 14:12:58 INFO - mozversion == 1.4 14:12:58 INFO - psutil == 3.1.1 14:12:58 INFO - requests == 1.2.3 14:12:58 INFO - wsgiref == 0.1.2 14:12:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:12:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:58 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 0x7f627e96df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1beb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a1c0>, '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 0x1c7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c7b550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466540867.982696-1936983635', '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 14:12:58 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 14:12:58 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 14:12:58 INFO - Using env: {'DISPLAY': ':0', 14:12:58 INFO - 'HOME': '/home/cltbld', 14:12:58 INFO - 'LANG': 'en_US.UTF-8', 14:12:58 INFO - 'LANGUAGE': 'en_US:en', 14:12:58 INFO - 'LOGNAME': 'cltbld', 14:12:58 INFO - 'MAIL': '/var/mail/cltbld', 14:12:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:58 INFO - 'MOZ_NO_REMOTE': '1', 14:12:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:58 INFO - 'NO_EM_RESTART': '1', 14:12:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:58 INFO - 'PWD': '/builds/slave/test', 14:12:58 INFO - 'SHELL': '/bin/bash', 14:12:58 INFO - 'SHLVL': '1', 14:12:58 INFO - 'TERM': 'linux', 14:12:58 INFO - 'TMOUT': '86400', 14:12:58 INFO - 'USER': 'cltbld', 14:12:58 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466540867.982696-1936983635', 14:12:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:58 INFO - '_': '/tools/buildbot/bin/python'} 14:12:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:58 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)) 14:12:58 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)) 14:12:58 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)) 14:12:58 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)) 14:12:58 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)) 14:12:58 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)) 14:12:58 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)) 14:12:58 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)) 14:12:58 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)) 14:12:58 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)) 14:12:58 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)) 14:12:58 INFO - Cleaning up... 14:12:58 INFO - Return code: 0 14:12:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:12:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:58 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 0x7f627e96df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1beb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a1c0>, '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 0x1c7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c7b550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466540867.982696-1936983635', '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 14:12:58 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 14:12:58 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 14:12:58 INFO - Using env: {'DISPLAY': ':0', 14:12:58 INFO - 'HOME': '/home/cltbld', 14:12:58 INFO - 'LANG': 'en_US.UTF-8', 14:12:58 INFO - 'LANGUAGE': 'en_US:en', 14:12:58 INFO - 'LOGNAME': 'cltbld', 14:12:58 INFO - 'MAIL': '/var/mail/cltbld', 14:12:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:58 INFO - 'MOZ_NO_REMOTE': '1', 14:12:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:58 INFO - 'NO_EM_RESTART': '1', 14:12:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:58 INFO - 'PWD': '/builds/slave/test', 14:12:58 INFO - 'SHELL': '/bin/bash', 14:12:58 INFO - 'SHLVL': '1', 14:12:58 INFO - 'TERM': 'linux', 14:12:58 INFO - 'TMOUT': '86400', 14:12:58 INFO - 'USER': 'cltbld', 14:12:58 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466540867.982696-1936983635', 14:12:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:58 INFO - '_': '/tools/buildbot/bin/python'} 14:12:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:12:58 INFO - Cleaning up... 14:12:58 INFO - Return code: 0 14:12:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:12:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:58 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f627e96df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1beb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a1c0>, '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 0x1c7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c7b550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466540867.982696-1936983635', '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 14:12:58 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', 'flake8'] in /builds/slave/test/build 14:12:58 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 flake8 14:12:58 INFO - Using env: {'DISPLAY': ':0', 14:12:58 INFO - 'HOME': '/home/cltbld', 14:12:58 INFO - 'LANG': 'en_US.UTF-8', 14:12:58 INFO - 'LANGUAGE': 'en_US:en', 14:12:58 INFO - 'LOGNAME': 'cltbld', 14:12:58 INFO - 'MAIL': '/var/mail/cltbld', 14:12:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:58 INFO - 'MOZ_NO_REMOTE': '1', 14:12:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:58 INFO - 'NO_EM_RESTART': '1', 14:12:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:58 INFO - 'PWD': '/builds/slave/test', 14:12:58 INFO - 'SHELL': '/bin/bash', 14:12:58 INFO - 'SHLVL': '1', 14:12:58 INFO - 'TERM': 'linux', 14:12:58 INFO - 'TMOUT': '86400', 14:12:58 INFO - 'USER': 'cltbld', 14:12:58 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466540867.982696-1936983635', 14:12:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:58 INFO - '_': '/tools/buildbot/bin/python'} 14:12:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:58 INFO - Downloading/unpacking flake8 14:12:58 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 14:12:58 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 14:12:58 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 14:12:58 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 14:12:58 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 14:12:58 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 14:13:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:13:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:13:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:13:01 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 14:13:01 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 14:13:01 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 14:13:01 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 14:13:01 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 14:13:01 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 14:13:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:13:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:13:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:13:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:13:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:13:01 INFO - no previously-included directories found matching 'docs/_build' 14:13:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:13:01 INFO - Running setup.py install for pep8 14:13:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:13:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:13:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:13:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:13:01 INFO - no previously-included directories found matching 'docs/_build' 14:13:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:13:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:13:01 INFO - Cleaning up... 14:13:01 INFO - Return code: 0 14:13:01 INFO - Running post-action listener: _resource_record_post_action 14:13:01 INFO - Running post-action listener: _start_resource_monitoring 14:13:01 INFO - Starting resource monitoring. 14:13:01 INFO - ##### 14:13:01 INFO - ##### Finished create-virtualenv step (success) 14:13:01 INFO - ##### 14:13:01 INFO - ##### 14:13:01 INFO - ##### Running install step. 14:13:01 INFO - ##### 14:13:01 INFO - Running pre-action listener: _resource_record_pre_action 14:13:01 INFO - Running main action method: install 14:13:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:13:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:13:01 INFO - Reading from file tmpfile_stdout 14:13:01 INFO - Detecting whether we're running mozinstall >=1.0... 14:13:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:13:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:13:02 INFO - Reading from file tmpfile_stdout 14:13:02 INFO - Output received: 14:13:02 INFO - Usage: mozinstall [options] installer 14:13:02 INFO - Options: 14:13:02 INFO - -h, --help show this help message and exit 14:13:02 INFO - -d DEST, --destination=DEST 14:13:02 INFO - Directory to install application into. [default: 14:13:02 INFO - "/builds/slave/test"] 14:13:02 INFO - --app=APP Application being installed. [default: firefox] 14:13:02 INFO - mkdir: /builds/slave/test/build/application 14:13:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:13:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:13:19 INFO - Reading from file tmpfile_stdout 14:13:19 INFO - Output received: 14:13:19 INFO - /builds/slave/test/build/application/firefox/firefox 14:13:19 INFO - Running post-action listener: _resource_record_post_action 14:13:19 INFO - ##### 14:13:19 INFO - ##### Finished install step (success) 14:13:19 INFO - ##### 14:13:19 INFO - ##### 14:13:19 INFO - ##### Running run-tests step. 14:13:19 INFO - ##### 14:13:19 INFO - Running pre-action listener: _resource_record_pre_action 14:13:19 INFO - Running main action method: run_tests 14:13:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:13:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:13:19 INFO - Python 2.7.3 14:13:19 INFO - Return code: 0 14:13:19 INFO - grabbing minidump binary from tooltool 14:13:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:13:19 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 0x1c7a1c0>, '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 0x1c7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c7b550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:13:19 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 14:13:19 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 14:13:19 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 14:13:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:13:19 INFO - Return code: 0 14:13:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:13:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:13:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:13:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:13:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:13:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:13:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:13:20 INFO - Return code: 0 14:13:20 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CbVqcauFTcWuPl-FW-CkVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:13:20 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CbVqcauFTcWuPl-FW-CkVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:13:20 INFO - Using env: {'DISPLAY': ':0', 14:13:20 INFO - 'HOME': '/home/cltbld', 14:13:20 INFO - 'LANG': 'en_US.UTF-8', 14:13:20 INFO - 'LANGUAGE': 'en_US:en', 14:13:20 INFO - 'LOGNAME': 'cltbld', 14:13:20 INFO - 'MAIL': '/var/mail/cltbld', 14:13:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:13:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:13:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:20 INFO - 'MOZ_NO_REMOTE': '1', 14:13:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:13:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:13:20 INFO - 'NO_EM_RESTART': '1', 14:13:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:13:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:13:20 INFO - 'PWD': '/builds/slave/test', 14:13:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:13:20 INFO - 'SHELL': '/bin/bash', 14:13:20 INFO - 'SHLVL': '1', 14:13:20 INFO - 'TERM': 'linux', 14:13:20 INFO - 'TMOUT': '86400', 14:13:20 INFO - 'USER': 'cltbld', 14:13:20 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466540867.982696-1936983635', 14:13:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:20 INFO - '_': '/tools/buildbot/bin/python'} 14:13:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CbVqcauFTcWuPl-FW-CkVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:13:20 INFO - mozversion application_buildid: 20160621113020 14:13:20 INFO - mozversion application_changeset: 448ad5bf7e92885c8c73acb0aee5d3e217712f95 14:13:20 INFO - mozversion application_display_name: Nightly 14:13:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:13:20 INFO - mozversion application_name: Firefox 14:13:20 INFO - mozversion application_remotingname: firefox 14:13:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:13:20 INFO - mozversion application_vendor: Mozilla 14:13:20 INFO - mozversion application_version: 50.0a1 14:13:20 INFO - mozversion platform_buildid: 20160621113020 14:13:20 INFO - mozversion platform_changeset: 448ad5bf7e92885c8c73acb0aee5d3e217712f95 14:13:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:13:20 INFO - mozversion platform_version: 50.0a1 14:13:20 INFO - using testdate: 1466543600 14:13:20 INFO - actual date: 1466543600 14:13:20 INFO - starting webserver on 'localhost:38898' 14:13:20 INFO - SUITE-START | Running 2 tests 14:13:20 INFO - TEST-START | dromaeo_css 14:13:20 INFO - operating with platform_type : linux_ 14:13:20 INFO - Initialising browser for dromaeo_css test... 14:13:20 INFO - TEST-INFO | started process 26338 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWmKX24/profile http://localhost:38898/getInfo.html) 14:13:25 INFO - PROCESS | 26338 | __metrics Screen width/height:1600/1200 14:13:25 INFO - PROCESS | 26338 | colorDepth:24 14:13:25 INFO - PROCESS | 26338 | Browser inner width/height: 1024/697 14:13:25 INFO - PROCESS | 26338 | __metrics 14:13:25 ERROR - PROCESS | 26338 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 14:13:26 INFO - TEST-INFO | 26338: exit 0 14:13:26 INFO - Browser initialized. 14:13:26 INFO - Running cycle 1/1 for dromaeo_css test... 14:13:26 INFO - TEST-INFO | started process 26462 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWmKX24/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:13:38 INFO - PROCESS | 26462 | RSS: Main: 184946688 14:13:38 INFO - PROCESS | 26462 | 14:14:28 INFO - PROCESS | 26462 | 1466543668463 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] 14:16:36 INFO - PROCESS | 26462 | Cycle 1(1): loaded http://localhost:38898/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38898/tests/dromaeo/cssquery-ext.html) 14:16:37 INFO - PROCESS | 26462 | RSS: Main: 188792832 14:16:37 INFO - PROCESS | 26462 | 14:19:39 INFO - PROCESS | 26462 | Cycle 1(1): loaded http://localhost:38898/tests/dromaeo/cssquery-ext.html (next: http://localhost:38898/tests/dromaeo/cssquery-jquery.html) 14:19:40 INFO - PROCESS | 26462 | RSS: Main: 187400192 14:19:40 INFO - PROCESS | 26462 | 14:22:42 INFO - PROCESS | 26462 | Cycle 1(1): loaded http://localhost:38898/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38898/tests/dromaeo/cssquery-mootools.html) 14:22:42 INFO - PROCESS | 26462 | RSS: Main: 188444672 14:22:42 INFO - PROCESS | 26462 | 14:25:44 INFO - PROCESS | 26462 | Cycle 1(1): loaded http://localhost:38898/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38898/tests/dromaeo/cssquery-prototype.html) 14:25:45 INFO - PROCESS | 26462 | RSS: Main: 185704448 14:25:45 INFO - PROCESS | 26462 | 14:28:47 INFO - PROCESS | 26462 | Cycle 1(1): loaded http://localhost:38898/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38898/tests/dromaeo/cssquery-yui.html) 14:28:48 INFO - PROCESS | 26462 | RSS: Main: 187969536 14:28:48 INFO - PROCESS | 26462 | 14:31:50 INFO - PROCESS | 26462 | Cycle 1(1): loaded http://localhost:38898/tests/dromaeo/cssquery-yui.html (next: http://localhost:38898/tests/dromaeo/cssquery-dojo.html) 14:31:50 INFO - PROCESS | 26462 | RSS: Main: 188428288 14:31:50 INFO - PROCESS | 26462 | 14:31:50 INFO - PROCESS | 26462 | __start_tp_report 14:31:50 INFO - PROCESS | 26462 | _x_x_mozilla_page_load 14:31:50 INFO - PROCESS | 26462 | _x_x_mozilla_page_load_details 14:31:50 INFO - PROCESS | 26462 | |i|pagename|runs| 14:31:50 INFO - PROCESS | 26462 | |0;dojo.html;3099.287163952291;3138.0428969164395;3147.732442742366;3168.524721291806;3173;5395.379531353896;5421.078416669166;5421.701806400652;5433.212184233284;5501.724913754307;5305.389880163772;5317.654352467087;5368.463153684639;5372.865678358043;5383.138697808351;4809.086273608021;4919.26211068339;4952.579030782388;4983.053219888209;5041.1178043842365;4852.636052296092;5126.589872810185;5128.871778205537;5137;5139.922901156486;4870.634702397334;4922.950770492285;4958.925616115761;5046.470120637336;5051.419086805009;4965.553100220997;4976.303317535548;4976.402831660224;4982.526659967333;5071.442141364447;4946.629002824767;4968.975155124237;4990.351254336949;5014.373203349582;5029.522195391469;5278.181881808326;5330.866728331784;5338.839834804962;5379.542738867201;5423.349198096214;5719.771209151629;5757.798477053325;5775.104858746901;5779.133130030487;5803.448672376117;5635.943640563582;5836.533077353802;5838.591298609099;5851.61964472308;5866.1494083357675;5285.577153827685;5302.893942121174;5324.334458192726;5368.651037682538;5375.973120134413;5782.855428614318;5813.3895940925595;5813.76744930198;5816.12758086282;5824.475797178275;5576.749046292926;5601.047821870292;5606.719664016783;5608.551315894719;5609.382967873531;5618.91571626426;5681.744321505542;5697.401772813878;5700.714964251771;5745.6552606843725;5556.861078473071;5617.578681598897;5661.377248502661;5665.915011274834;5747.770089196469;5543.390227075019;5680.573956953245;5790.276215473066;5795.855103622359;5804.100364443518;4374.540673229329;4413.845515406945;4414.205443020223;4446.82212711488;4462.040661257845;3943.171933893857;3955.3869150281753;3968.0873399117786;3980.0845805464905;4002.3596224603925;5348.786048558014;5384.380796208487;5458.426865179178;5480.643758155787;5503.752331145108;5857.384974577693;5894.469497745224;5894.734736936763;5905.202797622352;5907.438793314628;5539.390667026704;5544.556435485232;5545.944540554624;5547.639403438763;5557.444255574491;4871.318015477765;4931.0630980113665;4969.478204788517;4976.104301225814;5051.621128415383;5899.852503687443;5926.614770039933;5952.077427998667;5963.135345374896;5970.582059255898;5734.139879018181;5737.827865163968;5747.396523365153;5762.855928601651;5766.625169363978;5843.853903652443;5893.6463812171405;5911.527077833849;5960.254968128984;5992.43071908168;5707.8858422832145;5757.5681823864215;5771.422857714195;5773.018586840331;5816.854578635568;5764.827055188351;5768.711564421846;5818.214541036906;5830.4461076197695;5909.349971503218;5512.641678290898;5590.077637189818;5603.3836278008575;5622.044252477007;5731.140328950691;5636.041872881702;5673.347565030074;5680.630759000652;5683.488486036276;5703.800366987136;5576.609637325349;5586.273784408001;5591.664500130005;5610.382857885711;5610.663360198401;5575.553955683455;5587.832365029056;5588.077967135378;5644.576656750843;5686.914696279477;5528.198411230269;5541.16882467617;5558.583106266965;5562.833115006556;5563.13771365439 14:31:50 INFO - PROCESS | 26462 | |1;ext.html;582.5252419278288;620.4044117647059;624.3194917539884;645.6061802300597;652.3574279334857;38483.422748658755;41502.584974150246;41537.58462415375;41955.16089678212;42024.36963445547;41814;42683;42693;42711.14577708444;42771.35842962358;8790.428622139556;8872.423292486;8930.776730581723;8978.955105224464;8999.955000225022;8815.250703690193;8853.291736661084;8883.51140687262;8901;8907.287417006657;8923.107689231058;8961.372703910729;8971.05803890592;8997.100289971017;9013.05362936892;8907.554622268894;8939.508327042011;8949.64201431942;8957.507337096456;8966.641334346617;8761;8777.253933415668;8783.209511144029;8820.029796722356;8824.470531768115;40478.392824107665;40696.79651601723;40787;40817;40850.710675379254;3284.2446237365302;3352;3511.2597992709893;3725.366687663077;3805.5813860475328;31755.04734857958;34240.657593423995;34359.31281374383;34369.14077148066;34548.13629659254;4363.214621368153;4515.552181101612;4535.31970204472;4589.839355622537;4689.268635654181;348216;349602;352399;354657;355717;64620.676896615216;64968.67515662391;65234.67382663056;65287;65368.673156633915;68334.65832670804;68427.65786171037;68615;68803.65598171977;69177.30822691809;17152.571185720455;17411.303547857944;17495.30018799234;17502.21240044201;17537.12314384301;11800.763984720257;11958.521659133537;11970.04239660825;11986.52053917851;12082.57710980129;20071.899640501702;20544.28095016667;20629.381118566467;20665.483362916046;20694.58610827805;7864.960675196702;7966.960165199137;7975.720849770346;8054.516728996279;8101.918980810235;938.9671361502315;950.3062764182048;1052.9947350263199;1080.1574771678104;1096.1121491591837;33233.66766332306;33471.83264083664;33475.33049338999;33604.663953360156;34268.82865585656;1107.778444311141;1134.7957367673898;1137.732632831284;1145.2269717940358;1194.5162209305245;16957.15214239283;17330.913345433193;17331.393401230896;17340.65318693619;17402.039184326117;573804;574632;577120;579921;582324;59125;59706;59865.700671496365;60031;60170;1334.3928512526777;1370.328539015875;1383.8616138386283;1383.9238841863794;1400.7618704820204;31570.842145789124;32217.35565288634;32555.51166732548;32591.34817303593;32613.18467038248;51535.742321288155;51635.741821290656;52051.47948520466;52279.477205227464;52352.21471678004;481646;483880;485075;488284;489979;29194;29236;29598.704012959595;29825.70174298316;30131.849340754034;48464.515354846;48653.2702009463;49189;49426.50573494219;49628;41679.374809377274;41845;42434.787826060674;42446.787766060974;43073;40362;41759.892556023064;41903.79048104862;41957.58042419537;42029;42108.789456052524;42611;42843;43495.78252108719;43658;36107.63892361148;37367.43948840715;37704;38262.2347553053;38275.23449531049;28764.85617571899;29428.411431771674;29478.705212947596;29867;29940.550891736206 14:31:50 INFO - PROCESS | 26462 | |2;jquery.html;381.66032231314136;383.3138681759652;393.3215203773491;397.81943362814303;406.8291317646588;13613.591592252224;15373.23133843309;17950;19469.221231150754;19548.609027819435;15789.28948197331;18244.442333744926;18619.348322808706;18721.812781872177;18727.063646817674;5778.451047150535;5809.506191973687;5915.142304365864;5975.372585878486;5985.850353741148;5735.1970724098655;5799.304083509985;5845.649261044329;5846.941530584703;5863.648181109126;5167.9224811627855;5521.585881058916;5534.335879694442;5603.859903502404;5625.578081643873;5271.367435907678;5535.169724541311;5587.05020146576;5614.326280846284;5625.6905870177125;5241.711705856176;5457.072297709399;5471.261379713727;5474.206240095204;5690.544756419518;12648.367581620882;12771.361431928366;12803.103782735212;12884.677883052906;15651;2122.946926326839;2127.8723276603455;2347.0963678983544;2394.976050239493;2617.9659034681385;9032.819343613091;9200.907990920072;9503.57233924475;9555.23558115349;9869.654562090363;1915.5115445561294;1997.850161237913;2026.3211824038965;2037.8165965063215;2056.598963202176;82010.58994704988;82601.17398825995;83719.5814020926;84334;84538;10993.175511836644;11010.669679909615;11017.559297628006;11206.495707693173;11234.719132021764;15120.924395378173;15132.621684457756;15245.3901843925;15247.23763811805;15257.694846103015;8088.555129467818;8149.796255093552;8277.917220827714;8408.201220884128;8445.619947102272;7883.856840758058;7946.7615971520945;8091.352691784643;8167.060788009455;8277.213664701843;4310.956890431055;4352.347147927836;4410.0738844842945;4475.1049790042125;4660.231061874821;1905.6093500832574;1939.146775418811;1967.4392798052772;1971.9704204436946;1972.6942323939813;936.578539657157;958.2956526952685;966.8888077870994;1003.2575893838507;1036.8859425463193;17271.74092388615;18618.720719189223;19697.803021969597;19801.702974455395;20071.29750458756;1000.1448761309122;1003.2926786615565;1004.8894621591619;1005.2058873489862;1064.6167379743285;10556.683299501028;10970.561177552969;10970.835437468444;11038.834417483744;11114.7218069923;313433;351268;532545;536534;546432;61959.69020154961;81666.18333816585;96608;97377.51311243398;99384.50307748414;972.9951350243203;999.4652860719481;1008.5763979128784;1013.7921726046143;1024.3700124423426;17569.736453953457;17753.822461775217;17865.73201401954;18079.728804067687;18223.908880455514;42560.36159457672;42666.57333426626;43227.78386108175;43687.56312436835;44083;61455;62281;62472.687636561524;63190.10429686933;63688.68155659192;8278.172182781673;8324.6670133194;8325.83348333042;8353.749387518385;8777.824443510966;8154.184581542036;8489.83020339602;8683.435576687496;8824.117588241124;8925.687600933936;7581.962090189734;7621.161672215941;8055.556944368116;8165.550894700611;8421.87367189505;7863.331616812635;8039.758807235792;8144.674213031412;8161.143079976517;8270.214329638675;8011.6394762237005;8113.553754543556;8177.427580069338;8336.166383361615;8506.702265420681;13139.737205256033;13214.27321497327;13336.333183340601;13538.255395952923;13548;12149.514019439124;12337.876621233672;12379.75240495167;12913;13075.869241307846 14:31:50 INFO - PROCESS | 26462 | |3;mootools.html;1401.1312985948712;1444.530527578537;1548.1949386319113;1693.6612677464511;1715.74263860421;7703.768886933387;8343.123971982945;8462.66149354026;9002.684906028291;9053.321000924923;8021.3983951203745;8099.149589293128;8271.586420678972;8324.458910170835;8357;2251.6735073414384;2313.421644588853;2317.397476656073;2321.8955147018423;2326.5579539887367;2175.0755928730305;2228.6434170532716;2317.2468947592015;2317.5249073939885;2332.4985128197436;2259.5706815705043;2293.3693234360517;2299.4021554395895;2306.08909480755;2308.7806658367513;2181.214762685432;2200.3948914048606;2202.1631779923687;2214.1143542582936;2222.344408399526;2180.2042254576963;2208.4920468292385;2222.2333295013195;2227.599032174208;2240.7535171131162;8499.490030598123;8605.311575074042;8621.913780862174;8635.222829945273;8654.524001179932;5068.4424713281505;5173.922391164136;5183.637145399824;5184.766685499161;5202.5172825744485;3058.2048667346426;3126.421612001787;3220.5813244278092;3266.6243382011135;3277.2789986202997;1113.1595645287755;1124.3703526025452;1131.0160160660196;1170.970725731855;1174.1546086817477;12009.759804803854;12353.814692779615;12359.32023738703;12375.876241237562;12377.443015064344;4442.73343599385;4453.532379100213;4545.818167273272;4575.81696732127;4606.976965115153;10404.427756473468;10446.791064178826;10452.425116618659;10469.895301047045;10502.73743156412;5268.789248430096;5275.841724748264;5285.233641122016;5288.312519372457;5296.629235953446;4310.331898555729;4687.789049492781;4772.379590653193;4830.637702172351;4846.975765121152;4028.71798974069;4039.333509970822;4104.384342348611;4147.294959856831;4155.148194620096;1228.8955438787625;1289.8516670582815;1293.8706129386985;1299.2659147581776;1303.0683061610805;858.3004851046377;967.8451447768323;992.1219720547367;1009.3893194617151;1021.6985989133224;6107.603005804608;6227.750889964442;6236.875262494725;6271.529635277372;6298.1812364392335;410.852093246431;411.80439291336376;415.4847988494306;418.4016855896037;420.7538589924867;4323.69734118615;4418.182636212311;4462.263726485158;4464.129494748558;4470.821167153343;10626.415547144827;10950.890491095146;11096.05683516894;11111.499982500807;11122.388268645302;10753.354798712102;10823.512941917475;10905.999999999842;10952.34285942846;10975.451227438596;7832.647530861125;8144.959275203704;8148.511089334659;8223.095459499451;8397.790055248668;6116.143739876332;6365.96817015912;6376.4261216488885;6399.136116624382;6403.391677790602;9927.801443971224;10088.899111008795;10259.384436933808;10306.433146176732;10306.742331441774;9689.563969621244;10050;10077.69766906994;10334.379937203792;10399.844002340122;7558.206388329366;7686.192949740197;7689;7741.806454838674;7885.369170466234;8581.442206256574;8587.957060214909;8589.484630922165;8598.183172598594;8631.56842157902;7427.7771666850085;7515.586642734702;7657;7755.806104847424;7893;7603.581803000888;7626.54240745557;7729.497582657109;7731.304182623591;7821.569813660303;7177.928220717726;7189.317014883578;7229.783106506813;7234.74678386254;7235.819104522429;4889.095517329305;5161.354830646169;5259.55293800016;5399.568034557305;5414.269073675004;5044.167712327425;5186.507281808223;5207.4271830097905;5312.760925758273;5442.510174084351 14:31:50 INFO - PROCESS | 26462 | |4;prototype.html;324.3771957840945;327.28978117485053;330.8560776062414;332.0751706497407;334.56673607678056;5618.269624948756;5692.800751973677;5699.202111704365;5713.400092990233;5732.742026608802;5602.495775380215;5627.296587926509;5628.183913332565;5631.915521267174;5665.660060396379;4212.620864122236;4257.638100761439;4375.4093197418415;4376.2997920332755;4376.665117139271;4383.671224658147;4407.228734971383;4419.867403977886;4420.535843736409;4441.444819397575;4385.2106620808245;4390.121975604876;4400.537943515933;4408.501109622727;4422.690411671184;4263.081613274024;4351.5648435156545;4367.8861890217795;4383.824647014116;4391.407160033386;3820.8346454331418;3837.6929845612285;3839.6753120173494;3861.4787003754413;3872.3029854626157;5421.756020979026;5447.863803404907;5465.289512363367;5480.808171713971;5525.867197224559;4785.487619000018;4929;4970.229614409773;4971.527704868032;5003.2995380646735;5751.654900705971;5788.826335209908;5801.187833703285;5845.7431652194555;5852.67810270435;4242.787860606957;4246.808893599796;4260.297050986584;4279.422277992462;4288.442502474658;5987.25159355085;6022.638641681469;6027.246594175728;6030.216071910623;6040.553575801808;4281.186574550888;4301.956980430218;4332.393464914914;4350.695451318441;4358.65130789536;4419.46966364032;4420.248557745191;4420.80106395213;4435.955640443619;4439.866803995821;4957.959697229942;4983.152864013126;5017.498250174954;5017.573506251936;5024.120778863684;5835.474807267281;5895.616784908967;5913.793017244376;5928.8814223716145;5965.791197308074;1503.8796896248493;1507.6080219143103;1517.0808926707723;1518.460946364047;1523.7638166084275;949.3402085550614;951.0964583645564;974.444566597047;979.3193730357333;1010.1565193063727;5615.939313074385;5664.9803035454015;5685.436504961086;5686.800961966312;5710.71446427677;6006.069059295816;6030.939690603038;6036.3360030396625;6041.640630858022;6051.878962420815;5381.973090134525;5615.9157612635845;5752.194692743019;5759.424057594207;5763.510101641407;3306.768526203191;3309.4043072246745;3319.13702437368;3328.384248913959;3329.5338652588657;6145.385461453819;6381.1066450696935;6392.328805475451;6447.323031081763;6452.064450654629;6148.9692551536955;6266.342034086447;6271.843203919847;6279.937200627935;6290.779822706183;6173.413525715139;6254.906176407358;6257.311695713468;6264.718087686065;6361.2048493938255;6102.38976102404;6106.664133472524;6123.877522449615;6150.261968563801;6153.446189842935;6033.577649564489;6035.366286540026;6057.757689692363;6062.969685151546;6115.480184184395;6105.8168254952425;6289.591176573508;6309.287006587211;6320.905186422116;6336.809895703136;4182.602652747984;4187.581241875788;4233.174530966432;4271.31658934569;4286.721363111388;5830.795922142875;6073.423024812636;6086.421789929949;6125.264968203844;6243.719032643451;5883.823485295448;5888.969430349586;5892.852678682896;5895.528357731457;5934.732937017931;5891.528677705859;5900.5574581907385;5920.970395147997;5945.494632956074;5978.4021597839865;5634.436556344497;5800.172945522147;5849.356570777126;5863.120531920246;5894.557908156819;5976.491998180029;5978.850528736642;5987.13186587951;6021.54838387114;6023.897692688181;5620.269364982526;5879.470847623735;5881.264841894763;5908.497777688945;5926.881462370815 14:31:50 INFO - PROCESS | 26462 | |5;yui.html;660.960342379457;681.7920534237056;691.7820886420777;742.6732237815361;765.2041876448492;13891.513797017107;14378.424863005468;14384.712305753905;14416.855831441682;14481.565553033413;13135.934320328384;14068.22624755638;14074.507392241274;14112.506062287823;14116.929415352935;764.2624867003341;768.2471178245308;776.2819392062348;783.220695408067;793.7777422321759;794.7099308752322;795.3676826922582;795.8249185179251;797.7128233835814;798.0503201190564;833.3250067445358;836.1429534726893;837.6733074101105;839.3075712537151;841.0286119531951;830.3606223208126;831.40969911363;833.1335411172373;834.6869923778584;837.3468694418364;607.7143742441045;609.832296118571;610.6397225636896;611.119987218404;611.1566038866335;14439.422423103064;14449.349779259854;14450.638734031629;14524.201168935704;14529.78205326921;12222.327771972537;12227.266364018187;12326.445309961073;12633.684157896034;12943.417546210443;10968.23222374434;11147.331160130418;11201;11222.66332010041;11671.474783634672;3603.963960360389;3624.9456258156147;3646.872359467406;3673.6510031547227;3755.6995440364976;61392;76949.61525192394;78446;78747.60626196832;79256.20743792603;9549.09283618055;9806.754831129136;9888.851667224997;10108.646197383056;10137.087662110445;19134.330298439487;19171.712424313646;19296.22815087381;19297.903510482356;19306;7745.961270193726;7778.49439786412;7805.921940780633;7814.570198639016;7923.049234091831;4616.538346165356;4695.3426520287185;4740.810367585258;4794.065157294294;4833.275008748716;3231.757618178599;3340.732741380684;3353.6814002669707;3358.8488518016748;3359.177001634615;581.4970050906021;587.9088741245114;595.979140730081;596.9044952807529;608.7808388979963;616.7717944360616;681.7341236917606;695.2630211975322;716.4268585131873;727.5052963984541;9051.773705657279;9370.405753914225;9386.249100072115;9448.669296574586;9712.805743885083;579.2932622200908;581.9854503637358;620.9223847019123;643.2955913274957;702.3819039245432;4329.242382583098;4410.779461026936;4504.106158990107;4577.885552861205;4618;108491;111050;111528;117053;119015.12136888216;101272;102935;103701.48149259205;103868.48065759623;104458.05768192957;56283.672729620215;57510.71244643834;57847.421525785045;58121.70939145277;75798.66214716376;8839;8846.557672116498;8942;8944.731658050268;8975.92212606935;52584;53118.2032269524;53919.46080539301;55229;56734.71632641811;77922.61038694771;78983.08972767113;81410;81756;82117;10481.528331225265;10521.842172367573;10840.566377345134;10916.672499825017;10955.452227388758;11654.883451165719;12333.75332493363;12569.748605028031;12642.178258413174;12960.740785184433;11540.769184616092;11829.70425739329;11887.934759395293;12059.336736479578;12109.212901161396;11667.474963626826;11677.824832627348;11830.763384732429;12230.449629766505;12631.368431578201;11297.71755706114;11552;11793.823092653445;11820.822687659864;11878.643640690792;9694.515274236119;9770.31607787448;9904.356216845881;9943.900560994587;9969.950150249202;9748.463834489172;10151.155602528543;10219.469569823825;10226;10308.793824123626 14:31:50 INFO - PROCESS | 26462 | __end_tp_report 14:31:50 INFO - PROCESS | 26462 | __start_cc_report 14:31:50 INFO - PROCESS | 26462 | _x_x_mozilla_cycle_collect,348 14:31:50 INFO - PROCESS | 26462 | __end_cc_report 14:31:50 INFO - PROCESS | 26462 | __startTimestamp1466544710920__endTimestamp 14:31:50 INFO - PROCESS | 26462 | 14:31:50 INFO - PROCESS | 26462 | ------- Summary: start ------- 14:31:50 INFO - PROCESS | 26462 | Number of tests: 6 14:31:50 INFO - PROCESS | 26462 | 14:31:50 INFO - PROCESS | 26462 | [#0] dojo.html Cycles:165 Average:5366.69 Median:5563.14 stddev:589.87 (10.6%) stddev-sans-first:564.23 14:31:50 INFO - PROCESS | 26462 | Values: 3099.3 3138.0 3147.7 3168.5 3173.0 5395.4 5421.1 5421.7 5433.2 5501.7 5305.4 5317.7 5368.5 5372.9 5383.1 4809.1 4919.3 4952.6 4983.1 5041.1 4852.6 5126.6 5128.9 5137.0 5139.9 4870.6 4923.0 4958.9 5046.5 5051.4 4965.6 4976.3 4976.4 4982.5 5071.4 4946.6 4969.0 4990.4 5014.4 5029.5 5278.2 5330.9 5338.8 5379.5 5423.3 5719.8 5757.8 5775.1 5779.1 5803.4 5635.9 5836.5 5838.6 5851.6 5866.1 5285.6 5302.9 5324.3 5368.7 5376.0 5782.9 5813.4 5813.8 5816.1 5824.5 5576.7 5601.0 5606.7 5608.6 5609.4 5618.9 5681.7 5697.4 5700.7 5745.7 5556.9 5617.6 5661.4 5665.9 5747.8 5543.4 5680.6 5790.3 5795.9 5804.1 4374.5 4413.8 4414.2 4446.8 4462.0 3943.2 3955.4 3968.1 3980.1 4002.4 5348.8 5384.4 5458.4 5480.6 5503.8 5857.4 5894.5 5894.7 5905.2 5907.4 5539.4 5544.6 5545.9 5547.6 5557.4 4871.3 4931.1 4969.5 4976.1 5051.6 5899.9 5926.6 5952.1 5963.1 5970.6 5734.1 5737.8 5747.4 5762.9 5766.6 5843.9 5893.6 5911.5 5960.3 5992.4 5707.9 5757.6 5771.4 5773.0 5816.9 5764.8 5768.7 5818.2 5830.4 5909.3 5512.6 5590.1 5603.4 5622.0 5731.1 5636.0 5673.3 5680.6 5683.5 5703.8 5576.6 5586.3 5591.7 5610.4 5610.7 5575.6 5587.8 5588.1 5644.6 5686.9 5528.2 5541.2 5558.6 5562.8 5563.1 14:31:50 INFO - PROCESS | 26462 | 14:31:50 INFO - PROCESS | 26462 | [#1] ext.html Cycles:180 Average:63598.89 Median:42068.89 stddev:127749.51 (303.7%) stddev-sans-first:128020.27 14:31:50 INFO - PROCESS | 26462 | Values: 582.5 620.4 624.3 645.6 652.4 38483.4 41502.6 41537.6 41955.2 42024.4 41814.0 42683.0 42693.0 42711.1 42771.4 8790.4 8872.4 8930.8 8979.0 9000.0 8815.3 8853.3 8883.5 8901.0 8907.3 8923.1 8961.4 8971.1 8997.1 9013.1 8907.6 8939.5 8949.6 8957.5 8966.6 8761.0 8777.3 8783.2 8820.0 8824.5 40478.4 40696.8 40787.0 40817.0 40850.7 3284.2 3352.0 3511.3 3725.4 3805.6 31755.0 34240.7 34359.3 34369.1 34548.1 4363.2 4515.6 4535.3 4589.8 4689.3 348216.0 349602.0 352399.0 354657.0 355717.0 64620.7 64968.7 65234.7 65287.0 65368.7 68334.7 68427.7 68615.0 68803.7 69177.3 17152.6 17411.3 17495.3 17502.2 17537.1 11800.8 11958.5 11970.0 11986.5 12082.6 20071.9 20544.3 20629.4 20665.5 20694.6 7865.0 7967.0 7975.7 8054.5 8101.9 939.0 950.3 1053.0 1080.2 1096.1 33233.7 33471.8 33475.3 33604.7 34268.8 1107.8 1134.8 1137.7 1145.2 1194.5 16957.2 17330.9 17331.4 17340.7 17402.0 573804.0 574632.0 577120.0 579921.0 582324.0 59125.0 59706.0 59865.7 60031.0 60170.0 1334.4 1370.3 1383.9 1383.9 1400.8 31570.8 32217.4 32555.5 32591.3 32613.2 51535.7 51635.7 52051.5 52279.5 52352.2 481646.0 483880.0 485075.0 488284.0 489979.0 29194.0 29236.0 29598.7 29825.7 30131.8 48464.5 48653.3 49189.0 49426.5 49628.0 41679.4 41845.0 42434.8 42446.8 43073.0 40362.0 41759.9 41903.8 41957.6 42029.0 42108.8 42611.0 42843.0 43495.8 43658.0 36107.6 37367.4 37704.0 38262.2 38275.2 28764.9 29428.4 29478.7 29867.0 29940.6 14:31:50 INFO - PROCESS | 26462 | 14:31:50 INFO - PROCESS | 26462 | [#2] jquery.html Cycles:180 Average:27523.89 Median:4567.67 stddev:77446.01 (1695.5%) stddev-sans-first:77636.45 14:31:50 INFO - PROCESS | 26462 | Values: 381.7 383.3 393.3 397.8 406.8 13613.6 15373.2 17950.0 19469.2 19548.6 15789.3 18244.4 18619.3 18721.8 18727.1 5778.5 5809.5 5915.1 5975.4 5985.9 5735.2 5799.3 5845.6 5846.9 5863.6 5167.9 5521.6 5534.3 5603.9 5625.6 5271.4 5535.2 5587.1 5614.3 5625.7 5241.7 5457.1 5471.3 5474.2 5690.5 12648.4 12771.4 12803.1 12884.7 15651.0 2122.9 2127.9 2347.1 2395.0 2618.0 9032.8 9200.9 9503.6 9555.2 9869.7 1915.5 1997.9 2026.3 2037.8 2056.6 82010.6 82601.2 83719.6 84334.0 84538.0 10993.2 11010.7 11017.6 11206.5 11234.7 15120.9 15132.6 15245.4 15247.2 15257.7 8088.6 8149.8 8277.9 8408.2 8445.6 7883.9 7946.8 8091.4 8167.1 8277.2 4311.0 4352.3 4410.1 4475.1 4660.2 1905.6 1939.1 1967.4 1972.0 1972.7 936.6 958.3 966.9 1003.3 1036.9 17271.7 18618.7 19697.8 19801.7 20071.3 1000.1 1003.3 1004.9 1005.2 1064.6 10556.7 10970.6 10970.8 11038.8 11114.7 313433.0 351268.0 532545.0 536534.0 546432.0 61959.7 81666.2 96608.0 97377.5 99384.5 973.0 999.5 1008.6 1013.8 1024.4 17569.7 17753.8 17865.7 18079.7 18223.9 42560.4 42666.6 43227.8 43687.6 44083.0 61455.0 62281.0 62472.7 63190.1 63688.7 8278.2 8324.7 8325.8 8353.7 8777.8 8154.2 8489.8 8683.4 8824.1 8925.7 7582.0 7621.2 8055.6 8165.6 8421.9 7863.3 8039.8 8144.7 8161.1 8270.2 8011.6 8113.6 8177.4 8336.2 8506.7 13139.7 13214.3 13336.3 13538.3 13548.0 12149.5 12337.9 12379.8 12913.0 13075.9 14:31:50 INFO - PROCESS | 26462 | 14:31:50 INFO - PROCESS | 26462 | [#3] mootools.html Cycles:180 Average:5786.69 Median:4463.20 stddev:3314.78 (74.3%) stddev-sans-first:3307.69 14:31:50 INFO - PROCESS | 26462 | Values: 1401.1 1444.5 1548.2 1693.7 1715.7 7703.8 8343.1 8462.7 9002.7 9053.3 8021.4 8099.1 8271.6 8324.5 8357.0 2251.7 2313.4 2317.4 2321.9 2326.6 2175.1 2228.6 2317.2 2317.5 2332.5 2259.6 2293.4 2299.4 2306.1 2308.8 2181.2 2200.4 2202.2 2214.1 2222.3 2180.2 2208.5 2222.2 2227.6 2240.8 8499.5 8605.3 8621.9 8635.2 8654.5 5068.4 5173.9 5183.6 5184.8 5202.5 3058.2 3126.4 3220.6 3266.6 3277.3 1113.2 1124.4 1131.0 1171.0 1174.2 12009.8 12353.8 12359.3 12375.9 12377.4 4442.7 4453.5 4545.8 4575.8 4607.0 10404.4 10446.8 10452.4 10469.9 10502.7 5268.8 5275.8 5285.2 5288.3 5296.6 4310.3 4687.8 4772.4 4830.6 4847.0 4028.7 4039.3 4104.4 4147.3 4155.1 1228.9 1289.9 1293.9 1299.3 1303.1 858.3 967.8 992.1 1009.4 1021.7 6107.6 6227.8 6236.9 6271.5 6298.2 410.9 411.8 415.5 418.4 420.8 4323.7 4418.2 4462.3 4464.1 4470.8 10626.4 10950.9 11096.1 11111.5 11122.4 10753.4 10823.5 10906.0 10952.3 10975.5 7832.6 8145.0 8148.5 8223.1 8397.8 6116.1 6366.0 6376.4 6399.1 6403.4 9927.8 10088.9 10259.4 10306.4 10306.7 9689.6 10050.0 10077.7 10334.4 10399.8 7558.2 7686.2 7689.0 7741.8 7885.4 8581.4 8588.0 8589.5 8598.2 8631.6 7427.8 7515.6 7657.0 7755.8 7893.0 7603.6 7626.5 7729.5 7731.3 7821.6 7177.9 7189.3 7229.8 7234.7 7235.8 4889.1 5161.4 5259.6 5399.6 5414.3 5044.2 5186.5 5207.4 5312.8 5442.5 14:31:50 INFO - PROCESS | 26462 | 14:31:50 INFO - PROCESS | 26462 | [#4] prototype.html Cycles:180 Average:4984.01 Median:5696.00 stddev:1473.48 (25.9%) stddev-sans-first:1435.50 14:31:50 INFO - PROCESS | 26462 | Values: 324.4 327.3 330.9 332.1 334.6 5618.3 5692.8 5699.2 5713.4 5732.7 5602.5 5627.3 5628.2 5631.9 5665.7 4212.6 4257.6 4375.4 4376.3 4376.7 4383.7 4407.2 4419.9 4420.5 4441.4 4385.2 4390.1 4400.5 4408.5 4422.7 4263.1 4351.6 4367.9 4383.8 4391.4 3820.8 3837.7 3839.7 3861.5 3872.3 5421.8 5447.9 5465.3 5480.8 5525.9 4785.5 4929.0 4970.2 4971.5 5003.3 5751.7 5788.8 5801.2 5845.7 5852.7 4242.8 4246.8 4260.3 4279.4 4288.4 5987.3 6022.6 6027.2 6030.2 6040.6 4281.2 4302.0 4332.4 4350.7 4358.7 4419.5 4420.2 4420.8 4436.0 4439.9 4958.0 4983.2 5017.5 5017.6 5024.1 5835.5 5895.6 5913.8 5928.9 5965.8 1503.9 1507.6 1517.1 1518.5 1523.8 949.3 951.1 974.4 979.3 1010.2 5615.9 5665.0 5685.4 5686.8 5710.7 6006.1 6030.9 6036.3 6041.6 6051.9 5382.0 5615.9 5752.2 5759.4 5763.5 3306.8 3309.4 3319.1 3328.4 3329.5 6145.4 6381.1 6392.3 6447.3 6452.1 6149.0 6266.3 6271.8 6279.9 6290.8 6173.4 6254.9 6257.3 6264.7 6361.2 6102.4 6106.7 6123.9 6150.3 6153.4 6033.6 6035.4 6057.8 6063.0 6115.5 6105.8 6289.6 6309.3 6320.9 6336.8 4182.6 4187.6 4233.2 4271.3 4286.7 5830.8 6073.4 6086.4 6125.3 6243.7 5883.8 5889.0 5892.9 5895.5 5934.7 5891.5 5900.6 5921.0 5945.5 5978.4 5634.4 5800.2 5849.4 5863.1 5894.6 5976.5 5978.9 5987.1 6021.5 6023.9 5620.3 5879.5 5881.3 5908.5 5926.9 14:31:50 INFO - PROCESS | 26462 | 14:31:50 INFO - PROCESS | 26462 | [#5] yui.html Cycles:180 Average:19738.02 Median:28708.64 stddev:29401.81 (102.4%) stddev-sans-first:29449.40 14:31:50 INFO - PROCESS | 26462 | Values: 661.0 681.8 691.8 742.7 765.2 13891.5 14378.4 14384.7 14416.9 14481.6 13135.9 14068.2 14074.5 14112.5 14116.9 764.3 768.2 776.3 783.2 793.8 794.7 795.4 795.8 797.7 798.1 833.3 836.1 837.7 839.3 841.0 830.4 831.4 833.1 834.7 837.3 607.7 609.8 610.6 611.1 611.2 14439.4 14449.3 14450.6 14524.2 14529.8 12222.3 12227.3 12326.4 12633.7 12943.4 10968.2 11147.3 11201.0 11222.7 11671.5 3604.0 3624.9 3646.9 3673.7 3755.7 61392.0 76949.6 78446.0 78747.6 79256.2 9549.1 9806.8 9888.9 10108.6 10137.1 19134.3 19171.7 19296.2 19297.9 19306.0 7746.0 7778.5 7805.9 7814.6 7923.0 4616.5 4695.3 4740.8 4794.1 4833.3 3231.8 3340.7 3353.7 3358.8 3359.2 581.5 587.9 596.0 596.9 608.8 616.8 681.7 695.3 716.4 727.5 9051.8 9370.4 9386.2 9448.7 9712.8 579.3 582.0 620.9 643.3 702.4 4329.2 4410.8 4504.1 4577.9 4618.0 108491.0 111050.0 111528.0 117053.0 119015.1 101272.0 102935.0 103701.5 103868.5 104458.1 56283.7 57510.7 57847.4 58121.7 75798.7 8839.0 8846.6 8942.0 8944.7 8975.9 52584.0 53118.2 53919.5 55229.0 56734.7 77922.6 78983.1 81410.0 81756.0 82117.0 10481.5 10521.8 10840.6 10916.7 10955.5 11654.9 12333.8 12569.7 12642.2 12960.7 11540.8 11829.7 11887.9 12059.3 12109.2 11667.5 11677.8 11830.8 12230.4 12631.4 11297.7 11552.0 11793.8 11820.8 11878.6 9694.5 9770.3 9904.4 9943.9 9970.0 9748.5 10151.2 10219.5 10226.0 10308.8 14:31:50 INFO - PROCESS | 26462 | -------- Summary: end -------- 14:31:50 INFO - PROCESS | 26462 | 14:31:51 INFO - TEST-INFO | 26462: exit 0 14:31:51 INFO - TEST-OK | dromaeo_css | took 1111424ms 14:31:51 INFO - TEST-START | kraken 14:31:51 INFO - operating with platform_type : linux_ 14:31:51 INFO - Initialising browser for kraken test... 14:31:51 INFO - TEST-INFO | started process 26700 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMyDdM5/profile http://localhost:38898/getInfo.html) 14:31:56 INFO - PROCESS | 26700 | __metrics Screen width/height:1600/1200 14:31:56 INFO - PROCESS | 26700 | colorDepth:24 14:31:56 INFO - PROCESS | 26700 | Browser inner width/height: 1024/697 14:31:56 INFO - PROCESS | 26700 | __metrics 14:31:57 ERROR - PROCESS | 26700 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 14:31:58 INFO - TEST-INFO | 26700: exit 0 14:31:58 INFO - Browser initialized. 14:31:58 INFO - Running cycle 1/1 for kraken test... 14:31:58 INFO - TEST-INFO | started process 26824 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMyDdM5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:32:10 INFO - PROCESS | 26824 | RSS: Main: 185008128 14:32:10 INFO - PROCESS | 26824 | 14:32:12 INFO - PROCESS | 26824 | Cycle 1(1): loaded http://localhost:38898/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38898/tests/kraken/driver.html?testName=audio-beat-detection) 14:32:13 INFO - PROCESS | 26824 | RSS: Main: 191197184 14:32:13 INFO - PROCESS | 26824 | 14:32:16 INFO - PROCESS | 26824 | Cycle 1(1): loaded http://localhost:38898/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38898/tests/kraken/driver.html?testName=audio-dft) 14:32:16 INFO - PROCESS | 26824 | RSS: Main: 190701568 14:32:16 INFO - PROCESS | 26824 | 14:32:19 INFO - PROCESS | 26824 | Cycle 1(1): loaded http://localhost:38898/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38898/tests/kraken/driver.html?testName=audio-fft) 14:32:20 INFO - PROCESS | 26824 | RSS: Main: 185622528 14:32:20 INFO - PROCESS | 26824 | 14:32:22 INFO - PROCESS | 26824 | Cycle 1(1): loaded http://localhost:38898/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38898/tests/kraken/driver.html?testName=audio-oscillator) 14:32:23 INFO - PROCESS | 26824 | RSS: Main: 186511360 14:32:23 INFO - PROCESS | 26824 | 14:32:25 INFO - PROCESS | 26824 | Cycle 1(1): loaded http://localhost:38898/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38898/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:32:25 INFO - PROCESS | 26824 | RSS: Main: 186785792 14:32:25 INFO - PROCESS | 26824 | 14:32:28 INFO - PROCESS | 26824 | Cycle 1(1): loaded http://localhost:38898/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38898/tests/kraken/driver.html?testName=imaging-darkroom) 14:32:29 INFO - PROCESS | 26824 | RSS: Main: 187084800 14:32:29 INFO - PROCESS | 26824 | 14:32:33 INFO - PROCESS | 26824 | Cycle 1(1): loaded http://localhost:38898/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38898/tests/kraken/driver.html?testName=imaging-desaturate) 14:32:33 INFO - PROCESS | 26824 | RSS: Main: 184233984 14:32:33 INFO - PROCESS | 26824 | 14:32:36 INFO - PROCESS | 26824 | Cycle 1(1): loaded http://localhost:38898/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38898/tests/kraken/driver.html?testName=json-parse-financial) 14:32:37 INFO - PROCESS | 26824 | RSS: Main: 185876480 14:32:37 INFO - PROCESS | 26824 | 14:32:38 INFO - PROCESS | 26824 | Cycle 1(1): loaded http://localhost:38898/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38898/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:32:39 INFO - PROCESS | 26824 | RSS: Main: 186101760 14:32:39 INFO - PROCESS | 26824 | 14:32:41 INFO - PROCESS | 26824 | Cycle 1(1): loaded http://localhost:38898/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38898/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:32:41 INFO - PROCESS | 26824 | RSS: Main: 186499072 14:32:41 INFO - PROCESS | 26824 | 14:32:43 INFO - PROCESS | 26824 | Cycle 1(1): loaded http://localhost:38898/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38898/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:32:44 INFO - PROCESS | 26824 | RSS: Main: 187121664 14:32:44 INFO - PROCESS | 26824 | 14:32:47 INFO - PROCESS | 26824 | Cycle 1(1): loaded http://localhost:38898/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38898/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:32:47 INFO - PROCESS | 26824 | RSS: Main: 186814464 14:32:47 INFO - PROCESS | 26824 | 14:32:50 INFO - PROCESS | 26824 | Cycle 1(1): loaded http://localhost:38898/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38898/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:32:51 INFO - PROCESS | 26824 | RSS: Main: 186925056 14:32:51 INFO - PROCESS | 26824 | 14:32:52 INFO - PROCESS | 26824 | Cycle 1(1): loaded http://localhost:38898/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38898/tests/kraken/driver.html?testName=ai-astar) 14:32:53 INFO - PROCESS | 26824 | RSS: Main: 187789312 14:32:53 INFO - PROCESS | 26824 | 14:32:53 INFO - PROCESS | 26824 | __start_tp_report 14:32:53 INFO - PROCESS | 26824 | _x_x_mozilla_page_load 14:32:53 INFO - PROCESS | 26824 | _x_x_mozilla_page_load_details 14:32:53 INFO - PROCESS | 26824 | |i|pagename|runs| 14:32:53 INFO - PROCESS | 26824 | |0;ai-astar;114;106;112;111;112;111;110;110;111;110 14:32:53 INFO - PROCESS | 26824 | |1;audio-beat-detection;152;129;159;184;140;151;156;128;178;127 14:32:53 INFO - PROCESS | 26824 | |2;audio-dft;163;162;164;162;164;175;161;164;165;162 14:32:53 INFO - PROCESS | 26824 | |3;audio-fft;74;76;76;170;76;75;75;75;168;74 14:32:53 INFO - PROCESS | 26824 | |4;audio-oscillator;86;85;149;85;85;86;147;83;90;145 14:32:53 INFO - PROCESS | 26824 | |5;imaging-gaussian-blur;118;118;118;118;118;118;117;117;118;118 14:32:53 INFO - PROCESS | 26824 | |6;imaging-darkroom;149;149;147;148;154;148;148;147;148;148 14:32:53 INFO - PROCESS | 26824 | |7;imaging-desaturate;97;96;96;96;95;95;96;96;97;96 14:32:53 INFO - PROCESS | 26824 | |8;json-parse-financial;54;55;57;54;53;53;54;56;53;57 14:32:53 INFO - PROCESS | 26824 | |9;json-stringify-tinderbox;60;60;60;60;61;69;60;59;60;60 14:32:53 INFO - PROCESS | 26824 | |10;stanford-crypto-aes;81;81;81;79;88;80;81;80;102;80 14:32:53 INFO - PROCESS | 26824 | |11;stanford-crypto-ccm;132;122;140;121;132;125;122;136;128;125 14:32:53 INFO - PROCESS | 26824 | |12;stanford-crypto-pbkdf2;164;162;167;162;165;159;164;162;161;163 14:32:53 INFO - PROCESS | 26824 | |13;stanford-crypto-sha256-iterative;65;66;65;66;69;64;64;63;63;63 14:32:53 INFO - PROCESS | 26824 | __end_tp_report 14:32:53 INFO - PROCESS | 26824 | __start_cc_report 14:32:53 INFO - PROCESS | 26824 | _x_x_mozilla_cycle_collect,893 14:32:53 INFO - PROCESS | 26824 | __end_cc_report 14:32:53 INFO - PROCESS | 26824 | __startTimestamp1466544773086__endTimestamp 14:32:53 INFO - PROCESS | 26824 | 14:32:53 INFO - PROCESS | 26824 | ------- Summary: start ------- 14:32:53 INFO - PROCESS | 26824 | Number of tests: 14 14:32:53 INFO - PROCESS | 26824 | 14:32:53 INFO - PROCESS | 26824 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:2.06 (1.9%) stddev-sans-first:1.80 14:32:53 INFO - PROCESS | 26824 | Values: 114.0 106.0 112.0 111.0 112.0 111.0 110.0 110.0 111.0 110.0 14:32:53 INFO - PROCESS | 26824 | 14:32:53 INFO - PROCESS | 26824 | [#1] audio-beat-detection Cycles:10 Average:150.40 Median:154.00 stddev:20.04 (13.0%) stddev-sans-first:21.25 14:32:53 INFO - PROCESS | 26824 | Values: 152.0 129.0 159.0 184.0 140.0 151.0 156.0 128.0 178.0 127.0 14:32:53 INFO - PROCESS | 26824 | 14:32:53 INFO - PROCESS | 26824 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:3.99 (2.4%) stddev-sans-first:4.21 14:32:53 INFO - PROCESS | 26824 | Values: 163.0 162.0 164.0 162.0 164.0 175.0 161.0 164.0 165.0 162.0 14:32:53 INFO - PROCESS | 26824 | 14:32:53 INFO - PROCESS | 26824 | [#3] audio-fft Cycles:10 Average:93.90 Median:75.00 stddev:39.59 (52.8%) stddev-sans-first:41.33 14:32:53 INFO - PROCESS | 26824 | Values: 74.0 76.0 76.0 170.0 76.0 75.0 75.0 75.0 168.0 74.0 14:32:53 INFO - PROCESS | 26824 | 14:32:53 INFO - PROCESS | 26824 | [#4] audio-oscillator Cycles:10 Average:104.10 Median:85.00 stddev:29.67 (34.9%) stddev-sans-first:30.74 14:32:53 INFO - PROCESS | 26824 | Values: 86.0 85.0 149.0 85.0 85.0 86.0 147.0 83.0 90.0 145.0 14:32:53 INFO - PROCESS | 26824 | 14:32:53 INFO - PROCESS | 26824 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 14:32:53 INFO - PROCESS | 26824 | Values: 118.0 118.0 118.0 118.0 118.0 118.0 117.0 117.0 118.0 118.0 14:32:53 INFO - PROCESS | 26824 | 14:32:53 INFO - PROCESS | 26824 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:148.00 stddev:2.01 (1.4%) stddev-sans-first:2.13 14:32:53 INFO - PROCESS | 26824 | Values: 149.0 149.0 147.0 148.0 154.0 148.0 148.0 147.0 148.0 148.0 14:32:53 INFO - PROCESS | 26824 | 14:32:53 INFO - PROCESS | 26824 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 14:32:53 INFO - PROCESS | 26824 | Values: 97.0 96.0 96.0 96.0 95.0 95.0 96.0 96.0 97.0 96.0 14:32:53 INFO - PROCESS | 26824 | 14:32:53 INFO - PROCESS | 26824 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:54.50 stddev:1.58 (2.9%) stddev-sans-first:1.66 14:32:53 INFO - PROCESS | 26824 | Values: 54.0 55.0 57.0 54.0 53.0 53.0 54.0 56.0 53.0 57.0 14:32:53 INFO - PROCESS | 26824 | 14:32:53 INFO - PROCESS | 26824 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:60.00 stddev:2.88 (4.8%) stddev-sans-first:3.04 14:32:53 INFO - PROCESS | 26824 | Values: 60.0 60.0 60.0 60.0 61.0 69.0 60.0 59.0 60.0 60.0 14:32:53 INFO - PROCESS | 26824 | 14:32:53 INFO - PROCESS | 26824 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:81.00 stddev:7.02 (8.7%) stddev-sans-first:7.40 14:32:53 INFO - PROCESS | 26824 | Values: 81.0 81.0 81.0 79.0 88.0 80.0 81.0 80.0 102.0 80.0 14:32:53 INFO - PROCESS | 26824 | 14:32:53 INFO - PROCESS | 26824 | [#11] stanford-crypto-ccm Cycles:10 Average:128.30 Median:130.00 stddev:6.48 (5.0%) stddev-sans-first:6.74 14:32:53 INFO - PROCESS | 26824 | Values: 132.0 122.0 140.0 121.0 132.0 125.0 122.0 136.0 128.0 125.0 14:32:53 INFO - PROCESS | 26824 | 14:32:53 INFO - PROCESS | 26824 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.90 Median:163.50 stddev:2.23 (1.4%) stddev-sans-first:2.33 14:32:53 INFO - PROCESS | 26824 | Values: 164.0 162.0 167.0 162.0 165.0 159.0 164.0 162.0 161.0 163.0 14:32:53 INFO - PROCESS | 26824 | 14:32:53 INFO - PROCESS | 26824 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:65.00 stddev:1.87 (2.9%) stddev-sans-first:1.99 14:32:53 INFO - PROCESS | 26824 | Values: 65.0 66.0 65.0 66.0 69.0 64.0 64.0 63.0 63.0 63.0 14:32:53 INFO - PROCESS | 26824 | -------- Summary: end -------- 14:32:53 INFO - PROCESS | 26824 | 14:32:54 INFO - TEST-INFO | 26824: exit 0 14:32:54 INFO - TEST-OK | kraken | took 62374ms 14:32:54 INFO - SUITE-END | took 1173s 14:32:54 INFO - Completed test suite (00:19:33) 14:32:54 INFO - javascript benchmark 14:32:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7196.7735552791755, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3099.287163952291, 3138.0428969164395, 3147.732442742366, 3168.524721291806, 3173.0, 5395.379531353896, 5421.078416669166, 5421.701806400652, 5433.212184233284, 5501.724913754307, 5305.389880163772, 5317.654352467087, 5368.463153684639, 5372.865678358043, 5383.138697808351, 4809.086273608021, 4919.26211068339, 4952.579030782388, 4983.053219888209, 5041.1178043842365, 4852.636052296092, 5126.589872810185, 5128.871778205537, 5137.0, 5139.922901156486, 4870.634702397334, 4922.950770492285, 4958.925616115761, 5046.470120637336, 5051.419086805009, 4965.553100220997, 4976.303317535548, 4976.402831660224, 4982.526659967333, 5071.442141364447, 4946.629002824767, 4968.975155124237, 4990.351254336949, 5014.373203349582, 5029.522195391469, 5278.181881808326, 5330.866728331784, 5338.839834804962, 5379.542738867201, 5423.349198096214, 5719.771209151629, 5757.798477053325, 5775.104858746901, 5779.133130030487, 5803.448672376117, 5635.943640563582, 5836.533077353802, 5838.591298609099, 5851.61964472308, 5866.1494083357675, 5285.577153827685, 5302.893942121174, 5324.334458192726, 5368.651037682538, 5375.973120134413, 5782.855428614318, 5813.3895940925595, 5813.76744930198, 5816.12758086282, 5824.475797178275, 5576.749046292926, 5601.047821870292, 5606.719664016783, 5608.551315894719, 5609.382967873531, 5618.91571626426, 5681.744321505542, 5697.401772813878, 5700.714964251771, 5745.6552606843725, 5556.861078473071, 5617.578681598897, 5661.377248502661, 5665.915011274834, 5747.770089196469, 5543.390227075019, 5680.573956953245, 5790.276215473066, 5795.855103622359, 5804.100364443518, 4374.540673229329, 4413.845515406945, 4414.205443020223, 4446.82212711488, 4462.040661257845, 3943.171933893857, 3955.3869150281753, 3968.0873399117786, 3980.0845805464905, 4002.3596224603925, 5348.786048558014, 5384.380796208487, 5458.426865179178, 5480.643758155787, 5503.752331145108, 5857.384974577693, 5894.469497745224, 5894.734736936763, 5905.202797622352, 5907.438793314628, 5539.390667026704, 5544.556435485232, 5545.944540554624, 5547.639403438763, 5557.444255574491, 4871.318015477765, 4931.0630980113665, 4969.478204788517, 4976.104301225814, 5051.621128415383, 5899.852503687443, 5926.614770039933, 5952.077427998667, 5963.135345374896, 5970.582059255898, 5734.139879018181, 5737.827865163968, 5747.396523365153, 5762.855928601651, 5766.625169363978, 5843.853903652443, 5893.6463812171405, 5911.527077833849, 5960.254968128984, 5992.43071908168, 5707.8858422832145, 5757.5681823864215, 5771.422857714195, 5773.018586840331, 5816.854578635568, 5764.827055188351, 5768.711564421846, 5818.214541036906, 5830.4461076197695, 5909.349971503218, 5512.641678290898, 5590.077637189818, 5603.3836278008575, 5622.044252477007, 5731.140328950691, 5636.041872881702, 5673.347565030074, 5680.630759000652, 5683.488486036276, 5703.800366987136, 5576.609637325349, 5586.273784408001, 5591.664500130005, 5610.382857885711, 5610.663360198401, 5575.553955683455, 5587.832365029056, 5588.077967135378, 5644.576656750843, 5686.914696279477, 5528.198411230269, 5541.16882467617, 5558.583106266965, 5562.833115006556, 5563.13771365439], "value": 5327.922178279577, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.5252419278288, 620.4044117647059, 624.3194917539884, 645.6061802300597, 652.3574279334857, 38483.422748658755, 41502.584974150246, 41537.58462415375, 41955.16089678212, 42024.36963445547, 41814.0, 42683.0, 42693.0, 42711.14577708444, 42771.35842962358, 8790.428622139556, 8872.423292486, 8930.776730581723, 8978.955105224464, 8999.955000225022, 8815.250703690193, 8853.291736661084, 8883.51140687262, 8901.0, 8907.287417006657, 8923.107689231058, 8961.372703910729, 8971.05803890592, 8997.100289971017, 9013.05362936892, 8907.554622268894, 8939.508327042011, 8949.64201431942, 8957.507337096456, 8966.641334346617, 8761.0, 8777.253933415668, 8783.209511144029, 8820.029796722356, 8824.470531768115, 40478.392824107665, 40696.79651601723, 40787.0, 40817.0, 40850.710675379254, 3284.2446237365302, 3352.0, 3511.2597992709893, 3725.366687663077, 3805.5813860475328, 31755.04734857958, 34240.657593423995, 34359.31281374383, 34369.14077148066, 34548.13629659254, 4363.214621368153, 4515.552181101612, 4535.31970204472, 4589.839355622537, 4689.268635654181, 348216.0, 349602.0, 352399.0, 354657.0, 355717.0, 64620.676896615216, 64968.67515662391, 65234.67382663056, 65287.0, 65368.673156633915, 68334.65832670804, 68427.65786171037, 68615.0, 68803.65598171977, 69177.30822691809, 17152.571185720455, 17411.303547857944, 17495.30018799234, 17502.21240044201, 17537.12314384301, 11800.763984720257, 11958.521659133537, 11970.04239660825, 11986.52053917851, 12082.57710980129, 20071.899640501702, 20544.28095016667, 20629.381118566467, 20665.483362916046, 20694.58610827805, 7864.960675196702, 7966.960165199137, 7975.720849770346, 8054.516728996279, 8101.918980810235, 938.9671361502315, 950.3062764182048, 1052.9947350263199, 1080.1574771678104, 1096.1121491591837, 33233.66766332306, 33471.83264083664, 33475.33049338999, 33604.663953360156, 34268.82865585656, 1107.778444311141, 1134.7957367673898, 1137.732632831284, 1145.2269717940358, 1194.5162209305245, 16957.15214239283, 17330.913345433193, 17331.393401230896, 17340.65318693619, 17402.039184326117, 573804.0, 574632.0, 577120.0, 579921.0, 582324.0, 59125.0, 59706.0, 59865.700671496365, 60031.0, 60170.0, 1334.3928512526777, 1370.328539015875, 1383.8616138386283, 1383.9238841863794, 1400.7618704820204, 31570.842145789124, 32217.35565288634, 32555.51166732548, 32591.34817303593, 32613.18467038248, 51535.742321288155, 51635.741821290656, 52051.47948520466, 52279.477205227464, 52352.21471678004, 481646.0, 483880.0, 485075.0, 488284.0, 489979.0, 29194.0, 29236.0, 29598.704012959595, 29825.70174298316, 30131.849340754034, 48464.515354846, 48653.2702009463, 49189.0, 49426.50573494219, 49628.0, 41679.374809377274, 41845.0, 42434.787826060674, 42446.787766060974, 43073.0, 40362.0, 41759.892556023064, 41903.79048104862, 41957.58042419537, 42029.0, 42108.789456052524, 42611.0, 42843.0, 43495.78252108719, 43658.0, 36107.63892361148, 37367.43948840715, 37704.0, 38262.2347553053, 38275.23449531049, 28764.85617571899, 29428.411431771674, 29478.705212947596, 29867.0, 29940.550891736206], "value": 20690.410182209107, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.66032231314136, 383.3138681759652, 393.3215203773491, 397.81943362814303, 406.8291317646588, 13613.591592252224, 15373.23133843309, 17950.0, 19469.221231150754, 19548.609027819435, 15789.28948197331, 18244.442333744926, 18619.348322808706, 18721.812781872177, 18727.063646817674, 5778.451047150535, 5809.506191973687, 5915.142304365864, 5975.372585878486, 5985.850353741148, 5735.1970724098655, 5799.304083509985, 5845.649261044329, 5846.941530584703, 5863.648181109126, 5167.9224811627855, 5521.585881058916, 5534.335879694442, 5603.859903502404, 5625.578081643873, 5271.367435907678, 5535.169724541311, 5587.05020146576, 5614.326280846284, 5625.6905870177125, 5241.711705856176, 5457.072297709399, 5471.261379713727, 5474.206240095204, 5690.544756419518, 12648.367581620882, 12771.361431928366, 12803.103782735212, 12884.677883052906, 15651.0, 2122.946926326839, 2127.8723276603455, 2347.0963678983544, 2394.976050239493, 2617.9659034681385, 9032.819343613091, 9200.907990920072, 9503.57233924475, 9555.23558115349, 9869.654562090363, 1915.5115445561294, 1997.850161237913, 2026.3211824038965, 2037.8165965063215, 2056.598963202176, 82010.58994704988, 82601.17398825995, 83719.5814020926, 84334.0, 84538.0, 10993.175511836644, 11010.669679909615, 11017.559297628006, 11206.495707693173, 11234.719132021764, 15120.924395378173, 15132.621684457756, 15245.3901843925, 15247.23763811805, 15257.694846103015, 8088.555129467818, 8149.796255093552, 8277.917220827714, 8408.201220884128, 8445.619947102272, 7883.856840758058, 7946.7615971520945, 8091.352691784643, 8167.060788009455, 8277.213664701843, 4310.956890431055, 4352.347147927836, 4410.0738844842945, 4475.1049790042125, 4660.231061874821, 1905.6093500832574, 1939.146775418811, 1967.4392798052772, 1971.9704204436946, 1972.6942323939813, 936.578539657157, 958.2956526952685, 966.8888077870994, 1003.2575893838507, 1036.8859425463193, 17271.74092388615, 18618.720719189223, 19697.803021969597, 19801.702974455395, 20071.29750458756, 1000.1448761309122, 1003.2926786615565, 1004.8894621591619, 1005.2058873489862, 1064.6167379743285, 10556.683299501028, 10970.561177552969, 10970.835437468444, 11038.834417483744, 11114.7218069923, 313433.0, 351268.0, 532545.0, 536534.0, 546432.0, 61959.69020154961, 81666.18333816585, 96608.0, 97377.51311243398, 99384.50307748414, 972.9951350243203, 999.4652860719481, 1008.5763979128784, 1013.7921726046143, 1024.3700124423426, 17569.736453953457, 17753.822461775217, 17865.73201401954, 18079.728804067687, 18223.908880455514, 42560.36159457672, 42666.57333426626, 43227.78386108175, 43687.56312436835, 44083.0, 61455.0, 62281.0, 62472.687636561524, 63190.10429686933, 63688.68155659192, 8278.172182781673, 8324.6670133194, 8325.83348333042, 8353.749387518385, 8777.824443510966, 8154.184581542036, 8489.83020339602, 8683.435576687496, 8824.117588241124, 8925.687600933936, 7581.962090189734, 7621.161672215941, 8055.556944368116, 8165.550894700611, 8421.87367189505, 7863.331616812635, 8039.758807235792, 8144.674213031412, 8161.143079976517, 8270.214329638675, 8011.6394762237005, 8113.553754543556, 8177.427580069338, 8336.166383361615, 8506.702265420681, 13139.737205256033, 13214.27321497327, 13336.333183340601, 13538.255395952923, 13548.0, 12149.514019439124, 12337.876621233672, 12379.75240495167, 12913.0, 13075.869241307846], "value": 8764.072156878523, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1401.1312985948712, 1444.530527578537, 1548.1949386319113, 1693.6612677464511, 1715.74263860421, 7703.768886933387, 8343.123971982945, 8462.66149354026, 9002.684906028291, 9053.321000924923, 8021.3983951203745, 8099.149589293128, 8271.586420678972, 8324.458910170835, 8357.0, 2251.6735073414384, 2313.421644588853, 2317.397476656073, 2321.8955147018423, 2326.5579539887367, 2175.0755928730305, 2228.6434170532716, 2317.2468947592015, 2317.5249073939885, 2332.4985128197436, 2259.5706815705043, 2293.3693234360517, 2299.4021554395895, 2306.08909480755, 2308.7806658367513, 2181.214762685432, 2200.3948914048606, 2202.1631779923687, 2214.1143542582936, 2222.344408399526, 2180.2042254576963, 2208.4920468292385, 2222.2333295013195, 2227.599032174208, 2240.7535171131162, 8499.490030598123, 8605.311575074042, 8621.913780862174, 8635.222829945273, 8654.524001179932, 5068.4424713281505, 5173.922391164136, 5183.637145399824, 5184.766685499161, 5202.5172825744485, 3058.2048667346426, 3126.421612001787, 3220.5813244278092, 3266.6243382011135, 3277.2789986202997, 1113.1595645287755, 1124.3703526025452, 1131.0160160660196, 1170.970725731855, 1174.1546086817477, 12009.759804803854, 12353.814692779615, 12359.32023738703, 12375.876241237562, 12377.443015064344, 4442.73343599385, 4453.532379100213, 4545.818167273272, 4575.81696732127, 4606.976965115153, 10404.427756473468, 10446.791064178826, 10452.425116618659, 10469.895301047045, 10502.73743156412, 5268.789248430096, 5275.841724748264, 5285.233641122016, 5288.312519372457, 5296.629235953446, 4310.331898555729, 4687.789049492781, 4772.379590653193, 4830.637702172351, 4846.975765121152, 4028.71798974069, 4039.333509970822, 4104.384342348611, 4147.294959856831, 4155.148194620096, 1228.8955438787625, 1289.8516670582815, 1293.8706129386985, 1299.2659147581776, 1303.0683061610805, 858.3004851046377, 967.8451447768323, 992.1219720547367, 1009.3893194617151, 1021.6985989133224, 6107.603005804608, 6227.750889964442, 6236.875262494725, 6271.529635277372, 6298.1812364392335, 410.852093246431, 411.80439291336376, 415.4847988494306, 418.4016855896037, 420.7538589924867, 4323.69734118615, 4418.182636212311, 4462.263726485158, 4464.129494748558, 4470.821167153343, 10626.415547144827, 10950.890491095146, 11096.05683516894, 11111.499982500807, 11122.388268645302, 10753.354798712102, 10823.512941917475, 10905.999999999842, 10952.34285942846, 10975.451227438596, 7832.647530861125, 8144.959275203704, 8148.511089334659, 8223.095459499451, 8397.790055248668, 6116.143739876332, 6365.96817015912, 6376.4261216488885, 6399.136116624382, 6403.391677790602, 9927.801443971224, 10088.899111008795, 10259.384436933808, 10306.433146176732, 10306.742331441774, 9689.563969621244, 10050.0, 10077.69766906994, 10334.379937203792, 10399.844002340122, 7558.206388329366, 7686.192949740197, 7689.0, 7741.806454838674, 7885.369170466234, 8581.442206256574, 8587.957060214909, 8589.484630922165, 8598.183172598594, 8631.56842157902, 7427.7771666850085, 7515.586642734702, 7657.0, 7755.806104847424, 7893.0, 7603.581803000888, 7626.54240745557, 7729.497582657109, 7731.304182623591, 7821.569813660303, 7177.928220717726, 7189.317014883578, 7229.783106506813, 7234.74678386254, 7235.819104522429, 4889.095517329305, 5161.354830646169, 5259.55293800016, 5399.568034557305, 5414.269073675004, 5044.167712327425, 5186.507281808223, 5207.4271830097905, 5312.760925758273, 5442.510174084351], "value": 4533.809721775188, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.3771957840945, 327.28978117485053, 330.8560776062414, 332.0751706497407, 334.56673607678056, 5618.269624948756, 5692.800751973677, 5699.202111704365, 5713.400092990233, 5732.742026608802, 5602.495775380215, 5627.296587926509, 5628.183913332565, 5631.915521267174, 5665.660060396379, 4212.620864122236, 4257.638100761439, 4375.4093197418415, 4376.2997920332755, 4376.665117139271, 4383.671224658147, 4407.228734971383, 4419.867403977886, 4420.535843736409, 4441.444819397575, 4385.2106620808245, 4390.121975604876, 4400.537943515933, 4408.501109622727, 4422.690411671184, 4263.081613274024, 4351.5648435156545, 4367.8861890217795, 4383.824647014116, 4391.407160033386, 3820.8346454331418, 3837.6929845612285, 3839.6753120173494, 3861.4787003754413, 3872.3029854626157, 5421.756020979026, 5447.863803404907, 5465.289512363367, 5480.808171713971, 5525.867197224559, 4785.487619000018, 4929.0, 4970.229614409773, 4971.527704868032, 5003.2995380646735, 5751.654900705971, 5788.826335209908, 5801.187833703285, 5845.7431652194555, 5852.67810270435, 4242.787860606957, 4246.808893599796, 4260.297050986584, 4279.422277992462, 4288.442502474658, 5987.25159355085, 6022.638641681469, 6027.246594175728, 6030.216071910623, 6040.553575801808, 4281.186574550888, 4301.956980430218, 4332.393464914914, 4350.695451318441, 4358.65130789536, 4419.46966364032, 4420.248557745191, 4420.80106395213, 4435.955640443619, 4439.866803995821, 4957.959697229942, 4983.152864013126, 5017.498250174954, 5017.573506251936, 5024.120778863684, 5835.474807267281, 5895.616784908967, 5913.793017244376, 5928.8814223716145, 5965.791197308074, 1503.8796896248493, 1507.6080219143103, 1517.0808926707723, 1518.460946364047, 1523.7638166084275, 949.3402085550614, 951.0964583645564, 974.444566597047, 979.3193730357333, 1010.1565193063727, 5615.939313074385, 5664.9803035454015, 5685.436504961086, 5686.800961966312, 5710.71446427677, 6006.069059295816, 6030.939690603038, 6036.3360030396625, 6041.640630858022, 6051.878962420815, 5381.973090134525, 5615.9157612635845, 5752.194692743019, 5759.424057594207, 5763.510101641407, 3306.768526203191, 3309.4043072246745, 3319.13702437368, 3328.384248913959, 3329.5338652588657, 6145.385461453819, 6381.1066450696935, 6392.328805475451, 6447.323031081763, 6452.064450654629, 6148.9692551536955, 6266.342034086447, 6271.843203919847, 6279.937200627935, 6290.779822706183, 6173.413525715139, 6254.906176407358, 6257.311695713468, 6264.718087686065, 6361.2048493938255, 6102.38976102404, 6106.664133472524, 6123.877522449615, 6150.261968563801, 6153.446189842935, 6033.577649564489, 6035.366286540026, 6057.757689692363, 6062.969685151546, 6115.480184184395, 6105.8168254952425, 6289.591176573508, 6309.287006587211, 6320.905186422116, 6336.809895703136, 4182.602652747984, 4187.581241875788, 4233.174530966432, 4271.31658934569, 4286.721363111388, 5830.795922142875, 6073.423024812636, 6086.421789929949, 6125.264968203844, 6243.719032643451, 5883.823485295448, 5888.969430349586, 5892.852678682896, 5895.528357731457, 5934.732937017931, 5891.528677705859, 5900.5574581907385, 5920.970395147997, 5945.494632956074, 5978.4021597839865, 5634.436556344497, 5800.172945522147, 5849.356570777126, 5863.120531920246, 5894.557908156819, 5976.491998180029, 5978.850528736642, 5987.13186587951, 6021.54838387114, 6023.897692688181, 5620.269364982526, 5879.470847623735, 5881.264841894763, 5908.497777688945, 5926.881462370815], "value": 4504.663508642152, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [660.960342379457, 681.7920534237056, 691.7820886420777, 742.6732237815361, 765.2041876448492, 13891.513797017107, 14378.424863005468, 14384.712305753905, 14416.855831441682, 14481.565553033413, 13135.934320328384, 14068.22624755638, 14074.507392241274, 14112.506062287823, 14116.929415352935, 764.2624867003341, 768.2471178245308, 776.2819392062348, 783.220695408067, 793.7777422321759, 794.7099308752322, 795.3676826922582, 795.8249185179251, 797.7128233835814, 798.0503201190564, 833.3250067445358, 836.1429534726893, 837.6733074101105, 839.3075712537151, 841.0286119531951, 830.3606223208126, 831.40969911363, 833.1335411172373, 834.6869923778584, 837.3468694418364, 607.7143742441045, 609.832296118571, 610.6397225636896, 611.119987218404, 611.1566038866335, 14439.422423103064, 14449.349779259854, 14450.638734031629, 14524.201168935704, 14529.78205326921, 12222.327771972537, 12227.266364018187, 12326.445309961073, 12633.684157896034, 12943.417546210443, 10968.23222374434, 11147.331160130418, 11201.0, 11222.66332010041, 11671.474783634672, 3603.963960360389, 3624.9456258156147, 3646.872359467406, 3673.6510031547227, 3755.6995440364976, 61392.0, 76949.61525192394, 78446.0, 78747.60626196832, 79256.20743792603, 9549.09283618055, 9806.754831129136, 9888.851667224997, 10108.646197383056, 10137.087662110445, 19134.330298439487, 19171.712424313646, 19296.22815087381, 19297.903510482356, 19306.0, 7745.961270193726, 7778.49439786412, 7805.921940780633, 7814.570198639016, 7923.049234091831, 4616.538346165356, 4695.3426520287185, 4740.810367585258, 4794.065157294294, 4833.275008748716, 3231.757618178599, 3340.732741380684, 3353.6814002669707, 3358.8488518016748, 3359.177001634615, 581.4970050906021, 587.9088741245114, 595.979140730081, 596.9044952807529, 608.7808388979963, 616.7717944360616, 681.7341236917606, 695.2630211975322, 716.4268585131873, 727.5052963984541, 9051.773705657279, 9370.405753914225, 9386.249100072115, 9448.669296574586, 9712.805743885083, 579.2932622200908, 581.9854503637358, 620.9223847019123, 643.2955913274957, 702.3819039245432, 4329.242382583098, 4410.779461026936, 4504.106158990107, 4577.885552861205, 4618.0, 108491.0, 111050.0, 111528.0, 117053.0, 119015.12136888216, 101272.0, 102935.0, 103701.48149259205, 103868.48065759623, 104458.05768192957, 56283.672729620215, 57510.71244643834, 57847.421525785045, 58121.70939145277, 75798.66214716376, 8839.0, 8846.557672116498, 8942.0, 8944.731658050268, 8975.92212606935, 52584.0, 53118.2032269524, 53919.46080539301, 55229.0, 56734.71632641811, 77922.61038694771, 78983.08972767113, 81410.0, 81756.0, 82117.0, 10481.528331225265, 10521.842172367573, 10840.566377345134, 10916.672499825017, 10955.452227388758, 11654.883451165719, 12333.75332493363, 12569.748605028031, 12642.178258413174, 12960.740785184433, 11540.769184616092, 11829.70425739329, 11887.934759395293, 12059.336736479578, 12109.212901161396, 11667.474963626826, 11677.824832627348, 11830.763384732429, 12230.449629766505, 12631.368431578201, 11297.71755706114, 11552.0, 11793.823092653445, 11820.822687659864, 11878.643640690792, 9694.515274236119, 9770.31607787448, 9904.356216845881, 9943.900560994587, 9969.950150249202, 9748.463834489172, 10151.155602528543, 10219.469569823825, 10226.0, 10308.793824123626], "value": 7040.842207184421, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1540.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 106.0, 112.0, 111.0, 112.0, 111.0, 110.0, 110.0, 111.0, 110.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 129.0, 159.0, 184.0, 140.0, 151.0, 156.0, 128.0, 178.0, 127.0], "value": 150.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 164.0, 162.0, 164.0, 175.0, 161.0, 164.0, 165.0, 162.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 170.0, 76.0, 75.0, 75.0, 75.0, 168.0, 74.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 149.0, 85.0, 85.0, 86.0, 147.0, 83.0, 90.0, 145.0], "value": 104.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 147.0, 148.0, 154.0, 148.0, 148.0, 147.0, 148.0, 148.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 97.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 57.0, 54.0, 53.0, 53.0, 54.0, 56.0, 53.0, 57.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 61.0, 69.0, 60.0, 59.0, 60.0, 60.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 81.0, 79.0, 88.0, 80.0, 81.0, 80.0, 102.0, 80.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 122.0, 140.0, 121.0, 132.0, 125.0, 122.0, 136.0, 128.0, 125.0], "value": 128.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 167.0, 162.0, 165.0, 159.0, 164.0, 162.0, 161.0, 163.0], "value": 162.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 69.0, 64.0, 64.0, 63.0, 63.0, 63.0], "value": 64.8, "unit": "score"}]}]} 14:32:54 INFO - Return code: 0 14:32:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:32:54 ERROR - # TBPL SUCCESS # 14:32:54 INFO - Running post-action listener: _resource_record_post_action 14:32:54 INFO - ##### 14:32:54 INFO - ##### Finished run-tests step (success) 14:32:54 INFO - ##### 14:32:54 INFO - Running post-run listener: _resource_record_post_run 14:32:54 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 394829824; Read time: 0; Write time: 258956 14:32:54 INFO - TinderboxPrint: CPU usage
13.4% 14:32:54 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 14:32:54 INFO - TinderboxPrint: I/O write bytes / time
394,829,824 / 258,956 14:32:54 INFO - TinderboxPrint: CPU idle
8,228.6 (86.5%) 14:32:54 INFO - TinderboxPrint: CPU user
1,223.5 (12.9%) 14:32:54 INFO - TinderboxPrint: Swap in / out
0 / 0 14:32:54 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 104509440; Read time: 0; Write time: 60036 14:32:54 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 290320384; Read time: 0; Write time: 198920 14:32:55 INFO - Running post-run listener: _upload_blobber_files 14:32:55 INFO - Blob upload gear active. 14:32:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:32:55 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 14:32:55 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'] 14:32:55 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 14:32:55 INFO - (blobuploader) - INFO - Open directory for files ... 14:32:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:32:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:32:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:32:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:32:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:32:58 INFO - (blobuploader) - INFO - Done attempting. 14:32:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:32:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:32:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:32:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:32:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:32:59 INFO - (blobuploader) - INFO - Done attempting. 14:32:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:32:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:32:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:33:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:33:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:33:00 INFO - (blobuploader) - INFO - Done attempting. 14:33:00 INFO - (blobuploader) - INFO - Iteration through files over. 14:33:00 INFO - Return code: 0 14:33:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:33:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:33:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c05ee7966987bf08126d02d235259dc448663396533b90ba3ee016102a25dccdc703d904e8e0d3bf09bc93c4ffe42543bc15a5738062e436de1489e5f6fb6bfd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a3596917091cd8649565ac4fa12df8d1301adf7bdf75a9f486ee8d4553e1a7fa6c202951cf8fd8728eac0cf42cf885501ee2be9b500510f4a1fcd17966eb0dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c1e4d812a09a8fed8fa643e7aa3e65f8ebed1f47b6227a8eb0b36d73f7d2afe5f105158476a5a718f073648d3cd339a76349dfbbb13ed9c4c334e6523e4e1c42"} 14:33:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:33:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:33:00 INFO - Contents: 14:33:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c05ee7966987bf08126d02d235259dc448663396533b90ba3ee016102a25dccdc703d904e8e0d3bf09bc93c4ffe42543bc15a5738062e436de1489e5f6fb6bfd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a3596917091cd8649565ac4fa12df8d1301adf7bdf75a9f486ee8d4553e1a7fa6c202951cf8fd8728eac0cf42cf885501ee2be9b500510f4a1fcd17966eb0dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c1e4d812a09a8fed8fa643e7aa3e65f8ebed1f47b6227a8eb0b36d73f7d2afe5f105158476a5a718f073648d3cd339a76349dfbbb13ed9c4c334e6523e4e1c42"} 14:33:00 INFO - Running post-run listener: copy_logs_to_upload_dir 14:33:00 INFO - Copying logs to upload dir... 14:33:00 INFO - mkdir: /builds/slave/test/build/upload/logs 14:33:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.456561 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-06-21 14:33:00.061779) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 14:33:00.067543) ========= 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=8887e36bb8e381bfd44124ac000001a8-1466540867.982696-1936983635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c05ee7966987bf08126d02d235259dc448663396533b90ba3ee016102a25dccdc703d904e8e0d3bf09bc93c4ffe42543bc15a5738062e436de1489e5f6fb6bfd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a3596917091cd8649565ac4fa12df8d1301adf7bdf75a9f486ee8d4553e1a7fa6c202951cf8fd8728eac0cf42cf885501ee2be9b500510f4a1fcd17966eb0dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c1e4d812a09a8fed8fa643e7aa3e65f8ebed1f47b6227a8eb0b36d73f7d2afe5f105158476a5a718f073648d3cd339a76349dfbbb13ed9c4c334e6523e4e1c42"} build_url:https://queue.taskcluster.net/v1/task/CbVqcauFTcWuPl-FW-CkVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011446 build_url: 'https://queue.taskcluster.net/v1/task/CbVqcauFTcWuPl-FW-CkVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c05ee7966987bf08126d02d235259dc448663396533b90ba3ee016102a25dccdc703d904e8e0d3bf09bc93c4ffe42543bc15a5738062e436de1489e5f6fb6bfd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a3596917091cd8649565ac4fa12df8d1301adf7bdf75a9f486ee8d4553e1a7fa6c202951cf8fd8728eac0cf42cf885501ee2be9b500510f4a1fcd17966eb0dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c1e4d812a09a8fed8fa643e7aa3e65f8ebed1f47b6227a8eb0b36d73f7d2afe5f105158476a5a718f073648d3cd339a76349dfbbb13ed9c4c334e6523e4e1c42"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 14:33:00.093330) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 14:33:00.093721) ========= 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=8887e36bb8e381bfd44124ac000001a8-1466540867.982696-1936983635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 14:33:00.177472) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 14:33:00.177854) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 14:33:00.178202) ========= ========= Total master_lag: 0.18 =========