builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-006 starttime: 1465517734.84 results: success (0) buildid: 20160609143002 builduid: 62633a00d7bc48198a66f6b64e9cc4e4 revision: f48fbe4116507315b13ddf3e1861d74c15d72550 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 17:15:34.837924) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 17:15:34.838400) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 17:15:34.838692) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 17:15:34.854035) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 17:15:34.854786) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1465517734.342769-524867587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 17:15:35-- 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% 46.8M=0s 2016-06-09 17:15:35 (46.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118598 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 17:15:34.994453) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 17:15:34.994793) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1465517734.342769-524867587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013685 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 17:15:35.044457) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 17:15:35.044813) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f48fbe4116507315b13ddf3e1861d74c15d72550 --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 f48fbe4116507315b13ddf3e1861d74c15d72550 --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=e31afd3c0f0de4e86ebe4d94000001b5-1465517734.342769-524867587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 17:15:35,267 truncating revision to first 12 chars 2016-06-09 17:15:35,267 Setting DEBUG logging. 2016-06-09 17:15:35,267 attempt 1/10 2016-06-09 17:15:35,267 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f48fbe411650?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 17:15:35,627 unpacking tar archive at: fx-team-f48fbe411650/testing/mozharness/ program finished with exit code 0 elapsedTime=0.696917 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 17:15:35.755075) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 17:15:35.755403) ========= script_repo_revision: f48fbe4116507315b13ddf3e1861d74c15d72550 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 17:15:35.755809) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 17:15:35.756072) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 17:15:35.765312) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-09 17:15:35.765605) ========= /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=e31afd3c0f0de4e86ebe4d94000001b5-1465517734.342769-524867587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:15:36 INFO - MultiFileLogger online at 20160609 17:15:36 in /builds/slave/test 17:15:36 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 17:15:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:15:36 INFO - {'append_to_log': False, 17:15:36 INFO - 'base_work_dir': '/builds/slave/test', 17:15:36 INFO - 'blob_upload_branch': 'Fx-Team', 17:15:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:15:36 INFO - 'branch': 'Fx-Team', 17:15:36 INFO - 'buildbot_json_path': 'buildprops.json', 17:15:36 INFO - 'config_files': ('talos/linux_config.py',), 17:15:36 INFO - 'default_actions': ('clobber', 17:15:36 INFO - 'read-buildbot-config', 17:15:36 INFO - 'download-and-extract', 17:15:36 INFO - 'populate-webroot', 17:15:36 INFO - 'create-virtualenv', 17:15:36 INFO - 'install', 17:15:36 INFO - 'run-tests'), 17:15:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:15:36 INFO - 'download_minidump_stackwalk': True, 17:15:36 INFO - 'download_symbols': 'ondemand', 17:15:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:15:36 INFO - 'tooltool.py': '/tools/tooltool.py', 17:15:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:15:36 INFO - '/tools/misc-python/virtualenv.py')}, 17:15:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:15:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:15:36 INFO - 'installer_path': 'installer.exe', 17:15:36 INFO - 'log_level': 'info', 17:15:36 INFO - 'log_name': 'talos', 17:15:36 INFO - 'log_to_console': True, 17:15:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:15:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:15:36 INFO - 'opt_config_files': (), 17:15:36 INFO - 'pip_index': False, 17:15:36 INFO - 'sps_profile': False, 17:15:36 INFO - 'sps_profile_interval': 0, 17:15:36 INFO - 'suite': 'dromaeojs-e10s', 17:15:36 INFO - 'system_bits': '32', 17:15:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:15:36 INFO - 'title': 'talos-linux64-ix-006', 17:15:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:15:36 INFO - 'use_talos_json': True, 17:15:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:15:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:15:36 INFO - 'work_dir': 'build'} 17:15:36 INFO - ##### 17:15:36 INFO - ##### Running clobber step. 17:15:36 INFO - ##### 17:15:36 INFO - Running pre-action listener: _resource_record_pre_action 17:15:36 INFO - Running main action method: clobber 17:15:36 INFO - rmtree: /builds/slave/test/build 17:15:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:15:36 INFO - Running post-action listener: _resource_record_post_action 17:15:36 INFO - ##### 17:15:36 INFO - ##### Finished clobber step (success) 17:15:36 INFO - ##### 17:15:36 INFO - ##### 17:15:36 INFO - ##### Running read-buildbot-config step. 17:15:36 INFO - ##### 17:15:36 INFO - Running pre-action listener: _resource_record_pre_action 17:15:36 INFO - Running main action method: read_buildbot_config 17:15:36 INFO - Using buildbot properties: 17:15:36 INFO - { 17:15:36 INFO - "project": "", 17:15:36 INFO - "product": "firefox", 17:15:36 INFO - "script_repo_revision": "production", 17:15:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:15:36 INFO - "repository": "", 17:15:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 17:15:36 INFO - "buildid": "20160609143002", 17:15:36 INFO - "pgo_build": "True", 17:15:36 INFO - "basedir": "/builds/slave/test", 17:15:36 INFO - "buildnumber": 452, 17:15:36 INFO - "slavename": "talos-linux64-ix-006", 17:15:36 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:15:36 INFO - "platform": "ubuntu64_hw", 17:15:36 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:15:36 INFO - "branch": "fx-team", 17:15:36 INFO - "repo_path": "integration/fx-team", 17:15:36 INFO - "revision": "f48fbe4116507315b13ddf3e1861d74c15d72550", 17:15:36 INFO - "stage_platform": "linux64-pgo", 17:15:36 INFO - "builduid": "62633a00d7bc48198a66f6b64e9cc4e4", 17:15:36 INFO - "slavebuilddir": "test" 17:15:36 INFO - } 17:15:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 17:15:36 INFO - Running post-action listener: _resource_record_post_action 17:15:36 INFO - ##### 17:15:36 INFO - ##### Finished read-buildbot-config step (success) 17:15:36 INFO - ##### 17:15:36 INFO - ##### 17:15:36 INFO - ##### Running download-and-extract step. 17:15:36 INFO - ##### 17:15:36 INFO - Running pre-action listener: _resource_record_pre_action 17:15:36 INFO - Running main action method: download_and_extract 17:15:36 INFO - mkdir: /builds/slave/test/build/tests 17:15:36 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')]} 17:15:36 INFO - https://queue.taskcluster.net/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:15:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:15:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:15:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsuHfWo7TFq884r4E8XQ8A/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 17:15:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsuHfWo7TFq884r4E8XQ8A/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 17:15:37 INFO - Downloaded 1361 bytes. 17:15:37 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:15:37 INFO - Using the following test package requirements: 17:15:37 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:15:37 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:15:37 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:15:37 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:37 INFO - u'jsshell-linux-x86_64.zip'], 17:15:37 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:15:37 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:15:37 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:15:37 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:15:37 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:15:37 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:15:37 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:15:37 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')]} 17:15:37 INFO - https://queue.taskcluster.net/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:15:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:15:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:15:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsuHfWo7TFq884r4E8XQ8A/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 17:15:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsuHfWo7TFq884r4E8XQ8A/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 17:15:38 INFO - Downloaded 24452313 bytes. 17:15:38 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'] 17:15:38 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 17:15:39 INFO - Return code: 0 17:15:39 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 17:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:39 INFO - https://queue.taskcluster.net/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:15:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:15:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:15:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsuHfWo7TFq884r4E8XQ8A/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 17:15:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsuHfWo7TFq884r4E8XQ8A/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 17:15:40 INFO - Downloaded 24452313 bytes. 17:15:40 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'] 17:15:40 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 17:15:42 INFO - Return code: 0 17:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:42 INFO - https://queue.taskcluster.net/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:15:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:15:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:15:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsuHfWo7TFq884r4E8XQ8A/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 17:15:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsuHfWo7TFq884r4E8XQ8A/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 17:15:43 INFO - Downloaded 10833377 bytes. 17:15:43 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'] 17:15:43 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 17:15:43 INFO - Return code: 0 17:15:43 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')]} 17:15:43 INFO - https://queue.taskcluster.net/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:15:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:15:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:15:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsuHfWo7TFq884r4E8XQ8A/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 17:15:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsuHfWo7TFq884r4E8XQ8A/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 17:15:45 INFO - Downloaded 59281989 bytes. 17:15:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:15:45 INFO - mkdir: /builds/slave/test/properties 17:15:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:15:45 INFO - Writing to file /builds/slave/test/properties/build_url 17:15:45 INFO - Contents: 17:15:45 INFO - build_url:https://queue.taskcluster.net/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:15:45 INFO - Running post-action listener: _resource_record_post_action 17:15:45 INFO - Running post-action listener: set_extra_try_arguments 17:15:45 INFO - ##### 17:15:45 INFO - ##### Finished download-and-extract step (success) 17:15:45 INFO - ##### 17:15:45 INFO - ##### 17:15:45 INFO - ##### Running populate-webroot step. 17:15:45 INFO - ##### 17:15:45 INFO - Running pre-action listener: _resource_record_pre_action 17:15:45 INFO - Running main action method: populate_webroot 17:15:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:15:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:15:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:15:45 INFO - '--tppagecycles', 17:15:45 INFO - '7'], 17:15:45 INFO - 'tests': ['tsvgm']}}, 17:15:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:15:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:15:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:15:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:15:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:15:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:15:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:45 INFO - 'talos_options': ['--disable-e10s'], 17:15:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:15:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:15:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:45 INFO - 'talos_options': ['--disable-e10s'], 17:15:45 INFO - 'tests': ['damp', 'tps']}, 17:15:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:45 INFO - 'tests': ['damp', 'tps']}, 17:15:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:15:45 INFO - 'tests': ['dromaeo_dom']}, 17:15:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:15:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:15:45 INFO - 'tests': ['a11yr', 17:15:45 INFO - 'ts_paint', 17:15:45 INFO - 'tpaint', 17:15:45 INFO - 'sessionrestore', 17:15:45 INFO - 'sessionrestore_no_auto_restore', 17:15:45 INFO - 'tabpaint']}, 17:15:45 INFO - 'other-e10s': {'tests': ['a11yr', 17:15:45 INFO - 'ts_paint', 17:15:45 INFO - 'tpaint', 17:15:45 INFO - 'sessionrestore', 17:15:45 INFO - 'sessionrestore_no_auto_restore', 17:15:45 INFO - 'tabpaint']}, 17:15:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:15:45 INFO - 'ts_paint', 17:15:45 INFO - 'tpaint', 17:15:45 INFO - 'sessionrestore', 17:15:45 INFO - 'sessionrestore_no_auto_restore', 17:15:45 INFO - 'tabpaint']}, 17:15:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:15:45 INFO - 'ts_paint', 17:15:45 INFO - 'tpaint', 17:15:45 INFO - 'sessionrestore', 17:15:45 INFO - 'sessionrestore_no_auto_restore', 17:15:45 INFO - 'tabpaint']}, 17:15:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:15:45 INFO - 'tests': ['a11yr', 17:15:45 INFO - 'ts_paint', 17:15:45 INFO - 'tpaint', 17:15:45 INFO - 'sessionrestore', 17:15:45 INFO - 'sessionrestore_no_auto_restore', 17:15:45 INFO - 'tabpaint']}, 17:15:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:15:45 INFO - 'tests': ['a11yr', 17:15:45 INFO - 'ts_paint', 17:15:45 INFO - 'tpaint', 17:15:45 INFO - 'sessionrestore', 17:15:45 INFO - 'sessionrestore_no_auto_restore', 17:15:45 INFO - 'tabpaint']}, 17:15:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:15:45 INFO - 'tests': ['tsvgx', 17:15:45 INFO - 'tsvgr_opacity', 17:15:45 INFO - 'tart', 17:15:45 INFO - 'tscrollx', 17:15:45 INFO - 'cart']}, 17:15:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:15:45 INFO - 'tsvgr_opacity', 17:15:45 INFO - 'tart', 17:15:45 INFO - 'tscrollx', 17:15:45 INFO - 'cart']}, 17:15:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:45 INFO - 'talos_options': ['--disable-e10s'], 17:15:45 INFO - 'tests': ['tp5o']}, 17:15:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:45 INFO - 'tests': ['tp5o']}, 17:15:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:45 INFO - 'talos_options': ['--disable-e10s', 17:15:45 INFO - '--xperf_path', 17:15:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:15:45 INFO - 'tests': ['tp5n']}, 17:15:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:45 INFO - 'talos_options': ['--xperf_path', 17:15:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:15:45 INFO - 'tests': ['tp5n']}}, 17:15:45 INFO - 'talos.zip': {'path': '', 17:15:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:15:45 INFO - Running post-action listener: _resource_record_post_action 17:15:45 INFO - ##### 17:15:45 INFO - ##### Finished populate-webroot step (success) 17:15:45 INFO - ##### 17:15:45 INFO - ##### 17:15:45 INFO - ##### Running create-virtualenv step. 17:15:45 INFO - ##### 17:15:45 INFO - Running pre-action listener: _resource_record_pre_action 17:15:45 INFO - Running main action method: create_virtualenv 17:15:45 INFO - Creating virtualenv /builds/slave/test/build/venv 17:15:45 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 17:15:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:15:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:15:45 INFO - Using real prefix '/usr' 17:15:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:15:46 INFO - Installing distribute.............................................................................................................................................................................................done. 17:15:48 INFO - Installing pip.................done. 17:15:48 INFO - Return code: 0 17:15:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:48 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 0x7fb6530a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a92190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b24110>, '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 0x2a90230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a906c0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1465517734.342769-524867587', '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 17:15:48 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 17:15:48 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 17:15:48 INFO - Using env: {'DISPLAY': ':0', 17:15:48 INFO - 'HOME': '/home/cltbld', 17:15:48 INFO - 'LANG': 'en_US.UTF-8', 17:15:48 INFO - 'LANGUAGE': 'en_US:en', 17:15:48 INFO - 'LOGNAME': 'cltbld', 17:15:48 INFO - 'MAIL': '/var/mail/cltbld', 17:15:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:48 INFO - 'MOZ_NO_REMOTE': '1', 17:15:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:48 INFO - 'NO_EM_RESTART': '1', 17:15:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:48 INFO - 'PWD': '/builds/slave/test', 17:15:48 INFO - 'SHELL': '/bin/bash', 17:15:48 INFO - 'SHLVL': '1', 17:15:48 INFO - 'TERM': 'linux', 17:15:48 INFO - 'TMOUT': '86400', 17:15:48 INFO - 'USER': 'cltbld', 17:15:48 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465517734.342769-524867587', 17:15:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:48 INFO - '_': '/tools/buildbot/bin/python'} 17:15:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:48 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 17:15:48 INFO - Cleaning up... 17:15:48 INFO - Return code: 0 17:15:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:48 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 0x7fb6530a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a92190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b24110>, '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 0x2a90230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a906c0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1465517734.342769-524867587', '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 17:15:48 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 17:15:48 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 17:15:48 INFO - Using env: {'DISPLAY': ':0', 17:15:48 INFO - 'HOME': '/home/cltbld', 17:15:48 INFO - 'LANG': 'en_US.UTF-8', 17:15:48 INFO - 'LANGUAGE': 'en_US:en', 17:15:48 INFO - 'LOGNAME': 'cltbld', 17:15:48 INFO - 'MAIL': '/var/mail/cltbld', 17:15:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:48 INFO - 'MOZ_NO_REMOTE': '1', 17:15:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:48 INFO - 'NO_EM_RESTART': '1', 17:15:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:48 INFO - 'PWD': '/builds/slave/test', 17:15:48 INFO - 'SHELL': '/bin/bash', 17:15:48 INFO - 'SHLVL': '1', 17:15:48 INFO - 'TERM': 'linux', 17:15:48 INFO - 'TMOUT': '86400', 17:15:48 INFO - 'USER': 'cltbld', 17:15:48 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465517734.342769-524867587', 17:15:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:48 INFO - '_': '/tools/buildbot/bin/python'} 17:15:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:48 INFO - Downloading/unpacking psutil>=3.1.1 17:15:48 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 17:15:48 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 17:15:48 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 17:15:48 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 17:15:48 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 17:15:48 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 17:15:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:15:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:15:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:15:50 INFO - Installing collected packages: psutil 17:15:50 INFO - Running setup.py install for psutil 17:15:50 INFO - building 'psutil._psutil_linux' extension 17:15:50 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 17:15:51 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 17:15:51 INFO - building 'psutil._psutil_posix' extension 17:15:51 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 17:15:51 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 17:15:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:15:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:15:51 INFO - Successfully installed psutil 17:15:51 INFO - Cleaning up... 17:15:51 INFO - Return code: 0 17:15:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17: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')]} 17:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17: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')]} 17:15:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:51 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 0x7fb6530a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a92190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b24110>, '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 0x2a90230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a906c0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1465517734.342769-524867587', '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 17:15:51 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 17:15:51 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 17:15:51 INFO - Using env: {'DISPLAY': ':0', 17:15:51 INFO - 'HOME': '/home/cltbld', 17:15:51 INFO - 'LANG': 'en_US.UTF-8', 17:15:51 INFO - 'LANGUAGE': 'en_US:en', 17:15:51 INFO - 'LOGNAME': 'cltbld', 17:15:51 INFO - 'MAIL': '/var/mail/cltbld', 17:15:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:51 INFO - 'MOZ_NO_REMOTE': '1', 17:15:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:51 INFO - 'NO_EM_RESTART': '1', 17:15:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:51 INFO - 'PWD': '/builds/slave/test', 17:15:51 INFO - 'SHELL': '/bin/bash', 17:15:51 INFO - 'SHLVL': '1', 17:15:51 INFO - 'TERM': 'linux', 17:15:51 INFO - 'TMOUT': '86400', 17:15:51 INFO - 'USER': 'cltbld', 17:15:51 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465517734.342769-524867587', 17:15:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:51 INFO - '_': '/tools/buildbot/bin/python'} 17:15:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:15:51 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 17:15:51 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 17:15:51 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 17:15:51 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 17:15:51 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 17:15:51 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 17:15:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:15:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:15:53 INFO - Installing collected packages: mozsystemmonitor 17:15:53 INFO - Running setup.py install for mozsystemmonitor 17:15:53 INFO - Successfully installed mozsystemmonitor 17:15:53 INFO - Cleaning up... 17:15:53 INFO - Return code: 0 17:15:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:15:53 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')]} 17:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:53 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')]} 17:15:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:53 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 0x7fb6530a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a92190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b24110>, '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 0x2a90230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a906c0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1465517734.342769-524867587', '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 17:15:53 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 17:15:53 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 17:15:53 INFO - Using env: {'DISPLAY': ':0', 17:15:53 INFO - 'HOME': '/home/cltbld', 17:15:53 INFO - 'LANG': 'en_US.UTF-8', 17:15:53 INFO - 'LANGUAGE': 'en_US:en', 17:15:53 INFO - 'LOGNAME': 'cltbld', 17:15:53 INFO - 'MAIL': '/var/mail/cltbld', 17:15:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:53 INFO - 'MOZ_NO_REMOTE': '1', 17:15:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:53 INFO - 'NO_EM_RESTART': '1', 17:15:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:53 INFO - 'PWD': '/builds/slave/test', 17:15:53 INFO - 'SHELL': '/bin/bash', 17:15:53 INFO - 'SHLVL': '1', 17:15:53 INFO - 'TERM': 'linux', 17:15:53 INFO - 'TMOUT': '86400', 17:15:53 INFO - 'USER': 'cltbld', 17:15:53 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465517734.342769-524867587', 17:15:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:53 INFO - '_': '/tools/buildbot/bin/python'} 17:15:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:53 INFO - Downloading/unpacking jsonschema==2.5.1 17:15:53 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 17:15:53 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 17:15:53 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 17:15:53 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 17:15:53 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 17:15:53 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 17:15:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:15:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:56 INFO - Downloading functools32-3.2.3-2.tar.gz 17:15:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:15:56 INFO - warning: no files found matching '*.txt' 17:15:56 INFO - no previously-included directories found matching 'build' 17:15:56 INFO - no previously-included directories found matching 'dist' 17:15:56 INFO - no previously-included directories found matching '.git*' 17:15:56 INFO - Installing collected packages: jsonschema, functools32 17:15:56 INFO - Running setup.py install for functools32 17:15:56 INFO - warning: no files found matching '*.txt' 17:15:56 INFO - no previously-included directories found matching 'build' 17:15:56 INFO - no previously-included directories found matching 'dist' 17:15:56 INFO - no previously-included directories found matching '.git*' 17:15:56 INFO - Successfully installed jsonschema functools32 17:15:56 INFO - Cleaning up... 17:15:56 INFO - Return code: 0 17:15:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:56 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 0x7fb6530a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a92190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b24110>, '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 0x2a90230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a906c0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1465517734.342769-524867587', '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 17:15:56 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 17:15:56 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 17:15:56 INFO - Using env: {'DISPLAY': ':0', 17:15:56 INFO - 'HOME': '/home/cltbld', 17:15:56 INFO - 'LANG': 'en_US.UTF-8', 17:15:56 INFO - 'LANGUAGE': 'en_US:en', 17:15:56 INFO - 'LOGNAME': 'cltbld', 17:15:56 INFO - 'MAIL': '/var/mail/cltbld', 17:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:56 INFO - 'MOZ_NO_REMOTE': '1', 17:15:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:56 INFO - 'NO_EM_RESTART': '1', 17:15:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:56 INFO - 'PWD': '/builds/slave/test', 17:15:56 INFO - 'SHELL': '/bin/bash', 17:15:56 INFO - 'SHLVL': '1', 17:15:56 INFO - 'TERM': 'linux', 17:15:56 INFO - 'TMOUT': '86400', 17:15:56 INFO - 'USER': 'cltbld', 17:15:56 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465517734.342769-524867587', 17:15:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:56 INFO - '_': '/tools/buildbot/bin/python'} 17:15:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:56 INFO - Downloading/unpacking blobuploader==1.2.4 17:15:56 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 17:15:56 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 17:15:56 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 17:15:56 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 17:15:56 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 17:15:56 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 17:15:58 INFO - Downloading blobuploader-1.2.4.tar.gz 17:15:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:15:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17: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 17: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 17: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 17: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 17: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 17: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 17:15:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:15:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17: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 17: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 17: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 17: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 17: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 17: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 17:15:59 INFO - Downloading docopt-0.6.1.tar.gz 17:15:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:15:59 INFO - Installing collected packages: blobuploader, requests, docopt 17:15:59 INFO - Running setup.py install for blobuploader 17:15:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:15:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:15:59 INFO - Running setup.py install for requests 17:15:59 INFO - Running setup.py install for docopt 17:15:59 INFO - Successfully installed blobuploader requests docopt 17:15:59 INFO - Cleaning up... 17:15:59 INFO - Return code: 0 17:15:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:59 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 0x7fb6530a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a92190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b24110>, '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 0x2a90230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a906c0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1465517734.342769-524867587', '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 17:15:59 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 17:15:59 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 17:15:59 INFO - Using env: {'DISPLAY': ':0', 17:15:59 INFO - 'HOME': '/home/cltbld', 17:15:59 INFO - 'LANG': 'en_US.UTF-8', 17:15:59 INFO - 'LANGUAGE': 'en_US:en', 17:15:59 INFO - 'LOGNAME': 'cltbld', 17:15:59 INFO - 'MAIL': '/var/mail/cltbld', 17:15:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:59 INFO - 'MOZ_NO_REMOTE': '1', 17:15:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:59 INFO - 'NO_EM_RESTART': '1', 17:15:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:59 INFO - 'PWD': '/builds/slave/test', 17:15:59 INFO - 'SHELL': '/bin/bash', 17:15:59 INFO - 'SHLVL': '1', 17:15:59 INFO - 'TERM': 'linux', 17:15:59 INFO - 'TMOUT': '86400', 17:15:59 INFO - 'USER': 'cltbld', 17:15:59 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465517734.342769-524867587', 17:15:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:59 INFO - '_': '/tools/buildbot/bin/python'} 17:15:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:15:59 INFO - Running setup.py (path:/tmp/pip-j6yXVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:16:00 INFO - Running setup.py (path:/tmp/pip-bQhXl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:16:00 INFO - Running setup.py (path:/tmp/pip-uDL6Gk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:16:00 INFO - Running setup.py (path:/tmp/pip-y_uFh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:16:00 INFO - Running setup.py (path:/tmp/pip-wAgCyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:16:00 INFO - Running setup.py (path:/tmp/pip-TeZkEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:16:00 INFO - Running setup.py (path:/tmp/pip-8qoPeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:16:00 INFO - Running setup.py (path:/tmp/pip-IsRq4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:16:00 INFO - Running setup.py (path:/tmp/pip-rJg26E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:16:00 INFO - Running setup.py (path:/tmp/pip-R0simA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:16:00 INFO - Running setup.py (path:/tmp/pip-rW0uOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:16:00 INFO - Running setup.py (path:/tmp/pip-wYHpnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:16:00 INFO - Running setup.py (path:/tmp/pip-cJTKZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:16:00 INFO - Running setup.py (path:/tmp/pip-HpfVYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:16:01 INFO - Running setup.py (path:/tmp/pip-7ZHjX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:16:01 INFO - Running setup.py (path:/tmp/pip-IjZnL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:16:01 INFO - Running setup.py (path:/tmp/pip-xlRM3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:16:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:16:01 INFO - Running setup.py install for manifestparser 17:16:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:16:01 INFO - Running setup.py install for mozcrash 17:16:01 INFO - Running setup.py install for mozdebug 17:16:01 INFO - Running setup.py install for mozdevice 17:16:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:16:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:16:01 INFO - Running setup.py install for mozfile 17:16:01 INFO - Running setup.py install for mozhttpd 17:16:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:16:01 INFO - Running setup.py install for mozinfo 17:16:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:16:01 INFO - Running setup.py install for mozInstall 17:16:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:16:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:16:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:16:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:16:02 INFO - Running setup.py install for mozleak 17:16:02 INFO - Running setup.py install for mozlog 17:16:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:16:02 INFO - Running setup.py install for moznetwork 17:16:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:16:02 INFO - Running setup.py install for mozprocess 17:16:02 INFO - Running setup.py install for mozprofile 17:16:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:16:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:16:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:16:02 INFO - Running setup.py install for mozrunner 17:16:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:16:02 INFO - Running setup.py install for mozscreenshot 17:16:02 INFO - Running setup.py install for moztest 17:16:02 INFO - Running setup.py install for mozversion 17:16:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:16:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:16:03 INFO - Cleaning up... 17:16:03 INFO - Return code: 0 17:16:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17: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')]} 17:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17: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')]} 17:16:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:03 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 0x7fb6530a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a92190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b24110>, '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 0x2a90230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a906c0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1465517734.342769-524867587', '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 17:16:03 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 17:16:03 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 17:16:03 INFO - Using env: {'DISPLAY': ':0', 17:16:03 INFO - 'HOME': '/home/cltbld', 17:16:03 INFO - 'LANG': 'en_US.UTF-8', 17:16:03 INFO - 'LANGUAGE': 'en_US:en', 17:16:03 INFO - 'LOGNAME': 'cltbld', 17:16:03 INFO - 'MAIL': '/var/mail/cltbld', 17:16:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:03 INFO - 'MOZ_NO_REMOTE': '1', 17:16:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:03 INFO - 'NO_EM_RESTART': '1', 17:16:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:03 INFO - 'PWD': '/builds/slave/test', 17:16:03 INFO - 'SHELL': '/bin/bash', 17:16:03 INFO - 'SHLVL': '1', 17:16:03 INFO - 'TERM': 'linux', 17:16:03 INFO - 'TMOUT': '86400', 17:16:03 INFO - 'USER': 'cltbld', 17:16:03 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465517734.342769-524867587', 17:16:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:03 INFO - '_': '/tools/buildbot/bin/python'} 17:16:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:16:03 INFO - Running setup.py (path:/tmp/pip-UVcX6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:16:03 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)) 17:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:16:03 INFO - Running setup.py (path:/tmp/pip-E8G9Na-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:16:03 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)) 17:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:16:03 INFO - Running setup.py (path:/tmp/pip-IMJZG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:16:03 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)) 17:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:16:03 INFO - Running setup.py (path:/tmp/pip-gIC_EJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:16:03 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)) 17:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:16:03 INFO - Running setup.py (path:/tmp/pip-Tc3BfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:16:03 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)) 17:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:16:03 INFO - Running setup.py (path:/tmp/pip-GJMhNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:16:03 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)) 17:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:16:03 INFO - Running setup.py (path:/tmp/pip-SQ5EM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:16:03 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)) 17:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:16:03 INFO - Running setup.py (path:/tmp/pip-koQNpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:16:03 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)) 17:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:16:03 INFO - Running setup.py (path:/tmp/pip-ML2fBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:16:03 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)) 17:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:16:03 INFO - Running setup.py (path:/tmp/pip-h1R2ZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:16:03 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)) 17:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:16:03 INFO - Running setup.py (path:/tmp/pip-Co3svW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:16:04 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)) 17:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:16:04 INFO - Running setup.py (path:/tmp/pip-V2lwD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:16:04 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)) 17:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:16:04 INFO - Running setup.py (path:/tmp/pip-2LtN0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:16:04 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)) 17:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:16:04 INFO - Running setup.py (path:/tmp/pip-rh8fms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:16:04 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)) 17:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:16:04 INFO - Running setup.py (path:/tmp/pip-CuFOEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:16:04 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)) 17:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:16:04 INFO - Running setup.py (path:/tmp/pip-bxZvIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:16:04 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)) 17:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:16:04 INFO - Running setup.py (path:/tmp/pip-8mbhSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:16:04 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)) 17:16:04 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)) 17:16:04 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)) 17:16:04 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)) 17:16:04 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)) 17:16:04 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)) 17:16:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:06 INFO - Downloading blessings-1.6.tar.gz 17:16:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:16:06 INFO - Installing collected packages: blessings 17:16:06 INFO - Running setup.py install for blessings 17:16:06 INFO - Successfully installed blessings 17:16:06 INFO - Cleaning up... 17:16:06 INFO - Return code: 0 17:16:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:16:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:16:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:16:06 INFO - Reading from file tmpfile_stdout 17:16:06 INFO - Current package versions: 17:16:06 INFO - argparse == 1.2.1 17:16:06 INFO - blessings == 1.6 17:16:06 INFO - blobuploader == 1.2.4 17:16:06 INFO - docopt == 0.6.1 17:16:06 INFO - functools32 == 3.2.3-2 17:16:06 INFO - jsonschema == 2.5.1 17:16:06 INFO - manifestparser == 1.1 17:16:06 INFO - mozInstall == 1.12 17:16:06 INFO - mozcrash == 0.17 17:16:06 INFO - mozdebug == 0.1 17:16:06 INFO - mozdevice == 0.48 17:16:06 INFO - mozfile == 1.2 17:16:06 INFO - mozhttpd == 0.7 17:16:06 INFO - mozinfo == 0.9 17:16:06 INFO - mozleak == 0.1 17:16:06 INFO - mozlog == 3.2 17:16:06 INFO - moznetwork == 0.27 17:16:06 INFO - mozprocess == 0.22 17:16:06 INFO - mozprofile == 0.28 17:16:06 INFO - mozrunner == 6.11 17:16:06 INFO - mozscreenshot == 0.1 17:16:06 INFO - mozsystemmonitor == 0.3 17:16:06 INFO - moztest == 0.7 17:16:06 INFO - mozversion == 1.4 17:16:06 INFO - psutil == 3.1.1 17:16:06 INFO - requests == 1.2.3 17:16:06 INFO - wsgiref == 0.1.2 17:16:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:16:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:06 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 0x7fb6530a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a92190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b24110>, '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 0x2a90230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a906c0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1465517734.342769-524867587', '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 17:16:06 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 17:16:06 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 17:16:06 INFO - Using env: {'DISPLAY': ':0', 17:16:06 INFO - 'HOME': '/home/cltbld', 17:16:06 INFO - 'LANG': 'en_US.UTF-8', 17:16:06 INFO - 'LANGUAGE': 'en_US:en', 17:16:06 INFO - 'LOGNAME': 'cltbld', 17:16:06 INFO - 'MAIL': '/var/mail/cltbld', 17:16:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:06 INFO - 'MOZ_NO_REMOTE': '1', 17:16:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:06 INFO - 'NO_EM_RESTART': '1', 17:16:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:06 INFO - 'PWD': '/builds/slave/test', 17:16:06 INFO - 'SHELL': '/bin/bash', 17:16:06 INFO - 'SHLVL': '1', 17:16:06 INFO - 'TERM': 'linux', 17:16:06 INFO - 'TMOUT': '86400', 17:16:06 INFO - 'USER': 'cltbld', 17:16:06 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465517734.342769-524867587', 17:16:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:06 INFO - '_': '/tools/buildbot/bin/python'} 17:16:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:07 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)) 17:16:07 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)) 17:16:07 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)) 17:16:07 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)) 17:16:07 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)) 17:16:07 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)) 17:16:07 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)) 17:16:07 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)) 17:16:07 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)) 17:16:07 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)) 17:16:07 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)) 17:16:07 INFO - Cleaning up... 17:16:07 INFO - Return code: 0 17:16:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17: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')]} 17:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17: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')]} 17:16:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6530a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a92190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b24110>, '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 0x2a90230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a906c0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1465517734.342769-524867587', '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 17: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', 'jsonschema'] in /builds/slave/test/build 17: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 jsonschema 17:16:07 INFO - Using env: {'DISPLAY': ':0', 17:16:07 INFO - 'HOME': '/home/cltbld', 17:16:07 INFO - 'LANG': 'en_US.UTF-8', 17:16:07 INFO - 'LANGUAGE': 'en_US:en', 17:16:07 INFO - 'LOGNAME': 'cltbld', 17:16:07 INFO - 'MAIL': '/var/mail/cltbld', 17:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:07 INFO - 'MOZ_NO_REMOTE': '1', 17:16:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:07 INFO - 'NO_EM_RESTART': '1', 17:16:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:07 INFO - 'PWD': '/builds/slave/test', 17:16:07 INFO - 'SHELL': '/bin/bash', 17:16:07 INFO - 'SHLVL': '1', 17:16:07 INFO - 'TERM': 'linux', 17:16:07 INFO - 'TMOUT': '86400', 17:16:07 INFO - 'USER': 'cltbld', 17:16:07 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465517734.342769-524867587', 17:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:07 INFO - '_': '/tools/buildbot/bin/python'} 17:16:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:16:07 INFO - Cleaning up... 17:16:07 INFO - Return code: 0 17:16:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17: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')]} 17:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17: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')]} 17:16:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6530a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a92190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b24110>, '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 0x2a90230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a906c0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1465517734.342769-524867587', '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 17: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', 'flake8'] in /builds/slave/test/build 17: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 flake8 17:16:07 INFO - Using env: {'DISPLAY': ':0', 17:16:07 INFO - 'HOME': '/home/cltbld', 17:16:07 INFO - 'LANG': 'en_US.UTF-8', 17:16:07 INFO - 'LANGUAGE': 'en_US:en', 17:16:07 INFO - 'LOGNAME': 'cltbld', 17:16:07 INFO - 'MAIL': '/var/mail/cltbld', 17:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:07 INFO - 'MOZ_NO_REMOTE': '1', 17:16:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:07 INFO - 'NO_EM_RESTART': '1', 17:16:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:07 INFO - 'PWD': '/builds/slave/test', 17:16:07 INFO - 'SHELL': '/bin/bash', 17:16:07 INFO - 'SHLVL': '1', 17:16:07 INFO - 'TERM': 'linux', 17:16:07 INFO - 'TMOUT': '86400', 17:16:07 INFO - 'USER': 'cltbld', 17:16:07 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465517734.342769-524867587', 17:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:07 INFO - '_': '/tools/buildbot/bin/python'} 17:16:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:07 INFO - Downloading/unpacking flake8 17: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 17: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 17: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 17: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 17: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 17: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 17:16:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:16:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17: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 17: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 17: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 17: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 17: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 17: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 17:16:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:16:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17: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 17: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 17: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 17: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 17: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 17: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 17:16:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17: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 17: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 17: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 17: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 17: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 17: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 17:16:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:16:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:16:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:16:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:16:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:16:10 INFO - no previously-included directories found matching 'docs/_build' 17:16:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:16:10 INFO - Running setup.py install for pep8 17:16:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:16:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:16:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:16:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:16:10 INFO - no previously-included directories found matching 'docs/_build' 17:16:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:16:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:16:10 INFO - Cleaning up... 17:16:10 INFO - Return code: 0 17:16:10 INFO - Running post-action listener: _resource_record_post_action 17:16:10 INFO - Running post-action listener: _start_resource_monitoring 17:16:10 INFO - Starting resource monitoring. 17:16:10 INFO - ##### 17:16:10 INFO - ##### Finished create-virtualenv step (success) 17:16:10 INFO - ##### 17:16:10 INFO - ##### 17:16:10 INFO - ##### Running install step. 17:16:10 INFO - ##### 17:16:10 INFO - Running pre-action listener: _resource_record_pre_action 17:16:10 INFO - Running main action method: install 17:16:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:16:10 INFO - Reading from file tmpfile_stdout 17:16:10 INFO - Detecting whether we're running mozinstall >=1.0... 17:16:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:16:10 INFO - Reading from file tmpfile_stdout 17:16:10 INFO - Output received: 17:16:10 INFO - Usage: mozinstall [options] installer 17:16:10 INFO - Options: 17:16:10 INFO - -h, --help show this help message and exit 17:16:10 INFO - -d DEST, --destination=DEST 17:16:10 INFO - Directory to install application into. [default: 17:16:10 INFO - "/builds/slave/test"] 17:16:10 INFO - --app=APP Application being installed. [default: firefox] 17:16:10 INFO - mkdir: /builds/slave/test/build/application 17:16:10 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'] 17:16:10 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 17:16:27 INFO - Reading from file tmpfile_stdout 17:16:27 INFO - Output received: 17:16:27 INFO - /builds/slave/test/build/application/firefox/firefox 17:16:27 INFO - Running post-action listener: _resource_record_post_action 17:16:27 INFO - ##### 17:16:27 INFO - ##### Finished install step (success) 17:16:27 INFO - ##### 17:16:27 INFO - ##### 17:16:27 INFO - ##### Running run-tests step. 17:16:27 INFO - ##### 17:16:27 INFO - Running pre-action listener: _resource_record_pre_action 17:16:27 INFO - Running main action method: run_tests 17:16:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:16:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:16:27 INFO - Python 2.7.3 17:16:27 INFO - Return code: 0 17:16:27 INFO - grabbing minidump binary from tooltool 17:16:27 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')]} 17:16:27 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 0x2b24110>, '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 0x2a90230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a906c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:16:27 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 17:16:27 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 17:16:27 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 17:16:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:16:27 INFO - Return code: 0 17:16:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:16:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:16:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:16:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:16:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:16:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:16:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:16:28 INFO - Return code: 0 17:16:28 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/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 17:16:28 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/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 17:16:28 INFO - Using env: {'DISPLAY': ':0', 17:16:28 INFO - 'HOME': '/home/cltbld', 17:16:28 INFO - 'LANG': 'en_US.UTF-8', 17:16:28 INFO - 'LANGUAGE': 'en_US:en', 17:16:28 INFO - 'LOGNAME': 'cltbld', 17:16:28 INFO - 'MAIL': '/var/mail/cltbld', 17:16:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:16:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:16:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:28 INFO - 'MOZ_NO_REMOTE': '1', 17:16:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:16:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:28 INFO - 'NO_EM_RESTART': '1', 17:16:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:28 INFO - 'PWD': '/builds/slave/test', 17:16:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:16:28 INFO - 'SHELL': '/bin/bash', 17:16:28 INFO - 'SHLVL': '1', 17:16:28 INFO - 'TERM': 'linux', 17:16:28 INFO - 'TMOUT': '86400', 17:16:28 INFO - 'USER': 'cltbld', 17:16:28 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465517734.342769-524867587', 17:16:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:28 INFO - '_': '/tools/buildbot/bin/python'} 17:16:28 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/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 17:16:28 INFO - mozversion application_buildid: 20160609143002 17:16:28 INFO - mozversion application_changeset: f48fbe4116507315b13ddf3e1861d74c15d72550 17:16:28 INFO - mozversion application_display_name: Nightly 17:16:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:16:28 INFO - mozversion application_name: Firefox 17:16:28 INFO - mozversion application_remotingname: firefox 17:16:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:16:28 INFO - mozversion application_vendor: Mozilla 17:16:28 INFO - mozversion application_version: 50.0a1 17:16:28 INFO - mozversion platform_buildid: 20160609143002 17:16:28 INFO - mozversion platform_changeset: f48fbe4116507315b13ddf3e1861d74c15d72550 17:16:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:16:28 INFO - mozversion platform_version: 50.0a1 17:16:28 INFO - using testdate: 1465517788 17:16:28 INFO - actual date: 1465517788 17:16:28 INFO - starting webserver on 'localhost:59792' 17:16:28 INFO - SUITE-START | Running 2 tests 17:16:28 INFO - TEST-START | dromaeo_css 17:16:28 INFO - operating with platform_type : linux_ 17:16:28 INFO - Initialising browser for dromaeo_css test... 17:16:28 INFO - TEST-INFO | started process 17392 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEkUfmG/profile http://localhost:59792/getInfo.html) 17:16:33 INFO - PROCESS | 17392 | __metrics Screen width/height:1600/1200 17:16:33 INFO - PROCESS | 17392 | colorDepth:24 17:16:33 INFO - PROCESS | 17392 | Browser inner width/height: 1024/697 17:16:33 INFO - PROCESS | 17392 | __metrics 17:16:33 ERROR - PROCESS | 17392 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 17:16:34 INFO - TEST-INFO | 17392: exit 0 17:16:34 INFO - Browser initialized. 17:16:34 INFO - Running cycle 1/1 for dromaeo_css test... 17:16:34 INFO - TEST-INFO | started process 17510 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEkUfmG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:16:46 INFO - PROCESS | 17510 | RSS: Main: 184823808 17:16:46 INFO - PROCESS | 17510 | 17:17:36 INFO - PROCESS | 17510 | 1465517856378 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] 17:19:44 INFO - PROCESS | 17510 | Cycle 1(1): loaded http://localhost:59792/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59792/tests/dromaeo/cssquery-ext.html) 17:19:45 INFO - PROCESS | 17510 | RSS: Main: 187207680 17:19:45 INFO - PROCESS | 17510 | 17:22:47 INFO - PROCESS | 17510 | Cycle 1(1): loaded http://localhost:59792/tests/dromaeo/cssquery-ext.html (next: http://localhost:59792/tests/dromaeo/cssquery-jquery.html) 17:22:47 INFO - PROCESS | 17510 | RSS: Main: 187244544 17:22:47 INFO - PROCESS | 17510 | 17:25:49 INFO - PROCESS | 17510 | Cycle 1(1): loaded http://localhost:59792/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59792/tests/dromaeo/cssquery-mootools.html) 17:25:50 INFO - PROCESS | 17510 | RSS: Main: 188264448 17:25:50 INFO - PROCESS | 17510 | 17:28:52 INFO - PROCESS | 17510 | Cycle 1(1): loaded http://localhost:59792/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59792/tests/dromaeo/cssquery-prototype.html) 17:28:52 INFO - PROCESS | 17510 | RSS: Main: 185831424 17:28:52 INFO - PROCESS | 17510 | 17:31:55 INFO - PROCESS | 17510 | Cycle 1(1): loaded http://localhost:59792/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59792/tests/dromaeo/cssquery-yui.html) 17:31:56 INFO - PROCESS | 17510 | RSS: Main: 188162048 17:31:56 INFO - PROCESS | 17510 | 17:34:58 INFO - PROCESS | 17510 | Cycle 1(1): loaded http://localhost:59792/tests/dromaeo/cssquery-yui.html (next: http://localhost:59792/tests/dromaeo/cssquery-dojo.html) 17:34:59 INFO - PROCESS | 17510 | RSS: Main: 189063168 17:34:59 INFO - PROCESS | 17510 | 17:34:59 INFO - PROCESS | 17510 | __start_tp_report 17:34:59 INFO - PROCESS | 17510 | _x_x_mozilla_page_load 17:34:59 INFO - PROCESS | 17510 | _x_x_mozilla_page_load_details 17:34:59 INFO - PROCESS | 17510 | |i|pagename|runs| 17:34:59 INFO - PROCESS | 17510 | |0;dojo.html;3045.2539127913656;3067.432524982877;3100.178452710032;3110.0358888744477;3118.6101737282825;5207.869803254921;5268.894622107556;5273.683578985264;5292.3913749918775;5351.866203344918;5277.208418737191;5277.287566178565;5303.787848486056;5355.464453554642;5384.030874442598;4780.832670856521;4798.280257961299;4858.927116093261;4941.986892687009;4970.70175789452;750.822925217991;4888.780004899771;4940.629452791037;4953.529414705597;4999.625028122887;4868.9269660955115;4882.438519570242;4898.657094003421;4905.975470122645;4933.260010998379;4775.092732380871;4898.14282500561;4901.607871370317;4929.8028078876805;4954.578860796837;4781.856544303677;4792.137415265251;4804.25534042224;4829.299751536043;4835.323054772335;5274.103402421598;5336;5364.0612892744;5364.517193452608;5391.946080539223;5683.630564013367;5706.600537962344;5725.942740572583;5726.427357264281;5749.856253593652;5739.512141467981;5790.855228619276;5796.188533605298;5798.710064496759;5837.153612726131;5383;5392.5685945123905;5393.541548968303;5395.271638328814;5411.053065713484;5700.8004719835435;5785.71071446426;5799.33307669615;5820.505257053198;5869.207656966255;5624;5630.577706672016;5662.745176467069;5667.376588575254;5681.857953551112;5711.543076553866;5723.484886360247;5729.742161602738;5730.541556675456;5745.913811292834;5575.163725441135;5660.462256085665;5676.262085928803;5724.141378793214;5784.4504772046585;5572.888542229132;5672.943270567324;5693.516051135617;5725.541956643458;5757.280339957505;4346.478422589246;4369.038811461473;4370.8033138508845;4388.0785035142335;4410.69125161242;3875.5930627284292;3878.2243551289853;3904.550976637723;3920;3952.4268980997595;5453.64551304164;5471.06991811393;5474.91787623186;5479.342478902558;5485.807996720096;5757.251557297608;5800.216970708984;5812.622179558315;5824.825255242349;5825.359210486843;5294.205869119586;5442.183672449164;5467.480589344006;5505.862353441196;5525.254090697785;4973.104841128559;4987.0524600325825;4997.450280469146;5002.59979201663;5039.521245481674;5720.88442753659;5973.313068997034;5978.55160862937;5998.1002849572915;6006.849828754229;5704.686242256633;5735.627184233012;5748.109043098327;5795.188673585617;5803.47768700802;5942.851428714143;5949.583529152917;5953.196318496947;5955.731992060281;5969.194158788508;5569.944300556943;5620.606557540933;5676.318841739017;5684.403137670651;5694.658320500783;5681.801136960186;5774.249347584787;5779.739911704068;5782.450667186778;5820.708964551671;5631.1271752878365;5639.295088113986;5645.350784659817;5647.491725744702;5663.490285874126;5488.25908502363;5497.45025497463;5508.228847961369;5587.7485513152815;5627.971860140673;5353.75908084145;5402.594805389533;5413.10683737179;5438;5547.528460080938;5550.555955523468;5606.775728970795;5614.7192640367;5630.042892708331;5648.774049037993;5420.159875219348;5495.203195536705;5518.06192947208;5527.8894422112135;5533.2253484513 17:34:59 INFO - PROCESS | 17510 | |1;ext.html;587.9882402351953;636.9012803015535;637.7704026550442;639.1850390751794;655.8065370715639;42352.78823605881;43969.34045989309;44017.33973990389;45794.313085303744;46020;44428.11143777122;45171;45263.54736452635;45286.32070518945;45369.7731511342;8997.865032024509;9084.818303633923;9102;9137.543122843865;9164.358494905326;8898.421602595843;8994.145556172152;8995.775105622346;8995.955020224923;8996.730098097067;8981.326400519954;8988.865167022499;9026.368154229207;9052.321075919332;9064.864027039599;8965.417247878868;8996.055414181548;8996.550172491348;9018.909810901905;9043.412178208395;8808.779780505474;8809.295256379473;8831.60257788401;8839.02770695223;8859.335549833788;43249.13501729948;43272.13455730868;43503.12993740139;43695.56304436947;43809;3417.7607567470286;3581.982090089559;4105.876823695294;4224.809883555247;4227.661787057059;32525.83737081323;32880.50679239813;33128.6687133128;33460.49809252863;34599.82700086509;4382.4741031076155;4401.846638000561;4435.667324950609;4456.19788438081;4516.728996260234;245808;247897;247934;248061;249202;36323.27353452916;37586.87239382823;37625;60125.699371502866;60305;37030;37438.25123497515;37444.62555374411;37490;37519.437208441894;15955;16037.358505659877;16101.275442604876;16204.432844850373;16247.918760406123;12397.690057748629;12404.75190496185;12413.379331033593;12419.254844709347;12482.75034499305;8305.543195124326;8357.331413486907;8357.373197010127;8404.369672274604;8417.158284171657;3242.367738291058;3242.7567932405163;3263.6246831614194;3282.14664187313;3286.1784553861535;983.6409710455632;1026.503912861661;1115.3475216997986;1159.750653609478;1177.3053898200103;32362.676373236438;32480.187995299835;32688.67311326904;33199.83400082984;33351.66648333534;1115.6764538283808;1153.1005815463952;1162.1574358589955;1171.5957994491887;1203.5667159822458;16788.83211167897;17224.311027559008;17261.741073883903;17279.91360043217;17314;571571;576854;581745;583910;584193;58596.41403585995;59637.70181149067;59711.40288597145;59740.70129649324;59822.40177598255;1236.913416060885;1322.7619028574757;1333.2600406774334;1338.946442142323;1344.4286178374152;30488;31355.275459849927;31719.365612688078;31855;32076.839615802706;51866;52009;52304.21543676772;52576.21135683044;52637.7368113157;517941;521429;524137;525029;529176;28928.132156035354;29270.70729292765;29368.853155734083;29396.853015734785;29433.11700648984;49604.75197623989;50029.49970500248;50078.74960625174;51177.23234151565;51199.23201151911;42235.1552968945;42954;43125;43964;44006.779966099966;41576.79211603923;42295.5770442304;42608.78695606502;42814.78592607017;42896.35655465233;41927.371089434295;42392;42441.15117697567;42655.57344426516;42978;35925.64074359223;37613.623863761015;37869.24261514809;38551.807240963615;38713.61286387213;28787.85606071956;28943.42113157683;29033;29097.27256818512;29285.7071429283 17:34:59 INFO - PROCESS | 17510 | |2;jquery.html;390.9628585284399;401.4600362512422;403.233855674219;403.3344980781708;419.79010494752623;17714.734278985827;19137.61724765504;19331.516712082186;19361.419157425284;20538.794612053876;18288;19359.128839202236;19368.418947431564;19419.514512137204;19490.122944467497;5227.2159176123605;5286.259923610678;5861.17943487912;5861.472467477926;5881.529477641779;5676.517496012844;5680.11958146488;5725.942740572583;5729.197912292261;5761.452661997125;5524.502794748471;5717.056685646863;5790.36306006339;5801.680907550104;5828.03837366834;5279.947200527984;5694.999999999979;5714.51426628737;5738.167965644979;5742.799002034951;5137.588992880561;5149.0474262261605;5150.253213284091;5159.355080614923;5168.767405466763;13366.46534138643;13461.057725959186;17533.912330438267;22938.31185064434;22943;2362.385779697291;2437.902483900642;2510.8242423030397;2576.600626902833;2739.2467071555484;10096.14182794456;10246.948765256126;10316.226283028804;10446.529906154241;10530.315529490636;1857.7306290587924;1944.0765636322774;1951.717001034842;1955.3742802303268;1967.6950072738748;81741.59129204375;87134.5643271786;87313;87322.5633871833;87398;10499.527521261562;10568.15057364958;10792.086136743035;10816.809041332826;10959.83560246597;14842.851571484363;14843.257837108102;14914.627134321729;14920.70158596822;15007;7844.176361482077;8116.310113640407;8251.546164960864;8400.78998025042;8435.873461898076;8008.879866802003;8072.273495385443;8074.232947869943;8194;8248.54632995179;4411.029573493826;4451.77741112943;4550.317452382103;4561.7262964222255;4664.230401983703;1849.6763066463316;1849.9835179654242;1856.8143185681595;1896.2320260294603;1929.4501067195781;969.3602222533094;977.7408986618552;1027.275770581738;1069.1126365116934;1075.3118004477142;18326.81673183251;18902.149403276886;19550.5112372189;19610.70583941242;19672.803271967383;982.6462473509531;1003.6487229469773;1004.322082594246;1051.321897376188;1064.2603390643428;10396.740081498023;10941.617043403601;11016.953389427992;11019.449027548591;11048.447577621248;515114;523555;525418;525961;529729.3513532408;93226;95823;96860.51569742247;97959.51020244854;98096;987.8863930648067;990.6978371596588;1031.6234574380296;1034.8706411698538;1048.09863517375;16246.268917898487;16607.91696041512;16771;17044.14779261057;17204.827951720825;40774.59225407708;41645.1670966585;41859.58140418557;43534.56465435305;43689.56310436855;57156;57697.4230257692;58101.4189858096;59090.40909590849;59502.70248648729;8345.248927596303;8385.1195624461;8439.70461033861;8511.361647876558;8724.520151391735;9696.95151524238;12933.935330323287;13062.216267024009;13099;13266.602001939957;11510.424478776195;11530.135239856876;11569.595064172714;11612.593559225386;11927.761444770882;11403.828942565702;11445.828312575484;11523.596674116367;11544.538218471167;11681.299122052704;11349.943250284026;11606.24559403636;11955.815464587326;12036.03711703044;12085.395730213279;7222.241664625139;7589.241075892367;7994.120646728739;8433.83132337362;8483.363747718822;8649.048604653357;11818.586349477728;11868.05055595533;11873.821892671443;11922.105842061706 17:34:59 INFO - PROCESS | 17510 | |3;mootools.html;1481.6369989352606;1506.9849301506986;1653.9834601653988;1767.2489192093358;1787.3744189533666;7368.59472729001;8526.87209691855;8569.614367353468;9216.631334746611;9235.307351948606;8589;8804.471731696087;8868.645254189825;8924.241439477652;8950.239229665487;2280.315905228433;2310.2722642367685;2313.005407674699;2313.178821518362;2315.016118149788;2348.6477028445784;2363.125643511903;2380.2502211803226;2392.1866565367773;2395.9880200598973;2355.199232261031;2360.114956891166;2373.549025685123;2395.3652282145244;2396.5446565152565;2291.9312420627407;2304.1704986204954;2317.9072837086496;2326.1393284484766;2338.0530884991604;2244.5398693268003;2270.3189043286948;2271.057511132878;2272.0798076778933;2274.078998005794;8890.377673562853;8901;8960.059193784624;8960.23837973773;8963.372563920528;5113.590912726973;5203.219517072432;5204.557612602934;5206.114960456694;5208.062548741225;3202.3755367703307;3307.6361600223954;3419.076849250713;3436.1066122808;3443.6900678939014;1126.0991207034422;1130.129800053962;1164.4643464006567;1170.4440390814295;1173.5012619636705;11426.657200283922;11440.370779607118;11442.256253343588;11445.370504622242;11464.770704585862;4512.458504979358;4576.725396476222;4654.301854721819;4672.672912896064;4677.508861569554;9686.467244301632;9711.611535538499;9723.270754693285;9736;9736.269779766404;5075.3402057732255;5155.53600175986;5166.870828229325;5211.218317252366;5227.686338819683;4274.829006839692;4783.760811959388;4908.631852610997;4993.27597498368;4996.850094497171;4072.9757860214913;4086.6117718816663;4191.413202151702;4199.769012704331;4225.661947044229;1281.5770795637418;1318.7362527494347;1330.0689517337903;1335.6327010072307;1356.3828458051562;991.3011327014582;1006.9395836249848;1021.7521452803861;1026.1944373666636;1047.4343854318736;5987.491063259672;6232.0963460298;6299.0866324382705;6303.117563541108;6312.463440607508;439.15243579891114;445.4387471785509;447.77387419353016;451.4920714196529;468.9390379250744;4182.979085104555;4356.869293921188;4402.6037656610415;4406.449193850769;4432.135733531994;10771.569137234423;11210.327380357205;11277.887221127849;11292.266002709797;11308;10539.947300263602;11153.665390038312;11172.162087843444;11187.888121118847;11221.60724374643;8062.7581172564915;8342.16578342161;8372.1627837217;8435.662573496991;8441.95779021101;6050.757969681164;6345.7144428499905;6356.3325850785;6379.138816259931;6385.521085918482;10176.287659863738;10365.63720269787;10386.532606032595;10504.527296271839;10507.527161277914;9906.554205060933;10195;10277.794444111225;10281.074703276741;10481.37111773296;6886.655667216719;7599.962000189964;7799.688012479437;7989.520628762293;8111.269985701315;8766.868496972424;8830.249428798625;8845.380823342304;8908.55457227123;8910.153535414125;7651.885221721567;7912.525248485109;7924.1283458820635;7932.6033698316005;8003.19968003195;7568.318851303409;7633.122190948112;7707.075150981918;7879.330256928225;7930.088039875257;7278.708851646086;7348.595827229554;7486.4759466836795;7502.099748030271;7509.474336796372;5054.646174767731;5168.638195326291;5181.1969144782615;5248.501392367719;5278.287431196739;5050.974745126251;5114.539691427641;5127.359080114986;5185.688858668492;5245.973770131125 17:34:59 INFO - PROCESS | 17510 | |4;prototype.html;317.2243863753122;322.9693179147981;324.1782082421063;329.3314571420017;329.6686829736115;5521.475459831319;5601.103823388259;5610.803621873235;5648.491635752786;5673.943260567393;5577.609567330289;5599.356074051475;5606.523445507127;5631.8028868989595;5636.746346414411;4347.260965635849;4353.802704256339;4367.890802729941;4381.255186618267;4383.649308055348;4103.1793641271715;4154.709170358076;4261.318189089746;4264.445622069126;4284.5715428457215;4232.470941132358;4241.830326786925;4253.553376895427;4256.127493863766;4260.275753121961;4176.102138040321;4195.727277726938;4228.217779710732;4234.708413933749;4265.829366825324;3560.893173204808;3691.9446208306895;3713.387291096966;3723.3484140275345;3725.8882233533036;5412.9458705412835;5421.834305624309;5432.972835135839;5438.428964958662;5441.891162176774;4838.250071238964;4863.8540843774745;4885.096257192431;4890.31284206948;4895.534924182232;5629.915551266734;5761.683107429089;5815.79644712433;5824.388439213906;5835.416458354173;4041.838326466938;4068.837246510136;4070.837166513336;4074.6332830045144;4086.8160932758096;5988.550858685616;6005.729742161613;6014.2181516403025;6017.06735456005;6017.699115044274;3966.8413263469715;4151.750894946313;4166.250074986471;4166.687493439556;4169.478815148106;4184.497860256789;4200.85297014603;4211.873643790691;4212.894677633084;4213.641840443535;4828.368539146174;4843.733594652328;4853.2336568155815;4859.441164266084;4870.634702397334;5769;5832.24180856486;5852.385499522574;5879.470847623649;5960.225170727865;1450.2821103553808;1457.1766951672482;1458.8103546538882;1460.2990564529086;1461.101422625078;899.2221728205055;899.9460032398077;922.935394522377;933.6732143749633;936.9625214991324;4968.478309777493;5002.74986250686;5514.91727624086;5593.972030139905;5633.267675202197;6064.181335519648;6105.267367915879;6118.359576052242;6127.601705889192;6135.32511423743;5502.642328248651;5610.49505544503;5611.803586874522;5618.937678964974;5621.4378562144275;3196.4406228909847;3225.59680039995;3235.3044095519576;3238.951415728766;3257.1694217974264;6226.626402415779;6272.905906411407;6318.72525890679;6326.493880489642;6343.908179224467;5901.5868889177345;6210;6263.6241825490615;6320.735852829453;6332.52506062038;6321.715522801393;6322.589031712924;6339.619622822645;6355.459785918156;6358;5936.940630593639;6092.482139018233;6140.324564298013;6144.723487443165;6155.84610384744;6054.8183554493435;6056.788012419544;6075.392460753889;6079.544034197364;6125.448709616156;5951.702414879325;6248;6313.96843015782;6362.872742545216;6375.266844312963;4189.601987811153;4200.789960502024;4228.794793483966;4247.702660813713;4254.127903779656;6077;6080;6086.452219300284;6097.695115244309;6132.877342453036;5840.153177789111;5969.582129250911;5986.3115741688525;6051.576389652682;6055.788047418319;5895.469407753323;5920.911186332295;5941;5941.207632412759;5980.850478738066;5867.882642347215;5869.53043756507;5888.234529511307;5901.881962360643;5916;5778.191053252632;5882.441168089024;6009.579329446897;6025.6083354581815;6031.728572214173;5759.769609215752;5782.508486778503;5844.824655260349;5856.092305692625;5860.589758716849 17:34:59 INFO - PROCESS | 17510 | |5;yui.html;772.5001864141378;783.7335305995964;792.7463211772235;800.4836880212263;815.4821688227976;14446.783298250535;15003.249837508121;15199.696006079872;15209.695806083872;15252.161131137796;14000.859991400108;14494.202818844959;14532.200728959902;15001.92499037506;15024.248787560633;810.6028046257336;818.5661599352353;822.3339095332769;822.7984143884756;823.4524041512417;801.5992003998001;813.1096449387911;831.7089018843386;839.529863276564;839.7816567692413;842.5744998775609;855.0637052427613;857.5926434943415;858.4162769316862;858.4634603372892;840.3193413335218;842.2714352085463;846.7502086884354;847.7244895409017;849.4903058165113;615.5106690181317;617.9165812615284;619.8357435279654;621.2793159934454;621.3724138620026;13850.445982160702;13894.444222231099;13920.373583188679;13924.651883702887;13943.302834858318;14482.782758258634;14745.11529308245;14795.852041479662;14797.852021479863;14910.552683419515;12129.332886691229;12329.075319351085;12350;12423.75152496945;12451.377431128407;3824.3689791184697;3949.7037722170953;4057.634812866856;4066.3900414938;4070.2266569352023;74043;74452.76641700757;75375.24624753738;76294.23705762927;76573.61713191398;11427.714307142222;11712.590059347882;11787.469563869647;11826.053915686725;11903;21395;21505.032273547728;21517.139314427248;21615.243466478598;21664.02511886969;8296.751097467086;8608.913910860936;8651.091635378194;8839.911600884037;8923.643054277885;4714.868827772051;4836.081144582588;4838.225883858636;4934.8766280843265;4955.900881982412;3594.3350480161253;3687.3731465650903;3715.108373990223;3716.591174970751;3728.981355093207;640.5740182778493;655.757369773187;657.5922927784804;700.1038670501766;702.0557350363753;662.1888186971019;716.7419728897593;729.7701224114387;746.1493896957472;768.9500182488121;9509.191718703849;9825.557849896772;9868.851967220497;9886.555105020292;9980.351277166961;711.5872793779596;718.267367285366;728.351766927435;744.6462930108155;758.1698040645484;4839.588634966068;5112.718800465936;5120.1039818031695;5143.871403214875;5146.768395422215;77613;100939;101524.49237753764;104338.47830760798;107685;52290.215646765326;69318;89538;100333;106076.46961765141;63047;71649;91023;91867;92487.07512924919;10066.949665251626;10250.692479225636;10359.689209323733;10399.53202105892;10533.315334503233;53041.20438193353;53338.46661533335;54841;55429.16856247079;56238;77648.61175694085;78022.21977780377;78163.18702394597;80390.59804701174;81696.59151704203;13815.516456923959;13835.930820345833;13855.722885542435;14396;14400.279986000449;14871.107733536022;15070.472533461276;15208.619784505476;15229.923850380677;15328.616784580474;13904.791428128789;13958.23229722375;14044.227567483886;14081.647958801112;14792.408303667733;13839.30803459843;14102.083364581269;14522.709545809235;14710.19093949843;14740;12118.885337774138;13441.059125861488;13942.79085813734;14402.495912643426;14605.196714180822;11263.66209013731;11596.188266821242;11655.125865559947;11711.472983715923;11763.705907352385;10916.399598022184;11359.602413915472;11465.713357166138;11546.249493782878;11619.038185329897 17:34:59 INFO - PROCESS | 17510 | __end_tp_report 17:34:59 INFO - PROCESS | 17510 | __start_cc_report 17:34:59 INFO - PROCESS | 17510 | _x_x_mozilla_cycle_collect,360 17:34:59 INFO - PROCESS | 17510 | __end_cc_report 17:34:59 INFO - PROCESS | 17510 | __startTimestamp1465518899223__endTimestamp 17:34:59 INFO - PROCESS | 17510 | 17:34:59 INFO - PROCESS | 17510 | ------- Summary: start ------- 17:34:59 INFO - PROCESS | 17510 | Number of tests: 6 17:34:59 INFO - PROCESS | 17510 | 17:34:59 INFO - PROCESS | 17510 | [#0] dojo.html Cycles:165 Average:5298.72 Median:5518.06 stddev:701.38 (12.7%) stddev-sans-first:680.89 17:34:59 INFO - PROCESS | 17510 | Values: 3045.3 3067.4 3100.2 3110.0 3118.6 5207.9 5268.9 5273.7 5292.4 5351.9 5277.2 5277.3 5303.8 5355.5 5384.0 4780.8 4798.3 4858.9 4942.0 4970.7 750.8 4888.8 4940.6 4953.5 4999.6 4868.9 4882.4 4898.7 4906.0 4933.3 4775.1 4898.1 4901.6 4929.8 4954.6 4781.9 4792.1 4804.3 4829.3 4835.3 5274.1 5336.0 5364.1 5364.5 5391.9 5683.6 5706.6 5725.9 5726.4 5749.9 5739.5 5790.9 5796.2 5798.7 5837.2 5383.0 5392.6 5393.5 5395.3 5411.1 5700.8 5785.7 5799.3 5820.5 5869.2 5624.0 5630.6 5662.7 5667.4 5681.9 5711.5 5723.5 5729.7 5730.5 5745.9 5575.2 5660.5 5676.3 5724.1 5784.5 5572.9 5672.9 5693.5 5725.5 5757.3 4346.5 4369.0 4370.8 4388.1 4410.7 3875.6 3878.2 3904.6 3920.0 3952.4 5453.6 5471.1 5474.9 5479.3 5485.8 5757.3 5800.2 5812.6 5824.8 5825.4 5294.2 5442.2 5467.5 5505.9 5525.3 4973.1 4987.1 4997.5 5002.6 5039.5 5720.9 5973.3 5978.6 5998.1 6006.8 5704.7 5735.6 5748.1 5795.2 5803.5 5942.9 5949.6 5953.2 5955.7 5969.2 5569.9 5620.6 5676.3 5684.4 5694.7 5681.8 5774.2 5779.7 5782.5 5820.7 5631.1 5639.3 5645.4 5647.5 5663.5 5488.3 5497.5 5508.2 5587.7 5628.0 5353.8 5402.6 5413.1 5438.0 5547.5 5550.6 5606.8 5614.7 5630.0 5648.8 5420.2 5495.2 5518.1 5527.9 5533.2 17:34:59 INFO - PROCESS | 17510 | 17:34:59 INFO - PROCESS | 17510 | [#1] ext.html Cycles:180 Average:60185.14 Median:42735.18 stddev:126462.54 (295.9%) stddev-sans-first:126738.14 17:34:59 INFO - PROCESS | 17510 | Values: 588.0 636.9 637.8 639.2 655.8 42352.8 43969.3 44017.3 45794.3 46020.0 44428.1 45171.0 45263.5 45286.3 45369.8 8997.9 9084.8 9102.0 9137.5 9164.4 8898.4 8994.1 8995.8 8996.0 8996.7 8981.3 8988.9 9026.4 9052.3 9064.9 8965.4 8996.1 8996.6 9018.9 9043.4 8808.8 8809.3 8831.6 8839.0 8859.3 43249.1 43272.1 43503.1 43695.6 43809.0 3417.8 3582.0 4105.9 4224.8 4227.7 32525.8 32880.5 33128.7 33460.5 34599.8 4382.5 4401.8 4435.7 4456.2 4516.7 245808.0 247897.0 247934.0 248061.0 249202.0 36323.3 37586.9 37625.0 60125.7 60305.0 37030.0 37438.3 37444.6 37490.0 37519.4 15955.0 16037.4 16101.3 16204.4 16247.9 12397.7 12404.8 12413.4 12419.3 12482.8 8305.5 8357.3 8357.4 8404.4 8417.2 3242.4 3242.8 3263.6 3282.1 3286.2 983.6 1026.5 1115.3 1159.8 1177.3 32362.7 32480.2 32688.7 33199.8 33351.7 1115.7 1153.1 1162.2 1171.6 1203.6 16788.8 17224.3 17261.7 17279.9 17314.0 571571.0 576854.0 581745.0 583910.0 584193.0 58596.4 59637.7 59711.4 59740.7 59822.4 1236.9 1322.8 1333.3 1338.9 1344.4 30488.0 31355.3 31719.4 31855.0 32076.8 51866.0 52009.0 52304.2 52576.2 52637.7 517941.0 521429.0 524137.0 525029.0 529176.0 28928.1 29270.7 29368.9 29396.9 29433.1 49604.8 50029.5 50078.7 51177.2 51199.2 42235.2 42954.0 43125.0 43964.0 44006.8 41576.8 42295.6 42608.8 42814.8 42896.4 41927.4 42392.0 42441.2 42655.6 42978.0 35925.6 37613.6 37869.2 38551.8 38713.6 28787.9 28943.4 29033.0 29097.3 29285.7 17:34:59 INFO - PROCESS | 17510 | 17:34:59 INFO - PROCESS | 17510 | [#2] jquery.html Cycles:180 Average:29998.97 Median:2543.71 stddev:86444.69 (3398.4%) stddev-sans-first:86658.60 17:34:59 INFO - PROCESS | 17510 | Values: 391.0 401.5 403.2 403.3 419.8 17714.7 19137.6 19331.5 19361.4 20538.8 18288.0 19359.1 19368.4 19419.5 19490.1 5227.2 5286.3 5861.2 5861.5 5881.5 5676.5 5680.1 5725.9 5729.2 5761.5 5524.5 5717.1 5790.4 5801.7 5828.0 5279.9 5695.0 5714.5 5738.2 5742.8 5137.6 5149.0 5150.3 5159.4 5168.8 13366.5 13461.1 17533.9 22938.3 22943.0 2362.4 2437.9 2510.8 2576.6 2739.2 10096.1 10246.9 10316.2 10446.5 10530.3 1857.7 1944.1 1951.7 1955.4 1967.7 81741.6 87134.6 87313.0 87322.6 87398.0 10499.5 10568.2 10792.1 10816.8 10959.8 14842.9 14843.3 14914.6 14920.7 15007.0 7844.2 8116.3 8251.5 8400.8 8435.9 8008.9 8072.3 8074.2 8194.0 8248.5 4411.0 4451.8 4550.3 4561.7 4664.2 1849.7 1850.0 1856.8 1896.2 1929.5 969.4 977.7 1027.3 1069.1 1075.3 18326.8 18902.1 19550.5 19610.7 19672.8 982.6 1003.6 1004.3 1051.3 1064.3 10396.7 10941.6 11017.0 11019.4 11048.4 515114.0 523555.0 525418.0 525961.0 529729.4 93226.0 95823.0 96860.5 97959.5 98096.0 987.9 990.7 1031.6 1034.9 1048.1 16246.3 16607.9 16771.0 17044.1 17204.8 40774.6 41645.2 41859.6 43534.6 43689.6 57156.0 57697.4 58101.4 59090.4 59502.7 8345.2 8385.1 8439.7 8511.4 8724.5 9697.0 12933.9 13062.2 13099.0 13266.6 11510.4 11530.1 11569.6 11612.6 11927.8 11403.8 11445.8 11523.6 11544.5 11681.3 11349.9 11606.2 11955.8 12036.0 12085.4 7222.2 7589.2 7994.1 8433.8 8483.4 8649.0 11818.6 11868.1 11873.8 11922.1 17:34:59 INFO - PROCESS | 17510 | 17:34:59 INFO - PROCESS | 17510 | [#3] mootools.html Cycles:180 Average:5833.12 Median:4663.49 stddev:3291.96 (70.6%) stddev-sans-first:3284.95 17:34:59 INFO - PROCESS | 17510 | Values: 1481.6 1507.0 1654.0 1767.2 1787.4 7368.6 8526.9 8569.6 9216.6 9235.3 8589.0 8804.5 8868.6 8924.2 8950.2 2280.3 2310.3 2313.0 2313.2 2315.0 2348.6 2363.1 2380.3 2392.2 2396.0 2355.2 2360.1 2373.5 2395.4 2396.5 2291.9 2304.2 2317.9 2326.1 2338.1 2244.5 2270.3 2271.1 2272.1 2274.1 8890.4 8901.0 8960.1 8960.2 8963.4 5113.6 5203.2 5204.6 5206.1 5208.1 3202.4 3307.6 3419.1 3436.1 3443.7 1126.1 1130.1 1164.5 1170.4 1173.5 11426.7 11440.4 11442.3 11445.4 11464.8 4512.5 4576.7 4654.3 4672.7 4677.5 9686.5 9711.6 9723.3 9736.0 9736.3 5075.3 5155.5 5166.9 5211.2 5227.7 4274.8 4783.8 4908.6 4993.3 4996.9 4073.0 4086.6 4191.4 4199.8 4225.7 1281.6 1318.7 1330.1 1335.6 1356.4 991.3 1006.9 1021.8 1026.2 1047.4 5987.5 6232.1 6299.1 6303.1 6312.5 439.2 445.4 447.8 451.5 468.9 4183.0 4356.9 4402.6 4406.4 4432.1 10771.6 11210.3 11277.9 11292.3 11308.0 10539.9 11153.7 11172.2 11187.9 11221.6 8062.8 8342.2 8372.2 8435.7 8442.0 6050.8 6345.7 6356.3 6379.1 6385.5 10176.3 10365.6 10386.5 10504.5 10507.5 9906.6 10195.0 10277.8 10281.1 10481.4 6886.7 7600.0 7799.7 7989.5 8111.3 8766.9 8830.2 8845.4 8908.6 8910.2 7651.9 7912.5 7924.1 7932.6 8003.2 7568.3 7633.1 7707.1 7879.3 7930.1 7278.7 7348.6 7486.5 7502.1 7509.5 5054.6 5168.6 5181.2 5248.5 5278.3 5051.0 5114.5 5127.4 5185.7 5246.0 17:34:59 INFO - PROCESS | 17510 | 17:34:59 INFO - PROCESS | 17510 | [#4] prototype.html Cycles:180 Average:4924.48 Median:5630.86 stddev:1497.27 (26.6%) stddev-sans-first:1460.99 17:34:59 INFO - PROCESS | 17510 | Values: 317.2 323.0 324.2 329.3 329.7 5521.5 5601.1 5610.8 5648.5 5673.9 5577.6 5599.4 5606.5 5631.8 5636.7 4347.3 4353.8 4367.9 4381.3 4383.6 4103.2 4154.7 4261.3 4264.4 4284.6 4232.5 4241.8 4253.6 4256.1 4260.3 4176.1 4195.7 4228.2 4234.7 4265.8 3560.9 3691.9 3713.4 3723.3 3725.9 5412.9 5421.8 5433.0 5438.4 5441.9 4838.3 4863.9 4885.1 4890.3 4895.5 5629.9 5761.7 5815.8 5824.4 5835.4 4041.8 4068.8 4070.8 4074.6 4086.8 5988.6 6005.7 6014.2 6017.1 6017.7 3966.8 4151.8 4166.3 4166.7 4169.5 4184.5 4200.9 4211.9 4212.9 4213.6 4828.4 4843.7 4853.2 4859.4 4870.6 5769.0 5832.2 5852.4 5879.5 5960.2 1450.3 1457.2 1458.8 1460.3 1461.1 899.2 899.9 922.9 933.7 937.0 4968.5 5002.7 5514.9 5594.0 5633.3 6064.2 6105.3 6118.4 6127.6 6135.3 5502.6 5610.5 5611.8 5618.9 5621.4 3196.4 3225.6 3235.3 3239.0 3257.2 6226.6 6272.9 6318.7 6326.5 6343.9 5901.6 6210.0 6263.6 6320.7 6332.5 6321.7 6322.6 6339.6 6355.5 6358.0 5936.9 6092.5 6140.3 6144.7 6155.8 6054.8 6056.8 6075.4 6079.5 6125.4 5951.7 6248.0 6314.0 6362.9 6375.3 4189.6 4200.8 4228.8 4247.7 4254.1 6077.0 6080.0 6086.5 6097.7 6132.9 5840.2 5969.6 5986.3 6051.6 6055.8 5895.5 5920.9 5941.0 5941.2 5980.9 5867.9 5869.5 5888.2 5901.9 5916.0 5778.2 5882.4 6009.6 6025.6 6031.7 5759.8 5782.5 5844.8 5856.1 5860.6 17:34:59 INFO - PROCESS | 17510 | 17:34:59 INFO - PROCESS | 17510 | [#5] yui.html Cycles:180 Average:20129.65 Median:4392.55 stddev:27791.26 (632.7%) stddev-sans-first:27831.21 17:34:59 INFO - PROCESS | 17510 | Values: 772.5 783.7 792.7 800.5 815.5 14446.8 15003.2 15199.7 15209.7 15252.2 14000.9 14494.2 14532.2 15001.9 15024.2 810.6 818.6 822.3 822.8 823.5 801.6 813.1 831.7 839.5 839.8 842.6 855.1 857.6 858.4 858.5 840.3 842.3 846.8 847.7 849.5 615.5 617.9 619.8 621.3 621.4 13850.4 13894.4 13920.4 13924.7 13943.3 14482.8 14745.1 14795.9 14797.9 14910.6 12129.3 12329.1 12350.0 12423.8 12451.4 3824.4 3949.7 4057.6 4066.4 4070.2 74043.0 74452.8 75375.2 76294.2 76573.6 11427.7 11712.6 11787.5 11826.1 11903.0 21395.0 21505.0 21517.1 21615.2 21664.0 8296.8 8608.9 8651.1 8839.9 8923.6 4714.9 4836.1 4838.2 4934.9 4955.9 3594.3 3687.4 3715.1 3716.6 3729.0 640.6 655.8 657.6 700.1 702.1 662.2 716.7 729.8 746.1 769.0 9509.2 9825.6 9868.9 9886.6 9980.4 711.6 718.3 728.4 744.6 758.2 4839.6 5112.7 5120.1 5143.9 5146.8 77613.0 100939.0 101524.5 104338.5 107685.0 52290.2 69318.0 89538.0 100333.0 106076.5 63047.0 71649.0 91023.0 91867.0 92487.1 10066.9 10250.7 10359.7 10399.5 10533.3 53041.2 53338.5 54841.0 55429.2 56238.0 77648.6 78022.2 78163.2 80390.6 81696.6 13815.5 13835.9 13855.7 14396.0 14400.3 14871.1 15070.5 15208.6 15229.9 15328.6 13904.8 13958.2 14044.2 14081.6 14792.4 13839.3 14102.1 14522.7 14710.2 14740.0 12118.9 13441.1 13942.8 14402.5 14605.2 11263.7 11596.2 11655.1 11711.5 11763.7 10916.4 11359.6 11465.7 11546.2 11619.0 17:34:59 INFO - PROCESS | 17510 | -------- Summary: end -------- 17:34:59 INFO - PROCESS | 17510 | 17:34:59 INFO - TEST-INFO | 17510: exit 0 17:34:59 INFO - TEST-OK | dromaeo_css | took 1111201ms 17:34:59 INFO - TEST-START | kraken 17:34:59 INFO - operating with platform_type : linux_ 17:34:59 INFO - Initialising browser for kraken test... 17:35:00 INFO - TEST-INFO | started process 17741 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1_pmck/profile http://localhost:59792/getInfo.html) 17:35:04 INFO - PROCESS | 17741 | __metrics Screen width/height:1600/1200 17:35:04 INFO - PROCESS | 17741 | colorDepth:24 17:35:04 INFO - PROCESS | 17741 | Browser inner width/height: 1024/697 17:35:04 INFO - PROCESS | 17741 | __metrics 17:35:05 ERROR - PROCESS | 17741 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 17:35:06 INFO - TEST-INFO | 17741: exit 0 17:35:06 INFO - Browser initialized. 17:35:06 INFO - Running cycle 1/1 for kraken test... 17:35:06 INFO - TEST-INFO | started process 17859 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1_pmck/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:35:18 INFO - PROCESS | 17859 | RSS: Main: 185151488 17:35:18 INFO - PROCESS | 17859 | 17:35:20 INFO - PROCESS | 17859 | Cycle 1(1): loaded http://localhost:59792/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59792/tests/kraken/driver.html?testName=audio-beat-detection) 17:35:21 INFO - PROCESS | 17859 | RSS: Main: 190214144 17:35:21 INFO - PROCESS | 17859 | 17:35:24 INFO - PROCESS | 17859 | Cycle 1(1): loaded http://localhost:59792/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59792/tests/kraken/driver.html?testName=audio-dft) 17:35:24 INFO - PROCESS | 17859 | RSS: Main: 189566976 17:35:24 INFO - PROCESS | 17859 | 17:35:27 INFO - PROCESS | 17859 | Cycle 1(1): loaded http://localhost:59792/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59792/tests/kraken/driver.html?testName=audio-fft) 17:35:28 INFO - PROCESS | 17859 | RSS: Main: 184500224 17:35:28 INFO - PROCESS | 17859 | 17:35:30 INFO - PROCESS | 17859 | Cycle 1(1): loaded http://localhost:59792/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59792/tests/kraken/driver.html?testName=audio-oscillator) 17:35:31 INFO - PROCESS | 17859 | RSS: Main: 185442304 17:35:31 INFO - PROCESS | 17859 | 17:35:33 INFO - PROCESS | 17859 | Cycle 1(1): loaded http://localhost:59792/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59792/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:35:34 INFO - PROCESS | 17859 | RSS: Main: 185782272 17:35:34 INFO - PROCESS | 17859 | 17:35:37 INFO - PROCESS | 17859 | Cycle 1(1): loaded http://localhost:59792/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59792/tests/kraken/driver.html?testName=imaging-darkroom) 17:35:37 INFO - PROCESS | 17859 | RSS: Main: 185810944 17:35:37 INFO - PROCESS | 17859 | 17:35:41 INFO - PROCESS | 17859 | Cycle 1(1): loaded http://localhost:59792/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59792/tests/kraken/driver.html?testName=imaging-desaturate) 17:35:41 INFO - PROCESS | 17859 | RSS: Main: 183566336 17:35:41 INFO - PROCESS | 17859 | 17:35:44 INFO - PROCESS | 17859 | Cycle 1(1): loaded http://localhost:59792/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59792/tests/kraken/driver.html?testName=json-parse-financial) 17:35:45 INFO - PROCESS | 17859 | RSS: Main: 184643584 17:35:45 INFO - PROCESS | 17859 | 17:35:46 INFO - PROCESS | 17859 | Cycle 1(1): loaded http://localhost:59792/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59792/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:35:47 INFO - PROCESS | 17859 | RSS: Main: 184934400 17:35:47 INFO - PROCESS | 17859 | 17:35:49 INFO - PROCESS | 17859 | Cycle 1(1): loaded http://localhost:59792/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59792/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:35:49 INFO - PROCESS | 17859 | RSS: Main: 185147392 17:35:49 INFO - PROCESS | 17859 | 17:35:51 INFO - PROCESS | 17859 | Cycle 1(1): loaded http://localhost:59792/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59792/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:35:52 INFO - PROCESS | 17859 | RSS: Main: 185339904 17:35:52 INFO - PROCESS | 17859 | 17:35:55 INFO - PROCESS | 17859 | Cycle 1(1): loaded http://localhost:59792/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59792/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:35:55 INFO - PROCESS | 17859 | RSS: Main: 185823232 17:35:55 INFO - PROCESS | 17859 | 17:35:58 INFO - PROCESS | 17859 | Cycle 1(1): loaded http://localhost:59792/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59792/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:35:59 INFO - PROCESS | 17859 | RSS: Main: 185602048 17:35:59 INFO - PROCESS | 17859 | 17:36:00 INFO - PROCESS | 17859 | Cycle 1(1): loaded http://localhost:59792/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59792/tests/kraken/driver.html?testName=ai-astar) 17:36:01 INFO - PROCESS | 17859 | RSS: Main: 186068992 17:36:01 INFO - PROCESS | 17859 | 17:36:01 INFO - PROCESS | 17859 | __start_tp_report 17:36:01 INFO - PROCESS | 17859 | _x_x_mozilla_page_load 17:36:01 INFO - PROCESS | 17859 | _x_x_mozilla_page_load_details 17:36:01 INFO - PROCESS | 17859 | |i|pagename|runs| 17:36:01 INFO - PROCESS | 17859 | |0;ai-astar;111;106;111;111;111;113;110;112;110;110 17:36:01 INFO - PROCESS | 17859 | |1;audio-beat-detection;159;137;157;171;131;152;154;132;178;130 17:36:01 INFO - PROCESS | 17859 | |2;audio-dft;162;162;164;163;164;168;161;161;162;163 17:36:01 INFO - PROCESS | 17859 | |3;audio-fft;75;75;76;162;76;76;74;74;159;76 17:36:01 INFO - PROCESS | 17859 | |4;audio-oscillator;85;84;146;86;92;85;150;84;85;144 17:36:01 INFO - PROCESS | 17859 | |5;imaging-gaussian-blur;118;117;117;117;118;117;117;117;117;117 17:36:01 INFO - PROCESS | 17859 | |6;imaging-darkroom;148;147;149;148;146;147;146;149;147;148 17:36:01 INFO - PROCESS | 17859 | |7;imaging-desaturate;98;96;96;95;95;96;96;96;96;95 17:36:01 INFO - PROCESS | 17859 | |8;json-parse-financial;55;56;56;57;55;57;57;57;55;56 17:36:01 INFO - PROCESS | 17859 | |9;json-stringify-tinderbox;61;61;62;62;64;62;62;62;62;62 17:36:01 INFO - PROCESS | 17859 | |10;stanford-crypto-aes;80;82;79;80;79;81;80;79;113;89 17:36:01 INFO - PROCESS | 17859 | |11;stanford-crypto-ccm;128;123;133;126;122;137;139;124;135;122 17:36:01 INFO - PROCESS | 17859 | |12;stanford-crypto-pbkdf2;167;160;164;159;159;160;162;172;158;161 17:36:01 INFO - PROCESS | 17859 | |13;stanford-crypto-sha256-iterative;63;63;64;63;64;65;66;63;63;63 17:36:01 INFO - PROCESS | 17859 | __end_tp_report 17:36:01 INFO - PROCESS | 17859 | __start_cc_report 17:36:01 INFO - PROCESS | 17859 | _x_x_mozilla_cycle_collect,905 17:36:01 INFO - PROCESS | 17859 | __end_cc_report 17:36:01 INFO - PROCESS | 17859 | __startTimestamp1465518961190__endTimestamp 17:36:01 INFO - PROCESS | 17859 | 17:36:01 INFO - PROCESS | 17859 | ------- Summary: start ------- 17:36:01 INFO - PROCESS | 17859 | Number of tests: 14 17:36:01 INFO - PROCESS | 17859 | 17:36:01 INFO - PROCESS | 17859 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:1.84 (1.7%) stddev-sans-first:1.94 17:36:01 INFO - PROCESS | 17859 | Values: 111.0 106.0 111.0 111.0 111.0 113.0 110.0 112.0 110.0 110.0 17:36:01 INFO - PROCESS | 17859 | 17:36:01 INFO - PROCESS | 17859 | [#1] audio-beat-detection Cycles:10 Average:150.10 Median:155.50 stddev:17.09 (11.0%) stddev-sans-first:17.82 17:36:01 INFO - PROCESS | 17859 | Values: 159.0 137.0 157.0 171.0 131.0 152.0 154.0 132.0 178.0 130.0 17:36:01 INFO - PROCESS | 17859 | 17:36:01 INFO - PROCESS | 17859 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:2.05 (1.3%) stddev-sans-first:2.15 17:36:01 INFO - PROCESS | 17859 | Values: 162.0 162.0 164.0 163.0 164.0 168.0 161.0 161.0 162.0 163.0 17:36:01 INFO - PROCESS | 17859 | 17:36:01 INFO - PROCESS | 17859 | [#3] audio-fft Cycles:10 Average:92.30 Median:75.50 stddev:35.96 (47.6%) stddev-sans-first:37.59 17:36:01 INFO - PROCESS | 17859 | Values: 75.0 75.0 76.0 162.0 76.0 76.0 74.0 74.0 159.0 76.0 17:36:01 INFO - PROCESS | 17859 | 17:36:01 INFO - PROCESS | 17859 | [#4] audio-oscillator Cycles:10 Average:104.10 Median:85.00 stddev:29.50 (34.7%) stddev-sans-first:30.47 17:36:01 INFO - PROCESS | 17859 | Values: 85.0 84.0 146.0 86.0 92.0 85.0 150.0 84.0 85.0 144.0 17:36:01 INFO - PROCESS | 17859 | 17:36:01 INFO - PROCESS | 17859 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 17:36:01 INFO - PROCESS | 17859 | Values: 118.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 17:36:01 INFO - PROCESS | 17859 | 17:36:01 INFO - PROCESS | 17859 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:1.08 (0.7%) stddev-sans-first:1.13 17:36:01 INFO - PROCESS | 17859 | Values: 148.0 147.0 149.0 148.0 146.0 147.0 146.0 149.0 147.0 148.0 17:36:01 INFO - PROCESS | 17859 | 17:36:01 INFO - PROCESS | 17859 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.88 (0.9%) stddev-sans-first:0.50 17:36:01 INFO - PROCESS | 17859 | Values: 98.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 95.0 17:36:01 INFO - PROCESS | 17859 | 17:36:01 INFO - PROCESS | 17859 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.50 stddev:0.88 (1.5%) stddev-sans-first:0.83 17:36:01 INFO - PROCESS | 17859 | Values: 55.0 56.0 56.0 57.0 55.0 57.0 57.0 57.0 55.0 56.0 17:36:01 INFO - PROCESS | 17859 | 17:36:01 INFO - PROCESS | 17859 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:0.82 (1.3%) stddev-sans-first:0.78 17:36:01 INFO - PROCESS | 17859 | Values: 61.0 61.0 62.0 62.0 64.0 62.0 62.0 62.0 62.0 62.0 17:36:01 INFO - PROCESS | 17859 | 17:36:01 INFO - PROCESS | 17859 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:80.00 stddev:10.55 (13.2%) stddev-sans-first:11.08 17:36:01 INFO - PROCESS | 17859 | Values: 80.0 82.0 79.0 80.0 79.0 81.0 80.0 79.0 113.0 89.0 17:36:01 INFO - PROCESS | 17859 | 17:36:01 INFO - PROCESS | 17859 | [#11] stanford-crypto-ccm Cycles:10 Average:128.90 Median:130.50 stddev:6.54 (5.0%) stddev-sans-first:6.93 17:36:01 INFO - PROCESS | 17859 | Values: 128.0 123.0 133.0 126.0 122.0 137.0 139.0 124.0 135.0 122.0 17:36:01 INFO - PROCESS | 17859 | 17:36:01 INFO - PROCESS | 17859 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.20 Median:161.50 stddev:4.37 (2.7%) stddev-sans-first:4.27 17:36:01 INFO - PROCESS | 17859 | Values: 167.0 160.0 164.0 159.0 159.0 160.0 162.0 172.0 158.0 161.0 17:36:01 INFO - PROCESS | 17859 | 17:36:01 INFO - PROCESS | 17859 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:63.50 stddev:1.06 (1.7%) stddev-sans-first:1.09 17:36:01 INFO - PROCESS | 17859 | Values: 63.0 63.0 64.0 63.0 64.0 65.0 66.0 63.0 63.0 63.0 17:36:01 INFO - PROCESS | 17859 | -------- Summary: end -------- 17:36:01 INFO - PROCESS | 17859 | 17:36:02 INFO - TEST-INFO | 17859: exit 0 17:36:02 INFO - TEST-OK | kraken | took 62167ms 17:36:02 INFO - SUITE-END | took 1173s 17:36:02 INFO - Completed test suite (00:19:33) 17:36:02 INFO - javascript benchmark 17:36:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7240.501779917251, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3045.2539127913656, 3067.432524982877, 3100.178452710032, 3110.0358888744477, 3118.6101737282825, 5207.869803254921, 5268.894622107556, 5273.683578985264, 5292.3913749918775, 5351.866203344918, 5277.208418737191, 5277.287566178565, 5303.787848486056, 5355.464453554642, 5384.030874442598, 4780.832670856521, 4798.280257961299, 4858.927116093261, 4941.986892687009, 4970.70175789452, 750.822925217991, 4888.780004899771, 4940.629452791037, 4953.529414705597, 4999.625028122887, 4868.9269660955115, 4882.438519570242, 4898.657094003421, 4905.975470122645, 4933.260010998379, 4775.092732380871, 4898.14282500561, 4901.607871370317, 4929.8028078876805, 4954.578860796837, 4781.856544303677, 4792.137415265251, 4804.25534042224, 4829.299751536043, 4835.323054772335, 5274.103402421598, 5336.0, 5364.0612892744, 5364.517193452608, 5391.946080539223, 5683.630564013367, 5706.600537962344, 5725.942740572583, 5726.427357264281, 5749.856253593652, 5739.512141467981, 5790.855228619276, 5796.188533605298, 5798.710064496759, 5837.153612726131, 5383.0, 5392.5685945123905, 5393.541548968303, 5395.271638328814, 5411.053065713484, 5700.8004719835435, 5785.71071446426, 5799.33307669615, 5820.505257053198, 5869.207656966255, 5624.0, 5630.577706672016, 5662.745176467069, 5667.376588575254, 5681.857953551112, 5711.543076553866, 5723.484886360247, 5729.742161602738, 5730.541556675456, 5745.913811292834, 5575.163725441135, 5660.462256085665, 5676.262085928803, 5724.141378793214, 5784.4504772046585, 5572.888542229132, 5672.943270567324, 5693.516051135617, 5725.541956643458, 5757.280339957505, 4346.478422589246, 4369.038811461473, 4370.8033138508845, 4388.0785035142335, 4410.69125161242, 3875.5930627284292, 3878.2243551289853, 3904.550976637723, 3920.0, 3952.4268980997595, 5453.64551304164, 5471.06991811393, 5474.91787623186, 5479.342478902558, 5485.807996720096, 5757.251557297608, 5800.216970708984, 5812.622179558315, 5824.825255242349, 5825.359210486843, 5294.205869119586, 5442.183672449164, 5467.480589344006, 5505.862353441196, 5525.254090697785, 4973.104841128559, 4987.0524600325825, 4997.450280469146, 5002.59979201663, 5039.521245481674, 5720.88442753659, 5973.313068997034, 5978.55160862937, 5998.1002849572915, 6006.849828754229, 5704.686242256633, 5735.627184233012, 5748.109043098327, 5795.188673585617, 5803.47768700802, 5942.851428714143, 5949.583529152917, 5953.196318496947, 5955.731992060281, 5969.194158788508, 5569.944300556943, 5620.606557540933, 5676.318841739017, 5684.403137670651, 5694.658320500783, 5681.801136960186, 5774.249347584787, 5779.739911704068, 5782.450667186778, 5820.708964551671, 5631.1271752878365, 5639.295088113986, 5645.350784659817, 5647.491725744702, 5663.490285874126, 5488.25908502363, 5497.45025497463, 5508.228847961369, 5587.7485513152815, 5627.971860140673, 5353.75908084145, 5402.594805389533, 5413.10683737179, 5438.0, 5547.528460080938, 5550.555955523468, 5606.775728970795, 5614.7192640367, 5630.042892708331, 5648.774049037993, 5420.159875219348, 5495.203195536705, 5518.06192947208, 5527.8894422112135, 5533.2253484513], "value": 5253.425757733347, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.9882402351953, 636.9012803015535, 637.7704026550442, 639.1850390751794, 655.8065370715639, 42352.78823605881, 43969.34045989309, 44017.33973990389, 45794.313085303744, 46020.0, 44428.11143777122, 45171.0, 45263.54736452635, 45286.32070518945, 45369.7731511342, 8997.865032024509, 9084.818303633923, 9102.0, 9137.543122843865, 9164.358494905326, 8898.421602595843, 8994.145556172152, 8995.775105622346, 8995.955020224923, 8996.730098097067, 8981.326400519954, 8988.865167022499, 9026.368154229207, 9052.321075919332, 9064.864027039599, 8965.417247878868, 8996.055414181548, 8996.550172491348, 9018.909810901905, 9043.412178208395, 8808.779780505474, 8809.295256379473, 8831.60257788401, 8839.02770695223, 8859.335549833788, 43249.13501729948, 43272.13455730868, 43503.12993740139, 43695.56304436947, 43809.0, 3417.7607567470286, 3581.982090089559, 4105.876823695294, 4224.809883555247, 4227.661787057059, 32525.83737081323, 32880.50679239813, 33128.6687133128, 33460.49809252863, 34599.82700086509, 4382.4741031076155, 4401.846638000561, 4435.667324950609, 4456.19788438081, 4516.728996260234, 245808.0, 247897.0, 247934.0, 248061.0, 249202.0, 36323.27353452916, 37586.87239382823, 37625.0, 60125.699371502866, 60305.0, 37030.0, 37438.25123497515, 37444.62555374411, 37490.0, 37519.437208441894, 15955.0, 16037.358505659877, 16101.275442604876, 16204.432844850373, 16247.918760406123, 12397.690057748629, 12404.75190496185, 12413.379331033593, 12419.254844709347, 12482.75034499305, 8305.543195124326, 8357.331413486907, 8357.373197010127, 8404.369672274604, 8417.158284171657, 3242.367738291058, 3242.7567932405163, 3263.6246831614194, 3282.14664187313, 3286.1784553861535, 983.6409710455632, 1026.503912861661, 1115.3475216997986, 1159.750653609478, 1177.3053898200103, 32362.676373236438, 32480.187995299835, 32688.67311326904, 33199.83400082984, 33351.66648333534, 1115.6764538283808, 1153.1005815463952, 1162.1574358589955, 1171.5957994491887, 1203.5667159822458, 16788.83211167897, 17224.311027559008, 17261.741073883903, 17279.91360043217, 17314.0, 571571.0, 576854.0, 581745.0, 583910.0, 584193.0, 58596.41403585995, 59637.70181149067, 59711.40288597145, 59740.70129649324, 59822.40177598255, 1236.913416060885, 1322.7619028574757, 1333.2600406774334, 1338.946442142323, 1344.4286178374152, 30488.0, 31355.275459849927, 31719.365612688078, 31855.0, 32076.839615802706, 51866.0, 52009.0, 52304.21543676772, 52576.21135683044, 52637.7368113157, 517941.0, 521429.0, 524137.0, 525029.0, 529176.0, 28928.132156035354, 29270.70729292765, 29368.853155734083, 29396.853015734785, 29433.11700648984, 49604.75197623989, 50029.49970500248, 50078.74960625174, 51177.23234151565, 51199.23201151911, 42235.1552968945, 42954.0, 43125.0, 43964.0, 44006.779966099966, 41576.79211603923, 42295.5770442304, 42608.78695606502, 42814.78592607017, 42896.35655465233, 41927.371089434295, 42392.0, 42441.15117697567, 42655.57344426516, 42978.0, 35925.64074359223, 37613.623863761015, 37869.24261514809, 38551.807240963615, 38713.61286387213, 28787.85606071956, 28943.42113157683, 29033.0, 29097.27256818512, 29285.7071429283], "value": 19190.229866511923, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.9628585284399, 401.4600362512422, 403.233855674219, 403.3344980781708, 419.79010494752623, 17714.734278985827, 19137.61724765504, 19331.516712082186, 19361.419157425284, 20538.794612053876, 18288.0, 19359.128839202236, 19368.418947431564, 19419.514512137204, 19490.122944467497, 5227.2159176123605, 5286.259923610678, 5861.17943487912, 5861.472467477926, 5881.529477641779, 5676.517496012844, 5680.11958146488, 5725.942740572583, 5729.197912292261, 5761.452661997125, 5524.502794748471, 5717.056685646863, 5790.36306006339, 5801.680907550104, 5828.03837366834, 5279.947200527984, 5694.999999999979, 5714.51426628737, 5738.167965644979, 5742.799002034951, 5137.588992880561, 5149.0474262261605, 5150.253213284091, 5159.355080614923, 5168.767405466763, 13366.46534138643, 13461.057725959186, 17533.912330438267, 22938.31185064434, 22943.0, 2362.385779697291, 2437.902483900642, 2510.8242423030397, 2576.600626902833, 2739.2467071555484, 10096.14182794456, 10246.948765256126, 10316.226283028804, 10446.529906154241, 10530.315529490636, 1857.7306290587924, 1944.0765636322774, 1951.717001034842, 1955.3742802303268, 1967.6950072738748, 81741.59129204375, 87134.5643271786, 87313.0, 87322.5633871833, 87398.0, 10499.527521261562, 10568.15057364958, 10792.086136743035, 10816.809041332826, 10959.83560246597, 14842.851571484363, 14843.257837108102, 14914.627134321729, 14920.70158596822, 15007.0, 7844.176361482077, 8116.310113640407, 8251.546164960864, 8400.78998025042, 8435.873461898076, 8008.879866802003, 8072.273495385443, 8074.232947869943, 8194.0, 8248.54632995179, 4411.029573493826, 4451.77741112943, 4550.317452382103, 4561.7262964222255, 4664.230401983703, 1849.6763066463316, 1849.9835179654242, 1856.8143185681595, 1896.2320260294603, 1929.4501067195781, 969.3602222533094, 977.7408986618552, 1027.275770581738, 1069.1126365116934, 1075.3118004477142, 18326.81673183251, 18902.149403276886, 19550.5112372189, 19610.70583941242, 19672.803271967383, 982.6462473509531, 1003.6487229469773, 1004.322082594246, 1051.321897376188, 1064.2603390643428, 10396.740081498023, 10941.617043403601, 11016.953389427992, 11019.449027548591, 11048.447577621248, 515114.0, 523555.0, 525418.0, 525961.0, 529729.3513532408, 93226.0, 95823.0, 96860.51569742247, 97959.51020244854, 98096.0, 987.8863930648067, 990.6978371596588, 1031.6234574380296, 1034.8706411698538, 1048.09863517375, 16246.268917898487, 16607.91696041512, 16771.0, 17044.14779261057, 17204.827951720825, 40774.59225407708, 41645.1670966585, 41859.58140418557, 43534.56465435305, 43689.56310436855, 57156.0, 57697.4230257692, 58101.4189858096, 59090.40909590849, 59502.70248648729, 8345.248927596303, 8385.1195624461, 8439.70461033861, 8511.361647876558, 8724.520151391735, 9696.95151524238, 12933.935330323287, 13062.216267024009, 13099.0, 13266.602001939957, 11510.424478776195, 11530.135239856876, 11569.595064172714, 11612.593559225386, 11927.761444770882, 11403.828942565702, 11445.828312575484, 11523.596674116367, 11544.538218471167, 11681.299122052704, 11349.943250284026, 11606.24559403636, 11955.815464587326, 12036.03711703044, 12085.395730213279, 7222.241664625139, 7589.241075892367, 7994.120646728739, 8433.83132337362, 8483.363747718822, 8649.048604653357, 11818.586349477728, 11868.05055595533, 11873.821892671443, 11922.105842061706], "value": 9140.465806297156, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1481.6369989352606, 1506.9849301506986, 1653.9834601653988, 1767.2489192093358, 1787.3744189533666, 7368.59472729001, 8526.87209691855, 8569.614367353468, 9216.631334746611, 9235.307351948606, 8589.0, 8804.471731696087, 8868.645254189825, 8924.241439477652, 8950.239229665487, 2280.315905228433, 2310.2722642367685, 2313.005407674699, 2313.178821518362, 2315.016118149788, 2348.6477028445784, 2363.125643511903, 2380.2502211803226, 2392.1866565367773, 2395.9880200598973, 2355.199232261031, 2360.114956891166, 2373.549025685123, 2395.3652282145244, 2396.5446565152565, 2291.9312420627407, 2304.1704986204954, 2317.9072837086496, 2326.1393284484766, 2338.0530884991604, 2244.5398693268003, 2270.3189043286948, 2271.057511132878, 2272.0798076778933, 2274.078998005794, 8890.377673562853, 8901.0, 8960.059193784624, 8960.23837973773, 8963.372563920528, 5113.590912726973, 5203.219517072432, 5204.557612602934, 5206.114960456694, 5208.062548741225, 3202.3755367703307, 3307.6361600223954, 3419.076849250713, 3436.1066122808, 3443.6900678939014, 1126.0991207034422, 1130.129800053962, 1164.4643464006567, 1170.4440390814295, 1173.5012619636705, 11426.657200283922, 11440.370779607118, 11442.256253343588, 11445.370504622242, 11464.770704585862, 4512.458504979358, 4576.725396476222, 4654.301854721819, 4672.672912896064, 4677.508861569554, 9686.467244301632, 9711.611535538499, 9723.270754693285, 9736.0, 9736.269779766404, 5075.3402057732255, 5155.53600175986, 5166.870828229325, 5211.218317252366, 5227.686338819683, 4274.829006839692, 4783.760811959388, 4908.631852610997, 4993.27597498368, 4996.850094497171, 4072.9757860214913, 4086.6117718816663, 4191.413202151702, 4199.769012704331, 4225.661947044229, 1281.5770795637418, 1318.7362527494347, 1330.0689517337903, 1335.6327010072307, 1356.3828458051562, 991.3011327014582, 1006.9395836249848, 1021.7521452803861, 1026.1944373666636, 1047.4343854318736, 5987.491063259672, 6232.0963460298, 6299.0866324382705, 6303.117563541108, 6312.463440607508, 439.15243579891114, 445.4387471785509, 447.77387419353016, 451.4920714196529, 468.9390379250744, 4182.979085104555, 4356.869293921188, 4402.6037656610415, 4406.449193850769, 4432.135733531994, 10771.569137234423, 11210.327380357205, 11277.887221127849, 11292.266002709797, 11308.0, 10539.947300263602, 11153.665390038312, 11172.162087843444, 11187.888121118847, 11221.60724374643, 8062.7581172564915, 8342.16578342161, 8372.1627837217, 8435.662573496991, 8441.95779021101, 6050.757969681164, 6345.7144428499905, 6356.3325850785, 6379.138816259931, 6385.521085918482, 10176.287659863738, 10365.63720269787, 10386.532606032595, 10504.527296271839, 10507.527161277914, 9906.554205060933, 10195.0, 10277.794444111225, 10281.074703276741, 10481.37111773296, 6886.655667216719, 7599.962000189964, 7799.688012479437, 7989.520628762293, 8111.269985701315, 8766.868496972424, 8830.249428798625, 8845.380823342304, 8908.55457227123, 8910.153535414125, 7651.885221721567, 7912.525248485109, 7924.1283458820635, 7932.6033698316005, 8003.19968003195, 7568.318851303409, 7633.122190948112, 7707.075150981918, 7879.330256928225, 7930.088039875257, 7278.708851646086, 7348.595827229554, 7486.4759466836795, 7502.099748030271, 7509.474336796372, 5054.646174767731, 5168.638195326291, 5181.1969144782615, 5248.501392367719, 5278.287431196739, 5050.974745126251, 5114.539691427641, 5127.359080114986, 5185.688858668492, 5245.973770131125], "value": 4605.619961703401, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.2243863753122, 322.9693179147981, 324.1782082421063, 329.3314571420017, 329.6686829736115, 5521.475459831319, 5601.103823388259, 5610.803621873235, 5648.491635752786, 5673.943260567393, 5577.609567330289, 5599.356074051475, 5606.523445507127, 5631.8028868989595, 5636.746346414411, 4347.260965635849, 4353.802704256339, 4367.890802729941, 4381.255186618267, 4383.649308055348, 4103.1793641271715, 4154.709170358076, 4261.318189089746, 4264.445622069126, 4284.5715428457215, 4232.470941132358, 4241.830326786925, 4253.553376895427, 4256.127493863766, 4260.275753121961, 4176.102138040321, 4195.727277726938, 4228.217779710732, 4234.708413933749, 4265.829366825324, 3560.893173204808, 3691.9446208306895, 3713.387291096966, 3723.3484140275345, 3725.8882233533036, 5412.9458705412835, 5421.834305624309, 5432.972835135839, 5438.428964958662, 5441.891162176774, 4838.250071238964, 4863.8540843774745, 4885.096257192431, 4890.31284206948, 4895.534924182232, 5629.915551266734, 5761.683107429089, 5815.79644712433, 5824.388439213906, 5835.416458354173, 4041.838326466938, 4068.837246510136, 4070.837166513336, 4074.6332830045144, 4086.8160932758096, 5988.550858685616, 6005.729742161613, 6014.2181516403025, 6017.06735456005, 6017.699115044274, 3966.8413263469715, 4151.750894946313, 4166.250074986471, 4166.687493439556, 4169.478815148106, 4184.497860256789, 4200.85297014603, 4211.873643790691, 4212.894677633084, 4213.641840443535, 4828.368539146174, 4843.733594652328, 4853.2336568155815, 4859.441164266084, 4870.634702397334, 5769.0, 5832.24180856486, 5852.385499522574, 5879.470847623649, 5960.225170727865, 1450.2821103553808, 1457.1766951672482, 1458.8103546538882, 1460.2990564529086, 1461.101422625078, 899.2221728205055, 899.9460032398077, 922.935394522377, 933.6732143749633, 936.9625214991324, 4968.478309777493, 5002.74986250686, 5514.91727624086, 5593.972030139905, 5633.267675202197, 6064.181335519648, 6105.267367915879, 6118.359576052242, 6127.601705889192, 6135.32511423743, 5502.642328248651, 5610.49505544503, 5611.803586874522, 5618.937678964974, 5621.4378562144275, 3196.4406228909847, 3225.59680039995, 3235.3044095519576, 3238.951415728766, 3257.1694217974264, 6226.626402415779, 6272.905906411407, 6318.72525890679, 6326.493880489642, 6343.908179224467, 5901.5868889177345, 6210.0, 6263.6241825490615, 6320.735852829453, 6332.52506062038, 6321.715522801393, 6322.589031712924, 6339.619622822645, 6355.459785918156, 6358.0, 5936.940630593639, 6092.482139018233, 6140.324564298013, 6144.723487443165, 6155.84610384744, 6054.8183554493435, 6056.788012419544, 6075.392460753889, 6079.544034197364, 6125.448709616156, 5951.702414879325, 6248.0, 6313.96843015782, 6362.872742545216, 6375.266844312963, 4189.601987811153, 4200.789960502024, 4228.794793483966, 4247.702660813713, 4254.127903779656, 6077.0, 6080.0, 6086.452219300284, 6097.695115244309, 6132.877342453036, 5840.153177789111, 5969.582129250911, 5986.3115741688525, 6051.576389652682, 6055.788047418319, 5895.469407753323, 5920.911186332295, 5941.0, 5941.207632412759, 5980.850478738066, 5867.882642347215, 5869.53043756507, 5888.234529511307, 5901.881962360643, 5916.0, 5778.191053252632, 5882.441168089024, 6009.579329446897, 6025.6083354581815, 6031.728572214173, 5759.769609215752, 5782.508486778503, 5844.824655260349, 5856.092305692625, 5860.589758716849], "value": 4434.6174585222525, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [772.5001864141378, 783.7335305995964, 792.7463211772235, 800.4836880212263, 815.4821688227976, 14446.783298250535, 15003.249837508121, 15199.696006079872, 15209.695806083872, 15252.161131137796, 14000.859991400108, 14494.202818844959, 14532.200728959902, 15001.92499037506, 15024.248787560633, 810.6028046257336, 818.5661599352353, 822.3339095332769, 822.7984143884756, 823.4524041512417, 801.5992003998001, 813.1096449387911, 831.7089018843386, 839.529863276564, 839.7816567692413, 842.5744998775609, 855.0637052427613, 857.5926434943415, 858.4162769316862, 858.4634603372892, 840.3193413335218, 842.2714352085463, 846.7502086884354, 847.7244895409017, 849.4903058165113, 615.5106690181317, 617.9165812615284, 619.8357435279654, 621.2793159934454, 621.3724138620026, 13850.445982160702, 13894.444222231099, 13920.373583188679, 13924.651883702887, 13943.302834858318, 14482.782758258634, 14745.11529308245, 14795.852041479662, 14797.852021479863, 14910.552683419515, 12129.332886691229, 12329.075319351085, 12350.0, 12423.75152496945, 12451.377431128407, 3824.3689791184697, 3949.7037722170953, 4057.634812866856, 4066.3900414938, 4070.2266569352023, 74043.0, 74452.76641700757, 75375.24624753738, 76294.23705762927, 76573.61713191398, 11427.714307142222, 11712.590059347882, 11787.469563869647, 11826.053915686725, 11903.0, 21395.0, 21505.032273547728, 21517.139314427248, 21615.243466478598, 21664.02511886969, 8296.751097467086, 8608.913910860936, 8651.091635378194, 8839.911600884037, 8923.643054277885, 4714.868827772051, 4836.081144582588, 4838.225883858636, 4934.8766280843265, 4955.900881982412, 3594.3350480161253, 3687.3731465650903, 3715.108373990223, 3716.591174970751, 3728.981355093207, 640.5740182778493, 655.757369773187, 657.5922927784804, 700.1038670501766, 702.0557350363753, 662.1888186971019, 716.7419728897593, 729.7701224114387, 746.1493896957472, 768.9500182488121, 9509.191718703849, 9825.557849896772, 9868.851967220497, 9886.555105020292, 9980.351277166961, 711.5872793779596, 718.267367285366, 728.351766927435, 744.6462930108155, 758.1698040645484, 4839.588634966068, 5112.718800465936, 5120.1039818031695, 5143.871403214875, 5146.768395422215, 77613.0, 100939.0, 101524.49237753764, 104338.47830760798, 107685.0, 52290.215646765326, 69318.0, 89538.0, 100333.0, 106076.46961765141, 63047.0, 71649.0, 91023.0, 91867.0, 92487.07512924919, 10066.949665251626, 10250.692479225636, 10359.689209323733, 10399.53202105892, 10533.315334503233, 53041.20438193353, 53338.46661533335, 54841.0, 55429.16856247079, 56238.0, 77648.61175694085, 78022.21977780377, 78163.18702394597, 80390.59804701174, 81696.59151704203, 13815.516456923959, 13835.930820345833, 13855.722885542435, 14396.0, 14400.279986000449, 14871.107733536022, 15070.472533461276, 15208.619784505476, 15229.923850380677, 15328.616784580474, 13904.791428128789, 13958.23229722375, 14044.227567483886, 14081.647958801112, 14792.408303667733, 13839.30803459843, 14102.083364581269, 14522.709545809235, 14710.19093949843, 14740.0, 12118.885337774138, 13441.059125861488, 13942.79085813734, 14402.495912643426, 14605.196714180822, 11263.66209013731, 11596.188266821242, 11655.125865559947, 11711.472983715923, 11763.705907352385, 10916.399598022184, 11359.602413915472, 11465.713357166138, 11546.249493782878, 11619.038185329897], "value": 7654.8157826586175, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1537.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 111.0, 111.0, 111.0, 113.0, 110.0, 112.0, 110.0, 110.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 137.0, 157.0, 171.0, 131.0, 152.0, 154.0, 132.0, 178.0, 130.0], "value": 150.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 164.0, 163.0, 164.0, 168.0, 161.0, 161.0, 162.0, 163.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 162.0, 76.0, 76.0, 74.0, 74.0, 159.0, 76.0], "value": 92.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 146.0, 86.0, 92.0, 85.0, 150.0, 84.0, 85.0, 144.0], "value": 104.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 149.0, 148.0, 146.0, 147.0, 146.0, 149.0, 147.0, 148.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 57.0, 55.0, 57.0, 57.0, 57.0, 55.0, 56.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 62.0, 64.0, 62.0, 62.0, 62.0, 62.0, 62.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 82.0, 79.0, 80.0, 79.0, 81.0, 80.0, 79.0, 113.0, 89.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 123.0, 133.0, 126.0, 122.0, 137.0, 139.0, 124.0, 135.0, 122.0], "value": 128.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 160.0, 164.0, 159.0, 159.0, 160.0, 162.0, 172.0, 158.0, 161.0], "value": 162.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 63.0, 64.0, 65.0, 66.0, 63.0, 63.0, 63.0], "value": 63.7, "unit": "score"}]}]} 17:36:02 INFO - Return code: 0 17:36:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:36:02 ERROR - # TBPL SUCCESS # 17:36:02 INFO - Running post-action listener: _resource_record_post_action 17:36:02 INFO - ##### 17:36:02 INFO - ##### Finished run-tests step (success) 17:36:02 INFO - ##### 17:36:02 INFO - Running post-run listener: _resource_record_post_run 17:36:02 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 541650944; Read time: 12; Write time: 467384 17:36:02 INFO - TinderboxPrint: CPU usage
13.4% 17:36:02 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 17:36:02 INFO - TinderboxPrint: I/O write bytes / time
541,650,944 / 467,384 17:36:02 INFO - TinderboxPrint: CPU idle
8,230.7 (86.6%) 17:36:02 INFO - TinderboxPrint: CPU user
1,221.7 (12.8%) 17:36:02 INFO - TinderboxPrint: Swap in / out
0 / 0 17:36:02 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 248455168; Read time: 0; Write time: 269688 17:36:02 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293195776; Read time: 12; Write time: 197696 17:36:03 INFO - Running post-run listener: _upload_blobber_files 17:36:03 INFO - Blob upload gear active. 17:36:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:36:03 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 17:36:03 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'] 17:36:03 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 17:36:03 INFO - (blobuploader) - INFO - Open directory for files ... 17:36:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:36:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:36:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:36:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:36:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:36:04 INFO - (blobuploader) - INFO - Done attempting. 17:36:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:36:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:36:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:36:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:36:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:36:08 INFO - (blobuploader) - INFO - Done attempting. 17:36:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:36:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:36:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:36:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:36:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:36:09 INFO - (blobuploader) - INFO - Done attempting. 17:36:09 INFO - (blobuploader) - INFO - Iteration through files over. 17:36:09 INFO - Return code: 0 17:36:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:36:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:36:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ef8a697ab48737731a0082cb72cff61cac9c098abf423552342f77b4de0982997f53a8f366d880ecc3b6165649a59f74a8d2b40245972b92e249e14d9c6d7da4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0eedda49b7dbce2df70768addb26ac73f14cd2b64f680343a589796a0c4b9c6088bdf482c1dc0565dfd06902550e086edcda03baddbe3e76ff07cd578a35915", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3217347a1e596f2427e3258ff852d75412f58b4199fff559a8d9f28a62c4a4b9db843e2b105a2f96d423ac6146573b6e9ab3e7d38739131acad131d77022a46b"} 17:36:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:36:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:36:09 INFO - Contents: 17:36:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ef8a697ab48737731a0082cb72cff61cac9c098abf423552342f77b4de0982997f53a8f366d880ecc3b6165649a59f74a8d2b40245972b92e249e14d9c6d7da4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0eedda49b7dbce2df70768addb26ac73f14cd2b64f680343a589796a0c4b9c6088bdf482c1dc0565dfd06902550e086edcda03baddbe3e76ff07cd578a35915", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3217347a1e596f2427e3258ff852d75412f58b4199fff559a8d9f28a62c4a4b9db843e2b105a2f96d423ac6146573b6e9ab3e7d38739131acad131d77022a46b"} 17:36:09 INFO - Running post-run listener: copy_logs_to_upload_dir 17:36:09 INFO - Copying logs to upload dir... 17:36:09 INFO - mkdir: /builds/slave/test/build/upload/logs 17:36:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.486456 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-09 17:36:09.289316) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 17:36:09.294001) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1465517734.342769-524867587 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/ef8a697ab48737731a0082cb72cff61cac9c098abf423552342f77b4de0982997f53a8f366d880ecc3b6165649a59f74a8d2b40245972b92e249e14d9c6d7da4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0eedda49b7dbce2df70768addb26ac73f14cd2b64f680343a589796a0c4b9c6088bdf482c1dc0565dfd06902550e086edcda03baddbe3e76ff07cd578a35915", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3217347a1e596f2427e3258ff852d75412f58b4199fff559a8d9f28a62c4a4b9db843e2b105a2f96d423ac6146573b6e9ab3e7d38739131acad131d77022a46b"} build_url:https://queue.taskcluster.net/v1/task/LsuHfWo7TFq884r4E8XQ8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011310 build_url: 'https://queue.taskcluster.net/v1/task/LsuHfWo7TFq884r4E8XQ8A/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/ef8a697ab48737731a0082cb72cff61cac9c098abf423552342f77b4de0982997f53a8f366d880ecc3b6165649a59f74a8d2b40245972b92e249e14d9c6d7da4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0eedda49b7dbce2df70768addb26ac73f14cd2b64f680343a589796a0c4b9c6088bdf482c1dc0565dfd06902550e086edcda03baddbe3e76ff07cd578a35915", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3217347a1e596f2427e3258ff852d75412f58b4199fff559a8d9f28a62c4a4b9db843e2b105a2f96d423ac6146573b6e9ab3e7d38739131acad131d77022a46b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 17:36:09.322801) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 17:36:09.323216) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1465517734.342769-524867587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 17:36:09.402441) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 17:36:09.405843) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 17:36:09.406157) ========= ========= Total master_lag: 0.20 =========