builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-002 starttime: 1465365518.97 results: success (0) buildid: 20160607203013 builduid: cbad0c3de0f74bd9a62abdbc5329ba3e revision: a7b31be0a19ae5413db3e10ad4e5251cac84b08d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 22:58:38.967041) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 22:58:38.967471) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 22:58:38.967757) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 22:58:39.028147) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 22:58:39.028424) ========= 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=a0d2d2de893abaa8702a9954000001a7-1465363236.288551-509201038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-07 22:58:39-- 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% 46.1M=0s 2016-06-07 22:58:39 (46.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095346 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 22:58:39.148413) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 22:58:39.148713) ========= 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=a0d2d2de893abaa8702a9954000001a7-1465363236.288551-509201038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020540 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 22:58:39.204692) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 22:58:39.205024) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a7b31be0a19ae5413db3e10ad4e5251cac84b08d --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 a7b31be0a19ae5413db3e10ad4e5251cac84b08d --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=a0d2d2de893abaa8702a9954000001a7-1465363236.288551-509201038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-07 22:58:39,286 truncating revision to first 12 chars 2016-06-07 22:58:39,286 Setting DEBUG logging. 2016-06-07 22:58:39,286 attempt 1/10 2016-06-07 22:58:39,286 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a7b31be0a19a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-07 22:58:40,159 unpacking tar archive at: fx-team-a7b31be0a19a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.211052 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 22:58:40.433764) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 22:58:40.434058) ========= script_repo_revision: a7b31be0a19ae5413db3e10ad4e5251cac84b08d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 22:58:40.434472) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 22:58:40.434739) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 22:58:40.444225) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-07 22:58:40.444510) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1465363236.288551-509201038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:58:40 INFO - MultiFileLogger online at 20160607 22:58:40 in /builds/slave/test 22:58:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 22:58:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:58:40 INFO - {'append_to_log': False, 22:58:40 INFO - 'base_work_dir': '/builds/slave/test', 22:58:40 INFO - 'blob_upload_branch': 'Fx-Team', 22:58:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:58:40 INFO - 'branch': 'Fx-Team', 22:58:40 INFO - 'buildbot_json_path': 'buildprops.json', 22:58:40 INFO - 'config_files': ('talos/linux_config.py',), 22:58:40 INFO - 'default_actions': ('clobber', 22:58:40 INFO - 'read-buildbot-config', 22:58:40 INFO - 'download-and-extract', 22:58:40 INFO - 'populate-webroot', 22:58:40 INFO - 'create-virtualenv', 22:58:40 INFO - 'install', 22:58:40 INFO - 'run-tests'), 22:58:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:58:40 INFO - 'download_minidump_stackwalk': True, 22:58:40 INFO - 'download_symbols': 'ondemand', 22:58:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:58:40 INFO - 'tooltool.py': '/tools/tooltool.py', 22:58:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:58:40 INFO - '/tools/misc-python/virtualenv.py')}, 22:58:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:58:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:58:40 INFO - 'installer_path': 'installer.exe', 22:58:40 INFO - 'log_level': 'info', 22:58:40 INFO - 'log_name': 'talos', 22:58:40 INFO - 'log_to_console': True, 22:58:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:58:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:58:40 INFO - 'opt_config_files': (), 22:58:40 INFO - 'pip_index': False, 22:58:40 INFO - 'sps_profile': False, 22:58:40 INFO - 'sps_profile_interval': 0, 22:58:40 INFO - 'suite': 'dromaeojs', 22:58:40 INFO - 'system_bits': '32', 22:58:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:58:40 INFO - 'title': 'talos-linux64-ix-002', 22:58:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:58:40 INFO - 'use_talos_json': True, 22:58:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:58:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:58:40 INFO - 'work_dir': 'build'} 22:58:40 INFO - ##### 22:58:40 INFO - ##### Running clobber step. 22:58:40 INFO - ##### 22:58:40 INFO - Running pre-action listener: _resource_record_pre_action 22:58:40 INFO - Running main action method: clobber 22:58:40 INFO - rmtree: /builds/slave/test/build 22:58:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:58:41 INFO - Running post-action listener: _resource_record_post_action 22:58:41 INFO - ##### 22:58:41 INFO - ##### Finished clobber step (success) 22:58:41 INFO - ##### 22:58:41 INFO - ##### 22:58:41 INFO - ##### Running read-buildbot-config step. 22:58:41 INFO - ##### 22:58:41 INFO - Running pre-action listener: _resource_record_pre_action 22:58:41 INFO - Running main action method: read_buildbot_config 22:58:41 INFO - Using buildbot properties: 22:58:41 INFO - { 22:58:41 INFO - "project": "", 22:58:41 INFO - "product": "firefox", 22:58:41 INFO - "script_repo_revision": "production", 22:58:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:58:41 INFO - "repository": "", 22:58:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 22:58:41 INFO - "buildid": "20160607203013", 22:58:41 INFO - "pgo_build": "True", 22:58:41 INFO - "basedir": "/builds/slave/test", 22:58:41 INFO - "buildnumber": 1236, 22:58:41 INFO - "slavename": "talos-linux64-ix-002", 22:58:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:58:41 INFO - "platform": "ubuntu64_hw", 22:58:41 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 22:58:41 INFO - "branch": "fx-team", 22:58:41 INFO - "repo_path": "integration/fx-team", 22:58:41 INFO - "revision": "a7b31be0a19ae5413db3e10ad4e5251cac84b08d", 22:58:41 INFO - "stage_platform": "linux64-pgo", 22:58:41 INFO - "builduid": "cbad0c3de0f74bd9a62abdbc5329ba3e", 22:58:41 INFO - "slavebuilddir": "test" 22:58:41 INFO - } 22:58:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 22:58:41 INFO - Running post-action listener: _resource_record_post_action 22:58:41 INFO - ##### 22:58:41 INFO - ##### Finished read-buildbot-config step (success) 22:58:41 INFO - ##### 22:58:41 INFO - ##### 22:58:41 INFO - ##### Running download-and-extract step. 22:58:41 INFO - ##### 22:58:41 INFO - Running pre-action listener: _resource_record_pre_action 22:58:41 INFO - Running main action method: download_and_extract 22:58:41 INFO - mkdir: /builds/slave/test/build/tests 22:58:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:58:41 INFO - https://queue.taskcluster.net/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:58:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:58:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:58:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEi06RDARjWL9aVedZ5jtQ/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 22:58:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEi06RDARjWL9aVedZ5jtQ/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 22:58:50 INFO - Downloaded 1361 bytes. 22:58:50 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:58:50 INFO - Using the following test package requirements: 22:58:50 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:58:50 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:58:50 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:58:50 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:50 INFO - u'jsshell-linux-x86_64.zip'], 22:58:50 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:58:50 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:58:50 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:58:50 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:58:50 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:58:50 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:58:50 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:58:50 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')]} 22:58:50 INFO - https://queue.taskcluster.net/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:58:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:58:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:58:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEi06RDARjWL9aVedZ5jtQ/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 22:58:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEi06RDARjWL9aVedZ5jtQ/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 22:58:55 INFO - Downloaded 24447005 bytes. 22:58:55 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'] 22:58:55 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 22:58:56 INFO - Return code: 0 22:58:56 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 22:58:56 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')]} 22:58:56 INFO - https://queue.taskcluster.net/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:58:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:58:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:58:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEi06RDARjWL9aVedZ5jtQ/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 22:58:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEi06RDARjWL9aVedZ5jtQ/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 22:58:58 INFO - Downloaded 24447005 bytes. 22:58:58 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'] 22:58:58 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 22:58:59 INFO - Return code: 0 22:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:58:59 INFO - https://queue.taskcluster.net/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:58:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:58:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:58:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEi06RDARjWL9aVedZ5jtQ/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 22:58:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEi06RDARjWL9aVedZ5jtQ/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 22:59:00 INFO - Downloaded 10833369 bytes. 22:59:00 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'] 22:59:00 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 22:59:00 INFO - Return code: 0 22:59:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:59:00 INFO - https://queue.taskcluster.net/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:59:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:59:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:59:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEi06RDARjWL9aVedZ5jtQ/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 22:59:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEi06RDARjWL9aVedZ5jtQ/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 22:59:02 INFO - Downloaded 59190267 bytes. 22:59:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:59:02 INFO - mkdir: /builds/slave/test/properties 22:59:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:59:02 INFO - Writing to file /builds/slave/test/properties/build_url 22:59:02 INFO - Contents: 22:59:02 INFO - build_url:https://queue.taskcluster.net/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:59:03 INFO - Running post-action listener: _resource_record_post_action 22:59:03 INFO - Running post-action listener: set_extra_try_arguments 22:59:03 INFO - ##### 22:59:03 INFO - ##### Finished download-and-extract step (success) 22:59:03 INFO - ##### 22:59:03 INFO - ##### 22:59:03 INFO - ##### Running populate-webroot step. 22:59:03 INFO - ##### 22:59:03 INFO - Running pre-action listener: _resource_record_pre_action 22:59:03 INFO - Running main action method: populate_webroot 22:59:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:59:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:59:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:59:03 INFO - '--tppagecycles', 22:59:03 INFO - '7'], 22:59:03 INFO - 'tests': ['tsvgm']}}, 22:59:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:59:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:59:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:59:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:59:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:59:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:59:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:59:03 INFO - 'talos_options': ['--disable-e10s'], 22:59:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:59:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:59:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:59:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:59:03 INFO - 'talos_options': ['--disable-e10s'], 22:59:03 INFO - 'tests': ['damp', 'tps']}, 22:59:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:59:03 INFO - 'tests': ['damp', 'tps']}, 22:59:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:59:03 INFO - 'tests': ['dromaeo_dom']}, 22:59:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:59:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:59:03 INFO - 'tests': ['a11yr', 22:59:03 INFO - 'ts_paint', 22:59:03 INFO - 'tpaint', 22:59:03 INFO - 'sessionrestore', 22:59:03 INFO - 'sessionrestore_no_auto_restore', 22:59:03 INFO - 'tabpaint']}, 22:59:03 INFO - 'other-e10s': {'tests': ['a11yr', 22:59:03 INFO - 'ts_paint', 22:59:03 INFO - 'tpaint', 22:59:03 INFO - 'sessionrestore', 22:59:03 INFO - 'sessionrestore_no_auto_restore', 22:59:03 INFO - 'tabpaint']}, 22:59:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:59:03 INFO - 'ts_paint', 22:59:03 INFO - 'tpaint', 22:59:03 INFO - 'sessionrestore', 22:59:03 INFO - 'sessionrestore_no_auto_restore', 22:59:03 INFO - 'tabpaint']}, 22:59:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:59:03 INFO - 'ts_paint', 22:59:03 INFO - 'tpaint', 22:59:03 INFO - 'sessionrestore', 22:59:03 INFO - 'sessionrestore_no_auto_restore', 22:59:03 INFO - 'tabpaint']}, 22:59:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:59:03 INFO - 'tests': ['a11yr', 22:59:03 INFO - 'ts_paint', 22:59:03 INFO - 'tpaint', 22:59:03 INFO - 'sessionrestore', 22:59:03 INFO - 'sessionrestore_no_auto_restore', 22:59:03 INFO - 'tabpaint']}, 22:59:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:59:03 INFO - 'tests': ['a11yr', 22:59:03 INFO - 'ts_paint', 22:59:03 INFO - 'tpaint', 22:59:03 INFO - 'sessionrestore', 22:59:03 INFO - 'sessionrestore_no_auto_restore', 22:59:03 INFO - 'tabpaint']}, 22:59:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:59:03 INFO - 'tests': ['tsvgx', 22:59:03 INFO - 'tsvgr_opacity', 22:59:03 INFO - 'tart', 22:59:03 INFO - 'tscrollx', 22:59:03 INFO - 'cart']}, 22:59:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:59:03 INFO - 'tsvgr_opacity', 22:59:03 INFO - 'tart', 22:59:03 INFO - 'tscrollx', 22:59:03 INFO - 'cart']}, 22:59:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:59:03 INFO - 'talos_options': ['--disable-e10s'], 22:59:03 INFO - 'tests': ['tp5o']}, 22:59:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:59:03 INFO - 'tests': ['tp5o']}, 22:59:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:59:03 INFO - 'talos_options': ['--disable-e10s', 22:59:03 INFO - '--xperf_path', 22:59:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:59:03 INFO - 'tests': ['tp5n']}, 22:59:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:59:03 INFO - 'talos_options': ['--xperf_path', 22:59:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:59:03 INFO - 'tests': ['tp5n']}}, 22:59:03 INFO - 'talos.zip': {'path': '', 22:59:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:59:03 INFO - Running post-action listener: _resource_record_post_action 22:59:03 INFO - ##### 22:59:03 INFO - ##### Finished populate-webroot step (success) 22:59:03 INFO - ##### 22:59:03 INFO - ##### 22:59:03 INFO - ##### Running create-virtualenv step. 22:59:03 INFO - ##### 22:59:03 INFO - Running pre-action listener: _resource_record_pre_action 22:59:03 INFO - Running main action method: create_virtualenv 22:59:03 INFO - Creating virtualenv /builds/slave/test/build/venv 22:59:03 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 22:59:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:59:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:59:03 INFO - Using real prefix '/usr' 22:59:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:59:03 INFO - Installing distribute.............................................................................................................................................................................................done. 22:59:05 INFO - Installing pip.................done. 22:59:05 INFO - Return code: 0 22:59:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:59:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:59:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3a292e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f44350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd31c0>, '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 0x1fd40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd4550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1465363236.288551-509201038', '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 22:59:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:59:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:59:05 INFO - Using env: {'DISPLAY': ':0', 22:59:05 INFO - 'HOME': '/home/cltbld', 22:59:05 INFO - 'LANG': 'en_US.UTF-8', 22:59:05 INFO - 'LANGUAGE': 'en_US:en', 22:59:05 INFO - 'LOGNAME': 'cltbld', 22:59:05 INFO - 'MAIL': '/var/mail/cltbld', 22:59:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:05 INFO - 'MOZ_NO_REMOTE': '1', 22:59:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:05 INFO - 'NO_EM_RESTART': '1', 22:59:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:05 INFO - 'PWD': '/builds/slave/test', 22:59:05 INFO - 'SHELL': '/bin/bash', 22:59:05 INFO - 'SHLVL': '1', 22:59:05 INFO - 'TERM': 'linux', 22:59:05 INFO - 'TMOUT': '86400', 22:59:05 INFO - 'USER': 'cltbld', 22:59:05 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1465363236.288551-509201038', 22:59:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:05 INFO - '_': '/tools/buildbot/bin/python'} 22:59:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:06 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 22:59:06 INFO - Cleaning up... 22:59:06 INFO - Return code: 0 22:59:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:59:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:59:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3a292e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f44350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd31c0>, '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 0x1fd40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd4550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1465363236.288551-509201038', '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 22:59:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 22:59:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:59:06 INFO - Using env: {'DISPLAY': ':0', 22:59:06 INFO - 'HOME': '/home/cltbld', 22:59:06 INFO - 'LANG': 'en_US.UTF-8', 22:59:06 INFO - 'LANGUAGE': 'en_US:en', 22:59:06 INFO - 'LOGNAME': 'cltbld', 22:59:06 INFO - 'MAIL': '/var/mail/cltbld', 22:59:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:06 INFO - 'MOZ_NO_REMOTE': '1', 22:59:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:06 INFO - 'NO_EM_RESTART': '1', 22:59:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:06 INFO - 'PWD': '/builds/slave/test', 22:59:06 INFO - 'SHELL': '/bin/bash', 22:59:06 INFO - 'SHLVL': '1', 22:59:06 INFO - 'TERM': 'linux', 22:59:06 INFO - 'TMOUT': '86400', 22:59:06 INFO - 'USER': 'cltbld', 22:59:06 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1465363236.288551-509201038', 22:59:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:06 INFO - '_': '/tools/buildbot/bin/python'} 22:59:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:06 INFO - Downloading/unpacking psutil>=3.1.1 22:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:59:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:59:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:59:08 INFO - Installing collected packages: psutil 22:59:08 INFO - Running setup.py install for psutil 22:59:08 INFO - building 'psutil._psutil_linux' extension 22:59:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:59:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:59:08 INFO - building 'psutil._psutil_posix' extension 22:59:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:59:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:59:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:59:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:59:08 INFO - Successfully installed psutil 22:59:08 INFO - Cleaning up... 22:59:09 INFO - Return code: 0 22:59:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:59:09 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')]} 22:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:09 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')]} 22:59:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:09 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 0x7f3a292e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f44350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd31c0>, '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 0x1fd40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd4550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1465363236.288551-509201038', '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 22:59:09 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 22:59:09 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 22:59:09 INFO - Using env: {'DISPLAY': ':0', 22:59:09 INFO - 'HOME': '/home/cltbld', 22:59:09 INFO - 'LANG': 'en_US.UTF-8', 22:59:09 INFO - 'LANGUAGE': 'en_US:en', 22:59:09 INFO - 'LOGNAME': 'cltbld', 22:59:09 INFO - 'MAIL': '/var/mail/cltbld', 22:59:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:09 INFO - 'MOZ_NO_REMOTE': '1', 22:59:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:09 INFO - 'NO_EM_RESTART': '1', 22:59:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:09 INFO - 'PWD': '/builds/slave/test', 22:59:09 INFO - 'SHELL': '/bin/bash', 22:59:09 INFO - 'SHLVL': '1', 22:59:09 INFO - 'TERM': 'linux', 22:59:09 INFO - 'TMOUT': '86400', 22:59:09 INFO - 'USER': 'cltbld', 22:59:09 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1465363236.288551-509201038', 22:59:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:09 INFO - '_': '/tools/buildbot/bin/python'} 22:59:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:59:09 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 22:59:09 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 22:59:09 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 22:59:09 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 22:59:09 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 22:59:09 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 22:59:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:59:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:59:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:59:11 INFO - Installing collected packages: mozsystemmonitor 22:59:11 INFO - Running setup.py install for mozsystemmonitor 22:59:11 INFO - Successfully installed mozsystemmonitor 22:59:11 INFO - Cleaning up... 22:59:11 INFO - Return code: 0 22:59:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:59:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:59:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3a292e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f44350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd31c0>, '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 0x1fd40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd4550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1465363236.288551-509201038', '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 22:59:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 22:59:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 22:59:11 INFO - Using env: {'DISPLAY': ':0', 22:59:11 INFO - 'HOME': '/home/cltbld', 22:59:11 INFO - 'LANG': 'en_US.UTF-8', 22:59:11 INFO - 'LANGUAGE': 'en_US:en', 22:59:11 INFO - 'LOGNAME': 'cltbld', 22:59:11 INFO - 'MAIL': '/var/mail/cltbld', 22:59:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:11 INFO - 'MOZ_NO_REMOTE': '1', 22:59:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:11 INFO - 'NO_EM_RESTART': '1', 22:59:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:11 INFO - 'PWD': '/builds/slave/test', 22:59:11 INFO - 'SHELL': '/bin/bash', 22:59:11 INFO - 'SHLVL': '1', 22:59:11 INFO - 'TERM': 'linux', 22:59:11 INFO - 'TMOUT': '86400', 22:59:11 INFO - 'USER': 'cltbld', 22:59:11 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1465363236.288551-509201038', 22:59:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:11 INFO - '_': '/tools/buildbot/bin/python'} 22:59:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:11 INFO - Downloading/unpacking jsonschema==2.5.1 22:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:59:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:13 INFO - Downloading functools32-3.2.3-2.tar.gz 22:59:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:59:13 INFO - warning: no files found matching '*.txt' 22:59:13 INFO - no previously-included directories found matching 'build' 22:59:13 INFO - no previously-included directories found matching 'dist' 22:59:13 INFO - no previously-included directories found matching '.git*' 22:59:13 INFO - Installing collected packages: jsonschema, functools32 22:59:13 INFO - Running setup.py install for functools32 22:59:13 INFO - warning: no files found matching '*.txt' 22:59:13 INFO - no previously-included directories found matching 'build' 22:59:13 INFO - no previously-included directories found matching 'dist' 22:59:13 INFO - no previously-included directories found matching '.git*' 22:59:13 INFO - Successfully installed jsonschema functools32 22:59:13 INFO - Cleaning up... 22:59:13 INFO - Return code: 0 22:59:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:59:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:59:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3a292e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f44350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd31c0>, '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 0x1fd40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd4550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1465363236.288551-509201038', '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 22:59:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:59:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:59:13 INFO - Using env: {'DISPLAY': ':0', 22:59:13 INFO - 'HOME': '/home/cltbld', 22:59:13 INFO - 'LANG': 'en_US.UTF-8', 22:59:13 INFO - 'LANGUAGE': 'en_US:en', 22:59:13 INFO - 'LOGNAME': 'cltbld', 22:59:13 INFO - 'MAIL': '/var/mail/cltbld', 22:59:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:13 INFO - 'MOZ_NO_REMOTE': '1', 22:59:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:13 INFO - 'NO_EM_RESTART': '1', 22:59:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:13 INFO - 'PWD': '/builds/slave/test', 22:59:13 INFO - 'SHELL': '/bin/bash', 22:59:13 INFO - 'SHLVL': '1', 22:59:13 INFO - 'TERM': 'linux', 22:59:13 INFO - 'TMOUT': '86400', 22:59:13 INFO - 'USER': 'cltbld', 22:59:13 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1465363236.288551-509201038', 22:59:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:13 INFO - '_': '/tools/buildbot/bin/python'} 22:59:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:14 INFO - Downloading/unpacking blobuploader==1.2.4 22:59:14 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 22:59:14 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 22:59:14 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 22:59:14 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 22:59:14 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 22:59:14 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 22:59:15 INFO - Downloading blobuploader-1.2.4.tar.gz 22:59:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:59:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:59:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:16 INFO - Downloading docopt-0.6.1.tar.gz 22:59:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:59:16 INFO - Installing collected packages: blobuploader, requests, docopt 22:59:16 INFO - Running setup.py install for blobuploader 22:59:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:59:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:59:16 INFO - Running setup.py install for requests 22:59:17 INFO - Running setup.py install for docopt 22:59:17 INFO - Successfully installed blobuploader requests docopt 22:59:17 INFO - Cleaning up... 22:59:17 INFO - Return code: 0 22:59:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:59:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:59:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3a292e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f44350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd31c0>, '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 0x1fd40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd4550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1465363236.288551-509201038', '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 22:59:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:59:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:59:17 INFO - Using env: {'DISPLAY': ':0', 22:59:17 INFO - 'HOME': '/home/cltbld', 22:59:17 INFO - 'LANG': 'en_US.UTF-8', 22:59:17 INFO - 'LANGUAGE': 'en_US:en', 22:59:17 INFO - 'LOGNAME': 'cltbld', 22:59:17 INFO - 'MAIL': '/var/mail/cltbld', 22:59:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:17 INFO - 'MOZ_NO_REMOTE': '1', 22:59:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:17 INFO - 'NO_EM_RESTART': '1', 22:59:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:17 INFO - 'PWD': '/builds/slave/test', 22:59:17 INFO - 'SHELL': '/bin/bash', 22:59:17 INFO - 'SHLVL': '1', 22:59:17 INFO - 'TERM': 'linux', 22:59:17 INFO - 'TMOUT': '86400', 22:59:17 INFO - 'USER': 'cltbld', 22:59:17 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1465363236.288551-509201038', 22:59:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:17 INFO - '_': '/tools/buildbot/bin/python'} 22:59:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:59:17 INFO - Running setup.py (path:/tmp/pip-zSpltC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:59:17 INFO - Running setup.py (path:/tmp/pip-IO5YJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:59:17 INFO - Running setup.py (path:/tmp/pip-79FUjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:59:17 INFO - Running setup.py (path:/tmp/pip-e7GIv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:59:17 INFO - Running setup.py (path:/tmp/pip-v5WVv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:59:17 INFO - Running setup.py (path:/tmp/pip-G3gnWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:59:18 INFO - Running setup.py (path:/tmp/pip-zzhkrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:59:18 INFO - Running setup.py (path:/tmp/pip-kQRq1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:59:18 INFO - Running setup.py (path:/tmp/pip-TCtYzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:59:18 INFO - Running setup.py (path:/tmp/pip-G0IvwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:59:18 INFO - Running setup.py (path:/tmp/pip-T80RWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:59:18 INFO - Running setup.py (path:/tmp/pip-Nqm2GJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:59:18 INFO - Running setup.py (path:/tmp/pip-qfuT4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:59:18 INFO - Running setup.py (path:/tmp/pip-7ZqIt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:59:18 INFO - Running setup.py (path:/tmp/pip-1YxHlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:59:18 INFO - Running setup.py (path:/tmp/pip-ic3q67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:59:18 INFO - Running setup.py (path:/tmp/pip-qz5izV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:59:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:59:18 INFO - Running setup.py install for manifestparser 22:59:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:59:18 INFO - Running setup.py install for mozcrash 22:59:19 INFO - Running setup.py install for mozdebug 22:59:19 INFO - Running setup.py install for mozdevice 22:59:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:59:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:59:19 INFO - Running setup.py install for mozfile 22:59:19 INFO - Running setup.py install for mozhttpd 22:59:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:59:19 INFO - Running setup.py install for mozinfo 22:59:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:59:19 INFO - Running setup.py install for mozInstall 22:59:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:59:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:59:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:59:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:59:19 INFO - Running setup.py install for mozleak 22:59:19 INFO - Running setup.py install for mozlog 22:59:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:59:19 INFO - Running setup.py install for moznetwork 22:59:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:59:19 INFO - Running setup.py install for mozprocess 22:59:20 INFO - Running setup.py install for mozprofile 22:59:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:59:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:59:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:59:20 INFO - Running setup.py install for mozrunner 22:59:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:59:20 INFO - Running setup.py install for mozscreenshot 22:59:20 INFO - Running setup.py install for moztest 22:59:20 INFO - Running setup.py install for mozversion 22:59:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:59:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:59:20 INFO - Cleaning up... 22:59:20 INFO - Return code: 0 22:59:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:59: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')]} 22:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59: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')]} 22:59:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3a292e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f44350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd31c0>, '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 0x1fd40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd4550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1465363236.288551-509201038', '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 22:59:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:59:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:59:20 INFO - Using env: {'DISPLAY': ':0', 22:59:20 INFO - 'HOME': '/home/cltbld', 22:59:20 INFO - 'LANG': 'en_US.UTF-8', 22:59:20 INFO - 'LANGUAGE': 'en_US:en', 22:59:20 INFO - 'LOGNAME': 'cltbld', 22:59:20 INFO - 'MAIL': '/var/mail/cltbld', 22:59:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:20 INFO - 'MOZ_NO_REMOTE': '1', 22:59:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:20 INFO - 'NO_EM_RESTART': '1', 22:59:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:20 INFO - 'PWD': '/builds/slave/test', 22:59:20 INFO - 'SHELL': '/bin/bash', 22:59:20 INFO - 'SHLVL': '1', 22:59:20 INFO - 'TERM': 'linux', 22:59:20 INFO - 'TMOUT': '86400', 22:59:20 INFO - 'USER': 'cltbld', 22:59:20 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1465363236.288551-509201038', 22:59:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:20 INFO - '_': '/tools/buildbot/bin/python'} 22:59:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:59:20 INFO - Running setup.py (path:/tmp/pip-IQL3wY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:59:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 22:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:59:20 INFO - Running setup.py (path:/tmp/pip-XRZcD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:59:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:59:20 INFO - Running setup.py (path:/tmp/pip-S_tnpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:59:21 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)) 22:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:59:21 INFO - Running setup.py (path:/tmp/pip-8ylNSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:59:21 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)) 22:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:59:21 INFO - Running setup.py (path:/tmp/pip-Q4c_fB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:59:21 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)) 22:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:59:21 INFO - Running setup.py (path:/tmp/pip-Pda0Mv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:59:21 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)) 22:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:59:21 INFO - Running setup.py (path:/tmp/pip-5wNaRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:59:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 22:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:59:21 INFO - Running setup.py (path:/tmp/pip-VhVFcO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:59:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 22:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:59:21 INFO - Running setup.py (path:/tmp/pip-uu7tKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:59:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 22:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:59:21 INFO - Running setup.py (path:/tmp/pip-8fwz7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:59:21 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)) 22:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:59:21 INFO - Running setup.py (path:/tmp/pip-JAt0Wm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:59:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 22:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:59:21 INFO - Running setup.py (path:/tmp/pip-PeC_OS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:59:21 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)) 22:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:59:21 INFO - Running setup.py (path:/tmp/pip-442JYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:59:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 22:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:59:21 INFO - Running setup.py (path:/tmp/pip-AdA4Pt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:59:21 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)) 22:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:59:21 INFO - Running setup.py (path:/tmp/pip-iZ1l8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:59:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 22:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:59:21 INFO - Running setup.py (path:/tmp/pip-fNtpJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:59:22 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)) 22:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:59:22 INFO - Running setup.py (path:/tmp/pip-BH5_dL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:59:22 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)) 22:59:22 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)) 22:59:22 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)) 22:59:22 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)) 22:59:22 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)) 22:59:22 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)) 22:59:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:59:22 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 22:59:22 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 22:59:22 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 22:59:22 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 22:59:22 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 22:59:22 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 22:59:23 INFO - Downloading blessings-1.6.tar.gz 22:59:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:59:24 INFO - Installing collected packages: blessings 22:59:24 INFO - Running setup.py install for blessings 22:59:24 INFO - Successfully installed blessings 22:59:24 INFO - Cleaning up... 22:59:24 INFO - Return code: 0 22:59:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:59:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:59:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:59:24 INFO - Reading from file tmpfile_stdout 22:59:24 INFO - Current package versions: 22:59:24 INFO - argparse == 1.2.1 22:59:24 INFO - blessings == 1.6 22:59:24 INFO - blobuploader == 1.2.4 22:59:24 INFO - docopt == 0.6.1 22:59:24 INFO - functools32 == 3.2.3-2 22:59:24 INFO - jsonschema == 2.5.1 22:59:24 INFO - manifestparser == 1.1 22:59:24 INFO - mozInstall == 1.12 22:59:24 INFO - mozcrash == 0.17 22:59:24 INFO - mozdebug == 0.1 22:59:24 INFO - mozdevice == 0.48 22:59:24 INFO - mozfile == 1.2 22:59:24 INFO - mozhttpd == 0.7 22:59:24 INFO - mozinfo == 0.9 22:59:24 INFO - mozleak == 0.1 22:59:24 INFO - mozlog == 3.2 22:59:24 INFO - moznetwork == 0.27 22:59:24 INFO - mozprocess == 0.22 22:59:24 INFO - mozprofile == 0.28 22:59:24 INFO - mozrunner == 6.11 22:59:24 INFO - mozscreenshot == 0.1 22:59:24 INFO - mozsystemmonitor == 0.3 22:59:24 INFO - moztest == 0.7 22:59:24 INFO - mozversion == 1.4 22:59:24 INFO - psutil == 3.1.1 22:59:24 INFO - requests == 1.2.3 22:59:24 INFO - wsgiref == 0.1.2 22:59:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:59:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3a292e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f44350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd31c0>, '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 0x1fd40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd4550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1465363236.288551-509201038', '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 22:59:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 22:59:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:59:24 INFO - Using env: {'DISPLAY': ':0', 22:59:24 INFO - 'HOME': '/home/cltbld', 22:59:24 INFO - 'LANG': 'en_US.UTF-8', 22:59:24 INFO - 'LANGUAGE': 'en_US:en', 22:59:24 INFO - 'LOGNAME': 'cltbld', 22:59:24 INFO - 'MAIL': '/var/mail/cltbld', 22:59:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:24 INFO - 'MOZ_NO_REMOTE': '1', 22:59:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:24 INFO - 'NO_EM_RESTART': '1', 22:59:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:24 INFO - 'PWD': '/builds/slave/test', 22:59:24 INFO - 'SHELL': '/bin/bash', 22:59:24 INFO - 'SHLVL': '1', 22:59:24 INFO - 'TERM': 'linux', 22:59:24 INFO - 'TMOUT': '86400', 22:59:24 INFO - 'USER': 'cltbld', 22:59:24 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1465363236.288551-509201038', 22:59:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:24 INFO - '_': '/tools/buildbot/bin/python'} 22:59:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:59:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 22:59:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 22:59:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:59:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 22:59:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 22:59:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 22:59:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 22:59:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 22:59:24 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:59:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:59:24 INFO - Cleaning up... 22:59:24 INFO - Return code: 0 22:59:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:59:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3a292e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f44350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd31c0>, '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 0x1fd40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd4550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1465363236.288551-509201038', '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 22:59:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:59:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:59:24 INFO - Using env: {'DISPLAY': ':0', 22:59:24 INFO - 'HOME': '/home/cltbld', 22:59:24 INFO - 'LANG': 'en_US.UTF-8', 22:59:24 INFO - 'LANGUAGE': 'en_US:en', 22:59:24 INFO - 'LOGNAME': 'cltbld', 22:59:24 INFO - 'MAIL': '/var/mail/cltbld', 22:59:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:24 INFO - 'MOZ_NO_REMOTE': '1', 22:59:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:24 INFO - 'NO_EM_RESTART': '1', 22:59:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:24 INFO - 'PWD': '/builds/slave/test', 22:59:24 INFO - 'SHELL': '/bin/bash', 22:59:24 INFO - 'SHLVL': '1', 22:59:24 INFO - 'TERM': 'linux', 22:59:24 INFO - 'TMOUT': '86400', 22:59:24 INFO - 'USER': 'cltbld', 22:59:24 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1465363236.288551-509201038', 22:59:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:24 INFO - '_': '/tools/buildbot/bin/python'} 22:59:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:59:24 INFO - Cleaning up... 22:59:24 INFO - Return code: 0 22:59:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:59:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3a292e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f44350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd31c0>, '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 0x1fd40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd4550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1465363236.288551-509201038', '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 22:59:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 22:59:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:59:24 INFO - Using env: {'DISPLAY': ':0', 22:59:24 INFO - 'HOME': '/home/cltbld', 22:59:24 INFO - 'LANG': 'en_US.UTF-8', 22:59:24 INFO - 'LANGUAGE': 'en_US:en', 22:59:24 INFO - 'LOGNAME': 'cltbld', 22:59:24 INFO - 'MAIL': '/var/mail/cltbld', 22:59:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:24 INFO - 'MOZ_NO_REMOTE': '1', 22:59:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:24 INFO - 'NO_EM_RESTART': '1', 22:59:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:24 INFO - 'PWD': '/builds/slave/test', 22:59:24 INFO - 'SHELL': '/bin/bash', 22:59:24 INFO - 'SHLVL': '1', 22:59:24 INFO - 'TERM': 'linux', 22:59:24 INFO - 'TMOUT': '86400', 22:59:24 INFO - 'USER': 'cltbld', 22:59:24 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1465363236.288551-509201038', 22:59:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:24 INFO - '_': '/tools/buildbot/bin/python'} 22:59:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:25 INFO - Downloading/unpacking flake8 22:59:25 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 22:59:25 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 22:59:25 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 22:59:25 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 22:59:25 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 22:59:25 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 22:59:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:59:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:59:26 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 22:59:26 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 22:59:26 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 22:59:26 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 22:59:26 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 22:59:26 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 22:59:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:59:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:59:27 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 22:59:27 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 22:59:27 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 22:59:27 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 22:59:27 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 22:59:27 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 22:59:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:59:27 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 22:59:27 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 22:59:27 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 22:59:27 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 22:59:27 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 22:59:27 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 22:59:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:59:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:59:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:59:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:59:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:59:27 INFO - no previously-included directories found matching 'docs/_build' 22:59:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:59:27 INFO - Running setup.py install for pep8 22:59:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:59:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:59:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:59:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:59:28 INFO - no previously-included directories found matching 'docs/_build' 22:59:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:59:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:59:28 INFO - Cleaning up... 22:59:28 INFO - Return code: 0 22:59:28 INFO - Running post-action listener: _resource_record_post_action 22:59:28 INFO - Running post-action listener: _start_resource_monitoring 22:59:28 INFO - Starting resource monitoring. 22:59:28 INFO - ##### 22:59:28 INFO - ##### Finished create-virtualenv step (success) 22:59:28 INFO - ##### 22:59:28 INFO - ##### 22:59:28 INFO - ##### Running install step. 22:59:28 INFO - ##### 22:59:28 INFO - Running pre-action listener: _resource_record_pre_action 22:59:28 INFO - Running main action method: install 22:59:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:59:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:59:28 INFO - Reading from file tmpfile_stdout 22:59:28 INFO - Detecting whether we're running mozinstall >=1.0... 22:59:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:59:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:59:28 INFO - Reading from file tmpfile_stdout 22:59:28 INFO - Output received: 22:59:28 INFO - Usage: mozinstall [options] installer 22:59:28 INFO - Options: 22:59:28 INFO - -h, --help show this help message and exit 22:59:28 INFO - -d DEST, --destination=DEST 22:59:28 INFO - Directory to install application into. [default: 22:59:28 INFO - "/builds/slave/test"] 22:59:28 INFO - --app=APP Application being installed. [default: firefox] 22:59:28 INFO - mkdir: /builds/slave/test/build/application 22:59:28 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'] 22:59:28 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 22:59:45 INFO - Reading from file tmpfile_stdout 22:59:45 INFO - Output received: 22:59:45 INFO - /builds/slave/test/build/application/firefox/firefox 22:59:45 INFO - Running post-action listener: _resource_record_post_action 22:59:45 INFO - ##### 22:59:45 INFO - ##### Finished install step (success) 22:59:45 INFO - ##### 22:59:45 INFO - ##### 22:59:45 INFO - ##### Running run-tests step. 22:59:45 INFO - ##### 22:59:45 INFO - Running pre-action listener: _resource_record_pre_action 22:59:45 INFO - Running main action method: run_tests 22:59:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:59:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:59:45 INFO - Python 2.7.3 22:59:45 INFO - Return code: 0 22:59:45 INFO - grabbing minidump binary from tooltool 22:59:45 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')]} 22:59:45 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 0x1fd31c0>, '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 0x1fd40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd4550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:59:45 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 22:59:45 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 22:59:45 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 22:59:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:59:45 INFO - Return code: 0 22:59:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:59:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:59:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:59:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:59:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:59:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:59:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:59:46 INFO - Return code: 0 22:59:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 22:59:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 22:59:46 INFO - Using env: {'DISPLAY': ':0', 22:59:46 INFO - 'HOME': '/home/cltbld', 22:59:46 INFO - 'LANG': 'en_US.UTF-8', 22:59:46 INFO - 'LANGUAGE': 'en_US:en', 22:59:46 INFO - 'LOGNAME': 'cltbld', 22:59:46 INFO - 'MAIL': '/var/mail/cltbld', 22:59:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:59:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:59:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:46 INFO - 'MOZ_NO_REMOTE': '1', 22:59:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:59:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:46 INFO - 'NO_EM_RESTART': '1', 22:59:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:46 INFO - 'PWD': '/builds/slave/test', 22:59:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:59:46 INFO - 'SHELL': '/bin/bash', 22:59:46 INFO - 'SHLVL': '1', 22:59:46 INFO - 'TERM': 'linux', 22:59:46 INFO - 'TMOUT': '86400', 22:59:46 INFO - 'USER': 'cltbld', 22:59:46 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1465363236.288551-509201038', 22:59:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:46 INFO - '_': '/tools/buildbot/bin/python'} 22:59:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 22:59:46 INFO - mozversion application_buildid: 20160607203013 22:59:46 INFO - mozversion application_changeset: a7b31be0a19ae5413db3e10ad4e5251cac84b08d 22:59:46 INFO - mozversion application_display_name: Nightly 22:59:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:59:46 INFO - mozversion application_name: Firefox 22:59:46 INFO - mozversion application_remotingname: firefox 22:59:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:59:46 INFO - mozversion application_vendor: Mozilla 22:59:46 INFO - mozversion application_version: 50.0a1 22:59:46 INFO - mozversion platform_buildid: 20160607203013 22:59:46 INFO - mozversion platform_changeset: a7b31be0a19ae5413db3e10ad4e5251cac84b08d 22:59:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:59:46 INFO - mozversion platform_version: 50.0a1 22:59:46 INFO - using testdate: 1465365586 22:59:46 INFO - actual date: 1465365586 22:59:46 INFO - starting webserver on 'localhost:55087' 22:59:46 INFO - SUITE-START | Running 2 tests 22:59:46 INFO - TEST-START | dromaeo_css 22:59:46 INFO - operating with platform_type : linux_ 22:59:46 INFO - Initialising browser for dromaeo_css test... 22:59:46 INFO - TEST-INFO | started process 17202 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCE15uT/profile http://localhost:55087/getInfo.html) 22:59:50 INFO - PROCESS | 17202 | __metrics Screen width/height:1600/1200 22:59:50 INFO - PROCESS | 17202 | colorDepth:24 22:59:50 INFO - PROCESS | 17202 | Browser inner width/height: 1024/697 22:59:50 INFO - PROCESS | 17202 | __metrics 22:59:51 ERROR - PROCESS | 17202 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:59:51 INFO - PROCESS | 17202 | console.error: PushService: 22:59:51 INFO - PROCESS | 17202 | stateChangeProcessEnqueue: Error transitioning state 22:59:51 INFO - PROCESS | 17202 | UnknownError 22:59:52 INFO - TEST-INFO | 17202: exit 0 22:59:52 INFO - Browser initialized. 22:59:52 INFO - Running cycle 1/1 for dromaeo_css test... 22:59:52 INFO - TEST-INFO | started process 17282 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCE15uT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:00:04 INFO - PROCESS | 17282 | RSS: Main: 156626944 23:00:04 INFO - PROCESS | 17282 | 23:00:55 INFO - PROCESS | 17282 | 1465365655681 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] 23:03:03 INFO - PROCESS | 17282 | Cycle 1(1): loaded http://localhost:55087/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55087/tests/dromaeo/cssquery-ext.html) 23:03:04 INFO - PROCESS | 17282 | RSS: Main: 288440320 23:03:04 INFO - PROCESS | 17282 | 23:06:07 INFO - PROCESS | 17282 | Cycle 1(1): loaded http://localhost:55087/tests/dromaeo/cssquery-ext.html (next: http://localhost:55087/tests/dromaeo/cssquery-jquery.html) 23:06:07 INFO - PROCESS | 17282 | RSS: Main: 240582656 23:06:07 INFO - PROCESS | 17282 | 23:09:09 INFO - PROCESS | 17282 | Cycle 1(1): loaded http://localhost:55087/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55087/tests/dromaeo/cssquery-mootools.html) 23:09:10 INFO - PROCESS | 17282 | RSS: Main: 243404800 23:09:10 INFO - PROCESS | 17282 | 23:12:12 INFO - PROCESS | 17282 | Cycle 1(1): loaded http://localhost:55087/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55087/tests/dromaeo/cssquery-prototype.html) 23:12:13 INFO - PROCESS | 17282 | RSS: Main: 231596032 23:12:13 INFO - PROCESS | 17282 | 23:15:15 INFO - PROCESS | 17282 | Cycle 1(1): loaded http://localhost:55087/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55087/tests/dromaeo/cssquery-yui.html) 23:15:16 INFO - PROCESS | 17282 | RSS: Main: 220352512 23:15:16 INFO - PROCESS | 17282 | 23:18:18 INFO - PROCESS | 17282 | Cycle 1(1): loaded http://localhost:55087/tests/dromaeo/cssquery-yui.html (next: http://localhost:55087/tests/dromaeo/cssquery-dojo.html) 23:18:19 INFO - PROCESS | 17282 | RSS: Main: 274595840 23:18:19 INFO - PROCESS | 17282 | 23:18:19 INFO - PROCESS | 17282 | __start_tp_report 23:18:19 INFO - PROCESS | 17282 | _x_x_mozilla_page_load 23:18:19 INFO - PROCESS | 17282 | _x_x_mozilla_page_load_details 23:18:19 INFO - PROCESS | 17282 | |i|pagename|runs| 23:18:19 INFO - PROCESS | 17282 | |0;dojo.html;3122.921926951826;3137.670544592818;3169.8890538831147;3172.381385629803;3213.196700824794;5244.318238628983;5315.3887302960175;5329.067413202693;5395;5415.539679127274;5318.574514038877;5332.33345831771;5363.168708850125;5393.325834270716;5407.134858422653;4775.044991001805;4873.731944743037;4878.926816097762;4891.730954797485;5043.823466178685;4958.727270000149;4982.725950072744;5005.399352077756;5024.447310795827;5064.797408103672;4708.128996135709;4723.3859598252175;4853.563179313879;4890.8043678252825;4897.14299997499;4824.541668541483;4825;4846.684965477268;4900.901981960341;4958.578520825734;4833.63747718919;4865.416150062015;4874.975625121887;4879.072976134523;4903.485134060944;5198.376194856603;5228.686278823245;5301;5336.092864213093;5357.196420536911;5662.433756624346;5761.971190144064;5770.105633626795;5770.653760774325;5774.82675519735;5773.971130144364;5804.245448091763;5811.4479124483105;5816.156657284712;5820.970895145497;5184.533391994739;5281.551068159211;5321.467853214647;5321.574274058066;5347.385050719178;5906.645601263938;5908.940910590925;5912.3496415394275;5921.111833225051;5922.407759224043;5608.1587761835235;5677.290338707661;5679.062954612443;5681;5682.687452190169;5505.532029777433;5558.360788509373;5594.188842617879;5606.831795046155;5743.994800909824;5598.944010559842;5615.2700148980375;5616.494515493625;5619.522340601095;5622.690752008679;5569.47869759269;5610.97194514033;5618.157276408489;5622.8313150605545;5630.352509461464;4296.2696341621995;4324.221640104812;4335.197988372098;4371;4374.62815660666;3875.5736868944396;3880.4567360569545;3888.105735680809;3923.6272554107313;3929.31237033518;5203.973980130075;5336.573074154058;5339.652922560022;5348.812791552277;5349.839504814861;5731.083026715705;5743.62666426681;5783.59514833966;5813.069908814569;5814;5384.811531596375;5418.45815418455;5428.077226871442;5429.67421954684;5441.945580544223;4842.927356089662;4904.950950490449;4970.652054356233;4978.925316120261;5032.924506132411;5860.296764388216;5934.940650593525;5946.464818166386;5948.167256584082;5998.70006499682;5736.282964629421;5741.167530708108;5741.74162162712;5743.684097374685;5784.595078344475;5753.626014309057;5796.21751063601;5799.159121927381;5934.258217722785;5946.137810017437;5593.664380137205;5644.52021578154;5652.378238393856;5653.321601407857;5689.516391106802;5679;5679.9432005681065;5689.260396148474;5707.657540547414;5741.25363702716;5418.106012507892;5521.585881059017;5526.530244929226;5577.665340079446;5594.02104631696;5584.609077364546;5589.608727389043;5590.944090559043;5590.972045139911;5591.916121258103;5476.452354764491;5497.422770609189;5497.725113744376;5498.230247765396;5519.696416696959;5389.56883449331;5460.071787796163;5557.694326812064;5566.137248726453;5601.019821531134;5472.835814925558;5473.67157970523;5474.479924407175;5519.227308176778;5536.695481748381 23:18:19 INFO - PROCESS | 17282 | |1;ext.html;599.6252342286072;615.0835255469351;637.2384999925089;646.1083704487809;652.2499126005091;31234.375312493736;43666.12667746647;44296.55703442964;44307.55692443075;44355;44778.552214477844;45301;45358.31962520565;45390.319145212765;45465;8774.47353158811;8909.777255568597;8926.062763409846;8994.190522852941;8998.055204203563;8692.956535217316;8852.955735221314;8856.070112638177;8869.113088691143;8919.152680495376;8974.820503589925;8998.730038098867;9064.410813297147;9065.95467022664;9068.047854975232;8914.55427228636;8956.19394254517;8969.282457403391;8976.326775491863;8981.056989016124;8820.867686984637;8903.243224325875;8905.332100092519;8911.287097032222;8920.598573064228;42141.57858421407;42225.78887105575;42596.78701606472;42638.786806066084;42695;3307.7684562080663;3764;4086.5913408659194;4091.4272001919753;4237.512686041114;32091.679083209103;32420;32900.50649240263;32951.835240823646;34040.48939265913;4316.956830431687;4336.111097225062;4425;4458.3535387368975;4548.317752337143;356481;357762;358072;358078;361102;59492;59932;60197.699011504665;60225.397746022856;60236.096458553155;64305.678471607345;64330;64386.67806660937;64505.67747161234;64533.224011478116;17526.29894804219;17800.643987120184;17811.821881781274;17815.821841781675;17816.376426824998;13069.411876465581;13152.605421837361;13164.539241126515;13170.07809453329;13184;16552.586185345463;18300;18372.908135459238;18413.447596572125;18511;6358.205224346957;6583.802485925334;6654.900176497356;6711.899321510181;6715.294894036056;963.5182408795603;1038.8026275007724;1059.1412071813918;1061.840723891407;1141.0529260713588;32200.35599288048;32472.675273247438;32632;32682.83658581692;33102;1112.7718817642365;1141.5547936304847;1141.760230351619;1160.8955194032408;1168.5734706831945;16578.83421165797;16913.7462938056;16956.406525771537;17100.828991710172;17276.481705548853;542520;542551;544308;545604;551423;58549;58752.70623646854;58753.41246587565;58879.70560147172;58939.705301473216;1235;1279.174932168746;1334.6463187255579;1362.8364596248316;1409.4644035266533;30270.09206208022;33778.49332260067;33793.66206337905;34041.82979085089;34169.829150854086;51174.74412627913;51586;51588;51732.48267517427;51747;422703;431460;433841;434063;434286;35798.28403431969;36605;39448.40827387534;42171.57828421799;42509.36235956525;47467.762661186476;47832.76083619559;48048.27927581019;48179;48707.51292487171;37363.43954840734;41593.58406416018;41760;42502;43127;40617.673938093816;41159.7942010288;41378.793106034274;41422;41496.58503415048;40944;41368.79315603403;41492.79253603713;41808.58191418047;42485.787571063185;35891.64108358987;36447.81776091208;36969.10381693809;37450.438243426914;37461.81269093637;27618.585721213796;27974;28070.57894131549;28281.858590706914;28539.42921141607 23:18:19 INFO - PROCESS | 17282 | |2;jquery.html;359.5344029481821;383.601054902901;383.9635234652709;395.335835795863;414.7242084014131;16865.83134168658;18757.15592798324;18808.717869231972;19747.210111595556;19797.307094251704;17911.64176716465;18250.63498730028;18568.907155464203;18688.906555467205;19265.229390824352;5513.669179849202;5552.361478429982;5618.5786066045;5755.136729490589;5755.25181726375;5487.917681234785;5521.944780552183;5621.100623900177;5646.548276137899;5648.096304591266;5510.448955104497;5569.164625306196;5596.804111856086;5615.0454422748235;5660.518855897254;5470.507654311092;5533.889322213573;5573.554115670737;5579.497845193931;5593.3847276799515;4890.657653964224;4930.556249937487;4963;4963.305137280783;5249.212618107276;13663;13665.18008919458;18321.992290424023;21515.354539363845;21858.781412185992;2086.6765651324067;2125.6705210692367;2281.863088214712;2316.328264803205;2559.398541342783;9104.772380690469;9413;9657.082577155159;9929.851052234222;13342.33288335589;1719.3380548488797;1829.6706592813289;1835.2567210279858;1854.805245449222;1881.5578339090303;58967;65916.69291574771;77394.6130269345;80081.59959200225;80919.5954020232;10005.149562287286;10276;10361.378317300987;10569.101626361691;10678.466076696133;14606.707865842836;14638.707225855424;14663.120212787268;14693.926530367493;14771.778423323658;7741.18717534662;7747.186545412763;7844.4901081429525;8001.599920004093;8241.175882411711;7477.252274772479;7534.924650753423;7629.923700762922;7660.119086305035;7667.808304792425;4233.957660423418;4292.91414171721;4308.310670292738;4405.898525368658;4447.776861363151;1768.6285879965094;1769.7079981803115;1771.822817718218;1829.1220214297211;1858.8327050565515;951.5813042261383;988.3575675810637;1003.909648131657;1065.1638463805875;1114.0586204657052;18220.180091895898;18464.538386540444;18738.688291819442;19335.12991915339;19405.51486212856;899.8965119011267;999.9100080992746;1020.5611587017505;1039.428314427062;1093.8632670916136;9680.854787178198;10473.738156546147;10484.318519296221;10517.15862730995;10533.9473302633;513939;521314;525864;526731;560263;55880.441195587526;89912.5504372474;90768;90894.54552727194;90978;918.8805455290769;957.4207604399378;982.1013772398319;1003.9247056470793;1009.5911155981839;16450;17226.138693065546;17338.73991890148;17468.12659367052;17747.911260443616;40507.18985620212;40983.79508102559;41284.58715412807;41799.79100104602;42339;58709.41290587039;58918.116228255756;59447.40552594592;59675;59887;8245.670173193004;8458.196471335214;8554.27288680469;8662.956685216534;8756.168164024408;11902.166848320534;12759.872401275868;12880.227186368847;12949.352532373532;13026.153300035467;11104.888951110386;11330.94334528322;11379.203455758017;11506.424678766196;11687.474063666985;11315.151363647594;11334.716632084264;11448.198626096093;11773.175877688822;11830.231034982698;10876.347419154876;11195.720106997065;11418.486168122621;11597.710057248636;11694.824577631172;8017.690916969244;8130.552819594743;8316.085230624505;8538.78653033679;8582.914170858212;8785.956070219863;11485.19603627738;11567.826482602935;11576.536938522364;11613.6515904523 23:18:19 INFO - PROCESS | 17282 | |3;mootools.html;1335.799630055491;1480.7112613040458;1509.2680050175663;1649.5876030992251;1807.918643661035;8203.466774659642;8535.445196062252;8547.059823419426;8780.078091800366;8792.604332805024;8550.102239264881;8717;8728;8731.214190722834;8737;1969.724238606589;2258.9887050564807;2294.219965211832;2327.7323107842562;2332.4285550040263;2360.303710405426;2364.8344615876895;2367.360812580602;2368.100121953655;2368.384220102777;2273.033960566761;2295.162265772989;2302.355340504653;2303.9424014399606;2307.3078076577044;1926.9807301927012;2163.5348400094053;2214.534947660993;2223.2440970070093;2229.6321107017325;2236.1279101150562;2243.6089624432793;2264.977350226493;2267;2267.013848975701;8616;8676.089010653854;8696.217340439327;8705.129487051308;8718.346124040723;5141;5291.57667386612;5292.153255479144;5299.761510732026;5302.946970530284;3298.340331933599;3358.714509266691;3411.6588341165934;3417.5044618530424;3434.708049815769;1187.156759560847;1191.1126210972793;1191.7973944429468;1206.4510647655295;2060.1347434077725;12113.39433028354;12225.144239903211;12237;12257.080718946114;12258;4260.10537787062;4413.249747542925;4478.41780568524;4485.932711009337;4486.1924853526025;9428.387154834914;9544.761380965532;9559.856602150974;9560.139587437165;9560.61757529691;5055.848324550196;5057.241413787961;5058.861756104847;5062.772175252123;5068.41713202979;4116.526599441043;4566.383538222298;4671.743054131987;4683;4757.452892917358;3667.8349474273723;3745.138618117848;3793.1844653399653;3822.3884178531302;3867.690584753213;1116.413882711583;1135.4663308245113;1139.464451707696;1142.4230763464398;1154.6940060883871;925.6991477769752;1006.954687039085;1014.2291858187683;1025.3130402630256;1026.8921763214755;6004.189434426384;6171.197744293213;6192.133101365813;6216.222972128484;6264.59280146789;453.61216160183227;464.0996466854292;469.2445163287105;470.01297275720714;471.69339929046396;4240.575942405796;4300.892477688083;4329.978350108229;4334.544872788312;4345.239583072949;10554;10914.836277455686;10918.727031824268;10928.633920759905;10928.781424371467;10189.949050254849;10766.354018758899;10808.189385796097;10811.081058109992;10819.404932728776;7838.529688218725;8101.270885620204;8188.713395031145;8191.139930307351;8213.38399620031;5840.678762667924;6097.847553811191;6133.50931925436;6162.537809664203;6252.749890004349;9479.715608531755;9602.95198524003;9660.178884794872;9697.127258546765;9755.951220243853;10170.186385089028;10225.84661230097;10260.692179234635;10269.74325641865;10351.689449316533;6727.562708423937;6752.69612867432;7499.212582678741;7613.352865006315;7806.375489960676;8335.583220838813;8540.658373665232;8636.17956294151;8637.309015278888;8654.22112009922;7283.635818209174;7476.439267054884;7518.360939320219;7589.924100759143;7712.537247765152;7276.490645654753;7326.743563975236;7485;7539.924600753922;7697.461177717506;6895.689693963884;6930.7227710891;6981.0924579804305;6986.336298051677;6988.475864310299;5153.948460515347;5247.895042099213;5384.596155288447;5434.592405569519;5472.2065300531995;5130.79476820923;5172.767225474938;5181.1969144782615;5276.498732620395;5479.75341109659 23:18:19 INFO - PROCESS | 17282 | |4;prototype.html;318.6208411989732;319.8193020943167;324.62992188904667;328.1059113914583;329.711502435369;5149.974250128749;5229.7385130743405;5230.398504172012;5255.185446255827;5263.131583288758;5142.460041695625;5143.27994080829;5144.09978253806;5153;5154.201098829678;3888.2806680764147;3956.4856568646037;4063.8577649782114;4075.6157647776085;4105.60996705314;4038.6567141792984;4055.452513910614;4070.6946978976694;4074.816633251496;4090.713650044498;3906.8046597670004;4022.4167495713104;4055.371417430288;4056.9391459128137;4058.756474611518;3801.904952376213;3980.4228386883883;4019.41718450823;4061.79691015451;4084.9591504084874;3575.1955809942815;3581.3195492856535;3604.855805767766;3608.4226523756074;3615.349237137314;4984.800607975677;5004.8999020019755;5016.949830501721;5024.899502009976;5041.395032596112;4512.774361281923;4624.884377890546;4633.189191891439;4650.674452788307;4656.32483289921;5347.839564813062;5384.0847056000575;5397.46025397461;5402.676848954948;5416.431274716177;3938.1729836734035;3944.4872166618443;3951.1429628074757;3953.8418463261437;3973.1457736586485;5454.563634909237;5575.1915972184215;5602.411746766612;5642.915356269659;5711.286089238845;3993;4009.7393669411395;4018.83924643011;4023.6177563131455;4025.7181997260495;4033.3344998075577;4047.5142982841658;4071.450354202204;4082.387641853686;4082.8366865325647;4518.796654150571;4620.584147426748;4641.443026836733;4641.698289611165;4645.442546894326;5459.590530710133;5464.535514481314;5473.343198816167;5481.397046324901;5482.972585137049;1383.5157694806737;1405.5361730628867;1424.8601119104674;1429.5425463851675;1435.7200345932652;883.4586466165388;919.7378747057056;920.6466494253436;921.6267761036008;929.8140371925642;5142.588592912558;5317;5318.44156363584;5325.201219816981;5347.385050719139;5644.6613203207935;5644.915326270027;5656.953463609246;5667.829965101054;5685.800996965087;5053.469385714447;5132.30713853625;5298.178782288752;5305.257263983045;5322.494363035506;2967.812874850034;2986.2683642507723;2990.1179152150166;2994.835284059354;3016.6380034395575;5797.710114494258;5807.796727114531;5817.76728930838;5832.504237139806;5852.8536786579825;5529.0324193266015;5737.254156959569;5764.884702305931;5772.037507247556;5780.265920224;5747.885042299215;5797.188393624896;5798.246227990334;5817.418258174149;5854.4730974212525;5387.676739395649;5646.71766411686;5654.971725141348;5655.830325090254;5688.971555142363;5572.4148964358155;5590.608657393944;5617.410171931889;5620.8875822482505;5628.718564071698;5856.297244330707;5860.120981852756;5863.62204881861;5888.970555147197;5889.793857215148;3902.687784977252;4058.8782336529953;4060.675145988373;4063.2279866826393;4069.7354671946227;5608.663480191201;5614.7192640367;5633.605647604629;5653.180288858175;5666.405027472221;5514.338279406336;5516.668999860021;5544.750486228048;5559.58303127259;5566.554675625859;5314.601404894725;5399.433059528693;5456.727163641882;5471.753771080391;5494.615376923577;5193.662411943212;5367.1680889462195;5386.59600529954;5396.83809485716;5420.8644783879145;5316.8936621266585;5526;5546.805861794818;5562.2490963721;5573.801632649;5279.841604751864;5377.300950876361;5384.407715151252;5395.919061214006;5422 23:18:19 INFO - PROCESS | 17282 | |5;yui.html;654.1071437487827;659.3176062775023;750.9887351689725;805.4563169860344;829.9709510167145;13397.665058373534;13433.865661343383;13446.596602101929;13450.798238026437;14931.328090235938;14435.494757683484;14741.778873316882;14745.852541474582;14748.483803066894;14762.409503619869;799.3525244551903;808.9716859909904;813.3411936331561;813.5037627047496;813.5484805932705;682.5324652612951;784.5136015670264;800.4196957206037;814.6944895664126;817.9836403271931;853.4665833853842;857.1985193843744;857.6055014693248;858.5664239559014;859.0893652728129;851.93610479214;853.0658928473374;853.2960307746104;854.6196942360652;854.7649396415973;500.5120007992215;510.98722531936625;517.2938938349126;613.3069631316629;617.8671585609071;12526.561570345086;12574.679658635803;12580.81128783069;12595.937020314932;12613.180143290656;12565.434555445026;12949;13024.218546887123;13110.934445327808;13575.321233938363;11628.622164022909;11749.118816088741;11838.171328007043;11970.102242331774;12209.877901221053;4284.807183676711;4304.978475107636;4338.58783415575;4408.823647054146;4516.683832131752;64384;64821.67589162071;65157.67421162911;69872.3012769876;69898.3010169902;10218.335808172593;10494.265401421828;10835.729106772395;10850.945745271223;10951.726206844893;19492.902535487232;20729.0671919764;20797.272095476586;20802.58394832095;20804;7506.13679426862;7507.51201171933;7611.771646850603;7692.19231980634;7805.33654639362;4517.141743068806;4587.472440669299;4606.654500912445;4609.193391156601;4624.329472226508;3274.705276525124;3339.833008349621;3344.2141096842224;3361.8991430257133;3365.899023029313;573.7131434282859;581.528961541153;597.1132867691475;598.9700514974321;600.6126048698565;680.8944613584903;695.9547629404072;769.61134627013;796.307212724933;802.9959850200712;9718.902810971942;10047.24645651579;10109.29234953561;10147.289689721796;10150.644727434652;550.3890681343705;592.8577141486098;668.238208442376;717.7057406463325;750.1748077115238;4542.182407166676;4730.810767569259;4787.521247875255;4794.2808578713475;4901.607871370282;106457;107415;107526;112748.43625781819;115901;60038;66714.66642666853;75943.24056759362;83399.58300208581;97828.51085744526;81972;88981.55509222412;89257;92180;92443.53778231065;9541.284403669613;9739.853902191331;9789.85315220258;9903.158231550398;10169.135623472088;49982.001799821184;50309.49690503195;51013.744931275105;52182.21726674179;53309.46690533045;44295.77852110719;74965;75544;76795.2320476788;77255.34308211473;12352.254705407018;13532.17315662373;13538;13722.65693357674;14495;13391;13925.582232533041;14317;14519.78220326717;14724.79128130789;12785.232886026868;12916.547920822726;13028.088033837541;13182.143160694524;13332.2667253302;13530.18818870871;13781.379837907118;13824.516141934984;13858.861411385757;14349.784753228501;12861.099723019299;12941.805872912102;13012.609621711365;13196.208227505997;13351.799723004357;9250.612408138833;9765.951170244103;9805.264605154785;9946.602135914482;10010.699679009642;9315.25477961775;9520.917544453394;9628.807423851344;9749.463779492196;9871.210303175872 23:18:19 INFO - PROCESS | 17282 | __end_tp_report 23:18:19 INFO - PROCESS | 17282 | __start_cc_report 23:18:19 INFO - PROCESS | 17282 | _x_x_mozilla_cycle_collect,1168 23:18:19 INFO - PROCESS | 17282 | __end_cc_report 23:18:19 INFO - PROCESS | 17282 | __startTimestamp1465366699241__endTimestamp 23:18:19 INFO - PROCESS | 17282 | 23:18:19 INFO - PROCESS | 17282 | ------- Summary: start ------- 23:18:19 INFO - PROCESS | 17282 | Number of tests: 6 23:18:19 INFO - PROCESS | 17282 | 23:18:19 INFO - PROCESS | 17282 | [#0] dojo.html Cycles:165 Average:5304.92 Median:5497.42 stddev:590.78 (10.7%) stddev-sans-first:567.26 23:18:19 INFO - PROCESS | 17282 | Values: 3122.9 3137.7 3169.9 3172.4 3213.2 5244.3 5315.4 5329.1 5395.0 5415.5 5318.6 5332.3 5363.2 5393.3 5407.1 4775.0 4873.7 4878.9 4891.7 5043.8 4958.7 4982.7 5005.4 5024.4 5064.8 4708.1 4723.4 4853.6 4890.8 4897.1 4824.5 4825.0 4846.7 4900.9 4958.6 4833.6 4865.4 4875.0 4879.1 4903.5 5198.4 5228.7 5301.0 5336.1 5357.2 5662.4 5762.0 5770.1 5770.7 5774.8 5774.0 5804.2 5811.4 5816.2 5821.0 5184.5 5281.6 5321.5 5321.6 5347.4 5906.6 5908.9 5912.3 5921.1 5922.4 5608.2 5677.3 5679.1 5681.0 5682.7 5505.5 5558.4 5594.2 5606.8 5744.0 5598.9 5615.3 5616.5 5619.5 5622.7 5569.5 5611.0 5618.2 5622.8 5630.4 4296.3 4324.2 4335.2 4371.0 4374.6 3875.6 3880.5 3888.1 3923.6 3929.3 5204.0 5336.6 5339.7 5348.8 5349.8 5731.1 5743.6 5783.6 5813.1 5814.0 5384.8 5418.5 5428.1 5429.7 5441.9 4842.9 4905.0 4970.7 4978.9 5032.9 5860.3 5934.9 5946.5 5948.2 5998.7 5736.3 5741.2 5741.7 5743.7 5784.6 5753.6 5796.2 5799.2 5934.3 5946.1 5593.7 5644.5 5652.4 5653.3 5689.5 5679.0 5679.9 5689.3 5707.7 5741.3 5418.1 5521.6 5526.5 5577.7 5594.0 5584.6 5589.6 5590.9 5591.0 5591.9 5476.5 5497.4 5497.7 5498.2 5519.7 5389.6 5460.1 5557.7 5566.1 5601.0 5472.8 5473.7 5474.5 5519.2 5536.7 23:18:19 INFO - PROCESS | 17282 | 23:18:19 INFO - PROCESS | 17282 | [#1] ext.html Cycles:180 Average:61212.02 Median:42505.68 stddev:119624.64 (281.4%) stddev-sans-first:119873.65 23:18:19 INFO - PROCESS | 17282 | Values: 599.6 615.1 637.2 646.1 652.2 31234.4 43666.1 44296.6 44307.6 44355.0 44778.6 45301.0 45358.3 45390.3 45465.0 8774.5 8909.8 8926.1 8994.2 8998.1 8693.0 8853.0 8856.1 8869.1 8919.2 8974.8 8998.7 9064.4 9066.0 9068.0 8914.6 8956.2 8969.3 8976.3 8981.1 8820.9 8903.2 8905.3 8911.3 8920.6 42141.6 42225.8 42596.8 42638.8 42695.0 3307.8 3764.0 4086.6 4091.4 4237.5 32091.7 32420.0 32900.5 32951.8 34040.5 4317.0 4336.1 4425.0 4458.4 4548.3 356481.0 357762.0 358072.0 358078.0 361102.0 59492.0 59932.0 60197.7 60225.4 60236.1 64305.7 64330.0 64386.7 64505.7 64533.2 17526.3 17800.6 17811.8 17815.8 17816.4 13069.4 13152.6 13164.5 13170.1 13184.0 16552.6 18300.0 18372.9 18413.4 18511.0 6358.2 6583.8 6654.9 6711.9 6715.3 963.5 1038.8 1059.1 1061.8 1141.1 32200.4 32472.7 32632.0 32682.8 33102.0 1112.8 1141.6 1141.8 1160.9 1168.6 16578.8 16913.7 16956.4 17100.8 17276.5 542520.0 542551.0 544308.0 545604.0 551423.0 58549.0 58752.7 58753.4 58879.7 58939.7 1235.0 1279.2 1334.6 1362.8 1409.5 30270.1 33778.5 33793.7 34041.8 34169.8 51174.7 51586.0 51588.0 51732.5 51747.0 422703.0 431460.0 433841.0 434063.0 434286.0 35798.3 36605.0 39448.4 42171.6 42509.4 47467.8 47832.8 48048.3 48179.0 48707.5 37363.4 41593.6 41760.0 42502.0 43127.0 40617.7 41159.8 41378.8 41422.0 41496.6 40944.0 41368.8 41492.8 41808.6 42485.8 35891.6 36447.8 36969.1 37450.4 37461.8 27618.6 27974.0 28070.6 28281.9 28539.4 23:18:19 INFO - PROCESS | 17282 | 23:18:19 INFO - PROCESS | 17282 | [#2] jquery.html Cycles:180 Average:29303.84 Median:20451.26 stddev:86999.52 (425.4%) stddev-sans-first:87216.43 23:18:19 INFO - PROCESS | 17282 | Values: 359.5 383.6 384.0 395.3 414.7 16865.8 18757.2 18808.7 19747.2 19797.3 17911.6 18250.6 18568.9 18688.9 19265.2 5513.7 5552.4 5618.6 5755.1 5755.3 5487.9 5521.9 5621.1 5646.5 5648.1 5510.4 5569.2 5596.8 5615.0 5660.5 5470.5 5533.9 5573.6 5579.5 5593.4 4890.7 4930.6 4963.0 4963.3 5249.2 13663.0 13665.2 18322.0 21515.4 21858.8 2086.7 2125.7 2281.9 2316.3 2559.4 9104.8 9413.0 9657.1 9929.9 13342.3 1719.3 1829.7 1835.3 1854.8 1881.6 58967.0 65916.7 77394.6 80081.6 80919.6 10005.1 10276.0 10361.4 10569.1 10678.5 14606.7 14638.7 14663.1 14693.9 14771.8 7741.2 7747.2 7844.5 8001.6 8241.2 7477.3 7534.9 7629.9 7660.1 7667.8 4234.0 4292.9 4308.3 4405.9 4447.8 1768.6 1769.7 1771.8 1829.1 1858.8 951.6 988.4 1003.9 1065.2 1114.1 18220.2 18464.5 18738.7 19335.1 19405.5 899.9 999.9 1020.6 1039.4 1093.9 9680.9 10473.7 10484.3 10517.2 10533.9 513939.0 521314.0 525864.0 526731.0 560263.0 55880.4 89912.6 90768.0 90894.5 90978.0 918.9 957.4 982.1 1003.9 1009.6 16450.0 17226.1 17338.7 17468.1 17747.9 40507.2 40983.8 41284.6 41799.8 42339.0 58709.4 58918.1 59447.4 59675.0 59887.0 8245.7 8458.2 8554.3 8663.0 8756.2 11902.2 12759.9 12880.2 12949.4 13026.2 11104.9 11330.9 11379.2 11506.4 11687.5 11315.2 11334.7 11448.2 11773.2 11830.2 10876.3 11195.7 11418.5 11597.7 11694.8 8017.7 8130.6 8316.1 8538.8 8582.9 8786.0 11485.2 11567.8 11576.5 11613.7 23:18:19 INFO - PROCESS | 17282 | 23:18:19 INFO - PROCESS | 17282 | [#3] mootools.html Cycles:180 Average:5707.62 Median:469.63 stddev:3243.62 (690.7%) stddev-sans-first:3236.08 23:18:19 INFO - PROCESS | 17282 | Values: 1335.8 1480.7 1509.3 1649.6 1807.9 8203.5 8535.4 8547.1 8780.1 8792.6 8550.1 8717.0 8728.0 8731.2 8737.0 1969.7 2259.0 2294.2 2327.7 2332.4 2360.3 2364.8 2367.4 2368.1 2368.4 2273.0 2295.2 2302.4 2303.9 2307.3 1927.0 2163.5 2214.5 2223.2 2229.6 2236.1 2243.6 2265.0 2267.0 2267.0 8616.0 8676.1 8696.2 8705.1 8718.3 5141.0 5291.6 5292.2 5299.8 5302.9 3298.3 3358.7 3411.7 3417.5 3434.7 1187.2 1191.1 1191.8 1206.5 2060.1 12113.4 12225.1 12237.0 12257.1 12258.0 4260.1 4413.2 4478.4 4485.9 4486.2 9428.4 9544.8 9559.9 9560.1 9560.6 5055.8 5057.2 5058.9 5062.8 5068.4 4116.5 4566.4 4671.7 4683.0 4757.5 3667.8 3745.1 3793.2 3822.4 3867.7 1116.4 1135.5 1139.5 1142.4 1154.7 925.7 1007.0 1014.2 1025.3 1026.9 6004.2 6171.2 6192.1 6216.2 6264.6 453.6 464.1 469.2 470.0 471.7 4240.6 4300.9 4330.0 4334.5 4345.2 10554.0 10914.8 10918.7 10928.6 10928.8 10189.9 10766.4 10808.2 10811.1 10819.4 7838.5 8101.3 8188.7 8191.1 8213.4 5840.7 6097.8 6133.5 6162.5 6252.7 9479.7 9603.0 9660.2 9697.1 9756.0 10170.2 10225.8 10260.7 10269.7 10351.7 6727.6 6752.7 7499.2 7613.4 7806.4 8335.6 8540.7 8636.2 8637.3 8654.2 7283.6 7476.4 7518.4 7589.9 7712.5 7276.5 7326.7 7485.0 7539.9 7697.5 6895.7 6930.7 6981.1 6986.3 6988.5 5153.9 5247.9 5384.6 5434.6 5472.2 5130.8 5172.8 5181.2 5276.5 5479.8 23:18:19 INFO - PROCESS | 17282 | 23:18:19 INFO - PROCESS | 17282 | [#4] prototype.html Cycles:180 Average:4608.50 Median:5301.72 stddev:1358.69 (25.6%) stddev-sans-first:1323.80 23:18:19 INFO - PROCESS | 17282 | Values: 318.6 319.8 324.6 328.1 329.7 5150.0 5229.7 5230.4 5255.2 5263.1 5142.5 5143.3 5144.1 5153.0 5154.2 3888.3 3956.5 4063.9 4075.6 4105.6 4038.7 4055.5 4070.7 4074.8 4090.7 3906.8 4022.4 4055.4 4056.9 4058.8 3801.9 3980.4 4019.4 4061.8 4085.0 3575.2 3581.3 3604.9 3608.4 3615.3 4984.8 5004.9 5016.9 5024.9 5041.4 4512.8 4624.9 4633.2 4650.7 4656.3 5347.8 5384.1 5397.5 5402.7 5416.4 3938.2 3944.5 3951.1 3953.8 3973.1 5454.6 5575.2 5602.4 5642.9 5711.3 3993.0 4009.7 4018.8 4023.6 4025.7 4033.3 4047.5 4071.5 4082.4 4082.8 4518.8 4620.6 4641.4 4641.7 4645.4 5459.6 5464.5 5473.3 5481.4 5483.0 1383.5 1405.5 1424.9 1429.5 1435.7 883.5 919.7 920.6 921.6 929.8 5142.6 5317.0 5318.4 5325.2 5347.4 5644.7 5644.9 5657.0 5667.8 5685.8 5053.5 5132.3 5298.2 5305.3 5322.5 2967.8 2986.3 2990.1 2994.8 3016.6 5797.7 5807.8 5817.8 5832.5 5852.9 5529.0 5737.3 5764.9 5772.0 5780.3 5747.9 5797.2 5798.2 5817.4 5854.5 5387.7 5646.7 5655.0 5655.8 5689.0 5572.4 5590.6 5617.4 5620.9 5628.7 5856.3 5860.1 5863.6 5889.0 5889.8 3902.7 4058.9 4060.7 4063.2 4069.7 5608.7 5614.7 5633.6 5653.2 5666.4 5514.3 5516.7 5544.8 5559.6 5566.6 5314.6 5399.4 5456.7 5471.8 5494.6 5193.7 5367.2 5386.6 5396.8 5420.9 5316.9 5526.0 5546.8 5562.2 5573.8 5279.8 5377.3 5384.4 5395.9 5422.0 23:18:19 INFO - PROCESS | 17282 | 23:18:19 INFO - PROCESS | 17282 | [#5] yui.html Cycles:180 Average:19417.39 Median:4847.94 stddev:27732.78 (572.1%) stddev-sans-first:27774.79 23:18:19 INFO - PROCESS | 17282 | Values: 654.1 659.3 751.0 805.5 830.0 13397.7 13433.9 13446.6 13450.8 14931.3 14435.5 14741.8 14745.9 14748.5 14762.4 799.4 809.0 813.3 813.5 813.5 682.5 784.5 800.4 814.7 818.0 853.5 857.2 857.6 858.6 859.1 851.9 853.1 853.3 854.6 854.8 500.5 511.0 517.3 613.3 617.9 12526.6 12574.7 12580.8 12595.9 12613.2 12565.4 12949.0 13024.2 13110.9 13575.3 11628.6 11749.1 11838.2 11970.1 12209.9 4284.8 4305.0 4338.6 4408.8 4516.7 64384.0 64821.7 65157.7 69872.3 69898.3 10218.3 10494.3 10835.7 10850.9 10951.7 19492.9 20729.1 20797.3 20802.6 20804.0 7506.1 7507.5 7611.8 7692.2 7805.3 4517.1 4587.5 4606.7 4609.2 4624.3 3274.7 3339.8 3344.2 3361.9 3365.9 573.7 581.5 597.1 599.0 600.6 680.9 696.0 769.6 796.3 803.0 9718.9 10047.2 10109.3 10147.3 10150.6 550.4 592.9 668.2 717.7 750.2 4542.2 4730.8 4787.5 4794.3 4901.6 106457.0 107415.0 107526.0 112748.4 115901.0 60038.0 66714.7 75943.2 83399.6 97828.5 81972.0 88981.6 89257.0 92180.0 92443.5 9541.3 9739.9 9789.9 9903.2 10169.1 49982.0 50309.5 51013.7 52182.2 53309.5 44295.8 74965.0 75544.0 76795.2 77255.3 12352.3 13532.2 13538.0 13722.7 14495.0 13391.0 13925.6 14317.0 14519.8 14724.8 12785.2 12916.5 13028.1 13182.1 13332.3 13530.2 13781.4 13824.5 13858.9 14349.8 12861.1 12941.8 13012.6 13196.2 13351.8 9250.6 9766.0 9805.3 9946.6 10010.7 9315.3 9520.9 9628.8 9749.5 9871.2 23:18:19 INFO - PROCESS | 17282 | -------- Summary: end -------- 23:18:19 INFO - PROCESS | 17282 | 23:18:19 INFO - TEST-INFO | 17282: exit 0 23:18:19 INFO - TEST-OK | dromaeo_css | took 1113449ms 23:18:19 INFO - TEST-START | kraken 23:18:19 INFO - operating with platform_type : linux_ 23:18:19 INFO - Initialising browser for kraken test... 23:18:19 INFO - TEST-INFO | started process 17473 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHDxmoM/profile http://localhost:55087/getInfo.html) 23:18:23 INFO - PROCESS | 17473 | __metrics Screen width/height:1600/1200 23:18:23 INFO - PROCESS | 17473 | colorDepth:24 23:18:23 INFO - PROCESS | 17473 | Browser inner width/height: 1024/697 23:18:23 INFO - PROCESS | 17473 | __metrics 23:18:24 ERROR - PROCESS | 17473 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:18:25 INFO - PROCESS | 17473 | console.error: PushService: 23:18:25 INFO - PROCESS | 17473 | stateChangeProcessEnqueue: Error transitioning state 23:18:25 INFO - PROCESS | 17473 | UnknownError 23:18:25 INFO - TEST-INFO | 17473: exit 0 23:18:25 INFO - Browser initialized. 23:18:25 INFO - Running cycle 1/1 for kraken test... 23:18:25 INFO - TEST-INFO | started process 17557 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHDxmoM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:18:37 INFO - PROCESS | 17557 | RSS: Main: 156332032 23:18:37 INFO - PROCESS | 17557 | 23:18:40 INFO - PROCESS | 17557 | Cycle 1(1): loaded http://localhost:55087/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55087/tests/kraken/driver.html?testName=audio-beat-detection) 23:18:40 INFO - PROCESS | 17557 | RSS: Main: 215027712 23:18:40 INFO - PROCESS | 17557 | 23:18:43 INFO - PROCESS | 17557 | Cycle 1(1): loaded http://localhost:55087/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55087/tests/kraken/driver.html?testName=audio-dft) 23:18:44 INFO - PROCESS | 17557 | RSS: Main: 202948608 23:18:44 INFO - PROCESS | 17557 | 23:18:47 INFO - PROCESS | 17557 | Cycle 1(1): loaded http://localhost:55087/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55087/tests/kraken/driver.html?testName=audio-fft) 23:18:48 INFO - PROCESS | 17557 | RSS: Main: 268861440 23:18:48 INFO - PROCESS | 17557 | 23:18:50 INFO - PROCESS | 17557 | Cycle 1(1): loaded http://localhost:55087/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55087/tests/kraken/driver.html?testName=audio-oscillator) 23:18:50 INFO - PROCESS | 17557 | RSS: Main: 178913280 23:18:50 INFO - PROCESS | 17557 | 23:18:52 INFO - PROCESS | 17557 | Cycle 1(1): loaded http://localhost:55087/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55087/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:18:53 INFO - PROCESS | 17557 | RSS: Main: 183398400 23:18:53 INFO - PROCESS | 17557 | 23:18:56 INFO - PROCESS | 17557 | Cycle 1(1): loaded http://localhost:55087/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55087/tests/kraken/driver.html?testName=imaging-darkroom) 23:18:57 INFO - PROCESS | 17557 | RSS: Main: 218234880 23:18:57 INFO - PROCESS | 17557 | 23:19:00 INFO - PROCESS | 17557 | Cycle 1(1): loaded http://localhost:55087/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55087/tests/kraken/driver.html?testName=imaging-desaturate) 23:19:00 INFO - PROCESS | 17557 | RSS: Main: 219893760 23:19:00 INFO - PROCESS | 17557 | 23:19:03 INFO - PROCESS | 17557 | Cycle 1(1): loaded http://localhost:55087/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55087/tests/kraken/driver.html?testName=json-parse-financial) 23:19:04 INFO - PROCESS | 17557 | RSS: Main: 220135424 23:19:04 INFO - PROCESS | 17557 | 23:19:05 INFO - PROCESS | 17557 | Cycle 1(1): loaded http://localhost:55087/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55087/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:19:06 INFO - PROCESS | 17557 | RSS: Main: 207863808 23:19:06 INFO - PROCESS | 17557 | 23:19:08 INFO - PROCESS | 17557 | Cycle 1(1): loaded http://localhost:55087/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55087/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:19:08 INFO - PROCESS | 17557 | RSS: Main: 209960960 23:19:08 INFO - PROCESS | 17557 | 23:19:10 INFO - PROCESS | 17557 | Cycle 1(1): loaded http://localhost:55087/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55087/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:19:11 INFO - PROCESS | 17557 | RSS: Main: 216100864 23:19:11 INFO - PROCESS | 17557 | 23:19:14 INFO - PROCESS | 17557 | Cycle 1(1): loaded http://localhost:55087/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55087/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:19:14 INFO - PROCESS | 17557 | RSS: Main: 221458432 23:19:14 INFO - PROCESS | 17557 | 23:19:17 INFO - PROCESS | 17557 | Cycle 1(1): loaded http://localhost:55087/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55087/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:19:18 INFO - PROCESS | 17557 | RSS: Main: 221896704 23:19:18 INFO - PROCESS | 17557 | 23:19:19 INFO - PROCESS | 17557 | Cycle 1(1): loaded http://localhost:55087/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55087/tests/kraken/driver.html?testName=ai-astar) 23:19:19 INFO - PROCESS | 17557 | RSS: Main: 265191424 23:19:19 INFO - PROCESS | 17557 | 23:19:19 INFO - PROCESS | 17557 | __start_tp_report 23:19:19 INFO - PROCESS | 17557 | _x_x_mozilla_page_load 23:19:19 INFO - PROCESS | 17557 | _x_x_mozilla_page_load_details 23:19:19 INFO - PROCESS | 17557 | |i|pagename|runs| 23:19:19 INFO - PROCESS | 17557 | |0;ai-astar;112;106;111;112;111;110;112;111;110;110 23:19:19 INFO - PROCESS | 17557 | |1;audio-beat-detection;149;133;127;175;127;132;151;130;159;133 23:19:19 INFO - PROCESS | 17557 | |2;audio-dft;160;160;159;163;160;159;160;160;161;161 23:19:19 INFO - PROCESS | 17557 | |3;audio-fft;74;76;76;136;75;75;75;74;98;75 23:19:19 INFO - PROCESS | 17557 | |4;audio-oscillator;85;84;117;85;85;86;116;85;84;128 23:19:19 INFO - PROCESS | 17557 | |5;imaging-gaussian-blur;116;117;117;118;116;116;117;117;117;117 23:19:19 INFO - PROCESS | 17557 | |6;imaging-darkroom;145;145;145;145;145;145;145;145;145;144 23:19:19 INFO - PROCESS | 17557 | |7;imaging-desaturate;95;95;96;94;95;95;94;95;95;95 23:19:19 INFO - PROCESS | 17557 | |8;json-parse-financial;54;52;51;59;52;52;53;53;52;51 23:19:19 INFO - PROCESS | 17557 | |9;json-stringify-tinderbox;62;64;64;64;64;62;63;63;63;64 23:19:19 INFO - PROCESS | 17557 | |10;stanford-crypto-aes;79;82;80;86;81;80;87;80;109;80 23:19:19 INFO - PROCESS | 17557 | |11;stanford-crypto-ccm;126;131;123;120;119;119;120;121;124;134 23:19:19 INFO - PROCESS | 17557 | |12;stanford-crypto-pbkdf2;171;158;164;160;161;158;158;160;156;162 23:19:19 INFO - PROCESS | 17557 | |13;stanford-crypto-sha256-iterative;63;64;63;63;63;68;63;62;62;65 23:19:19 INFO - PROCESS | 17557 | __end_tp_report 23:19:19 INFO - PROCESS | 17557 | __start_cc_report 23:19:19 INFO - PROCESS | 17557 | _x_x_mozilla_cycle_collect,1619 23:19:19 INFO - PROCESS | 17557 | __end_cc_report 23:19:19 INFO - PROCESS | 17557 | __startTimestamp1465366759959__endTimestamp 23:19:19 INFO - PROCESS | 17557 | 23:19:19 INFO - PROCESS | 17557 | ------- Summary: start ------- 23:19:19 INFO - PROCESS | 17557 | Number of tests: 14 23:19:19 INFO - PROCESS | 17557 | 23:19:19 INFO - PROCESS | 17557 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:1.78 (1.6%) stddev-sans-first:1.80 23:19:19 INFO - PROCESS | 17557 | Values: 112.0 106.0 111.0 112.0 111.0 110.0 112.0 111.0 110.0 110.0 23:19:19 INFO - PROCESS | 17557 | 23:19:19 INFO - PROCESS | 17557 | [#1] audio-beat-detection Cycles:10 Average:141.60 Median:141.00 stddev:16.20 (11.5%) stddev-sans-first:16.96 23:19:19 INFO - PROCESS | 17557 | Values: 149.0 133.0 127.0 175.0 127.0 132.0 151.0 130.0 159.0 133.0 23:19:19 INFO - PROCESS | 17557 | 23:19:19 INFO - PROCESS | 17557 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.00 stddev:1.16 (0.7%) stddev-sans-first:1.22 23:19:19 INFO - PROCESS | 17557 | Values: 160.0 160.0 159.0 163.0 160.0 159.0 160.0 160.0 161.0 161.0 23:19:19 INFO - PROCESS | 17557 | 23:19:19 INFO - PROCESS | 17557 | [#3] audio-fft Cycles:10 Average:83.40 Median:75.00 stddev:19.86 (26.5%) stddev-sans-first:20.77 23:19:19 INFO - PROCESS | 17557 | Values: 74.0 76.0 76.0 136.0 75.0 75.0 75.0 74.0 98.0 75.0 23:19:19 INFO - PROCESS | 17557 | 23:19:19 INFO - PROCESS | 17557 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:85.00 stddev:17.43 (20.5%) stddev-sans-first:18.07 23:19:19 INFO - PROCESS | 17557 | Values: 85.0 84.0 117.0 85.0 85.0 86.0 116.0 85.0 84.0 128.0 23:19:19 INFO - PROCESS | 17557 | 23:19:19 INFO - PROCESS | 17557 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 23:19:19 INFO - PROCESS | 17557 | Values: 116.0 117.0 117.0 118.0 116.0 116.0 117.0 117.0 117.0 117.0 23:19:19 INFO - PROCESS | 17557 | 23:19:19 INFO - PROCESS | 17557 | [#6] imaging-darkroom Cycles:10 Average:144.90 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 23:19:19 INFO - PROCESS | 17557 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 144.0 23:19:19 INFO - PROCESS | 17557 | 23:19:19 INFO - PROCESS | 17557 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 23:19:19 INFO - PROCESS | 17557 | Values: 95.0 95.0 96.0 94.0 95.0 95.0 94.0 95.0 95.0 95.0 23:19:19 INFO - PROCESS | 17557 | 23:19:19 INFO - PROCESS | 17557 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:52.50 stddev:2.33 (4.4%) stddev-sans-first:2.44 23:19:19 INFO - PROCESS | 17557 | Values: 54.0 52.0 51.0 59.0 52.0 52.0 53.0 53.0 52.0 51.0 23:19:19 INFO - PROCESS | 17557 | 23:19:19 INFO - PROCESS | 17557 | [#9] json-stringify-tinderbox Cycles:10 Average:63.30 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.73 23:19:19 INFO - PROCESS | 17557 | Values: 62.0 64.0 64.0 64.0 64.0 62.0 63.0 63.0 63.0 64.0 23:19:19 INFO - PROCESS | 17557 | 23:19:19 INFO - PROCESS | 17557 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:80.50 stddev:9.06 (11.3%) stddev-sans-first:9.39 23:19:19 INFO - PROCESS | 17557 | Values: 79.0 82.0 80.0 86.0 81.0 80.0 87.0 80.0 109.0 80.0 23:19:19 INFO - PROCESS | 17557 | 23:19:19 INFO - PROCESS | 17557 | [#11] stanford-crypto-ccm Cycles:10 Average:123.70 Median:123.50 stddev:5.21 (4.2%) stddev-sans-first:5.46 23:19:19 INFO - PROCESS | 17557 | Values: 126.0 131.0 123.0 120.0 119.0 119.0 120.0 121.0 124.0 134.0 23:19:19 INFO - PROCESS | 17557 | 23:19:19 INFO - PROCESS | 17557 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.80 Median:160.50 stddev:4.26 (2.7%) stddev-sans-first:2.45 23:19:19 INFO - PROCESS | 17557 | Values: 171.0 158.0 164.0 160.0 161.0 158.0 158.0 160.0 156.0 162.0 23:19:19 INFO - PROCESS | 17557 | 23:19:19 INFO - PROCESS | 17557 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:63.00 stddev:1.78 (2.8%) stddev-sans-first:1.87 23:19:19 INFO - PROCESS | 17557 | Values: 63.0 64.0 63.0 63.0 63.0 68.0 63.0 62.0 62.0 65.0 23:19:19 INFO - PROCESS | 17557 | -------- Summary: end -------- 23:19:19 INFO - PROCESS | 17557 | 23:19:20 INFO - TEST-INFO | 17557: exit 0 23:19:20 INFO - TEST-OK | kraken | took 60896ms 23:19:20 INFO - SUITE-END | took 1174s 23:19:21 INFO - Completed test suite (00:19:34) 23:19:21 INFO - javascript benchmark 23:19:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3122.921926951826, 3137.670544592818, 3169.8890538831147, 3172.381385629803, 3213.196700824794, 5244.318238628983, 5315.3887302960175, 5329.067413202693, 5395.0, 5415.539679127274, 5318.574514038877, 5332.33345831771, 5363.168708850125, 5393.325834270716, 5407.134858422653, 4775.044991001805, 4873.731944743037, 4878.926816097762, 4891.730954797485, 5043.823466178685, 4958.727270000149, 4982.725950072744, 5005.399352077756, 5024.447310795827, 5064.797408103672, 4708.128996135709, 4723.3859598252175, 4853.563179313879, 4890.8043678252825, 4897.14299997499, 4824.541668541483, 4825.0, 4846.684965477268, 4900.901981960341, 4958.578520825734, 4833.63747718919, 4865.416150062015, 4874.975625121887, 4879.072976134523, 4903.485134060944, 5198.376194856603, 5228.686278823245, 5301.0, 5336.092864213093, 5357.196420536911, 5662.433756624346, 5761.971190144064, 5770.105633626795, 5770.653760774325, 5774.82675519735, 5773.971130144364, 5804.245448091763, 5811.4479124483105, 5816.156657284712, 5820.970895145497, 5184.533391994739, 5281.551068159211, 5321.467853214647, 5321.574274058066, 5347.385050719178, 5906.645601263938, 5908.940910590925, 5912.3496415394275, 5921.111833225051, 5922.407759224043, 5608.1587761835235, 5677.290338707661, 5679.062954612443, 5681.0, 5682.687452190169, 5505.532029777433, 5558.360788509373, 5594.188842617879, 5606.831795046155, 5743.994800909824, 5598.944010559842, 5615.2700148980375, 5616.494515493625, 5619.522340601095, 5622.690752008679, 5569.47869759269, 5610.97194514033, 5618.157276408489, 5622.8313150605545, 5630.352509461464, 4296.2696341621995, 4324.221640104812, 4335.197988372098, 4371.0, 4374.62815660666, 3875.5736868944396, 3880.4567360569545, 3888.105735680809, 3923.6272554107313, 3929.31237033518, 5203.973980130075, 5336.573074154058, 5339.652922560022, 5348.812791552277, 5349.839504814861, 5731.083026715705, 5743.62666426681, 5783.59514833966, 5813.069908814569, 5814.0, 5384.811531596375, 5418.45815418455, 5428.077226871442, 5429.67421954684, 5441.945580544223, 4842.927356089662, 4904.950950490449, 4970.652054356233, 4978.925316120261, 5032.924506132411, 5860.296764388216, 5934.940650593525, 5946.464818166386, 5948.167256584082, 5998.70006499682, 5736.282964629421, 5741.167530708108, 5741.74162162712, 5743.684097374685, 5784.595078344475, 5753.626014309057, 5796.21751063601, 5799.159121927381, 5934.258217722785, 5946.137810017437, 5593.664380137205, 5644.52021578154, 5652.378238393856, 5653.321601407857, 5689.516391106802, 5679.0, 5679.9432005681065, 5689.260396148474, 5707.657540547414, 5741.25363702716, 5418.106012507892, 5521.585881059017, 5526.530244929226, 5577.665340079446, 5594.02104631696, 5584.609077364546, 5589.608727389043, 5590.944090559043, 5590.972045139911, 5591.916121258103, 5476.452354764491, 5497.422770609189, 5497.725113744376, 5498.230247765396, 5519.696416696959, 5389.56883449331, 5460.071787796163, 5557.694326812064, 5566.137248726453, 5601.019821531134, 5472.835814925558, 5473.67157970523, 5474.479924407175, 5519.227308176778, 5536.695481748381], "value": 5266.1259088059605, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.6252342286072, 615.0835255469351, 637.2384999925089, 646.1083704487809, 652.2499126005091, 31234.375312493736, 43666.12667746647, 44296.55703442964, 44307.55692443075, 44355.0, 44778.552214477844, 45301.0, 45358.31962520565, 45390.319145212765, 45465.0, 8774.47353158811, 8909.777255568597, 8926.062763409846, 8994.190522852941, 8998.055204203563, 8692.956535217316, 8852.955735221314, 8856.070112638177, 8869.113088691143, 8919.152680495376, 8974.820503589925, 8998.730038098867, 9064.410813297147, 9065.95467022664, 9068.047854975232, 8914.55427228636, 8956.19394254517, 8969.282457403391, 8976.326775491863, 8981.056989016124, 8820.867686984637, 8903.243224325875, 8905.332100092519, 8911.287097032222, 8920.598573064228, 42141.57858421407, 42225.78887105575, 42596.78701606472, 42638.786806066084, 42695.0, 3307.7684562080663, 3764.0, 4086.5913408659194, 4091.4272001919753, 4237.512686041114, 32091.679083209103, 32420.0, 32900.50649240263, 32951.835240823646, 34040.48939265913, 4316.956830431687, 4336.111097225062, 4425.0, 4458.3535387368975, 4548.317752337143, 356481.0, 357762.0, 358072.0, 358078.0, 361102.0, 59492.0, 59932.0, 60197.699011504665, 60225.397746022856, 60236.096458553155, 64305.678471607345, 64330.0, 64386.67806660937, 64505.67747161234, 64533.224011478116, 17526.29894804219, 17800.643987120184, 17811.821881781274, 17815.821841781675, 17816.376426824998, 13069.411876465581, 13152.605421837361, 13164.539241126515, 13170.07809453329, 13184.0, 16552.586185345463, 18300.0, 18372.908135459238, 18413.447596572125, 18511.0, 6358.205224346957, 6583.802485925334, 6654.900176497356, 6711.899321510181, 6715.294894036056, 963.5182408795603, 1038.8026275007724, 1059.1412071813918, 1061.840723891407, 1141.0529260713588, 32200.35599288048, 32472.675273247438, 32632.0, 32682.83658581692, 33102.0, 1112.7718817642365, 1141.5547936304847, 1141.760230351619, 1160.8955194032408, 1168.5734706831945, 16578.83421165797, 16913.7462938056, 16956.406525771537, 17100.828991710172, 17276.481705548853, 542520.0, 542551.0, 544308.0, 545604.0, 551423.0, 58549.0, 58752.70623646854, 58753.41246587565, 58879.70560147172, 58939.705301473216, 1235.0, 1279.174932168746, 1334.6463187255579, 1362.8364596248316, 1409.4644035266533, 30270.09206208022, 33778.49332260067, 33793.66206337905, 34041.82979085089, 34169.829150854086, 51174.74412627913, 51586.0, 51588.0, 51732.48267517427, 51747.0, 422703.0, 431460.0, 433841.0, 434063.0, 434286.0, 35798.28403431969, 36605.0, 39448.40827387534, 42171.57828421799, 42509.36235956525, 47467.762661186476, 47832.76083619559, 48048.27927581019, 48179.0, 48707.51292487171, 37363.43954840734, 41593.58406416018, 41760.0, 42502.0, 43127.0, 40617.673938093816, 41159.7942010288, 41378.793106034274, 41422.0, 41496.58503415048, 40944.0, 41368.79315603403, 41492.79253603713, 41808.58191418047, 42485.787571063185, 35891.64108358987, 36447.81776091208, 36969.10381693809, 37450.438243426914, 37461.81269093637, 27618.585721213796, 27974.0, 28070.57894131549, 28281.858590706914, 28539.42921141607], "value": 20545.175744436958, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.5344029481821, 383.601054902901, 383.9635234652709, 395.335835795863, 414.7242084014131, 16865.83134168658, 18757.15592798324, 18808.717869231972, 19747.210111595556, 19797.307094251704, 17911.64176716465, 18250.63498730028, 18568.907155464203, 18688.906555467205, 19265.229390824352, 5513.669179849202, 5552.361478429982, 5618.5786066045, 5755.136729490589, 5755.25181726375, 5487.917681234785, 5521.944780552183, 5621.100623900177, 5646.548276137899, 5648.096304591266, 5510.448955104497, 5569.164625306196, 5596.804111856086, 5615.0454422748235, 5660.518855897254, 5470.507654311092, 5533.889322213573, 5573.554115670737, 5579.497845193931, 5593.3847276799515, 4890.657653964224, 4930.556249937487, 4963.0, 4963.305137280783, 5249.212618107276, 13663.0, 13665.18008919458, 18321.992290424023, 21515.354539363845, 21858.781412185992, 2086.6765651324067, 2125.6705210692367, 2281.863088214712, 2316.328264803205, 2559.398541342783, 9104.772380690469, 9413.0, 9657.082577155159, 9929.851052234222, 13342.33288335589, 1719.3380548488797, 1829.6706592813289, 1835.2567210279858, 1854.805245449222, 1881.5578339090303, 58967.0, 65916.69291574771, 77394.6130269345, 80081.59959200225, 80919.5954020232, 10005.149562287286, 10276.0, 10361.378317300987, 10569.101626361691, 10678.466076696133, 14606.707865842836, 14638.707225855424, 14663.120212787268, 14693.926530367493, 14771.778423323658, 7741.18717534662, 7747.186545412763, 7844.4901081429525, 8001.599920004093, 8241.175882411711, 7477.252274772479, 7534.924650753423, 7629.923700762922, 7660.119086305035, 7667.808304792425, 4233.957660423418, 4292.91414171721, 4308.310670292738, 4405.898525368658, 4447.776861363151, 1768.6285879965094, 1769.7079981803115, 1771.822817718218, 1829.1220214297211, 1858.8327050565515, 951.5813042261383, 988.3575675810637, 1003.909648131657, 1065.1638463805875, 1114.0586204657052, 18220.180091895898, 18464.538386540444, 18738.688291819442, 19335.12991915339, 19405.51486212856, 899.8965119011267, 999.9100080992746, 1020.5611587017505, 1039.428314427062, 1093.8632670916136, 9680.854787178198, 10473.738156546147, 10484.318519296221, 10517.15862730995, 10533.9473302633, 513939.0, 521314.0, 525864.0, 526731.0, 560263.0, 55880.441195587526, 89912.5504372474, 90768.0, 90894.54552727194, 90978.0, 918.8805455290769, 957.4207604399378, 982.1013772398319, 1003.9247056470793, 1009.5911155981839, 16450.0, 17226.138693065546, 17338.73991890148, 17468.12659367052, 17747.911260443616, 40507.18985620212, 40983.79508102559, 41284.58715412807, 41799.79100104602, 42339.0, 58709.41290587039, 58918.116228255756, 59447.40552594592, 59675.0, 59887.0, 8245.670173193004, 8458.196471335214, 8554.27288680469, 8662.956685216534, 8756.168164024408, 11902.166848320534, 12759.872401275868, 12880.227186368847, 12949.352532373532, 13026.153300035467, 11104.888951110386, 11330.94334528322, 11379.203455758017, 11506.424678766196, 11687.474063666985, 11315.151363647594, 11334.716632084264, 11448.198626096093, 11773.175877688822, 11830.231034982698, 10876.347419154876, 11195.720106997065, 11418.486168122621, 11597.710057248636, 11694.824577631172, 8017.690916969244, 8130.552819594743, 8316.085230624505, 8538.78653033679, 8582.914170858212, 8785.956070219863, 11485.19603627738, 11567.826482602935, 11576.536938522364, 11613.6515904523], "value": 8887.282498839233, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1335.799630055491, 1480.7112613040458, 1509.2680050175663, 1649.5876030992251, 1807.918643661035, 8203.466774659642, 8535.445196062252, 8547.059823419426, 8780.078091800366, 8792.604332805024, 8550.102239264881, 8717.0, 8728.0, 8731.214190722834, 8737.0, 1969.724238606589, 2258.9887050564807, 2294.219965211832, 2327.7323107842562, 2332.4285550040263, 2360.303710405426, 2364.8344615876895, 2367.360812580602, 2368.100121953655, 2368.384220102777, 2273.033960566761, 2295.162265772989, 2302.355340504653, 2303.9424014399606, 2307.3078076577044, 1926.9807301927012, 2163.5348400094053, 2214.534947660993, 2223.2440970070093, 2229.6321107017325, 2236.1279101150562, 2243.6089624432793, 2264.977350226493, 2267.0, 2267.013848975701, 8616.0, 8676.089010653854, 8696.217340439327, 8705.129487051308, 8718.346124040723, 5141.0, 5291.57667386612, 5292.153255479144, 5299.761510732026, 5302.946970530284, 3298.340331933599, 3358.714509266691, 3411.6588341165934, 3417.5044618530424, 3434.708049815769, 1187.156759560847, 1191.1126210972793, 1191.7973944429468, 1206.4510647655295, 2060.1347434077725, 12113.39433028354, 12225.144239903211, 12237.0, 12257.080718946114, 12258.0, 4260.10537787062, 4413.249747542925, 4478.41780568524, 4485.932711009337, 4486.1924853526025, 9428.387154834914, 9544.761380965532, 9559.856602150974, 9560.139587437165, 9560.61757529691, 5055.848324550196, 5057.241413787961, 5058.861756104847, 5062.772175252123, 5068.41713202979, 4116.526599441043, 4566.383538222298, 4671.743054131987, 4683.0, 4757.452892917358, 3667.8349474273723, 3745.138618117848, 3793.1844653399653, 3822.3884178531302, 3867.690584753213, 1116.413882711583, 1135.4663308245113, 1139.464451707696, 1142.4230763464398, 1154.6940060883871, 925.6991477769752, 1006.954687039085, 1014.2291858187683, 1025.3130402630256, 1026.8921763214755, 6004.189434426384, 6171.197744293213, 6192.133101365813, 6216.222972128484, 6264.59280146789, 453.61216160183227, 464.0996466854292, 469.2445163287105, 470.01297275720714, 471.69339929046396, 4240.575942405796, 4300.892477688083, 4329.978350108229, 4334.544872788312, 4345.239583072949, 10554.0, 10914.836277455686, 10918.727031824268, 10928.633920759905, 10928.781424371467, 10189.949050254849, 10766.354018758899, 10808.189385796097, 10811.081058109992, 10819.404932728776, 7838.529688218725, 8101.270885620204, 8188.713395031145, 8191.139930307351, 8213.38399620031, 5840.678762667924, 6097.847553811191, 6133.50931925436, 6162.537809664203, 6252.749890004349, 9479.715608531755, 9602.95198524003, 9660.178884794872, 9697.127258546765, 9755.951220243853, 10170.186385089028, 10225.84661230097, 10260.692179234635, 10269.74325641865, 10351.689449316533, 6727.562708423937, 6752.69612867432, 7499.212582678741, 7613.352865006315, 7806.375489960676, 8335.583220838813, 8540.658373665232, 8636.17956294151, 8637.309015278888, 8654.22112009922, 7283.635818209174, 7476.439267054884, 7518.360939320219, 7589.924100759143, 7712.537247765152, 7276.490645654753, 7326.743563975236, 7485.0, 7539.924600753922, 7697.461177717506, 6895.689693963884, 6930.7227710891, 6981.0924579804305, 6986.336298051677, 6988.475864310299, 5153.948460515347, 5247.895042099213, 5384.596155288447, 5434.592405569519, 5472.2065300531995, 5130.79476820923, 5172.767225474938, 5181.1969144782615, 5276.498732620395, 5479.75341109659], "value": 4509.848445172494, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.6208411989732, 319.8193020943167, 324.62992188904667, 328.1059113914583, 329.711502435369, 5149.974250128749, 5229.7385130743405, 5230.398504172012, 5255.185446255827, 5263.131583288758, 5142.460041695625, 5143.27994080829, 5144.09978253806, 5153.0, 5154.201098829678, 3888.2806680764147, 3956.4856568646037, 4063.8577649782114, 4075.6157647776085, 4105.60996705314, 4038.6567141792984, 4055.452513910614, 4070.6946978976694, 4074.816633251496, 4090.713650044498, 3906.8046597670004, 4022.4167495713104, 4055.371417430288, 4056.9391459128137, 4058.756474611518, 3801.904952376213, 3980.4228386883883, 4019.41718450823, 4061.79691015451, 4084.9591504084874, 3575.1955809942815, 3581.3195492856535, 3604.855805767766, 3608.4226523756074, 3615.349237137314, 4984.800607975677, 5004.8999020019755, 5016.949830501721, 5024.899502009976, 5041.395032596112, 4512.774361281923, 4624.884377890546, 4633.189191891439, 4650.674452788307, 4656.32483289921, 5347.839564813062, 5384.0847056000575, 5397.46025397461, 5402.676848954948, 5416.431274716177, 3938.1729836734035, 3944.4872166618443, 3951.1429628074757, 3953.8418463261437, 3973.1457736586485, 5454.563634909237, 5575.1915972184215, 5602.411746766612, 5642.915356269659, 5711.286089238845, 3993.0, 4009.7393669411395, 4018.83924643011, 4023.6177563131455, 4025.7181997260495, 4033.3344998075577, 4047.5142982841658, 4071.450354202204, 4082.387641853686, 4082.8366865325647, 4518.796654150571, 4620.584147426748, 4641.443026836733, 4641.698289611165, 4645.442546894326, 5459.590530710133, 5464.535514481314, 5473.343198816167, 5481.397046324901, 5482.972585137049, 1383.5157694806737, 1405.5361730628867, 1424.8601119104674, 1429.5425463851675, 1435.7200345932652, 883.4586466165388, 919.7378747057056, 920.6466494253436, 921.6267761036008, 929.8140371925642, 5142.588592912558, 5317.0, 5318.44156363584, 5325.201219816981, 5347.385050719139, 5644.6613203207935, 5644.915326270027, 5656.953463609246, 5667.829965101054, 5685.800996965087, 5053.469385714447, 5132.30713853625, 5298.178782288752, 5305.257263983045, 5322.494363035506, 2967.812874850034, 2986.2683642507723, 2990.1179152150166, 2994.835284059354, 3016.6380034395575, 5797.710114494258, 5807.796727114531, 5817.76728930838, 5832.504237139806, 5852.8536786579825, 5529.0324193266015, 5737.254156959569, 5764.884702305931, 5772.037507247556, 5780.265920224, 5747.885042299215, 5797.188393624896, 5798.246227990334, 5817.418258174149, 5854.4730974212525, 5387.676739395649, 5646.71766411686, 5654.971725141348, 5655.830325090254, 5688.971555142363, 5572.4148964358155, 5590.608657393944, 5617.410171931889, 5620.8875822482505, 5628.718564071698, 5856.297244330707, 5860.120981852756, 5863.62204881861, 5888.970555147197, 5889.793857215148, 3902.687784977252, 4058.8782336529953, 4060.675145988373, 4063.2279866826393, 4069.7354671946227, 5608.663480191201, 5614.7192640367, 5633.605647604629, 5653.180288858175, 5666.405027472221, 5514.338279406336, 5516.668999860021, 5544.750486228048, 5559.58303127259, 5566.554675625859, 5314.601404894725, 5399.433059528693, 5456.727163641882, 5471.753771080391, 5494.615376923577, 5193.662411943212, 5367.1680889462195, 5386.59600529954, 5396.83809485716, 5420.8644783879145, 5316.8936621266585, 5526.0, 5546.805861794818, 5562.2490963721, 5573.801632649, 5279.841604751864, 5377.300950876361, 5384.407715151252, 5395.919061214006, 5422.0], "value": 4174.062023914508, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [654.1071437487827, 659.3176062775023, 750.9887351689725, 805.4563169860344, 829.9709510167145, 13397.665058373534, 13433.865661343383, 13446.596602101929, 13450.798238026437, 14931.328090235938, 14435.494757683484, 14741.778873316882, 14745.852541474582, 14748.483803066894, 14762.409503619869, 799.3525244551903, 808.9716859909904, 813.3411936331561, 813.5037627047496, 813.5484805932705, 682.5324652612951, 784.5136015670264, 800.4196957206037, 814.6944895664126, 817.9836403271931, 853.4665833853842, 857.1985193843744, 857.6055014693248, 858.5664239559014, 859.0893652728129, 851.93610479214, 853.0658928473374, 853.2960307746104, 854.6196942360652, 854.7649396415973, 500.5120007992215, 510.98722531936625, 517.2938938349126, 613.3069631316629, 617.8671585609071, 12526.561570345086, 12574.679658635803, 12580.81128783069, 12595.937020314932, 12613.180143290656, 12565.434555445026, 12949.0, 13024.218546887123, 13110.934445327808, 13575.321233938363, 11628.622164022909, 11749.118816088741, 11838.171328007043, 11970.102242331774, 12209.877901221053, 4284.807183676711, 4304.978475107636, 4338.58783415575, 4408.823647054146, 4516.683832131752, 64384.0, 64821.67589162071, 65157.67421162911, 69872.3012769876, 69898.3010169902, 10218.335808172593, 10494.265401421828, 10835.729106772395, 10850.945745271223, 10951.726206844893, 19492.902535487232, 20729.0671919764, 20797.272095476586, 20802.58394832095, 20804.0, 7506.13679426862, 7507.51201171933, 7611.771646850603, 7692.19231980634, 7805.33654639362, 4517.141743068806, 4587.472440669299, 4606.654500912445, 4609.193391156601, 4624.329472226508, 3274.705276525124, 3339.833008349621, 3344.2141096842224, 3361.8991430257133, 3365.899023029313, 573.7131434282859, 581.528961541153, 597.1132867691475, 598.9700514974321, 600.6126048698565, 680.8944613584903, 695.9547629404072, 769.61134627013, 796.307212724933, 802.9959850200712, 9718.902810971942, 10047.24645651579, 10109.29234953561, 10147.289689721796, 10150.644727434652, 550.3890681343705, 592.8577141486098, 668.238208442376, 717.7057406463325, 750.1748077115238, 4542.182407166676, 4730.810767569259, 4787.521247875255, 4794.2808578713475, 4901.607871370282, 106457.0, 107415.0, 107526.0, 112748.43625781819, 115901.0, 60038.0, 66714.66642666853, 75943.24056759362, 83399.58300208581, 97828.51085744526, 81972.0, 88981.55509222412, 89257.0, 92180.0, 92443.53778231065, 9541.284403669613, 9739.853902191331, 9789.85315220258, 9903.158231550398, 10169.135623472088, 49982.001799821184, 50309.49690503195, 51013.744931275105, 52182.21726674179, 53309.46690533045, 44295.77852110719, 74965.0, 75544.0, 76795.2320476788, 77255.34308211473, 12352.254705407018, 13532.17315662373, 13538.0, 13722.65693357674, 14495.0, 13391.0, 13925.582232533041, 14317.0, 14519.78220326717, 14724.79128130789, 12785.232886026868, 12916.547920822726, 13028.088033837541, 13182.143160694524, 13332.2667253302, 13530.18818870871, 13781.379837907118, 13824.516141934984, 13858.861411385757, 14349.784753228501, 12861.099723019299, 12941.805872912102, 13012.609621711365, 13196.208227505997, 13351.799723004357, 9250.612408138833, 9765.951170244103, 9805.264605154785, 9946.602135914482, 10010.699679009642, 9315.25477961775, 9520.917544453394, 9628.807423851344, 9749.463779492196, 9871.210303175872], "value": 7235.42692181184, "unit": "score"}], "name": "dromaeo_css", "value": 7126.348304715034, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 111.0, 112.0, 111.0, 110.0, 112.0, 111.0, 110.0, 110.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 133.0, 127.0, 175.0, 127.0, 132.0, 151.0, 130.0, 159.0, 133.0], "value": 141.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 159.0, 163.0, 160.0, 159.0, 160.0, 160.0, 161.0, 161.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 136.0, 75.0, 75.0, 75.0, 74.0, 98.0, 75.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 117.0, 85.0, 85.0, 86.0, 116.0, 85.0, 84.0, 128.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 118.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 144.0], "value": 144.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 51.0, 59.0, 52.0, 52.0, 53.0, 53.0, 52.0, 51.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 64.0, 64.0, 64.0, 62.0, 63.0, 63.0, 63.0, 64.0], "value": 63.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 82.0, 80.0, 86.0, 81.0, 80.0, 87.0, 80.0, 109.0, 80.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 131.0, 123.0, 120.0, 119.0, 119.0, 120.0, 121.0, 124.0, 134.0], "value": 123.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 158.0, 164.0, 160.0, 161.0, 158.0, 158.0, 160.0, 156.0, 162.0], "value": 160.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 63.0, 63.0, 68.0, 63.0, 62.0, 62.0, 65.0], "value": 63.6, "unit": "score"}], "name": "kraken", "value": 1496.6, "alertThreshold": 2.0}]} 23:19:21 INFO - Return code: 0 23:19:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:19:21 ERROR - # TBPL SUCCESS # 23:19:21 INFO - Running post-action listener: _resource_record_post_action 23:19:21 INFO - ##### 23:19:21 INFO - ##### Finished run-tests step (success) 23:19:21 INFO - ##### 23:19:21 INFO - Running post-run listener: _resource_record_post_run 23:19:21 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 542482432; Read time: 4; Write time: 406736 23:19:21 INFO - TinderboxPrint: CPU usage
13.1% 23:19:21 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 23:19:21 INFO - TinderboxPrint: I/O write bytes / time
542,482,432 / 406,736 23:19:21 INFO - TinderboxPrint: CPU idle
8,270.6 (86.9%) 23:19:21 INFO - TinderboxPrint: CPU user
1,207.7 (12.7%) 23:19:21 INFO - TinderboxPrint: Swap in / out
0 / 0 23:19:21 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 233566208; Read time: 0; Write time: 231016 23:19:21 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293978112; Read time: 4; Write time: 172432 23:19:21 INFO - Running post-run listener: _upload_blobber_files 23:19:21 INFO - Blob upload gear active. 23:19:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:19:21 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 23:19:21 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'] 23:19:21 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 23:19:22 INFO - (blobuploader) - INFO - Open directory for files ... 23:19:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:19:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:19:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:19:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:19:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:19:22 INFO - (blobuploader) - INFO - Done attempting. 23:19:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:19:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:19:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:19:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:19:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:19:26 INFO - (blobuploader) - INFO - Done attempting. 23:19:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:19:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:19:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:19:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:19:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:19:27 INFO - (blobuploader) - INFO - Done attempting. 23:19:27 INFO - (blobuploader) - INFO - Iteration through files over. 23:19:27 INFO - Return code: 0 23:19:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:19:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:19:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/da443a19df1b00c55b4dfdbfa1b9cfa5656112bea95bd0aac29fb1d78b100e7e941438c6d4385e436f8abfaf181040cd4e0710ad50f56c596f4ac7c456e69a1b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0d586dfef6989f6bdd03ebbedc7aaf99c99ab062819b46101ee6e1945cc7243bf34664bab286a2f20c87c24714799d742059296559d017d1d0917c87e89f2d28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e4e48a435fd4e045541a193b42ea928055cdbd899dc4cbce7d51a5f5291c592190fd4dfe7dfa983bebb082635c9e3a4e5eeb2c2a8edecc9375e76273a9295961"} 23:19:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:19:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:19:27 INFO - Contents: 23:19:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/da443a19df1b00c55b4dfdbfa1b9cfa5656112bea95bd0aac29fb1d78b100e7e941438c6d4385e436f8abfaf181040cd4e0710ad50f56c596f4ac7c456e69a1b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0d586dfef6989f6bdd03ebbedc7aaf99c99ab062819b46101ee6e1945cc7243bf34664bab286a2f20c87c24714799d742059296559d017d1d0917c87e89f2d28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e4e48a435fd4e045541a193b42ea928055cdbd899dc4cbce7d51a5f5291c592190fd4dfe7dfa983bebb082635c9e3a4e5eeb2c2a8edecc9375e76273a9295961"} 23:19:27 INFO - Running post-run listener: copy_logs_to_upload_dir 23:19:27 INFO - Copying logs to upload dir... 23:19:27 INFO - mkdir: /builds/slave/test/build/upload/logs 23:19:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.923688 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-07 23:19:27.393320) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 23:19:27.396896) ========= 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=a0d2d2de893abaa8702a9954000001a7-1465363236.288551-509201038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/da443a19df1b00c55b4dfdbfa1b9cfa5656112bea95bd0aac29fb1d78b100e7e941438c6d4385e436f8abfaf181040cd4e0710ad50f56c596f4ac7c456e69a1b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0d586dfef6989f6bdd03ebbedc7aaf99c99ab062819b46101ee6e1945cc7243bf34664bab286a2f20c87c24714799d742059296559d017d1d0917c87e89f2d28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e4e48a435fd4e045541a193b42ea928055cdbd899dc4cbce7d51a5f5291c592190fd4dfe7dfa983bebb082635c9e3a4e5eeb2c2a8edecc9375e76273a9295961"} build_url:https://queue.taskcluster.net/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011280 build_url: 'https://queue.taskcluster.net/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/da443a19df1b00c55b4dfdbfa1b9cfa5656112bea95bd0aac29fb1d78b100e7e941438c6d4385e436f8abfaf181040cd4e0710ad50f56c596f4ac7c456e69a1b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0d586dfef6989f6bdd03ebbedc7aaf99c99ab062819b46101ee6e1945cc7243bf34664bab286a2f20c87c24714799d742059296559d017d1d0917c87e89f2d28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e4e48a435fd4e045541a193b42ea928055cdbd899dc4cbce7d51a5f5291c592190fd4dfe7dfa983bebb082635c9e3a4e5eeb2c2a8edecc9375e76273a9295961"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 23:19:27.425257) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 23:19:27.425985) ========= 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=a0d2d2de893abaa8702a9954000001a7-1465363236.288551-509201038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 23:19:27.509675) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 23:19:27.510326) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 23:19:27.510966) ========= ========= Total master_lag: 0.20 =========