builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-052 starttime: 1466176539.07 results: success (0) buildid: 20160617053003 builduid: a87d7cf7d9e74bcda32a5e3bf8bb01db revision: 6b61c987f9ed4c5c4927da0c0edff369d8fa7fb5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-17 08:15:39.067070) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-17 08:15:39.067579) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-17 08:15:39.067872) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-17 08:15:39.167921) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 08:15:39.168200) ========= 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=826874ccc97bd7bf541b4875000001d5-1466174075.94240-979900600 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-17 08:15: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-06-17 08:15:39 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095885 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 08:15:39.281927) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 08:15:39.282263) ========= 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=826874ccc97bd7bf541b4875000001d5-1466174075.94240-979900600 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018574 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 08:15:39.331935) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 08:15:39.332245) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6b61c987f9ed4c5c4927da0c0edff369d8fa7fb5 --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 6b61c987f9ed4c5c4927da0c0edff369d8fa7fb5 --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=826874ccc97bd7bf541b4875000001d5-1466174075.94240-979900600 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-17 08:15:39,483 truncating revision to first 12 chars 2016-06-17 08:15:39,483 Setting DEBUG logging. 2016-06-17 08:15:39,483 attempt 1/10 2016-06-17 08:15:39,483 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6b61c987f9ed?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-17 08:15:39,914 unpacking tar archive at: fx-team-6b61c987f9ed/testing/mozharness/ program finished with exit code 0 elapsedTime=0.775138 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 08:15:40.120540) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 08:15:40.120816) ========= script_repo_revision: 6b61c987f9ed4c5c4927da0c0edff369d8fa7fb5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 08:15:40.121209) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 08:15:40.121489) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 08:15:40.135883) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-06-17 08:15:40.136161) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1466174075.94240-979900600 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:15:40 INFO - MultiFileLogger online at 20160617 08:15:40 in /builds/slave/test 08:15:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:15:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:15:40 INFO - {'append_to_log': False, 08:15:40 INFO - 'base_work_dir': '/builds/slave/test', 08:15:40 INFO - 'blob_upload_branch': 'Fx-Team', 08:15:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:15:40 INFO - 'branch': 'Fx-Team', 08:15:40 INFO - 'buildbot_json_path': 'buildprops.json', 08:15:40 INFO - 'config_files': ('talos/linux_config.py',), 08:15:40 INFO - 'default_actions': ('clobber', 08:15:40 INFO - 'read-buildbot-config', 08:15:40 INFO - 'download-and-extract', 08:15:40 INFO - 'populate-webroot', 08:15:40 INFO - 'create-virtualenv', 08:15:40 INFO - 'install', 08:15:40 INFO - 'run-tests'), 08:15:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:15:40 INFO - 'download_minidump_stackwalk': True, 08:15:40 INFO - 'download_symbols': 'ondemand', 08:15:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:15:40 INFO - 'tooltool.py': '/tools/tooltool.py', 08:15:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:15:40 INFO - '/tools/misc-python/virtualenv.py')}, 08:15:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:15:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:15:40 INFO - 'installer_path': 'installer.exe', 08:15:40 INFO - 'log_level': 'info', 08:15:40 INFO - 'log_name': 'talos', 08:15:40 INFO - 'log_to_console': True, 08:15:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:15:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:15:40 INFO - 'opt_config_files': (), 08:15:40 INFO - 'pip_index': False, 08:15:40 INFO - 'sps_profile': False, 08:15:40 INFO - 'sps_profile_interval': 0, 08:15:40 INFO - 'suite': 'dromaeojs-e10s', 08:15:40 INFO - 'system_bits': '32', 08:15:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:15:40 INFO - 'title': 'talos-linux64-ix-052', 08:15:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:15:40 INFO - 'use_talos_json': True, 08:15:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:15:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:15:40 INFO - 'work_dir': 'build'} 08:15:40 INFO - ##### 08:15:40 INFO - ##### Running clobber step. 08:15:40 INFO - ##### 08:15:40 INFO - Running pre-action listener: _resource_record_pre_action 08:15:40 INFO - Running main action method: clobber 08:15:40 INFO - rmtree: /builds/slave/test/build 08:15:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:15:41 INFO - Running post-action listener: _resource_record_post_action 08:15:41 INFO - ##### 08:15:41 INFO - ##### Finished clobber step (success) 08:15:41 INFO - ##### 08:15:41 INFO - ##### 08:15:41 INFO - ##### Running read-buildbot-config step. 08:15:41 INFO - ##### 08:15:41 INFO - Running pre-action listener: _resource_record_pre_action 08:15:41 INFO - Running main action method: read_buildbot_config 08:15:41 INFO - Using buildbot properties: 08:15:41 INFO - { 08:15:41 INFO - "project": "", 08:15:41 INFO - "product": "firefox", 08:15:41 INFO - "script_repo_revision": "production", 08:15:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:15:41 INFO - "repository": "", 08:15:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:15:41 INFO - "buildid": "20160617053003", 08:15:41 INFO - "pgo_build": "True", 08:15:41 INFO - "basedir": "/builds/slave/test", 08:15:41 INFO - "buildnumber": 837, 08:15:41 INFO - "slavename": "talos-linux64-ix-052", 08:15:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:15:41 INFO - "platform": "ubuntu64_hw", 08:15:41 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:15:41 INFO - "branch": "fx-team", 08:15:41 INFO - "repo_path": "integration/fx-team", 08:15:41 INFO - "revision": "6b61c987f9ed4c5c4927da0c0edff369d8fa7fb5", 08:15:41 INFO - "stage_platform": "linux64-pgo", 08:15:41 INFO - "builduid": "a87d7cf7d9e74bcda32a5e3bf8bb01db", 08:15:41 INFO - "slavebuilddir": "test" 08:15:41 INFO - } 08:15:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:15:41 INFO - Running post-action listener: _resource_record_post_action 08:15:41 INFO - ##### 08:15:41 INFO - ##### Finished read-buildbot-config step (success) 08:15:41 INFO - ##### 08:15:41 INFO - ##### 08:15:41 INFO - ##### Running download-and-extract step. 08:15:41 INFO - ##### 08:15:41 INFO - Running pre-action listener: _resource_record_pre_action 08:15:41 INFO - Running main action method: download_and_extract 08:15:41 INFO - mkdir: /builds/slave/test/build/tests 08:15: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')]} 08:15:41 INFO - https://queue.taskcluster.net/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:15:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:15:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:15:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cx_b3inOSrGvBfIdvwoG8w/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 08:15:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cx_b3inOSrGvBfIdvwoG8w/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 08:15:44 INFO - Downloaded 1361 bytes. 08:15:44 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:15:44 INFO - Using the following test package requirements: 08:15:44 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:15:44 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:15:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:15:44 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:15:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:15:44 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:15:44 INFO - u'jsshell-linux-x86_64.zip'], 08:15:44 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:15:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:15:44 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:15:44 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:15:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:15:44 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:15:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:15:44 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:15:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:15:44 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:15:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:15:44 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:15:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:44 INFO - https://queue.taskcluster.net/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:15:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:15:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:15:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cx_b3inOSrGvBfIdvwoG8w/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 08:15:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cx_b3inOSrGvBfIdvwoG8w/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 08:15:46 INFO - Downloaded 24175990 bytes. 08:15:46 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'] 08:15:46 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 08:15:47 INFO - Return code: 0 08:15:47 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 08:15:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:47 INFO - https://queue.taskcluster.net/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:15:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:15:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:15:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cx_b3inOSrGvBfIdvwoG8w/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 08:15:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cx_b3inOSrGvBfIdvwoG8w/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 08:15:50 INFO - Downloaded 24175990 bytes. 08:15:50 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'] 08:15:50 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 08:15:51 INFO - Return code: 0 08:15:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:51 INFO - https://queue.taskcluster.net/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:15:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:15:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:15:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cx_b3inOSrGvBfIdvwoG8w/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 08:15:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cx_b3inOSrGvBfIdvwoG8w/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 08:15:52 INFO - Downloaded 14405384 bytes. 08:15:52 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'] 08:15:52 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 08:15:52 INFO - Return code: 0 08:15:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:15:52 INFO - https://queue.taskcluster.net/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:15:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:15:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:15:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cx_b3inOSrGvBfIdvwoG8w/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 08:15:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cx_b3inOSrGvBfIdvwoG8w/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 08:15:54 INFO - Downloaded 58447307 bytes. 08:15:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:15:54 INFO - mkdir: /builds/slave/test/properties 08:15:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:15:54 INFO - Writing to file /builds/slave/test/properties/build_url 08:15:54 INFO - Contents: 08:15:54 INFO - build_url:https://queue.taskcluster.net/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:15:55 INFO - Running post-action listener: _resource_record_post_action 08:15:55 INFO - Running post-action listener: set_extra_try_arguments 08:15:55 INFO - ##### 08:15:55 INFO - ##### Finished download-and-extract step (success) 08:15:55 INFO - ##### 08:15:55 INFO - ##### 08:15:55 INFO - ##### Running populate-webroot step. 08:15:55 INFO - ##### 08:15:55 INFO - Running pre-action listener: _resource_record_pre_action 08:15:55 INFO - Running main action method: populate_webroot 08:15:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:15:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:15:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:15:55 INFO - '--tppagecycles', 08:15:55 INFO - '7'], 08:15:55 INFO - 'tests': ['tsvgm']}}, 08:15:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:15:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:15:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:15:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:15:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:15:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:15:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:55 INFO - 'talos_options': ['--disable-e10s'], 08:15:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:15:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:15:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:55 INFO - 'talos_options': ['--disable-e10s'], 08:15:55 INFO - 'tests': ['damp', 'tps']}, 08:15:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:55 INFO - 'tests': ['damp', 'tps']}, 08:15:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:15:55 INFO - 'tests': ['dromaeo_dom']}, 08:15:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:15:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:15:55 INFO - 'tests': ['basic_compositor_video']}, 08:15:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:15:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:15:55 INFO - 'tests': ['a11yr', 08:15:55 INFO - 'ts_paint', 08:15:55 INFO - 'tpaint', 08:15:55 INFO - 'sessionrestore', 08:15:55 INFO - 'sessionrestore_no_auto_restore', 08:15:55 INFO - 'tabpaint']}, 08:15:55 INFO - 'other-e10s': {'tests': ['a11yr', 08:15:55 INFO - 'ts_paint', 08:15:55 INFO - 'tpaint', 08:15:55 INFO - 'sessionrestore', 08:15:55 INFO - 'sessionrestore_no_auto_restore', 08:15:55 INFO - 'tabpaint']}, 08:15:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:15:55 INFO - 'ts_paint', 08:15:55 INFO - 'tpaint', 08:15:55 INFO - 'sessionrestore', 08:15:55 INFO - 'sessionrestore_no_auto_restore', 08:15:55 INFO - 'tabpaint']}, 08:15:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:15:55 INFO - 'ts_paint', 08:15:55 INFO - 'tpaint', 08:15:55 INFO - 'sessionrestore', 08:15:55 INFO - 'sessionrestore_no_auto_restore', 08:15:55 INFO - 'tabpaint']}, 08:15:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:15:55 INFO - 'tests': ['a11yr', 08:15:55 INFO - 'ts_paint', 08:15:55 INFO - 'tpaint', 08:15:55 INFO - 'sessionrestore', 08:15:55 INFO - 'sessionrestore_no_auto_restore', 08:15:55 INFO - 'tabpaint']}, 08:15:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:15:55 INFO - 'tests': ['a11yr', 08:15:55 INFO - 'ts_paint', 08:15:55 INFO - 'tpaint', 08:15:55 INFO - 'sessionrestore', 08:15:55 INFO - 'sessionrestore_no_auto_restore', 08:15:55 INFO - 'tabpaint']}, 08:15:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:15:55 INFO - 'tests': ['tsvgx', 08:15:55 INFO - 'tsvgr_opacity', 08:15:55 INFO - 'tart', 08:15:55 INFO - 'tscrollx', 08:15:55 INFO - 'cart']}, 08:15:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:15:55 INFO - 'tsvgr_opacity', 08:15:55 INFO - 'tart', 08:15:55 INFO - 'tscrollx', 08:15:55 INFO - 'cart']}, 08:15:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:55 INFO - 'talos_options': ['--disable-e10s'], 08:15:55 INFO - 'tests': ['tp5o']}, 08:15:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:55 INFO - 'tests': ['tp5o']}, 08:15:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:55 INFO - 'talos_options': ['--disable-e10s', 08:15:55 INFO - '--xperf_path', 08:15:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:15:55 INFO - 'tests': ['tp5n']}, 08:15:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:55 INFO - 'talos_options': ['--xperf_path', 08:15:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:15:55 INFO - 'tests': ['tp5n']}}, 08:15:55 INFO - 'talos.zip': {'path': '', 08:15:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:15:55 INFO - Running post-action listener: _resource_record_post_action 08:15:55 INFO - ##### 08:15:55 INFO - ##### Finished populate-webroot step (success) 08:15:55 INFO - ##### 08:15:55 INFO - ##### 08:15:55 INFO - ##### Running create-virtualenv step. 08:15:55 INFO - ##### 08:15:55 INFO - Running pre-action listener: _resource_record_pre_action 08:15:55 INFO - Running main action method: create_virtualenv 08:15:55 INFO - Creating virtualenv /builds/slave/test/build/venv 08:15:55 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 08:15:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:15:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:15:55 INFO - Using real prefix '/usr' 08:15:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:15:55 INFO - Installing distribute.............................................................................................................................................................................................done. 08:15:57 INFO - Installing pip.................done. 08:15:57 INFO - Return code: 0 08:15:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:15:57 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')]} 08:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:57 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')]} 08:15:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:57 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 0x7fc4c6355f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17443b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d6990>, '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 0x1742470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1742900>, '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': '826874ccc97bd7bf541b4875000001d5-1466174075.94240-979900600', '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 08:15:57 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 08:15:57 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 08:15:57 INFO - Using env: {'DISPLAY': ':0', 08:15:57 INFO - 'HOME': '/home/cltbld', 08:15:57 INFO - 'LANG': 'en_US.UTF-8', 08:15:57 INFO - 'LANGUAGE': 'en_US:en', 08:15:57 INFO - 'LOGNAME': 'cltbld', 08:15:57 INFO - 'MAIL': '/var/mail/cltbld', 08:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:57 INFO - 'MOZ_NO_REMOTE': '1', 08:15:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:57 INFO - 'NO_EM_RESTART': '1', 08:15:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:57 INFO - 'PWD': '/builds/slave/test', 08:15:57 INFO - 'SHELL': '/bin/bash', 08:15:57 INFO - 'SHLVL': '1', 08:15:57 INFO - 'TERM': 'linux', 08:15:57 INFO - 'TMOUT': '86400', 08:15:57 INFO - 'USER': 'cltbld', 08:15:57 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466174075.94240-979900600', 08:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:57 INFO - '_': '/tools/buildbot/bin/python'} 08:15:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:57 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 08:15:57 INFO - Cleaning up... 08:15:57 INFO - Return code: 0 08:15:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:15:57 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')]} 08:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:57 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')]} 08:15:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:57 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 0x7fc4c6355f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17443b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d6990>, '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 0x1742470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1742900>, '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': '826874ccc97bd7bf541b4875000001d5-1466174075.94240-979900600', '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 08:15:57 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 08:15:57 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 08:15:57 INFO - Using env: {'DISPLAY': ':0', 08:15:57 INFO - 'HOME': '/home/cltbld', 08:15:57 INFO - 'LANG': 'en_US.UTF-8', 08:15:57 INFO - 'LANGUAGE': 'en_US:en', 08:15:57 INFO - 'LOGNAME': 'cltbld', 08:15:57 INFO - 'MAIL': '/var/mail/cltbld', 08:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:57 INFO - 'MOZ_NO_REMOTE': '1', 08:15:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:57 INFO - 'NO_EM_RESTART': '1', 08:15:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:57 INFO - 'PWD': '/builds/slave/test', 08:15:57 INFO - 'SHELL': '/bin/bash', 08:15:57 INFO - 'SHLVL': '1', 08:15:57 INFO - 'TERM': 'linux', 08:15:57 INFO - 'TMOUT': '86400', 08:15:57 INFO - 'USER': 'cltbld', 08:15:57 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466174075.94240-979900600', 08:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:57 INFO - '_': '/tools/buildbot/bin/python'} 08:15:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:58 INFO - Downloading/unpacking psutil>=3.1.1 08:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:16:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:16:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:16:00 INFO - Installing collected packages: psutil 08:16:00 INFO - Running setup.py install for psutil 08:16:00 INFO - building 'psutil._psutil_linux' extension 08:16:00 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 08:16:00 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 08:16:00 INFO - building 'psutil._psutil_posix' extension 08:16:00 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 08:16:00 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 08:16:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:16:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:16:00 INFO - Successfully installed psutil 08:16:00 INFO - Cleaning up... 08:16:00 INFO - Return code: 0 08:16:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:16: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')]} 08:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16: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')]} 08:16:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:00 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 0x7fc4c6355f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17443b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d6990>, '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 0x1742470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1742900>, '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': '826874ccc97bd7bf541b4875000001d5-1466174075.94240-979900600', '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 08:16:00 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 08:16:00 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 08:16:00 INFO - Using env: {'DISPLAY': ':0', 08:16:00 INFO - 'HOME': '/home/cltbld', 08:16:00 INFO - 'LANG': 'en_US.UTF-8', 08:16:00 INFO - 'LANGUAGE': 'en_US:en', 08:16:00 INFO - 'LOGNAME': 'cltbld', 08:16:00 INFO - 'MAIL': '/var/mail/cltbld', 08:16:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:00 INFO - 'MOZ_NO_REMOTE': '1', 08:16:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:00 INFO - 'NO_EM_RESTART': '1', 08:16:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:00 INFO - 'PWD': '/builds/slave/test', 08:16:00 INFO - 'SHELL': '/bin/bash', 08:16:00 INFO - 'SHLVL': '1', 08:16:00 INFO - 'TERM': 'linux', 08:16:00 INFO - 'TMOUT': '86400', 08:16:00 INFO - 'USER': 'cltbld', 08:16:00 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466174075.94240-979900600', 08:16:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:00 INFO - '_': '/tools/buildbot/bin/python'} 08:16:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:16:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:16:02 INFO - Installing collected packages: mozsystemmonitor 08:16:02 INFO - Running setup.py install for mozsystemmonitor 08:16:03 INFO - Successfully installed mozsystemmonitor 08:16:03 INFO - Cleaning up... 08:16:03 INFO - Return code: 0 08:16:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:16:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc4c6355f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17443b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d6990>, '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 0x1742470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1742900>, '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': '826874ccc97bd7bf541b4875000001d5-1466174075.94240-979900600', '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 08:16:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:16:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:16:03 INFO - Using env: {'DISPLAY': ':0', 08:16:03 INFO - 'HOME': '/home/cltbld', 08:16:03 INFO - 'LANG': 'en_US.UTF-8', 08:16:03 INFO - 'LANGUAGE': 'en_US:en', 08:16:03 INFO - 'LOGNAME': 'cltbld', 08:16:03 INFO - 'MAIL': '/var/mail/cltbld', 08:16:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:03 INFO - 'MOZ_NO_REMOTE': '1', 08:16:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:03 INFO - 'NO_EM_RESTART': '1', 08:16:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:03 INFO - 'PWD': '/builds/slave/test', 08:16:03 INFO - 'SHELL': '/bin/bash', 08:16:03 INFO - 'SHLVL': '1', 08:16:03 INFO - 'TERM': 'linux', 08:16:03 INFO - 'TMOUT': '86400', 08:16:03 INFO - 'USER': 'cltbld', 08:16:03 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466174075.94240-979900600', 08:16:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:03 INFO - '_': '/tools/buildbot/bin/python'} 08:16:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:03 INFO - Downloading/unpacking jsonschema==2.5.1 08:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:16:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:16: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 08:16: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 08:16: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 08:16: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 08:16: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 08:16: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 08:16:07 INFO - Downloading functools32-3.2.3-2.tar.gz 08:16:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:16:07 INFO - warning: no files found matching '*.txt' 08:16:07 INFO - no previously-included directories found matching 'build' 08:16:07 INFO - no previously-included directories found matching 'dist' 08:16:07 INFO - no previously-included directories found matching '.git*' 08:16:07 INFO - Installing collected packages: jsonschema, functools32 08:16:07 INFO - Running setup.py install for functools32 08:16:07 INFO - warning: no files found matching '*.txt' 08:16:07 INFO - no previously-included directories found matching 'build' 08:16:07 INFO - no previously-included directories found matching 'dist' 08:16:07 INFO - no previously-included directories found matching '.git*' 08:16:07 INFO - Successfully installed jsonschema functools32 08:16:07 INFO - Cleaning up... 08:16:07 INFO - Return code: 0 08:16:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:16:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4c6355f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17443b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d6990>, '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 0x1742470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1742900>, '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': '826874ccc97bd7bf541b4875000001d5-1466174075.94240-979900600', '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 08:16:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:16:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:16:07 INFO - Using env: {'DISPLAY': ':0', 08:16:07 INFO - 'HOME': '/home/cltbld', 08:16:07 INFO - 'LANG': 'en_US.UTF-8', 08:16:07 INFO - 'LANGUAGE': 'en_US:en', 08:16:07 INFO - 'LOGNAME': 'cltbld', 08:16:07 INFO - 'MAIL': '/var/mail/cltbld', 08:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:07 INFO - 'MOZ_NO_REMOTE': '1', 08:16:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:07 INFO - 'NO_EM_RESTART': '1', 08:16:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:07 INFO - 'PWD': '/builds/slave/test', 08:16:07 INFO - 'SHELL': '/bin/bash', 08:16:07 INFO - 'SHLVL': '1', 08:16:07 INFO - 'TERM': 'linux', 08:16:07 INFO - 'TMOUT': '86400', 08:16:07 INFO - 'USER': 'cltbld', 08:16:07 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466174075.94240-979900600', 08:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:07 INFO - '_': '/tools/buildbot/bin/python'} 08:16:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:07 INFO - Downloading/unpacking blobuploader==1.2.4 08:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:09 INFO - Downloading blobuploader-1.2.4.tar.gz 08:16:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:16:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:16: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 08:16: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 08:16: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 08:16: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 08:16: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 08:16: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 08:16:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:16:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:16: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 08:16: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 08:16: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 08:16: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 08:16: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 08:16: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 08:16:10 INFO - Downloading docopt-0.6.1.tar.gz 08:16:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:16:10 INFO - Installing collected packages: blobuploader, requests, docopt 08:16:10 INFO - Running setup.py install for blobuploader 08:16:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:16:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:16:10 INFO - Running setup.py install for requests 08:16:10 INFO - Running setup.py install for docopt 08:16:10 INFO - Successfully installed blobuploader requests docopt 08:16:10 INFO - Cleaning up... 08:16:10 INFO - Return code: 0 08:16:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:16:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:16:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:10 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 0x7fc4c6355f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17443b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d6990>, '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 0x1742470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1742900>, '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': '826874ccc97bd7bf541b4875000001d5-1466174075.94240-979900600', '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 08:16:10 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 08:16:10 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 08:16:10 INFO - Using env: {'DISPLAY': ':0', 08:16:10 INFO - 'HOME': '/home/cltbld', 08:16:10 INFO - 'LANG': 'en_US.UTF-8', 08:16:10 INFO - 'LANGUAGE': 'en_US:en', 08:16:10 INFO - 'LOGNAME': 'cltbld', 08:16:10 INFO - 'MAIL': '/var/mail/cltbld', 08:16:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:10 INFO - 'MOZ_NO_REMOTE': '1', 08:16:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:10 INFO - 'NO_EM_RESTART': '1', 08:16:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:10 INFO - 'PWD': '/builds/slave/test', 08:16:10 INFO - 'SHELL': '/bin/bash', 08:16:10 INFO - 'SHLVL': '1', 08:16:10 INFO - 'TERM': 'linux', 08:16:10 INFO - 'TMOUT': '86400', 08:16:10 INFO - 'USER': 'cltbld', 08:16:10 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466174075.94240-979900600', 08:16:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:10 INFO - '_': '/tools/buildbot/bin/python'} 08:16:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:16:10 INFO - Running setup.py (path:/tmp/pip-_MrnXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:16:11 INFO - Running setup.py (path:/tmp/pip-kphR44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:16:11 INFO - Running setup.py (path:/tmp/pip-wcoF49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:16:11 INFO - Running setup.py (path:/tmp/pip-WqMG1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:16:11 INFO - Running setup.py (path:/tmp/pip-ehi_Bx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:16:11 INFO - Running setup.py (path:/tmp/pip-mV1mj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:16:11 INFO - Running setup.py (path:/tmp/pip-dG7AAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:16:11 INFO - Running setup.py (path:/tmp/pip-wbpgE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:16:11 INFO - Running setup.py (path:/tmp/pip-QLpjXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:16:11 INFO - Running setup.py (path:/tmp/pip-XQxDq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:16:11 INFO - Running setup.py (path:/tmp/pip-98oQQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:16:11 INFO - Running setup.py (path:/tmp/pip-K8zM8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:16:11 INFO - Running setup.py (path:/tmp/pip-7NpWN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:16:11 INFO - Running setup.py (path:/tmp/pip-TFABMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:11 INFO - Running setup.py (path:/tmp/pip-kU2zxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:16:12 INFO - Running setup.py (path:/tmp/pip-GBdh3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:16:12 INFO - Running setup.py (path:/tmp/pip-TnunFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:16:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:16:12 INFO - Running setup.py install for manifestparser 08:16:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:16:12 INFO - Running setup.py install for mozcrash 08:16:12 INFO - Running setup.py install for mozdebug 08:16:12 INFO - Running setup.py install for mozdevice 08:16:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:16:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:16:12 INFO - Running setup.py install for mozfile 08:16:12 INFO - Running setup.py install for mozhttpd 08:16:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:16:12 INFO - Running setup.py install for mozinfo 08:16:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:16:12 INFO - Running setup.py install for mozInstall 08:16:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:16:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:16:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:16:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:16:12 INFO - Running setup.py install for mozleak 08:16:13 INFO - Running setup.py install for mozlog 08:16:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:16:13 INFO - Running setup.py install for moznetwork 08:16:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:16:13 INFO - Running setup.py install for mozprocess 08:16:13 INFO - Running setup.py install for mozprofile 08:16:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:16:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:16:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:16:13 INFO - Running setup.py install for mozrunner 08:16:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:16:13 INFO - Running setup.py install for mozscreenshot 08:16:13 INFO - Running setup.py install for moztest 08:16:13 INFO - Running setup.py install for mozversion 08:16:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:16:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:16:13 INFO - Cleaning up... 08:16:13 INFO - Return code: 0 08:16:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:16: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')]} 08:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16: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')]} 08:16:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:13 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 0x7fc4c6355f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17443b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d6990>, '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 0x1742470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1742900>, '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': '826874ccc97bd7bf541b4875000001d5-1466174075.94240-979900600', '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 08:16:13 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 08:16:13 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 08:16:13 INFO - Using env: {'DISPLAY': ':0', 08:16:13 INFO - 'HOME': '/home/cltbld', 08:16:13 INFO - 'LANG': 'en_US.UTF-8', 08:16:13 INFO - 'LANGUAGE': 'en_US:en', 08:16:13 INFO - 'LOGNAME': 'cltbld', 08:16:13 INFO - 'MAIL': '/var/mail/cltbld', 08:16:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:13 INFO - 'MOZ_NO_REMOTE': '1', 08:16:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:13 INFO - 'NO_EM_RESTART': '1', 08:16:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:13 INFO - 'PWD': '/builds/slave/test', 08:16:13 INFO - 'SHELL': '/bin/bash', 08:16:13 INFO - 'SHLVL': '1', 08:16:13 INFO - 'TERM': 'linux', 08:16:13 INFO - 'TMOUT': '86400', 08:16:13 INFO - 'USER': 'cltbld', 08:16:13 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466174075.94240-979900600', 08:16:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:13 INFO - '_': '/tools/buildbot/bin/python'} 08:16:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:16:14 INFO - Running setup.py (path:/tmp/pip-3SuV_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:16:14 INFO - Running setup.py (path:/tmp/pip-ccLUZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:16:14 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)) 08:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:16:14 INFO - Running setup.py (path:/tmp/pip-zmdyly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:16:14 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)) 08:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:16:14 INFO - Running setup.py (path:/tmp/pip-4MnZ0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:16:14 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)) 08:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:16:14 INFO - Running setup.py (path:/tmp/pip-VCE24c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:16:14 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)) 08:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:16:14 INFO - Running setup.py (path:/tmp/pip-o1np4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:16:14 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)) 08:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:16:14 INFO - Running setup.py (path:/tmp/pip-6TT1Zq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:16:14 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)) 08:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:16:14 INFO - Running setup.py (path:/tmp/pip-pblgN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:16:14 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)) 08:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:16:14 INFO - Running setup.py (path:/tmp/pip-qqtJm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:16:14 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)) 08:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:16:14 INFO - Running setup.py (path:/tmp/pip-hjR8iY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:16:14 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)) 08:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:16:14 INFO - Running setup.py (path:/tmp/pip-vwaGFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:16:14 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)) 08:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:16:14 INFO - Running setup.py (path:/tmp/pip-gfPuzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:16:15 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)) 08:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:16:15 INFO - Running setup.py (path:/tmp/pip-xhBdZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:16:15 INFO - Running setup.py (path:/tmp/pip-cVTHv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:16:15 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)) 08:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:15 INFO - Running setup.py (path:/tmp/pip-49tdKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:16:15 INFO - Running setup.py (path:/tmp/pip-O7z6ft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:16:15 INFO - Running setup.py (path:/tmp/pip-vOZIjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:16:15 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)) 08:16:15 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)) 08:16:15 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)) 08:16:15 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)) 08:16:15 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)) 08:16:15 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)) 08:16:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:17 INFO - Downloading blessings-1.6.tar.gz 08:16:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:16:17 INFO - Installing collected packages: blessings 08:16:17 INFO - Running setup.py install for blessings 08:16:17 INFO - Successfully installed blessings 08:16:17 INFO - Cleaning up... 08:16:17 INFO - Return code: 0 08:16:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:16:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:16:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:16:17 INFO - Reading from file tmpfile_stdout 08:16:17 INFO - Current package versions: 08:16:17 INFO - argparse == 1.2.1 08:16:17 INFO - blessings == 1.6 08:16:17 INFO - blobuploader == 1.2.4 08:16:17 INFO - docopt == 0.6.1 08:16:17 INFO - functools32 == 3.2.3-2 08:16:17 INFO - jsonschema == 2.5.1 08:16:17 INFO - manifestparser == 1.1 08:16:17 INFO - mozInstall == 1.12 08:16:17 INFO - mozcrash == 0.17 08:16:17 INFO - mozdebug == 0.1 08:16:17 INFO - mozdevice == 0.48 08:16:17 INFO - mozfile == 1.2 08:16:17 INFO - mozhttpd == 0.7 08:16:17 INFO - mozinfo == 0.9 08:16:17 INFO - mozleak == 0.1 08:16:17 INFO - mozlog == 3.2 08:16:17 INFO - moznetwork == 0.27 08:16:17 INFO - mozprocess == 0.22 08:16:17 INFO - mozprofile == 0.28 08:16:17 INFO - mozrunner == 6.11 08:16:17 INFO - mozscreenshot == 0.1 08:16:17 INFO - mozsystemmonitor == 0.3 08:16:17 INFO - moztest == 0.7 08:16:17 INFO - mozversion == 1.4 08:16:17 INFO - psutil == 3.1.1 08:16:17 INFO - requests == 1.2.3 08:16:17 INFO - wsgiref == 0.1.2 08:16:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:16: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')]} 08:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16: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')]} 08:16:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:17 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 0x7fc4c6355f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17443b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d6990>, '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 0x1742470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1742900>, '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': '826874ccc97bd7bf541b4875000001d5-1466174075.94240-979900600', '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 08:16:17 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 08:16:17 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 08:16:17 INFO - Using env: {'DISPLAY': ':0', 08:16:17 INFO - 'HOME': '/home/cltbld', 08:16:17 INFO - 'LANG': 'en_US.UTF-8', 08:16:17 INFO - 'LANGUAGE': 'en_US:en', 08:16:17 INFO - 'LOGNAME': 'cltbld', 08:16:17 INFO - 'MAIL': '/var/mail/cltbld', 08:16:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:17 INFO - 'MOZ_NO_REMOTE': '1', 08:16:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:17 INFO - 'NO_EM_RESTART': '1', 08:16:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:17 INFO - 'PWD': '/builds/slave/test', 08:16:17 INFO - 'SHELL': '/bin/bash', 08:16:17 INFO - 'SHLVL': '1', 08:16:17 INFO - 'TERM': 'linux', 08:16:17 INFO - 'TMOUT': '86400', 08:16:17 INFO - 'USER': 'cltbld', 08:16:17 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466174075.94240-979900600', 08:16:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:17 INFO - '_': '/tools/buildbot/bin/python'} 08:16:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:17 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)) 08:16:17 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)) 08:16:17 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)) 08:16:17 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)) 08:16:17 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)) 08:16:17 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)) 08:16:17 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)) 08:16:17 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)) 08:16:17 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)) 08:16:17 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)) 08:16:17 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)) 08:16:17 INFO - Cleaning up... 08:16:17 INFO - Return code: 0 08:16:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:16: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')]} 08:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16: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')]} 08:16:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:17 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 0x7fc4c6355f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17443b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d6990>, '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 0x1742470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1742900>, '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': '826874ccc97bd7bf541b4875000001d5-1466174075.94240-979900600', '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 08:16:17 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 08:16:17 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 08:16:17 INFO - Using env: {'DISPLAY': ':0', 08:16:17 INFO - 'HOME': '/home/cltbld', 08:16:17 INFO - 'LANG': 'en_US.UTF-8', 08:16:17 INFO - 'LANGUAGE': 'en_US:en', 08:16:17 INFO - 'LOGNAME': 'cltbld', 08:16:17 INFO - 'MAIL': '/var/mail/cltbld', 08:16:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:17 INFO - 'MOZ_NO_REMOTE': '1', 08:16:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:17 INFO - 'NO_EM_RESTART': '1', 08:16:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:17 INFO - 'PWD': '/builds/slave/test', 08:16:17 INFO - 'SHELL': '/bin/bash', 08:16:17 INFO - 'SHLVL': '1', 08:16:17 INFO - 'TERM': 'linux', 08:16:17 INFO - 'TMOUT': '86400', 08:16:17 INFO - 'USER': 'cltbld', 08:16:17 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466174075.94240-979900600', 08:16:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:17 INFO - '_': '/tools/buildbot/bin/python'} 08:16:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:16:18 INFO - Cleaning up... 08:16:18 INFO - Return code: 0 08:16:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:16:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:16:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4c6355f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17443b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d6990>, '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 0x1742470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1742900>, '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': '826874ccc97bd7bf541b4875000001d5-1466174075.94240-979900600', '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 08:16:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:16:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:16:18 INFO - Using env: {'DISPLAY': ':0', 08:16:18 INFO - 'HOME': '/home/cltbld', 08:16:18 INFO - 'LANG': 'en_US.UTF-8', 08:16:18 INFO - 'LANGUAGE': 'en_US:en', 08:16:18 INFO - 'LOGNAME': 'cltbld', 08:16:18 INFO - 'MAIL': '/var/mail/cltbld', 08:16:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:18 INFO - 'MOZ_NO_REMOTE': '1', 08:16:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:18 INFO - 'NO_EM_RESTART': '1', 08:16:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:18 INFO - 'PWD': '/builds/slave/test', 08:16:18 INFO - 'SHELL': '/bin/bash', 08:16:18 INFO - 'SHLVL': '1', 08:16:18 INFO - 'TERM': 'linux', 08:16:18 INFO - 'TMOUT': '86400', 08:16:18 INFO - 'USER': 'cltbld', 08:16:18 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466174075.94240-979900600', 08:16:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:18 INFO - '_': '/tools/buildbot/bin/python'} 08:16:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:18 INFO - Downloading/unpacking flake8 08:16:18 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 08:16:18 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 08:16:18 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 08:16:18 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 08:16:18 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 08:16:18 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 08:16:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:16:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:16:20 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 08:16:20 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 08:16:20 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 08:16:20 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 08:16:20 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 08:16:20 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 08:16:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:16:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:16:20 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 08:16:20 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 08:16:20 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 08:16:20 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 08:16:20 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 08:16:20 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 08:16:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:16:20 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 08:16:20 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 08:16:20 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 08:16:20 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 08:16:20 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 08:16:20 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 08:16:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:16:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:16:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:16:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:16:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:16:20 INFO - no previously-included directories found matching 'docs/_build' 08:16:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:16:21 INFO - Running setup.py install for pep8 08:16:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:16:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:16:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:16:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:16:21 INFO - no previously-included directories found matching 'docs/_build' 08:16:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:16:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:16:21 INFO - Cleaning up... 08:16:21 INFO - Return code: 0 08:16:21 INFO - Running post-action listener: _resource_record_post_action 08:16:21 INFO - Running post-action listener: _start_resource_monitoring 08:16:21 INFO - Starting resource monitoring. 08:16:21 INFO - ##### 08:16:21 INFO - ##### Finished create-virtualenv step (success) 08:16:21 INFO - ##### 08:16:21 INFO - ##### 08:16:21 INFO - ##### Running install step. 08:16:21 INFO - ##### 08:16:21 INFO - Running pre-action listener: _resource_record_pre_action 08:16:21 INFO - Running main action method: install 08:16:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:16:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:16:21 INFO - Reading from file tmpfile_stdout 08:16:21 INFO - Detecting whether we're running mozinstall >=1.0... 08:16:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:16:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:16:21 INFO - Reading from file tmpfile_stdout 08:16:21 INFO - Output received: 08:16:21 INFO - Usage: mozinstall [options] installer 08:16:21 INFO - Options: 08:16:21 INFO - -h, --help show this help message and exit 08:16:21 INFO - -d DEST, --destination=DEST 08:16:21 INFO - Directory to install application into. [default: 08:16:21 INFO - "/builds/slave/test"] 08:16:21 INFO - --app=APP Application being installed. [default: firefox] 08:16:21 INFO - mkdir: /builds/slave/test/build/application 08:16:21 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'] 08:16:21 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 08:16:38 INFO - Reading from file tmpfile_stdout 08:16:38 INFO - Output received: 08:16:38 INFO - /builds/slave/test/build/application/firefox/firefox 08:16:38 INFO - Running post-action listener: _resource_record_post_action 08:16:38 INFO - ##### 08:16:38 INFO - ##### Finished install step (success) 08:16:38 INFO - ##### 08:16:38 INFO - ##### 08:16:38 INFO - ##### Running run-tests step. 08:16:38 INFO - ##### 08:16:38 INFO - Running pre-action listener: _resource_record_pre_action 08:16:38 INFO - Running main action method: run_tests 08:16:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:16:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:16:38 INFO - Python 2.7.3 08:16:38 INFO - Return code: 0 08:16:38 INFO - grabbing minidump binary from tooltool 08:16:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:16:38 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d6990>, '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 0x1742470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1742900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:16:38 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:16:38 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:16:38 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:16:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:16:38 INFO - Return code: 0 08:16:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:16:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:16:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:16:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:16:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:16:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:16:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:16:39 INFO - Return code: 0 08:16:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:16:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:16:39 INFO - Using env: {'DISPLAY': ':0', 08:16:39 INFO - 'HOME': '/home/cltbld', 08:16:39 INFO - 'LANG': 'en_US.UTF-8', 08:16:39 INFO - 'LANGUAGE': 'en_US:en', 08:16:39 INFO - 'LOGNAME': 'cltbld', 08:16:39 INFO - 'MAIL': '/var/mail/cltbld', 08:16:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:16:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:16:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:39 INFO - 'MOZ_NO_REMOTE': '1', 08:16:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:16:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:39 INFO - 'NO_EM_RESTART': '1', 08:16:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:39 INFO - 'PWD': '/builds/slave/test', 08:16:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:16:39 INFO - 'SHELL': '/bin/bash', 08:16:39 INFO - 'SHLVL': '1', 08:16:39 INFO - 'TERM': 'linux', 08:16:39 INFO - 'TMOUT': '86400', 08:16:39 INFO - 'USER': 'cltbld', 08:16:39 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466174075.94240-979900600', 08:16:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:39 INFO - '_': '/tools/buildbot/bin/python'} 08:16:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:16:39 INFO - mozversion application_buildid: 20160617053003 08:16:39 INFO - mozversion application_changeset: 6b61c987f9ed4c5c4927da0c0edff369d8fa7fb5 08:16:39 INFO - mozversion application_display_name: Nightly 08:16:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:16:39 INFO - mozversion application_name: Firefox 08:16:39 INFO - mozversion application_remotingname: firefox 08:16:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:16:39 INFO - mozversion application_vendor: Mozilla 08:16:39 INFO - mozversion application_version: 50.0a1 08:16:39 INFO - mozversion platform_buildid: 20160617053003 08:16:39 INFO - mozversion platform_changeset: 6b61c987f9ed4c5c4927da0c0edff369d8fa7fb5 08:16:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:16:39 INFO - mozversion platform_version: 50.0a1 08:16:39 INFO - using testdate: 1466176599 08:16:39 INFO - actual date: 1466176599 08:16:39 INFO - starting webserver on 'localhost:35492' 08:16:39 INFO - SUITE-START | Running 2 tests 08:16:39 INFO - TEST-START | dromaeo_css 08:16:39 INFO - operating with platform_type : linux_ 08:16:39 INFO - Initialising browser for dromaeo_css test... 08:16:39 INFO - TEST-INFO | started process 28655 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK1jDOW/profile http://localhost:35492/getInfo.html) 08:16:44 INFO - PROCESS | 28655 | __metrics Screen width/height:1600/1200 08:16:44 INFO - PROCESS | 28655 | colorDepth:24 08:16:44 INFO - PROCESS | 28655 | Browser inner width/height: 1024/697 08:16:44 INFO - PROCESS | 28655 | __metrics 08:16:44 ERROR - PROCESS | 28655 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 08:16:45 INFO - TEST-INFO | 28655: exit 0 08:16:45 INFO - Browser initialized. 08:16:45 INFO - Running cycle 1/1 for dromaeo_css test... 08:16:45 INFO - TEST-INFO | started process 28774 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK1jDOW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:16:57 INFO - PROCESS | 28774 | RSS: Main: 185245696 08:16:57 INFO - PROCESS | 28774 | 08:17:46 INFO - PROCESS | 28774 | 1466176666978 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] 08:19:53 INFO - PROCESS | 28774 | Cycle 1(1): loaded http://localhost:35492/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35492/tests/dromaeo/cssquery-ext.html) 08:19:54 INFO - PROCESS | 28774 | RSS: Main: 189816832 08:19:54 INFO - PROCESS | 28774 | 08:22:56 INFO - PROCESS | 28774 | Cycle 1(1): loaded http://localhost:35492/tests/dromaeo/cssquery-ext.html (next: http://localhost:35492/tests/dromaeo/cssquery-jquery.html) 08:22:57 INFO - PROCESS | 28774 | RSS: Main: 188006400 08:22:57 INFO - PROCESS | 28774 | 08:25:58 INFO - PROCESS | 28774 | Cycle 1(1): loaded http://localhost:35492/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35492/tests/dromaeo/cssquery-mootools.html) 08:25:59 INFO - PROCESS | 28774 | RSS: Main: 189120512 08:25:59 INFO - PROCESS | 28774 | 08:29:01 INFO - PROCESS | 28774 | Cycle 1(1): loaded http://localhost:35492/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35492/tests/dromaeo/cssquery-prototype.html) 08:29:01 INFO - PROCESS | 28774 | RSS: Main: 186515456 08:29:01 INFO - PROCESS | 28774 | 08:32:04 INFO - PROCESS | 28774 | Cycle 1(1): loaded http://localhost:35492/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35492/tests/dromaeo/cssquery-yui.html) 08:32:04 INFO - PROCESS | 28774 | RSS: Main: 188850176 08:32:04 INFO - PROCESS | 28774 | 08:35:07 INFO - PROCESS | 28774 | Cycle 1(1): loaded http://localhost:35492/tests/dromaeo/cssquery-yui.html (next: http://localhost:35492/tests/dromaeo/cssquery-dojo.html) 08:35:07 INFO - PROCESS | 28774 | RSS: Main: 189476864 08:35:07 INFO - PROCESS | 28774 | 08:35:07 INFO - PROCESS | 28774 | __start_tp_report 08:35:07 INFO - PROCESS | 28774 | _x_x_mozilla_page_load 08:35:07 INFO - PROCESS | 28774 | _x_x_mozilla_page_load_details 08:35:07 INFO - PROCESS | 28774 | |i|pagename|runs| 08:35:07 INFO - PROCESS | 28774 | |0;dojo.html;2814.8170368926017;2888.0758157389632;2888.610037644917;2892.6094977178072;2898.536234202527;4704.835330763424;4757.357756702844;4774.14065468216;4806.5193480651915;4851.975740121304;4686.156491831469;4755.500672429397;4784.497627749089;4826.469088400273;4867.245576935572;4367.213901497729;4437.378766972626;4460.55394460553;4489;4509.436320459942;150.20965609748657;4337.696361254713;4427.313766366202;4475.418195634563;4522.819087236507;4342.848000319974;4369.257226271541;4395.626371758389;4399.340098985146;4431.6233120184825;4339.826406943718;4375.584319489675;4388.253996820548;4393.253146965024;4423.447069116361;4265.466816647919;4308.9784551077355;4324.156789426063;4376.5623437656295;4396.318570621527;4707.505711900236;4727.550882666142;4739.834105806315;4767;4808.158572249842;4907.950920490785;5058.114829904752;5108.795648174068;5109.310243117169;5111.7699703513435;5065.493450654905;5087.872803179913;5115.897682046376;5128.282040514294;5130.871728206787;4797.0645724083815;4811.9037619247765;4822.71063736177;4823.493533179001;4869.634777391674;4994.525520075587;5112.36095488064;5222.451642577551;5229.424763276036;5276.314079169683;4991.326170966873;4996.725180115129;4997;5010.824621138316;5058.266551350107;5047.394312682428;5065.468125846733;5075.720835354091;5076.111680455905;5122.078025955289;4957.925631115536;4992.151334273182;4993.17612593918;5052.974735126374;5063.772130254148;4931.654784165074;5007.7245751484015;5011.298418221452;5056.988602279559;5111.284420181103;4063.065494936181;4076.735012224196;4078.8368465261055;4081.469408976814;4116.9707573106725;3578.0875876651808;3622.529071220777;3626.0934766308424;3668.321360548307;3703.0372103252807;4936.3829521309835;4945.604351651859;4947.886725486808;4956.752162391866;4994.550490455877;5076.7207803571155;5116.386033675983;5120.257562653469;5126.769295381717;5142.948570514322;4802.6638135330195;4918.2376731606655;4929.728864912464;4939.357883475197;4964.8758781030765;4467.30756732707;4469.664775141878;4476.552344765498;4483.708558943658;4540.137373898949;5181.093308670967;5287.9471205287455;5292.894142117136;5309;5326.2543243945875;5029.748512574357;5040.621953353587;5080.46655101209;5087.4403815581;5102.591792656504;5257.63196576236;5259.15853463444;5271.262023316815;5282.31329927107;5314.840554783363;4879.365682461257;4938.827141050046;4982.128127577732;4984.37695288089;5006.874828129326;5008.69947803133;5062.367204099488;5069.03688299222;5077.517635824591;5124.948750512447;4953.975230123826;4958.330625365529;4962.106820772296;4980.726060066586;4998.400191976986;4832.975835120802;4947.851564453073;4980.178270585313;4991.850244492671;5008.248762685481;4773.11697335994;4830.396200474941;4924.655274130777;4962.082014827269;4998.850034498971;5002.924956125734;5021.548060674557;5031.471695471922;5035.446100928822;5089.389273287081;4769.046190761931;4845;4933.136701077369;4938.308636790924;4938.827141050046 08:35:07 INFO - PROCESS | 28774 | |1;ext.html;599.1192946368836;613.0987448450777;632.7342516143219;653.545785678953;657.5200103924134;40520;42601.14797704048;42874.571254287446;42962.78518607406;45808.54191458093;43642.12715745683;43763.34354984678;43819;43894.34158487625;43925.56074439255;8737.344699147558;8910.287177025855;8965.95517022414;8978.685745998891;8984.730458086267;8789;8878.556072196398;8881.067487913773;8899.822003559924;8908.777280567972;8845.95577022114;8847.380683352168;8891.422057566237;8910.198082172603;8918;8826.779330516723;8872.556372181398;8886.600102995348;8909.955450222773;8963.775905602346;8795.824083518293;8934;8957.6864809732;8958.283337332998;8965.596548155349;42013.579864201274;42262.57737422617;42288.365674514906;42314.61483081346;42782.78608606937;3454.5854497460464;3540.4689296605716;3604.153024039375;3666.211764470625;3691.298653255873;31899.52150717741;32216.355672886646;32418.18954526132;32422.675773242438;32972.3405531888;4445.11097780442;4467.508574056851;4495.910081798378;4502.707324023928;4551.340055691906;330155;333893;334937;335066;335707;33614.83192584071;35009.64990350115;58530;59401.40598594045;59539.40460595425;35845;36287.637123628425;36374.636253637655;36472.27055458876;36711.63288367082;12760.042996775279;12778.808317875239;12784.105112642212;12810.59083500814;12838.80741788874;11693.473793679304;11755.235909665844;11755.706107347385;11789.587364442375;11799.76400472003;8200.58997050145;8326.25063744266;8332.250097491255;8349.83300334002;8453.830923381498;3212.2932954749917;3254.4792833146585;3310.1393637654382;3322.302316513511;3332.900012999614;951.2580187453797;1083.0360978728938;1090.5583238788304;1097.5280629329304;1141.611851970334;30742.846285768428;31179.84410077935;31245;31342.686573134433;31422.685773141977;1102.72431892027;1109.3066833229232;1181.0964612071773;1193.003841792096;1218.0255795363673;16381.25607234484;16414.835851641332;16633.667326653398;16700.49898503047;16969.15154242283;539340;539539;540284;542097;545615;55918.440815592134;56280;56484.71757641186;56493.43506564964;56727;1326.8341457317836;1339.361457927861;1343.6976680246867;1345.6030471011074;1367.6375760423496;30223.69776302209;30327.696723032488;30518;31187.84406077955;31408.05775826729;49775.50224497853;50052;50254.49745502498;50436.747816260686;50564.49435505745;441771;442412;442857;446111;448177;27834.44331113407;27928.045036847227;27971.04202705791;28064.71935280621;28142.43715125727;46669;47194.52805471901;47529;48269.75865120652;48807.511924880295;39804.800975994935;40341.59658403378;40366.39450408187;41005;41260.38109428301;39614.40578391269;40492.797536012135;40908.59091409048;40938.59061409467;41708.79145604253;39673.60326396814;40229;40487.392689110275;40778;42729;33387.66612333846;36785;37076;37459.62540374562;37480.250394992494;27331.316717081438;28056.859715701292;28404.307440032662;28500;28517.857410712815 08:35:07 INFO - PROCESS | 28774 | |2;jquery.html;393.6122918924859;394.8045717369902;399.79410603539185;400.67745464900753;410.68787721331796;13027.28349940753;14196.077254978445;17149.82850171498;18851.43445696631;18951.71572426413;16709;17374.739378909326;17911.283548658037;18021.819781802176;18065.4580362589;5599.916001259974;5669.971650141743;5768.913466298009;5780.71096445176;5784.652920824764;5608.915866262009;5683.232763576905;5703.9714801425935;5718;5744.253247077874;5610.438956104377;5663.886722265553;5687.886242275152;5704.172894930232;5719.313682358123;5568.470995255444;5651.350094739117;5694.5159661428825;5698.0883058710615;5698.287714035746;4758.595519380857;5073.949260507421;5074.340335756328;5076.289319495274;5113.590912726973;12617.432215550321;12674.112812103156;12921.612351629467;12973.740525189538;12994.350282485932;2125.7342832145982;2323.2565579014554;2324.3491822289784;2329.2779238436137;2339.298210536849;9780.217582593446;9815.607375704963;9851.261155413302;9908.603655853758;10113.949430252802;1774.943908374515;1831.5054935167564;1893.214316058834;1895.649304878602;1971.704244363357;76496;84549;85442;86447.56776216079;88027.55986220091;10039.14667253277;10097.596096156072;10399.272050956512;10462.47687615616;10519.894801052045;14812.111273323635;14874.330655120546;14895.92552037233;14910.478133265284;14942.701145977237;7455.85088298231;7554.169041405441;7608.961955190189;7705.961470192725;7740.225977402328;7410.629468526552;7495.925040749632;7529.058867641545;7651.311381975537;7677.30904218623;4500.752458614742;4567.132244873464;4633.536646335339;4720.150372932836;4744.383230180055;1808.6111486030566;1941.6602094633383;1950.3368854589507;1977.67368384215;1985.860989730705;893.4862454088795;945.8486642137225;955.1737746848926;982.8230918434607;1010.3836659637615;17477.912610436866;17600.471985840446;17892.194851231725;18211.54471138232;18290.359837405627;949.8290307744534;957.1720461800493;964.3538828984597;981.764376549623;1006.059334522224;9131.223845973034;10054.748631284276;10065.345752526062;10069.395836249849;10088.49557522121;453124;455529;459655;461204;465157;87075.56462217648;90740.5462972681;91274.54362728144;91715;92992.53503732439;945.432740355781;946.6166202687922;961.2694352292308;964.8842138943372;992.4690290694443;16005.839941600902;16314.184290785175;16330.428435004718;16460.34158633689;16586.75119873179;39044;40166;40456.39315410212;40819.795901020305;40934.79532602318;56314.718426407606;56753;57288.42711572831;57518.42481575131;57624.423755763586;8054.597270136587;8085.919140808516;8256.917430825615;8348.499090054373;8388;8758.47449153053;11998.220115692453;12997.40051989587;13336.266505342299;13361.26513041753;10299.3820370778;10857.457127143769;11284.43577821122;12054.276743395074;12142.575009874612;11578.478968446609;11659.825102623638;11668.708282292671;11737.941310293736;11747.353895535827;11889.464974076014;12042.277463352228;12177.69555761113;12226.327551984727;12353.32056736852;8410.789730256793;8432.704855330034;8437;8609.87085193735;8613.621820508939;10524.210684198868;11782.52869885195;12024.939875300568;12047.698807529881;12100.394980251129 08:35:07 INFO - PROCESS | 28774 | |3;mootools.html;1418.2837666978176;1476.1438365747863;1524.5197762704747;1707.4962885948644;1726.6546690661871;7951.681932722699;8698.130186981298;8797.120287971207;9371;9387.389819661727;8804;8887.733367998953;9097.772555686111;9147.817043659123;9148.130927561888;2426.575349313872;2462.8645424501647;2464.125235541384;2464.2853572464055;2467.2968204061845;2402.855828650278;2404.7475015123423;2454.607262837946;2463.864487453189;2465.9136930207446;2407.458321877581;2414.9517009659885;2434.1358817619757;2449.8285120041605;2455.005722682308;2357.127862690807;2369.7156341239074;2383.570957227707;2399.124319623342;2423.551642946061;2354.564405584972;2357.0807385119815;2358.5872472317274;2360.492494113774;2364.385259832439;9094.81810363789;9203.033681463417;9208.861867071932;9227.077292270786;9241.537923103886;5253.763580638881;5428.4842939920645;5434.239206511052;5434.3207099112615;5448.4279150689;3355.748318876094;3430.1596108953217;3470.3753324401596;3497.6152623211683;3611.927761444783;1160.280626011878;1197.4671271284283;1203.3622180244483;1204.1450570095242;1213.6905089202285;13084.934575327063;13088.934555327163;13112.606621801362;13117.737645247042;13121.803172952317;4774.474807771212;4838.879028024327;4841.685290456179;4869.70781753096;4939.382577177853;10852.511636976355;10876.782464350668;10913.39976301311;10928;10933.945330273456;5419.105847535191;5434.809781657623;5435.945640543623;5442.591805614516;5442.673439593637;4243.469566304212;4765.928511072337;4875.219964805614;4932.53140951609;4933.531314525115;4099.323611604052;4105.91287234994;4136.028033412145;4155;4171.749695018309;1300.1029289790015;1314.1326724361875;1316.1313533068128;1316.3352506983913;1321.5110409148485;783.7374479549414;833.2459124492344;949.027247071757;951.5242378810594;975.5707488705089;5770.134479827975;6018.127371531104;6071.939280607137;6155.292141403706;6285.968570157212;901.7790641292926;911.7492689510437;934.8130373925242;940.8024314893948;949.5489642419933;4045.3527435610163;4158.500979882373;4170.520390155171;4190.832366705297;4280.914381712349;11265.831012534818;11560.421978901022;11571.19001669875;11583.826242606368;11594.304341739522;10842.40366779819;11427.771444571063;11432.657020289405;11498.367589782642;11550.88449115498;7948.523088614702;8295.792605184797;8306.08633050364;8348.123447038095;8394.580270986426;5921.171036055042;6180.196574445294;6223.724136552087;6234.438900498977;6351.301356850835;10473.21450891171;10606.840897386392;10619.893801061891;10649.840252396376;10811.837822432828;10703.197260205672;10972;10972.122230221723;11142.220044596801;11150.275232109887;7454.776356709307;8013.078495972804;8167.224113709188;8226.917730822615;8328.333733301442;8956.462612243286;8978.86531702012;9000.909990900007;9011.864822027806;9023.503707296162;7774.766756997073;7996.56018918965;8011.238932301422;8092.83814323722;8137.79655508617;7974.840503189787;8015.238552337519;8093;8113.918860811553;8189.836203276021;6625.602463852184;6796.524243303119;7285.089363829521;7406.925930740839;7428.73999410018;5005.899882002413;5080.288759573737;5113.488651134857;5172.043172013189;5176.4047134580005;5087.9061001884775;5175.560077393313;5184.662996905189;5266.210068489757;5323.733813309396 08:35:07 INFO - PROCESS | 28774 | |4;prototype.html;324.49702960411366;324.50836981972316;328.51707989255783;329.8499182871794;331.9502074688798;4926.261060840871;4956.603471722263;5002.474740152277;5003.299538064669;5009.323741294924;4946.332245146904;4958.479359667237;4963.280324352976;4969.993154141746;4979.651424400294;3658.1769101952045;3787.4697542344093;3896.4350169225445;3917.1382295895;3922.745021573603;3892.610738926113;3897.512810898638;3899.6490315871706;3905.414187871828;3915.2169566086895;3861.4787003754554;3891.182851601167;3897.6881849452116;3899.6685281751083;3900.8244628991765;3864.401017842239;3879.7866117363533;3911.7286881763257;3918.8824335269987;3938.8621398251066;3439.2777516721517;3471.461923401877;3480.5475288212624;3491.7381196410115;3503.5795704515367;4816.614670826326;4820.613796170918;4836.379812762729;4849.272609108627;4851.878703032417;4359.629431498326;4393.7363758174615;4405.691601587891;4421.248387774086;4468.061707041526;5045.772940217662;5101.413337466165;5110.233464980245;5149.1205709915985;5161.7161056141895;3765.510483637137;3786.3563194257044;3792.4880141180865;3794.962050379516;3809.9238015239816;5237.214417837316;5280.471952804727;5292.52367286946;5354.250404943311;5397.487238712316;3761.887143385703;3873.96126038736;3876.7092468065007;3893.9415908761393;3903.1803321302846;3897.986523503853;3917.7845218513257;3926.5680775114715;3935.0555866591812;3946.861859834892;4434.3348497724955;4455.799489023002;4456.417971620093;4460.598546130864;4484.282514797616;5050.141475949097;5140.177571588602;5164.3802743671;5230.4632253357095;5233.764480598382;1322.8677132286887;1344.1330341929597;1345.3945724423852;1357.7576517486389;1359.3475131936527;844.3287586368851;865.4158443050916;890.5947793753827;902.3503077783985;902.5442151713343;4928.408590969107;5036.244563315532;5040.2691609716385;5041.941192349647;5042.755973591717;5266.94661067788;5284.762185701653;5291.814786482455;5295.682259064469;5297.490215288702;4902.852914412573;5001.974595207974;5002.374703162105;5010.148274793294;5087.211482220262;2785.637867077267;2791.6231308773463;2809.7049809770087;2831.150654803551;2835.4187391584674;5421.918671219935;5448.346198456211;5479.671219726829;5488.890222195613;5516.179660711956;5209.47905209476;5345.33183352081;5370.140777475585;5371.731413429313;5374.892502150014;5439.700816455133;5456.48163424474;5466.289382380265;5483.99834060565;5493.14856197298;5258;5269.104252277199;5287.387346859245;5295.76169072385;5318.787248510016;5051.4443411224;5157.613179011514;5192.610554208374;5217.217417387422;5252.080885845038;5431.8098866539485;5442.102053161342;5456.809011684572;5457.945420545744;5482.382697104284;3881.7865017424315;3882.1847412043785;3908.511436070491;3916.2754890345377;3928.1161738608585;5035.244713293036;5278.788848446019;5319.627626066293;5345.33183352081;5349.625526213128;5126.154184559506;5152.330197074356;5177.145770947752;5191.402988656202;5249.370075590953;4929.309896614405;5164.509371609691;5167.811403377169;5190.169572868323;5225.216217567243;5094.8216812412875;5137.87155321105;5139.152039913372;5163.328767260232;5174.15421518171;5066.949330506648;5232.267482552522;5240.449752776056;5250.26496290512;5250.921236181537;5086.593072554261;5106.591472682102;5131.717755523333;5149.073166829857;5153.45888681683 08:35:07 INFO - PROCESS | 28774 | |5;yui.html;739.6153999920042;755.7014979083266;756.3079781999468;763.8510490454361;786.8677220921774;12831.550895718652;15581.298841552129;15965.680686386266;16005.679886402266;16076.51770446887;11534.423278836046;14411.927940360283;14540.636484087903;14574.271286435662;14587.927060364684;758.0751483190527;778.3850757901251;783.6904422753009;784.9764507064797;788.9368850491946;767.1867820110673;769.3383690026573;771.8610650082983;771.9691212351499;776.6427443376026;815.4129027100478;815.808285053012;816.1797393619404;819.3404309530825;819.7581713394563;812.5206128384252;813.8209593889335;816.0411516468156;820.6430202861715;821.7082935557851;592.3927973826862;593.946544810969;596.2844586496221;596.4125336543501;596.9462748352669;13200.405981730844;13258.138221015699;13265.3367331634;13294.667633309147;13300.73398532024;14264.35810388535;14380.209088500129;14408.567742967623;14470.49353272641;14692.779608305884;12112.81830772539;12193.615240524497;12306.446209920576;12470.937645311715;12673.619791406272;3908.8436462541463;3919.764814111134;3933.3903244997073;3944.9211015779524;3991.501062367204;70146;75975.62012189958;77157;77722;78429;11447;11715.17993740447;11716;11841.407929603485;12104.244884491876;17202.483925482255;19006.144723487476;19072.427827165207;19203.615927681367;19252;7815.179406162385;7824.569648669378;8212.958935205404;8238.09380968093;8257.752267431986;4623.745693986863;4630.421197350332;4673.135469938073;4755.785989630475;4909.975450122726;3286.8849590264226;3415.316936612687;3416.0947348952545;3419.9487007694906;3424.6917777400154;642.213288721322;654.3750718064238;664.9135612370458;672.9865402691919;691.595416681237;719.9568025918462;720.8810546259808;724.9275072492709;725.9310365515267;731.2468157797371;9147;9516.095970882756;9584.329096963145;9842.458664773507;9856.556454959544;713.6859781696037;717.3507975282378;723.2044750774106;723.7430712097236;730.817295676081;4291.249031419551;4619.538046195421;4665.081331681404;4668.206404911173;4725.243960966298;109167.45416273027;111919;112131;116536;120168.39915800365;102743.29425292983;104453;104678.47660761648;105006;105388;58328.12507812386;73266.6336668324;85855;90358.09641903629;95235.047649524;8512.40413171072;8633.30933525329;8649.437786543855;8809.647614095364;8911.955440222757;42906.35640465458;42920.78539607282;43490.82545872757;50597;53504;24966;25400;34475;71597;75274.36539721303;12946.352682365656;13052.608421747364;13202.801957970447;13294.534691285759;13402.128861623964;14468.493602724275;14849;14978.400863965755;15568.688626227638;15729.842701573296;12938.676533086747;13223.404946777226;14384.28078596045;14391.568252952427;14912;13725.382357794122;14136.363863626368;14251;14315.212663303619;14360.712785744436;12964.870351296366;13037.932591853936;13041.543545976225;13182.472701091849;13860.306984650928;11540;11627.709307267047;11648.301101933912;12155.45300461499;12601.117921745756;11471.885281147082;11555.133364997828;11727.706807329885;11851.940740296242;12251.938740306598 08:35:07 INFO - PROCESS | 28774 | __end_tp_report 08:35:07 INFO - PROCESS | 28774 | __start_cc_report 08:35:07 INFO - PROCESS | 28774 | _x_x_mozilla_cycle_collect,349 08:35:07 INFO - PROCESS | 28774 | __end_cc_report 08:35:07 INFO - PROCESS | 28774 | __startTimestamp1466177707759__endTimestamp 08:35:07 INFO - PROCESS | 28774 | 08:35:07 INFO - PROCESS | 28774 | ------- Summary: start ------- 08:35:07 INFO - PROCESS | 28774 | Number of tests: 6 08:35:07 INFO - PROCESS | 28774 | 08:35:07 INFO - PROCESS | 28774 | [#0] dojo.html Cycles:165 Average:4733.32 Median:4939.36 stddev:607.26 (12.3%) stddev-sans-first:590.18 08:35:07 INFO - PROCESS | 28774 | Values: 2814.8 2888.1 2888.6 2892.6 2898.5 4704.8 4757.4 4774.1 4806.5 4852.0 4686.2 4755.5 4784.5 4826.5 4867.2 4367.2 4437.4 4460.6 4489.0 4509.4 150.2 4337.7 4427.3 4475.4 4522.8 4342.8 4369.3 4395.6 4399.3 4431.6 4339.8 4375.6 4388.3 4393.3 4423.4 4265.5 4309.0 4324.2 4376.6 4396.3 4707.5 4727.6 4739.8 4767.0 4808.2 4908.0 5058.1 5108.8 5109.3 5111.8 5065.5 5087.9 5115.9 5128.3 5130.9 4797.1 4811.9 4822.7 4823.5 4869.6 4994.5 5112.4 5222.5 5229.4 5276.3 4991.3 4996.7 4997.0 5010.8 5058.3 5047.4 5065.5 5075.7 5076.1 5122.1 4957.9 4992.2 4993.2 5053.0 5063.8 4931.7 5007.7 5011.3 5057.0 5111.3 4063.1 4076.7 4078.8 4081.5 4117.0 3578.1 3622.5 3626.1 3668.3 3703.0 4936.4 4945.6 4947.9 4956.8 4994.6 5076.7 5116.4 5120.3 5126.8 5142.9 4802.7 4918.2 4929.7 4939.4 4964.9 4467.3 4469.7 4476.6 4483.7 4540.1 5181.1 5287.9 5292.9 5309.0 5326.3 5029.7 5040.6 5080.5 5087.4 5102.6 5257.6 5259.2 5271.3 5282.3 5314.8 4879.4 4938.8 4982.1 4984.4 5006.9 5008.7 5062.4 5069.0 5077.5 5124.9 4954.0 4958.3 4962.1 4980.7 4998.4 4833.0 4947.9 4980.2 4991.9 5008.2 4773.1 4830.4 4924.7 4962.1 4998.9 5002.9 5021.5 5031.5 5035.4 5089.4 4769.0 4845.0 4933.1 4938.3 4938.8 08:35:07 INFO - PROCESS | 28774 | 08:35:07 INFO - PROCESS | 28774 | [#1] ext.html Cycles:180 Average:58529.60 Median:40843.30 stddev:119125.39 (291.7%) stddev-sans-first:119380.16 08:35:07 INFO - PROCESS | 28774 | Values: 599.1 613.1 632.7 653.5 657.5 40520.0 42601.1 42874.6 42962.8 45808.5 43642.1 43763.3 43819.0 43894.3 43925.6 8737.3 8910.3 8966.0 8978.7 8984.7 8789.0 8878.6 8881.1 8899.8 8908.8 8846.0 8847.4 8891.4 8910.2 8918.0 8826.8 8872.6 8886.6 8910.0 8963.8 8795.8 8934.0 8957.7 8958.3 8965.6 42013.6 42262.6 42288.4 42314.6 42782.8 3454.6 3540.5 3604.2 3666.2 3691.3 31899.5 32216.4 32418.2 32422.7 32972.3 4445.1 4467.5 4495.9 4502.7 4551.3 330155.0 333893.0 334937.0 335066.0 335707.0 33614.8 35009.6 58530.0 59401.4 59539.4 35845.0 36287.6 36374.6 36472.3 36711.6 12760.0 12778.8 12784.1 12810.6 12838.8 11693.5 11755.2 11755.7 11789.6 11799.8 8200.6 8326.3 8332.3 8349.8 8453.8 3212.3 3254.5 3310.1 3322.3 3332.9 951.3 1083.0 1090.6 1097.5 1141.6 30742.8 31179.8 31245.0 31342.7 31422.7 1102.7 1109.3 1181.1 1193.0 1218.0 16381.3 16414.8 16633.7 16700.5 16969.2 539340.0 539539.0 540284.0 542097.0 545615.0 55918.4 56280.0 56484.7 56493.4 56727.0 1326.8 1339.4 1343.7 1345.6 1367.6 30223.7 30327.7 30518.0 31187.8 31408.1 49775.5 50052.0 50254.5 50436.7 50564.5 441771.0 442412.0 442857.0 446111.0 448177.0 27834.4 27928.0 27971.0 28064.7 28142.4 46669.0 47194.5 47529.0 48269.8 48807.5 39804.8 40341.6 40366.4 41005.0 41260.4 39614.4 40492.8 40908.6 40938.6 41708.8 39673.6 40229.0 40487.4 40778.0 42729.0 33387.7 36785.0 37076.0 37459.6 37480.3 27331.3 28056.9 28404.3 28500.0 28517.9 08:35:07 INFO - PROCESS | 28774 | 08:35:07 INFO - PROCESS | 28774 | [#2] jquery.html Cycles:180 Average:27499.23 Median:2455.72 stddev:75976.34 (3093.9%) stddev-sans-first:76162.21 08:35:07 INFO - PROCESS | 28774 | Values: 393.6 394.8 399.8 400.7 410.7 13027.3 14196.1 17149.8 18851.4 18951.7 16709.0 17374.7 17911.3 18021.8 18065.5 5599.9 5670.0 5768.9 5780.7 5784.7 5608.9 5683.2 5704.0 5718.0 5744.3 5610.4 5663.9 5687.9 5704.2 5719.3 5568.5 5651.4 5694.5 5698.1 5698.3 4758.6 5073.9 5074.3 5076.3 5113.6 12617.4 12674.1 12921.6 12973.7 12994.4 2125.7 2323.3 2324.3 2329.3 2339.3 9780.2 9815.6 9851.3 9908.6 10113.9 1774.9 1831.5 1893.2 1895.6 1971.7 76496.0 84549.0 85442.0 86447.6 88027.6 10039.1 10097.6 10399.3 10462.5 10519.9 14812.1 14874.3 14895.9 14910.5 14942.7 7455.9 7554.2 7609.0 7706.0 7740.2 7410.6 7495.9 7529.1 7651.3 7677.3 4500.8 4567.1 4633.5 4720.2 4744.4 1808.6 1941.7 1950.3 1977.7 1985.9 893.5 945.8 955.2 982.8 1010.4 17477.9 17600.5 17892.2 18211.5 18290.4 949.8 957.2 964.4 981.8 1006.1 9131.2 10054.7 10065.3 10069.4 10088.5 453124.0 455529.0 459655.0 461204.0 465157.0 87075.6 90740.5 91274.5 91715.0 92992.5 945.4 946.6 961.3 964.9 992.5 16005.8 16314.2 16330.4 16460.3 16586.8 39044.0 40166.0 40456.4 40819.8 40934.8 56314.7 56753.0 57288.4 57518.4 57624.4 8054.6 8085.9 8256.9 8348.5 8388.0 8758.5 11998.2 12997.4 13336.3 13361.3 10299.4 10857.5 11284.4 12054.3 12142.6 11578.5 11659.8 11668.7 11737.9 11747.4 11889.5 12042.3 12177.7 12226.3 12353.3 8410.8 8432.7 8437.0 8609.9 8613.6 10524.2 11782.5 12024.9 12047.7 12100.4 08:35:07 INFO - PROCESS | 28774 | 08:35:07 INFO - PROCESS | 28774 | [#3] mootools.html Cycles:180 Average:6021.61 Median:4872.46 stddev:3485.03 (71.5%) stddev-sans-first:3477.63 08:35:07 INFO - PROCESS | 28774 | Values: 1418.3 1476.1 1524.5 1707.5 1726.7 7951.7 8698.1 8797.1 9371.0 9387.4 8804.0 8887.7 9097.8 9147.8 9148.1 2426.6 2462.9 2464.1 2464.3 2467.3 2402.9 2404.7 2454.6 2463.9 2465.9 2407.5 2415.0 2434.1 2449.8 2455.0 2357.1 2369.7 2383.6 2399.1 2423.6 2354.6 2357.1 2358.6 2360.5 2364.4 9094.8 9203.0 9208.9 9227.1 9241.5 5253.8 5428.5 5434.2 5434.3 5448.4 3355.7 3430.2 3470.4 3497.6 3611.9 1160.3 1197.5 1203.4 1204.1 1213.7 13084.9 13088.9 13112.6 13117.7 13121.8 4774.5 4838.9 4841.7 4869.7 4939.4 10852.5 10876.8 10913.4 10928.0 10933.9 5419.1 5434.8 5435.9 5442.6 5442.7 4243.5 4765.9 4875.2 4932.5 4933.5 4099.3 4105.9 4136.0 4155.0 4171.7 1300.1 1314.1 1316.1 1316.3 1321.5 783.7 833.2 949.0 951.5 975.6 5770.1 6018.1 6071.9 6155.3 6286.0 901.8 911.7 934.8 940.8 949.5 4045.4 4158.5 4170.5 4190.8 4280.9 11265.8 11560.4 11571.2 11583.8 11594.3 10842.4 11427.8 11432.7 11498.4 11550.9 7948.5 8295.8 8306.1 8348.1 8394.6 5921.2 6180.2 6223.7 6234.4 6351.3 10473.2 10606.8 10619.9 10649.8 10811.8 10703.2 10972.0 10972.1 11142.2 11150.3 7454.8 8013.1 8167.2 8226.9 8328.3 8956.5 8978.9 9000.9 9011.9 9023.5 7774.8 7996.6 8011.2 8092.8 8137.8 7974.8 8015.2 8093.0 8113.9 8189.8 6625.6 6796.5 7285.1 7406.9 7428.7 5005.9 5080.3 5113.5 5172.0 5176.4 5087.9 5175.6 5184.7 5266.2 5323.7 08:35:07 INFO - PROCESS | 28774 | 08:35:07 INFO - PROCESS | 28774 | [#4] prototype.html Cycles:180 Average:4378.88 Median:5022.70 stddev:1267.60 (25.2%) stddev-sans-first:1234.09 08:35:07 INFO - PROCESS | 28774 | Values: 324.5 324.5 328.5 329.8 332.0 4926.3 4956.6 5002.5 5003.3 5009.3 4946.3 4958.5 4963.3 4970.0 4979.7 3658.2 3787.5 3896.4 3917.1 3922.7 3892.6 3897.5 3899.6 3905.4 3915.2 3861.5 3891.2 3897.7 3899.7 3900.8 3864.4 3879.8 3911.7 3918.9 3938.9 3439.3 3471.5 3480.5 3491.7 3503.6 4816.6 4820.6 4836.4 4849.3 4851.9 4359.6 4393.7 4405.7 4421.2 4468.1 5045.8 5101.4 5110.2 5149.1 5161.7 3765.5 3786.4 3792.5 3795.0 3809.9 5237.2 5280.5 5292.5 5354.3 5397.5 3761.9 3874.0 3876.7 3893.9 3903.2 3898.0 3917.8 3926.6 3935.1 3946.9 4434.3 4455.8 4456.4 4460.6 4484.3 5050.1 5140.2 5164.4 5230.5 5233.8 1322.9 1344.1 1345.4 1357.8 1359.3 844.3 865.4 890.6 902.4 902.5 4928.4 5036.2 5040.3 5041.9 5042.8 5266.9 5284.8 5291.8 5295.7 5297.5 4902.9 5002.0 5002.4 5010.1 5087.2 2785.6 2791.6 2809.7 2831.2 2835.4 5421.9 5448.3 5479.7 5488.9 5516.2 5209.5 5345.3 5370.1 5371.7 5374.9 5439.7 5456.5 5466.3 5484.0 5493.1 5258.0 5269.1 5287.4 5295.8 5318.8 5051.4 5157.6 5192.6 5217.2 5252.1 5431.8 5442.1 5456.8 5457.9 5482.4 3881.8 3882.2 3908.5 3916.3 3928.1 5035.2 5278.8 5319.6 5345.3 5349.6 5126.2 5152.3 5177.1 5191.4 5249.4 4929.3 5164.5 5167.8 5190.2 5225.2 5094.8 5137.9 5139.2 5163.3 5174.2 5066.9 5232.3 5240.4 5250.3 5250.9 5086.6 5106.6 5131.7 5149.1 5153.5 08:35:07 INFO - PROCESS | 28774 | 08:35:07 INFO - PROCESS | 28774 | [#5] yui.html Cycles:180 Average:19742.79 Median:3939.16 stddev:29044.48 (737.3%) stddev-sans-first:29090.91 08:35:07 INFO - PROCESS | 28774 | Values: 739.6 755.7 756.3 763.9 786.9 12831.6 15581.3 15965.7 16005.7 16076.5 11534.4 14411.9 14540.6 14574.3 14587.9 758.1 778.4 783.7 785.0 788.9 767.2 769.3 771.9 772.0 776.6 815.4 815.8 816.2 819.3 819.8 812.5 813.8 816.0 820.6 821.7 592.4 593.9 596.3 596.4 596.9 13200.4 13258.1 13265.3 13294.7 13300.7 14264.4 14380.2 14408.6 14470.5 14692.8 12112.8 12193.6 12306.4 12470.9 12673.6 3908.8 3919.8 3933.4 3944.9 3991.5 70146.0 75975.6 77157.0 77722.0 78429.0 11447.0 11715.2 11716.0 11841.4 12104.2 17202.5 19006.1 19072.4 19203.6 19252.0 7815.2 7824.6 8213.0 8238.1 8257.8 4623.7 4630.4 4673.1 4755.8 4910.0 3286.9 3415.3 3416.1 3419.9 3424.7 642.2 654.4 664.9 673.0 691.6 720.0 720.9 724.9 725.9 731.2 9147.0 9516.1 9584.3 9842.5 9856.6 713.7 717.4 723.2 723.7 730.8 4291.2 4619.5 4665.1 4668.2 4725.2 109167.5 111919.0 112131.0 116536.0 120168.4 102743.3 104453.0 104678.5 105006.0 105388.0 58328.1 73266.6 85855.0 90358.1 95235.0 8512.4 8633.3 8649.4 8809.6 8912.0 42906.4 42920.8 43490.8 50597.0 53504.0 24966.0 25400.0 34475.0 71597.0 75274.4 12946.4 13052.6 13202.8 13294.5 13402.1 14468.5 14849.0 14978.4 15568.7 15729.8 12938.7 13223.4 14384.3 14391.6 14912.0 13725.4 14136.4 14251.0 14315.2 14360.7 12964.9 13037.9 13041.5 13182.5 13860.3 11540.0 11627.7 11648.3 12155.5 12601.1 11471.9 11555.1 11727.7 11851.9 12251.9 08:35:07 INFO - PROCESS | 28774 | -------- Summary: end -------- 08:35:07 INFO - PROCESS | 28774 | 08:35:08 INFO - TEST-INFO | 28774: exit 0 08:35:08 INFO - TEST-OK | dromaeo_css | took 1109084ms 08:35:08 INFO - TEST-START | kraken 08:35:08 INFO - operating with platform_type : linux_ 08:35:08 INFO - Initialising browser for kraken test... 08:35:08 INFO - TEST-INFO | started process 29018 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHmfxgf/profile http://localhost:35492/getInfo.html) 08:35:12 INFO - PROCESS | 29018 | __metrics Screen width/height:1600/1200 08:35:12 INFO - PROCESS | 29018 | colorDepth:24 08:35:12 INFO - PROCESS | 29018 | Browser inner width/height: 1024/697 08:35:12 INFO - PROCESS | 29018 | __metrics 08:35:13 ERROR - PROCESS | 29018 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 08:35:13 INFO - TEST-INFO | 29018: exit 0 08:35:13 INFO - Browser initialized. 08:35:13 INFO - Running cycle 1/1 for kraken test... 08:35:13 INFO - TEST-INFO | started process 29137 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHmfxgf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:35:25 INFO - PROCESS | 29137 | RSS: Main: 185520128 08:35:25 INFO - PROCESS | 29137 | 08:35:28 INFO - PROCESS | 29137 | Cycle 1(1): loaded http://localhost:35492/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35492/tests/kraken/driver.html?testName=audio-beat-detection) 08:35:29 INFO - PROCESS | 29137 | RSS: Main: 191041536 08:35:29 INFO - PROCESS | 29137 | 08:35:32 INFO - PROCESS | 29137 | Cycle 1(1): loaded http://localhost:35492/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35492/tests/kraken/driver.html?testName=audio-dft) 08:35:32 INFO - PROCESS | 29137 | RSS: Main: 190636032 08:35:32 INFO - PROCESS | 29137 | 08:35:35 INFO - PROCESS | 29137 | Cycle 1(1): loaded http://localhost:35492/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35492/tests/kraken/driver.html?testName=audio-fft) 08:35:36 INFO - PROCESS | 29137 | RSS: Main: 185204736 08:35:36 INFO - PROCESS | 29137 | 08:35:38 INFO - PROCESS | 29137 | Cycle 1(1): loaded http://localhost:35492/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35492/tests/kraken/driver.html?testName=audio-oscillator) 08:35:39 INFO - PROCESS | 29137 | RSS: Main: 186007552 08:35:39 INFO - PROCESS | 29137 | 08:35:41 INFO - PROCESS | 29137 | Cycle 1(1): loaded http://localhost:35492/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35492/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:35:41 INFO - PROCESS | 29137 | RSS: Main: 186724352 08:35:41 INFO - PROCESS | 29137 | 08:35:45 INFO - PROCESS | 29137 | Cycle 1(1): loaded http://localhost:35492/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35492/tests/kraken/driver.html?testName=imaging-darkroom) 08:35:45 INFO - PROCESS | 29137 | RSS: Main: 186818560 08:35:45 INFO - PROCESS | 29137 | 08:35:49 INFO - PROCESS | 29137 | Cycle 1(1): loaded http://localhost:35492/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35492/tests/kraken/driver.html?testName=imaging-desaturate) 08:35:49 INFO - PROCESS | 29137 | RSS: Main: 184459264 08:35:49 INFO - PROCESS | 29137 | 08:35:52 INFO - PROCESS | 29137 | Cycle 1(1): loaded http://localhost:35492/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35492/tests/kraken/driver.html?testName=json-parse-financial) 08:35:53 INFO - PROCESS | 29137 | RSS: Main: 186515456 08:35:53 INFO - PROCESS | 29137 | 08:35:55 INFO - PROCESS | 29137 | Cycle 1(1): loaded http://localhost:35492/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35492/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:35:55 INFO - PROCESS | 29137 | RSS: Main: 186404864 08:35:55 INFO - PROCESS | 29137 | 08:35:57 INFO - PROCESS | 29137 | Cycle 1(1): loaded http://localhost:35492/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35492/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:35:58 INFO - PROCESS | 29137 | RSS: Main: 186732544 08:35:58 INFO - PROCESS | 29137 | 08:36:00 INFO - PROCESS | 29137 | Cycle 1(1): loaded http://localhost:35492/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35492/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:36:00 INFO - PROCESS | 29137 | RSS: Main: 186896384 08:36:00 INFO - PROCESS | 29137 | 08:36:03 INFO - PROCESS | 29137 | Cycle 1(1): loaded http://localhost:35492/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35492/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:36:04 INFO - PROCESS | 29137 | RSS: Main: 187379712 08:36:04 INFO - PROCESS | 29137 | 08:36:07 INFO - PROCESS | 29137 | Cycle 1(1): loaded http://localhost:35492/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35492/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:36:07 INFO - PROCESS | 29137 | RSS: Main: 186880000 08:36:07 INFO - PROCESS | 29137 | 08:36:09 INFO - PROCESS | 29137 | Cycle 1(1): loaded http://localhost:35492/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35492/tests/kraken/driver.html?testName=ai-astar) 08:36:09 INFO - PROCESS | 29137 | RSS: Main: 188170240 08:36:09 INFO - PROCESS | 29137 | 08:36:09 INFO - PROCESS | 29137 | __start_tp_report 08:36:09 INFO - PROCESS | 29137 | _x_x_mozilla_page_load 08:36:09 INFO - PROCESS | 29137 | _x_x_mozilla_page_load_details 08:36:09 INFO - PROCESS | 29137 | |i|pagename|runs| 08:36:09 INFO - PROCESS | 29137 | |0;ai-astar;110;103;109;110;109;110;110;108;108;109 08:36:09 INFO - PROCESS | 29137 | |1;audio-beat-detection;154;125;154;178;128;153;157;129;189;133 08:36:09 INFO - PROCESS | 29137 | |2;audio-dft;163;166;162;161;167;175;163;164;163;162 08:36:09 INFO - PROCESS | 29137 | |3;audio-fft;75;76;75;154;75;77;76;77;157;76 08:36:09 INFO - PROCESS | 29137 | |4;audio-oscillator;86;85;141;86;85;86;138;86;85;141 08:36:09 INFO - PROCESS | 29137 | |5;imaging-gaussian-blur;118;117;118;119;119;118;119;118;117;117 08:36:09 INFO - PROCESS | 29137 | |6;imaging-darkroom;146;146;147;148;147;148;148;148;148;148 08:36:09 INFO - PROCESS | 29137 | |7;imaging-desaturate;95;96;97;96;96;101;97;96;96;95 08:36:09 INFO - PROCESS | 29137 | |8;json-parse-financial;61;63;62;62;62;62;62;62;61;61 08:36:09 INFO - PROCESS | 29137 | |9;json-stringify-tinderbox;61;61;61;61;62;61;60;61;61;61 08:36:09 INFO - PROCESS | 29137 | |10;stanford-crypto-aes;81;81;83;82;90;83;83;87;118;93 08:36:09 INFO - PROCESS | 29137 | |11;stanford-crypto-ccm;138;136;125;127;135;129;130;137;137;141 08:36:09 INFO - PROCESS | 29137 | |12;stanford-crypto-pbkdf2;168;169;167;165;168;165;169;166;163;169 08:36:09 INFO - PROCESS | 29137 | |13;stanford-crypto-sha256-iterative;64;66;63;65;69;65;63;64;64;66 08:36:09 INFO - PROCESS | 29137 | __end_tp_report 08:36:09 INFO - PROCESS | 29137 | __start_cc_report 08:36:09 INFO - PROCESS | 29137 | _x_x_mozilla_cycle_collect,922 08:36:09 INFO - PROCESS | 29137 | __end_cc_report 08:36:09 INFO - PROCESS | 29137 | __startTimestamp1466177769589__endTimestamp 08:36:09 INFO - PROCESS | 29137 | 08:36:09 INFO - PROCESS | 29137 | ------- Summary: start ------- 08:36:09 INFO - PROCESS | 29137 | Number of tests: 14 08:36:09 INFO - PROCESS | 29137 | 08:36:09 INFO - PROCESS | 29137 | [#0] ai-astar Cycles:10 Average:108.60 Median:109.50 stddev:2.12 (1.9%) stddev-sans-first:2.19 08:36:09 INFO - PROCESS | 29137 | Values: 110.0 103.0 109.0 110.0 109.0 110.0 110.0 108.0 108.0 109.0 08:36:09 INFO - PROCESS | 29137 | 08:36:09 INFO - PROCESS | 29137 | [#1] audio-beat-detection Cycles:10 Average:150.00 Median:154.00 stddev:21.69 (14.1%) stddev-sans-first:22.96 08:36:09 INFO - PROCESS | 29137 | Values: 154.0 125.0 154.0 178.0 128.0 153.0 157.0 129.0 189.0 133.0 08:36:09 INFO - PROCESS | 29137 | 08:36:09 INFO - PROCESS | 29137 | [#2] audio-dft Cycles:10 Average:164.60 Median:163.50 stddev:4.09 (2.5%) stddev-sans-first:4.29 08:36:09 INFO - PROCESS | 29137 | Values: 163.0 166.0 162.0 161.0 167.0 175.0 163.0 164.0 163.0 162.0 08:36:09 INFO - PROCESS | 29137 | 08:36:09 INFO - PROCESS | 29137 | [#3] audio-fft Cycles:10 Average:91.80 Median:76.00 stddev:33.59 (44.2%) stddev-sans-first:35.07 08:36:09 INFO - PROCESS | 29137 | Values: 75.0 76.0 75.0 154.0 75.0 77.0 76.0 77.0 157.0 76.0 08:36:09 INFO - PROCESS | 29137 | 08:36:09 INFO - PROCESS | 29137 | [#4] audio-oscillator Cycles:10 Average:101.90 Median:85.50 stddev:26.31 (30.8%) stddev-sans-first:27.27 08:36:09 INFO - PROCESS | 29137 | Values: 86.0 85.0 141.0 86.0 85.0 86.0 138.0 86.0 85.0 141.0 08:36:09 INFO - PROCESS | 29137 | 08:36:09 INFO - PROCESS | 29137 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 08:36:09 INFO - PROCESS | 29137 | Values: 118.0 117.0 118.0 119.0 119.0 118.0 119.0 118.0 117.0 117.0 08:36:09 INFO - PROCESS | 29137 | 08:36:09 INFO - PROCESS | 29137 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:148.00 stddev:0.84 (0.6%) stddev-sans-first:0.73 08:36:09 INFO - PROCESS | 29137 | Values: 146.0 146.0 147.0 148.0 147.0 148.0 148.0 148.0 148.0 148.0 08:36:09 INFO - PROCESS | 29137 | 08:36:09 INFO - PROCESS | 29137 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.00 stddev:1.72 (1.8%) stddev-sans-first:1.73 08:36:09 INFO - PROCESS | 29137 | Values: 95.0 96.0 97.0 96.0 96.0 101.0 97.0 96.0 96.0 95.0 08:36:09 INFO - PROCESS | 29137 | 08:36:09 INFO - PROCESS | 29137 | [#8] json-parse-financial Cycles:10 Average:61.80 Median:62.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 08:36:09 INFO - PROCESS | 29137 | Values: 61.0 63.0 62.0 62.0 62.0 62.0 62.0 62.0 61.0 61.0 08:36:09 INFO - PROCESS | 29137 | 08:36:09 INFO - PROCESS | 29137 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 08:36:09 INFO - PROCESS | 29137 | Values: 61.0 61.0 61.0 61.0 62.0 61.0 60.0 61.0 61.0 61.0 08:36:09 INFO - PROCESS | 29137 | 08:36:09 INFO - PROCESS | 29137 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:83.00 stddev:11.25 (13.6%) stddev-sans-first:11.63 08:36:09 INFO - PROCESS | 29137 | Values: 81.0 81.0 83.0 82.0 90.0 83.0 83.0 87.0 118.0 93.0 08:36:09 INFO - PROCESS | 29137 | 08:36:09 INFO - PROCESS | 29137 | [#11] stanford-crypto-ccm Cycles:10 Average:133.50 Median:136.50 stddev:5.34 (3.9%) stddev-sans-first:5.41 08:36:09 INFO - PROCESS | 29137 | Values: 138.0 136.0 125.0 127.0 135.0 129.0 130.0 137.0 137.0 141.0 08:36:09 INFO - PROCESS | 29137 | 08:36:09 INFO - PROCESS | 29137 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.90 Median:168.00 stddev:2.08 (1.2%) stddev-sans-first:2.17 08:36:09 INFO - PROCESS | 29137 | Values: 168.0 169.0 167.0 165.0 168.0 165.0 169.0 166.0 163.0 169.0 08:36:09 INFO - PROCESS | 29137 | 08:36:09 INFO - PROCESS | 29137 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:1.79 (2.8%) stddev-sans-first:1.87 08:36:09 INFO - PROCESS | 29137 | Values: 64.0 66.0 63.0 65.0 69.0 65.0 63.0 64.0 64.0 66.0 08:36:09 INFO - PROCESS | 29137 | -------- Summary: end -------- 08:36:09 INFO - PROCESS | 29137 | 08:36:10 INFO - TEST-INFO | 29137: exit 0 08:36:10 INFO - TEST-OK | kraken | took 62119ms 08:36:10 INFO - SUITE-END | took 1171s 08:36:10 INFO - Completed test suite (00:19:31) 08:36:10 INFO - javascript benchmark 08:36:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6899.538705458529, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2814.8170368926017, 2888.0758157389632, 2888.610037644917, 2892.6094977178072, 2898.536234202527, 4704.835330763424, 4757.357756702844, 4774.14065468216, 4806.5193480651915, 4851.975740121304, 4686.156491831469, 4755.500672429397, 4784.497627749089, 4826.469088400273, 4867.245576935572, 4367.213901497729, 4437.378766972626, 4460.55394460553, 4489.0, 4509.436320459942, 150.20965609748657, 4337.696361254713, 4427.313766366202, 4475.418195634563, 4522.819087236507, 4342.848000319974, 4369.257226271541, 4395.626371758389, 4399.340098985146, 4431.6233120184825, 4339.826406943718, 4375.584319489675, 4388.253996820548, 4393.253146965024, 4423.447069116361, 4265.466816647919, 4308.9784551077355, 4324.156789426063, 4376.5623437656295, 4396.318570621527, 4707.505711900236, 4727.550882666142, 4739.834105806315, 4767.0, 4808.158572249842, 4907.950920490785, 5058.114829904752, 5108.795648174068, 5109.310243117169, 5111.7699703513435, 5065.493450654905, 5087.872803179913, 5115.897682046376, 5128.282040514294, 5130.871728206787, 4797.0645724083815, 4811.9037619247765, 4822.71063736177, 4823.493533179001, 4869.634777391674, 4994.525520075587, 5112.36095488064, 5222.451642577551, 5229.424763276036, 5276.314079169683, 4991.326170966873, 4996.725180115129, 4997.0, 5010.824621138316, 5058.266551350107, 5047.394312682428, 5065.468125846733, 5075.720835354091, 5076.111680455905, 5122.078025955289, 4957.925631115536, 4992.151334273182, 4993.17612593918, 5052.974735126374, 5063.772130254148, 4931.654784165074, 5007.7245751484015, 5011.298418221452, 5056.988602279559, 5111.284420181103, 4063.065494936181, 4076.735012224196, 4078.8368465261055, 4081.469408976814, 4116.9707573106725, 3578.0875876651808, 3622.529071220777, 3626.0934766308424, 3668.321360548307, 3703.0372103252807, 4936.3829521309835, 4945.604351651859, 4947.886725486808, 4956.752162391866, 4994.550490455877, 5076.7207803571155, 5116.386033675983, 5120.257562653469, 5126.769295381717, 5142.948570514322, 4802.6638135330195, 4918.2376731606655, 4929.728864912464, 4939.357883475197, 4964.8758781030765, 4467.30756732707, 4469.664775141878, 4476.552344765498, 4483.708558943658, 4540.137373898949, 5181.093308670967, 5287.9471205287455, 5292.894142117136, 5309.0, 5326.2543243945875, 5029.748512574357, 5040.621953353587, 5080.46655101209, 5087.4403815581, 5102.591792656504, 5257.63196576236, 5259.15853463444, 5271.262023316815, 5282.31329927107, 5314.840554783363, 4879.365682461257, 4938.827141050046, 4982.128127577732, 4984.37695288089, 5006.874828129326, 5008.69947803133, 5062.367204099488, 5069.03688299222, 5077.517635824591, 5124.948750512447, 4953.975230123826, 4958.330625365529, 4962.106820772296, 4980.726060066586, 4998.400191976986, 4832.975835120802, 4947.851564453073, 4980.178270585313, 4991.850244492671, 5008.248762685481, 4773.11697335994, 4830.396200474941, 4924.655274130777, 4962.082014827269, 4998.850034498971, 5002.924956125734, 5021.548060674557, 5031.471695471922, 5035.446100928822, 5089.389273287081, 4769.046190761931, 4845.0, 4933.136701077369, 4938.308636790924, 4938.827141050046], "value": 4698.8240263510625, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.1192946368836, 613.0987448450777, 632.7342516143219, 653.545785678953, 657.5200103924134, 40520.0, 42601.14797704048, 42874.571254287446, 42962.78518607406, 45808.54191458093, 43642.12715745683, 43763.34354984678, 43819.0, 43894.34158487625, 43925.56074439255, 8737.344699147558, 8910.287177025855, 8965.95517022414, 8978.685745998891, 8984.730458086267, 8789.0, 8878.556072196398, 8881.067487913773, 8899.822003559924, 8908.777280567972, 8845.95577022114, 8847.380683352168, 8891.422057566237, 8910.198082172603, 8918.0, 8826.779330516723, 8872.556372181398, 8886.600102995348, 8909.955450222773, 8963.775905602346, 8795.824083518293, 8934.0, 8957.6864809732, 8958.283337332998, 8965.596548155349, 42013.579864201274, 42262.57737422617, 42288.365674514906, 42314.61483081346, 42782.78608606937, 3454.5854497460464, 3540.4689296605716, 3604.153024039375, 3666.211764470625, 3691.298653255873, 31899.52150717741, 32216.355672886646, 32418.18954526132, 32422.675773242438, 32972.3405531888, 4445.11097780442, 4467.508574056851, 4495.910081798378, 4502.707324023928, 4551.340055691906, 330155.0, 333893.0, 334937.0, 335066.0, 335707.0, 33614.83192584071, 35009.64990350115, 58530.0, 59401.40598594045, 59539.40460595425, 35845.0, 36287.637123628425, 36374.636253637655, 36472.27055458876, 36711.63288367082, 12760.042996775279, 12778.808317875239, 12784.105112642212, 12810.59083500814, 12838.80741788874, 11693.473793679304, 11755.235909665844, 11755.706107347385, 11789.587364442375, 11799.76400472003, 8200.58997050145, 8326.25063744266, 8332.250097491255, 8349.83300334002, 8453.830923381498, 3212.2932954749917, 3254.4792833146585, 3310.1393637654382, 3322.302316513511, 3332.900012999614, 951.2580187453797, 1083.0360978728938, 1090.5583238788304, 1097.5280629329304, 1141.611851970334, 30742.846285768428, 31179.84410077935, 31245.0, 31342.686573134433, 31422.685773141977, 1102.72431892027, 1109.3066833229232, 1181.0964612071773, 1193.003841792096, 1218.0255795363673, 16381.25607234484, 16414.835851641332, 16633.667326653398, 16700.49898503047, 16969.15154242283, 539340.0, 539539.0, 540284.0, 542097.0, 545615.0, 55918.440815592134, 56280.0, 56484.71757641186, 56493.43506564964, 56727.0, 1326.8341457317836, 1339.361457927861, 1343.6976680246867, 1345.6030471011074, 1367.6375760423496, 30223.69776302209, 30327.696723032488, 30518.0, 31187.84406077955, 31408.05775826729, 49775.50224497853, 50052.0, 50254.49745502498, 50436.747816260686, 50564.49435505745, 441771.0, 442412.0, 442857.0, 446111.0, 448177.0, 27834.44331113407, 27928.045036847227, 27971.04202705791, 28064.71935280621, 28142.43715125727, 46669.0, 47194.52805471901, 47529.0, 48269.75865120652, 48807.511924880295, 39804.800975994935, 40341.59658403378, 40366.39450408187, 41005.0, 41260.38109428301, 39614.40578391269, 40492.797536012135, 40908.59091409048, 40938.59061409467, 41708.79145604253, 39673.60326396814, 40229.0, 40487.392689110275, 40778.0, 42729.0, 33387.66612333846, 36785.0, 37076.0, 37459.62540374562, 37480.250394992494, 27331.316717081438, 28056.859715701292, 28404.307440032662, 28500.0, 28517.857410712815], "value": 18695.94253989093, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.6122918924859, 394.8045717369902, 399.79410603539185, 400.67745464900753, 410.68787721331796, 13027.28349940753, 14196.077254978445, 17149.82850171498, 18851.43445696631, 18951.71572426413, 16709.0, 17374.739378909326, 17911.283548658037, 18021.819781802176, 18065.4580362589, 5599.916001259974, 5669.971650141743, 5768.913466298009, 5780.71096445176, 5784.652920824764, 5608.915866262009, 5683.232763576905, 5703.9714801425935, 5718.0, 5744.253247077874, 5610.438956104377, 5663.886722265553, 5687.886242275152, 5704.172894930232, 5719.313682358123, 5568.470995255444, 5651.350094739117, 5694.5159661428825, 5698.0883058710615, 5698.287714035746, 4758.595519380857, 5073.949260507421, 5074.340335756328, 5076.289319495274, 5113.590912726973, 12617.432215550321, 12674.112812103156, 12921.612351629467, 12973.740525189538, 12994.350282485932, 2125.7342832145982, 2323.2565579014554, 2324.3491822289784, 2329.2779238436137, 2339.298210536849, 9780.217582593446, 9815.607375704963, 9851.261155413302, 9908.603655853758, 10113.949430252802, 1774.943908374515, 1831.5054935167564, 1893.214316058834, 1895.649304878602, 1971.704244363357, 76496.0, 84549.0, 85442.0, 86447.56776216079, 88027.55986220091, 10039.14667253277, 10097.596096156072, 10399.272050956512, 10462.47687615616, 10519.894801052045, 14812.111273323635, 14874.330655120546, 14895.92552037233, 14910.478133265284, 14942.701145977237, 7455.85088298231, 7554.169041405441, 7608.961955190189, 7705.961470192725, 7740.225977402328, 7410.629468526552, 7495.925040749632, 7529.058867641545, 7651.311381975537, 7677.30904218623, 4500.752458614742, 4567.132244873464, 4633.536646335339, 4720.150372932836, 4744.383230180055, 1808.6111486030566, 1941.6602094633383, 1950.3368854589507, 1977.67368384215, 1985.860989730705, 893.4862454088795, 945.8486642137225, 955.1737746848926, 982.8230918434607, 1010.3836659637615, 17477.912610436866, 17600.471985840446, 17892.194851231725, 18211.54471138232, 18290.359837405627, 949.8290307744534, 957.1720461800493, 964.3538828984597, 981.764376549623, 1006.059334522224, 9131.223845973034, 10054.748631284276, 10065.345752526062, 10069.395836249849, 10088.49557522121, 453124.0, 455529.0, 459655.0, 461204.0, 465157.0, 87075.56462217648, 90740.5462972681, 91274.54362728144, 91715.0, 92992.53503732439, 945.432740355781, 946.6166202687922, 961.2694352292308, 964.8842138943372, 992.4690290694443, 16005.839941600902, 16314.184290785175, 16330.428435004718, 16460.34158633689, 16586.75119873179, 39044.0, 40166.0, 40456.39315410212, 40819.795901020305, 40934.79532602318, 56314.718426407606, 56753.0, 57288.42711572831, 57518.42481575131, 57624.423755763586, 8054.597270136587, 8085.919140808516, 8256.917430825615, 8348.499090054373, 8388.0, 8758.47449153053, 11998.220115692453, 12997.40051989587, 13336.266505342299, 13361.26513041753, 10299.3820370778, 10857.457127143769, 11284.43577821122, 12054.276743395074, 12142.575009874612, 11578.478968446609, 11659.825102623638, 11668.708282292671, 11737.941310293736, 11747.353895535827, 11889.464974076014, 12042.277463352228, 12177.69555761113, 12226.327551984727, 12353.32056736852, 8410.789730256793, 8432.704855330034, 8437.0, 8609.87085193735, 8613.621820508939, 10524.210684198868, 11782.52869885195, 12024.939875300568, 12047.698807529881, 12100.394980251129], "value": 8765.768848377174, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1418.2837666978176, 1476.1438365747863, 1524.5197762704747, 1707.4962885948644, 1726.6546690661871, 7951.681932722699, 8698.130186981298, 8797.120287971207, 9371.0, 9387.389819661727, 8804.0, 8887.733367998953, 9097.772555686111, 9147.817043659123, 9148.130927561888, 2426.575349313872, 2462.8645424501647, 2464.125235541384, 2464.2853572464055, 2467.2968204061845, 2402.855828650278, 2404.7475015123423, 2454.607262837946, 2463.864487453189, 2465.9136930207446, 2407.458321877581, 2414.9517009659885, 2434.1358817619757, 2449.8285120041605, 2455.005722682308, 2357.127862690807, 2369.7156341239074, 2383.570957227707, 2399.124319623342, 2423.551642946061, 2354.564405584972, 2357.0807385119815, 2358.5872472317274, 2360.492494113774, 2364.385259832439, 9094.81810363789, 9203.033681463417, 9208.861867071932, 9227.077292270786, 9241.537923103886, 5253.763580638881, 5428.4842939920645, 5434.239206511052, 5434.3207099112615, 5448.4279150689, 3355.748318876094, 3430.1596108953217, 3470.3753324401596, 3497.6152623211683, 3611.927761444783, 1160.280626011878, 1197.4671271284283, 1203.3622180244483, 1204.1450570095242, 1213.6905089202285, 13084.934575327063, 13088.934555327163, 13112.606621801362, 13117.737645247042, 13121.803172952317, 4774.474807771212, 4838.879028024327, 4841.685290456179, 4869.70781753096, 4939.382577177853, 10852.511636976355, 10876.782464350668, 10913.39976301311, 10928.0, 10933.945330273456, 5419.105847535191, 5434.809781657623, 5435.945640543623, 5442.591805614516, 5442.673439593637, 4243.469566304212, 4765.928511072337, 4875.219964805614, 4932.53140951609, 4933.531314525115, 4099.323611604052, 4105.91287234994, 4136.028033412145, 4155.0, 4171.749695018309, 1300.1029289790015, 1314.1326724361875, 1316.1313533068128, 1316.3352506983913, 1321.5110409148485, 783.7374479549414, 833.2459124492344, 949.027247071757, 951.5242378810594, 975.5707488705089, 5770.134479827975, 6018.127371531104, 6071.939280607137, 6155.292141403706, 6285.968570157212, 901.7790641292926, 911.7492689510437, 934.8130373925242, 940.8024314893948, 949.5489642419933, 4045.3527435610163, 4158.500979882373, 4170.520390155171, 4190.832366705297, 4280.914381712349, 11265.831012534818, 11560.421978901022, 11571.19001669875, 11583.826242606368, 11594.304341739522, 10842.40366779819, 11427.771444571063, 11432.657020289405, 11498.367589782642, 11550.88449115498, 7948.523088614702, 8295.792605184797, 8306.08633050364, 8348.123447038095, 8394.580270986426, 5921.171036055042, 6180.196574445294, 6223.724136552087, 6234.438900498977, 6351.301356850835, 10473.21450891171, 10606.840897386392, 10619.893801061891, 10649.840252396376, 10811.837822432828, 10703.197260205672, 10972.0, 10972.122230221723, 11142.220044596801, 11150.275232109887, 7454.776356709307, 8013.078495972804, 8167.224113709188, 8226.917730822615, 8328.333733301442, 8956.462612243286, 8978.86531702012, 9000.909990900007, 9011.864822027806, 9023.503707296162, 7774.766756997073, 7996.56018918965, 8011.238932301422, 8092.83814323722, 8137.79655508617, 7974.840503189787, 8015.238552337519, 8093.0, 8113.918860811553, 8189.836203276021, 6625.602463852184, 6796.524243303119, 7285.089363829521, 7406.925930740839, 7428.73999410018, 5005.899882002413, 5080.288759573737, 5113.488651134857, 5172.043172013189, 5176.4047134580005, 5087.9061001884775, 5175.560077393313, 5184.662996905189, 5266.210068489757, 5323.733813309396], "value": 4785.294402350912, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.49702960411366, 324.50836981972316, 328.51707989255783, 329.8499182871794, 331.9502074688798, 4926.261060840871, 4956.603471722263, 5002.474740152277, 5003.299538064669, 5009.323741294924, 4946.332245146904, 4958.479359667237, 4963.280324352976, 4969.993154141746, 4979.651424400294, 3658.1769101952045, 3787.4697542344093, 3896.4350169225445, 3917.1382295895, 3922.745021573603, 3892.610738926113, 3897.512810898638, 3899.6490315871706, 3905.414187871828, 3915.2169566086895, 3861.4787003754554, 3891.182851601167, 3897.6881849452116, 3899.6685281751083, 3900.8244628991765, 3864.401017842239, 3879.7866117363533, 3911.7286881763257, 3918.8824335269987, 3938.8621398251066, 3439.2777516721517, 3471.461923401877, 3480.5475288212624, 3491.7381196410115, 3503.5795704515367, 4816.614670826326, 4820.613796170918, 4836.379812762729, 4849.272609108627, 4851.878703032417, 4359.629431498326, 4393.7363758174615, 4405.691601587891, 4421.248387774086, 4468.061707041526, 5045.772940217662, 5101.413337466165, 5110.233464980245, 5149.1205709915985, 5161.7161056141895, 3765.510483637137, 3786.3563194257044, 3792.4880141180865, 3794.962050379516, 3809.9238015239816, 5237.214417837316, 5280.471952804727, 5292.52367286946, 5354.250404943311, 5397.487238712316, 3761.887143385703, 3873.96126038736, 3876.7092468065007, 3893.9415908761393, 3903.1803321302846, 3897.986523503853, 3917.7845218513257, 3926.5680775114715, 3935.0555866591812, 3946.861859834892, 4434.3348497724955, 4455.799489023002, 4456.417971620093, 4460.598546130864, 4484.282514797616, 5050.141475949097, 5140.177571588602, 5164.3802743671, 5230.4632253357095, 5233.764480598382, 1322.8677132286887, 1344.1330341929597, 1345.3945724423852, 1357.7576517486389, 1359.3475131936527, 844.3287586368851, 865.4158443050916, 890.5947793753827, 902.3503077783985, 902.5442151713343, 4928.408590969107, 5036.244563315532, 5040.2691609716385, 5041.941192349647, 5042.755973591717, 5266.94661067788, 5284.762185701653, 5291.814786482455, 5295.682259064469, 5297.490215288702, 4902.852914412573, 5001.974595207974, 5002.374703162105, 5010.148274793294, 5087.211482220262, 2785.637867077267, 2791.6231308773463, 2809.7049809770087, 2831.150654803551, 2835.4187391584674, 5421.918671219935, 5448.346198456211, 5479.671219726829, 5488.890222195613, 5516.179660711956, 5209.47905209476, 5345.33183352081, 5370.140777475585, 5371.731413429313, 5374.892502150014, 5439.700816455133, 5456.48163424474, 5466.289382380265, 5483.99834060565, 5493.14856197298, 5258.0, 5269.104252277199, 5287.387346859245, 5295.76169072385, 5318.787248510016, 5051.4443411224, 5157.613179011514, 5192.610554208374, 5217.217417387422, 5252.080885845038, 5431.8098866539485, 5442.102053161342, 5456.809011684572, 5457.945420545744, 5482.382697104284, 3881.7865017424315, 3882.1847412043785, 3908.511436070491, 3916.2754890345377, 3928.1161738608585, 5035.244713293036, 5278.788848446019, 5319.627626066293, 5345.33183352081, 5349.625526213128, 5126.154184559506, 5152.330197074356, 5177.145770947752, 5191.402988656202, 5249.370075590953, 4929.309896614405, 5164.509371609691, 5167.811403377169, 5190.169572868323, 5225.216217567243, 5094.8216812412875, 5137.87155321105, 5139.152039913372, 5163.328767260232, 5174.15421518171, 5066.949330506648, 5232.267482552522, 5240.449752776056, 5250.26496290512, 5250.921236181537, 5086.593072554261, 5106.591472682102, 5131.717755523333, 5149.073166829857, 5153.45888681683], "value": 3978.425092862522, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.6153999920042, 755.7014979083266, 756.3079781999468, 763.8510490454361, 786.8677220921774, 12831.550895718652, 15581.298841552129, 15965.680686386266, 16005.679886402266, 16076.51770446887, 11534.423278836046, 14411.927940360283, 14540.636484087903, 14574.271286435662, 14587.927060364684, 758.0751483190527, 778.3850757901251, 783.6904422753009, 784.9764507064797, 788.9368850491946, 767.1867820110673, 769.3383690026573, 771.8610650082983, 771.9691212351499, 776.6427443376026, 815.4129027100478, 815.808285053012, 816.1797393619404, 819.3404309530825, 819.7581713394563, 812.5206128384252, 813.8209593889335, 816.0411516468156, 820.6430202861715, 821.7082935557851, 592.3927973826862, 593.946544810969, 596.2844586496221, 596.4125336543501, 596.9462748352669, 13200.405981730844, 13258.138221015699, 13265.3367331634, 13294.667633309147, 13300.73398532024, 14264.35810388535, 14380.209088500129, 14408.567742967623, 14470.49353272641, 14692.779608305884, 12112.81830772539, 12193.615240524497, 12306.446209920576, 12470.937645311715, 12673.619791406272, 3908.8436462541463, 3919.764814111134, 3933.3903244997073, 3944.9211015779524, 3991.501062367204, 70146.0, 75975.62012189958, 77157.0, 77722.0, 78429.0, 11447.0, 11715.17993740447, 11716.0, 11841.407929603485, 12104.244884491876, 17202.483925482255, 19006.144723487476, 19072.427827165207, 19203.615927681367, 19252.0, 7815.179406162385, 7824.569648669378, 8212.958935205404, 8238.09380968093, 8257.752267431986, 4623.745693986863, 4630.421197350332, 4673.135469938073, 4755.785989630475, 4909.975450122726, 3286.8849590264226, 3415.316936612687, 3416.0947348952545, 3419.9487007694906, 3424.6917777400154, 642.213288721322, 654.3750718064238, 664.9135612370458, 672.9865402691919, 691.595416681237, 719.9568025918462, 720.8810546259808, 724.9275072492709, 725.9310365515267, 731.2468157797371, 9147.0, 9516.095970882756, 9584.329096963145, 9842.458664773507, 9856.556454959544, 713.6859781696037, 717.3507975282378, 723.2044750774106, 723.7430712097236, 730.817295676081, 4291.249031419551, 4619.538046195421, 4665.081331681404, 4668.206404911173, 4725.243960966298, 109167.45416273027, 111919.0, 112131.0, 116536.0, 120168.39915800365, 102743.29425292983, 104453.0, 104678.47660761648, 105006.0, 105388.0, 58328.12507812386, 73266.6336668324, 85855.0, 90358.09641903629, 95235.047649524, 8512.40413171072, 8633.30933525329, 8649.437786543855, 8809.647614095364, 8911.955440222757, 42906.35640465458, 42920.78539607282, 43490.82545872757, 50597.0, 53504.0, 24966.0, 25400.0, 34475.0, 71597.0, 75274.36539721303, 12946.352682365656, 13052.608421747364, 13202.801957970447, 13294.534691285759, 13402.128861623964, 14468.493602724275, 14849.0, 14978.400863965755, 15568.688626227638, 15729.842701573296, 12938.676533086747, 13223.404946777226, 14384.28078596045, 14391.568252952427, 14912.0, 13725.382357794122, 14136.363863626368, 14251.0, 14315.212663303619, 14360.712785744436, 12964.870351296366, 13037.932591853936, 13041.543545976225, 13182.472701091849, 13860.306984650928, 11540.0, 11627.709307267047, 11648.301101933912, 12155.45300461499, 12601.117921745756, 11471.885281147082, 11555.133364997828, 11727.706807329885, 11851.940740296242, 12251.938740306598], "value": 7357.452461707901, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1555.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 103.0, 109.0, 110.0, 109.0, 110.0, 110.0, 108.0, 108.0, 109.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 125.0, 154.0, 178.0, 128.0, 153.0, 157.0, 129.0, 189.0, 133.0], "value": 150.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 162.0, 161.0, 167.0, 175.0, 163.0, 164.0, 163.0, 162.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 154.0, 75.0, 77.0, 76.0, 77.0, 157.0, 76.0], "value": 91.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 141.0, 86.0, 85.0, 86.0, 138.0, 86.0, 85.0, 141.0], "value": 101.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 119.0, 119.0, 118.0, 119.0, 118.0, 117.0, 117.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 148.0, 147.0, 148.0, 148.0, 148.0, 148.0, 148.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 96.0, 96.0, 101.0, 97.0, 96.0, 96.0, 95.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 61.0, 61.0], "value": 61.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 62.0, 61.0, 60.0, 61.0, 61.0, 61.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 83.0, 82.0, 90.0, 83.0, 83.0, 87.0, 118.0, 93.0], "value": 88.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 136.0, 125.0, 127.0, 135.0, 129.0, 130.0, 137.0, 137.0, 141.0], "value": 133.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 169.0, 167.0, 165.0, 168.0, 165.0, 169.0, 166.0, 163.0, 169.0], "value": 166.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 63.0, 65.0, 69.0, 65.0, 63.0, 64.0, 64.0, 66.0], "value": 64.9, "unit": "score"}]}]} 08:36:10 INFO - Return code: 0 08:36:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:36:10 ERROR - # TBPL SUCCESS # 08:36:10 INFO - Running post-action listener: _resource_record_post_action 08:36:10 INFO - ##### 08:36:10 INFO - ##### Finished run-tests step (success) 08:36:10 INFO - ##### 08:36:10 INFO - Running post-run listener: _resource_record_post_run 08:36:10 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 16384; Write bytes: 290742272; Read time: 224; Write time: 181172 08:36:10 INFO - TinderboxPrint: CPU usage
13.3% 08:36:10 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 224 08:36:10 INFO - TinderboxPrint: I/O write bytes / time
290,742,272 / 181,172 08:36:10 INFO - TinderboxPrint: CPU idle
8,219.3 (86.7%) 08:36:10 INFO - TinderboxPrint: CPU user
1,212.4 (12.8%) 08:36:10 INFO - TinderboxPrint: Swap in / out
0 / 0 08:36:10 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 1212416; Read time: 0; Write time: 48 08:36:11 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 16384; Write bytes: 289529856; Read time: 224; Write time: 181124 08:36:11 INFO - Running post-run listener: _upload_blobber_files 08:36:11 INFO - Blob upload gear active. 08:36:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:36:11 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 08:36:11 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'] 08:36:11 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 08:36:11 INFO - (blobuploader) - INFO - Open directory for files ... 08:36:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:36:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:36:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:36:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:36:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:36:12 INFO - (blobuploader) - INFO - Done attempting. 08:36:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:36:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:36:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:36:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:36:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:36:17 INFO - (blobuploader) - INFO - Done attempting. 08:36:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:36:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:36:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:36:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:36:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:36:19 INFO - (blobuploader) - INFO - Done attempting. 08:36:19 INFO - (blobuploader) - INFO - Iteration through files over. 08:36:19 INFO - Return code: 0 08:36:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:36:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:36:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4522620df120bac856f5095c2855a7bd5b7b9951c5a4880bad47f6b0c157e011aef1f5fc550f7df0df4fa828497d59db118e612b6e90f104b37051887d4b04d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c9b836512189fb8c296de8d9fe0a156468220cb374ac9a42d8afedec0f38bb775fac55c2cc9e3bd19120bf2195771ffcce416668ba6cc97a9439b4a56d47d4e3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/02281019193a15d7c63e637fd324446833a373eef86a8420cf08f6231c9a5f8ad878b30f309bfb2494e3c4e2eed21e78464a895ec0bf3df92d58cdedc211764d"} 08:36:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:36:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:36:19 INFO - Contents: 08:36:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4522620df120bac856f5095c2855a7bd5b7b9951c5a4880bad47f6b0c157e011aef1f5fc550f7df0df4fa828497d59db118e612b6e90f104b37051887d4b04d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c9b836512189fb8c296de8d9fe0a156468220cb374ac9a42d8afedec0f38bb775fac55c2cc9e3bd19120bf2195771ffcce416668ba6cc97a9439b4a56d47d4e3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/02281019193a15d7c63e637fd324446833a373eef86a8420cf08f6231c9a5f8ad878b30f309bfb2494e3c4e2eed21e78464a895ec0bf3df92d58cdedc211764d"} 08:36:19 INFO - Running post-run listener: copy_logs_to_upload_dir 08:36:19 INFO - Copying logs to upload dir... 08:36:19 INFO - mkdir: /builds/slave/test/build/upload/logs 08:36:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.858268 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-06-17 08:36:19.002722) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 08:36:19.006069) ========= 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=826874ccc97bd7bf541b4875000001d5-1466174075.94240-979900600 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4522620df120bac856f5095c2855a7bd5b7b9951c5a4880bad47f6b0c157e011aef1f5fc550f7df0df4fa828497d59db118e612b6e90f104b37051887d4b04d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c9b836512189fb8c296de8d9fe0a156468220cb374ac9a42d8afedec0f38bb775fac55c2cc9e3bd19120bf2195771ffcce416668ba6cc97a9439b4a56d47d4e3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/02281019193a15d7c63e637fd324446833a373eef86a8420cf08f6231c9a5f8ad878b30f309bfb2494e3c4e2eed21e78464a895ec0bf3df92d58cdedc211764d"} build_url:https://queue.taskcluster.net/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011394 build_url: 'https://queue.taskcluster.net/v1/task/Cx_b3inOSrGvBfIdvwoG8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4522620df120bac856f5095c2855a7bd5b7b9951c5a4880bad47f6b0c157e011aef1f5fc550f7df0df4fa828497d59db118e612b6e90f104b37051887d4b04d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c9b836512189fb8c296de8d9fe0a156468220cb374ac9a42d8afedec0f38bb775fac55c2cc9e3bd19120bf2195771ffcce416668ba6cc97a9439b4a56d47d4e3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/02281019193a15d7c63e637fd324446833a373eef86a8420cf08f6231c9a5f8ad878b30f309bfb2494e3c4e2eed21e78464a895ec0bf3df92d58cdedc211764d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 08:36:19.032511) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 08:36:19.032889) ========= 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=826874ccc97bd7bf541b4875000001d5-1466174075.94240-979900600 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 08:36:19.114825) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 08:36:19.115194) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 08:36:19.115589) ========= ========= Total master_lag: 0.16 =========